[103.848476] Initializing watchdogs
[103.849359]   /dev/watchdog0
[103.877633] [001/171] (960s left) i915_module_load (load)
[104.526234] Starting subtest: load
[109.775234] Subtest load: SUCCESS (5.239s)
[109.941734] [002/171] (954s left) core_auth (basic-auth)
[111.640216] Starting subtest: basic-auth
[111.644478] Subtest basic-auth: SUCCESS (0.003s)
[111.767652] [003/171] (952s left) debugfs_test (read_all_entries)
[112.466905] Starting subtest: read_all_entries
[112.684733] Subtest read_all_entries: SUCCESS (0.215s)
[112.881461] [004/171] (951s left) debugfs_test (basic-hwmon)
[113.608381] Starting subtest: basic-hwmon
[113.616658] Subtest basic-hwmon: SKIP (0.002s)
[113.793744] [005/171] (950s left) fbdev (eof)
[114.459273] Starting subtest: eof
[114.464187] Subtest eof: SUCCESS (0.001s)
[114.566402] [006/171] (950s left) fbdev (info)
[115.283895] Starting subtest: info
[115.290221] Subtest info: SUCCESS (0.000s)
[115.397910] [007/171] (949s left) fbdev (nullptr)
[116.041330] Starting subtest: nullptr
[116.046550] Subtest nullptr: SUCCESS (0.000s)
[116.148396] [008/171] (948s left) fbdev (read)
[116.792137] Starting subtest: read
[117.082388] Subtest read: SUCCESS (0.290s)
[117.202162] [009/171] (947s left) fbdev (write)
[117.927833] Starting subtest: write
[118.124960] Subtest write: SUCCESS (0.196s)
[118.255680] [010/171] (946s left) gem_basic (bad-close)
[118.931215] Starting subtest: bad-close
[118.942764] Subtest bad-close: SUCCESS (0.001s)
[119.058931] [011/171] (946s left) gem_basic (create-close)
[119.721325] Starting subtest: create-close
[119.730555] Subtest create-close: SUCCESS (0.001s)
[119.872669] [012/171] (945s left) gem_basic (create-fd-close)
[120.556572] Starting subtest: create-fd-close
[120.565897] Subtest create-fd-close: SUCCESS (0.002s)
[120.697680] [013/171] (944s left) gem_busy (busy@all-engines)
[121.415654] Starting subtest: busy
[121.420325] Starting dynamic subtest: all-engines
[121.520556] Dynamic subtest all-engines: SUCCESS (0.112s)
[121.524319] Subtest busy: SUCCESS (0.114s)
[122.013683] [014/171] (943s left) gem_close_race (basic-process)
[122.732485] Starting subtest: basic-process
[122.916475] Subtest basic-process: SUCCESS (0.184s)
[123.174528] [015/171] (942s left) gem_close_race (basic-threads)
[123.898653] Starting subtest: basic-threads
[125.327126] Subtest basic-threads: SUCCESS (1.429s)
[125.597422] [016/171] (939s left) gem_ctx_create (basic)
[126.246617] Subtest basic: SKIP (0.000s)
[126.350157] [017/171] (939s left) gem_ctx_create (basic-files)
[127.018160] Subtest basic-files: SKIP (0.000s)
[127.119304] [018/171] (938s left) gem_ctx_exec (basic)
[127.775495] Subtest basic: SKIP (0.000s)
[127.902920] [019/171] (937s left) gem_exec_basic (basic)
[128.587823] Starting subtest: basic
[128.591498] Starting dynamic subtest: rcs0-smem
[128.595139] Dynamic subtest rcs0-smem: SUCCESS (0.002s)
[128.598681] Subtest basic: SUCCESS (0.006s)
[128.866452] [020/171] (937s left) gem_exec_create (basic)
[129.557891] Starting subtest: basic
[129.563972] Starting dynamic subtest: smem
[131.686808] Dynamic subtest smem: SUCCESS (2.129s)
[131.690297] Subtest basic: SUCCESS (2.130s)
[131.952842] [021/171] (934s left) gem_exec_fence (basic-busy)
[132.833307] Starting subtest: basic-busy
[132.838649] Starting dynamic subtest: rcs0
[132.872714] Dynamic subtest rcs0: SUCCESS (0.040s)
[132.876273] Subtest basic-busy: SUCCESS (0.042s)
[133.774429] [022/171] (932s left) gem_exec_fence (basic-wait)
[134.645802] Starting subtest: basic-wait
[134.651918] Starting dynamic subtest: rcs0
[134.683597] Dynamic subtest rcs0: SUCCESS (0.036s)
[134.686999] Subtest basic-wait: SUCCESS (0.039s)
[135.359163] [023/171] (930s left) gem_exec_fence (basic-await)
[136.208440] Starting subtest: basic-await
[136.213787] Starting dynamic subtest: rcs0
[136.317703] Dynamic subtest rcs0: SUCCESS (0.108s)
[136.321391] Subtest basic-await: SUCCESS (0.111s)
[136.994260] [024/171] (929s left) gem_exec_fence (nb-await)
[137.883781] Starting subtest: nb-await
[137.888164] Starting dynamic subtest: rcs0
[137.951651] Dynamic subtest rcs0: SUCCESS (0.066s)
[137.955427] Subtest nb-await: SUCCESS (0.069s)
[138.627382] [025/171] (927s left) gem_exec_gttfill (basic)
[139.342791] Starting subtest: basic
[156.968814] Subtest basic: SUCCESS (17.623s)
[157.267711] [026/171] (909s left) gem_exec_parallel (engines)
[158.433546] Starting subtest: engines
[158.438386] Starting dynamic subtest: basic
[162.973240] Dynamic subtest basic: SUCCESS (4.537s)
[163.017570] Starting dynamic subtest: contexts
[163.026451] Dynamic subtest contexts: SKIP (0.003s)
[163.064567] Starting dynamic subtest: fds
[163.072372] Dynamic subtest fds: SKIP (0.003s)
[163.109801] Starting dynamic subtest: userptr
[167.586299] Dynamic subtest userptr: SUCCESS (4.603s)
[167.589933] Subtest engines: SUCCESS (9.151s)
[167.869316] [027/171] (898s left) gem_exec_store (basic)
[168.561838] Starting subtest: basic
[168.624685] Subtest basic: SUCCESS (0.064s)
[168.907383] [028/171] (897s left) gem_flink_basic (bad-flink)
[169.522817] Starting subtest: bad-flink
[169.527599] Subtest bad-flink: SUCCESS (0.000s)
[169.663106] [029/171] (896s left) gem_flink_basic (bad-open)
[170.284861] Starting subtest: bad-open
[170.288726] Subtest bad-open: SUCCESS (0.000s)
[170.413281] [030/171] (896s left) gem_flink_basic (basic)
[171.047152] Starting subtest: basic
[171.051562] Subtest basic: SUCCESS (0.001s)
[171.197407] [031/171] (895s left) gem_flink_basic (double-flink)
[171.826351] Starting subtest: double-flink
[171.830466] Subtest double-flink: SUCCESS (0.001s)
[171.965422] [032/171] (894s left) gem_flink_basic (flink-lifetime)
[172.588251] Starting subtest: flink-lifetime
[172.600396] Subtest flink-lifetime: SUCCESS (0.006s)
[172.735683] [033/171] (894s left) gem_huc_copy (huc-copy)
[173.379111] Subtest huc-copy: SKIP (0.000s)
[173.488709] [034/171] (893s left) gem_linear_blits (basic)
[174.701295] Starting subtest: basic
[174.762998] Subtest basic: SUCCESS (0.068s)
[175.002089] [035/171] (892s left) gem_mmap (basic)
[175.964194] Starting subtest: basic
[175.982356] Subtest basic: SUCCESS (0.003s)
[176.105550] [036/171] (891s left) gem_mmap_gtt (basic)
[176.751581] Starting subtest: basic
[176.756695] Subtest basic: SUCCESS (0.004s)
[176.893170] [037/171] (890s left) gem_render_linear_blits (basic)
[177.555281] Starting subtest: basic
[177.716866] Subtest basic: SUCCESS (0.162s)
[177.862215] [038/171] (889s left) gem_render_tiled_blits (basic)
[178.494627] Starting subtest: basic
[178.674551] Subtest basic: SUCCESS (0.176s)
[178.836096] [039/171] (888s left) gem_ringfill (basic-all)
[179.531676] Starting subtest: basic-all
[180.724210] Subtest basic-all: SUCCESS (1.195s)
[180.863658] [040/171] (886s left) gem_softpin (allocator-basic)
[181.508889] Subtest allocator-basic: SKIP (0.000s)
[181.644284] [041/171] (885s left) gem_softpin (allocator-basic-reserve)
[182.281595] Subtest allocator-basic-reserve: SKIP (0.000s)
[182.415407] [042/171] (885s left) gem_softpin (safe-alignment)
[183.061650] Starting subtest: safe-alignment
[183.089137] Subtest safe-alignment: SUCCESS (0.031s)
[183.249446] [043/171] (884s left) gem_sync (basic-all)
[183.943958] Starting subtest: basic-all
[186.173780] Subtest basic-all: SUCCESS (2.226s)
[186.450454] [044/171] (881s left) gem_sync (basic-each)
[187.139870] Starting subtest: basic-each
[189.369495] Subtest basic-each: SUCCESS (2.229s)
[189.637476] [045/171] (878s left) gem_tiled_blits (basic)
[190.677999] Starting subtest: basic
[190.796765] Subtest basic: SUCCESS (0.120s)
[191.016758] [046/171] (877s left) gem_tiled_fence_blits (basic)
[192.416326] Starting subtest: basic
[192.494643] Subtest basic: SUCCESS (0.078s)
[192.722281] [047/171] (875s left) gem_tiled_pread_basic
[195.509486] [048/171] (872s left) gem_wait (busy@all-engines)
[196.236274] Starting subtest: busy
[196.241883] Starting dynamic subtest: all-engines
[196.771297] Dynamic subtest all-engines: SUCCESS (0.536s)
[196.775380] Subtest busy: SUCCESS (0.539s)
[197.163611] [049/171] (871s left) gem_wait (wait@all-engines)
[197.871589] Starting subtest: wait
[197.877916] Starting dynamic subtest: all-engines
[198.915149] Dynamic subtest all-engines: SUCCESS (1.043s)
[198.918993] Subtest wait: SUCCESS (1.046s)
[199.303786] [050/171] (869s left) i915_getparams_basic (basic-eu-total)
[199.926126] Starting subtest: basic-eu-total
[199.932748] Subtest basic-eu-total: SUCCESS (0.000s)
[200.062352] [051/171] (868s left) i915_getparams_basic (basic-subslice-total)
[200.695274] Starting subtest: basic-subslice-total
[200.702811] Subtest basic-subslice-total: SUCCESS (0.000s)
[200.843550] [052/171] (867s left) i915_hangman (error-state-basic)
[201.496620] Starting subtest: error-state-basic
[201.849781] Subtest error-state-basic: SUCCESS (0.358s)
[201.992577] [053/171] (866s left) i915_pciid
[202.791582] [054/171] (865s left) kms_addfb_basic (addfb25-bad-modifier)
[203.497336] Starting subtest: addfb25-bad-modifier
[203.502500] Subtest addfb25-bad-modifier: SUCCESS (0.002s)
[203.720486] [055/171] (865s left) kms_addfb_basic (addfb25-framebuffer-vs-set-tiling)
[204.400139] Starting subtest: addfb25-framebuffer-vs-set-tiling
[204.405310] Subtest addfb25-framebuffer-vs-set-tiling: SUCCESS (0.000s)
[204.607874] [056/171] (864s left) kms_addfb_basic (addfb25-modifier-no-flag)
[205.279769] Starting subtest: addfb25-modifier-no-flag
[205.284515] Subtest addfb25-modifier-no-flag: SUCCESS (0.000s)
[205.508570] [057/171] (863s left) kms_addfb_basic (addfb25-x-tiled-legacy)
[206.199335] Starting subtest: addfb25-x-tiled-legacy
[206.203864] Subtest addfb25-x-tiled-legacy: SUCCESS (0.001s)
[206.423244] [058/171] (862s left) kms_addfb_basic (addfb25-x-tiled-mismatch-legacy)
[207.102752] Starting subtest: addfb25-x-tiled-mismatch-legacy
[207.108127] Subtest addfb25-x-tiled-mismatch-legacy: SUCCESS (0.001s)
[207.335133] [059/171] (861s left) kms_addfb_basic (addfb25-yf-tiled-legacy)
[208.037478] Starting subtest: addfb25-yf-tiled-legacy
[208.041933] Subtest addfb25-yf-tiled-legacy: SUCCESS (0.002s)
[208.223442] [060/171] (861s left) kms_addfb_basic (addfb25-y-tiled-legacy)
[208.952799] Starting subtest: addfb25-y-tiled-legacy
[208.958309] Subtest addfb25-y-tiled-legacy: SUCCESS (0.002s)
[209.145527] [061/171] (860s left) kms_addfb_basic (addfb25-y-tiled-small-legacy)
[209.873933] Starting subtest: addfb25-y-tiled-small-legacy
[209.882505] Subtest addfb25-y-tiled-small-legacy: SKIP (0.000s)
[210.064211] [062/171] (859s left) kms_addfb_basic (bad-pitch-0)
[210.700389] Starting subtest: bad-pitch-0
[210.705484] Subtest bad-pitch-0: SUCCESS (0.000s)
[210.984258] [063/171] (858s left) kms_addfb_basic (bad-pitch-1024)
[211.605481] Starting subtest: bad-pitch-1024
[211.609538] Subtest bad-pitch-1024: SUCCESS (0.000s)
[211.887255] [064/171] (857s left) kms_addfb_basic (bad-pitch-128)
[212.529669] Starting subtest: bad-pitch-128
[212.534278] Subtest bad-pitch-128: SUCCESS (0.000s)
[212.795889] [065/171] (856s left) kms_addfb_basic (bad-pitch-256)
[213.408575] Starting subtest: bad-pitch-256
[213.413129] Subtest bad-pitch-256: SUCCESS (0.000s)
[213.686706] [066/171] (856s left) kms_addfb_basic (bad-pitch-32)
[214.342585] Starting subtest: bad-pitch-32
[214.346161] Subtest bad-pitch-32: SUCCESS (0.001s)
[214.619783] [067/171] (855s left) kms_addfb_basic (bad-pitch-63)
[215.280409] Starting subtest: bad-pitch-63
[215.285410] Subtest bad-pitch-63: SUCCESS (0.000s)
[215.551517] [068/171] (854s left) kms_addfb_basic (bad-pitch-65536)
[216.190588] Starting subtest: bad-pitch-65536
[216.194826] Subtest bad-pitch-65536: SUCCESS (0.002s)
[216.475579] [069/171] (853s left) kms_addfb_basic (bad-pitch-999)
[217.094547] Starting subtest: bad-pitch-999
[217.099391] Subtest bad-pitch-999: SUCCESS (0.000s)
[217.366197] [070/171] (852s left) kms_addfb_basic (basic)
[218.000820] Starting subtest: basic
[218.004549] Subtest basic: SUCCESS (0.000s)
[218.292687] [071/171] (851s left) kms_addfb_basic (basic-x-tiled-legacy)
[219.050672] Starting subtest: basic-x-tiled-legacy
[219.055412] Subtest basic-x-tiled-legacy: SUCCESS (0.000s)
[219.200395] [072/171] (851s left) kms_addfb_basic (basic-y-tiled-legacy)
[219.948672] Starting subtest: basic-y-tiled-legacy
[219.953552] Subtest basic-y-tiled-legacy: SUCCESS (0.002s)
[220.104688] [073/171] (850s left) kms_addfb_basic (bo-too-small)
[220.779483] Starting subtest: bo-too-small
[220.783789] Subtest bo-too-small: SUCCESS (0.002s)
[221.006148] [074/171] (849s left) kms_addfb_basic (bo-too-small-due-to-tiling)
[221.662199] Starting subtest: bo-too-small-due-to-tiling
[221.666892] Subtest bo-too-small-due-to-tiling: SUCCESS (0.002s)
[221.889903] [075/171] (848s left) kms_addfb_basic (clobberred-modifier)
[222.533919] Starting subtest: clobberred-modifier
[222.538701] Subtest clobberred-modifier: SUCCESS (0.001s)
[222.815966] [076/171] (847s left) kms_addfb_basic (framebuffer-vs-set-tiling)
[223.565639] Starting subtest: framebuffer-vs-set-tiling
[223.570822] Subtest framebuffer-vs-set-tiling: SUCCESS (0.001s)
[223.708199] [077/171] (847s left) kms_addfb_basic (invalid-get-prop)
[224.451174] Starting subtest: invalid-get-prop
[224.455944] Subtest invalid-get-prop: SUCCESS (0.000s)
[224.604602] [078/171] (846s left) kms_addfb_basic (invalid-get-prop-any)
[225.370569] Starting subtest: invalid-get-prop-any
[225.376407] Subtest invalid-get-prop-any: SUCCESS (0.000s)
[225.512166] [079/171] (845s left) kms_addfb_basic (invalid-set-prop)
[226.258585] Starting subtest: invalid-set-prop
[226.262573] Subtest invalid-set-prop: SUCCESS (0.000s)
[226.423798] [080/171] (844s left) kms_addfb_basic (invalid-set-prop-any)
[227.176628] Starting subtest: invalid-set-prop-any
[227.180825] Subtest invalid-set-prop-any: SUCCESS (0.000s)
[227.338436] [081/171] (843s left) kms_addfb_basic (no-handle)
[227.971401] Starting subtest: no-handle
[227.975155] Subtest no-handle: SUCCESS (0.000s)
[228.246586] [082/171] (842s left) kms_addfb_basic (size-max)
[228.923595] Starting subtest: size-max
[228.928511] Subtest size-max: SUCCESS (0.001s)
[229.145088] [083/171] (842s left) kms_addfb_basic (small-bo)
[229.805542] Starting subtest: small-bo
[229.810983] Subtest small-bo: SUCCESS (0.000s)
[230.035875] [084/171] (841s left) kms_addfb_basic (tile-pitch-mismatch)
[230.798629] Starting subtest: tile-pitch-mismatch
[230.802877] Subtest tile-pitch-mismatch: SUCCESS (0.001s)
[230.953684] [085/171] (840s left) kms_addfb_basic (too-high)
[231.627735] Starting subtest: too-high
[231.631702] Subtest too-high: SUCCESS (0.006s)
[231.868150] [086/171] (839s left) kms_addfb_basic (too-wide)
[232.548760] Starting subtest: too-wide
[232.552541] Subtest too-wide: SUCCESS (0.000s)
[232.752632] [087/171] (838s left) kms_addfb_basic (unused-handle)
[233.373243] Starting subtest: unused-handle
[233.376591] Subtest unused-handle: SUCCESS (0.000s)
[233.658442] [088/171] (838s left) kms_addfb_basic (unused-modifier)
[234.284864] Starting subtest: unused-modifier
[234.290834] Subtest unused-modifier: SUCCESS (0.000s)
[234.565527] [089/171] (837s left) kms_addfb_basic (unused-offsets)
[235.192707] Starting subtest: unused-offsets
[235.197794] Subtest unused-offsets: SUCCESS (0.000s)
[235.474390] [090/171] (836s left) kms_addfb_basic (unused-pitches)
[236.110874] Starting subtest: unused-pitches
[236.115695] Subtest unused-pitches: SUCCESS (0.000s)
[236.379220] [091/171] (835s left) kms_busy (basic)
[237.089901] Starting subtest: basic
[237.094483] Starting dynamic subtest: flip
[238.762174] Dynamic subtest flip: SUCCESS (1.669s)
[238.805868] Starting dynamic subtest: modeset
[238.815314] Dynamic subtest modeset: SKIP (0.000s)
[238.820222] Subtest basic: SUCCESS (1.672s)
[239.067132] [092/171] (833s left) kms_chamelium_hpd (dp-hpd-fast)
[239.773240] Subtest dp-hpd-fast: SKIP (0.000s)
[239.888499] [093/171] (832s left) kms_chamelium_edid (dp-edid-read)
[240.553527] Subtest dp-edid-read: SKIP (0.000s)
[240.670616] [094/171] (831s left) kms_chamelium_frames (dp-crc-fast)
[241.337592] Subtest dp-crc-fast: SKIP (0.000s)
[241.449876] [095/171] (830s left) kms_chamelium_hpd (hdmi-hpd-fast)
[242.138589] Subtest hdmi-hpd-fast: SKIP (0.000s)
[242.258376] [096/171] (830s left) kms_chamelium_edid (hdmi-edid-read)
[242.927272] Subtest hdmi-edid-read: SKIP (0.000s)
[243.032762] [097/171] (829s left) kms_chamelium_frames (hdmi-crc-fast)
[243.708464] Subtest hdmi-crc-fast: SKIP (0.000s)
[243.820786] [098/171] (828s left) kms_chamelium_hpd (vga-hpd-fast)
[244.520330] Subtest vga-hpd-fast: SKIP (0.000s)
[244.658232] [099/171] (828s left) kms_chamelium_edid (vga-edid-read)
[245.328244] Subtest vga-edid-read: SKIP (0.000s)
[245.436664] [100/171] (827s left) kms_prop_blob (basic)
[246.077310] Starting subtest: basic
[246.081717] Subtest basic: SUCCESS (0.000s)
[246.210534] [101/171] (826s left) kms_cursor_legacy (basic-busy-flip-before-cursor-atomic)
[246.894125] Starting subtest: basic-busy-flip-before-cursor-atomic
[246.911176] Subtest basic-busy-flip-before-cursor-atomic: SKIP (0.015s)
[247.068154] [102/171] (825s left) kms_cursor_legacy (basic-busy-flip-before-cursor-legacy)
[247.762651] Starting subtest: basic-busy-flip-before-cursor-legacy
[249.116292] Subtest basic-busy-flip-before-cursor-legacy: SUCCESS (1.348s)
[249.416764] [103/171] (823s left) kms_cursor_legacy (basic-flip-after-cursor-atomic)
[250.098812] Starting subtest: basic-flip-after-cursor-atomic
[250.108854] Subtest basic-flip-after-cursor-atomic: SKIP (0.000s)
[250.234199] [104/171] (822s left) kms_cursor_legacy (basic-flip-after-cursor-legacy)
[250.917297] Starting subtest: basic-flip-after-cursor-legacy
[252.234541] Subtest basic-flip-after-cursor-legacy: SUCCESS (1.323s)
[252.516934] [105/171] (820s left) kms_cursor_legacy (basic-flip-after-cursor-varying-size)
[253.192210] Starting subtest: basic-flip-after-cursor-varying-size
[254.533431] Subtest basic-flip-after-cursor-varying-size: SUCCESS (1.341s)
[254.815406] [106/171] (818s left) kms_cursor_legacy (basic-flip-before-cursor-atomic)
[255.492649] Starting subtest: basic-flip-before-cursor-atomic
[255.500781] Subtest basic-flip-before-cursor-atomic: SKIP (0.000s)
[255.629943] [107/171] (817s left) kms_cursor_legacy (basic-flip-before-cursor-legacy)
[256.297663] Starting subtest: basic-flip-before-cursor-legacy
[257.633322] Subtest basic-flip-before-cursor-legacy: SUCCESS (1.342s)
[257.901303] [108/171] (815s left) kms_cursor_legacy (basic-flip-before-cursor-varying-size)
[258.579905] Starting subtest: basic-flip-before-cursor-varying-size
[259.916545] Subtest basic-flip-before-cursor-varying-size: SUCCESS (1.340s)
[260.198250] [109/171] (813s left) kms_flip (basic-flip-vs-dpms)
[260.856308] Starting subtest: basic-flip-vs-dpms
[260.860529] Starting dynamic subtest: A-VGA1
[262.678817] Dynamic subtest A-VGA1: SUCCESS (1.820s)
[262.725762] Starting dynamic subtest: B-VGA1
[264.173449] Dynamic subtest B-VGA1: SUCCESS (1.491s)
[264.178071] Subtest basic-flip-vs-dpms: SUCCESS (3.317s)
[264.571421] [110/171] (809s left) kms_flip (basic-flip-vs-modeset)
[265.232870] Starting subtest: basic-flip-vs-modeset
[265.238278] Starting dynamic subtest: A-VGA1
[266.898830] Dynamic subtest A-VGA1: SUCCESS (1.668s)
[266.946156] Starting dynamic subtest: B-VGA1
[268.236576] Dynamic subtest B-VGA1: SUCCESS (1.335s)
[268.241203] Subtest basic-flip-vs-modeset: SUCCESS (3.009s)
[268.621541] [111/171] (805s left) kms_flip (basic-flip-vs-wf_vblank)
[269.298306] Starting subtest: basic-flip-vs-wf_vblank
[269.303386] Starting dynamic subtest: A-VGA1
[271.255083] Dynamic subtest A-VGA1: SUCCESS (1.955s)
[271.293576] Starting dynamic subtest: B-VGA1
[272.974182] Dynamic subtest B-VGA1: SUCCESS (1.710s)
[272.978908] Subtest basic-flip-vs-wf_vblank: SUCCESS (3.672s)
[273.482223] [112/171] (800s left) kms_flip (basic-plain-flip)
[274.432506] Starting subtest: basic-plain-flip
[274.444159] Starting dynamic subtest: A-VGA1
[276.090567] Dynamic subtest A-VGA1: SUCCESS (1.650s)
[276.132672] Starting dynamic subtest: B-VGA1
[277.494739] Dynamic subtest B-VGA1: SUCCESS (1.404s)
[277.499443] Subtest basic-plain-flip: SUCCESS (3.060s)
[277.923237] [113/171] (796s left) kms_force_connector_basic (force-connector-state)
[278.638829] Starting subtest: force-connector-state
[278.907148] Subtest force-connector-state: SUCCESS (0.271s)
[279.350861] [114/171] (794s left) kms_force_connector_basic (force-edid)
[280.068480] Starting subtest: force-edid
[280.163183] Subtest force-edid: SUCCESS (0.100s)
[280.400624] [115/171] (793s left) kms_force_connector_basic (force-load-detect)
[281.126572] Starting subtest: force-load-detect
[281.584967] Subtest force-load-detect: SUCCESS (0.460s)
[281.979594] [116/171] (792s left) kms_force_connector_basic (prune-stale-modes)
[282.673668] Starting subtest: prune-stale-modes
[282.790178] Subtest prune-stale-modes: SUCCESS (0.114s)
[283.052537] [117/171] (791s left) kms_frontbuffer_tracking (basic)
[283.745691] Subtest basic: SKIP (0.000s)
[283.870434] [118/171] (790s left) kms_pipe_crc_basic (compare-crc-sanitycheck)
[284.538610] Starting subtest: compare-crc-sanitycheck
[284.542793] Starting dynamic subtest: pipe-A-VGA-1
[284.932378] Dynamic subtest pipe-A-VGA-1: SUCCESS (0.388s)
[284.972590] Starting dynamic subtest: pipe-B-VGA-1
[285.449829] Dynamic subtest pipe-B-VGA-1: SUCCESS (0.514s)
[285.464271] Subtest compare-crc-sanitycheck: SUCCESS (0.905s)
[285.742836] [119/171] (788s left) kms_pipe_crc_basic (hang-read-crc)
[286.422238] Starting subtest: hang-read-crc
[286.426871] Starting dynamic subtest: pipe-A-VGA-1
[287.685651] Dynamic subtest pipe-A-VGA-1: SUCCESS (1.262s)
[287.737535] Starting dynamic subtest: pipe-B-VGA-1
[288.993312] Dynamic subtest pipe-B-VGA-1: SUCCESS (1.312s)
[288.997315] Subtest hang-read-crc: SUCCESS (2.577s)
[289.279553] [120/171] (785s left) kms_pipe_crc_basic (nonblocking-crc)
[289.968693] Starting subtest: nonblocking-crc
[289.974248] Starting dynamic subtest: pipe-A-VGA-1
[290.554400] Dynamic subtest pipe-A-VGA-1: SUCCESS (0.580s)
[290.588467] Starting dynamic subtest: pipe-B-VGA-1
[291.254908] Dynamic subtest pipe-B-VGA-1: SUCCESS (0.698s)
[291.261687] Subtest nonblocking-crc: SUCCESS (1.282s)
[291.514354] [121/171] (783s left) kms_pipe_crc_basic (nonblocking-crc-frame-sequence)
[292.206159] Starting subtest: nonblocking-crc-frame-sequence
[292.210546] Starting dynamic subtest: pipe-A-VGA-1
[292.792791] Dynamic subtest pipe-A-VGA-1: SUCCESS (0.584s)
[292.838203] Starting dynamic subtest: pipe-B-VGA-1
[293.495532] Dynamic subtest pipe-B-VGA-1: SUCCESS (0.698s)
[293.501183] Subtest nonblocking-crc-frame-sequence: SUCCESS (1.285s)
[293.745913] [122/171] (781s left) kms_pipe_crc_basic (read-crc)
[294.422853] Starting subtest: read-crc
[294.428111] Starting dynamic subtest: pipe-A-VGA-1
[294.926786] Dynamic subtest pipe-A-VGA-1: SUCCESS (0.502s)
[294.973137] Starting dynamic subtest: pipe-B-VGA-1
[295.543830] Dynamic subtest pipe-B-VGA-1: SUCCESS (0.615s)
[295.548766] Subtest read-crc: SUCCESS (1.120s)
[295.807421] [123/171] (779s left) kms_pipe_crc_basic (read-crc-frame-sequence)
[296.494758] Starting subtest: read-crc-frame-sequence
[296.500120] Starting dynamic subtest: pipe-A-VGA-1
[297.039163] Dynamic subtest pipe-A-VGA-1: SUCCESS (0.539s)
[297.089248] Starting dynamic subtest: pipe-B-VGA-1
[297.652560] Dynamic subtest pipe-B-VGA-1: SUCCESS (0.613s)
[297.659576] Subtest read-crc-frame-sequence: SUCCESS (1.155s)
[297.920833] [124/171] (777s left) kms_psr (primary_page_flip)
[298.552332] Subtest primary_page_flip: SKIP (0.000s)
[298.658758] [125/171] (776s left) kms_psr (cursor_plane_move)
[299.284908] Subtest cursor_plane_move: SKIP (0.000s)
[299.403854] [126/171] (775s left) kms_psr (sprite_plane_onoff)
[300.048853] Subtest sprite_plane_onoff: SKIP (0.000s)
[300.158943] [127/171] (775s left) kms_psr (primary_mmap_gtt)
[300.785841] Subtest primary_mmap_gtt: SKIP (0.000s)
[300.898889] [128/171] (774s left) kms_setmode (basic-clone-single-crtc)
[301.542505] Starting subtest: basic-clone-single-crtc
[301.553750] Subtest basic-clone-single-crtc: SKIP (0.001s)
[301.683979] [129/171] (773s left) i915_pm_backlight (basic-brightness)
[302.386698] Subtest basic-brightness: SKIP (0.000s)
[302.503978] [130/171] (773s left) i915_pm_rpm (basic-pci-d3-state)
[314.764694] Subtest basic-pci-d3-state: SKIP (0.000s)
[314.869584] [131/171] (760s left) i915_pm_rpm (basic-rte)
[315.488538] Starting subtest: basic-rte
[327.101462] Subtest basic-rte: SKIP (11.580s)
[327.201699] [132/171] (748s left) i915_pm_rps (basic-api)
[327.856850] Subtest basic-api: SKIP (0.000s)
[327.965656] [133/171] (747s left) prime_self_import (basic-llseek-bad)
[328.565893] Starting subtest: basic-llseek-bad
[328.580082] Subtest basic-llseek-bad: SUCCESS (0.009s)
[328.727706] [134/171] (747s left) prime_self_import (basic-llseek-size)
[329.335119] Starting subtest: basic-llseek-size
[329.352323] Subtest basic-llseek-size: SUCCESS (0.019s)
[329.494682] [135/171] (746s left) prime_self_import (basic-with_fd_dup)
[330.103695] Starting subtest: basic-with_fd_dup
[330.116857] Subtest basic-with_fd_dup: SUCCESS (0.015s)
[330.271989] [136/171] (745s left) prime_self_import (basic-with_one_bo)
[330.877375] Starting subtest: basic-with_one_bo
[330.896934] Subtest basic-with_one_bo: SUCCESS (0.020s)
[331.037470] [137/171] (745s left) prime_self_import (basic-with_one_bo_two_files)
[331.642864] Starting subtest: basic-with_one_bo_two_files
[331.663142] Subtest basic-with_one_bo_two_files: SUCCESS (0.015s)
[331.814920] [138/171] (744s left) prime_self_import (basic-with_two_bos)
[332.437875] Starting subtest: basic-with_two_bos
[332.461468] Subtest basic-with_two_bos: SUCCESS (0.018s)
[332.603561] [139/171] (743s left) prime_vgem (basic-fence-flip)
[333.280366] Starting subtest: basic-fence-flip
[333.897822] Subtest basic-fence-flip: SUCCESS (0.613s)
[334.087988] [140/171] (742s left) prime_vgem (basic-fence-mmap)
[334.718624] Starting subtest: basic-fence-mmap
[334.898683] Subtest basic-fence-mmap: SUCCESS (0.180s)
[335.056185] [141/171] (741s left) prime_vgem (basic-fence-read)
[335.687700] Starting subtest: basic-fence-read
[335.995696] Subtest basic-fence-read: SUCCESS (0.313s)
[336.155562] [142/171] (740s left) prime_vgem (basic-gtt)
[336.785264] Starting subtest: basic-gtt
[336.862813] Subtest basic-gtt: SUCCESS (0.077s)
[337.041650] [143/171] (739s left) prime_vgem (basic-read)
[337.688995] Starting subtest: basic-read
[337.833664] Subtest basic-read: SUCCESS (0.144s)
[337.988633] [144/171] (738s left) prime_vgem (basic-write)
[338.633767] Starting subtest: basic-write
[338.799382] Subtest basic-write: SUCCESS (0.166s)
[338.954444] [145/171] (738s left) prime_vgem (basic-userptr)
[339.589819] Starting subtest: basic-userptr
[339.655679] Subtest basic-userptr: SKIP (0.059s)
[339.831761] [146/171] (737s left) vgem_basic (setversion)
[340.433657] Starting subtest: setversion
[340.442352] Subtest setversion: SUCCESS (0.000s)
[340.566717] [147/171] (736s left) vgem_basic (create)
[341.174497] Starting subtest: create
[341.178863] Subtest create: SUCCESS (0.002s)
[341.291745] [148/171] (735s left) vgem_basic (debugfs)
[341.901577] Starting subtest: debugfs
[341.912560] Subtest debugfs: SUCCESS (0.006s)
[342.055850] [149/171] (735s left) vgem_basic (dmabuf-export)
[342.670762] Starting subtest: dmabuf-export
[342.686410] Subtest dmabuf-export: SUCCESS (0.010s)
[342.826533] [150/171] (734s left) vgem_basic (dmabuf-fence)
[343.454454] Starting subtest: dmabuf-fence
[343.460362] Subtest dmabuf-fence: SUCCESS (0.004s)
[343.595301] [151/171] (733s left) vgem_basic (dmabuf-fence-before)
[344.210309] Starting subtest: dmabuf-fence-before
[344.215274] Subtest dmabuf-fence-before: SUCCESS (0.004s)
[344.336269] [152/171] (733s left) vgem_basic (dmabuf-mmap)
[344.954931] Starting subtest: dmabuf-mmap
[345.059683] Subtest dmabuf-mmap: SUCCESS (0.104s)
[345.181646] [153/171] (732s left) vgem_basic (mmap)
[345.806717] Starting subtest: mmap
[345.878299] Subtest mmap: SUCCESS (0.072s)
[346.002703] [154/171] (731s left) vgem_basic (second-client)
[346.607857] Starting subtest: second-client
[346.655792] Subtest second-client: SUCCESS (0.049s)
[346.779968] [155/171] (731s left) vgem_basic (sysfs)
[347.378575] Starting subtest: sysfs
[347.383644] Subtest sysfs: SUCCESS (0.005s)
[347.500709] [156/171] (730s left) core_hotunplug (unbind-rebind)
[348.175191] Starting subtest: unbind-rebind
[351.436433] Subtest unbind-rebind: SUCCESS (3.256s)
[351.650967] [157/171] (726s left) vgem_basic (unload)
[352.863445] Starting subtest: unload
[382.297955] Subtest unload: SUCCESS (29.418s)
[382.645452] [158/171] (695s left) i915_module_load (reload)
[383.251761] Starting subtest: reload
[390.638917] Subtest reload: SUCCESS (7.388s)
[390.799494] [159/171] (687s left) gem_lmem_swapping (basic)
[392.376934] Subtest basic: SKIP (0.000s)
[392.488096] [160/171] (686s left) gem_lmem_swapping (parallel-random-engines)
[393.115502] Subtest parallel-random-engines: SKIP (0.000s)
[393.221107] [161/171] (685s left) gem_lmem_swapping (random-engines)
[393.840660] Subtest random-engines: SKIP (0.000s)
[393.963333] [162/171] (684s left) gem_lmem_swapping (verify-random)
[394.587504] Subtest verify-random: SKIP (0.000s)
[394.704382] [163/171] (684s left) i915_pm_rpm (module-reload)
[407.019772] Subtest module-reload: SKIP (0.000s)
[407.125796] [164/171] (671s left) i915_selftest (live)
[409.921992] Starting subtest: live
[409.926664] Starting dynamic subtest: sanitycheck
[412.844296] Dynamic subtest sanitycheck: SUCCESS (2.921s)
[412.881348] Starting dynamic subtest: uncore
[415.433099] Dynamic subtest uncore: SUCCESS (2.585s)
[415.469189] Starting dynamic subtest: workarounds
[417.942762] Dynamic subtest workarounds: SUCCESS (2.507s)
[417.979768] Starting dynamic subtest: gt_engines
[420.489908] Dynamic subtest gt_engines: SUCCESS (2.543s)
[420.525812] Starting dynamic subtest: gt_timelines
[433.002708] Dynamic subtest gt_timelines: SUCCESS (12.504s)
[433.035212] Starting dynamic subtest: gt_contexts
[435.548101] Dynamic subtest gt_contexts: SUCCESS (2.542s)
[435.583615] Starting dynamic subtest: gt_lrc
[438.146634] Dynamic subtest gt_lrc: SUCCESS (2.596s)
[438.182606] Starting dynamic subtest: gt_mocs
[440.835848] Dynamic subtest gt_mocs: SUCCESS (2.685s)
[440.873323] Starting dynamic subtest: gt_pm
[443.799601] Dynamic subtest gt_pm: SUCCESS (2.960s)
[443.835230] Starting dynamic subtest: gt_heartbeat
[446.419972] Dynamic subtest gt_heartbeat: SUCCESS (2.617s)
[446.457165] Starting dynamic subtest: requests
[451.551710] Dynamic subtest requests: SUCCESS (5.126s)
[451.583245] Starting dynamic subtest: migrate
[454.174672] Dynamic subtest migrate: SUCCESS (2.620s)
[454.213548] Starting dynamic subtest: active
[456.723448] Dynamic subtest active: SUCCESS (2.544s)
[456.758848] Starting dynamic subtest: objects
[460.535475] Dynamic subtest objects: SUCCESS (3.810s)
[460.564463] Starting dynamic subtest: mman
[474.902718] Dynamic subtest mman: SUCCESS (14.357s)
[474.932112] Starting dynamic subtest: dmabuf
[477.640871] Dynamic subtest dmabuf: SUCCESS (2.733s)
[477.677378] Starting dynamic subtest: vma
[480.248974] Dynamic subtest vma: SUCCESS (2.605s)
[480.285104] Starting dynamic subtest: coherency
[488.794724] Dynamic subtest coherency: SUCCESS (8.540s)
[488.826612] Starting dynamic subtest: gtt
[494.287793] Dynamic subtest gtt: SUCCESS (5.488s)
[494.317105] Starting dynamic subtest: gem
[496.909693] Dynamic subtest gem: SUCCESS (2.617s)
[496.947307] Starting dynamic subtest: evict
[499.497308] Dynamic subtest evict: SUCCESS (2.584s)
[499.533590] Starting dynamic subtest: hugepages
[502.087815] Dynamic subtest hugepages: SUCCESS (2.586s)
[502.124087] Starting dynamic subtest: gem_contexts
[504.641652] Dynamic subtest gem_contexts: SUCCESS (2.551s)
[504.678235] Starting dynamic subtest: client
[507.247576] Dynamic subtest client: SUCCESS (2.600s)
[507.287885] Starting dynamic subtest: gem_migrate
[509.800642] Dynamic subtest gem_migrate: SUCCESS (2.549s)
[509.834372] Starting dynamic subtest: reset
[512.913859] Dynamic subtest reset: SUCCESS (3.109s)
[512.945976] Starting dynamic subtest: memory_region
[515.469444] Dynamic subtest memory_region: SUCCESS (2.552s)
[515.506485] Starting dynamic subtest: hangcheck
[519.132279] Dynamic subtest hangcheck: SUCCESS (3.658s)
[519.163858] Starting dynamic subtest: execlists
[521.651087] Dynamic subtest execlists: SUCCESS (2.515s)
[521.688480] Starting dynamic subtest: ring_submission
[524.269223] Dynamic subtest ring_submission: SUCCESS (2.615s)
[524.307862] Starting dynamic subtest: perf
[526.907757] Dynamic subtest perf: SUCCESS (2.634s)
[526.945534] Starting dynamic subtest: slpc
[529.541674] Dynamic subtest slpc: SUCCESS (2.629s)
[529.578531] Starting dynamic subtest: guc
[532.107322] Dynamic subtest guc: SUCCESS (2.561s)
[532.143852] Starting dynamic subtest: guc_multi_lrc
[535.294309] Dynamic subtest guc_multi_lrc: SUCCESS (3.184s)
[535.338570] Starting dynamic subtest: guc_hang
[538.147545] Dynamic subtest guc_hang: SUCCESS (2.848s)
[538.184195] Starting dynamic subtest: late_gt_pm
[540.727409] Dynamic subtest late_gt_pm: SUCCESS (2.576s)
[540.731785] Subtest live: SUCCESS (130.743s)
[540.923260] [165/171] (538s left) dmabuf (all-tests)
[541.559453] Starting subtest: all-tests
[541.567614] Starting dynamic subtest: sanitycheck
[541.611539] Dynamic subtest sanitycheck: SUCCESS (0.056s)
[541.650763] Starting dynamic subtest: dma_fence
[541.802257] Dynamic subtest dma_fence: SUCCESS (0.187s)
[541.843456] Starting dynamic subtest: dma_fence_chain
[609.851749] Dynamic subtest dma_fence_chain: SUCCESS (68.008s)
[609.889596] Starting dynamic subtest: dma_fence_unwrap
[609.909241] Dynamic subtest dma_fence_unwrap: SUCCESS (0.057s)
[609.954680] Starting dynamic subtest: dma_resv
[609.976117] Dynamic subtest dma_resv: SUCCESS (0.062s)
[609.981206] Subtest all-tests: SUCCESS (68.389s)
[610.075129] [166/171] (469s left) i915_suspend (basic-s2idle-without-i915)
[610.661751] Starting subtest: basic-s2idle-without-i915
[634.173891] Subtest basic-s2idle-without-i915: SUCCESS (8.473s)
[637.488338] [167/171] (459s left) i915_suspend (basic-s3-without-i915)
[638.473585] Starting subtest: basic-s3-without-i915
[662.000319] Subtest basic-s3-without-i915: SUCCESS (7.317s)
[665.523362] [168/171] (451s left) gem_exec_suspend (basic-s0)
[666.283892] Starting subtest: basic-S0
[666.300258] Starting dynamic subtest: smem
[689.193547] Dynamic subtest smem: SUCCESS (7.361s)
[689.197121] Subtest basic-S0: SUCCESS (7.368s)
[691.815917] [169/171] (443s left) gem_exec_suspend (basic-s3)
[692.476133] Starting subtest: basic-S3
[692.481327] Starting dynamic subtest: smem
[715.401218] Dynamic subtest smem: SUCCESS (7.345s)
[715.405195] Subtest basic-S3: SUCCESS (7.350s)
[719.724402] [170/171] (434s left) kms_chamelium_hpd (common-hpd-after-suspend)
[720.418537] Subtest common-hpd-after-suspend: SKIP (0.000s)
[720.552253] [171/171] (434s left) kms_pipe_crc_basic (suspend-read-crc)
[721.201645] Starting subtest: suspend-read-crc
[721.206324] Starting dynamic subtest: pipe-A-VGA-1
[739.820696] Dynamic subtest pipe-A-VGA-1: SUCCESS (2.926s)
[739.879052] Starting dynamic subtest: pipe-B-VGA-1
[758.814172] Dynamic subtest pipe-B-VGA-1: SUCCESS (2.748s)
[758.817653] Subtest suspend-read-crc: SUCCESS (5.681s)
[765.093742] Closing watchdogs
Done.