[113.549609] Initializing watchdogs
[113.550495]   /dev/watchdog0
[113.573355] [001/171] (960s left) i915_module_load (load)
[114.364754] Starting subtest: load
[118.854587] Subtest load: SUCCESS (4.490s)
[119.009740] [002/171] (955s left) core_auth (basic-auth)
[120.585535] Starting subtest: basic-auth
[120.590233] Subtest basic-auth: SUCCESS (0.004s)
[120.717228] [003/171] (953s left) debugfs_test (read_all_entries)
[121.325768] Starting subtest: read_all_entries
[121.510759] Subtest read_all_entries: SUCCESS (0.184s)
[121.680423] [004/171] (952s left) debugfs_test (basic-hwmon)
[122.295502] Starting subtest: basic-hwmon
[122.303358] Subtest basic-hwmon: SKIP (0.001s)
[122.478857] [005/171] (951s left) fbdev (eof)
[123.072544] Starting subtest: eof
[123.076787] Subtest eof: SUCCESS (0.001s)
[123.175873] [006/171] (951s left) fbdev (info)
[123.767481] Starting subtest: info
[123.770741] Subtest info: SUCCESS (0.000s)
[123.876229] [007/171] (950s left) fbdev (nullptr)
[124.473416] Starting subtest: nullptr
[124.477933] Subtest nullptr: SUCCESS (0.000s)
[124.632283] [008/171] (950s left) fbdev (read)
[125.305676] Starting subtest: read
[125.588889] Subtest read: SUCCESS (0.283s)
[125.699785] [009/171] (949s left) fbdev (write)
[126.323391] Starting subtest: write
[126.497704] Subtest write: SUCCESS (0.174s)
[126.613294] [010/171] (948s left) gem_basic (bad-close)
[127.225596] Starting subtest: bad-close
[127.231971] Subtest bad-close: SUCCESS (0.000s)
[127.346507] [011/171] (947s left) gem_basic (create-close)
[127.937708] Starting subtest: create-close
[127.945485] Subtest create-close: SUCCESS (0.001s)
[128.063121] [012/171] (946s left) gem_basic (create-fd-close)
[128.660433] Starting subtest: create-fd-close
[128.668489] Subtest create-fd-close: SUCCESS (0.001s)
[128.796892] [013/171] (946s left) gem_busy (busy@all-engines)
[129.449443] Starting subtest: busy
[129.453962] Starting dynamic subtest: all-engines
[129.560289] Dynamic subtest all-engines: SUCCESS (0.110s)
[129.563503] Subtest busy: SUCCESS (0.114s)
[130.051347] [014/171] (945s left) gem_close_race (basic-process)
[130.724542] Starting subtest: basic-process
[130.897249] Subtest basic-process: SUCCESS (0.174s)
[131.168223] [015/171] (944s left) gem_close_race (basic-threads)
[131.831258] Starting subtest: basic-threads
[133.233420] Subtest basic-threads: SUCCESS (1.403s)
[133.505816] [016/171] (941s left) gem_ctx_create (basic)
[134.146390] Subtest basic: SKIP (0.000s)
[134.237737] [017/171] (941s left) gem_ctx_create (basic-files)
[134.840777] Subtest basic-files: SKIP (0.000s)
[134.938948] [018/171] (940s left) gem_ctx_exec (basic)
[135.546340] Subtest basic: SKIP (0.000s)
[135.656444] [019/171] (939s left) gem_exec_basic (basic)
[136.283776] Starting subtest: basic
[136.287858] Starting dynamic subtest: rcs0-smem
[136.291181] Dynamic subtest rcs0-smem: SUCCESS (0.002s)
[136.293950] Subtest basic: SUCCESS (0.007s)
[136.553846] [020/171] (938s left) gem_exec_create (basic)
[137.186557] Starting subtest: basic
[137.190110] Starting dynamic subtest: smem
[139.310876] Dynamic subtest smem: SUCCESS (2.123s)
[139.314588] Subtest basic: SUCCESS (2.127s)
[139.576159] [021/171] (936s left) gem_exec_fence (basic-busy)
[140.411538] Starting subtest: basic-busy
[140.416452] Starting dynamic subtest: rcs0
[140.447275] Dynamic subtest rcs0: SUCCESS (0.033s)
[140.450502] Subtest basic-busy: SUCCESS (0.037s)
[141.324250] [022/171] (934s left) gem_exec_fence (basic-wait)
[142.152492] Starting subtest: basic-wait
[142.156453] Starting dynamic subtest: rcs0
[142.176501] Dynamic subtest rcs0: SUCCESS (0.023s)
[142.179441] Subtest basic-wait: SUCCESS (0.026s)
[142.862285] [023/171] (932s left) gem_exec_fence (basic-await)
[143.688725] Starting subtest: basic-await
[143.693121] Starting dynamic subtest: rcs0
[143.800290] Dynamic subtest rcs0: SUCCESS (0.111s)
[143.803281] Subtest basic-await: SUCCESS (0.113s)
[144.492079] [024/171] (931s left) gem_exec_fence (nb-await)
[145.313970] Starting subtest: nb-await
[145.317765] Starting dynamic subtest: rcs0
[145.378828] Dynamic subtest rcs0: SUCCESS (0.064s)
[145.382387] Subtest nb-await: SUCCESS (0.067s)
[146.064462] [025/171] (929s left) gem_exec_gttfill (basic)
[146.713507] Starting subtest: basic
[161.103946] Subtest basic: SUCCESS (14.390s)
[161.402924] [026/171] (914s left) gem_exec_parallel (engines)
[162.466569] Starting subtest: engines
[162.470400] Starting dynamic subtest: basic
[166.567812] Dynamic subtest basic: SUCCESS (4.102s)
[166.600387] Starting dynamic subtest: contexts
[166.606199] Dynamic subtest contexts: SKIP (0.003s)
[166.634538] Starting dynamic subtest: fds
[166.640291] Dynamic subtest fds: SKIP (0.003s)
[166.667602] Starting dynamic subtest: userptr
[170.871968] Dynamic subtest userptr: SUCCESS (4.295s)
[170.875293] Subtest engines: SUCCESS (8.409s)
[171.149807] [027/171] (904s left) gem_exec_store (basic)
[171.805498] Starting subtest: basic
[171.863429] Subtest basic: SUCCESS (0.059s)
[172.131877] [028/171] (904s left) gem_flink_basic (bad-flink)
[172.725776] Starting subtest: bad-flink
[172.729654] Subtest bad-flink: SUCCESS (0.000s)
[172.863842] [029/171] (903s left) gem_flink_basic (bad-open)
[173.458583] Starting subtest: bad-open
[173.462324] Subtest bad-open: SUCCESS (0.000s)
[173.594756] [030/171] (902s left) gem_flink_basic (basic)
[174.168981] Starting subtest: basic
[174.172535] Subtest basic: SUCCESS (0.001s)
[174.312262] [031/171] (902s left) gem_flink_basic (double-flink)
[174.894670] Starting subtest: double-flink
[174.898571] Subtest double-flink: SUCCESS (0.000s)
[175.031412] [032/171] (901s left) gem_flink_basic (flink-lifetime)
[175.623828] Starting subtest: flink-lifetime
[175.628598] Subtest flink-lifetime: SUCCESS (0.005s)
[175.764990] [033/171] (900s left) gem_huc_copy (huc-copy)
[176.363578] Subtest huc-copy: SKIP (0.000s)
[176.472079] [034/171] (900s left) gem_linear_blits (basic)
[177.501408] Starting subtest: basic
[177.561902] Subtest basic: SUCCESS (0.061s)
[177.797384] [035/171] (898s left) gem_mmap (basic)
[178.718622] Starting subtest: basic
[178.736634] Subtest basic: SUCCESS (0.003s)
[178.850833] [036/171] (897s left) gem_mmap_gtt (basic)
[179.442186] Starting subtest: basic
[179.446546] Subtest basic: SUCCESS (0.004s)
[179.569787] [037/171] (897s left) gem_render_linear_blits (basic)
[180.165271] Starting subtest: basic
[180.288717] Subtest basic: SUCCESS (0.123s)
[180.401126] [038/171] (896s left) gem_render_tiled_blits (basic)
[180.987733] Starting subtest: basic
[181.132753] Subtest basic: SUCCESS (0.144s)
[181.253169] [039/171] (895s left) gem_ringfill (basic-all)
[181.888697] Starting subtest: basic-all
[183.090249] Subtest basic-all: SUCCESS (1.202s)
[183.222119] [040/171] (893s left) gem_softpin (allocator-basic)
[183.830185] Subtest allocator-basic: SKIP (0.000s)
[183.953245] [041/171] (893s left) gem_softpin (allocator-basic-reserve)
[184.531420] Subtest allocator-basic-reserve: SKIP (0.000s)
[184.650927] [042/171] (892s left) gem_softpin (safe-alignment)
[185.236909] Starting subtest: safe-alignment
[185.263277] Subtest safe-alignment: SUCCESS (0.029s)
[185.419794] [043/171] (891s left) gem_sync (basic-all)
[186.073491] Starting subtest: basic-all
[188.357488] Subtest basic-all: SUCCESS (2.286s)
[188.621794] [044/171] (888s left) gem_sync (basic-each)
[189.250716] Starting subtest: basic-each
[191.554960] Subtest basic-each: SUCCESS (2.304s)
[191.825262] [045/171] (885s left) gem_tiled_blits (basic)
[192.708614] Starting subtest: basic
[192.799929] Subtest basic: SUCCESS (0.092s)
[193.011966] [046/171] (884s left) gem_tiled_fence_blits (basic)
[194.217616] Starting subtest: basic
[194.287172] Subtest basic: SUCCESS (0.071s)
[194.512273] [047/171] (883s left) gem_tiled_pread_basic
[197.180337] [048/171] (880s left) gem_wait (busy@all-engines)
[197.865938] Starting subtest: busy
[197.870480] Starting dynamic subtest: all-engines
[198.398337] Dynamic subtest all-engines: SUCCESS (0.533s)
[198.402400] Subtest busy: SUCCESS (0.536s)
[198.796754] [049/171] (879s left) gem_wait (wait@all-engines)
[199.475581] Starting subtest: wait
[199.479540] Starting dynamic subtest: all-engines
[200.516478] Dynamic subtest all-engines: SUCCESS (1.042s)
[200.520537] Subtest wait: SUCCESS (1.044s)
[200.913993] [050/171] (877s left) i915_getparams_basic (basic-eu-total)
[201.507587] Starting subtest: basic-eu-total
[201.514922] Subtest basic-eu-total: SUCCESS (0.000s)
[201.629638] [051/171] (876s left) i915_getparams_basic (basic-subslice-total)
[202.206442] Starting subtest: basic-subslice-total
[202.213700] Subtest basic-subslice-total: SUCCESS (0.000s)
[202.330472] [052/171] (875s left) i915_hangman (error-state-basic)
[202.925665] Starting subtest: error-state-basic
[203.272703] Subtest error-state-basic: SUCCESS (0.334s)
[203.380182] [053/171] (874s left) i915_pciid
[204.094698] [054/171] (874s left) kms_addfb_basic (addfb25-bad-modifier)
[204.686868] Starting subtest: addfb25-bad-modifier
[204.691706] Subtest addfb25-bad-modifier: SUCCESS (0.002s)
[204.904766] [055/171] (873s left) kms_addfb_basic (addfb25-framebuffer-vs-set-tiling)
[205.497457] Starting subtest: addfb25-framebuffer-vs-set-tiling
[205.501345] Subtest addfb25-framebuffer-vs-set-tiling: SUCCESS (0.000s)
[205.680247] [056/171] (872s left) kms_addfb_basic (addfb25-modifier-no-flag)
[206.283401] Starting subtest: addfb25-modifier-no-flag
[206.289256] Subtest addfb25-modifier-no-flag: SUCCESS (0.000s)
[206.511517] [057/171] (872s left) kms_addfb_basic (addfb25-x-tiled-legacy)
[207.111708] Starting subtest: addfb25-x-tiled-legacy
[207.115505] Subtest addfb25-x-tiled-legacy: SUCCESS (0.001s)
[207.295920] [058/171] (871s left) kms_addfb_basic (addfb25-x-tiled-mismatch-legacy)
[207.888489] Starting subtest: addfb25-x-tiled-mismatch-legacy
[207.891688] Subtest addfb25-x-tiled-mismatch-legacy: SUCCESS (0.002s)
[208.098700] [059/171] (870s left) kms_addfb_basic (addfb25-yf-tiled-legacy)
[208.748438] Starting subtest: addfb25-yf-tiled-legacy
[208.751592] Subtest addfb25-yf-tiled-legacy: SUCCESS (0.002s)
[208.930631] [060/171] (869s left) kms_addfb_basic (addfb25-y-tiled-legacy)
[209.562165] Starting subtest: addfb25-y-tiled-legacy
[209.566579] Subtest addfb25-y-tiled-legacy: SUCCESS (0.002s)
[209.748458] [061/171] (869s left) kms_addfb_basic (addfb25-y-tiled-small-legacy)
[210.379642] Starting subtest: addfb25-y-tiled-small-legacy
[210.387446] Subtest addfb25-y-tiled-small-legacy: SKIP (0.000s)
[210.517856] [062/171] (868s left) kms_addfb_basic (bad-pitch-0)
[211.103501] Starting subtest: bad-pitch-0
[211.107381] Subtest bad-pitch-0: SUCCESS (0.000s)
[211.283723] [063/171] (867s left) kms_addfb_basic (bad-pitch-1024)
[211.881292] Starting subtest: bad-pitch-1024
[211.885382] Subtest bad-pitch-1024: SUCCESS (0.000s)
[212.070353] [064/171] (867s left) kms_addfb_basic (bad-pitch-128)
[212.672686] Starting subtest: bad-pitch-128
[212.676538] Subtest bad-pitch-128: SUCCESS (0.000s)
[212.848727] [065/171] (866s left) kms_addfb_basic (bad-pitch-256)
[213.438826] Starting subtest: bad-pitch-256
[213.444248] Subtest bad-pitch-256: SUCCESS (0.000s)
[213.645798] [066/171] (865s left) kms_addfb_basic (bad-pitch-32)
[214.250945] Starting subtest: bad-pitch-32
[214.254576] Subtest bad-pitch-32: SUCCESS (0.000s)
[214.434569] [067/171] (864s left) kms_addfb_basic (bad-pitch-63)
[215.021734] Starting subtest: bad-pitch-63
[215.025668] Subtest bad-pitch-63: SUCCESS (0.000s)
[215.215581] [068/171] (864s left) kms_addfb_basic (bad-pitch-65536)
[215.823201] Starting subtest: bad-pitch-65536
[215.827991] Subtest bad-pitch-65536: SUCCESS (0.002s)
[216.020367] [069/171] (863s left) kms_addfb_basic (bad-pitch-999)
[216.605215] Starting subtest: bad-pitch-999
[216.608693] Subtest bad-pitch-999: SUCCESS (0.000s)
[216.789364] [070/171] (862s left) kms_addfb_basic (basic)
[217.385766] Starting subtest: basic
[217.390748] Subtest basic: SUCCESS (0.000s)
[217.586543] [071/171] (862s left) kms_addfb_basic (basic-x-tiled-legacy)
[218.192381] Starting subtest: basic-x-tiled-legacy
[218.196499] Subtest basic-x-tiled-legacy: SUCCESS (0.000s)
[218.377640] [072/171] (861s left) kms_addfb_basic (basic-y-tiled-legacy)
[218.965888] Starting subtest: basic-y-tiled-legacy
[218.969724] Subtest basic-y-tiled-legacy: SUCCESS (0.001s)
[219.172311] [073/171] (860s left) kms_addfb_basic (bo-too-small)
[219.809109] Starting subtest: bo-too-small
[219.812261] Subtest bo-too-small: SUCCESS (0.001s)
[219.953519] [074/171] (860s left) kms_addfb_basic (bo-too-small-due-to-tiling)
[220.601696] Starting subtest: bo-too-small-due-to-tiling
[220.605812] Subtest bo-too-small-due-to-tiling: SUCCESS (0.002s)
[220.755605] [075/171] (859s left) kms_addfb_basic (clobberred-modifier)
[221.354214] Starting subtest: clobberred-modifier
[221.358543] Subtest clobberred-modifier: SUCCESS (0.001s)
[221.543998] [076/171] (858s left) kms_addfb_basic (framebuffer-vs-set-tiling)
[222.134519] Starting subtest: framebuffer-vs-set-tiling
[222.138669] Subtest framebuffer-vs-set-tiling: SUCCESS (0.000s)
[222.323801] [077/171] (857s left) kms_addfb_basic (invalid-get-prop)
[222.897247] Starting subtest: invalid-get-prop
[222.901360] Subtest invalid-get-prop: SUCCESS (0.000s)
[223.088304] [078/171] (857s left) kms_addfb_basic (invalid-get-prop-any)
[223.683542] Starting subtest: invalid-get-prop-any
[223.687104] Subtest invalid-get-prop-any: SUCCESS (0.000s)
[223.888802] [079/171] (856s left) kms_addfb_basic (invalid-set-prop)
[224.472596] Starting subtest: invalid-set-prop
[224.476249] Subtest invalid-set-prop: SUCCESS (0.000s)
[224.689320] [080/171] (855s left) kms_addfb_basic (invalid-set-prop-any)
[225.283698] Starting subtest: invalid-set-prop-any
[225.287776] Subtest invalid-set-prop-any: SUCCESS (0.000s)
[225.492591] [081/171] (855s left) kms_addfb_basic (no-handle)
[226.084084] Starting subtest: no-handle
[226.088657] Subtest no-handle: SUCCESS (0.000s)
[226.283112] [082/171] (854s left) kms_addfb_basic (size-max)
[226.927274] Starting subtest: size-max
[226.931101] Subtest size-max: SUCCESS (0.001s)
[227.091653] [083/171] (853s left) kms_addfb_basic (small-bo)
[227.738800] Starting subtest: small-bo
[227.742939] Subtest small-bo: SUCCESS (0.001s)
[227.892860] [084/171] (853s left) kms_addfb_basic (tile-pitch-mismatch)
[228.495631] Starting subtest: tile-pitch-mismatch
[228.499499] Subtest tile-pitch-mismatch: SUCCESS (0.002s)
[228.675409] [085/171] (852s left) kms_addfb_basic (too-high)
[229.318604] Starting subtest: too-high
[229.323480] Subtest too-high: SUCCESS (0.005s)
[229.475215] [086/171] (851s left) kms_addfb_basic (too-wide)
[230.103711] Starting subtest: too-wide
[230.107820] Subtest too-wide: SUCCESS (0.000s)
[230.243443] [087/171] (850s left) kms_addfb_basic (unused-handle)
[230.833879] Starting subtest: unused-handle
[230.837522] Subtest unused-handle: SUCCESS (0.000s)
[231.024872] [088/171] (850s left) kms_addfb_basic (unused-modifier)
[231.600377] Starting subtest: unused-modifier
[231.604764] Subtest unused-modifier: SUCCESS (0.000s)
[231.809203] [089/171] (849s left) kms_addfb_basic (unused-offsets)
[232.390594] Starting subtest: unused-offsets
[232.394634] Subtest unused-offsets: SUCCESS (0.000s)
[232.587294] [090/171] (848s left) kms_addfb_basic (unused-pitches)
[233.185712] Starting subtest: unused-pitches
[233.189565] Subtest unused-pitches: SUCCESS (0.000s)
[233.396777] [091/171] (848s left) kms_busy (basic)
[234.056140] Starting subtest: basic
[234.060624] Starting dynamic subtest: flip
[235.510656] Dynamic subtest flip: SUCCESS (1.450s)
[235.549161] Starting dynamic subtest: modeset
[235.556522] Dynamic subtest modeset: SKIP (0.000s)
[235.560096] Subtest basic: SUCCESS (1.457s)
[235.782153] [092/171] (845s left) kms_chamelium_hpd (dp-hpd-fast)
[236.406186] Subtest dp-hpd-fast: SKIP (0.000s)
[236.512822] [093/171] (845s left) kms_chamelium_edid (dp-edid-read)
[237.137226] Subtest dp-edid-read: SKIP (0.000s)
[237.243175] [094/171] (844s left) kms_chamelium_frames (dp-crc-fast)
[237.871991] Subtest dp-crc-fast: SKIP (0.000s)
[237.985323] [095/171] (843s left) kms_chamelium_hpd (hdmi-hpd-fast)
[238.621248] Subtest hdmi-hpd-fast: SKIP (0.000s)
[238.737101] [096/171] (843s left) kms_chamelium_edid (hdmi-edid-read)
[239.376255] Subtest hdmi-edid-read: SKIP (0.000s)
[239.486275] [097/171] (842s left) kms_chamelium_frames (hdmi-crc-fast)
[240.138746] Subtest hdmi-crc-fast: SKIP (0.000s)
[240.242929] [098/171] (841s left) kms_chamelium_hpd (vga-hpd-fast)
[240.884238] Subtest vga-hpd-fast: SKIP (0.000s)
[240.977531] [099/171] (841s left) kms_chamelium_edid (vga-edid-read)
[241.619133] Subtest vga-edid-read: SKIP (0.000s)
[241.712402] [100/171] (840s left) kms_prop_blob (basic)
[242.288947] Starting subtest: basic
[242.294129] Subtest basic: SUCCESS (0.000s)
[242.422296] [101/171] (839s left) kms_cursor_legacy (basic-busy-flip-before-cursor-atomic)
[243.043402] Starting subtest: basic-busy-flip-before-cursor-atomic
[243.059873] Subtest basic-busy-flip-before-cursor-atomic: SKIP (0.011s)
[243.217759] [102/171] (839s left) kms_cursor_legacy (basic-busy-flip-before-cursor-legacy)
[243.842596] Starting subtest: basic-busy-flip-before-cursor-legacy
[245.153646] Subtest basic-busy-flip-before-cursor-legacy: SUCCESS (1.313s)
[245.417959] [103/171] (837s left) kms_cursor_legacy (basic-flip-after-cursor-atomic)
[246.048265] Starting subtest: basic-flip-after-cursor-atomic
[246.055577] Subtest basic-flip-after-cursor-atomic: SKIP (0.000s)
[246.179488] [104/171] (836s left) kms_cursor_legacy (basic-flip-after-cursor-legacy)
[246.818946] Starting subtest: basic-flip-after-cursor-legacy
[248.101245] Subtest basic-flip-after-cursor-legacy: SUCCESS (1.288s)
[248.373585] [105/171] (834s left) kms_cursor_legacy (basic-flip-after-cursor-varying-size)
[249.015752] Starting subtest: basic-flip-after-cursor-varying-size
[250.307741] Subtest basic-flip-after-cursor-varying-size: SUCCESS (1.292s)
[250.589365] [106/171] (832s left) kms_cursor_legacy (basic-flip-before-cursor-atomic)
[251.217165] Starting subtest: basic-flip-before-cursor-atomic
[251.224723] Subtest basic-flip-before-cursor-atomic: SKIP (0.000s)
[251.349515] [107/171] (831s left) kms_cursor_legacy (basic-flip-before-cursor-legacy)
[252.002667] Starting subtest: basic-flip-before-cursor-legacy
[253.290895] Subtest basic-flip-before-cursor-legacy: SUCCESS (1.291s)
[253.551405] [108/171] (829s left) kms_cursor_legacy (basic-flip-before-cursor-varying-size)
[254.175817] Starting subtest: basic-flip-before-cursor-varying-size
[255.471311] Subtest basic-flip-before-cursor-varying-size: SUCCESS (1.295s)
[255.748247] [109/171] (827s left) kms_flip (basic-flip-vs-dpms)
[256.370865] Starting subtest: basic-flip-vs-dpms
[256.383120] Starting dynamic subtest: A-VGA1
[258.100878] Dynamic subtest A-VGA1: SUCCESS (1.727s)
[258.139474] Starting dynamic subtest: B-VGA1
[259.594700] Dynamic subtest B-VGA1: SUCCESS (1.487s)
[259.598558] Subtest basic-flip-vs-dpms: SUCCESS (3.221s)
[259.982334] [110/171] (823s left) kms_flip (basic-flip-vs-modeset)
[260.593529] Starting subtest: basic-flip-vs-modeset
[260.597793] Starting dynamic subtest: A-VGA1
[262.192573] Dynamic subtest A-VGA1: SUCCESS (1.600s)
[262.234210] Starting dynamic subtest: B-VGA1
[263.502587] Dynamic subtest B-VGA1: SUCCESS (1.290s)
[263.507189] Subtest basic-flip-vs-modeset: SUCCESS (2.897s)
[263.846397] [111/171] (819s left) kms_flip (basic-flip-vs-wf_vblank)
[264.470763] Starting subtest: basic-flip-vs-wf_vblank
[264.474860] Starting dynamic subtest: A-VGA1
[266.370876] Dynamic subtest A-VGA1: SUCCESS (1.898s)
[266.409846] Starting dynamic subtest: B-VGA1
[268.047115] Dynamic subtest B-VGA1: SUCCESS (1.675s)
[268.051253] Subtest basic-flip-vs-wf_vblank: SUCCESS (3.580s)
[268.465996] [112/171] (814s left) kms_flip (basic-plain-flip)
[269.077665] Starting subtest: basic-plain-flip
[269.082971] Starting dynamic subtest: A-VGA1
[270.682403] Dynamic subtest A-VGA1: SUCCESS (1.599s)
[270.722598] Starting dynamic subtest: B-VGA1
[272.074619] Dynamic subtest B-VGA1: SUCCESS (1.393s)
[272.083587] Subtest basic-plain-flip: SUCCESS (3.000s)
[272.511738] [113/171] (810s left) kms_force_connector_basic (force-connector-state)
[273.161383] Starting subtest: force-connector-state
[273.426313] Subtest force-connector-state: SUCCESS (0.260s)
[273.836853] [114/171] (809s left) kms_force_connector_basic (force-edid)
[274.471253] Starting subtest: force-edid
[274.547800] Subtest force-edid: SUCCESS (0.082s)
[274.821836] [115/171] (808s left) kms_force_connector_basic (force-load-detect)
[275.468572] Starting subtest: force-load-detect
[275.883755] Subtest force-load-detect: SUCCESS (0.410s)
[276.262649] [116/171] (807s left) kms_force_connector_basic (prune-stale-modes)
[276.920628] Starting subtest: prune-stale-modes
[277.001565] Subtest prune-stale-modes: SUCCESS (0.083s)
[277.233522] [117/171] (806s left) kms_frontbuffer_tracking (basic)
[277.890560] Subtest basic: SKIP (0.000s)
[278.005508] [118/171] (805s left) kms_pipe_crc_basic (compare-crc-sanitycheck-xr24)
[278.634803] Starting subtest: compare-crc-sanitycheck-xr24
[278.639742] Starting dynamic subtest: pipe-A-VGA-1
[279.006536] Dynamic subtest pipe-A-VGA-1: SUCCESS (0.368s)
[279.058501] Starting dynamic subtest: pipe-B-VGA-1
[279.492326] Dynamic subtest pipe-B-VGA-1: SUCCESS (0.477s)
[279.495857] Subtest compare-crc-sanitycheck-xr24: SUCCESS (0.859s)
[279.756881] [119/171] (804s left) kms_pipe_crc_basic (compare-crc-sanitycheck-nv12)
[280.408695] Starting subtest: compare-crc-sanitycheck-nv12
[280.412925] Starting dynamic subtest: pipe-A-VGA-1
[280.421521] Dynamic subtest pipe-A-VGA-1: SKIP (0.001s)
[280.459246] Starting dynamic subtest: pipe-B-VGA-1
[280.464713] Dynamic subtest pipe-B-VGA-1: SKIP (0.001s)
[280.470378] Subtest compare-crc-sanitycheck-nv12: SKIP (0.014s)
[280.570796] [120/171] (803s left) kms_pipe_crc_basic (hang-read-crc)
[281.191839] Starting subtest: hang-read-crc
[281.196677] Starting dynamic subtest: pipe-A-VGA-1
[282.429632] Dynamic subtest pipe-A-VGA-1: SUCCESS (1.227s)
[282.472799] Starting dynamic subtest: pipe-B-VGA-1
[283.715727] Dynamic subtest pipe-B-VGA-1: SUCCESS (1.286s)
[283.724553] Subtest hang-read-crc: SUCCESS (2.524s)
[283.963807] [121/171] (800s left) kms_pipe_crc_basic (nonblocking-crc)
[284.593781] Starting subtest: nonblocking-crc
[284.597192] Starting dynamic subtest: pipe-A-VGA-1
[285.162731] Dynamic subtest pipe-A-VGA-1: SUCCESS (0.564s)
[285.198672] Starting dynamic subtest: pipe-B-VGA-1
[285.845509] Dynamic subtest pipe-B-VGA-1: SUCCESS (0.676s)
[285.849608] Subtest nonblocking-crc: SUCCESS (1.254s)
[286.100243] [122/171] (798s left) kms_pipe_crc_basic (nonblocking-crc-frame-sequence)
[286.723725] Starting subtest: nonblocking-crc-frame-sequence
[286.727994] Starting dynamic subtest: pipe-A-VGA-1
[287.291508] Dynamic subtest pipe-A-VGA-1: SUCCESS (0.565s)
[287.339998] Starting dynamic subtest: pipe-B-VGA-1
[287.955773] Dynamic subtest pipe-B-VGA-1: SUCCESS (0.659s)
[287.959741] Subtest nonblocking-crc-frame-sequence: SUCCESS (1.237s)
[288.223284] [123/171] (796s left) kms_pipe_crc_basic (read-crc)
[288.848615] Starting subtest: read-crc
[288.853673] Starting dynamic subtest: pipe-A-VGA-1
[289.332954] Dynamic subtest pipe-A-VGA-1: SUCCESS (0.479s)
[289.384866] Starting dynamic subtest: pipe-B-VGA-1
[289.931322] Dynamic subtest pipe-B-VGA-1: SUCCESS (0.587s)
[289.937586] Subtest read-crc: SUCCESS (1.078s)
[290.191868] [124/171] (794s left) kms_pipe_crc_basic (read-crc-frame-sequence)
[290.818409] Starting subtest: read-crc-frame-sequence
[290.823670] Starting dynamic subtest: pipe-A-VGA-1
[291.324333] Dynamic subtest pipe-A-VGA-1: SUCCESS (0.498s)
[291.368706] Starting dynamic subtest: pipe-B-VGA-1
[291.937676] Dynamic subtest pipe-B-VGA-1: SUCCESS (0.606s)
[291.942765] Subtest read-crc-frame-sequence: SUCCESS (1.119s)
[292.186251] [125/171] (792s left) kms_psr (primary_page_flip)
[292.775666] Subtest primary_page_flip: SKIP (0.000s)
[292.879685] [126/171] (791s left) kms_psr (cursor_plane_move)
[293.464266] Subtest cursor_plane_move: SKIP (0.000s)
[293.578439] [127/171] (791s left) kms_psr (sprite_plane_onoff)
[294.176349] Subtest sprite_plane_onoff: SKIP (0.000s)
[294.280188] [128/171] (790s left) kms_psr (primary_mmap_gtt)
[294.868496] Subtest primary_mmap_gtt: SKIP (0.000s)
[294.977796] [129/171] (789s left) kms_setmode (basic-clone-single-crtc)
[295.574812] Starting subtest: basic-clone-single-crtc
[295.587466] Subtest basic-clone-single-crtc: SKIP (0.001s)
[295.704757] [130/171] (789s left) i915_pm_backlight (basic-brightness)
[296.339090] Subtest basic-brightness: SKIP (0.000s)
[296.466246] [131/171] (788s left) i915_pm_rpm (basic-pci-d3-state)
[308.575782] Subtest basic-pci-d3-state: SKIP (0.000s)
[308.744154] [132/171] (776s left) i915_pm_rpm (basic-rte)
[309.503294] Starting subtest: basic-rte
[321.024248] Subtest basic-rte: SKIP (11.480s)
[321.143382] [133/171] (764s left) i915_pm_rps (basic-api)
[321.835439] Subtest basic-api: SKIP (0.000s)
[321.948614] [134/171] (763s left) prime_self_import (basic-llseek-bad)
[322.527869] Starting subtest: basic-llseek-bad
[322.537654] Subtest basic-llseek-bad: SUCCESS (0.010s)
[322.685134] [135/171] (762s left) prime_self_import (basic-llseek-size)
[323.281648] Starting subtest: basic-llseek-size
[323.303393] Subtest basic-llseek-size: SUCCESS (0.022s)
[323.454410] [136/171] (762s left) prime_self_import (basic-with_fd_dup)
[324.033768] Starting subtest: basic-with_fd_dup
[324.049203] Subtest basic-with_fd_dup: SUCCESS (0.015s)
[324.187351] [137/171] (761s left) prime_self_import (basic-with_one_bo)
[324.767169] Starting subtest: basic-with_one_bo
[324.785587] Subtest basic-with_one_bo: SUCCESS (0.019s)
[324.915879] [138/171] (760s left) prime_self_import (basic-with_one_bo_two_files)
[325.490124] Starting subtest: basic-with_one_bo_two_files
[325.505612] Subtest basic-with_one_bo_two_files: SUCCESS (0.012s)
[325.654808] [139/171] (760s left) prime_self_import (basic-with_two_bos)
[326.230925] Starting subtest: basic-with_two_bos
[326.248574] Subtest basic-with_two_bos: SUCCESS (0.017s)
[326.407980] [140/171] (759s left) prime_vgem (basic-fence-flip)
[327.021737] Starting subtest: basic-fence-flip
[327.624395] Subtest basic-fence-flip: SUCCESS (0.598s)
[327.822237] [141/171] (758s left) prime_vgem (basic-fence-mmap)
[328.447191] Starting subtest: basic-fence-mmap
[328.613104] Subtest basic-fence-mmap: SUCCESS (0.169s)
[328.757922] [142/171] (757s left) prime_vgem (basic-fence-read)
[329.355243] Starting subtest: basic-fence-read
[329.636984] Subtest basic-fence-read: SUCCESS (0.281s)
[329.790913] [143/171] (756s left) prime_vgem (basic-gtt)
[330.388462] Starting subtest: basic-gtt
[330.454167] Subtest basic-gtt: SUCCESS (0.063s)
[330.586300] [144/171] (755s left) prime_vgem (basic-read)
[331.190404] Starting subtest: basic-read
[331.310784] Subtest basic-read: SUCCESS (0.119s)
[331.452302] [145/171] (754s left) prime_vgem (basic-write)
[332.056113] Starting subtest: basic-write
[332.190091] Subtest basic-write: SUCCESS (0.133s)
[332.341619] [146/171] (754s left) vgem_basic (setversion)
[332.942589] Starting subtest: setversion
[332.949378] Subtest setversion: SUCCESS (0.000s)
[333.057125] [147/171] (753s left) vgem_basic (create)
[333.642524] Starting subtest: create
[333.646724] Subtest create: SUCCESS (0.002s)
[333.770216] [148/171] (752s left) vgem_basic (debugfs)
[334.358758] Starting subtest: debugfs
[334.363819] Subtest debugfs: SUCCESS (0.004s)
[334.485852] [149/171] (752s left) vgem_basic (dmabuf-export)
[335.110328] Starting subtest: dmabuf-export
[335.119803] Subtest dmabuf-export: SUCCESS (0.012s)
[335.261336] [150/171] (751s left) vgem_basic (dmabuf-fence)
[335.877102] Starting subtest: dmabuf-fence
[335.880988] Subtest dmabuf-fence: SUCCESS (0.005s)
[336.010415] [151/171] (750s left) vgem_basic (dmabuf-fence-before)
[336.609804] Starting subtest: dmabuf-fence-before
[336.614712] Subtest dmabuf-fence-before: SUCCESS (0.004s)
[336.738400] [152/171] (750s left) vgem_basic (dmabuf-mmap)
[337.328361] Starting subtest: dmabuf-mmap
[337.410537] Subtest dmabuf-mmap: SUCCESS (0.084s)
[337.526202] [153/171] (749s left) vgem_basic (mmap)
[338.095600] Starting subtest: mmap
[338.148374] Subtest mmap: SUCCESS (0.056s)
[338.263696] [154/171] (748s left) vgem_basic (second-client)
[338.845281] Starting subtest: second-client
[338.878398] Subtest second-client: SUCCESS (0.033s)
[338.994792] [155/171] (748s left) vgem_basic (sysfs)
[339.595256] Starting subtest: sysfs
[339.603955] Subtest sysfs: SUCCESS (0.005s)
[339.734515] [156/171] (747s left) core_hotunplug (unbind-rebind)
[340.481673] Starting subtest: unbind-rebind
[343.286240] Subtest unbind-rebind: SUCCESS (2.809s)
[343.522365] [157/171] (743s left) vgem_basic (unload)
[344.504346] Starting subtest: unload
[373.911478] Subtest unload: SUCCESS (29.409s)
[374.183547] [158/171] (713s left) i915_module_load (reload)
[374.743348] Starting subtest: reload
[380.048696] Subtest reload: SUCCESS (5.300s)
[380.195258] [159/171] (707s left) gem_lmem_swapping (basic)
[381.580607] Subtest basic: SKIP (0.000s)
[381.689167] [160/171] (706s left) gem_lmem_swapping (parallel-random-engines)
[382.287874] Subtest parallel-random-engines: SKIP (0.000s)
[382.404374] [161/171] (705s left) gem_lmem_swapping (random-engines)
[383.058188] Subtest random-engines: SKIP (0.000s)
[383.150443] [162/171] (704s left) gem_lmem_swapping (verify-random)
[383.746374] Subtest verify-random: SKIP (0.000s)
[383.831611] [163/171] (704s left) i915_pm_rpm (module-reload)
[395.967739] Subtest module-reload: SKIP (0.000s)
[396.058870] [164/171] (692s left) i915_selftest (live)
[398.564928] Starting subtest: live
[398.568923] Starting dynamic subtest: sanitycheck
[400.934296] Dynamic subtest sanitycheck: SUCCESS (2.373s)
[400.972791] Starting dynamic subtest: uncore
[403.063245] Dynamic subtest uncore: SUCCESS (2.127s)
[403.097789] Starting dynamic subtest: workarounds
[405.193727] Dynamic subtest workarounds: SUCCESS (2.126s)
[405.231517] Starting dynamic subtest: gt_engines
[407.285989] Dynamic subtest gt_engines: SUCCESS (2.090s)
[407.321164] Starting dynamic subtest: gt_timelines
[418.260505] Dynamic subtest gt_timelines: SUCCESS (10.970s)
[418.293725] Starting dynamic subtest: gt_contexts
[420.392270] Dynamic subtest gt_contexts: SUCCESS (2.129s)
[420.425665] Starting dynamic subtest: gt_lrc
[422.593929] Dynamic subtest gt_lrc: SUCCESS (2.198s)
[422.630583] Starting dynamic subtest: gt_mocs
[424.686214] Dynamic subtest gt_mocs: SUCCESS (2.090s)
[424.719957] Starting dynamic subtest: gt_pm
[427.162743] Dynamic subtest gt_pm: SUCCESS (2.472s)
[427.195589] Starting dynamic subtest: gt_heartbeat
[429.328903] Dynamic subtest gt_heartbeat: SUCCESS (2.163s)
[429.362768] Starting dynamic subtest: gt_tlb
[431.424709] Dynamic subtest gt_tlb: SUCCESS (2.092s)
[431.462509] Starting dynamic subtest: requests
[436.102426] Dynamic subtest requests: SUCCESS (4.674s)
[436.136575] Starting dynamic subtest: migrate
[438.227534] Dynamic subtest migrate: SUCCESS (2.120s)
[438.264478] Starting dynamic subtest: active
[440.383237] Dynamic subtest active: SUCCESS (2.152s)
[440.416681] Starting dynamic subtest: objects
[443.474794] Dynamic subtest objects: SUCCESS (3.088s)
[443.509139] Starting dynamic subtest: mman
[455.123504] Dynamic subtest mman: SUCCESS (11.645s)
[455.157979] Starting dynamic subtest: dmabuf
[457.346820] Dynamic subtest dmabuf: SUCCESS (2.219s)
[457.384629] Starting dynamic subtest: vma
[459.493636] Dynamic subtest vma: SUCCESS (2.143s)
[459.527416] Starting dynamic subtest: coherency
[466.522374] Dynamic subtest coherency: SUCCESS (7.025s)
[466.555293] Starting dynamic subtest: gtt
[471.616787] Dynamic subtest gtt: SUCCESS (5.090s)
[471.648461] Starting dynamic subtest: gem
[473.787272] Dynamic subtest gem: SUCCESS (2.166s)
[473.821534] Starting dynamic subtest: evict
[475.886322] Dynamic subtest evict: SUCCESS (2.094s)
[475.920450] Starting dynamic subtest: hugepages
[478.019233] Dynamic subtest hugepages: SUCCESS (2.129s)
[478.058585] Starting dynamic subtest: gem_contexts
[480.153727] Dynamic subtest gem_contexts: SUCCESS (2.131s)
[480.198365] Starting dynamic subtest: client
[482.238447] Dynamic subtest client: SUCCESS (2.079s)
[482.272577] Starting dynamic subtest: gem_migrate
[484.366286] Dynamic subtest gem_migrate: SUCCESS (2.124s)
[484.404239] Starting dynamic subtest: reset
[487.071502] Dynamic subtest reset: SUCCESS (2.702s)
[487.105560] Starting dynamic subtest: memory_region
[489.196927] Dynamic subtest memory_region: SUCCESS (2.121s)
[489.234760] Starting dynamic subtest: hangcheck
[492.421327] Dynamic subtest hangcheck: SUCCESS (3.221s)
[492.459224] Starting dynamic subtest: execlists
[494.511385] Dynamic subtest execlists: SUCCESS (2.084s)
[494.550583] Starting dynamic subtest: ring_submission
[496.647610] Dynamic subtest ring_submission: SUCCESS (2.132s)
[496.681662] Starting dynamic subtest: perf
[498.687435] Dynamic subtest perf: SUCCESS (2.036s)
[498.721585] Starting dynamic subtest: slpc
[500.810465] Dynamic subtest slpc: SUCCESS (2.119s)
[500.847825] Starting dynamic subtest: guc
[502.934173] Dynamic subtest guc: SUCCESS (2.120s)
[502.968333] Starting dynamic subtest: guc_multi_lrc
[505.019234] Dynamic subtest guc_multi_lrc: SUCCESS (2.079s)
[505.057713] Starting dynamic subtest: guc_hang
[507.094694] Dynamic subtest guc_hang: SUCCESS (2.073s)
[507.131888] Starting dynamic subtest: late_gt_pm
[509.198657] Dynamic subtest late_gt_pm: SUCCESS (2.100s)
[509.202488] Subtest live: SUCCESS (110.642s)
[509.485665] [165/171] (578s left) dmabuf (all-tests)
[510.077451] Starting subtest: all-tests
[510.081764] Starting dynamic subtest: sanitycheck
[510.176747] Dynamic subtest sanitycheck: SUCCESS (0.098s)
[510.216203] Starting dynamic subtest: dma_fence
[510.394656] Dynamic subtest dma_fence: SUCCESS (0.214s)
[510.431479] Starting dynamic subtest: dma_fence_chain
[562.348537] Dynamic subtest dma_fence_chain: SUCCESS (51.948s)
[562.384304] Starting dynamic subtest: dma_fence_unwrap
[562.450528] Dynamic subtest dma_fence_unwrap: SUCCESS (0.099s)
[562.498687] Starting dynamic subtest: dma_resv
[562.563666] Dynamic subtest dma_resv: SUCCESS (0.108s)
[562.567313] Subtest all-tests: SUCCESS (52.490s)
[562.659987] [166/171] (525s left) i915_suspend (basic-s2idle-without-i915)
[563.236810] Starting subtest: basic-s2idle-without-i915
[585.273929] Subtest basic-s2idle-without-i915: SUCCESS (7.068s)
[587.591393] [167/171] (517s left) i915_suspend (basic-s3-without-i915)
[588.423596] Starting subtest: basic-s3-without-i915
[609.419659] Subtest basic-s3-without-i915: SUCCESS (4.902s)
[613.677265] [168/171] (511s left) gem_exec_suspend (basic-s0)
[614.378476] Starting subtest: basic-S0
[614.383337] Starting dynamic subtest: smem
[635.423098] Dynamic subtest smem: SUCCESS (6.379s)
[635.426308] Subtest basic-S0: SUCCESS (6.385s)
[637.264257] [169/171] (504s left) gem_exec_suspend (basic-s3)
[637.959929] Starting subtest: basic-S3
[637.963816] Starting dynamic subtest: smem
[660.566369] Dynamic subtest smem: SUCCESS (6.380s)
[660.570374] Subtest basic-S3: SUCCESS (6.385s)
[663.867089] [170/171] (497s left) kms_chamelium_hpd (common-hpd-after-suspend)
[664.604819] Subtest common-hpd-after-suspend: SKIP (0.000s)
[664.730485] [171/171] (496s left) kms_pipe_crc_basic (suspend-read-crc)
[665.365861] Starting subtest: suspend-read-crc
[665.370363] Starting dynamic subtest: pipe-A-VGA-1
[684.346940] Dynamic subtest pipe-A-VGA-1: SUCCESS (2.503s)
[684.410897] Starting dynamic subtest: pipe-B-VGA-1
[703.332727] Dynamic subtest pipe-B-VGA-1: SUCCESS (2.581s)
[703.337103] Subtest suspend-read-crc: SUCCESS (5.103s)
[707.593319] Closing watchdogs
Done.