[105.366589] Initializing watchdogs
[105.367508]   /dev/watchdog0
[105.390618] [001/171] (960s left) i915_module_load (load)
[106.020813] Starting subtest: load
[110.188465] Subtest load: SUCCESS (4.174s)
[110.376689] [002/171] (955s left) core_auth (basic-auth)
[111.653418] Starting subtest: basic-auth
[111.656727] Subtest basic-auth: SUCCESS (0.005s)
[111.800859] [003/171] (954s left) debugfs_test (read_all_entries)
[112.418575] Starting subtest: read_all_entries
[112.581569] Subtest read_all_entries: SUCCESS (0.161s)
[112.748947] [004/171] (953s left) debugfs_test (basic-hwmon)
[113.380630] Starting subtest: basic-hwmon
[113.388502] Subtest basic-hwmon: SKIP (0.000s)
[113.565969] [005/171] (952s left) fbdev (eof)
[114.157361] Starting subtest: eof
[114.161420] Subtest eof: SUCCESS (0.001s)
[114.261295] [006/171] (952s left) fbdev (info)
[114.837286] Starting subtest: info
[114.840825] Subtest info: SUCCESS (0.000s)
[114.966452] [007/171] (951s left) fbdev (nullptr)
[115.605520] Starting subtest: nullptr
[115.609641] Subtest nullptr: SUCCESS (0.000s)
[115.715284] [008/171] (950s left) fbdev (read)
[116.305887] Starting subtest: read
[116.598795] Subtest read: SUCCESS (0.293s)
[116.713871] [009/171] (949s left) fbdev (write)
[117.288716] Starting subtest: write
[117.451326] Subtest write: SUCCESS (0.162s)
[117.563799] [010/171] (949s left) gem_basic (bad-close)
[118.153647] Starting subtest: bad-close
[118.161533] Subtest bad-close: SUCCESS (0.000s)
[118.280804] [011/171] (948s left) gem_basic (create-close)
[118.859281] Starting subtest: create-close
[118.866295] Subtest create-close: SUCCESS (0.001s)
[118.995820] [012/171] (947s left) gem_basic (create-fd-close)
[119.582283] Starting subtest: create-fd-close
[119.588574] Subtest create-fd-close: SUCCESS (0.001s)
[119.712137] [013/171] (947s left) gem_busy (busy@all-engines)
[120.346177] Starting subtest: busy
[120.349966] Starting dynamic subtest: all-engines
[120.458278] Dynamic subtest all-engines: SUCCESS (0.111s)
[120.461746] Subtest busy: SUCCESS (0.113s)
[120.932982] [014/171] (945s left) gem_close_race (basic-process)
[121.585906] Starting subtest: basic-process
[121.755147] Subtest basic-process: SUCCESS (0.171s)
[122.016246] [015/171] (944s left) gem_close_race (basic-threads)
[122.652579] Starting subtest: basic-threads
[124.056670] Subtest basic-threads: SUCCESS (1.404s)
[124.317206] [016/171] (942s left) gem_ctx_create (basic)
[124.921452] Subtest basic: SKIP (0.000s)
[125.018691] [017/171] (942s left) gem_ctx_create (basic-files)
[125.610092] Subtest basic-files: SKIP (0.000s)
[125.701760] [018/171] (941s left) gem_ctx_exec (basic)
[126.299698] Subtest basic: SKIP (0.000s)
[126.419177] [019/171] (940s left) gem_exec_basic (basic)
[127.026191] Starting subtest: basic
[127.030152] Starting dynamic subtest: rcs0-smem
[127.033419] Dynamic subtest rcs0-smem: SUCCESS (0.002s)
[127.036566] Subtest basic: SUCCESS (0.005s)
[127.299317] [020/171] (940s left) gem_exec_create (basic)
[127.945421] Starting subtest: basic
[127.950138] Starting dynamic subtest: smem
[130.079331] Dynamic subtest smem: SUCCESS (2.135s)
[130.082240] Subtest basic: SUCCESS (2.137s)
[130.353902] [021/171] (937s left) gem_exec_fence (basic-busy)
[131.179966] Starting subtest: basic-busy
[131.184893] Starting dynamic subtest: rcs0
[131.212563] Dynamic subtest rcs0: SUCCESS (0.030s)
[131.215536] Subtest basic-busy: SUCCESS (0.033s)
[132.084599] [022/171] (935s left) gem_exec_fence (basic-wait)
[132.902567] Starting subtest: basic-wait
[132.907092] Starting dynamic subtest: rcs0
[132.930961] Dynamic subtest rcs0: SUCCESS (0.027s)
[132.934290] Subtest basic-wait: SUCCESS (0.030s)
[133.600553] [023/171] (933s left) gem_exec_fence (basic-await)
[134.410640] Starting subtest: basic-await
[134.414862] Starting dynamic subtest: rcs0
[134.521612] Dynamic subtest rcs0: SUCCESS (0.110s)
[134.524905] Subtest basic-await: SUCCESS (0.113s)
[135.201270] [024/171] (932s left) gem_exec_fence (nb-await)
[136.034484] Starting subtest: nb-await
[136.038399] Starting dynamic subtest: rcs0
[136.098729] Dynamic subtest rcs0: SUCCESS (0.063s)
[136.103175] Subtest nb-await: SUCCESS (0.066s)
[136.770527] [025/171] (930s left) gem_exec_gttfill (basic)
[137.415264] Starting subtest: basic
[151.031197] Subtest basic: SUCCESS (13.622s)
[151.334958] [026/171] (916s left) gem_exec_parallel (engines)
[152.364542] Starting subtest: engines
[152.368777] Starting dynamic subtest: basic
[156.414294] Dynamic subtest basic: SUCCESS (4.051s)
[156.462106] Starting dynamic subtest: contexts
[156.468950] Dynamic subtest contexts: SKIP (0.002s)
[156.506624] Starting dynamic subtest: fds
[156.512629] Dynamic subtest fds: SKIP (0.003s)
[156.550678] Starting dynamic subtest: userptr
[160.605416] Dynamic subtest userptr: SUCCESS (4.185s)
[160.608397] Subtest engines: SUCCESS (8.247s)
[160.880265] [027/171] (907s left) gem_exec_store (basic)
[161.489301] Starting subtest: basic
[161.537512] Subtest basic: SUCCESS (0.050s)
[161.813778] [028/171] (906s left) gem_flink_basic (bad-flink)
[162.369846] Starting subtest: bad-flink
[162.374739] Subtest bad-flink: SUCCESS (0.000s)
[162.507158] [029/171] (905s left) gem_flink_basic (bad-open)
[163.056165] Starting subtest: bad-open
[163.059616] Subtest bad-open: SUCCESS (0.000s)
[163.191911] [030/171] (904s left) gem_flink_basic (basic)
[163.775212] Starting subtest: basic
[163.779470] Subtest basic: SUCCESS (0.001s)
[163.923786] [031/171] (904s left) gem_flink_basic (double-flink)
[164.482522] Starting subtest: double-flink
[164.486582] Subtest double-flink: SUCCESS (0.000s)
[164.621937] [032/171] (903s left) gem_flink_basic (flink-lifetime)
[165.192478] Starting subtest: flink-lifetime
[165.201314] Subtest flink-lifetime: SUCCESS (0.006s)
[165.340777] [033/171] (903s left) gem_huc_copy (huc-copy)
[165.930231] Subtest huc-copy: SKIP (0.000s)
[166.029767] [034/171] (902s left) gem_linear_blits (basic)
[167.061472] Starting subtest: basic
[167.112325] Subtest basic: SUCCESS (0.051s)
[167.319595] [035/171] (901s left) gem_mmap (basic)
[168.166832] Starting subtest: basic
[168.181491] Subtest basic: SUCCESS (0.004s)
[168.308283] [036/171] (900s left) gem_mmap_gtt (basic)
[168.875540] Starting subtest: basic
[168.879546] Subtest basic: SUCCESS (0.005s)
[169.011310] [037/171] (899s left) gem_render_linear_blits (basic)
[169.601430] Starting subtest: basic
[169.724824] Subtest basic: SUCCESS (0.124s)
[169.843815] [038/171] (898s left) gem_render_tiled_blits (basic)
[170.412626] Starting subtest: basic
[170.557770] Subtest basic: SUCCESS (0.146s)
[170.677993] [039/171] (898s left) gem_ringfill (basic-all)
[171.290277] Starting subtest: basic-all
[172.488148] Subtest basic-all: SUCCESS (1.202s)
[172.625908] [040/171] (896s left) gem_softpin (allocator-basic)
[173.209434] Subtest allocator-basic: SKIP (0.000s)
[173.339094] [041/171] (895s left) gem_softpin (allocator-basic-reserve)
[173.925342] Subtest allocator-basic-reserve: SKIP (0.000s)
[174.055871] [042/171] (895s left) gem_softpin (safe-alignment)
[174.641630] Starting subtest: safe-alignment
[174.670305] Subtest safe-alignment: SUCCESS (0.030s)
[174.806083] [043/171] (894s left) gem_sync (basic-all)
[175.425788] Starting subtest: basic-all
[177.734816] Subtest basic-all: SUCCESS (2.308s)
[178.008640] [044/171] (891s left) gem_sync (basic-each)
[178.618852] Starting subtest: basic-each
[180.901440] Subtest basic-each: SUCCESS (2.282s)
[181.178273] [045/171] (888s left) gem_tiled_blits (basic)
[182.045435] Starting subtest: basic
[182.128603] Subtest basic: SUCCESS (0.082s)
[182.337702] [046/171] (887s left) gem_tiled_fence_blits (basic)
[183.552556] Starting subtest: basic
[183.623155] Subtest basic: SUCCESS (0.071s)
[183.837321] [047/171] (885s left) gem_tiled_pread_basic
[186.495129] [048/171] (883s left) gem_wait (busy@all-engines)
[187.164995] Starting subtest: busy
[187.168807] Starting dynamic subtest: all-engines
[187.699336] Dynamic subtest all-engines: SUCCESS (0.537s)
[187.702513] Subtest busy: SUCCESS (0.539s)
[188.094972] [049/171] (881s left) gem_wait (wait@all-engines)
[188.750803] Starting subtest: wait
[188.756755] Starting dynamic subtest: all-engines
[189.787455] Dynamic subtest all-engines: SUCCESS (1.038s)
[189.791732] Subtest wait: SUCCESS (1.040s)
[190.175926] [050/171] (879s left) i915_getparams_basic (basic-eu-total)
[190.755158] Starting subtest: basic-eu-total
[190.761575] Subtest basic-eu-total: SUCCESS (0.000s)
[190.893074] [051/171] (878s left) i915_getparams_basic (basic-subslice-total)
[191.453504] Starting subtest: basic-subslice-total
[191.459459] Subtest basic-subslice-total: SUCCESS (0.000s)
[191.590963] [052/171] (878s left) i915_hangman (error-state-basic)
[192.164276] Starting subtest: error-state-basic
[192.489666] Subtest error-state-basic: SUCCESS (0.313s)
[192.605760] [053/171] (877s left) i915_pciid
[193.302505] [054/171] (876s left) kms_addfb_basic (addfb25-bad-modifier)
[193.892859] Starting subtest: addfb25-bad-modifier
[193.896755] Subtest addfb25-bad-modifier: SUCCESS (0.002s)
[194.121727] [055/171] (876s left) kms_addfb_basic (addfb25-framebuffer-vs-set-tiling)
[194.703986] Starting subtest: addfb25-framebuffer-vs-set-tiling
[194.708539] Subtest addfb25-framebuffer-vs-set-tiling: SUCCESS (0.000s)
[194.901943] [056/171] (875s left) kms_addfb_basic (addfb25-modifier-no-flag)
[195.463602] Starting subtest: addfb25-modifier-no-flag
[195.467360] Subtest addfb25-modifier-no-flag: SUCCESS (0.000s)
[195.672103] [057/171] (874s left) kms_addfb_basic (addfb25-x-tiled-legacy)
[196.261576] Starting subtest: addfb25-x-tiled-legacy
[196.265232] Subtest addfb25-x-tiled-legacy: SUCCESS (0.000s)
[196.465564] [058/171] (873s left) kms_addfb_basic (addfb25-x-tiled-mismatch-legacy)
[197.038783] Starting subtest: addfb25-x-tiled-mismatch-legacy
[197.042536] Subtest addfb25-x-tiled-mismatch-legacy: SUCCESS (0.002s)
[197.230305] [059/171] (873s left) kms_addfb_basic (addfb25-yf-tiled-legacy)
[197.885847] Starting subtest: addfb25-yf-tiled-legacy
[197.890508] Subtest addfb25-yf-tiled-legacy: SUCCESS (0.002s)
[198.030165] [060/171] (872s left) kms_addfb_basic (addfb25-y-tiled-legacy)
[198.668581] Starting subtest: addfb25-y-tiled-legacy
[198.671742] Subtest addfb25-y-tiled-legacy: SUCCESS (0.001s)
[198.827336] [061/171] (871s left) kms_addfb_basic (addfb25-y-tiled-small-legacy)
[199.449109] Starting subtest: addfb25-y-tiled-small-legacy
[199.455444] Subtest addfb25-y-tiled-small-legacy: SKIP (0.000s)
[199.618822] [062/171] (871s left) kms_addfb_basic (bad-pitch-0)
[200.200649] Starting subtest: bad-pitch-0
[200.204991] Subtest bad-pitch-0: SUCCESS (0.000s)
[200.387606] [063/171] (870s left) kms_addfb_basic (bad-pitch-1024)
[200.951994] Starting subtest: bad-pitch-1024
[200.955676] Subtest bad-pitch-1024: SUCCESS (0.000s)
[201.178767] [064/171] (869s left) kms_addfb_basic (bad-pitch-128)
[201.751707] Starting subtest: bad-pitch-128
[201.756649] Subtest bad-pitch-128: SUCCESS (0.000s)
[201.937270] [065/171] (869s left) kms_addfb_basic (bad-pitch-256)
[202.518879] Starting subtest: bad-pitch-256
[202.522851] Subtest bad-pitch-256: SUCCESS (0.000s)
[202.706204] [066/171] (868s left) kms_addfb_basic (bad-pitch-32)
[203.289940] Starting subtest: bad-pitch-32
[203.294432] Subtest bad-pitch-32: SUCCESS (0.000s)
[203.469990] [067/171] (867s left) kms_addfb_basic (bad-pitch-63)
[204.032559] Starting subtest: bad-pitch-63
[204.035920] Subtest bad-pitch-63: SUCCESS (0.000s)
[204.237183] [068/171] (867s left) kms_addfb_basic (bad-pitch-65536)
[204.817810] Starting subtest: bad-pitch-65536
[204.821604] Subtest bad-pitch-65536: SUCCESS (0.002s)
[205.018988] [069/171] (866s left) kms_addfb_basic (bad-pitch-999)
[205.765452] Starting subtest: bad-pitch-999
[205.769517] Subtest bad-pitch-999: SUCCESS (0.000s)
[205.951674] [070/171] (865s left) kms_addfb_basic (basic)
[206.509571] Starting subtest: basic
[206.513628] Subtest basic: SUCCESS (0.000s)
[206.720937] [071/171] (864s left) kms_addfb_basic (basic-x-tiled-legacy)
[207.301334] Starting subtest: basic-x-tiled-legacy
[207.304441] Subtest basic-x-tiled-legacy: SUCCESS (0.000s)
[207.507337] [072/171] (864s left) kms_addfb_basic (basic-y-tiled-legacy)
[208.104250] Starting subtest: basic-y-tiled-legacy
[208.107889] Subtest basic-y-tiled-legacy: SUCCESS (0.002s)
[208.292568] [073/171] (863s left) kms_addfb_basic (bo-too-small)
[208.913704] Starting subtest: bo-too-small
[208.917664] Subtest bo-too-small: SUCCESS (0.001s)
[209.059944] [074/171] (862s left) kms_addfb_basic (bo-too-small-due-to-tiling)
[209.684248] Starting subtest: bo-too-small-due-to-tiling
[209.687442] Subtest bo-too-small-due-to-tiling: SUCCESS (0.002s)
[209.821368] [075/171] (862s left) kms_addfb_basic (clobberred-modifier)
[210.393470] Starting subtest: clobberred-modifier
[210.404212] Subtest clobberred-modifier: SUCCESS (0.001s)
[210.589787] [076/171] (861s left) kms_addfb_basic (framebuffer-vs-set-tiling)
[211.191262] Starting subtest: framebuffer-vs-set-tiling
[211.195092] Subtest framebuffer-vs-set-tiling: SUCCESS (0.001s)
[211.374189] [077/171] (860s left) kms_addfb_basic (invalid-get-prop)
[211.963587] Starting subtest: invalid-get-prop
[211.966649] Subtest invalid-get-prop: SUCCESS (0.000s)
[212.152823] [078/171] (860s left) kms_addfb_basic (invalid-get-prop-any)
[212.717597] Starting subtest: invalid-get-prop-any
[212.721542] Subtest invalid-get-prop-any: SUCCESS (0.000s)
[212.904429] [079/171] (859s left) kms_addfb_basic (invalid-set-prop)
[213.469787] Starting subtest: invalid-set-prop
[213.473784] Subtest invalid-set-prop: SUCCESS (0.000s)
[213.653914] [080/171] (858s left) kms_addfb_basic (invalid-set-prop-any)
[214.230576] Starting subtest: invalid-set-prop-any
[214.234136] Subtest invalid-set-prop-any: SUCCESS (0.000s)
[214.421448] [081/171] (858s left) kms_addfb_basic (no-handle)
[214.997200] Starting subtest: no-handle
[215.000973] Subtest no-handle: SUCCESS (0.000s)
[215.200772] [082/171] (857s left) kms_addfb_basic (size-max)
[215.801341] Starting subtest: size-max
[215.804486] Subtest size-max: SUCCESS (0.001s)
[215.944758] [083/171] (856s left) kms_addfb_basic (small-bo)
[216.550956] Starting subtest: small-bo
[216.554392] Subtest small-bo: SUCCESS (0.000s)
[216.702679] [084/171] (856s left) kms_addfb_basic (tile-pitch-mismatch)
[217.284362] Starting subtest: tile-pitch-mismatch
[217.289242] Subtest tile-pitch-mismatch: SUCCESS (0.002s)
[217.471464] [085/171] (855s left) kms_addfb_basic (too-high)
[218.103745] Starting subtest: too-high
[218.107365] Subtest too-high: SUCCESS (0.005s)
[218.261840] [086/171] (854s left) kms_addfb_basic (too-wide)
[218.887146] Starting subtest: too-wide
[218.889884] Subtest too-wide: SUCCESS (0.000s)
[219.017958] [087/171] (854s left) kms_addfb_basic (unused-handle)
[219.576156] Starting subtest: unused-handle
[219.580209] Subtest unused-handle: SUCCESS (0.000s)
[219.771547] [088/171] (853s left) kms_addfb_basic (unused-modifier)
[220.355952] Starting subtest: unused-modifier
[220.361810] Subtest unused-modifier: SUCCESS (0.000s)
[220.540693] [089/171] (852s left) kms_addfb_basic (unused-offsets)
[221.110506] Starting subtest: unused-offsets
[221.114587] Subtest unused-offsets: SUCCESS (0.000s)
[221.314220] [090/171] (851s left) kms_addfb_basic (unused-pitches)
[221.892591] Starting subtest: unused-pitches
[221.896468] Subtest unused-pitches: SUCCESS (0.000s)
[222.068808] [091/171] (851s left) kms_busy (basic)
[222.683850] Starting subtest: basic
[222.688240] Starting dynamic subtest: flip
[224.133416] Dynamic subtest flip: SUCCESS (1.441s)
[224.173676] Starting dynamic subtest: modeset
[224.181492] Dynamic subtest modeset: SKIP (0.000s)
[224.185430] Subtest basic: SUCCESS (1.449s)
[224.419879] [092/171] (849s left) kms_chamelium_hpd (dp-hpd-fast)
[225.052219] Subtest dp-hpd-fast: SKIP (0.000s)
[225.166219] [093/171] (848s left) kms_chamelium_edid (dp-edid-read)
[225.782452] Subtest dp-edid-read: SKIP (0.000s)
[225.893889] [094/171] (847s left) kms_chamelium_frames (dp-crc-fast)
[226.537211] Subtest dp-crc-fast: SKIP (0.000s)
[226.649925] [095/171] (847s left) kms_chamelium_hpd (hdmi-hpd-fast)
[227.249901] Subtest hdmi-hpd-fast: SKIP (0.000s)
[227.377125] [096/171] (846s left) kms_chamelium_edid (hdmi-edid-read)
[227.983490] Subtest hdmi-edid-read: SKIP (0.000s)
[228.092609] [097/171] (845s left) kms_chamelium_frames (hdmi-crc-fast)
[228.716420] Subtest hdmi-crc-fast: SKIP (0.000s)
[228.824699] [098/171] (845s left) kms_chamelium_hpd (vga-hpd-fast)
[229.448949] Subtest vga-hpd-fast: SKIP (0.000s)
[229.574948] [099/171] (844s left) kms_chamelium_edid (vga-edid-read)
[230.184493] Subtest vga-edid-read: SKIP (0.000s)
[230.292455] [100/171] (843s left) kms_prop_blob (basic)
[230.872775] Starting subtest: basic
[230.877583] Subtest basic: SUCCESS (0.000s)
[231.000578] [101/171] (843s left) kms_cursor_legacy (basic-busy-flip-before-cursor-atomic)
[231.615480] Starting subtest: basic-busy-flip-before-cursor-atomic
[231.630080] Subtest basic-busy-flip-before-cursor-atomic: SKIP (0.012s)
[231.769954] [102/171] (842s left) kms_cursor_legacy (basic-busy-flip-before-cursor-legacy)
[232.370495] Starting subtest: basic-busy-flip-before-cursor-legacy
[233.677706] Subtest basic-busy-flip-before-cursor-legacy: SUCCESS (1.308s)
[233.945541] [103/171] (840s left) kms_cursor_legacy (basic-flip-after-cursor-atomic)
[234.558878] Starting subtest: basic-flip-after-cursor-atomic
[234.566259] Subtest basic-flip-after-cursor-atomic: SKIP (0.000s)
[234.695383] [104/171] (839s left) kms_cursor_legacy (basic-flip-after-cursor-legacy)
[235.307478] Starting subtest: basic-flip-after-cursor-legacy
[236.604185] Subtest basic-flip-after-cursor-legacy: SUCCESS (1.294s)
[236.867082] [105/171] (837s left) kms_cursor_legacy (basic-flip-after-cursor-varying-size)
[237.475587] Starting subtest: basic-flip-after-cursor-varying-size
[238.786757] Subtest basic-flip-after-cursor-varying-size: SUCCESS (1.309s)
[239.051873] [106/171] (835s left) kms_cursor_legacy (basic-flip-before-cursor-atomic)
[239.681443] Starting subtest: basic-flip-before-cursor-atomic
[239.687958] Subtest basic-flip-before-cursor-atomic: SKIP (0.000s)
[239.830919] [107/171] (834s left) kms_cursor_legacy (basic-flip-before-cursor-legacy)
[240.451601] Starting subtest: basic-flip-before-cursor-legacy
[241.725622] Subtest basic-flip-before-cursor-legacy: SUCCESS (1.275s)
[241.989216] [108/171] (832s left) kms_cursor_legacy (basic-flip-before-cursor-varying-size)
[242.612422] Starting subtest: basic-flip-before-cursor-varying-size
[243.900238] Subtest basic-flip-before-cursor-varying-size: SUCCESS (1.290s)
[244.174993] [109/171] (830s left) kms_flip (basic-flip-vs-dpms)
[244.774152] Starting subtest: basic-flip-vs-dpms
[244.778374] Starting dynamic subtest: A-VGA1
[246.515638] Dynamic subtest A-VGA1: SUCCESS (1.734s)
[246.556448] Starting dynamic subtest: B-VGA1
[247.986219] Dynamic subtest B-VGA1: SUCCESS (1.471s)
[247.991235] Subtest basic-flip-vs-dpms: SUCCESS (3.212s)
[248.395267] [110/171] (826s left) kms_flip (basic-flip-vs-modeset)
[248.992187] Starting subtest: basic-flip-vs-modeset
[248.996527] Starting dynamic subtest: A-VGA1
[250.740481] Dynamic subtest A-VGA1: SUCCESS (1.750s)
[250.785396] Starting dynamic subtest: B-VGA1
[252.233465] Dynamic subtest B-VGA1: SUCCESS (1.491s)
[252.237124] Subtest basic-flip-vs-modeset: SUCCESS (3.247s)
[252.587862] [111/171] (822s left) kms_flip (basic-flip-vs-wf_vblank)
[253.191135] Starting subtest: basic-flip-vs-wf_vblank
[253.195289] Starting dynamic subtest: A-VGA1
[255.077579] Dynamic subtest A-VGA1: SUCCESS (1.884s)
[255.119604] Starting dynamic subtest: B-VGA1
[256.914423] Dynamic subtest B-VGA1: SUCCESS (1.839s)
[256.918285] Subtest basic-flip-vs-wf_vblank: SUCCESS (3.728s)
[257.329382] [112/171] (817s left) kms_flip (basic-plain-flip)
[257.918186] Starting subtest: basic-plain-flip
[257.922296] Starting dynamic subtest: A-VGA1
[259.528762] Dynamic subtest A-VGA1: SUCCESS (1.605s)
[259.571067] Starting dynamic subtest: B-VGA1
[260.903754] Dynamic subtest B-VGA1: SUCCESS (1.386s)
[260.910238] Subtest basic-plain-flip: SUCCESS (2.996s)
[261.326786] [113/171] (814s left) kms_force_connector_basic (force-connector-state)
[261.954817] Starting subtest: force-connector-state
[262.237738] Subtest force-connector-state: SUCCESS (0.279s)
[262.667780] [114/171] (812s left) kms_force_connector_basic (force-edid)
[263.309119] Starting subtest: force-edid
[263.399440] Subtest force-edid: SUCCESS (0.097s)
[263.645642] [115/171] (811s left) kms_force_connector_basic (force-load-detect)
[264.331464] Starting subtest: force-load-detect
[264.745100] Subtest force-load-detect: SUCCESS (0.416s)
[265.197796] [116/171] (810s left) kms_force_connector_basic (prune-stale-modes)
[266.193669] Starting subtest: prune-stale-modes
[266.339653] Subtest prune-stale-modes: SUCCESS (0.140s)
[266.629847] [117/171] (809s left) kms_frontbuffer_tracking (basic)
[267.566658] Subtest basic: SKIP (0.000s)
[267.725928] [118/171] (808s left) kms_pipe_crc_basic (compare-crc-sanitycheck-xr24)
[268.659375] Starting subtest: compare-crc-sanitycheck-xr24
[268.663794] Starting dynamic subtest: pipe-A-VGA-1
[269.060822] Dynamic subtest pipe-A-VGA-1: SUCCESS (0.387s)
[269.125348] Starting dynamic subtest: pipe-B-VGA-1
[269.617275] Dynamic subtest pipe-B-VGA-1: SUCCESS (0.554s)
[269.625880] Subtest compare-crc-sanitycheck-xr24: SUCCESS (0.957s)
[269.938553] [119/171] (806s left) kms_pipe_crc_basic (compare-crc-sanitycheck-nv12)
[270.605866] Starting subtest: compare-crc-sanitycheck-nv12
[270.611307] Starting dynamic subtest: pipe-A-VGA-1
[270.621337] Dynamic subtest pipe-A-VGA-1: SKIP (0.002s)
[270.663505] Starting dynamic subtest: pipe-B-VGA-1
[270.669791] Dynamic subtest pipe-B-VGA-1: SKIP (0.002s)
[270.676721] Subtest compare-crc-sanitycheck-nv12: SKIP (0.016s)
[270.773445] [120/171] (805s left) kms_pipe_crc_basic (hang-read-crc)
[271.670149] Starting subtest: hang-read-crc
[271.675827] Starting dynamic subtest: pipe-A-VGA-1
[273.013843] Dynamic subtest pipe-A-VGA-1: SUCCESS (1.341s)
[273.072833] Starting dynamic subtest: pipe-B-VGA-1
[274.386915] Dynamic subtest pipe-B-VGA-1: SUCCESS (1.364s)
[274.391806] Subtest hang-read-crc: SUCCESS (2.718s)
[274.635742] [121/171] (801s left) kms_pipe_crc_basic (nonblocking-crc)
[275.255578] Starting subtest: nonblocking-crc
[275.259594] Starting dynamic subtest: pipe-A-VGA-1
[275.814219] Dynamic subtest pipe-A-VGA-1: SUCCESS (0.553s)
[275.853479] Starting dynamic subtest: pipe-B-VGA-1
[276.511742] Dynamic subtest pipe-B-VGA-1: SUCCESS (0.695s)
[276.515865] Subtest nonblocking-crc: SUCCESS (1.260s)
[276.765560] [122/171] (799s left) kms_pipe_crc_basic (nonblocking-crc-frame-sequence)
[277.390714] Starting subtest: nonblocking-crc-frame-sequence
[277.394944] Starting dynamic subtest: pipe-A-VGA-1
[277.958296] Dynamic subtest pipe-A-VGA-1: SUCCESS (0.563s)
[278.014865] Starting dynamic subtest: pipe-B-VGA-1
[278.632849] Dynamic subtest pipe-B-VGA-1: SUCCESS (0.665s)
[278.636695] Subtest nonblocking-crc-frame-sequence: SUCCESS (1.240s)
[278.886490] [123/171] (797s left) kms_pipe_crc_basic (read-crc)
[279.499593] Starting subtest: read-crc
[279.504652] Starting dynamic subtest: pipe-A-VGA-1
[279.987099] Dynamic subtest pipe-A-VGA-1: SUCCESS (0.485s)
[280.038767] Starting dynamic subtest: pipe-B-VGA-1
[280.609484] Dynamic subtest pipe-B-VGA-1: SUCCESS (0.619s)
[280.613245] Subtest read-crc: SUCCESS (1.117s)
[280.891673] [124/171] (795s left) kms_pipe_crc_basic (read-crc-frame-sequence)
[281.523745] Starting subtest: read-crc-frame-sequence
[281.527383] Starting dynamic subtest: pipe-A-VGA-1
[282.022773] Dynamic subtest pipe-A-VGA-1: SUCCESS (0.495s)
[282.067571] Starting dynamic subtest: pipe-B-VGA-1
[282.644339] Dynamic subtest pipe-B-VGA-1: SUCCESS (0.614s)
[282.648323] Subtest read-crc-frame-sequence: SUCCESS (1.122s)
[282.888599] [125/171] (793s left) kms_psr (primary_page_flip)
[283.455106] Subtest primary_page_flip: SKIP (0.000s)
[283.560897] [126/171] (793s left) kms_psr (cursor_plane_move)
[284.125217] Subtest cursor_plane_move: SKIP (0.000s)
[284.228927] [127/171] (792s left) kms_psr (sprite_plane_onoff)
[284.811138] Subtest sprite_plane_onoff: SKIP (0.000s)
[284.956721] [128/171] (791s left) kms_psr (primary_mmap_gtt)
[285.520646] Subtest primary_mmap_gtt: SKIP (0.000s)
[285.633542] [129/171] (791s left) kms_setmode (basic-clone-single-crtc)
[286.214709] Starting subtest: basic-clone-single-crtc
[286.223759] Subtest basic-clone-single-crtc: SKIP (0.000s)
[286.371881] [130/171] (790s left) i915_pm_backlight (basic-brightness)
[286.987446] Subtest basic-brightness: SKIP (0.000s)
[287.100436] [131/171] (790s left) i915_pm_rpm (basic-pci-d3-state)
[299.178088] Subtest basic-pci-d3-state: SKIP (0.000s)
[299.282893] [132/171] (777s left) i915_pm_rpm (basic-rte)
[299.853683] Starting subtest: basic-rte
[311.362834] Subtest basic-rte: SKIP (11.494s)
[311.468790] [133/171] (765s left) i915_pm_rps (basic-api)
[312.057633] Subtest basic-api: SKIP (0.000s)
[312.161819] [134/171] (765s left) prime_self_import (basic-llseek-bad)
[312.706555] Starting subtest: basic-llseek-bad
[312.720823] Subtest basic-llseek-bad: SUCCESS (0.012s)
[312.860364] [135/171] (764s left) prime_self_import (basic-llseek-size)
[313.420443] Starting subtest: basic-llseek-size
[313.439473] Subtest basic-llseek-size: SUCCESS (0.019s)
[313.592775] [136/171] (763s left) prime_self_import (basic-with_fd_dup)
[314.159505] Starting subtest: basic-with_fd_dup
[314.167553] Subtest basic-with_fd_dup: SUCCESS (0.015s)
[314.328304] [137/171] (763s left) prime_self_import (basic-with_one_bo)
[314.890645] Starting subtest: basic-with_one_bo
[314.913734] Subtest basic-with_one_bo: SUCCESS (0.025s)
[315.049667] [138/171] (762s left) prime_self_import (basic-with_one_bo_two_files)
[315.603107] Starting subtest: basic-with_one_bo_two_files
[315.615932] Subtest basic-with_one_bo_two_files: SUCCESS (0.014s)
[315.761678] [139/171] (762s left) prime_self_import (basic-with_two_bos)
[316.321251] Starting subtest: basic-with_two_bos
[316.336759] Subtest basic-with_two_bos: SUCCESS (0.017s)
[316.491287] [140/171] (761s left) prime_vgem (basic-fence-flip)
[317.072645] Starting subtest: basic-fence-flip
[317.690593] Subtest basic-fence-flip: SUCCESS (0.615s)
[317.856366] [141/171] (760s left) prime_vgem (basic-fence-mmap)
[318.439812] Starting subtest: basic-fence-mmap
[318.608467] Subtest basic-fence-mmap: SUCCESS (0.169s)
[318.759839] [142/171] (759s left) prime_vgem (basic-fence-read)
[319.340694] Starting subtest: basic-fence-read
[319.621502] Subtest basic-fence-read: SUCCESS (0.281s)
[319.777567] [143/171] (758s left) prime_vgem (basic-gtt)
[320.355982] Starting subtest: basic-gtt
[320.422647] Subtest basic-gtt: SUCCESS (0.065s)
[320.576595] [144/171] (757s left) prime_vgem (basic-read)
[321.161254] Starting subtest: basic-read
[321.285657] Subtest basic-read: SUCCESS (0.122s)
[321.440607] [145/171] (756s left) prime_vgem (basic-write)
[322.025906] Starting subtest: basic-write
[322.168930] Subtest basic-write: SUCCESS (0.142s)
[322.311812] [146/171] (756s left) vgem_basic (setversion)
[322.891284] Starting subtest: setversion
[322.898773] Subtest setversion: SUCCESS (0.001s)
[323.016811] [147/171] (755s left) vgem_basic (create)
[323.640791] Starting subtest: create
[323.644583] Subtest create: SUCCESS (0.002s)
[323.767515] [148/171] (754s left) vgem_basic (debugfs)
[324.322467] Starting subtest: debugfs
[324.325997] Subtest debugfs: SUCCESS (0.004s)
[324.463396] [149/171] (754s left) vgem_basic (dmabuf-export)
[325.057455] Starting subtest: dmabuf-export
[325.067256] Subtest dmabuf-export: SUCCESS (0.011s)
[325.209077] [150/171] (753s left) vgem_basic (dmabuf-fence)
[325.773709] Starting subtest: dmabuf-fence
[325.778630] Subtest dmabuf-fence: SUCCESS (0.004s)
[325.896217] [151/171] (753s left) vgem_basic (dmabuf-fence-before)
[326.472709] Starting subtest: dmabuf-fence-before
[326.476079] Subtest dmabuf-fence-before: SUCCESS (0.003s)
[326.620407] [152/171] (752s left) vgem_basic (dmabuf-mmap)
[327.206968] Starting subtest: dmabuf-mmap
[327.293301] Subtest dmabuf-mmap: SUCCESS (0.087s)
[327.409655] [153/171] (751s left) vgem_basic (mmap)
[327.973610] Starting subtest: mmap
[328.028837] Subtest mmap: SUCCESS (0.057s)
[328.160178] [154/171] (751s left) vgem_basic (second-client)
[328.724540] Starting subtest: second-client
[328.756376] Subtest second-client: SUCCESS (0.032s)
[328.875796] [155/171] (750s left) vgem_basic (sysfs)
[329.456418] Starting subtest: sysfs
[329.465645] Subtest sysfs: SUCCESS (0.006s)
[329.594277] [156/171] (749s left) core_hotunplug (unbind-rebind)
[330.305143] Starting subtest: unbind-rebind
[333.070374] Subtest unbind-rebind: SUCCESS (2.766s)
[333.271202] [157/171] (746s left) vgem_basic (unload)
[334.257538] Starting subtest: unload
[363.702065] Subtest unload: SUCCESS (29.456s)
[363.976506] [158/171] (715s left) i915_module_load (reload)
[364.536730] Starting subtest: reload
[369.565464] Subtest reload: SUCCESS (5.032s)
[369.802508] [159/171] (709s left) gem_lmem_swapping (basic)
[371.227701] Subtest basic: SKIP (0.000s)
[371.361160] [160/171] (708s left) gem_lmem_swapping (parallel-random-engines)
[371.946206] Subtest parallel-random-engines: SKIP (0.000s)
[372.060589] [161/171] (707s left) gem_lmem_swapping (random-engines)
[372.643290] Subtest random-engines: SKIP (0.000s)
[372.749147] [162/171] (707s left) gem_lmem_swapping (verify-random)
[373.336118] Subtest verify-random: SKIP (0.000s)
[373.442690] [163/171] (706s left) i915_pm_rpm (module-reload)
[385.516987] Subtest module-reload: SKIP (0.000s)
[385.612814] [164/171] (694s left) i915_selftest (live)
[388.115140] Starting subtest: live
[388.119249] Starting dynamic subtest: sanitycheck
[390.482286] Dynamic subtest sanitycheck: SUCCESS (2.367s)
[390.517865] Starting dynamic subtest: uncore
[392.630299] Dynamic subtest uncore: SUCCESS (2.144s)
[392.678135] Starting dynamic subtest: workarounds
[394.749507] Dynamic subtest workarounds: SUCCESS (2.116s)
[394.789496] Starting dynamic subtest: gt_engines
[396.818277] Dynamic subtest gt_engines: SUCCESS (2.066s)
[396.857330] Starting dynamic subtest: gt_timelines
[407.689399] Dynamic subtest gt_timelines: SUCCESS (10.867s)
[407.724520] Starting dynamic subtest: gt_contexts
[409.846507] Dynamic subtest gt_contexts: SUCCESS (2.154s)
[409.882937] Starting dynamic subtest: gt_lrc
[412.074664] Dynamic subtest gt_lrc: SUCCESS (2.222s)
[412.132834] Starting dynamic subtest: gt_mocs
[414.365581] Dynamic subtest gt_mocs: SUCCESS (2.267s)
[414.405680] Starting dynamic subtest: gt_pm
[416.877747] Dynamic subtest gt_pm: SUCCESS (2.510s)
[416.912486] Starting dynamic subtest: gt_heartbeat
[419.041160] Dynamic subtest gt_heartbeat: SUCCESS (2.159s)
[419.084424] Starting dynamic subtest: gt_tlb
[421.136521] Dynamic subtest gt_tlb: SUCCESS (2.090s)
[421.177770] Starting dynamic subtest: requests
[425.814632] Dynamic subtest requests: SUCCESS (4.675s)
[425.850471] Starting dynamic subtest: migrate
[427.898213] Dynamic subtest migrate: SUCCESS (2.081s)
[427.934902] Starting dynamic subtest: active
[430.072333] Dynamic subtest active: SUCCESS (2.169s)
[430.111531] Starting dynamic subtest: objects
[433.179706] Dynamic subtest objects: SUCCESS (3.104s)
[433.215978] Starting dynamic subtest: mman
[444.950280] Dynamic subtest mman: SUCCESS (11.766s)
[444.985709] Starting dynamic subtest: dmabuf
[447.153131] Dynamic subtest dmabuf: SUCCESS (2.198s)
[447.191824] Starting dynamic subtest: vma
[449.279748] Dynamic subtest vma: SUCCESS (2.122s)
[449.320331] Starting dynamic subtest: coherency
[456.266129] Dynamic subtest coherency: SUCCESS (6.983s)
[456.301738] Starting dynamic subtest: gtt
[461.915899] Dynamic subtest gtt: SUCCESS (5.646s)
[461.952560] Starting dynamic subtest: gem
[464.086663] Dynamic subtest gem: SUCCESS (2.166s)
[464.127615] Starting dynamic subtest: evict
[466.165201] Dynamic subtest evict: SUCCESS (2.075s)
[466.201616] Starting dynamic subtest: hugepages
[468.272508] Dynamic subtest hugepages: SUCCESS (2.104s)
[468.309379] Starting dynamic subtest: gem_contexts
[470.351595] Dynamic subtest gem_contexts: SUCCESS (2.076s)
[470.401271] Starting dynamic subtest: client
[472.478116] Dynamic subtest client: SUCCESS (2.119s)
[472.518540] Starting dynamic subtest: gem_migrate
[474.561775] Dynamic subtest gem_migrate: SUCCESS (2.080s)
[474.599546] Starting dynamic subtest: reset
[477.246603] Dynamic subtest reset: SUCCESS (2.681s)
[477.282502] Starting dynamic subtest: memory_region
[479.351912] Dynamic subtest memory_region: SUCCESS (2.100s)
[479.393592] Starting dynamic subtest: hangcheck
[482.543404] Dynamic subtest hangcheck: SUCCESS (3.187s)
[482.593429] Starting dynamic subtest: execlists
[484.673590] Dynamic subtest execlists: SUCCESS (2.125s)
[484.719352] Starting dynamic subtest: ring_submission
[486.819878] Dynamic subtest ring_submission: SUCCESS (2.140s)
[486.861610] Starting dynamic subtest: perf
[488.896928] Dynamic subtest perf: SUCCESS (2.072s)
[488.938766] Starting dynamic subtest: slpc
[491.005575] Dynamic subtest slpc: SUCCESS (2.104s)
[491.036905] Starting dynamic subtest: guc
[493.125523] Dynamic subtest guc: SUCCESS (2.116s)
[493.166733] Starting dynamic subtest: guc_multi_lrc
[495.211625] Dynamic subtest guc_multi_lrc: SUCCESS (2.083s)
[495.249502] Starting dynamic subtest: guc_hang
[497.335638] Dynamic subtest guc_hang: SUCCESS (2.120s)
[497.372591] Starting dynamic subtest: late_gt_pm
[499.461555] Dynamic subtest late_gt_pm: SUCCESS (2.121s)
[499.466318] Subtest live: SUCCESS (111.350s)
[499.746995] [165/171] (580s left) dmabuf (all-tests)
[500.368749] Starting subtest: all-tests
[500.379147] Starting dynamic subtest: sanitycheck
[500.470195] Dynamic subtest sanitycheck: SUCCESS (0.093s)
[500.505679] Starting dynamic subtest: dma_fence
[500.716733] Dynamic subtest dma_fence: SUCCESS (0.242s)
[500.765211] Starting dynamic subtest: dma_fence_chain
[552.467950] Dynamic subtest dma_fence_chain: SUCCESS (51.745s)
[552.518440] Starting dynamic subtest: dma_fence_unwrap
[552.600086] Dynamic subtest dma_fence_unwrap: SUCCESS (0.124s)
[552.649610] Starting dynamic subtest: dma_resv
[552.763252] Dynamic subtest dma_resv: SUCCESS (0.157s)
[552.775116] Subtest all-tests: SUCCESS (52.398s)
[552.884118] [166/171] (527s left) i915_suspend (basic-s2idle-without-i915)
[553.466857] Starting subtest: basic-s2idle-without-i915
[576.712422] Subtest basic-s2idle-without-i915: SUCCESS (7.567s)
[578.690409] [167/171] (519s left) i915_suspend (basic-s3-without-i915)
[579.419564] Starting subtest: basic-s3-without-i915
[600.758724] Subtest basic-s3-without-i915: SUCCESS (4.857s)
[603.747975] [168/171] (513s left) gem_exec_suspend (basic-s0)
[604.468373] Starting subtest: basic-S0
[604.473688] Starting dynamic subtest: smem
[625.797676] Dynamic subtest smem: SUCCESS (6.261s)
[625.801783] Subtest basic-S0: SUCCESS (6.268s)
[627.808574] [169/171] (506s left) gem_exec_suspend (basic-s3)
[628.475932] Starting subtest: basic-S3
[628.480353] Starting dynamic subtest: smem
[650.904817] Dynamic subtest smem: SUCCESS (6.366s)
[650.908481] Subtest basic-S3: SUCCESS (6.372s)
[654.196379] [170/171] (499s left) kms_chamelium_hpd (common-hpd-after-suspend)
[654.929613] Subtest common-hpd-after-suspend: SKIP (0.000s)
[655.051409] [171/171] (498s left) kms_pipe_crc_basic (suspend-read-crc)
[655.643626] Starting subtest: suspend-read-crc
[655.647503] Starting dynamic subtest: pipe-A-VGA-1
[674.622040] Dynamic subtest pipe-A-VGA-1: SUCCESS (2.438s)
[674.691604] Starting dynamic subtest: pipe-B-VGA-1
[693.644690] Dynamic subtest pipe-B-VGA-1: SUCCESS (2.570s)
[693.648763] Subtest suspend-read-crc: SUCCESS (5.027s)
[697.908554] Closing watchdogs
Done.