[41.581356] Initializing watchdogs
[41.581526]   /dev/watchdog0
[41.588663] [001/171] (960s left) i915_module_load (load)
[42.002579] Starting subtest: load
[43.601696] Subtest load: SUCCESS (1.601s)
[43.624717] [002/171] (958s left) core_auth (basic-auth)
[43.752952] Starting subtest: basic-auth
[43.754202] Subtest basic-auth: SUCCESS (0.001s)
[43.828789] [003/171] (958s left) debugfs_test (read_all_entries)
[43.984215] Starting subtest: read_all_entries
[44.041170] Subtest read_all_entries: SUCCESS (0.055s)
[44.205371] [004/171] (957s left) debugfs_test (basic-hwmon)
[44.389700] Starting subtest: basic-hwmon
[44.391922] Subtest basic-hwmon: SKIP (0.000s)
[44.495075] [005/171] (957s left) fbdev (eof)
[44.624102] Starting subtest: eof
[44.625871] Subtest eof: SUCCESS (0.000s)
[44.679835] [006/171] (957s left) fbdev (info)
[44.799822] Starting subtest: info
[44.800959] Subtest info: SUCCESS (0.000s)
[44.864425] [007/171] (957s left) fbdev (nullptr)
[44.993059] Starting subtest: nullptr
[44.994465] Subtest nullptr: SUCCESS (0.000s)
[45.045966] [008/171] (957s left) fbdev (read)
[45.175128] Starting subtest: read
[45.408297] Subtest read: SUCCESS (0.233s)
[45.468782] [009/171] (956s left) fbdev (write)
[45.592031] Starting subtest: write
[45.711085] Subtest write: SUCCESS (0.117s)
[45.767438] [010/171] (956s left) gem_basic (bad-close)
[45.889634] Starting subtest: bad-close
[45.892931] Subtest bad-close: SUCCESS (0.000s)
[45.949452] [011/171] (956s left) gem_basic (create-close)
[46.071220] Starting subtest: create-close
[46.076070] Subtest create-close: SUCCESS (0.000s)
[46.135248] [012/171] (956s left) gem_basic (create-fd-close)
[46.258399] Starting subtest: create-fd-close
[46.260845] Subtest create-fd-close: SUCCESS (0.000s)
[46.335891] [013/171] (955s left) gem_busy (busy@all-engines)
[46.468624] Starting subtest: busy
[46.470358] Starting dynamic subtest: all-engines
[46.494559] Dynamic subtest all-engines: SUCCESS (0.025s)
[46.495721] Subtest busy: SUCCESS (0.026s)
[46.805276] [014/171] (955s left) gem_close_race (basic-process)
[46.940964] Starting subtest: basic-process
[46.984317] Subtest basic-process: SUCCESS (0.044s)
[47.173603] [015/171] (955s left) gem_close_race (basic-threads)
[47.312108] Starting subtest: basic-threads
[48.442639] Subtest basic-threads: SUCCESS (1.132s)
[48.629298] [016/171] (953s left) gem_ctx_create (basic)
[48.760629] Subtest basic: SKIP (0.000s)
[48.779588] [017/171] (953s left) gem_ctx_create (basic-files)
[48.909311] Subtest basic-files: SKIP (0.000s)
[48.930392] [018/171] (953s left) gem_ctx_exec (basic)
[49.059188] Subtest basic: SKIP (0.000s)
[49.133146] [019/171] (953s left) gem_exec_basic (basic)
[49.261379] Starting subtest: basic
[49.262390] Starting dynamic subtest: rcs0-smem
[49.263572] Dynamic subtest rcs0-smem: SUCCESS (0.000s)
[49.264680] Subtest basic: SUCCESS (0.001s)
[49.447525] [020/171] (953s left) gem_exec_create (basic)
[49.578803] Starting subtest: basic
[49.580395] Starting dynamic subtest: smem
[51.612345] Dynamic subtest smem: SUCCESS (2.033s)
[51.613430] Subtest basic: SUCCESS (2.034s)
[51.788372] [021/171] (950s left) gem_exec_fence (basic-busy)
[52.046151] Starting subtest: basic-busy
[52.047203] Starting dynamic subtest: rcs0
[52.056224] Dynamic subtest rcs0: SUCCESS (0.012s)
[52.057187] Subtest basic-busy: SUCCESS (0.012s)
[52.542620] [022/171] (949s left) gem_exec_fence (basic-wait)
[52.796176] Starting subtest: basic-wait
[52.797245] Starting dynamic subtest: rcs0
[52.805167] Dynamic subtest rcs0: SUCCESS (0.010s)
[52.806273] Subtest basic-wait: SUCCESS (0.011s)
[53.244626] [023/171] (949s left) gem_exec_fence (basic-await)
[53.504682] Starting subtest: basic-await
[53.505742] Starting dynamic subtest: rcs0
[53.566132] Dynamic subtest rcs0: SUCCESS (0.062s)
[53.567227] Subtest basic-await: SUCCESS (0.063s)
[53.996779] [024/171] (948s left) gem_exec_fence (nb-await)
[54.258344] Starting subtest: nb-await
[54.259495] Starting dynamic subtest: rcs0
[54.309237] Dynamic subtest rcs0: SUCCESS (0.052s)
[54.310492] Subtest nb-await: SUCCESS (0.053s)
[54.748690] [025/171] (947s left) gem_exec_gttfill (basic)
[54.882691] Starting subtest: basic
[58.266912] Subtest basic: SUCCESS (3.383s)
[58.449359] [026/171] (944s left) gem_exec_parallel (engines)
[58.691655] Starting subtest: engines
[58.692830] Starting dynamic subtest: basic
[60.467285] Dynamic subtest basic: SUCCESS (1.774s)
[60.475109] Starting dynamic subtest: contexts
[60.479766] Dynamic subtest contexts: SKIP (0.001s)
[60.487766] Starting dynamic subtest: fds
[60.490306] Dynamic subtest fds: SKIP (0.001s)
[60.497535] Starting dynamic subtest: userptr
[62.278514] Dynamic subtest userptr: SUCCESS (1.811s)
[62.279598] Subtest engines: SUCCESS (3.587s)
[62.461954] [027/171] (940s left) gem_exec_store (basic)
[62.600330] Starting subtest: basic
[62.617389] Subtest basic: SUCCESS (0.017s)
[62.795013] [028/171] (939s left) gem_flink_basic (bad-flink)
[62.916217] Starting subtest: bad-flink
[62.918179] Subtest bad-flink: SUCCESS (0.000s)
[62.995577] [029/171] (939s left) gem_flink_basic (bad-open)
[63.121711] Starting subtest: bad-open
[63.122769] Subtest bad-open: SUCCESS (0.000s)
[63.178686] [030/171] (939s left) gem_flink_basic (basic)
[63.309213] Starting subtest: basic
[63.310309] Subtest basic: SUCCESS (0.000s)
[63.379639] [031/171] (939s left) gem_flink_basic (double-flink)
[63.501973] Starting subtest: double-flink
[63.503070] Subtest double-flink: SUCCESS (0.000s)
[63.579351] [032/171] (939s left) gem_flink_basic (flink-lifetime)
[63.705583] Starting subtest: flink-lifetime
[63.706710] Subtest flink-lifetime: SUCCESS (0.001s)
[63.780913] [033/171] (938s left) gem_huc_copy (huc-copy)
[63.910885] Subtest huc-copy: SKIP (0.000s)
[63.931878] [034/171] (938s left) gem_linear_blits (basic)
[64.345249] Starting subtest: basic
[64.358344] Subtest basic: SUCCESS (0.012s)
[64.467752] [035/171] (938s left) gem_mmap (basic)
[64.708364] Starting subtest: basic
[64.713837] Subtest basic: SUCCESS (0.000s)
[64.787710] [036/171] (938s left) gem_mmap_gtt (basic)
[64.916388] Starting subtest: basic
[64.917543] Subtest basic: SUCCESS (0.001s)
[64.987229] [037/171] (937s left) gem_render_linear_blits (basic)
[65.116093] Starting subtest: basic
[65.165439] Subtest basic: SUCCESS (0.049s)
[65.221388] [038/171] (937s left) gem_render_tiled_blits (basic)
[65.349937] Starting subtest: basic
[65.390321] Subtest basic: SUCCESS (0.041s)
[65.439835] [039/171] (937s left) gem_ringfill (basic-all)
[65.584342] Starting subtest: basic-all
[66.691687] Subtest basic-all: SUCCESS (1.107s)
[66.757944] [040/171] (936s left) gem_softpin (allocator-basic)
[66.887292] Subtest allocator-basic: SKIP (0.000s)
[66.958234] [041/171] (935s left) gem_softpin (allocator-basic-reserve)
[67.084840] Subtest allocator-basic-reserve: SKIP (0.000s)
[67.142672] [042/171] (935s left) gem_softpin (safe-alignment)
[67.280110] Starting subtest: safe-alignment
[67.281869] Subtest safe-alignment: SUCCESS (0.014s)
[67.358027] [043/171] (935s left) gem_sync (basic-all)
[67.494747] Starting subtest: basic-all
[69.551305] Subtest basic-all: SUCCESS (2.056s)
[69.734683] [044/171] (933s left) gem_sync (basic-each)
[69.868701] Starting subtest: basic-each
[71.896674] Subtest basic-each: SUCCESS (2.028s)
[72.076351] [045/171] (930s left) gem_tiled_blits (basic)
[72.467125] Starting subtest: basic
[72.487708] Subtest basic: SUCCESS (0.021s)
[72.595368] [046/171] (930s left) gem_tiled_fence_blits (basic)
[73.139064] Starting subtest: basic
[73.150218] Subtest basic: SUCCESS (0.013s)
[73.263079] [047/171] (929s left) gem_tiled_pread_basic
[73.765352] [048/171] (929s left) gem_wait (busy@all-engines)
[73.906835] Starting subtest: busy
[73.907978] Starting dynamic subtest: all-engines
[74.419284] Dynamic subtest all-engines: SUCCESS (0.513s)
[74.420400] Subtest busy: SUCCESS (0.513s)
[74.635194] [049/171] (928s left) gem_wait (wait@all-engines)
[74.777678] Starting subtest: wait
[74.779510] Starting dynamic subtest: all-engines
[75.791313] Dynamic subtest all-engines: SUCCESS (1.013s)
[75.792418] Subtest wait: SUCCESS (1.014s)
[76.007361] [050/171] (927s left) i915_getparams_basic (basic-eu-total)
[76.131034] Starting subtest: basic-eu-total
[76.133203] Subtest basic-eu-total: SUCCESS (0.000s)
[76.190172] [051/171] (926s left) i915_getparams_basic (basic-subslice-total)
[76.316234] Starting subtest: basic-subslice-total
[76.318383] Subtest basic-subslice-total: SUCCESS (0.000s)
[76.377849] [052/171] (926s left) i915_hangman (error-state-basic)
[76.507330] Starting subtest: error-state-basic
[76.624720] Subtest error-state-basic: SUCCESS (0.116s)
[76.678117] [053/171] (926s left) i915_pciid
[76.875715] [054/171] (926s left) kms_addfb_basic (addfb25-bad-modifier)
[77.001904] Starting subtest: addfb25-bad-modifier
[77.003033] Subtest addfb25-bad-modifier: SUCCESS (0.000s)
[77.110542] [055/171] (926s left) kms_addfb_basic (addfb25-framebuffer-vs-set-tiling)
[77.239212] Starting subtest: addfb25-framebuffer-vs-set-tiling
[77.240274] Subtest addfb25-framebuffer-vs-set-tiling: SUCCESS (0.000s)
[77.344170] [056/171] (925s left) kms_addfb_basic (addfb25-modifier-no-flag)
[77.470455] Starting subtest: addfb25-modifier-no-flag
[77.471576] Subtest addfb25-modifier-no-flag: SUCCESS (0.000s)
[77.579784] [057/171] (925s left) kms_addfb_basic (addfb25-x-tiled-legacy)
[77.709394] Starting subtest: addfb25-x-tiled-legacy
[77.710449] Subtest addfb25-x-tiled-legacy: SUCCESS (0.000s)
[77.814140] [058/171] (925s left) kms_addfb_basic (addfb25-x-tiled-mismatch-legacy)
[77.942271] Starting subtest: addfb25-x-tiled-mismatch-legacy
[77.943328] Subtest addfb25-x-tiled-mismatch-legacy: SUCCESS (0.000s)
[78.047373] [059/171] (925s left) kms_addfb_basic (addfb25-yf-tiled-legacy)
[78.206150] Starting subtest: addfb25-yf-tiled-legacy
[78.207235] Subtest addfb25-yf-tiled-legacy: SUCCESS (0.000s)
[78.279825] [060/171] (925s left) kms_addfb_basic (addfb25-y-tiled-legacy)
[78.440899] Starting subtest: addfb25-y-tiled-legacy
[78.442292] Subtest addfb25-y-tiled-legacy: SUCCESS (0.001s)
[78.515037] [061/171] (924s left) kms_addfb_basic (addfb25-y-tiled-small-legacy)
[78.675251] Starting subtest: addfb25-y-tiled-small-legacy
[78.677580] Subtest addfb25-y-tiled-small-legacy: SKIP (0.000s)
[78.747884] [062/171] (924s left) kms_addfb_basic (bad-pitch-0)
[78.876350] Starting subtest: bad-pitch-0
[78.877566] Subtest bad-pitch-0: SUCCESS (0.000s)
[78.986085] [063/171] (924s left) kms_addfb_basic (bad-pitch-1024)
[79.114206] Starting subtest: bad-pitch-1024
[79.115271] Subtest bad-pitch-1024: SUCCESS (0.000s)
[79.217398] [064/171] (924s left) kms_addfb_basic (bad-pitch-128)
[79.346382] Starting subtest: bad-pitch-128
[79.347423] Subtest bad-pitch-128: SUCCESS (0.000s)
[79.451348] [065/171] (923s left) kms_addfb_basic (bad-pitch-256)
[79.578962] Starting subtest: bad-pitch-256
[79.580082] Subtest bad-pitch-256: SUCCESS (0.000s)
[79.685592] [066/171] (923s left) kms_addfb_basic (bad-pitch-32)
[79.813253] Starting subtest: bad-pitch-32
[79.814333] Subtest bad-pitch-32: SUCCESS (0.000s)
[79.919221] [067/171] (923s left) kms_addfb_basic (bad-pitch-63)
[80.047308] Starting subtest: bad-pitch-63
[80.048360] Subtest bad-pitch-63: SUCCESS (0.000s)
[80.154507] [068/171] (923s left) kms_addfb_basic (bad-pitch-65536)
[80.282301] Starting subtest: bad-pitch-65536
[80.283420] Subtest bad-pitch-65536: SUCCESS (0.000s)
[80.387926] [069/171] (923s left) kms_addfb_basic (bad-pitch-999)
[80.516121] Starting subtest: bad-pitch-999
[80.517235] Subtest bad-pitch-999: SUCCESS (0.000s)
[80.621551] [070/171] (922s left) kms_addfb_basic (basic)
[80.748143] Starting subtest: basic
[80.749213] Subtest basic: SUCCESS (0.000s)
[80.840685] [071/171] (922s left) kms_addfb_basic (basic-x-tiled-legacy)
[80.966810] Starting subtest: basic-x-tiled-legacy
[80.967925] Subtest basic-x-tiled-legacy: SUCCESS (0.000s)
[81.073886] [072/171] (922s left) kms_addfb_basic (basic-y-tiled-legacy)
[81.200847] Starting subtest: basic-y-tiled-legacy
[81.201929] Subtest basic-y-tiled-legacy: SUCCESS (0.000s)
[81.292533] [073/171] (922s left) kms_addfb_basic (bo-too-small)
[81.452264] Starting subtest: bo-too-small
[81.453407] Subtest bo-too-small: SUCCESS (0.001s)
[81.525286] [074/171] (922s left) kms_addfb_basic (bo-too-small-due-to-tiling)
[81.686442] Starting subtest: bo-too-small-due-to-tiling
[81.687621] Subtest bo-too-small-due-to-tiling: SUCCESS (0.000s)
[81.758180] [075/171] (921s left) kms_addfb_basic (clobberred-modifier)
[81.885128] Starting subtest: clobberred-modifier
[81.886261] Subtest clobberred-modifier: SUCCESS (0.000s)
[81.995066] [076/171] (921s left) kms_addfb_basic (framebuffer-vs-set-tiling)
[82.122634] Starting subtest: framebuffer-vs-set-tiling
[82.123745] Subtest framebuffer-vs-set-tiling: SUCCESS (0.000s)
[82.228179] [077/171] (921s left) kms_addfb_basic (invalid-get-prop)
[82.355244] Starting subtest: invalid-get-prop
[82.356293] Subtest invalid-get-prop: SUCCESS (0.000s)
[82.461969] [078/171] (921s left) kms_addfb_basic (invalid-get-prop-any)
[82.589434] Starting subtest: invalid-get-prop-any
[82.590602] Subtest invalid-get-prop-any: SUCCESS (0.000s)
[82.679346] [079/171] (921s left) kms_addfb_basic (invalid-set-prop)
[82.808922] Starting subtest: invalid-set-prop
[82.810114] Subtest invalid-set-prop: SUCCESS (0.000s)
[82.913410] [080/171] (920s left) kms_addfb_basic (invalid-set-prop-any)
[83.041363] Starting subtest: invalid-set-prop-any
[83.042517] Subtest invalid-set-prop-any: SUCCESS (0.000s)
[83.147431] [081/171] (920s left) kms_addfb_basic (no-handle)
[83.272860] Starting subtest: no-handle
[83.273928] Subtest no-handle: SUCCESS (0.000s)
[83.381842] [082/171] (920s left) kms_addfb_basic (size-max)
[83.541167] Starting subtest: size-max
[83.542531] Subtest size-max: SUCCESS (0.000s)
[83.615210] [083/171] (920s left) kms_addfb_basic (small-bo)
[83.772317] Starting subtest: small-bo
[83.773533] Subtest small-bo: SUCCESS (0.001s)
[83.848850] [084/171] (919s left) kms_addfb_basic (tile-pitch-mismatch)
[83.976867] Starting subtest: tile-pitch-mismatch
[83.978001] Subtest tile-pitch-mismatch: SUCCESS (0.001s)
[84.085369] [085/171] (919s left) kms_addfb_basic (too-high)
[84.245230] Starting subtest: too-high
[84.246407] Subtest too-high: SUCCESS (0.002s)
[84.317347] [086/171] (919s left) kms_addfb_basic (too-wide)
[84.477711] Starting subtest: too-wide
[84.479108] Subtest too-wide: SUCCESS (0.000s)
[84.551579] [087/171] (919s left) kms_addfb_basic (unused-handle)
[84.677407] Starting subtest: unused-handle
[84.678500] Subtest unused-handle: SUCCESS (0.000s)
[84.769691] [088/171] (919s left) kms_addfb_basic (unused-modifier)
[84.896952] Starting subtest: unused-modifier
[84.898049] Subtest unused-modifier: SUCCESS (0.000s)
[84.987326] [089/171] (918s left) kms_addfb_basic (unused-offsets)
[85.113257] Starting subtest: unused-offsets
[85.116875] Subtest unused-offsets: SUCCESS (0.000s)
[85.221437] [090/171] (918s left) kms_addfb_basic (unused-pitches)
[85.350309] Starting subtest: unused-pitches
[85.351393] Subtest unused-pitches: SUCCESS (0.000s)
[85.454967] [091/171] (918s left) kms_busy (basic)
[85.613890] Starting subtest: basic
[85.615300] Starting dynamic subtest: flip
[86.233838] Dynamic subtest flip: SUCCESS (0.617s)
[86.252888] Starting dynamic subtest: modeset
[86.262792] Dynamic subtest modeset: SKIP (0.000s)
[86.270553] Subtest basic: SUCCESS (0.619s)
[86.334253] [092/171] (917s left) kms_chamelium_hpd (dp-hpd-fast)
[86.489731] Subtest dp-hpd-fast: SKIP (0.000s)
[86.533664] [093/171] (917s left) kms_chamelium_edid (dp-edid-read)
[86.689768] Subtest dp-edid-read: SKIP (0.000s)
[86.734286] [094/171] (917s left) kms_chamelium_frames (dp-crc-fast)
[86.892885] Subtest dp-crc-fast: SKIP (0.000s)
[86.936616] [095/171] (917s left) kms_chamelium_hpd (hdmi-hpd-fast)
[87.109708] Subtest hdmi-hpd-fast: SKIP (0.000s)
[87.135971] [096/171] (916s left) kms_chamelium_edid (hdmi-edid-read)
[87.291690] Subtest hdmi-edid-read: SKIP (0.000s)
[87.336286] [097/171] (916s left) kms_chamelium_frames (hdmi-crc-fast)
[87.492437] Subtest hdmi-crc-fast: SKIP (0.000s)
[87.537077] [098/171] (916s left) kms_chamelium_hpd (vga-hpd-fast)
[87.694349] Subtest vga-hpd-fast: SKIP (0.000s)
[87.737862] [099/171] (916s left) kms_chamelium_edid (vga-edid-read)
[87.894290] Subtest vga-edid-read: SKIP (0.000s)
[87.938420] [100/171] (916s left) kms_prop_blob (basic)
[88.063404] Starting subtest: basic
[88.064555] Subtest basic: SUCCESS (0.000s)
[88.137803] [101/171] (916s left) kms_cursor_legacy (basic-busy-flip-before-cursor-atomic)
[88.295451] Starting subtest: basic-busy-flip-before-cursor-atomic
[88.299438] Subtest basic-busy-flip-before-cursor-atomic: SKIP (0.003s)
[88.368983] [102/171] (915s left) kms_cursor_legacy (basic-busy-flip-before-cursor-legacy)
[88.512164] Starting subtest: basic-busy-flip-before-cursor-legacy
[89.520182] Subtest basic-busy-flip-before-cursor-legacy: SUCCESS (1.009s)
[89.633892] [103/171] (914s left) kms_cursor_legacy (basic-flip-after-cursor-atomic)
[89.805774] Starting subtest: basic-flip-after-cursor-atomic
[89.808048] Subtest basic-flip-after-cursor-atomic: SKIP (0.000s)
[89.880948] [104/171] (914s left) kms_cursor_legacy (basic-flip-after-cursor-legacy)
[90.042586] Starting subtest: basic-flip-after-cursor-legacy
[91.054922] Subtest basic-flip-after-cursor-legacy: SUCCESS (1.006s)
[91.167938] [105/171] (913s left) kms_cursor_legacy (basic-flip-after-cursor-varying-size)
[91.324888] Starting subtest: basic-flip-after-cursor-varying-size
[92.328314] Subtest basic-flip-after-cursor-varying-size: SUCCESS (1.001s)
[92.454849] [106/171] (911s left) kms_cursor_legacy (basic-flip-before-cursor-atomic)
[92.612873] Starting subtest: basic-flip-before-cursor-atomic
[92.615121] Subtest basic-flip-before-cursor-atomic: SKIP (0.000s)
[92.687870] [107/171] (911s left) kms_cursor_legacy (basic-flip-before-cursor-legacy)
[92.831158] Starting subtest: basic-flip-before-cursor-legacy
[93.834426] Subtest basic-flip-before-cursor-legacy: SUCCESS (1.003s)
[93.948700] [108/171] (910s left) kms_cursor_legacy (basic-flip-before-cursor-varying-size)
[94.105891] Starting subtest: basic-flip-before-cursor-varying-size
[95.106638] Subtest basic-flip-before-cursor-varying-size: SUCCESS (1.002s)
[95.224936] [109/171] (909s left) kms_flip (basic-flip-vs-dpms)
[95.365674] Starting subtest: basic-flip-vs-dpms
[95.367193] Starting dynamic subtest: A-VGA1
[96.616862] Dynamic subtest A-VGA1: SUCCESS (1.247s)
[96.626818] Starting dynamic subtest: B-VGA1
[97.802994] Dynamic subtest B-VGA1: SUCCESS (1.189s)
[97.804094] Subtest basic-flip-vs-dpms: SUCCESS (2.437s)
[97.943191] [110/171] (906s left) kms_flip (basic-flip-vs-modeset)
[98.100552] Starting subtest: basic-flip-vs-modeset
[98.101694] Starting dynamic subtest: A-VGA1
[99.396902] Dynamic subtest A-VGA1: SUCCESS (1.286s)
[99.412123] Starting dynamic subtest: B-VGA1
[100.571068] Dynamic subtest B-VGA1: SUCCESS (1.173s)
[100.572136] Subtest basic-flip-vs-modeset: SUCCESS (2.471s)
[100.715087] [111/171] (903s left) kms_flip (basic-flip-vs-wf_vblank)
[100.873294] Starting subtest: basic-flip-vs-wf_vblank
[100.874360] Starting dynamic subtest: A-VGA1
[102.422317] Dynamic subtest A-VGA1: SUCCESS (1.547s)
[102.444594] Starting dynamic subtest: B-VGA1
[103.947259] Dynamic subtest B-VGA1: SUCCESS (1.515s)
[103.954121] Subtest basic-flip-vs-wf_vblank: SUCCESS (3.075s)
[104.122896] [112/171] (900s left) kms_flip (basic-plain-flip)
[104.261554] Starting subtest: basic-plain-flip
[104.262662] Starting dynamic subtest: A-VGA1
[105.505975] Dynamic subtest A-VGA1: SUCCESS (1.243s)
[105.518894] Starting dynamic subtest: B-VGA1
[106.739107] Dynamic subtest B-VGA1: SUCCESS (1.218s)
[106.745183] Subtest basic-plain-flip: SUCCESS (2.463s)
[106.867478] [113/171] (897s left) kms_force_connector_basic (force-connector-state)
[107.056928] Starting subtest: force-connector-state
[107.258610] Subtest force-connector-state: SUCCESS (0.200s)
[107.518460] [114/171] (896s left) kms_force_connector_basic (force-edid)
[107.693175] Starting subtest: force-edid
[107.793236] Subtest force-edid: SUCCESS (0.099s)
[107.953956] [115/171] (896s left) kms_force_connector_basic (force-load-detect)
[108.143628] Starting subtest: force-load-detect
[108.363844] Subtest force-load-detect: SUCCESS (0.218s)
[108.584985] [116/171] (895s left) kms_force_connector_basic (prune-stale-modes)
[108.810440] Starting subtest: prune-stale-modes
[108.908503] Subtest prune-stale-modes: SUCCESS (0.098s)
[109.104472] [117/171] (895s left) kms_frontbuffer_tracking (basic)
[109.261950] Subtest basic: SKIP (0.000s)
[109.308213] [118/171] (895s left) kms_pipe_crc_basic (compare-crc-sanitycheck-xr24)
[109.461969] Starting subtest: compare-crc-sanitycheck-xr24
[109.463121] Starting dynamic subtest: pipe-A-VGA-1
[109.775567] Dynamic subtest pipe-A-VGA-1: SUCCESS (0.313s)
[109.796271] Starting dynamic subtest: pipe-B-VGA-1
[110.137040] Dynamic subtest pipe-B-VGA-1: SUCCESS (0.332s)
[110.138112] Subtest compare-crc-sanitycheck-xr24: SUCCESS (0.673s)
[110.261499] [119/171] (894s left) kms_pipe_crc_basic (compare-crc-sanitycheck-nv12)
[110.416768] Starting subtest: compare-crc-sanitycheck-nv12
[110.417863] Starting dynamic subtest: pipe-A-VGA-1
[110.420196] Dynamic subtest pipe-A-VGA-1: SKIP (0.000s)
[110.428309] Starting dynamic subtest: pipe-B-VGA-1
[110.430392] Dynamic subtest pipe-B-VGA-1: SKIP (0.000s)
[110.433097] Subtest compare-crc-sanitycheck-nv12: SKIP (0.003s)
[110.491538] [120/171] (894s left) kms_pipe_crc_basic (hang-read-crc)
[110.651824] Starting subtest: hang-read-crc
[110.652941] Starting dynamic subtest: pipe-A-VGA-1
[111.547941] Dynamic subtest pipe-A-VGA-1: SUCCESS (0.895s)
[111.562889] Starting dynamic subtest: pipe-B-VGA-1
[112.430233] Dynamic subtest pipe-B-VGA-1: SUCCESS (0.881s)
[112.431728] Subtest hang-read-crc: SUCCESS (1.779s)
[112.536516] [121/171] (892s left) kms_pipe_crc_basic (nonblocking-crc)
[112.693965] Starting subtest: nonblocking-crc
[112.695198] Starting dynamic subtest: pipe-A-VGA-1
[113.162708] Dynamic subtest pipe-A-VGA-1: SUCCESS (0.467s)
[113.177918] Starting dynamic subtest: pipe-B-VGA-1
[113.671395] Dynamic subtest pipe-B-VGA-1: SUCCESS (0.506s)
[113.672580] Subtest nonblocking-crc: SUCCESS (0.978s)
[113.792045] [122/171] (890s left) kms_pipe_crc_basic (nonblocking-crc-frame-sequence)
[113.949147] Starting subtest: nonblocking-crc-frame-sequence
[113.951390] Starting dynamic subtest: pipe-A-VGA-1
[114.419861] Dynamic subtest pipe-A-VGA-1: SUCCESS (0.468s)
[114.436272] Starting dynamic subtest: pipe-B-VGA-1
[114.961384] Dynamic subtest pipe-B-VGA-1: SUCCESS (0.540s)
[114.962555] Subtest nonblocking-crc-frame-sequence: SUCCESS (1.012s)
[115.080905] [123/171] (889s left) kms_pipe_crc_basic (read-crc)
[115.240106] Starting subtest: read-crc
[115.241217] Starting dynamic subtest: pipe-A-VGA-1
[115.640729] Dynamic subtest pipe-A-VGA-1: SUCCESS (0.399s)
[115.652872] Starting dynamic subtest: pipe-B-VGA-1
[116.078405] Dynamic subtest pipe-B-VGA-1: SUCCESS (0.435s)
[116.079603] Subtest read-crc: SUCCESS (0.839s)
[116.199151] [124/171] (888s left) kms_pipe_crc_basic (read-crc-frame-sequence)
[116.357901] Starting subtest: read-crc-frame-sequence
[116.360248] Starting dynamic subtest: pipe-A-VGA-1
[116.757541] Dynamic subtest pipe-A-VGA-1: SUCCESS (0.397s)
[116.774934] Starting dynamic subtest: pipe-B-VGA-1
[117.211204] Dynamic subtest pipe-B-VGA-1: SUCCESS (0.451s)
[117.212320] Subtest read-crc-frame-sequence: SUCCESS (0.854s)
[117.333058] [125/171] (887s left) kms_psr (primary_page_flip)
[117.462227] Subtest primary_page_flip: SKIP (0.000s)
[117.501980] [126/171] (887s left) kms_psr (cursor_plane_move)
[117.626538] Subtest cursor_plane_move: SKIP (0.000s)
[117.668950] [127/171] (887s left) kms_psr (sprite_plane_onoff)
[117.795619] Subtest sprite_plane_onoff: SKIP (0.000s)
[117.835978] [128/171] (886s left) kms_psr (primary_mmap_gtt)
[117.962696] Subtest primary_mmap_gtt: SKIP (0.000s)
[118.003281] [129/171] (886s left) kms_setmode (basic-clone-single-crtc)
[118.130537] Starting subtest: basic-clone-single-crtc
[118.134218] Subtest basic-clone-single-crtc: SKIP (0.000s)
[118.201054] [130/171] (886s left) i915_pm_backlight (basic-brightness)
[118.358714] Subtest basic-brightness: SKIP (0.000s)
[118.404658] [131/171] (886s left) i915_pm_rpm (basic-pci-d3-state)
[129.727723] Subtest basic-pci-d3-state: SKIP (0.000s)
[129.761865] [132/171] (875s left) i915_pm_rpm (basic-rte)
[129.882097] Starting subtest: basic-rte
[141.079332] Subtest basic-rte: SKIP (11.181s)
[141.101116] [133/171] (863s left) i915_pm_rps (basic-api)
[141.238624] Subtest basic-api: SKIP (0.000s)
[141.268442] [134/171] (863s left) prime_self_import (basic-llseek-bad)
[141.390657] Starting subtest: basic-llseek-bad
[141.392892] Subtest basic-llseek-bad: SUCCESS (0.002s)
[141.465765] [135/171] (863s left) prime_self_import (basic-llseek-size)
[141.586251] Starting subtest: basic-llseek-size
[141.594178] Subtest basic-llseek-size: SUCCESS (0.006s)
[141.665597] [136/171] (863s left) prime_self_import (basic-with_fd_dup)
[141.790193] Starting subtest: basic-with_fd_dup
[141.794038] Subtest basic-with_fd_dup: SUCCESS (0.003s)
[141.867893] [137/171] (863s left) prime_self_import (basic-with_one_bo)
[141.993159] Starting subtest: basic-with_one_bo
[141.995434] Subtest basic-with_one_bo: SUCCESS (0.004s)
[142.070757] [138/171] (862s left) prime_self_import (basic-with_one_bo_two_files)
[142.194244] Starting subtest: basic-with_one_bo_two_files
[142.196396] Subtest basic-with_one_bo_two_files: SUCCESS (0.003s)
[142.268496] [139/171] (862s left) prime_self_import (basic-with_two_bos)
[142.387205] Starting subtest: basic-with_two_bos
[142.393832] Subtest basic-with_two_bos: SUCCESS (0.005s)
[142.470576] [140/171] (862s left) prime_vgem (basic-fence-flip)
[142.616975] Starting subtest: basic-fence-flip
[143.017391] Subtest basic-fence-flip: SUCCESS (0.397s)
[143.104621] [141/171] (861s left) prime_vgem (basic-fence-mmap)
[143.236961] Starting subtest: basic-fence-mmap
[143.275189] Subtest basic-fence-mmap: SUCCESS (0.042s)
[143.355587] [142/171] (861s left) prime_vgem (basic-fence-read)
[143.486912] Starting subtest: basic-fence-read
[143.548397] Subtest basic-fence-read: SUCCESS (0.064s)
[143.625074] [143/171] (861s left) prime_vgem (basic-gtt)
[143.754200] Starting subtest: basic-gtt
[143.768656] Subtest basic-gtt: SUCCESS (0.017s)
[143.841675] [144/171] (861s left) prime_vgem (basic-read)
[143.971860] Starting subtest: basic-read
[143.996805] Subtest basic-read: SUCCESS (0.028s)
[144.076748] [145/171] (861s left) prime_vgem (basic-write)
[144.207151] Starting subtest: basic-write
[144.231965] Subtest basic-write: SUCCESS (0.030s)
[144.308836] [146/171] (860s left) vgem_basic (setversion)
[144.434137] Starting subtest: setversion
[144.436399] Subtest setversion: SUCCESS (0.000s)
[144.493510] [147/171] (860s left) vgem_basic (create)
[144.618264] Starting subtest: create
[144.619404] Subtest create: SUCCESS (0.000s)
[144.677065] [148/171] (860s left) vgem_basic (debugfs)
[144.802823] Starting subtest: debugfs
[144.803953] Subtest debugfs: SUCCESS (0.000s)
[144.860849] [149/171] (860s left) vgem_basic (dmabuf-export)
[144.987903] Starting subtest: dmabuf-export
[144.990608] Subtest dmabuf-export: SUCCESS (0.002s)
[145.062284] [150/171] (860s left) vgem_basic (dmabuf-fence)
[145.189169] Starting subtest: dmabuf-fence
[145.190270] Subtest dmabuf-fence: SUCCESS (0.001s)
[145.246150] [151/171] (860s left) vgem_basic (dmabuf-fence-before)
[145.389732] Starting subtest: dmabuf-fence-before
[145.390921] Subtest dmabuf-fence-before: SUCCESS (0.001s)
[145.446750] [152/171] (859s left) vgem_basic (dmabuf-mmap)
[145.571309] Starting subtest: dmabuf-mmap
[145.591241] Subtest dmabuf-mmap: SUCCESS (0.021s)
[145.647636] [153/171] (859s left) vgem_basic (mmap)
[145.789377] Starting subtest: mmap
[145.804741] Subtest mmap: SUCCESS (0.017s)
[145.864590] [154/171] (859s left) vgem_basic (second-client)
[145.989668] Starting subtest: second-client
[146.022928] Subtest second-client: SUCCESS (0.033s)
[146.082436] [155/171] (859s left) vgem_basic (sysfs)
[146.206544] Starting subtest: sysfs
[146.207650] Subtest sysfs: SUCCESS (0.001s)
[146.265782] [156/171] (859s left) core_hotunplug (unbind-rebind)
[146.439296] Starting subtest: unbind-rebind
[147.211797] Subtest unbind-rebind: SUCCESS (0.772s)
[147.265940] [157/171] (858s left) vgem_basic (unload)
[147.449863] Starting subtest: unload
[176.459442] Subtest unload: SUCCESS (29.009s)
[176.556125] [158/171] (828s left) i915_module_load (reload)
[176.680257] Starting subtest: reload
[178.595270] Subtest reload: SUCCESS (1.916s)
[178.635386] [159/171] (826s left) gem_lmem_swapping (basic)
[178.785778] Subtest basic: SKIP (0.000s)
[178.823915] [160/171] (826s left) gem_lmem_swapping (parallel-random-engines)
[179.048380] Subtest parallel-random-engines: SKIP (0.000s)
[179.119477] [161/171] (826s left) gem_lmem_swapping (random-engines)
[179.253451] Subtest random-engines: SKIP (0.000s)
[179.292413] [162/171] (826s left) gem_lmem_swapping (verify-random)
[179.418991] Subtest verify-random: SKIP (0.000s)
[179.441586] [163/171] (826s left) i915_pm_rpm (module-reload)
[190.758647] Subtest module-reload: SKIP (0.000s)
[190.783564] [164/171] (814s left) i915_selftest (live)
[191.521078] Starting subtest: live
[191.522165] Starting dynamic subtest: sanitycheck
[192.237195] Dynamic subtest sanitycheck: SUCCESS (0.717s)
[192.248685] Starting dynamic subtest: uncore
[192.909935] Dynamic subtest uncore: SUCCESS (0.671s)
[192.920550] Starting dynamic subtest: workarounds
[193.555674] Dynamic subtest workarounds: SUCCESS (0.645s)
[193.566819] Starting dynamic subtest: gt_engines
[194.208058] Dynamic subtest gt_engines: SUCCESS (0.651s)
[194.219305] Starting dynamic subtest: gt_timelines
[197.118026] Dynamic subtest gt_timelines: SUCCESS (2.907s)
[197.127631] Starting dynamic subtest: gt_contexts
[197.763843] Dynamic subtest gt_contexts: SUCCESS (0.647s)
[197.774724] Starting dynamic subtest: gt_lrc
[198.418785] Dynamic subtest gt_lrc: SUCCESS (0.654s)
[198.430469] Starting dynamic subtest: gt_mocs
[199.057348] Dynamic subtest gt_mocs: SUCCESS (0.638s)
[199.067844] Starting dynamic subtest: gt_pm
[200.195103] Dynamic subtest gt_pm: SUCCESS (1.136s)
[200.206868] Starting dynamic subtest: gt_heartbeat
[200.856645] Dynamic subtest gt_heartbeat: SUCCESS (0.661s)
[200.864952] Starting dynamic subtest: gt_tlb
[201.494445] Dynamic subtest gt_tlb: SUCCESS (0.637s)
[201.505082] Starting dynamic subtest: requests
[204.716993] Dynamic subtest requests: SUCCESS (3.220s)
[204.727305] Starting dynamic subtest: migrate
[205.407875] Dynamic subtest migrate: SUCCESS (0.689s)
[205.415956] Starting dynamic subtest: active
[206.053597] Dynamic subtest active: SUCCESS (0.646s)
[206.065372] Starting dynamic subtest: objects
[207.010164] Dynamic subtest objects: SUCCESS (0.955s)
[207.021840] Starting dynamic subtest: mman
[211.907970] Dynamic subtest mman: SUCCESS (4.897s)
[211.916159] Starting dynamic subtest: dmabuf
[212.597855] Dynamic subtest dmabuf: SUCCESS (0.688s)
[212.609117] Starting dynamic subtest: vma
[213.255560] Dynamic subtest vma: SUCCESS (0.657s)
[213.266616] Starting dynamic subtest: coherency
[215.037102] Dynamic subtest coherency: SUCCESS (1.779s)
[215.046961] Starting dynamic subtest: gtt
[219.270061] Dynamic subtest gtt: SUCCESS (4.233s)
[219.281181] Starting dynamic subtest: gem
[219.982132] Dynamic subtest gem: SUCCESS (0.711s)
[219.993428] Starting dynamic subtest: evict
[220.639615] Dynamic subtest evict: SUCCESS (0.657s)
[220.650260] Starting dynamic subtest: hugepages
[221.282899] Dynamic subtest hugepages: SUCCESS (0.642s)
[221.293250] Starting dynamic subtest: gem_contexts
[221.902413] Dynamic subtest gem_contexts: SUCCESS (0.619s)
[221.912909] Starting dynamic subtest: client
[222.551585] Dynamic subtest client: SUCCESS (0.647s)
[222.563230] Starting dynamic subtest: gem_migrate
[223.205990] Dynamic subtest gem_migrate: SUCCESS (0.653s)
[223.216739] Starting dynamic subtest: reset
[224.210214] Dynamic subtest reset: SUCCESS (1.003s)
[224.221775] Starting dynamic subtest: memory_region
[224.822462] Dynamic subtest memory_region: SUCCESS (0.611s)
[224.829256] Starting dynamic subtest: hangcheck
[226.493979] Dynamic subtest hangcheck: SUCCESS (1.669s)
[226.504068] Starting dynamic subtest: execlists
[227.151404] Dynamic subtest execlists: SUCCESS (0.657s)
[227.162370] Starting dynamic subtest: ring_submission
[227.806688] Dynamic subtest ring_submission: SUCCESS (0.654s)
[227.817184] Starting dynamic subtest: perf
[228.455596] Dynamic subtest perf: SUCCESS (0.647s)
[228.467078] Starting dynamic subtest: slpc
[229.170970] Dynamic subtest slpc: SUCCESS (0.713s)
[229.180803] Starting dynamic subtest: guc
[229.822791] Dynamic subtest guc: SUCCESS (0.652s)
[229.833073] Starting dynamic subtest: guc_multi_lrc
[230.467302] Dynamic subtest guc_multi_lrc: SUCCESS (0.643s)
[230.478251] Starting dynamic subtest: guc_hang
[231.126760] Dynamic subtest guc_hang: SUCCESS (0.658s)
[231.137132] Starting dynamic subtest: late_gt_pm
[231.805157] Dynamic subtest late_gt_pm: SUCCESS (0.677s)
[231.808737] Subtest live: SUCCESS (40.286s)
[231.950536] [165/171] (773s left) dmabuf (all-tests)
[232.077578] Starting subtest: all-tests
[232.082722] Starting dynamic subtest: sanitycheck
[232.143606] Dynamic subtest sanitycheck: SUCCESS (0.064s)
[232.152379] Starting dynamic subtest: dma_fence
[232.329801] Dynamic subtest dma_fence: SUCCESS (0.184s)
[232.342814] Starting dynamic subtest: dma_fence_chain
[249.794818] Dynamic subtest dma_fence_chain: SUCCESS (17.464s)
[249.809674] Starting dynamic subtest: dma_fence_unwrap
[249.854191] Dynamic subtest dma_fence_unwrap: SUCCESS (0.061s)
[249.867702] Starting dynamic subtest: dma_resv
[249.915139] Dynamic subtest dma_resv: SUCCESS (0.060s)
[249.918457] Subtest all-tests: SUCCESS (17.839s)
[249.935287] [166/171] (755s left) i915_suspend (basic-s2idle-without-i915)
[250.055257] Starting subtest: basic-s2idle-without-i915
[268.441911] Subtest basic-s2idle-without-i915: SUCCESS (18.388s)
[271.078666] [167/171] (737s left) i915_suspend (basic-s3-without-i915)
[271.205407] Starting subtest: basic-s3-without-i915
[288.197289] Subtest basic-s3-without-i915: SUCCESS (2.268s)
[291.291203] [168/171] (734s left) gem_exec_suspend (basic-s0)
[291.433238] Starting subtest: basic-S0
[291.435151] Starting dynamic subtest: smem
[309.102028] Dynamic subtest smem: SUCCESS (17.669s)
[309.103222] Subtest basic-S0: SUCCESS (17.671s)
[313.837904] [169/171] (716s left) gem_exec_suspend (basic-s3)
[313.976197] Starting subtest: basic-S3
[313.977802] Starting dynamic subtest: smem
[331.908434] Dynamic subtest smem: SUCCESS (1.885s)
[331.909424] Subtest basic-S3: SUCCESS (1.887s)
[335.102105] [170/171] (714s left) kms_chamelium_hpd (common-hpd-after-suspend)
[335.264854] Subtest common-hpd-after-suspend: SKIP (0.000s)
[335.336932] [171/171] (714s left) kms_pipe_crc_basic (suspend-read-crc)
[335.486438] Starting subtest: suspend-read-crc
[335.487575] Starting dynamic subtest: pipe-A-VGA-1
[353.076283] Dynamic subtest pipe-A-VGA-1: SUCCESS (1.897s)
[353.095148] Starting dynamic subtest: pipe-B-VGA-1
[371.017643] Dynamic subtest pipe-B-VGA-1: SUCCESS (1.817s)
[371.019239] Subtest suspend-read-crc: SUCCESS (3.730s)
[374.150906] Closing watchdogs
Done.