[41.138258] Initializing watchdogs
[41.138471]   /dev/watchdog0
[41.150461] [001/165] (960s left) i915_module_load (load)
[41.232019] Starting subtest: load
[43.468172] Subtest load: SUCCESS (2.234s)
[43.510598] [002/165] (958s left) core_auth (basic-auth)
[43.621689] Starting subtest: basic-auth
[43.622981] Subtest basic-auth: SUCCESS (0.002s)
[43.678541] [003/165] (958s left) debugfs_test (read_all_entries)
[43.738446] Starting subtest: read_all_entries
[43.805730] Subtest read_all_entries: SUCCESS (0.065s)
[44.313943] [004/165] (957s left) debugfs_test (basic-hwmon)
[44.422173] Starting subtest: basic-hwmon
[44.423362] Subtest basic-hwmon: SKIP (0.000s)
[44.863388] [005/165] (956s left) fbdev (eof)
[44.949533] Starting subtest: eof
[44.950248] Subtest eof: SUCCESS (0.001s)
[44.996134] [006/165] (956s left) fbdev (info)
[45.046605] Starting subtest: info
[45.047184] Subtest info: SUCCESS (0.000s)
[45.097026] [007/165] (956s left) fbdev (nullptr)
[45.165655] Starting subtest: nullptr
[45.166281] Subtest nullptr: SUCCESS (0.000s)
[45.213560] [008/165] (956s left) fbdev (read)
[45.282856] Starting subtest: read
[45.506052] Subtest read: SUCCESS (0.224s)
[45.545520] [009/165] (956s left) fbdev (write)
[45.600372] Starting subtest: write
[45.714912] Subtest write: SUCCESS (0.116s)
[45.761342] [010/165] (956s left) gem_basic (bad-close)
[45.813425] Starting subtest: bad-close
[45.814537] Subtest bad-close: SUCCESS (0.000s)
[45.862148] [011/165] (955s left) gem_basic (create-close)
[45.915591] Starting subtest: create-close
[45.916643] Subtest create-close: SUCCESS (0.000s)
[46.024962] [012/165] (955s left) gem_basic (create-fd-close)
[46.080227] Starting subtest: create-fd-close
[46.081414] Subtest create-fd-close: SUCCESS (0.000s)
[46.146698] [013/165] (955s left) gem_busy (busy@all-engines)
[46.218036] Starting subtest: busy
[46.218595] Starting dynamic subtest: all-engines
[46.288526] Dynamic subtest all-engines: SUCCESS (0.071s)
[46.289152] Subtest busy: SUCCESS (0.071s)
[46.692581] [014/165] (955s left) gem_close_race (basic-process)
[46.762952] Starting subtest: basic-process
[46.817748] Subtest basic-process: SUCCESS (0.055s)
[47.033881] [015/165] (954s left) gem_close_race (basic-threads)
[47.105254] Starting subtest: basic-threads
[48.254230] Subtest basic-threads: SUCCESS (1.149s)
[48.478125] [016/165] (953s left) gem_ctx_create (basic)
[48.560602] Starting subtest: basic
[48.561218] Subtest basic: SUCCESS (0.000s)
[48.759199] [017/165] (953s left) gem_ctx_create (basic-files)
[48.841665] Starting subtest: basic-files
[50.858686] Subtest basic-files: SUCCESS (2.017s)
[51.093849] [018/165] (950s left) gem_ctx_exec (basic)
[51.151908] Starting subtest: basic
[51.155163] Subtest basic: SUCCESS (0.003s)
[51.272050] [019/165] (950s left) gem_exec_basic (basic)
[51.334699] Starting subtest: basic
[51.338135] Starting dynamic subtest: rcs0-smem
[51.338718] Dynamic subtest rcs0-smem: SUCCESS (0.001s)
[51.343473] Starting dynamic subtest: bcs0-smem
[51.343923] Dynamic subtest bcs0-smem: SUCCESS (0.001s)
[51.348611] Starting dynamic subtest: vcs0-smem
[51.349279] Dynamic subtest vcs0-smem: SUCCESS (0.001s)
[51.353967] Starting dynamic subtest: vcs1-smem
[51.354677] Dynamic subtest vcs1-smem: SUCCESS (0.000s)
[51.359228] Starting dynamic subtest: vecs0-smem
[51.359894] Dynamic subtest vecs0-smem: SUCCESS (0.001s)
[51.360479] Subtest basic: SUCCESS (0.006s)
[51.555722] [020/165] (950s left) gem_exec_create (basic)
[51.631963] Starting subtest: basic
[51.635123] Starting dynamic subtest: smem
[53.674947] Dynamic subtest smem: SUCCESS (2.043s)
[53.676754] Subtest basic: SUCCESS (2.043s)
[53.875184] [021/165] (948s left) gem_exec_fence (basic-busy)
[54.082470] Starting subtest: basic-busy
[54.083835] Starting dynamic subtest: rcs0
[54.114284] Dynamic subtest rcs0: SUCCESS (0.030s)
[54.125794] Starting dynamic subtest: bcs0
[54.147592] Dynamic subtest bcs0: SUCCESS (0.035s)
[54.159550] Starting dynamic subtest: vcs0
[54.185290] Dynamic subtest vcs0: SUCCESS (0.034s)
[54.213127] Starting dynamic subtest: vcs1
[54.218594] Dynamic subtest vcs1: SUCCESS (0.033s)
[54.228407] Starting dynamic subtest: vecs0
[54.235825] Dynamic subtest vecs0: SUCCESS (0.021s)
[54.236393] Subtest basic-busy: SUCCESS (0.154s)
[54.891991] [022/165] (947s left) gem_exec_fence (basic-wait)
[55.092492] Starting subtest: basic-wait
[55.093593] Starting dynamic subtest: rcs0
[55.117261] Dynamic subtest rcs0: SUCCESS (0.025s)
[55.127835] Starting dynamic subtest: bcs0
[55.149320] Dynamic subtest bcs0: SUCCESS (0.032s)
[55.159919] Starting dynamic subtest: vcs0
[55.176152] Dynamic subtest vcs0: SUCCESS (0.027s)
[55.186213] Starting dynamic subtest: vcs1
[55.207255] Dynamic subtest vcs1: SUCCESS (0.031s)
[55.217361] Starting dynamic subtest: vecs0
[55.232221] Dynamic subtest vecs0: SUCCESS (0.025s)
[55.233286] Subtest basic-wait: SUCCESS (0.140s)
[55.845364] [023/165] (946s left) gem_exec_fence (basic-await)
[56.049985] Starting subtest: basic-await
[56.051091] Starting dynamic subtest: rcs0
[56.151044] Dynamic subtest rcs0: SUCCESS (0.101s)
[56.158029] Starting dynamic subtest: bcs0
[56.248179] Dynamic subtest bcs0: SUCCESS (0.097s)
[56.257322] Starting dynamic subtest: vcs0
[56.352078] Dynamic subtest vcs0: SUCCESS (0.104s)
[56.360247] Starting dynamic subtest: vcs1
[56.448270] Dynamic subtest vcs1: SUCCESS (0.096s)
[56.454865] Starting dynamic subtest: vecs0
[56.548587] Dynamic subtest vecs0: SUCCESS (0.100s)
[56.549338] Subtest basic-await: SUCCESS (0.499s)
[57.183249] [024/165] (944s left) gem_exec_fence (nb-await)
[57.394249] Starting subtest: nb-await
[57.395429] Starting dynamic subtest: rcs0
[57.470483] Dynamic subtest rcs0: SUCCESS (0.072s)
[57.499551] Starting dynamic subtest: bcs0
[57.560769] Dynamic subtest bcs0: SUCCESS (0.092s)
[57.585626] Starting dynamic subtest: vcs0
[57.649091] Dynamic subtest vcs0: SUCCESS (0.085s)
[57.676358] Starting dynamic subtest: vcs1
[57.739959] Dynamic subtest vcs1: SUCCESS (0.091s)
[57.765661] Starting dynamic subtest: vecs0
[57.829118] Dynamic subtest vecs0: SUCCESS (0.088s)
[57.830938] Subtest nb-await: SUCCESS (0.433s)
[58.459857] [025/165] (943s left) gem_exec_gttfill (basic)
[58.542357] Starting subtest: basic
[66.788992] Subtest basic: SUCCESS (8.247s)
[66.951348] [026/165] (935s left) gem_exec_parallel (engines)
[67.084110] Starting subtest: engines
[67.084746] Starting dynamic subtest: basic
[69.147347] Dynamic subtest basic: SUCCESS (2.065s)
[69.153944] Starting dynamic subtest: contexts
[71.790373] Dynamic subtest contexts: SUCCESS (2.643s)
[71.796984] Starting dynamic subtest: fds
[76.950581] Dynamic subtest fds: SUCCESS (5.160s)
[76.956942] Starting dynamic subtest: userptr
[78.951074] Dynamic subtest userptr: SUCCESS (2.000s)
[78.951879] Subtest engines: SUCCESS (11.869s)
[79.138501] [027/165] (923s left) gem_exec_store (basic)
[79.203610] Starting subtest: basic
[79.263150] Subtest basic: SUCCESS (0.060s)
[79.478221] [028/165] (922s left) gem_flink_basic (bad-flink)
[79.551180] Starting subtest: bad-flink
[79.551829] Subtest bad-flink: SUCCESS (0.000s)
[79.613460] [029/165] (922s left) gem_flink_basic (bad-open)
[79.667214] Starting subtest: bad-open
[79.667816] Subtest bad-open: SUCCESS (0.000s)
[79.733521] [030/165] (922s left) gem_flink_basic (basic)
[79.794851] Starting subtest: basic
[79.795487] Subtest basic: SUCCESS (0.000s)
[79.867549] [031/165] (922s left) gem_flink_basic (double-flink)
[79.933689] Starting subtest: double-flink
[79.934283] Subtest double-flink: SUCCESS (0.000s)
[80.026262] [032/165] (922s left) gem_flink_basic (flink-lifetime)
[80.102679] Starting subtest: flink-lifetime
[80.103133] Subtest flink-lifetime: SUCCESS (0.001s)
[80.187863] [033/165] (922s left) gem_huc_copy (huc-copy)
[80.259090] Starting subtest: huc-copy
[80.260264] Subtest huc-copy: SKIP (0.000s)
[80.373926] [034/165] (921s left) gem_linear_blits (basic)
[80.563966] Starting subtest: basic
[80.570242] Subtest basic: SUCCESS (0.007s)
[80.734168] [035/165] (921s left) gem_mmap (basic)
[80.929626] Starting subtest: basic
[80.932221] Subtest basic: SUCCESS (0.000s)
[80.999755] [036/165] (921s left) gem_mmap_gtt (basic)
[81.059340] Starting subtest: basic
[81.060215] Subtest basic: SUCCESS (0.001s)
[81.107182] [037/165] (921s left) gem_render_linear_blits (basic)
[81.169417] Starting subtest: basic
[81.199910] Subtest basic: SUCCESS (0.030s)
[81.239331] [038/165] (921s left) gem_render_tiled_blits (basic)
[81.298735] Starting subtest: basic
[81.343247] Subtest basic: SUCCESS (0.041s)
[81.373105] [039/165] (921s left) gem_ringfill (basic-all)
[81.661185] Starting subtest: basic-all
[82.840650] Subtest basic-all: SUCCESS (1.181s)
[82.943845] [040/165] (919s left) gem_softpin (allocator-basic)
[83.017113] Starting subtest: allocator-basic
[83.118761] Subtest allocator-basic: SUCCESS (0.104s)
[83.222782] [041/165] (919s left) gem_softpin (allocator-basic-reserve)
[83.290395] Starting subtest: allocator-basic-reserve
[83.402819] Subtest allocator-basic-reserve: SUCCESS (0.112s)
[83.486701] [042/165] (919s left) gem_softpin (safe-alignment)
[83.557282] Starting subtest: safe-alignment
[83.570756] Subtest safe-alignment: SUCCESS (0.013s)
[83.699367] [043/165] (918s left) gem_sync (basic-all)
[83.781957] Starting subtest: basic-all
[86.191095] Subtest basic-all: SUCCESS (2.411s)
[86.398067] [044/165] (916s left) gem_sync (basic-each)
[86.466852] Starting subtest: basic-each
[88.666871] Subtest basic-each: SUCCESS (2.200s)
[88.871526] [045/165] (913s left) gem_tiled_blits (basic)
[89.088226] Starting subtest: basic
[89.107419] Subtest basic: SUCCESS (0.017s)
[89.246112] [046/165] (913s left) gem_tiled_fence_blits (basic)
[89.519167] Starting subtest: basic
[89.531933] Subtest basic: SUCCESS (0.011s)
[89.689401] [047/165] (912s left) gem_tiled_pread_basic
[90.053800] [048/165] (912s left) gem_wait (busy@all-engines)
[90.138244] Starting subtest: busy
[90.138958] Starting dynamic subtest: all-engines
[90.664106] Dynamic subtest all-engines: SUCCESS (0.526s)
[90.665024] Subtest busy: SUCCESS (0.526s)
[90.870035] [049/165] (911s left) gem_wait (wait@all-engines)
[90.944061] Starting subtest: wait
[90.946804] Starting dynamic subtest: all-engines
[91.986717] Dynamic subtest all-engines: SUCCESS (1.041s)
[91.988951] Subtest wait: SUCCESS (1.041s)
[92.251254] [050/165] (910s left) i915_getparams_basic (basic-eu-total)
[92.308721] Starting subtest: basic-eu-total
[92.309900] Subtest basic-eu-total: SUCCESS (0.000s)
[92.363079] [051/165] (910s left) i915_getparams_basic (basic-subslice-total)
[92.416159] Starting subtest: basic-subslice-total
[92.417222] Subtest basic-subslice-total: SUCCESS (0.000s)
[92.482232] [052/165] (910s left) i915_hangman (error-state-basic)
[92.553497] Starting subtest: error-state-basic
[92.560013] Subtest error-state-basic: SUCCESS (0.006s)
[92.659916] [053/165] (910s left) i915_pciid
[92.800119] [054/165] (910s left) kms_addfb_basic (addfb25-4-tiled)
[93.238471] Starting subtest: addfb25-4-tiled
[93.239213] Subtest addfb25-4-tiled: SUCCESS (0.000s)
[93.352265] [055/165] (909s left) kms_addfb_basic (addfb25-bad-modifier)
[93.423675] Starting subtest: addfb25-bad-modifier
[93.424181] Subtest addfb25-bad-modifier: SUCCESS (0.000s)
[93.908868] [056/165] (909s left) kms_addfb_basic (addfb25-framebuffer-vs-set-tiling)
[93.986598] Starting subtest: addfb25-framebuffer-vs-set-tiling
[93.987158] Subtest addfb25-framebuffer-vs-set-tiling: SUCCESS (0.000s)
[94.475340] [057/165] (908s left) kms_addfb_basic (addfb25-modifier-no-flag)
[94.534831] Starting subtest: addfb25-modifier-no-flag
[94.535424] Subtest addfb25-modifier-no-flag: SUCCESS (0.000s)
[95.019824] [058/165] (907s left) kms_addfb_basic (addfb25-x-tiled-legacy)
[95.079718] Starting subtest: addfb25-x-tiled-legacy
[95.080327] Subtest addfb25-x-tiled-legacy: SUCCESS (0.000s)
[95.550202] [059/165] (907s left) kms_addfb_basic (addfb25-x-tiled-mismatch-legacy)
[95.623732] Starting subtest: addfb25-x-tiled-mismatch-legacy
[95.624389] Subtest addfb25-x-tiled-mismatch-legacy: SUCCESS (0.000s)
[96.093218] [060/165] (906s left) kms_addfb_basic (addfb25-yf-tiled-legacy)
[96.545932] Starting subtest: addfb25-yf-tiled-legacy
[96.546721] Subtest addfb25-yf-tiled-legacy: SUCCESS (0.000s)
[96.673328] [061/165] (906s left) kms_addfb_basic (addfb25-y-tiled-legacy)
[97.124288] Starting subtest: addfb25-y-tiled-legacy
[97.124877] Subtest addfb25-y-tiled-legacy: SUCCESS (0.000s)
[97.223215] [062/165] (905s left) kms_addfb_basic (addfb25-y-tiled-small-legacy)
[97.679233] Starting subtest: addfb25-y-tiled-small-legacy
[97.679778] Subtest addfb25-y-tiled-small-legacy: SUCCESS (0.000s)
[97.764095] [063/165] (905s left) kms_addfb_basic (bad-pitch-0)
[97.847968] Starting subtest: bad-pitch-0
[97.848534] Subtest bad-pitch-0: SUCCESS (0.000s)
[98.335980] [064/165] (904s left) kms_addfb_basic (bad-pitch-1024)
[98.411167] Starting subtest: bad-pitch-1024
[98.411713] Subtest bad-pitch-1024: SUCCESS (0.000s)
[98.907762] [065/165] (904s left) kms_addfb_basic (bad-pitch-128)
[98.984683] Starting subtest: bad-pitch-128
[98.985284] Subtest bad-pitch-128: SUCCESS (0.000s)
[99.498275] [066/165] (903s left) kms_addfb_basic (bad-pitch-256)
[99.573291] Starting subtest: bad-pitch-256
[99.573819] Subtest bad-pitch-256: SUCCESS (0.000s)
[100.063296] [067/165] (903s left) kms_addfb_basic (bad-pitch-32)
[100.140446] Starting subtest: bad-pitch-32
[100.141108] Subtest bad-pitch-32: SUCCESS (0.000s)
[100.615483] [068/165] (902s left) kms_addfb_basic (bad-pitch-63)
[100.677964] Starting subtest: bad-pitch-63
[100.678538] Subtest bad-pitch-63: SUCCESS (0.000s)
[101.169481] [069/165] (902s left) kms_addfb_basic (bad-pitch-65536)
[101.245065] Starting subtest: bad-pitch-65536
[101.245582] Subtest bad-pitch-65536: SUCCESS (0.000s)
[101.753172] [070/165] (901s left) kms_addfb_basic (bad-pitch-999)
[101.821643] Starting subtest: bad-pitch-999
[101.822363] Subtest bad-pitch-999: SUCCESS (0.000s)
[102.323885] [071/165] (901s left) kms_addfb_basic (basic)
[102.383185] Starting subtest: basic
[102.383778] Subtest basic: SUCCESS (0.000s)
[102.884051] [072/165] (900s left) kms_addfb_basic (basic-x-tiled-legacy)
[102.941440] Starting subtest: basic-x-tiled-legacy
[102.942078] Subtest basic-x-tiled-legacy: SUCCESS (0.000s)
[103.422369] [073/165] (900s left) kms_addfb_basic (basic-y-tiled-legacy)
[103.487817] Starting subtest: basic-y-tiled-legacy
[103.488545] Subtest basic-y-tiled-legacy: SUCCESS (0.000s)
[103.998432] [074/165] (899s left) kms_addfb_basic (bo-too-small)
[104.447600] Starting subtest: bo-too-small
[104.448470] Subtest bo-too-small: SUCCESS (0.000s)
[104.583372] [075/165] (899s left) kms_addfb_basic (bo-too-small-due-to-tiling)
[105.031825] Starting subtest: bo-too-small-due-to-tiling
[105.032711] Subtest bo-too-small-due-to-tiling: SUCCESS (0.000s)
[105.154983] [076/165] (898s left) kms_addfb_basic (clobberred-modifier)
[105.214187] Starting subtest: clobberred-modifier
[105.214843] Subtest clobberred-modifier: SUCCESS (0.000s)
[105.684580] [077/165] (898s left) kms_addfb_basic (framebuffer-vs-set-tiling)
[105.773224] Starting subtest: framebuffer-vs-set-tiling
[105.773700] Subtest framebuffer-vs-set-tiling: SUCCESS (0.000s)
[106.262170] [078/165] (897s left) kms_addfb_basic (invalid-get-prop)
[106.336716] Starting subtest: invalid-get-prop
[106.337202] Subtest invalid-get-prop: SUCCESS (0.000s)
[106.795679] [079/165] (897s left) kms_addfb_basic (invalid-get-prop-any)
[106.874450] Starting subtest: invalid-get-prop-any
[106.874896] Subtest invalid-get-prop-any: SUCCESS (0.000s)
[107.338675] [080/165] (896s left) kms_addfb_basic (invalid-set-prop)
[107.424694] Starting subtest: invalid-set-prop
[107.425253] Subtest invalid-set-prop: SUCCESS (0.000s)
[107.891993] [081/165] (896s left) kms_addfb_basic (invalid-set-prop-any)
[107.955211] Starting subtest: invalid-set-prop-any
[107.955746] Subtest invalid-set-prop-any: SUCCESS (0.000s)
[108.448499] [082/165] (895s left) kms_addfb_basic (no-handle)
[108.523265] Starting subtest: no-handle
[108.523946] Subtest no-handle: SUCCESS (0.000s)
[109.016257] [083/165] (894s left) kms_addfb_basic (size-max)
[109.444594] Starting subtest: size-max
[109.445128] Subtest size-max: SUCCESS (0.000s)
[109.553268] [084/165] (894s left) kms_addfb_basic (small-bo)
[110.006443] Starting subtest: small-bo
[110.007162] Subtest small-bo: SUCCESS (0.000s)
[110.131569] [085/165] (893s left) kms_addfb_basic (tile-pitch-mismatch)
[110.202168] Starting subtest: tile-pitch-mismatch
[110.202792] Subtest tile-pitch-mismatch: SUCCESS (0.000s)
[110.705858] [086/165] (893s left) kms_addfb_basic (too-high)
[111.141526] Starting subtest: too-high
[111.142886] Subtest too-high: SUCCESS (0.001s)
[111.237190] [087/165] (892s left) kms_addfb_basic (too-wide)
[111.693884] Starting subtest: too-wide
[111.694650] Subtest too-wide: SUCCESS (0.000s)
[111.824132] [088/165] (892s left) kms_addfb_basic (unused-handle)
[111.884397] Starting subtest: unused-handle
[111.884999] Subtest unused-handle: SUCCESS (0.000s)
[112.359092] [089/165] (891s left) kms_addfb_basic (unused-modifier)
[112.443789] Starting subtest: unused-modifier
[112.444353] Subtest unused-modifier: SUCCESS (0.000s)
[112.949851] [090/165] (891s left) kms_addfb_basic (unused-offsets)
[113.021813] Starting subtest: unused-offsets
[113.022370] Subtest unused-offsets: SUCCESS (0.000s)
[113.534458] [091/165] (890s left) kms_addfb_basic (unused-pitches)
[113.604399] Starting subtest: unused-pitches
[113.605144] Subtest unused-pitches: SUCCESS (0.000s)
[114.114944] [092/165] (890s left) kms_busy (basic)
[114.562619] Starting subtest: basic
[114.564106] Starting dynamic subtest: flip
[115.273718] Dynamic subtest flip: SUCCESS (0.709s)
[115.281375] Starting dynamic subtest: modeset
[116.456222] Dynamic subtest modeset: SUCCESS (1.181s)
[116.456920] Subtest basic: SUCCESS (1.894s)
[116.770609] [093/165] (887s left) kms_prop_blob (basic)
[116.841415] Starting subtest: basic
[116.841875] Subtest basic: SUCCESS (0.000s)
[116.902305] [094/165] (887s left) kms_cursor_legacy (basic-busy-flip-before-cursor-atomic)
[117.336917] Starting subtest: basic-busy-flip-before-cursor-atomic
[117.338335] Subtest basic-busy-flip-before-cursor-atomic: SKIP (0.000s)
[117.426565] [095/165] (887s left) kms_cursor_legacy (basic-busy-flip-before-cursor-legacy)
[117.876634] Starting subtest: basic-busy-flip-before-cursor-legacy
[117.877925] Subtest basic-busy-flip-before-cursor-legacy: SKIP (0.000s)
[117.977644] [096/165] (886s left) kms_cursor_legacy (basic-flip-after-cursor-atomic)
[118.430956] Starting subtest: basic-flip-after-cursor-atomic
[119.424093] Subtest basic-flip-after-cursor-atomic: SUCCESS (0.992s)
[119.687864] [097/165] (884s left) kms_cursor_legacy (basic-flip-after-cursor-legacy)
[120.115101] Starting subtest: basic-flip-after-cursor-legacy
[121.105461] Subtest basic-flip-after-cursor-legacy: SUCCESS (0.991s)
[121.359573] [098/165] (883s left) kms_cursor_legacy (basic-flip-after-cursor-varying-size)
[121.803873] Starting subtest: basic-flip-after-cursor-varying-size
[122.786081] Subtest basic-flip-after-cursor-varying-size: SUCCESS (0.981s)
[123.081755] [099/165] (881s left) kms_cursor_legacy (basic-flip-before-cursor-atomic)
[123.526871] Starting subtest: basic-flip-before-cursor-atomic
[124.504300] Subtest basic-flip-before-cursor-atomic: SUCCESS (0.978s)
[124.792348] [100/165] (879s left) kms_cursor_legacy (basic-flip-before-cursor-legacy)
[125.241977] Starting subtest: basic-flip-before-cursor-legacy
[126.218978] Subtest basic-flip-before-cursor-legacy: SUCCESS (0.977s)
[126.480672] [101/165] (878s left) kms_cursor_legacy (basic-flip-before-cursor-varying-size)
[126.922973] Starting subtest: basic-flip-before-cursor-varying-size
[127.924358] Subtest basic-flip-before-cursor-varying-size: SUCCESS (0.998s)
[128.298826] [102/165] (876s left) kms_dsc (dsc-basic)
[128.742222] Subtest dsc-basic: SKIP (0.000s)
[128.768601] [103/165] (875s left) kms_flip (basic-flip-vs-dpms)
[128.962542] Starting subtest: basic-flip-vs-dpms
[128.964971] Starting dynamic subtest: A-DP1
[129.995332] Dynamic subtest A-DP1: SUCCESS (1.029s)
[130.017828] Starting dynamic subtest: B-DP1
[131.043734] Dynamic subtest B-DP1: SUCCESS (1.042s)
[131.067261] Starting dynamic subtest: C-DP1
[132.076874] Dynamic subtest C-DP1: SUCCESS (1.030s)
[132.079861] Subtest basic-flip-vs-dpms: SUCCESS (3.117s)
[132.399535] [104/165] (872s left) kms_flip (basic-flip-vs-modeset)
[132.625728] Starting subtest: basic-flip-vs-modeset
[132.628129] Starting dynamic subtest: A-DP1
[133.729333] Dynamic subtest A-DP1: SUCCESS (1.098s)
[133.745190] Starting dynamic subtest: B-DP1
[134.925911] Dynamic subtest B-DP1: SUCCESS (1.196s)
[134.939877] Starting dynamic subtest: C-DP1
[136.137511] Dynamic subtest C-DP1: SUCCESS (1.204s)
[136.140644] Subtest basic-flip-vs-modeset: SUCCESS (3.512s)
[136.494090] [105/165] (868s left) kms_flip (basic-flip-vs-wf_vblank)
[136.719537] Starting subtest: basic-flip-vs-wf_vblank
[136.721715] Starting dynamic subtest: A-DP1
[138.001421] Dynamic subtest A-DP1: SUCCESS (1.279s)
[138.013982] Starting dynamic subtest: B-DP1
[139.270402] Dynamic subtest B-DP1: SUCCESS (1.267s)
[139.279037] Starting dynamic subtest: C-DP1
[140.623861] Dynamic subtest C-DP1: SUCCESS (1.351s)
[140.626118] Subtest basic-flip-vs-wf_vblank: SUCCESS (3.907s)
[140.992179] [106/165] (863s left) kms_flip (basic-plain-flip)
[141.196205] Starting subtest: basic-plain-flip
[141.197786] Starting dynamic subtest: A-DP1
[142.204130] Dynamic subtest A-DP1: SUCCESS (1.004s)
[142.212118] Starting dynamic subtest: B-DP1
[143.165277] Dynamic subtest B-DP1: SUCCESS (0.962s)
[143.175391] Starting dynamic subtest: C-DP1
[144.181668] Dynamic subtest C-DP1: SUCCESS (1.014s)
[144.183931] Subtest basic-plain-flip: SUCCESS (2.988s)
[144.525947] [107/165] (860s left) kms_force_connector_basic (force-connector-state)
[144.793916] Starting subtest: force-connector-state
[145.742095] Subtest force-connector-state: SUCCESS (0.954s)
[146.586706] [108/165] (858s left) kms_force_connector_basic (force-edid)
[146.843597] Starting subtest: force-edid
[147.248371] Subtest force-edid: SUCCESS (0.403s)
[147.880046] [109/165] (857s left) kms_force_connector_basic (force-load-detect)
[148.131986] Starting subtest: force-load-detect
[148.133412] Subtest force-load-detect: SKIP (0.000s)
[148.572619] [110/165] (856s left) kms_force_connector_basic (prune-stale-modes)
[148.850380] Starting subtest: prune-stale-modes
[149.321767] Subtest prune-stale-modes: SUCCESS (0.468s)
[149.916717] [111/165] (855s left) kms_frontbuffer_tracking (basic)
[150.397729] Starting subtest: basic
[153.100330] Subtest basic: SUCCESS (2.698s)
[153.204186] [112/165] (851s left) kms_hdmi_inject (inject-audio)
[153.325971] Starting subtest: inject-audio
[153.842437] Subtest inject-audio: SUCCESS (0.510s)
[154.427658] [113/165] (850s left) kms_pipe_crc_basic (compare-crc-sanitycheck-xr24)
[154.893974] Starting subtest: compare-crc-sanitycheck-xr24
[154.895891] Starting dynamic subtest: pipe-A-DP-1
[155.357614] Dynamic subtest pipe-A-DP-1: SUCCESS (0.460s)
[155.377105] Starting dynamic subtest: pipe-B-DP-1
[155.942394] Dynamic subtest pipe-B-DP-1: SUCCESS (0.576s)
[155.960309] Starting dynamic subtest: pipe-C-DP-1
[156.525545] Dynamic subtest pipe-C-DP-1: SUCCESS (0.576s)
[156.526964] Subtest compare-crc-sanitycheck-xr24: SUCCESS (1.630s)
[156.832521] [114/165] (848s left) kms_pipe_crc_basic (compare-crc-sanitycheck-nv12)
[157.294696] Starting subtest: compare-crc-sanitycheck-nv12
[157.297370] Starting dynamic subtest: pipe-A-DP-1
[157.783819] Dynamic subtest pipe-A-DP-1: SUCCESS (0.486s)
[157.796314] Starting dynamic subtest: pipe-B-DP-1
[158.382434] Dynamic subtest pipe-B-DP-1: SUCCESS (0.594s)
[158.401314] Starting dynamic subtest: pipe-C-DP-1
[158.402793] Dynamic subtest pipe-C-DP-1: SKIP (0.002s)
[158.403578] Subtest compare-crc-sanitycheck-nv12: SUCCESS (1.097s)
[158.668748] [115/165] (846s left) kms_pipe_crc_basic (hang-read-crc)
[159.130034] Starting subtest: hang-read-crc
[159.131587] Starting dynamic subtest: pipe-A-DP-1
[160.465955] Dynamic subtest pipe-A-DP-1: SUCCESS (1.333s)
[160.481889] Starting dynamic subtest: pipe-B-DP-1
[161.950198] Dynamic subtest pipe-B-DP-1: SUCCESS (1.472s)
[161.984319] Starting dynamic subtest: pipe-C-DP-1
[163.385817] Dynamic subtest pipe-C-DP-1: SUCCESS (1.426s)
[163.386851] Subtest hang-read-crc: SUCCESS (4.256s)
[163.653429] [116/165] (841s left) kms_pipe_crc_basic (nonblocking-crc)
[164.146134] Starting subtest: nonblocking-crc
[164.147674] Starting dynamic subtest: pipe-A-DP-1
[164.826687] Dynamic subtest pipe-A-DP-1: SUCCESS (0.678s)
[164.838531] Starting dynamic subtest: pipe-B-DP-1
[165.607125] Dynamic subtest pipe-B-DP-1: SUCCESS (0.776s)
[165.621838] Starting dynamic subtest: pipe-C-DP-1
[166.372090] Dynamic subtest pipe-C-DP-1: SUCCESS (0.761s)
[166.374823] Subtest nonblocking-crc: SUCCESS (2.229s)
[166.653465] [117/165] (838s left) kms_pipe_crc_basic (nonblocking-crc-frame-sequence)
[167.133557] Starting subtest: nonblocking-crc-frame-sequence
[167.134972] Starting dynamic subtest: pipe-A-DP-1
[167.826278] Dynamic subtest pipe-A-DP-1: SUCCESS (0.690s)
[167.840694] Starting dynamic subtest: pipe-B-DP-1
[168.594690] Dynamic subtest pipe-B-DP-1: SUCCESS (0.761s)
[168.611384] Starting dynamic subtest: pipe-C-DP-1
[169.368273] Dynamic subtest pipe-C-DP-1: SUCCESS (0.770s)
[169.371144] Subtest nonblocking-crc-frame-sequence: SUCCESS (2.238s)
[169.623835] [118/165] (835s left) kms_pipe_crc_basic (read-crc)
[170.114473] Starting subtest: read-crc
[170.115627] Starting dynamic subtest: pipe-A-DP-1
[170.707691] Dynamic subtest pipe-A-DP-1: SUCCESS (0.589s)
[170.725238] Starting dynamic subtest: pipe-B-DP-1
[171.418374] Dynamic subtest pipe-B-DP-1: SUCCESS (0.701s)
[171.430358] Starting dynamic subtest: pipe-C-DP-1
[172.144115] Dynamic subtest pipe-C-DP-1: SUCCESS (0.725s)
[172.145411] Subtest read-crc: SUCCESS (2.029s)
[172.439418] [119/165] (833s left) kms_pipe_crc_basic (read-crc-frame-sequence)
[172.898844] Starting subtest: read-crc-frame-sequence
[172.901129] Starting dynamic subtest: pipe-A-DP-1
[173.511266] Dynamic subtest pipe-A-DP-1: SUCCESS (0.608s)
[173.525376] Starting dynamic subtest: pipe-B-DP-1
[174.232242] Dynamic subtest pipe-B-DP-1: SUCCESS (0.715s)
[174.248254] Starting dynamic subtest: pipe-C-DP-1
[174.937875] Dynamic subtest pipe-C-DP-1: SUCCESS (0.701s)
[174.938950] Subtest read-crc-frame-sequence: SUCCESS (2.038s)
[175.179209] [120/165] (830s left) kms_pm_backlight (basic-brightness)
[175.670981] Subtest basic-brightness: SKIP (0.000s)
[175.704046] [121/165] (829s left) kms_pm_rpm (basic-pci-d3-state)
[177.621560] Starting subtest: basic-pci-d3-state
[178.223670] Subtest basic-pci-d3-state: SUCCESS (0.604s)
[178.530294] [122/165] (827s left) kms_pm_rpm (basic-rte)
[178.621912] Starting subtest: basic-rte
[181.128866] Subtest basic-rte: SUCCESS (2.507s)
[182.488780] [123/165] (823s left) kms_psr (primary_page_flip)
[182.579859] Subtest primary_page_flip: SKIP (0.000s)
[182.626569] [124/165] (823s left) kms_psr (cursor_plane_move)
[182.687868] Subtest cursor_plane_move: SKIP (0.000s)
[182.705995] [125/165] (823s left) kms_psr (sprite_plane_onoff)
[182.759753] Subtest sprite_plane_onoff: SKIP (0.000s)
[182.789274] [126/165] (822s left) kms_psr (primary_mmap_gtt)
[182.843088] Subtest primary_mmap_gtt: SKIP (0.000s)
[182.872183] [127/165] (822s left) kms_setmode (basic-clone-single-crtc)
[182.930658] Starting subtest: basic-clone-single-crtc
[182.932301] Subtest basic-clone-single-crtc: SKIP (0.000s)
[183.024601] [128/165] (822s left) i915_pm_rps (basic-api)
[183.099127] Starting subtest: basic-api
[183.102609] Subtest basic-api: SUCCESS (0.004s)
[183.165029] [129/165] (822s left) prime_self_import (basic-llseek-bad)
[183.219978] Starting subtest: basic-llseek-bad
[183.224032] Subtest basic-llseek-bad: SUCCESS (0.002s)
[183.306269] [130/165] (822s left) prime_self_import (basic-llseek-size)
[183.371716] Starting subtest: basic-llseek-size
[183.375152] Subtest basic-llseek-size: SUCCESS (0.004s)
[183.462378] [131/165] (822s left) prime_self_import (basic-with_fd_dup)
[183.535356] Starting subtest: basic-with_fd_dup
[183.538123] Subtest basic-with_fd_dup: SUCCESS (0.003s)
[183.616833] [132/165] (822s left) prime_self_import (basic-with_one_bo)
[183.676371] Starting subtest: basic-with_one_bo
[183.679236] Subtest basic-with_one_bo: SUCCESS (0.003s)
[183.738756] [133/165] (822s left) prime_self_import (basic-with_one_bo_two_files)
[183.791864] Starting subtest: basic-with_one_bo_two_files
[183.794784] Subtest basic-with_one_bo_two_files: SUCCESS (0.002s)
[183.894143] [134/165] (822s left) prime_self_import (basic-with_two_bos)
[183.967136] Starting subtest: basic-with_two_bos
[183.968088] Subtest basic-with_two_bos: SUCCESS (0.003s)
[184.077228] [135/165] (821s left) prime_vgem (basic-fence-flip)
[184.162894] Starting subtest: basic-fence-flip
[184.999389] Subtest basic-fence-flip: SUCCESS (0.836s)
[185.116952] [136/165] (820s left) prime_vgem (basic-fence-mmap)
[185.189951] Starting subtest: basic-fence-mmap
[185.212338] Subtest basic-fence-mmap: SUCCESS (0.027s)
[185.330300] [137/165] (820s left) prime_vgem (basic-fence-read)
[185.438489] Starting subtest: basic-fence-read
[185.486498] Subtest basic-fence-read: SUCCESS (0.048s)
[185.550266] [138/165] (820s left) prime_vgem (basic-gtt)
[185.623181] Starting subtest: basic-gtt
[185.631330] Subtest basic-gtt: SUCCESS (0.013s)
[185.761588] [139/165] (820s left) prime_vgem (basic-read)
[185.835484] Starting subtest: basic-read
[185.855130] Subtest basic-read: SUCCESS (0.020s)
[185.937659] [140/165] (820s left) prime_vgem (basic-write)
[186.028426] Starting subtest: basic-write
[186.051285] Subtest basic-write: SUCCESS (0.023s)
[186.113523] [141/165] (819s left) vgem_basic (setversion)
[186.182919] Starting subtest: setversion
[186.184036] Subtest setversion: SUCCESS (0.000s)
[186.229426] [142/165] (819s left) vgem_basic (create)
[186.298958] Starting subtest: create
[186.299635] Subtest create: SUCCESS (0.000s)
[186.351736] [143/165] (819s left) vgem_basic (debugfs)
[186.430265] Starting subtest: debugfs
[186.430836] Subtest debugfs: SUCCESS (0.000s)
[186.483046] [144/165] (819s left) vgem_basic (dmabuf-export)
[186.546957] Starting subtest: dmabuf-export
[186.551332] Subtest dmabuf-export: SUCCESS (0.002s)
[186.633449] [145/165] (819s left) vgem_basic (dmabuf-fence)
[186.697120] Starting subtest: dmabuf-fence
[186.697797] Subtest dmabuf-fence: SUCCESS (0.001s)
[186.745364] [146/165] (819s left) vgem_basic (dmabuf-fence-before)
[186.814510] Starting subtest: dmabuf-fence-before
[186.814962] Subtest dmabuf-fence-before: SUCCESS (0.000s)
[186.863449] [147/165] (819s left) vgem_basic (dmabuf-mmap)
[186.932862] Starting subtest: dmabuf-mmap
[186.943513] Subtest dmabuf-mmap: SUCCESS (0.013s)
[187.001416] [148/165] (819s left) vgem_basic (mmap)
[187.063625] Starting subtest: mmap
[187.072783] Subtest mmap: SUCCESS (0.009s)
[187.111903] [149/165] (819s left) vgem_basic (second-client)
[187.181818] Starting subtest: second-client
[187.215978] Subtest second-client: SUCCESS (0.033s)
[187.301928] [150/165] (818s left) vgem_basic (sysfs)
[187.380308] Starting subtest: sysfs
[187.380914] Subtest sysfs: SUCCESS (0.001s)
[187.431629] [151/165] (818s left) core_hotunplug (unbind-rebind)
[187.566411] Starting subtest: unbind-rebind
[191.356228] Subtest unbind-rebind: SUCCESS (3.791s)
[191.375333] [152/165] (814s left) vgem_basic (unload)
[191.431609] Starting subtest: unload
[220.457831] Subtest unload: SUCCESS (29.025s)
[220.565979] [153/165] (785s left) i915_module_load (reload)
[220.626497] Starting subtest: reload
[223.613488] Subtest reload: SUCCESS (2.985s)
[223.648050] [154/165] (782s left) gem_lmem_swapping (basic)
[223.767972] Subtest basic: SKIP (0.000s)
[223.803748] [155/165] (782s left) gem_lmem_swapping (parallel-random-engines)
[223.862062] Subtest parallel-random-engines: SKIP (0.000s)
[223.886681] [156/165] (782s left) gem_lmem_swapping (random-engines)
[223.945505] Subtest random-engines: SKIP (0.000s)
[223.969776] [157/165] (782s left) gem_lmem_swapping (verify-random)
[224.025704] Subtest verify-random: SKIP (0.000s)
[224.053572] [158/165] (782s left) i915_pm_rpm (module-reload)
[226.393737] Starting subtest: module-reload
[236.784261] Subtest module-reload: SUCCESS (10.393s)
[236.803813] [159/165] (769s left) i915_selftest (live)
[236.873501] Starting subtest: live
[236.875101] Starting dynamic subtest: sanitycheck
[238.121181] Dynamic subtest sanitycheck: SUCCESS (1.245s)
[238.127308] Starting dynamic subtest: uncore
[239.379118] Dynamic subtest uncore: SUCCESS (1.256s)
[239.387271] Starting dynamic subtest: workarounds
[240.882596] Dynamic subtest workarounds: SUCCESS (1.503s)
[240.891427] Starting dynamic subtest: gt_engines
[242.667172] Dynamic subtest gt_engines: SUCCESS (1.781s)
[242.673279] Starting dynamic subtest: gt_timelines
[253.548601] Dynamic subtest gt_timelines: SUCCESS (10.881s)
[253.555695] Starting dynamic subtest: gt_contexts
[254.945461] Dynamic subtest gt_contexts: SUCCESS (1.395s)
[254.952533] Starting dynamic subtest: gt_lrc
[259.111507] Dynamic subtest gt_lrc: SUCCESS (4.165s)
[259.119360] Starting dynamic subtest: gt_mocs
[260.487185] Dynamic subtest gt_mocs: SUCCESS (1.372s)
[260.492604] Starting dynamic subtest: gt_pm
[267.694038] Dynamic subtest gt_pm: SUCCESS (7.206s)
[267.700908] Starting dynamic subtest: gt_heartbeat
[269.061759] Dynamic subtest gt_heartbeat: SUCCESS (1.367s)
[269.070090] Starting dynamic subtest: gt_tlb
[271.599382] Dynamic subtest gt_tlb: SUCCESS (2.536s)
[271.608023] Starting dynamic subtest: requests
[280.345645] Dynamic subtest requests: SUCCESS (8.744s)
[280.352383] Starting dynamic subtest: migrate
[284.423501] Dynamic subtest migrate: SUCCESS (4.076s)
[284.430974] Starting dynamic subtest: active
[285.720432] Dynamic subtest active: SUCCESS (1.295s)
[285.728969] Starting dynamic subtest: objects
[287.890574] Dynamic subtest objects: SUCCESS (2.168s)
[287.898555] Starting dynamic subtest: mman
[292.901415] Dynamic subtest mman: SUCCESS (5.009s)
[292.915743] Starting dynamic subtest: dmabuf
[294.249543] Dynamic subtest dmabuf: SUCCESS (1.346s)
[294.258168] Starting dynamic subtest: vma
[295.536449] Dynamic subtest vma: SUCCESS (1.285s)
[295.543527] Starting dynamic subtest: coherency
[297.605155] Dynamic subtest coherency: SUCCESS (2.065s)
[297.610131] Starting dynamic subtest: gtt
[306.378535] Dynamic subtest gtt: SUCCESS (8.774s)
[306.385394] Starting dynamic subtest: gem
[307.801510] Dynamic subtest gem: SUCCESS (1.422s)
[307.810957] Starting dynamic subtest: evict
[310.555130] Dynamic subtest evict: SUCCESS (2.750s)
[310.563263] Starting dynamic subtest: hugepages
[317.775746] Dynamic subtest hugepages: SUCCESS (7.220s)
[317.783173] Starting dynamic subtest: gem_contexts
[334.593752] Dynamic subtest gem_contexts: SUCCESS (16.816s)
[334.602515] Starting dynamic subtest: client
[335.913688] Dynamic subtest client: SUCCESS (1.318s)
[335.921222] Starting dynamic subtest: gem_migrate
[337.144615] Dynamic subtest gem_migrate: SUCCESS (1.229s)
[337.154678] Starting dynamic subtest: reset
[339.044514] Dynamic subtest reset: SUCCESS (1.898s)
[339.053025] Starting dynamic subtest: memory_region
[340.265666] Dynamic subtest memory_region: SUCCESS (1.219s)
[340.272042] Starting dynamic subtest: hangcheck
[370.023950] Dynamic subtest hangcheck: SUCCESS (29.757s)
[370.032703] Starting dynamic subtest: execlists
[383.915249] Dynamic subtest execlists: SUCCESS (13.888s)
[383.922919] Starting dynamic subtest: ring_submission
[385.181577] Dynamic subtest ring_submission: SUCCESS (1.266s)
[385.189802] Starting dynamic subtest: perf
[386.567445] Dynamic subtest perf: SUCCESS (1.384s)
[386.574931] Starting dynamic subtest: slpc
[387.825157] Dynamic subtest slpc: SUCCESS (1.254s)
[387.831551] Starting dynamic subtest: guc
[389.080096] Dynamic subtest guc: SUCCESS (1.253s)
[389.085756] Starting dynamic subtest: guc_multi_lrc
[390.328601] Dynamic subtest guc_multi_lrc: SUCCESS (1.248s)
[390.334676] Starting dynamic subtest: guc_hang
[391.595143] Dynamic subtest guc_hang: SUCCESS (1.263s)
[391.600415] Starting dynamic subtest: late_gt_pm
[392.901801] Dynamic subtest late_gt_pm: SUCCESS (1.307s)
[392.902805] Subtest live: SUCCESS (156.029s)
[392.922470] [160/165] (613s left) dmabuf (all-tests)
[392.986534] Starting subtest: all-tests
[392.987951] Starting dynamic subtest: sanitycheck
[393.052228] Dynamic subtest sanitycheck: SUCCESS (0.062s)
[393.064116] Starting dynamic subtest: dma_fence
[393.222977] Dynamic subtest dma_fence: SUCCESS (0.170s)
[393.231571] Starting dynamic subtest: dma_fence_chain
[407.485154] Dynamic subtest dma_fence_chain: SUCCESS (14.260s)
[407.496810] Starting dynamic subtest: dma_fence_unwrap
[407.559657] Dynamic subtest dma_fence_unwrap: SUCCESS (0.071s)
[407.589694] Starting dynamic subtest: dma_resv
[407.650226] Dynamic subtest dma_resv: SUCCESS (0.083s)
[407.658899] Subtest all-tests: SUCCESS (14.665s)
[407.693738] [161/165] (598s left) i915_suspend (basic-s2idle-without-i915)
[407.747124] Starting subtest: basic-s2idle-without-i915
[426.882325] Subtest basic-s2idle-without-i915: SUCCESS (4.754s)
[430.281941] [162/165] (593s left) i915_suspend (basic-s3-without-i915)
[430.337105] Starting subtest: basic-s3-without-i915
[448.515840] Subtest basic-s3-without-i915: SUCCESS (3.660s)
[451.644592] [163/165] (589s left) gem_exec_suspend (basic-s0)
[451.738965] Starting subtest: basic-S0
[451.739917] Starting dynamic subtest: smem
[470.459416] Dynamic subtest smem: SUCCESS (3.333s)
[470.465749] Subtest basic-S0: SUCCESS (3.335s)
[475.615050] [164/165] (585s left) gem_exec_suspend (basic-s3)
[475.681604] Starting subtest: basic-S3
[475.683580] Starting dynamic subtest: smem
[494.493080] Dynamic subtest smem: SUCCESS (3.646s)
[494.495147] Subtest basic-S3: SUCCESS (3.648s)
[497.545047] [165/165] (581s left) kms_pipe_crc_basic (suspend-read-crc)
[497.976613] Starting subtest: suspend-read-crc
[497.977194] Starting dynamic subtest: pipe-A-DP-1
[517.450324] Dynamic subtest pipe-A-DP-1: SUCCESS (2.914s)
[520.037767] Closing watchdogs
Done.