[46.340356] Initializing watchdogs
[46.340413]   /dev/watchdog0
[46.347129] [001/160] (960s left) i915_module_load (load)
[46.412190] Starting subtest: load
[49.395088] Subtest load: SUCCESS (2.986s)
[49.420048] [002/160] (957s left) core_auth (basic-auth)
[49.559582] Starting subtest: basic-auth
[49.563630] Subtest basic-auth: SUCCESS (0.002s)
[49.643064] [003/160] (957s left) debugfs_test (read_all_entries)
[49.726536] Starting subtest: read_all_entries
[49.864194] Subtest read_all_entries: SUCCESS (0.135s)
[49.980865] [004/160] (956s left) debugfs_test (basic-hwmon)
[50.045119] Starting subtest: basic-hwmon
[50.051522] Subtest basic-hwmon: SKIP (0.000s)
[50.164537] [005/160] (956s left) fbdev (eof)
[50.247571] Starting subtest: eof
[50.250935] Subtest eof: SUCCESS (0.000s)
[50.291510] [006/160] (956s left) fbdev (info)
[50.341542] Starting subtest: info
[50.344692] Subtest info: SUCCESS (0.000s)
[50.419483] [007/160] (956s left) fbdev (nullptr)
[50.510958] Starting subtest: nullptr
[50.514575] Subtest nullptr: SUCCESS (0.000s)
[50.561230] [008/160] (956s left) fbdev (read)
[50.644022] Starting subtest: read
[50.859731] Subtest read: SUCCESS (0.216s)
[50.907318] [009/160] (956s left) fbdev (write)
[50.960827] Starting subtest: write
[51.069739] Subtest write: SUCCESS (0.109s)
[51.107253] [010/160] (955s left) gem_basic (bad-close)
[51.160194] Starting subtest: bad-close
[51.166689] Subtest bad-close: SUCCESS (0.000s)
[51.238236] [011/160] (955s left) gem_basic (create-close)
[51.290790] Starting subtest: create-close
[51.297275] Subtest create-close: SUCCESS (0.000s)
[51.390754] [012/160] (955s left) gem_basic (create-fd-close)
[51.487618] Starting subtest: create-fd-close
[51.494567] Subtest create-fd-close: SUCCESS (0.000s)
[51.574709] [013/160] (955s left) gem_busy (busy@all-engines)
[51.683792] Starting subtest: busy
[51.689293] Starting dynamic subtest: all-engines
[51.705275] Dynamic subtest all-engines: SUCCESS (0.022s)
[51.708593] Subtest busy: SUCCESS (0.022s)
[52.035804] [014/160] (955s left) gem_close_race (basic-process)
[52.096768] Starting subtest: basic-process
[52.143562] Subtest basic-process: SUCCESS (0.046s)
[52.335467] [015/160] (954s left) gem_close_race (basic-threads)
[52.415534] Starting subtest: basic-threads
[53.714864] Subtest basic-threads: SUCCESS (1.212s)
[54.009635] [016/160] (953s left) gem_ctx_create (basic)
[54.506053] Starting subtest: basic
[54.572268] Subtest basic: SUCCESS (0.000s)
[54.802942] [017/160] (952s left) gem_ctx_create (basic-files)
[55.072189] Starting subtest: basic-files
[57.088396] Subtest basic-files: SUCCESS (2.016s)
[57.324788] [018/160] (950s left) gem_ctx_exec (basic)
[57.432444] Starting subtest: basic
[57.435556] Subtest basic: SUCCESS (0.003s)
[57.565773] [019/160] (950s left) gem_exec_basic (basic)
[57.642714] Starting subtest: basic
[57.646098] Starting dynamic subtest: rcs0-smem
[57.649407] Dynamic subtest rcs0-smem: SUCCESS (0.001s)
[57.656200] Starting dynamic subtest: bcs0-smem
[57.659498] Dynamic subtest bcs0-smem: SUCCESS (0.001s)
[57.666395] Starting dynamic subtest: vcs0-smem
[57.669744] Dynamic subtest vcs0-smem: SUCCESS (0.000s)
[57.676877] Starting dynamic subtest: vecs0-smem
[57.679843] Dynamic subtest vecs0-smem: SUCCESS (0.000s)
[57.682799] Subtest basic: SUCCESS (0.003s)
[57.899544] [020/160] (949s left) gem_exec_create (basic)
[57.997603] Starting subtest: basic
[58.001080] Starting dynamic subtest: smem
[60.029779] Dynamic subtest smem: SUCCESS (2.032s)
[60.033358] Subtest basic: SUCCESS (2.032s)
[60.242644] [021/160] (947s left) gem_exec_fence (basic-busy)
[60.465133] Starting subtest: basic-busy
[60.469732] Starting dynamic subtest: rcs0
[60.504228] Dynamic subtest rcs0: SUCCESS (0.040s)
[60.512811] Starting dynamic subtest: bcs0
[60.539494] Dynamic subtest bcs0: SUCCESS (0.036s)
[60.547255] Starting dynamic subtest: vcs0
[60.565667] Dynamic subtest vcs0: SUCCESS (0.026s)
[60.576687] Starting dynamic subtest: vecs0
[60.596504] Dynamic subtest vecs0: SUCCESS (0.030s)
[60.600821] Subtest basic-busy: SUCCESS (0.132s)
[61.185509] [022/160] (946s left) gem_exec_fence (basic-wait)
[61.403693] Starting subtest: basic-wait
[61.408279] Starting dynamic subtest: rcs0
[61.446675] Dynamic subtest rcs0: SUCCESS (0.043s)
[61.471629] Starting dynamic subtest: bcs0
[61.496846] Dynamic subtest bcs0: SUCCESS (0.050s)
[61.522067] Starting dynamic subtest: vcs0
[61.534821] Dynamic subtest vcs0: SUCCESS (0.038s)
[61.549056] Starting dynamic subtest: vecs0
[61.565603] Dynamic subtest vecs0: SUCCESS (0.031s)
[61.569155] Subtest basic-wait: SUCCESS (0.163s)
[62.101961] [023/160] (945s left) gem_exec_fence (basic-await)
[62.277099] Starting subtest: basic-await
[62.280143] Starting dynamic subtest: rcs0
[62.346435] Dynamic subtest rcs0: SUCCESS (0.069s)
[62.358055] Starting dynamic subtest: bcs0
[62.431593] Dynamic subtest bcs0: SUCCESS (0.084s)
[62.448567] Starting dynamic subtest: vcs0
[62.524605] Dynamic subtest vcs0: SUCCESS (0.093s)
[62.538281] Starting dynamic subtest: vecs0
[62.611969] Dynamic subtest vecs0: SUCCESS (0.087s)
[62.616253] Subtest basic-await: SUCCESS (0.334s)
[63.112894] [024/160] (944s left) gem_exec_fence (nb-await)
[63.299927] Starting subtest: nb-await
[63.303133] Starting dynamic subtest: rcs0
[63.359187] Dynamic subtest rcs0: SUCCESS (0.058s)
[63.371205] Starting dynamic subtest: bcs0
[63.421297] Dynamic subtest bcs0: SUCCESS (0.063s)
[63.434649] Starting dynamic subtest: vcs0
[63.481920] Dynamic subtest vcs0: SUCCESS (0.059s)
[63.505602] Starting dynamic subtest: vecs0
[63.553505] Dynamic subtest vecs0: SUCCESS (0.071s)
[63.558124] Subtest nb-await: SUCCESS (0.253s)
[64.112451] [025/160] (943s left) gem_exec_gttfill (basic)
[64.183371] Starting subtest: basic
[69.011578] Subtest basic: SUCCESS (4.828s)
[69.175228] [026/160] (938s left) gem_exec_parallel (engines)
[69.306150] Starting subtest: engines
[69.309317] Starting dynamic subtest: basic
[70.876724] Dynamic subtest basic: SUCCESS (1.570s)
[70.885744] Starting dynamic subtest: contexts
[73.600726] Dynamic subtest contexts: SUCCESS (2.724s)
[73.608418] Starting dynamic subtest: fds
[76.681610] Dynamic subtest fds: SUCCESS (3.031s)
[76.747347] Starting dynamic subtest: userptr
[78.409493] Dynamic subtest userptr: SUCCESS (1.778s)
[78.412936] Subtest engines: SUCCESS (9.103s)
[78.638429] [027/160] (929s left) gem_exec_store (basic)
[78.720491] Starting subtest: basic
[78.783810] Subtest basic: SUCCESS (0.066s)
[78.950780] [028/160] (929s left) gem_flink_basic (bad-flink)
[79.003848] Starting subtest: bad-flink
[79.007260] Subtest bad-flink: SUCCESS (0.000s)
[79.072931] [029/160] (928s left) gem_flink_basic (bad-open)
[79.169381] Starting subtest: bad-open
[79.172694] Subtest bad-open: SUCCESS (0.000s)
[79.235494] [030/160] (928s left) gem_flink_basic (basic)
[79.327169] Starting subtest: basic
[79.330457] Subtest basic: SUCCESS (0.000s)
[79.405308] [031/160] (928s left) gem_flink_basic (double-flink)
[79.471189] Starting subtest: double-flink
[79.474612] Subtest double-flink: SUCCESS (0.000s)
[79.586457] [032/160] (928s left) gem_flink_basic (flink-lifetime)
[79.677539] Starting subtest: flink-lifetime
[79.680793] Subtest flink-lifetime: SUCCESS (0.001s)
[79.781776] [033/160] (928s left) gem_huc_copy (huc-copy)
[79.842226] Starting subtest: huc-copy
[79.845536] Subtest huc-copy: SUCCESS (0.002s)
[79.986705] [034/160] (928s left) gem_linear_blits (basic)
[80.131110] Starting subtest: basic
[80.140083] Subtest basic: SUCCESS (0.006s)
[80.273133] [035/160] (927s left) gem_mmap (basic)
[80.412810] Starting subtest: basic
[80.429753] Subtest basic: SUCCESS (0.000s)
[80.528513] [036/160] (927s left) gem_mmap_gtt (basic)
[80.626761] Starting subtest: basic
[80.630200] Subtest basic: SUCCESS (0.001s)
[80.722361] [037/160] (927s left) gem_render_linear_blits (basic)
[80.793930] Starting subtest: basic
[80.811810] Subtest basic: SUCCESS (0.019s)
[80.853189] [038/160] (927s left) gem_render_tiled_blits (basic)
[80.908697] Starting subtest: basic
[80.928856] Subtest basic: SUCCESS (0.022s)
[80.971812] [039/160] (927s left) gem_ringfill (basic-all)
[81.176660] Starting subtest: basic-all
[82.303155] Subtest basic-all: SUCCESS (1.122s)
[82.420532] [040/160] (925s left) gem_softpin (allocator-basic)
[82.478425] Starting subtest: allocator-basic
[82.538284] Subtest allocator-basic: SUCCESS (0.061s)
[82.639312] [041/160] (925s left) gem_softpin (allocator-basic-reserve)
[82.703282] Starting subtest: allocator-basic-reserve
[82.760429] Subtest allocator-basic-reserve: SUCCESS (0.059s)
[82.897928] [042/160] (925s left) gem_softpin (safe-alignment)
[82.977447] Starting subtest: safe-alignment
[82.995654] Subtest safe-alignment: SUCCESS (0.008s)
[83.138135] [043/160] (925s left) gem_sync (basic-all)
[83.253458] Starting subtest: basic-all
[85.446795] Subtest basic-all: SUCCESS (2.216s)
[85.630103] [044/160] (922s left) gem_sync (basic-each)
[85.717052] Starting subtest: basic-each
[87.802222] Subtest basic-each: SUCCESS (2.105s)
[88.022192] [045/160] (920s left) gem_tiled_blits (basic)
[88.208158] Starting subtest: basic
[88.220537] Subtest basic: SUCCESS (0.011s)
[88.363276] [046/160] (920s left) gem_tiled_fence_blits (basic)
[88.581686] Starting subtest: basic
[88.591531] Subtest basic: SUCCESS (0.008s)
[88.746677] [047/160] (919s left) gem_tiled_pread_basic
[89.085823] [048/160] (919s left) gem_wait (busy@all-engines)
[89.157250] Starting subtest: busy
[89.164238] Starting dynamic subtest: all-engines
[89.678114] Dynamic subtest all-engines: SUCCESS (0.521s)
[89.681422] Subtest busy: SUCCESS (0.521s)
[89.903577] [049/160] (918s left) gem_wait (wait@all-engines)
[89.975781] Starting subtest: wait
[89.979203] Starting dynamic subtest: all-engines
[91.011615] Dynamic subtest all-engines: SUCCESS (1.034s)
[91.015786] Subtest wait: SUCCESS (1.035s)
[91.194746] [050/160] (917s left) i915_getparams_basic (basic-eu-total)
[91.256045] Starting subtest: basic-eu-total
[91.262664] Subtest basic-eu-total: SUCCESS (0.000s)
[91.369629] [051/160] (917s left) i915_getparams_basic (basic-subslice-total)
[91.433195] Starting subtest: basic-subslice-total
[91.439688] Subtest basic-subslice-total: SUCCESS (0.000s)
[91.495251] [052/160] (917s left) i915_hangman (error-state-basic)
[91.572227] Starting subtest: error-state-basic
[91.623454] Subtest error-state-basic: SUCCESS (0.049s)
[91.681101] [053/160] (917s left) i915_pciid
[91.847736] [054/160] (917s left) kms_addfb_basic (addfb25-4-tiled)
[92.005290] Starting subtest: addfb25-4-tiled
[92.008539] Subtest addfb25-4-tiled: SUCCESS (0.000s)
[92.088130] [055/160] (916s left) kms_addfb_basic (addfb25-bad-modifier)
[92.151980] Starting subtest: addfb25-bad-modifier
[92.155173] Subtest addfb25-bad-modifier: SUCCESS (0.000s)
[92.261752] [056/160] (916s left) kms_addfb_basic (addfb25-framebuffer-vs-set-tiling)
[92.322548] Starting subtest: addfb25-framebuffer-vs-set-tiling
[92.325653] Subtest addfb25-framebuffer-vs-set-tiling: SUCCESS (0.000s)
[92.427369] [057/160] (916s left) kms_addfb_basic (addfb25-modifier-no-flag)
[92.483994] Starting subtest: addfb25-modifier-no-flag
[92.487081] Subtest addfb25-modifier-no-flag: SUCCESS (0.000s)
[92.647944] [058/160] (916s left) kms_addfb_basic (addfb25-x-tiled-legacy)
[92.748176] Starting subtest: addfb25-x-tiled-legacy
[92.751311] Subtest addfb25-x-tiled-legacy: SUCCESS (0.000s)
[92.863067] [059/160] (916s left) kms_addfb_basic (addfb25-x-tiled-mismatch-legacy)
[92.934143] Starting subtest: addfb25-x-tiled-mismatch-legacy
[92.937209] Subtest addfb25-x-tiled-mismatch-legacy: SUCCESS (0.000s)
[93.071627] [060/160] (915s left) kms_addfb_basic (addfb25-yf-tiled-legacy)
[93.190140] Starting subtest: addfb25-yf-tiled-legacy
[93.192985] Subtest addfb25-yf-tiled-legacy: SUCCESS (0.000s)
[93.269273] [061/160] (915s left) kms_addfb_basic (addfb25-y-tiled-legacy)
[93.416348] Starting subtest: addfb25-y-tiled-legacy
[93.419141] Subtest addfb25-y-tiled-legacy: SUCCESS (0.000s)
[93.480417] [062/160] (915s left) kms_addfb_basic (addfb25-y-tiled-small-legacy)
[93.617650] Starting subtest: addfb25-y-tiled-small-legacy
[93.620624] Subtest addfb25-y-tiled-small-legacy: SUCCESS (0.000s)
[93.680145] [063/160] (915s left) kms_addfb_basic (bad-pitch-0)
[93.759470] Starting subtest: bad-pitch-0
[93.762689] Subtest bad-pitch-0: SUCCESS (0.000s)
[93.863961] [064/160] (915s left) kms_addfb_basic (bad-pitch-1024)
[93.948363] Starting subtest: bad-pitch-1024
[93.951761] Subtest bad-pitch-1024: SUCCESS (0.000s)
[94.062756] [065/160] (915s left) kms_addfb_basic (bad-pitch-128)
[94.116834] Starting subtest: bad-pitch-128
[94.120098] Subtest bad-pitch-128: SUCCESS (0.000s)
[94.259944] [066/160] (914s left) kms_addfb_basic (bad-pitch-256)
[94.362874] Starting subtest: bad-pitch-256
[94.366147] Subtest bad-pitch-256: SUCCESS (0.000s)
[94.514073] [067/160] (914s left) kms_addfb_basic (bad-pitch-32)
[94.612889] Starting subtest: bad-pitch-32
[94.615991] Subtest bad-pitch-32: SUCCESS (0.000s)
[94.732589] [068/160] (914s left) kms_addfb_basic (bad-pitch-63)
[94.824565] Starting subtest: bad-pitch-63
[94.827886] Subtest bad-pitch-63: SUCCESS (0.000s)
[94.969959] [069/160] (914s left) kms_addfb_basic (bad-pitch-65536)
[95.066814] Starting subtest: bad-pitch-65536
[95.069939] Subtest bad-pitch-65536: SUCCESS (0.000s)
[95.203029] [070/160] (914s left) kms_addfb_basic (bad-pitch-999)
[95.275778] Starting subtest: bad-pitch-999
[95.278863] Subtest bad-pitch-999: SUCCESS (0.000s)
[95.418567] [071/160] (913s left) kms_addfb_basic (basic)
[95.480847] Starting subtest: basic
[95.483929] Subtest basic: SUCCESS (0.000s)
[95.597346] [072/160] (913s left) kms_addfb_basic (basic-x-tiled-legacy)
[95.672895] Starting subtest: basic-x-tiled-legacy
[95.676011] Subtest basic-x-tiled-legacy: SUCCESS (0.000s)
[95.801560] [073/160] (913s left) kms_addfb_basic (basic-y-tiled-legacy)
[95.888326] Starting subtest: basic-y-tiled-legacy
[95.891437] Subtest basic-y-tiled-legacy: SUCCESS (0.000s)
[95.996178] [074/160] (913s left) kms_addfb_basic (bo-too-small)
[96.111022] Starting subtest: bo-too-small
[96.114225] Subtest bo-too-small: SUCCESS (0.000s)
[96.213062] [075/160] (913s left) kms_addfb_basic (bo-too-small-due-to-tiling)
[96.324034] Starting subtest: bo-too-small-due-to-tiling
[96.327122] Subtest bo-too-small-due-to-tiling: SUCCESS (0.000s)
[96.398749] [076/160] (913s left) kms_addfb_basic (clobberred-modifier)
[96.455740] Starting subtest: clobberred-modifier
[96.458927] Subtest clobberred-modifier: SUCCESS (0.000s)
[96.586027] [077/160] (912s left) kms_addfb_basic (framebuffer-vs-set-tiling)
[96.679190] Starting subtest: framebuffer-vs-set-tiling
[96.682304] Subtest framebuffer-vs-set-tiling: SUCCESS (0.000s)
[96.832470] [078/160] (912s left) kms_addfb_basic (invalid-get-prop)
[96.897876] Starting subtest: invalid-get-prop
[96.901031] Subtest invalid-get-prop: SUCCESS (0.000s)
[97.039221] [079/160] (912s left) kms_addfb_basic (invalid-get-prop-any)
[97.135758] Starting subtest: invalid-get-prop-any
[97.138765] Subtest invalid-get-prop-any: SUCCESS (0.000s)
[97.273364] [080/160] (912s left) kms_addfb_basic (invalid-set-prop)
[97.372062] Starting subtest: invalid-set-prop
[97.375166] Subtest invalid-set-prop: SUCCESS (0.000s)
[97.503467] [081/160] (912s left) kms_addfb_basic (invalid-set-prop-any)
[97.595061] Starting subtest: invalid-set-prop-any
[97.598229] Subtest invalid-set-prop-any: SUCCESS (0.000s)
[97.712291] [082/160] (911s left) kms_addfb_basic (no-handle)
[97.800754] Starting subtest: no-handle
[97.803565] Subtest no-handle: SUCCESS (0.000s)
[97.901971] [083/160] (911s left) kms_addfb_basic (size-max)
[98.031456] Starting subtest: size-max
[98.034344] Subtest size-max: SUCCESS (0.000s)
[98.126093] [084/160] (911s left) kms_addfb_basic (small-bo)
[98.272360] Starting subtest: small-bo
[98.275538] Subtest small-bo: SUCCESS (0.000s)
[98.351722] [085/160] (911s left) kms_addfb_basic (tile-pitch-mismatch)
[98.421542] Starting subtest: tile-pitch-mismatch
[98.424618] Subtest tile-pitch-mismatch: SUCCESS (0.000s)
[98.529627] [086/160] (911s left) kms_addfb_basic (too-high)
[98.642597] Starting subtest: too-high
[98.645670] Subtest too-high: SUCCESS (0.000s)
[98.732958] [087/160] (911s left) kms_addfb_basic (too-wide)
[98.834472] Starting subtest: too-wide
[98.837313] Subtest too-wide: SUCCESS (0.000s)
[98.895029] [088/160] (910s left) kms_addfb_basic (unused-handle)
[98.964686] Starting subtest: unused-handle
[98.967794] Subtest unused-handle: SUCCESS (0.000s)
[99.110404] [089/160] (910s left) kms_addfb_basic (unused-modifier)
[99.202738] Starting subtest: unused-modifier
[99.205889] Subtest unused-modifier: SUCCESS (0.000s)
[99.336248] [090/160] (910s left) kms_addfb_basic (unused-offsets)
[99.422754] Starting subtest: unused-offsets
[99.425950] Subtest unused-offsets: SUCCESS (0.000s)
[99.551231] [091/160] (910s left) kms_addfb_basic (unused-pitches)
[99.634507] Starting subtest: unused-pitches
[99.637797] Subtest unused-pitches: SUCCESS (0.000s)
[99.745306] [092/160] (910s left) kms_busy (basic)
[99.850040] Starting subtest: basic
[99.853038] Starting dynamic subtest: flip
[100.494013] Dynamic subtest flip: SUCCESS (0.549s)
[100.558436] Starting dynamic subtest: modeset
[101.081349] Dynamic subtest modeset: SUCCESS (0.611s)
[101.147079] Subtest basic: SUCCESS (1.160s)
[101.377903] [093/160] (908s left) kms_prop_blob (basic)
[101.783707] Starting subtest: basic
[101.787011] Subtest basic: SUCCESS (0.000s)
[101.866304] [094/160] (908s left) kms_cursor_legacy (basic-busy-flip-before-cursor-atomic)
[101.968686] Starting subtest: basic-busy-flip-before-cursor-atomic
[101.975049] Subtest basic-busy-flip-before-cursor-atomic: SKIP (0.000s)
[102.034054] [095/160] (908s left) kms_cursor_legacy (basic-busy-flip-before-cursor-legacy)
[102.140509] Starting subtest: basic-busy-flip-before-cursor-legacy
[102.146586] Subtest basic-busy-flip-before-cursor-legacy: SKIP (0.000s)
[102.195658] [096/160] (908s left) kms_cursor_legacy (basic-flip-after-cursor-atomic)
[102.301885] Starting subtest: basic-flip-after-cursor-atomic
[103.235792] Subtest basic-flip-after-cursor-atomic: SUCCESS (0.933s)
[103.352489] [097/160] (906s left) kms_cursor_legacy (basic-flip-after-cursor-legacy)
[103.469784] Starting subtest: basic-flip-after-cursor-legacy
[104.433943] Subtest basic-flip-after-cursor-legacy: SUCCESS (0.950s)
[104.548055] [098/160] (905s left) kms_cursor_legacy (basic-flip-after-cursor-varying-size)
[104.670758] Starting subtest: basic-flip-after-cursor-varying-size
[105.617051] Subtest basic-flip-after-cursor-varying-size: SUCCESS (0.943s)
[105.727969] [099/160] (904s left) kms_cursor_legacy (basic-flip-before-cursor-atomic)
[105.851560] Starting subtest: basic-flip-before-cursor-atomic
[106.813090] Subtest basic-flip-before-cursor-atomic: SUCCESS (0.960s)
[106.940277] [100/160] (903s left) kms_cursor_legacy (basic-flip-before-cursor-legacy)
[107.049841] Starting subtest: basic-flip-before-cursor-legacy
[108.008431] Subtest basic-flip-before-cursor-legacy: SUCCESS (0.957s)
[108.123487] [101/160] (902s left) kms_cursor_legacy (basic-flip-before-cursor-varying-size)
[108.247791] Starting subtest: basic-flip-before-cursor-varying-size
[109.189635] Subtest basic-flip-before-cursor-varying-size: SUCCESS (0.941s)
[109.303066] [102/160] (901s left) kms_dsc (dsc-basic)
[109.426939] Subtest dsc-basic: SKIP (0.000s)
[109.443339] [103/160] (900s left) kms_flip (basic-flip-vs-dpms)
[109.554808] Starting subtest: basic-flip-vs-dpms
[109.557828] Starting dynamic subtest: A-HDMI-A1
[110.466791] Dynamic subtest A-HDMI-A1: SUCCESS (0.910s)
[110.475019] Starting dynamic subtest: B-HDMI-A1
[111.321442] Dynamic subtest B-HDMI-A1: SUCCESS (0.854s)
[111.330176] Starting dynamic subtest: C-HDMI-A1
[112.171891] Dynamic subtest C-HDMI-A1: SUCCESS (0.853s)
[112.175312] Subtest basic-flip-vs-dpms: SUCCESS (2.623s)
[112.291341] [104/160] (898s left) kms_flip (basic-flip-vs-modeset)
[112.404743] Starting subtest: basic-flip-vs-modeset
[112.407536] Starting dynamic subtest: A-HDMI-A1
[113.306503] Dynamic subtest A-HDMI-A1: SUCCESS (0.901s)
[113.316129] Starting dynamic subtest: B-HDMI-A1
[114.156016] Dynamic subtest B-HDMI-A1: SUCCESS (0.848s)
[114.168226] Starting dynamic subtest: C-HDMI-A1
[115.020180] Dynamic subtest C-HDMI-A1: SUCCESS (0.864s)
[115.024387] Subtest basic-flip-vs-modeset: SUCCESS (2.619s)
[115.158290] [105/160] (895s left) kms_flip (basic-flip-vs-wf_vblank)
[115.267754] Starting subtest: basic-flip-vs-wf_vblank
[115.270769] Starting dynamic subtest: A-HDMI-A1
[116.412096] Dynamic subtest A-HDMI-A1: SUCCESS (1.145s)
[116.420429] Starting dynamic subtest: B-HDMI-A1
[117.537405] Dynamic subtest B-HDMI-A1: SUCCESS (1.125s)
[117.548201] Starting dynamic subtest: C-HDMI-A1
[118.684882] Dynamic subtest C-HDMI-A1: SUCCESS (1.146s)
[118.688127] Subtest basic-flip-vs-wf_vblank: SUCCESS (3.421s)
[118.885570] [106/160] (891s left) kms_flip (basic-plain-flip)
[118.993766] Starting subtest: basic-plain-flip
[118.996882] Starting dynamic subtest: A-HDMI-A1
[119.843597] Dynamic subtest A-HDMI-A1: SUCCESS (0.852s)
[119.851743] Starting dynamic subtest: B-HDMI-A1
[120.681424] Dynamic subtest B-HDMI-A1: SUCCESS (0.837s)
[120.689587] Starting dynamic subtest: C-HDMI-A1
[121.525724] Dynamic subtest C-HDMI-A1: SUCCESS (0.843s)
[121.528830] Subtest basic-plain-flip: SUCCESS (2.537s)
[121.734880] [107/160] (888s left) kms_force_connector_basic (force-connector-state)
[121.902526] Starting subtest: force-connector-state
[122.183185] Subtest force-connector-state: SUCCESS (0.281s)
[122.590720] [108/160] (887s left) kms_force_connector_basic (force-edid)
[122.757517] Starting subtest: force-edid
[122.898267] Subtest force-edid: SUCCESS (0.141s)
[123.089531] [109/160] (887s left) kms_force_connector_basic (force-load-detect)
[123.257677] Starting subtest: force-load-detect
[123.263816] Subtest force-load-detect: SKIP (0.000s)
[123.457455] [110/160] (887s left) kms_force_connector_basic (prune-stale-modes)
[123.612693] Starting subtest: prune-stale-modes
[123.748425] Subtest prune-stale-modes: SUCCESS (0.135s)
[123.939449] [111/160] (886s left) kms_frontbuffer_tracking (basic)
[124.067269] Starting subtest: basic
[126.506328] Subtest basic: SUCCESS (2.450s)
[126.636959] [112/160] (883s left) kms_hdmi_inject (inject-audio)
[126.762293] Starting subtest: inject-audio
[126.880589] Subtest inject-audio: SUCCESS (0.118s)
[127.047062] [113/160] (883s left) kms_pipe_crc_basic (compare-crc-sanitycheck-xr24)
[127.170472] Starting subtest: compare-crc-sanitycheck-xr24
[127.173918] Starting dynamic subtest: pipe-A-HDMI-A-1
[127.556383] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.385s)
[127.564223] Starting dynamic subtest: pipe-B-HDMI-A-1
[127.924267] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.363s)
[127.932701] Starting dynamic subtest: pipe-C-HDMI-A-1
[128.291187] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.366s)
[128.294501] Subtest compare-crc-sanitycheck-xr24: SUCCESS (1.118s)
[128.419361] [114/160] (882s left) kms_pipe_crc_basic (compare-crc-sanitycheck-nv12)
[128.532166] Starting subtest: compare-crc-sanitycheck-nv12
[128.535220] Starting dynamic subtest: pipe-A-HDMI-A-1
[128.954622] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.421s)
[128.962509] Starting dynamic subtest: pipe-B-HDMI-A-1
[129.347485] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.392s)
[129.355585] Starting dynamic subtest: pipe-C-HDMI-A-1
[129.362488] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.000s)
[129.366052] Subtest compare-crc-sanitycheck-nv12: SUCCESS (0.817s)
[129.485529] [115/160] (881s left) kms_pipe_crc_basic (hang-read-crc)
[129.595903] Starting subtest: hang-read-crc
[129.599200] Starting dynamic subtest: pipe-A-HDMI-A-1
[130.582163] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.985s)
[130.590032] Starting dynamic subtest: pipe-B-HDMI-A-1
[131.534566] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.950s)
[131.542744] Starting dynamic subtest: pipe-C-HDMI-A-1
[132.469495] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.934s)
[132.472650] Subtest hang-read-crc: SUCCESS (2.873s)
[132.577812] [116/160] (878s left) kms_pipe_crc_basic (nonblocking-crc)
[132.726311] Starting subtest: nonblocking-crc
[132.729458] Starting dynamic subtest: pipe-A-HDMI-A-1
[133.244611] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.514s)
[133.258213] Starting dynamic subtest: pipe-B-HDMI-A-1
[133.791540] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.547s)
[133.799938] Starting dynamic subtest: pipe-C-HDMI-A-1
[134.287898] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.495s)
[134.290912] Subtest nonblocking-crc: SUCCESS (1.561s)
[134.396937] [117/160] (876s left) kms_pipe_crc_basic (nonblocking-crc-frame-sequence)
[134.506956] Starting subtest: nonblocking-crc-frame-sequence
[134.509635] Starting dynamic subtest: pipe-A-HDMI-A-1
[135.032504] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.525s)
[135.042303] Starting dynamic subtest: pipe-B-HDMI-A-1
[135.546719] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.513s)
[135.556753] Starting dynamic subtest: pipe-C-HDMI-A-1
[136.098572] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.549s)
[136.101597] Subtest nonblocking-crc-frame-sequence: SUCCESS (1.591s)
[136.205144] [118/160] (874s left) kms_pipe_crc_basic (read-crc)
[136.318015] Starting subtest: read-crc
[136.320725] Starting dynamic subtest: pipe-A-HDMI-A-1
[136.802648] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.481s)
[136.810669] Starting dynamic subtest: pipe-B-HDMI-A-1
[137.263504] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.460s)
[137.271939] Starting dynamic subtest: pipe-C-HDMI-A-1
[137.728425] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.464s)
[137.731337] Subtest read-crc: SUCCESS (1.409s)
[137.834561] [119/160] (872s left) kms_pipe_crc_basic (read-crc-frame-sequence)
[137.944980] Starting subtest: read-crc-frame-sequence
[137.948122] Starting dynamic subtest: pipe-A-HDMI-A-1
[138.417031] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.471s)
[138.426963] Starting dynamic subtest: pipe-B-HDMI-A-1
[138.863106] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.446s)
[138.871141] Starting dynamic subtest: pipe-C-HDMI-A-1
[139.410931] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.462s)
[139.476194] Subtest read-crc-frame-sequence: SUCCESS (1.382s)
[139.705870] [120/160] (871s left) kms_pm_backlight (basic-brightness)
[140.295913] Subtest basic-brightness: SKIP (0.000s)
[140.547625] [121/160] (870s left) kms_pm_rpm (basic-pci-d3-state)
[141.966100] Starting subtest: basic-pci-d3-state
[142.249640] Subtest basic-pci-d3-state: SUCCESS (0.283s)
[142.521664] [122/160] (868s left) kms_pm_rpm (basic-rte)
[142.565733] Starting subtest: basic-rte
[144.203619] Subtest basic-rte: SUCCESS (1.640s)
[145.054998] [123/160] (866s left) kms_psr (psr-primary-page-flip)
[145.172200] Subtest psr-primary-page-flip: SKIP (0.000s)
[145.197607] [124/160] (866s left) kms_psr (psr-cursor-plane-move)
[145.304139] Subtest psr-cursor-plane-move: SKIP (0.000s)
[145.330904] [125/160] (865s left) kms_psr (psr-sprite-plane-onoff)
[145.441015] Subtest psr-sprite-plane-onoff: SKIP (0.000s)
[145.465939] [126/160] (865s left) kms_psr (psr-primary-mmap-gtt)
[145.575127] Subtest psr-primary-mmap-gtt: SKIP (0.000s)
[145.598216] [127/160] (865s left) kms_setmode (basic-clone-single-crtc)
[145.653962] Starting subtest: basic-clone-single-crtc
[145.663357] Subtest basic-clone-single-crtc: SKIP (0.000s)
[145.783273] [128/160] (865s left) i915_pm_rps (basic-api)
[145.851175] Starting subtest: basic-api
[145.854604] Subtest basic-api: SUCCESS (0.002s)
[145.968288] [129/160] (865s left) prime_self_import (basic-llseek-bad)
[146.021543] Starting subtest: basic-llseek-bad
[146.035786] Subtest basic-llseek-bad: SUCCESS (0.017s)
[146.167927] [130/160] (865s left) prime_self_import (basic-llseek-size)
[146.237160] Starting subtest: basic-llseek-size
[146.243604] Subtest basic-llseek-size: SUCCESS (0.007s)
[146.350115] [131/160] (865s left) prime_self_import (basic-with_fd_dup)
[146.424876] Starting subtest: basic-with_fd_dup
[146.435715] Subtest basic-with_fd_dup: SUCCESS (0.009s)
[146.514289] [132/160] (865s left) prime_self_import (basic-with_one_bo)
[146.557351] Starting subtest: basic-with_one_bo
[146.572425] Subtest basic-with_one_bo: SUCCESS (0.015s)
[146.693821] [133/160] (864s left) prime_self_import (basic-with_one_bo_two_files)
[146.771855] Starting subtest: basic-with_one_bo_two_files
[146.778186] Subtest basic-with_one_bo_two_files: SUCCESS (0.011s)
[146.875097] [134/160] (864s left) prime_self_import (basic-with_two_bos)
[146.928739] Starting subtest: basic-with_two_bos
[146.939422] Subtest basic-with_two_bos: SUCCESS (0.009s)
[147.036086] [135/160] (864s left) prime_vgem (basic-fence-flip)
[147.157758] Starting subtest: basic-fence-flip
[147.572010] Subtest basic-fence-flip: SUCCESS (0.416s)
[147.657092] [136/160] (864s left) prime_vgem (basic-fence-mmap)
[147.725734] Starting subtest: basic-fence-mmap
[147.747793] Subtest basic-fence-mmap: SUCCESS (0.023s)
[147.886779] [137/160] (863s left) prime_vgem (basic-fence-read)
[148.000095] Starting subtest: basic-fence-read
[148.038517] Subtest basic-fence-read: SUCCESS (0.039s)
[148.167888] [138/160] (863s left) prime_vgem (basic-gtt)
[148.251960] Starting subtest: basic-gtt
[148.258492] Subtest basic-gtt: SUCCESS (0.008s)
[148.354337] [139/160] (863s left) prime_vgem (basic-read)
[148.450418] Starting subtest: basic-read
[148.465309] Subtest basic-read: SUCCESS (0.016s)
[148.577184] [140/160] (863s left) prime_vgem (basic-write)
[148.656555] Starting subtest: basic-write
[148.672954] Subtest basic-write: SUCCESS (0.018s)
[148.774259] [141/160] (863s left) vgem_basic (setversion)
[148.840432] Starting subtest: setversion
[148.846439] Subtest setversion: SUCCESS (0.000s)
[148.893713] [142/160] (863s left) vgem_basic (create)
[148.973594] Starting subtest: create
[148.976959] Subtest create: SUCCESS (0.000s)
[149.026199] [143/160] (862s left) vgem_basic (debugfs)
[149.106193] Starting subtest: debugfs
[149.109106] Subtest debugfs: SUCCESS (0.000s)
[149.157049] [144/160] (862s left) vgem_basic (dmabuf-export)
[149.211833] Starting subtest: dmabuf-export
[149.229467] Subtest dmabuf-export: SUCCESS (0.022s)
[149.351643] [145/160] (862s left) vgem_basic (dmabuf-fence)
[149.440602] Starting subtest: dmabuf-fence
[149.444227] Subtest dmabuf-fence: SUCCESS (0.000s)
[149.490994] [146/160] (862s left) vgem_basic (dmabuf-fence-before)
[149.573023] Starting subtest: dmabuf-fence-before
[149.575956] Subtest dmabuf-fence-before: SUCCESS (0.000s)
[149.623862] [147/160] (862s left) vgem_basic (dmabuf-mmap)
[149.672805] Starting subtest: dmabuf-mmap
[149.679928] Subtest dmabuf-mmap: SUCCESS (0.009s)
[149.719407] [148/160] (862s left) vgem_basic (mmap)
[149.789586] Starting subtest: mmap
[149.795864] Subtest mmap: SUCCESS (0.006s)
[149.839674] [149/160] (862s left) vgem_basic (second-client)
[149.907169] Starting subtest: second-client
[149.939896] Subtest second-client: SUCCESS (0.033s)
[150.034069] [150/160] (862s left) vgem_basic (sysfs)
[150.093999] Starting subtest: sysfs
[150.097746] Subtest sysfs: SUCCESS (0.000s)
[150.140050] [151/160] (862s left) core_hotunplug (unbind-rebind)
[150.254315] Starting subtest: unbind-rebind
[155.073697] Subtest unbind-rebind: SUCCESS (4.820s)
[155.092942] [152/160] (857s left) vgem_basic (unload)
[155.143862] Starting subtest: unload
[184.075503] Subtest unload: SUCCESS (28.933s)
[184.166628] [153/160] (828s left) i915_module_load (reload)
[184.215985] Starting subtest: reload
[188.028042] Subtest reload: SUCCESS (3.818s)
[188.051593] [154/160] (824s left) gem_lmem_swapping (basic)
[188.158804] Subtest basic: SKIP (0.000s)
[188.193885] [155/160] (824s left) gem_lmem_swapping (parallel-random-engines)
[188.270091] Subtest parallel-random-engines: SKIP (0.000s)
[188.288861] [156/160] (824s left) gem_lmem_swapping (random-engines)
[188.349806] Subtest random-engines: SKIP (0.000s)
[188.373409] [157/160] (823s left) gem_lmem_swapping (verify-random)
[188.435542] Subtest verify-random: SKIP (0.000s)
[188.454726] [158/160] (823s left) i915_pm_rpm (module-reload)
[190.154588] Starting subtest: module-reload
[199.946914] Subtest module-reload: SUCCESS (9.793s)
[199.966183] [159/160] (812s left) i915_selftest (live)
[200.045617] Starting subtest: live
[200.048753] Starting dynamic subtest: sanitycheck
[202.588420] Dynamic subtest sanitycheck: SUCCESS (2.543s)
[202.596065] Starting dynamic subtest: uncore
[205.192552] Dynamic subtest uncore: SUCCESS (2.541s)
[205.257384] Starting dynamic subtest: workarounds
[207.850568] Dynamic subtest workarounds: SUCCESS (2.719s)
[207.858029] Starting dynamic subtest: gt_engines
[210.766396] Dynamic subtest gt_engines: SUCCESS (2.915s)
[210.773396] Starting dynamic subtest: gt_timelines
[219.309455] Dynamic subtest gt_timelines: SUCCESS (8.542s)
[219.316704] Starting dynamic subtest: gt_contexts
[221.911381] Dynamic subtest gt_contexts: SUCCESS (2.601s)
[221.918144] Starting dynamic subtest: gt_lrc
[226.770785] Dynamic subtest gt_lrc: SUCCESS (4.858s)
[226.779059] Starting dynamic subtest: gt_mocs
[229.464903] Dynamic subtest gt_mocs: SUCCESS (2.655s)
[229.530502] Starting dynamic subtest: gt_pm
[233.748440] Dynamic subtest gt_pm: SUCCESS (4.321s)
[233.755776] Starting dynamic subtest: gt_heartbeat
[236.322214] Dynamic subtest gt_heartbeat: SUCCESS (2.571s)
[236.329465] Starting dynamic subtest: gt_tlb
[239.739488] Dynamic subtest gt_tlb: SUCCESS (3.418s)
[239.747104] Starting dynamic subtest: requests
[248.492583] Dynamic subtest requests: SUCCESS (8.752s)
[248.500461] Starting dynamic subtest: migrate
[254.225618] Dynamic subtest migrate: SUCCESS (5.732s)
[254.233584] Starting dynamic subtest: active
[256.780676] Dynamic subtest active: SUCCESS (2.554s)
[256.788455] Starting dynamic subtest: objects
[259.813480] Dynamic subtest objects: SUCCESS (3.032s)
[259.820936] Starting dynamic subtest: mman
[265.614563] Dynamic subtest mman: SUCCESS (5.800s)
[265.621871] Starting dynamic subtest: dmabuf
[268.218540] Dynamic subtest dmabuf: SUCCESS (2.603s)
[268.226689] Starting dynamic subtest: vma
[270.772704] Dynamic subtest vma: SUCCESS (2.553s)
[270.780417] Starting dynamic subtest: coherency
[274.784616] Dynamic subtest coherency: SUCCESS (4.011s)
[274.792433] Starting dynamic subtest: gtt
[285.238607] Dynamic subtest gtt: SUCCESS (10.453s)
[285.245624] Starting dynamic subtest: gem
[287.912609] Dynamic subtest gem: SUCCESS (2.673s)
[287.920205] Starting dynamic subtest: evict
[291.318440] Dynamic subtest evict: SUCCESS (3.405s)
[291.326040] Starting dynamic subtest: hugepages
[299.804712] Dynamic subtest hugepages: SUCCESS (8.485s)
[299.812930] Starting dynamic subtest: gem_contexts
[314.380673] Dynamic subtest gem_contexts: SUCCESS (14.575s)
[314.388219] Starting dynamic subtest: client
[317.003619] Dynamic subtest client: SUCCESS (2.622s)
[317.011362] Starting dynamic subtest: gem_migrate
[319.568319] Dynamic subtest gem_migrate: SUCCESS (2.562s)
[319.576100] Starting dynamic subtest: reset
[322.607087] Dynamic subtest reset: SUCCESS (2.993s)
[322.676697] Starting dynamic subtest: memory_region
[325.160499] Dynamic subtest memory_region: SUCCESS (2.599s)
[325.168076] Starting dynamic subtest: hangcheck
[350.695366] Dynamic subtest hangcheck: SUCCESS (25.532s)
[350.702785] Starting dynamic subtest: execlists
[361.177682] Dynamic subtest execlists: SUCCESS (10.483s)
[361.185498] Starting dynamic subtest: ring_submission
[363.697565] Dynamic subtest ring_submission: SUCCESS (2.519s)
[363.705198] Starting dynamic subtest: perf
[366.350393] Dynamic subtest perf: SUCCESS (2.652s)
[366.357883] Starting dynamic subtest: slpc
[368.854525] Dynamic subtest slpc: SUCCESS (2.503s)
[368.862056] Starting dynamic subtest: guc
[371.397492] Dynamic subtest guc: SUCCESS (2.542s)
[371.404276] Starting dynamic subtest: guc_multi_lrc
[373.996511] Dynamic subtest guc_multi_lrc: SUCCESS (2.598s)
[374.003913] Starting dynamic subtest: guc_hang
[376.515368] Dynamic subtest guc_hang: SUCCESS (2.516s)
[376.524193] Starting dynamic subtest: late_gt_pm
[379.099389] Dynamic subtest late_gt_pm: SUCCESS (2.585s)
[379.102315] Subtest live: SUCCESS (179.054s)
[379.124075] [160/160] (633s left) dmabuf (all-tests)
[379.207037] Starting subtest: all-tests
[379.214691] Starting dynamic subtest: sanitycheck
[379.285474] Dynamic subtest sanitycheck: SUCCESS (0.073s)
[379.296330] Starting dynamic subtest: dma_fence
[379.465283] Dynamic subtest dma_fence: SUCCESS (0.179s)
[379.476211] Starting dynamic subtest: dma_fence_chain
[389.753115] Dynamic subtest dma_fence_chain: SUCCESS (10.287s)
[389.761907] Starting dynamic subtest: dma_fence_unwrap
[389.827703] Dynamic subtest dma_fence_unwrap: SUCCESS (0.073s)
[389.844891] Starting dynamic subtest: dma_resv
[389.902881] Dynamic subtest dma_resv: SUCCESS (0.074s)
[389.906915] Subtest all-tests: SUCCESS (10.697s)
[389.937717] Closing watchdogs
Done.