[46.306429] Initializing watchdogs
[46.306718]   /dev/watchdog0
[46.323101] [001/164] (960s left) i915_module_load (load)
[46.591425] Starting subtest: load
[50.300306] Subtest load: SUCCESS (3.703s)
[50.413468] [002/164] (956s left) core_auth (basic-auth)
[50.803352] Starting subtest: basic-auth
[50.827227] Subtest basic-auth: SUCCESS (0.023s)
[51.142139] [003/164] (955s left) debugfs_test (read_all_entries)
[51.468983] Starting subtest: read_all_entries
[51.650418] Subtest read_all_entries: SUCCESS (0.182s)
[52.230510] [004/164] (954s left) debugfs_test (basic-hwmon)
[52.473473] Starting subtest: basic-hwmon
[52.478576] Subtest basic-hwmon: SKIP (0.000s)
[53.065489] [005/164] (954s left) fbdev (eof)
[53.331410] Starting subtest: eof
[53.335090] Subtest eof: SUCCESS (0.005s)
[53.459129] [006/164] (953s left) fbdev (info)
[53.676082] Starting subtest: info
[53.678274] Subtest info: SUCCESS (0.000s)
[53.827399] [007/164] (953s left) fbdev (nullptr)
[54.064255] Starting subtest: nullptr
[54.066584] Subtest nullptr: SUCCESS (0.000s)
[54.189517] [008/164] (953s left) fbdev (read)
[54.428616] Starting subtest: read
[62.995933] Subtest read: SUCCESS (8.564s)
[63.126751] [009/164] (944s left) fbdev (write)
[63.365939] Starting subtest: write
[67.833926] Subtest write: SUCCESS (4.466s)
[67.994325] [010/164] (939s left) gem_basic (bad-close)
[68.219357] Starting subtest: bad-close
[68.224442] Subtest bad-close: SUCCESS (0.000s)
[68.357219] [011/164] (939s left) gem_basic (create-close)
[68.580351] Starting subtest: create-close
[68.585626] Subtest create-close: SUCCESS (0.000s)
[68.759666] [012/164] (938s left) gem_basic (create-fd-close)
[69.037216] Starting subtest: create-fd-close
[69.046310] Subtest create-fd-close: SUCCESS (0.000s)
[69.192616] [013/164] (938s left) gem_busy (busy@all-engines)
[69.481280] Starting subtest: busy
[69.484130] Starting dynamic subtest: all-engines
[69.686309] Dynamic subtest all-engines: SUCCESS (0.205s)
[69.687946] Subtest busy: SUCCESS (0.206s)
[70.163312] [014/164] (937s left) gem_close_race (basic-process)
[70.479062] Starting subtest: basic-process
[70.624757] Subtest basic-process: SUCCESS (0.146s)
[70.928165] [015/164] (936s left) gem_close_race (basic-threads)
[71.213184] Starting subtest: basic-threads
[72.423675] Subtest basic-threads: SUCCESS (1.214s)
[72.729906] [016/164] (934s left) gem_ctx_create (basic)
[72.997977] Starting subtest: basic
[73.000798] Subtest basic: SUCCESS (0.000s)
[73.295603] [017/164] (934s left) gem_ctx_create (basic-files)
[73.573654] Starting subtest: basic-files
[75.634292] Subtest basic-files: SUCCESS (2.066s)
[75.925664] [018/164] (931s left) gem_ctx_exec (basic)
[76.167660] Starting subtest: basic
[76.186197] Subtest basic: SUCCESS (0.015s)
[76.361114] [019/164] (931s left) gem_exec_basic (basic)
[76.621079] Starting subtest: basic
[76.624100] Starting dynamic subtest: rcs0-smem
[76.626764] Dynamic subtest rcs0-smem: SUCCESS (0.006s)
[76.658399] Starting dynamic subtest: bcs0-smem
[76.659968] Dynamic subtest bcs0-smem: SUCCESS (0.003s)
[76.677041] Starting dynamic subtest: vcs0-smem
[76.678788] Dynamic subtest vcs0-smem: SUCCESS (0.003s)
[76.695754] Starting dynamic subtest: vecs0-smem
[76.697396] Dynamic subtest vecs0-smem: SUCCESS (0.003s)
[76.698993] Subtest basic: SUCCESS (0.020s)
[76.958379] [020/164] (930s left) gem_exec_create (basic)
[77.229620] Starting subtest: basic
[77.231390] Starting dynamic subtest: smem
[79.306808] Dynamic subtest smem: SUCCESS (2.077s)
[79.309796] Subtest basic: SUCCESS (2.078s)
[79.592225] [021/164] (928s left) gem_exec_fence (basic-busy)
[80.018421] Starting subtest: basic-busy
[80.019987] Starting dynamic subtest: rcs0
[80.037940] Dynamic subtest rcs0: SUCCESS (0.021s)
[80.083676] Starting dynamic subtest: bcs0
[80.087561] Dynamic subtest bcs0: SUCCESS (0.027s)
[80.124477] Starting dynamic subtest: vcs0
[80.130689] Dynamic subtest vcs0: SUCCESS (0.030s)
[80.149973] Starting dynamic subtest: vecs0
[80.154300] Dynamic subtest vecs0: SUCCESS (0.030s)
[80.156822] Subtest basic-busy: SUCCESS (0.111s)
[81.000138] [022/164] (927s left) gem_exec_fence (basic-wait)
[81.421633] Starting subtest: basic-wait
[81.424499] Starting dynamic subtest: rcs0
[81.445127] Dynamic subtest rcs0: SUCCESS (0.025s)
[81.479613] Starting dynamic subtest: bcs0
[81.481543] Dynamic subtest bcs0: SUCCESS (0.028s)
[81.507824] Starting dynamic subtest: vcs0
[81.509650] Dynamic subtest vcs0: SUCCESS (0.027s)
[81.531069] Starting dynamic subtest: vecs0
[81.532648] Dynamic subtest vecs0: SUCCESS (0.028s)
[81.534242] Subtest basic-wait: SUCCESS (0.111s)
[82.231888] [023/164] (925s left) gem_exec_fence (basic-await)
[82.664481] Starting subtest: basic-await
[82.666453] Starting dynamic subtest: rcs0
[82.853181] Dynamic subtest rcs0: SUCCESS (0.184s)
[82.874257] Starting dynamic subtest: bcs0
[83.039217] Dynamic subtest bcs0: SUCCESS (0.184s)
[83.062507] Starting dynamic subtest: vcs0
[83.221408] Dynamic subtest vcs0: SUCCESS (0.178s)
[83.244525] Starting dynamic subtest: vecs0
[83.402492] Dynamic subtest vecs0: SUCCESS (0.185s)
[83.404208] Subtest basic-await: SUCCESS (0.740s)
[84.128676] [024/164] (923s left) gem_exec_fence (nb-await)
[84.559393] Starting subtest: nb-await
[84.561130] Starting dynamic subtest: rcs0
[84.640974] Dynamic subtest rcs0: SUCCESS (0.083s)
[84.667756] Starting dynamic subtest: bcs0
[84.725956] Dynamic subtest bcs0: SUCCESS (0.081s)
[84.753796] Starting dynamic subtest: vcs0
[84.805304] Dynamic subtest vcs0: SUCCESS (0.077s)
[84.831686] Starting dynamic subtest: vecs0
[84.878838] Dynamic subtest vecs0: SUCCESS (0.075s)
[84.880589] Subtest nb-await: SUCCESS (0.322s)
[85.598687] [025/164] (922s left) gem_exec_gttfill (basic)
[85.868516] Starting subtest: basic
[90.018419] Subtest basic: SKIP (4.127s)
[90.337981] [026/164] (917s left) gem_exec_parallel (engines)
[90.741552] Starting subtest: engines
[90.743538] Starting dynamic subtest: basic
[95.716539] Dynamic subtest basic: SUCCESS (4.977s)
[95.748648] Starting dynamic subtest: contexts
[104.357945] Dynamic subtest contexts: SUCCESS (8.638s)
[104.386457] Starting dynamic subtest: fds
[116.502272] Dynamic subtest fds: SUCCESS (12.141s)
[116.526967] Starting dynamic subtest: userptr
[121.862786] Dynamic subtest userptr: SUCCESS (5.363s)
[121.864757] Subtest engines: SUCCESS (31.125s)
[122.200132] [027/164] (886s left) gem_exec_store (basic)
[122.479284] Starting subtest: basic
[122.541892] Subtest basic: SUCCESS (0.069s)
[122.837801] [028/164] (885s left) gem_flink_basic (bad-flink)
[123.070136] Starting subtest: bad-flink
[123.073602] Subtest bad-flink: SUCCESS (0.000s)
[123.234570] [029/164] (885s left) gem_flink_basic (bad-open)
[123.461335] Starting subtest: bad-open
[123.464729] Subtest bad-open: SUCCESS (0.000s)
[123.633761] [030/164] (884s left) gem_flink_basic (basic)
[123.860588] Starting subtest: basic
[123.864315] Subtest basic: SUCCESS (0.000s)
[124.031991] [031/164] (884s left) gem_flink_basic (double-flink)
[124.266474] Starting subtest: double-flink
[124.268667] Subtest double-flink: SUCCESS (0.000s)
[124.428953] [032/164] (884s left) gem_flink_basic (flink-lifetime)
[124.653697] Starting subtest: flink-lifetime
[124.659992] Subtest flink-lifetime: SUCCESS (0.005s)
[124.831458] [033/164] (883s left) gem_huc_copy (huc-copy)
[125.087331] Subtest huc-copy: SKIP (0.000s)
[125.191525] [034/164] (883s left) gem_linear_blits (basic)
[127.033437] Subtest basic: SKIP (0.000s)
[127.207383] [035/164] (881s left) gem_mmap (basic)
[127.561951] Starting subtest: basic
[127.574956] Subtest basic: SUCCESS (0.001s)
[127.727686] [036/164] (881s left) gem_mmap_gtt (basic)
[127.965454] Starting subtest: basic
[127.967920] Subtest basic: SUCCESS (0.003s)
[128.127905] [037/164] (880s left) gem_render_linear_blits (basic)
[128.369685] Starting subtest: basic
[128.477180] Subtest basic: SUCCESS (0.104s)
[128.589058] [038/164] (880s left) gem_render_tiled_blits (basic)
[128.828656] Starting subtest: basic
[128.969734] Subtest basic: SUCCESS (0.129s)
[129.095569] [039/164] (879s left) gem_ringfill (basic-all)
[129.532054] Starting subtest: basic-all
[130.869692] Subtest basic-all: SUCCESS (1.336s)
[131.038662] [040/164] (878s left) gem_softpin (allocator-basic)
[131.283635] Starting subtest: allocator-basic
[131.586476] Subtest allocator-basic: SUCCESS (0.298s)
[131.829438] [041/164] (877s left) gem_softpin (allocator-basic-reserve)
[132.070606] Starting subtest: allocator-basic-reserve
[132.372056] Subtest allocator-basic-reserve: SUCCESS (0.292s)
[132.564841] [042/164] (876s left) gem_softpin (safe-alignment)
[132.819501] Starting subtest: safe-alignment
[132.866352] Subtest safe-alignment: SUCCESS (0.046s)
[133.030148] [043/164] (876s left) gem_sync (basic-all)
[133.310676] Starting subtest: basic-all
[136.065306] Subtest basic-all: SUCCESS (2.756s)
[136.365550] [044/164] (872s left) gem_sync (basic-each)
[136.642771] Starting subtest: basic-each
[139.503663] Subtest basic-each: SUCCESS (2.863s)
[139.812325] [045/164] (869s left) gem_tiled_blits (basic)
[141.864144] Subtest basic: SKIP (0.000s)
[141.994238] [046/164] (867s left) gem_tiled_fence_blits (basic)
[143.904709] Starting subtest: basic
[143.956315] Subtest basic: SUCCESS (0.052s)
[144.169169] [047/164] (865s left) gem_tiled_pread_basic
[145.401738] [048/164] (864s left) gem_wait (busy@all-engines)
[145.698226] Starting subtest: busy
[145.700969] Starting dynamic subtest: all-engines
[146.224640] Dynamic subtest all-engines: SUCCESS (0.528s)
[146.227848] Subtest busy: SUCCESS (0.530s)
[146.602439] [049/164] (862s left) gem_wait (wait@all-engines)
[146.893721] Starting subtest: wait
[146.896996] Starting dynamic subtest: all-engines
[147.935683] Dynamic subtest all-engines: SUCCESS (1.040s)
[147.938166] Subtest wait: SUCCESS (1.041s)
[148.301938] [050/164] (861s left) i915_getparams_basic (basic-eu-total)
[148.531730] Starting subtest: basic-eu-total
[148.535696] Subtest basic-eu-total: SUCCESS (0.000s)
[148.702879] [051/164] (861s left) i915_getparams_basic (basic-subslice-total)
[148.931474] Starting subtest: basic-subslice-total
[148.937275] Subtest basic-subslice-total: SUCCESS (0.000s)
[149.097631] [052/164] (860s left) i915_hangman (error-state-basic)
[149.355388] Starting subtest: error-state-basic
[149.400120] Subtest error-state-basic: SUCCESS (0.036s)
[149.569715] [053/164] (860s left) i915_pciid
[149.963262] [054/164] (859s left) kms_addfb_basic (addfb25-4-tiled)
[150.662337] Starting subtest: addfb25-4-tiled
[150.666113] Subtest addfb25-4-tiled: SUCCESS (0.003s)
[150.832329] [055/164] (859s left) kms_addfb_basic (addfb25-bad-modifier)
[151.065217] Starting subtest: addfb25-bad-modifier
[151.070171] Subtest addfb25-bad-modifier: SUCCESS (0.001s)
[151.664546] [056/164] (858s left) kms_addfb_basic (addfb25-framebuffer-vs-set-tiling)
[151.894265] Starting subtest: addfb25-framebuffer-vs-set-tiling
[151.897116] Subtest addfb25-framebuffer-vs-set-tiling: SUCCESS (0.001s)
[152.469395] [057/164] (857s left) kms_addfb_basic (addfb25-modifier-no-flag)
[152.705854] Starting subtest: addfb25-modifier-no-flag
[152.710683] Subtest addfb25-modifier-no-flag: SUCCESS (0.000s)
[153.302148] [058/164] (856s left) kms_addfb_basic (addfb25-x-tiled-legacy)
[153.533986] Starting subtest: addfb25-x-tiled-legacy
[153.536665] Subtest addfb25-x-tiled-legacy: SUCCESS (0.000s)
[154.103857] [059/164] (856s left) kms_addfb_basic (addfb25-x-tiled-mismatch-legacy)
[154.340939] Starting subtest: addfb25-x-tiled-mismatch-legacy
[154.344136] Subtest addfb25-x-tiled-mismatch-legacy: SUCCESS (0.001s)
[154.936969] [060/164] (855s left) kms_addfb_basic (addfb25-yf-tiled-legacy)
[155.589566] Starting subtest: addfb25-yf-tiled-legacy
[155.591568] Subtest addfb25-yf-tiled-legacy: SUCCESS (0.003s)
[155.774763] [061/164] (854s left) kms_addfb_basic (addfb25-y-tiled-legacy)
[156.426431] Starting subtest: addfb25-y-tiled-legacy
[156.429358] Subtest addfb25-y-tiled-legacy: SUCCESS (0.002s)
[156.601081] [062/164] (853s left) kms_addfb_basic (addfb25-y-tiled-small-legacy)
[157.249572] Starting subtest: addfb25-y-tiled-small-legacy
[157.256518] Subtest addfb25-y-tiled-small-legacy: SKIP (0.000s)
[157.398797] [063/164] (852s left) kms_addfb_basic (bad-pitch-0)
[157.629377] Starting subtest: bad-pitch-0
[157.632712] Subtest bad-pitch-0: SUCCESS (0.000s)
[158.234966] [064/164] (852s left) kms_addfb_basic (bad-pitch-1024)
[158.465322] Starting subtest: bad-pitch-1024
[158.469040] Subtest bad-pitch-1024: SUCCESS (0.000s)
[159.067665] [065/164] (851s left) kms_addfb_basic (bad-pitch-128)
[159.300436] Starting subtest: bad-pitch-128
[159.304542] Subtest bad-pitch-128: SUCCESS (0.000s)
[159.895952] [066/164] (850s left) kms_addfb_basic (bad-pitch-256)
[160.126178] Starting subtest: bad-pitch-256
[160.129743] Subtest bad-pitch-256: SUCCESS (0.000s)
[160.736181] [067/164] (849s left) kms_addfb_basic (bad-pitch-32)
[160.974523] Starting subtest: bad-pitch-32
[160.976261] Subtest bad-pitch-32: SUCCESS (0.000s)
[161.668593] [068/164] (849s left) kms_addfb_basic (bad-pitch-63)
[161.909768] Starting subtest: bad-pitch-63
[161.914745] Subtest bad-pitch-63: SUCCESS (0.000s)
[162.534316] [069/164] (848s left) kms_addfb_basic (bad-pitch-65536)
[162.774151] Starting subtest: bad-pitch-65536
[162.776034] Subtest bad-pitch-65536: SUCCESS (0.001s)
[163.367323] [070/164] (847s left) kms_addfb_basic (bad-pitch-999)
[163.595179] Starting subtest: bad-pitch-999
[163.597621] Subtest bad-pitch-999: SUCCESS (0.000s)
[164.201242] [071/164] (846s left) kms_addfb_basic (basic)
[164.436784] Starting subtest: basic
[164.441356] Subtest basic: SUCCESS (0.002s)
[165.037670] [072/164] (845s left) kms_addfb_basic (basic-x-tiled-legacy)
[165.281572] Starting subtest: basic-x-tiled-legacy
[165.283663] Subtest basic-x-tiled-legacy: SUCCESS (0.000s)
[165.895974] [073/164] (845s left) kms_addfb_basic (basic-y-tiled-legacy)
[166.138617] Starting subtest: basic-y-tiled-legacy
[166.141372] Subtest basic-y-tiled-legacy: SUCCESS (0.001s)
[166.765484] [074/164] (844s left) kms_addfb_basic (bo-too-small)
[167.422836] Starting subtest: bo-too-small
[167.428410] Subtest bo-too-small: SUCCESS (0.002s)
[167.597198] [075/164] (843s left) kms_addfb_basic (bo-too-small-due-to-tiling)
[168.252623] Starting subtest: bo-too-small-due-to-tiling
[168.255793] Subtest bo-too-small-due-to-tiling: SUCCESS (0.002s)
[168.433581] [076/164] (842s left) kms_addfb_basic (clobberred-modifier)
[168.666671] Starting subtest: clobberred-modifier
[168.671261] Subtest clobberred-modifier: SUCCESS (0.000s)
[169.235663] [077/164] (841s left) kms_addfb_basic (framebuffer-vs-set-tiling)
[169.478692] Starting subtest: framebuffer-vs-set-tiling
[169.480618] Subtest framebuffer-vs-set-tiling: SUCCESS (0.000s)
[170.101680] [078/164] (841s left) kms_addfb_basic (invalid-get-prop)
[170.337664] Starting subtest: invalid-get-prop
[170.341362] Subtest invalid-get-prop: SUCCESS (0.000s)
[170.936519] [079/164] (840s left) kms_addfb_basic (invalid-get-prop-any)
[171.172046] Starting subtest: invalid-get-prop-any
[171.173713] Subtest invalid-get-prop-any: SUCCESS (0.000s)
[171.764684] [080/164] (839s left) kms_addfb_basic (invalid-set-prop)
[172.000731] Starting subtest: invalid-set-prop
[172.002434] Subtest invalid-set-prop: SUCCESS (0.000s)
[172.568465] [081/164] (838s left) kms_addfb_basic (invalid-set-prop-any)
[172.802247] Starting subtest: invalid-set-prop-any
[172.807594] Subtest invalid-set-prop-any: SUCCESS (0.000s)
[173.398849] [082/164] (838s left) kms_addfb_basic (no-handle)
[173.628942] Starting subtest: no-handle
[173.632762] Subtest no-handle: SUCCESS (0.000s)
[174.197415] [083/164] (837s left) kms_addfb_basic (size-max)
[174.856214] Starting subtest: size-max
[174.857953] Subtest size-max: SUCCESS (0.000s)
[175.032876] [084/164] (836s left) kms_addfb_basic (small-bo)
[175.677927] Starting subtest: small-bo
[175.681684] Subtest small-bo: SUCCESS (0.000s)
[175.833490] [085/164] (835s left) kms_addfb_basic (tile-pitch-mismatch)
[176.077390] Starting subtest: tile-pitch-mismatch
[176.080138] Subtest tile-pitch-mismatch: SUCCESS (0.002s)
[176.668877] [086/164] (835s left) kms_addfb_basic (too-high)
[177.323969] Starting subtest: too-high
[177.330343] Subtest too-high: SUCCESS (0.006s)
[177.503705] [087/164] (834s left) kms_addfb_basic (too-wide)
[178.159342] Starting subtest: too-wide
[178.161622] Subtest too-wide: SUCCESS (0.000s)
[178.338723] [088/164] (833s left) kms_addfb_basic (unused-handle)
[178.588230] Starting subtest: unused-handle
[178.592191] Subtest unused-handle: SUCCESS (0.000s)
[179.197721] [089/164] (832s left) kms_addfb_basic (unused-modifier)
[179.432354] Starting subtest: unused-modifier
[179.438666] Subtest unused-modifier: SUCCESS (0.000s)
[180.031895] [090/164] (831s left) kms_addfb_basic (unused-offsets)
[180.264360] Starting subtest: unused-offsets
[180.269148] Subtest unused-offsets: SUCCESS (0.000s)
[180.828311] [091/164] (831s left) kms_addfb_basic (unused-pitches)
[181.058697] Starting subtest: unused-pitches
[181.062131] Subtest unused-pitches: SUCCESS (0.000s)
[181.632130] [092/164] (830s left) kms_busy (basic)
[182.307943] Starting subtest: basic
[182.320224] Starting dynamic subtest: flip
[183.916592] Dynamic subtest flip: SUCCESS (1.606s)
[183.965266] Starting dynamic subtest: modeset
[186.819456] Dynamic subtest modeset: SUCCESS (2.888s)
[186.827174] Subtest basic: SUCCESS (4.502s)
[187.502280] [093/164] (824s left) kms_prop_blob (basic)
[187.739951] Starting subtest: basic
[187.742789] Subtest basic: SUCCESS (0.000s)
[187.902657] [094/164] (824s left) kms_cursor_legacy (basic-busy-flip-before-cursor-atomic)
[188.567413] Starting subtest: basic-busy-flip-before-cursor-atomic
[190.795525] Subtest basic-busy-flip-before-cursor-atomic: SUCCESS (2.218s)
[191.391696] [095/164] (820s left) kms_cursor_legacy (basic-busy-flip-before-cursor-legacy)
[192.043313] Starting subtest: basic-busy-flip-before-cursor-legacy
[194.333298] Subtest basic-busy-flip-before-cursor-legacy: SUCCESS (2.294s)
[194.954586] [096/164] (817s left) kms_cursor_legacy (basic-flip-after-cursor-atomic)
[195.600186] Starting subtest: basic-flip-after-cursor-atomic
[197.871636] Subtest basic-flip-after-cursor-atomic: SUCCESS (2.263s)
[198.381967] [097/164] (813s left) kms_cursor_legacy (basic-flip-after-cursor-legacy)
[199.042115] Starting subtest: basic-flip-after-cursor-legacy
[201.240999] Subtest basic-flip-after-cursor-legacy: SUCCESS (2.200s)
[201.844305] [098/164] (810s left) kms_cursor_legacy (basic-flip-after-cursor-varying-size)
[202.524756] Starting subtest: basic-flip-after-cursor-varying-size
[204.731082] Subtest basic-flip-after-cursor-varying-size: SUCCESS (2.207s)
[205.539554] [099/164] (806s left) kms_cursor_legacy (basic-flip-before-cursor-atomic)
[206.229246] Starting subtest: basic-flip-before-cursor-atomic
[208.459685] Subtest basic-flip-before-cursor-atomic: SUCCESS (2.235s)
[209.089760] [100/164] (803s left) kms_cursor_legacy (basic-flip-before-cursor-legacy)
[209.754442] Starting subtest: basic-flip-before-cursor-legacy
[211.967508] Subtest basic-flip-before-cursor-legacy: SUCCESS (2.212s)
[212.573823] [101/164] (799s left) kms_cursor_legacy (basic-flip-before-cursor-varying-size)
[213.247380] Starting subtest: basic-flip-before-cursor-varying-size
[215.482599] Subtest basic-flip-before-cursor-varying-size: SUCCESS (2.238s)
[216.060155] [102/164] (796s left) kms_flip (basic-flip-vs-dpms)
[216.516630] Starting subtest: basic-flip-vs-dpms
[216.533300] Starting dynamic subtest: C-HDMI-A2
[219.770103] Dynamic subtest C-HDMI-A2: SUCCESS (3.229s)
[219.777697] Subtest basic-flip-vs-dpms: SUCCESS (3.252s)
[220.380294] [103/164] (792s left) kms_flip (basic-flip-vs-modeset)
[220.846583] Starting subtest: basic-flip-vs-modeset
[220.858785] Starting dynamic subtest: C-HDMI-A2
[224.075919] Dynamic subtest C-HDMI-A2: SUCCESS (3.203s)
[224.084172] Subtest basic-flip-vs-modeset: SUCCESS (3.230s)
[224.776475] [104/164] (787s left) kms_flip (basic-flip-vs-wf_vblank)
[225.235138] Starting subtest: basic-flip-vs-wf_vblank
[225.256778] Starting dynamic subtest: C-HDMI-A2
[228.785298] Dynamic subtest C-HDMI-A2: SUCCESS (3.529s)
[228.787890] Subtest basic-flip-vs-wf_vblank: SUCCESS (3.557s)
[229.024810] [105/164] (783s left) kms_flip (basic-plain-flip)
[229.490551] Starting subtest: basic-plain-flip
[229.506730] Starting dynamic subtest: C-HDMI-A2
[232.462791] Dynamic subtest C-HDMI-A2: SUCCESS (2.948s)
[232.469186] Subtest basic-plain-flip: SUCCESS (2.972s)
[232.701907] [106/164] (780s left) kms_force_connector_basic (force-connector-state)
[233.069209] Starting subtest: force-connector-state
[233.999310] Subtest force-connector-state: SUCCESS (0.932s)
[235.419714] [107/164] (777s left) kms_force_connector_basic (force-edid)
[235.766650] Starting subtest: force-edid
[235.863748] Subtest force-edid: SUCCESS (0.100s)
[236.717881] [108/164] (776s left) kms_force_connector_basic (force-load-detect)
[237.061739] Starting subtest: force-load-detect
[237.067472] Subtest force-load-detect: SKIP (0.000s)
[237.652764] [109/164] (775s left) kms_force_connector_basic (prune-stale-modes)
[238.040704] Starting subtest: prune-stale-modes
[238.162892] Subtest prune-stale-modes: SUCCESS (0.129s)
[239.056630] [110/164] (774s left) kms_frontbuffer_tracking (basic)
[239.789113] Starting subtest: basic
[245.290651] Subtest basic: FAIL (5.044s)
[245.330478] [111/164] (767s left) kms_hdmi_inject (inject-audio)
[245.735397] Starting subtest: inject-audio
[246.203392] Subtest inject-audio: FAIL (0.403s)
[247.228744] [112/164] (765s left) kms_pipe_crc_basic (compare-crc-sanitycheck-xr24)
[247.965547] Starting subtest: compare-crc-sanitycheck-xr24
[247.968631] Starting dynamic subtest: pipe-C-HDMI-A-2
[249.008571] Dynamic subtest pipe-C-HDMI-A-2: SUCCESS (1.032s)
[249.012157] Subtest compare-crc-sanitycheck-xr24: SUCCESS (1.046s)
[249.694989] [113/164] (763s left) kms_pipe_crc_basic (compare-crc-sanitycheck-nv12)
[250.383612] Starting subtest: compare-crc-sanitycheck-nv12
[250.385373] Starting dynamic subtest: pipe-C-HDMI-A-2
[250.397884] Dynamic subtest pipe-C-HDMI-A-2: SKIP (0.008s)
[250.406124] Subtest compare-crc-sanitycheck-nv12: SKIP (0.020s)
[250.585273] [114/164] (762s left) kms_pipe_crc_basic (hang-read-crc)
[251.265399] Starting subtest: hang-read-crc
[251.269314] Starting dynamic subtest: pipe-C-HDMI-A-2
[254.061743] Dynamic subtest pipe-C-HDMI-A-2: SUCCESS (2.792s)
[254.064471] Subtest hang-read-crc: SUCCESS (2.807s)
[254.606115] [115/164] (758s left) kms_pipe_crc_basic (nonblocking-crc)
[255.313511] Starting subtest: nonblocking-crc
[255.318979] Starting dynamic subtest: pipe-C-HDMI-A-2
[256.691760] Dynamic subtest pipe-C-HDMI-A-2: SUCCESS (1.367s)
[256.694308] Subtest nonblocking-crc: SUCCESS (1.381s)
[257.280213] [116/164] (756s left) kms_pipe_crc_basic (nonblocking-crc-frame-sequence)
[257.989184] Starting subtest: nonblocking-crc-frame-sequence
[257.992225] Starting dynamic subtest: pipe-C-HDMI-A-2
[259.356369] Dynamic subtest pipe-C-HDMI-A-2: SUCCESS (1.371s)
[259.358150] Subtest nonblocking-crc-frame-sequence: SUCCESS (1.379s)
[259.939285] [117/164] (753s left) kms_pipe_crc_basic (read-crc)
[260.632758] Starting subtest: read-crc
[260.647160] Starting dynamic subtest: pipe-C-HDMI-A-2
[261.888904] Dynamic subtest pipe-C-HDMI-A-2: SUCCESS (1.247s)
[261.890978] Subtest read-crc: SUCCESS (1.256s)
[262.478324] [118/164] (751s left) kms_pipe_crc_basic (read-crc-frame-sequence)
[263.193697] Starting subtest: read-crc-frame-sequence
[263.200133] Starting dynamic subtest: pipe-C-HDMI-A-2
[264.484835] Dynamic subtest pipe-C-HDMI-A-2: SUCCESS (1.284s)
[264.487242] Subtest read-crc-frame-sequence: SUCCESS (1.300s)
[265.066893] [119/164] (748s left) kms_pm_backlight (basic-brightness)
[265.773690] Subtest basic-brightness: SKIP (0.000s)
[265.861206] [120/164] (747s left) kms_psr (primary_page_flip)
[266.098165] Subtest primary_page_flip: SKIP (0.000s)
[266.194641] [121/164] (747s left) kms_psr (cursor_plane_move)
[266.479498] Subtest cursor_plane_move: SKIP (0.000s)
[266.591829] [122/164] (747s left) kms_psr (sprite_plane_onoff)
[266.829862] Subtest sprite_plane_onoff: SKIP (0.000s)
[266.927667] [123/164] (746s left) kms_psr (primary_mmap_gtt)
[267.165669] Subtest primary_mmap_gtt: SKIP (0.000s)
[267.263426] [124/164] (746s left) kms_setmode (basic-clone-single-crtc)
[267.502709] Starting subtest: basic-clone-single-crtc
[267.510420] Subtest basic-clone-single-crtc: SKIP (0.001s)
[267.666621] [125/164] (746s left) i915_pm_rpm (basic-pci-d3-state)
[270.215830] Starting subtest: basic-pci-d3-state
[270.621106] Subtest basic-pci-d3-state: SUCCESS (0.393s)
[271.046353] [126/164] (743s left) i915_pm_rpm (basic-rte)
[271.279967] Starting subtest: basic-rte
[273.932452] Subtest basic-rte: SUCCESS (2.649s)
[275.107546] [127/164] (739s left) i915_pm_rps (basic-api)
[275.356639] Starting subtest: basic-api
[275.370501] Subtest basic-api: SUCCESS (0.014s)
[275.544631] [128/164] (738s left) prime_self_import (basic-llseek-bad)
[275.767690] Starting subtest: basic-llseek-bad
[275.772858] Subtest basic-llseek-bad: SUCCESS (0.007s)
[275.944747] [129/164] (738s left) prime_self_import (basic-llseek-size)
[276.169469] Starting subtest: basic-llseek-size
[276.190302] Subtest basic-llseek-size: SUCCESS (0.018s)
[276.374645] [130/164] (737s left) prime_self_import (basic-with_fd_dup)
[276.600955] Starting subtest: basic-with_fd_dup
[276.615773] Subtest basic-with_fd_dup: SUCCESS (0.015s)
[276.801930] [131/164] (737s left) prime_self_import (basic-with_one_bo)
[277.029108] Starting subtest: basic-with_one_bo
[277.041669] Subtest basic-with_one_bo: SUCCESS (0.011s)
[277.200175] [132/164] (737s left) prime_self_import (basic-with_one_bo_two_files)
[277.424453] Starting subtest: basic-with_one_bo_two_files
[277.440851] Subtest basic-with_one_bo_two_files: SUCCESS (0.015s)
[277.601578] [133/164] (736s left) prime_self_import (basic-with_two_bos)
[277.828330] Starting subtest: basic-with_two_bos
[277.840277] Subtest basic-with_two_bos: SUCCESS (0.012s)
[278.000692] [134/164] (736s left) prime_vgem (basic-fence-flip)
[278.304504] Starting subtest: basic-fence-flip
[279.318775] Subtest basic-fence-flip: SKIP (1.022s)
[279.567294] [135/164] (735s left) prime_vgem (basic-fence-mmap)
[279.857698] Starting subtest: basic-fence-mmap
[279.967234] Subtest basic-fence-mmap: SUCCESS (0.106s)
[280.134535] [136/164] (734s left) prime_vgem (basic-fence-read)
[280.424305] Starting subtest: basic-fence-read
[280.614565] Subtest basic-fence-read: SUCCESS (0.193s)
[280.804442] [137/164] (733s left) prime_vgem (basic-gtt)
[281.089051] Starting subtest: basic-gtt
[281.138803] Subtest basic-gtt: SUCCESS (0.046s)
[281.299404] [138/164] (733s left) prime_vgem (basic-read)
[281.559704] Starting subtest: basic-read
[281.638629] Subtest basic-read: SUCCESS (0.079s)
[281.838700] [139/164] (733s left) prime_vgem (basic-write)
[282.127532] Starting subtest: basic-write
[282.214942] Subtest basic-write: SUCCESS (0.092s)
[282.402074] [140/164] (732s left) vgem_basic (setversion)
[282.668245] Starting subtest: setversion
[282.671356] Subtest setversion: SUCCESS (0.000s)
[282.801646] [141/164] (732s left) vgem_basic (create)
[283.033426] Starting subtest: create
[283.036732] Subtest create: SUCCESS (0.001s)
[283.166678] [142/164] (731s left) vgem_basic (debugfs)
[283.435048] Starting subtest: debugfs
[283.437106] Subtest debugfs: SUCCESS (0.002s)
[283.565713] [143/164] (731s left) vgem_basic (dmabuf-export)
[283.797669] Starting subtest: dmabuf-export
[283.809175] Subtest dmabuf-export: SUCCESS (0.008s)
[283.970906] [144/164] (731s left) vgem_basic (dmabuf-fence)
[284.236175] Starting subtest: dmabuf-fence
[284.238388] Subtest dmabuf-fence: SUCCESS (0.002s)
[284.366918] [145/164] (730s left) vgem_basic (dmabuf-fence-before)
[284.637334] Starting subtest: dmabuf-fence-before
[284.639155] Subtest dmabuf-fence-before: SUCCESS (0.001s)
[284.774788] [146/164] (730s left) vgem_basic (dmabuf-mmap)
[285.028463] Starting subtest: dmabuf-mmap
[285.070691] Subtest dmabuf-mmap: SUCCESS (0.042s)
[285.202154] [147/164] (730s left) vgem_basic (mmap)
[285.467517] Starting subtest: mmap
[285.495643] Subtest mmap: SUCCESS (0.029s)
[285.634762] [148/164] (729s left) vgem_basic (second-client)
[285.906197] Starting subtest: second-client
[285.967630] Subtest second-client: SUCCESS (0.061s)
[286.105975] [149/164] (729s left) vgem_basic (sysfs)
[286.372152] Starting subtest: sysfs
[286.374193] Subtest sysfs: SUCCESS (0.002s)
[286.506903] [150/164] (728s left) core_hotunplug (unbind-rebind)
[286.863165] Starting subtest: unbind-rebind
[291.946224] Subtest unbind-rebind: SUCCESS (5.083s)
[292.015705] [151/164] (723s left) vgem_basic (unload)
[292.261461] Starting subtest: unload
[321.442783] Subtest unload: SUCCESS (29.182s)
[321.755582] [152/164] (693s left) i915_module_load (reload)
[321.983136] Starting subtest: reload
[327.094116] Subtest reload: SUCCESS (5.103s)
[327.239597] [153/164] (688s left) gem_lmem_swapping (basic)
[327.567710] Subtest basic: SKIP (0.000s)
[327.739291] [154/164] (688s left) gem_lmem_swapping (parallel-random-engines)
[328.008097] Subtest parallel-random-engines: SKIP (0.000s)
[328.111136] [155/164] (687s left) gem_lmem_swapping (random-engines)
[328.369491] Subtest random-engines: SKIP (0.000s)
[328.479137] [156/164] (687s left) gem_lmem_swapping (verify-random)
[328.727786] Subtest verify-random: SKIP (0.000s)
[328.850982] [157/164] (687s left) i915_pm_rpm (module-reload)
[331.743169] Starting subtest: module-reload
[346.265089] Subtest module-reload: SUCCESS (14.533s)
[346.319678] [158/164] (669s left) i915_selftest (live)
[346.589715] Starting subtest: live
[346.591752] Starting dynamic subtest: sanitycheck
[348.396886] Dynamic subtest sanitycheck: SUCCESS (1.807s)
[348.431242] Starting dynamic subtest: uncore
[350.265541] Dynamic subtest uncore: SUCCESS (1.865s)
[350.284893] Starting dynamic subtest: workarounds
[352.346731] Dynamic subtest workarounds: SUCCESS (2.077s)
[352.366536] Starting dynamic subtest: gt_engines
[354.621607] Dynamic subtest gt_engines: SUCCESS (2.273s)
[354.649836] Starting dynamic subtest: gt_timelines
[383.715848] Dynamic subtest gt_timelines: SUCCESS (29.083s)
[383.735167] Starting dynamic subtest: gt_contexts
[385.685172] Dynamic subtest gt_contexts: SUCCESS (1.962s)
[385.705812] Starting dynamic subtest: gt_lrc
[390.774467] Dynamic subtest gt_lrc: SUCCESS (5.088s)
[390.796948] Starting dynamic subtest: gt_mocs
[392.605580] Dynamic subtest gt_mocs: SUCCESS (1.826s)
[392.638419] Starting dynamic subtest: gt_pm
[395.518878] Dynamic subtest gt_pm: SUCCESS (2.904s)
[395.540150] Starting dynamic subtest: gt_heartbeat
[397.467053] Dynamic subtest gt_heartbeat: SUCCESS (1.943s)
[397.488269] Starting dynamic subtest: gt_tlb
[399.642162] Dynamic subtest gt_tlb: SUCCESS (2.171s)
[399.662932] Starting dynamic subtest: requests
[407.936214] Dynamic subtest requests: SUCCESS (8.290s)
[407.955902] Starting dynamic subtest: migrate
[413.030243] Dynamic subtest migrate: SUCCESS (5.091s)
[413.049560] Starting dynamic subtest: active
[415.001414] Dynamic subtest active: SUCCESS (1.965s)
[415.021378] Starting dynamic subtest: objects
[418.772416] Dynamic subtest objects: SUCCESS (3.766s)
[418.791849] Starting dynamic subtest: mman
[429.028067] Dynamic subtest mman: SUCCESS (10.252s)
[429.049962] Starting dynamic subtest: dmabuf
[431.015572] Dynamic subtest dmabuf: SUCCESS (1.984s)
[431.039783] Starting dynamic subtest: vma
[432.830828] Dynamic subtest vma: SUCCESS (1.808s)
[432.851196] Starting dynamic subtest: coherency
[440.126292] Dynamic subtest coherency: SUCCESS (7.291s)
[440.146312] Starting dynamic subtest: gtt
[449.535140] Dynamic subtest gtt: SUCCESS (9.406s)
[449.558772] Starting dynamic subtest: gem
[452.322851] Dynamic subtest gem: SUCCESS (2.781s)
[452.343054] Starting dynamic subtest: evict
[460.379361] Dynamic subtest evict: SUCCESS (8.053s)
[460.400354] Starting dynamic subtest: hugepages
[462.607724] Dynamic subtest hugepages: SUCCESS (2.227s)
[462.637857] Starting dynamic subtest: gem_contexts
[486.932323] Dynamic subtest gem_contexts: SUCCESS (24.316s)
[486.958114] Starting dynamic subtest: client
[488.898762] Dynamic subtest client: SUCCESS (1.958s)
[488.922865] Starting dynamic subtest: gem_migrate
[490.722066] Dynamic subtest gem_migrate: SUCCESS (1.817s)
[490.743278] Starting dynamic subtest: reset
[500.489715] Dynamic subtest reset: SUCCESS (9.763s)
[500.511072] Starting dynamic subtest: memory_region
[502.214255] Dynamic subtest memory_region: SUCCESS (1.720s)
[502.240201] Starting dynamic subtest: hangcheck
[527.332296] Dynamic subtest hangcheck: SUCCESS (25.112s)
[527.351933] Starting dynamic subtest: execlists
[539.027791] Dynamic subtest execlists: SUCCESS (11.694s)
[539.062210] Starting dynamic subtest: ring_submission
[540.876119] Dynamic subtest ring_submission: SUCCESS (1.840s)
[540.913395] Starting dynamic subtest: perf
[543.081053] Dynamic subtest perf: SUCCESS (2.199s)
[543.102129] Starting dynamic subtest: slpc
[544.836539] Dynamic subtest slpc: SUCCESS (1.754s)
[544.864156] Starting dynamic subtest: guc
[546.572278] Dynamic subtest guc: SUCCESS (1.730s)
[546.593145] Starting dynamic subtest: guc_multi_lrc
[548.358236] Dynamic subtest guc_multi_lrc: SUCCESS (1.782s)
[548.379389] Starting dynamic subtest: guc_hang
[550.176618] Dynamic subtest guc_hang: SUCCESS (1.817s)
[550.225112] Starting dynamic subtest: late_gt_pm
[552.094159] Dynamic subtest late_gt_pm: SUCCESS (1.906s)
[552.095876] Subtest live: SUCCESS (205.510s)
[552.154450] [159/164] (463s left) dmabuf (all-tests)
[552.410432] Starting subtest: all-tests
[552.412600] Starting dynamic subtest: sanitycheck
[552.482256] Dynamic subtest sanitycheck: SUCCESS (0.076s)
[552.542220] Starting dynamic subtest: dma_fence
[552.688577] Dynamic subtest dma_fence: SUCCESS (0.198s)
[552.736339] Starting dynamic subtest: dma_fence_chain
[583.878139] Dynamic subtest dma_fence_chain: SUCCESS (31.181s)
[583.925500] Starting dynamic subtest: dma_fence_unwrap
[583.947571] Dynamic subtest dma_fence_unwrap: SUCCESS (0.063s)
[583.991857] Starting dynamic subtest: dma_resv
[584.019266] Dynamic subtest dma_resv: SUCCESS (0.062s)
[584.025645] Subtest all-tests: SUCCESS (31.621s)
[584.080704] [160/164] (432s left) i915_suspend (basic-s2idle-without-i915)
[584.303110] Starting subtest: basic-s2idle-without-i915
[606.523768] Subtest basic-s2idle-without-i915: SUCCESS (7.751s)
[609.206747] [161/164] (423s left) i915_suspend (basic-s3-without-i915)
[609.453871] Starting subtest: basic-s3-without-i915
[630.333409] Subtest basic-s3-without-i915: SUCCESS (6.073s)
[631.567754] [162/164] (416s left) gem_exec_suspend (basic-s0)
[632.023645] Starting subtest: basic-S0
[632.026434] Starting dynamic subtest: smem
[654.475881] Dynamic subtest smem: SUCCESS (7.829s)
[654.477827] Subtest basic-S0: SUCCESS (7.835s)
[656.733390] [163/164] (408s left) gem_exec_suspend (basic-s3)
[657.017474] Starting subtest: basic-S3
[657.022337] Starting dynamic subtest: smem
[680.000736] Dynamic subtest smem: SUCCESS (8.304s)
[680.002913] Subtest basic-S3: SUCCESS (8.308s)
[681.260380] [164/164] (399s left) kms_pipe_crc_basic (suspend-read-crc)
[681.965176] Starting subtest: suspend-read-crc
[681.971756] Starting dynamic subtest: pipe-C-HDMI-A-2
[703.121825] Dynamic subtest pipe-C-HDMI-A-2: SUCCESS (5.460s)
[703.126145] Subtest suspend-read-crc: SUCCESS (5.474s)
[705.546789] Closing watchdogs
Done.