[43.891483] Initializing watchdogs
[43.891636]   /dev/watchdog0
[43.901309] [001/160] (960s left) i915_module_load (load)
[44.002913] Starting subtest: load
[48.214577] Subtest load: SUCCESS (4.211s)
[48.237236] [002/160] (956s left) core_auth (basic-auth)
[48.351417] Starting subtest: basic-auth
[48.353882] Subtest basic-auth: SUCCESS (0.002s)
[48.449324] [003/160] (955s left) debugfs_test (read_all_entries)
[48.564148] Starting subtest: read_all_entries
[48.653256] Subtest read_all_entries: SUCCESS (0.088s)
[48.767293] [004/160] (955s left) debugfs_test (basic-hwmon)
[48.878760] Starting subtest: basic-hwmon
[48.880871] Subtest basic-hwmon: SKIP (0.000s)
[48.980778] [005/160] (955s left) fbdev (eof)
[49.101925] Starting subtest: eof
[49.104318] Subtest eof: SUCCESS (0.003s)
[49.187413] [006/160] (955s left) fbdev (info)
[49.277066] Starting subtest: info
[49.278364] Subtest info: SUCCESS (0.000s)
[49.370950] [007/160] (955s left) fbdev (nullptr)
[49.465939] Starting subtest: nullptr
[49.467190] Subtest nullptr: SUCCESS (0.000s)
[49.533847] [008/160] (955s left) fbdev (read)
[49.632897] Starting subtest: read
[56.719382] Subtest read: SUCCESS (7.052s)
[56.755382] [009/160] (947s left) fbdev (write)
[56.857390] Starting subtest: write
[60.644664] Subtest write: SUCCESS (3.753s)
[60.675620] [010/160] (943s left) gem_basic (bad-close)
[60.784769] Starting subtest: bad-close
[60.787089] Subtest bad-close: SUCCESS (0.000s)
[60.898458] [011/160] (943s left) gem_basic (create-close)
[60.991451] Starting subtest: create-close
[60.993638] Subtest create-close: SUCCESS (0.000s)
[61.080999] [012/160] (943s left) gem_basic (create-fd-close)
[61.179884] Starting subtest: create-fd-close
[61.183099] Subtest create-fd-close: SUCCESS (0.000s)
[61.282055] [013/160] (943s left) gem_busy (busy@all-engines)
[61.404378] Starting subtest: busy
[61.405649] Starting dynamic subtest: all-engines
[61.466107] Dynamic subtest all-engines: SUCCESS (0.064s)
[61.467361] Subtest busy: SUCCESS (0.065s)
[61.852126] [014/160] (942s left) gem_close_race (basic-process)
[61.984494] Starting subtest: basic-process
[62.060598] Subtest basic-process: SUCCESS (0.077s)
[62.267413] [015/160] (942s left) gem_close_race (basic-threads)
[62.395251] Starting subtest: basic-threads
[63.610839] Subtest basic-threads: SUCCESS (1.215s)
[63.833896] [016/160] (940s left) gem_ctx_create (basic)
[63.958771] Starting subtest: basic
[63.960136] Subtest basic: SUCCESS (0.000s)
[64.169871] [017/160] (940s left) gem_ctx_create (basic-files)
[64.291740] Starting subtest: basic-files
[66.318257] Subtest basic-files: SUCCESS (2.026s)
[66.551366] [018/160] (938s left) gem_ctx_exec (basic)
[66.655156] Starting subtest: basic
[66.662076] Subtest basic: SUCCESS (0.007s)
[66.780412] [019/160] (938s left) gem_exec_basic (basic)
[66.887777] Starting subtest: basic
[66.888953] Starting dynamic subtest: rcs0-smem
[66.890238] Dynamic subtest rcs0-smem: SUCCESS (0.003s)
[66.901749] Starting dynamic subtest: bcs0-smem
[66.903072] Dynamic subtest bcs0-smem: SUCCESS (0.001s)
[66.913712] Starting dynamic subtest: vcs0-smem
[66.915046] Dynamic subtest vcs0-smem: SUCCESS (0.001s)
[66.925628] Starting dynamic subtest: vecs0-smem
[66.927360] Dynamic subtest vecs0-smem: SUCCESS (0.001s)
[66.928946] Subtest basic: SUCCESS (0.006s)
[67.105746] [020/160] (937s left) gem_exec_create (basic)
[67.231385] Starting subtest: basic
[67.232768] Starting dynamic subtest: smem
[69.294334] Dynamic subtest smem: SUCCESS (2.043s)
[69.295789] Subtest basic: SUCCESS (2.044s)
[69.499709] [021/160] (935s left) gem_exec_fence (basic-busy)
[69.766845] Starting subtest: basic-busy
[69.768479] Starting dynamic subtest: rcs0
[69.787716] Dynamic subtest rcs0: SUCCESS (0.029s)
[69.799608] Starting dynamic subtest: bcs0
[69.818343] Dynamic subtest bcs0: SUCCESS (0.030s)
[69.830992] Starting dynamic subtest: vcs0
[69.841497] Dynamic subtest vcs0: SUCCESS (0.023s)
[69.853290] Starting dynamic subtest: vecs0
[69.875136] Dynamic subtest vecs0: SUCCESS (0.033s)
[69.876365] Subtest basic-busy: SUCCESS (0.117s)
[70.476591] [022/160] (934s left) gem_exec_fence (basic-wait)
[70.740096] Starting subtest: basic-wait
[70.741485] Starting dynamic subtest: rcs0
[70.763542] Dynamic subtest rcs0: SUCCESS (0.031s)
[70.776916] Starting dynamic subtest: bcs0
[70.806633] Dynamic subtest bcs0: SUCCESS (0.042s)
[70.821801] Starting dynamic subtest: vcs0
[70.835574] Dynamic subtest vcs0: SUCCESS (0.029s)
[70.847945] Starting dynamic subtest: vecs0
[70.861491] Dynamic subtest vecs0: SUCCESS (0.025s)
[70.862810] Subtest basic-wait: SUCCESS (0.130s)
[71.412145] [023/160] (933s left) gem_exec_fence (basic-await)
[71.677476] Starting subtest: basic-await
[71.678653] Starting dynamic subtest: rcs0
[71.770262] Dynamic subtest rcs0: SUCCESS (0.100s)
[71.798047] Starting dynamic subtest: bcs0
[71.884373] Dynamic subtest bcs0: SUCCESS (0.113s)
[71.911933] Starting dynamic subtest: vcs0
[72.025480] Dynamic subtest vcs0: SUCCESS (0.132s)
[72.052109] Starting dynamic subtest: vecs0
[72.146529] Dynamic subtest vecs0: SUCCESS (0.128s)
[72.148856] Subtest basic-await: SUCCESS (0.476s)
[72.728600] [024/160] (932s left) gem_exec_fence (nb-await)
[72.989047] Starting subtest: nb-await
[72.990259] Starting dynamic subtest: rcs0
[73.045191] Dynamic subtest rcs0: SUCCESS (0.064s)
[73.065677] Starting dynamic subtest: bcs0
[73.120485] Dynamic subtest bcs0: SUCCESS (0.072s)
[73.144062] Starting dynamic subtest: vcs0
[73.192263] Dynamic subtest vcs0: SUCCESS (0.073s)
[73.219350] Starting dynamic subtest: vecs0
[73.267815] Dynamic subtest vecs0: SUCCESS (0.076s)
[73.269828] Subtest nb-await: SUCCESS (0.287s)
[73.830933] [025/160] (931s left) gem_exec_gttfill (basic)
[73.954924] Starting subtest: basic
[80.274359] Subtest basic: SUCCESS (6.311s)
[80.453505] [026/160] (924s left) gem_exec_parallel (engines)
[80.679091] Starting subtest: engines
[80.680343] Starting dynamic subtest: basic
[83.142403] Dynamic subtest basic: SUCCESS (2.461s)
[83.156305] Starting dynamic subtest: contexts
[89.530110] Dynamic subtest contexts: SUCCESS (6.381s)
[89.543905] Starting dynamic subtest: fds
[102.785773] Dynamic subtest fds: SUCCESS (13.264s)
[102.800209] Starting dynamic subtest: userptr
[105.514182] Dynamic subtest userptr: SUCCESS (2.703s)
[105.516408] Subtest engines: SUCCESS (24.811s)
[105.720262] [027/160] (899s left) gem_exec_store (basic)
[105.834994] Starting subtest: basic
[105.891925] Subtest basic: SUCCESS (0.058s)
[106.093328] [028/160] (899s left) gem_flink_basic (bad-flink)
[106.190545] Starting subtest: bad-flink
[106.191811] Subtest bad-flink: SUCCESS (0.000s)
[106.286523] [029/160] (898s left) gem_flink_basic (bad-open)
[106.383475] Starting subtest: bad-open
[106.384586] Subtest bad-open: SUCCESS (0.000s)
[106.482612] [030/160] (898s left) gem_flink_basic (basic)
[106.583563] Starting subtest: basic
[106.584674] Subtest basic: SUCCESS (0.000s)
[106.682979] [031/160] (898s left) gem_flink_basic (double-flink)
[106.779416] Starting subtest: double-flink
[106.780510] Subtest double-flink: SUCCESS (0.000s)
[106.882952] [032/160] (898s left) gem_flink_basic (flink-lifetime)
[106.979927] Starting subtest: flink-lifetime
[106.983610] Subtest flink-lifetime: SUCCESS (0.003s)
[107.082597] [033/160] (898s left) gem_huc_copy (huc-copy)
[107.187176] Starting subtest: huc-copy
[107.189397] Subtest huc-copy: SKIP (0.000s)
[107.318260] [034/160] (897s left) gem_linear_blits (basic)
[107.568419] Starting subtest: basic
[107.584756] Subtest basic: SUCCESS (0.016s)
[107.721596] [035/160] (897s left) gem_mmap (basic)
[107.892489] Starting subtest: basic
[107.897788] Subtest basic: SUCCESS (0.001s)
[108.000922] [036/160] (897s left) gem_mmap_gtt (basic)
[108.102632] Starting subtest: basic
[108.103768] Subtest basic: SUCCESS (0.002s)
[108.209948] [037/160] (897s left) gem_render_linear_blits (basic)
[108.313915] Starting subtest: basic
[108.372274] Subtest basic: SUCCESS (0.058s)
[108.426563] [038/160] (896s left) gem_render_tiled_blits (basic)
[108.530542] Starting subtest: basic
[108.596365] Subtest basic: SUCCESS (0.065s)
[108.662165] [039/160] (896s left) gem_ringfill (basic-all)
[108.921227] Starting subtest: basic-all
[110.178986] Subtest basic-all: SUCCESS (1.248s)
[110.274844] [040/160] (895s left) gem_softpin (allocator-basic)
[110.376353] Starting subtest: allocator-basic
[110.550490] Subtest allocator-basic: SUCCESS (0.166s)
[110.671912] [041/160] (894s left) gem_softpin (allocator-basic-reserve)
[110.775940] Starting subtest: allocator-basic-reserve
[110.949335] Subtest allocator-basic-reserve: SUCCESS (0.165s)
[111.072678] [042/160] (894s left) gem_softpin (safe-alignment)
[111.182741] Starting subtest: safe-alignment
[111.204199] Subtest safe-alignment: SUCCESS (0.021s)
[111.321878] [043/160] (894s left) gem_sync (basic-all)
[111.435808] Starting subtest: basic-all
[114.068735] Subtest basic-all: SUCCESS (2.633s)
[114.275210] [044/160] (891s left) gem_sync (basic-each)
[114.395058] Starting subtest: basic-each
[116.725695] Subtest basic-each: SUCCESS (2.329s)
[116.977497] [045/160] (888s left) gem_tiled_blits (basic)
[117.215710] Starting subtest: basic
[117.247770] Subtest basic: SUCCESS (0.032s)
[117.380328] [046/160] (888s left) gem_tiled_fence_blits (basic)
[117.681089] Starting subtest: basic
[117.709764] Subtest basic: SUCCESS (0.029s)
[117.845469] [047/160] (887s left) gem_tiled_pread_basic
[118.346024] [048/160] (887s left) gem_wait (busy@all-engines)
[118.478054] Starting subtest: busy
[118.479219] Starting dynamic subtest: all-engines
[119.011629] Dynamic subtest all-engines: SUCCESS (0.533s)
[119.012724] Subtest busy: SUCCESS (0.534s)
[119.263880] [049/160] (886s left) gem_wait (wait@all-engines)
[119.396256] Starting subtest: wait
[119.397383] Starting dynamic subtest: all-engines
[120.433854] Dynamic subtest all-engines: SUCCESS (1.037s)
[120.435302] Subtest wait: SUCCESS (1.038s)
[120.683334] [050/160] (885s left) i915_getparams_basic (basic-eu-total)
[120.785631] Starting subtest: basic-eu-total
[120.792943] Subtest basic-eu-total: SUCCESS (0.000s)
[120.881740] [051/160] (884s left) i915_getparams_basic (basic-subslice-total)
[120.986681] Starting subtest: basic-subslice-total
[120.988989] Subtest basic-subslice-total: SUCCESS (0.000s)
[121.081969] [052/160] (884s left) i915_hangman (error-state-basic)
[121.194562] Starting subtest: error-state-basic
[121.208847] Subtest error-state-basic: SUCCESS (0.013s)
[121.294185] [053/160] (884s left) i915_pciid
[121.482896] [054/160] (884s left) kms_addfb_basic (addfb25-4-tiled)
[121.616412] Starting subtest: addfb25-4-tiled
[121.617666] Subtest addfb25-4-tiled: SUCCESS (0.000s)
[121.709633] [055/160] (884s left) kms_addfb_basic (addfb25-bad-modifier)
[121.815827] Starting subtest: addfb25-bad-modifier
[121.816903] Subtest addfb25-bad-modifier: SUCCESS (0.000s)
[121.931634] [056/160] (883s left) kms_addfb_basic (addfb25-framebuffer-vs-set-tiling)
[122.033100] Starting subtest: addfb25-framebuffer-vs-set-tiling
[122.034276] Subtest addfb25-framebuffer-vs-set-tiling: SUCCESS (0.000s)
[122.186413] [057/160] (883s left) kms_addfb_basic (addfb25-modifier-no-flag)
[122.289686] Starting subtest: addfb25-modifier-no-flag
[122.290769] Subtest addfb25-modifier-no-flag: SUCCESS (0.000s)
[122.417318] [058/160] (883s left) kms_addfb_basic (addfb25-x-tiled-legacy)
[122.514694] Starting subtest: addfb25-x-tiled-legacy
[122.515759] Subtest addfb25-x-tiled-legacy: SUCCESS (0.000s)
[122.632448] [059/160] (883s left) kms_addfb_basic (addfb25-x-tiled-mismatch-legacy)
[122.733721] Starting subtest: addfb25-x-tiled-mismatch-legacy
[122.734794] Subtest addfb25-x-tiled-mismatch-legacy: SUCCESS (0.000s)
[122.866284] [060/160] (883s left) kms_addfb_basic (addfb25-yf-tiled-legacy)
[122.997781] Starting subtest: addfb25-yf-tiled-legacy
[122.999101] Subtest addfb25-yf-tiled-legacy: SUCCESS (0.000s)
[123.101989] [061/160] (882s left) kms_addfb_basic (addfb25-y-tiled-legacy)
[123.237782] Starting subtest: addfb25-y-tiled-legacy
[123.238924] Subtest addfb25-y-tiled-legacy: SUCCESS (0.000s)
[123.334411] [062/160] (882s left) kms_addfb_basic (addfb25-y-tiled-small-legacy)
[123.462099] Starting subtest: addfb25-y-tiled-small-legacy
[123.463220] Subtest addfb25-y-tiled-small-legacy: SUCCESS (0.000s)
[123.549972] [063/160] (882s left) kms_addfb_basic (bad-pitch-0)
[123.649719] Starting subtest: bad-pitch-0
[123.650783] Subtest bad-pitch-0: SUCCESS (0.000s)
[123.780202] [064/160] (882s left) kms_addfb_basic (bad-pitch-1024)
[123.884692] Starting subtest: bad-pitch-1024
[123.885758] Subtest bad-pitch-1024: SUCCESS (0.000s)
[124.018673] [065/160] (882s left) kms_addfb_basic (bad-pitch-128)
[124.122081] Starting subtest: bad-pitch-128
[124.123118] Subtest bad-pitch-128: SUCCESS (0.000s)
[124.255440] [066/160] (881s left) kms_addfb_basic (bad-pitch-256)
[124.358600] Starting subtest: bad-pitch-256
[124.359724] Subtest bad-pitch-256: SUCCESS (0.000s)
[124.502412] [067/160] (881s left) kms_addfb_basic (bad-pitch-32)
[124.599607] Starting subtest: bad-pitch-32
[124.600876] Subtest bad-pitch-32: SUCCESS (0.000s)
[124.744603] [068/160] (881s left) kms_addfb_basic (bad-pitch-63)
[124.840398] Starting subtest: bad-pitch-63
[124.841506] Subtest bad-pitch-63: SUCCESS (0.000s)
[124.963206] [069/160] (881s left) kms_addfb_basic (bad-pitch-65536)
[125.077638] Starting subtest: bad-pitch-65536
[125.078800] Subtest bad-pitch-65536: SUCCESS (0.000s)
[125.200170] [070/160] (881s left) kms_addfb_basic (bad-pitch-999)
[125.297555] Starting subtest: bad-pitch-999
[125.298701] Subtest bad-pitch-999: SUCCESS (0.000s)
[125.419710] [071/160] (880s left) kms_addfb_basic (basic)
[125.526129] Starting subtest: basic
[125.527271] Subtest basic: SUCCESS (0.000s)
[125.653931] [072/160] (880s left) kms_addfb_basic (basic-x-tiled-legacy)
[125.752809] Starting subtest: basic-x-tiled-legacy
[125.753959] Subtest basic-x-tiled-legacy: SUCCESS (0.000s)
[125.890249] [073/160] (880s left) kms_addfb_basic (basic-y-tiled-legacy)
[125.990771] Starting subtest: basic-y-tiled-legacy
[125.992099] Subtest basic-y-tiled-legacy: SUCCESS (0.000s)
[126.120709] [074/160] (880s left) kms_addfb_basic (bo-too-small)
[126.257463] Starting subtest: bo-too-small
[126.258678] Subtest bo-too-small: SUCCESS (0.000s)
[126.348187] [075/160] (880s left) kms_addfb_basic (bo-too-small-due-to-tiling)
[126.476216] Starting subtest: bo-too-small-due-to-tiling
[126.477492] Subtest bo-too-small-due-to-tiling: SUCCESS (0.000s)
[126.567514] [076/160] (879s left) kms_addfb_basic (clobberred-modifier)
[126.665453] Starting subtest: clobberred-modifier
[126.666804] Subtest clobberred-modifier: SUCCESS (0.000s)
[126.789746] [077/160] (879s left) kms_addfb_basic (framebuffer-vs-set-tiling)
[126.893133] Starting subtest: framebuffer-vs-set-tiling
[126.894340] Subtest framebuffer-vs-set-tiling: SUCCESS (0.000s)
[127.039185] [078/160] (879s left) kms_addfb_basic (invalid-get-prop)
[127.139116] Starting subtest: invalid-get-prop
[127.140230] Subtest invalid-get-prop: SUCCESS (0.000s)
[127.288124] [079/160] (879s left) kms_addfb_basic (invalid-get-prop-any)
[127.392150] Starting subtest: invalid-get-prop-any
[127.393289] Subtest invalid-get-prop-any: SUCCESS (0.000s)
[127.516672] [080/160] (879s left) kms_addfb_basic (invalid-set-prop)
[127.614633] Starting subtest: invalid-set-prop
[127.615693] Subtest invalid-set-prop: SUCCESS (0.000s)
[127.733804] [081/160] (878s left) kms_addfb_basic (invalid-set-prop-any)
[127.835078] Starting subtest: invalid-set-prop-any
[127.836122] Subtest invalid-set-prop-any: SUCCESS (0.000s)
[127.975793] [082/160] (878s left) kms_addfb_basic (no-handle)
[128.080547] Starting subtest: no-handle
[128.081672] Subtest no-handle: SUCCESS (0.000s)
[128.224709] [083/160] (878s left) kms_addfb_basic (size-max)
[128.352305] Starting subtest: size-max
[128.353629] Subtest size-max: SUCCESS (0.000s)
[128.473150] [084/160] (878s left) kms_addfb_basic (small-bo)
[128.605328] Starting subtest: small-bo
[128.606487] Subtest small-bo: SUCCESS (0.000s)
[128.706506] [085/160] (878s left) kms_addfb_basic (tile-pitch-mismatch)
[128.804844] Starting subtest: tile-pitch-mismatch
[128.805949] Subtest tile-pitch-mismatch: SUCCESS (0.000s)
[128.939963] [086/160] (877s left) kms_addfb_basic (too-high)
[129.068146] Starting subtest: too-high
[129.069493] Subtest too-high: SUCCESS (0.001s)
[129.169391] [087/160] (877s left) kms_addfb_basic (too-wide)
[129.300479] Starting subtest: too-wide
[129.301604] Subtest too-wide: SUCCESS (0.000s)
[129.389720] [088/160] (877s left) kms_addfb_basic (unused-handle)
[129.489444] Starting subtest: unused-handle
[129.490550] Subtest unused-handle: SUCCESS (0.000s)
[129.623705] [089/160] (877s left) kms_addfb_basic (unused-modifier)
[129.726501] Starting subtest: unused-modifier
[129.727615] Subtest unused-modifier: SUCCESS (0.000s)
[129.852278] [090/160] (877s left) kms_addfb_basic (unused-offsets)
[129.959687] Starting subtest: unused-offsets
[129.960822] Subtest unused-offsets: SUCCESS (0.000s)
[130.092469] [091/160] (876s left) kms_addfb_basic (unused-pitches)
[130.189396] Starting subtest: unused-pitches
[130.190512] Subtest unused-pitches: SUCCESS (0.000s)
[130.327836] [092/160] (876s left) kms_busy (basic)
[130.464621] Starting subtest: basic
[130.465935] Starting dynamic subtest: flip
[131.476404] Dynamic subtest flip: SUCCESS (1.011s)
[131.492801] Starting dynamic subtest: modeset
[135.415367] Dynamic subtest modeset: SUCCESS (3.938s)
[135.416574] Subtest basic: SUCCESS (4.952s)
[136.385197] [093/160] (870s left) kms_prop_blob (basic)
[136.492388] Starting subtest: basic
[136.493469] Subtest basic: SUCCESS (0.000s)
[136.602793] [094/160] (870s left) kms_cursor_legacy (basic-busy-flip-before-cursor-atomic)
[136.732707] Starting subtest: basic-busy-flip-before-cursor-atomic
[136.735074] Subtest basic-busy-flip-before-cursor-atomic: SKIP (0.000s)
[136.817281] [095/160] (870s left) kms_cursor_legacy (basic-busy-flip-before-cursor-legacy)
[136.949762] Starting subtest: basic-busy-flip-before-cursor-legacy
[136.952074] Subtest basic-busy-flip-before-cursor-legacy: SKIP (0.000s)
[137.037430] [096/160] (870s left) kms_cursor_legacy (basic-flip-after-cursor-atomic)
[137.168157] Starting subtest: basic-flip-after-cursor-atomic
[138.482121] Subtest basic-flip-after-cursor-atomic: SUCCESS (1.313s)
[139.459901] [097/160] (867s left) kms_cursor_legacy (basic-flip-after-cursor-legacy)
[139.589701] Starting subtest: basic-flip-after-cursor-legacy
[140.887748] Subtest basic-flip-after-cursor-legacy: SUCCESS (1.298s)
[141.825364] [098/160] (865s left) kms_cursor_legacy (basic-flip-after-cursor-varying-size)
[141.952367] Starting subtest: basic-flip-after-cursor-varying-size
[143.224056] Subtest basic-flip-after-cursor-varying-size: SUCCESS (1.273s)
[144.191504] [099/160] (862s left) kms_cursor_legacy (basic-flip-before-cursor-atomic)
[144.316375] Starting subtest: basic-flip-before-cursor-atomic
[145.619862] Subtest basic-flip-before-cursor-atomic: SUCCESS (1.303s)
[146.561934] [100/160] (860s left) kms_cursor_legacy (basic-flip-before-cursor-legacy)
[146.687960] Starting subtest: basic-flip-before-cursor-legacy
[147.990038] Subtest basic-flip-before-cursor-legacy: SUCCESS (1.303s)
[148.930180] [101/160] (858s left) kms_cursor_legacy (basic-flip-before-cursor-varying-size)
[149.053467] Starting subtest: basic-flip-before-cursor-varying-size
[150.360135] Subtest basic-flip-before-cursor-varying-size: SUCCESS (1.307s)
[151.297209] [102/160] (855s left) kms_dsc (dsc-basic)
[151.429845] Starting subtest: dsc-basic
[151.432405] Subtest dsc-basic: SKIP (0.001s)
[151.507280] [103/160] (855s left) kms_flip (basic-flip-vs-dpms)
[151.638364] Starting subtest: basic-flip-vs-dpms
[151.641347] Starting dynamic subtest: A-eDP1
[154.505125] Dynamic subtest A-eDP1: SUCCESS (2.862s)
[154.521442] Starting dynamic subtest: B-eDP1
[156.936617] Dynamic subtest B-eDP1: SUCCESS (2.432s)
[156.954152] Starting dynamic subtest: C-eDP1
[159.366462] Dynamic subtest C-eDP1: SUCCESS (2.428s)
[159.370093] Subtest basic-flip-vs-dpms: SUCCESS (7.731s)
[160.281070] [104/160] (846s left) kms_flip (basic-flip-vs-modeset)
[160.413139] Starting subtest: basic-flip-vs-modeset
[160.415646] Starting dynamic subtest: A-eDP1
[163.315076] Dynamic subtest A-eDP1: SUCCESS (2.899s)
[163.331866] Starting dynamic subtest: B-eDP1
[165.686227] Dynamic subtest B-eDP1: SUCCESS (2.369s)
[165.703212] Starting dynamic subtest: C-eDP1
[168.058959] Dynamic subtest C-eDP1: SUCCESS (2.369s)
[168.060270] Subtest basic-flip-vs-modeset: SUCCESS (7.646s)
[169.026186] [105/160] (838s left) kms_flip (basic-flip-vs-wf_vblank)
[169.153030] Starting subtest: basic-flip-vs-wf_vblank
[169.156811] Starting dynamic subtest: A-eDP1
[171.485720] Dynamic subtest A-eDP1: SUCCESS (2.327s)
[171.504023] Starting dynamic subtest: B-eDP1
[173.772578] Dynamic subtest B-eDP1: SUCCESS (2.285s)
[173.791816] Starting dynamic subtest: C-eDP1
[176.077832] Dynamic subtest C-eDP1: SUCCESS (2.302s)
[176.082251] Subtest basic-flip-vs-wf_vblank: SUCCESS (6.929s)
[177.409440] [106/160] (829s left) kms_flip (basic-plain-flip)
[177.540429] Starting subtest: basic-plain-flip
[177.544243] Starting dynamic subtest: A-eDP1
[179.585815] Dynamic subtest A-eDP1: SUCCESS (2.041s)
[179.604310] Starting dynamic subtest: B-eDP1
[181.558075] Dynamic subtest B-eDP1: SUCCESS (1.969s)
[181.578108] Starting dynamic subtest: C-eDP1
[183.536769] Dynamic subtest C-eDP1: SUCCESS (1.977s)
[183.541589] Subtest basic-plain-flip: SUCCESS (6.002s)
[184.829978] [107/160] (822s left) kms_force_connector_basic (force-connector-state)
[184.936083] Starting subtest: force-connector-state
[185.520759] Subtest force-connector-state: SUCCESS (0.584s)
[186.607209] [108/160] (820s left) kms_force_connector_basic (force-edid)
[186.710639] Starting subtest: force-edid
[186.972142] Subtest force-edid: SUCCESS (0.263s)
[187.124591] [109/160] (820s left) kms_force_connector_basic (force-load-detect)
[187.225513] Starting subtest: force-load-detect
[187.227763] Subtest force-load-detect: SKIP (0.000s)
[187.351584] [110/160] (820s left) kms_force_connector_basic (prune-stale-modes)
[187.465622] Starting subtest: prune-stale-modes
[187.787431] Subtest prune-stale-modes: SUCCESS (0.320s)
[187.918337] [111/160] (819s left) kms_frontbuffer_tracking (basic)
[188.052983] Starting subtest: basic
[191.753942] Subtest basic: SUCCESS (3.700s)
[191.880754] [112/160] (815s left) kms_hdmi_inject (inject-audio)
[192.310180] Starting subtest: inject-audio
[192.559789] Subtest inject-audio: SUCCESS (0.247s)
[193.246308] [113/160] (814s left) kms_pipe_crc_basic (compare-crc-sanitycheck-xr24)
[193.381385] Starting subtest: compare-crc-sanitycheck-xr24
[193.384552] Starting dynamic subtest: pipe-A-eDP-1
[194.075519] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.691s)
[194.095204] Starting dynamic subtest: pipe-B-eDP-1
[195.486339] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.409s)
[195.507391] Starting dynamic subtest: pipe-C-eDP-1
[196.889541] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.399s)
[196.890702] Subtest compare-crc-sanitycheck-xr24: SUCCESS (3.508s)
[197.822758] [114/160] (809s left) kms_pipe_crc_basic (compare-crc-sanitycheck-nv12)
[197.954660] Starting subtest: compare-crc-sanitycheck-nv12
[197.957501] Starting dynamic subtest: pipe-A-eDP-1
[198.886902] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.929s)
[198.907074] Starting dynamic subtest: pipe-B-eDP-1
[200.284381] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.391s)
[200.301765] Starting dynamic subtest: pipe-C-eDP-1
[201.732203] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.446s)
[201.733347] Subtest compare-crc-sanitycheck-nv12: SUCCESS (3.776s)
[202.689523] [115/160] (804s left) kms_pipe_crc_basic (hang-read-crc)
[202.824290] Starting subtest: hang-read-crc
[202.825524] Starting dynamic subtest: pipe-A-eDP-1
[205.240607] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.415s)
[205.258978] Starting dynamic subtest: pipe-B-eDP-1
[208.322415] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.077s)
[208.340800] Starting dynamic subtest: pipe-C-eDP-1
[211.314730] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.990s)
[211.316034] Subtest hang-read-crc: SUCCESS (8.492s)
[212.289556] [116/160] (795s left) kms_pipe_crc_basic (nonblocking-crc)
[212.422912] Starting subtest: nonblocking-crc
[212.426042] Starting dynamic subtest: pipe-A-eDP-1
[213.317371] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.892s)
[213.335893] Starting dynamic subtest: pipe-B-eDP-1
[214.936924] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.616s)
[214.955866] Starting dynamic subtest: pipe-C-eDP-1
[216.500460] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.559s)
[216.501615] Subtest nonblocking-crc: SUCCESS (4.078s)
[217.474150] [117/160] (790s left) kms_pipe_crc_basic (nonblocking-crc-frame-sequence)
[217.608369] Starting subtest: nonblocking-crc-frame-sequence
[217.609524] Starting dynamic subtest: pipe-A-eDP-1
[218.502034] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.892s)
[218.520831] Starting dynamic subtest: pipe-B-eDP-1
[220.119399] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.612s)
[220.137746] Starting dynamic subtest: pipe-C-eDP-1
[221.667234] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.546s)
[221.668424] Subtest nonblocking-crc-frame-sequence: SUCCESS (4.061s)
[222.592701] [118/160] (785s left) kms_pipe_crc_basic (read-crc)
[222.720013] Starting subtest: read-crc
[222.723113] Starting dynamic subtest: pipe-A-eDP-1
[223.554681] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.831s)
[223.573370] Starting dynamic subtest: pipe-B-eDP-1
[225.105519] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.547s)
[225.124149] Starting dynamic subtest: pipe-C-eDP-1
[226.645362] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.535s)
[226.646651] Subtest read-crc: SUCCESS (3.925s)
[227.587487] [119/160] (780s left) kms_pipe_crc_basic (read-crc-frame-sequence)
[227.715883] Starting subtest: read-crc-frame-sequence
[227.719296] Starting dynamic subtest: pipe-A-eDP-1
[228.549199] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.830s)
[228.566367] Starting dynamic subtest: pipe-B-eDP-1
[230.082617] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.530s)
[230.101220] Starting dynamic subtest: pipe-C-eDP-1
[231.582027] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.495s)
[231.583392] Subtest read-crc-frame-sequence: SUCCESS (3.866s)
[232.513418] [120/160] (775s left) kms_pm_backlight (basic-brightness)
[232.643493] Starting subtest: basic-brightness
[232.739455] Starting dynamic subtest: eDP-1
[233.307941] Dynamic subtest eDP-1: SUCCESS (0.568s)
[233.309430] Subtest basic-brightness: SUCCESS (0.665s)
[234.239979] [121/160] (773s left) kms_pm_rpm (basic-pci-d3-state)
[236.077775] Starting subtest: basic-pci-d3-state
[240.476213] Subtest basic-pci-d3-state: SUCCESS (4.399s)
[240.679495] [122/160] (767s left) kms_pm_rpm (basic-rte)
[240.769732] Starting subtest: basic-rte
[246.936845] Subtest basic-rte: SUCCESS (6.168s)
[248.449943] [123/160] (759s left) kms_psr (psr-primary-page-flip)
[248.581654] Starting subtest: psr-primary-page-flip
[248.582925] Starting dynamic subtest: eDP-1
[252.370105] Dynamic subtest eDP-1: SUCCESS (3.788s)
[252.374073] Subtest psr-primary-page-flip: SUCCESS (3.790s)
[253.313248] [124/160] (754s left) kms_psr (psr-cursor-plane-move)
[253.441954] Starting subtest: psr-cursor-plane-move
[253.443336] Starting dynamic subtest: eDP-1
[257.229464] Dynamic subtest eDP-1: SUCCESS (3.786s)
[257.233692] Subtest psr-cursor-plane-move: SUCCESS (3.789s)
[258.177039] [125/160] (749s left) kms_psr (psr-sprite-plane-onoff)
[258.310208] Starting subtest: psr-sprite-plane-onoff
[258.311801] Starting dynamic subtest: eDP-1
[262.161557] Dynamic subtest eDP-1: SUCCESS (3.851s)
[262.162757] Subtest psr-sprite-plane-onoff: SUCCESS (3.854s)
[263.106564] [126/160] (744s left) kms_psr (psr-primary-mmap-gtt)
[263.248410] Starting subtest: psr-primary-mmap-gtt
[263.249642] Starting dynamic subtest: eDP-1
[267.083855] Dynamic subtest eDP-1: SUCCESS (3.834s)
[267.088115] Subtest psr-primary-mmap-gtt: SUCCESS (3.837s)
[268.028204] [127/160] (739s left) kms_setmode (basic-clone-single-crtc)
[268.130422] Starting subtest: basic-clone-single-crtc
[268.133587] Subtest basic-clone-single-crtc: SKIP (0.000s)
[268.227169] [128/160] (739s left) i915_pm_rps (basic-api)
[268.337671] Starting subtest: basic-api
[268.342786] Subtest basic-api: SUCCESS (0.005s)
[268.445919] [129/160] (739s left) prime_self_import (basic-llseek-bad)
[268.538411] Starting subtest: basic-llseek-bad
[268.543391] Subtest basic-llseek-bad: SUCCESS (0.009s)
[268.644937] [130/160] (739s left) prime_self_import (basic-llseek-size)
[268.734092] Starting subtest: basic-llseek-size
[268.747878] Subtest basic-llseek-size: SUCCESS (0.014s)
[268.845217] [131/160] (739s left) prime_self_import (basic-with_fd_dup)
[268.933711] Starting subtest: basic-with_fd_dup
[268.950578] Subtest basic-with_fd_dup: SUCCESS (0.017s)
[269.061290] [132/160] (739s left) prime_self_import (basic-with_one_bo)
[269.149606] Starting subtest: basic-with_one_bo
[269.170498] Subtest basic-with_one_bo: SUCCESS (0.021s)
[269.290094] [133/160] (738s left) prime_self_import (basic-with_one_bo_two_files)
[269.381629] Starting subtest: basic-with_one_bo_two_files
[269.395485] Subtest basic-with_one_bo_two_files: SUCCESS (0.017s)
[269.496989] [134/160] (738s left) prime_self_import (basic-with_two_bos)
[269.584403] Starting subtest: basic-with_two_bos
[269.607488] Subtest basic-with_two_bos: SUCCESS (0.023s)
[269.710363] [135/160] (738s left) prime_vgem (basic-fence-flip)
[269.839809] Starting subtest: basic-fence-flip
[270.385528] Subtest basic-fence-flip: SUCCESS (0.546s)
[270.515699] [136/160] (737s left) prime_vgem (basic-fence-mmap)
[270.636850] Starting subtest: basic-fence-mmap
[270.686472] Subtest basic-fence-mmap: SUCCESS (0.049s)
[270.781308] [137/160] (737s left) prime_vgem (basic-fence-read)
[270.910237] Starting subtest: basic-fence-read
[271.012334] Subtest basic-fence-read: SUCCESS (0.099s)
[271.099279] [138/160] (737s left) prime_vgem (basic-gtt)
[271.223834] Starting subtest: basic-gtt
[271.248927] Subtest basic-gtt: SUCCESS (0.025s)
[271.347364] [139/160] (736s left) prime_vgem (basic-read)
[271.473752] Starting subtest: basic-read
[271.522758] Subtest basic-read: SUCCESS (0.049s)
[271.649906] [140/160] (736s left) prime_vgem (basic-write)
[271.786600] Starting subtest: basic-write
[271.851375] Subtest basic-write: SUCCESS (0.066s)
[271.947971] [141/160] (736s left) vgem_basic (setversion)
[272.055456] Starting subtest: setversion
[272.057583] Subtest setversion: SUCCESS (0.000s)
[272.126817] [142/160] (736s left) vgem_basic (create)
[272.221791] Starting subtest: create
[272.223066] Subtest create: SUCCESS (0.000s)
[272.298833] [143/160] (736s left) vgem_basic (debugfs)
[272.406192] Starting subtest: debugfs
[272.407469] Subtest debugfs: SUCCESS (0.001s)
[272.481392] [144/160] (736s left) vgem_basic (dmabuf-export)
[272.589249] Starting subtest: dmabuf-export
[272.605439] Subtest dmabuf-export: SUCCESS (0.015s)
[272.717550] [145/160] (735s left) vgem_basic (dmabuf-fence)
[272.823029] Starting subtest: dmabuf-fence
[272.824316] Subtest dmabuf-fence: SUCCESS (0.001s)
[272.897629] [146/160] (735s left) vgem_basic (dmabuf-fence-before)
[272.989549] Starting subtest: dmabuf-fence-before
[272.990688] Subtest dmabuf-fence-before: SUCCESS (0.001s)
[273.061968] [147/160] (735s left) vgem_basic (dmabuf-mmap)
[273.155818] Starting subtest: dmabuf-mmap
[273.181674] Subtest dmabuf-mmap: SUCCESS (0.026s)
[273.245091] [148/160] (735s left) vgem_basic (mmap)
[273.339795] Starting subtest: mmap
[273.358753] Subtest mmap: SUCCESS (0.017s)
[273.429185] [149/160] (735s left) vgem_basic (second-client)
[273.522824] Starting subtest: second-client
[273.558718] Subtest second-client: SUCCESS (0.034s)
[273.633736] [150/160] (735s left) vgem_basic (sysfs)
[273.740671] Starting subtest: sysfs
[273.742042] Subtest sysfs: SUCCESS (0.001s)
[273.816168] [151/160] (734s left) core_hotunplug (unbind-rebind)
[273.956712] Starting subtest: unbind-rebind
[280.015330] Subtest unbind-rebind: SUCCESS (6.058s)
[280.050844] [152/160] (728s left) vgem_basic (unload)
[280.144747] Starting subtest: unload
[309.192663] Subtest unload: SUCCESS (29.013s)
[309.307271] [153/160] (699s left) i915_module_load (reload)
[309.396500] Starting subtest: reload
[314.365614] Subtest reload: SUCCESS (4.969s)
[314.395381] [154/160] (694s left) gem_lmem_swapping (basic)
[314.507654] Subtest basic: SKIP (0.000s)
[314.549700] [155/160] (694s left) gem_lmem_swapping (parallel-random-engines)
[314.647546] Subtest parallel-random-engines: SKIP (0.000s)
[314.700288] [156/160] (694s left) gem_lmem_swapping (random-engines)
[314.798360] Subtest random-engines: SKIP (0.000s)
[314.850342] [157/160] (694s left) gem_lmem_swapping (verify-random)
[314.945653] Subtest verify-random: SKIP (0.000s)
[315.007933] [158/160] (693s left) i915_pm_rpm (module-reload)
[327.472338] Starting subtest: module-reload
[359.929187] Subtest module-reload: SUCCESS (32.453s)
[359.952483] [159/160] (648s left) i915_selftest (live)
[360.053168] Starting subtest: live
[360.054508] Starting dynamic subtest: sanitycheck
[363.483684] Dynamic subtest sanitycheck: SUCCESS (3.421s)
[363.494331] Starting dynamic subtest: uncore
[366.933577] Dynamic subtest uncore: SUCCESS (3.446s)
[366.944254] Starting dynamic subtest: workarounds
[370.649314] Dynamic subtest workarounds: SUCCESS (3.712s)
[370.659897] Starting dynamic subtest: gt_engines
[374.542050] Dynamic subtest gt_engines: SUCCESS (3.889s)
[374.553403] Starting dynamic subtest: gt_timelines
[390.152688] Dynamic subtest gt_timelines: SUCCESS (15.607s)
[390.163280] Starting dynamic subtest: gt_contexts
[393.693644] Dynamic subtest gt_contexts: SUCCESS (3.537s)
[393.704332] Starting dynamic subtest: gt_lrc
[399.143274] Dynamic subtest gt_lrc: SUCCESS (5.446s)
[399.154377] Starting dynamic subtest: gt_mocs
[402.718624] Dynamic subtest gt_mocs: SUCCESS (3.572s)
[402.729169] Starting dynamic subtest: gt_pm
[409.438433] Dynamic subtest gt_pm: SUCCESS (6.716s)
[409.449093] Starting dynamic subtest: gt_heartbeat
[413.018594] Dynamic subtest gt_heartbeat: SUCCESS (3.577s)
[413.029399] Starting dynamic subtest: gt_tlb
[417.592075] Dynamic subtest gt_tlb: SUCCESS (4.570s)
[417.603224] Starting dynamic subtest: requests
[426.872653] Dynamic subtest requests: SUCCESS (9.277s)
[426.883614] Starting dynamic subtest: migrate
[432.734473] Dynamic subtest migrate: SUCCESS (5.858s)
[432.745264] Starting dynamic subtest: active
[436.209470] Dynamic subtest active: SUCCESS (3.476s)
[436.221471] Starting dynamic subtest: objects
[440.940605] Dynamic subtest objects: SUCCESS (4.722s)
[440.951417] Starting dynamic subtest: mman
[449.523444] Dynamic subtest mman: SUCCESS (8.579s)
[449.534194] Starting dynamic subtest: dmabuf
[453.003463] Dynamic subtest dmabuf: SUCCESS (3.477s)
[453.014322] Starting dynamic subtest: vma
[456.477517] Dynamic subtest vma: SUCCESS (3.470s)
[456.488213] Starting dynamic subtest: coherency
[462.852442] Dynamic subtest coherency: SUCCESS (6.372s)
[462.863206] Starting dynamic subtest: gtt
[473.632708] Dynamic subtest gtt: SUCCESS (10.777s)
[473.643539] Starting dynamic subtest: gem
[477.213327] Dynamic subtest gem: SUCCESS (3.577s)
[477.224068] Starting dynamic subtest: evict
[482.362398] Dynamic subtest evict: SUCCESS (5.146s)
[482.373255] Starting dynamic subtest: hugepages
[491.714726] Dynamic subtest hugepages: SUCCESS (9.349s)
[491.726041] Starting dynamic subtest: gem_contexts
[510.189908] Dynamic subtest gem_contexts: SUCCESS (18.469s)
[510.201480] Starting dynamic subtest: client
[513.705528] Dynamic subtest client: SUCCESS (3.515s)
[513.716865] Starting dynamic subtest: gem_migrate
[517.160479] Dynamic subtest gem_migrate: SUCCESS (3.451s)
[517.171498] Starting dynamic subtest: reset
[524.123661] Dynamic subtest reset: SUCCESS (6.960s)
[524.135296] Starting dynamic subtest: memory_region
[527.590524] Dynamic subtest memory_region: SUCCESS (3.463s)
[527.601548] Starting dynamic subtest: hangcheck
[553.646048] Dynamic subtest hangcheck: SUCCESS (26.052s)
[553.657060] Starting dynamic subtest: execlists
[565.882635] Dynamic subtest execlists: SUCCESS (12.233s)
[565.893709] Starting dynamic subtest: ring_submission
[569.370663] Dynamic subtest ring_submission: SUCCESS (3.485s)
[569.381771] Starting dynamic subtest: perf
[572.958684] Dynamic subtest perf: SUCCESS (3.584s)
[572.969863] Starting dynamic subtest: slpc
[576.410643] Dynamic subtest slpc: SUCCESS (3.449s)
[576.421778] Starting dynamic subtest: guc
[579.891709] Dynamic subtest guc: SUCCESS (3.477s)
[579.903236] Starting dynamic subtest: guc_multi_lrc
[583.312587] Dynamic subtest guc_multi_lrc: SUCCESS (3.417s)
[583.323683] Starting dynamic subtest: guc_hang
[586.798413] Dynamic subtest guc_hang: SUCCESS (3.483s)
[586.809615] Starting dynamic subtest: late_gt_pm
[590.245434] Dynamic subtest late_gt_pm: SUCCESS (3.444s)
[590.246624] Subtest live: SUCCESS (230.185s)
[590.272098] [160/160] (418s left) dmabuf (all-tests)
[590.367051] Starting subtest: all-tests
[590.368764] Starting dynamic subtest: sanitycheck
[590.432469] Dynamic subtest sanitycheck: SUCCESS (0.063s)
[590.451069] Starting dynamic subtest: dma_fence
[590.614070] Dynamic subtest dma_fence: SUCCESS (0.178s)
[590.631487] Starting dynamic subtest: dma_fence_chain
[608.788116] Dynamic subtest dma_fence_chain: SUCCESS (18.162s)
[608.800594] Starting dynamic subtest: dma_fence_unwrap
[608.848574] Dynamic subtest dma_fence_unwrap: SUCCESS (0.065s)
[608.868036] Starting dynamic subtest: dma_resv
[608.926653] Dynamic subtest dma_resv: SUCCESS (0.074s)
[608.928815] Subtest all-tests: SUCCESS (18.561s)
[608.957614] Closing watchdogs
Done.