[42.485974] Initializing watchdogs [42.486146] /dev/watchdog0 [42.495623] [001/165] (960s left) i915_module_load (load) [42.596767] Starting subtest: load [45.186906] Subtest load: SUCCESS (2.587s) [45.211391] [002/165] (957s left) core_auth (basic-auth) [45.310876] Starting subtest: basic-auth [45.312347] Subtest basic-auth: SUCCESS (0.001s) [45.383597] [003/165] (957s left) debugfs_test (read_all_entries) [45.484260] Starting subtest: read_all_entries [45.553249] Subtest read_all_entries: SUCCESS (0.069s) [45.670173] [004/165] (957s left) debugfs_test (basic-hwmon) [45.765412] Starting subtest: basic-hwmon [45.767500] Subtest basic-hwmon: SKIP (0.000s) [45.869124] [005/165] (957s left) fbdev (eof) [45.969129] Starting subtest: eof [45.970363] Subtest eof: SUCCESS (0.001s) [46.032524] [006/165] (957s left) fbdev (info) [46.152902] Starting subtest: info [46.154091] Subtest info: SUCCESS (0.000s) [46.240913] [007/165] (956s left) fbdev (nullptr) [46.351683] Starting subtest: nullptr [46.352857] Subtest nullptr: SUCCESS (0.000s) [46.442667] [008/165] (956s left) fbdev (read) [46.534612] Starting subtest: read [53.615337] Subtest read: SUCCESS (7.046s) [53.659591] [009/165] (949s left) fbdev (write) [53.759365] Starting subtest: write [57.544027] Subtest write: SUCCESS (3.750s) [57.579476] [010/165] (945s left) gem_basic (bad-close) [57.668480] Starting subtest: bad-close [57.670793] Subtest bad-close: SUCCESS (0.000s) [57.746151] [011/165] (945s left) gem_basic (create-close) [57.834659] Starting subtest: create-close [57.836969] Subtest create-close: SUCCESS (0.000s) [57.934751] [012/165] (945s left) gem_basic (create-fd-close) [58.024703] Starting subtest: create-fd-close [58.026853] Subtest create-fd-close: SUCCESS (0.000s) [58.120442] [013/165] (945s left) gem_busy (busy@all-engines) [58.230921] Starting subtest: busy [58.232162] Starting dynamic subtest: all-engines [58.290998] Dynamic subtest all-engines: SUCCESS (0.060s) [58.292159] Subtest busy: SUCCESS (0.060s) [58.687741] [014/165] (944s left) gem_close_race (basic-process) [58.799421] Starting subtest: basic-process [58.863207] Subtest basic-process: SUCCESS (0.064s) [59.070628] [015/165] (944s left) gem_close_race (basic-threads) [59.182202] Starting subtest: basic-threads [60.368372] Subtest basic-threads: SUCCESS (1.188s) [60.601676] [016/165] (942s left) gem_ctx_create (basic) [60.707860] Starting subtest: basic [60.709017] Subtest basic: SUCCESS (0.000s) [60.905960] [017/165] (942s left) gem_ctx_create (basic-files) [61.012602] Starting subtest: basic-files [63.037405] Subtest basic-files: SUCCESS (2.026s) [63.270733] [018/165] (940s left) gem_ctx_exec (basic) [63.365202] Starting subtest: basic [63.370463] Subtest basic: SUCCESS (0.005s) [63.474610] [019/165] (939s left) gem_exec_basic (basic) [63.573757] Starting subtest: basic [63.574954] Starting dynamic subtest: rcs0-smem [63.576120] Dynamic subtest rcs0-smem: SUCCESS (0.002s) [63.588668] Starting dynamic subtest: bcs0-smem [63.589764] Dynamic subtest bcs0-smem: SUCCESS (0.001s) [63.600409] Starting dynamic subtest: vcs0-smem [63.602181] Dynamic subtest vcs0-smem: SUCCESS (0.001s) [63.612934] Starting dynamic subtest: vecs0-smem [63.614281] Dynamic subtest vecs0-smem: SUCCESS (0.001s) [63.615677] Subtest basic: SUCCESS (0.006s) [63.792242] [020/165] (939s left) gem_exec_create (basic) [63.896319] Starting subtest: basic [63.897884] Starting dynamic subtest: smem [65.943758] Dynamic subtest smem: SUCCESS (2.048s) [65.945036] Subtest basic: SUCCESS (2.048s) [66.181659] [021/165] (937s left) gem_exec_fence (basic-busy) [66.436607] Starting subtest: basic-busy [66.437851] Starting dynamic subtest: rcs0 [66.458239] Dynamic subtest rcs0: SUCCESS (0.030s) [66.472171] Starting dynamic subtest: bcs0 [66.480439] Dynamic subtest bcs0: SUCCESS (0.022s) [66.491610] Starting dynamic subtest: vcs0 [66.519615] Dynamic subtest vcs0: SUCCESS (0.038s) [66.534110] Starting dynamic subtest: vecs0 [66.550054] Dynamic subtest vecs0: SUCCESS (0.030s) [66.551585] Subtest basic-busy: SUCCESS (0.122s) [67.149574] [022/165] (936s left) gem_exec_fence (basic-wait) [67.408208] Starting subtest: basic-wait [67.409453] Starting dynamic subtest: rcs0 [67.435825] Dynamic subtest rcs0: SUCCESS (0.035s) [67.450157] Starting dynamic subtest: bcs0 [67.464109] Dynamic subtest bcs0: SUCCESS (0.028s) [67.477083] Starting dynamic subtest: vcs0 [67.495254] Dynamic subtest vcs0: SUCCESS (0.031s) [67.508630] Starting dynamic subtest: vecs0 [67.516523] Dynamic subtest vecs0: SUCCESS (0.021s) [67.518454] Subtest basic-wait: SUCCESS (0.117s) [68.067525] [023/165] (935s left) gem_exec_fence (basic-await) [68.321170] Starting subtest: basic-await [68.322425] Starting dynamic subtest: rcs0 [68.413884] Dynamic subtest rcs0: SUCCESS (0.100s) [68.437613] Starting dynamic subtest: bcs0 [68.524637] Dynamic subtest bcs0: SUCCESS (0.109s) [68.551379] Starting dynamic subtest: vcs0 [68.653377] Dynamic subtest vcs0: SUCCESS (0.128s) [68.680305] Starting dynamic subtest: vecs0 [68.784497] Dynamic subtest vecs0: SUCCESS (0.129s) [68.786488] Subtest basic-await: SUCCESS (0.470s) [69.384286] [024/165] (934s left) gem_exec_fence (nb-await) [69.633146] Starting subtest: nb-await [69.634380] Starting dynamic subtest: rcs0 [69.690902] Dynamic subtest rcs0: SUCCESS (0.065s) [69.709359] Starting dynamic subtest: bcs0 [69.759955] Dynamic subtest bcs0: SUCCESS (0.068s) [69.781601] Starting dynamic subtest: vcs0 [69.830785] Dynamic subtest vcs0: SUCCESS (0.070s) [69.858403] Starting dynamic subtest: vecs0 [69.904912] Dynamic subtest vecs0: SUCCESS (0.074s) [69.908116] Subtest nb-await: SUCCESS (0.280s) [70.467361] [025/165] (933s left) gem_exec_gttfill (basic) [70.573280] Starting subtest: basic [77.021718] Subtest basic: SUCCESS (6.448s) [77.222407] [026/165] (926s left) gem_exec_parallel (engines) [77.397115] Starting subtest: engines [77.400421] Starting dynamic subtest: basic [79.736847] Dynamic subtest basic: SUCCESS (2.317s) [79.760307] Starting dynamic subtest: contexts [85.194689] Dynamic subtest contexts: SUCCESS (5.474s) [85.208290] Starting dynamic subtest: fds [95.103468] Dynamic subtest fds: SUCCESS (9.917s) [95.128380] Starting dynamic subtest: userptr [97.495737] Dynamic subtest userptr: SUCCESS (2.373s) [97.497272] Subtest engines: SUCCESS (20.081s) [97.691250] [027/165] (906s left) gem_exec_store (basic) [97.798564] Starting subtest: basic [97.869656] Subtest basic: SUCCESS (0.070s) [98.080881] [028/165] (905s left) gem_flink_basic (bad-flink) [98.169773] Starting subtest: bad-flink [98.170992] Subtest bad-flink: SUCCESS (0.000s) [98.263589] [029/165] (905s left) gem_flink_basic (bad-open) [98.352606] Starting subtest: bad-open [98.353702] Subtest bad-open: SUCCESS (0.000s) [98.432708] [030/165] (905s left) gem_flink_basic (basic) [98.520775] Starting subtest: basic [98.522043] Subtest basic: SUCCESS (0.000s) [98.631451] [031/165] (905s left) gem_flink_basic (double-flink) [98.719129] Starting subtest: double-flink [98.720295] Subtest double-flink: SUCCESS (0.000s) [98.813949] [032/165] (905s left) gem_flink_basic (flink-lifetime) [98.903196] Starting subtest: flink-lifetime [98.905766] Subtest flink-lifetime: SUCCESS (0.002s) [98.997206] [033/165] (904s left) gem_huc_copy (huc-copy) [99.092479] Starting subtest: huc-copy [99.094798] Subtest huc-copy: SKIP (0.000s) [99.217981] [034/165] (904s left) gem_linear_blits (basic) [99.450279] Starting subtest: basic [99.461805] Subtest basic: SUCCESS (0.012s) [99.601670] [035/165] (904s left) gem_mmap (basic) [99.758189] Starting subtest: basic [99.763450] Subtest basic: SUCCESS (0.001s) [99.870222] [036/165] (904s left) gem_mmap_gtt (basic) [99.961610] Starting subtest: basic [99.962865] Subtest basic: SUCCESS (0.001s) [100.040836] [037/165] (903s left) gem_render_linear_blits (basic) [100.136800] Starting subtest: basic [100.186352] Subtest basic: SUCCESS (0.049s) [100.258774] [038/165] (903s left) gem_render_tiled_blits (basic) [100.355689] Starting subtest: basic [100.420302] Subtest basic: SUCCESS (0.066s) [100.473725] [039/165] (903s left) gem_ringfill (basic-all) [100.696179] Starting subtest: basic-all [101.952862] Subtest basic-all: SUCCESS (1.248s) [102.038294] [040/165] (902s left) gem_softpin (allocator-basic) [102.134164] Starting subtest: allocator-basic [102.302431] Subtest allocator-basic: SUCCESS (0.160s) [102.418841] [041/165] (901s left) gem_softpin (allocator-basic-reserve) [102.514909] Starting subtest: allocator-basic-reserve [102.682860] Subtest allocator-basic-reserve: SUCCESS (0.157s) [102.803256] [042/165] (901s left) gem_softpin (safe-alignment) [102.899685] Starting subtest: safe-alignment [102.917268] Subtest safe-alignment: SUCCESS (0.017s) [103.035793] [043/165] (901s left) gem_sync (basic-all) [103.140752] Starting subtest: basic-all [105.343992] Subtest basic-all: SUCCESS (2.180s) [105.538657] [044/165] (898s left) gem_sync (basic-each) [105.644072] Starting subtest: basic-each [107.997923] Subtest basic-each: SUCCESS (2.354s) [108.207436] [045/165] (896s left) gem_tiled_blits (basic) [108.416479] Starting subtest: basic [108.446524] Subtest basic: SUCCESS (0.030s) [108.560260] [046/165] (895s left) gem_tiled_fence_blits (basic) [108.844408] Starting subtest: basic [108.871881] Subtest basic: SUCCESS (0.028s) [109.007104] [047/165] (895s left) gem_tiled_pread_basic [109.558698] [048/165] (894s left) gem_wait (busy@all-engines) [109.674599] Starting subtest: busy [109.675853] Starting dynamic subtest: all-engines [110.196372] Dynamic subtest all-engines: SUCCESS (0.522s) [110.197485] Subtest busy: SUCCESS (0.522s) [110.443894] [049/165] (893s left) gem_wait (wait@all-engines) [110.557631] Starting subtest: wait [110.558849] Starting dynamic subtest: all-engines [111.593117] Dynamic subtest all-engines: SUCCESS (1.034s) [111.594984] Subtest wait: SUCCESS (1.035s) [111.845934] [050/165] (892s left) i915_getparams_basic (basic-eu-total) [111.936892] Starting subtest: basic-eu-total [111.939262] Subtest basic-eu-total: SUCCESS (0.000s) [112.026501] [051/165] (892s left) i915_getparams_basic (basic-subslice-total) [112.113822] Starting subtest: basic-subslice-total [112.116191] Subtest basic-subslice-total: SUCCESS (0.000s) [112.192442] [052/165] (892s left) i915_hangman (error-state-basic) [112.297705] Starting subtest: error-state-basic [112.314106] Subtest error-state-basic: SUCCESS (0.015s) [112.410988] [053/165] (892s left) i915_pciid [112.595241] [054/165] (891s left) kms_addfb_basic (addfb25-4-tiled) [112.722099] Starting subtest: addfb25-4-tiled [112.723246] Subtest addfb25-4-tiled: SUCCESS (0.000s) [112.811264] [055/165] (891s left) kms_addfb_basic (addfb25-bad-modifier) [112.902221] Starting subtest: addfb25-bad-modifier [112.903380] Subtest addfb25-bad-modifier: SUCCESS (0.000s) [113.047302] [056/165] (891s left) kms_addfb_basic (addfb25-framebuffer-vs-set-tiling) [113.137427] Starting subtest: addfb25-framebuffer-vs-set-tiling [113.138494] Subtest addfb25-framebuffer-vs-set-tiling: SUCCESS (0.000s) [113.263064] [057/165] (891s left) kms_addfb_basic (addfb25-modifier-no-flag) [113.354177] Starting subtest: addfb25-modifier-no-flag [113.355398] Subtest addfb25-modifier-no-flag: SUCCESS (0.000s) [113.479563] [058/165] (891s left) kms_addfb_basic (addfb25-x-tiled-legacy) [113.572077] Starting subtest: addfb25-x-tiled-legacy [113.573118] Subtest addfb25-x-tiled-legacy: SUCCESS (0.000s) [113.714063] [059/165] (890s left) kms_addfb_basic (addfb25-x-tiled-mismatch-legacy) [113.803943] Starting subtest: addfb25-x-tiled-mismatch-legacy [113.805157] Subtest addfb25-x-tiled-mismatch-legacy: SUCCESS (0.000s) [113.949245] [060/165] (890s left) kms_addfb_basic (addfb25-yf-tiled-legacy) [114.067505] Starting subtest: addfb25-yf-tiled-legacy [114.068775] Subtest addfb25-yf-tiled-legacy: SUCCESS (0.000s) [114.181899] [061/165] (890s left) kms_addfb_basic (addfb25-y-tiled-legacy) [114.301405] Starting subtest: addfb25-y-tiled-legacy [114.302539] Subtest addfb25-y-tiled-legacy: SUCCESS (0.000s) [114.397218] [062/165] (890s left) kms_addfb_basic (addfb25-y-tiled-small-legacy) [114.515791] Starting subtest: addfb25-y-tiled-small-legacy [114.516980] Subtest addfb25-y-tiled-small-legacy: SUCCESS (0.000s) [114.630500] [063/165] (890s left) kms_addfb_basic (bad-pitch-0) [114.721761] Starting subtest: bad-pitch-0 [114.722852] Subtest bad-pitch-0: SUCCESS (0.000s) [114.847790] [064/165] (889s left) kms_addfb_basic (bad-pitch-1024) [114.939036] Starting subtest: bad-pitch-1024 [114.940192] Subtest bad-pitch-1024: SUCCESS (0.000s) [115.064514] [065/165] (889s left) kms_addfb_basic (bad-pitch-128) [115.155115] Starting subtest: bad-pitch-128 [115.156204] Subtest bad-pitch-128: SUCCESS (0.000s) [115.299624] [066/165] (889s left) kms_addfb_basic (bad-pitch-256) [115.390171] Starting subtest: bad-pitch-256 [115.391267] Subtest bad-pitch-256: SUCCESS (0.000s) [115.516116] [067/165] (889s left) kms_addfb_basic (bad-pitch-32) [115.607172] Starting subtest: bad-pitch-32 [115.608209] Subtest bad-pitch-32: SUCCESS (0.000s) [115.731480] [068/165] (889s left) kms_addfb_basic (bad-pitch-63) [115.821807] Starting subtest: bad-pitch-63 [115.823015] Subtest bad-pitch-63: SUCCESS (0.000s) [115.948498] [069/165] (888s left) kms_addfb_basic (bad-pitch-65536) [116.039570] Starting subtest: bad-pitch-65536 [116.040688] Subtest bad-pitch-65536: SUCCESS (0.000s) [116.183738] [070/165] (888s left) kms_addfb_basic (bad-pitch-999) [116.275110] Starting subtest: bad-pitch-999 [116.276259] Subtest bad-pitch-999: SUCCESS (0.000s) [116.393448] [071/165] (888s left) kms_addfb_basic (basic) [116.483527] Starting subtest: basic [116.484571] Subtest basic: SUCCESS (0.000s) [116.616635] [072/165] (888s left) kms_addfb_basic (basic-x-tiled-legacy) [116.707434] Starting subtest: basic-x-tiled-legacy [116.708540] Subtest basic-x-tiled-legacy: SUCCESS (0.000s) [116.851678] [073/165] (888s left) kms_addfb_basic (basic-y-tiled-legacy) [116.942252] Starting subtest: basic-y-tiled-legacy [116.943359] Subtest basic-y-tiled-legacy: SUCCESS (0.000s) [117.067453] [074/165] (887s left) kms_addfb_basic (bo-too-small) [117.185590] Starting subtest: bo-too-small [117.187014] Subtest bo-too-small: SUCCESS (0.000s) [117.284186] [075/165] (887s left) kms_addfb_basic (bo-too-small-due-to-tiling) [117.403199] Starting subtest: bo-too-small-due-to-tiling [117.404320] Subtest bo-too-small-due-to-tiling: SUCCESS (0.000s) [117.509778] [076/165] (887s left) kms_addfb_basic (clobberred-modifier) [117.598311] Starting subtest: clobberred-modifier [117.599404] Subtest clobberred-modifier: SUCCESS (0.000s) [117.711421] [077/165] (887s left) kms_addfb_basic (framebuffer-vs-set-tiling) [117.801758] Starting subtest: framebuffer-vs-set-tiling [117.802911] Subtest framebuffer-vs-set-tiling: SUCCESS (0.000s) [117.935430] [078/165] (887s left) kms_addfb_basic (invalid-get-prop) [118.027676] Starting subtest: invalid-get-prop [118.028886] Subtest invalid-get-prop: SUCCESS (0.000s) [118.151281] [079/165] (887s left) kms_addfb_basic (invalid-get-prop-any) [118.241796] Starting subtest: invalid-get-prop-any [118.242861] Subtest invalid-get-prop-any: SUCCESS (0.000s) [118.363169] [080/165] (886s left) kms_addfb_basic (invalid-set-prop) [118.453147] Starting subtest: invalid-set-prop [118.454253] Subtest invalid-set-prop: SUCCESS (0.000s) [118.567110] [081/165] (886s left) kms_addfb_basic (invalid-set-prop-any) [118.656545] Starting subtest: invalid-set-prop-any [118.657684] Subtest invalid-set-prop-any: SUCCESS (0.000s) [118.778862] [082/165] (886s left) kms_addfb_basic (no-handle) [118.869437] Starting subtest: no-handle [118.870490] Subtest no-handle: SUCCESS (0.000s) [119.002476] [083/165] (886s left) kms_addfb_basic (size-max) [119.120950] Starting subtest: size-max [119.122115] Subtest size-max: SUCCESS (0.000s) [119.218529] [084/165] (886s left) kms_addfb_basic (small-bo) [119.338252] Starting subtest: small-bo [119.339405] Subtest small-bo: SUCCESS (0.000s) [119.435911] [085/165] (885s left) kms_addfb_basic (tile-pitch-mismatch) [119.526070] Starting subtest: tile-pitch-mismatch [119.527205] Subtest tile-pitch-mismatch: SUCCESS (0.000s) [119.672573] [086/165] (885s left) kms_addfb_basic (too-high) [119.793175] Starting subtest: too-high [119.794357] Subtest too-high: SUCCESS (0.001s) [119.902843] [087/165] (885s left) kms_addfb_basic (too-wide) [120.021559] Starting subtest: too-wide [120.022749] Subtest too-wide: SUCCESS (0.000s) [120.116602] [088/165] (885s left) kms_addfb_basic (unused-handle) [120.207029] Starting subtest: unused-handle [120.208119] Subtest unused-handle: SUCCESS (0.000s) [120.337952] [089/165] (885s left) kms_addfb_basic (unused-modifier) [120.427338] Starting subtest: unused-modifier [120.428436] Subtest unused-modifier: SUCCESS (0.000s) [120.572737] [090/165] (884s left) kms_addfb_basic (unused-offsets) [120.662143] Starting subtest: unused-offsets [120.663272] Subtest unused-offsets: SUCCESS (0.000s) [120.787173] [091/165] (884s left) kms_addfb_basic (unused-pitches) [120.877331] Starting subtest: unused-pitches [120.878465] Subtest unused-pitches: SUCCESS (0.000s) [121.022522] [092/165] (884s left) kms_busy (basic) [121.146652] Starting subtest: basic [121.147851] Starting dynamic subtest: flip [122.154346] Dynamic subtest flip: SUCCESS (1.006s) [122.171738] Starting dynamic subtest: modeset [126.010022] Dynamic subtest modeset: SUCCESS (3.852s) [126.011205] Subtest basic: SUCCESS (4.861s) [126.943911] [093/165] (878s left) kms_prop_blob (basic) [127.037619] Starting subtest: basic [127.038809] Subtest basic: SUCCESS (0.000s) [127.124305] [094/165] (878s left) kms_cursor_legacy (basic-busy-flip-before-cursor-atomic) [127.242760] Starting subtest: basic-busy-flip-before-cursor-atomic [127.245071] Subtest basic-busy-flip-before-cursor-atomic: SKIP (0.000s) [127.327130] [095/165] (878s left) kms_cursor_legacy (basic-busy-flip-before-cursor-legacy) [127.445427] Starting subtest: basic-busy-flip-before-cursor-legacy [127.447975] Subtest basic-busy-flip-before-cursor-legacy: SKIP (0.000s) [127.522227] [096/165] (878s left) kms_cursor_legacy (basic-flip-after-cursor-atomic) [127.640035] Starting subtest: basic-flip-after-cursor-atomic [128.902953] Subtest basic-flip-after-cursor-atomic: SUCCESS (1.263s) [129.820046] [097/165] (875s left) kms_cursor_legacy (basic-flip-after-cursor-legacy) [129.937765] Starting subtest: basic-flip-after-cursor-legacy [131.246547] Subtest basic-flip-after-cursor-legacy: SUCCESS (1.309s) [132.187300] [098/165] (873s left) kms_cursor_legacy (basic-flip-after-cursor-varying-size) [132.305035] Starting subtest: basic-flip-after-cursor-varying-size [133.615414] Subtest basic-flip-after-cursor-varying-size: SUCCESS (1.310s) [134.554075] [099/165] (871s left) kms_cursor_legacy (basic-flip-before-cursor-atomic) [134.674376] Starting subtest: basic-flip-before-cursor-atomic [135.950654] Subtest basic-flip-before-cursor-atomic: SUCCESS (1.277s) [136.920181] [100/165] (868s left) kms_cursor_legacy (basic-flip-before-cursor-legacy) [137.039739] Starting subtest: basic-flip-before-cursor-legacy [138.348461] Subtest basic-flip-before-cursor-legacy: SUCCESS (1.309s) [139.290954] [101/165] (866s left) kms_cursor_legacy (basic-flip-before-cursor-varying-size) [139.408066] Starting subtest: basic-flip-before-cursor-varying-size [140.718106] Subtest basic-flip-before-cursor-varying-size: SUCCESS (1.310s) [141.656589] [102/165] (864s left) kms_dsc (dsc-basic) [141.776308] Subtest dsc-basic: SKIP (0.000s) [141.815072] [103/165] (864s left) kms_flip (basic-flip-vs-dpms) [141.935904] Starting subtest: basic-flip-vs-dpms [141.938442] Starting dynamic subtest: A-eDP1 [144.800450] Dynamic subtest A-eDP1: SUCCESS (2.860s) [144.816112] Starting dynamic subtest: B-eDP1 [147.235266] Dynamic subtest B-eDP1: SUCCESS (2.432s) [147.250731] Starting dynamic subtest: C-eDP1 [149.647369] Dynamic subtest C-eDP1: SUCCESS (2.415s) [149.652084] Subtest basic-flip-vs-dpms: SUCCESS (7.716s) [150.563922] [104/165] (855s left) kms_flip (basic-flip-vs-modeset) [150.685776] Starting subtest: basic-flip-vs-modeset [150.688639] Starting dynamic subtest: A-eDP1 [153.548986] Dynamic subtest A-eDP1: SUCCESS (2.859s) [153.566270] Starting dynamic subtest: B-eDP1 [155.918076] Dynamic subtest B-eDP1: SUCCESS (2.368s) [155.934593] Starting dynamic subtest: C-eDP1 [158.288980] Dynamic subtest C-eDP1: SUCCESS (2.370s) [158.291987] Subtest basic-flip-vs-modeset: SUCCESS (7.606s) [159.258473] [105/165] (846s left) kms_flip (basic-flip-vs-wf_vblank) [159.380676] Starting subtest: basic-flip-vs-wf_vblank [159.383860] Starting dynamic subtest: A-eDP1 [161.720224] Dynamic subtest A-eDP1: SUCCESS (2.336s) [161.743147] Starting dynamic subtest: B-eDP1 [164.008542] Dynamic subtest B-eDP1: SUCCESS (2.286s) [164.028021] Starting dynamic subtest: C-eDP1 [166.248276] Dynamic subtest C-eDP1: SUCCESS (2.237s) [166.253034] Subtest basic-flip-vs-wf_vblank: SUCCESS (6.874s) [167.578764] [106/165] (838s left) kms_flip (basic-plain-flip) [167.699425] Starting subtest: basic-plain-flip [167.702529] Starting dynamic subtest: A-eDP1 [169.757553] Dynamic subtest A-eDP1: SUCCESS (2.054s) [169.776952] Starting dynamic subtest: B-eDP1 [171.723532] Dynamic subtest B-eDP1: SUCCESS (1.963s) [171.741781] Starting dynamic subtest: C-eDP1 [173.708422] Dynamic subtest C-eDP1: SUCCESS (1.982s) [173.713944] Subtest basic-plain-flip: SUCCESS (6.015s) [175.003563] [107/165] (830s left) kms_force_connector_basic (force-connector-state) [175.097795] Starting subtest: force-connector-state [175.694779] Subtest force-connector-state: SUCCESS (0.596s) [176.769141] [108/165] (829s left) kms_force_connector_basic (force-edid) [176.863282] Starting subtest: force-edid [177.123935] Subtest force-edid: SUCCESS (0.260s) [177.268586] [109/165] (828s left) kms_force_connector_basic (force-load-detect) [177.360474] Starting subtest: force-load-detect [177.363026] Subtest force-load-detect: SKIP (0.000s) [177.478261] [110/165] (828s left) kms_force_connector_basic (prune-stale-modes) [177.571437] Starting subtest: prune-stale-modes [177.889038] Subtest prune-stale-modes: SUCCESS (0.318s) [178.012107] [111/165] (828s left) kms_frontbuffer_tracking (basic) [178.140843] Starting subtest: basic [181.464566] Subtest basic: SUCCESS (3.323s) [181.590739] [112/165] (824s left) kms_hdmi_inject (inject-audio) [182.005082] Starting subtest: inject-audio [182.253985] Subtest inject-audio: SUCCESS (0.246s) [182.944207] [113/165] (823s left) kms_pipe_crc_basic (compare-crc-sanitycheck-xr24) [183.064977] Starting subtest: compare-crc-sanitycheck-xr24 [183.066172] Starting dynamic subtest: pipe-A-eDP-1 [183.751770] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.684s) [183.771344] Starting dynamic subtest: pipe-B-eDP-1 [185.144709] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.389s) [185.162805] Starting dynamic subtest: pipe-C-eDP-1 [186.550085] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.401s) [186.551239] Subtest compare-crc-sanitycheck-xr24: SUCCESS (3.484s) [187.483629] [114/165] (818s left) kms_pipe_crc_basic (compare-crc-sanitycheck-nv12) [187.604286] Starting subtest: compare-crc-sanitycheck-nv12 [187.605453] Starting dynamic subtest: pipe-A-eDP-1 [188.550846] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.940s) [188.567413] Starting dynamic subtest: pipe-B-eDP-1 [189.944452] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.395s) [189.966554] Starting dynamic subtest: pipe-C-eDP-1 [191.345568] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.396s) [191.346812] Subtest compare-crc-sanitycheck-nv12: SUCCESS (3.742s) [192.284901] [115/165] (813s left) kms_pipe_crc_basic (hang-read-crc) [192.404309] Starting subtest: hang-read-crc [192.407289] Starting dynamic subtest: pipe-A-eDP-1 [194.829865] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.423s) [194.848286] Starting dynamic subtest: pipe-B-eDP-1 [197.930780] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.098s) [197.949290] Starting dynamic subtest: pipe-C-eDP-1 [200.986274] Dynamic subtest pipe-C-eDP-1: SUCCESS (3.051s) [200.987500] Subtest hang-read-crc: SUCCESS (8.582s) [201.947438] [116/165] (804s left) kms_pipe_crc_basic (nonblocking-crc) [202.068208] Starting subtest: nonblocking-crc [202.071401] Starting dynamic subtest: pipe-A-eDP-1 [202.956056] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.885s) [202.974383] Starting dynamic subtest: pipe-B-eDP-1 [204.575509] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.616s) [204.594428] Starting dynamic subtest: pipe-C-eDP-1 [206.136404] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.556s) [206.137689] Subtest nonblocking-crc: SUCCESS (4.069s) [207.067132] [117/165] (799s left) kms_pipe_crc_basic (nonblocking-crc-frame-sequence) [207.187151] Starting subtest: nonblocking-crc-frame-sequence [207.190228] Starting dynamic subtest: pipe-A-eDP-1 [208.079355] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.889s) [208.097547] Starting dynamic subtest: pipe-B-eDP-1 [209.699370] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.616s) [209.718135] Starting dynamic subtest: pipe-C-eDP-1 [211.249167] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.546s) [211.250428] Subtest nonblocking-crc-frame-sequence: SUCCESS (4.062s) [212.184810] [118/165] (794s left) kms_pipe_crc_basic (read-crc) [212.306391] Starting subtest: read-crc [212.309390] Starting dynamic subtest: pipe-A-eDP-1 [213.130891] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.821s) [213.150080] Starting dynamic subtest: pipe-B-eDP-1 [214.699856] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.565s) [214.718403] Starting dynamic subtest: pipe-C-eDP-1 [216.209864] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.506s) [216.211096] Subtest read-crc: SUCCESS (3.904s) [217.179045] [119/165] (789s left) kms_pipe_crc_basic (read-crc-frame-sequence) [217.300792] Starting subtest: read-crc-frame-sequence [217.302130] Starting dynamic subtest: pipe-A-eDP-1 [218.124458] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.822s) [218.144867] Starting dynamic subtest: pipe-B-eDP-1 [219.695991] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.565s) [219.714550] Starting dynamic subtest: pipe-C-eDP-1 [221.187318] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.487s) [221.188571] Subtest read-crc-frame-sequence: SUCCESS (3.887s) [222.107164] [120/165] (784s left) kms_pm_backlight (basic-brightness) [222.228569] Starting subtest: basic-brightness [222.335916] Starting dynamic subtest: eDP-1 [222.906391] Dynamic subtest eDP-1: SUCCESS (0.568s) [222.907628] Subtest basic-brightness: SUCCESS (0.675s) [223.841587] [121/165] (782s left) kms_pm_rpm (basic-pci-d3-state) [225.675876] Starting subtest: basic-pci-d3-state [230.064159] Subtest basic-pci-d3-state: SUCCESS (4.387s) [230.268984] [122/165] (776s left) kms_pm_rpm (basic-rte) [230.357204] Starting subtest: basic-rte [236.468458] Subtest basic-rte: SUCCESS (6.109s) [237.960203] [123/165] (768s left) kms_psr (psr-primary-page-flip) [238.082773] Starting subtest: psr-primary-page-flip [238.086138] Starting dynamic subtest: eDP-1 [241.889879] Dynamic subtest eDP-1: SUCCESS (3.803s) [241.891159] Subtest psr-primary-page-flip: SUCCESS (3.806s) [242.844697] [124/165] (763s left) kms_psr (psr-cursor-plane-move) [242.968022] Starting subtest: psr-cursor-plane-move [242.969836] Starting dynamic subtest: eDP-1 [246.776409] Dynamic subtest eDP-1: SUCCESS (3.807s) [246.777561] Subtest psr-cursor-plane-move: SUCCESS (3.810s) [247.709601] [125/165] (758s left) kms_psr (psr-sprite-plane-onoff) [247.830798] Starting subtest: psr-sprite-plane-onoff [247.832087] Starting dynamic subtest: eDP-1 [251.742336] Dynamic subtest eDP-1: SUCCESS (3.911s) [251.743594] Subtest psr-sprite-plane-onoff: SUCCESS (3.914s) [252.699978] [126/165] (753s left) kms_psr (psr-primary-mmap-gtt) [252.821347] Starting subtest: psr-primary-mmap-gtt [252.822489] Starting dynamic subtest: eDP-1 [256.633734] Dynamic subtest eDP-1: SUCCESS (3.806s) [256.634965] Subtest psr-primary-mmap-gtt: SUCCESS (3.809s) [257.564228] [127/165] (749s left) kms_setmode (basic-clone-single-crtc) [257.657781] Starting subtest: basic-clone-single-crtc [257.661690] Subtest basic-clone-single-crtc: SKIP (0.000s) [257.745147] [128/165] (748s left) i915_pm_rps (basic-api) [257.843206] Starting subtest: basic-api [257.847583] Subtest basic-api: SUCCESS (0.005s) [257.947801] [129/165] (748s left) prime_self_import (basic-llseek-bad) [258.038205] Starting subtest: basic-llseek-bad [258.040412] Subtest basic-llseek-bad: SUCCESS (0.003s) [258.128926] [130/165] (748s left) prime_self_import (basic-llseek-size) [258.217468] Starting subtest: basic-llseek-size [258.221954] Subtest basic-llseek-size: SUCCESS (0.004s) [258.314039] [131/165] (748s left) prime_self_import (basic-with_fd_dup) [258.401164] Starting subtest: basic-with_fd_dup [258.405979] Subtest basic-with_fd_dup: SUCCESS (0.005s) [258.514699] [132/165] (748s left) prime_self_import (basic-with_one_bo) [258.602729] Starting subtest: basic-with_one_bo [258.607513] Subtest basic-with_one_bo: SUCCESS (0.005s) [258.692939] [133/165] (748s left) prime_self_import (basic-with_one_bo_two_files) [258.780707] Starting subtest: basic-with_one_bo_two_files [258.785567] Subtest basic-with_one_bo_two_files: SUCCESS (0.004s) [258.881415] [134/165] (747s left) prime_self_import (basic-with_two_bos) [258.969996] Starting subtest: basic-with_two_bos [258.974624] Subtest basic-with_two_bos: SUCCESS (0.004s) [259.082854] [135/165] (747s left) prime_vgem (basic-fence-flip) [259.212524] Starting subtest: basic-fence-flip [259.754345] Subtest basic-fence-flip: SUCCESS (0.542s) [259.885257] [136/165] (746s left) prime_vgem (basic-fence-mmap) [260.009157] Starting subtest: basic-fence-mmap [260.059140] Subtest basic-fence-mmap: SUCCESS (0.050s) [260.154218] [137/165] (746s left) prime_vgem (basic-fence-read) [260.274329] Starting subtest: basic-fence-read [260.349825] Subtest basic-fence-read: SUCCESS (0.075s) [260.451120] [138/165] (746s left) prime_vgem (basic-gtt) [260.564687] Starting subtest: basic-gtt [260.589636] Subtest basic-gtt: SUCCESS (0.025s) [260.700516] [139/165] (746s left) prime_vgem (basic-read) [260.814722] Starting subtest: basic-read [260.852668] Subtest basic-read: SUCCESS (0.037s) [260.956267] [140/165] (746s left) prime_vgem (basic-write) [261.075507] Starting subtest: basic-write [261.119651] Subtest basic-write: SUCCESS (0.043s) [261.216606] [141/165] (745s left) vgem_basic (setversion) [261.324262] Starting subtest: setversion [261.326989] Subtest setversion: SUCCESS (0.000s) [261.399702] [142/165] (745s left) vgem_basic (create) [261.490829] Starting subtest: create [261.492154] Subtest create: SUCCESS (0.000s) [261.567214] [143/165] (745s left) vgem_basic (debugfs) [261.674759] Starting subtest: debugfs [261.676093] Subtest debugfs: SUCCESS (0.001s) [261.751491] [144/165] (745s left) vgem_basic (dmabuf-export) [261.858506] Starting subtest: dmabuf-export [261.863326] Subtest dmabuf-export: SUCCESS (0.003s) [261.968226] [145/165] (745s left) vgem_basic (dmabuf-fence) [262.075937] Starting subtest: dmabuf-fence [262.077588] Subtest dmabuf-fence: SUCCESS (0.002s) [262.150363] [146/165] (745s left) vgem_basic (dmabuf-fence-before) [262.242511] Starting subtest: dmabuf-fence-before [262.243654] Subtest dmabuf-fence-before: SUCCESS (0.000s) [262.318897] [147/165] (744s left) vgem_basic (dmabuf-mmap) [262.425645] Starting subtest: dmabuf-mmap [262.450365] Subtest dmabuf-mmap: SUCCESS (0.026s) [262.514075] [148/165] (744s left) vgem_basic (mmap) [262.608626] Starting subtest: mmap [262.625470] Subtest mmap: SUCCESS (0.017s) [262.699254] [149/165] (744s left) vgem_basic (second-client) [262.793191] Starting subtest: second-client [262.826613] Subtest second-client: SUCCESS (0.033s) [262.902456] [150/165] (744s left) vgem_basic (sysfs) [263.009488] Starting subtest: sysfs [263.010827] Subtest sysfs: SUCCESS (0.001s) [263.085990] [151/165] (744s left) core_hotunplug (unbind-rebind) [263.225932] Starting subtest: unbind-rebind [267.768674] Subtest unbind-rebind: SUCCESS (4.543s) [267.804933] [152/165] (739s left) vgem_basic (unload) [267.898925] Starting subtest: unload [296.932182] Subtest unload: SUCCESS (28.999s) [297.026218] [153/165] (710s left) i915_module_load (reload) [297.114641] Starting subtest: reload [300.418330] Subtest reload: SUCCESS (3.304s) [300.447727] [154/165] (706s left) gem_lmem_swapping (basic) [300.557269] Subtest basic: SKIP (0.000s) [300.602869] [155/165] (706s left) gem_lmem_swapping (parallel-random-engines) [300.699779] Subtest parallel-random-engines: SKIP (0.000s) [300.752706] [156/165] (706s left) gem_lmem_swapping (random-engines) [300.848269] Subtest random-engines: SKIP (0.000s) [300.905248] [157/165] (706s left) gem_lmem_swapping (verify-random) [301.000716] Subtest verify-random: SKIP (0.000s) [301.054401] [158/165] (706s left) i915_pm_rpm (module-reload) [313.525714] Starting subtest: module-reload [342.743081] Subtest module-reload: SUCCESS (29.210s) [342.766153] [159/165] (664s left) i915_selftest (live) [342.868885] Starting subtest: live [342.870192] Starting dynamic subtest: sanitycheck [344.752652] Dynamic subtest sanitycheck: SUCCESS (1.875s) [344.767604] Starting dynamic subtest: uncore [346.619560] Dynamic subtest uncore: SUCCESS (1.863s) [346.634416] Starting dynamic subtest: workarounds [348.723051] Dynamic subtest workarounds: SUCCESS (2.099s) [348.738184] Starting dynamic subtest: gt_engines [351.044570] Dynamic subtest gt_engines: SUCCESS (2.318s) [351.059317] Starting dynamic subtest: gt_timelines [363.637624] Dynamic subtest gt_timelines: SUCCESS (12.590s) [363.651936] Starting dynamic subtest: gt_contexts [365.613542] Dynamic subtest gt_contexts: SUCCESS (1.972s) [365.627927] Starting dynamic subtest: gt_lrc [369.970038] Dynamic subtest gt_lrc: SUCCESS (4.352s) [369.984829] Starting dynamic subtest: gt_mocs [371.951594] Dynamic subtest gt_mocs: SUCCESS (1.979s) [371.966484] Starting dynamic subtest: gt_pm [377.026071] Dynamic subtest gt_pm: SUCCESS (5.071s) [377.040981] Starting dynamic subtest: gt_heartbeat [378.934348] Dynamic subtest gt_heartbeat: SUCCESS (1.905s) [378.949136] Starting dynamic subtest: gt_tlb [382.053490] Dynamic subtest gt_tlb: SUCCESS (3.116s) [382.068329] Starting dynamic subtest: requests [389.748683] Dynamic subtest requests: SUCCESS (7.692s) [389.763259] Starting dynamic subtest: migrate [394.325685] Dynamic subtest migrate: SUCCESS (4.573s) [394.340510] Starting dynamic subtest: active [396.222400] Dynamic subtest active: SUCCESS (1.894s) [396.237227] Starting dynamic subtest: objects [399.960431] Dynamic subtest objects: SUCCESS (3.735s) [399.975478] Starting dynamic subtest: mman [407.323674] Dynamic subtest mman: SUCCESS (7.359s) [407.338234] Starting dynamic subtest: dmabuf [409.228742] Dynamic subtest dmabuf: SUCCESS (1.901s) [409.243629] Starting dynamic subtest: vma [411.054828] Dynamic subtest vma: SUCCESS (1.822s) [411.069899] Starting dynamic subtest: coherency [417.607508] Dynamic subtest coherency: SUCCESS (6.549s) [417.622443] Starting dynamic subtest: gtt [427.006508] Dynamic subtest gtt: SUCCESS (9.395s) [427.021265] Starting dynamic subtest: gem [429.050507] Dynamic subtest gem: SUCCESS (2.040s) [429.065558] Starting dynamic subtest: evict [432.867574] Dynamic subtest evict: SUCCESS (3.814s) [432.882353] Starting dynamic subtest: hugepages [440.651923] Dynamic subtest hugepages: SUCCESS (7.780s) [440.667073] Starting dynamic subtest: gem_contexts [455.893135] Dynamic subtest gem_contexts: SUCCESS (15.238s) [455.908633] Starting dynamic subtest: client [457.797606] Dynamic subtest client: SUCCESS (1.902s) [457.813052] Starting dynamic subtest: gem_migrate [459.647699] Dynamic subtest gem_migrate: SUCCESS (1.847s) [459.663042] Starting dynamic subtest: reset [465.012619] Dynamic subtest reset: SUCCESS (5.361s) [465.028350] Starting dynamic subtest: memory_region [466.847573] Dynamic subtest memory_region: SUCCESS (1.831s) [466.863251] Starting dynamic subtest: hangcheck [491.275586] Dynamic subtest hangcheck: SUCCESS (24.425s) [491.290899] Starting dynamic subtest: execlists [501.337581] Dynamic subtest execlists: SUCCESS (10.058s) [501.352945] Starting dynamic subtest: ring_submission [503.166495] Dynamic subtest ring_submission: SUCCESS (1.825s) [503.181889] Starting dynamic subtest: perf [505.105267] Dynamic subtest perf: SUCCESS (1.935s) [505.120891] Starting dynamic subtest: slpc [506.945650] Dynamic subtest slpc: SUCCESS (1.837s) [506.960926] Starting dynamic subtest: guc [508.798965] Dynamic subtest guc: SUCCESS (1.850s) [508.814473] Starting dynamic subtest: guc_multi_lrc [510.636060] Dynamic subtest guc_multi_lrc: SUCCESS (1.837s) [510.650771] Starting dynamic subtest: guc_hang [512.505431] Dynamic subtest guc_hang: SUCCESS (1.862s) [512.521199] Starting dynamic subtest: late_gt_pm [514.437792] Dynamic subtest late_gt_pm: SUCCESS (1.929s) [514.439144] Subtest live: SUCCESS (171.563s) [514.464970] [160/165] (493s left) dmabuf (all-tests) [514.561606] Starting subtest: all-tests [514.562857] Starting dynamic subtest: sanitycheck [514.622720] Dynamic subtest sanitycheck: SUCCESS (0.059s) [514.641688] Starting dynamic subtest: dma_fence [514.808730] Dynamic subtest dma_fence: SUCCESS (0.182s) [514.826734] Starting dynamic subtest: dma_fence_chain [533.303927] Dynamic subtest dma_fence_chain: SUCCESS (18.483s) [533.316445] Starting dynamic subtest: dma_fence_unwrap [533.370918] Dynamic subtest dma_fence_unwrap: SUCCESS (0.071s) [533.390046] Starting dynamic subtest: dma_resv [533.443759] Dynamic subtest dma_resv: SUCCESS (0.069s) [533.446097] Subtest all-tests: SUCCESS (18.883s) [533.476162] [161/165] (474s left) i915_suspend (basic-s2idle-without-i915) [533.566388] Starting subtest: basic-s2idle-without-i915 [556.948556] Subtest basic-s2idle-without-i915: SUCCESS (8.306s) [557.044849] [162/165] (465s left) i915_suspend (basic-s3-without-i915) [557.134508] Starting subtest: basic-s3-without-i915 [581.045334] Subtest basic-s3-without-i915: SUCCESS (7.155s) [581.097423] [163/165] (458s left) gem_exec_suspend (basic-s0) [581.218652] Starting subtest: basic-S0 [581.219841] Starting dynamic subtest: smem [600.953015] Dynamic subtest smem: SUCCESS (3.850s) [600.954424] Subtest basic-S0: SUCCESS (3.852s) [601.156858] [164/165] (454s left) gem_exec_suspend (basic-s3) [601.267513] Starting subtest: basic-S3 [601.268844] Starting dynamic subtest: smem [619.885817] Dynamic subtest smem: SUCCESS (3.564s) [619.887148] Subtest basic-S3: SUCCESS (3.566s) [620.095684] [165/165] (450s left) kms_pipe_crc_basic (suspend-read-crc) [620.216870] Starting subtest: suspend-read-crc [620.218314] Starting dynamic subtest: pipe-A-eDP-1 [637.889656] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.523s) [637.911213] Starting dynamic subtest: pipe-B-eDP-1 [656.830457] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.155s) [656.853266] Starting dynamic subtest: pipe-C-eDP-1 [674.849372] Dynamic subtest pipe-C-eDP-1: SUCCESS (3.128s) [674.850715] Subtest suspend-read-crc: SUCCESS (8.818s) [675.725797] Closing watchdogs Done.