[84.830472] Initializing watchdogs
[84.831209]   /dev/watchdog0
[84.855324] [001/171] (960s left) i915_module_load (load)
[85.488118] Starting subtest: load
[90.236344] Subtest load: SUCCESS (4.742s)
[90.548625] [002/171] (954s left) core_auth (basic-auth)
[92.370875] Starting subtest: basic-auth
[92.377581] Subtest basic-auth: SUCCESS (0.004s)
[92.536325] [003/171] (953s left) debugfs_test (read_all_entries)
[93.255852] Starting subtest: read_all_entries
[93.426923] Subtest read_all_entries: SUCCESS (0.175s)
[93.610696] [004/171] (952s left) debugfs_test (basic-hwmon)
[94.199949] Starting subtest: basic-hwmon
[94.206921] Subtest basic-hwmon: SKIP (0.000s)
[94.381241] [005/171] (951s left) fbdev (eof)
[94.990252] Starting subtest: eof
[94.994520] Subtest eof: SUCCESS (0.001s)
[95.093526] [006/171] (950s left) fbdev (info)
[95.656548] Starting subtest: info
[95.659631] Subtest info: SUCCESS (0.000s)
[95.777115] [007/171] (950s left) fbdev (nullptr)
[96.405838] Starting subtest: nullptr
[96.410188] Subtest nullptr: SUCCESS (0.000s)
[96.509826] [008/171] (949s left) fbdev (read)
[97.090493] Starting subtest: read
[97.373758] Subtest read: SUCCESS (0.284s)
[97.479442] [009/171] (948s left) fbdev (write)
[98.074343] Starting subtest: write
[98.248329] Subtest write: SUCCESS (0.175s)
[98.361933] [010/171] (947s left) gem_basic (bad-close)
[98.934662] Starting subtest: bad-close
[98.942762] Subtest bad-close: SUCCESS (0.000s)
[99.046483] [011/171] (947s left) gem_basic (create-close)
[99.640194] Starting subtest: create-close
[99.646895] Subtest create-close: SUCCESS (0.001s)
[99.765726] [012/171] (946s left) gem_basic (create-fd-close)
[100.359699] Starting subtest: create-fd-close
[100.366633] Subtest create-fd-close: SUCCESS (0.001s)
[100.480154] [013/171] (945s left) gem_busy (busy@all-engines)
[101.146444] Starting subtest: busy
[101.150224] Starting dynamic subtest: all-engines
[101.260197] Dynamic subtest all-engines: SUCCESS (0.114s)
[101.263131] Subtest busy: SUCCESS (0.116s)
[101.735588] [014/171] (944s left) gem_close_race (basic-process)
[102.383695] Starting subtest: basic-process
[102.558414] Subtest basic-process: SUCCESS (0.176s)
[102.820885] [015/171] (943s left) gem_close_race (basic-threads)
[103.485844] Starting subtest: basic-threads
[104.918885] Subtest basic-threads: SUCCESS (1.434s)
[105.189339] [016/171] (941s left) gem_ctx_create (basic)
[105.800622] Subtest basic: SKIP (0.000s)
[105.892969] [017/171] (940s left) gem_ctx_create (basic-files)
[106.484581] Subtest basic-files: SKIP (0.000s)
[106.576224] [018/171] (940s left) gem_ctx_exec (basic)
[107.178146] Subtest basic: SKIP (0.000s)
[107.299475] [019/171] (939s left) gem_exec_basic (basic)
[107.911707] Starting subtest: basic
[107.915114] Starting dynamic subtest: rcs0-smem
[107.918171] Dynamic subtest rcs0-smem: SUCCESS (0.001s)
[107.921208] Subtest basic: SUCCESS (0.005s)
[108.178520] [020/171] (938s left) gem_exec_create (basic)
[108.822878] Starting subtest: basic
[108.828388] Starting dynamic subtest: smem
[110.954354] Dynamic subtest smem: SUCCESS (2.130s)
[110.957509] Subtest basic: SUCCESS (2.132s)
[111.232326] [021/171] (935s left) gem_exec_fence (basic-busy)
[112.087135] Starting subtest: basic-busy
[112.091796] Starting dynamic subtest: rcs0
[112.119314] Dynamic subtest rcs0: SUCCESS (0.033s)
[112.123236] Subtest basic-busy: SUCCESS (0.035s)
[113.078558] [022/171] (933s left) gem_exec_fence (basic-wait)
[113.927392] Starting subtest: basic-wait
[113.931668] Starting dynamic subtest: rcs0
[113.964359] Dynamic subtest rcs0: SUCCESS (0.035s)
[113.967335] Subtest basic-wait: SUCCESS (0.038s)
[114.637578] [023/171] (932s left) gem_exec_fence (basic-await)
[115.471507] Starting subtest: basic-await
[115.475749] Starting dynamic subtest: rcs0
[115.581219] Dynamic subtest rcs0: SUCCESS (0.109s)
[115.584214] Subtest basic-await: SUCCESS (0.111s)
[116.251934] [024/171] (930s left) gem_exec_fence (nb-await)
[117.088946] Starting subtest: nb-await
[117.093254] Starting dynamic subtest: rcs0
[117.154122] Dynamic subtest rcs0: SUCCESS (0.064s)
[117.157079] Subtest nb-await: SUCCESS (0.067s)
[117.820822] [025/171] (929s left) gem_exec_gttfill (basic)
[118.461892] Starting subtest: basic
[132.648848] Subtest basic: SUCCESS (14.180s)
[132.962373] [026/171] (914s left) gem_exec_parallel (engines)
[134.020317] Starting subtest: engines
[134.024073] Starting dynamic subtest: basic
[138.188229] Dynamic subtest basic: SUCCESS (4.166s)
[138.228588] Starting dynamic subtest: contexts
[138.235106] Dynamic subtest contexts: SKIP (0.004s)
[138.266961] Starting dynamic subtest: fds
[138.273068] Dynamic subtest fds: SKIP (0.002s)
[138.300911] Starting dynamic subtest: userptr
[142.816741] Dynamic subtest userptr: SUCCESS (4.619s)
[142.819664] Subtest engines: SUCCESS (8.793s)
[143.094718] [027/171] (904s left) gem_exec_store (basic)
[143.837527] Starting subtest: basic
[143.892929] Subtest basic: SUCCESS (0.057s)
[144.173424] [028/171] (903s left) gem_flink_basic (bad-flink)
[144.769700] Starting subtest: bad-flink
[144.773706] Subtest bad-flink: SUCCESS (0.000s)
[144.902764] [029/171] (902s left) gem_flink_basic (bad-open)
[145.483742] Starting subtest: bad-open
[145.487527] Subtest bad-open: SUCCESS (0.000s)
[145.620114] [030/171] (902s left) gem_flink_basic (basic)
[146.193839] Starting subtest: basic
[146.197555] Subtest basic: SUCCESS (0.001s)
[146.322276] [031/171] (901s left) gem_flink_basic (double-flink)
[146.912720] Starting subtest: double-flink
[146.917744] Subtest double-flink: SUCCESS (0.001s)
[147.054341] [032/171] (900s left) gem_flink_basic (flink-lifetime)
[147.648558] Starting subtest: flink-lifetime
[147.659411] Subtest flink-lifetime: SUCCESS (0.007s)
[147.791503] [033/171] (900s left) gem_huc_copy (huc-copy)
[148.384633] Subtest huc-copy: SKIP (0.000s)
[148.476276] [034/171] (899s left) gem_linear_blits (basic)
[149.500145] Starting subtest: basic
[149.550786] Subtest basic: SUCCESS (0.051s)
[149.766153] [035/171] (898s left) gem_mmap (basic)
[150.645178] Starting subtest: basic
[150.662495] Subtest basic: SUCCESS (0.004s)
[150.794262] [036/171] (897s left) gem_mmap_gtt (basic)
[151.384181] Starting subtest: basic
[151.388646] Subtest basic: SUCCESS (0.004s)
[151.513235] [037/171] (896s left) gem_render_linear_blits (basic)
[152.127343] Starting subtest: basic
[152.257493] Subtest basic: SUCCESS (0.132s)
[152.381247] [038/171] (895s left) gem_render_tiled_blits (basic)
[152.972212] Starting subtest: basic
[153.116942] Subtest basic: SUCCESS (0.143s)
[153.236154] [039/171] (895s left) gem_ringfill (basic-all)
[153.871715] Starting subtest: basic-all
[155.069210] Subtest basic-all: SUCCESS (1.198s)
[155.198500] [040/171] (893s left) gem_softpin (allocator-basic)
[155.792485] Subtest allocator-basic: SKIP (0.000s)
[155.914534] [041/171] (892s left) gem_softpin (allocator-basic-reserve)
[156.508165] Subtest allocator-basic-reserve: SKIP (0.000s)
[156.633778] [042/171] (891s left) gem_softpin (safe-alignment)
[157.240225] Starting subtest: safe-alignment
[157.269528] Subtest safe-alignment: SUCCESS (0.032s)
[157.417364] [043/171] (891s left) gem_sync (basic-all)
[158.067792] Starting subtest: basic-all
[160.339097] Subtest basic-all: SUCCESS (2.269s)
[160.606155] [044/171] (888s left) gem_sync (basic-each)
[161.262643] Starting subtest: basic-each
[163.553202] Subtest basic-each: SUCCESS (2.288s)
[163.825805] [045/171] (885s left) gem_tiled_blits (basic)
[164.676581] Starting subtest: basic
[164.761571] Subtest basic: SUCCESS (0.086s)
[164.979508] [046/171] (883s left) gem_tiled_fence_blits (basic)
[166.171813] Starting subtest: basic
[166.241360] Subtest basic: SUCCESS (0.070s)
[166.463557] [047/171] (882s left) gem_tiled_pread_basic
[169.148814] [048/171] (879s left) gem_wait (busy@all-engines)
[169.837711] Starting subtest: busy
[169.842101] Starting dynamic subtest: all-engines
[170.377555] Dynamic subtest all-engines: SUCCESS (0.540s)
[170.381467] Subtest busy: SUCCESS (0.542s)
[170.768963] [049/171] (878s left) gem_wait (wait@all-engines)
[171.449387] Starting subtest: wait
[171.452970] Starting dynamic subtest: all-engines
[172.486680] Dynamic subtest all-engines: SUCCESS (1.038s)
[172.490693] Subtest wait: SUCCESS (1.041s)
[172.888913] [050/171] (876s left) i915_getparams_basic (basic-eu-total)
[173.491402] Starting subtest: basic-eu-total
[173.497121] Subtest basic-eu-total: SUCCESS (0.000s)
[173.618298] [051/171] (875s left) i915_getparams_basic (basic-subslice-total)
[174.206153] Starting subtest: basic-subslice-total
[174.212617] Subtest basic-subslice-total: SUCCESS (0.000s)
[174.334845] [052/171] (875s left) i915_hangman (error-state-basic)
[174.949281] Starting subtest: error-state-basic
[175.286140] Subtest error-state-basic: SUCCESS (0.335s)
[175.404738] [053/171] (874s left) i915_pciid
[176.117700] [054/171] (873s left) kms_addfb_basic (addfb25-bad-modifier)
[176.710503] Starting subtest: addfb25-bad-modifier
[176.716359] Subtest addfb25-bad-modifier: SUCCESS (0.002s)
[176.919855] [055/171] (872s left) kms_addfb_basic (addfb25-framebuffer-vs-set-tiling)
[177.507721] Starting subtest: addfb25-framebuffer-vs-set-tiling
[177.511562] Subtest addfb25-framebuffer-vs-set-tiling: SUCCESS (0.000s)
[177.736999] [056/171] (872s left) kms_addfb_basic (addfb25-modifier-no-flag)
[178.346909] Starting subtest: addfb25-modifier-no-flag
[178.350830] Subtest addfb25-modifier-no-flag: SUCCESS (0.000s)
[178.544532] [057/171] (871s left) kms_addfb_basic (addfb25-x-tiled-legacy)
[179.151587] Starting subtest: addfb25-x-tiled-legacy
[179.154946] Subtest addfb25-x-tiled-legacy: SUCCESS (0.000s)
[179.358529] [058/171] (870s left) kms_addfb_basic (addfb25-x-tiled-mismatch-legacy)
[179.958640] Starting subtest: addfb25-x-tiled-mismatch-legacy
[179.964182] Subtest addfb25-x-tiled-mismatch-legacy: SUCCESS (0.002s)
[180.144428] [059/171] (869s left) kms_addfb_basic (addfb25-yf-tiled-legacy)
[180.790706] Starting subtest: addfb25-yf-tiled-legacy
[180.794459] Subtest addfb25-yf-tiled-legacy: SUCCESS (0.001s)
[180.932169] [060/171] (869s left) kms_addfb_basic (addfb25-y-tiled-legacy)
[181.598171] Starting subtest: addfb25-y-tiled-legacy
[181.601368] Subtest addfb25-y-tiled-legacy: SUCCESS (0.001s)
[181.783780] [061/171] (868s left) kms_addfb_basic (addfb25-y-tiled-small-legacy)
[182.476911] Starting subtest: addfb25-y-tiled-small-legacy
[182.483589] Subtest addfb25-y-tiled-small-legacy: SKIP (0.000s)
[182.609478] [062/171] (867s left) kms_addfb_basic (bad-pitch-0)
[183.196721] Starting subtest: bad-pitch-0
[183.200712] Subtest bad-pitch-0: SUCCESS (0.000s)
[183.395172] [063/171] (867s left) kms_addfb_basic (bad-pitch-1024)
[183.978799] Starting subtest: bad-pitch-1024
[183.982690] Subtest bad-pitch-1024: SUCCESS (0.000s)
[184.163656] [064/171] (866s left) kms_addfb_basic (bad-pitch-128)
[184.779391] Starting subtest: bad-pitch-128
[184.783367] Subtest bad-pitch-128: SUCCESS (0.000s)
[185.057188] [065/171] (865s left) kms_addfb_basic (bad-pitch-256)
[185.689104] Starting subtest: bad-pitch-256
[185.692663] Subtest bad-pitch-256: SUCCESS (0.000s)
[185.866753] [066/171] (864s left) kms_addfb_basic (bad-pitch-32)
[186.483555] Starting subtest: bad-pitch-32
[186.487257] Subtest bad-pitch-32: SUCCESS (0.000s)
[186.680735] [067/171] (864s left) kms_addfb_basic (bad-pitch-63)
[187.260521] Starting subtest: bad-pitch-63
[187.264568] Subtest bad-pitch-63: SUCCESS (0.000s)
[187.475407] [068/171] (863s left) kms_addfb_basic (bad-pitch-65536)
[188.066099] Starting subtest: bad-pitch-65536
[188.073315] Subtest bad-pitch-65536: SUCCESS (0.002s)
[188.258582] [069/171] (862s left) kms_addfb_basic (bad-pitch-999)
[188.852475] Starting subtest: bad-pitch-999
[188.856809] Subtest bad-pitch-999: SUCCESS (0.000s)
[189.039922] [070/171] (862s left) kms_addfb_basic (basic)
[189.644880] Starting subtest: basic
[189.649992] Subtest basic: SUCCESS (0.000s)
[189.850811] [071/171] (861s left) kms_addfb_basic (basic-x-tiled-legacy)
[190.446746] Starting subtest: basic-x-tiled-legacy
[190.450891] Subtest basic-x-tiled-legacy: SUCCESS (0.000s)
[190.636371] [072/171] (860s left) kms_addfb_basic (basic-y-tiled-legacy)
[191.241765] Starting subtest: basic-y-tiled-legacy
[191.245659] Subtest basic-y-tiled-legacy: SUCCESS (0.002s)
[191.428781] [073/171] (859s left) kms_addfb_basic (bo-too-small)
[192.067665] Starting subtest: bo-too-small
[192.071996] Subtest bo-too-small: SUCCESS (0.002s)
[192.219521] [074/171] (859s left) kms_addfb_basic (bo-too-small-due-to-tiling)
[192.874731] Starting subtest: bo-too-small-due-to-tiling
[192.879362] Subtest bo-too-small-due-to-tiling: SUCCESS (0.002s)
[193.016669] [075/171] (858s left) kms_addfb_basic (clobberred-modifier)
[193.612855] Starting subtest: clobberred-modifier
[193.620461] Subtest clobberred-modifier: SUCCESS (0.001s)
[193.805887] [076/171] (857s left) kms_addfb_basic (framebuffer-vs-set-tiling)
[194.402354] Starting subtest: framebuffer-vs-set-tiling
[194.405457] Subtest framebuffer-vs-set-tiling: SUCCESS (0.001s)
[194.613238] [077/171] (857s left) kms_addfb_basic (invalid-get-prop)
[195.218405] Starting subtest: invalid-get-prop
[195.222775] Subtest invalid-get-prop: SUCCESS (0.000s)
[195.423431] [078/171] (856s left) kms_addfb_basic (invalid-get-prop-any)
[196.016638] Starting subtest: invalid-get-prop-any
[196.020697] Subtest invalid-get-prop-any: SUCCESS (0.000s)
[196.198451] [079/171] (855s left) kms_addfb_basic (invalid-set-prop)
[196.797359] Starting subtest: invalid-set-prop
[196.801237] Subtest invalid-set-prop: SUCCESS (0.000s)
[196.975757] [080/171] (854s left) kms_addfb_basic (invalid-set-prop-any)
[197.567526] Starting subtest: invalid-set-prop-any
[197.570529] Subtest invalid-set-prop-any: SUCCESS (0.000s)
[197.792448] [081/171] (854s left) kms_addfb_basic (no-handle)
[198.396819] Starting subtest: no-handle
[198.401952] Subtest no-handle: SUCCESS (0.000s)
[198.581876] [082/171] (853s left) kms_addfb_basic (size-max)
[199.226153] Starting subtest: size-max
[199.229574] Subtest size-max: SUCCESS (0.001s)
[199.359893] [083/171] (852s left) kms_addfb_basic (small-bo)
[199.999307] Starting subtest: small-bo
[200.003573] Subtest small-bo: SUCCESS (0.000s)
[200.131951] [084/171] (852s left) kms_addfb_basic (tile-pitch-mismatch)
[200.722691] Starting subtest: tile-pitch-mismatch
[200.726481] Subtest tile-pitch-mismatch: SUCCESS (0.002s)
[200.927988] [085/171] (851s left) kms_addfb_basic (too-high)
[201.557118] Starting subtest: too-high
[201.560993] Subtest too-high: SUCCESS (0.005s)
[201.713629] [086/171] (850s left) kms_addfb_basic (too-wide)
[202.343593] Starting subtest: too-wide
[202.348756] Subtest too-wide: SUCCESS (0.000s)
[202.483404] [087/171] (850s left) kms_addfb_basic (unused-handle)
[203.080300] Starting subtest: unused-handle
[203.084769] Subtest unused-handle: SUCCESS (0.000s)
[203.272519] [088/171] (849s left) kms_addfb_basic (unused-modifier)
[203.869725] Starting subtest: unused-modifier
[203.873610] Subtest unused-modifier: SUCCESS (0.000s)
[204.066534] [089/171] (848s left) kms_addfb_basic (unused-offsets)
[204.681803] Starting subtest: unused-offsets
[204.686357] Subtest unused-offsets: SUCCESS (0.000s)
[204.884257] [090/171] (847s left) kms_addfb_basic (unused-pitches)
[205.496201] Starting subtest: unused-pitches
[205.500362] Subtest unused-pitches: SUCCESS (0.000s)
[205.693878] [091/171] (847s left) kms_busy (basic)
[206.355895] Starting subtest: basic
[206.360776] Starting dynamic subtest: flip
[207.805848] Dynamic subtest flip: SUCCESS (1.448s)
[207.842865] Starting dynamic subtest: modeset
[207.849617] Dynamic subtest modeset: SKIP (0.000s)
[207.852565] Subtest basic: SUCCESS (1.454s)
[208.082271] [092/171] (844s left) kms_chamelium_hpd (dp-hpd-fast)
[208.707958] Subtest dp-hpd-fast: SKIP (0.000s)
[208.832127] [093/171] (844s left) kms_chamelium_edid (dp-edid-read)
[209.489285] Subtest dp-edid-read: SKIP (0.000s)
[209.600667] [094/171] (843s left) kms_chamelium_frames (dp-crc-fast)
[210.226723] Subtest dp-crc-fast: SKIP (0.000s)
[210.333969] [095/171] (842s left) kms_chamelium_hpd (hdmi-hpd-fast)
[210.995089] Subtest hdmi-hpd-fast: SKIP (0.000s)
[211.105598] [096/171] (842s left) kms_chamelium_edid (hdmi-edid-read)
[211.743413] Subtest hdmi-edid-read: SKIP (0.000s)
[211.858189] [097/171] (841s left) kms_chamelium_frames (hdmi-crc-fast)
[212.511565] Subtest hdmi-crc-fast: SKIP (0.000s)
[212.616360] [098/171] (840s left) kms_chamelium_hpd (vga-hpd-fast)
[213.260961] Subtest vga-hpd-fast: SKIP (0.000s)
[213.367245] [099/171] (840s left) kms_chamelium_edid (vga-edid-read)
[214.015400] Subtest vga-edid-read: SKIP (0.000s)
[214.136961] [100/171] (839s left) kms_prop_blob (basic)
[214.732665] Starting subtest: basic
[214.736817] Subtest basic: SUCCESS (0.000s)
[214.861334] [101/171] (838s left) kms_cursor_legacy (basic-busy-flip-before-cursor-atomic)
[215.497556] Starting subtest: basic-busy-flip-before-cursor-atomic
[215.511388] Subtest basic-busy-flip-before-cursor-atomic: SKIP (0.014s)
[215.684127] [102/171] (838s left) kms_cursor_legacy (basic-busy-flip-before-cursor-legacy)
[216.298673] Starting subtest: basic-busy-flip-before-cursor-legacy
[217.590763] Subtest basic-busy-flip-before-cursor-legacy: SUCCESS (1.295s)
[217.863215] [103/171] (836s left) kms_cursor_legacy (basic-flip-after-cursor-atomic)
[218.503317] Starting subtest: basic-flip-after-cursor-atomic
[218.511529] Subtest basic-flip-after-cursor-atomic: SKIP (0.000s)
[218.641770] [104/171] (835s left) kms_cursor_legacy (basic-flip-after-cursor-legacy)
[219.270197] Starting subtest: basic-flip-after-cursor-legacy
[220.561658] Subtest basic-flip-after-cursor-legacy: SUCCESS (1.293s)
[220.831118] [105/171] (833s left) kms_cursor_legacy (basic-flip-after-cursor-varying-size)
[221.502590] Starting subtest: basic-flip-after-cursor-varying-size
[222.795480] Subtest basic-flip-after-cursor-varying-size: SUCCESS (1.292s)
[223.060944] [106/171] (831s left) kms_cursor_legacy (basic-flip-before-cursor-atomic)
[223.700336] Starting subtest: basic-flip-before-cursor-atomic
[223.707470] Subtest basic-flip-before-cursor-atomic: SKIP (0.000s)
[223.839222] [107/171] (830s left) kms_cursor_legacy (basic-flip-before-cursor-legacy)
[224.488576] Starting subtest: basic-flip-before-cursor-legacy
[225.761560] Subtest basic-flip-before-cursor-legacy: SUCCESS (1.275s)
[226.039572] [108/171] (828s left) kms_cursor_legacy (basic-flip-before-cursor-varying-size)
[226.667661] Starting subtest: basic-flip-before-cursor-varying-size
[227.958589] Subtest basic-flip-before-cursor-varying-size: SUCCESS (1.292s)
[228.240606] [109/171] (826s left) kms_flip (basic-flip-vs-dpms)
[228.866505] Starting subtest: basic-flip-vs-dpms
[228.870627] Starting dynamic subtest: A-VGA1
[230.616190] Dynamic subtest A-VGA1: SUCCESS (1.748s)
[230.655642] Starting dynamic subtest: B-VGA1
[232.098460] Dynamic subtest B-VGA1: SUCCESS (1.483s)
[232.106236] Subtest basic-flip-vs-dpms: SUCCESS (3.236s)
[232.505279] [110/171] (822s left) kms_flip (basic-flip-vs-modeset)
[233.114632] Starting subtest: basic-flip-vs-modeset
[233.120372] Starting dynamic subtest: A-VGA1
[234.904331] Dynamic subtest A-VGA1: SUCCESS (1.784s)
[234.943346] Starting dynamic subtest: B-VGA1
[236.400285] Dynamic subtest B-VGA1: SUCCESS (1.493s)
[236.407578] Subtest basic-flip-vs-modeset: SUCCESS (3.283s)
[236.744435] [111/171] (817s left) kms_flip (basic-flip-vs-wf_vblank)
[237.367383] Starting subtest: basic-flip-vs-wf_vblank
[237.371552] Starting dynamic subtest: A-VGA1
[239.275635] Dynamic subtest A-VGA1: SUCCESS (1.904s)
[239.309506] Starting dynamic subtest: B-VGA1
[240.979836] Dynamic subtest B-VGA1: SUCCESS (1.697s)
[240.983706] Subtest basic-flip-vs-wf_vblank: SUCCESS (3.605s)
[241.386655] [112/171] (813s left) kms_flip (basic-plain-flip)
[242.000433] Starting subtest: basic-plain-flip
[242.004628] Starting dynamic subtest: A-VGA1
[243.608715] Dynamic subtest A-VGA1: SUCCESS (1.606s)
[243.649626] Starting dynamic subtest: B-VGA1
[245.000462] Dynamic subtest B-VGA1: SUCCESS (1.390s)
[245.004319] Subtest basic-plain-flip: SUCCESS (3.001s)
[245.400320] [113/171] (809s left) kms_force_connector_basic (force-connector-state)
[246.074657] Starting subtest: force-connector-state
[246.365381] Subtest force-connector-state: SUCCESS (0.291s)
[246.782225] [114/171] (808s left) kms_force_connector_basic (force-edid)
[247.430724] Starting subtest: force-edid
[247.528649] Subtest force-edid: SUCCESS (0.100s)
[247.749521] [115/171] (807s left) kms_force_connector_basic (force-load-detect)
[248.394569] Starting subtest: force-load-detect
[248.770678] Subtest force-load-detect: SUCCESS (0.374s)
[249.149165] [116/171] (806s left) kms_force_connector_basic (prune-stale-modes)
[249.808644] Starting subtest: prune-stale-modes
[249.907376] Subtest prune-stale-modes: SUCCESS (0.104s)
[250.161166] [117/171] (805s left) kms_frontbuffer_tracking (basic)
[250.820241] Subtest basic: SKIP (0.000s)
[250.931994] [118/171] (804s left) kms_pipe_crc_basic (compare-crc-sanitycheck-xr24)
[251.555884] Starting subtest: compare-crc-sanitycheck-xr24
[251.561624] Starting dynamic subtest: pipe-A-VGA-1
[251.931346] Dynamic subtest pipe-A-VGA-1: SUCCESS (0.368s)
[251.972126] Starting dynamic subtest: pipe-B-VGA-1
[252.403840] Dynamic subtest pipe-B-VGA-1: SUCCESS (0.466s)
[252.407739] Subtest compare-crc-sanitycheck-xr24: SUCCESS (0.844s)
[252.668150] [119/171] (802s left) kms_pipe_crc_basic (compare-crc-sanitycheck-nv12)
[253.299384] Starting subtest: compare-crc-sanitycheck-nv12
[253.303607] Starting dynamic subtest: pipe-A-VGA-1
[253.314201] Dynamic subtest pipe-A-VGA-1: SKIP (0.001s)
[253.345794] Starting dynamic subtest: pipe-B-VGA-1
[253.353886] Dynamic subtest pipe-B-VGA-1: SKIP (0.001s)
[253.365321] Subtest compare-crc-sanitycheck-nv12: SKIP (0.010s)
[253.444681] [120/171] (802s left) kms_pipe_crc_basic (hang-read-crc)
[254.105230] Starting subtest: hang-read-crc
[254.109154] Starting dynamic subtest: pipe-A-VGA-1
[255.351550] Dynamic subtest pipe-A-VGA-1: SUCCESS (1.241s)
[255.393522] Starting dynamic subtest: pipe-B-VGA-1
[256.658938] Dynamic subtest pipe-B-VGA-1: SUCCESS (1.305s)
[256.662490] Subtest hang-read-crc: SUCCESS (2.556s)
[256.917590] [121/171] (798s left) kms_pipe_crc_basic (nonblocking-crc)
[257.543594] Starting subtest: nonblocking-crc
[257.547653] Starting dynamic subtest: pipe-A-VGA-1
[258.095198] Dynamic subtest pipe-A-VGA-1: SUCCESS (0.549s)
[258.139513] Starting dynamic subtest: pipe-B-VGA-1
[258.769727] Dynamic subtest pipe-B-VGA-1: SUCCESS (0.671s)
[258.773839] Subtest nonblocking-crc: SUCCESS (1.229s)
[259.014133] [122/171] (796s left) kms_pipe_crc_basic (nonblocking-crc-frame-sequence)
[259.628696] Starting subtest: nonblocking-crc-frame-sequence
[259.633553] Starting dynamic subtest: pipe-A-VGA-1
[260.199580] Dynamic subtest pipe-A-VGA-1: SUCCESS (0.567s)
[260.239570] Starting dynamic subtest: pipe-B-VGA-1
[260.868128] Dynamic subtest pipe-B-VGA-1: SUCCESS (0.659s)
[260.871516] Subtest nonblocking-crc-frame-sequence: SUCCESS (1.237s)
[261.133259] [123/171] (794s left) kms_pipe_crc_basic (read-crc)
[261.770826] Starting subtest: read-crc
[261.775196] Starting dynamic subtest: pipe-A-VGA-1
[262.254616] Dynamic subtest pipe-A-VGA-1: SUCCESS (0.482s)
[262.295649] Starting dynamic subtest: pipe-B-VGA-1
[262.853889] Dynamic subtest pipe-B-VGA-1: SUCCESS (0.595s)
[262.858271] Subtest read-crc: SUCCESS (1.087s)
[263.123725] [124/171] (792s left) kms_pipe_crc_basic (read-crc-frame-sequence)
[263.751599] Starting subtest: read-crc-frame-sequence
[263.759188] Starting dynamic subtest: pipe-A-VGA-1
[264.247947] Dynamic subtest pipe-A-VGA-1: SUCCESS (0.495s)
[264.300216] Starting dynamic subtest: pipe-B-VGA-1
[264.849152] Dynamic subtest pipe-B-VGA-1: SUCCESS (0.596s)
[264.852850] Subtest read-crc-frame-sequence: SUCCESS (1.101s)
[265.106736] [125/171] (790s left) kms_psr (primary_page_flip)
[265.698609] Subtest primary_page_flip: SKIP (0.000s)
[265.818370] [126/171] (790s left) kms_psr (cursor_plane_move)
[266.410622] Subtest cursor_plane_move: SKIP (0.000s)
[266.512685] [127/171] (789s left) kms_psr (sprite_plane_onoff)
[267.108784] Subtest sprite_plane_onoff: SKIP (0.000s)
[267.212231] [128/171] (788s left) kms_psr (primary_mmap_gtt)
[267.819224] Subtest primary_mmap_gtt: SKIP (0.000s)
[267.940211] [129/171] (788s left) kms_setmode (basic-clone-single-crtc)
[268.560901] Starting subtest: basic-clone-single-crtc
[268.570642] Subtest basic-clone-single-crtc: SKIP (0.000s)
[268.697590] [130/171] (787s left) i915_pm_backlight (basic-brightness)
[269.327699] Subtest basic-brightness: SKIP (0.000s)
[269.431917] [131/171] (787s left) i915_pm_rpm (basic-pci-d3-state)
[281.520920] Subtest basic-pci-d3-state: SKIP (0.000s)
[281.618746] [132/171] (774s left) i915_pm_rpm (basic-rte)
[282.200827] Starting subtest: basic-rte
[293.737616] Subtest basic-rte: SKIP (11.510s)
[293.839917] [133/171] (762s left) i915_pm_rps (basic-api)
[294.453717] Subtest basic-api: SKIP (0.000s)
[294.572801] [134/171] (762s left) prime_self_import (basic-llseek-bad)
[295.139593] Starting subtest: basic-llseek-bad
[295.153749] Subtest basic-llseek-bad: SUCCESS (0.009s)
[295.291657] [135/171] (761s left) prime_self_import (basic-llseek-size)
[295.865738] Starting subtest: basic-llseek-size
[295.885351] Subtest basic-llseek-size: SUCCESS (0.018s)
[296.024187] [136/171] (760s left) prime_self_import (basic-with_fd_dup)
[296.612658] Starting subtest: basic-with_fd_dup
[296.628569] Subtest basic-with_fd_dup: SUCCESS (0.016s)
[296.773312] [137/171] (760s left) prime_self_import (basic-with_one_bo)
[297.358158] Starting subtest: basic-with_one_bo
[297.382120] Subtest basic-with_one_bo: SUCCESS (0.025s)
[297.516613] [138/171] (759s left) prime_self_import (basic-with_one_bo_two_files)
[298.083631] Starting subtest: basic-with_one_bo_two_files
[298.103297] Subtest basic-with_one_bo_two_files: SUCCESS (0.013s)
[298.244639] [139/171] (758s left) prime_self_import (basic-with_two_bos)
[298.837284] Starting subtest: basic-with_two_bos
[298.855551] Subtest basic-with_two_bos: SUCCESS (0.017s)
[299.016650] [140/171] (758s left) prime_vgem (basic-fence-flip)
[299.626096] Starting subtest: basic-fence-flip
[300.243413] Subtest basic-fence-flip: SUCCESS (0.614s)
[300.410801] [141/171] (756s left) prime_vgem (basic-fence-mmap)
[301.009423] Starting subtest: basic-fence-mmap
[301.179941] Subtest basic-fence-mmap: SUCCESS (0.170s)
[301.329352] [142/171] (756s left) prime_vgem (basic-fence-read)
[301.941654] Starting subtest: basic-fence-read
[302.224753] Subtest basic-fence-read: SUCCESS (0.283s)
[302.365668] [143/171] (755s left) prime_vgem (basic-gtt)
[302.980579] Starting subtest: basic-gtt
[303.047680] Subtest basic-gtt: SUCCESS (0.067s)
[303.214988] [144/171] (754s left) prime_vgem (basic-read)
[303.831679] Starting subtest: basic-read
[303.948713] Subtest basic-read: SUCCESS (0.118s)
[304.098467] [145/171] (753s left) prime_vgem (basic-write)
[304.697764] Starting subtest: basic-write
[304.827265] Subtest basic-write: SUCCESS (0.130s)
[304.963285] [146/171] (752s left) vgem_basic (setversion)
[305.565496] Starting subtest: setversion
[305.571634] Subtest setversion: SUCCESS (0.000s)
[305.680972] [147/171] (752s left) vgem_basic (create)
[306.281920] Starting subtest: create
[306.285898] Subtest create: SUCCESS (0.002s)
[306.398619] [148/171] (751s left) vgem_basic (debugfs)
[306.983304] Starting subtest: debugfs
[306.987149] Subtest debugfs: SUCCESS (0.004s)
[307.115397] [149/171] (750s left) vgem_basic (dmabuf-export)
[307.699539] Starting subtest: dmabuf-export
[307.712194] Subtest dmabuf-export: SUCCESS (0.012s)
[307.855785] [150/171] (750s left) vgem_basic (dmabuf-fence)
[308.469661] Starting subtest: dmabuf-fence
[308.473765] Subtest dmabuf-fence: SUCCESS (0.004s)
[308.586200] [151/171] (749s left) vgem_basic (dmabuf-fence-before)
[309.184112] Starting subtest: dmabuf-fence-before
[309.187761] Subtest dmabuf-fence-before: SUCCESS (0.003s)
[309.310701] [152/171] (749s left) vgem_basic (dmabuf-mmap)
[309.920106] Starting subtest: dmabuf-mmap
[309.997764] Subtest dmabuf-mmap: SUCCESS (0.080s)
[310.120732] [153/171] (748s left) vgem_basic (mmap)
[310.720280] Starting subtest: mmap
[310.774581] Subtest mmap: SUCCESS (0.056s)
[310.906795] [154/171] (747s left) vgem_basic (second-client)
[311.521365] Starting subtest: second-client
[311.553418] Subtest second-client: SUCCESS (0.033s)
[311.679632] [155/171] (746s left) vgem_basic (sysfs)
[312.288102] Starting subtest: sysfs
[312.291428] Subtest sysfs: SUCCESS (0.005s)
[312.439296] [156/171] (746s left) core_hotunplug (unbind-rebind)
[313.437288] Starting subtest: unbind-rebind
[316.148180] Subtest unbind-rebind: SUCCESS (2.709s)
[316.512466] [157/171] (742s left) vgem_basic (unload)
[317.497847] Starting subtest: unload
[346.948755] Subtest unload: SUCCESS (29.435s)
[347.216683] [158/171] (711s left) i915_module_load (reload)
[347.791565] Starting subtest: reload
[352.969608] Subtest reload: SUCCESS (5.172s)
[353.116477] [159/171] (706s left) gem_lmem_swapping (basic)
[354.333222] Subtest basic: SKIP (0.000s)
[354.488661] [160/171] (704s left) gem_lmem_swapping (parallel-random-engines)
[355.088757] Subtest parallel-random-engines: SKIP (0.000s)
[355.187936] [161/171] (704s left) gem_lmem_swapping (random-engines)
[355.811220] Subtest random-engines: SKIP (0.000s)
[355.921844] [162/171] (703s left) gem_lmem_swapping (verify-random)
[356.524356] Subtest verify-random: SKIP (0.000s)
[356.619123] [163/171] (702s left) i915_pm_rpm (module-reload)
[368.746684] Subtest module-reload: SKIP (0.000s)
[368.850684] [164/171] (690s left) i915_selftest (live)
[371.320425] Starting subtest: live
[371.324499] Starting dynamic subtest: sanitycheck
[373.709240] Dynamic subtest sanitycheck: SUCCESS (2.387s)
[373.743767] Starting dynamic subtest: uncore
[375.825122] Dynamic subtest uncore: SUCCESS (2.113s)
[375.857282] Starting dynamic subtest: workarounds
[377.944496] Dynamic subtest workarounds: SUCCESS (2.116s)
[377.979955] Starting dynamic subtest: gt_engines
[380.081355] Dynamic subtest gt_engines: SUCCESS (2.135s)
[380.114131] Starting dynamic subtest: gt_timelines
[391.004528] Dynamic subtest gt_timelines: SUCCESS (10.916s)
[391.030999] Starting dynamic subtest: gt_contexts
[393.141389] Dynamic subtest gt_contexts: SUCCESS (2.133s)
[393.173633] Starting dynamic subtest: gt_lrc
[395.224375] Dynamic subtest gt_lrc: SUCCESS (2.080s)
[395.256592] Starting dynamic subtest: gt_mocs
[397.350361] Dynamic subtest gt_mocs: SUCCESS (2.123s)
[397.382584] Starting dynamic subtest: gt_pm
[399.908528] Dynamic subtest gt_pm: SUCCESS (2.555s)
[399.940852] Starting dynamic subtest: gt_heartbeat
[402.021447] Dynamic subtest gt_heartbeat: SUCCESS (2.110s)
[402.054840] Starting dynamic subtest: gt_tlb
[404.114952] Dynamic subtest gt_tlb: SUCCESS (2.091s)
[404.155794] Starting dynamic subtest: requests
[409.174811] Dynamic subtest requests: SUCCESS (5.055s)
[409.209314] Starting dynamic subtest: migrate
[412.103717] Dynamic subtest migrate: SUCCESS (2.923s)
[412.140104] Starting dynamic subtest: active
[414.301582] Dynamic subtest active: SUCCESS (2.195s)
[414.334439] Starting dynamic subtest: objects
[417.341265] Dynamic subtest objects: SUCCESS (3.036s)
[417.368301] Starting dynamic subtest: mman
[428.953286] Dynamic subtest mman: SUCCESS (11.604s)
[428.983509] Starting dynamic subtest: dmabuf
[431.162426] Dynamic subtest dmabuf: SUCCESS (2.206s)
[431.198550] Starting dynamic subtest: vma
[433.315292] Dynamic subtest vma: SUCCESS (2.150s)
[433.347775] Starting dynamic subtest: coherency
[440.519551] Dynamic subtest coherency: SUCCESS (7.198s)
[440.549119] Starting dynamic subtest: gtt
[445.667300] Dynamic subtest gtt: SUCCESS (5.143s)
[445.695099] Starting dynamic subtest: gem
[447.839474] Dynamic subtest gem: SUCCESS (2.169s)
[447.872494] Starting dynamic subtest: evict
[449.940265] Dynamic subtest evict: SUCCESS (2.098s)
[449.978264] Starting dynamic subtest: hugepages
[452.036394] Dynamic subtest hugepages: SUCCESS (2.092s)
[452.070984] Starting dynamic subtest: gem_contexts
[454.104320] Dynamic subtest gem_contexts: SUCCESS (2.066s)
[454.139559] Starting dynamic subtest: client
[456.239497] Dynamic subtest client: SUCCESS (2.132s)
[456.272649] Starting dynamic subtest: gem_migrate
[458.327295] Dynamic subtest gem_migrate: SUCCESS (2.085s)
[458.360454] Starting dynamic subtest: reset
[460.953618] Dynamic subtest reset: SUCCESS (2.623s)
[460.982488] Starting dynamic subtest: memory_region
[463.037454] Dynamic subtest memory_region: SUCCESS (2.080s)
[463.070381] Starting dynamic subtest: hangcheck
[466.213456] Dynamic subtest hangcheck: SUCCESS (3.173s)
[466.242435] Starting dynamic subtest: execlists
[468.337328] Dynamic subtest execlists: SUCCESS (2.121s)
[468.364462] Starting dynamic subtest: ring_submission
[470.475202] Dynamic subtest ring_submission: SUCCESS (2.133s)
[470.508420] Starting dynamic subtest: perf
[472.567450] Dynamic subtest perf: SUCCESS (2.089s)
[472.603787] Starting dynamic subtest: slpc
[474.689829] Dynamic subtest slpc: SUCCESS (2.120s)
[474.723472] Starting dynamic subtest: guc
[476.788787] Dynamic subtest guc: SUCCESS (2.096s)
[476.824826] Starting dynamic subtest: guc_multi_lrc
[478.859873] Dynamic subtest guc_multi_lrc: SUCCESS (2.068s)
[478.895137] Starting dynamic subtest: guc_hang
[480.995544] Dynamic subtest guc_hang: SUCCESS (2.132s)
[481.028353] Starting dynamic subtest: late_gt_pm
[483.140978] Dynamic subtest late_gt_pm: SUCCESS (2.139s)
[483.144735] Subtest live: SUCCESS (111.765s)
[483.402755] [165/171] (576s left) dmabuf (all-tests)
[484.088808] Starting subtest: all-tests
[484.096974] Starting dynamic subtest: sanitycheck
[484.177678] Dynamic subtest sanitycheck: SUCCESS (0.092s)
[484.216116] Starting dynamic subtest: dma_fence
[484.406568] Dynamic subtest dma_fence: SUCCESS (0.226s)
[484.441452] Starting dynamic subtest: dma_fence_chain
[535.870294] Dynamic subtest dma_fence_chain: SUCCESS (51.435s)
[535.902695] Starting dynamic subtest: dma_fence_unwrap
[535.966492] Dynamic subtest dma_fence_unwrap: SUCCESS (0.094s)
[536.001528] Starting dynamic subtest: dma_resv
[536.065507] Dynamic subtest dma_resv: SUCCESS (0.096s)
[536.069645] Subtest all-tests: SUCCESS (51.956s)
[536.153228] [166/171] (523s left) i915_suspend (basic-s2idle-without-i915)
[536.731663] Starting subtest: basic-s2idle-without-i915
[558.706153] Subtest basic-s2idle-without-i915: SUCCESS (7.123s)
[560.889274] [167/171] (515s left) i915_suspend (basic-s3-without-i915)
[561.602580] Starting subtest: basic-s3-without-i915
[582.759529] Subtest basic-s3-without-i915: SUCCESS (4.851s)
[588.058916] [168/171] (510s left) gem_exec_suspend (basic-s0)
[588.908385] Starting subtest: basic-S0
[588.912580] Starting dynamic subtest: smem
[609.767259] Dynamic subtest smem: SUCCESS (6.093s)
[609.770635] Subtest basic-S0: SUCCESS (6.096s)
[611.924371] [169/171] (503s left) gem_exec_suspend (basic-s3)
[612.563757] Starting subtest: basic-S3
[612.568278] Starting dynamic subtest: smem
[635.011174] Dynamic subtest smem: SUCCESS (6.612s)
[635.014643] Subtest basic-S3: SUCCESS (6.615s)
[639.326155] [170/171] (495s left) kms_chamelium_hpd (common-hpd-after-suspend)
[639.976075] Subtest common-hpd-after-suspend: SKIP (0.000s)
[640.080157] [171/171] (495s left) kms_pipe_crc_basic (suspend-read-crc)
[640.716191] Starting subtest: suspend-read-crc
[640.720012] Starting dynamic subtest: pipe-A-VGA-1
[659.735987] Dynamic subtest pipe-A-VGA-1: SUCCESS (2.641s)
[659.799079] Starting dynamic subtest: pipe-B-VGA-1
[678.639199] Dynamic subtest pipe-B-VGA-1: SUCCESS (2.576s)
[678.643970] Subtest suspend-read-crc: SUCCESS (5.232s)
[682.898155] Closing watchdogs
Done.