[52.145680] Initializing watchdogs
[52.145980]   /dev/watchdog0
[52.161901] [001/165] (960s left) i915_module_load (load)
[52.414929] Starting subtest: load
[55.707164] Subtest load: SUCCESS (3.294s)
[55.847490] [002/165] (956s left) core_auth (basic-auth)
[56.567079] Starting subtest: basic-auth
[56.578259] Subtest basic-auth: SUCCESS (0.012s)
[56.780162] [003/165] (956s left) debugfs_test (read_all_entries)
[57.031140] Starting subtest: read_all_entries
[57.206992] Subtest read_all_entries: SUCCESS (0.175s)
[57.711483] [004/165] (955s left) debugfs_test (basic-hwmon)
[57.953651] Starting subtest: basic-hwmon
[57.959568] Subtest basic-hwmon: SKIP (0.000s)
[58.478787] [005/165] (954s left) fbdev (eof)
[58.713636] Starting subtest: eof
[58.716604] Subtest eof: SUCCESS (0.002s)
[58.792324] [006/165] (954s left) fbdev (info)
[59.029176] Starting subtest: info
[59.030823] Subtest info: SUCCESS (0.000s)
[59.144824] [007/165] (953s left) fbdev (nullptr)
[59.382836] Starting subtest: nullptr
[59.384925] Subtest nullptr: SUCCESS (0.001s)
[59.481342] [008/165] (953s left) fbdev (read)
[59.715371] Starting subtest: read
[63.482640] Subtest read: SUCCESS (3.766s)
[63.585119] [009/165] (949s left) fbdev (write)
[63.816230] Starting subtest: write
[65.730402] Subtest write: SUCCESS (1.914s)
[65.834399] [010/165] (947s left) gem_basic (bad-close)
[66.056727] Starting subtest: bad-close
[66.066312] Subtest bad-close: SUCCESS (0.001s)
[66.164888] [011/165] (947s left) gem_basic (create-close)
[66.388799] Starting subtest: create-close
[66.396816] Subtest create-close: SUCCESS (0.000s)
[66.499340] [012/165] (946s left) gem_basic (create-fd-close)
[66.719127] Starting subtest: create-fd-close
[66.724132] Subtest create-fd-close: SUCCESS (0.001s)
[66.815253] [013/165] (946s left) gem_busy (busy@all-engines)
[67.084400] Starting subtest: busy
[67.087559] Starting dynamic subtest: all-engines
[67.231463] Dynamic subtest all-engines: SUCCESS (0.152s)
[67.233559] Subtest busy: SUCCESS (0.153s)
[67.652411] [014/165] (945s left) gem_close_race (basic-process)
[67.929646] Starting subtest: basic-process
[68.038953] Subtest basic-process: SUCCESS (0.113s)
[68.276641] [015/165] (945s left) gem_close_race (basic-threads)
[68.557331] Starting subtest: basic-threads
[69.767932] Subtest basic-threads: SUCCESS (1.212s)
[70.025349] [016/165] (943s left) gem_ctx_create (basic)
[70.298734] Starting subtest: basic
[70.300455] Subtest basic: SUCCESS (0.000s)
[70.523216] [017/165] (943s left) gem_ctx_create (basic-files)
[70.786125] Starting subtest: basic-files
[72.842593] Subtest basic-files: SUCCESS (2.058s)
[73.146507] [018/165] (940s left) gem_ctx_exec (basic)
[73.379343] Starting subtest: basic
[73.392913] Subtest basic: SUCCESS (0.012s)
[73.511119] [019/165] (940s left) gem_exec_basic (basic)
[73.764501] Starting subtest: basic
[73.767907] Starting dynamic subtest: rcs0-smem
[73.771575] Dynamic subtest rcs0-smem: SUCCESS (0.006s)
[73.794910] Starting dynamic subtest: bcs0-smem
[73.798107] Dynamic subtest bcs0-smem: SUCCESS (0.003s)
[73.818103] Starting dynamic subtest: vcs0-smem
[73.821467] Dynamic subtest vcs0-smem: SUCCESS (0.004s)
[73.840938] Starting dynamic subtest: vecs0-smem
[73.845791] Dynamic subtest vecs0-smem: SUCCESS (0.004s)
[73.849394] Subtest basic: SUCCESS (0.022s)
[74.026885] [020/165] (939s left) gem_exec_create (basic)
[74.292697] Starting subtest: basic
[74.294446] Starting dynamic subtest: smem
[76.372107] Dynamic subtest smem: SUCCESS (2.079s)
[76.374194] Subtest basic: SUCCESS (2.080s)
[76.594332] [021/165] (937s left) gem_exec_fence (basic-busy)
[77.022485] Starting subtest: basic-busy
[77.027128] Starting dynamic subtest: rcs0
[77.046744] Dynamic subtest rcs0: SUCCESS (0.024s)
[77.089579] Starting dynamic subtest: bcs0
[77.092591] Dynamic subtest bcs0: SUCCESS (0.025s)
[77.117142] Starting dynamic subtest: vcs0
[77.120474] Dynamic subtest vcs0: SUCCESS (0.018s)
[77.136865] Starting dynamic subtest: vecs0
[77.139721] Dynamic subtest vecs0: SUCCESS (0.030s)
[77.141262] Subtest basic-busy: SUCCESS (0.099s)
[77.961840] [022/165] (935s left) gem_exec_fence (basic-wait)
[78.382650] Starting subtest: basic-wait
[78.385088] Starting dynamic subtest: rcs0
[78.402683] Dynamic subtest rcs0: SUCCESS (0.020s)
[78.433331] Starting dynamic subtest: bcs0
[78.436714] Dynamic subtest bcs0: SUCCESS (0.027s)
[78.467893] Starting dynamic subtest: vcs0
[78.471218] Dynamic subtest vcs0: SUCCESS (0.024s)
[78.494165] Starting dynamic subtest: vecs0
[78.495891] Dynamic subtest vecs0: SUCCESS (0.031s)
[78.497565] Subtest basic-wait: SUCCESS (0.105s)
[79.149611] [023/165] (934s left) gem_exec_fence (basic-await)
[79.572528] Starting subtest: basic-await
[79.574386] Starting dynamic subtest: rcs0
[79.758791] Dynamic subtest rcs0: SUCCESS (0.187s)
[79.783531] Starting dynamic subtest: bcs0
[79.939344] Dynamic subtest bcs0: SUCCESS (0.176s)
[79.961763] Starting dynamic subtest: vcs0
[80.118993] Dynamic subtest vcs0: SUCCESS (0.184s)
[80.142491] Starting dynamic subtest: vecs0
[80.302967] Dynamic subtest vecs0: SUCCESS (0.184s)
[80.305485] Subtest basic-await: SUCCESS (0.734s)
[80.982325] [024/165] (932s left) gem_exec_fence (nb-await)
[81.402597] Starting subtest: nb-await
[81.405096] Starting dynamic subtest: rcs0
[81.493994] Dynamic subtest rcs0: SUCCESS (0.088s)
[81.517806] Starting dynamic subtest: bcs0
[81.581123] Dynamic subtest bcs0: SUCCESS (0.088s)
[81.607844] Starting dynamic subtest: vcs0
[81.659233] Dynamic subtest vcs0: SUCCESS (0.078s)
[81.679748] Starting dynamic subtest: vecs0
[81.745338] Dynamic subtest vecs0: SUCCESS (0.085s)
[81.753398] Subtest nb-await: SUCCESS (0.343s)
[82.399386] [025/165] (931s left) gem_exec_gttfill (basic)
[82.667720] Starting subtest: basic
[84.584453] Subtest basic: SKIP (1.898s)
[84.844095] [026/165] (929s left) gem_exec_parallel (engines)
[85.243680] Starting subtest: engines
[85.245840] Starting dynamic subtest: basic
[90.556742] Dynamic subtest basic: SUCCESS (5.311s)
[90.584829] Starting dynamic subtest: contexts
[99.205699] Dynamic subtest contexts: SUCCESS (8.651s)
[99.236996] Starting dynamic subtest: fds
[111.733680] Dynamic subtest fds: SUCCESS (12.527s)
[111.757232] Starting dynamic subtest: userptr
[116.717174] Dynamic subtest userptr: SUCCESS (4.983s)
[116.720031] Subtest engines: SUCCESS (31.478s)
[117.003063] [027/165] (897s left) gem_exec_store (basic)
[117.268737] Starting subtest: basic
[117.328490] Subtest basic: SUCCESS (0.065s)
[117.581470] [028/165] (896s left) gem_flink_basic (bad-flink)
[117.805355] Starting subtest: bad-flink
[117.809667] Subtest bad-flink: SUCCESS (0.000s)
[117.912627] [029/165] (896s left) gem_flink_basic (bad-open)
[118.133160] Starting subtest: bad-open
[118.136847] Subtest bad-open: SUCCESS (0.000s)
[118.241452] [030/165] (896s left) gem_flink_basic (basic)
[118.460271] Starting subtest: basic
[118.464624] Subtest basic: SUCCESS (0.000s)
[118.569127] [031/165] (895s left) gem_flink_basic (double-flink)
[118.792063] Starting subtest: double-flink
[118.795247] Subtest double-flink: SUCCESS (0.000s)
[118.897063] [032/165] (895s left) gem_flink_basic (flink-lifetime)
[119.116855] Starting subtest: flink-lifetime
[119.123148] Subtest flink-lifetime: SUCCESS (0.006s)
[119.235949] [033/165] (895s left) gem_huc_copy (huc-copy)
[119.472866] Subtest huc-copy: SKIP (0.000s)
[119.555245] [034/165] (894s left) gem_linear_blits (basic)
[120.178864] Subtest basic: SKIP (0.000s)
[120.305556] [035/165] (894s left) gem_mmap (basic)
[120.655618] Starting subtest: basic
[120.671049] Subtest basic: SUCCESS (0.003s)
[120.768913] [036/165] (893s left) gem_mmap_gtt (basic)
[120.991783] Starting subtest: basic
[120.993855] Subtest basic: SUCCESS (0.003s)
[121.087270] [037/165] (893s left) gem_render_linear_blits (basic)
[121.326072] Starting subtest: basic
[121.435253] Subtest basic: SUCCESS (0.104s)
[121.528214] [038/165] (893s left) gem_render_tiled_blits (basic)
[121.765892] Starting subtest: basic
[121.908156] Subtest basic: SUCCESS (0.133s)
[121.993634] [039/165] (892s left) gem_ringfill (basic-all)
[122.419739] Starting subtest: basic-all
[123.763446] Subtest basic-all: SUCCESS (1.346s)
[123.877972] [040/165] (890s left) gem_softpin (allocator-basic)
[124.119569] Starting subtest: allocator-basic
[124.409683] Subtest allocator-basic: SUCCESS (0.286s)
[124.584819] [041/165] (890s left) gem_softpin (allocator-basic-reserve)
[124.825521] Starting subtest: allocator-basic-reserve
[125.118602] Subtest allocator-basic-reserve: SUCCESS (0.290s)
[125.305701] [042/165] (889s left) gem_softpin (safe-alignment)
[125.551183] Starting subtest: safe-alignment
[125.594580] Subtest safe-alignment: SUCCESS (0.042s)
[125.703258] [043/165] (889s left) gem_sync (basic-all)
[125.968692] Starting subtest: basic-all
[128.724072] Subtest basic-all: SUCCESS (2.754s)
[128.965936] [044/165] (886s left) gem_sync (basic-each)
[129.235712] Starting subtest: basic-each
[132.098985] Subtest basic-each: SUCCESS (2.866s)
[132.328188] [045/165] (882s left) gem_tiled_blits (basic)
[132.876660] Subtest basic: SKIP (0.000s)
[132.969196] [046/165] (882s left) gem_tiled_fence_blits (basic)
[133.638592] Starting subtest: basic
[133.691624] Subtest basic: SUCCESS (0.054s)
[133.987040] [047/165] (881s left) gem_tiled_pread_basic
[135.171059] [048/165] (880s left) gem_wait (busy@all-engines)
[135.467599] Starting subtest: busy
[135.470480] Starting dynamic subtest: all-engines
[135.992120] Dynamic subtest all-engines: SUCCESS (0.527s)
[135.996029] Subtest busy: SUCCESS (0.529s)
[136.303329] [049/165] (879s left) gem_wait (wait@all-engines)
[136.588756] Starting subtest: wait
[136.591075] Starting dynamic subtest: all-engines
[137.626928] Dynamic subtest all-engines: SUCCESS (1.039s)
[137.628541] Subtest wait: SUCCESS (1.040s)
[137.949524] [050/165] (877s left) i915_getparams_basic (basic-eu-total)
[138.171523] Starting subtest: basic-eu-total
[138.175628] Subtest basic-eu-total: SUCCESS (0.000s)
[138.284158] [051/165] (877s left) i915_getparams_basic (basic-subslice-total)
[138.512834] Starting subtest: basic-subslice-total
[138.518057] Subtest basic-subslice-total: SUCCESS (0.000s)
[138.619524] [052/165] (876s left) i915_hangman (error-state-basic)
[138.880618] Starting subtest: error-state-basic
[138.905429] Subtest error-state-basic: SUCCESS (0.024s)
[139.036132] [053/165] (876s left) i915_pciid
[139.382978] [054/165] (876s left) kms_addfb_basic (addfb25-4-tiled)
[140.028764] Starting subtest: addfb25-4-tiled
[140.030706] Subtest addfb25-4-tiled: SUCCESS (0.002s)
[140.132977] [055/165] (875s left) kms_addfb_basic (addfb25-bad-modifier)
[140.360745] Starting subtest: addfb25-bad-modifier
[140.365591] Subtest addfb25-bad-modifier: SUCCESS (0.001s)
[140.851806] [056/165] (874s left) kms_addfb_basic (addfb25-framebuffer-vs-set-tiling)
[141.076047] Starting subtest: addfb25-framebuffer-vs-set-tiling
[141.079172] Subtest addfb25-framebuffer-vs-set-tiling: SUCCESS (0.000s)
[141.585228] [057/165] (874s left) kms_addfb_basic (addfb25-modifier-no-flag)
[141.808398] Starting subtest: addfb25-modifier-no-flag
[141.811218] Subtest addfb25-modifier-no-flag: SUCCESS (0.000s)
[142.352857] [058/165] (873s left) kms_addfb_basic (addfb25-x-tiled-legacy)
[142.582710] Starting subtest: addfb25-x-tiled-legacy
[142.586606] Subtest addfb25-x-tiled-legacy: SUCCESS (0.000s)
[143.103207] [059/165] (872s left) kms_addfb_basic (addfb25-x-tiled-mismatch-legacy)
[143.325262] Starting subtest: addfb25-x-tiled-mismatch-legacy
[143.326857] Subtest addfb25-x-tiled-mismatch-legacy: SUCCESS (0.001s)
[143.838338] [060/165] (872s left) kms_addfb_basic (addfb25-yf-tiled-legacy)
[144.461210] Starting subtest: addfb25-yf-tiled-legacy
[144.466168] Subtest addfb25-yf-tiled-legacy: SUCCESS (0.001s)
[144.573175] [061/165] (871s left) kms_addfb_basic (addfb25-y-tiled-legacy)
[145.191133] Starting subtest: addfb25-y-tiled-legacy
[145.192877] Subtest addfb25-y-tiled-legacy: SUCCESS (0.003s)
[145.305330] [062/165] (870s left) kms_addfb_basic (addfb25-y-tiled-small-legacy)
[146.004677] Starting subtest: addfb25-y-tiled-small-legacy
[146.008754] Subtest addfb25-y-tiled-small-legacy: SKIP (0.001s)
[146.123581] [063/165] (870s left) kms_addfb_basic (bad-pitch-0)
[146.352478] Starting subtest: bad-pitch-0
[146.355789] Subtest bad-pitch-0: SUCCESS (0.000s)
[146.889178] [064/165] (869s left) kms_addfb_basic (bad-pitch-1024)
[147.120490] Starting subtest: bad-pitch-1024
[147.122658] Subtest bad-pitch-1024: SUCCESS (0.000s)
[147.640056] [065/165] (868s left) kms_addfb_basic (bad-pitch-128)
[147.865984] Starting subtest: bad-pitch-128
[147.867786] Subtest bad-pitch-128: SUCCESS (0.000s)
[148.376422] [066/165] (867s left) kms_addfb_basic (bad-pitch-256)
[148.605589] Starting subtest: bad-pitch-256
[148.607159] Subtest bad-pitch-256: SUCCESS (0.000s)
[149.141834] [067/165] (867s left) kms_addfb_basic (bad-pitch-32)
[149.366344] Starting subtest: bad-pitch-32
[149.369342] Subtest bad-pitch-32: SUCCESS (0.000s)
[149.892351] [068/165] (866s left) kms_addfb_basic (bad-pitch-63)
[150.121275] Starting subtest: bad-pitch-63
[150.124612] Subtest bad-pitch-63: SUCCESS (0.000s)
[150.662163] [069/165] (865s left) kms_addfb_basic (bad-pitch-65536)
[150.886393] Starting subtest: bad-pitch-65536
[150.890612] Subtest bad-pitch-65536: SUCCESS (0.002s)
[151.410139] [070/165] (865s left) kms_addfb_basic (bad-pitch-999)
[151.635495] Starting subtest: bad-pitch-999
[151.638438] Subtest bad-pitch-999: SUCCESS (0.000s)
[152.177416] [071/165] (864s left) kms_addfb_basic (basic)
[152.406659] Starting subtest: basic
[152.408987] Subtest basic: SUCCESS (0.000s)
[152.944551] [072/165] (863s left) kms_addfb_basic (basic-x-tiled-legacy)
[153.178680] Starting subtest: basic-x-tiled-legacy
[153.183119] Subtest basic-x-tiled-legacy: SUCCESS (0.000s)
[153.696827] [073/165] (862s left) kms_addfb_basic (basic-y-tiled-legacy)
[153.926715] Starting subtest: basic-y-tiled-legacy
[153.931996] Subtest basic-y-tiled-legacy: SUCCESS (0.001s)
[154.460941] [074/165] (862s left) kms_addfb_basic (bo-too-small)
[155.088753] Starting subtest: bo-too-small
[155.090488] Subtest bo-too-small: SUCCESS (0.003s)
[155.198802] [075/165] (861s left) kms_addfb_basic (bo-too-small-due-to-tiling)
[155.825925] Starting subtest: bo-too-small-due-to-tiling
[155.829604] Subtest bo-too-small-due-to-tiling: SUCCESS (0.001s)
[155.930731] [076/165] (860s left) kms_addfb_basic (clobberred-modifier)
[156.160669] Starting subtest: clobberred-modifier
[156.163292] Subtest clobberred-modifier: SUCCESS (0.000s)
[156.682437] [077/165] (860s left) kms_addfb_basic (framebuffer-vs-set-tiling)
[156.916770] Starting subtest: framebuffer-vs-set-tiling
[156.919123] Subtest framebuffer-vs-set-tiling: SUCCESS (0.000s)
[157.414475] [078/165] (859s left) kms_addfb_basic (invalid-get-prop)
[157.633261] Starting subtest: invalid-get-prop
[157.635664] Subtest invalid-get-prop: SUCCESS (0.000s)
[158.151673] [079/165] (858s left) kms_addfb_basic (invalid-get-prop-any)
[158.379246] Starting subtest: invalid-get-prop-any
[158.382087] Subtest invalid-get-prop-any: SUCCESS (0.000s)
[158.899683] [080/165] (858s left) kms_addfb_basic (invalid-set-prop)
[159.118634] Starting subtest: invalid-set-prop
[159.120245] Subtest invalid-set-prop: SUCCESS (0.000s)
[159.617927] [081/165] (857s left) kms_addfb_basic (invalid-set-prop-any)
[159.843710] Starting subtest: invalid-set-prop-any
[159.847073] Subtest invalid-set-prop-any: SUCCESS (0.000s)
[160.350503] [082/165] (856s left) kms_addfb_basic (no-handle)
[160.574818] Starting subtest: no-handle
[160.576508] Subtest no-handle: SUCCESS (0.000s)
[161.082680] [083/165] (856s left) kms_addfb_basic (size-max)
[161.731814] Starting subtest: size-max
[161.735058] Subtest size-max: SUCCESS (0.000s)
[161.834225] [084/165] (855s left) kms_addfb_basic (small-bo)
[162.496629] Starting subtest: small-bo
[162.501076] Subtest small-bo: SUCCESS (0.000s)
[162.602268] [085/165] (854s left) kms_addfb_basic (tile-pitch-mismatch)
[162.827405] Starting subtest: tile-pitch-mismatch
[162.829900] Subtest tile-pitch-mismatch: SUCCESS (0.001s)
[163.336382] [086/165] (854s left) kms_addfb_basic (too-high)
[163.980895] Starting subtest: too-high
[163.982725] Subtest too-high: SUCCESS (0.003s)
[164.103812] [087/165] (853s left) kms_addfb_basic (too-wide)
[164.729539] Starting subtest: too-wide
[164.732230] Subtest too-wide: SUCCESS (0.000s)
[164.844138] [088/165] (852s left) kms_addfb_basic (unused-handle)
[165.062825] Starting subtest: unused-handle
[165.066157] Subtest unused-handle: SUCCESS (0.000s)
[165.588917] [089/165] (851s left) kms_addfb_basic (unused-modifier)
[165.816694] Starting subtest: unused-modifier
[165.820692] Subtest unused-modifier: SUCCESS (0.000s)
[166.360589] [090/165] (851s left) kms_addfb_basic (unused-offsets)
[166.587752] Starting subtest: unused-offsets
[166.591593] Subtest unused-offsets: SUCCESS (0.002s)
[167.122634] [091/165] (850s left) kms_addfb_basic (unused-pitches)
[167.347317] Starting subtest: unused-pitches
[167.349150] Subtest unused-pitches: SUCCESS (0.000s)
[167.872272] [092/165] (849s left) kms_busy (basic)
[168.493872] Starting subtest: basic
[168.502035] Starting dynamic subtest: flip
[169.683080] Dynamic subtest flip: SUCCESS (1.174s)
[169.756103] Starting dynamic subtest: modeset
[171.794176] Dynamic subtest modeset: SUCCESS (2.106s)
[171.800103] Subtest basic: SUCCESS (3.292s)
[172.315678] [093/165] (845s left) kms_prop_blob (basic)
[172.544673] Starting subtest: basic
[172.546702] Subtest basic: SUCCESS (0.000s)
[172.664951] [094/165] (845s left) kms_cursor_legacy (basic-busy-flip-before-cursor-atomic)
[173.329062] Starting subtest: basic-busy-flip-before-cursor-atomic
[174.542608] Subtest basic-busy-flip-before-cursor-atomic: SUCCESS (1.215s)
[175.036041] [095/165] (842s left) kms_cursor_legacy (basic-busy-flip-before-cursor-legacy)
[175.727493] Starting subtest: basic-busy-flip-before-cursor-legacy
[176.980208] Subtest basic-busy-flip-before-cursor-legacy: SUCCESS (1.283s)
[177.482932] [096/165] (840s left) kms_cursor_legacy (basic-flip-after-cursor-atomic)
[178.189208] Starting subtest: basic-flip-after-cursor-atomic
[179.440149] Subtest basic-flip-after-cursor-atomic: SUCCESS (1.252s)
[179.901486] [097/165] (838s left) kms_cursor_legacy (basic-flip-after-cursor-legacy)
[180.582464] Starting subtest: basic-flip-after-cursor-legacy
[181.870454] Subtest basic-flip-after-cursor-legacy: SUCCESS (1.285s)
[182.407440] [098/165] (835s left) kms_cursor_legacy (basic-flip-after-cursor-varying-size)
[183.051131] Starting subtest: basic-flip-after-cursor-varying-size
[184.259934] Subtest basic-flip-after-cursor-varying-size: SUCCESS (1.214s)
[184.790987] [099/165] (833s left) kms_cursor_legacy (basic-flip-before-cursor-atomic)
[185.462975] Starting subtest: basic-flip-before-cursor-atomic
[186.669606] Subtest basic-flip-before-cursor-atomic: SUCCESS (1.206s)
[187.135157] [100/165] (830s left) kms_cursor_legacy (basic-flip-before-cursor-legacy)
[187.805054] Starting subtest: basic-flip-before-cursor-legacy
[189.020645] Subtest basic-flip-before-cursor-legacy: SUCCESS (1.207s)
[189.524522] [101/165] (828s left) kms_cursor_legacy (basic-flip-before-cursor-varying-size)
[190.194125] Starting subtest: basic-flip-before-cursor-varying-size
[191.405185] Subtest basic-flip-before-cursor-varying-size: SUCCESS (1.215s)
[191.953726] [102/165] (826s left) kms_dsc (dsc-basic)
[192.621129] Subtest dsc-basic: SKIP (0.000s)
[192.702345] [103/165] (825s left) kms_flip (basic-flip-vs-dpms)
[193.157835] Starting subtest: basic-flip-vs-dpms
[193.180881] Starting dynamic subtest: C-HDMI-A2
[196.102045] Dynamic subtest C-HDMI-A2: SUCCESS (2.903s)
[196.108419] Subtest basic-flip-vs-dpms: SUCCESS (2.933s)
[196.670622] [104/165] (821s left) kms_flip (basic-flip-vs-modeset)
[197.127962] Starting subtest: basic-flip-vs-modeset
[197.146689] Starting dynamic subtest: C-HDMI-A2
[200.090127] Dynamic subtest C-HDMI-A2: SUCCESS (2.938s)
[200.092532] Subtest basic-flip-vs-modeset: SUCCESS (2.963s)
[200.675061] [105/165] (817s left) kms_flip (basic-flip-vs-wf_vblank)
[201.154954] Starting subtest: basic-flip-vs-wf_vblank
[201.171079] Starting dynamic subtest: C-HDMI-A2
[204.133141] Dynamic subtest C-HDMI-A2: SUCCESS (2.949s)
[204.134799] Subtest basic-flip-vs-wf_vblank: SUCCESS (2.975s)
[204.294350] [106/165] (814s left) kms_flip (basic-plain-flip)
[204.771920] Starting subtest: basic-plain-flip
[204.781584] Starting dynamic subtest: C-HDMI-A2
[207.474791] Dynamic subtest C-HDMI-A2: SUCCESS (2.688s)
[207.477657] Subtest basic-plain-flip: SUCCESS (2.713s)
[207.642378] [107/165] (810s left) kms_force_connector_basic (force-connector-state)
[208.000159] Starting subtest: force-connector-state
[208.783893] Subtest force-connector-state: SUCCESS (0.784s)
[210.253552] [108/165] (808s left) kms_force_connector_basic (force-edid)
[210.604604] Starting subtest: force-edid
[210.730127] Subtest force-edid: SUCCESS (0.124s)
[211.525434] [109/165] (807s left) kms_force_connector_basic (force-load-detect)
[211.842547] Starting subtest: force-load-detect
[211.849514] Subtest force-load-detect: SKIP (0.000s)
[212.386550] [110/165] (806s left) kms_force_connector_basic (prune-stale-modes)
[212.737559] Starting subtest: prune-stale-modes
[212.855272] Subtest prune-stale-modes: SUCCESS (0.115s)
[213.639196] [111/165] (805s left) kms_frontbuffer_tracking (basic)
[214.361691] Starting subtest: basic
[219.003090] Subtest basic: SUCCESS (4.641s)
[219.152922] [112/165] (799s left) kms_hdmi_inject (inject-audio)
[219.528710] Starting subtest: inject-audio
[220.127846] Subtest inject-audio: FAIL (0.515s)
[220.967078] [113/165] (797s left) kms_pipe_crc_basic (compare-crc-sanitycheck-xr24)
[221.682081] Starting subtest: compare-crc-sanitycheck-xr24
[221.688766] Starting dynamic subtest: pipe-C-HDMI-A-2
[222.245604] Dynamic subtest pipe-C-HDMI-A-2: SUCCESS (0.554s)
[222.247317] Subtest compare-crc-sanitycheck-xr24: SUCCESS (0.568s)
[222.700856] [114/165] (796s left) kms_pipe_crc_basic (compare-crc-sanitycheck-nv12)
[223.394631] Starting subtest: compare-crc-sanitycheck-nv12
[223.398680] Starting dynamic subtest: pipe-C-HDMI-A-2
[223.403762] Dynamic subtest pipe-C-HDMI-A-2: SKIP (0.003s)
[223.410887] Subtest compare-crc-sanitycheck-nv12: SKIP (0.014s)
[223.515881] [115/165] (795s left) kms_pipe_crc_basic (hang-read-crc)
[224.221981] Starting subtest: hang-read-crc
[224.224591] Starting dynamic subtest: pipe-C-HDMI-A-2
[225.895374] Dynamic subtest pipe-C-HDMI-A-2: SUCCESS (1.677s)
[225.897284] Subtest hang-read-crc: SUCCESS (1.685s)
[226.390274] [116/165] (792s left) kms_pipe_crc_basic (nonblocking-crc)
[227.088094] Starting subtest: nonblocking-crc
[227.089883] Starting dynamic subtest: pipe-C-HDMI-A-2
[227.836790] Dynamic subtest pipe-C-HDMI-A-2: SUCCESS (0.741s)
[227.838463] Subtest nonblocking-crc: SUCCESS (0.752s)
[228.325101] [117/165] (790s left) kms_pipe_crc_basic (nonblocking-crc-frame-sequence)
[229.016989] Starting subtest: nonblocking-crc-frame-sequence
[229.022632] Starting dynamic subtest: pipe-C-HDMI-A-2
[229.765340] Dynamic subtest pipe-C-HDMI-A-2: SUCCESS (0.740s)
[229.767738] Subtest nonblocking-crc-frame-sequence: SUCCESS (0.754s)
[230.268551] [118/165] (788s left) kms_pipe_crc_basic (read-crc)
[230.953602] Starting subtest: read-crc
[230.958710] Starting dynamic subtest: pipe-C-HDMI-A-2
[231.610730] Dynamic subtest pipe-C-HDMI-A-2: SUCCESS (0.648s)
[231.613222] Subtest read-crc: SUCCESS (0.661s)
[232.100213] [119/165] (787s left) kms_pipe_crc_basic (read-crc-frame-sequence)
[232.804200] Starting subtest: read-crc-frame-sequence
[232.805932] Starting dynamic subtest: pipe-C-HDMI-A-2
[233.497405] Dynamic subtest pipe-C-HDMI-A-2: SUCCESS (0.691s)
[233.500122] Subtest read-crc-frame-sequence: SUCCESS (0.703s)
[234.003912] [120/165] (785s left) kms_pm_backlight (basic-brightness)
[234.780570] Subtest basic-brightness: SKIP (0.000s)
[234.859560] [121/165] (784s left) kms_pm_rpm (basic-pci-d3-state)
[237.229609] Starting subtest: basic-pci-d3-state
[237.548166] Subtest basic-pci-d3-state: SUCCESS (0.307s)
[237.881414] [122/165] (781s left) kms_pm_rpm (basic-rte)
[238.100476] Starting subtest: basic-rte
[240.541625] Subtest basic-rte: SUCCESS (2.422s)
[241.618839] [123/165] (777s left) kms_psr (psr_primary_page_flip)
[242.316760] Subtest psr_primary_page_flip: SKIP (0.000s)
[242.402154] [124/165] (777s left) kms_psr (psr_cursor_plane_move)
[243.086688] Subtest psr_cursor_plane_move: SKIP (0.000s)
[243.167444] [125/165] (776s left) kms_psr (psr_sprite_plane_onoff)
[243.869716] Subtest psr_sprite_plane_onoff: SKIP (0.000s)
[243.955718] [126/165] (775s left) kms_psr (psr_primary_mmap_gtt)
[244.674642] Subtest psr_primary_mmap_gtt: SKIP (0.000s)
[244.757454] [127/165] (774s left) kms_setmode (basic-clone-single-crtc)
[244.996526] Starting subtest: basic-clone-single-crtc
[245.006149] Subtest basic-clone-single-crtc: SKIP (0.001s)
[245.126198] [128/165] (774s left) i915_pm_rps (basic-api)
[245.368156] Starting subtest: basic-api
[245.388113] Subtest basic-api: SUCCESS (0.017s)
[245.501984] [129/165] (774s left) prime_self_import (basic-llseek-bad)
[245.719968] Starting subtest: basic-llseek-bad
[245.726705] Subtest basic-llseek-bad: SUCCESS (0.007s)
[245.837335] [130/165] (773s left) prime_self_import (basic-llseek-size)
[246.054157] Starting subtest: basic-llseek-size
[246.065669] Subtest basic-llseek-size: SUCCESS (0.011s)
[246.192290] [131/165] (773s left) prime_self_import (basic-with_fd_dup)
[246.411128] Starting subtest: basic-with_fd_dup
[246.423395] Subtest basic-with_fd_dup: SUCCESS (0.012s)
[246.535423] [132/165] (773s left) prime_self_import (basic-with_one_bo)
[246.747394] Starting subtest: basic-with_one_bo
[246.768612] Subtest basic-with_one_bo: SUCCESS (0.023s)
[246.909111] [133/165] (773s left) prime_self_import (basic-with_one_bo_two_files)
[247.125223] Starting subtest: basic-with_one_bo_two_files
[247.135174] Subtest basic-with_one_bo_two_files: SUCCESS (0.009s)
[247.258908] [134/165] (772s left) prime_self_import (basic-with_two_bos)
[247.482059] Starting subtest: basic-with_two_bos
[247.495089] Subtest basic-with_two_bos: SUCCESS (0.012s)
[247.616702] [135/165] (772s left) prime_vgem (basic-fence-flip)
[247.868623] Starting subtest: basic-fence-flip
[248.708609] Subtest basic-fence-flip: SKIP (0.830s)
[248.888945] [136/165] (771s left) prime_vgem (basic-fence-mmap)
[249.151700] Starting subtest: basic-fence-mmap
[249.260304] Subtest basic-fence-mmap: SUCCESS (0.106s)
[249.393502] [137/165] (770s left) prime_vgem (basic-fence-read)
[249.650684] Starting subtest: basic-fence-read
[249.828680] Subtest basic-fence-read: SUCCESS (0.177s)
[249.954817] [138/165] (770s left) prime_vgem (basic-gtt)
[250.204226] Starting subtest: basic-gtt
[250.253949] Subtest basic-gtt: SUCCESS (0.044s)
[250.370093] [139/165] (769s left) prime_vgem (basic-read)
[250.619610] Starting subtest: basic-read
[250.698662] Subtest basic-read: SUCCESS (0.076s)
[250.827387] [140/165] (769s left) prime_vgem (basic-write)
[251.085546] Starting subtest: basic-write
[251.177564] Subtest basic-write: SUCCESS (0.091s)
[251.303790] [141/165] (769s left) vgem_basic (setversion)
[251.534684] Starting subtest: setversion
[251.539367] Subtest setversion: SUCCESS (0.000s)
[251.631789] [142/165] (768s left) vgem_basic (create)
[251.865999] Starting subtest: create
[251.869339] Subtest create: SUCCESS (0.001s)
[251.967711] [143/165] (768s left) vgem_basic (debugfs)
[252.205601] Starting subtest: debugfs
[252.210333] Subtest debugfs: SUCCESS (0.001s)
[252.293711] [144/165] (768s left) vgem_basic (dmabuf-export)
[252.535954] Starting subtest: dmabuf-export
[252.541714] Subtest dmabuf-export: SUCCESS (0.007s)
[252.654315] [145/165] (768s left) vgem_basic (dmabuf-fence)
[252.880235] Starting subtest: dmabuf-fence
[252.888041] Subtest dmabuf-fence: SUCCESS (0.004s)
[252.971987] [146/165] (767s left) vgem_basic (dmabuf-fence-before)
[253.200707] Starting subtest: dmabuf-fence-before
[253.203030] Subtest dmabuf-fence-before: SUCCESS (0.001s)
[253.292596] [147/165] (767s left) vgem_basic (dmabuf-mmap)
[253.540619] Starting subtest: dmabuf-mmap
[253.579087] Subtest dmabuf-mmap: SUCCESS (0.039s)
[253.679073] [148/165] (767s left) vgem_basic (mmap)
[253.916729] Starting subtest: mmap
[253.944261] Subtest mmap: SUCCESS (0.027s)
[254.039591] [149/165] (766s left) vgem_basic (second-client)
[254.271406] Starting subtest: second-client
[254.298875] Subtest second-client: SUCCESS (0.031s)
[254.394233] [150/165] (766s left) vgem_basic (sysfs)
[254.637207] Starting subtest: sysfs
[254.646587] Subtest sysfs: SUCCESS (0.004s)
[254.740126] [151/165] (766s left) core_hotunplug (unbind-rebind)
[255.071085] Starting subtest: unbind-rebind
[259.988157] Subtest unbind-rebind: SUCCESS (4.918s)
[260.059976] [152/165] (761s left) vgem_basic (unload)
[260.311944] Starting subtest: unload
[289.400908] Subtest unload: SUCCESS (29.093s)
[289.590327] [153/165] (731s left) i915_module_load (reload)
[289.812615] Starting subtest: reload
[294.389046] Subtest reload: SUCCESS (4.579s)
[294.560217] [154/165] (726s left) gem_lmem_swapping (basic)
[295.168711] Subtest basic: SKIP (0.000s)
[295.308782] [155/165] (726s left) gem_lmem_swapping (parallel-random-engines)
[295.548724] Subtest parallel-random-engines: SKIP (0.000s)
[295.636451] [156/165] (725s left) gem_lmem_swapping (random-engines)
[295.876403] Subtest random-engines: SKIP (0.000s)
[295.962202] [157/165] (725s left) gem_lmem_swapping (verify-random)
[296.208750] Subtest verify-random: SKIP (0.000s)
[296.285134] [158/165] (725s left) i915_pm_rpm (module-reload)
[299.012595] Starting subtest: module-reload
[310.968471] Subtest module-reload: SUCCESS (11.959s)
[311.027146] [159/165] (710s left) i915_selftest (live)
[311.278645] Starting subtest: live
[311.280970] Starting dynamic subtest: sanitycheck
[313.056250] Dynamic subtest sanitycheck: SUCCESS (1.776s)
[313.074682] Starting dynamic subtest: uncore
[314.832552] Dynamic subtest uncore: SUCCESS (1.772s)
[314.850282] Starting dynamic subtest: workarounds
[316.834372] Dynamic subtest workarounds: SUCCESS (1.997s)
[316.852846] Starting dynamic subtest: gt_engines
[319.000367] Dynamic subtest gt_engines: SUCCESS (2.162s)
[319.019941] Starting dynamic subtest: gt_timelines
[347.638444] Dynamic subtest gt_timelines: SUCCESS (28.637s)
[347.665347] Starting dynamic subtest: gt_contexts
[349.588535] Dynamic subtest gt_contexts: SUCCESS (1.944s)
[349.610300] Starting dynamic subtest: gt_lrc
[354.672501] Dynamic subtest gt_lrc: SUCCESS (5.076s)
[354.690477] Starting dynamic subtest: gt_mocs
[356.397847] Dynamic subtest gt_mocs: SUCCESS (1.725s)
[356.468821] Starting dynamic subtest: gt_pm
[359.556471] Dynamic subtest gt_pm: SUCCESS (3.148s)
[359.575392] Starting dynamic subtest: gt_heartbeat
[361.462965] Dynamic subtest gt_heartbeat: SUCCESS (1.904s)
[361.486479] Starting dynamic subtest: gt_tlb
[363.664828] Dynamic subtest gt_tlb: SUCCESS (2.194s)
[363.688251] Starting dynamic subtest: requests
[372.021318] Dynamic subtest requests: SUCCESS (8.350s)
[372.041028] Starting dynamic subtest: migrate
[377.281207] Dynamic subtest migrate: SUCCESS (5.254s)
[377.299188] Starting dynamic subtest: active
[379.099911] Dynamic subtest active: SUCCESS (1.816s)
[379.120229] Starting dynamic subtest: objects
[382.801761] Dynamic subtest objects: SUCCESS (3.695s)
[382.820252] Starting dynamic subtest: mman
[392.824959] Dynamic subtest mman: SUCCESS (10.019s)
[392.843283] Starting dynamic subtest: dmabuf
[394.742255] Dynamic subtest dmabuf: SUCCESS (1.916s)
[394.765185] Starting dynamic subtest: vma
[396.526342] Dynamic subtest vma: SUCCESS (1.779s)
[396.545804] Starting dynamic subtest: coherency
[402.182664] Dynamic subtest coherency: SUCCESS (5.650s)
[402.200881] Starting dynamic subtest: gtt
[411.351267] Dynamic subtest gtt: SUCCESS (9.165s)
[411.369584] Starting dynamic subtest: gem
[414.091440] Dynamic subtest gem: SUCCESS (2.735s)
[414.109493] Starting dynamic subtest: evict
[422.070310] Dynamic subtest evict: SUCCESS (7.974s)
[422.088634] Starting dynamic subtest: hugepages
[424.325718] Dynamic subtest hugepages: SUCCESS (2.254s)
[424.349619] Starting dynamic subtest: gem_contexts
[448.713923] Dynamic subtest gem_contexts: SUCCESS (24.383s)
[448.736680] Starting dynamic subtest: client
[450.526046] Dynamic subtest client: SUCCESS (1.807s)
[450.549691] Starting dynamic subtest: gem_migrate
[452.306069] Dynamic subtest gem_migrate: SUCCESS (1.775s)
[452.355303] Starting dynamic subtest: reset
[462.031516] Dynamic subtest reset: SUCCESS (9.711s)
[462.050367] Starting dynamic subtest: memory_region
[463.751187] Dynamic subtest memory_region: SUCCESS (1.718s)
[463.778501] Starting dynamic subtest: hangcheck
[488.786357] Dynamic subtest hangcheck: SUCCESS (25.031s)
[488.810139] Starting dynamic subtest: execlists
[500.278149] Dynamic subtest execlists: SUCCESS (11.481s)
[500.297048] Starting dynamic subtest: ring_submission
[501.938579] Dynamic subtest ring_submission: SUCCESS (1.662s)
[501.963230] Starting dynamic subtest: perf
[504.060527] Dynamic subtest perf: SUCCESS (2.114s)
[504.078920] Starting dynamic subtest: slpc
[505.809138] Dynamic subtest slpc: SUCCESS (1.746s)
[505.832419] Starting dynamic subtest: guc
[507.645202] Dynamic subtest guc: SUCCESS (1.829s)
[507.664420] Starting dynamic subtest: guc_multi_lrc
[509.388987] Dynamic subtest guc_multi_lrc: SUCCESS (1.740s)
[509.407764] Starting dynamic subtest: guc_hang
[511.217635] Dynamic subtest guc_hang: SUCCESS (1.822s)
[511.235955] Starting dynamic subtest: late_gt_pm
[512.975101] Dynamic subtest late_gt_pm: SUCCESS (1.755s)
[512.976885] Subtest live: SUCCESS (201.700s)
[513.033747] [160/165] (508s left) dmabuf (all-tests)
[513.274693] Starting subtest: all-tests
[513.280072] Starting dynamic subtest: sanitycheck
[513.345825] Dynamic subtest sanitycheck: SUCCESS (0.072s)
[513.395609] Starting dynamic subtest: dma_fence
[513.546847] Dynamic subtest dma_fence: SUCCESS (0.193s)
[513.578867] Starting dynamic subtest: dma_fence_chain
[544.329088] Dynamic subtest dma_fence_chain: SUCCESS (30.773s)
[544.371490] Starting dynamic subtest: dma_fence_unwrap
[544.389473] Dynamic subtest dma_fence_unwrap: SUCCESS (0.059s)
[544.418384] Starting dynamic subtest: dma_resv
[544.490547] Dynamic subtest dma_resv: SUCCESS (0.090s)
[544.499285] Subtest all-tests: SUCCESS (31.222s)
[544.557204] [161/165] (477s left) i915_suspend (basic-s2idle-without-i915)
[544.776618] Starting subtest: basic-s2idle-without-i915
[566.517431] Subtest basic-s2idle-without-i915: SUCCESS (7.587s)
[569.092115] [162/165] (468s left) i915_suspend (basic-s3-without-i915)
[569.331936] Starting subtest: basic-s3-without-i915
[590.512658] Subtest basic-s3-without-i915: SUCCESS (6.114s)
[592.224499] [163/165] (461s left) gem_exec_suspend (basic-s0)
[592.541492] Starting subtest: basic-S0
[592.543374] Starting dynamic subtest: smem
[615.040317] Dynamic subtest smem: SUCCESS (7.836s)
[615.042112] Subtest basic-S0: SUCCESS (7.841s)
[617.294560] [164/165] (453s left) gem_exec_suspend (basic-s3)
[617.572271] Starting subtest: basic-S3
[617.576084] Starting dynamic subtest: smem
[641.867586] Dynamic subtest smem: SUCCESS (8.821s)
[641.870886] Subtest basic-S3: SUCCESS (8.826s)
[643.089053] [165/165] (444s left) kms_pipe_crc_basic (suspend-read-crc)
[643.811295] Starting subtest: suspend-read-crc
[643.817330] Starting dynamic subtest: pipe-C-HDMI-A-2
[663.738215] Dynamic subtest pipe-C-HDMI-A-2: SUCCESS (4.415s)
[663.740940] Subtest suspend-read-crc: SUCCESS (4.426s)
[666.065343] Closing watchdogs
Done.