[37.952980] Initializing watchdogs
[37.953129]   /dev/watchdog0
[37.960090] [001/165] (960s left) i915_module_load (load)
[38.151529] Starting subtest: load
[39.226875] Subtest load: SUCCESS (1.076s)
[39.250085] [002/165] (959s left) core_auth (basic-auth)
[39.339077] Starting subtest: basic-auth
[39.340277] Subtest basic-auth: SUCCESS (0.001s)
[39.427350] [003/165] (959s left) debugfs_test (read_all_entries)
[39.536190] Starting subtest: read_all_entries
[39.634020] Subtest read_all_entries: SUCCESS (0.098s)
[39.736654] [004/165] (958s left) debugfs_test (basic-hwmon)
[39.811072] Starting subtest: basic-hwmon
[39.813058] Subtest basic-hwmon: SKIP (0.000s)
[39.948064] [005/165] (958s left) fbdev (eof)
[40.020513] Starting subtest: eof
[40.024310] Subtest eof: SUCCESS (0.001s)
[40.077851] [006/165] (958s left) fbdev (info)
[40.146440] Starting subtest: info
[40.147525] Subtest info: SUCCESS (0.000s)
[40.208942] [007/165] (958s left) fbdev (nullptr)
[40.286804] Starting subtest: nullptr
[40.287850] Subtest nullptr: SUCCESS (0.000s)
[40.341485] [008/165] (958s left) fbdev (read)
[40.420420] Starting subtest: read
[41.272849] Subtest read: SUCCESS (0.844s)
[41.329412] [009/165] (957s left) fbdev (write)
[41.403818] Starting subtest: write
[41.828545] Subtest write: SUCCESS (0.416s)
[41.908477] [010/165] (956s left) gem_basic (bad-close)
[41.974759] Starting subtest: bad-close
[41.976787] Subtest bad-close: SUCCESS (0.000s)
[42.035960] [011/165] (956s left) gem_basic (create-close)
[42.104940] Starting subtest: create-close
[42.107047] Subtest create-close: SUCCESS (0.000s)
[42.218202] [012/165] (956s left) gem_basic (create-fd-close)
[42.302235] Starting subtest: create-fd-close
[42.304161] Subtest create-fd-close: SUCCESS (0.000s)
[42.421123] [013/165] (956s left) gem_busy (busy@all-engines)
[42.506962] Starting subtest: busy
[42.507970] Starting dynamic subtest: all-engines
[42.562924] Dynamic subtest all-engines: SUCCESS (0.057s)
[42.564022] Subtest busy: SUCCESS (0.057s)
[42.997907] [014/165] (955s left) gem_close_race (basic-process)
[43.088440] Starting subtest: basic-process
[43.166454] Subtest basic-process: SUCCESS (0.078s)
[43.409871] [015/165] (955s left) gem_close_race (basic-threads)
[43.517551] Starting subtest: basic-threads
[44.673106] Subtest basic-threads: SUCCESS (1.156s)
[44.938265] [016/165] (953s left) gem_ctx_create (basic)
[45.031148] Starting subtest: basic
[45.032296] Subtest basic: SUCCESS (0.000s)
[45.273985] [017/165] (953s left) gem_ctx_create (basic-files)
[45.366256] Starting subtest: basic-files
[47.387178] Subtest basic-files: SUCCESS (2.021s)
[47.673057] [018/165] (951s left) gem_ctx_exec (basic)
[47.747163] Starting subtest: basic
[47.751388] Subtest basic: SUCCESS (0.004s)
[47.892028] [019/165] (950s left) gem_exec_basic (basic)
[47.972252] Starting subtest: basic
[47.973216] Starting dynamic subtest: rcs0-smem
[47.975145] Dynamic subtest rcs0-smem: SUCCESS (0.002s)
[47.982471] Starting dynamic subtest: bcs0-smem
[47.983350] Dynamic subtest bcs0-smem: SUCCESS (0.001s)
[47.990337] Starting dynamic subtest: vcs0-smem
[47.991218] Dynamic subtest vcs0-smem: SUCCESS (0.001s)
[47.998381] Starting dynamic subtest: vecs0-smem
[47.999542] Dynamic subtest vecs0-smem: SUCCESS (0.001s)
[48.000412] Subtest basic: SUCCESS (0.006s)
[48.247591] [020/165] (950s left) gem_exec_create (basic)
[48.334852] Starting subtest: basic
[48.335972] Starting dynamic subtest: smem
[50.381637] Dynamic subtest smem: SUCCESS (2.047s)
[50.382760] Subtest basic: SUCCESS (2.047s)
[50.621117] [021/165] (948s left) gem_exec_fence (basic-busy)
[50.861733] Starting subtest: basic-busy
[50.863048] Starting dynamic subtest: rcs0
[50.893320] Dynamic subtest rcs0: SUCCESS (0.032s)
[50.901532] Starting dynamic subtest: bcs0
[50.919342] Dynamic subtest bcs0: SUCCESS (0.026s)
[50.927029] Starting dynamic subtest: vcs0
[50.947223] Dynamic subtest vcs0: SUCCESS (0.028s)
[50.954663] Starting dynamic subtest: vecs0
[50.970398] Dynamic subtest vecs0: SUCCESS (0.023s)
[50.971476] Subtest basic-busy: SUCCESS (0.109s)
[51.689432] [022/165] (947s left) gem_exec_fence (basic-wait)
[51.922623] Starting subtest: basic-wait
[51.924021] Starting dynamic subtest: rcs0
[51.947266] Dynamic subtest rcs0: SUCCESS (0.025s)
[51.955846] Starting dynamic subtest: bcs0
[51.982372] Dynamic subtest bcs0: SUCCESS (0.035s)
[51.991163] Starting dynamic subtest: vcs0
[52.011255] Dynamic subtest vcs0: SUCCESS (0.029s)
[52.020744] Starting dynamic subtest: vecs0
[52.040400] Dynamic subtest vecs0: SUCCESS (0.029s)
[52.041684] Subtest basic-wait: SUCCESS (0.118s)
[52.735380] [023/165] (946s left) gem_exec_fence (basic-await)
[52.993140] Starting subtest: basic-await
[52.994272] Starting dynamic subtest: rcs0
[53.092363] Dynamic subtest rcs0: SUCCESS (0.101s)
[53.100649] Starting dynamic subtest: bcs0
[53.190076] Dynamic subtest bcs0: SUCCESS (0.097s)
[53.201151] Starting dynamic subtest: vcs0
[53.290124] Dynamic subtest vcs0: SUCCESS (0.100s)
[53.298617] Starting dynamic subtest: vecs0
[53.391707] Dynamic subtest vecs0: SUCCESS (0.101s)
[53.392873] Subtest basic-await: SUCCESS (0.400s)
[54.137543] [024/165] (944s left) gem_exec_fence (nb-await)
[54.384384] Starting subtest: nb-await
[54.385785] Starting dynamic subtest: rcs0
[54.452426] Dynamic subtest rcs0: SUCCESS (0.065s)
[54.473203] Starting dynamic subtest: bcs0
[54.528688] Dynamic subtest bcs0: SUCCESS (0.076s)
[54.563902] Starting dynamic subtest: vcs0
[54.617329] Dynamic subtest vcs0: SUCCESS (0.090s)
[54.629902] Starting dynamic subtest: vecs0
[54.688769] Dynamic subtest vecs0: SUCCESS (0.067s)
[54.692603] Subtest nb-await: SUCCESS (0.301s)
[55.396153] [025/165] (943s left) gem_exec_gttfill (basic)
[55.484293] Starting subtest: basic
[65.127165] Subtest basic: SUCCESS (9.634s)
[65.317403] [026/165] (933s left) gem_exec_parallel (engines)
[65.459238] Starting subtest: engines
[65.460325] Starting dynamic subtest: basic
[67.836795] Dynamic subtest basic: SUCCESS (2.377s)
[67.846280] Starting dynamic subtest: contexts
[74.060287] Dynamic subtest contexts: SUCCESS (6.223s)
[74.070466] Starting dynamic subtest: fds
[82.110103] Dynamic subtest fds: SUCCESS (8.050s)
[82.119412] Starting dynamic subtest: userptr
[84.357534] Dynamic subtest userptr: SUCCESS (2.247s)
[84.358856] Subtest engines: SUCCESS (18.898s)
[84.598749] [027/165] (914s left) gem_exec_store (basic)
[84.688203] Starting subtest: basic
[84.735560] Subtest basic: SUCCESS (0.048s)
[84.977818] [028/165] (914s left) gem_flink_basic (bad-flink)
[85.052145] Starting subtest: bad-flink
[85.053215] Subtest bad-flink: SUCCESS (0.000s)
[85.134507] [029/165] (913s left) gem_flink_basic (bad-open)
[85.208268] Starting subtest: bad-open
[85.209387] Subtest bad-open: SUCCESS (0.000s)
[85.280157] [030/165] (913s left) gem_flink_basic (basic)
[85.352338] Starting subtest: basic
[85.353316] Subtest basic: SUCCESS (0.000s)
[85.473595] [031/165] (913s left) gem_flink_basic (double-flink)
[85.546643] Starting subtest: double-flink
[85.547719] Subtest double-flink: SUCCESS (0.000s)
[85.677961] [032/165] (913s left) gem_flink_basic (flink-lifetime)
[85.751263] Starting subtest: flink-lifetime
[85.753685] Subtest flink-lifetime: SUCCESS (0.001s)
[85.884939] [033/165] (913s left) gem_huc_copy (huc-copy)
[85.966310] Starting subtest: huc-copy
[85.968160] Subtest huc-copy: SKIP (0.000s)
[86.102837] [034/165] (913s left) gem_linear_blits (basic)
[86.336451] Starting subtest: basic
[86.345964] Subtest basic: SUCCESS (0.010s)
[86.504730] [035/165] (912s left) gem_mmap (basic)
[86.629185] Starting subtest: basic
[86.633399] Subtest basic: SUCCESS (0.000s)
[86.740186] [036/165] (912s left) gem_mmap_gtt (basic)
[86.814153] Starting subtest: basic
[86.815257] Subtest basic: SUCCESS (0.001s)
[86.870207] [037/165] (912s left) gem_render_linear_blits (basic)
[86.950054] Starting subtest: basic
[86.990109] Subtest basic: SUCCESS (0.040s)
[87.037262] [038/165] (912s left) gem_render_tiled_blits (basic)
[87.116660] Starting subtest: basic
[87.169943] Subtest basic: SUCCESS (0.053s)
[87.220820] [039/165] (912s left) gem_ringfill (basic-all)
[87.501058] Starting subtest: basic-all
[88.672025] Subtest basic-all: SUCCESS (1.163s)
[88.797719] [040/165] (910s left) gem_softpin (allocator-basic)
[88.877702] Starting subtest: allocator-basic
[89.025263] Subtest allocator-basic: SUCCESS (0.139s)
[89.127288] [041/165] (910s left) gem_softpin (allocator-basic-reserve)
[89.212656] Starting subtest: allocator-basic-reserve
[89.362730] Subtest allocator-basic-reserve: SUCCESS (0.140s)
[89.485983] [042/165] (909s left) gem_softpin (safe-alignment)
[89.578119] Starting subtest: safe-alignment
[89.593709] Subtest safe-alignment: SUCCESS (0.015s)
[89.730769] [043/165] (909s left) gem_sync (basic-all)
[89.822762] Starting subtest: basic-all
[92.054374] Subtest basic-all: SUCCESS (2.232s)
[92.306205] [044/165] (907s left) gem_sync (basic-each)
[92.391041] Starting subtest: basic-each
[94.623496] Subtest basic-each: SUCCESS (2.232s)
[94.932789] [045/165] (904s left) gem_tiled_blits (basic)
[95.155794] Starting subtest: basic
[95.178263] Subtest basic: SUCCESS (0.023s)
[95.326228] [046/165] (904s left) gem_tiled_fence_blits (basic)
[95.599976] Starting subtest: basic
[95.613149] Subtest basic: SUCCESS (0.013s)
[95.769194] [047/165] (903s left) gem_tiled_pread_basic
[96.139573] [048/165] (903s left) gem_wait (busy@all-engines)
[96.234443] Starting subtest: busy
[96.235600] Starting dynamic subtest: all-engines
[96.761347] Dynamic subtest all-engines: SUCCESS (0.527s)
[96.762431] Subtest busy: SUCCESS (0.527s)
[97.025496] [049/165] (902s left) gem_wait (wait@all-engines)
[97.122188] Starting subtest: wait
[97.123262] Starting dynamic subtest: all-engines
[98.169311] Dynamic subtest all-engines: SUCCESS (1.047s)
[98.170370] Subtest wait: SUCCESS (1.047s)
[98.453446] [050/165] (901s left) i915_getparams_basic (basic-eu-total)
[98.526691] Starting subtest: basic-eu-total
[98.528705] Subtest basic-eu-total: SUCCESS (0.000s)
[98.590081] [051/165] (901s left) i915_getparams_basic (basic-subslice-total)
[98.663126] Starting subtest: basic-subslice-total
[98.665071] Subtest basic-subslice-total: SUCCESS (0.000s)
[98.751538] [052/165] (900s left) i915_hangman (error-state-basic)
[98.833593] Starting subtest: error-state-basic
[98.845554] Subtest error-state-basic: SUCCESS (0.012s)
[98.972632] [053/165] (900s left) i915_pciid
[99.118712] [054/165] (900s left) kms_addfb_basic (addfb25-4-tiled)
[99.236156] Starting subtest: addfb25-4-tiled
[99.237099] Subtest addfb25-4-tiled: SUCCESS (0.000s)
[99.346612] [055/165] (900s left) kms_addfb_basic (addfb25-bad-modifier)
[99.433133] Starting subtest: addfb25-bad-modifier
[99.434059] Subtest addfb25-bad-modifier: SUCCESS (0.000s)
[99.581636] [056/165] (900s left) kms_addfb_basic (addfb25-framebuffer-vs-set-tiling)
[99.657171] Starting subtest: addfb25-framebuffer-vs-set-tiling
[99.658104] Subtest addfb25-framebuffer-vs-set-tiling: SUCCESS (0.000s)
[99.797476] [057/165] (899s left) kms_addfb_basic (addfb25-modifier-no-flag)
[99.874307] Starting subtest: addfb25-modifier-no-flag
[99.875397] Subtest addfb25-modifier-no-flag: SUCCESS (0.000s)
[100.039974] [058/165] (899s left) kms_addfb_basic (addfb25-x-tiled-legacy)
[100.114519] Starting subtest: addfb25-x-tiled-legacy
[100.115608] Subtest addfb25-x-tiled-legacy: SUCCESS (0.000s)
[100.271726] [059/165] (899s left) kms_addfb_basic (addfb25-x-tiled-mismatch-legacy)
[100.345481] Starting subtest: addfb25-x-tiled-mismatch-legacy
[100.346535] Subtest addfb25-x-tiled-mismatch-legacy: SUCCESS (0.000s)
[100.519404] [060/165] (899s left) kms_addfb_basic (addfb25-yf-tiled-legacy)
[100.634184] Starting subtest: addfb25-yf-tiled-legacy
[100.635109] Subtest addfb25-yf-tiled-legacy: SUCCESS (0.000s)
[100.728151] [061/165] (899s left) kms_addfb_basic (addfb25-y-tiled-legacy)
[100.844826] Starting subtest: addfb25-y-tiled-legacy
[100.845962] Subtest addfb25-y-tiled-legacy: SUCCESS (0.000s)
[100.943765] [062/165] (898s left) kms_addfb_basic (addfb25-y-tiled-small-legacy)
[101.056880] Starting subtest: addfb25-y-tiled-small-legacy
[101.057960] Subtest addfb25-y-tiled-small-legacy: SUCCESS (0.000s)
[101.169242] [063/165] (898s left) kms_addfb_basic (bad-pitch-0)
[101.242658] Starting subtest: bad-pitch-0
[101.243873] Subtest bad-pitch-0: SUCCESS (0.000s)
[101.401565] [064/165] (898s left) kms_addfb_basic (bad-pitch-1024)
[101.483402] Starting subtest: bad-pitch-1024
[101.484602] Subtest bad-pitch-1024: SUCCESS (0.000s)
[101.652488] [065/165] (898s left) kms_addfb_basic (bad-pitch-128)
[101.730924] Starting subtest: bad-pitch-128
[101.732084] Subtest bad-pitch-128: SUCCESS (0.000s)
[101.861107] [066/165] (898s left) kms_addfb_basic (bad-pitch-256)
[101.935339] Starting subtest: bad-pitch-256
[101.936369] Subtest bad-pitch-256: SUCCESS (0.000s)
[102.082211] [067/165] (897s left) kms_addfb_basic (bad-pitch-32)
[102.169169] Starting subtest: bad-pitch-32
[102.170273] Subtest bad-pitch-32: SUCCESS (0.000s)
[102.317161] [068/165] (897s left) kms_addfb_basic (bad-pitch-63)
[102.390087] Starting subtest: bad-pitch-63
[102.391181] Subtest bad-pitch-63: SUCCESS (0.000s)
[102.545154] [069/165] (897s left) kms_addfb_basic (bad-pitch-65536)
[102.632073] Starting subtest: bad-pitch-65536
[102.633025] Subtest bad-pitch-65536: SUCCESS (0.000s)
[102.795138] [070/165] (897s left) kms_addfb_basic (bad-pitch-999)
[102.869701] Starting subtest: bad-pitch-999
[102.870802] Subtest bad-pitch-999: SUCCESS (0.000s)
[103.019758] [071/165] (897s left) kms_addfb_basic (basic)
[103.106029] Starting subtest: basic
[103.107223] Subtest basic: SUCCESS (0.000s)
[103.244201] [072/165] (896s left) kms_addfb_basic (basic-x-tiled-legacy)
[103.318172] Starting subtest: basic-x-tiled-legacy
[103.319056] Subtest basic-x-tiled-legacy: SUCCESS (0.000s)
[103.462042] [073/165] (896s left) kms_addfb_basic (basic-y-tiled-legacy)
[103.537346] Starting subtest: basic-y-tiled-legacy
[103.538423] Subtest basic-y-tiled-legacy: SUCCESS (0.000s)
[103.677781] [074/165] (896s left) kms_addfb_basic (bo-too-small)
[103.794455] Starting subtest: bo-too-small
[103.795550] Subtest bo-too-small: SUCCESS (0.000s)
[103.935695] [075/165] (896s left) kms_addfb_basic (bo-too-small-due-to-tiling)
[104.051824] Starting subtest: bo-too-small-due-to-tiling
[104.052993] Subtest bo-too-small-due-to-tiling: SUCCESS (0.000s)
[104.148458] [076/165] (896s left) kms_addfb_basic (clobberred-modifier)
[104.224217] Starting subtest: clobberred-modifier
[104.225266] Subtest clobberred-modifier: SUCCESS (0.000s)
[104.363143] [077/165] (895s left) kms_addfb_basic (framebuffer-vs-set-tiling)
[104.439173] Starting subtest: framebuffer-vs-set-tiling
[104.440066] Subtest framebuffer-vs-set-tiling: SUCCESS (0.000s)
[104.587315] [078/165] (895s left) kms_addfb_basic (invalid-get-prop)
[104.669234] Starting subtest: invalid-get-prop
[104.670190] Subtest invalid-get-prop: SUCCESS (0.000s)
[104.843827] [079/165] (895s left) kms_addfb_basic (invalid-get-prop-any)
[104.918206] Starting subtest: invalid-get-prop-any
[104.919162] Subtest invalid-get-prop-any: SUCCESS (0.000s)
[105.067039] [080/165] (895s left) kms_addfb_basic (invalid-set-prop)
[105.141368] Starting subtest: invalid-set-prop
[105.142475] Subtest invalid-set-prop: SUCCESS (0.000s)
[105.276506] [081/165] (895s left) kms_addfb_basic (invalid-set-prop-any)
[105.354375] Starting subtest: invalid-set-prop-any
[105.355424] Subtest invalid-set-prop-any: SUCCESS (0.000s)
[105.518481] [082/165] (894s left) kms_addfb_basic (no-handle)
[105.600748] Starting subtest: no-handle
[105.601816] Subtest no-handle: SUCCESS (0.000s)
[105.759453] [083/165] (894s left) kms_addfb_basic (size-max)
[105.886592] Starting subtest: size-max
[105.887717] Subtest size-max: SUCCESS (0.000s)
[106.004463] [084/165] (894s left) kms_addfb_basic (small-bo)
[106.127073] Starting subtest: small-bo
[106.128104] Subtest small-bo: SUCCESS (0.000s)
[106.240561] [085/165] (894s left) kms_addfb_basic (tile-pitch-mismatch)
[106.316215] Starting subtest: tile-pitch-mismatch
[106.317120] Subtest tile-pitch-mismatch: SUCCESS (0.000s)
[106.458383] [086/165] (894s left) kms_addfb_basic (too-high)
[106.568755] Starting subtest: too-high
[106.569909] Subtest too-high: SUCCESS (0.001s)
[106.679279] [087/165] (893s left) kms_addfb_basic (too-wide)
[106.809206] Starting subtest: too-wide
[106.810160] Subtest too-wide: SUCCESS (0.000s)
[106.921106] [088/165] (893s left) kms_addfb_basic (unused-handle)
[107.008410] Starting subtest: unused-handle
[107.009513] Subtest unused-handle: SUCCESS (0.000s)
[107.173514] [089/165] (893s left) kms_addfb_basic (unused-modifier)
[107.248255] Starting subtest: unused-modifier
[107.249313] Subtest unused-modifier: SUCCESS (0.000s)
[107.378109] [090/165] (893s left) kms_addfb_basic (unused-offsets)
[107.452670] Starting subtest: unused-offsets
[107.453783] Subtest unused-offsets: SUCCESS (0.000s)
[107.598263] [091/165] (893s left) kms_addfb_basic (unused-pitches)
[107.682522] Starting subtest: unused-pitches
[107.683628] Subtest unused-pitches: SUCCESS (0.000s)
[107.825728] [092/165] (892s left) kms_busy (basic)
[107.944610] Starting subtest: basic
[107.947033] Starting dynamic subtest: flip
[108.885409] Dynamic subtest flip: SUCCESS (0.938s)
[108.899078] Starting dynamic subtest: modeset
[112.734522] Dynamic subtest modeset: SUCCESS (3.847s)
[112.738490] Subtest basic: SUCCESS (4.787s)
[113.673767] [093/165] (887s left) kms_prop_blob (basic)
[113.755342] Starting subtest: basic
[113.756338] Subtest basic: SUCCESS (0.000s)
[113.877232] [094/165] (886s left) kms_cursor_legacy (basic-busy-flip-before-cursor-atomic)
[113.990699] Starting subtest: basic-busy-flip-before-cursor-atomic
[113.992820] Subtest basic-busy-flip-before-cursor-atomic: SKIP (0.000s)
[114.074501] [095/165] (886s left) kms_cursor_legacy (basic-busy-flip-before-cursor-legacy)
[114.182972] Starting subtest: basic-busy-flip-before-cursor-legacy
[114.185045] Subtest basic-busy-flip-before-cursor-legacy: SKIP (0.000s)
[114.281624] [096/165] (886s left) kms_cursor_legacy (basic-flip-after-cursor-atomic)
[114.395236] Starting subtest: basic-flip-after-cursor-atomic
[115.681958] Subtest basic-flip-after-cursor-atomic: SUCCESS (1.284s)
[116.575906] [097/165] (884s left) kms_cursor_legacy (basic-flip-after-cursor-legacy)
[116.689051] Starting subtest: basic-flip-after-cursor-legacy
[118.010166] Subtest basic-flip-after-cursor-legacy: SUCCESS (1.318s)
[118.911724] [098/165] (881s left) kms_cursor_legacy (basic-flip-after-cursor-varying-size)
[119.025072] Starting subtest: basic-flip-after-cursor-varying-size
[120.347412] Subtest basic-flip-after-cursor-varying-size: SUCCESS (1.317s)
[121.277872] [099/165] (879s left) kms_cursor_legacy (basic-flip-before-cursor-atomic)
[121.401911] Starting subtest: basic-flip-before-cursor-atomic
[122.720991] Subtest basic-flip-before-cursor-atomic: SUCCESS (1.312s)
[123.606703] [100/165] (877s left) kms_cursor_legacy (basic-flip-before-cursor-legacy)
[123.720074] Starting subtest: basic-flip-before-cursor-legacy
[125.038440] Subtest basic-flip-before-cursor-legacy: SUCCESS (1.316s)
[125.952950] [101/165] (874s left) kms_cursor_legacy (basic-flip-before-cursor-varying-size)
[126.063293] Starting subtest: basic-flip-before-cursor-varying-size
[127.405369] Subtest basic-flip-before-cursor-varying-size: SUCCESS (1.339s)
[128.320724] [102/165] (872s left) kms_dsc (dsc-basic)
[128.432282] Subtest dsc-basic: SKIP (0.000s)
[128.467866] [103/165] (872s left) kms_flip (basic-flip-vs-dpms)
[128.558338] Starting subtest: basic-flip-vs-dpms
[128.561303] Starting dynamic subtest: A-eDP1
[131.450188] Dynamic subtest A-eDP1: SUCCESS (2.881s)
[131.504996] Starting dynamic subtest: B-eDP1
[133.889459] Dynamic subtest B-eDP1: SUCCESS (2.434s)
[133.949228] Starting dynamic subtest: C-eDP1
[136.332797] Dynamic subtest C-eDP1: SUCCESS (2.439s)
[136.368945] Subtest basic-flip-vs-dpms: SUCCESS (7.808s)
[137.218957] [104/165] (863s left) kms_flip (basic-flip-vs-modeset)
[137.311346] Starting subtest: basic-flip-vs-modeset
[137.315451] Starting dynamic subtest: A-eDP1
[140.207327] Dynamic subtest A-eDP1: SUCCESS (2.888s)
[140.268130] Starting dynamic subtest: B-eDP1
[142.608370] Dynamic subtest B-eDP1: SUCCESS (2.391s)
[142.659956] Starting dynamic subtest: C-eDP1
[144.954276] Dynamic subtest C-eDP1: SUCCESS (2.336s)
[144.984275] Subtest basic-flip-vs-modeset: SUCCESS (7.670s)
[145.892921] [105/165] (855s left) kms_flip (basic-flip-vs-wf_vblank)
[145.983854] Starting subtest: basic-flip-vs-wf_vblank
[145.988040] Starting dynamic subtest: A-eDP1
[148.296650] Dynamic subtest A-eDP1: SUCCESS (2.308s)
[148.311677] Starting dynamic subtest: B-eDP1
[150.559550] Dynamic subtest B-eDP1: SUCCESS (2.260s)
[150.571992] Starting dynamic subtest: C-eDP1
[152.857111] Dynamic subtest C-eDP1: SUCCESS (2.297s)
[152.862879] Subtest basic-flip-vs-wf_vblank: SUCCESS (6.879s)
[154.242278] [106/165] (846s left) kms_flip (basic-plain-flip)
[154.330959] Starting subtest: basic-plain-flip
[154.335369] Starting dynamic subtest: A-eDP1
[156.347237] Dynamic subtest A-eDP1: SUCCESS (2.010s)
[156.358668] Starting dynamic subtest: B-eDP1
[158.353803] Dynamic subtest B-eDP1: SUCCESS (1.995s)
[158.417192] Starting dynamic subtest: C-eDP1
[160.428666] Dynamic subtest C-eDP1: SUCCESS (2.073s)
[160.451218] Subtest basic-plain-flip: SUCCESS (6.117s)
[161.798551] [107/165] (839s left) kms_force_connector_basic (force-connector-state)
[161.901138] Starting subtest: force-connector-state
[162.440760] Subtest force-connector-state: SUCCESS (0.541s)
[163.623152] [108/165] (837s left) kms_force_connector_basic (force-edid)
[163.727663] Starting subtest: force-edid
[163.761229] Subtest force-edid: SUCCESS (0.034s)
[163.923693] [109/165] (837s left) kms_force_connector_basic (force-load-detect)
[164.028121] Starting subtest: force-load-detect
[164.030246] Subtest force-load-detect: SKIP (0.000s)
[164.170056] [110/165] (836s left) kms_force_connector_basic (prune-stale-modes)
[164.272191] Starting subtest: prune-stale-modes
[164.301881] Subtest prune-stale-modes: SUCCESS (0.032s)
[164.488419] [111/165] (836s left) kms_frontbuffer_tracking (basic)
[164.597904] Starting subtest: basic
[167.620471] Subtest basic: SUCCESS (3.024s)
[167.742460] [112/165] (833s left) kms_hdmi_inject (inject-audio)
[168.150574] Starting subtest: inject-audio
[168.278736] Subtest inject-audio: SUCCESS (0.127s)
[169.086329] [113/165] (832s left) kms_pipe_crc_basic (compare-crc-sanitycheck-xr24)
[169.197849] Starting subtest: compare-crc-sanitycheck-xr24
[169.199077] Starting dynamic subtest: pipe-A-eDP-1
[169.984119] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.778s)
[170.038827] Starting dynamic subtest: pipe-B-eDP-1
[171.345171] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.343s)
[171.391092] Starting dynamic subtest: pipe-C-eDP-1
[172.703816] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.335s)
[172.710460] Subtest compare-crc-sanitycheck-xr24: SUCCESS (3.501s)
[173.613233] [114/165] (827s left) kms_pipe_crc_basic (compare-crc-sanitycheck-nv12)
[173.728624] Starting subtest: compare-crc-sanitycheck-nv12
[173.731060] Starting dynamic subtest: pipe-A-eDP-1
[173.732949] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[173.744236] Starting dynamic subtest: pipe-B-eDP-1
[173.746186] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[173.757088] Starting dynamic subtest: pipe-C-eDP-1
[173.759833] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[173.761748] Subtest compare-crc-sanitycheck-nv12: SKIP (0.013s)
[173.833403] [115/165] (827s left) kms_pipe_crc_basic (hang-read-crc)
[173.945728] Starting subtest: hang-read-crc
[173.948348] Starting dynamic subtest: pipe-A-eDP-1
[176.511418] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.556s)
[176.573195] Starting dynamic subtest: pipe-B-eDP-1
[179.797252] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.269s)
[179.871175] Starting dynamic subtest: pipe-C-eDP-1
[183.070291] Dynamic subtest pipe-C-eDP-1: SUCCESS (3.252s)
[183.073477] Subtest hang-read-crc: SUCCESS (9.125s)
[184.019201] [116/165] (817s left) kms_pipe_crc_basic (nonblocking-crc)
[184.134553] Starting subtest: nonblocking-crc
[184.136989] Starting dynamic subtest: pipe-A-eDP-1
[185.119254] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.973s)
[185.186263] Starting dynamic subtest: pipe-B-eDP-1
[186.926712] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.784s)
[187.002620] Starting dynamic subtest: pipe-C-eDP-1
[188.669166] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.723s)
[188.672438] Subtest nonblocking-crc: SUCCESS (4.535s)
[189.596180] [117/165] (811s left) kms_pipe_crc_basic (nonblocking-crc-frame-sequence)
[189.710193] Starting subtest: nonblocking-crc-frame-sequence
[189.711246] Starting dynamic subtest: pipe-A-eDP-1
[190.730735] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.006s)
[190.789168] Starting dynamic subtest: pipe-B-eDP-1
[192.477776] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.730s)
[192.533144] Starting dynamic subtest: pipe-C-eDP-1
[194.258193] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.753s)
[194.261436] Subtest nonblocking-crc-frame-sequence: SUCCESS (4.548s)
[195.185401] [118/165] (806s left) kms_pipe_crc_basic (read-crc)
[195.311710] Starting subtest: read-crc
[195.314265] Starting dynamic subtest: pipe-A-eDP-1
[196.254745] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.932s)
[196.325848] Starting dynamic subtest: pipe-B-eDP-1
[197.903406] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.628s)
[197.985749] Starting dynamic subtest: pipe-C-eDP-1
[199.526398] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.599s)
[199.529693] Subtest read-crc: SUCCESS (4.215s)
[200.460827] [119/165] (800s left) kms_pipe_crc_basic (read-crc-frame-sequence)
[200.576587] Starting subtest: read-crc-frame-sequence
[200.577612] Starting dynamic subtest: pipe-A-eDP-1
[201.450807] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.860s)
[201.513510] Starting dynamic subtest: pipe-B-eDP-1
[203.134333] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.665s)
[203.207511] Starting dynamic subtest: pipe-C-eDP-1
[204.773506] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.619s)
[204.779479] Subtest read-crc-frame-sequence: SUCCESS (4.190s)
[205.643846] [120/165] (795s left) kms_pm_backlight (basic-brightness)
[205.764635] Starting subtest: basic-brightness
[205.867618] Starting dynamic subtest: eDP-1
[206.542736] Dynamic subtest eDP-1: SUCCESS (0.674s)
[206.549567] Subtest basic-brightness: SUCCESS (0.783s)
[207.458023] [121/165] (793s left) kms_psr (primary_page_flip)
[207.572193] Starting subtest: primary_page_flip
[209.678379] Subtest primary_page_flip: SUCCESS (2.095s)
[210.583923] [122/165] (790s left) kms_psr (cursor_plane_move)
[210.701047] Starting subtest: cursor_plane_move
[212.670091] Subtest cursor_plane_move: SUCCESS (1.966s)
[213.609699] [123/165] (787s left) kms_psr (sprite_plane_onoff)
[213.726713] Starting subtest: sprite_plane_onoff
[215.824187] Subtest sprite_plane_onoff: SUCCESS (2.089s)
[216.700490] [124/165] (784s left) kms_psr (primary_mmap_gtt)
[216.817903] Starting subtest: primary_mmap_gtt
[218.958711] Subtest primary_mmap_gtt: SUCCESS (2.137s)
[219.889030] [125/165] (781s left) kms_setmode (basic-clone-single-crtc)
[219.966315] Starting subtest: basic-clone-single-crtc
[219.969296] Subtest basic-clone-single-crtc: SKIP (0.001s)
[220.064724] [126/165] (781s left) i915_pm_rpm (basic-pci-d3-state)
[221.814644] Starting subtest: basic-pci-d3-state
[226.280713] Subtest basic-pci-d3-state: SUCCESS (4.468s)
[226.504388] [127/165] (775s left) i915_pm_rpm (basic-rte)
[226.581321] Starting subtest: basic-rte
[232.728371] Subtest basic-rte: SUCCESS (6.148s)
[238.243542] [128/165] (763s left) i915_pm_rps (basic-api)
[238.326317] Starting subtest: basic-api
[238.331149] Subtest basic-api: SUCCESS (0.005s)
[238.400646] [129/165] (763s left) prime_self_import (basic-llseek-bad)
[238.473077] Starting subtest: basic-llseek-bad
[238.475211] Subtest basic-llseek-bad: SUCCESS (0.002s)
[238.592818] [130/165] (763s left) prime_self_import (basic-llseek-size)
[238.670038] Starting subtest: basic-llseek-size
[238.674705] Subtest basic-llseek-size: SUCCESS (0.004s)
[238.802854] [131/165] (762s left) prime_self_import (basic-with_fd_dup)
[238.872717] Starting subtest: basic-with_fd_dup
[238.877462] Subtest basic-with_fd_dup: SUCCESS (0.003s)
[238.998432] [132/165] (762s left) prime_self_import (basic-with_one_bo)
[239.069483] Starting subtest: basic-with_one_bo
[239.073473] Subtest basic-with_one_bo: SUCCESS (0.004s)
[239.130757] [133/165] (762s left) prime_self_import (basic-with_one_bo_two_files)
[239.205249] Starting subtest: basic-with_one_bo_two_files
[239.210078] Subtest basic-with_one_bo_two_files: SUCCESS (0.003s)
[239.301743] [134/165] (762s left) prime_self_import (basic-with_two_bos)
[239.380713] Starting subtest: basic-with_two_bos
[239.385523] Subtest basic-with_two_bos: SUCCESS (0.003s)
[239.467275] [135/165] (762s left) prime_vgem (basic-fence-flip)
[239.559645] Starting subtest: basic-fence-flip
[240.050543] Subtest basic-fence-flip: SUCCESS (0.491s)
[240.162078] [136/165] (761s left) prime_vgem (basic-fence-mmap)
[240.259904] Starting subtest: basic-fence-mmap
[240.298989] Subtest basic-fence-mmap: SUCCESS (0.039s)
[240.388739] [137/165] (761s left) prime_vgem (basic-fence-read)
[240.489086] Starting subtest: basic-fence-read
[240.549202] Subtest basic-fence-read: SUCCESS (0.060s)
[240.638822] [138/165] (761s left) prime_vgem (basic-gtt)
[240.724908] Starting subtest: basic-gtt
[240.742371] Subtest basic-gtt: SUCCESS (0.017s)
[240.871894] [139/165] (761s left) prime_vgem (basic-read)
[240.959430] Starting subtest: basic-read
[240.986769] Subtest basic-read: SUCCESS (0.027s)
[241.081339] [140/165] (760s left) prime_vgem (basic-write)
[241.188376] Starting subtest: basic-write
[241.218694] Subtest basic-write: SUCCESS (0.030s)
[241.298779] [141/165] (760s left) vgem_basic (setversion)
[241.385320] Starting subtest: setversion
[241.387434] Subtest setversion: SUCCESS (0.000s)
[241.448159] [142/165] (760s left) vgem_basic (create)
[241.537102] Starting subtest: create
[241.538281] Subtest create: SUCCESS (0.000s)
[241.595188] [143/165] (760s left) vgem_basic (debugfs)
[241.669682] Starting subtest: debugfs
[241.670725] Subtest debugfs: SUCCESS (0.000s)
[241.728481] [144/165] (760s left) vgem_basic (dmabuf-export)
[241.818820] Starting subtest: dmabuf-export
[241.843693] Subtest dmabuf-export: SUCCESS (0.023s)
[241.955119] [145/165] (760s left) vgem_basic (dmabuf-fence)
[242.035250] Starting subtest: dmabuf-fence
[242.036212] Subtest dmabuf-fence: SUCCESS (0.001s)
[242.094995] [146/165] (760s left) vgem_basic (dmabuf-fence-before)
[242.168817] Starting subtest: dmabuf-fence-before
[242.169953] Subtest dmabuf-fence-before: SUCCESS (0.001s)
[242.229322] [147/165] (759s left) vgem_basic (dmabuf-mmap)
[242.319322] Starting subtest: dmabuf-mmap
[242.337689] Subtest dmabuf-mmap: SUCCESS (0.018s)
[242.395161] [148/165] (759s left) vgem_basic (mmap)
[242.485547] Starting subtest: mmap
[242.498175] Subtest mmap: SUCCESS (0.013s)
[242.560967] [149/165] (759s left) vgem_basic (second-client)
[242.636524] Starting subtest: second-client
[242.669394] Subtest second-client: SUCCESS (0.033s)
[242.747020] [150/165] (759s left) vgem_basic (sysfs)
[242.835784] Starting subtest: sysfs
[242.836868] Subtest sysfs: SUCCESS (0.001s)
[242.895291] [151/165] (759s left) core_hotunplug (unbind-rebind)
[243.019135] Starting subtest: unbind-rebind
[247.387494] Subtest unbind-rebind: SUCCESS (4.368s)
[247.414996] [152/165] (754s left) vgem_basic (unload)
[247.495332] Starting subtest: unload
[276.615870] Subtest unload: SUCCESS (29.082s)
[276.707330] [153/165] (725s left) i915_module_load (reload)
[276.780729] Starting subtest: reload
[281.088993] Subtest reload: SUCCESS (4.305s)
[281.113424] [154/165] (721s left) gem_lmem_swapping (basic)
[281.249611] Subtest basic: SKIP (0.000s)
[281.303542] [155/165] (721s left) gem_lmem_swapping (parallel-random-engines)
[281.383998] Subtest parallel-random-engines: SKIP (0.000s)
[281.414780] [156/165] (720s left) gem_lmem_swapping (random-engines)
[281.496629] Subtest random-engines: SKIP (0.000s)
[281.531545] [157/165] (720s left) gem_lmem_swapping (verify-random)
[281.611237] Subtest verify-random: SKIP (0.000s)
[281.648561] [158/165] (720s left) i915_pm_rpm (module-reload)
[284.344228] Starting subtest: module-reload
[300.447067] Subtest module-reload: SUCCESS (16.096s)
[300.462155] [159/165] (701s left) i915_selftest (live)
[300.545110] Starting subtest: live
[300.546208] Starting dynamic subtest: sanitycheck
[302.288722] Dynamic subtest sanitycheck: SUCCESS (1.734s)
[302.298183] Starting dynamic subtest: uncore
[304.032665] Dynamic subtest uncore: SUCCESS (1.742s)
[304.040392] Starting dynamic subtest: workarounds
[306.013251] Dynamic subtest workarounds: SUCCESS (1.981s)
[306.023063] Starting dynamic subtest: gt_engines
[308.219069] Dynamic subtest gt_engines: SUCCESS (2.201s)
[308.226950] Starting dynamic subtest: gt_timelines
[318.965681] Dynamic subtest gt_timelines: SUCCESS (10.745s)
[318.973939] Starting dynamic subtest: gt_contexts
[320.781822] Dynamic subtest gt_contexts: SUCCESS (1.814s)
[320.790369] Starting dynamic subtest: gt_lrc
[325.013607] Dynamic subtest gt_lrc: SUCCESS (4.230s)
[325.021332] Starting dynamic subtest: gt_mocs
[326.875679] Dynamic subtest gt_mocs: SUCCESS (1.860s)
[326.883296] Starting dynamic subtest: gt_pm
[332.911798] Dynamic subtest gt_pm: SUCCESS (6.034s)
[332.919686] Starting dynamic subtest: gt_heartbeat
[334.680615] Dynamic subtest gt_heartbeat: SUCCESS (1.767s)
[334.691172] Starting dynamic subtest: gt_tlb
[337.523609] Dynamic subtest gt_tlb: SUCCESS (2.841s)
[337.531172] Starting dynamic subtest: requests
[344.983749] Dynamic subtest requests: SUCCESS (7.458s)
[344.994366] Starting dynamic subtest: migrate
[349.503077] Dynamic subtest migrate: SUCCESS (4.518s)
[349.513918] Starting dynamic subtest: active
[351.261679] Dynamic subtest active: SUCCESS (1.756s)
[351.269806] Starting dynamic subtest: objects
[354.089720] Dynamic subtest objects: SUCCESS (2.826s)
[354.101048] Starting dynamic subtest: mman
[359.234701] Dynamic subtest mman: SUCCESS (5.143s)
[359.242347] Starting dynamic subtest: dmabuf
[361.024075] Dynamic subtest dmabuf: SUCCESS (1.788s)
[361.033373] Starting dynamic subtest: vma
[362.764762] Dynamic subtest vma: SUCCESS (1.739s)
[362.776465] Starting dynamic subtest: coherency
[366.438728] Dynamic subtest coherency: SUCCESS (3.672s)
[366.448222] Starting dynamic subtest: gtt
[375.089065] Dynamic subtest gtt: SUCCESS (8.648s)
[375.103744] Starting dynamic subtest: gem
[377.026684] Dynamic subtest gem: SUCCESS (1.935s)
[377.038386] Starting dynamic subtest: evict
[380.272852] Dynamic subtest evict: SUCCESS (3.244s)
[380.287893] Starting dynamic subtest: hugepages
[387.268731] Dynamic subtest hugepages: SUCCESS (6.994s)
[387.280476] Starting dynamic subtest: gem_contexts
[401.868624] Dynamic subtest gem_contexts: SUCCESS (14.598s)
[401.876545] Starting dynamic subtest: client
[403.607547] Dynamic subtest client: SUCCESS (1.737s)
[403.615834] Starting dynamic subtest: gem_migrate
[405.398635] Dynamic subtest gem_migrate: SUCCESS (1.789s)
[405.406552] Starting dynamic subtest: reset
[407.787571] Dynamic subtest reset: SUCCESS (2.387s)
[407.795346] Starting dynamic subtest: memory_region
[409.556757] Dynamic subtest memory_region: SUCCESS (1.767s)
[409.568584] Starting dynamic subtest: hangcheck
[433.713782] Dynamic subtest hangcheck: SUCCESS (24.155s)
[433.724515] Starting dynamic subtest: execlists
[443.422949] Dynamic subtest execlists: SUCCESS (9.707s)
[443.436100] Starting dynamic subtest: ring_submission
[445.125739] Dynamic subtest ring_submission: SUCCESS (1.701s)
[445.135406] Starting dynamic subtest: perf
[447.055973] Dynamic subtest perf: SUCCESS (1.928s)
[447.066474] Starting dynamic subtest: slpc
[448.709868] Dynamic subtest slpc: SUCCESS (1.651s)
[448.717802] Starting dynamic subtest: guc
[450.464692] Dynamic subtest guc: SUCCESS (1.753s)
[450.473076] Starting dynamic subtest: guc_multi_lrc
[452.251722] Dynamic subtest guc_multi_lrc: SUCCESS (1.786s)
[452.259683] Starting dynamic subtest: guc_hang
[453.970724] Dynamic subtest guc_hang: SUCCESS (1.717s)
[453.978696] Starting dynamic subtest: late_gt_pm
[455.764620] Dynamic subtest late_gt_pm: SUCCESS (1.792s)
[455.765673] Subtest live: SUCCESS (155.212s)
[455.783279] [160/165] (546s left) dmabuf (all-tests)
[455.861403] Starting subtest: all-tests
[455.862390] Starting dynamic subtest: sanitycheck
[455.934278] Dynamic subtest sanitycheck: SUCCESS (0.070s)
[455.975468] Starting dynamic subtest: dma_fence
[456.146593] Dynamic subtest dma_fence: SUCCESS (0.203s)
[456.159386] Starting dynamic subtest: dma_fence_chain
[472.438683] Dynamic subtest dma_fence_chain: SUCCESS (16.279s)
[472.466336] Starting dynamic subtest: dma_fence_unwrap
[472.529380] Dynamic subtest dma_fence_unwrap: SUCCESS (0.093s)
[472.562302] Starting dynamic subtest: dma_resv
[472.607498] Dynamic subtest dma_resv: SUCCESS (0.072s)
[472.608669] Subtest all-tests: SUCCESS (16.747s)
[472.636845] [161/165] (529s left) i915_suspend (basic-s2idle-without-i915)
[472.716550] Starting subtest: basic-s2idle-without-i915
[492.420549] Subtest basic-s2idle-without-i915: SUCCESS (4.059s)
[494.791279] [162/165] (525s left) i915_suspend (basic-s3-without-i915)
[494.879304] Starting subtest: basic-s3-without-i915
[515.287257] Subtest basic-s3-without-i915: SUCCESS (4.082s)
[518.737355] [163/165] (520s left) gem_exec_suspend (basic-s0)
[518.868893] Starting subtest: basic-S0
[518.870144] Starting dynamic subtest: smem
[537.400711] Dynamic subtest smem: SUCCESS (3.179s)
[537.401802] Subtest basic-S0: SUCCESS (3.181s)
[540.639050] [164/165] (517s left) gem_exec_suspend (basic-s3)
[540.764961] Starting subtest: basic-S3
[540.766061] Starting dynamic subtest: smem
[561.797482] Dynamic subtest smem: SUCCESS (4.525s)
[561.799293] Subtest basic-S3: SUCCESS (4.530s)
[563.984640] [165/165] (512s left) kms_pipe_crc_basic (suspend-read-crc)
[564.109341] Starting subtest: suspend-read-crc
[564.113770] Starting dynamic subtest: pipe-A-eDP-1
[584.446768] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.443s)
[584.471391] Starting dynamic subtest: pipe-B-eDP-1
[605.631363] Dynamic subtest pipe-B-eDP-1: SUCCESS (4.322s)
[605.673026] Starting dynamic subtest: pipe-C-eDP-1
[626.966649] Dynamic subtest pipe-C-eDP-1: SUCCESS (4.594s)
[626.968357] Subtest suspend-read-crc: SUCCESS (12.386s)
[628.861976] Closing watchdogs
Done.