[40.368210] Initializing watchdogs
[40.368426]   /dev/watchdog0
[40.399496] [001/161] (960s left) i915_module_load (load)
[40.590253] Starting subtest: load
[42.249400] Subtest load: SUCCESS (1.665s)
[42.372913] [002/161] (958s left) core_auth (basic-auth)
[42.615089] Starting subtest: basic-auth
[42.635784] Subtest basic-auth: SUCCESS (0.001s)
[42.710962] [003/161] (958s left) debugfs_test (read_all_entries)
[42.885088] Starting subtest: read_all_entries
[42.925763] Subtest read_all_entries: SUCCESS (0.052s)
[43.031596] [004/161] (958s left) debugfs_test (basic-hwmon)
[43.237070] Starting subtest: basic-hwmon
[43.277778] Subtest basic-hwmon: SKIP (0.000s)
[43.355528] [005/161] (957s left) debugfs_test (sysfs)
[43.529265] Starting subtest: sysfs
[43.550109] Subtest sysfs: SUCCESS (0.022s)
[43.632867] [006/161] (957s left) fbdev (eof)
[43.793429] Starting subtest: eof
[43.815277] Subtest eof: SUCCESS (0.001s)
[43.918768] [007/161] (957s left) fbdev (info)
[44.090420] Starting subtest: info
[44.112106] Subtest info: SUCCESS (0.000s)
[44.210834] [008/161] (957s left) fbdev (nullptr)
[44.349733] Starting subtest: nullptr
[44.373128] Subtest nullptr: SUCCESS (0.000s)
[44.466331] [009/161] (957s left) fbdev (read)
[44.609937] Starting subtest: read
[44.870142] Subtest read: SUCCESS (0.276s)
[44.966880] [010/161] (956s left) fbdev (write)
[45.108972] Starting subtest: write
[45.234237] Subtest write: SUCCESS (0.139s)
[45.335603] [011/161] (956s left) gem_basic (bad-close)
[45.506993] Starting subtest: bad-close
[45.548868] Subtest bad-close: SUCCESS (0.000s)
[45.624704] [012/161] (956s left) gem_basic (create-close)
[45.820272] Starting subtest: create-close
[45.867287] Subtest create-close: SUCCESS (0.000s)
[45.951142] [013/161] (955s left) gem_basic (create-fd-close)
[46.152715] Starting subtest: create-fd-close
[46.196378] Subtest create-fd-close: SUCCESS (0.000s)
[46.271774] [014/161] (955s left) gem_busy (busy@all-engines)
[46.456219] Starting subtest: busy
[46.475955] Starting dynamic subtest: all-engines
[46.495377] Dynamic subtest all-engines: SUCCESS (0.031s)
[46.514546] Subtest busy: SUCCESS (0.031s)
[46.838304] [015/161] (955s left) gem_close_race (basic-process)
[47.027673] Starting subtest: basic-process
[47.068122] Subtest basic-process: SUCCESS (0.058s)
[47.284674] [016/161] (954s left) gem_close_race (basic-threads)
[47.484768] Starting subtest: basic-threads
[48.606351] Subtest basic-threads: SUCCESS (1.169s)
[48.825870] [017/161] (953s left) gem_ctx_create (basic)
[48.995866] Starting subtest: basic
[49.016950] Subtest basic: SUCCESS (0.000s)
[49.166418] [018/161] (953s left) gem_ctx_create (basic-files)
[49.339378] Starting subtest: basic-files
[51.372030] Subtest basic-files: SUCCESS (2.021s)
[51.614805] [019/161] (950s left) gem_ctx_exec (basic)
[51.823131] Starting subtest: basic
[51.848638] Subtest basic: SUCCESS (0.001s)
[51.951284] [020/161] (950s left) gem_exec_basic (basic)
[52.145907] Starting subtest: basic
[52.167414] Starting dynamic subtest: rcs0-smem
[52.188692] Dynamic subtest rcs0-smem: SUCCESS (0.001s)
[52.222883] Starting dynamic subtest: vcs0-smem
[52.242540] Dynamic subtest vcs0-smem: SUCCESS (0.000s)
[52.261724] Subtest basic: SUCCESS (0.002s)
[52.346563] [021/161] (950s left) gem_exec_create (basic)
[52.525243] Starting subtest: basic
[52.548117] Starting dynamic subtest: smem
[54.561857] Dynamic subtest smem: SUCCESS (2.046s)
[54.581243] Subtest basic: SUCCESS (2.046s)
[54.759857] [022/161] (947s left) gem_exec_fence (basic-busy)
[55.050677] Starting subtest: basic-busy
[55.070247] Starting dynamic subtest: rcs0
[55.109029] Dynamic subtest rcs0: SUCCESS (0.025s)
[55.139083] Starting dynamic subtest: vcs0
[55.182967] Dynamic subtest vcs0: SUCCESS (0.027s)
[55.204162] Subtest basic-busy: SUCCESS (0.053s)
[55.667918] [023/161] (946s left) gem_exec_fence (basic-wait)
[55.956148] Starting subtest: basic-wait
[55.978700] Starting dynamic subtest: rcs0
[56.000940] Dynamic subtest rcs0: SUCCESS (0.029s)
[56.034556] Starting dynamic subtest: vcs0
[56.055705] Dynamic subtest vcs0: SUCCESS (0.024s)
[56.076248] Subtest basic-wait: SUCCESS (0.053s)
[56.529200] [024/161] (946s left) gem_exec_fence (basic-await)
[56.833673] Starting subtest: basic-await
[56.853816] Starting dynamic subtest: rcs0
[56.909070] Dynamic subtest rcs0: SUCCESS (0.072s)
[56.937816] Starting dynamic subtest: vcs0
[56.983649] Dynamic subtest vcs0: SUCCESS (0.075s)
[57.003270] Subtest basic-await: SUCCESS (0.149s)
[57.499731] [025/161] (945s left) gem_exec_fence (nb-await)
[57.788151] Starting subtest: nb-await
[57.809436] Starting dynamic subtest: rcs0
[57.851918] Dynamic subtest rcs0: SUCCESS (0.054s)
[57.881146] Starting dynamic subtest: vcs0
[57.900536] Dynamic subtest vcs0: SUCCESS (0.056s)
[57.921073] Subtest nb-await: SUCCESS (0.111s)
[58.431156] [026/161] (944s left) gem_exec_gttfill (basic)
[58.607671] Starting subtest: basic
[68.286870] Subtest basic: SUCCESS (9.706s)
[68.496374] [027/161] (934s left) gem_exec_parallel (engines)
[68.816124] Starting subtest: engines
[68.834996] Starting dynamic subtest: basic
[70.408106] Dynamic subtest basic: SUCCESS (1.603s)
[70.435936] Starting dynamic subtest: contexts
[72.175288] Dynamic subtest contexts: SUCCESS (1.776s)
[72.201208] Starting dynamic subtest: fds
[72.243591] Dynamic subtest fds: SKIP (0.001s)
[72.271413] Starting dynamic subtest: userptr
[73.930823] Dynamic subtest userptr: SUCCESS (1.743s)
[73.950390] Subtest engines: SUCCESS (5.124s)
[74.131372] [028/161] (928s left) gem_exec_store (basic)
[74.380621] Starting subtest: basic
[74.400100] Subtest basic: SUCCESS (0.037s)
[74.557576] [029/161] (928s left) gem_flink_basic (bad-flink)
[74.748143] Starting subtest: bad-flink
[74.769975] Subtest bad-flink: SUCCESS (0.000s)
[74.852619] [030/161] (928s left) gem_flink_basic (bad-open)
[75.043490] Starting subtest: bad-open
[75.062920] Subtest bad-open: SUCCESS (0.000s)
[75.139775] [031/161] (928s left) gem_flink_basic (basic)
[75.327398] Starting subtest: basic
[75.346895] Subtest basic: SUCCESS (0.000s)
[75.430728] [032/161] (927s left) gem_flink_basic (double-flink)
[75.610633] Starting subtest: double-flink
[75.632300] Subtest double-flink: SUCCESS (0.000s)
[75.717765] [033/161] (927s left) gem_flink_basic (flink-lifetime)
[75.899558] Starting subtest: flink-lifetime
[75.921662] Subtest flink-lifetime: SUCCESS (0.002s)
[76.001083] [034/161] (927s left) gem_huc_copy (huc-copy)
[76.216381] Subtest huc-copy: SKIP (0.000s)
[76.295325] [035/161] (927s left) gem_linear_blits (basic)
[76.574034] Starting subtest: basic
[76.596908] Subtest basic: SUCCESS (0.014s)
[76.745697] [036/161] (926s left) gem_mmap (basic)
[77.059460] Starting subtest: basic
[77.158902] Subtest basic: SUCCESS (0.000s)
[77.241311] [037/161] (926s left) gem_mmap_gtt (basic)
[77.426551] Starting subtest: basic
[77.448129] Subtest basic: SUCCESS (0.001s)
[77.527443] [038/161] (926s left) gem_render_linear_blits (basic)
[77.719515] Starting subtest: basic
[77.818935] Subtest basic: SUCCESS (0.041s)
[77.902099] [039/161] (925s left) gem_render_tiled_blits (basic)
[78.064588] Starting subtest: basic
[78.188302] Subtest basic: SUCCESS (0.042s)
[78.271182] [040/161] (925s left) gem_ringfill (basic-all)
[78.523806] Starting subtest: basic-all
[79.597311] Subtest basic-all: SUCCESS (1.106s)
[79.707873] [041/161] (924s left) gem_softpin (allocator-basic)
[79.913054] Subtest allocator-basic: SKIP (0.000s)
[80.024956] [042/161] (923s left) gem_softpin (allocator-basic-reserve)
[80.204612] Subtest allocator-basic-reserve: SKIP (0.000s)
[80.304981] [043/161] (923s left) gem_softpin (safe-alignment)
[80.532620] Starting subtest: safe-alignment
[80.552069] Subtest safe-alignment: SUCCESS (0.009s)
[80.643539] [044/161] (923s left) gem_sync (basic-all)
[80.874423] Starting subtest: basic-all
[82.865885] Subtest basic-all: SUCCESS (2.040s)
[83.079806] [045/161] (921s left) gem_sync (basic-each)
[83.316821] Starting subtest: basic-each
[85.359188] Subtest basic-each: SUCCESS (2.102s)
[85.576681] [046/161] (918s left) gem_tiled_blits (basic)
[85.833783] Starting subtest: basic
[85.875461] Subtest basic: SUCCESS (0.036s)
[86.024826] [047/161] (918s left) gem_tiled_fence_blits (basic)
[86.397218] Starting subtest: basic
[86.420091] Subtest basic: SUCCESS (0.014s)
[86.569277] [048/161] (917s left) gem_tiled_pread_basic
[87.126740] [049/161] (917s left) gem_wait (busy@all-engines)
[87.313945] Starting subtest: busy
[87.334565] Starting dynamic subtest: all-engines
[87.820936] Dynamic subtest all-engines: SUCCESS (0.523s)
[87.840574] Subtest busy: SUCCESS (0.523s)
[88.091314] [050/161] (916s left) gem_wait (wait@all-engines)
[88.262492] Starting subtest: wait
[88.293464] Starting dynamic subtest: all-engines
[89.287200] Dynamic subtest all-engines: SUCCESS (1.022s)
[89.316157] Subtest wait: SUCCESS (1.022s)
[89.538439] [051/161] (915s left) i915_getparams_basic (basic-eu-total)
[89.753208] Starting subtest: basic-eu-total
[89.803566] Subtest basic-eu-total: SUCCESS (0.000s)
[89.903091] [052/161] (914s left) i915_getparams_basic (basic-subslice-total)
[90.083927] Starting subtest: basic-subslice-total
[90.133070] Subtest basic-subslice-total: SUCCESS (0.000s)
[90.236754] [053/161] (914s left) i915_hangman (error-state-basic)
[90.459584] Starting subtest: error-state-basic
[90.485087] Subtest error-state-basic: SUCCESS (0.006s)
[90.604371] [054/161] (914s left) i915_pciid
[90.895822] [055/161] (914s left) kms_addfb_basic (addfb25-4-tiled)
[91.128790] Starting subtest: addfb25-4-tiled
[91.150493] Subtest addfb25-4-tiled: SUCCESS (0.000s)
[91.232266] [056/161] (913s left) kms_addfb_basic (addfb25-bad-modifier)
[91.420509] Starting subtest: addfb25-bad-modifier
[91.441221] Subtest addfb25-bad-modifier: SUCCESS (0.000s)
[91.519221] [057/161] (913s left) kms_addfb_basic (addfb25-framebuffer-vs-set-tiling)
[91.702121] Starting subtest: addfb25-framebuffer-vs-set-tiling
[91.721664] Subtest addfb25-framebuffer-vs-set-tiling: SUCCESS (0.000s)
[91.803639] [058/161] (913s left) kms_addfb_basic (addfb25-modifier-no-flag)
[91.979879] Starting subtest: addfb25-modifier-no-flag
[92.001351] Subtest addfb25-modifier-no-flag: SUCCESS (0.000s)
[92.086444] [059/161] (913s left) kms_addfb_basic (addfb25-x-tiled-legacy)
[92.260911] Starting subtest: addfb25-x-tiled-legacy
[92.282516] Subtest addfb25-x-tiled-legacy: SUCCESS (0.000s)
[92.360814] [060/161] (912s left) kms_addfb_basic (addfb25-x-tiled-mismatch-legacy)
[92.537188] Starting subtest: addfb25-x-tiled-mismatch-legacy
[92.556541] Subtest addfb25-x-tiled-mismatch-legacy: SUCCESS (0.001s)
[92.635194] [061/161] (912s left) kms_addfb_basic (addfb25-yf-tiled-legacy)
[92.817980] Starting subtest: addfb25-yf-tiled-legacy
[92.837349] Subtest addfb25-yf-tiled-legacy: SUCCESS (0.000s)
[92.921697] [062/161] (912s left) kms_addfb_basic (addfb25-y-tiled-legacy)
[93.096277] Starting subtest: addfb25-y-tiled-legacy
[93.117803] Subtest addfb25-y-tiled-legacy: SUCCESS (0.000s)
[93.209599] [063/161] (912s left) kms_addfb_basic (addfb25-y-tiled-small-legacy)
[93.388723] Starting subtest: addfb25-y-tiled-small-legacy
[93.431076] Subtest addfb25-y-tiled-small-legacy: SKIP (0.000s)
[93.516772] [064/161] (912s left) kms_addfb_basic (bad-pitch-0)
[93.698424] Starting subtest: bad-pitch-0
[93.717541] Subtest bad-pitch-0: SUCCESS (0.000s)
[93.801496] [065/161] (911s left) kms_addfb_basic (bad-pitch-1024)
[93.963812] Starting subtest: bad-pitch-1024
[93.984477] Subtest bad-pitch-1024: SUCCESS (0.000s)
[94.074857] [066/161] (911s left) kms_addfb_basic (bad-pitch-128)
[94.258677] Starting subtest: bad-pitch-128
[94.279858] Subtest bad-pitch-128: SUCCESS (0.000s)
[94.360607] [067/161] (911s left) kms_addfb_basic (bad-pitch-256)
[94.539504] Starting subtest: bad-pitch-256
[94.559997] Subtest bad-pitch-256: SUCCESS (0.000s)
[94.639496] [068/161] (911s left) kms_addfb_basic (bad-pitch-32)
[94.839047] Starting subtest: bad-pitch-32
[94.858216] Subtest bad-pitch-32: SUCCESS (0.000s)
[94.942873] [069/161] (911s left) kms_addfb_basic (bad-pitch-63)
[95.128880] Starting subtest: bad-pitch-63
[95.150964] Subtest bad-pitch-63: SUCCESS (0.000s)
[95.235229] [070/161] (910s left) kms_addfb_basic (bad-pitch-65536)
[95.433246] Starting subtest: bad-pitch-65536
[95.453516] Subtest bad-pitch-65536: SUCCESS (0.000s)
[95.534458] [071/161] (910s left) kms_addfb_basic (bad-pitch-999)
[95.733694] Starting subtest: bad-pitch-999
[95.753479] Subtest bad-pitch-999: SUCCESS (0.000s)
[95.837420] [072/161] (910s left) kms_addfb_basic (basic)
[96.023216] Starting subtest: basic
[96.044520] Subtest basic: SUCCESS (0.000s)
[96.130639] [073/161] (910s left) kms_addfb_basic (basic-x-tiled-legacy)
[96.297818] Starting subtest: basic-x-tiled-legacy
[96.319242] Subtest basic-x-tiled-legacy: SUCCESS (0.000s)
[96.398903] [074/161] (910s left) kms_addfb_basic (basic-y-tiled-legacy)
[96.595124] Starting subtest: basic-y-tiled-legacy
[96.614315] Subtest basic-y-tiled-legacy: SUCCESS (0.000s)
[96.696340] [075/161] (909s left) kms_addfb_basic (bo-too-small)
[96.895278] Starting subtest: bo-too-small
[96.915685] Subtest bo-too-small: SUCCESS (0.000s)
[97.003269] [076/161] (909s left) kms_addfb_basic (bo-too-small-due-to-tiling)
[97.176237] Starting subtest: bo-too-small-due-to-tiling
[97.197358] Subtest bo-too-small-due-to-tiling: SUCCESS (0.000s)
[97.279280] [077/161] (909s left) kms_addfb_basic (clobberred-modifier)
[97.465525] Starting subtest: clobberred-modifier
[97.486383] Subtest clobberred-modifier: SUCCESS (0.000s)
[97.570233] [078/161] (909s left) kms_addfb_basic (framebuffer-vs-set-tiling)
[97.744948] Starting subtest: framebuffer-vs-set-tiling
[97.763950] Subtest framebuffer-vs-set-tiling: SUCCESS (0.000s)
[97.845425] [079/161] (908s left) kms_addfb_basic (invalid-get-prop)
[98.014425] Starting subtest: invalid-get-prop
[98.036364] Subtest invalid-get-prop: SUCCESS (0.000s)
[98.124442] [080/161] (908s left) kms_addfb_basic (invalid-get-prop-any)
[98.308852] Starting subtest: invalid-get-prop-any
[98.330390] Subtest invalid-get-prop-any: SUCCESS (0.000s)
[98.414513] [081/161] (908s left) kms_addfb_basic (invalid-set-prop)
[98.598055] Starting subtest: invalid-set-prop
[98.617626] Subtest invalid-set-prop: SUCCESS (0.000s)
[98.696354] [082/161] (908s left) kms_addfb_basic (invalid-set-prop-any)
[98.865705] Starting subtest: invalid-set-prop-any
[98.883991] Subtest invalid-set-prop-any: SUCCESS (0.000s)
[98.973601] [083/161] (908s left) kms_addfb_basic (no-handle)
[99.171963] Starting subtest: no-handle
[99.193936] Subtest no-handle: SUCCESS (0.000s)
[99.279343] [084/161] (907s left) kms_addfb_basic (size-max)
[99.455114] Starting subtest: size-max
[99.476324] Subtest size-max: SUCCESS (0.000s)
[99.555466] [085/161] (907s left) kms_addfb_basic (small-bo)
[99.753789] Starting subtest: small-bo
[99.774102] Subtest small-bo: SUCCESS (0.000s)
[99.852824] [086/161] (907s left) kms_addfb_basic (tile-pitch-mismatch)
[100.052965] Starting subtest: tile-pitch-mismatch
[100.075293] Subtest tile-pitch-mismatch: SUCCESS (0.000s)
[100.180245] [087/161] (907s left) kms_addfb_basic (too-high)
[100.373054] Starting subtest: too-high
[100.393244] Subtest too-high: SUCCESS (0.001s)
[100.471339] [088/161] (907s left) kms_addfb_basic (too-wide)
[100.657144] Starting subtest: too-wide
[100.676365] Subtest too-wide: SUCCESS (0.000s)
[100.759591] [089/161] (906s left) kms_addfb_basic (unused-handle)
[100.934670] Starting subtest: unused-handle
[100.956419] Subtest unused-handle: SUCCESS (0.000s)
[101.049821] [090/161] (906s left) kms_addfb_basic (unused-modifier)
[101.230031] Starting subtest: unused-modifier
[101.250910] Subtest unused-modifier: SUCCESS (0.000s)
[101.330785] [091/161] (906s left) kms_addfb_basic (unused-offsets)
[101.525948] Starting subtest: unused-offsets
[101.545364] Subtest unused-offsets: SUCCESS (0.000s)
[101.625324] [092/161] (906s left) kms_addfb_basic (unused-pitches)
[101.803582] Starting subtest: unused-pitches
[101.823042] Subtest unused-pitches: SUCCESS (0.000s)
[101.907980] [093/161] (905s left) kms_busy (basic)
[102.087213] Starting subtest: basic
[102.109117] Starting dynamic subtest: flip
[102.845928] Dynamic subtest flip: SUCCESS (0.750s)
[102.875996] Starting dynamic subtest: modeset
[103.472146] Dynamic subtest modeset: SUCCESS (0.627s)
[103.494244] Subtest basic: SUCCESS (1.379s)
[103.646485] [094/161] (904s left) kms_prop_blob (basic)
[103.845621] Starting subtest: basic
[103.865200] Subtest basic: SUCCESS (0.000s)
[103.945905] [095/161] (904s left) kms_cursor_legacy (basic-busy-flip-before-cursor-atomic)
[104.145434] Starting subtest: basic-busy-flip-before-cursor-atomic
[105.150257] Subtest basic-busy-flip-before-cursor-atomic: SUCCESS (1.013s)
[105.323921] [096/161] (902s left) kms_cursor_legacy (basic-busy-flip-before-cursor-legacy)
[105.492188] Starting subtest: basic-busy-flip-before-cursor-legacy
[106.487272] Subtest basic-busy-flip-before-cursor-legacy: SUCCESS (0.990s)
[106.660708] [097/161] (901s left) kms_cursor_legacy (basic-flip-after-cursor-atomic)
[106.889197] Starting subtest: basic-flip-after-cursor-atomic
[107.841680] Subtest basic-flip-after-cursor-atomic: SUCCESS (0.978s)
[108.012137] [098/161] (900s left) kms_cursor_legacy (basic-flip-after-cursor-legacy)
[108.194600] Starting subtest: basic-flip-after-cursor-legacy
[109.180560] Subtest basic-flip-after-cursor-legacy: SUCCESS (0.980s)
[109.336673] [099/161] (898s left) kms_cursor_legacy (basic-flip-after-cursor-varying-size)
[109.524339] Starting subtest: basic-flip-after-cursor-varying-size
[110.483172] Subtest basic-flip-after-cursor-varying-size: SUCCESS (0.982s)
[110.645709] [100/161] (897s left) kms_cursor_legacy (basic-flip-before-cursor-atomic)
[110.822663] Starting subtest: basic-flip-before-cursor-atomic
[111.798484] Subtest basic-flip-before-cursor-atomic: SUCCESS (0.980s)
[111.961493] [101/161] (896s left) kms_cursor_legacy (basic-flip-before-cursor-legacy)
[112.164390] Starting subtest: basic-flip-before-cursor-legacy
[113.147116] Subtest basic-flip-before-cursor-legacy: SUCCESS (0.982s)
[113.315704] [102/161] (895s left) kms_cursor_legacy (basic-flip-before-cursor-varying-size)
[113.489505] Starting subtest: basic-flip-before-cursor-varying-size
[114.465622] Subtest basic-flip-before-cursor-varying-size: SUCCESS (0.978s)
[114.628653] [103/161] (893s left) kms_dsc (dsc-basic)
[114.834833] Subtest dsc-basic: SKIP (0.000s)
[114.923267] [104/161] (893s left) kms_flip (basic-flip-vs-dpms)
[115.128036] Starting subtest: basic-flip-vs-dpms
[115.146687] Starting dynamic subtest: A-VGA1
[116.401924] Dynamic subtest A-VGA1: SUCCESS (1.253s)
[116.432853] Starting dynamic subtest: B-VGA1
[117.580832] Dynamic subtest B-VGA1: SUCCESS (1.215s)
[117.599845] Subtest basic-flip-vs-dpms: SUCCESS (2.471s)
[117.756718] [105/161] (891s left) kms_flip (basic-flip-vs-modeset)
[117.951255] Starting subtest: basic-flip-vs-modeset
[117.972614] Starting dynamic subtest: A-VGA1
[119.166266] Dynamic subtest A-VGA1: SUCCESS (1.236s)
[119.198472] Starting dynamic subtest: B-VGA1
[120.344327] Dynamic subtest B-VGA1: SUCCESS (1.173s)
[120.363232] Subtest basic-flip-vs-modeset: SUCCESS (2.412s)
[120.523147] [106/161] (888s left) kms_flip (basic-flip-vs-wf_vblank)
[120.718039] Starting subtest: basic-flip-vs-wf_vblank
[120.738674] Starting dynamic subtest: A-VGA1
[122.217704] Dynamic subtest A-VGA1: SUCCESS (1.531s)
[122.244360] Starting dynamic subtest: B-VGA1
[123.721195] Dynamic subtest B-VGA1: SUCCESS (1.503s)
[123.742410] Subtest basic-flip-vs-wf_vblank: SUCCESS (3.039s)
[123.948655] [107/161] (884s left) kms_flip (basic-plain-flip)
[124.158635] Starting subtest: basic-plain-flip
[124.180141] Starting dynamic subtest: A-VGA1
[125.360736] Dynamic subtest A-VGA1: SUCCESS (1.248s)
[125.389487] Starting dynamic subtest: B-VGA1
[126.588750] Dynamic subtest B-VGA1: SUCCESS (1.225s)
[126.610141] Subtest basic-plain-flip: SUCCESS (2.478s)
[126.812936] [108/161] (882s left) kms_force_connector_basic (force-connector-state)
[126.991257] Starting subtest: force-connector-state
[127.094905] Subtest force-connector-state: SUCCESS (0.113s)
[127.293909] [109/161] (881s left) kms_force_connector_basic (force-edid)
[127.480122] Starting subtest: force-edid
[127.498743] Subtest force-edid: SUCCESS (0.021s)
[127.602819] [110/161] (881s left) kms_force_connector_basic (force-load-detect)
[127.783073] Starting subtest: force-load-detect
[127.945778] Subtest force-load-detect: SUCCESS (0.182s)
[128.184359] [111/161] (881s left) kms_force_connector_basic (prune-stale-modes)
[128.382831] Starting subtest: prune-stale-modes
[128.402627] Subtest prune-stale-modes: SUCCESS (0.016s)
[128.507735] [112/161] (880s left) kms_frontbuffer_tracking (basic)
[128.743855] Starting subtest: basic
[130.919269] Subtest basic: SUCCESS (2.234s)
[131.059617] [113/161] (878s left) kms_hdmi_inject (inject-audio)
[131.292182] Starting subtest: inject-audio
[131.498216] Subtest inject-audio: SUCCESS (0.168s)
[131.722512] [114/161] (877s left) kms_pipe_crc_basic (compare-crc-sanitycheck-xr24)
[131.922245] Starting subtest: compare-crc-sanitycheck-xr24
[131.941677] Starting dynamic subtest: pipe-A-VGA-1
[132.234839] Dynamic subtest pipe-A-VGA-1: SUCCESS (0.322s)
[132.261428] Starting dynamic subtest: pipe-B-VGA-1
[132.555113] Dynamic subtest pipe-B-VGA-1: SUCCESS (0.328s)
[132.576469] Subtest compare-crc-sanitycheck-xr24: SUCCESS (0.655s)
[132.739389] [115/161] (876s left) kms_pipe_crc_basic (compare-crc-sanitycheck-nv12)
[132.917787] Starting subtest: compare-crc-sanitycheck-nv12
[132.937632] Starting dynamic subtest: pipe-A-VGA-1
[132.976337] Dynamic subtest pipe-A-VGA-1: SKIP (0.000s)
[133.008245] Starting dynamic subtest: pipe-B-VGA-1
[133.050967] Dynamic subtest pipe-B-VGA-1: SKIP (0.000s)
[133.094403] Subtest compare-crc-sanitycheck-nv12: SKIP (0.003s)
[133.174959] [116/161] (876s left) kms_pipe_crc_basic (hang-read-crc)
[133.369124] Starting subtest: hang-read-crc
[133.388427] Starting dynamic subtest: pipe-A-VGA-1
[134.219836] Dynamic subtest pipe-A-VGA-1: SUCCESS (0.856s)
[134.246557] Starting dynamic subtest: pipe-B-VGA-1
[135.123946] Dynamic subtest pipe-B-VGA-1: SUCCESS (0.898s)
[135.142520] Subtest hang-read-crc: SUCCESS (1.758s)
[135.289509] [117/161] (874s left) kms_pipe_crc_basic (nonblocking-crc)
[135.493869] Starting subtest: nonblocking-crc
[135.515418] Starting dynamic subtest: pipe-A-VGA-1
[135.970385] Dynamic subtest pipe-A-VGA-1: SUCCESS (0.500s)
[135.997101] Starting dynamic subtest: pipe-B-VGA-1
[136.482791] Dynamic subtest pipe-B-VGA-1: SUCCESS (0.522s)
[136.503821] Subtest nonblocking-crc: SUCCESS (1.025s)
[136.652144] [118/161] (873s left) kms_pipe_crc_basic (nonblocking-crc-frame-sequence)
[136.840264] Starting subtest: nonblocking-crc-frame-sequence
[136.859915] Starting dynamic subtest: pipe-A-VGA-1
[137.311974] Dynamic subtest pipe-A-VGA-1: SUCCESS (0.480s)
[137.342613] Starting dynamic subtest: pipe-B-VGA-1
[137.816163] Dynamic subtest pipe-B-VGA-1: SUCCESS (0.496s)
[137.835033] Subtest nonblocking-crc-frame-sequence: SUCCESS (0.980s)
[137.966926] [119/161] (871s left) kms_pipe_crc_basic (read-crc)
[138.182807] Starting subtest: read-crc
[138.204430] Starting dynamic subtest: pipe-A-VGA-1
[138.566555] Dynamic subtest pipe-A-VGA-1: SUCCESS (0.401s)
[138.595684] Starting dynamic subtest: pipe-B-VGA-1
[138.983307] Dynamic subtest pipe-B-VGA-1: SUCCESS (0.428s)
[139.002937] Subtest read-crc: SUCCESS (0.831s)
[139.146230] [120/161] (870s left) kms_pipe_crc_basic (read-crc-frame-sequence)
[139.347905] Starting subtest: read-crc-frame-sequence
[139.367491] Starting dynamic subtest: pipe-A-VGA-1
[139.738414] Dynamic subtest pipe-A-VGA-1: SUCCESS (0.415s)
[139.769837] Starting dynamic subtest: pipe-B-VGA-1
[140.190347] Dynamic subtest pipe-B-VGA-1: SUCCESS (0.445s)
[140.209269] Subtest read-crc-frame-sequence: SUCCESS (0.862s)
[140.344569] [121/161] (869s left) kms_pm_backlight (basic-brightness)
[140.545561] Subtest basic-brightness: SKIP (0.000s)
[140.634252] [122/161] (869s left) kms_pm_rpm (basic-pci-d3-state)
[142.127765] Subtest basic-pci-d3-state: SKIP (0.000s)
[142.213975] [123/161] (867s left) kms_pm_rpm (basic-rte)
[142.364961] Starting subtest: basic-rte
[143.976983] Subtest basic-rte: SKIP (1.567s)
[144.098554] [124/161] (866s left) kms_psr (psr-primary-page-flip)
[144.296368] Subtest psr-primary-page-flip: SKIP (0.000s)
[144.384512] [125/161] (865s left) kms_psr (psr-cursor-plane-move)
[144.606309] Subtest psr-cursor-plane-move: SKIP (0.000s)
[144.687324] [126/161] (865s left) kms_psr (psr-sprite-plane-onoff)
[144.907478] Subtest psr-sprite-plane-onoff: SKIP (0.000s)
[145.001278] [127/161] (865s left) kms_psr (psr-primary-mmap-gtt)
[145.202693] Subtest psr-primary-mmap-gtt: SKIP (0.000s)
[145.288262] [128/161] (865s left) kms_setmode (basic-clone-single-crtc)
[145.503762] Starting subtest: basic-clone-single-crtc
[145.562666] Subtest basic-clone-single-crtc: SKIP (0.001s)
[145.659457] [129/161] (865s left) i915_pm_rps (basic-api)
[145.870934] Subtest basic-api: SKIP (0.000s)
[145.956039] [130/161] (864s left) prime_self_import (basic-llseek-bad)
[146.136634] Starting subtest: basic-llseek-bad
[146.179123] Subtest basic-llseek-bad: SUCCESS (0.002s)
[146.261427] [131/161] (864s left) prime_self_import (basic-llseek-size)
[146.428411] Starting subtest: basic-llseek-size
[146.466746] Subtest basic-llseek-size: SUCCESS (0.010s)
[146.550477] [132/161] (864s left) prime_self_import (basic-with_fd_dup)
[146.715973] Starting subtest: basic-with_fd_dup
[146.758812] Subtest basic-with_fd_dup: SUCCESS (0.004s)
[146.842543] [133/161] (864s left) prime_self_import (basic-with_one_bo)
[146.989448] Starting subtest: basic-with_one_bo
[147.032289] Subtest basic-with_one_bo: SUCCESS (0.007s)
[147.121853] [134/161] (864s left) prime_self_import (basic-with_one_bo_two_files)
[147.278204] Starting subtest: basic-with_one_bo_two_files
[147.318262] Subtest basic-with_one_bo_two_files: SUCCESS (0.008s)
[147.399939] [135/161] (863s left) prime_self_import (basic-with_two_bos)
[147.553056] Starting subtest: basic-with_two_bos
[147.591746] Subtest basic-with_two_bos: SUCCESS (0.007s)
[147.678366] [136/161] (863s left) prime_vgem (basic-fence-flip)
[147.865823] Starting subtest: basic-fence-flip
[148.178190] Subtest basic-fence-flip: SUCCESS (0.362s)
[148.299176] [137/161] (863s left) prime_vgem (basic-fence-mmap)
[148.518910] Starting subtest: basic-fence-mmap
[148.540136] Subtest basic-fence-mmap: SUCCESS (0.051s)
[148.643287] [138/161] (862s left) prime_vgem (basic-fence-read)
[148.871134] Starting subtest: basic-fence-read
[148.899752] Subtest basic-fence-read: SUCCESS (0.062s)
[149.035540] [139/161] (862s left) prime_vgem (basic-gtt)
[149.267911] Starting subtest: basic-gtt
[149.296262] Subtest basic-gtt: SUCCESS (0.028s)
[149.430272] [140/161] (862s left) prime_vgem (basic-read)
[149.661758] Starting subtest: basic-read
[149.685032] Subtest basic-read: SUCCESS (0.031s)
[149.819096] [141/161] (861s left) prime_vgem (basic-write)
[150.042606] Starting subtest: basic-write
[150.065696] Subtest basic-write: SUCCESS (0.034s)
[150.186980] [142/161] (861s left) vgem_basic (setversion)
[150.397097] Starting subtest: setversion
[150.450113] Subtest setversion: SUCCESS (0.000s)
[150.548981] [143/161] (861s left) vgem_basic (create)
[150.736270] Starting subtest: create
[150.756764] Subtest create: SUCCESS (0.000s)
[150.836786] [144/161] (861s left) vgem_basic (debugfs)
[151.015847] Starting subtest: debugfs
[151.035366] Subtest debugfs: SUCCESS (0.001s)
[151.117967] [145/161] (860s left) vgem_basic (dmabuf-export)
[151.293308] Starting subtest: dmabuf-export
[151.335619] Subtest dmabuf-export: SUCCESS (0.004s)
[151.420464] [146/161] (860s left) vgem_basic (dmabuf-fence)
[151.617612] Starting subtest: dmabuf-fence
[151.637333] Subtest dmabuf-fence: SUCCESS (0.001s)
[151.715709] [147/161] (860s left) vgem_basic (dmabuf-fence-before)
[151.892554] Starting subtest: dmabuf-fence-before
[151.911820] Subtest dmabuf-fence-before: SUCCESS (0.001s)
[151.997836] [148/161] (860s left) vgem_basic (dmabuf-mmap)
[152.186831] Starting subtest: dmabuf-mmap
[152.208665] Subtest dmabuf-mmap: SUCCESS (0.030s)
[152.290541] [149/161] (860s left) vgem_basic (mmap)
[152.450674] Starting subtest: mmap
[152.471599] Subtest mmap: SUCCESS (0.021s)
[152.553498] [150/161] (859s left) vgem_basic (second-client)
[152.756294] Starting subtest: second-client
[152.795069] Subtest second-client: SUCCESS (0.033s)
[152.875611] [151/161] (859s left) vgem_basic (sysfs)
[153.065346] Starting subtest: sysfs
[153.086281] Subtest sysfs: SUCCESS (0.001s)
[153.173748] [152/161] (859s left) core_hotunplug (unbind-rebind)
[153.397679] Starting subtest: unbind-rebind
[156.223826] Subtest unbind-rebind: SUCCESS (2.827s)
[156.305792] [153/161] (856s left) vgem_basic (unload)
[156.476924] Starting subtest: unload
[185.588622] Subtest unload: SUCCESS (28.950s)
[185.675689] [154/161] (827s left) i915_module_load (reload)
[185.847729] Starting subtest: reload
[187.954156] Subtest reload: SUCCESS (2.125s)
[188.041179] [155/161] (824s left) gem_lmem_swapping (basic)
[188.256648] Subtest basic: SKIP (0.000s)
[188.335552] [156/161] (824s left) gem_lmem_swapping (parallel-random-engines)
[188.535027] Subtest parallel-random-engines: SKIP (0.000s)
[188.615046] [157/161] (824s left) gem_lmem_swapping (random-engines)
[188.842532] Subtest random-engines: SKIP (0.000s)
[188.926540] [158/161] (824s left) gem_lmem_swapping (verify-random)
[189.146252] Subtest verify-random: SKIP (0.000s)
[189.226153] [159/161] (823s left) i915_pm_rpm (module-reload)
[190.697968] Subtest module-reload: SKIP (0.000s)
[190.791731] [160/161] (822s left) i915_selftest (live)
[191.654675] Starting subtest: live
[191.673894] Starting dynamic subtest: sanitycheck
[192.396988] Dynamic subtest sanitycheck: SUCCESS (0.740s)
[192.425121] Starting dynamic subtest: uncore
[193.046119] Dynamic subtest uncore: SUCCESS (0.648s)
[193.071875] Starting dynamic subtest: workarounds
[193.771198] Dynamic subtest workarounds: SUCCESS (0.723s)
[193.799910] Starting dynamic subtest: gt_engines
[194.509645] Dynamic subtest gt_engines: SUCCESS (0.736s)
[194.538452] Starting dynamic subtest: gt_timelines
[199.100142] Dynamic subtest gt_timelines: SUCCESS (4.587s)
[199.127076] Starting dynamic subtest: gt_contexts
[199.790552] Dynamic subtest gt_contexts: SUCCESS (0.692s)
[199.818411] Starting dynamic subtest: gt_lrc
[200.535295] Dynamic subtest gt_lrc: SUCCESS (0.743s)
[200.560714] Starting dynamic subtest: gt_mocs
[201.215471] Dynamic subtest gt_mocs: SUCCESS (0.676s)
[201.243378] Starting dynamic subtest: gt_pm
[202.357554] Dynamic subtest gt_pm: SUCCESS (1.143s)
[202.384865] Starting dynamic subtest: gt_heartbeat
[203.059331] Dynamic subtest gt_heartbeat: SUCCESS (0.698s)
[203.085994] Starting dynamic subtest: gt_tlb
[203.725128] Dynamic subtest gt_tlb: SUCCESS (0.663s)
[203.751053] Starting dynamic subtest: requests
[208.069211] Dynamic subtest requests: SUCCESS (4.345s)
[208.094707] Starting dynamic subtest: migrate
[208.754081] Dynamic subtest migrate: SUCCESS (0.684s)
[208.782773] Starting dynamic subtest: active
[209.430220] Dynamic subtest active: SUCCESS (0.672s)
[209.466723] Starting dynamic subtest: objects
[211.610818] Dynamic subtest objects: SUCCESS (2.177s)
[211.641284] Starting dynamic subtest: mman
[217.540570] Dynamic subtest mman: SUCCESS (5.929s)
[217.574227] Starting dynamic subtest: dmabuf
[218.328308] Dynamic subtest dmabuf: SUCCESS (0.786s)
[218.359908] Starting dynamic subtest: vma
[219.068851] Dynamic subtest vma: SUCCESS (0.737s)
[219.106121] Starting dynamic subtest: coherency
[221.301140] Dynamic subtest coherency: SUCCESS (2.235s)
[221.329065] Starting dynamic subtest: gtt
[224.861717] Dynamic subtest gtt: SUCCESS (3.561s)
[224.890794] Starting dynamic subtest: gem
[225.695133] Dynamic subtest gem: SUCCESS (0.827s)
[225.722698] Starting dynamic subtest: evict
[226.348572] Dynamic subtest evict: SUCCESS (0.656s)
[226.376216] Starting dynamic subtest: hugepages
[227.033857] Dynamic subtest hugepages: SUCCESS (0.681s)
[227.062331] Starting dynamic subtest: gem_contexts
[230.833402] Dynamic subtest gem_contexts: SUCCESS (3.798s)
[230.862051] Starting dynamic subtest: client
[231.625750] Dynamic subtest client: SUCCESS (0.791s)
[231.654814] Starting dynamic subtest: gem_migrate
[232.340064] Dynamic subtest gem_migrate: SUCCESS (0.711s)
[232.366076] Starting dynamic subtest: reset
[233.082407] Dynamic subtest reset: SUCCESS (0.739s)
[233.111451] Starting dynamic subtest: memory_region
[233.746664] Dynamic subtest memory_region: SUCCESS (0.665s)
[233.773121] Starting dynamic subtest: hangcheck
[236.142249] Dynamic subtest hangcheck: SUCCESS (2.391s)
[236.169972] Starting dynamic subtest: execlists
[236.854356] Dynamic subtest execlists: SUCCESS (0.712s)
[236.879754] Starting dynamic subtest: ring_submission
[237.517953] Dynamic subtest ring_submission: SUCCESS (0.659s)
[237.545616] Starting dynamic subtest: perf
[238.179185] Dynamic subtest perf: SUCCESS (0.660s)
[238.208496] Starting dynamic subtest: slpc
[238.927072] Dynamic subtest slpc: SUCCESS (0.744s)
[238.955047] Starting dynamic subtest: guc
[239.590405] Dynamic subtest guc: SUCCESS (0.664s)
[239.616303] Starting dynamic subtest: guc_multi_lrc
[240.262506] Dynamic subtest guc_multi_lrc: SUCCESS (0.668s)
[240.291447] Starting dynamic subtest: guc_hang
[240.922312] Dynamic subtest guc_hang: SUCCESS (0.659s)
[240.950212] Starting dynamic subtest: late_gt_pm
[241.608056] Dynamic subtest late_gt_pm: SUCCESS (0.681s)
[241.629737] Subtest live: SUCCESS (49.978s)
[241.708408] [161/161] (771s left) dmabuf (all-tests)
[241.900485] Starting subtest: all-tests
[241.919586] Starting dynamic subtest: sanitycheck
[241.979230] Dynamic subtest sanitycheck: SUCCESS (0.081s)
[242.006858] Starting dynamic subtest: dma_fence
[242.153212] Dynamic subtest dma_fence: SUCCESS (0.175s)
[242.177579] Starting dynamic subtest: dma_fence_chain
[257.373222] Dynamic subtest dma_fence_chain: SUCCESS (15.223s)
[257.402261] Starting dynamic subtest: dma_fence_unwrap
[257.447436] Dynamic subtest dma_fence_unwrap: SUCCESS (0.075s)
[257.474809] Starting dynamic subtest: dma_resv
[257.521213] Dynamic subtest dma_resv: SUCCESS (0.069s)
[257.543135] Subtest all-tests: SUCCESS (15.632s)
[257.604610] Closing watchdogs
Done.