[62.808622] Initializing watchdogs
[62.808665]   /dev/watchdog0
[62.812204] [001/165] (960s left) i915_module_load (load)
[62.886847] Starting subtest: load
[65.076980] Subtest load: SUCCESS (2.190s)
[65.085395] [002/165] (958s left) core_auth (basic-auth)
[65.156610] Starting subtest: basic-auth
[65.157608] Subtest basic-auth: SUCCESS (0.001s)
[65.231086] [003/165] (958s left) debugfs_test (read_all_entries)
[65.275828] Starting subtest: read_all_entries
[65.410819] Subtest read_all_entries: SUCCESS (0.135s)
[65.663708] [004/165] (957s left) debugfs_test (basic-hwmon)
[65.706969] Starting subtest: basic-hwmon
[65.708907] Subtest basic-hwmon: SKIP (0.000s)
[65.965456] [005/165] (957s left) fbdev (eof)
[66.011066] Starting subtest: eof
[66.012128] Subtest eof: SUCCESS (0.000s)
[66.061772] [006/165] (957s left) fbdev (info)
[66.095717] Starting subtest: info
[66.096893] Subtest info: SUCCESS (0.000s)
[66.159050] [007/165] (957s left) fbdev (nullptr)
[66.193967] Starting subtest: nullptr
[66.194941] Subtest nullptr: SUCCESS (0.000s)
[66.243042] [008/165] (957s left) fbdev (read)
[66.277218] Starting subtest: read
[68.785082] Subtest read: SUCCESS (2.499s)
[68.826131] [009/165] (954s left) fbdev (write)
[68.860661] Starting subtest: write
[70.726548] Subtest write: SUCCESS (1.857s)
[70.776258] [010/165] (952s left) gem_basic (bad-close)
[70.815081] Starting subtest: bad-close
[70.817053] Subtest bad-close: SUCCESS (0.000s)
[70.900766] [011/165] (952s left) gem_basic (create-close)
[70.941162] Starting subtest: create-close
[70.943071] Subtest create-close: SUCCESS (0.000s)
[71.013871] [012/165] (952s left) gem_basic (create-fd-close)
[71.053995] Starting subtest: create-fd-close
[71.055989] Subtest create-fd-close: SUCCESS (0.000s)
[71.131038] [013/165] (952s left) gem_busy (busy@all-engines)
[71.179511] Starting subtest: busy
[71.180501] Starting dynamic subtest: all-engines
[71.228850] Dynamic subtest all-engines: SUCCESS (0.049s)
[71.229675] Subtest busy: SUCCESS (0.049s)
[71.565681] [014/165] (951s left) gem_close_race (basic-process)
[71.622277] Starting subtest: basic-process
[71.663473] Subtest basic-process: SUCCESS (0.040s)
[71.849389] [015/165] (951s left) gem_close_race (basic-threads)
[71.903630] Starting subtest: basic-threads
[73.187241] Subtest basic-threads: SUCCESS (1.284s)
[73.365204] [016/165] (950s left) gem_ctx_create (basic)
[73.412601] Starting subtest: basic
[73.413628] Subtest basic: SUCCESS (0.000s)
[73.582228] [017/165] (949s left) gem_ctx_create (basic-files)
[73.634279] Starting subtest: basic-files
[75.647486] Subtest basic-files: SUCCESS (2.010s)
[75.828646] [018/165] (947s left) gem_ctx_exec (basic)
[75.878284] Starting subtest: basic
[75.881239] Subtest basic: SUCCESS (0.003s)
[75.980577] [019/165] (947s left) gem_exec_basic (basic)
[76.024849] Starting subtest: basic
[76.025723] Starting dynamic subtest: rcs0-smem
[76.026595] Dynamic subtest rcs0-smem: SUCCESS (0.001s)
[76.031310] Starting dynamic subtest: bcs0-smem
[76.032220] Dynamic subtest bcs0-smem: SUCCESS (0.000s)
[76.035780] Starting dynamic subtest: vcs0-smem
[76.036723] Dynamic subtest vcs0-smem: SUCCESS (0.000s)
[76.040234] Starting dynamic subtest: vcs1-smem
[76.041056] Dynamic subtest vcs1-smem: SUCCESS (0.000s)
[76.044830] Starting dynamic subtest: vecs0-smem
[76.045815] Dynamic subtest vecs0-smem: SUCCESS (0.000s)
[76.046592] Subtest basic: SUCCESS (0.002s)
[76.201199] [020/165] (947s left) gem_exec_create (basic)
[76.245489] Starting subtest: basic
[76.246317] Starting dynamic subtest: smem
[78.332423] Dynamic subtest smem: SUCCESS (2.086s)
[78.334050] Subtest basic: SUCCESS (2.087s)
[78.498735] [021/165] (945s left) gem_exec_fence (basic-busy)
[78.674297] Starting subtest: basic-busy
[78.675470] Starting dynamic subtest: rcs0
[78.733652] Dynamic subtest rcs0: SUCCESS (0.068s)
[78.743174] Starting dynamic subtest: bcs0
[78.780274] Dynamic subtest bcs0: SUCCESS (0.046s)
[78.793095] Starting dynamic subtest: vcs0
[78.828610] Dynamic subtest vcs0: SUCCESS (0.048s)
[78.840184] Starting dynamic subtest: vcs1
[78.879356] Dynamic subtest vcs1: SUCCESS (0.051s)
[78.888142] Starting dynamic subtest: vecs0
[78.930986] Dynamic subtest vecs0: SUCCESS (0.052s)
[78.932635] Subtest basic-busy: SUCCESS (0.265s)
[79.416766] [022/165] (944s left) gem_exec_fence (basic-wait)
[79.599871] Starting subtest: basic-wait
[79.601533] Starting dynamic subtest: rcs0
[79.641895] Dynamic subtest rcs0: SUCCESS (0.050s)
[79.651327] Starting dynamic subtest: bcs0
[79.693497] Dynamic subtest bcs0: SUCCESS (0.050s)
[79.702768] Starting dynamic subtest: vcs0
[79.739065] Dynamic subtest vcs0: SUCCESS (0.047s)
[79.750361] Starting dynamic subtest: vcs1
[79.787267] Dynamic subtest vcs1: SUCCESS (0.048s)
[79.800166] Starting dynamic subtest: vecs0
[79.835147] Dynamic subtest vecs0: SUCCESS (0.048s)
[79.837074] Subtest basic-wait: SUCCESS (0.244s)
[80.315755] [023/165] (943s left) gem_exec_fence (basic-await)
[80.481755] Starting subtest: basic-await
[80.482614] Starting dynamic subtest: rcs0
[80.544487] Dynamic subtest rcs0: SUCCESS (0.072s)
[80.550205] Starting dynamic subtest: bcs0
[80.615579] Dynamic subtest bcs0: SUCCESS (0.070s)
[80.622423] Starting dynamic subtest: vcs0
[80.686163] Dynamic subtest vcs0: SUCCESS (0.070s)
[80.695496] Starting dynamic subtest: vcs1
[80.761290] Dynamic subtest vcs1: SUCCESS (0.075s)
[80.769118] Starting dynamic subtest: vecs0
[80.833807] Dynamic subtest vecs0: SUCCESS (0.072s)
[80.835585] Subtest basic-await: SUCCESS (0.361s)
[81.319826] [024/165] (942s left) gem_exec_fence (nb-await)
[81.495165] Starting subtest: nb-await
[81.496188] Starting dynamic subtest: rcs0
[81.544145] Dynamic subtest rcs0: SUCCESS (0.058s)
[81.555547] Starting dynamic subtest: bcs0
[81.605132] Dynamic subtest bcs0: SUCCESS (0.061s)
[81.614578] Starting dynamic subtest: vcs0
[81.665282] Dynamic subtest vcs0: SUCCESS (0.060s)
[81.676646] Starting dynamic subtest: vcs1
[81.726080] Dynamic subtest vcs1: SUCCESS (0.061s)
[81.732512] Starting dynamic subtest: vecs0
[81.783813] Dynamic subtest vecs0: SUCCESS (0.057s)
[81.785914] Subtest nb-await: SUCCESS (0.297s)
[82.269574] [025/165] (941s left) gem_exec_gttfill (basic)
[82.317815] Starting subtest: basic
[84.590637] Subtest basic: SUCCESS (2.273s)
[84.761455] [026/165] (938s left) gem_exec_parallel (engines)
[84.843919] Starting subtest: engines
[84.844959] Starting dynamic subtest: basic
[86.458292] Dynamic subtest basic: SUCCESS (1.614s)
[86.463223] Starting dynamic subtest: contexts
[88.516213] Dynamic subtest contexts: SUCCESS (2.049s)
[88.522208] Starting dynamic subtest: fds
[90.953432] Dynamic subtest fds: SUCCESS (2.446s)
[90.957862] Starting dynamic subtest: userptr
[92.509492] Dynamic subtest userptr: SUCCESS (1.556s)
[92.510818] Subtest engines: SUCCESS (7.665s)
[92.687931] [027/165] (930s left) gem_exec_store (basic)
[92.744173] Starting subtest: basic
[92.821327] Subtest basic: SUCCESS (0.076s)
[92.998017] [028/165] (930s left) gem_flink_basic (bad-flink)
[93.040802] Starting subtest: bad-flink
[93.041696] Subtest bad-flink: SUCCESS (0.000s)
[93.117780] [029/165] (930s left) gem_flink_basic (bad-open)
[93.158736] Starting subtest: bad-open
[93.159674] Subtest bad-open: SUCCESS (0.000s)
[93.232213] [030/165] (930s left) gem_flink_basic (basic)
[93.270743] Starting subtest: basic
[93.271688] Subtest basic: SUCCESS (0.000s)
[93.331148] [031/165] (930s left) gem_flink_basic (double-flink)
[93.378875] Starting subtest: double-flink
[93.379778] Subtest double-flink: SUCCESS (0.000s)
[93.450207] [032/165] (930s left) gem_flink_basic (flink-lifetime)
[93.503049] Starting subtest: flink-lifetime
[93.504527] Subtest flink-lifetime: SUCCESS (0.002s)
[93.584461] [033/165] (930s left) gem_huc_copy (huc-copy)
[93.629445] Starting subtest: huc-copy
[93.630546] Subtest huc-copy: SUCCESS (0.002s)
[93.720220] [034/165] (929s left) gem_linear_blits (basic)
[93.842881] Starting subtest: basic
[93.847530] Subtest basic: SUCCESS (0.005s)
[93.964176] [035/165] (929s left) gem_mmap (basic)
[94.037235] Starting subtest: basic
[94.042560] Subtest basic: SUCCESS (0.000s)
[94.117690] [036/165] (929s left) gem_mmap_gtt (basic)
[94.155558] Starting subtest: basic
[94.156538] Subtest basic: SUCCESS (0.001s)
[94.218353] [037/165] (929s left) gem_render_linear_blits (basic)
[94.263295] Starting subtest: basic
[94.279172] Subtest basic: SUCCESS (0.016s)
[94.334185] [038/165] (929s left) gem_render_tiled_blits (basic)
[94.373028] Starting subtest: basic
[94.394183] Subtest basic: SUCCESS (0.022s)
[94.450332] [039/165] (929s left) gem_ringfill (basic-all)
[94.781658] Starting subtest: basic-all
[95.904441] Subtest basic-all: SUCCESS (1.115s)
[96.002669] [040/165] (927s left) gem_softpin (allocator-basic)
[96.037978] Starting subtest: allocator-basic
[96.086525] Subtest allocator-basic: SUCCESS (0.048s)
[96.185865] [041/165] (927s left) gem_softpin (allocator-basic-reserve)
[96.221067] Starting subtest: allocator-basic-reserve
[96.269922] Subtest allocator-basic-reserve: SUCCESS (0.049s)
[96.367438] [042/165] (927s left) gem_softpin (safe-alignment)
[96.415079] Starting subtest: safe-alignment
[96.422963] Subtest safe-alignment: SUCCESS (0.008s)
[96.514459] [043/165] (927s left) gem_sync (basic-all)
[96.563788] Starting subtest: basic-all
[99.041539] Subtest basic-all: SUCCESS (2.477s)
[99.218972] [044/165] (924s left) gem_sync (basic-each)
[99.269196] Starting subtest: basic-each
[101.543571] Subtest basic-each: SUCCESS (2.274s)
[101.721208] [045/165] (922s left) gem_tiled_blits (basic)
[101.843848] Starting subtest: basic
[101.855419] Subtest basic: SUCCESS (0.012s)
[101.964484] [046/165] (921s left) gem_tiled_fence_blits (basic)
[102.121949] Starting subtest: basic
[102.143235] Subtest basic: SUCCESS (0.021s)
[102.242074] [047/165] (921s left) gem_tiled_pread_basic
[102.352098] [048/165] (921s left) gem_wait (busy@all-engines)
[102.401847] Starting subtest: busy
[102.402808] Starting dynamic subtest: all-engines
[102.952797] Dynamic subtest all-engines: SUCCESS (0.550s)
[102.954228] Subtest busy: SUCCESS (0.551s)
[103.153159] [049/165] (920s left) gem_wait (wait@all-engines)
[103.199631] Starting subtest: wait
[103.200647] Starting dynamic subtest: all-engines
[104.252172] Dynamic subtest all-engines: SUCCESS (1.052s)
[104.253899] Subtest wait: SUCCESS (1.052s)
[104.450215] [050/165] (919s left) i915_getparams_basic (basic-eu-total)
[104.485553] Starting subtest: basic-eu-total
[104.487072] Subtest basic-eu-total: SUCCESS (0.000s)
[104.549265] [051/165] (919s left) i915_getparams_basic (basic-subslice-total)
[104.587833] Starting subtest: basic-subslice-total
[104.589723] Subtest basic-subslice-total: SUCCESS (0.000s)
[104.650804] [052/165] (919s left) i915_hangman (error-state-basic)
[104.702910] Starting subtest: error-state-basic
[104.796469] Subtest error-state-basic: SUCCESS (0.094s)
[104.867208] [053/165] (918s left) i915_pciid
[104.984198] [054/165] (918s left) kms_addfb_basic (addfb25-4-tiled)
[105.220750] Starting subtest: addfb25-4-tiled
[105.221754] Subtest addfb25-4-tiled: SUCCESS (0.000s)
[105.285629] [055/165] (918s left) kms_addfb_basic (addfb25-bad-modifier)
[105.324194] Starting subtest: addfb25-bad-modifier
[105.325309] Subtest addfb25-bad-modifier: SUCCESS (0.000s)
[105.585457] [056/165] (918s left) kms_addfb_basic (addfb25-framebuffer-vs-set-tiling)
[105.635595] Starting subtest: addfb25-framebuffer-vs-set-tiling
[105.636691] Subtest addfb25-framebuffer-vs-set-tiling: SUCCESS (0.000s)
[105.900618] [057/165] (917s left) kms_addfb_basic (addfb25-modifier-no-flag)
[105.944309] Starting subtest: addfb25-modifier-no-flag
[105.945341] Subtest addfb25-modifier-no-flag: SUCCESS (0.000s)
[106.200055] [058/165] (917s left) kms_addfb_basic (addfb25-x-tiled-legacy)
[106.246382] Starting subtest: addfb25-x-tiled-legacy
[106.247416] Subtest addfb25-x-tiled-legacy: SUCCESS (0.000s)
[106.502256] [059/165] (917s left) kms_addfb_basic (addfb25-x-tiled-mismatch-legacy)
[106.540877] Starting subtest: addfb25-x-tiled-mismatch-legacy
[106.541884] Subtest addfb25-x-tiled-mismatch-legacy: SUCCESS (0.000s)
[106.820211] [060/165] (917s left) kms_addfb_basic (addfb25-yf-tiled-legacy)
[107.044683] Starting subtest: addfb25-yf-tiled-legacy
[107.045815] Subtest addfb25-yf-tiled-legacy: SUCCESS (0.000s)
[107.136906] [061/165] (916s left) kms_addfb_basic (addfb25-y-tiled-legacy)
[107.366069] Starting subtest: addfb25-y-tiled-legacy
[107.366851] Subtest addfb25-y-tiled-legacy: SUCCESS (0.000s)
[107.437127] [062/165] (916s left) kms_addfb_basic (addfb25-y-tiled-small-legacy)
[107.669749] Starting subtest: addfb25-y-tiled-small-legacy
[107.670999] Subtest addfb25-y-tiled-small-legacy: SUCCESS (0.000s)
[107.735730] [063/165] (916s left) kms_addfb_basic (bad-pitch-0)
[107.780887] Starting subtest: bad-pitch-0
[107.781840] Subtest bad-pitch-0: SUCCESS (0.000s)
[108.053320] [064/165] (915s left) kms_addfb_basic (bad-pitch-1024)
[108.095681] Starting subtest: bad-pitch-1024
[108.096564] Subtest bad-pitch-1024: SUCCESS (0.000s)
[108.368930] [065/165] (915s left) kms_addfb_basic (bad-pitch-128)
[108.412933] Starting subtest: bad-pitch-128
[108.413912] Subtest bad-pitch-128: SUCCESS (0.000s)
[108.668851] [066/165] (915s left) kms_addfb_basic (bad-pitch-256)
[108.708197] Starting subtest: bad-pitch-256
[108.709029] Subtest bad-pitch-256: SUCCESS (0.000s)
[108.986269] [067/165] (915s left) kms_addfb_basic (bad-pitch-32)
[109.029955] Starting subtest: bad-pitch-32
[109.030999] Subtest bad-pitch-32: SUCCESS (0.000s)
[109.285565] [068/165] (914s left) kms_addfb_basic (bad-pitch-63)
[109.328933] Starting subtest: bad-pitch-63
[109.329778] Subtest bad-pitch-63: SUCCESS (0.000s)
[109.585034] [069/165] (914s left) kms_addfb_basic (bad-pitch-65536)
[109.627384] Starting subtest: bad-pitch-65536
[109.628372] Subtest bad-pitch-65536: SUCCESS (0.000s)
[109.901998] [070/165] (914s left) kms_addfb_basic (bad-pitch-999)
[109.940631] Starting subtest: bad-pitch-999
[109.941543] Subtest bad-pitch-999: SUCCESS (0.000s)
[110.202550] [071/165] (913s left) kms_addfb_basic (basic)
[110.241890] Starting subtest: basic
[110.242931] Subtest basic: SUCCESS (0.000s)
[110.503451] [072/165] (913s left) kms_addfb_basic (basic-x-tiled-legacy)
[110.545246] Starting subtest: basic-x-tiled-legacy
[110.546376] Subtest basic-x-tiled-legacy: SUCCESS (0.000s)
[110.803205] [073/165] (913s left) kms_addfb_basic (basic-y-tiled-legacy)
[110.854455] Starting subtest: basic-y-tiled-legacy
[110.855558] Subtest basic-y-tiled-legacy: SUCCESS (0.000s)
[111.118662] [074/165] (912s left) kms_addfb_basic (bo-too-small)
[111.352406] Starting subtest: bo-too-small
[111.353396] Subtest bo-too-small: SUCCESS (0.000s)
[111.435707] [075/165] (912s left) kms_addfb_basic (bo-too-small-due-to-tiling)
[111.662864] Starting subtest: bo-too-small-due-to-tiling
[111.663882] Subtest bo-too-small-due-to-tiling: SUCCESS (0.000s)
[111.735611] [076/165] (912s left) kms_addfb_basic (clobberred-modifier)
[111.775732] Starting subtest: clobberred-modifier
[111.776625] Subtest clobberred-modifier: SUCCESS (0.000s)
[112.035552] [077/165] (912s left) kms_addfb_basic (framebuffer-vs-set-tiling)
[112.076368] Starting subtest: framebuffer-vs-set-tiling
[112.077430] Subtest framebuffer-vs-set-tiling: SUCCESS (0.000s)
[112.336726] [078/165] (911s left) kms_addfb_basic (invalid-get-prop)
[112.386442] Starting subtest: invalid-get-prop
[112.387529] Subtest invalid-get-prop: SUCCESS (0.000s)
[112.638242] [079/165] (911s left) kms_addfb_basic (invalid-get-prop-any)
[112.689550] Starting subtest: invalid-get-prop-any
[112.690581] Subtest invalid-get-prop-any: SUCCESS (0.000s)
[112.971028] [080/165] (911s left) kms_addfb_basic (invalid-set-prop)
[113.013832] Starting subtest: invalid-set-prop
[113.014686] Subtest invalid-set-prop: SUCCESS (0.000s)
[113.270308] [081/165] (910s left) kms_addfb_basic (invalid-set-prop-any)
[113.312671] Starting subtest: invalid-set-prop-any
[113.313364] Subtest invalid-set-prop-any: SUCCESS (0.000s)
[113.585588] [082/165] (910s left) kms_addfb_basic (no-handle)
[113.632790] Starting subtest: no-handle
[113.633580] Subtest no-handle: SUCCESS (0.000s)
[113.885518] [083/165] (910s left) kms_addfb_basic (size-max)
[114.110260] Starting subtest: size-max
[114.111190] Subtest size-max: SUCCESS (0.000s)
[114.186222] [084/165] (909s left) kms_addfb_basic (small-bo)
[114.418927] Starting subtest: small-bo
[114.419752] Subtest small-bo: SUCCESS (0.000s)
[114.490928] [085/165] (909s left) kms_addfb_basic (tile-pitch-mismatch)
[114.531019] Starting subtest: tile-pitch-mismatch
[114.531894] Subtest tile-pitch-mismatch: SUCCESS (0.000s)
[114.805102] [086/165] (909s left) kms_addfb_basic (too-high)
[115.038449] Starting subtest: too-high
[115.039452] Subtest too-high: SUCCESS (0.000s)
[115.120754] [087/165] (909s left) kms_addfb_basic (too-wide)
[115.355181] Starting subtest: too-wide
[115.356155] Subtest too-wide: SUCCESS (0.000s)
[115.436614] [088/165] (908s left) kms_addfb_basic (unused-handle)
[115.485203] Starting subtest: unused-handle
[115.486226] Subtest unused-handle: SUCCESS (0.000s)
[115.753469] [089/165] (908s left) kms_addfb_basic (unused-modifier)
[115.796077] Starting subtest: unused-modifier
[115.797139] Subtest unused-modifier: SUCCESS (0.000s)
[116.069942] [090/165] (908s left) kms_addfb_basic (unused-offsets)
[116.111881] Starting subtest: unused-offsets
[116.112873] Subtest unused-offsets: SUCCESS (0.000s)
[116.369697] [091/165] (907s left) kms_addfb_basic (unused-pitches)
[116.411083] Starting subtest: unused-pitches
[116.412230] Subtest unused-pitches: SUCCESS (0.000s)
[116.687576] [092/165] (907s left) kms_busy (basic)
[116.919996] Starting subtest: basic
[116.920935] Starting dynamic subtest: flip
[117.490233] Dynamic subtest flip: SUCCESS (0.569s)
[117.497047] Starting dynamic subtest: modeset
[118.259411] Dynamic subtest modeset: SUCCESS (0.769s)
[118.260250] Subtest basic: SUCCESS (1.340s)
[118.421119] [093/165] (905s left) kms_prop_blob (basic)
[118.464710] Starting subtest: basic
[118.465509] Subtest basic: SUCCESS (0.000s)
[118.539284] [094/165] (905s left) kms_cursor_legacy (basic-busy-flip-before-cursor-atomic)
[118.767850] Starting subtest: basic-busy-flip-before-cursor-atomic
[118.769826] Subtest basic-busy-flip-before-cursor-atomic: SKIP (0.000s)
[118.838928] [095/165] (905s left) kms_cursor_legacy (basic-busy-flip-before-cursor-legacy)
[119.068413] Starting subtest: basic-busy-flip-before-cursor-legacy
[119.070365] Subtest basic-busy-flip-before-cursor-legacy: SKIP (0.000s)
[119.138225] [096/165] (905s left) kms_cursor_legacy (basic-flip-after-cursor-atomic)
[119.360341] Starting subtest: basic-flip-after-cursor-atomic
[120.345074] Subtest basic-flip-after-cursor-atomic: SUCCESS (0.984s)
[120.493814] [097/165] (903s left) kms_cursor_legacy (basic-flip-after-cursor-legacy)
[120.733415] Starting subtest: basic-flip-after-cursor-legacy
[121.715807] Subtest basic-flip-after-cursor-legacy: SUCCESS (0.983s)
[121.874237] [098/165] (902s left) kms_cursor_legacy (basic-flip-after-cursor-varying-size)
[122.111508] Starting subtest: basic-flip-after-cursor-varying-size
[123.079513] Subtest basic-flip-after-cursor-varying-size: SUCCESS (0.968s)
[123.246684] [099/165] (901s left) kms_cursor_legacy (basic-flip-before-cursor-atomic)
[123.483336] Starting subtest: basic-flip-before-cursor-atomic
[124.448989] Subtest basic-flip-before-cursor-atomic: SUCCESS (0.966s)
[124.625917] [100/165] (899s left) kms_cursor_legacy (basic-flip-before-cursor-legacy)
[124.852062] Starting subtest: basic-flip-before-cursor-legacy
[125.827424] Subtest basic-flip-before-cursor-legacy: SUCCESS (0.975s)
[125.993925] [101/165] (898s left) kms_cursor_legacy (basic-flip-before-cursor-varying-size)
[126.230460] Starting subtest: basic-flip-before-cursor-varying-size
[127.209981] Subtest basic-flip-before-cursor-varying-size: SUCCESS (0.980s)
[127.377263] [102/165] (897s left) kms_dsc (dsc-basic)
[127.607340] Starting subtest: dsc-basic
[127.608905] Subtest dsc-basic: SKIP (0.000s)
[127.676419] [103/165] (896s left) kms_flip (basic-flip-vs-dpms)
[127.907309] Starting subtest: basic-flip-vs-dpms
[127.909485] Starting dynamic subtest: A-DP1
[128.795138] Dynamic subtest A-DP1: SUCCESS (0.885s)
[128.799701] Starting dynamic subtest: B-DP1
[129.547871] Dynamic subtest B-DP1: SUCCESS (0.753s)
[129.555297] Starting dynamic subtest: C-DP1
[130.305343] Dynamic subtest C-DP1: SUCCESS (0.757s)
[130.312943] Starting dynamic subtest: D-DP1
[131.053674] Dynamic subtest D-DP1: SUCCESS (0.748s)
[131.055482] Subtest basic-flip-vs-dpms: SUCCESS (3.149s)
[131.211460] [104/165] (893s left) kms_flip (basic-flip-vs-modeset)
[131.436568] Starting subtest: basic-flip-vs-modeset
[131.438607] Starting dynamic subtest: A-DP1
[132.339369] Dynamic subtest A-DP1: SUCCESS (0.901s)
[132.346494] Starting dynamic subtest: B-DP1
[133.100831] Dynamic subtest B-DP1: SUCCESS (0.760s)
[133.108165] Starting dynamic subtest: C-DP1
[133.856111] Dynamic subtest C-DP1: SUCCESS (0.755s)
[133.863605] Starting dynamic subtest: D-DP1
[134.611641] Dynamic subtest D-DP1: SUCCESS (0.755s)
[134.613650] Subtest basic-flip-vs-modeset: SUCCESS (3.178s)
[134.784477] [105/165] (889s left) kms_flip (basic-flip-vs-wf_vblank)
[135.023032] Starting subtest: basic-flip-vs-wf_vblank
[135.024809] Starting dynamic subtest: A-DP1
[136.095267] Dynamic subtest A-DP1: SUCCESS (1.069s)
[136.105519] Starting dynamic subtest: B-DP1
[137.109175] Dynamic subtest B-DP1: SUCCESS (1.011s)
[137.118052] Starting dynamic subtest: C-DP1
[138.121679] Dynamic subtest C-DP1: SUCCESS (1.011s)
[138.131907] Starting dynamic subtest: D-DP1
[139.135686] Dynamic subtest D-DP1: SUCCESS (1.013s)
[139.139805] Subtest basic-flip-vs-wf_vblank: SUCCESS (4.118s)
[139.373163] [106/165] (885s left) kms_flip (basic-plain-flip)
[139.603707] Starting subtest: basic-plain-flip
[139.604586] Starting dynamic subtest: A-DP1
[140.382725] Dynamic subtest A-DP1: SUCCESS (0.777s)
[140.390858] Starting dynamic subtest: B-DP1
[141.118084] Dynamic subtest B-DP1: SUCCESS (0.731s)
[141.126877] Starting dynamic subtest: C-DP1
[141.850496] Dynamic subtest C-DP1: SUCCESS (0.729s)
[141.856350] Starting dynamic subtest: D-DP1
[142.580844] Dynamic subtest D-DP1: SUCCESS (0.731s)
[142.587987] Subtest basic-plain-flip: SUCCESS (2.986s)
[142.804442] [107/165] (881s left) kms_force_connector_basic (force-connector-state)
[143.064733] Starting subtest: force-connector-state
[143.774569] Subtest force-connector-state: SUCCESS (0.710s)
[144.435883] [108/165] (880s left) kms_force_connector_basic (force-edid)
[144.687679] Starting subtest: force-edid
[145.094167] Subtest force-edid: SUCCESS (0.407s)
[145.620859] [109/165] (878s left) kms_force_connector_basic (force-load-detect)
[145.870214] Starting subtest: force-load-detect
[145.871957] Subtest force-load-detect: SKIP (0.000s)
[146.252316] [110/165] (878s left) kms_force_connector_basic (prune-stale-modes)
[146.500820] Starting subtest: prune-stale-modes
[146.973051] Subtest prune-stale-modes: SUCCESS (0.472s)
[147.469535] [111/165] (877s left) kms_frontbuffer_tracking (basic)
[147.704305] Starting subtest: basic
[151.215102] Subtest basic: SUCCESS (3.511s)
[151.321099] [112/165] (873s left) kms_hdmi_inject (inject-audio)
[151.440466] Starting subtest: inject-audio
[151.971975] Subtest inject-audio: SUCCESS (0.532s)
[152.363776] [113/165] (872s left) kms_pipe_crc_basic (compare-crc-sanitycheck-xr24)
[152.590478] Starting subtest: compare-crc-sanitycheck-xr24
[152.591537] Starting dynamic subtest: pipe-A-DP-1
[152.999486] Dynamic subtest pipe-A-DP-1: SUCCESS (0.409s)
[153.005033] Starting dynamic subtest: pipe-B-DP-1
[153.397697] Dynamic subtest pipe-B-DP-1: SUCCESS (0.397s)
[153.402810] Starting dynamic subtest: pipe-C-DP-1
[153.799182] Dynamic subtest pipe-C-DP-1: SUCCESS (0.400s)
[153.806769] Starting dynamic subtest: pipe-D-DP-1
[154.201680] Dynamic subtest pipe-D-DP-1: SUCCESS (0.402s)
[154.202547] Subtest compare-crc-sanitycheck-xr24: SUCCESS (1.613s)
[154.373799] [114/165] (870s left) kms_pipe_crc_basic (compare-crc-sanitycheck-nv12)
[154.615297] Starting subtest: compare-crc-sanitycheck-nv12
[154.616128] Starting dynamic subtest: pipe-A-DP-1
[155.209819] Dynamic subtest pipe-A-DP-1: SUCCESS (0.593s)
[155.215337] Starting dynamic subtest: pipe-B-DP-1
[155.761763] Dynamic subtest pipe-B-DP-1: SUCCESS (0.551s)
[155.767903] Starting dynamic subtest: pipe-C-DP-1
[156.309647] Dynamic subtest pipe-C-DP-1: SUCCESS (0.546s)
[156.314515] Starting dynamic subtest: pipe-D-DP-1
[156.890130] Dynamic subtest pipe-D-DP-1: SUCCESS (0.580s)
[156.890909] Subtest compare-crc-sanitycheck-nv12: SUCCESS (2.275s)
[157.056044] [115/165] (867s left) kms_pipe_crc_basic (hang-read-crc)
[157.292504] Starting subtest: hang-read-crc
[157.293463] Starting dynamic subtest: pipe-A-DP-1
[158.492658] Dynamic subtest pipe-A-DP-1: SUCCESS (1.202s)
[158.497879] Starting dynamic subtest: pipe-B-DP-1
[159.618941] Dynamic subtest pipe-B-DP-1: SUCCESS (1.125s)
[159.626371] Starting dynamic subtest: pipe-C-DP-1
[160.741943] Dynamic subtest pipe-C-DP-1: SUCCESS (1.122s)
[160.747138] Starting dynamic subtest: pipe-D-DP-1
[161.849845] Dynamic subtest pipe-D-DP-1: SUCCESS (1.107s)
[161.850754] Subtest hang-read-crc: SUCCESS (4.561s)
[161.997679] [116/165] (862s left) kms_pipe_crc_basic (nonblocking-crc)
[162.111517] Subtest nonblocking-crc: SKIP (0.000s)
[162.140356] [117/165] (862s left) kms_pipe_crc_basic (nonblocking-crc-frame-sequence)
[162.195594] Subtest nonblocking-crc-frame-sequence: SKIP (0.000s)
[162.222800] [118/165] (862s left) kms_pipe_crc_basic (read-crc)
[162.286022] Subtest read-crc: SKIP (0.000s)
[162.314138] [119/165] (862s left) kms_pipe_crc_basic (read-crc-frame-sequence)
[162.365142] Subtest read-crc-frame-sequence: SKIP (0.000s)
[162.383536] [120/165] (862s left) kms_pm_backlight (basic-brightness)
[162.437009] Subtest basic-brightness: SKIP (0.000s)
[162.451957] [121/165] (862s left) kms_pm_rpm (basic-pci-d3-state)
[163.646673] Starting subtest: basic-pci-d3-state
[164.431378] Subtest basic-pci-d3-state: SUCCESS (0.786s)
[164.800382] [122/165] (859s left) kms_pm_rpm (basic-rte)
[164.833486] Starting subtest: basic-rte
[166.706584] Subtest basic-rte: SUCCESS (1.871s)
[167.283512] [123/165] (857s left) kms_psr (psr-primary-page-flip)
[167.517191] Subtest psr-primary-page-flip: SKIP (0.000s)
[167.537104] [124/165] (857s left) kms_psr (psr-cursor-plane-move)
[167.775180] Subtest psr-cursor-plane-move: SKIP (0.000s)
[167.803898] [125/165] (856s left) kms_psr (psr-sprite-plane-onoff)
[168.030143] Subtest psr-sprite-plane-onoff: SKIP (0.000s)
[168.052387] [126/165] (856s left) kms_psr (psr-primary-mmap-gtt)
[168.280580] Subtest psr-primary-mmap-gtt: SKIP (0.000s)
[168.303265] [127/165] (856s left) kms_setmode (basic-clone-single-crtc)
[168.343100] Starting subtest: basic-clone-single-crtc
[168.345906] Subtest basic-clone-single-crtc: SKIP (0.000s)
[168.418487] [128/165] (856s left) i915_pm_rps (basic-api)
[168.458213] Starting subtest: basic-api
[168.460049] Subtest basic-api: SKIP (0.000s)
[168.553390] [129/165] (856s left) prime_self_import (basic-llseek-bad)
[168.581570] Starting subtest: basic-llseek-bad
[168.590884] Subtest basic-llseek-bad: SUCCESS (0.010s)
[168.686259] [130/165] (856s left) prime_self_import (basic-llseek-size)
[168.719752] Starting subtest: basic-llseek-size
[168.732063] Subtest basic-llseek-size: SUCCESS (0.013s)
[168.802224] [131/165] (855s left) prime_self_import (basic-with_fd_dup)
[168.830172] Starting subtest: basic-with_fd_dup
[168.849367] Subtest basic-with_fd_dup: SUCCESS (0.020s)
[168.919106] [132/165] (855s left) prime_self_import (basic-with_one_bo)
[168.945896] Starting subtest: basic-with_one_bo
[168.959063] Subtest basic-with_one_bo: SUCCESS (0.013s)
[169.019700] [133/165] (855s left) prime_self_import (basic-with_one_bo_two_files)
[169.046080] Starting subtest: basic-with_one_bo_two_files
[169.059066] Subtest basic-with_one_bo_two_files: SUCCESS (0.012s)
[169.136315] [134/165] (855s left) prime_self_import (basic-with_two_bos)
[169.164611] Starting subtest: basic-with_two_bos
[169.178270] Subtest basic-with_two_bos: SUCCESS (0.014s)
[169.252371] [135/165] (855s left) prime_vgem (basic-fence-flip)
[169.308946] Starting subtest: basic-fence-flip
[169.880156] Subtest basic-fence-flip: SUCCESS (0.571s)
[169.973074] [136/165] (854s left) prime_vgem (basic-fence-mmap)
[170.034608] Starting subtest: basic-fence-mmap
[170.055231] Subtest basic-fence-mmap: SUCCESS (0.021s)
[170.138077] [137/165] (854s left) prime_vgem (basic-fence-read)
[170.193980] Starting subtest: basic-fence-read
[170.198213] Subtest basic-fence-read: SKIP (0.003s)
[170.288825] [138/165] (854s left) prime_vgem (basic-gtt)
[170.354188] Starting subtest: basic-gtt
[170.362820] Subtest basic-gtt: SUCCESS (0.009s)
[170.454743] [139/165] (854s left) prime_vgem (basic-read)
[170.517107] Starting subtest: basic-read
[170.520989] Subtest basic-read: SKIP (0.003s)
[170.620140] [140/165] (854s left) prime_vgem (basic-write)
[170.677357] Starting subtest: basic-write
[170.682244] Subtest basic-write: SKIP (0.004s)
[170.788727] [141/165] (854s left) vgem_basic (setversion)
[170.830952] Starting subtest: setversion
[170.832977] Subtest setversion: SUCCESS (0.000s)
[170.887427] [142/165] (853s left) vgem_basic (create)
[170.930943] Starting subtest: create
[170.931832] Subtest create: SUCCESS (0.000s)
[170.988582] [143/165] (853s left) vgem_basic (debugfs)
[171.030995] Starting subtest: debugfs
[171.031870] Subtest debugfs: SUCCESS (0.000s)
[171.087525] [144/165] (853s left) vgem_basic (dmabuf-export)
[171.131129] Starting subtest: dmabuf-export
[171.158377] Subtest dmabuf-export: SUCCESS (0.027s)
[171.252965] [145/165] (853s left) vgem_basic (dmabuf-fence)
[171.297654] Starting subtest: dmabuf-fence
[171.298771] Subtest dmabuf-fence: SUCCESS (0.000s)
[171.355203] [146/165] (853s left) vgem_basic (dmabuf-fence-before)
[171.397158] Starting subtest: dmabuf-fence-before
[171.397928] Subtest dmabuf-fence-before: SUCCESS (0.000s)
[171.454545] [147/165] (853s left) vgem_basic (dmabuf-mmap)
[171.497664] Starting subtest: dmabuf-mmap
[171.503715] Subtest dmabuf-mmap: SUCCESS (0.007s)
[171.550152] [148/165] (853s left) vgem_basic (mmap)
[171.597307] Starting subtest: mmap
[171.602083] Subtest mmap: SUCCESS (0.005s)
[171.652637] [149/165] (853s left) vgem_basic (second-client)
[171.697474] Starting subtest: second-client
[171.732367] Subtest second-client: SUCCESS (0.034s)
[171.786142] [150/165] (853s left) vgem_basic (sysfs)
[171.831716] Starting subtest: sysfs
[171.832429] Subtest sysfs: SUCCESS (0.000s)
[171.883969] [151/165] (853s left) core_hotunplug (unbind-rebind)
[171.946642] Starting subtest: unbind-rebind
[176.301369] Subtest unbind-rebind: SUCCESS (4.355s)
[176.312965] [152/165] (848s left) vgem_basic (unload)
[176.341650] Starting subtest: unload
[205.310658] Subtest unload: SUCCESS (28.934s)
[205.375506] [153/165] (819s left) i915_module_load (reload)
[205.408267] Starting subtest: reload
[208.459535] Subtest reload: SUCCESS (3.054s)
[208.473802] [154/165] (816s left) gem_lmem_swapping (basic)
[208.509593] Subtest basic: SKIP (0.000s)
[208.531531] [155/165] (816s left) gem_lmem_swapping (parallel-random-engines)
[208.568621] Subtest parallel-random-engines: SKIP (0.000s)
[208.600590] [156/165] (816s left) gem_lmem_swapping (random-engines)
[208.634312] Subtest random-engines: SKIP (0.000s)
[208.666390] [157/165] (816s left) gem_lmem_swapping (verify-random)
[208.694246] Subtest verify-random: SKIP (0.000s)
[208.715608] [158/165] (816s left) i915_pm_rpm (module-reload)
[210.383263] Starting subtest: module-reload
[218.804836] Subtest module-reload: SUCCESS (8.415s)
[218.815440] [159/165] (806s left) i915_selftest (live)
[218.855329] Starting subtest: live
[218.856213] Starting dynamic subtest: sanitycheck
[220.769184] Dynamic subtest sanitycheck: SUCCESS (1.904s)
[220.773414] Starting dynamic subtest: uncore
[222.714803] Dynamic subtest uncore: SUCCESS (1.944s)
[222.718769] Starting dynamic subtest: workarounds
[225.520345] Dynamic subtest workarounds: SUCCESS (2.806s)
[225.524080] Starting dynamic subtest: gt_engines
[227.923574] Dynamic subtest gt_engines: SUCCESS (2.406s)
[227.931023] Starting dynamic subtest: gt_timelines
[239.557361] Dynamic subtest gt_timelines: SUCCESS (11.627s)
[239.561042] Starting dynamic subtest: gt_contexts
[241.446411] Dynamic subtest gt_contexts: SUCCESS (1.888s)
[241.450318] Starting dynamic subtest: gt_lrc
[246.244317] Dynamic subtest gt_lrc: SUCCESS (4.796s)
[246.248183] Starting dynamic subtest: gt_mocs
[248.577383] Dynamic subtest gt_mocs: SUCCESS (2.333s)
[248.581053] Starting dynamic subtest: gt_pm
[251.333388] Dynamic subtest gt_pm: SUCCESS (2.755s)
[251.337213] Starting dynamic subtest: gt_heartbeat
[253.349131] Dynamic subtest gt_heartbeat: SUCCESS (2.015s)
[253.353509] Starting dynamic subtest: gt_tlb
[256.741694] Dynamic subtest gt_tlb: SUCCESS (3.391s)
[256.745272] Starting dynamic subtest: requests
[266.505470] Dynamic subtest requests: SUCCESS (9.762s)
[266.509316] Starting dynamic subtest: migrate
[271.595524] Dynamic subtest migrate: SUCCESS (5.089s)
[271.599459] Starting dynamic subtest: active
[273.449099] Dynamic subtest active: SUCCESS (1.854s)
[273.465424] Starting dynamic subtest: objects
[275.742349] Dynamic subtest objects: SUCCESS (2.294s)
[275.746068] Starting dynamic subtest: mman
[281.216174] Dynamic subtest mman: SUCCESS (5.469s)
[281.220860] Starting dynamic subtest: dmabuf
[283.151204] Dynamic subtest dmabuf: SUCCESS (1.934s)
[283.154943] Starting dynamic subtest: vma
[285.044581] Dynamic subtest vma: SUCCESS (1.892s)
[285.049896] Starting dynamic subtest: coherency
[289.783419] Dynamic subtest coherency: SUCCESS (4.738s)
[289.787108] Starting dynamic subtest: gtt
[298.912636] Dynamic subtest gtt: SUCCESS (9.128s)
[298.916679] Starting dynamic subtest: gem
[300.909169] Dynamic subtest gem: SUCCESS (2.002s)
[300.913759] Starting dynamic subtest: evict
[304.113477] Dynamic subtest evict: SUCCESS (3.197s)
[304.117518] Starting dynamic subtest: hugepages
[312.453566] Dynamic subtest hugepages: SUCCESS (8.339s)
[312.457177] Starting dynamic subtest: gem_contexts
[330.614384] Dynamic subtest gem_contexts: SUCCESS (18.160s)
[330.618091] Starting dynamic subtest: client
[332.573203] Dynamic subtest client: SUCCESS (1.958s)
[332.576994] Starting dynamic subtest: gem_migrate
[334.466108] Dynamic subtest gem_migrate: SUCCESS (1.892s)
[334.469931] Starting dynamic subtest: reset
[340.475360] Dynamic subtest reset: SUCCESS (6.008s)
[340.479275] Starting dynamic subtest: memory_region
[342.353152] Dynamic subtest memory_region: SUCCESS (1.876s)
[342.357828] Starting dynamic subtest: hangcheck
[361.601481] Dynamic subtest hangcheck: SUCCESS (19.247s)
[361.605596] Starting dynamic subtest: execlists
[363.485449] Dynamic subtest execlists: SUCCESS (1.882s)
[363.491172] Starting dynamic subtest: ring_submission
[365.413923] Dynamic subtest ring_submission: SUCCESS (1.927s)
[365.419400] Starting dynamic subtest: perf
[367.360149] Dynamic subtest perf: SUCCESS (1.948s)
[367.364400] Starting dynamic subtest: slpc
[375.853588] Dynamic subtest slpc: SUCCESS (8.489s)
[375.857894] Starting dynamic subtest: guc
[378.624535] Dynamic subtest guc: SUCCESS (2.770s)
[378.628634] Starting dynamic subtest: guc_multi_lrc
[380.552834] Dynamic subtest guc_multi_lrc: SUCCESS (1.927s)
[380.557147] Starting dynamic subtest: guc_hang
[383.090363] Dynamic subtest guc_hang: SUCCESS (2.536s)
[383.094128] Starting dynamic subtest: late_gt_pm
[385.004588] Dynamic subtest late_gt_pm: SUCCESS (1.912s)
[385.006169] Subtest live: SUCCESS (166.140s)
[385.020350] [160/165] (640s left) dmabuf (all-tests)
[385.054888] Starting subtest: all-tests
[385.055770] Starting dynamic subtest: sanitycheck
[385.114593] Dynamic subtest sanitycheck: SUCCESS (0.060s)
[385.121815] Starting dynamic subtest: dma_fence
[385.294302] Dynamic subtest dma_fence: SUCCESS (0.178s)
[385.301321] Starting dynamic subtest: dma_fence_chain
[394.673343] Dynamic subtest dma_fence_chain: SUCCESS (9.379s)
[394.680910] Starting dynamic subtest: dma_fence_unwrap
[394.735299] Dynamic subtest dma_fence_unwrap: SUCCESS (0.060s)
[394.743745] Starting dynamic subtest: dma_resv
[394.798425] Dynamic subtest dma_resv: SUCCESS (0.061s)
[394.803511] Subtest all-tests: SUCCESS (9.745s)
[394.819847] [161/165] (630s left) i915_suspend (basic-s2idle-without-i915)
[394.849519] Starting subtest: basic-s2idle-without-i915
[416.080876] Subtest basic-s2idle-without-i915: SUCCESS (6.050s)
[416.241568] [162/165] (624s left) i915_suspend (basic-s3-without-i915)
[416.274158] Starting subtest: basic-s3-without-i915
[436.595328] Subtest basic-s3-without-i915: SUCCESS (4.550s)
[436.856951] [163/165] (619s left) gem_exec_suspend (basic-s0)
[436.901929] Starting subtest: basic-S0
[436.902863] Starting dynamic subtest: smem
[454.589785] Dynamic subtest smem: SUCCESS (2.398s)
[454.591089] Subtest basic-S0: SUCCESS (2.399s)
[454.726078] [164/165] (616s left) gem_exec_suspend (basic-s3)
[454.770777] Starting subtest: basic-S3
[454.771804] Starting dynamic subtest: smem
[472.581098] Dynamic subtest smem: SUCCESS (2.377s)
[472.582578] Subtest basic-S3: SUCCESS (2.379s)
[472.710032] [165/165] (614s left) kms_pipe_crc_basic (suspend-read-crc)
[472.952966] Starting subtest: suspend-read-crc
[472.954224] Starting dynamic subtest: pipe-A-DP-1
[490.755333] Dynamic subtest pipe-A-DP-1: SUCCESS (2.251s)
[490.760866] Starting dynamic subtest: pipe-B-DP-1
[508.749988] Dynamic subtest pipe-B-DP-1: SUCCESS (2.234s)
[508.756297] Starting dynamic subtest: pipe-C-DP-1
[526.750795] Dynamic subtest pipe-C-DP-1: SUCCESS (2.231s)
[526.758436] Starting dynamic subtest: pipe-D-DP-1
[544.707916] Dynamic subtest pipe-D-DP-1: SUCCESS (2.263s)
[544.708674] Subtest suspend-read-crc: SUCCESS (8.984s)
[544.810818] Closing watchdogs
Done.