[35.489617] Initializing watchdogs
[35.489769]   /dev/watchdog0
[35.497929] [001/171] (960s left) i915_module_load (load)
[35.639337] Starting subtest: load
[37.313186] Subtest load: SUCCESS (1.675s)
[37.341756] [002/171] (958s left) core_auth (basic-auth)
[37.474851] Starting subtest: basic-auth
[37.477246] Subtest basic-auth: SUCCESS (0.002s)
[37.541849] [003/171] (958s left) debugfs_test (read_all_entries)
[37.691573] Starting subtest: read_all_entries
[37.851834] Subtest read_all_entries: SUCCESS (0.158s)
[38.004069] [004/171] (958s left) debugfs_test (basic-hwmon)
[38.172276] Starting subtest: basic-hwmon
[38.174844] Subtest basic-hwmon: SKIP (0.000s)
[38.292129] [005/171] (957s left) fbdev (eof)
[38.434761] Starting subtest: eof
[38.437070] Subtest eof: SUCCESS (0.002s)
[38.492501] [006/171] (957s left) fbdev (info)
[38.623603] Starting subtest: info
[38.624777] Subtest info: SUCCESS (0.000s)
[38.692840] [007/171] (957s left) fbdev (nullptr)
[38.835786] Starting subtest: nullptr
[38.836975] Subtest nullptr: SUCCESS (0.000s)
[38.893049] [008/171] (957s left) fbdev (read)
[39.021570] Starting subtest: read
[39.254241] Subtest read: SUCCESS (0.233s)
[39.312700] [009/171] (956s left) fbdev (write)
[39.437960] Starting subtest: write
[39.560518] Subtest write: SUCCESS (0.120s)
[39.613966] [010/171] (956s left) gem_basic (bad-close)
[39.738386] Starting subtest: bad-close
[39.740624] Subtest bad-close: SUCCESS (0.000s)
[39.797800] [011/171] (956s left) gem_basic (create-close)
[39.920995] Starting subtest: create-close
[39.923654] Subtest create-close: SUCCESS (0.000s)
[39.998382] [012/171] (956s left) gem_basic (create-fd-close)
[40.123310] Starting subtest: create-fd-close
[40.125506] Subtest create-fd-close: SUCCESS (0.000s)
[40.198844] [013/171] (956s left) gem_busy (busy@all-engines)
[40.338681] Starting subtest: busy
[40.339831] Starting dynamic subtest: all-engines
[40.365454] Dynamic subtest all-engines: SUCCESS (0.027s)
[40.366625] Subtest busy: SUCCESS (0.028s)
[40.686329] [014/171] (955s left) gem_close_race (basic-process)
[40.824597] Starting subtest: basic-process
[40.873403] Subtest basic-process: SUCCESS (0.049s)
[41.054399] [015/171] (955s left) gem_close_race (basic-threads)
[41.194858] Starting subtest: basic-threads
[42.336786] Subtest basic-threads: SUCCESS (1.142s)
[42.524832] [016/171] (953s left) gem_ctx_create (basic)
[42.658525] Subtest basic: SKIP (0.000s)
[42.693975] [017/171] (953s left) gem_ctx_create (basic-files)
[42.824151] Subtest basic-files: SKIP (0.000s)
[42.860436] [018/171] (953s left) gem_ctx_exec (basic)
[42.988268] Subtest basic: SKIP (0.000s)
[43.062225] [019/171] (953s left) gem_exec_basic (basic)
[43.194616] Starting subtest: basic
[43.195798] Starting dynamic subtest: rcs0-smem
[43.196878] Dynamic subtest rcs0-smem: SUCCESS (0.000s)
[43.197957] Subtest basic: SUCCESS (0.001s)
[43.377362] [020/171] (953s left) gem_exec_create (basic)
[43.512151] Starting subtest: basic
[43.514807] Starting dynamic subtest: smem
[45.547342] Dynamic subtest smem: SUCCESS (2.036s)
[45.548454] Subtest basic: SUCCESS (2.037s)
[45.736132] [021/171] (950s left) gem_exec_fence (basic-busy)
[45.995150] Starting subtest: basic-busy
[45.996258] Starting dynamic subtest: rcs0
[46.006365] Dynamic subtest rcs0: SUCCESS (0.012s)
[46.007451] Subtest basic-busy: SUCCESS (0.013s)
[46.505234] [022/171] (949s left) gem_exec_fence (basic-wait)
[46.764111] Starting subtest: basic-wait
[46.765126] Starting dynamic subtest: rcs0
[46.775403] Dynamic subtest rcs0: SUCCESS (0.012s)
[46.776534] Subtest basic-wait: SUCCESS (0.013s)
[47.224342] [023/171] (949s left) gem_exec_fence (basic-await)
[47.483930] Starting subtest: basic-await
[47.484969] Starting dynamic subtest: rcs0
[47.546238] Dynamic subtest rcs0: SUCCESS (0.063s)
[47.547385] Subtest basic-await: SUCCESS (0.063s)
[47.994217] [024/171] (948s left) gem_exec_fence (nb-await)
[48.252406] Starting subtest: nb-await
[48.253478] Starting dynamic subtest: rcs0
[48.303798] Dynamic subtest rcs0: SUCCESS (0.053s)
[48.305216] Subtest nb-await: SUCCESS (0.054s)
[48.747097] [025/171] (947s left) gem_exec_gttfill (basic)
[48.882606] Starting subtest: basic
[52.074761] Subtest basic: SUCCESS (3.190s)
[52.262761] [026/171] (944s left) gem_exec_parallel (engines)
[52.513508] Starting subtest: engines
[52.515850] Starting dynamic subtest: basic
[54.322616] Dynamic subtest basic: SUCCESS (1.809s)
[54.334888] Starting dynamic subtest: contexts
[54.337401] Dynamic subtest contexts: SKIP (0.002s)
[54.345298] Starting dynamic subtest: fds
[54.347331] Dynamic subtest fds: SKIP (0.001s)
[54.355721] Starting dynamic subtest: userptr
[56.150946] Dynamic subtest userptr: SUCCESS (1.822s)
[56.152177] Subtest engines: SUCCESS (3.635s)
[56.324227] [027/171] (940s left) gem_exec_store (basic)
[56.458392] Starting subtest: basic
[56.476311] Subtest basic: SUCCESS (0.018s)
[56.656788] [028/171] (939s left) gem_flink_basic (bad-flink)
[56.780496] Starting subtest: bad-flink
[56.781576] Subtest bad-flink: SUCCESS (0.000s)
[56.841448] [029/171] (939s left) gem_flink_basic (bad-open)
[56.965423] Starting subtest: bad-open
[56.966599] Subtest bad-open: SUCCESS (0.000s)
[57.041618] [030/171] (939s left) gem_flink_basic (basic)
[57.164137] Starting subtest: basic
[57.165632] Subtest basic: SUCCESS (0.000s)
[57.241035] [031/171] (939s left) gem_flink_basic (double-flink)
[57.361781] Starting subtest: double-flink
[57.363359] Subtest double-flink: SUCCESS (0.000s)
[57.444836] [032/171] (939s left) gem_flink_basic (flink-lifetime)
[57.568591] Starting subtest: flink-lifetime
[57.569629] Subtest flink-lifetime: SUCCESS (0.001s)
[57.644060] [033/171] (939s left) gem_huc_copy (huc-copy)
[57.772743] Subtest huc-copy: SKIP (0.000s)
[57.813179] [034/171] (938s left) gem_linear_blits (basic)
[58.264394] Starting subtest: basic
[58.277872] Subtest basic: SUCCESS (0.015s)
[58.395922] [035/171] (938s left) gem_mmap (basic)
[58.648458] Starting subtest: basic
[58.656817] Subtest basic: SUCCESS (0.005s)
[58.731437] [036/171] (938s left) gem_mmap_gtt (basic)
[58.875121] Starting subtest: basic
[58.880196] Subtest basic: SUCCESS (0.004s)
[58.966855] [037/171] (937s left) gem_render_linear_blits (basic)
[59.090812] Starting subtest: basic
[59.126771] Subtest basic: SUCCESS (0.038s)
[59.168103] [038/171] (937s left) gem_render_tiled_blits (basic)
[59.295733] Starting subtest: basic
[59.329699] Subtest basic: SUCCESS (0.037s)
[59.366951] [039/171] (937s left) gem_ringfill (basic-all)
[59.514245] Starting subtest: basic-all
[60.620607] Subtest basic-all: SUCCESS (1.104s)
[60.688543] [040/171] (936s left) gem_softpin (allocator-basic)
[60.817451] Subtest allocator-basic: SKIP (0.000s)
[60.887779] [041/171] (935s left) gem_softpin (allocator-basic-reserve)
[61.012044] Subtest allocator-basic-reserve: SKIP (0.000s)
[61.088938] [042/171] (935s left) gem_softpin (safe-alignment)
[61.216706] Starting subtest: safe-alignment
[61.217790] Subtest safe-alignment: SUCCESS (0.006s)
[61.288440] [043/171] (935s left) gem_sync (basic-all)
[61.424892] Starting subtest: basic-all
[63.502693] Subtest basic-all: SUCCESS (2.076s)
[63.682358] [044/171] (933s left) gem_sync (basic-each)
[63.817998] Starting subtest: basic-each
[65.883099] Subtest basic-each: SUCCESS (2.068s)
[66.073793] [045/171] (930s left) gem_tiled_blits (basic)
[66.482023] Starting subtest: basic
[66.501824] Subtest basic: SUCCESS (0.021s)
[66.607878] [046/171] (930s left) gem_tiled_fence_blits (basic)
[67.142711] Starting subtest: basic
[67.153913] Subtest basic: SUCCESS (0.013s)
[67.262456] [047/171] (929s left) gem_tiled_pread_basic
[67.762152] [048/171] (929s left) gem_wait (busy@all-engines)
[67.908235] Starting subtest: busy
[67.910038] Starting dynamic subtest: all-engines
[68.417186] Dynamic subtest all-engines: SUCCESS (0.510s)
[68.418343] Subtest busy: SUCCESS (0.511s)
[68.632213] [049/171] (928s left) gem_wait (wait@all-engines)
[68.773106] Starting subtest: wait
[68.775072] Starting dynamic subtest: all-engines
[69.787245] Dynamic subtest all-engines: SUCCESS (1.014s)
[69.788405] Subtest wait: SUCCESS (1.015s)
[70.003060] [050/171] (927s left) i915_getparams_basic (basic-eu-total)
[70.126379] Starting subtest: basic-eu-total
[70.129583] Subtest basic-eu-total: SUCCESS (0.000s)
[70.186571] [051/171] (926s left) i915_getparams_basic (basic-subslice-total)
[70.310436] Starting subtest: basic-subslice-total
[70.312685] Subtest basic-subslice-total: SUCCESS (0.000s)
[70.370779] [052/171] (926s left) i915_hangman (error-state-basic)
[70.498848] Starting subtest: error-state-basic
[70.619334] Subtest error-state-basic: SUCCESS (0.118s)
[70.673643] [053/171] (926s left) i915_pciid
[70.871352] [054/171] (926s left) kms_addfb_basic (addfb25-bad-modifier)
[70.998473] Starting subtest: addfb25-bad-modifier
[70.999579] Subtest addfb25-bad-modifier: SUCCESS (0.000s)
[71.105252] [055/171] (926s left) kms_addfb_basic (addfb25-framebuffer-vs-set-tiling)
[71.234447] Starting subtest: addfb25-framebuffer-vs-set-tiling
[71.235573] Subtest addfb25-framebuffer-vs-set-tiling: SUCCESS (0.000s)
[71.342307] [056/171] (925s left) kms_addfb_basic (addfb25-modifier-no-flag)
[71.472354] Starting subtest: addfb25-modifier-no-flag
[71.473436] Subtest addfb25-modifier-no-flag: SUCCESS (0.000s)
[71.575959] [057/171] (925s left) kms_addfb_basic (addfb25-x-tiled-legacy)
[71.704047] Starting subtest: addfb25-x-tiled-legacy
[71.705106] Subtest addfb25-x-tiled-legacy: SUCCESS (0.000s)
[71.811941] [058/171] (925s left) kms_addfb_basic (addfb25-x-tiled-mismatch-legacy)
[71.941291] Starting subtest: addfb25-x-tiled-mismatch-legacy
[71.942368] Subtest addfb25-x-tiled-mismatch-legacy: SUCCESS (0.000s)
[72.044082] [059/171] (925s left) kms_addfb_basic (addfb25-yf-tiled-legacy)
[72.202279] Starting subtest: addfb25-yf-tiled-legacy
[72.203476] Subtest addfb25-yf-tiled-legacy: SUCCESS (0.001s)
[72.276680] [060/171] (925s left) kms_addfb_basic (addfb25-y-tiled-legacy)
[72.437240] Starting subtest: addfb25-y-tiled-legacy
[72.438520] Subtest addfb25-y-tiled-legacy: SUCCESS (0.001s)
[72.510224] [061/171] (924s left) kms_addfb_basic (addfb25-y-tiled-small-legacy)
[72.669456] Starting subtest: addfb25-y-tiled-small-legacy
[72.672124] Subtest addfb25-y-tiled-small-legacy: SKIP (0.000s)
[72.746822] [062/171] (924s left) kms_addfb_basic (bad-pitch-0)
[72.873221] Starting subtest: bad-pitch-0
[72.874293] Subtest bad-pitch-0: SUCCESS (0.000s)
[72.980540] [063/171] (924s left) kms_addfb_basic (bad-pitch-1024)
[73.109149] Starting subtest: bad-pitch-1024
[73.110242] Subtest bad-pitch-1024: SUCCESS (0.000s)
[73.213683] [064/171] (924s left) kms_addfb_basic (bad-pitch-128)
[73.342432] Starting subtest: bad-pitch-128
[73.343534] Subtest bad-pitch-128: SUCCESS (0.000s)
[73.447367] [065/171] (923s left) kms_addfb_basic (bad-pitch-256)
[73.575279] Starting subtest: bad-pitch-256
[73.576442] Subtest bad-pitch-256: SUCCESS (0.000s)
[73.682661] [066/171] (923s left) kms_addfb_basic (bad-pitch-32)
[73.812014] Starting subtest: bad-pitch-32
[73.813096] Subtest bad-pitch-32: SUCCESS (0.000s)
[73.930722] [067/171] (923s left) kms_addfb_basic (bad-pitch-63)
[74.060085] Starting subtest: bad-pitch-63
[74.061209] Subtest bad-pitch-63: SUCCESS (0.000s)
[74.168950] [068/171] (923s left) kms_addfb_basic (bad-pitch-65536)
[74.298026] Starting subtest: bad-pitch-65536
[74.299024] Subtest bad-pitch-65536: SUCCESS (0.000s)
[74.400538] [069/171] (923s left) kms_addfb_basic (bad-pitch-999)
[74.530105] Starting subtest: bad-pitch-999
[74.531182] Subtest bad-pitch-999: SUCCESS (0.000s)
[74.636378] [070/171] (922s left) kms_addfb_basic (basic)
[74.767512] Starting subtest: basic
[74.768721] Subtest basic: SUCCESS (0.000s)
[74.871268] [071/171] (922s left) kms_addfb_basic (basic-x-tiled-legacy)
[75.002076] Starting subtest: basic-x-tiled-legacy
[75.003286] Subtest basic-x-tiled-legacy: SUCCESS (0.000s)
[75.104266] [072/171] (922s left) kms_addfb_basic (basic-y-tiled-legacy)
[75.228956] Starting subtest: basic-y-tiled-legacy
[75.231883] Subtest basic-y-tiled-legacy: SUCCESS (0.000s)
[75.339003] [073/171] (922s left) kms_addfb_basic (bo-too-small)
[75.497224] Starting subtest: bo-too-small
[75.498320] Subtest bo-too-small: SUCCESS (0.001s)
[75.572697] [074/171] (922s left) kms_addfb_basic (bo-too-small-due-to-tiling)
[75.727401] Starting subtest: bo-too-small-due-to-tiling
[75.728674] Subtest bo-too-small-due-to-tiling: SUCCESS (0.001s)
[75.805564] [075/171] (921s left) kms_addfb_basic (clobberred-modifier)
[75.931235] Starting subtest: clobberred-modifier
[75.932309] Subtest clobberred-modifier: SUCCESS (0.000s)
[76.041104] [076/171] (921s left) kms_addfb_basic (framebuffer-vs-set-tiling)
[76.170629] Starting subtest: framebuffer-vs-set-tiling
[76.171809] Subtest framebuffer-vs-set-tiling: SUCCESS (0.000s)
[76.276213] [077/171] (921s left) kms_addfb_basic (invalid-get-prop)
[76.405739] Starting subtest: invalid-get-prop
[76.406931] Subtest invalid-get-prop: SUCCESS (0.000s)
[76.509805] [078/171] (921s left) kms_addfb_basic (invalid-get-prop-any)
[76.644021] Starting subtest: invalid-get-prop-any
[76.644978] Subtest invalid-get-prop-any: SUCCESS (0.000s)
[76.744306] [079/171] (920s left) kms_addfb_basic (invalid-set-prop)
[76.875661] Starting subtest: invalid-set-prop
[76.876861] Subtest invalid-set-prop: SUCCESS (0.000s)
[76.978917] [080/171] (920s left) kms_addfb_basic (invalid-set-prop-any)
[77.109529] Starting subtest: invalid-set-prop-any
[77.110687] Subtest invalid-set-prop-any: SUCCESS (0.000s)
[77.211676] [081/171] (920s left) kms_addfb_basic (no-handle)
[77.341286] Starting subtest: no-handle
[77.342458] Subtest no-handle: SUCCESS (0.000s)
[77.445716] [082/171] (920s left) kms_addfb_basic (size-max)
[77.603176] Starting subtest: size-max
[77.604452] Subtest size-max: SUCCESS (0.001s)
[77.678529] [083/171] (920s left) kms_addfb_basic (small-bo)
[77.836521] Starting subtest: small-bo
[77.838120] Subtest small-bo: SUCCESS (0.000s)
[77.912412] [084/171] (919s left) kms_addfb_basic (tile-pitch-mismatch)
[78.041190] Starting subtest: tile-pitch-mismatch
[78.042265] Subtest tile-pitch-mismatch: SUCCESS (0.000s)
[78.148841] [085/171] (919s left) kms_addfb_basic (too-high)
[78.306766] Starting subtest: too-high
[78.310276] Subtest too-high: SUCCESS (0.003s)
[78.380334] [086/171] (919s left) kms_addfb_basic (too-wide)
[78.542457] Starting subtest: too-wide
[78.543639] Subtest too-wide: SUCCESS (0.000s)
[78.614775] [087/171] (919s left) kms_addfb_basic (unused-handle)
[78.742939] Starting subtest: unused-handle
[78.744061] Subtest unused-handle: SUCCESS (0.000s)
[78.851034] [088/171] (919s left) kms_addfb_basic (unused-modifier)
[78.981744] Starting subtest: unused-modifier
[78.982844] Subtest unused-modifier: SUCCESS (0.000s)
[79.083086] [089/171] (918s left) kms_addfb_basic (unused-offsets)
[79.213773] Starting subtest: unused-offsets
[79.214932] Subtest unused-offsets: SUCCESS (0.000s)
[79.318567] [090/171] (918s left) kms_addfb_basic (unused-pitches)
[79.446703] Starting subtest: unused-pitches
[79.447895] Subtest unused-pitches: SUCCESS (0.000s)
[79.553162] [091/171] (918s left) kms_busy (basic)
[79.708161] Starting subtest: basic
[79.711346] Starting dynamic subtest: flip
[80.364534] Dynamic subtest flip: SUCCESS (0.655s)
[80.379033] Starting dynamic subtest: modeset
[80.381142] Dynamic subtest modeset: SKIP (0.000s)
[80.385719] Subtest basic: SUCCESS (0.656s)
[80.488549] [092/171] (917s left) kms_chamelium_hpd (dp-hpd-fast)
[80.642722] Subtest dp-hpd-fast: SKIP (0.000s)
[80.686592] [093/171] (917s left) kms_chamelium_edid (dp-edid-read)
[80.842330] Subtest dp-edid-read: SKIP (0.000s)
[80.886572] [094/171] (917s left) kms_chamelium_frames (dp-crc-fast)
[81.044448] Subtest dp-crc-fast: SKIP (0.000s)
[81.087400] [095/171] (917s left) kms_chamelium_hpd (hdmi-hpd-fast)
[81.245903] Subtest hdmi-hpd-fast: SKIP (0.000s)
[81.287853] [096/171] (916s left) kms_chamelium_edid (hdmi-edid-read)
[81.444348] Subtest hdmi-edid-read: SKIP (0.000s)
[81.488581] [097/171] (916s left) kms_chamelium_frames (hdmi-crc-fast)
[81.648341] Subtest hdmi-crc-fast: SKIP (0.000s)
[81.689269] [098/171] (916s left) kms_chamelium_hpd (vga-hpd-fast)
[81.846995] Subtest vga-hpd-fast: SKIP (0.000s)
[81.889928] [099/171] (916s left) kms_chamelium_edid (vga-edid-read)
[82.047251] Subtest vga-edid-read: SKIP (0.000s)
[82.090678] [100/171] (916s left) kms_prop_blob (basic)
[82.215172] Starting subtest: basic
[82.216210] Subtest basic: SUCCESS (0.000s)
[82.293212] [101/171] (915s left) kms_cursor_legacy (basic-busy-flip-before-cursor-atomic)
[82.448547] Starting subtest: basic-busy-flip-before-cursor-atomic
[82.454189] Subtest basic-busy-flip-before-cursor-atomic: SKIP (0.005s)
[82.523591] [102/171] (915s left) kms_cursor_legacy (basic-busy-flip-before-cursor-legacy)
[82.683476] Starting subtest: basic-busy-flip-before-cursor-legacy
[83.696504] Subtest basic-busy-flip-before-cursor-legacy: SUCCESS (1.005s)
[83.799740] [103/171] (914s left) kms_cursor_legacy (basic-flip-after-cursor-atomic)
[83.957693] Starting subtest: basic-flip-after-cursor-atomic
[83.960171] Subtest basic-flip-after-cursor-atomic: SKIP (0.000s)
[84.032396] [104/171] (914s left) kms_cursor_legacy (basic-flip-after-cursor-legacy)
[84.191812] Starting subtest: basic-flip-after-cursor-legacy
[85.197177] Subtest basic-flip-after-cursor-legacy: SUCCESS (1.005s)
[85.316544] [105/171] (913s left) kms_cursor_legacy (basic-flip-after-cursor-varying-size)
[85.475952] Starting subtest: basic-flip-after-cursor-varying-size
[86.511976] Subtest basic-flip-after-cursor-varying-size: SUCCESS (1.037s)
[86.641297] [106/171] (911s left) kms_cursor_legacy (basic-flip-before-cursor-atomic)
[86.797898] Starting subtest: basic-flip-before-cursor-atomic
[86.800237] Subtest basic-flip-before-cursor-atomic: SKIP (0.000s)
[86.874217] [107/171] (911s left) kms_cursor_legacy (basic-flip-before-cursor-legacy)
[87.033418] Starting subtest: basic-flip-before-cursor-legacy
[88.031991] Subtest basic-flip-before-cursor-legacy: SUCCESS (0.998s)
[88.147150] [108/171] (910s left) kms_cursor_legacy (basic-flip-before-cursor-varying-size)
[88.301204] Starting subtest: basic-flip-before-cursor-varying-size
[89.320044] Subtest basic-flip-before-cursor-varying-size: SUCCESS (1.012s)
[89.440750] [109/171] (908s left) kms_flip (basic-flip-vs-dpms)
[89.598223] Starting subtest: basic-flip-vs-dpms
[89.599314] Starting dynamic subtest: A-VGA1
[90.935853] Dynamic subtest A-VGA1: SUCCESS (1.327s)
[90.955971] Starting dynamic subtest: B-VGA1
[92.203750] Dynamic subtest B-VGA1: SUCCESS (1.257s)
[92.207861] Subtest basic-flip-vs-dpms: SUCCESS (2.607s)
[92.367915] [110/171] (906s left) kms_flip (basic-flip-vs-modeset)
[92.524502] Starting subtest: basic-flip-vs-modeset
[92.525774] Starting dynamic subtest: A-VGA1
[93.765818] Dynamic subtest A-VGA1: SUCCESS (1.240s)
[93.781790] Starting dynamic subtest: B-VGA1
[95.030902] Dynamic subtest B-VGA1: SUCCESS (1.260s)
[95.032012] Subtest basic-flip-vs-modeset: SUCCESS (2.502s)
[95.164638] [111/171] (903s left) kms_flip (basic-flip-vs-wf_vblank)
[95.319342] Starting subtest: basic-flip-vs-wf_vblank
[95.320564] Starting dynamic subtest: A-VGA1
[96.875738] Dynamic subtest A-VGA1: SUCCESS (1.554s)
[96.892948] Starting dynamic subtest: B-VGA1
[98.418132] Dynamic subtest B-VGA1: SUCCESS (1.534s)
[98.419248] Subtest basic-flip-vs-wf_vblank: SUCCESS (3.099s)
[98.603140] [112/171] (899s left) kms_flip (basic-plain-flip)
[98.760205] Starting subtest: basic-plain-flip
[98.761293] Starting dynamic subtest: A-VGA1
[100.031806] Dynamic subtest A-VGA1: SUCCESS (1.261s)
[100.052083] Starting dynamic subtest: B-VGA1
[101.275646] Dynamic subtest B-VGA1: SUCCESS (1.219s)
[101.282505] Subtest basic-plain-flip: SUCCESS (2.517s)
[101.460166] [113/171] (897s left) kms_force_connector_basic (force-connector-state)
[101.682961] Starting subtest: force-connector-state
[101.870951] Subtest force-connector-state: SUCCESS (0.188s)
[102.140770] [114/171] (896s left) kms_force_connector_basic (force-edid)
[102.400066] Starting subtest: force-edid
[102.498322] Subtest force-edid: SUCCESS (0.098s)
[102.706220] [115/171] (895s left) kms_force_connector_basic (force-load-detect)
[102.951725] Starting subtest: force-load-detect
[103.186975] Subtest force-load-detect: SUCCESS (0.231s)
[103.452114] [116/171] (895s left) kms_force_connector_basic (prune-stale-modes)
[103.724077] Starting subtest: prune-stale-modes
[103.805615] Subtest prune-stale-modes: SUCCESS (0.083s)
[104.010549] [117/171] (894s left) kms_frontbuffer_tracking (basic)
[104.344985] Subtest basic: SKIP (0.000s)
[104.457586] [118/171] (894s left) kms_pipe_crc_basic (compare-crc-sanitycheck-xr24)
[104.724212] Starting subtest: compare-crc-sanitycheck-xr24
[104.733019] Starting dynamic subtest: pipe-A-VGA-1
[105.087934] Dynamic subtest pipe-A-VGA-1: SUCCESS (0.365s)
[105.113049] Starting dynamic subtest: pipe-B-VGA-1
[105.463855] Dynamic subtest pipe-B-VGA-1: SUCCESS (0.347s)
[105.464896] Subtest compare-crc-sanitycheck-xr24: SUCCESS (0.740s)
[105.592441] [119/171] (893s left) kms_pipe_crc_basic (compare-crc-sanitycheck-nv12)
[105.749895] Starting subtest: compare-crc-sanitycheck-nv12
[105.752153] Starting dynamic subtest: pipe-A-VGA-1
[105.754398] Dynamic subtest pipe-A-VGA-1: SKIP (0.000s)
[105.765997] Starting dynamic subtest: pipe-B-VGA-1
[105.768133] Dynamic subtest pipe-B-VGA-1: SKIP (0.000s)
[105.770307] Subtest compare-crc-sanitycheck-nv12: SKIP (0.005s)
[105.826378] [120/171] (893s left) kms_pipe_crc_basic (hang-read-crc)
[105.981121] Starting subtest: hang-read-crc
[105.983812] Starting dynamic subtest: pipe-A-VGA-1
[106.938647] Dynamic subtest pipe-A-VGA-1: SUCCESS (0.955s)
[106.952968] Starting dynamic subtest: pipe-B-VGA-1
[107.908680] Dynamic subtest pipe-B-VGA-1: SUCCESS (0.968s)
[107.910073] Subtest hang-read-crc: SUCCESS (1.927s)
[108.032966] [121/171] (890s left) kms_pipe_crc_basic (nonblocking-crc)
[108.191192] Starting subtest: nonblocking-crc
[108.193453] Starting dynamic subtest: pipe-A-VGA-1
[108.688754] Dynamic subtest pipe-A-VGA-1: SUCCESS (0.495s)
[108.699921] Starting dynamic subtest: pipe-B-VGA-1
[109.230176] Dynamic subtest pipe-B-VGA-1: SUCCESS (0.540s)
[109.231426] Subtest nonblocking-crc: SUCCESS (1.039s)
[109.355286] [122/171] (889s left) kms_pipe_crc_basic (nonblocking-crc-frame-sequence)
[109.513163] Starting subtest: nonblocking-crc-frame-sequence
[109.514198] Starting dynamic subtest: pipe-A-VGA-1
[110.009071] Dynamic subtest pipe-A-VGA-1: SUCCESS (0.495s)
[110.023132] Starting dynamic subtest: pipe-B-VGA-1
[110.556201] Dynamic subtest pipe-B-VGA-1: SUCCESS (0.545s)
[110.557426] Subtest nonblocking-crc-frame-sequence: SUCCESS (1.043s)
[110.678059] [123/171] (888s left) kms_pipe_crc_basic (read-crc)
[110.835377] Starting subtest: read-crc
[110.838214] Starting dynamic subtest: pipe-A-VGA-1
[111.266711] Dynamic subtest pipe-A-VGA-1: SUCCESS (0.428s)
[111.279941] Starting dynamic subtest: pipe-B-VGA-1
[111.748235] Dynamic subtest pipe-B-VGA-1: SUCCESS (0.479s)
[111.749368] Subtest read-crc: SUCCESS (0.913s)
[111.875168] [124/171] (887s left) kms_pipe_crc_basic (read-crc-frame-sequence)
[112.030200] Starting subtest: read-crc-frame-sequence
[112.034175] Starting dynamic subtest: pipe-A-VGA-1
[112.465592] Dynamic subtest pipe-A-VGA-1: SUCCESS (0.432s)
[112.482982] Starting dynamic subtest: pipe-B-VGA-1
[112.913372] Dynamic subtest pipe-B-VGA-1: SUCCESS (0.446s)
[112.914531] Subtest read-crc-frame-sequence: SUCCESS (0.883s)
[113.021895] [125/171] (885s left) kms_psr (primary_page_flip)
[113.151732] Subtest primary_page_flip: SKIP (0.000s)
[113.191365] [126/171] (885s left) kms_psr (cursor_plane_move)
[113.317835] Subtest cursor_plane_move: SKIP (0.000s)
[113.358708] [127/171] (885s left) kms_psr (sprite_plane_onoff)
[113.483808] Subtest sprite_plane_onoff: SKIP (0.000s)
[113.525715] [128/171] (885s left) kms_psr (primary_mmap_gtt)
[113.651619] Subtest primary_mmap_gtt: SKIP (0.000s)
[113.692934] [129/171] (885s left) kms_setmode (basic-clone-single-crtc)
[113.820288] Starting subtest: basic-clone-single-crtc
[113.823979] Subtest basic-clone-single-crtc: SKIP (0.000s)
[113.890959] [130/171] (885s left) i915_pm_backlight (basic-brightness)
[114.048046] Subtest basic-brightness: SKIP (0.000s)
[114.094285] [131/171] (884s left) i915_pm_rpm (basic-pci-d3-state)
[125.420144] Subtest basic-pci-d3-state: SKIP (0.000s)
[125.450780] [132/171] (873s left) i915_pm_rpm (basic-rte)
[125.573317] Starting subtest: basic-rte
[136.783357] Subtest basic-rte: SKIP (11.194s)
[136.807843] [133/171] (862s left) i915_pm_rps (basic-api)
[136.938996] Subtest basic-api: SKIP (0.000s)
[136.973498] [134/171] (862s left) prime_self_import (basic-llseek-bad)
[137.097728] Starting subtest: basic-llseek-bad
[137.099988] Subtest basic-llseek-bad: SUCCESS (0.003s)
[137.172632] [135/171] (862s left) prime_self_import (basic-llseek-size)
[137.295698] Starting subtest: basic-llseek-size
[137.298163] Subtest basic-llseek-size: SUCCESS (0.003s)
[137.373970] [136/171] (861s left) prime_self_import (basic-with_fd_dup)
[137.492261] Starting subtest: basic-with_fd_dup
[137.496777] Subtest basic-with_fd_dup: SUCCESS (0.005s)
[137.574042] [137/171] (861s left) prime_self_import (basic-with_one_bo)
[137.697055] Starting subtest: basic-with_one_bo
[137.700257] Subtest basic-with_one_bo: SUCCESS (0.004s)
[137.758689] [138/171] (861s left) prime_self_import (basic-with_one_bo_two_files)
[137.880438] Starting subtest: basic-with_one_bo_two_files
[137.882791] Subtest basic-with_one_bo_two_files: SUCCESS (0.003s)
[137.959177] [139/171] (861s left) prime_self_import (basic-with_two_bos)
[138.082783] Starting subtest: basic-with_two_bos
[138.085387] Subtest basic-with_two_bos: SUCCESS (0.004s)
[138.160085] [140/171] (861s left) prime_vgem (basic-fence-flip)
[138.308874] Starting subtest: basic-fence-flip
[138.706087] Subtest basic-fence-flip: SUCCESS (0.397s)
[138.778578] [141/171] (860s left) prime_vgem (basic-fence-mmap)
[138.909964] Starting subtest: basic-fence-mmap
[138.942382] Subtest basic-fence-mmap: SUCCESS (0.038s)
[139.012639] [142/171] (860s left) prime_vgem (basic-fence-read)
[139.143208] Starting subtest: basic-fence-read
[139.203573] Subtest basic-fence-read: SUCCESS (0.065s)
[139.280826] [143/171] (860s left) prime_vgem (basic-gtt)
[139.409654] Starting subtest: basic-gtt
[139.424356] Subtest basic-gtt: SUCCESS (0.017s)
[139.497888] [144/171] (859s left) prime_vgem (basic-read)
[139.627557] Starting subtest: basic-read
[139.652963] Subtest basic-read: SUCCESS (0.028s)
[139.730431] [145/171] (859s left) prime_vgem (basic-write)
[139.860184] Starting subtest: basic-write
[139.887570] Subtest basic-write: SUCCESS (0.030s)
[139.966880] [146/171] (859s left) vgem_basic (setversion)
[140.106423] Starting subtest: setversion
[140.108752] Subtest setversion: SUCCESS (0.000s)
[140.166771] [147/171] (859s left) vgem_basic (create)
[140.290689] Starting subtest: create
[140.291950] Subtest create: SUCCESS (0.000s)
[140.350911] [148/171] (859s left) vgem_basic (debugfs)
[140.473191] Starting subtest: debugfs
[140.474948] Subtest debugfs: SUCCESS (0.000s)
[140.533882] [149/171] (858s left) vgem_basic (dmabuf-export)
[140.660148] Starting subtest: dmabuf-export
[140.662508] Subtest dmabuf-export: SUCCESS (0.002s)
[140.735219] [150/171] (858s left) vgem_basic (dmabuf-fence)
[140.859823] Starting subtest: dmabuf-fence
[140.861026] Subtest dmabuf-fence: SUCCESS (0.001s)
[140.918820] [151/171] (858s left) vgem_basic (dmabuf-fence-before)
[141.043445] Starting subtest: dmabuf-fence-before
[141.044674] Subtest dmabuf-fence-before: SUCCESS (0.001s)
[141.100888] [152/171] (858s left) vgem_basic (dmabuf-mmap)
[141.226183] Starting subtest: dmabuf-mmap
[141.246778] Subtest dmabuf-mmap: SUCCESS (0.021s)
[141.303921] [153/171] (858s left) vgem_basic (mmap)
[141.427113] Starting subtest: mmap
[141.441042] Subtest mmap: SUCCESS (0.014s)
[141.504521] [154/171] (858s left) vgem_basic (second-client)
[141.627608] Starting subtest: second-client
[141.661026] Subtest second-client: SUCCESS (0.033s)
[141.722385] [155/171] (857s left) vgem_basic (sysfs)
[141.846269] Starting subtest: sysfs
[141.847496] Subtest sysfs: SUCCESS (0.001s)
[141.905111] [156/171] (857s left) core_hotunplug (unbind-rebind)
[142.077996] Starting subtest: unbind-rebind
[142.874310] Subtest unbind-rebind: SUCCESS (0.796s)
[142.904638] [157/171] (856s left) vgem_basic (unload)
[143.063109] Starting subtest: unload
[171.980817] Subtest unload: SUCCESS (28.915s)
[172.087286] [158/171] (827s left) i915_module_load (reload)
[172.210198] Starting subtest: reload
[174.213945] Subtest reload: SUCCESS (2.004s)
[174.245592] [159/171] (825s left) gem_lmem_swapping (basic)
[174.407164] Subtest basic: SKIP (0.000s)
[174.442125] [160/171] (825s left) gem_lmem_swapping (parallel-random-engines)
[174.681948] Subtest parallel-random-engines: SKIP (0.000s)
[174.732317] [161/171] (825s left) gem_lmem_swapping (random-engines)
[174.871456] Subtest random-engines: SKIP (0.000s)
[174.911957] [162/171] (824s left) gem_lmem_swapping (verify-random)
[175.040448] Subtest verify-random: SKIP (0.000s)
[175.079265] [163/171] (824s left) i915_pm_rpm (module-reload)
[186.412836] Subtest module-reload: SKIP (0.000s)
[186.432831] [164/171] (813s left) i915_selftest (live)
[187.221377] Starting subtest: live
[187.224033] Starting dynamic subtest: sanitycheck
[187.944911] Dynamic subtest sanitycheck: SUCCESS (0.724s)
[187.955392] Starting dynamic subtest: uncore
[188.624988] Dynamic subtest uncore: SUCCESS (0.678s)
[188.635563] Starting dynamic subtest: workarounds
[189.300985] Dynamic subtest workarounds: SUCCESS (0.676s)
[189.313038] Starting dynamic subtest: gt_engines
[190.016083] Dynamic subtest gt_engines: SUCCESS (0.713s)
[190.027157] Starting dynamic subtest: gt_timelines
[193.018559] Dynamic subtest gt_timelines: SUCCESS (3.000s)
[193.027893] Starting dynamic subtest: gt_contexts
[193.704101] Dynamic subtest gt_contexts: SUCCESS (0.687s)
[193.715709] Starting dynamic subtest: gt_lrc
[194.382779] Dynamic subtest gt_lrc: SUCCESS (0.678s)
[194.391747] Starting dynamic subtest: gt_mocs
[195.043102] Dynamic subtest gt_mocs: SUCCESS (0.659s)
[195.053769] Starting dynamic subtest: gt_pm
[196.201410] Dynamic subtest gt_pm: SUCCESS (1.156s)
[196.209709] Starting dynamic subtest: gt_heartbeat
[196.917833] Dynamic subtest gt_heartbeat: SUCCESS (0.717s)
[196.927565] Starting dynamic subtest: gt_tlb
[197.586182] Dynamic subtest gt_tlb: SUCCESS (0.667s)
[197.596908] Starting dynamic subtest: requests
[200.832737] Dynamic subtest requests: SUCCESS (3.243s)
[200.841888] Starting dynamic subtest: migrate
[201.486686] Dynamic subtest migrate: SUCCESS (0.656s)
[201.498305] Starting dynamic subtest: active
[202.178110] Dynamic subtest active: SUCCESS (0.690s)
[202.189202] Starting dynamic subtest: objects
[203.179045] Dynamic subtest objects: SUCCESS (0.999s)
[203.190171] Starting dynamic subtest: mman
[208.087299] Dynamic subtest mman: SUCCESS (4.908s)
[208.096069] Starting dynamic subtest: dmabuf
[208.821995] Dynamic subtest dmabuf: SUCCESS (0.732s)
[208.833164] Starting dynamic subtest: vma
[209.488936] Dynamic subtest vma: SUCCESS (0.666s)
[209.500143] Starting dynamic subtest: coherency
[211.324151] Dynamic subtest coherency: SUCCESS (1.833s)
[211.334550] Starting dynamic subtest: gtt
[215.522060] Dynamic subtest gtt: SUCCESS (4.196s)
[215.531484] Starting dynamic subtest: gem
[216.260714] Dynamic subtest gem: SUCCESS (0.740s)
[216.271982] Starting dynamic subtest: evict
[216.937108] Dynamic subtest evict: SUCCESS (0.675s)
[216.948352] Starting dynamic subtest: hugepages
[217.619977] Dynamic subtest hugepages: SUCCESS (0.682s)
[217.631916] Starting dynamic subtest: gem_contexts
[218.268886] Dynamic subtest gem_contexts: SUCCESS (0.648s)
[218.280200] Starting dynamic subtest: client
[218.946387] Dynamic subtest client: SUCCESS (0.677s)
[218.957398] Starting dynamic subtest: gem_migrate
[219.640143] Dynamic subtest gem_migrate: SUCCESS (0.692s)
[219.651419] Starting dynamic subtest: reset
[220.645155] Dynamic subtest reset: SUCCESS (1.003s)
[220.655781] Starting dynamic subtest: memory_region
[221.312644] Dynamic subtest memory_region: SUCCESS (0.668s)
[221.324557] Starting dynamic subtest: hangcheck
[223.031154] Dynamic subtest hangcheck: SUCCESS (1.717s)
[223.043157] Starting dynamic subtest: execlists
[223.721122] Dynamic subtest execlists: SUCCESS (0.689s)
[223.732435] Starting dynamic subtest: ring_submission
[224.400824] Dynamic subtest ring_submission: SUCCESS (0.679s)
[224.412548] Starting dynamic subtest: perf
[225.092298] Dynamic subtest perf: SUCCESS (0.690s)
[225.103148] Starting dynamic subtest: slpc
[225.741539] Dynamic subtest slpc: SUCCESS (0.650s)
[225.753343] Starting dynamic subtest: guc
[226.458559] Dynamic subtest guc: SUCCESS (0.716s)
[226.471743] Starting dynamic subtest: guc_multi_lrc
[227.124521] Dynamic subtest guc_multi_lrc: SUCCESS (0.664s)
[227.136954] Starting dynamic subtest: guc_hang
[227.776496] Dynamic subtest guc_hang: SUCCESS (0.649s)
[227.789438] Starting dynamic subtest: late_gt_pm
[228.427238] Dynamic subtest late_gt_pm: SUCCESS (0.650s)
[228.428409] Subtest live: SUCCESS (41.209s)
[228.579701] [165/171] (771s left) dmabuf (all-tests)
[228.708031] Starting subtest: all-tests
[228.712909] Starting dynamic subtest: sanitycheck
[228.769523] Dynamic subtest sanitycheck: SUCCESS (0.060s)
[228.778545] Starting dynamic subtest: dma_fence
[228.944350] Dynamic subtest dma_fence: SUCCESS (0.174s)
[228.960629] Starting dynamic subtest: dma_fence_chain
[246.449730] Dynamic subtest dma_fence_chain: SUCCESS (17.503s)
[246.462457] Starting dynamic subtest: dma_fence_unwrap
[246.517164] Dynamic subtest dma_fence_unwrap: SUCCESS (0.066s)
[246.526825] Starting dynamic subtest: dma_resv
[246.586535] Dynamic subtest dma_resv: SUCCESS (0.072s)
[246.591280] Subtest all-tests: SUCCESS (17.881s)
[246.611349] [166/171] (753s left) i915_suspend (basic-s2idle-without-i915)
[246.731960] Starting subtest: basic-s2idle-without-i915
[265.596917] Subtest basic-s2idle-without-i915: SUCCESS (18.864s)
[268.036676] [167/171] (734s left) i915_suspend (basic-s3-without-i915)
[268.165052] Starting subtest: basic-s3-without-i915
[285.267631] Subtest basic-s3-without-i915: SUCCESS (2.313s)
[289.866895] [168/171] (731s left) gem_exec_suspend (basic-s0)
[290.011469] Starting subtest: basic-S0
[290.013337] Starting dynamic subtest: smem
[307.180573] Dynamic subtest smem: SUCCESS (17.169s)
[307.181724] Subtest basic-S0: SUCCESS (17.171s)
[309.895333] [169/171] (714s left) gem_exec_suspend (basic-s3)
[310.055542] Starting subtest: basic-S3
[310.057351] Starting dynamic subtest: smem
[328.012886] Dynamic subtest smem: SUCCESS (1.964s)
[328.015437] Subtest basic-S3: SUCCESS (1.967s)
[333.215119] [170/171] (711s left) kms_chamelium_hpd (common-hpd-after-suspend)
[333.381879] Subtest common-hpd-after-suspend: SKIP (0.000s)
[333.424796] [171/171] (711s left) kms_pipe_crc_basic (suspend-read-crc)
[333.582123] Starting subtest: suspend-read-crc
[333.583324] Starting dynamic subtest: pipe-A-VGA-1
[351.035181] Dynamic subtest pipe-A-VGA-1: SUCCESS (1.771s)
[351.059152] Starting dynamic subtest: pipe-B-VGA-1
[369.084300] Dynamic subtest pipe-B-VGA-1: SUCCESS (1.892s)
[369.085458] Subtest suspend-read-crc: SUCCESS (3.668s)
[374.224488] Closing watchdogs
Done.