[32.049608] Initializing watchdogs [32.049656] /dev/watchdog0 [32.054036] [001/171] (960s left) i915_module_load (load) [32.088361] Starting subtest: load [34.483327] Subtest load: SUCCESS (2.395s) [34.493208] [002/171] (958s left) core_auth (basic-auth) [34.606408] Starting subtest: basic-auth [34.607209] Subtest basic-auth: SUCCESS (0.001s) [34.667639] [003/171] (957s left) debugfs_test (read_all_entries) [34.729204] Starting subtest: read_all_entries [35.867963] Subtest read_all_entries: SUCCESS (1.138s) [35.971695] [004/171] (956s left) debugfs_test (basic-hwmon) [36.035118] Starting subtest: basic-hwmon [36.038393] Subtest basic-hwmon: SUCCESS (0.002s) [36.134678] [005/171] (956s left) fbdev (eof) [36.200303] Starting subtest: eof [36.201088] Subtest eof: SUCCESS (0.000s) [36.267810] [006/171] (956s left) fbdev (info) [36.322361] Starting subtest: info [36.323133] Subtest info: SUCCESS (0.000s) [36.401084] [007/171] (956s left) fbdev (nullptr) [36.467717] Starting subtest: nullptr [36.468541] Subtest nullptr: SUCCESS (0.000s) [36.534773] [008/171] (956s left) fbdev (read) [36.600378] Starting subtest: read [51.046884] Subtest read: SUCCESS (14.437s) [51.084309] [009/171] (941s left) fbdev (write) [51.134223] Starting subtest: write [60.785376] Subtest write: SUCCESS (9.642s) [60.833813] [010/171] (931s left) gem_basic (bad-close) [60.878314] Starting subtest: bad-close [60.880139] Subtest bad-close: SUCCESS (0.000s) [60.937436] [011/171] (931s left) gem_basic (create-close) [60.982656] Starting subtest: create-close [60.984466] Subtest create-close: SUCCESS (0.000s) [61.057348] [012/171] (931s left) gem_basic (create-fd-close) [61.103627] Starting subtest: create-fd-close [61.105263] Subtest create-fd-close: SUCCESS (0.000s) [61.188753] [013/171] (931s left) gem_busy (busy@all-engines) [61.238812] Starting subtest: busy [61.239854] Starting dynamic subtest: all-engines [61.310864] Dynamic subtest all-engines: SUCCESS (0.071s) [61.313080] Subtest busy: SUCCESS (0.071s) [61.673927] [014/171] (931s left) gem_close_race (basic-process) [61.749797] Starting subtest: basic-process [61.803514] Subtest basic-process: SUCCESS (0.053s) [62.008518] [015/171] (930s left) gem_close_race (basic-threads) [62.080482] Starting subtest: basic-threads [63.295355] Subtest basic-threads: SUCCESS (1.215s) [63.491319] [016/171] (929s left) gem_ctx_create (basic) [63.542195] Starting subtest: basic [63.543147] Subtest basic: SUCCESS (0.000s) [63.728998] [017/171] (928s left) gem_ctx_create (basic-files) [63.776497] Starting subtest: basic-files [65.784453] Subtest basic-files: SUCCESS (2.008s) [66.586062] [018/171] (926s left) gem_ctx_exec (basic) [66.632800] Starting subtest: basic [66.635489] Subtest basic: SUCCESS (0.003s) [66.736349] [019/171] (926s left) gem_exec_basic (basic) [66.784247] Starting subtest: basic [66.785142] Starting dynamic subtest: rcs0-smem [66.785976] Dynamic subtest rcs0-smem: SUCCESS (0.001s) [66.789855] Starting dynamic subtest: bcs0-smem [66.790780] Dynamic subtest bcs0-smem: SUCCESS (0.000s) [66.795072] Starting dynamic subtest: vcs0-smem [66.795912] Dynamic subtest vcs0-smem: SUCCESS (0.000s) [66.799388] Starting dynamic subtest: vcs1-smem [66.800219] Dynamic subtest vcs1-smem: SUCCESS (0.000s) [66.804149] Starting dynamic subtest: vecs0-smem [66.810720] Dynamic subtest vecs0-smem: SUCCESS (0.000s) [66.815492] Starting dynamic subtest: vecs1-smem [66.816720] Dynamic subtest vecs1-smem: SUCCESS (0.001s) [66.820192] Starting dynamic subtest: ccs0-smem [66.821031] Dynamic subtest ccs0-smem: SUCCESS (0.000s) [66.824652] Starting dynamic subtest: rcs0-lmem0 [66.825605] Dynamic subtest rcs0-lmem0: SUCCESS (0.000s) [66.829282] Starting dynamic subtest: bcs0-lmem0 [66.830115] Dynamic subtest bcs0-lmem0: SUCCESS (0.000s) [66.833606] Starting dynamic subtest: vcs0-lmem0 [66.834384] Dynamic subtest vcs0-lmem0: SUCCESS (0.000s) [66.838146] Starting dynamic subtest: vcs1-lmem0 [66.839034] Dynamic subtest vcs1-lmem0: SUCCESS (0.000s) [66.843206] Starting dynamic subtest: vecs0-lmem0 [66.844032] Dynamic subtest vecs0-lmem0: SUCCESS (0.000s) [66.847866] Starting dynamic subtest: vecs1-lmem0 [66.849086] Dynamic subtest vecs1-lmem0: SUCCESS (0.000s) [66.852533] Starting dynamic subtest: ccs0-lmem0 [66.853338] Dynamic subtest ccs0-lmem0: SUCCESS (0.000s) [66.854169] Subtest basic: SUCCESS (0.009s) [66.974129] [020/171] (925s left) gem_exec_create (basic) [67.026272] Starting subtest: basic [67.027247] Starting dynamic subtest: smem [69.122066] Dynamic subtest smem: SUCCESS (2.095s) [69.128649] Starting dynamic subtest: lmem0 [71.218153] Dynamic subtest lmem0: SUCCESS (2.096s) [71.219181] Subtest basic: SUCCESS (4.192s) [71.388698] [021/171] (921s left) gem_exec_fence (basic-busy) [71.557288] Starting subtest: basic-busy [71.558562] Starting dynamic subtest: rcs0 [71.667755] Dynamic subtest rcs0: SUCCESS (0.109s) [71.677099] Starting dynamic subtest: bcs0 [71.714863] Dynamic subtest bcs0: SUCCESS (0.048s) [71.720497] Starting dynamic subtest: vcs0 [71.771582] Dynamic subtest vcs0: SUCCESS (0.056s) [71.780533] Starting dynamic subtest: vcs1 [71.828928] Dynamic subtest vcs1: SUCCESS (0.057s) [71.842322] Starting dynamic subtest: vecs0 [71.880616] Dynamic subtest vecs0: SUCCESS (0.051s) [71.893052] Starting dynamic subtest: vecs1 [71.930330] Dynamic subtest vecs1: SUCCESS (0.050s) [71.941355] Starting dynamic subtest: ccs0 [71.981661] Dynamic subtest ccs0: SUCCESS (0.050s) [71.983964] Subtest basic-busy: SUCCESS (0.424s) [72.622754] [022/171] (920s left) gem_exec_fence (basic-wait) [72.798200] Starting subtest: basic-wait [72.799066] Starting dynamic subtest: rcs0 [72.872107] Dynamic subtest rcs0: SUCCESS (0.082s) [72.881386] Starting dynamic subtest: bcs0 [72.921080] Dynamic subtest bcs0: SUCCESS (0.048s) [72.932023] Starting dynamic subtest: vcs0 [72.970723] Dynamic subtest vcs0: SUCCESS (0.050s) [72.983133] Starting dynamic subtest: vcs1 [73.021761] Dynamic subtest vcs1: SUCCESS (0.051s) [73.030696] Starting dynamic subtest: vecs0 [73.078100] Dynamic subtest vecs0: SUCCESS (0.056s) [73.090956] Starting dynamic subtest: vecs1 [73.130500] Dynamic subtest vecs1: SUCCESS (0.052s) [73.139915] Starting dynamic subtest: ccs0 [73.181485] Dynamic subtest ccs0: SUCCESS (0.050s) [73.183542] Subtest basic-wait: SUCCESS (0.392s) [73.789444] [023/171] (918s left) gem_exec_fence (basic-await) [73.958036] Starting subtest: basic-await [73.959311] Starting dynamic subtest: rcs0 [74.052092] Dynamic subtest rcs0: SUCCESS (0.093s) [74.058222] Starting dynamic subtest: bcs0 [74.126232] Dynamic subtest bcs0: SUCCESS (0.075s) [74.134594] Starting dynamic subtest: vcs0 [74.204321] Dynamic subtest vcs0: SUCCESS (0.077s) [74.214187] Starting dynamic subtest: vcs1 [74.282979] Dynamic subtest vcs1: SUCCESS (0.077s) [74.299897] Starting dynamic subtest: vecs0 [74.358632] Dynamic subtest vecs0: SUCCESS (0.076s) [74.365933] Starting dynamic subtest: vecs1 [74.435164] Dynamic subtest vecs1: SUCCESS (0.077s) [74.446825] Starting dynamic subtest: ccs0 [74.516395] Dynamic subtest ccs0: SUCCESS (0.081s) [74.518706] Subtest basic-await: SUCCESS (0.557s) [75.121537] [024/171] (917s left) gem_exec_fence (nb-await) [75.297295] Starting subtest: nb-await [75.298090] Starting dynamic subtest: rcs0 [75.369491] Dynamic subtest rcs0: SUCCESS (0.080s) [75.377890] Starting dynamic subtest: bcs0 [75.434635] Dynamic subtest bcs0: SUCCESS (0.064s) [75.444154] Starting dynamic subtest: vcs0 [75.504756] Dynamic subtest vcs0: SUCCESS (0.070s) [75.513099] Starting dynamic subtest: vcs1 [75.567912] Dynamic subtest vcs1: SUCCESS (0.063s) [75.575248] Starting dynamic subtest: vecs0 [75.629079] Dynamic subtest vecs0: SUCCESS (0.061s) [75.635412] Starting dynamic subtest: vecs1 [75.691872] Dynamic subtest vecs1: SUCCESS (0.061s) [75.702591] Starting dynamic subtest: ccs0 [75.759932] Dynamic subtest ccs0: SUCCESS (0.067s) [75.762868] Subtest nb-await: SUCCESS (0.470s) [76.390174] [025/171] (916s left) gem_exec_gttfill (basic) [76.443619] Starting subtest: basic [80.412900] Subtest basic: SUCCESS (3.960s) [80.664904] [026/171] (912s left) gem_exec_parallel (engines) [80.749642] Starting subtest: engines [80.750412] Starting dynamic subtest: basic [82.319036] Dynamic subtest basic: SUCCESS (1.569s) [82.326570] Starting dynamic subtest: contexts [84.809773] Dynamic subtest contexts: SUCCESS (2.481s) [84.815256] Starting dynamic subtest: fds [87.352529] Dynamic subtest fds: SUCCESS (2.543s) [87.357045] Starting dynamic subtest: userptr [88.796184] Dynamic subtest userptr: SUCCESS (1.453s) [88.797900] Subtest engines: SUCCESS (8.046s) [89.014123] [027/171] (903s left) gem_exec_store (basic) [89.064833] Starting subtest: basic [89.177780] Subtest basic: SUCCESS (0.112s) [89.372950] [028/171] (903s left) gem_flink_basic (bad-flink) [89.428335] Starting subtest: bad-flink [89.429991] Subtest bad-flink: SUCCESS (0.000s) [89.491119] [029/171] (903s left) gem_flink_basic (bad-open) [89.537009] Starting subtest: bad-open [89.537821] Subtest bad-open: SUCCESS (0.000s) [89.603190] [030/171] (903s left) gem_flink_basic (basic) [89.647936] Starting subtest: basic [89.648759] Subtest basic: SUCCESS (0.000s) [89.738074] [031/171] (903s left) gem_flink_basic (double-flink) [89.784786] Starting subtest: double-flink [89.785768] Subtest double-flink: SUCCESS (0.000s) [89.874155] [032/171] (903s left) gem_flink_basic (flink-lifetime) [89.920617] Starting subtest: flink-lifetime [89.921600] Subtest flink-lifetime: SUCCESS (0.001s) [90.006463] [033/171] (902s left) gem_huc_copy (huc-copy) [90.065668] Starting subtest: huc-copy [90.070164] Subtest huc-copy: SUCCESS (0.005s) [90.190025] [034/171] (902s left) gem_linear_blits (basic) [90.283959] Starting subtest: basic [90.305892] Subtest basic: SUCCESS (0.022s) [90.436225] [035/171] (902s left) gem_mmap (basic) [90.517805] Subtest basic: SKIP (0.000s) [90.540224] [036/171] (902s left) gem_mmap_gtt (basic) [90.589738] Subtest basic: SKIP (0.000s) [90.607204] [037/171] (902s left) gem_render_linear_blits (basic) [90.652460] Starting subtest: basic [90.718307] Subtest basic: SUCCESS (0.066s) [90.793349] [038/171] (902s left) gem_render_tiled_blits (basic) [90.843872] Subtest basic: SKIP (0.000s) [90.874253] [039/171] (902s left) gem_ringfill (basic-all) [91.264506] Starting subtest: basic-all [93.139946] Subtest basic-all: SUCCESS (1.867s) [93.243986] [040/171] (899s left) gem_softpin (allocator-basic) [93.300166] Starting subtest: allocator-basic [93.430270] Subtest allocator-basic: SUCCESS (0.120s) [93.523031] [041/171] (899s left) gem_softpin (allocator-basic-reserve) [93.573180] Starting subtest: allocator-basic-reserve [93.687204] Subtest allocator-basic-reserve: SUCCESS (0.114s) [93.787129] [042/171] (899s left) gem_softpin (safe-alignment) [93.837549] Starting subtest: safe-alignment [93.873695] Subtest safe-alignment: SUCCESS (0.036s) [93.971806] [043/171] (899s left) gem_sync (basic-all) [94.026232] Starting subtest: basic-all [96.243561] Subtest basic-all: SUCCESS (2.218s) [96.425064] [044/171] (896s left) gem_sync (basic-each) [96.479628] Starting subtest: basic-each [98.732708] Subtest basic-each: SUCCESS (2.254s) [98.909264] [045/171] (894s left) gem_tiled_blits (basic) [98.959824] Subtest basic: SKIP (0.000s) [98.991541] [046/171] (894s left) gem_tiled_fence_blits (basic) [99.041741] Subtest basic: SKIP (0.000s) [99.075021] [047/171] (893s left) gem_tiled_pread_basic [99.160050] [048/171] (893s left) gem_wait (busy@all-engines) [99.213262] Starting subtest: busy [99.214145] Starting dynamic subtest: all-engines [99.777648] Dynamic subtest all-engines: SUCCESS (0.564s) [99.778847] Subtest busy: SUCCESS (0.564s) [99.990681] [049/171] (893s left) gem_wait (wait@all-engines) [100.045823] Starting subtest: wait [100.046780] Starting dynamic subtest: all-engines [101.121607] Dynamic subtest all-engines: SUCCESS (1.076s) [101.123269] Subtest wait: SUCCESS (1.076s) [101.340604] [050/171] (891s left) i915_getparams_basic (basic-eu-total) [101.388079] Starting subtest: basic-eu-total [101.389720] Subtest basic-eu-total: SUCCESS (0.000s) [101.456996] [051/171] (891s left) i915_getparams_basic (basic-subslice-total) [101.503027] Starting subtest: basic-subslice-total [101.504602] Subtest basic-subslice-total: SUCCESS (0.000s) [101.572124] [052/171] (891s left) i915_hangman (error-state-basic) [101.624600] Starting subtest: error-state-basic [101.870615] Subtest error-state-basic: SUCCESS (0.246s) [101.939962] [053/171] (891s left) i915_pciid [102.057516] [054/171] (891s left) kms_addfb_basic (addfb25-bad-modifier) [102.105182] Starting subtest: addfb25-bad-modifier [102.105965] Subtest addfb25-bad-modifier: SUCCESS (0.000s) [102.221630] [055/171] (890s left) kms_addfb_basic (addfb25-framebuffer-vs-set-tiling) [102.268924] Subtest addfb25-framebuffer-vs-set-tiling: SKIP (0.000s) [102.370955] [056/171] (890s left) kms_addfb_basic (addfb25-modifier-no-flag) [102.417744] Starting subtest: addfb25-modifier-no-flag [102.418740] Subtest addfb25-modifier-no-flag: SUCCESS (0.000s) [102.520573] [057/171] (890s left) kms_addfb_basic (addfb25-x-tiled-legacy) [102.568748] Subtest addfb25-x-tiled-legacy: SKIP (0.000s) [102.689813] [058/171] (890s left) kms_addfb_basic (addfb25-x-tiled-mismatch-legacy) [102.736596] Subtest addfb25-x-tiled-mismatch-legacy: SKIP (0.000s) [102.837777] [059/171] (890s left) kms_addfb_basic (addfb25-yf-tiled-legacy) [102.919624] Starting subtest: addfb25-yf-tiled-legacy [102.920372] Subtest addfb25-yf-tiled-legacy: SUCCESS (0.000s) [103.003278] [060/171] (890s left) kms_addfb_basic (addfb25-y-tiled-legacy) [103.084383] Starting subtest: addfb25-y-tiled-legacy [103.085164] Subtest addfb25-y-tiled-legacy: SUCCESS (0.000s) [103.154901] [061/171] (890s left) kms_addfb_basic (addfb25-y-tiled-small-legacy) [103.237973] Starting subtest: addfb25-y-tiled-small-legacy [103.240119] Subtest addfb25-y-tiled-small-legacy: SKIP (0.000s) [103.322177] [062/171] (889s left) kms_addfb_basic (bad-pitch-0) [103.369310] Starting subtest: bad-pitch-0 [103.370282] Subtest bad-pitch-0: SUCCESS (0.000s) [103.493388] [063/171] (889s left) kms_addfb_basic (bad-pitch-1024) [103.542080] Starting subtest: bad-pitch-1024 [103.542934] Subtest bad-pitch-1024: SUCCESS (0.000s) [103.655296] [064/171] (889s left) kms_addfb_basic (bad-pitch-128) [103.702866] Starting subtest: bad-pitch-128 [103.703788] Subtest bad-pitch-128: SUCCESS (0.000s) [103.823858] [065/171] (889s left) kms_addfb_basic (bad-pitch-256) [103.870621] Starting subtest: bad-pitch-256 [103.872395] Subtest bad-pitch-256: SUCCESS (0.000s) [103.991344] [066/171] (889s left) kms_addfb_basic (bad-pitch-32) [104.037141] Starting subtest: bad-pitch-32 [104.038110] Subtest bad-pitch-32: SUCCESS (0.000s) [104.155068] [067/171] (889s left) kms_addfb_basic (bad-pitch-63) [104.200949] Starting subtest: bad-pitch-63 [104.201889] Subtest bad-pitch-63: SUCCESS (0.000s) [104.303453] [068/171] (888s left) kms_addfb_basic (bad-pitch-65536) [104.348654] Starting subtest: bad-pitch-65536 [104.349687] Subtest bad-pitch-65536: SUCCESS (0.000s) [104.474309] [069/171] (888s left) kms_addfb_basic (bad-pitch-999) [104.521653] Starting subtest: bad-pitch-999 [104.522727] Subtest bad-pitch-999: SUCCESS (0.000s) [104.622022] [070/171] (888s left) kms_addfb_basic (basic) [104.668760] Starting subtest: basic [104.669833] Subtest basic: SUCCESS (0.000s) [104.791064] [071/171] (888s left) kms_addfb_basic (basic-x-tiled-legacy) [104.840168] Starting subtest: basic-x-tiled-legacy [104.841956] Subtest basic-x-tiled-legacy: SKIP (0.000s) [104.954364] [072/171] (888s left) kms_addfb_basic (basic-y-tiled-legacy) [105.002147] Starting subtest: basic-y-tiled-legacy [105.003739] Subtest basic-y-tiled-legacy: SKIP (0.000s) [105.103984] [073/171] (888s left) kms_addfb_basic (bo-too-small) [105.185797] Starting subtest: bo-too-small [105.186963] Subtest bo-too-small: SUCCESS (0.000s) [105.272165] [074/171] (888s left) kms_addfb_basic (bo-too-small-due-to-tiling) [105.361334] Starting subtest: bo-too-small-due-to-tiling [105.362904] Subtest bo-too-small-due-to-tiling: SKIP (0.000s) [105.438091] [075/171] (887s left) kms_addfb_basic (clobberred-modifier) [105.484166] Starting subtest: clobberred-modifier [105.485598] Subtest clobberred-modifier: SKIP (0.000s) [105.586855] [076/171] (887s left) kms_addfb_basic (framebuffer-vs-set-tiling) [105.633789] Starting subtest: framebuffer-vs-set-tiling [105.635615] Subtest framebuffer-vs-set-tiling: SKIP (0.000s) [105.738914] [077/171] (887s left) kms_addfb_basic (invalid-get-prop) [105.783183] Starting subtest: invalid-get-prop [105.784057] Subtest invalid-get-prop: SUCCESS (0.000s) [105.887116] [078/171] (887s left) kms_addfb_basic (invalid-get-prop-any) [105.933911] Starting subtest: invalid-get-prop-any [105.934807] Subtest invalid-get-prop-any: SUCCESS (0.000s) [106.055878] [079/171] (887s left) kms_addfb_basic (invalid-set-prop) [106.102745] Starting subtest: invalid-set-prop [106.103752] Subtest invalid-set-prop: SUCCESS (0.000s) [106.222277] [080/171] (887s left) kms_addfb_basic (invalid-set-prop-any) [106.268837] Starting subtest: invalid-set-prop-any [106.269679] Subtest invalid-set-prop-any: SUCCESS (0.000s) [106.369682] [081/171] (887s left) kms_addfb_basic (no-handle) [106.415876] Starting subtest: no-handle [106.416594] Subtest no-handle: SUCCESS (0.000s) [106.519666] [082/171] (886s left) kms_addfb_basic (size-max) [106.601195] Starting subtest: size-max [106.602067] Subtest size-max: SUCCESS (0.000s) [106.690228] [083/171] (886s left) kms_addfb_basic (small-bo) [106.770436] Starting subtest: small-bo [106.771470] Subtest small-bo: SUCCESS (0.000s) [106.855541] [084/171] (886s left) kms_addfb_basic (tile-pitch-mismatch) [106.900844] Starting subtest: tile-pitch-mismatch [106.903050] Subtest tile-pitch-mismatch: SKIP (0.000s) [107.002641] [085/171] (886s left) kms_addfb_basic (too-high) [107.083773] Starting subtest: too-high [107.084842] Subtest too-high: SUCCESS (0.000s) [107.152486] [086/171] (886s left) kms_addfb_basic (too-wide) [107.235514] Starting subtest: too-wide [107.236435] Subtest too-wide: SUCCESS (0.000s) [107.302300] [087/171] (886s left) kms_addfb_basic (unused-handle) [107.348480] Starting subtest: unused-handle [107.349260] Subtest unused-handle: SUCCESS (0.000s) [107.453298] [088/171] (886s left) kms_addfb_basic (unused-modifier) [107.500346] Starting subtest: unused-modifier [107.501185] Subtest unused-modifier: SUCCESS (0.000s) [107.603165] [089/171] (885s left) kms_addfb_basic (unused-offsets) [107.650669] Starting subtest: unused-offsets [107.651635] Subtest unused-offsets: SUCCESS (0.000s) [107.772331] [090/171] (885s left) kms_addfb_basic (unused-pitches) [107.819300] Starting subtest: unused-pitches [107.820048] Subtest unused-pitches: SUCCESS (0.000s) [107.937331] [091/171] (885s left) kms_busy (basic) [108.020907] Starting subtest: basic [108.021726] Starting dynamic subtest: flip [108.716069] Dynamic subtest flip: SUCCESS (0.694s) [108.720894] Starting dynamic subtest: modeset [109.410345] Dynamic subtest modeset: SUCCESS (0.695s) [109.411411] Subtest basic: SUCCESS (1.390s) [109.543521] [092/171] (884s left) kms_chamelium_hpd (dp-hpd-fast) [109.699568] Subtest dp-hpd-fast: SKIP (0.000s) [109.772907] [093/171] (883s left) kms_chamelium_edid (dp-edid-read) [109.919949] Subtest dp-edid-read: SKIP (0.000s) [109.993158] [094/171] (883s left) kms_chamelium_frames (dp-crc-fast) [110.141352] Subtest dp-crc-fast: SKIP (0.000s) [110.213044] [095/171] (883s left) kms_chamelium_hpd (hdmi-hpd-fast) [110.360814] Subtest hdmi-hpd-fast: SKIP (0.000s) [110.433756] [096/171] (883s left) kms_chamelium_edid (hdmi-edid-read) [110.581932] Subtest hdmi-edid-read: SKIP (0.000s) [110.655618] [097/171] (882s left) kms_chamelium_frames (hdmi-crc-fast) [110.804025] Subtest hdmi-crc-fast: SKIP (0.000s) [110.877021] [098/171] (882s left) kms_chamelium_hpd (vga-hpd-fast) [111.024808] Subtest vga-hpd-fast: SKIP (0.000s) [111.097128] [099/171] (882s left) kms_chamelium_edid (vga-edid-read) [111.244186] Subtest vga-edid-read: SKIP (0.000s) [111.317130] [100/171] (882s left) kms_prop_blob (basic) [111.364177] Starting subtest: basic [111.364883] Subtest basic: SUCCESS (0.000s) [111.425763] [101/171] (882s left) kms_cursor_legacy (basic-busy-flip-before-cursor-atomic) [111.508218] Starting subtest: basic-busy-flip-before-cursor-atomic [111.509681] Subtest basic-busy-flip-before-cursor-atomic: SKIP (0.000s) [111.575988] [102/171] (882s left) kms_cursor_legacy (basic-busy-flip-before-cursor-legacy) [111.657459] Starting subtest: basic-busy-flip-before-cursor-legacy [111.659230] Subtest basic-busy-flip-before-cursor-legacy: SKIP (0.000s) [111.725842] [103/171] (881s left) kms_cursor_legacy (basic-flip-after-cursor-atomic) [111.806353] Starting subtest: basic-flip-after-cursor-atomic [112.830637] Subtest basic-flip-after-cursor-atomic: SUCCESS (1.024s) [112.979627] [104/171] (880s left) kms_cursor_legacy (basic-flip-after-cursor-legacy) [113.059448] Starting subtest: basic-flip-after-cursor-legacy [114.067048] Subtest basic-flip-after-cursor-legacy: SUCCESS (1.008s) [114.214887] [105/171] (879s left) kms_cursor_legacy (basic-flip-after-cursor-varying-size) [114.293610] Starting subtest: basic-flip-after-cursor-varying-size [115.336337] Subtest basic-flip-after-cursor-varying-size: SUCCESS (1.043s) [115.478434] [106/171] (878s left) kms_cursor_legacy (basic-flip-before-cursor-atomic) [115.558056] Starting subtest: basic-flip-before-cursor-atomic [116.564433] Subtest basic-flip-before-cursor-atomic: SUCCESS (1.006s) [116.714091] [107/171] (876s left) kms_cursor_legacy (basic-flip-before-cursor-legacy) [116.792902] Starting subtest: basic-flip-before-cursor-legacy [117.816300] Subtest basic-flip-before-cursor-legacy: SUCCESS (1.025s) [117.960523] [108/171] (875s left) kms_cursor_legacy (basic-flip-before-cursor-varying-size) [118.041597] Starting subtest: basic-flip-before-cursor-varying-size [119.079144] Subtest basic-flip-before-cursor-varying-size: SUCCESS (1.039s) [119.232298] [109/171] (874s left) kms_flip (basic-flip-vs-dpms) [119.304973] Starting subtest: basic-flip-vs-dpms [119.307698] Starting dynamic subtest: A-HDMI-A3 [120.121916] Dynamic subtest A-HDMI-A3: SUCCESS (0.813s) [120.126730] Starting dynamic subtest: B-HDMI-A3 [120.888563] Dynamic subtest B-HDMI-A3: SUCCESS (0.767s) [120.893919] Starting dynamic subtest: C-HDMI-A3 [121.656494] Dynamic subtest C-HDMI-A3: SUCCESS (0.766s) [121.661699] Starting dynamic subtest: D-HDMI-A3 [122.440586] Dynamic subtest D-HDMI-A3: SUCCESS (0.784s) [122.442358] Subtest basic-flip-vs-dpms: SUCCESS (3.137s) [122.602419] [110/171] (871s left) kms_flip (basic-flip-vs-modeset) [122.679523] Starting subtest: basic-flip-vs-modeset [122.682219] Starting dynamic subtest: A-HDMI-A3 [123.497379] Dynamic subtest A-HDMI-A3: SUCCESS (0.815s) [123.502354] Starting dynamic subtest: B-HDMI-A3 [124.280767] Dynamic subtest B-HDMI-A3: SUCCESS (0.783s) [124.285794] Starting dynamic subtest: C-HDMI-A3 [125.061218] Dynamic subtest C-HDMI-A3: SUCCESS (0.780s) [125.066286] Starting dynamic subtest: D-HDMI-A3 [125.841616] Dynamic subtest D-HDMI-A3: SUCCESS (0.780s) [125.843758] Subtest basic-flip-vs-modeset: SUCCESS (3.166s) [125.993428] [111/171] (867s left) kms_flip (basic-flip-vs-wf_vblank) [126.068668] Starting subtest: basic-flip-vs-wf_vblank [126.070436] Starting dynamic subtest: A-HDMI-A3 [127.171949] Dynamic subtest A-HDMI-A3: SUCCESS (1.101s) [127.183692] Starting dynamic subtest: B-HDMI-A3 [128.218074] Dynamic subtest B-HDMI-A3: SUCCESS (1.045s) [128.224320] Starting dynamic subtest: C-HDMI-A3 [129.247653] Dynamic subtest C-HDMI-A3: SUCCESS (1.028s) [129.254440] Starting dynamic subtest: D-HDMI-A3 [130.291651] Dynamic subtest D-HDMI-A3: SUCCESS (1.043s) [130.294069] Subtest basic-flip-vs-wf_vblank: SUCCESS (4.227s) [130.488132] [112/171] (863s left) kms_flip (basic-plain-flip) [130.565543] Starting subtest: basic-plain-flip [130.568328] Starting dynamic subtest: A-HDMI-A3 [131.384766] Dynamic subtest A-HDMI-A3: SUCCESS (0.815s) [131.393121] Starting dynamic subtest: B-HDMI-A3 [132.146839] Dynamic subtest B-HDMI-A3: SUCCESS (0.760s) [132.154219] Starting dynamic subtest: C-HDMI-A3 [132.908947] Dynamic subtest C-HDMI-A3: SUCCESS (0.761s) [132.915481] Starting dynamic subtest: D-HDMI-A3 [133.658623] Dynamic subtest D-HDMI-A3: SUCCESS (0.749s) [133.661125] Subtest basic-plain-flip: SUCCESS (3.098s) [133.854491] [113/171] (859s left) kms_force_connector_basic (force-connector-state) [133.956623] Starting subtest: force-connector-state [134.401290] Subtest force-connector-state: SUCCESS (0.446s) [134.658486] [114/171] (859s left) kms_force_connector_basic (force-edid) [134.756622] Starting subtest: force-edid [134.766893] Subtest force-edid: SUCCESS (0.011s) [134.975149] [115/171] (858s left) kms_force_connector_basic (force-load-detect) [135.072371] Starting subtest: force-load-detect [135.074029] Subtest force-load-detect: SKIP (0.000s) [135.241519] [116/171] (858s left) kms_force_connector_basic (prune-stale-modes) [135.338855] Starting subtest: prune-stale-modes [135.345918] Subtest prune-stale-modes: SKIP (0.007s) [135.542402] [117/171] (858s left) kms_frontbuffer_tracking (basic) [135.627305] Starting subtest: basic [138.391815] Subtest basic: SUCCESS (2.765s) [138.531591] [118/171] (855s left) kms_pipe_crc_basic (compare-crc-sanitycheck-xr24) [138.614099] Starting subtest: compare-crc-sanitycheck-xr24 [138.614931] Starting dynamic subtest: pipe-A-HDMI-A-3 [139.110772] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (0.496s) [139.117154] Starting dynamic subtest: pipe-B-HDMI-A-3 [139.580458] Dynamic subtest pipe-B-HDMI-A-3: SUCCESS (0.468s) [139.585506] Starting dynamic subtest: pipe-C-HDMI-A-3 [140.106786] Dynamic subtest pipe-C-HDMI-A-3: SUCCESS (0.526s) [140.112069] Starting dynamic subtest: pipe-D-HDMI-A-3 [140.668459] Dynamic subtest pipe-D-HDMI-A-3: SUCCESS (0.561s) [140.669255] Subtest compare-crc-sanitycheck-xr24: SUCCESS (2.055s) [140.804120] [119/171] (853s left) kms_pipe_crc_basic (compare-crc-sanitycheck-nv12) [140.887489] Starting subtest: compare-crc-sanitycheck-nv12 [140.888680] Starting dynamic subtest: pipe-A-HDMI-A-3 [142.855312] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (1.968s) [142.860880] Starting dynamic subtest: pipe-B-HDMI-A-3 [144.745161] Dynamic subtest pipe-B-HDMI-A-3: SUCCESS (1.889s) [144.751617] Starting dynamic subtest: pipe-C-HDMI-A-3 [146.500646] Dynamic subtest pipe-C-HDMI-A-3: SUCCESS (1.754s) [146.506074] Starting dynamic subtest: pipe-D-HDMI-A-3 [148.009753] Dynamic subtest pipe-D-HDMI-A-3: SUCCESS (1.508s) [148.010846] Subtest compare-crc-sanitycheck-nv12: SUCCESS (7.124s) [148.154105] [120/171] (845s left) kms_pipe_crc_basic (hang-read-crc) [148.235762] Starting subtest: hang-read-crc [148.236581] Starting dynamic subtest: pipe-A-HDMI-A-3 [149.890582] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (1.655s) [149.895717] Starting dynamic subtest: pipe-B-HDMI-A-3 [151.600550] Dynamic subtest pipe-B-HDMI-A-3: SUCCESS (1.709s) [151.606771] Starting dynamic subtest: pipe-C-HDMI-A-3 [153.333719] Dynamic subtest pipe-C-HDMI-A-3: SUCCESS (1.732s) [153.666688] [121/171] (840s left) kms_pipe_crc_basic (nonblocking-crc) [153.729733] Subtest nonblocking-crc: SKIP (0.000s) [153.749287] [122/171] (840s left) kms_pipe_crc_basic (nonblocking-crc-frame-sequence) [153.808160] Subtest nonblocking-crc-frame-sequence: SKIP (0.000s) [153.828194] [123/171] (840s left) kms_pipe_crc_basic (read-crc) [153.887916] Subtest read-crc: SKIP (0.000s) [153.907190] [124/171] (839s left) kms_pipe_crc_basic (read-crc-frame-sequence) [153.969538] Subtest read-crc-frame-sequence: SKIP (0.000s) [153.985797] [125/171] (839s left) kms_psr (primary_page_flip) [154.031680] Subtest primary_page_flip: SKIP (0.000s) [154.078186] [126/171] (839s left) kms_psr (cursor_plane_move) [154.159572] Subtest cursor_plane_move: SKIP (0.000s) [154.178552] [127/171] (839s left) kms_psr (sprite_plane_onoff) [154.226625] Subtest sprite_plane_onoff: SKIP (0.000s) [154.245479] [128/171] (839s left) kms_psr (primary_mmap_gtt) [154.292183] Subtest primary_mmap_gtt: SKIP (0.000s) [154.317363] [129/171] (839s left) kms_setmode (basic-clone-single-crtc) [154.363842] Starting subtest: basic-clone-single-crtc [154.366422] Subtest basic-clone-single-crtc: SKIP (0.000s) [154.426968] [130/171] (839s left) i915_pm_backlight (basic-brightness) [154.508128] Subtest basic-brightness: SKIP (0.000s) [154.528239] [131/171] (839s left) i915_pm_rpm (basic-pci-d3-state) [156.286431] Starting subtest: basic-pci-d3-state [157.325251] Subtest basic-pci-d3-state: SUCCESS (1.040s) [157.445327] [132/171] (836s left) i915_pm_rpm (basic-rte) [157.491257] Starting subtest: basic-rte [159.903867] Subtest basic-rte: SUCCESS (2.412s) [160.704373] [133/171] (833s left) i915_pm_rps (basic-api) [160.753191] Starting subtest: basic-api [160.754987] Subtest basic-api: SKIP (0.000s) [160.826281] [134/171] (833s left) prime_self_import (basic-llseek-bad) [160.870978] Starting subtest: basic-llseek-bad [160.872661] Subtest basic-llseek-bad: SUCCESS (0.001s) [160.960889] [135/171] (833s left) prime_self_import (basic-llseek-size) [161.005084] Starting subtest: basic-llseek-size [161.006849] Subtest basic-llseek-size: SUCCESS (0.002s) [161.094201] [136/171] (832s left) prime_self_import (basic-with_fd_dup) [161.138634] Starting subtest: basic-with_fd_dup [161.140211] Subtest basic-with_fd_dup: SUCCESS (0.002s) [161.208850] [137/171] (832s left) prime_self_import (basic-with_one_bo) [161.252928] Starting subtest: basic-with_one_bo [161.255056] Subtest basic-with_one_bo: SUCCESS (0.002s) [161.312384] [138/171] (832s left) prime_self_import (basic-with_one_bo_two_files) [161.358687] Starting subtest: basic-with_one_bo_two_files [161.360995] Subtest basic-with_one_bo_two_files: SUCCESS (0.002s) [161.442469] [139/171] (832s left) prime_self_import (basic-with_two_bos) [161.486756] Starting subtest: basic-with_two_bos [161.490169] Subtest basic-with_two_bos: SUCCESS (0.002s) [161.576558] [140/171] (832s left) prime_vgem (basic-fence-flip) [161.648868] Starting subtest: basic-fence-flip [161.709773] Subtest basic-fence-flip: SKIP (0.060s) [161.792718] [141/171] (832s left) prime_vgem (basic-fence-mmap) [161.868187] Starting subtest: basic-fence-mmap [161.870123] Subtest basic-fence-mmap: SKIP (0.000s) [161.959962] [142/171] (832s left) prime_vgem (basic-fence-read) [162.035111] Starting subtest: basic-fence-read [162.039292] Subtest basic-fence-read: SKIP (0.003s) [162.126898] [143/171] (831s left) prime_vgem (basic-gtt) [162.203166] Starting subtest: basic-gtt [162.204681] Subtest basic-gtt: SKIP (0.000s) [162.293813] [144/171] (831s left) prime_vgem (basic-read) [162.364751] Starting subtest: basic-read [162.369730] Subtest basic-read: SKIP (0.004s) [162.460464] [145/171] (831s left) prime_vgem (basic-write) [162.540143] Starting subtest: basic-write [162.544357] Subtest basic-write: SKIP (0.004s) [162.645045] [146/171] (831s left) vgem_basic (setversion) [162.704368] Starting subtest: setversion [162.706115] Subtest setversion: SUCCESS (0.000s) [162.758515] [147/171] (831s left) vgem_basic (create) [162.821559] Starting subtest: create [162.822713] Subtest create: SUCCESS (0.000s) [162.874839] [148/171] (831s left) vgem_basic (debugfs) [162.938124] Starting subtest: debugfs [162.939213] Subtest debugfs: SUCCESS (0.000s) [162.988497] [149/171] (831s left) vgem_basic (dmabuf-export) [163.037849] Starting subtest: dmabuf-export [163.039859] Subtest dmabuf-export: SUCCESS (0.002s) [163.125053] [150/171] (831s left) vgem_basic (dmabuf-fence) [163.187234] Starting subtest: dmabuf-fence [163.187998] Subtest dmabuf-fence: SUCCESS (0.000s) [163.239258] [151/171] (830s left) vgem_basic (dmabuf-fence-before) [163.304274] Starting subtest: dmabuf-fence-before [163.305541] Subtest dmabuf-fence-before: SUCCESS (0.000s) [163.356340] [152/171] (830s left) vgem_basic (dmabuf-mmap) [163.420937] Starting subtest: dmabuf-mmap [163.427044] Subtest dmabuf-mmap: SUCCESS (0.007s) [163.472488] [153/171] (830s left) vgem_basic (mmap) [163.521138] Starting subtest: mmap [163.525918] Subtest mmap: SUCCESS (0.005s) [163.571477] [154/171] (830s left) vgem_basic (second-client) [163.621312] Starting subtest: second-client [163.654932] Subtest second-client: SUCCESS (0.033s) [163.710191] [155/171] (830s left) vgem_basic (sysfs) [163.771161] Starting subtest: sysfs [163.772251] Subtest sysfs: SUCCESS (0.000s) [163.827151] [156/171] (830s left) core_hotunplug (unbind-rebind) [163.903977] Starting subtest: unbind-rebind [165.294590] Subtest unbind-rebind: SUCCESS (1.391s) [165.310950] [157/171] (828s left) vgem_basic (unload) [165.358612] Starting subtest: unload [194.312447] Subtest unload: SUCCESS (28.907s) [194.367931] [158/171] (799s left) i915_module_load (reload) [194.412897] Starting subtest: reload [198.763699] Subtest reload: SUCCESS (4.352s) [198.778359] [159/171] (795s left) gem_lmem_swapping (basic) [204.224108] Starting subtest: basic [204.224919] Starting dynamic subtest: lmem0 [221.681737] Dynamic subtest lmem0: SUCCESS (17.448s) [221.682626] Subtest basic: SUCCESS (17.449s) [223.682069] [160/171] (770s left) gem_lmem_swapping (parallel-random-engines) [226.287055] Starting subtest: parallel-random-engines [226.287869] Starting dynamic subtest: lmem0 [227.099680] Dynamic subtest lmem0: SUCCESS (0.812s) [227.100413] Subtest parallel-random-engines: SUCCESS (0.813s) [229.323127] [161/171] (765s left) gem_lmem_swapping (random-engines) [231.917047] Starting subtest: random-engines [231.917833] Starting dynamic subtest: lmem0 [232.516368] Dynamic subtest lmem0: SUCCESS (0.600s) [232.517297] Subtest random-engines: SUCCESS (0.601s) [234.944871] [162/171] (759s left) gem_lmem_swapping (verify-random) [237.531459] Starting subtest: verify-random [237.532218] Starting dynamic subtest: lmem0 [244.638216] Dynamic subtest lmem0: SUCCESS (7.096s) [244.639043] Subtest verify-random: SUCCESS (7.097s) [247.097642] [163/171] (747s left) i915_pm_rpm (module-reload) [252.100990] Starting subtest: module-reload [267.053028] Subtest module-reload: SUCCESS (14.942s) [267.065537] [164/171] (727s left) i915_selftest (live) [267.106660] Starting subtest: live [267.107406] Starting dynamic subtest: sanitycheck [269.192870] Dynamic subtest sanitycheck: SUCCESS (2.080s) [269.196696] Starting dynamic subtest: uncore [271.386187] Dynamic subtest uncore: SUCCESS (2.188s) [271.390131] Starting dynamic subtest: workarounds [277.867977] Dynamic subtest workarounds: SUCCESS (6.482s) [277.871986] Starting dynamic subtest: gt_engines [281.365793] Dynamic subtest gt_engines: SUCCESS (3.496s) [281.372053] Starting dynamic subtest: gt_timelines [308.240426] Dynamic subtest gt_timelines: SUCCESS (26.874s) [308.246820] Starting dynamic subtest: gt_contexts [310.476780] Dynamic subtest gt_contexts: SUCCESS (2.235s) [310.480970] Starting dynamic subtest: gt_lrc [320.262756] Dynamic subtest gt_lrc: SUCCESS (9.785s) [320.266855] Starting dynamic subtest: gt_mocs [325.794872] Dynamic subtest gt_mocs: SUCCESS (5.532s) [325.798982] Starting dynamic subtest: gt_pm [329.780517] Dynamic subtest gt_pm: SUCCESS (3.985s) [329.785664] Starting dynamic subtest: gt_heartbeat [332.226421] Dynamic subtest gt_heartbeat: SUCCESS (2.444s) [332.232972] Starting dynamic subtest: gt_tlb [341.881729] Dynamic subtest gt_tlb: SUCCESS (9.654s) [341.886013] Starting dynamic subtest: requests [364.199601] Dynamic subtest requests: SUCCESS (22.316s) [364.204034] Starting dynamic subtest: migrate [372.969547] Dynamic subtest migrate: SUCCESS (8.769s) [372.976807] Starting dynamic subtest: active [375.096741] Dynamic subtest active: SUCCESS (2.126s) [375.100593] Starting dynamic subtest: objects [378.265367] Dynamic subtest objects: SUCCESS (3.169s) [378.269215] Starting dynamic subtest: mman [391.426470] Dynamic subtest mman: SUCCESS (13.161s) [391.431395] Starting dynamic subtest: dmabuf [393.766278] Dynamic subtest dmabuf: SUCCESS (2.339s) [393.771211] Starting dynamic subtest: vma [396.008330] Dynamic subtest vma: SUCCESS (2.240s) [396.013226] Starting dynamic subtest: coherency [409.730687] Dynamic subtest coherency: SUCCESS (13.722s) [409.735654] Starting dynamic subtest: gtt [427.974735] Dynamic subtest gtt: SUCCESS (18.243s) [427.980128] Starting dynamic subtest: gem [430.571964] Dynamic subtest gem: SUCCESS (2.596s) [430.576811] Starting dynamic subtest: evict [436.941957] Dynamic subtest evict: SUCCESS (6.369s) [436.946705] Starting dynamic subtest: hugepages [462.873021] Dynamic subtest hugepages: SUCCESS (25.930s) [462.877580] Starting dynamic subtest: gem_contexts [511.262252] Dynamic subtest gem_contexts: SUCCESS (48.353s) [511.267310] Starting dynamic subtest: client [513.435627] Dynamic subtest client: SUCCESS (2.208s) [513.439981] Starting dynamic subtest: gem_migrate [520.975017] Dynamic subtest gem_migrate: SUCCESS (7.538s) [520.979531] Starting dynamic subtest: reset [544.491794] Dynamic subtest reset: SUCCESS (23.516s) [544.496270] Starting dynamic subtest: memory_region [548.242837] Dynamic subtest memory_region: SUCCESS (3.751s) [548.246882] Starting dynamic subtest: hangcheck [601.123898] Dynamic subtest hangcheck: SUCCESS (52.878s) [601.128602] Starting dynamic subtest: execlists [603.294899] Dynamic subtest execlists: SUCCESS (2.170s) [603.300624] Starting dynamic subtest: ring_submission [605.507958] Dynamic subtest ring_submission: SUCCESS (2.214s) [605.512660] Starting dynamic subtest: perf [607.878290] Dynamic subtest perf: SUCCESS (2.369s) [607.882522] Starting dynamic subtest: slpc [622.347198] Dynamic subtest slpc: SUCCESS (14.468s) [622.352521] Starting dynamic subtest: guc [626.709936] Dynamic subtest guc: SUCCESS (4.362s) [626.715347] Starting dynamic subtest: guc_multi_lrc [628.971571] Dynamic subtest guc_multi_lrc: SUCCESS (2.260s) [628.976303] Starting dynamic subtest: guc_hang [632.838025] Dynamic subtest guc_hang: SUCCESS (3.865s) [632.842755] Starting dynamic subtest: late_gt_pm [635.152207] Dynamic subtest late_gt_pm: SUCCESS (2.313s) [635.153816] Subtest live: SUCCESS (368.036s) [635.530443] [165/171] (358s left) dmabuf (all-tests) [635.571594] Starting subtest: all-tests [635.573201] Starting dynamic subtest: sanitycheck [635.648616] Dynamic subtest sanitycheck: SUCCESS (0.076s) [635.657323] Starting dynamic subtest: dma_fence [635.824282] Dynamic subtest dma_fence: SUCCESS (0.174s) [635.833511] Starting dynamic subtest: dma_fence_chain [644.839264] Dynamic subtest dma_fence_chain: SUCCESS (9.014s) [644.847308] Starting dynamic subtest: dma_fence_unwrap [644.903376] Dynamic subtest dma_fence_unwrap: SUCCESS (0.062s) [644.917112] Starting dynamic subtest: dma_resv [644.975465] Dynamic subtest dma_resv: SUCCESS (0.070s) [644.977335] Subtest all-tests: SUCCESS (9.404s) [644.994574] [166/171] (349s left) i915_suspend (basic-s2idle-without-i915) [645.033336] Starting subtest: basic-s2idle-without-i915 [669.817359] Subtest basic-s2idle-without-i915: SUCCESS (9.868s) [669.912904] [167/171] (339s left) i915_suspend (basic-s3-without-i915) [669.972872] Starting subtest: basic-s3-without-i915