[45.474422] Initializing watchdogs
[45.474564]   /dev/watchdog0
[45.485234] [001/164] (960s left) i915_module_load (load)
[45.589485] Starting subtest: load
[48.240483] Subtest load: SUCCESS (2.651s)
[48.266276] [002/164] (957s left) core_auth (basic-auth)
[48.368661] Starting subtest: basic-auth
[48.369894] Subtest basic-auth: SUCCESS (0.001s)
[48.443428] [003/164] (957s left) debugfs_test (read_all_entries)
[48.545182] Starting subtest: read_all_entries
[48.625835] Subtest read_all_entries: SUCCESS (0.081s)
[48.749621] [004/164] (957s left) debugfs_test (basic-hwmon)
[48.849397] Starting subtest: basic-hwmon
[48.851874] Subtest basic-hwmon: SKIP (0.000s)
[48.955860] [005/164] (957s left) fbdev (eof)
[49.060221] Starting subtest: eof
[49.062140] Subtest eof: SUCCESS (0.001s)
[49.135987] [006/164] (956s left) fbdev (info)
[49.255913] Starting subtest: info
[49.257077] Subtest info: SUCCESS (0.000s)
[49.322470] [007/164] (956s left) fbdev (nullptr)
[49.441229] Starting subtest: nullptr
[49.442404] Subtest nullptr: SUCCESS (0.000s)
[49.509188] [008/164] (956s left) fbdev (read)
[49.609523] Starting subtest: read
[56.688918] Subtest read: SUCCESS (7.071s)
[56.750155] [009/164] (949s left) fbdev (write)
[56.848889] Starting subtest: write
[60.633654] Subtest write: SUCCESS (3.749s)
[60.670217] [010/164] (945s left) gem_basic (bad-close)
[60.763495] Starting subtest: bad-close
[60.765643] Subtest bad-close: SUCCESS (0.000s)
[60.862103] [011/164] (945s left) gem_basic (create-close)
[60.953398] Starting subtest: create-close
[60.955333] Subtest create-close: SUCCESS (0.000s)
[61.057347] [012/164] (945s left) gem_basic (create-fd-close)
[61.152434] Starting subtest: create-fd-close
[61.154389] Subtest create-fd-close: SUCCESS (0.000s)
[61.260479] [013/164] (945s left) gem_busy (busy@all-engines)
[61.370928] Starting subtest: busy
[61.372141] Starting dynamic subtest: all-engines
[61.445492] Dynamic subtest all-engines: SUCCESS (0.074s)
[61.446586] Subtest busy: SUCCESS (0.075s)
[61.843580] [014/164] (944s left) gem_close_race (basic-process)
[61.957662] Starting subtest: basic-process
[62.038360] Subtest basic-process: SUCCESS (0.080s)
[62.244697] [015/164] (944s left) gem_close_race (basic-threads)
[62.356209] Starting subtest: basic-threads
[63.543220] Subtest basic-threads: SUCCESS (1.187s)
[63.781898] [016/164] (942s left) gem_ctx_create (basic)
[63.892958] Starting subtest: basic
[63.894055] Subtest basic: SUCCESS (0.000s)
[64.097184] [017/164] (942s left) gem_ctx_create (basic-files)
[64.204261] Starting subtest: basic-files
[66.231351] Subtest basic-files: SUCCESS (2.027s)
[66.462891] [018/164] (939s left) gem_ctx_exec (basic)
[66.558697] Starting subtest: basic
[66.563837] Subtest basic: SUCCESS (0.005s)
[66.697193] [019/164] (939s left) gem_exec_basic (basic)
[66.802325] Starting subtest: basic
[66.803495] Starting dynamic subtest: rcs0-smem
[66.804652] Dynamic subtest rcs0-smem: SUCCESS (0.002s)
[66.816014] Starting dynamic subtest: bcs0-smem
[66.817376] Dynamic subtest bcs0-smem: SUCCESS (0.001s)
[66.827929] Starting dynamic subtest: vcs0-smem
[66.829243] Dynamic subtest vcs0-smem: SUCCESS (0.001s)
[66.839767] Starting dynamic subtest: vecs0-smem
[66.840927] Dynamic subtest vecs0-smem: SUCCESS (0.001s)
[66.842190] Subtest basic: SUCCESS (0.005s)
[67.015696] [020/164] (939s left) gem_exec_create (basic)
[67.125770] Starting subtest: basic
[67.127258] Starting dynamic subtest: smem
[69.165499] Dynamic subtest smem: SUCCESS (2.042s)
[69.166518] Subtest basic: SUCCESS (2.042s)
[69.410800] [021/164] (937s left) gem_exec_fence (basic-busy)
[69.669979] Starting subtest: basic-busy
[69.671447] Starting dynamic subtest: rcs0
[69.686679] Dynamic subtest rcs0: SUCCESS (0.025s)
[69.699823] Starting dynamic subtest: bcs0
[69.707342] Dynamic subtest bcs0: SUCCESS (0.021s)
[69.718929] Starting dynamic subtest: vcs0
[69.741682] Dynamic subtest vcs0: SUCCESS (0.034s)
[69.757382] Starting dynamic subtest: vecs0
[69.764980] Dynamic subtest vecs0: SUCCESS (0.023s)
[69.766711] Subtest basic-busy: SUCCESS (0.103s)
[70.387848] [022/164] (936s left) gem_exec_fence (basic-wait)
[70.642445] Starting subtest: basic-wait
[70.643645] Starting dynamic subtest: rcs0
[70.663675] Dynamic subtest rcs0: SUCCESS (0.029s)
[70.678174] Starting dynamic subtest: bcs0
[70.687978] Dynamic subtest bcs0: SUCCESS (0.024s)
[70.700501] Starting dynamic subtest: vcs0
[70.709325] Dynamic subtest vcs0: SUCCESS (0.021s)
[70.721241] Starting dynamic subtest: vecs0
[70.751270] Dynamic subtest vecs0: SUCCESS (0.041s)
[70.753034] Subtest basic-wait: SUCCESS (0.117s)
[71.320129] [023/164] (935s left) gem_exec_fence (basic-await)
[71.578149] Starting subtest: basic-await
[71.579284] Starting dynamic subtest: rcs0
[71.673608] Dynamic subtest rcs0: SUCCESS (0.102s)
[71.699637] Starting dynamic subtest: bcs0
[71.816625] Dynamic subtest bcs0: SUCCESS (0.134s)
[71.843059] Starting dynamic subtest: vcs0
[71.942562] Dynamic subtest vcs0: SUCCESS (0.133s)
[71.970205] Starting dynamic subtest: vecs0
[72.076322] Dynamic subtest vecs0: SUCCESS (0.132s)
[72.078367] Subtest basic-await: SUCCESS (0.504s)
[72.654095] [024/164] (933s left) gem_exec_fence (nb-await)
[72.911421] Starting subtest: nb-await
[72.912529] Starting dynamic subtest: rcs0
[72.970312] Dynamic subtest rcs0: SUCCESS (0.066s)
[72.988185] Starting dynamic subtest: bcs0
[73.038994] Dynamic subtest bcs0: SUCCESS (0.068s)
[73.058636] Starting dynamic subtest: vcs0
[73.108621] Dynamic subtest vcs0: SUCCESS (0.069s)
[73.136287] Starting dynamic subtest: vecs0
[73.185252] Dynamic subtest vecs0: SUCCESS (0.075s)
[73.187301] Subtest nb-await: SUCCESS (0.281s)
[73.724479] [025/164] (932s left) gem_exec_gttfill (basic)
[73.835844] Starting subtest: basic
[80.015572] Subtest basic: SUCCESS (6.171s)
[80.212787] [026/164] (926s left) gem_exec_parallel (engines)
[80.396454] Starting subtest: engines
[80.397794] Starting dynamic subtest: basic
[82.949651] Dynamic subtest basic: SUCCESS (2.531s)
[82.963117] Starting dynamic subtest: contexts
[88.447855] Dynamic subtest contexts: SUCCESS (5.512s)
[88.462222] Starting dynamic subtest: fds
[98.450904] Dynamic subtest fds: SUCCESS (10.012s)
[98.467847] Starting dynamic subtest: userptr
[100.856040] Dynamic subtest userptr: SUCCESS (2.380s)
[100.857937] Subtest engines: SUCCESS (20.435s)
[101.105985] [027/164] (905s left) gem_exec_store (basic)
[101.214367] Starting subtest: basic
[101.275763] Subtest basic: SUCCESS (0.061s)
[101.487077] [028/164] (905s left) gem_flink_basic (bad-flink)
[101.580396] Starting subtest: bad-flink
[101.581512] Subtest bad-flink: SUCCESS (0.000s)
[101.670961] [029/164] (905s left) gem_flink_basic (bad-open)
[101.761702] Starting subtest: bad-open
[101.762832] Subtest bad-open: SUCCESS (0.000s)
[101.852264] [030/164] (904s left) gem_flink_basic (basic)
[101.944421] Starting subtest: basic
[101.945557] Subtest basic: SUCCESS (0.000s)
[102.054989] [031/164] (904s left) gem_flink_basic (double-flink)
[102.146356] Starting subtest: double-flink
[102.147489] Subtest double-flink: SUCCESS (0.000s)
[102.253473] [032/164] (904s left) gem_flink_basic (flink-lifetime)
[102.346326] Starting subtest: flink-lifetime
[102.348811] Subtest flink-lifetime: SUCCESS (0.002s)
[102.454486] [033/164] (904s left) gem_huc_copy (huc-copy)
[102.552844] Starting subtest: huc-copy
[102.555153] Subtest huc-copy: SKIP (0.000s)
[102.670739] [034/164] (904s left) gem_linear_blits (basic)
[102.938508] Starting subtest: basic
[102.952708] Subtest basic: SUCCESS (0.014s)
[103.089944] [035/164] (903s left) gem_mmap (basic)
[103.249961] Starting subtest: basic
[103.255224] Subtest basic: SUCCESS (0.001s)
[103.335181] [036/164] (903s left) gem_mmap_gtt (basic)
[103.427496] Starting subtest: basic
[103.428611] Subtest basic: SUCCESS (0.001s)
[103.514289] [037/164] (903s left) gem_render_linear_blits (basic)
[103.610742] Starting subtest: basic
[103.663266] Subtest basic: SUCCESS (0.051s)
[103.731863] [038/164] (903s left) gem_render_tiled_blits (basic)
[103.829000] Starting subtest: basic
[103.889370] Subtest basic: SUCCESS (0.060s)
[103.967296] [039/164] (903s left) gem_ringfill (basic-all)
[104.217981] Starting subtest: basic-all
[105.464147] Subtest basic-all: SUCCESS (1.237s)
[105.558834] [040/164] (901s left) gem_softpin (allocator-basic)
[105.658497] Starting subtest: allocator-basic
[105.836959] Subtest allocator-basic: SUCCESS (0.170s)
[105.957321] [041/164] (901s left) gem_softpin (allocator-basic-reserve)
[106.053956] Starting subtest: allocator-basic-reserve
[106.233831] Subtest allocator-basic-reserve: SUCCESS (0.171s)
[106.342104] [042/164] (900s left) gem_softpin (safe-alignment)
[106.440817] Starting subtest: safe-alignment
[106.460268] Subtest safe-alignment: SUCCESS (0.019s)
[106.594634] [043/164] (900s left) gem_sync (basic-all)
[106.706097] Starting subtest: basic-all
[109.015033] Subtest basic-all: SUCCESS (2.287s)
[109.211617] [044/164] (897s left) gem_sync (basic-each)
[109.321123] Starting subtest: basic-each
[111.591200] Subtest basic-each: SUCCESS (2.267s)
[111.843338] [045/164] (895s left) gem_tiled_blits (basic)
[112.086305] Starting subtest: basic
[112.114394] Subtest basic: SUCCESS (0.029s)
[112.267848] [046/164] (895s left) gem_tiled_fence_blits (basic)
[112.589402] Starting subtest: basic
[112.617419] Subtest basic: SUCCESS (0.028s)
[112.750185] [047/164] (894s left) gem_tiled_pread_basic
[113.266767] [048/164] (894s left) gem_wait (busy@all-engines)
[113.384100] Starting subtest: busy
[113.385382] Starting dynamic subtest: all-engines
[113.918156] Dynamic subtest all-engines: SUCCESS (0.534s)
[113.919387] Subtest busy: SUCCESS (0.534s)
[114.167299] [049/164] (893s left) gem_wait (wait@all-engines)
[114.284917] Starting subtest: wait
[114.286171] Starting dynamic subtest: all-engines
[115.319354] Dynamic subtest all-engines: SUCCESS (1.034s)
[115.320887] Subtest wait: SUCCESS (1.034s)
[115.568564] [050/164] (891s left) i915_getparams_basic (basic-eu-total)
[115.661387] Starting subtest: basic-eu-total
[115.663553] Subtest basic-eu-total: SUCCESS (0.000s)
[115.749592] [051/164] (891s left) i915_getparams_basic (basic-subslice-total)
[115.841218] Starting subtest: basic-subslice-total
[115.843540] Subtest basic-subslice-total: SUCCESS (0.000s)
[115.935674] [052/164] (891s left) i915_hangman (error-state-basic)
[116.042358] Starting subtest: error-state-basic
[116.054935] Subtest error-state-basic: SUCCESS (0.013s)
[116.150970] [053/164] (891s left) i915_pciid
[116.336131] [054/164] (891s left) kms_addfb_basic (addfb25-4-tiled)
[116.467724] Starting subtest: addfb25-4-tiled
[116.468947] Subtest addfb25-4-tiled: SUCCESS (0.000s)
[116.571203] [055/164] (890s left) kms_addfb_basic (addfb25-bad-modifier)
[116.665088] Starting subtest: addfb25-bad-modifier
[116.666128] Subtest addfb25-bad-modifier: SUCCESS (0.000s)
[116.803851] [056/164] (890s left) kms_addfb_basic (addfb25-framebuffer-vs-set-tiling)
[116.898495] Starting subtest: addfb25-framebuffer-vs-set-tiling
[116.899585] Subtest addfb25-framebuffer-vs-set-tiling: SUCCESS (0.000s)
[117.038231] [057/164] (890s left) kms_addfb_basic (addfb25-modifier-no-flag)
[117.129507] Starting subtest: addfb25-modifier-no-flag
[117.130601] Subtest addfb25-modifier-no-flag: SUCCESS (0.000s)
[117.252843] [058/164] (890s left) kms_addfb_basic (addfb25-x-tiled-legacy)
[117.347846] Starting subtest: addfb25-x-tiled-legacy
[117.349130] Subtest addfb25-x-tiled-legacy: SUCCESS (0.000s)
[117.472247] [059/164] (890s left) kms_addfb_basic (addfb25-x-tiled-mismatch-legacy)
[117.563673] Starting subtest: addfb25-x-tiled-mismatch-legacy
[117.564861] Subtest addfb25-x-tiled-mismatch-legacy: SUCCESS (0.000s)
[117.704290] [060/164] (889s left) kms_addfb_basic (addfb25-yf-tiled-legacy)
[117.827746] Starting subtest: addfb25-yf-tiled-legacy
[117.828825] Subtest addfb25-yf-tiled-legacy: SUCCESS (0.000s)
[117.921435] [061/164] (889s left) kms_addfb_basic (addfb25-y-tiled-legacy)
[118.041090] Starting subtest: addfb25-y-tiled-legacy
[118.042221] Subtest addfb25-y-tiled-legacy: SUCCESS (0.000s)
[118.137372] [062/164] (889s left) kms_addfb_basic (addfb25-y-tiled-small-legacy)
[118.260415] Starting subtest: addfb25-y-tiled-small-legacy
[118.261577] Subtest addfb25-y-tiled-small-legacy: SUCCESS (0.000s)
[118.352921] [063/164] (889s left) kms_addfb_basic (bad-pitch-0)
[118.446302] Starting subtest: bad-pitch-0
[118.447501] Subtest bad-pitch-0: SUCCESS (0.000s)
[118.589367] [064/164] (889s left) kms_addfb_basic (bad-pitch-1024)
[118.682773] Starting subtest: bad-pitch-1024
[118.683980] Subtest bad-pitch-1024: SUCCESS (0.000s)
[118.822682] [065/164] (888s left) kms_addfb_basic (bad-pitch-128)
[118.914217] Starting subtest: bad-pitch-128
[118.915424] Subtest bad-pitch-128: SUCCESS (0.000s)
[119.056069] [066/164] (888s left) kms_addfb_basic (bad-pitch-256)
[119.148584] Starting subtest: bad-pitch-256
[119.149685] Subtest bad-pitch-256: SUCCESS (0.000s)
[119.270234] [067/164] (888s left) kms_addfb_basic (bad-pitch-32)
[119.361462] Starting subtest: bad-pitch-32
[119.362596] Subtest bad-pitch-32: SUCCESS (0.000s)
[119.509889] [068/164] (888s left) kms_addfb_basic (bad-pitch-63)
[119.604074] Starting subtest: bad-pitch-63
[119.605224] Subtest bad-pitch-63: SUCCESS (0.000s)
[119.717593] [069/164] (888s left) kms_addfb_basic (bad-pitch-65536)
[119.810911] Starting subtest: bad-pitch-65536
[119.812122] Subtest bad-pitch-65536: SUCCESS (0.000s)
[119.933308] [070/164] (888s left) kms_addfb_basic (bad-pitch-999)
[120.026737] Starting subtest: bad-pitch-999
[120.027922] Subtest bad-pitch-999: SUCCESS (0.000s)
[120.157177] [071/164] (887s left) kms_addfb_basic (basic)
[120.252459] Starting subtest: basic
[120.254749] Subtest basic: SUCCESS (0.000s)
[120.372642] [072/164] (887s left) kms_addfb_basic (basic-x-tiled-legacy)
[120.468655] Starting subtest: basic-x-tiled-legacy
[120.469753] Subtest basic-x-tiled-legacy: SUCCESS (0.000s)
[120.608144] [073/164] (887s left) kms_addfb_basic (basic-y-tiled-legacy)
[120.700608] Starting subtest: basic-y-tiled-legacy
[120.701796] Subtest basic-y-tiled-legacy: SUCCESS (0.000s)
[120.842093] [074/164] (887s left) kms_addfb_basic (bo-too-small)
[120.963356] Starting subtest: bo-too-small
[120.964476] Subtest bo-too-small: SUCCESS (0.000s)
[121.073966] [075/164] (887s left) kms_addfb_basic (bo-too-small-due-to-tiling)
[121.195507] Starting subtest: bo-too-small-due-to-tiling
[121.196744] Subtest bo-too-small-due-to-tiling: SUCCESS (0.000s)
[121.290694] [076/164] (886s left) kms_addfb_basic (clobberred-modifier)
[121.383454] Starting subtest: clobberred-modifier
[121.384633] Subtest clobberred-modifier: SUCCESS (0.000s)
[121.507812] [077/164] (886s left) kms_addfb_basic (framebuffer-vs-set-tiling)
[121.599950] Starting subtest: framebuffer-vs-set-tiling
[121.601174] Subtest framebuffer-vs-set-tiling: SUCCESS (0.000s)
[121.724486] [078/164] (886s left) kms_addfb_basic (invalid-get-prop)
[121.816249] Starting subtest: invalid-get-prop
[121.817385] Subtest invalid-get-prop: SUCCESS (0.000s)
[121.935903] [079/164] (886s left) kms_addfb_basic (invalid-get-prop-any)
[122.025523] Starting subtest: invalid-get-prop-any
[122.026635] Subtest invalid-get-prop-any: SUCCESS (0.000s)
[122.159339] [080/164] (886s left) kms_addfb_basic (invalid-set-prop)
[122.252159] Starting subtest: invalid-set-prop
[122.253276] Subtest invalid-set-prop: SUCCESS (0.000s)
[122.393180] [081/164] (885s left) kms_addfb_basic (invalid-set-prop-any)
[122.485139] Starting subtest: invalid-set-prop-any
[122.486497] Subtest invalid-set-prop-any: SUCCESS (0.000s)
[122.625889] [082/164] (885s left) kms_addfb_basic (no-handle)
[122.717438] Starting subtest: no-handle
[122.718559] Subtest no-handle: SUCCESS (0.000s)
[122.842362] [083/164] (885s left) kms_addfb_basic (size-max)
[122.968465] Starting subtest: size-max
[122.969743] Subtest size-max: SUCCESS (0.000s)
[123.076303] [084/164] (885s left) kms_addfb_basic (small-bo)
[123.197138] Starting subtest: small-bo
[123.198309] Subtest small-bo: SUCCESS (0.000s)
[123.306906] [085/164] (885s left) kms_addfb_basic (tile-pitch-mismatch)
[123.401024] Starting subtest: tile-pitch-mismatch
[123.402091] Subtest tile-pitch-mismatch: SUCCESS (0.000s)
[123.524101] [086/164] (884s left) kms_addfb_basic (too-high)
[123.643340] Starting subtest: too-high
[123.644458] Subtest too-high: SUCCESS (0.001s)
[123.743282] [087/164] (884s left) kms_addfb_basic (too-wide)
[123.864023] Starting subtest: too-wide
[123.865147] Subtest too-wide: SUCCESS (0.000s)
[123.959761] [088/164] (884s left) kms_addfb_basic (unused-handle)
[124.051639] Starting subtest: unused-handle
[124.058021] Subtest unused-handle: SUCCESS (0.000s)
[124.196407] [089/164] (884s left) kms_addfb_basic (unused-modifier)
[124.288485] Starting subtest: unused-modifier
[124.289604] Subtest unused-modifier: SUCCESS (0.000s)
[124.428321] [090/164] (884s left) kms_addfb_basic (unused-offsets)
[124.522679] Starting subtest: unused-offsets
[124.523788] Subtest unused-offsets: SUCCESS (0.000s)
[124.662518] [091/164] (883s left) kms_addfb_basic (unused-pitches)
[124.754536] Starting subtest: unused-pitches
[124.755649] Subtest unused-pitches: SUCCESS (0.000s)
[124.894828] [092/164] (883s left) kms_busy (basic)
[125.020252] Starting subtest: basic
[125.021299] Starting dynamic subtest: flip
[126.025425] Dynamic subtest flip: SUCCESS (1.004s)
[126.042375] Starting dynamic subtest: modeset
[129.888065] Dynamic subtest modeset: SUCCESS (3.861s)
[129.889509] Subtest basic: SUCCESS (4.868s)
[130.812254] [093/164] (877s left) kms_prop_blob (basic)
[130.908661] Starting subtest: basic
[130.910060] Subtest basic: SUCCESS (0.000s)
[130.993443] [094/164] (877s left) kms_cursor_legacy (basic-busy-flip-before-cursor-atomic)
[131.115110] Starting subtest: basic-busy-flip-before-cursor-atomic
[131.117600] Subtest basic-busy-flip-before-cursor-atomic: SKIP (0.000s)
[131.206217] [095/164] (877s left) kms_cursor_legacy (basic-busy-flip-before-cursor-legacy)
[131.326574] Starting subtest: basic-busy-flip-before-cursor-legacy
[131.328838] Subtest basic-busy-flip-before-cursor-legacy: SKIP (0.000s)
[131.405119] [096/164] (877s left) kms_cursor_legacy (basic-flip-after-cursor-atomic)
[131.525107] Starting subtest: basic-flip-after-cursor-atomic
[132.787630] Subtest basic-flip-after-cursor-atomic: SUCCESS (1.262s)
[133.757595] [097/164] (874s left) kms_cursor_legacy (basic-flip-after-cursor-legacy)
[133.877826] Starting subtest: basic-flip-after-cursor-legacy
[135.182293] Subtest basic-flip-after-cursor-legacy: SUCCESS (1.304s)
[136.122804] [098/164] (872s left) kms_cursor_legacy (basic-flip-after-cursor-varying-size)
[136.242456] Starting subtest: basic-flip-after-cursor-varying-size
[137.550907] Subtest basic-flip-after-cursor-varying-size: SUCCESS (1.308s)
[138.491933] [099/164] (870s left) kms_cursor_legacy (basic-flip-before-cursor-atomic)
[138.614065] Starting subtest: basic-flip-before-cursor-atomic
[139.886843] Subtest basic-flip-before-cursor-atomic: SUCCESS (1.272s)
[140.859770] [100/164] (867s left) kms_cursor_legacy (basic-flip-before-cursor-legacy)
[140.979738] Starting subtest: basic-flip-before-cursor-legacy
[142.272205] Subtest basic-flip-before-cursor-legacy: SUCCESS (1.291s)
[143.228655] [101/164] (865s left) kms_cursor_legacy (basic-flip-before-cursor-varying-size)
[143.350063] Starting subtest: basic-flip-before-cursor-varying-size
[144.657137] Subtest basic-flip-before-cursor-varying-size: SUCCESS (1.306s)
[145.596107] [102/164] (863s left) kms_flip (basic-flip-vs-dpms)
[145.697132] Starting subtest: basic-flip-vs-dpms
[145.700408] Starting dynamic subtest: A-eDP1
[148.599078] Dynamic subtest A-eDP1: SUCCESS (2.894s)
[148.624224] Starting dynamic subtest: B-eDP1
[151.028034] Dynamic subtest B-eDP1: SUCCESS (2.428s)
[151.044767] Starting dynamic subtest: C-eDP1
[153.477474] Dynamic subtest C-eDP1: SUCCESS (2.452s)
[153.480978] Subtest basic-flip-vs-dpms: SUCCESS (7.784s)
[154.398273] [103/164] (854s left) kms_flip (basic-flip-vs-modeset)
[154.498490] Starting subtest: basic-flip-vs-modeset
[154.502135] Starting dynamic subtest: A-eDP1
[157.358351] Dynamic subtest A-eDP1: SUCCESS (2.855s)
[157.376358] Starting dynamic subtest: B-eDP1
[159.731482] Dynamic subtest B-eDP1: SUCCESS (2.371s)
[159.751589] Starting dynamic subtest: C-eDP1
[162.107171] Dynamic subtest C-eDP1: SUCCESS (2.371s)
[162.108564] Subtest basic-flip-vs-modeset: SUCCESS (7.610s)
[163.020310] [104/164] (845s left) kms_flip (basic-flip-vs-wf_vblank)
[163.123177] Starting subtest: basic-flip-vs-wf_vblank
[163.141869] Starting dynamic subtest: A-eDP1
[165.466086] Dynamic subtest A-eDP1: SUCCESS (2.338s)
[165.484388] Starting dynamic subtest: B-eDP1
[167.754648] Dynamic subtest B-eDP1: SUCCESS (2.286s)
[167.774165] Starting dynamic subtest: C-eDP1
[169.992876] Dynamic subtest C-eDP1: SUCCESS (2.236s)
[169.997799] Subtest basic-flip-vs-wf_vblank: SUCCESS (6.875s)
[171.321250] [105/164] (837s left) kms_flip (basic-plain-flip)
[171.422070] Starting subtest: basic-plain-flip
[171.425843] Starting dynamic subtest: A-eDP1
[173.501500] Dynamic subtest A-eDP1: SUCCESS (2.074s)
[173.522658] Starting dynamic subtest: B-eDP1
[175.468494] Dynamic subtest B-eDP1: SUCCESS (1.965s)
[175.488186] Starting dynamic subtest: C-eDP1
[177.452505] Dynamic subtest C-eDP1: SUCCESS (1.982s)
[177.456775] Subtest basic-plain-flip: SUCCESS (6.035s)
[178.746952] [106/164] (830s left) kms_force_connector_basic (force-connector-state)
[178.845806] Starting subtest: force-connector-state
[179.441998] Subtest force-connector-state: SUCCESS (0.595s)
[180.507736] [107/164] (828s left) kms_force_connector_basic (force-edid)
[180.604036] Starting subtest: force-edid
[180.864347] Subtest force-edid: SUCCESS (0.260s)
[180.986610] [108/164] (828s left) kms_force_connector_basic (force-load-detect)
[181.084827] Starting subtest: force-load-detect
[181.087181] Subtest force-load-detect: SKIP (0.000s)
[181.186864] [109/164] (827s left) kms_force_connector_basic (prune-stale-modes)
[181.283225] Starting subtest: prune-stale-modes
[181.599776] Subtest prune-stale-modes: SUCCESS (0.317s)
[181.720637] [110/164] (827s left) kms_frontbuffer_tracking (basic)
[181.853082] Starting subtest: basic
[185.205489] Subtest basic: SUCCESS (3.353s)
[185.346946] [111/164] (823s left) kms_hdmi_inject (inject-audio)
[185.759109] Starting subtest: inject-audio
[186.087047] Subtest inject-audio: SUCCESS (0.325s)
[186.693120] [112/164] (822s left) kms_pipe_crc_basic (compare-crc-sanitycheck-xr24)
[186.817207] Starting subtest: compare-crc-sanitycheck-xr24
[186.818303] Starting dynamic subtest: pipe-A-eDP-1
[187.510032] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.688s)
[187.529222] Starting dynamic subtest: pipe-B-eDP-1
[188.952870] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.441s)
[188.971160] Starting dynamic subtest: pipe-C-eDP-1
[190.327091] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.373s)
[190.328355] Subtest compare-crc-sanitycheck-xr24: SUCCESS (3.512s)
[191.292991] [113/164] (817s left) kms_pipe_crc_basic (compare-crc-sanitycheck-nv12)
[191.415761] Starting subtest: compare-crc-sanitycheck-nv12
[191.416910] Starting dynamic subtest: pipe-A-eDP-1
[192.366809] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.949s)
[192.388110] Starting dynamic subtest: pipe-B-eDP-1
[193.781719] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.411s)
[193.809721] Starting dynamic subtest: pipe-C-eDP-1
[195.175374] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.388s)
[195.176624] Subtest compare-crc-sanitycheck-nv12: SUCCESS (3.761s)
[196.090293] [114/164] (813s left) kms_pipe_crc_basic (hang-read-crc)
[196.211692] Starting subtest: hang-read-crc
[196.214539] Starting dynamic subtest: pipe-A-eDP-1
[198.583809] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.368s)
[198.601832] Starting dynamic subtest: pipe-B-eDP-1
[201.641051] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.054s)
[201.684098] Starting dynamic subtest: pipe-C-eDP-1
[204.670734] Dynamic subtest pipe-C-eDP-1: SUCCESS (3.022s)
[204.672129] Subtest hang-read-crc: SUCCESS (8.459s)
[205.627892] [115/164] (803s left) kms_pipe_crc_basic (nonblocking-crc)
[205.751101] Starting subtest: nonblocking-crc
[205.754192] Starting dynamic subtest: pipe-A-eDP-1
[206.653493] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.899s)
[206.672978] Starting dynamic subtest: pipe-B-eDP-1
[208.275035] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.615s)
[208.315130] Starting dynamic subtest: pipe-C-eDP-1
[209.834145] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.553s)
[209.835615] Subtest nonblocking-crc: SUCCESS (4.082s)
[210.750343] [116/164] (798s left) kms_pipe_crc_basic (nonblocking-crc-frame-sequence)
[210.873166] Starting subtest: nonblocking-crc-frame-sequence
[210.876106] Starting dynamic subtest: pipe-A-eDP-1
[211.777905] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.902s)
[211.803239] Starting dynamic subtest: pipe-B-eDP-1
[213.376215] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.591s)
[213.403863] Starting dynamic subtest: pipe-C-eDP-1
[214.925151] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.542s)
[214.927172] Subtest nonblocking-crc-frame-sequence: SUCCESS (4.053s)
[215.870987] [117/164] (793s left) kms_pipe_crc_basic (read-crc)
[215.996141] Starting subtest: read-crc
[215.997348] Starting dynamic subtest: pipe-A-eDP-1
[216.836166] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.835s)
[216.871489] Starting dynamic subtest: pipe-B-eDP-1
[218.344846] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.502s)
[218.380331] Starting dynamic subtest: pipe-C-eDP-1
[219.843841] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.492s)
[219.845913] Subtest read-crc: SUCCESS (3.849s)
[220.793073] [118/164] (788s left) kms_pipe_crc_basic (read-crc-frame-sequence)
[220.916583] Starting subtest: read-crc-frame-sequence
[220.919398] Starting dynamic subtest: pipe-A-eDP-1
[221.756852] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.838s)
[221.779927] Starting dynamic subtest: pipe-B-eDP-1
[223.290853] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.528s)
[223.312078] Starting dynamic subtest: pipe-C-eDP-1
[224.796380] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.497s)
[224.798142] Subtest read-crc-frame-sequence: SUCCESS (3.878s)
[225.724796] [119/164] (783s left) kms_pm_backlight (basic-brightness)
[225.848724] Starting subtest: basic-brightness
[225.952092] Starting dynamic subtest: eDP-1
[226.535222] Dynamic subtest eDP-1: SUCCESS (0.583s)
[226.536328] Subtest basic-brightness: SUCCESS (0.688s)
[227.452240] [120/164] (781s left) kms_psr (primary_page_flip)
[227.577486] Starting subtest: primary_page_flip
[231.476660] Subtest primary_page_flip: SUCCESS (3.893s)
[232.445856] [121/164] (777s left) kms_psr (cursor_plane_move)
[232.571643] Starting subtest: cursor_plane_move
[236.444396] Subtest cursor_plane_move: SUCCESS (3.868s)
[237.370734] [122/164] (772s left) kms_psr (sprite_plane_onoff)
[237.494714] Starting subtest: sprite_plane_onoff
[241.395269] Subtest sprite_plane_onoff: SUCCESS (3.900s)
[242.366019] [123/164] (767s left) kms_psr (primary_mmap_gtt)
[242.491362] Starting subtest: primary_mmap_gtt
[246.320676] Subtest primary_mmap_gtt: SUCCESS (3.829s)
[247.237322] [124/164] (762s left) kms_setmode (basic-clone-single-crtc)
[247.333698] Starting subtest: basic-clone-single-crtc
[247.336994] Subtest basic-clone-single-crtc: SKIP (0.000s)
[247.420604] [125/164] (762s left) i915_pm_rpm (basic-pci-d3-state)
[249.258892] Starting subtest: basic-pci-d3-state
[253.648337] Subtest basic-pci-d3-state: SUCCESS (4.392s)
[253.852879] [126/164] (755s left) i915_pm_rpm (basic-rte)
[253.945185] Starting subtest: basic-rte
[260.050041] Subtest basic-rte: SUCCESS (6.103s)
[265.437131] [127/164] (744s left) i915_pm_rps (basic-api)
[265.535152] Starting subtest: basic-api
[265.539411] Subtest basic-api: SUCCESS (0.004s)
[265.638656] [128/164] (744s left) prime_self_import (basic-llseek-bad)
[265.733365] Starting subtest: basic-llseek-bad
[265.735714] Subtest basic-llseek-bad: SUCCESS (0.003s)
[265.838637] [129/164] (743s left) prime_self_import (basic-llseek-size)
[265.928131] Starting subtest: basic-llseek-size
[265.933242] Subtest basic-llseek-size: SUCCESS (0.004s)
[266.039179] [130/164] (743s left) prime_self_import (basic-with_fd_dup)
[266.128263] Starting subtest: basic-with_fd_dup
[266.132889] Subtest basic-with_fd_dup: SUCCESS (0.005s)
[266.237862] [131/164] (743s left) prime_self_import (basic-with_one_bo)
[266.325986] Starting subtest: basic-with_one_bo
[266.330964] Subtest basic-with_one_bo: SUCCESS (0.005s)
[266.419122] [132/164] (743s left) prime_self_import (basic-with_one_bo_two_files)
[266.509262] Starting subtest: basic-with_one_bo_two_files
[266.514146] Subtest basic-with_one_bo_two_files: SUCCESS (0.004s)
[266.623160] [133/164] (743s left) prime_self_import (basic-with_two_bos)
[266.712993] Starting subtest: basic-with_two_bos
[266.717699] Subtest basic-with_two_bos: SUCCESS (0.005s)
[266.822422] [134/164] (743s left) prime_vgem (basic-fence-flip)
[266.949538] Starting subtest: basic-fence-flip
[267.496443] Subtest basic-fence-flip: SUCCESS (0.547s)
[267.625387] [135/164] (742s left) prime_vgem (basic-fence-mmap)
[267.741157] Starting subtest: basic-fence-mmap
[267.790803] Subtest basic-fence-mmap: SUCCESS (0.051s)
[267.892231] [136/164] (742s left) prime_vgem (basic-fence-read)
[268.006558] Starting subtest: basic-fence-read
[268.084551] Subtest basic-fence-read: SUCCESS (0.078s)
[268.176628] [137/164] (741s left) prime_vgem (basic-gtt)
[268.296636] Starting subtest: basic-gtt
[268.322284] Subtest basic-gtt: SUCCESS (0.025s)
[268.422923] [138/164] (741s left) prime_vgem (basic-read)
[268.540275] Starting subtest: basic-read
[268.578869] Subtest basic-read: SUCCESS (0.038s)
[268.692102] [139/164] (741s left) prime_vgem (basic-write)
[268.814894] Starting subtest: basic-write
[268.860031] Subtest basic-write: SUCCESS (0.045s)
[268.959899] [140/164] (741s left) vgem_basic (setversion)
[269.066202] Starting subtest: setversion
[269.068376] Subtest setversion: SUCCESS (0.000s)
[269.140597] [141/164] (740s left) vgem_basic (create)
[269.250785] Starting subtest: create
[269.252264] Subtest create: SUCCESS (0.001s)
[269.325769] [142/164] (740s left) vgem_basic (debugfs)
[269.432856] Starting subtest: debugfs
[269.434215] Subtest debugfs: SUCCESS (0.001s)
[269.507737] [143/164] (740s left) vgem_basic (dmabuf-export)
[269.616809] Starting subtest: dmabuf-export
[269.626513] Subtest dmabuf-export: SUCCESS (0.008s)
[269.726693] [144/164] (740s left) vgem_basic (dmabuf-fence)
[269.833900] Starting subtest: dmabuf-fence
[269.835150] Subtest dmabuf-fence: SUCCESS (0.001s)
[269.909763] [145/164] (740s left) vgem_basic (dmabuf-fence-before)
[270.017436] Starting subtest: dmabuf-fence-before
[270.018609] Subtest dmabuf-fence-before: SUCCESS (0.001s)
[270.091625] [146/164] (740s left) vgem_basic (dmabuf-mmap)
[270.200342] Starting subtest: dmabuf-mmap
[270.225803] Subtest dmabuf-mmap: SUCCESS (0.026s)
[270.308454] [147/164] (739s left) vgem_basic (mmap)
[270.417270] Starting subtest: mmap
[270.436557] Subtest mmap: SUCCESS (0.018s)
[270.506393] [148/164] (739s left) vgem_basic (second-client)
[270.618028] Starting subtest: second-client
[270.653176] Subtest second-client: SUCCESS (0.033s)
[270.726534] [149/164] (739s left) vgem_basic (sysfs)
[270.834553] Starting subtest: sysfs
[270.835778] Subtest sysfs: SUCCESS (0.001s)
[270.907365] [150/164] (739s left) core_hotunplug (unbind-rebind)
[271.050968] Starting subtest: unbind-rebind
[275.552329] Subtest unbind-rebind: SUCCESS (4.501s)
[275.589725] [151/164] (734s left) vgem_basic (unload)
[275.687054] Starting subtest: unload
[304.713458] Subtest unload: SUCCESS (29.017s)
[304.844252] [152/164] (705s left) i915_module_load (reload)
[304.934848] Starting subtest: reload
[308.334891] Subtest reload: SUCCESS (3.400s)
[308.365650] [153/164] (702s left) gem_lmem_swapping (basic)
[308.476358] Subtest basic: SKIP (0.000s)
[308.520898] [154/164] (701s left) gem_lmem_swapping (parallel-random-engines)
[308.624198] Subtest parallel-random-engines: SKIP (0.000s)
[308.669912] [155/164] (701s left) gem_lmem_swapping (random-engines)
[308.766448] Subtest random-engines: SKIP (0.000s)
[308.820169] [156/164] (701s left) gem_lmem_swapping (verify-random)
[308.918192] Subtest verify-random: SKIP (0.000s)
[308.970533] [157/164] (701s left) i915_pm_rpm (module-reload)
[321.422428] Starting subtest: module-reload
[355.874956] Subtest module-reload: SUCCESS (34.445s)
[355.899230] [158/164] (654s left) i915_selftest (live)
[356.008738] Starting subtest: live
[356.010046] Starting dynamic subtest: sanitycheck
[357.904981] Dynamic subtest sanitycheck: SUCCESS (1.889s)
[357.920154] Starting dynamic subtest: uncore
[359.769671] Dynamic subtest uncore: SUCCESS (1.862s)
[359.784524] Starting dynamic subtest: workarounds
[361.946366] Dynamic subtest workarounds: SUCCESS (2.173s)
[361.961426] Starting dynamic subtest: gt_engines
[364.243468] Dynamic subtest gt_engines: SUCCESS (2.293s)
[364.258340] Starting dynamic subtest: gt_timelines
[377.425569] Dynamic subtest gt_timelines: SUCCESS (13.178s)
[377.440498] Starting dynamic subtest: gt_contexts
[379.423275] Dynamic subtest gt_contexts: SUCCESS (1.994s)
[379.438486] Starting dynamic subtest: gt_lrc
[383.830459] Dynamic subtest gt_lrc: SUCCESS (4.404s)
[383.845295] Starting dynamic subtest: gt_mocs
[385.830528] Dynamic subtest gt_mocs: SUCCESS (1.996s)
[385.845318] Starting dynamic subtest: gt_pm
[391.003704] Dynamic subtest gt_pm: SUCCESS (5.169s)
[391.018758] Starting dynamic subtest: gt_heartbeat
[392.932447] Dynamic subtest gt_heartbeat: SUCCESS (1.925s)
[392.947512] Starting dynamic subtest: gt_tlb
[396.119667] Dynamic subtest gt_tlb: SUCCESS (3.184s)
[396.134816] Starting dynamic subtest: requests
[403.806844] Dynamic subtest requests: SUCCESS (7.683s)
[403.821979] Starting dynamic subtest: migrate
[408.421827] Dynamic subtest migrate: SUCCESS (4.611s)
[408.436747] Starting dynamic subtest: active
[410.331581] Dynamic subtest active: SUCCESS (1.906s)
[410.346841] Starting dynamic subtest: objects
[413.714639] Dynamic subtest objects: SUCCESS (3.379s)
[413.729631] Starting dynamic subtest: mman
[420.676468] Dynamic subtest mman: SUCCESS (6.958s)
[420.691519] Starting dynamic subtest: dmabuf
[422.574933] Dynamic subtest dmabuf: SUCCESS (1.894s)
[422.590083] Starting dynamic subtest: vma
[424.407209] Dynamic subtest vma: SUCCESS (1.829s)
[424.422793] Starting dynamic subtest: coherency
[429.012413] Dynamic subtest coherency: SUCCESS (4.602s)
[429.027824] Starting dynamic subtest: gtt
[438.782445] Dynamic subtest gtt: SUCCESS (9.767s)
[438.797504] Starting dynamic subtest: gem
[440.806610] Dynamic subtest gem: SUCCESS (2.020s)
[440.821756] Starting dynamic subtest: evict
[444.754516] Dynamic subtest evict: SUCCESS (3.944s)
[444.769798] Starting dynamic subtest: hugepages
[452.533948] Dynamic subtest hugepages: SUCCESS (7.776s)
[452.549491] Starting dynamic subtest: gem_contexts
[468.111566] Dynamic subtest gem_contexts: SUCCESS (15.574s)
[468.127296] Starting dynamic subtest: client
[470.020657] Dynamic subtest client: SUCCESS (1.906s)
[470.036445] Starting dynamic subtest: gem_migrate
[471.908660] Dynamic subtest gem_migrate: SUCCESS (1.884s)
[471.924021] Starting dynamic subtest: reset
[477.346501] Dynamic subtest reset: SUCCESS (5.434s)
[477.362082] Starting dynamic subtest: memory_region
[479.211570] Dynamic subtest memory_region: SUCCESS (1.862s)
[479.227156] Starting dynamic subtest: hangcheck
[503.737275] Dynamic subtest hangcheck: SUCCESS (24.522s)
[503.753105] Starting dynamic subtest: execlists
[513.873498] Dynamic subtest execlists: SUCCESS (10.133s)
[513.889097] Starting dynamic subtest: ring_submission
[515.735741] Dynamic subtest ring_submission: SUCCESS (1.859s)
[515.751539] Starting dynamic subtest: perf
[517.728712] Dynamic subtest perf: SUCCESS (1.990s)
[517.744510] Starting dynamic subtest: slpc
[519.598677] Dynamic subtest slpc: SUCCESS (1.867s)
[519.614532] Starting dynamic subtest: guc
[521.503456] Dynamic subtest guc: SUCCESS (1.902s)
[521.519232] Starting dynamic subtest: guc_multi_lrc
[523.358749] Dynamic subtest guc_multi_lrc: SUCCESS (1.852s)
[523.374095] Starting dynamic subtest: guc_hang
[525.236435] Dynamic subtest guc_hang: SUCCESS (1.874s)
[525.252076] Starting dynamic subtest: late_gt_pm
[527.133378] Dynamic subtest late_gt_pm: SUCCESS (1.893s)
[527.134583] Subtest live: SUCCESS (171.120s)
[527.159595] [159/164] (483s left) dmabuf (all-tests)
[527.258825] Starting subtest: all-tests
[527.260111] Starting dynamic subtest: sanitycheck
[527.321887] Dynamic subtest sanitycheck: SUCCESS (0.061s)
[527.341726] Starting dynamic subtest: dma_fence
[527.516873] Dynamic subtest dma_fence: SUCCESS (0.191s)
[527.535026] Starting dynamic subtest: dma_fence_chain
[545.713056] Dynamic subtest dma_fence_chain: SUCCESS (18.184s)
[545.726278] Starting dynamic subtest: dma_fence_unwrap
[545.784747] Dynamic subtest dma_fence_unwrap: SUCCESS (0.076s)
[545.805132] Starting dynamic subtest: dma_resv
[545.863639] Dynamic subtest dma_resv: SUCCESS (0.075s)
[545.865800] Subtest all-tests: SUCCESS (18.606s)
[545.897682] [160/164] (464s left) i915_suspend (basic-s2idle-without-i915)
[545.986673] Starting subtest: basic-s2idle-without-i915
[569.806584] Subtest basic-s2idle-without-i915: SUCCESS (8.120s)
[570.203020] [161/164] (456s left) i915_suspend (basic-s3-without-i915)
[570.293644] Starting subtest: basic-s3-without-i915
[593.902514] Subtest basic-s3-without-i915: SUCCESS (6.978s)
[594.249735] [162/164] (448s left) gem_exec_suspend (basic-s0)
[594.370596] Starting subtest: basic-S0
[594.371814] Starting dynamic subtest: smem
[614.073541] Dynamic subtest smem: SUCCESS (3.891s)
[614.074889] Subtest basic-S0: SUCCESS (3.893s)
[614.286614] [163/164] (444s left) gem_exec_suspend (basic-s3)
[614.395993] Starting subtest: basic-S3
[614.397276] Starting dynamic subtest: smem
[633.038199] Dynamic subtest smem: SUCCESS (3.756s)
[633.039705] Subtest basic-S3: SUCCESS (3.758s)
[633.248044] [164/164] (440s left) kms_pipe_crc_basic (suspend-read-crc)
[633.373933] Starting subtest: suspend-read-crc
[633.376835] Starting dynamic subtest: pipe-A-eDP-1
[651.005225] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.543s)
[651.038543] Starting dynamic subtest: pipe-B-eDP-1
[668.956312] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.129s)
[668.979332] Starting dynamic subtest: pipe-C-eDP-1
[686.962805] Dynamic subtest pipe-C-eDP-1: SUCCESS (3.118s)
[686.964043] Subtest suspend-read-crc: SUCCESS (8.806s)
[687.851482] Closing watchdogs
Done.