[99.924388] Initializing watchdogs
[99.924500]   /dev/watchdog0
[99.974765] [001/171] (960s left) i915_module_load (load)
[102.352741] Starting subtest: load
[108.068309] Subtest load: SUCCESS (5.788s)
[108.311822] [002/171] (952s left) core_auth (basic-auth)
[109.521447] Starting subtest: basic-auth
[109.579797] Subtest basic-auth: SUCCESS (0.001s)
[109.765794] [003/171] (951s left) debugfs_test (read_all_entries)
[110.558249] Starting subtest: read_all_entries
[110.641777] Subtest read_all_entries: SUCCESS (0.053s)
[110.986235] [004/171] (950s left) debugfs_test (basic-hwmon)
[111.703696] Starting subtest: basic-hwmon
[111.787508] Subtest basic-hwmon: SKIP (0.000s)
[112.099290] [005/171] (949s left) fbdev (eof)
[112.509497] Starting subtest: eof
[112.559684] Subtest eof: SUCCESS (0.000s)
[112.685953] [006/171] (948s left) fbdev (info)
[113.069719] Starting subtest: info
[113.111569] Subtest info: SUCCESS (0.000s)
[113.221484] [007/171] (948s left) fbdev (nullptr)
[113.596481] Starting subtest: nullptr
[113.646608] Subtest nullptr: SUCCESS (0.000s)
[113.764775] [008/171] (948s left) fbdev (read)
[114.122831] Starting subtest: read
[114.564973] Subtest read: SUCCESS (0.472s)
[114.666874] [009/171] (947s left) fbdev (write)
[115.058451] Starting subtest: write
[115.100385] Subtest write: SUCCESS (0.109s)
[115.211553] [010/171] (946s left) gem_basic (bad-close)
[115.679137] Starting subtest: bad-close
[115.762576] Subtest bad-close: SUCCESS (0.000s)
[115.880528] [011/171] (946s left) gem_basic (create-close)
[116.247629] Starting subtest: create-close
[116.331215] Subtest create-close: SUCCESS (0.000s)
[116.449279] [012/171] (946s left) gem_basic (create-fd-close)
[116.824667] Starting subtest: create-fd-close
[116.891630] Subtest create-fd-close: SUCCESS (0.000s)
[116.993110] [013/171] (945s left) gem_busy (busy@all-engines)
[117.443441] Starting subtest: busy
[117.485468] Starting dynamic subtest: all-engines
[117.527054] Dynamic subtest all-engines: SUCCESS (0.038s)
[117.570766] Subtest busy: SUCCESS (0.038s)
[117.814547] [014/171] (945s left) gem_close_race (basic-process)
[118.331714] Starting subtest: basic-process
[118.373420] Subtest basic-process: SUCCESS (0.052s)
[118.483479] [015/171] (944s left) gem_close_race (basic-threads)
[118.941572] Starting subtest: basic-threads
[120.037520] Subtest basic-threads: SUCCESS (1.161s)
[120.238533] [016/171] (942s left) gem_ctx_create (basic)
[120.714068] Starting subtest: basic
[120.764487] Subtest basic: SUCCESS (0.000s)
[120.882463] [017/171] (942s left) gem_ctx_create (basic-files)
[121.290951] Starting subtest: basic-files
[123.293497] Subtest basic-files: SUCCESS (2.018s)
[123.545457] [018/171] (939s left) gem_ctx_exec (basic)
[124.054444] Starting subtest: basic
[124.096346] Subtest basic: SUCCESS (0.001s)
[124.214442] [019/171] (939s left) gem_exec_basic (basic)
[124.614721] Starting subtest: basic
[124.665104] Starting dynamic subtest: rcs0-smem
[124.715076] Dynamic subtest rcs0-smem: SUCCESS (0.000s)
[124.773527] Starting dynamic subtest: bcs0-smem
[124.823843] Dynamic subtest bcs0-smem: SUCCESS (0.000s)
[124.884106] Starting dynamic subtest: vcs0-smem
[124.925860] Dynamic subtest vcs0-smem: SUCCESS (0.000s)
[124.967682] Subtest basic: SUCCESS (0.001s)
[125.077320] [020/171] (938s left) gem_exec_create (basic)
[125.552368] Starting subtest: basic
[125.594167] Starting dynamic subtest: smem
[127.520458] Dynamic subtest smem: SUCCESS (2.045s)
[127.562127] Subtest basic: SUCCESS (2.045s)
[127.730729] [021/171] (935s left) gem_exec_fence (basic-busy)
[128.631576] Subtest basic-busy: SKIP (0.000s)
[129.042516] [022/171] (934s left) gem_exec_fence (basic-wait)
[129.528147] Subtest basic-wait: SKIP (0.000s)
[129.805329] [023/171] (934s left) gem_exec_fence (basic-await)
[130.314242] Subtest basic-await: SKIP (0.000s)
[130.624925] [024/171] (933s left) gem_exec_fence (nb-await)
[131.158960] Subtest nb-await: SKIP (0.000s)
[131.461715] [025/171] (932s left) gem_exec_gttfill (basic)
[131.838165] Starting subtest: basic
[136.873437] Subtest basic: SUCCESS (5.143s)
[137.083010] [026/171] (926s left) gem_exec_parallel (engines)
[139.117529] Starting subtest: engines
[139.159362] Starting dynamic subtest: basic
[140.643398] Dynamic subtest basic: SUCCESS (1.613s)
[140.693567] Starting dynamic subtest: contexts
[142.435872] Dynamic subtest contexts: SUCCESS (1.826s)
[142.486102] Starting dynamic subtest: fds
[144.945144] Dynamic subtest fds: SUCCESS (2.505s)
[144.995370] Starting dynamic subtest: userptr
[146.696526] Dynamic subtest userptr: SUCCESS (1.719s)
[146.737889] Subtest engines: SUCCESS (7.663s)
[146.898543] [027/171] (917s left) gem_exec_store (basic)
[147.526427] Starting subtest: basic
[147.567937] Subtest basic: SUCCESS (0.039s)
[147.677713] [028/171] (916s left) gem_flink_basic (bad-flink)
[148.136435] Starting subtest: bad-flink
[148.178263] Subtest bad-flink: SUCCESS (0.000s)
[148.287888] [029/171] (916s left) gem_flink_basic (bad-open)
[148.655087] Starting subtest: bad-open
[148.696850] Subtest bad-open: SUCCESS (0.000s)
[148.806510] [030/171] (915s left) gem_flink_basic (basic)
[149.206808] Starting subtest: basic
[149.257099] Subtest basic: SUCCESS (0.000s)
[149.383543] [031/171] (915s left) gem_flink_basic (double-flink)
[149.750437] Starting subtest: double-flink
[149.800597] Subtest double-flink: SUCCESS (0.000s)
[149.912344] [032/171] (915s left) gem_flink_basic (flink-lifetime)
[150.304132] Starting subtest: flink-lifetime
[150.345948] Subtest flink-lifetime: SUCCESS (0.001s)
[150.455514] [033/171] (914s left) gem_huc_copy (huc-copy)
[150.897981] Subtest huc-copy: SKIP (0.000s)
[151.015820] [034/171] (914s left) gem_linear_blits (basic)
[151.533518] Starting subtest: basic
[151.600317] Subtest basic: SUCCESS (0.009s)
[152.043734] [035/171] (913s left) gem_mmap (basic)
[154.077336] Starting subtest: basic
[154.288068] Subtest basic: SUCCESS (0.000s)
[154.397783] [036/171] (911s left) gem_mmap_gtt (basic)
[154.831565] Starting subtest: basic
[154.873320] Subtest basic: SUCCESS (0.001s)
[154.991421] [037/171] (910s left) gem_render_linear_blits (basic)
[155.533367] Starting subtest: basic
[155.784179] Subtest basic: SUCCESS (0.025s)
[155.985449] [038/171] (910s left) gem_render_tiled_blits (basic)
[156.569800] Starting subtest: basic
[156.770477] Subtest basic: SUCCESS (0.029s)
[156.880548] [039/171] (909s left) gem_ringfill (basic-all)
[157.457407] Starting subtest: basic-all
[158.524934] Subtest basic-all: SUCCESS (1.165s)
[158.634742] [040/171] (908s left) gem_softpin (allocator-basic)
[159.143703] Subtest allocator-basic: SKIP (0.000s)
[159.269980] [041/171] (907s left) gem_softpin (allocator-basic-reserve)
[159.703762] Subtest allocator-basic-reserve: SKIP (0.000s)
[159.813669] [042/171] (907s left) gem_softpin (safe-alignment)
[160.238979] Starting subtest: safe-alignment
[160.280882] Subtest safe-alignment: SUCCESS (0.008s)
[160.450603] [043/171] (907s left) gem_sync (basic-all)
[161.026069] Starting subtest: basic-all
[162.960495] Subtest basic-all: SUCCESS (2.047s)
[163.154179] [044/171] (904s left) gem_sync (basic-each)
[163.637505] Starting subtest: basic-each
[165.580081] Subtest basic-each: SUCCESS (2.082s)
[165.731916] [045/171] (901s left) gem_tiled_blits (basic)
[166.123862] Starting subtest: basic
[166.191098] Subtest basic: SUCCESS (0.014s)
[166.567562] [046/171] (901s left) gem_tiled_fence_blits (basic)
[168.619716] Starting subtest: basic
[168.694887] Subtest basic: SUCCESS (0.012s)
[169.096385] [047/171] (898s left) gem_tiled_pread_basic
[171.198757] [048/171] (896s left) gem_wait (busy@all-engines)
[171.615495] Starting subtest: busy
[171.657328] Starting dynamic subtest: all-engines
[172.074874] Dynamic subtest all-engines: SUCCESS (0.512s)
[172.116400] Subtest busy: SUCCESS (0.512s)
[172.301638] [049/171] (895s left) gem_wait (wait@all-engines)
[172.693458] Starting subtest: wait
[172.735227] Starting dynamic subtest: all-engines
[173.704460] Dynamic subtest all-engines: SUCCESS (1.018s)
[173.745940] Subtest wait: SUCCESS (1.018s)
[173.906205] [050/171] (894s left) i915_getparams_basic (basic-eu-total)
[174.348423] Starting subtest: basic-eu-total
[174.432138] Subtest basic-eu-total: SUCCESS (0.000s)
[174.550406] [051/171] (893s left) i915_getparams_basic (basic-subslice-total)
[175.017288] Starting subtest: basic-subslice-total
[175.117593] Subtest basic-subslice-total: SUCCESS (0.000s)
[175.329397] [052/171] (893s left) i915_hangman (error-state-basic)
[175.886081] Starting subtest: error-state-basic
[175.952786] Subtest error-state-basic: SUCCESS (0.005s)
[176.320848] [053/171] (892s left) i915_pciid
[176.916409] [054/171] (892s left) kms_addfb_basic (addfb25-bad-modifier)
[177.424999] Starting subtest: addfb25-bad-modifier
[177.500207] Subtest addfb25-bad-modifier: SUCCESS (0.000s)
[178.104540] [055/171] (891s left) kms_addfb_basic (addfb25-framebuffer-vs-set-tiling)
[178.513087] Starting subtest: addfb25-framebuffer-vs-set-tiling
[178.554935] Subtest addfb25-framebuffer-vs-set-tiling: SUCCESS (0.000s)
[178.935335] [056/171] (890s left) kms_addfb_basic (addfb25-modifier-no-flag)
[179.335274] Starting subtest: addfb25-modifier-no-flag
[179.377058] Subtest addfb25-modifier-no-flag: SUCCESS (0.000s)
[179.755733] [057/171] (889s left) kms_addfb_basic (addfb25-x-tiled-legacy)
[180.239163] Starting subtest: addfb25-x-tiled-legacy
[180.281025] Subtest addfb25-x-tiled-legacy: SUCCESS (0.000s)
[180.686295] [058/171] (889s left) kms_addfb_basic (addfb25-x-tiled-mismatch-legacy)
[181.103390] Starting subtest: addfb25-x-tiled-mismatch-legacy
[181.145176] Subtest addfb25-x-tiled-mismatch-legacy: SUCCESS (0.000s)
[181.532354] [059/171] (888s left) kms_addfb_basic (addfb25-yf-tiled-legacy)
[182.124835] Starting subtest: addfb25-yf-tiled-legacy
[182.158287] Subtest addfb25-yf-tiled-legacy: SUCCESS (0.000s)
[182.454394] [060/171] (887s left) kms_addfb_basic (addfb25-y-tiled-legacy)
[183.047420] Starting subtest: addfb25-y-tiled-legacy
[183.089265] Subtest addfb25-y-tiled-legacy: SUCCESS (0.000s)
[183.392097] [061/171] (886s left) kms_addfb_basic (addfb25-y-tiled-small-legacy)
[183.951817] Starting subtest: addfb25-y-tiled-small-legacy
[184.035664] Subtest addfb25-y-tiled-small-legacy: SKIP (0.000s)
[184.264787] [062/171] (886s left) kms_addfb_basic (bad-pitch-0)
[184.731707] Starting subtest: bad-pitch-0
[184.773451] Subtest bad-pitch-0: SUCCESS (0.000s)
[185.235929] [063/171] (885s left) kms_addfb_basic (bad-pitch-1024)
[185.711024] Starting subtest: bad-pitch-1024
[185.752913] Subtest bad-pitch-1024: SUCCESS (0.000s)
[186.158368] [064/171] (884s left) kms_addfb_basic (bad-pitch-128)
[186.575076] Starting subtest: bad-pitch-128
[186.616928] Subtest bad-pitch-128: SUCCESS (0.000s)
[187.012520] [065/171] (883s left) kms_addfb_basic (bad-pitch-256)
[187.479276] Starting subtest: bad-pitch-256
[187.521104] Subtest bad-pitch-256: SUCCESS (0.000s)
[187.901458] [066/171] (882s left) kms_addfb_basic (bad-pitch-32)
[188.359746] Starting subtest: bad-pitch-32
[188.401613] Subtest bad-pitch-32: SUCCESS (0.000s)
[188.813610] [067/171] (881s left) kms_addfb_basic (bad-pitch-63)
[189.289055] Starting subtest: bad-pitch-63
[189.330920] Subtest bad-pitch-63: SUCCESS (0.000s)
[189.728182] [068/171] (881s left) kms_addfb_basic (bad-pitch-65536)
[190.194931] Starting subtest: bad-pitch-65536
[190.236820] Subtest bad-pitch-65536: SUCCESS (0.000s)
[190.615194] [069/171] (880s left) kms_addfb_basic (bad-pitch-999)
[191.098858] Starting subtest: bad-pitch-999
[191.140766] Subtest bad-pitch-999: SUCCESS (0.000s)
[191.561073] [070/171] (879s left) kms_addfb_basic (basic)
[192.021356] Starting subtest: basic
[192.063290] Subtest basic: SUCCESS (0.000s)
[192.500501] [071/171] (878s left) kms_addfb_basic (basic-x-tiled-legacy)
[192.950689] Starting subtest: basic-x-tiled-legacy
[192.992576] Subtest basic-x-tiled-legacy: SUCCESS (0.000s)
[193.414966] [072/171] (877s left) kms_addfb_basic (basic-y-tiled-legacy)
[193.831574] Starting subtest: basic-y-tiled-legacy
[193.873531] Subtest basic-y-tiled-legacy: SUCCESS (0.000s)
[194.318912] [073/171] (877s left) kms_addfb_basic (bo-too-small)
[194.961430] Starting subtest: bo-too-small
[195.061501] Subtest bo-too-small: SUCCESS (0.000s)
[195.296545] [074/171] (876s left) kms_addfb_basic (bo-too-small-due-to-tiling)
[195.849443] Starting subtest: bo-too-small-due-to-tiling
[195.891334] Subtest bo-too-small-due-to-tiling: SUCCESS (0.000s)
[196.194477] [075/171] (875s left) kms_addfb_basic (clobberred-modifier)
[196.628171] Starting subtest: clobberred-modifier
[196.678257] Subtest clobberred-modifier: SUCCESS (0.000s)
[197.031627] [076/171] (874s left) kms_addfb_basic (framebuffer-vs-set-tiling)
[197.473661] Starting subtest: framebuffer-vs-set-tiling
[197.515524] Subtest framebuffer-vs-set-tiling: SUCCESS (0.000s)
[197.912788] [077/171] (874s left) kms_addfb_basic (invalid-get-prop)
[198.404572] Starting subtest: invalid-get-prop
[198.446361] Subtest invalid-get-prop: SUCCESS (0.000s)
[198.824991] [078/171] (873s left) kms_addfb_basic (invalid-get-prop-any)
[199.266899] Starting subtest: invalid-get-prop-any
[199.308823] Subtest invalid-get-prop-any: SUCCESS (0.000s)
[199.713409] [079/171] (872s left) kms_addfb_basic (invalid-set-prop)
[200.206305] Starting subtest: invalid-set-prop
[200.248377] Subtest invalid-set-prop: SUCCESS (0.000s)
[200.651450] [080/171] (871s left) kms_addfb_basic (invalid-set-prop-any)
[201.110820] Starting subtest: invalid-set-prop-any
[201.154389] Subtest invalid-set-prop-any: SUCCESS (0.000s)
[201.549824] [081/171] (870s left) kms_addfb_basic (no-handle)
[202.000108] Starting subtest: no-handle
[202.041979] Subtest no-handle: SUCCESS (0.000s)
[202.412856] [082/171] (870s left) kms_addfb_basic (size-max)
[202.990214] Starting subtest: size-max
[203.032052] Subtest size-max: SUCCESS (0.000s)
[203.301111] [083/171] (869s left) kms_addfb_basic (small-bo)
[203.877775] Starting subtest: small-bo
[203.919628] Subtest small-bo: SUCCESS (0.000s)
[204.239468] [084/171] (868s left) kms_addfb_basic (tile-pitch-mismatch)
[204.741302] Starting subtest: tile-pitch-mismatch
[204.783061] Subtest tile-pitch-mismatch: SUCCESS (0.000s)
[205.153462] [085/171] (867s left) kms_addfb_basic (too-high)
[205.683629] Starting subtest: too-high
[205.720255] Subtest too-high: SUCCESS (0.001s)
[206.015488] [086/171] (866s left) kms_addfb_basic (too-wide)
[206.626340] Starting subtest: too-wide
[206.668232] Subtest too-wide: SUCCESS (0.000s)
[206.946827] [087/171] (865s left) kms_addfb_basic (unused-handle)
[207.396431] Starting subtest: unused-handle
[207.438281] Subtest unused-handle: SUCCESS (0.000s)
[207.859535] [088/171] (865s left) kms_addfb_basic (unused-modifier)
[208.292561] Starting subtest: unused-modifier
[208.334423] Subtest unused-modifier: SUCCESS (0.000s)
[208.731982] [089/171] (864s left) kms_addfb_basic (unused-offsets)
[209.165027] Starting subtest: unused-offsets
[209.206800] Subtest unused-offsets: SUCCESS (0.000s)
[209.619076] [090/171] (863s left) kms_addfb_basic (unused-pitches)
[210.110713] Starting subtest: unused-pitches
[210.152474] Subtest unused-pitches: SUCCESS (0.000s)
[210.558559] [091/171] (862s left) kms_busy (basic)
[211.150442] Starting subtest: basic
[211.200874] Starting dynamic subtest: flip
[215.402938] Dynamic subtest flip: SUCCESS (4.248s)
[215.453158] Starting dynamic subtest: modeset
[217.685070] Dynamic subtest modeset: SUCCESS (2.279s)
[217.727040] Subtest basic: SUCCESS (6.529s)
[218.614800] [092/171] (854s left) kms_chamelium_hpd (dp-hpd-fast)
[219.526038] Subtest dp-hpd-fast: SKIP (0.000s)
[220.313617] [093/171] (853s left) kms_chamelium_edid (dp-edid-read)
[221.298171] Subtest dp-edid-read: SKIP (0.000s)
[222.110861] [094/171] (851s left) kms_chamelium_frames (dp-crc-fast)
[223.071739] Subtest dp-crc-fast: SKIP (0.000s)
[223.925208] [095/171] (849s left) kms_chamelium_hpd (hdmi-hpd-fast)
[224.835600] Subtest hdmi-hpd-fast: SKIP (0.000s)
[225.599488] [096/171] (848s left) kms_chamelium_edid (hdmi-edid-read)
[226.459131] Subtest hdmi-edid-read: SKIP (0.000s)
[227.271338] [097/171] (846s left) kms_chamelium_frames (hdmi-crc-fast)
[228.174119] Subtest hdmi-crc-fast: SKIP (0.000s)
[228.985440] [098/171] (845s left) kms_chamelium_hpd (vga-hpd-fast)
[229.854083] Subtest vga-hpd-fast: SKIP (0.000s)
[230.566305] [099/171] (843s left) kms_chamelium_edid (vga-edid-read)
[231.452210] Subtest vga-edid-read: SKIP (0.000s)
[232.164122] [100/171] (842s left) kms_prop_blob (basic)
[232.614229] Starting subtest: basic
[232.656071] Subtest basic: SUCCESS (0.000s)
[232.766774] [101/171] (841s left) kms_cursor_legacy (basic-busy-flip-before-cursor-atomic)
[233.308039] Starting subtest: basic-busy-flip-before-cursor-atomic
[234.502888] Subtest basic-busy-flip-before-cursor-atomic: SUCCESS (1.182s)
[235.449877] [102/171] (839s left) kms_cursor_legacy (basic-busy-flip-before-cursor-legacy)
[236.058523] Starting subtest: basic-busy-flip-before-cursor-legacy
[237.251338] Subtest basic-busy-flip-before-cursor-legacy: SUCCESS (1.200s)
[238.215876] [103/171] (836s left) kms_cursor_legacy (basic-flip-after-cursor-atomic)
[238.766268] Starting subtest: basic-flip-after-cursor-atomic
[239.959445] Subtest basic-flip-after-cursor-atomic: SUCCESS (1.188s)
[240.925334] [104/171] (833s left) kms_cursor_legacy (basic-flip-after-cursor-legacy)
[241.474639] Starting subtest: basic-flip-after-cursor-legacy
[242.676162] Subtest basic-flip-after-cursor-legacy: SUCCESS (1.186s)
[243.646672] [105/171] (831s left) kms_cursor_legacy (basic-flip-after-cursor-varying-size)
[244.216141] Starting subtest: basic-flip-after-cursor-varying-size
[245.409459] Subtest basic-flip-after-cursor-varying-size: SUCCESS (1.192s)
[246.331605] [106/171] (828s left) kms_cursor_legacy (basic-flip-before-cursor-atomic)
[246.923228] Starting subtest: basic-flip-before-cursor-atomic
[248.126289] Subtest basic-flip-before-cursor-atomic: SUCCESS (1.207s)
[249.014180] [107/171] (826s left) kms_cursor_legacy (basic-flip-before-cursor-legacy)
[249.522788] Starting subtest: basic-flip-before-cursor-legacy
[250.716134] Subtest basic-flip-before-cursor-legacy: SUCCESS (1.179s)
[251.598109] [108/171] (823s left) kms_cursor_legacy (basic-flip-before-cursor-varying-size)
[252.172698] Starting subtest: basic-flip-before-cursor-varying-size
[253.390814] Subtest basic-flip-before-cursor-varying-size: SUCCESS (1.200s)
[254.337551] [109/171] (820s left) kms_flip (basic-flip-vs-dpms)
[254.905672] Starting subtest: basic-flip-vs-dpms
[254.947236] Starting dynamic subtest: A-LVDS1
[256.625759] Dynamic subtest A-LVDS1: SUCCESS (1.717s)
[256.675981] Starting dynamic subtest: B-LVDS1
[258.138218] Dynamic subtest B-LVDS1: SUCCESS (1.518s)
[258.180066] Starting dynamic subtest: A-VGA1
[258.828119] Dynamic subtest A-VGA1: SUCCESS (0.694s)
[258.870091] Starting dynamic subtest: B-VGA1
[259.534987] Dynamic subtest B-VGA1: SUCCESS (0.710s)
[259.576871] Subtest basic-flip-vs-dpms: SUCCESS (4.646s)
[259.938623] [110/171] (815s left) kms_flip (basic-flip-vs-modeset)
[260.447991] Starting subtest: basic-flip-vs-modeset
[260.489712] Starting dynamic subtest: A-LVDS1
[262.236717] Dynamic subtest A-LVDS1: SUCCESS (1.791s)
[262.286998] Starting dynamic subtest: B-LVDS1
[263.698708] Dynamic subtest B-LVDS1: SUCCESS (1.481s)
[263.749031] Starting dynamic subtest: A-VGA1
[264.431391] Dynamic subtest A-VGA1: SUCCESS (0.719s)
[264.481564] Starting dynamic subtest: B-VGA1
[265.153454] Dynamic subtest B-VGA1: SUCCESS (0.724s)
[265.195424] Subtest basic-flip-vs-modeset: SUCCESS (4.727s)
[265.542512] [111/171] (809s left) kms_flip (basic-flip-vs-wf_vblank)
[266.151697] Starting subtest: basic-flip-vs-wf_vblank
[266.193525] Starting dynamic subtest: A-LVDS1
[268.062557] Dynamic subtest A-LVDS1: SUCCESS (1.943s)
[268.113058] Starting dynamic subtest: B-LVDS1
[269.966752] Dynamic subtest B-LVDS1: SUCCESS (1.891s)
[270.017239] Starting dynamic subtest: A-VGA1
[271.160670] Dynamic subtest A-VGA1: SUCCESS (1.215s)
[271.219266] Starting dynamic subtest: B-VGA1
[272.121164] Dynamic subtest B-VGA1: SUCCESS (0.966s)
[272.162460] Subtest basic-flip-vs-wf_vblank: SUCCESS (6.025s)
[272.524386] [112/171] (802s left) kms_flip (basic-plain-flip)
[273.060174] Starting subtest: basic-plain-flip
[273.101954] Starting dynamic subtest: A-LVDS1
[274.529066] Dynamic subtest A-LVDS1: SUCCESS (1.473s)
[274.579490] Starting dynamic subtest: B-LVDS1
[276.023377] Dynamic subtest B-LVDS1: SUCCESS (1.504s)
[276.065297] Starting dynamic subtest: A-VGA1
[276.942584] Dynamic subtest A-VGA1: SUCCESS (0.940s)
[276.992787] Starting dynamic subtest: B-VGA1
[277.654201] Dynamic subtest B-VGA1: SUCCESS (0.706s)
[277.696234] Subtest basic-plain-flip: SUCCESS (4.633s)
[278.100283] [113/171] (797s left) kms_force_connector_basic (force-connector-state)
[278.517444] Starting subtest: force-connector-state
[278.985685] Subtest force-connector-state: SUCCESS (0.550s)
[280.118941] [114/171] (795s left) kms_force_connector_basic (force-edid)
[280.718358] Starting subtest: force-edid
[280.827208] Subtest force-edid: SUCCESS (0.200s)
[281.366780] [115/171] (794s left) kms_force_connector_basic (force-load-detect)
[281.900403] Starting subtest: force-load-detect
[282.218130] Subtest force-load-detect: SUCCESS (0.408s)
[282.780685] [116/171] (793s left) kms_force_connector_basic (prune-stale-modes)
[283.248151] Starting subtest: prune-stale-modes
[283.290065] Subtest prune-stale-modes: SUCCESS (0.020s)
[283.771676] [117/171] (792s left) kms_frontbuffer_tracking (basic)
[284.505621] Starting subtest: basic
[286.598690] Subtest basic: SUCCESS (2.229s)
[286.953260] [118/171] (789s left) kms_pipe_crc_basic (compare-crc-sanitycheck)
[287.487386] Starting subtest: compare-crc-sanitycheck
[287.529679] Starting dynamic subtest: pipe-A-LVDS-1
[288.014379] Dynamic subtest pipe-A-LVDS-1: SUCCESS (0.512s)
[288.106281] Starting dynamic subtest: pipe-B-LVDS-1
[288.916770] Dynamic subtest pipe-B-LVDS-1: SUCCESS (0.889s)
[288.958766] Subtest compare-crc-sanitycheck: SUCCESS (1.405s)
[289.871237] [119/171] (786s left) kms_pipe_crc_basic (hang-read-crc)
[290.457391] Starting subtest: hang-read-crc
[290.499293] Starting dynamic subtest: pipe-A-LVDS-1
[292.228419] Dynamic subtest pipe-A-LVDS-1: SUCCESS (1.788s)
[292.278658] Starting dynamic subtest: pipe-B-LVDS-1
[294.627763] Dynamic subtest pipe-B-LVDS-1: SUCCESS (2.405s)
[294.669691] Subtest hang-read-crc: SUCCESS (4.198s)
[295.625551] [120/171] (780s left) kms_pipe_crc_basic (nonblocking-crc)
[296.226441] Starting subtest: nonblocking-crc
[296.260323] Starting dynamic subtest: pipe-A-LVDS-1
[296.937115] Dynamic subtest pipe-A-LVDS-1: SUCCESS (0.689s)
[296.987350] Starting dynamic subtest: pipe-B-LVDS-1
[298.215189] Dynamic subtest pipe-B-LVDS-1: SUCCESS (1.264s)
[298.248739] Subtest nonblocking-crc: SUCCESS (1.957s)
[299.179297] [121/171] (777s left) kms_pipe_crc_basic (nonblocking-crc-frame-sequence)
[299.797168] Starting subtest: nonblocking-crc-frame-sequence
[299.839318] Starting dynamic subtest: pipe-A-LVDS-1
[300.524326] Dynamic subtest pipe-A-LVDS-1: SUCCESS (0.695s)
[300.566172] Starting dynamic subtest: pipe-B-LVDS-1
[301.818890] Dynamic subtest pipe-B-LVDS-1: SUCCESS (1.321s)
[301.852524] Subtest nonblocking-crc-frame-sequence: SUCCESS (2.020s)
[302.792748] [122/171] (773s left) kms_pipe_crc_basic (read-crc)
[303.267284] Starting subtest: read-crc
[303.301482] Starting dynamic subtest: pipe-A-LVDS-1
[303.886077] Dynamic subtest pipe-A-LVDS-1: SUCCESS (0.615s)
[303.928067] Starting dynamic subtest: pipe-B-LVDS-1
[305.165968] Dynamic subtest pipe-B-LVDS-1: SUCCESS (1.256s)
[305.207831] Subtest read-crc: SUCCESS (1.876s)
[306.087761] [123/171] (770s left) kms_pipe_crc_basic (read-crc-frame-sequence)
[306.704346] Starting subtest: read-crc-frame-sequence
[306.746655] Starting dynamic subtest: pipe-A-LVDS-1
[307.331704] Dynamic subtest pipe-A-LVDS-1: SUCCESS (0.624s)
[307.381924] Starting dynamic subtest: pipe-B-LVDS-1
[308.552956] Dynamic subtest pipe-B-LVDS-1: SUCCESS (1.189s)
[308.586623] Subtest read-crc-frame-sequence: SUCCESS (1.817s)
[309.466167] [124/171] (767s left) kms_psr (primary_page_flip)
[309.999605] Subtest primary_page_flip: SKIP (0.000s)
[310.110679] [125/171] (766s left) kms_psr (cursor_plane_move)
[310.561880] Subtest cursor_plane_move: SKIP (0.000s)
[310.673283] [126/171] (766s left) kms_psr (sprite_plane_onoff)
[311.147277] Subtest sprite_plane_onoff: SKIP (0.000s)
[311.266650] [127/171] (765s left) kms_psr (primary_mmap_gtt)
[311.757279] Subtest primary_mmap_gtt: SKIP (0.000s)
[311.918975] [128/171] (765s left) kms_setmode (basic-clone-single-crtc)
[312.383459] Starting subtest: basic-clone-single-crtc
[312.484658] Subtest basic-clone-single-crtc: SKIP (0.001s)
[312.587117] [129/171] (764s left) i915_pm_backlight (basic-brightness)
[313.280825] Subtest basic-brightness: SKIP (0.000s)
[313.409181] [130/171] (764s left) i915_pm_rpm (basic-pci-d3-state)
[315.443808] Subtest basic-pci-d3-state: SKIP (0.000s)
[315.579379] [131/171] (762s left) i915_pm_rpm (basic-rte)
[316.028889] Starting subtest: basic-rte
[317.458327] Subtest basic-rte: SKIP (1.375s)
[317.661598] [132/171] (760s left) i915_pm_rps (basic-api)
[318.185767] Starting subtest: basic-api
[318.227600] Subtest basic-api: SUCCESS (0.004s)
[318.339146] [133/171] (759s left) prime_self_import (basic-llseek-bad)
[318.796492] Starting subtest: basic-llseek-bad
[318.838315] Subtest basic-llseek-bad: SUCCESS (0.002s)
[318.957907] [134/171] (759s left) prime_self_import (basic-llseek-size)
[319.348319] Starting subtest: basic-llseek-size
[319.390139] Subtest basic-llseek-size: SUCCESS (0.003s)
[319.511758] [135/171] (758s left) prime_self_import (basic-with_fd_dup)
[319.943436] Starting subtest: basic-with_fd_dup
[319.985276] Subtest basic-with_fd_dup: SUCCESS (0.002s)
[320.105253] [136/171] (758s left) prime_self_import (basic-with_one_bo)
[320.520411] Starting subtest: basic-with_one_bo
[320.562140] Subtest basic-with_one_bo: SUCCESS (0.003s)
[320.673866] [137/171] (758s left) prime_self_import (basic-with_one_bo_two_files)
[321.106125] Starting subtest: basic-with_one_bo_two_files
[321.147850] Subtest basic-with_one_bo_two_files: SUCCESS (0.003s)
[321.259924] [138/171] (757s left) prime_self_import (basic-with_two_bos)
[321.691346] Starting subtest: basic-with_two_bos
[321.741341] Subtest basic-with_two_bos: SUCCESS (0.004s)
[321.868278] [139/171] (757s left) prime_vgem (basic-fence-flip)
[322.294353] Starting subtest: basic-fence-flip
[322.512102] Subtest basic-fence-flip: SKIP (0.219s)
[322.917286] [140/171] (756s left) prime_vgem (basic-fence-mmap)
[323.390806] Starting subtest: basic-fence-mmap
[323.432568] Subtest basic-fence-mmap: SUCCESS (0.034s)
[323.584361] [141/171] (755s left) prime_vgem (basic-fence-read)
[324.001398] Starting subtest: basic-fence-read
[324.043105] Subtest basic-fence-read: SUCCESS (0.048s)
[324.195513] [142/171] (755s left) prime_vgem (basic-gtt)
[324.688663] Starting subtest: basic-gtt
[324.730505] Subtest basic-gtt: SUCCESS (0.013s)
[324.883678] [143/171] (754s left) prime_vgem (basic-read)
[325.323972] Starting subtest: basic-read
[325.365758] Subtest basic-read: SUCCESS (0.021s)
[325.921247] [144/171] (754s left) prime_vgem (basic-write)
[326.760373] Starting subtest: basic-write
[326.860814] Subtest basic-write: SUCCESS (0.023s)
[327.013591] [145/171] (753s left) prime_vgem (basic-userptr)
[327.798531] Starting subtest: basic-userptr
[327.881956] Subtest basic-userptr: SKIP (0.009s)
[328.042747] [146/171] (752s left) vgem_basic (setversion)
[328.534166] Starting subtest: setversion
[328.617659] Subtest setversion: SUCCESS (0.000s)
[328.729326] [147/171] (752s left) vgem_basic (create)
[329.169571] Starting subtest: create
[329.211451] Subtest create: SUCCESS (0.000s)
[329.322931] [148/171] (751s left) vgem_basic (debugfs)
[329.679663] Starting subtest: debugfs
[329.713177] Subtest debugfs: SUCCESS (0.001s)
[329.807637] [149/171] (751s left) vgem_basic (dmabuf-export)
[330.200075] Starting subtest: dmabuf-export
[330.241850] Subtest dmabuf-export: SUCCESS (0.001s)
[330.361917] [150/171] (751s left) vgem_basic (dmabuf-fence)
[330.735234] Starting subtest: dmabuf-fence
[330.776826] Subtest dmabuf-fence: SUCCESS (0.001s)
[330.896572] [151/171] (750s left) vgem_basic (dmabuf-fence-before)
[331.236824] Starting subtest: dmabuf-fence-before
[331.278723] Subtest dmabuf-fence-before: SUCCESS (0.000s)
[331.398717] [152/171] (750s left) vgem_basic (dmabuf-mmap)
[331.788463] Starting subtest: dmabuf-mmap
[331.830234] Subtest dmabuf-mmap: SUCCESS (0.021s)
[331.941626] [153/171] (749s left) vgem_basic (mmap)
[332.365682] Starting subtest: mmap
[332.407488] Subtest mmap: SUCCESS (0.012s)
[332.520536] [154/171] (749s left) vgem_basic (second-client)
[332.919050] Starting subtest: second-client
[332.960863] Subtest second-client: SUCCESS (0.049s)
[333.089259] [155/171] (749s left) vgem_basic (sysfs)
[333.537744] Starting subtest: sysfs
[333.589036] Subtest sysfs: SUCCESS (0.001s)
[333.716098] [156/171] (748s left) core_hotunplug (unbind-rebind)
[334.422587] Starting subtest: unbind-rebind
[336.479197] Subtest unbind-rebind: SUCCESS (1.935s)
[336.939356] [157/171] (746s left) vgem_basic (unload)
[338.090169] Starting subtest: unload
[367.128344] Subtest unload: SUCCESS (29.218s)
[367.282313] [158/171] (715s left) i915_module_load (reload)
[367.698518] Starting subtest: reload
[373.028618] Subtest reload: SUCCESS (5.299s)
[373.155132] [159/171] (710s left) gem_lmem_swapping (basic)
[374.165232] Subtest basic: SKIP (0.000s)
[374.275478] [160/171] (709s left) gem_lmem_swapping (parallel-random-engines)
[374.685068] Subtest parallel-random-engines: SKIP (0.000s)
[374.795127] [161/171] (708s left) gem_lmem_swapping (random-engines)
[375.278804] Subtest random-engines: SKIP (0.000s)
[375.389751] [162/171] (708s left) gem_lmem_swapping (verify-random)
[375.830552] Subtest verify-random: SKIP (0.000s)
[375.959120] [163/171] (707s left) i915_pm_rpm (module-reload)
[377.826179] Subtest module-reload: SKIP (0.000s)
[377.948068] [164/171] (705s left) i915_selftest (live)
[379.439286] Starting subtest: live
[379.481046] Starting dynamic subtest: sanitycheck
[380.317110] Dynamic subtest sanitycheck: SUCCESS (0.928s)
[380.367221] Starting dynamic subtest: uncore
[381.105141] Dynamic subtest uncore: SUCCESS (0.784s)
[381.155255] Starting dynamic subtest: workarounds
[381.925445] Dynamic subtest workarounds: SUCCESS (0.822s)
[381.975563] Starting dynamic subtest: gt_engines
[382.720411] Dynamic subtest gt_engines: SUCCESS (0.791s)
[382.770513] Starting dynamic subtest: gt_timelines
[387.068572] Dynamic subtest gt_timelines: SUCCESS (4.345s)
[387.127055] Starting dynamic subtest: gt_contexts
[387.880401] Dynamic subtest gt_contexts: SUCCESS (0.818s)
[387.930618] Starting dynamic subtest: gt_lrc
[388.684977] Dynamic subtest gt_lrc: SUCCESS (0.793s)
[388.735094] Starting dynamic subtest: gt_mocs
[389.454288] Dynamic subtest gt_mocs: SUCCESS (0.769s)
[389.512776] Starting dynamic subtest: gt_pm
[395.321105] Dynamic subtest gt_pm: SUCCESS (5.867s)
[395.371158] Starting dynamic subtest: gt_heartbeat
[396.157870] Dynamic subtest gt_heartbeat: SUCCESS (0.834s)
[396.207986] Starting dynamic subtest: gt_tlb
[396.995878] Dynamic subtest gt_tlb: SUCCESS (0.834s)
[397.045993] Starting dynamic subtest: requests
[402.468503] Dynamic subtest requests: SUCCESS (5.475s)
[402.518603] Starting dynamic subtest: migrate
[403.331267] Dynamic subtest migrate: SUCCESS (0.852s)
[403.381518] Starting dynamic subtest: active
[404.101026] Dynamic subtest active: SUCCESS (0.774s)
[404.151192] Starting dynamic subtest: objects
[405.521507] Dynamic subtest objects: SUCCESS (1.413s)
[405.571618] Starting dynamic subtest: mman
[410.262752] Dynamic subtest mman: SUCCESS (4.743s)
[410.312856] Starting dynamic subtest: dmabuf
[411.065844] Dynamic subtest dmabuf: SUCCESS (0.811s)
[411.115990] Starting dynamic subtest: vma
[411.887595] Dynamic subtest vma: SUCCESS (0.817s)
[411.945992] Starting dynamic subtest: coherency
[412.815777] Dynamic subtest coherency: SUCCESS (0.930s)
[412.865916] Starting dynamic subtest: gtt
[416.940193] Dynamic subtest gtt: SUCCESS (4.113s)
[416.998680] Starting dynamic subtest: gem
[417.968954] Dynamic subtest gem: SUCCESS (1.033s)
[418.019108] Starting dynamic subtest: evict
[418.806986] Dynamic subtest evict: SUCCESS (0.834s)
[418.865377] Starting dynamic subtest: hugepages
[420.085444] Dynamic subtest hugepages: SUCCESS (1.274s)
[420.135460] Starting dynamic subtest: gem_contexts
[424.443648] Dynamic subtest gem_contexts: SUCCESS (4.363s)
[424.493643] Starting dynamic subtest: client
[425.246311] Dynamic subtest client: SUCCESS (0.794s)
[425.296430] Starting dynamic subtest: gem_migrate
[426.132679] Dynamic subtest gem_migrate: SUCCESS (0.883s)
[426.191095] Starting dynamic subtest: reset
[427.187968] Dynamic subtest reset: SUCCESS (1.060s)
[427.238037] Starting dynamic subtest: memory_region
[428.074295] Dynamic subtest memory_region: SUCCESS (0.875s)
[428.124380] Starting dynamic subtest: hangcheck
[430.511037] Dynamic subtest hangcheck: SUCCESS (2.309s)
[430.572493] Starting dynamic subtest: execlists
[431.174843] Dynamic subtest execlists: SUCCESS (0.790s)
[431.233170] Starting dynamic subtest: ring_submission
[431.961171] Dynamic subtest ring_submission: SUCCESS (0.795s)
[432.011277] Starting dynamic subtest: perf
[432.749374] Dynamic subtest perf: SUCCESS (0.775s)
[432.799493] Starting dynamic subtest: slpc
[433.510763] Dynamic subtest slpc: SUCCESS (0.770s)
[433.560810] Starting dynamic subtest: guc
[434.340445] Dynamic subtest guc: SUCCESS (0.824s)
[434.398887] Starting dynamic subtest: guc_multi_lrc
[435.126701] Dynamic subtest guc_multi_lrc: SUCCESS (0.790s)
[435.176907] Starting dynamic subtest: guc_hang
[435.946430] Dynamic subtest guc_hang: SUCCESS (0.810s)
[435.996574] Starting dynamic subtest: late_gt_pm
[436.851115] Dynamic subtest late_gt_pm: SUCCESS (0.910s)
[436.892847] Subtest live: SUCCESS (57.465s)
[437.121373] [165/171] (646s left) dmabuf (all-tests)
[438.070401] Starting subtest: all-tests
[438.112289] Starting dynamic subtest: sanitycheck
[438.154220] Dynamic subtest sanitycheck: SUCCESS (0.101s)
[438.212798] Starting dynamic subtest: dma_fence
[438.254669] Dynamic subtest dma_fence: SUCCESS (0.175s)
[438.313197] Starting dynamic subtest: dma_fence_chain
[453.141066] Dynamic subtest dma_fence_chain: SUCCESS (14.890s)
[453.190993] Starting dynamic subtest: dma_fence_unwrap
[453.233174] Dynamic subtest dma_fence_unwrap: SUCCESS (0.074s)
[453.283374] Starting dynamic subtest: dma_resv
[453.325299] Dynamic subtest dma_resv: SUCCESS (0.078s)
[453.366944] Subtest all-tests: SUCCESS (15.326s)
[453.503271] [166/171] (630s left) i915_suspend (basic-s2idle-without-i915)
[454.028839] Starting subtest: basic-s2idle-without-i915
[475.655587] Subtest basic-s2idle-without-i915: SUCCESS (7.089s)
[477.876291] [167/171] (623s left) i915_suspend (basic-s3-without-i915)
[478.735205] Starting subtest: basic-s3-without-i915
[499.529844] Subtest basic-s3-without-i915: SUCCESS (6.022s)
[501.110256] [168/171] (615s left) gem_exec_suspend (basic-s0)
[502.244055] Starting subtest: basic-S0
[502.285901] Starting dynamic subtest: smem
[522.087794] Dynamic subtest smem: SUCCESS (4.213s)
[522.129609] Subtest basic-S0: SUCCESS (4.214s)
[524.042390] [169/171] (610s left) gem_exec_suspend (basic-s3)
[524.740913] Starting subtest: basic-S3
[524.774364] Starting dynamic subtest: smem
[544.274106] Dynamic subtest smem: SUCCESS (4.448s)
[544.382887] Subtest basic-S3: SUCCESS (4.449s)
[546.707131] [170/171] (605s left) kms_chamelium_hpd (common-hpd-after-suspend)
[548.052876] Subtest common-hpd-after-suspend: SKIP (0.000s)
[548.498963] [171/171] (603s left) kms_pipe_crc_basic (suspend-read-crc)
[549.291869] Starting subtest: suspend-read-crc
[549.333974] Starting dynamic subtest: pipe-A-LVDS-1
[569.263877] Dynamic subtest pipe-A-LVDS-1: SUCCESS (4.536s)
[569.314106] Starting dynamic subtest: pipe-B-LVDS-1
[590.296104] Dynamic subtest pipe-B-LVDS-1: SUCCESS (5.427s)
[590.337947] Subtest suspend-read-crc: SUCCESS (9.968s)
[593.907284] Closing watchdogs
Done.