[42.681984] Initializing watchdogs
[42.682150]   /dev/watchdog0
[42.691868] [001/160] (960s left) i915_module_load (load)
[42.798459] Starting subtest: load
[47.010873] Subtest load: SUCCESS (4.212s)
[47.037851] [002/160] (956s left) core_auth (basic-auth)
[47.155113] Starting subtest: basic-auth
[47.156268] Subtest basic-auth: SUCCESS (0.002s)
[47.264511] [003/160] (955s left) debugfs_test (read_all_entries)
[47.387173] Starting subtest: read_all_entries
[47.484482] Subtest read_all_entries: SUCCESS (0.095s)
[47.601700] [004/160] (955s left) debugfs_test (basic-hwmon)
[47.709412] Starting subtest: basic-hwmon
[47.711426] Subtest basic-hwmon: SKIP (0.000s)
[47.814173] [005/160] (955s left) fbdev (eof)
[47.949551] Starting subtest: eof
[47.953360] Subtest eof: SUCCESS (0.004s)
[48.029538] [006/160] (955s left) fbdev (info)
[48.129333] Starting subtest: info
[48.131354] Subtest info: SUCCESS (0.000s)
[48.238631] [007/160] (955s left) fbdev (nullptr)
[48.346890] Starting subtest: nullptr
[48.348070] Subtest nullptr: SUCCESS (0.000s)
[48.415180] [008/160] (954s left) fbdev (read)
[48.513435] Starting subtest: read
[55.627485] Subtest read: SUCCESS (7.079s)
[55.672458] [009/160] (947s left) fbdev (write)
[55.771110] Starting subtest: write
[59.546623] Subtest write: SUCCESS (3.740s)
[59.593929] [010/160] (943s left) gem_basic (bad-close)
[59.697609] Starting subtest: bad-close
[59.700146] Subtest bad-close: SUCCESS (0.000s)
[59.795855] [011/160] (943s left) gem_basic (create-close)
[59.909741] Starting subtest: create-close
[59.912051] Subtest create-close: SUCCESS (0.000s)
[59.992783] [012/160] (943s left) gem_basic (create-fd-close)
[60.097444] Starting subtest: create-fd-close
[60.099634] Subtest create-fd-close: SUCCESS (0.000s)
[60.197425] [013/160] (943s left) gem_busy (busy@all-engines)
[60.330109] Starting subtest: busy
[60.331367] Starting dynamic subtest: all-engines
[60.402560] Dynamic subtest all-engines: SUCCESS (0.072s)
[60.403730] Subtest busy: SUCCESS (0.073s)
[60.802771] [014/160] (942s left) gem_close_race (basic-process)
[60.937105] Starting subtest: basic-process
[61.003318] Subtest basic-process: SUCCESS (0.068s)
[61.217037] [015/160] (942s left) gem_close_race (basic-threads)
[61.344869] Starting subtest: basic-threads
[62.537220] Subtest basic-threads: SUCCESS (1.195s)
[62.767928] [016/160] (940s left) gem_ctx_create (basic)
[62.893280] Starting subtest: basic
[62.894409] Subtest basic: SUCCESS (0.000s)
[63.105850] [017/160] (940s left) gem_ctx_create (basic-files)
[63.234673] Starting subtest: basic-files
[65.262322] Subtest basic-files: SUCCESS (2.028s)
[65.511295] [018/160] (938s left) gem_ctx_exec (basic)
[65.629240] Starting subtest: basic
[65.637797] Subtest basic: SUCCESS (0.007s)
[65.737163] [019/160] (937s left) gem_exec_basic (basic)
[65.863865] Starting subtest: basic
[65.865135] Starting dynamic subtest: rcs0-smem
[65.866303] Dynamic subtest rcs0-smem: SUCCESS (0.003s)
[65.877810] Starting dynamic subtest: bcs0-smem
[65.879036] Dynamic subtest bcs0-smem: SUCCESS (0.001s)
[65.889834] Starting dynamic subtest: vcs0-smem
[65.891211] Dynamic subtest vcs0-smem: SUCCESS (0.001s)
[65.902026] Starting dynamic subtest: vecs0-smem
[65.903444] Dynamic subtest vecs0-smem: SUCCESS (0.001s)
[65.904753] Subtest basic: SUCCESS (0.007s)
[66.072659] [020/160] (937s left) gem_exec_create (basic)
[66.196472] Starting subtest: basic
[66.197759] Starting dynamic subtest: smem
[68.262347] Dynamic subtest smem: SUCCESS (2.045s)
[68.264107] Subtest basic: SUCCESS (2.045s)
[68.475999] [021/160] (935s left) gem_exec_fence (basic-busy)
[68.748197] Starting subtest: basic-busy
[68.749606] Starting dynamic subtest: rcs0
[68.781842] Dynamic subtest rcs0: SUCCESS (0.039s)
[68.797503] Starting dynamic subtest: bcs0
[68.803560] Dynamic subtest bcs0: SUCCESS (0.022s)
[68.814994] Starting dynamic subtest: vcs0
[68.825545] Dynamic subtest vcs0: SUCCESS (0.022s)
[68.836927] Starting dynamic subtest: vecs0
[68.862201] Dynamic subtest vecs0: SUCCESS (0.035s)
[68.864148] Subtest basic-busy: SUCCESS (0.119s)
[69.478961] [022/160] (934s left) gem_exec_fence (basic-wait)
[69.745943] Starting subtest: basic-wait
[69.747445] Starting dynamic subtest: rcs0
[69.766290] Dynamic subtest rcs0: SUCCESS (0.025s)
[69.779498] Starting dynamic subtest: bcs0
[69.782162] Dynamic subtest bcs0: SUCCESS (0.015s)
[69.795552] Starting dynamic subtest: vcs0
[69.806175] Dynamic subtest vcs0: SUCCESS (0.024s)
[69.818490] Starting dynamic subtest: vecs0
[69.841679] Dynamic subtest vecs0: SUCCESS (0.035s)
[69.843449] Subtest basic-wait: SUCCESS (0.101s)
[70.391212] [023/160] (933s left) gem_exec_fence (basic-await)
[70.666837] Starting subtest: basic-await
[70.670352] Starting dynamic subtest: rcs0
[70.760789] Dynamic subtest rcs0: SUCCESS (0.103s)
[70.789562] Starting dynamic subtest: bcs0
[70.881805] Dynamic subtest bcs0: SUCCESS (0.120s)
[70.909803] Starting dynamic subtest: vcs0
[71.024472] Dynamic subtest vcs0: SUCCESS (0.136s)
[71.052082] Starting dynamic subtest: vecs0
[71.157680] Dynamic subtest vecs0: SUCCESS (0.132s)
[71.159701] Subtest basic-await: SUCCESS (0.496s)
[71.745170] [024/160] (932s left) gem_exec_fence (nb-await)
[72.023859] Starting subtest: nb-await
[72.025081] Starting dynamic subtest: rcs0
[72.083300] Dynamic subtest rcs0: SUCCESS (0.067s)
[72.108612] Starting dynamic subtest: bcs0
[72.156192] Dynamic subtest bcs0: SUCCESS (0.072s)
[72.183751] Starting dynamic subtest: vcs0
[72.233979] Dynamic subtest vcs0: SUCCESS (0.077s)
[72.262959] Starting dynamic subtest: vecs0
[72.310535] Dynamic subtest vecs0: SUCCESS (0.076s)
[72.312665] Subtest nb-await: SUCCESS (0.295s)
[72.895970] [025/160] (930s left) gem_exec_gttfill (basic)
[73.018341] Starting subtest: basic
[79.344398] Subtest basic: SUCCESS (6.317s)
[79.533494] [026/160] (924s left) gem_exec_parallel (engines)
[79.792895] Starting subtest: engines
[79.794182] Starting dynamic subtest: basic
[83.009693] Dynamic subtest basic: SUCCESS (3.199s)
[83.026434] Starting dynamic subtest: contexts
[91.272054] Dynamic subtest contexts: SUCCESS (8.283s)
[91.286370] Starting dynamic subtest: fds
[106.713199] Dynamic subtest fds: SUCCESS (15.441s)
[106.727448] Starting dynamic subtest: userptr
[110.486748] Dynamic subtest userptr: SUCCESS (3.752s)
[110.488695] Subtest engines: SUCCESS (30.675s)
[110.683679] [027/160] (893s left) gem_exec_store (basic)
[110.804541] Starting subtest: basic
[110.858804] Subtest basic: SUCCESS (0.055s)
[111.071538] [028/160] (892s left) gem_flink_basic (bad-flink)
[111.179734] Starting subtest: bad-flink
[111.181020] Subtest bad-flink: SUCCESS (0.000s)
[111.269860] [029/160] (892s left) gem_flink_basic (bad-open)
[111.377737] Starting subtest: bad-open
[111.378974] Subtest bad-open: SUCCESS (0.000s)
[111.487695] [030/160] (892s left) gem_flink_basic (basic)
[111.594609] Starting subtest: basic
[111.595747] Subtest basic: SUCCESS (0.000s)
[111.687516] [031/160] (892s left) gem_flink_basic (double-flink)
[111.789503] Starting subtest: double-flink
[111.790792] Subtest double-flink: SUCCESS (0.000s)
[111.888336] [032/160] (892s left) gem_flink_basic (flink-lifetime)
[111.993581] Starting subtest: flink-lifetime
[111.997343] Subtest flink-lifetime: SUCCESS (0.003s)
[112.103742] [033/160] (891s left) gem_huc_copy (huc-copy)
[112.218650] Starting subtest: huc-copy
[112.220835] Subtest huc-copy: SKIP (0.000s)
[112.339234] [034/160] (891s left) gem_linear_blits (basic)
[112.610961] Starting subtest: basic
[112.628595] Subtest basic: SUCCESS (0.018s)
[112.758189] [035/160] (891s left) gem_mmap (basic)
[112.926559] Starting subtest: basic
[112.932093] Subtest basic: SUCCESS (0.001s)
[113.020715] [036/160] (891s left) gem_mmap_gtt (basic)
[113.128661] Starting subtest: basic
[113.129854] Subtest basic: SUCCESS (0.002s)
[113.230346] [037/160] (890s left) gem_render_linear_blits (basic)
[113.346086] Starting subtest: basic
[113.406497] Subtest basic: SUCCESS (0.060s)
[113.463992] [038/160] (890s left) gem_render_tiled_blits (basic)
[113.571079] Starting subtest: basic
[113.640521] Subtest basic: SUCCESS (0.069s)
[113.697419] [039/160] (890s left) gem_ringfill (basic-all)
[113.973688] Starting subtest: basic-all
[115.213240] Subtest basic-all: SUCCESS (1.231s)
[115.294054] [040/160] (888s left) gem_softpin (allocator-basic)
[115.410204] Starting subtest: allocator-basic
[115.589965] Subtest allocator-basic: SUCCESS (0.171s)
[115.712752] [041/160] (888s left) gem_softpin (allocator-basic-reserve)
[115.821786] Starting subtest: allocator-basic-reserve
[116.001962] Subtest allocator-basic-reserve: SUCCESS (0.171s)
[116.127895] [042/160] (888s left) gem_softpin (safe-alignment)
[116.234093] Starting subtest: safe-alignment
[116.254775] Subtest safe-alignment: SUCCESS (0.020s)
[116.376755] [043/160] (887s left) gem_sync (basic-all)
[116.504382] Starting subtest: basic-all
[118.563921] Subtest basic-all: SUCCESS (2.047s)
[118.764081] [044/160] (885s left) gem_sync (basic-each)
[118.897395] Starting subtest: basic-each
[121.070315] Subtest basic-each: SUCCESS (2.173s)
[121.304810] [045/160] (883s left) gem_tiled_blits (basic)
[121.550543] Starting subtest: basic
[121.584708] Subtest basic: SUCCESS (0.034s)
[121.736211] [046/160] (882s left) gem_tiled_fence_blits (basic)
[122.047730] Starting subtest: basic
[122.077352] Subtest basic: SUCCESS (0.030s)
[122.214512] [047/160] (882s left) gem_tiled_pread_basic
[122.805579] [048/160] (881s left) gem_wait (busy@all-engines)
[122.946721] Starting subtest: busy
[122.947889] Starting dynamic subtest: all-engines
[123.479730] Dynamic subtest all-engines: SUCCESS (0.534s)
[123.480906] Subtest busy: SUCCESS (0.534s)
[123.737340] [049/160] (880s left) gem_wait (wait@all-engines)
[123.876871] Starting subtest: wait
[123.878121] Starting dynamic subtest: all-engines
[124.914363] Dynamic subtest all-engines: SUCCESS (1.037s)
[124.916637] Subtest wait: SUCCESS (1.037s)
[125.171262] [050/160] (879s left) i915_getparams_basic (basic-eu-total)
[125.276472] Starting subtest: basic-eu-total
[125.278995] Subtest basic-eu-total: SUCCESS (0.000s)
[125.367087] [051/160] (879s left) i915_getparams_basic (basic-subslice-total)
[125.471705] Starting subtest: basic-subslice-total
[125.473965] Subtest basic-subslice-total: SUCCESS (0.000s)
[125.569346] [052/160] (879s left) i915_hangman (error-state-basic)
[125.689664] Starting subtest: error-state-basic
[125.701980] Subtest error-state-basic: SUCCESS (0.013s)
[125.803635] [053/160] (878s left) i915_pciid
[126.003143] [054/160] (878s left) kms_addfb_basic (addfb25-4-tiled)
[126.148505] Starting subtest: addfb25-4-tiled
[126.149709] Subtest addfb25-4-tiled: SUCCESS (0.000s)
[126.253827] [055/160] (878s left) kms_addfb_basic (addfb25-bad-modifier)
[126.362108] Starting subtest: addfb25-bad-modifier
[126.363165] Subtest addfb25-bad-modifier: SUCCESS (0.000s)
[126.503235] [056/160] (878s left) kms_addfb_basic (addfb25-framebuffer-vs-set-tiling)
[126.610989] Starting subtest: addfb25-framebuffer-vs-set-tiling
[126.612114] Subtest addfb25-framebuffer-vs-set-tiling: SUCCESS (0.000s)
[126.754319] [057/160] (878s left) kms_addfb_basic (addfb25-modifier-no-flag)
[126.857871] Starting subtest: addfb25-modifier-no-flag
[126.858990] Subtest addfb25-modifier-no-flag: SUCCESS (0.000s)
[126.985626] [058/160] (877s left) kms_addfb_basic (addfb25-x-tiled-legacy)
[127.092939] Starting subtest: addfb25-x-tiled-legacy
[127.094760] Subtest addfb25-x-tiled-legacy: SUCCESS (0.000s)
[127.221843] [059/160] (877s left) kms_addfb_basic (addfb25-x-tiled-mismatch-legacy)
[127.325826] Starting subtest: addfb25-x-tiled-mismatch-legacy
[127.327066] Subtest addfb25-x-tiled-mismatch-legacy: SUCCESS (0.000s)
[127.457470] [060/160] (877s left) kms_addfb_basic (addfb25-yf-tiled-legacy)
[127.594260] Starting subtest: addfb25-yf-tiled-legacy
[127.595415] Subtest addfb25-yf-tiled-legacy: SUCCESS (0.000s)
[127.688596] [061/160] (877s left) kms_addfb_basic (addfb25-y-tiled-legacy)
[127.827446] Starting subtest: addfb25-y-tiled-legacy
[127.828771] Subtest addfb25-y-tiled-legacy: SUCCESS (0.000s)
[127.915629] [062/160] (877s left) kms_addfb_basic (addfb25-y-tiled-small-legacy)
[128.057556] Starting subtest: addfb25-y-tiled-small-legacy
[128.058756] Subtest addfb25-y-tiled-small-legacy: SUCCESS (0.000s)
[128.149372] [063/160] (876s left) kms_addfb_basic (bad-pitch-0)
[128.264696] Starting subtest: bad-pitch-0
[128.266050] Subtest bad-pitch-0: SUCCESS (0.000s)
[128.386430] [064/160] (876s left) kms_addfb_basic (bad-pitch-1024)
[128.503291] Starting subtest: bad-pitch-1024
[128.504497] Subtest bad-pitch-1024: SUCCESS (0.000s)
[128.635447] [065/160] (876s left) kms_addfb_basic (bad-pitch-128)
[128.748173] Starting subtest: bad-pitch-128
[128.749574] Subtest bad-pitch-128: SUCCESS (0.000s)
[128.884934] [066/160] (876s left) kms_addfb_basic (bad-pitch-256)
[128.991083] Starting subtest: bad-pitch-256
[128.992140] Subtest bad-pitch-256: SUCCESS (0.000s)
[129.139365] [067/160] (875s left) kms_addfb_basic (bad-pitch-32)
[129.250842] Starting subtest: bad-pitch-32
[129.252241] Subtest bad-pitch-32: SUCCESS (0.000s)
[129.388307] [068/160] (875s left) kms_addfb_basic (bad-pitch-63)
[129.497599] Starting subtest: bad-pitch-63
[129.498760] Subtest bad-pitch-63: SUCCESS (0.000s)
[129.641055] [069/160] (875s left) kms_addfb_basic (bad-pitch-65536)
[129.751848] Starting subtest: bad-pitch-65536
[129.753192] Subtest bad-pitch-65536: SUCCESS (0.000s)
[129.873162] [070/160] (875s left) kms_addfb_basic (bad-pitch-999)
[129.979492] Starting subtest: bad-pitch-999
[129.980617] Subtest bad-pitch-999: SUCCESS (0.000s)
[130.107603] [071/160] (875s left) kms_addfb_basic (basic)
[130.213059] Starting subtest: basic
[130.214116] Subtest basic: SUCCESS (0.000s)
[130.339379] [072/160] (874s left) kms_addfb_basic (basic-x-tiled-legacy)
[130.452908] Starting subtest: basic-x-tiled-legacy
[130.454080] Subtest basic-x-tiled-legacy: SUCCESS (0.000s)
[130.592345] [073/160] (874s left) kms_addfb_basic (basic-y-tiled-legacy)
[130.707207] Starting subtest: basic-y-tiled-legacy
[130.708303] Subtest basic-y-tiled-legacy: SUCCESS (0.000s)
[130.839210] [074/160] (874s left) kms_addfb_basic (bo-too-small)
[130.974430] Starting subtest: bo-too-small
[130.975609] Subtest bo-too-small: SUCCESS (0.000s)
[131.072119] [075/160] (874s left) kms_addfb_basic (bo-too-small-due-to-tiling)
[131.209239] Starting subtest: bo-too-small-due-to-tiling
[131.210435] Subtest bo-too-small-due-to-tiling: SUCCESS (0.000s)
[131.308510] [076/160] (874s left) kms_addfb_basic (clobberred-modifier)
[131.411628] Starting subtest: clobberred-modifier
[131.412914] Subtest clobberred-modifier: SUCCESS (0.000s)
[131.550323] [077/160] (873s left) kms_addfb_basic (framebuffer-vs-set-tiling)
[131.658673] Starting subtest: framebuffer-vs-set-tiling
[131.659743] Subtest framebuffer-vs-set-tiling: SUCCESS (0.000s)
[131.794252] [078/160] (873s left) kms_addfb_basic (invalid-get-prop)
[131.903683] Starting subtest: invalid-get-prop
[131.904880] Subtest invalid-get-prop: SUCCESS (0.000s)
[132.019344] [079/160] (873s left) kms_addfb_basic (invalid-get-prop-any)
[132.122947] Starting subtest: invalid-get-prop-any
[132.124069] Subtest invalid-get-prop-any: SUCCESS (0.000s)
[132.260570] [080/160] (873s left) kms_addfb_basic (invalid-set-prop)
[132.373218] Starting subtest: invalid-set-prop
[132.374335] Subtest invalid-set-prop: SUCCESS (0.000s)
[132.510893] [081/160] (872s left) kms_addfb_basic (invalid-set-prop-any)
[132.623305] Starting subtest: invalid-set-prop-any
[132.624439] Subtest invalid-set-prop-any: SUCCESS (0.000s)
[132.761261] [082/160] (872s left) kms_addfb_basic (no-handle)
[132.868913] Starting subtest: no-handle
[132.870055] Subtest no-handle: SUCCESS (0.000s)
[132.993439] [083/160] (872s left) kms_addfb_basic (size-max)
[133.127477] Starting subtest: size-max
[133.128777] Subtest size-max: SUCCESS (0.000s)
[133.227298] [084/160] (872s left) kms_addfb_basic (small-bo)
[133.371610] Starting subtest: small-bo
[133.372757] Subtest small-bo: SUCCESS (0.000s)
[133.472586] [085/160] (872s left) kms_addfb_basic (tile-pitch-mismatch)
[133.576910] Starting subtest: tile-pitch-mismatch
[133.578086] Subtest tile-pitch-mismatch: SUCCESS (0.000s)
[133.712625] [086/160] (871s left) kms_addfb_basic (too-high)
[133.845181] Starting subtest: too-high
[133.846499] Subtest too-high: SUCCESS (0.001s)
[133.943412] [087/160] (871s left) kms_addfb_basic (too-wide)
[134.077096] Starting subtest: too-wide
[134.078204] Subtest too-wide: SUCCESS (0.000s)
[134.187848] [088/160] (871s left) kms_addfb_basic (unused-handle)
[134.297525] Starting subtest: unused-handle
[134.298670] Subtest unused-handle: SUCCESS (0.000s)
[134.428504] [089/160] (871s left) kms_addfb_basic (unused-modifier)
[134.530538] Starting subtest: unused-modifier
[134.531700] Subtest unused-modifier: SUCCESS (0.000s)
[134.657250] [090/160] (871s left) kms_addfb_basic (unused-offsets)
[134.764423] Starting subtest: unused-offsets
[134.765527] Subtest unused-offsets: SUCCESS (0.000s)
[134.894854] [091/160] (870s left) kms_addfb_basic (unused-pitches)
[135.007910] Starting subtest: unused-pitches
[135.009167] Subtest unused-pitches: SUCCESS (0.000s)
[135.145845] [092/160] (870s left) kms_busy (basic)
[135.290690] Starting subtest: basic
[135.291835] Starting dynamic subtest: flip
[136.335785] Dynamic subtest flip: SUCCESS (1.039s)
[136.350822] Starting dynamic subtest: modeset
[140.276777] Dynamic subtest modeset: SUCCESS (3.946s)
[140.279208] Subtest basic: SUCCESS (4.987s)
[141.250573] [093/160] (864s left) kms_prop_blob (basic)
[141.360465] Starting subtest: basic
[141.361649] Subtest basic: SUCCESS (0.000s)
[141.452100] [094/160] (864s left) kms_cursor_legacy (basic-busy-flip-before-cursor-atomic)
[141.590483] Starting subtest: basic-busy-flip-before-cursor-atomic
[141.592668] Subtest basic-busy-flip-before-cursor-atomic: SKIP (0.000s)
[141.683034] [095/160] (864s left) kms_cursor_legacy (basic-busy-flip-before-cursor-legacy)
[141.815482] Starting subtest: basic-busy-flip-before-cursor-legacy
[141.817829] Subtest basic-busy-flip-before-cursor-legacy: SKIP (0.000s)
[141.899694] [096/160] (864s left) kms_cursor_legacy (basic-flip-after-cursor-atomic)
[142.030553] Starting subtest: basic-flip-after-cursor-atomic
[143.346890] Subtest basic-flip-after-cursor-atomic: SUCCESS (1.315s)
[144.319344] [097/160] (861s left) kms_cursor_legacy (basic-flip-after-cursor-legacy)
[144.457266] Starting subtest: basic-flip-after-cursor-legacy
[145.764676] Subtest basic-flip-after-cursor-legacy: SUCCESS (1.306s)
[146.687319] [098/160] (859s left) kms_cursor_legacy (basic-flip-after-cursor-varying-size)
[146.824642] Starting subtest: basic-flip-after-cursor-varying-size
[148.099422] Subtest basic-flip-after-cursor-varying-size: SUCCESS (1.275s)
[149.054724] [099/160] (856s left) kms_cursor_legacy (basic-flip-before-cursor-atomic)
[149.190559] Starting subtest: basic-flip-before-cursor-atomic
[150.499223] Subtest basic-flip-before-cursor-atomic: SUCCESS (1.309s)
[151.422861] [100/160] (854s left) kms_cursor_legacy (basic-flip-before-cursor-legacy)
[151.561286] Starting subtest: basic-flip-before-cursor-legacy
[152.867120] Subtest basic-flip-before-cursor-legacy: SUCCESS (1.306s)
[153.794419] [101/160] (852s left) kms_cursor_legacy (basic-flip-before-cursor-varying-size)
[153.931843] Starting subtest: basic-flip-before-cursor-varying-size
[155.236774] Subtest basic-flip-before-cursor-varying-size: SUCCESS (1.304s)
[156.159994] [102/160] (849s left) kms_dsc (dsc-basic)
[156.290956] Starting subtest: dsc-basic
[156.293438] Subtest dsc-basic: SKIP (0.001s)
[156.369658] [103/160] (849s left) kms_flip (basic-flip-vs-dpms)
[156.512527] Starting subtest: basic-flip-vs-dpms
[156.515404] Starting dynamic subtest: A-eDP1
[159.427863] Dynamic subtest A-eDP1: SUCCESS (2.911s)
[159.444434] Starting dynamic subtest: B-eDP1
[161.856351] Dynamic subtest B-eDP1: SUCCESS (2.428s)
[161.873890] Starting dynamic subtest: C-eDP1
[164.295059] Dynamic subtest C-eDP1: SUCCESS (2.437s)
[164.297459] Subtest basic-flip-vs-dpms: SUCCESS (7.786s)
[165.214774] [104/160] (840s left) kms_flip (basic-flip-vs-modeset)
[165.353148] Starting subtest: basic-flip-vs-modeset
[165.355630] Starting dynamic subtest: A-eDP1
[168.241680] Dynamic subtest A-eDP1: SUCCESS (2.884s)
[168.259300] Starting dynamic subtest: B-eDP1
[170.672429] Dynamic subtest B-eDP1: SUCCESS (2.431s)
[170.692326] Starting dynamic subtest: C-eDP1
[173.041524] Dynamic subtest C-eDP1: SUCCESS (2.369s)
[173.044502] Subtest basic-flip-vs-modeset: SUCCESS (7.693s)
[174.019488] [105/160] (832s left) kms_flip (basic-flip-vs-wf_vblank)
[174.166656] Starting subtest: basic-flip-vs-wf_vblank
[174.169218] Starting dynamic subtest: A-eDP1
[176.474776] Dynamic subtest A-eDP1: SUCCESS (2.304s)
[176.496986] Starting dynamic subtest: B-eDP1
[178.762588] Dynamic subtest B-eDP1: SUCCESS (2.286s)
[178.781110] Starting dynamic subtest: C-eDP1
[181.002237] Dynamic subtest C-eDP1: SUCCESS (2.236s)
[181.005537] Subtest basic-flip-vs-wf_vblank: SUCCESS (6.840s)
[182.335563] [106/160] (823s left) kms_flip (basic-plain-flip)
[182.477904] Starting subtest: basic-plain-flip
[182.480994] Starting dynamic subtest: A-eDP1
[184.511334] Dynamic subtest A-eDP1: SUCCESS (2.029s)
[184.529448] Starting dynamic subtest: B-eDP1
[186.479076] Dynamic subtest B-eDP1: SUCCESS (1.965s)
[186.497520] Starting dynamic subtest: C-eDP1
[188.461969] Dynamic subtest C-eDP1: SUCCESS (1.981s)
[188.465308] Subtest basic-plain-flip: SUCCESS (5.988s)
[189.760021] [107/160] (816s left) kms_force_connector_basic (force-connector-state)
[189.869632] Starting subtest: force-connector-state
[190.479858] Subtest force-connector-state: SUCCESS (0.601s)
[191.581285] [108/160] (814s left) kms_force_connector_basic (force-edid)
[191.709578] Starting subtest: force-edid
[191.972448] Subtest force-edid: SUCCESS (0.263s)
[192.112276] [109/160] (814s left) kms_force_connector_basic (force-load-detect)
[192.223587] Starting subtest: force-load-detect
[192.225825] Subtest force-load-detect: SKIP (0.000s)
[192.329633] [110/160] (814s left) kms_force_connector_basic (prune-stale-modes)
[192.439166] Starting subtest: prune-stale-modes
[192.758229] Subtest prune-stale-modes: SUCCESS (0.317s)
[192.880680] [111/160] (813s left) kms_frontbuffer_tracking (basic)
[193.027736] Starting subtest: basic
[196.848188] Subtest basic: SUCCESS (3.819s)
[196.991452] [112/160] (809s left) kms_hdmi_inject (inject-audio)
[197.419864] Starting subtest: inject-audio
[197.665529] Subtest inject-audio: SUCCESS (0.245s)
[198.359621] [113/160] (808s left) kms_pipe_crc_basic (compare-crc-sanitycheck-xr24)
[198.496194] Starting subtest: compare-crc-sanitycheck-xr24
[198.497505] Starting dynamic subtest: pipe-A-eDP-1
[199.188239] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.689s)
[199.206238] Starting dynamic subtest: pipe-B-eDP-1
[200.587677] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.398s)
[200.609573] Starting dynamic subtest: pipe-C-eDP-1
[201.973602] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.383s)
[201.974933] Subtest compare-crc-sanitycheck-xr24: SUCCESS (3.480s)
[202.941661] [114/160] (803s left) kms_pipe_crc_basic (compare-crc-sanitycheck-nv12)
[203.081693] Starting subtest: compare-crc-sanitycheck-nv12
[203.084694] Starting dynamic subtest: pipe-A-eDP-1
[204.040414] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.953s)
[204.057473] Starting dynamic subtest: pipe-B-eDP-1
[205.432888] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.392s)
[205.452423] Starting dynamic subtest: pipe-C-eDP-1
[206.830037] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.393s)
[206.831254] Subtest compare-crc-sanitycheck-nv12: SUCCESS (3.748s)
[207.760141] [115/160] (798s left) kms_pipe_crc_basic (hang-read-crc)
[207.891243] Starting subtest: hang-read-crc
[207.894365] Starting dynamic subtest: pipe-A-eDP-1
[210.304805] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.411s)
[210.323537] Starting dynamic subtest: pipe-B-eDP-1
[213.374112] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.066s)
[213.394713] Starting dynamic subtest: pipe-C-eDP-1
[216.353165] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.975s)
[216.354469] Subtest hang-read-crc: SUCCESS (8.461s)
[217.278236] [116/160] (789s left) kms_pipe_crc_basic (nonblocking-crc)
[217.411754] Starting subtest: nonblocking-crc
[217.414995] Starting dynamic subtest: pipe-A-eDP-1
[218.308108] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.893s)
[218.326721] Starting dynamic subtest: pipe-B-eDP-1
[219.903231] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.592s)
[219.921980] Starting dynamic subtest: pipe-C-eDP-1
[221.453290] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.546s)
[221.459378] Subtest nonblocking-crc: SUCCESS (4.041s)
[222.402134] [117/160] (784s left) kms_pipe_crc_basic (nonblocking-crc-frame-sequence)
[222.541341] Starting subtest: nonblocking-crc-frame-sequence
[222.552286] Starting dynamic subtest: pipe-A-eDP-1
[223.447858] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.903s)
[223.466378] Starting dynamic subtest: pipe-B-eDP-1
[225.043297] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.593s)
[225.063846] Starting dynamic subtest: pipe-C-eDP-1
[226.631205] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.583s)
[226.632593] Subtest nonblocking-crc-frame-sequence: SUCCESS (4.090s)
[227.581278] [118/160] (779s left) kms_pipe_crc_basic (read-crc)
[227.715965] Starting subtest: read-crc
[227.719289] Starting dynamic subtest: pipe-A-eDP-1
[228.541998] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.823s)
[228.560994] Starting dynamic subtest: pipe-B-eDP-1
[230.100361] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.553s)
[230.117701] Starting dynamic subtest: pipe-C-eDP-1
[231.584215] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.482s)
[231.585448] Subtest read-crc: SUCCESS (3.869s)
[232.510747] [119/160] (774s left) kms_pipe_crc_basic (read-crc-frame-sequence)
[232.652328] Starting subtest: read-crc-frame-sequence
[232.655705] Starting dynamic subtest: pipe-A-eDP-1
[233.488570] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.833s)
[233.507360] Starting dynamic subtest: pipe-B-eDP-1
[235.008749] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.515s)
[235.027837] Starting dynamic subtest: pipe-C-eDP-1
[236.505537] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.494s)
[236.506866] Subtest read-crc-frame-sequence: SUCCESS (3.853s)
[237.438818] [120/160] (769s left) kms_pm_backlight (basic-brightness)
[237.579173] Starting subtest: basic-brightness
[237.690441] Starting dynamic subtest: eDP-1
[238.247792] Dynamic subtest eDP-1: SUCCESS (0.567s)
[238.249098] Subtest basic-brightness: SUCCESS (0.670s)
[239.168225] [121/160] (767s left) kms_pm_rpm (basic-pci-d3-state)
[241.016403] Starting subtest: basic-pci-d3-state
[245.399278] Subtest basic-pci-d3-state: SUCCESS (4.383s)
[245.622828] [122/160] (761s left) kms_pm_rpm (basic-rte)
[245.717334] Starting subtest: basic-rte
[251.861807] Subtest basic-rte: SUCCESS (6.143s)
[253.375309] [123/160] (753s left) kms_psr (psr-primary-page-flip)
[253.511604] Starting subtest: psr-primary-page-flip
[253.512940] Starting dynamic subtest: eDP-1
[257.288904] Dynamic subtest eDP-1: SUCCESS (3.776s)
[257.292627] Subtest psr-primary-page-flip: SUCCESS (3.779s)
[258.240100] [124/160] (748s left) kms_psr (psr-cursor-plane-move)
[258.378536] Starting subtest: psr-cursor-plane-move
[258.379841] Starting dynamic subtest: eDP-1
[262.169539] Dynamic subtest eDP-1: SUCCESS (3.792s)
[262.170682] Subtest psr-cursor-plane-move: SUCCESS (3.794s)
[263.108651] [125/160] (743s left) kms_psr (psr-sprite-plane-onoff)
[263.244422] Starting subtest: psr-sprite-plane-onoff
[263.245825] Starting dynamic subtest: eDP-1
[267.105458] Dynamic subtest eDP-1: SUCCESS (3.859s)
[267.109635] Subtest psr-sprite-plane-onoff: SUCCESS (3.862s)
[268.043117] [126/160] (738s left) kms_psr (psr-primary-mmap-gtt)
[268.178664] Starting subtest: psr-primary-mmap-gtt
[268.180042] Starting dynamic subtest: eDP-1
[271.955114] Dynamic subtest eDP-1: SUCCESS (3.772s)
[271.956409] Subtest psr-primary-mmap-gtt: SUCCESS (3.775s)
[272.894383] [127/160] (733s left) kms_setmode (basic-clone-single-crtc)
[273.001429] Starting subtest: basic-clone-single-crtc
[273.004895] Subtest basic-clone-single-crtc: SKIP (0.000s)
[273.111409] [128/160] (733s left) i915_pm_rps (basic-api)
[273.229147] Starting subtest: basic-api
[273.234134] Subtest basic-api: SUCCESS (0.005s)
[273.328841] [129/160] (733s left) prime_self_import (basic-llseek-bad)
[273.422383] Starting subtest: basic-llseek-bad
[273.437405] Subtest basic-llseek-bad: SUCCESS (0.014s)
[273.562561] [130/160] (733s left) prime_self_import (basic-llseek-size)
[273.654614] Starting subtest: basic-llseek-size
[273.669996] Subtest basic-llseek-size: SUCCESS (0.016s)
[273.781389] [131/160] (733s left) prime_self_import (basic-with_fd_dup)
[273.874388] Starting subtest: basic-with_fd_dup
[273.890424] Subtest basic-with_fd_dup: SUCCESS (0.016s)
[273.995661] [132/160] (733s left) prime_self_import (basic-with_one_bo)
[274.087568] Starting subtest: basic-with_one_bo
[274.104530] Subtest basic-with_one_bo: SUCCESS (0.017s)
[274.204832] [133/160] (732s left) prime_self_import (basic-with_one_bo_two_files)
[274.297714] Starting subtest: basic-with_one_bo_two_files
[274.314674] Subtest basic-with_one_bo_two_files: SUCCESS (0.017s)
[274.414792] [134/160] (732s left) prime_self_import (basic-with_two_bos)
[274.507272] Starting subtest: basic-with_two_bos
[274.523442] Subtest basic-with_two_bos: SUCCESS (0.017s)
[274.631750] [135/160] (732s left) prime_vgem (basic-fence-flip)
[274.753572] Starting subtest: basic-fence-flip
[275.302491] Subtest basic-fence-flip: SUCCESS (0.548s)
[275.431385] [136/160] (731s left) prime_vgem (basic-fence-mmap)
[275.557472] Starting subtest: basic-fence-mmap
[275.609213] Subtest basic-fence-mmap: SUCCESS (0.051s)
[275.696506] [137/160] (731s left) prime_vgem (basic-fence-read)
[275.824855] Starting subtest: basic-fence-read
[275.937061] Subtest basic-fence-read: SUCCESS (0.103s)
[276.036374] [138/160] (731s left) prime_vgem (basic-gtt)
[276.155072] Starting subtest: basic-gtt
[276.181232] Subtest basic-gtt: SUCCESS (0.025s)
[276.284028] [139/160] (730s left) prime_vgem (basic-read)
[276.403507] Starting subtest: basic-read
[276.453576] Subtest basic-read: SUCCESS (0.050s)
[276.565872] [140/160] (730s left) prime_vgem (basic-write)
[276.693413] Starting subtest: basic-write
[276.762595] Subtest basic-write: SUCCESS (0.069s)
[276.867887] [141/160] (730s left) vgem_basic (setversion)
[276.970920] Starting subtest: setversion
[276.973455] Subtest setversion: SUCCESS (0.000s)
[277.050376] [142/160] (730s left) vgem_basic (create)
[277.154829] Starting subtest: create
[277.156117] Subtest create: SUCCESS (0.000s)
[277.232807] [143/160] (730s left) vgem_basic (debugfs)
[277.338513] Starting subtest: debugfs
[277.339843] Subtest debugfs: SUCCESS (0.001s)
[277.412840] [144/160] (730s left) vgem_basic (dmabuf-export)
[277.521917] Starting subtest: dmabuf-export
[277.536434] Subtest dmabuf-export: SUCCESS (0.013s)
[277.650315] [145/160] (729s left) vgem_basic (dmabuf-fence)
[277.755488] Starting subtest: dmabuf-fence
[277.756676] Subtest dmabuf-fence: SUCCESS (0.001s)
[277.833248] [146/160] (729s left) vgem_basic (dmabuf-fence-before)
[277.939166] Starting subtest: dmabuf-fence-before
[277.941198] Subtest dmabuf-fence-before: SUCCESS (0.001s)
[278.019775] [147/160] (729s left) vgem_basic (dmabuf-mmap)
[278.122204] Starting subtest: dmabuf-mmap
[278.147685] Subtest dmabuf-mmap: SUCCESS (0.026s)
[278.213050] [148/160] (729s left) vgem_basic (mmap)
[278.323015] Starting subtest: mmap
[278.341877] Subtest mmap: SUCCESS (0.017s)
[278.413852] [149/160] (729s left) vgem_basic (second-client)
[278.522768] Starting subtest: second-client
[278.557967] Subtest second-client: SUCCESS (0.034s)
[278.634121] [150/160] (728s left) vgem_basic (sysfs)
[278.739717] Starting subtest: sysfs
[278.741075] Subtest sysfs: SUCCESS (0.001s)
[278.817432] [151/160] (728s left) core_hotunplug (unbind-rebind)
[278.972890] Starting subtest: unbind-rebind
[285.044046] Subtest unbind-rebind: SUCCESS (6.071s)
[285.081049] [152/160] (722s left) vgem_basic (unload)
[285.181330] Starting subtest: unload
[314.224183] Subtest unload: SUCCESS (29.033s)
[314.352080] [153/160] (693s left) i915_module_load (reload)
[314.454540] Starting subtest: reload
[319.530503] Subtest reload: SUCCESS (5.077s)
[319.562753] [154/160] (688s left) gem_lmem_swapping (basic)
[319.679631] Subtest basic: SKIP (0.000s)
[319.733761] [155/160] (688s left) gem_lmem_swapping (parallel-random-engines)
[319.836464] Subtest parallel-random-engines: SKIP (0.000s)
[319.882356] [156/160] (687s left) gem_lmem_swapping (random-engines)
[319.985083] Subtest random-engines: SKIP (0.000s)
[320.034757] [157/160] (687s left) gem_lmem_swapping (verify-random)
[320.138658] Subtest verify-random: SKIP (0.000s)
[320.183048] [158/160] (687s left) i915_pm_rpm (module-reload)
[332.690192] Starting subtest: module-reload
[365.289903] Subtest module-reload: SUCCESS (32.592s)
[365.312434] [159/160] (642s left) i915_selftest (live)
[365.419833] Starting subtest: live
[365.421244] Starting dynamic subtest: sanitycheck
[368.941488] Dynamic subtest sanitycheck: SUCCESS (3.512s)
[368.952241] Starting dynamic subtest: uncore
[372.450541] Dynamic subtest uncore: SUCCESS (3.506s)
[372.461346] Starting dynamic subtest: workarounds
[376.221607] Dynamic subtest workarounds: SUCCESS (3.767s)
[376.232335] Starting dynamic subtest: gt_engines
[380.171462] Dynamic subtest gt_engines: SUCCESS (3.946s)
[380.182320] Starting dynamic subtest: gt_timelines
[396.166661] Dynamic subtest gt_timelines: SUCCESS (15.992s)
[396.177355] Starting dynamic subtest: gt_contexts
[399.776509] Dynamic subtest gt_contexts: SUCCESS (3.606s)
[399.787312] Starting dynamic subtest: gt_lrc
[405.320563] Dynamic subtest gt_lrc: SUCCESS (5.541s)
[405.331456] Starting dynamic subtest: gt_mocs
[408.951696] Dynamic subtest gt_mocs: SUCCESS (3.627s)
[408.962519] Starting dynamic subtest: gt_pm
[415.693818] Dynamic subtest gt_pm: SUCCESS (6.738s)
[415.704694] Starting dynamic subtest: gt_heartbeat
[419.230891] Dynamic subtest gt_heartbeat: SUCCESS (3.533s)
[419.241822] Starting dynamic subtest: gt_tlb
[423.804608] Dynamic subtest gt_tlb: SUCCESS (4.571s)
[423.815699] Starting dynamic subtest: requests
[433.152710] Dynamic subtest requests: SUCCESS (9.344s)
[433.163650] Starting dynamic subtest: migrate
[439.175758] Dynamic subtest migrate: SUCCESS (6.019s)
[439.186738] Starting dynamic subtest: active
[442.664038] Dynamic subtest active: SUCCESS (3.485s)
[442.674848] Starting dynamic subtest: objects
[447.239764] Dynamic subtest objects: SUCCESS (4.572s)
[447.250748] Starting dynamic subtest: mman
[455.914669] Dynamic subtest mman: SUCCESS (8.671s)
[455.925626] Starting dynamic subtest: dmabuf
[459.475588] Dynamic subtest dmabuf: SUCCESS (3.557s)
[459.486488] Starting dynamic subtest: vma
[462.970073] Dynamic subtest vma: SUCCESS (3.491s)
[462.980968] Starting dynamic subtest: coherency
[469.537443] Dynamic subtest coherency: SUCCESS (6.564s)
[469.548343] Starting dynamic subtest: gtt
[480.550813] Dynamic subtest gtt: SUCCESS (11.010s)
[480.561811] Starting dynamic subtest: gem
[484.230816] Dynamic subtest gem: SUCCESS (3.676s)
[484.241740] Starting dynamic subtest: evict
[489.523183] Dynamic subtest evict: SUCCESS (5.288s)
[489.534956] Starting dynamic subtest: hugepages
[498.920608] Dynamic subtest hugepages: SUCCESS (9.402s)
[498.935868] Starting dynamic subtest: gem_contexts
[517.721901] Dynamic subtest gem_contexts: SUCCESS (18.764s)
[517.737408] Starting dynamic subtest: client
[521.269843] Dynamic subtest client: SUCCESS (3.571s)
[521.281287] Starting dynamic subtest: gem_migrate
[524.767564] Dynamic subtest gem_migrate: SUCCESS (3.494s)
[524.778956] Starting dynamic subtest: reset
[531.759543] Dynamic subtest reset: SUCCESS (6.989s)
[531.770896] Starting dynamic subtest: memory_region
[535.273649] Dynamic subtest memory_region: SUCCESS (3.510s)
[535.284969] Starting dynamic subtest: hangcheck
[561.415540] Dynamic subtest hangcheck: SUCCESS (26.138s)
[561.426904] Starting dynamic subtest: execlists
[573.724588] Dynamic subtest execlists: SUCCESS (12.306s)
[573.735918] Starting dynamic subtest: ring_submission
[577.174596] Dynamic subtest ring_submission: SUCCESS (3.454s)
[577.189021] Starting dynamic subtest: perf
[580.784513] Dynamic subtest perf: SUCCESS (3.599s)
[580.795857] Starting dynamic subtest: slpc
[584.222750] Dynamic subtest slpc: SUCCESS (3.435s)
[584.234251] Starting dynamic subtest: guc
[587.743654] Dynamic subtest guc: SUCCESS (3.517s)
[587.754922] Starting dynamic subtest: guc_multi_lrc
[591.265949] Dynamic subtest guc_multi_lrc: SUCCESS (3.519s)
[591.277342] Starting dynamic subtest: guc_hang
[594.785548] Dynamic subtest guc_hang: SUCCESS (3.516s)
[594.796820] Starting dynamic subtest: late_gt_pm
[598.305181] Dynamic subtest late_gt_pm: SUCCESS (3.516s)
[598.306401] Subtest live: SUCCESS (232.878s)
[598.333911] [160/160] (409s left) dmabuf (all-tests)
[598.438685] Starting subtest: all-tests
[598.440061] Starting dynamic subtest: sanitycheck
[598.500777] Dynamic subtest sanitycheck: SUCCESS (0.060s)
[598.519444] Starting dynamic subtest: dma_fence
[598.694172] Dynamic subtest dma_fence: SUCCESS (0.189s)
[598.712058] Starting dynamic subtest: dma_fence_chain
[616.714331] Dynamic subtest dma_fence_chain: SUCCESS (18.008s)
[616.727440] Starting dynamic subtest: dma_fence_unwrap
[616.782684] Dynamic subtest dma_fence_unwrap: SUCCESS (0.073s)
[616.802669] Starting dynamic subtest: dma_resv
[616.860988] Dynamic subtest dma_resv: SUCCESS (0.074s)
[616.863291] Subtest all-tests: SUCCESS (18.423s)
[616.892465] Closing watchdogs
Done.