[54.372500] Initializing watchdogs
[54.372798]   /dev/watchdog0
[54.390532] [001/165] (960s left) i915_module_load (load)
[54.650790] Starting subtest: load
[58.080319] Subtest load: SUCCESS (3.433s)
[58.146934] [002/165] (956s left) core_auth (basic-auth)
[58.776099] Starting subtest: basic-auth
[58.797985] Subtest basic-auth: SUCCESS (0.016s)
[59.012464] [003/165] (956s left) debugfs_test (read_all_entries)
[59.274940] Starting subtest: read_all_entries
[59.419553] Subtest read_all_entries: SUCCESS (0.143s)
[59.946440] [004/165] (955s left) debugfs_test (basic-hwmon)
[60.191767] Starting subtest: basic-hwmon
[60.196768] Subtest basic-hwmon: SKIP (0.000s)
[60.730528] [005/165] (954s left) fbdev (eof)
[60.971855] Starting subtest: eof
[60.973484] Subtest eof: SUCCESS (0.002s)
[61.045061] [006/165] (954s left) fbdev (info)
[61.260229] Starting subtest: info
[61.265171] Subtest info: SUCCESS (0.000s)
[61.365682] [007/165] (953s left) fbdev (nullptr)
[61.596213] Starting subtest: nullptr
[61.600154] Subtest nullptr: SUCCESS (0.002s)
[61.695168] [008/165] (953s left) fbdev (read)
[61.936082] Starting subtest: read
[64.004149] Subtest read: SUCCESS (2.064s)
[64.112672] [009/165] (951s left) fbdev (write)
[64.352725] Starting subtest: write
[65.423617] Subtest write: SUCCESS (1.065s)
[65.494201] [010/165] (949s left) gem_basic (bad-close)
[65.721054] Starting subtest: bad-close
[65.724672] Subtest bad-close: SUCCESS (0.000s)
[65.812260] [011/165] (949s left) gem_basic (create-close)
[66.046834] Starting subtest: create-close
[66.053135] Subtest create-close: SUCCESS (0.000s)
[66.144856] [012/165] (949s left) gem_basic (create-fd-close)
[66.364633] Starting subtest: create-fd-close
[66.368314] Subtest create-fd-close: SUCCESS (0.001s)
[66.475125] [013/165] (949s left) gem_busy (busy@all-engines)
[66.752082] Starting subtest: busy
[66.755517] Starting dynamic subtest: all-engines
[66.899088] Dynamic subtest all-engines: SUCCESS (0.152s)
[66.900465] Subtest busy: SUCCESS (0.154s)
[67.318808] [014/165] (948s left) gem_close_race (basic-process)
[67.597098] Starting subtest: basic-process
[67.742442] Subtest basic-process: SUCCESS (0.144s)
[67.988850] [015/165] (947s left) gem_close_race (basic-threads)
[68.327966] Starting subtest: basic-threads
[69.583200] Subtest basic-threads: SUCCESS (1.259s)
[69.816289] [016/165] (945s left) gem_ctx_create (basic)
[70.101315] Starting subtest: basic
[70.103108] Subtest basic: SUCCESS (0.000s)
[70.332415] [017/165] (945s left) gem_ctx_create (basic-files)
[70.650959] Starting subtest: basic-files
[72.828950] Subtest basic-files: SUCCESS (2.180s)
[73.066470] [018/165] (942s left) gem_ctx_exec (basic)
[73.328166] Starting subtest: basic
[73.356820] Subtest basic: SUCCESS (0.025s)
[73.462529] [019/165] (942s left) gem_exec_basic (basic)
[73.742153] Starting subtest: basic
[73.744681] Starting dynamic subtest: rcs0-smem
[73.751136] Dynamic subtest rcs0-smem: SUCCESS (0.006s)
[73.777265] Starting dynamic subtest: bcs0-smem
[73.778844] Dynamic subtest bcs0-smem: SUCCESS (0.003s)
[73.795845] Starting dynamic subtest: vcs0-smem
[73.797386] Dynamic subtest vcs0-smem: SUCCESS (0.002s)
[73.814539] Starting dynamic subtest: vecs0-smem
[73.815941] Dynamic subtest vecs0-smem: SUCCESS (0.003s)
[73.817483] Subtest basic: SUCCESS (0.024s)
[73.998203] [020/165] (941s left) gem_exec_create (basic)
[74.292146] Starting subtest: basic
[74.294295] Starting dynamic subtest: smem
[76.374749] Dynamic subtest smem: SUCCESS (2.085s)
[76.378808] Subtest basic: SUCCESS (2.088s)
[76.620528] [021/165] (939s left) gem_exec_fence (basic-busy)
[77.052756] Starting subtest: basic-busy
[77.054360] Starting dynamic subtest: rcs0
[77.073573] Dynamic subtest rcs0: SUCCESS (0.024s)
[77.109586] Starting dynamic subtest: bcs0
[77.114887] Dynamic subtest bcs0: SUCCESS (0.028s)
[77.155082] Starting dynamic subtest: vcs0
[77.157877] Dynamic subtest vcs0: SUCCESS (0.028s)
[77.177622] Starting dynamic subtest: vecs0
[77.180242] Dynamic subtest vecs0: SUCCESS (0.035s)
[77.181674] Subtest basic-busy: SUCCESS (0.119s)
[77.933300] [022/165] (938s left) gem_exec_fence (basic-wait)
[78.360083] Starting subtest: basic-wait
[78.361831] Starting dynamic subtest: rcs0
[78.393310] Dynamic subtest rcs0: SUCCESS (0.032s)
[78.411846] Starting dynamic subtest: bcs0
[78.418240] Dynamic subtest bcs0: SUCCESS (0.024s)
[78.446620] Starting dynamic subtest: vcs0
[78.448426] Dynamic subtest vcs0: SUCCESS (0.025s)
[78.472043] Starting dynamic subtest: vecs0
[78.473555] Dynamic subtest vecs0: SUCCESS (0.022s)
[78.475064] Subtest basic-wait: SUCCESS (0.106s)
[79.112745] [023/165] (936s left) gem_exec_fence (basic-await)
[79.532068] Starting subtest: basic-await
[79.534262] Starting dynamic subtest: rcs0
[79.725123] Dynamic subtest rcs0: SUCCESS (0.191s)
[79.747519] Starting dynamic subtest: bcs0
[79.913058] Dynamic subtest bcs0: SUCCESS (0.179s)
[79.932087] Starting dynamic subtest: vcs0
[80.093380] Dynamic subtest vcs0: SUCCESS (0.184s)
[80.115476] Starting dynamic subtest: vecs0
[80.274428] Dynamic subtest vecs0: SUCCESS (0.180s)
[80.275927] Subtest basic-await: SUCCESS (0.740s)
[80.917544] [024/165] (935s left) gem_exec_fence (nb-await)
[81.351659] Starting subtest: nb-await
[81.353491] Starting dynamic subtest: rcs0
[81.431151] Dynamic subtest rcs0: SUCCESS (0.081s)
[81.454271] Starting dynamic subtest: bcs0
[81.508328] Dynamic subtest bcs0: SUCCESS (0.077s)
[81.532405] Starting dynamic subtest: vcs0
[81.588473] Dynamic subtest vcs0: SUCCESS (0.078s)
[81.610302] Starting dynamic subtest: vecs0
[81.664543] Dynamic subtest vecs0: SUCCESS (0.078s)
[81.665885] Subtest nb-await: SUCCESS (0.318s)
[82.318548] [025/165] (933s left) gem_exec_gttfill (basic)
[82.588780] Starting subtest: basic
[84.446810] Subtest basic: SKIP (1.844s)
[84.707135] [026/165] (931s left) gem_exec_parallel (engines)
[85.143391] Starting subtest: engines
[85.145169] Starting dynamic subtest: basic
[90.674513] Dynamic subtest basic: SUCCESS (5.528s)
[90.697214] Starting dynamic subtest: contexts
[99.799352] Dynamic subtest contexts: SUCCESS (9.124s)
[99.843460] Starting dynamic subtest: fds
[113.923898] Dynamic subtest fds: SUCCESS (14.119s)
[113.957650] Starting dynamic subtest: userptr
[119.425769] Dynamic subtest userptr: SUCCESS (5.500s)
[119.427278] Subtest engines: SUCCESS (34.280s)
[119.696237] [027/165] (896s left) gem_exec_store (basic)
[119.973060] Starting subtest: basic
[120.043198] Subtest basic: SUCCESS (0.075s)
[120.271577] [028/165] (896s left) gem_flink_basic (bad-flink)
[120.495936] Starting subtest: bad-flink
[120.498270] Subtest bad-flink: SUCCESS (0.000s)
[120.608058] [029/165] (895s left) gem_flink_basic (bad-open)
[120.835887] Starting subtest: bad-open
[120.838258] Subtest bad-open: SUCCESS (0.000s)
[120.931837] [030/165] (895s left) gem_flink_basic (basic)
[121.162373] Starting subtest: basic
[121.164272] Subtest basic: SUCCESS (0.000s)
[121.268519] [031/165] (895s left) gem_flink_basic (double-flink)
[121.493782] Starting subtest: double-flink
[121.495834] Subtest double-flink: SUCCESS (0.000s)
[121.601587] [032/165] (895s left) gem_flink_basic (flink-lifetime)
[121.830149] Starting subtest: flink-lifetime
[121.835396] Subtest flink-lifetime: SUCCESS (0.008s)
[121.949165] [033/165] (894s left) gem_huc_copy (huc-copy)
[122.188539] Subtest huc-copy: SKIP (0.000s)
[122.256175] [034/165] (894s left) gem_linear_blits (basic)
[122.847254] Subtest basic: SKIP (0.000s)
[122.951958] [035/165] (893s left) gem_mmap (basic)
[123.342135] Starting subtest: basic
[123.354960] Subtest basic: SUCCESS (0.001s)
[123.451306] [036/165] (893s left) gem_mmap_gtt (basic)
[123.698171] Starting subtest: basic
[123.704657] Subtest basic: SUCCESS (0.009s)
[123.826069] [037/165] (893s left) gem_render_linear_blits (basic)
[124.071288] Starting subtest: basic
[124.192214] Subtest basic: SUCCESS (0.117s)
[124.274978] [038/165] (892s left) gem_render_tiled_blits (basic)
[124.519396] Starting subtest: basic
[124.643123] Subtest basic: SUCCESS (0.115s)
[124.725555] [039/165] (892s left) gem_ringfill (basic-all)
[125.138771] Starting subtest: basic-all
[126.415611] Subtest basic-all: SUCCESS (1.274s)
[126.538113] [040/165] (890s left) gem_softpin (allocator-basic)
[126.788937] Starting subtest: allocator-basic
[127.085145] Subtest allocator-basic: SUCCESS (0.282s)
[127.247875] [041/165] (889s left) gem_softpin (allocator-basic-reserve)
[127.489693] Starting subtest: allocator-basic-reserve
[127.790058] Subtest allocator-basic-reserve: SUCCESS (0.292s)
[127.961909] [042/165] (889s left) gem_softpin (safe-alignment)
[128.206900] Starting subtest: safe-alignment
[128.258239] Subtest safe-alignment: SUCCESS (0.050s)
[128.371254] [043/165] (888s left) gem_sync (basic-all)
[128.652612] Starting subtest: basic-all
[131.388566] Subtest basic-all: SUCCESS (2.735s)
[131.624233] [044/165] (885s left) gem_sync (basic-each)
[131.896292] Starting subtest: basic-each
[134.731388] Subtest basic-each: SUCCESS (2.840s)
[134.969124] [045/165] (882s left) gem_tiled_blits (basic)
[135.476472] Subtest basic: SKIP (0.000s)
[135.578350] [046/165] (881s left) gem_tiled_fence_blits (basic)
[136.236901] Starting subtest: basic
[136.296398] Subtest basic: SUCCESS (0.056s)
[136.439074] [047/165] (881s left) gem_tiled_pread_basic
[137.682859] [048/165] (879s left) gem_wait (busy@all-engines)
[137.982419] Starting subtest: busy
[137.986206] Starting dynamic subtest: all-engines
[138.518689] Dynamic subtest all-engines: SUCCESS (0.535s)
[138.520474] Subtest busy: SUCCESS (0.536s)
[138.821377] [049/165] (878s left) gem_wait (wait@all-engines)
[139.122927] Starting subtest: wait
[139.126464] Starting dynamic subtest: all-engines
[140.176982] Dynamic subtest all-engines: SUCCESS (1.048s)
[140.178411] Subtest wait: SUCCESS (1.049s)
[140.511725] [050/165] (877s left) i915_getparams_basic (basic-eu-total)
[140.741559] Starting subtest: basic-eu-total
[140.745417] Subtest basic-eu-total: SUCCESS (0.000s)
[140.851252] [051/165] (876s left) i915_getparams_basic (basic-subslice-total)
[141.084817] Starting subtest: basic-subslice-total
[141.089155] Subtest basic-subslice-total: SUCCESS (0.000s)
[141.208450] [052/165] (876s left) i915_hangman (error-state-basic)
[141.470118] Starting subtest: error-state-basic
[141.501813] Subtest error-state-basic: SUCCESS (0.031s)
[141.617473] [053/165] (876s left) i915_pciid
[141.956136] [054/165] (875s left) kms_addfb_basic (addfb25-4-tiled)
[142.613198] Starting subtest: addfb25-4-tiled
[142.615963] Subtest addfb25-4-tiled: SUCCESS (0.001s)
[142.717090] [055/165] (875s left) kms_addfb_basic (addfb25-bad-modifier)
[142.947644] Starting subtest: addfb25-bad-modifier
[142.950107] Subtest addfb25-bad-modifier: SUCCESS (0.002s)
[143.484434] [056/165] (874s left) kms_addfb_basic (addfb25-framebuffer-vs-set-tiling)
[143.719264] Starting subtest: addfb25-framebuffer-vs-set-tiling
[143.720628] Subtest addfb25-framebuffer-vs-set-tiling: SUCCESS (0.000s)
[144.266999] [057/165] (873s left) kms_addfb_basic (addfb25-modifier-no-flag)
[144.501157] Starting subtest: addfb25-modifier-no-flag
[144.502626] Subtest addfb25-modifier-no-flag: SUCCESS (0.001s)
[145.035436] [058/165] (873s left) kms_addfb_basic (addfb25-x-tiled-legacy)
[145.266776] Starting subtest: addfb25-x-tiled-legacy
[145.269821] Subtest addfb25-x-tiled-legacy: SUCCESS (0.000s)
[145.802533] [059/165] (872s left) kms_addfb_basic (addfb25-x-tiled-mismatch-legacy)
[146.035221] Starting subtest: addfb25-x-tiled-mismatch-legacy
[146.037872] Subtest addfb25-x-tiled-mismatch-legacy: SUCCESS (0.001s)
[146.570961] [060/165] (871s left) kms_addfb_basic (addfb25-yf-tiled-legacy)
[147.239644] Starting subtest: addfb25-yf-tiled-legacy
[147.242897] Subtest addfb25-yf-tiled-legacy: SUCCESS (0.001s)
[147.350617] [061/165] (870s left) kms_addfb_basic (addfb25-y-tiled-legacy)
[148.013054] Starting subtest: addfb25-y-tiled-legacy
[148.014658] Subtest addfb25-y-tiled-legacy: SUCCESS (0.001s)
[148.118885] [062/165] (870s left) kms_addfb_basic (addfb25-y-tiled-small-legacy)
[148.771401] Starting subtest: addfb25-y-tiled-small-legacy
[148.776649] Subtest addfb25-y-tiled-small-legacy: SKIP (0.000s)
[148.885530] [063/165] (869s left) kms_addfb_basic (bad-pitch-0)
[149.118182] Starting subtest: bad-pitch-0
[149.122228] Subtest bad-pitch-0: SUCCESS (0.000s)
[149.684949] [064/165] (868s left) kms_addfb_basic (bad-pitch-1024)
[149.916987] Starting subtest: bad-pitch-1024
[149.919551] Subtest bad-pitch-1024: SUCCESS (0.000s)
[150.467435] [065/165] (867s left) kms_addfb_basic (bad-pitch-128)
[150.695807] Starting subtest: bad-pitch-128
[150.699301] Subtest bad-pitch-128: SUCCESS (0.000s)
[151.239192] [066/165] (867s left) kms_addfb_basic (bad-pitch-256)
[151.469155] Starting subtest: bad-pitch-256
[151.470784] Subtest bad-pitch-256: SUCCESS (0.000s)
[152.000691] [067/165] (866s left) kms_addfb_basic (bad-pitch-32)
[152.222525] Starting subtest: bad-pitch-32
[152.224707] Subtest bad-pitch-32: SUCCESS (0.000s)
[152.768756] [068/165] (865s left) kms_addfb_basic (bad-pitch-63)
[153.008729] Starting subtest: bad-pitch-63
[153.011850] Subtest bad-pitch-63: SUCCESS (0.000s)
[153.535540] [069/165] (865s left) kms_addfb_basic (bad-pitch-65536)
[153.766899] Starting subtest: bad-pitch-65536
[153.769993] Subtest bad-pitch-65536: SUCCESS (0.001s)
[154.301034] [070/165] (864s left) kms_addfb_basic (bad-pitch-999)
[154.532512] Starting subtest: bad-pitch-999
[154.534835] Subtest bad-pitch-999: SUCCESS (0.000s)
[155.083935] [071/165] (863s left) kms_addfb_basic (basic)
[155.313155] Starting subtest: basic
[155.316983] Subtest basic: SUCCESS (0.000s)
[155.853658] [072/165] (862s left) kms_addfb_basic (basic-x-tiled-legacy)
[156.086578] Starting subtest: basic-x-tiled-legacy
[156.089859] Subtest basic-x-tiled-legacy: SUCCESS (0.000s)
[156.602279] [073/165] (862s left) kms_addfb_basic (basic-y-tiled-legacy)
[156.828497] Starting subtest: basic-y-tiled-legacy
[156.831296] Subtest basic-y-tiled-legacy: SUCCESS (0.002s)
[157.368141] [074/165] (861s left) kms_addfb_basic (bo-too-small)
[158.043471] Starting subtest: bo-too-small
[158.046506] Subtest bo-too-small: SUCCESS (0.003s)
[158.166153] [075/165] (860s left) kms_addfb_basic (bo-too-small-due-to-tiling)
[158.816397] Starting subtest: bo-too-small-due-to-tiling
[158.818452] Subtest bo-too-small-due-to-tiling: SUCCESS (0.001s)
[158.934404] [076/165] (860s left) kms_addfb_basic (clobberred-modifier)
[159.160887] Starting subtest: clobberred-modifier
[159.163724] Subtest clobberred-modifier: SUCCESS (0.000s)
[159.684795] [077/165] (859s left) kms_addfb_basic (framebuffer-vs-set-tiling)
[159.914205] Starting subtest: framebuffer-vs-set-tiling
[159.917189] Subtest framebuffer-vs-set-tiling: SUCCESS (0.001s)
[160.453446] [078/165] (858s left) kms_addfb_basic (invalid-get-prop)
[160.677717] Starting subtest: invalid-get-prop
[160.679403] Subtest invalid-get-prop: SUCCESS (0.000s)
[161.204349] [079/165] (858s left) kms_addfb_basic (invalid-get-prop-any)
[161.427337] Starting subtest: invalid-get-prop-any
[161.430134] Subtest invalid-get-prop-any: SUCCESS (0.000s)
[161.954767] [080/165] (857s left) kms_addfb_basic (invalid-set-prop)
[162.180661] Starting subtest: invalid-set-prop
[162.185525] Subtest invalid-set-prop: SUCCESS (0.000s)
[162.705467] [081/165] (856s left) kms_addfb_basic (invalid-set-prop-any)
[162.932816] Starting subtest: invalid-set-prop-any
[162.935748] Subtest invalid-set-prop-any: SUCCESS (0.000s)
[163.468549] [082/165] (855s left) kms_addfb_basic (no-handle)
[163.697184] Starting subtest: no-handle
[163.699907] Subtest no-handle: SUCCESS (0.000s)
[164.250792] [083/165] (855s left) kms_addfb_basic (size-max)
[164.882652] Starting subtest: size-max
[164.886745] Subtest size-max: SUCCESS (0.000s)
[165.001345] [084/165] (854s left) kms_addfb_basic (small-bo)
[165.660230] Starting subtest: small-bo
[165.662741] Subtest small-bo: SUCCESS (0.000s)
[165.768603] [085/165] (853s left) kms_addfb_basic (tile-pitch-mismatch)
[165.997103] Starting subtest: tile-pitch-mismatch
[165.998835] Subtest tile-pitch-mismatch: SUCCESS (0.001s)
[166.538327] [086/165] (853s left) kms_addfb_basic (too-high)
[167.204453] Starting subtest: too-high
[167.206719] Subtest too-high: SUCCESS (0.006s)
[167.318416] [087/165] (852s left) kms_addfb_basic (too-wide)
[167.974787] Starting subtest: too-wide
[167.977318] Subtest too-wide: SUCCESS (0.000s)
[168.090453] [088/165] (851s left) kms_addfb_basic (unused-handle)
[168.318234] Starting subtest: unused-handle
[168.321446] Subtest unused-handle: SUCCESS (0.000s)
[168.853547] [089/165] (850s left) kms_addfb_basic (unused-modifier)
[169.072658] Starting subtest: unused-modifier
[169.076236] Subtest unused-modifier: SUCCESS (0.000s)
[169.601488] [090/165] (850s left) kms_addfb_basic (unused-offsets)
[169.833511] Starting subtest: unused-offsets
[169.835167] Subtest unused-offsets: SUCCESS (0.000s)
[170.401684] [091/165] (849s left) kms_addfb_basic (unused-pitches)
[170.635658] Starting subtest: unused-pitches
[170.638109] Subtest unused-pitches: SUCCESS (0.000s)
[171.167218] [092/165] (848s left) kms_busy (basic)
[171.824228] Starting subtest: basic
[171.825793] Starting dynamic subtest: flip
[172.938161] Dynamic subtest flip: SUCCESS (1.112s)
[173.007997] Starting dynamic subtest: modeset
[175.231050] Dynamic subtest modeset: SUCCESS (2.279s)
[175.235587] Subtest basic: SUCCESS (3.400s)
[175.740929] [093/165] (844s left) kms_prop_blob (basic)
[175.978660] Starting subtest: basic
[175.981515] Subtest basic: SUCCESS (0.000s)
[176.083651] [094/165] (843s left) kms_cursor_legacy (basic-busy-flip-before-cursor-atomic)
[176.716534] Starting subtest: basic-busy-flip-before-cursor-atomic
[177.918106] Subtest basic-busy-flip-before-cursor-atomic: SUCCESS (1.198s)
[178.380817] [095/165] (841s left) kms_cursor_legacy (basic-busy-flip-before-cursor-legacy)
[179.037687] Starting subtest: basic-busy-flip-before-cursor-legacy
[180.252758] Subtest basic-busy-flip-before-cursor-legacy: SUCCESS (1.214s)
[180.778939] [096/165] (839s left) kms_cursor_legacy (basic-flip-after-cursor-atomic)
[181.467948] Starting subtest: basic-flip-after-cursor-atomic
[182.748252] Subtest basic-flip-after-cursor-atomic: SUCCESS (1.283s)
[183.260322] [097/165] (836s left) kms_cursor_legacy (basic-flip-after-cursor-legacy)
[183.931095] Starting subtest: basic-flip-after-cursor-legacy
[185.098925] Subtest basic-flip-after-cursor-legacy: SUCCESS (1.158s)
[185.620458] [098/165] (834s left) kms_cursor_legacy (basic-flip-after-cursor-varying-size)
[186.282802] Starting subtest: basic-flip-after-cursor-varying-size
[187.483986] Subtest basic-flip-after-cursor-varying-size: SUCCESS (1.201s)
[187.983436] [099/165] (832s left) kms_cursor_legacy (basic-flip-before-cursor-atomic)
[188.663639] Starting subtest: basic-flip-before-cursor-atomic
[189.852513] Subtest basic-flip-before-cursor-atomic: SUCCESS (1.186s)
[190.356541] [100/165] (830s left) kms_cursor_legacy (basic-flip-before-cursor-legacy)
[191.037647] Starting subtest: basic-flip-before-cursor-legacy
[192.231952] Subtest basic-flip-before-cursor-legacy: SUCCESS (1.201s)
[192.758238] [101/165] (827s left) kms_cursor_legacy (basic-flip-before-cursor-varying-size)
[193.412968] Starting subtest: basic-flip-before-cursor-varying-size
[194.568946] Subtest basic-flip-before-cursor-varying-size: SUCCESS (1.155s)
[195.042875] [102/165] (825s left) kms_dsc (dsc-basic)
[195.712561] Subtest dsc-basic: SKIP (0.000s)
[195.780474] [103/165] (824s left) kms_flip (basic-flip-vs-dpms)
[196.241726] Starting subtest: basic-flip-vs-dpms
[196.264576] Starting dynamic subtest: C-HDMI-A2
[198.974085] Dynamic subtest C-HDMI-A2: SUCCESS (2.693s)
[198.984587] Subtest basic-flip-vs-dpms: SUCCESS (2.722s)
[199.452629] [104/165] (821s left) kms_flip (basic-flip-vs-modeset)
[199.918864] Starting subtest: basic-flip-vs-modeset
[199.937683] Starting dynamic subtest: C-HDMI-A2
[202.733362] Dynamic subtest C-HDMI-A2: SUCCESS (2.776s)
[202.737131] Subtest basic-flip-vs-modeset: SUCCESS (2.807s)
[203.246316] [105/165] (817s left) kms_flip (basic-flip-vs-wf_vblank)
[203.737832] Starting subtest: basic-flip-vs-wf_vblank
[203.761578] Starting dynamic subtest: C-HDMI-A2
[206.770934] Dynamic subtest C-HDMI-A2: SUCCESS (3.012s)
[206.774284] Subtest basic-flip-vs-wf_vblank: SUCCESS (3.035s)
[206.951385] [106/165] (813s left) kms_flip (basic-plain-flip)
[207.416696] Starting subtest: basic-plain-flip
[207.431484] Starting dynamic subtest: C-HDMI-A2
[210.021106] Dynamic subtest C-HDMI-A2: SUCCESS (2.584s)
[210.023202] Subtest basic-plain-flip: SUCCESS (2.605s)
[210.189795] [107/165] (810s left) kms_force_connector_basic (force-connector-state)
[210.577057] Starting subtest: force-connector-state
[211.431887] Subtest force-connector-state: SUCCESS (0.849s)
[212.689352] [108/165] (808s left) kms_force_connector_basic (force-edid)
[213.047226] Starting subtest: force-edid
[213.140176] Subtest force-edid: SUCCESS (0.085s)
[213.924236] [109/165] (806s left) kms_force_connector_basic (force-load-detect)
[214.300127] Starting subtest: force-load-detect
[214.306464] Subtest force-load-detect: SKIP (0.000s)
[214.855484] [110/165] (806s left) kms_force_connector_basic (prune-stale-modes)
[215.239801] Starting subtest: prune-stale-modes
[215.334856] Subtest prune-stale-modes: SUCCESS (0.097s)
[216.140666] [111/165] (804s left) kms_frontbuffer_tracking (basic)
[216.925664] Starting subtest: basic
[221.117407] Subtest basic: SUCCESS (4.191s)
[221.276695] [112/165] (799s left) kms_hdmi_inject (inject-audio)
[221.625630] Starting subtest: inject-audio
[222.128212] Subtest inject-audio: FAIL (0.451s)
[222.937697] [113/165] (798s left) kms_pipe_crc_basic (compare-crc-sanitycheck-xr24)
[223.688904] Starting subtest: compare-crc-sanitycheck-xr24
[223.692079] Starting dynamic subtest: pipe-C-HDMI-A-2
[224.237444] Dynamic subtest pipe-C-HDMI-A-2: SUCCESS (0.552s)
[224.245058] Subtest compare-crc-sanitycheck-xr24: SUCCESS (0.562s)
[224.748599] [114/165] (796s left) kms_pipe_crc_basic (compare-crc-sanitycheck-nv12)
[225.452727] Starting subtest: compare-crc-sanitycheck-nv12
[225.470155] Starting dynamic subtest: pipe-C-HDMI-A-2
[225.475708] Dynamic subtest pipe-C-HDMI-A-2: SKIP (0.002s)
[225.479415] Subtest compare-crc-sanitycheck-nv12: SKIP (0.008s)
[225.580845] [115/165] (795s left) kms_pipe_crc_basic (hang-read-crc)
[226.269114] Starting subtest: hang-read-crc
[226.278055] Starting dynamic subtest: pipe-C-HDMI-A-2
[227.938666] Dynamic subtest pipe-C-HDMI-A-2: SUCCESS (1.661s)
[227.946140] Subtest hang-read-crc: SUCCESS (1.675s)
[228.433428] [116/165] (792s left) kms_pipe_crc_basic (nonblocking-crc)
[229.145562] Starting subtest: nonblocking-crc
[229.149124] Starting dynamic subtest: pipe-C-HDMI-A-2
[229.869731] Dynamic subtest pipe-C-HDMI-A-2: SUCCESS (0.725s)
[229.874671] Subtest nonblocking-crc: SUCCESS (0.737s)
[230.364194] [117/165] (791s left) kms_pipe_crc_basic (nonblocking-crc-frame-sequence)
[231.073361] Starting subtest: nonblocking-crc-frame-sequence
[231.074807] Starting dynamic subtest: pipe-C-HDMI-A-2
[231.776655] Dynamic subtest pipe-C-HDMI-A-2: SUCCESS (0.704s)
[231.779060] Subtest nonblocking-crc-frame-sequence: SUCCESS (0.714s)
[232.274142] [118/165] (789s left) kms_pipe_crc_basic (read-crc)
[232.987471] Starting subtest: read-crc
[232.989175] Starting dynamic subtest: pipe-C-HDMI-A-2
[233.605157] Dynamic subtest pipe-C-HDMI-A-2: SUCCESS (0.613s)
[233.608853] Subtest read-crc: SUCCESS (0.625s)
[234.146940] [119/165] (787s left) kms_pipe_crc_basic (read-crc-frame-sequence)
[234.846518] Starting subtest: read-crc-frame-sequence
[234.847923] Starting dynamic subtest: pipe-C-HDMI-A-2
[235.458999] Dynamic subtest pipe-C-HDMI-A-2: SUCCESS (0.613s)
[235.462232] Subtest read-crc-frame-sequence: SUCCESS (0.621s)
[235.996828] [120/165] (785s left) kms_pm_backlight (basic-brightness)
[236.703225] Subtest basic-brightness: SKIP (0.000s)
[236.786704] [121/165] (784s left) kms_psr (primary_page_flip)
[237.022933] Subtest primary_page_flip: SKIP (0.000s)
[237.104083] [122/165] (784s left) kms_psr (cursor_plane_move)
[237.340071] Subtest cursor_plane_move: SKIP (0.000s)
[237.424323] [123/165] (784s left) kms_psr (sprite_plane_onoff)
[237.659296] Subtest sprite_plane_onoff: SKIP (0.000s)
[237.717713] [124/165] (784s left) kms_psr (primary_mmap_gtt)
[237.952316] Subtest primary_mmap_gtt: SKIP (0.000s)
[238.020287] [125/165] (783s left) kms_setmode (basic-clone-single-crtc)
[238.250733] Starting subtest: basic-clone-single-crtc
[238.256811] Subtest basic-clone-single-crtc: SKIP (0.001s)
[238.363827] [126/165] (783s left) i915_pm_rpm (basic-pci-d3-state)
[240.724850] Starting subtest: basic-pci-d3-state
[241.087180] Subtest basic-pci-d3-state: SUCCESS (0.354s)
[241.424999] [127/165] (780s left) i915_pm_rpm (basic-rte)
[241.651670] Starting subtest: basic-rte
[244.062779] Subtest basic-rte: SUCCESS (2.398s)
[245.131604] [128/165] (776s left) i915_pm_rps (basic-api)
[245.385260] Starting subtest: basic-api
[245.399198] Subtest basic-api: SUCCESS (0.015s)
[245.509207] [129/165] (776s left) prime_self_import (basic-llseek-bad)
[245.733984] Starting subtest: basic-llseek-bad
[245.738499] Subtest basic-llseek-bad: SUCCESS (0.007s)
[245.864415] [130/165] (776s left) prime_self_import (basic-llseek-size)
[246.084102] Starting subtest: basic-llseek-size
[246.095989] Subtest basic-llseek-size: SUCCESS (0.012s)
[246.217411] [131/165] (775s left) prime_self_import (basic-with_fd_dup)
[246.438571] Starting subtest: basic-with_fd_dup
[246.458755] Subtest basic-with_fd_dup: SUCCESS (0.019s)
[246.576515] [132/165] (775s left) prime_self_import (basic-with_one_bo)
[246.803964] Starting subtest: basic-with_one_bo
[246.817711] Subtest basic-with_one_bo: SUCCESS (0.015s)
[246.917869] [133/165] (775s left) prime_self_import (basic-with_one_bo_two_files)
[247.140064] Starting subtest: basic-with_one_bo_two_files
[247.153201] Subtest basic-with_one_bo_two_files: SUCCESS (0.014s)
[247.265755] [134/165] (775s left) prime_self_import (basic-with_two_bos)
[247.486506] Starting subtest: basic-with_two_bos
[247.505451] Subtest basic-with_two_bos: SUCCESS (0.016s)
[247.614369] [135/165] (774s left) prime_vgem (basic-fence-flip)
[247.898579] Starting subtest: basic-fence-flip
[248.710539] Subtest basic-fence-flip: SKIP (0.803s)
[248.863564] [136/165] (773s left) prime_vgem (basic-fence-mmap)
[249.129891] Starting subtest: basic-fence-mmap
[249.238669] Subtest basic-fence-mmap: SUCCESS (0.108s)
[249.349708] [137/165] (773s left) prime_vgem (basic-fence-read)
[249.610906] Starting subtest: basic-fence-read
[249.797836] Subtest basic-fence-read: SUCCESS (0.184s)
[249.913524] [138/165] (772s left) prime_vgem (basic-gtt)
[250.177403] Starting subtest: basic-gtt
[250.227458] Subtest basic-gtt: SUCCESS (0.046s)
[250.370252] [139/165] (772s left) prime_vgem (basic-read)
[250.622739] Starting subtest: basic-read
[250.712372] Subtest basic-read: SUCCESS (0.081s)
[250.832388] [140/165] (771s left) prime_vgem (basic-write)
[251.093165] Starting subtest: basic-write
[251.194778] Subtest basic-write: SUCCESS (0.098s)
[251.310413] [141/165] (771s left) vgem_basic (setversion)
[251.557235] Starting subtest: setversion
[251.560189] Subtest setversion: SUCCESS (0.000s)
[251.641945] [142/165] (771s left) vgem_basic (create)
[251.871859] Starting subtest: create
[251.873995] Subtest create: SUCCESS (0.001s)
[251.962381] [143/165] (770s left) vgem_basic (debugfs)
[252.189197] Starting subtest: debugfs
[252.190820] Subtest debugfs: SUCCESS (0.002s)
[252.279967] [144/165] (770s left) vgem_basic (dmabuf-export)
[252.523588] Starting subtest: dmabuf-export
[252.535825] Subtest dmabuf-export: SUCCESS (0.008s)
[252.644226] [145/165] (770s left) vgem_basic (dmabuf-fence)
[252.893098] Starting subtest: dmabuf-fence
[252.897274] Subtest dmabuf-fence: SUCCESS (0.002s)
[252.990702] [146/165] (770s left) vgem_basic (dmabuf-fence-before)
[253.224247] Starting subtest: dmabuf-fence-before
[253.228344] Subtest dmabuf-fence-before: SUCCESS (0.001s)
[253.326757] [147/165] (769s left) vgem_basic (dmabuf-mmap)
[253.582203] Starting subtest: dmabuf-mmap
[253.625085] Subtest dmabuf-mmap: SUCCESS (0.044s)
[253.711143] [148/165] (769s left) vgem_basic (mmap)
[253.957796] Starting subtest: mmap
[253.987367] Subtest mmap: SUCCESS (0.031s)
[254.087821] [149/165] (769s left) vgem_basic (second-client)
[254.321889] Starting subtest: second-client
[254.360991] Subtest second-client: SUCCESS (0.033s)
[254.446253] [150/165] (768s left) vgem_basic (sysfs)
[254.693630] Starting subtest: sysfs
[254.695192] Subtest sysfs: SUCCESS (0.002s)
[254.797357] [151/165] (768s left) core_hotunplug (unbind-rebind)
[255.140656] Starting subtest: unbind-rebind
[259.864604] Subtest unbind-rebind: SUCCESS (4.722s)
[259.935479] [152/165] (763s left) vgem_basic (unload)
[260.218239] Starting subtest: unload
[289.383437] Subtest unload: SUCCESS (29.159s)
[289.595355] [153/165] (733s left) i915_module_load (reload)
[289.823668] Starting subtest: reload
[294.600415] Subtest reload: SUCCESS (4.771s)
[294.827391] [154/165] (728s left) gem_lmem_swapping (basic)
[295.398194] Subtest basic: SKIP (0.000s)
[295.509418] [155/165] (728s left) gem_lmem_swapping (parallel-random-engines)
[295.768985] Subtest parallel-random-engines: SKIP (0.000s)
[295.844476] [156/165] (728s left) gem_lmem_swapping (random-engines)
[296.093269] Subtest random-engines: SKIP (0.000s)
[296.178609] [157/165] (727s left) gem_lmem_swapping (verify-random)
[296.424105] Subtest verify-random: SKIP (0.000s)
[296.510951] [158/165] (727s left) i915_pm_rpm (module-reload)
[299.152285] Starting subtest: module-reload
[312.970820] Subtest module-reload: SUCCESS (13.821s)
[313.026496] [159/165] (711s left) i915_selftest (live)
[313.283312] Starting subtest: live
[313.285237] Starting dynamic subtest: sanitycheck
[315.112090] Dynamic subtest sanitycheck: SUCCESS (1.824s)
[315.130928] Starting dynamic subtest: uncore
[316.942456] Dynamic subtest uncore: SUCCESS (1.825s)
[316.961119] Starting dynamic subtest: workarounds
[318.993445] Dynamic subtest workarounds: SUCCESS (2.047s)
[319.012414] Starting dynamic subtest: gt_engines
[321.285709] Dynamic subtest gt_engines: SUCCESS (2.286s)
[321.304671] Starting dynamic subtest: gt_timelines
[349.044338] Dynamic subtest gt_timelines: SUCCESS (27.754s)
[349.063359] Starting dynamic subtest: gt_contexts
[351.119417] Dynamic subtest gt_contexts: SUCCESS (2.073s)
[351.143959] Starting dynamic subtest: gt_lrc
[356.172920] Dynamic subtest gt_lrc: SUCCESS (5.046s)
[356.192039] Starting dynamic subtest: gt_mocs
[357.966145] Dynamic subtest gt_mocs: SUCCESS (1.792s)
[357.993688] Starting dynamic subtest: gt_pm
[360.945303] Dynamic subtest gt_pm: SUCCESS (2.968s)
[360.964490] Starting dynamic subtest: gt_heartbeat
[362.918425] Dynamic subtest gt_heartbeat: SUCCESS (1.970s)
[362.937948] Starting dynamic subtest: gt_tlb
[365.122331] Dynamic subtest gt_tlb: SUCCESS (2.197s)
[365.144836] Starting dynamic subtest: requests
[373.552309] Dynamic subtest requests: SUCCESS (8.430s)
[373.577296] Starting dynamic subtest: migrate
[378.749115] Dynamic subtest migrate: SUCCESS (5.186s)
[378.768640] Starting dynamic subtest: active
[380.676788] Dynamic subtest active: SUCCESS (1.923s)
[380.696493] Starting dynamic subtest: objects
[384.444397] Dynamic subtest objects: SUCCESS (3.762s)
[384.463671] Starting dynamic subtest: mman
[394.692264] Dynamic subtest mman: SUCCESS (10.246s)
[394.718766] Starting dynamic subtest: dmabuf
[396.612531] Dynamic subtest dmabuf: SUCCESS (1.910s)
[396.638416] Starting dynamic subtest: vma
[398.416815] Dynamic subtest vma: SUCCESS (1.800s)
[398.443660] Starting dynamic subtest: coherency
[404.073846] Dynamic subtest coherency: SUCCESS (5.647s)
[404.093566] Starting dynamic subtest: gtt
[413.304058] Dynamic subtest gtt: SUCCESS (9.226s)
[413.323878] Starting dynamic subtest: gem
[416.084938] Dynamic subtest gem: SUCCESS (2.777s)
[416.105646] Starting dynamic subtest: evict
[424.096085] Dynamic subtest evict: SUCCESS (8.005s)
[424.116391] Starting dynamic subtest: hugepages
[426.394472] Dynamic subtest hugepages: SUCCESS (2.293s)
[426.414952] Starting dynamic subtest: gem_contexts
[450.262528] Dynamic subtest gem_contexts: SUCCESS (23.862s)
[450.281871] Starting dynamic subtest: client
[452.199143] Dynamic subtest client: SUCCESS (1.934s)
[452.219136] Starting dynamic subtest: gem_migrate
[454.020269] Dynamic subtest gem_migrate: SUCCESS (1.816s)
[454.065782] Starting dynamic subtest: reset
[463.475228] Dynamic subtest reset: SUCCESS (9.445s)
[463.509535] Starting dynamic subtest: memory_region
[465.400488] Dynamic subtest memory_region: SUCCESS (1.907s)
[465.420334] Starting dynamic subtest: hangcheck
[490.455779] Dynamic subtest hangcheck: SUCCESS (25.051s)
[490.475402] Starting dynamic subtest: execlists
[502.007957] Dynamic subtest execlists: SUCCESS (11.549s)
[502.027746] Starting dynamic subtest: ring_submission
[503.832208] Dynamic subtest ring_submission: SUCCESS (1.816s)
[503.884402] Starting dynamic subtest: perf
[506.120844] Dynamic subtest perf: SUCCESS (2.287s)
[506.146493] Starting dynamic subtest: slpc
[508.008933] Dynamic subtest slpc: SUCCESS (1.878s)
[508.035550] Starting dynamic subtest: guc
[509.810514] Dynamic subtest guc: SUCCESS (1.790s)
[509.876458] Starting dynamic subtest: guc_multi_lrc
[511.659146] Dynamic subtest guc_multi_lrc: SUCCESS (1.849s)
[511.683300] Starting dynamic subtest: guc_hang
[513.420570] Dynamic subtest guc_hang: SUCCESS (1.756s)
[513.499281] Starting dynamic subtest: late_gt_pm
[515.339822] Dynamic subtest late_gt_pm: SUCCESS (1.907s)
[515.345497] Subtest live: SUCCESS (202.060s)
[515.429461] [160/165] (508s left) dmabuf (all-tests)
[515.670609] Starting subtest: all-tests
[515.672228] Starting dynamic subtest: sanitycheck
[515.735386] Dynamic subtest sanitycheck: SUCCESS (0.070s)
[515.773878] Starting dynamic subtest: dma_fence
[515.943442] Dynamic subtest dma_fence: SUCCESS (0.198s)
[515.973971] Starting dynamic subtest: dma_fence_chain
[546.453973] Dynamic subtest dma_fence_chain: SUCCESS (30.504s)
[546.482453] Starting dynamic subtest: dma_fence_unwrap
[546.527544] Dynamic subtest dma_fence_unwrap: SUCCESS (0.070s)
[546.565717] Starting dynamic subtest: dma_resv
[546.605807] Dynamic subtest dma_resv: SUCCESS (0.073s)
[546.616440] Subtest all-tests: SUCCESS (30.947s)
[546.665695] [161/165] (477s left) i915_suspend (basic-s2idle-without-i915)
[546.887870] Starting subtest: basic-s2idle-without-i915
[570.137532] Subtest basic-s2idle-without-i915: SUCCESS (8.238s)
[576.892745] [162/165] (468s left) i915_suspend (basic-s3-without-i915)
[577.120551] Starting subtest: basic-s3-without-i915
[599.175483] Subtest basic-s3-without-i915: SUCCESS (6.695s)
[602.116767] [163/165] (460s left) gem_exec_suspend (basic-s0)
[602.426633] Starting subtest: basic-S0
[602.428284] Starting dynamic subtest: smem
[626.655591] Dynamic subtest smem: SUCCESS (9.498s)
[626.657364] Subtest basic-S0: SUCCESS (9.502s)
[631.891460] [164/165] (450s left) gem_exec_suspend (basic-s3)
[632.161019] Starting subtest: basic-S3
[632.163263] Starting dynamic subtest: smem
[655.779837] Dynamic subtest smem: SUCCESS (8.860s)
[655.782059] Subtest basic-S3: SUCCESS (8.864s)
[661.023852] [165/165] (441s left) kms_pipe_crc_basic (suspend-read-crc)
[661.716471] Starting subtest: suspend-read-crc
[661.718975] Starting dynamic subtest: pipe-C-HDMI-A-2
[682.821385] Dynamic subtest pipe-C-HDMI-A-2: SUCCESS (5.548s)
[682.823384] Subtest suspend-read-crc: SUCCESS (5.560s)
[686.228732] Closing watchdogs
Done.