[35.068828] Initializing watchdogs
[35.068976]   /dev/watchdog0
[35.076990] [001/171] (960s left) i915_module_load (load)
[35.207455] Starting subtest: load
[36.829239] Subtest load: SUCCESS (1.622s)
[36.857523] [002/171] (958s left) core_auth (basic-auth)
[37.016129] Starting subtest: basic-auth
[37.018516] Subtest basic-auth: SUCCESS (0.001s)
[37.089449] [003/171] (958s left) debugfs_test (read_all_entries)
[37.268803] Starting subtest: read_all_entries
[37.407693] Subtest read_all_entries: SUCCESS (0.131s)
[37.541961] [004/171] (958s left) debugfs_test (basic-hwmon)
[37.675790] Starting subtest: basic-hwmon
[37.677983] Subtest basic-hwmon: SKIP (0.000s)
[37.790800] [005/171] (957s left) fbdev (eof)
[37.918980] Starting subtest: eof
[37.920846] Subtest eof: SUCCESS (0.001s)
[37.975852] [006/171] (957s left) fbdev (info)
[38.096168] Starting subtest: info
[38.097316] Subtest info: SUCCESS (0.000s)
[38.159348] [007/171] (957s left) fbdev (nullptr)
[38.286045] Starting subtest: nullptr
[38.287351] Subtest nullptr: SUCCESS (0.000s)
[38.344561] [008/171] (957s left) fbdev (read)
[38.469057] Starting subtest: read
[38.703059] Subtest read: SUCCESS (0.232s)
[38.760564] [009/171] (956s left) fbdev (write)
[38.886813] Starting subtest: write
[39.009934] Subtest write: SUCCESS (0.122s)
[39.061070] [010/171] (956s left) gem_basic (bad-close)
[39.187049] Starting subtest: bad-close
[39.189829] Subtest bad-close: SUCCESS (0.000s)
[39.249217] [011/171] (956s left) gem_basic (create-close)
[39.416753] Starting subtest: create-close
[39.418998] Subtest create-close: SUCCESS (0.000s)
[39.496379] [012/171] (956s left) gem_basic (create-fd-close)
[39.621749] Starting subtest: create-fd-close
[39.624389] Subtest create-fd-close: SUCCESS (0.000s)
[39.698355] [013/171] (956s left) gem_busy (busy@all-engines)
[39.837363] Starting subtest: busy
[39.842444] Starting dynamic subtest: all-engines
[39.863970] Dynamic subtest all-engines: SUCCESS (0.025s)
[39.865945] Subtest busy: SUCCESS (0.026s)
[40.183327] [014/171] (955s left) gem_close_race (basic-process)
[40.326407] Starting subtest: basic-process
[40.367399] Subtest basic-process: SUCCESS (0.044s)
[40.551977] [015/171] (955s left) gem_close_race (basic-threads)
[40.693796] Starting subtest: basic-threads
[41.827826] Subtest basic-threads: SUCCESS (1.134s)
[42.006412] [016/171] (953s left) gem_ctx_create (basic)
[42.137837] Subtest basic: SKIP (0.000s)
[42.175692] [017/171] (953s left) gem_ctx_create (basic-files)
[42.303801] Subtest basic-files: SKIP (0.000s)
[42.324311] [018/171] (953s left) gem_ctx_exec (basic)
[42.455264] Subtest basic: SKIP (0.000s)
[42.508815] [019/171] (953s left) gem_exec_basic (basic)
[42.641658] Starting subtest: basic
[42.642810] Starting dynamic subtest: rcs0-smem
[42.643885] Dynamic subtest rcs0-smem: SUCCESS (0.000s)
[42.645032] Subtest basic: SUCCESS (0.002s)
[42.826259] [020/171] (953s left) gem_exec_create (basic)
[42.961323] Starting subtest: basic
[42.962802] Starting dynamic subtest: smem
[45.004375] Dynamic subtest smem: SUCCESS (2.043s)
[45.005538] Subtest basic: SUCCESS (2.043s)
[45.184437] [021/171] (950s left) gem_exec_fence (basic-busy)
[45.445436] Starting subtest: basic-busy
[45.446601] Starting dynamic subtest: rcs0
[45.457336] Dynamic subtest rcs0: SUCCESS (0.014s)
[45.458485] Subtest basic-busy: SUCCESS (0.014s)
[45.953156] [022/171] (950s left) gem_exec_fence (basic-wait)
[46.213272] Starting subtest: basic-wait
[46.214314] Starting dynamic subtest: rcs0
[46.222318] Dynamic subtest rcs0: SUCCESS (0.010s)
[46.223414] Subtest basic-wait: SUCCESS (0.011s)
[46.656382] [023/171] (949s left) gem_exec_fence (basic-await)
[46.917563] Starting subtest: basic-await
[46.918647] Starting dynamic subtest: rcs0
[46.979189] Dynamic subtest rcs0: SUCCESS (0.063s)
[46.980213] Subtest basic-await: SUCCESS (0.063s)
[47.425118] [024/171] (948s left) gem_exec_fence (nb-await)
[47.687455] Starting subtest: nb-await
[47.688656] Starting dynamic subtest: rcs0
[47.738887] Dynamic subtest rcs0: SUCCESS (0.053s)
[47.740291] Subtest nb-await: SUCCESS (0.054s)
[48.178842] [025/171] (947s left) gem_exec_gttfill (basic)
[48.319047] Starting subtest: basic
[51.527228] Subtest basic: SUCCESS (3.211s)
[51.712566] [026/171] (944s left) gem_exec_parallel (engines)
[51.961417] Starting subtest: engines
[51.962889] Starting dynamic subtest: basic
[53.761816] Dynamic subtest basic: SUCCESS (1.801s)
[53.773897] Starting dynamic subtest: contexts
[53.776536] Dynamic subtest contexts: SKIP (0.001s)
[53.784076] Starting dynamic subtest: fds
[53.786124] Dynamic subtest fds: SKIP (0.000s)
[53.793712] Starting dynamic subtest: userptr
[55.637909] Dynamic subtest userptr: SUCCESS (1.874s)
[55.639076] Subtest engines: SUCCESS (3.677s)
[55.821839] [027/171] (940s left) gem_exec_store (basic)
[55.958220] Starting subtest: basic
[55.978302] Subtest basic: SUCCESS (0.020s)
[56.156391] [028/171] (940s left) gem_flink_basic (bad-flink)
[56.278127] Starting subtest: bad-flink
[56.279261] Subtest bad-flink: SUCCESS (0.000s)
[56.340360] [029/171] (939s left) gem_flink_basic (bad-open)
[56.465746] Starting subtest: bad-open
[56.466878] Subtest bad-open: SUCCESS (0.000s)
[56.540939] [030/171] (939s left) gem_flink_basic (basic)
[56.665184] Starting subtest: basic
[56.666271] Subtest basic: SUCCESS (0.000s)
[56.740763] [031/171] (939s left) gem_flink_basic (double-flink)
[56.864105] Starting subtest: double-flink
[56.865246] Subtest double-flink: SUCCESS (0.000s)
[56.941589] [032/171] (939s left) gem_flink_basic (flink-lifetime)
[57.064780] Starting subtest: flink-lifetime
[57.065857] Subtest flink-lifetime: SUCCESS (0.001s)
[57.142185] [033/171] (939s left) gem_huc_copy (huc-copy)
[57.266669] Subtest huc-copy: SKIP (0.000s)
[57.312312] [034/171] (938s left) gem_linear_blits (basic)
[57.718068] Starting subtest: basic
[57.729495] Subtest basic: SUCCESS (0.013s)
[57.845387] [035/171] (938s left) gem_mmap (basic)
[58.088066] Starting subtest: basic
[58.093624] Subtest basic: SUCCESS (0.000s)
[58.162605] [036/171] (938s left) gem_mmap_gtt (basic)
[58.291269] Starting subtest: basic
[58.292335] Subtest basic: SUCCESS (0.001s)
[58.366811] [037/171] (938s left) gem_render_linear_blits (basic)
[58.490297] Starting subtest: basic
[58.539442] Subtest basic: SUCCESS (0.049s)
[58.583272] [038/171] (937s left) gem_render_tiled_blits (basic)
[58.708588] Starting subtest: basic
[58.753036] Subtest basic: SUCCESS (0.041s)
[58.781645] [039/171] (937s left) gem_ringfill (basic-all)
[58.927945] Starting subtest: basic-all
[60.028195] Subtest basic-all: SUCCESS (1.100s)
[60.103516] [040/171] (936s left) gem_softpin (allocator-basic)
[60.231284] Subtest allocator-basic: SKIP (0.000s)
[60.304249] [041/171] (936s left) gem_softpin (allocator-basic-reserve)
[60.429565] Subtest allocator-basic-reserve: SKIP (0.000s)
[60.503216] [042/171] (935s left) gem_softpin (safe-alignment)
[60.633127] Starting subtest: safe-alignment
[60.634172] Subtest safe-alignment: SUCCESS (0.006s)
[60.704903] [043/171] (935s left) gem_sync (basic-all)
[60.840050] Starting subtest: basic-all
[62.911589] Subtest basic-all: SUCCESS (2.071s)
[63.097371] [044/171] (933s left) gem_sync (basic-each)
[63.233993] Starting subtest: basic-each
[65.270227] Subtest basic-each: SUCCESS (2.036s)
[65.455437] [045/171] (931s left) gem_tiled_blits (basic)
[65.850124] Starting subtest: basic
[65.871736] Subtest basic: SUCCESS (0.021s)
[65.970697] [046/171] (930s left) gem_tiled_fence_blits (basic)
[66.530225] Starting subtest: basic
[66.541665] Subtest basic: SUCCESS (0.013s)
[66.660807] [047/171] (929s left) gem_tiled_pread_basic
[67.161225] [048/171] (929s left) gem_wait (busy@all-engines)
[67.322034] Starting subtest: busy
[67.323579] Starting dynamic subtest: all-engines
[67.835280] Dynamic subtest all-engines: SUCCESS (0.514s)
[67.836287] Subtest busy: SUCCESS (0.515s)
[68.047378] [049/171] (928s left) gem_wait (wait@all-engines)
[68.188097] Starting subtest: wait
[68.190144] Starting dynamic subtest: all-engines
[69.203077] Dynamic subtest all-engines: SUCCESS (1.015s)
[69.204225] Subtest wait: SUCCESS (1.016s)
[69.418421] [050/171] (927s left) i915_getparams_basic (basic-eu-total)
[69.543112] Starting subtest: basic-eu-total
[69.545233] Subtest basic-eu-total: SUCCESS (0.000s)
[69.618208] [051/171] (927s left) i915_getparams_basic (basic-subslice-total)
[69.742089] Starting subtest: basic-subslice-total
[69.744121] Subtest basic-subslice-total: SUCCESS (0.000s)
[69.803527] [052/171] (926s left) i915_hangman (error-state-basic)
[69.933791] Starting subtest: error-state-basic
[70.033332] Subtest error-state-basic: SUCCESS (0.100s)
[70.087285] [053/171] (926s left) i915_pciid
[70.285498] [054/171] (926s left) kms_addfb_basic (addfb25-bad-modifier)
[70.416214] Starting subtest: addfb25-bad-modifier
[70.418206] Subtest addfb25-bad-modifier: SUCCESS (0.001s)
[70.538267] [055/171] (926s left) kms_addfb_basic (addfb25-framebuffer-vs-set-tiling)
[70.666809] Starting subtest: addfb25-framebuffer-vs-set-tiling
[70.667939] Subtest addfb25-framebuffer-vs-set-tiling: SUCCESS (0.000s)
[70.771849] [056/171] (926s left) kms_addfb_basic (addfb25-modifier-no-flag)
[70.900782] Starting subtest: addfb25-modifier-no-flag
[70.901870] Subtest addfb25-modifier-no-flag: SUCCESS (0.000s)
[71.008993] [057/171] (925s left) kms_addfb_basic (addfb25-x-tiled-legacy)
[71.139650] Starting subtest: addfb25-x-tiled-legacy
[71.140777] Subtest addfb25-x-tiled-legacy: SUCCESS (0.000s)
[71.240827] [058/171] (925s left) kms_addfb_basic (addfb25-x-tiled-mismatch-legacy)
[71.369903] Starting subtest: addfb25-x-tiled-mismatch-legacy
[71.371078] Subtest addfb25-x-tiled-mismatch-legacy: SUCCESS (0.000s)
[71.474056] [059/171] (925s left) kms_addfb_basic (addfb25-yf-tiled-legacy)
[71.633164] Starting subtest: addfb25-yf-tiled-legacy
[71.634397] Subtest addfb25-yf-tiled-legacy: SUCCESS (0.001s)
[71.706536] [060/171] (925s left) kms_addfb_basic (addfb25-y-tiled-legacy)
[71.867363] Starting subtest: addfb25-y-tiled-legacy
[71.868610] Subtest addfb25-y-tiled-legacy: SUCCESS (0.001s)
[71.941135] [061/171] (924s left) kms_addfb_basic (addfb25-y-tiled-small-legacy)
[72.102213] Starting subtest: addfb25-y-tiled-small-legacy
[72.104813] Subtest addfb25-y-tiled-small-legacy: SKIP (0.000s)
[72.175132] [062/171] (924s left) kms_addfb_basic (bad-pitch-0)
[72.297599] Starting subtest: bad-pitch-0
[72.298681] Subtest bad-pitch-0: SUCCESS (0.000s)
[72.410930] [063/171] (924s left) kms_addfb_basic (bad-pitch-1024)
[72.542959] Starting subtest: bad-pitch-1024
[72.544100] Subtest bad-pitch-1024: SUCCESS (0.000s)
[72.643359] [064/171] (924s left) kms_addfb_basic (bad-pitch-128)
[72.770340] Starting subtest: bad-pitch-128
[72.771460] Subtest bad-pitch-128: SUCCESS (0.000s)
[72.879751] [065/171] (924s left) kms_addfb_basic (bad-pitch-256)
[73.007835] Starting subtest: bad-pitch-256
[73.008903] Subtest bad-pitch-256: SUCCESS (0.000s)
[73.113404] [066/171] (923s left) kms_addfb_basic (bad-pitch-32)
[73.240534] Starting subtest: bad-pitch-32
[73.241688] Subtest bad-pitch-32: SUCCESS (0.000s)
[73.346555] [067/171] (923s left) kms_addfb_basic (bad-pitch-63)
[73.475106] Starting subtest: bad-pitch-63
[73.476179] Subtest bad-pitch-63: SUCCESS (0.000s)
[73.581361] [068/171] (923s left) kms_addfb_basic (bad-pitch-65536)
[73.703414] Starting subtest: bad-pitch-65536
[73.704619] Subtest bad-pitch-65536: SUCCESS (0.000s)
[73.815902] [069/171] (923s left) kms_addfb_basic (bad-pitch-999)
[73.950112] Starting subtest: bad-pitch-999
[73.951140] Subtest bad-pitch-999: SUCCESS (0.000s)
[74.049379] [070/171] (923s left) kms_addfb_basic (basic)
[74.178358] Starting subtest: basic
[74.179419] Subtest basic: SUCCESS (0.000s)
[74.284530] [071/171] (922s left) kms_addfb_basic (basic-x-tiled-legacy)
[74.411881] Starting subtest: basic-x-tiled-legacy
[74.413037] Subtest basic-x-tiled-legacy: SUCCESS (0.000s)
[74.516837] [072/171] (922s left) kms_addfb_basic (basic-y-tiled-legacy)
[74.646826] Starting subtest: basic-y-tiled-legacy
[74.647903] Subtest basic-y-tiled-legacy: SUCCESS (0.000s)
[74.754195] [073/171] (922s left) kms_addfb_basic (bo-too-small)
[74.910420] Starting subtest: bo-too-small
[74.911778] Subtest bo-too-small: SUCCESS (0.000s)
[74.985823] [074/171] (922s left) kms_addfb_basic (bo-too-small-due-to-tiling)
[75.144143] Starting subtest: bo-too-small-due-to-tiling
[75.145323] Subtest bo-too-small-due-to-tiling: SUCCESS (0.000s)
[75.219281] [075/171] (921s left) kms_addfb_basic (clobberred-modifier)
[75.347490] Starting subtest: clobberred-modifier
[75.348608] Subtest clobberred-modifier: SUCCESS (0.000s)
[75.455640] [076/171] (921s left) kms_addfb_basic (framebuffer-vs-set-tiling)
[75.583785] Starting subtest: framebuffer-vs-set-tiling
[75.584900] Subtest framebuffer-vs-set-tiling: SUCCESS (0.000s)
[75.689294] [077/171] (921s left) kms_addfb_basic (invalid-get-prop)
[75.812992] Starting subtest: invalid-get-prop
[75.814196] Subtest invalid-get-prop: SUCCESS (0.000s)
[75.924911] [078/171] (921s left) kms_addfb_basic (invalid-get-prop-any)
[76.049098] Starting subtest: invalid-get-prop-any
[76.050160] Subtest invalid-get-prop-any: SUCCESS (0.000s)
[76.157381] [079/171] (921s left) kms_addfb_basic (invalid-set-prop)
[76.284031] Starting subtest: invalid-set-prop
[76.285104] Subtest invalid-set-prop: SUCCESS (0.000s)
[76.390870] [080/171] (920s left) kms_addfb_basic (invalid-set-prop-any)
[76.520614] Starting subtest: invalid-set-prop-any
[76.521709] Subtest invalid-set-prop-any: SUCCESS (0.000s)
[76.625626] [081/171] (920s left) kms_addfb_basic (no-handle)
[76.754703] Starting subtest: no-handle
[76.755837] Subtest no-handle: SUCCESS (0.000s)
[76.859333] [082/171] (920s left) kms_addfb_basic (size-max)
[77.016181] Starting subtest: size-max
[77.017372] Subtest size-max: SUCCESS (0.000s)
[77.092357] [083/171] (920s left) kms_addfb_basic (small-bo)
[77.251361] Starting subtest: small-bo
[77.252525] Subtest small-bo: SUCCESS (0.000s)
[77.326509] [084/171] (920s left) kms_addfb_basic (tile-pitch-mismatch)
[77.453633] Starting subtest: tile-pitch-mismatch
[77.454735] Subtest tile-pitch-mismatch: SUCCESS (0.000s)
[77.561411] [085/171] (919s left) kms_addfb_basic (too-high)
[77.720419] Starting subtest: too-high
[77.721735] Subtest too-high: SUCCESS (0.002s)
[77.793513] [086/171] (919s left) kms_addfb_basic (too-wide)
[77.954198] Starting subtest: too-wide
[77.955374] Subtest too-wide: SUCCESS (0.001s)
[78.028745] [087/171] (919s left) kms_addfb_basic (unused-handle)
[78.157280] Starting subtest: unused-handle
[78.158428] Subtest unused-handle: SUCCESS (0.000s)
[78.263891] [088/171] (919s left) kms_addfb_basic (unused-modifier)
[78.391327] Starting subtest: unused-modifier
[78.392580] Subtest unused-modifier: SUCCESS (0.000s)
[78.498120] [089/171] (919s left) kms_addfb_basic (unused-offsets)
[78.628162] Starting subtest: unused-offsets
[78.629248] Subtest unused-offsets: SUCCESS (0.000s)
[78.732593] [090/171] (918s left) kms_addfb_basic (unused-pitches)
[78.861289] Starting subtest: unused-pitches
[78.862406] Subtest unused-pitches: SUCCESS (0.000s)
[78.967653] [091/171] (918s left) kms_busy (basic)
[79.124462] Starting subtest: basic
[79.127163] Starting dynamic subtest: flip
[79.790975] Dynamic subtest flip: SUCCESS (0.664s)
[79.804828] Starting dynamic subtest: modeset
[79.806894] Dynamic subtest modeset: SKIP (0.000s)
[79.807982] Subtest basic: SUCCESS (0.668s)
[79.904102] [092/171] (917s left) kms_chamelium_hpd (dp-hpd-fast)
[80.056282] Subtest dp-hpd-fast: SKIP (0.000s)
[80.100465] [093/171] (917s left) kms_chamelium_edid (dp-edid-read)
[80.256411] Subtest dp-edid-read: SKIP (0.000s)
[80.300882] [094/171] (917s left) kms_chamelium_frames (dp-crc-fast)
[80.458766] Subtest dp-crc-fast: SKIP (0.000s)
[80.501343] [095/171] (917s left) kms_chamelium_hpd (hdmi-hpd-fast)
[80.659526] Subtest hdmi-hpd-fast: SKIP (0.000s)
[80.701926] [096/171] (916s left) kms_chamelium_edid (hdmi-edid-read)
[80.859966] Subtest hdmi-edid-read: SKIP (0.000s)
[80.902767] [097/171] (916s left) kms_chamelium_frames (hdmi-crc-fast)
[81.059649] Subtest hdmi-crc-fast: SKIP (0.000s)
[81.103431] [098/171] (916s left) kms_chamelium_hpd (vga-hpd-fast)
[81.261621] Subtest vga-hpd-fast: SKIP (0.000s)
[81.304151] [099/171] (916s left) kms_chamelium_edid (vga-edid-read)
[81.461284] Subtest vga-edid-read: SKIP (0.000s)
[81.504915] [100/171] (916s left) kms_prop_blob (basic)
[81.629130] Starting subtest: basic
[81.630251] Subtest basic: SUCCESS (0.000s)
[81.705055] [101/171] (916s left) kms_cursor_legacy (basic-busy-flip-before-cursor-atomic)
[81.862723] Starting subtest: basic-busy-flip-before-cursor-atomic
[81.868271] Subtest basic-busy-flip-before-cursor-atomic: SKIP (0.004s)
[81.938124] [102/171] (915s left) kms_cursor_legacy (basic-busy-flip-before-cursor-legacy)
[82.098318] Starting subtest: basic-busy-flip-before-cursor-legacy
[83.111270] Subtest basic-busy-flip-before-cursor-legacy: SUCCESS (1.013s)
[83.241478] [103/171] (914s left) kms_cursor_legacy (basic-flip-after-cursor-atomic)
[83.397518] Starting subtest: basic-flip-after-cursor-atomic
[83.400115] Subtest basic-flip-after-cursor-atomic: SKIP (0.000s)
[83.473756] [104/171] (914s left) kms_cursor_legacy (basic-flip-after-cursor-legacy)
[83.632698] Starting subtest: basic-flip-after-cursor-legacy
[84.644108] Subtest basic-flip-after-cursor-legacy: SUCCESS (1.006s)
[84.764544] [105/171] (913s left) kms_cursor_legacy (basic-flip-after-cursor-varying-size)
[84.920875] Starting subtest: basic-flip-after-cursor-varying-size
[85.923523] Subtest basic-flip-after-cursor-varying-size: SUCCESS (1.003s)
[86.051833] [106/171] (911s left) kms_cursor_legacy (basic-flip-before-cursor-atomic)
[86.210112] Starting subtest: basic-flip-before-cursor-atomic
[86.212211] Subtest basic-flip-before-cursor-atomic: SKIP (0.000s)
[86.284596] [107/171] (911s left) kms_cursor_legacy (basic-flip-before-cursor-legacy)
[86.444156] Starting subtest: basic-flip-before-cursor-legacy
[87.446918] Subtest basic-flip-before-cursor-legacy: SUCCESS (1.003s)
[87.561943] [108/171] (910s left) kms_cursor_legacy (basic-flip-before-cursor-varying-size)
[87.718538] Starting subtest: basic-flip-before-cursor-varying-size
[88.725926] Subtest basic-flip-before-cursor-varying-size: SUCCESS (1.006s)
[88.842484] [109/171] (909s left) kms_flip (basic-flip-vs-dpms)
[89.000748] Starting subtest: basic-flip-vs-dpms
[89.002019] Starting dynamic subtest: A-VGA1
[90.301418] Dynamic subtest A-VGA1: SUCCESS (1.299s)
[90.323965] Starting dynamic subtest: B-VGA1
[91.566299] Dynamic subtest B-VGA1: SUCCESS (1.254s)
[91.572928] Subtest basic-flip-vs-dpms: SUCCESS (2.565s)
[91.730765] [110/171] (906s left) kms_flip (basic-flip-vs-modeset)
[91.886585] Starting subtest: basic-flip-vs-modeset
[91.887776] Starting dynamic subtest: A-VGA1
[93.209634] Dynamic subtest A-VGA1: SUCCESS (1.321s)
[93.221801] Starting dynamic subtest: B-VGA1
[94.477766] Dynamic subtest B-VGA1: SUCCESS (1.269s)
[94.478870] Subtest basic-flip-vs-modeset: SUCCESS (2.591s)
[94.618579] [111/171] (903s left) kms_flip (basic-flip-vs-wf_vblank)
[94.775650] Starting subtest: basic-flip-vs-wf_vblank
[94.776969] Starting dynamic subtest: A-VGA1
[96.319914] Dynamic subtest A-VGA1: SUCCESS (1.543s)
[96.336803] Starting dynamic subtest: B-VGA1
[97.853710] Dynamic subtest B-VGA1: SUCCESS (1.528s)
[97.854783] Subtest basic-flip-vs-wf_vblank: SUCCESS (3.074s)
[98.028134] [112/171] (899s left) kms_flip (basic-plain-flip)
[98.184705] Starting subtest: basic-plain-flip
[98.185951] Starting dynamic subtest: A-VGA1
[99.462970] Dynamic subtest A-VGA1: SUCCESS (1.269s)
[99.482933] Starting dynamic subtest: B-VGA1
[100.706957] Dynamic subtest B-VGA1: SUCCESS (1.219s)
[100.709504] Subtest basic-plain-flip: SUCCESS (2.524s)
[100.909421] [113/171] (897s left) kms_force_connector_basic (force-connector-state)
[101.130824] Starting subtest: force-connector-state
[101.318850] Subtest force-connector-state: SUCCESS (0.185s)
[101.594346] [114/171] (896s left) kms_force_connector_basic (force-edid)
[101.801348] Starting subtest: force-edid
[101.882472] Subtest force-edid: SUCCESS (0.081s)
[102.079345] [115/171] (896s left) kms_force_connector_basic (force-load-detect)
[102.302326] Starting subtest: force-load-detect
[102.530481] Subtest force-load-detect: SUCCESS (0.225s)
[102.755916] [116/171] (895s left) kms_force_connector_basic (prune-stale-modes)
[102.963952] Starting subtest: prune-stale-modes
[103.045386] Subtest prune-stale-modes: SUCCESS (0.082s)
[103.223947] [117/171] (894s left) kms_frontbuffer_tracking (basic)
[103.383229] Subtest basic: SKIP (0.000s)
[103.429101] [118/171] (894s left) kms_pipe_crc_basic (compare-crc-sanitycheck-xr24)
[103.582884] Starting subtest: compare-crc-sanitycheck-xr24
[103.583990] Starting dynamic subtest: pipe-A-VGA-1
[103.895734] Dynamic subtest pipe-A-VGA-1: SUCCESS (0.302s)
[103.915915] Starting dynamic subtest: pipe-B-VGA-1
[104.255166] Dynamic subtest pipe-B-VGA-1: SUCCESS (0.349s)
[104.256205] Subtest compare-crc-sanitycheck-xr24: SUCCESS (0.665s)
[104.385646] [119/171] (893s left) kms_pipe_crc_basic (compare-crc-sanitycheck-nv12)
[104.543957] Starting subtest: compare-crc-sanitycheck-nv12
[104.546151] Starting dynamic subtest: pipe-A-VGA-1
[104.548334] Dynamic subtest pipe-A-VGA-1: SKIP (0.000s)
[104.559525] Starting dynamic subtest: pipe-B-VGA-1
[104.561690] Dynamic subtest pipe-B-VGA-1: SKIP (0.000s)
[104.563850] Subtest compare-crc-sanitycheck-nv12: SKIP (0.005s)
[104.619416] [120/171] (893s left) kms_pipe_crc_basic (hang-read-crc)
[104.777617] Starting subtest: hang-read-crc
[104.778729] Starting dynamic subtest: pipe-A-VGA-1
[105.653369] Dynamic subtest pipe-A-VGA-1: SUCCESS (0.875s)
[105.667873] Starting dynamic subtest: pipe-B-VGA-1
[106.616139] Dynamic subtest pipe-B-VGA-1: SUCCESS (0.953s)
[106.617259] Subtest hang-read-crc: SUCCESS (1.839s)
[106.723203] [121/171] (891s left) kms_pipe_crc_basic (nonblocking-crc)
[106.881024] Starting subtest: nonblocking-crc
[106.883303] Starting dynamic subtest: pipe-A-VGA-1
[107.365669] Dynamic subtest pipe-A-VGA-1: SUCCESS (0.482s)
[107.378944] Starting dynamic subtest: pipe-B-VGA-1
[107.862184] Dynamic subtest pipe-B-VGA-1: SUCCESS (0.494s)
[107.863289] Subtest nonblocking-crc: SUCCESS (0.982s)
[107.965137] [122/171] (890s left) kms_pipe_crc_basic (nonblocking-crc-frame-sequence)
[108.121965] Starting subtest: nonblocking-crc-frame-sequence
[108.123063] Starting dynamic subtest: pipe-A-VGA-1
[108.587625] Dynamic subtest pipe-A-VGA-1: SUCCESS (0.466s)
[108.605946] Starting dynamic subtest: pipe-B-VGA-1
[109.096501] Dynamic subtest pipe-B-VGA-1: SUCCESS (0.498s)
[109.097629] Subtest nonblocking-crc-frame-sequence: SUCCESS (0.976s)
[109.211976] [123/171] (889s left) kms_pipe_crc_basic (read-crc)
[109.369700] Starting subtest: read-crc
[109.370836] Starting dynamic subtest: pipe-A-VGA-1
[109.770711] Dynamic subtest pipe-A-VGA-1: SUCCESS (0.400s)
[109.785950] Starting dynamic subtest: pipe-B-VGA-1
[110.230136] Dynamic subtest pipe-B-VGA-1: SUCCESS (0.457s)
[110.231103] Subtest read-crc: SUCCESS (0.861s)
[110.354398] [124/171] (887s left) kms_pipe_crc_basic (read-crc-frame-sequence)
[110.513201] Starting subtest: read-crc-frame-sequence
[110.515434] Starting dynamic subtest: pipe-A-VGA-1
[110.942696] Dynamic subtest pipe-A-VGA-1: SUCCESS (0.427s)
[110.954920] Starting dynamic subtest: pipe-B-VGA-1
[111.417146] Dynamic subtest pipe-B-VGA-1: SUCCESS (0.473s)
[111.418420] Subtest read-crc-frame-sequence: SUCCESS (0.904s)
[111.538434] [125/171] (886s left) kms_psr (primary_page_flip)
[111.665404] Subtest primary_page_flip: SKIP (0.000s)
[111.708197] [126/171] (886s left) kms_psr (cursor_plane_move)
[111.832679] Subtest cursor_plane_move: SKIP (0.000s)
[111.876488] [127/171] (886s left) kms_psr (sprite_plane_onoff)
[112.002095] Subtest sprite_plane_onoff: SKIP (0.000s)
[112.042971] [128/171] (886s left) kms_psr (primary_mmap_gtt)
[112.170168] Subtest primary_mmap_gtt: SKIP (0.000s)
[112.210062] [129/171] (886s left) kms_setmode (basic-clone-single-crtc)
[112.336774] Starting subtest: basic-clone-single-crtc
[112.340121] Subtest basic-clone-single-crtc: SKIP (0.000s)
[112.407953] [130/171] (886s left) i915_pm_backlight (basic-brightness)
[112.565952] Subtest basic-brightness: SKIP (0.000s)
[112.611346] [131/171] (885s left) i915_pm_rpm (basic-pci-d3-state)
[123.942266] Subtest basic-pci-d3-state: SKIP (0.000s)
[123.967557] [132/171] (874s left) i915_pm_rpm (basic-rte)
[124.088128] Starting subtest: basic-rte
[135.284779] Subtest basic-rte: SKIP (11.181s)
[135.306671] [133/171] (863s left) i915_pm_rps (basic-api)
[135.434946] Subtest basic-api: SKIP (0.000s)
[135.475586] [134/171] (863s left) prime_self_import (basic-llseek-bad)
[135.596644] Starting subtest: basic-llseek-bad
[135.599369] Subtest basic-llseek-bad: SUCCESS (0.002s)
[135.673133] [135/171] (862s left) prime_self_import (basic-llseek-size)
[135.799269] Starting subtest: basic-llseek-size
[135.801774] Subtest basic-llseek-size: SUCCESS (0.003s)
[135.875789] [136/171] (862s left) prime_self_import (basic-with_fd_dup)
[135.998811] Starting subtest: basic-with_fd_dup
[136.001076] Subtest basic-with_fd_dup: SUCCESS (0.003s)
[136.074275] [137/171] (862s left) prime_self_import (basic-with_one_bo)
[136.195663] Starting subtest: basic-with_one_bo
[136.198913] Subtest basic-with_one_bo: SUCCESS (0.005s)
[136.278561] [138/171] (862s left) prime_self_import (basic-with_one_bo_two_files)
[136.401987] Starting subtest: basic-with_one_bo_two_files
[136.404542] Subtest basic-with_one_bo_two_files: SUCCESS (0.003s)
[136.476596] [139/171] (862s left) prime_self_import (basic-with_two_bos)
[136.596986] Starting subtest: basic-with_two_bos
[136.601068] Subtest basic-with_two_bos: SUCCESS (0.004s)
[136.676055] [140/171] (861s left) prime_vgem (basic-fence-flip)
[136.807767] Starting subtest: basic-fence-flip
[137.204233] Subtest basic-fence-flip: SUCCESS (0.400s)
[137.295273] [141/171] (861s left) prime_vgem (basic-fence-mmap)
[137.425826] Starting subtest: basic-fence-mmap
[137.461362] Subtest basic-fence-mmap: SUCCESS (0.039s)
[137.546197] [142/171] (861s left) prime_vgem (basic-fence-read)
[137.674803] Starting subtest: basic-fence-read
[137.743736] Subtest basic-fence-read: SUCCESS (0.069s)
[137.813586] [143/171] (860s left) prime_vgem (basic-gtt)
[137.943788] Starting subtest: basic-gtt
[137.956765] Subtest basic-gtt: SUCCESS (0.016s)
[138.030817] [144/171] (860s left) prime_vgem (basic-read)
[138.161841] Starting subtest: basic-read
[138.185331] Subtest basic-read: SUCCESS (0.028s)
[138.265647] [145/171] (860s left) prime_vgem (basic-write)
[138.396109] Starting subtest: basic-write
[138.421275] Subtest basic-write: SUCCESS (0.030s)
[138.498764] [146/171] (860s left) vgem_basic (setversion)
[138.624052] Starting subtest: setversion
[138.626367] Subtest setversion: SUCCESS (0.000s)
[138.682165] [147/171] (860s left) vgem_basic (create)
[138.808105] Starting subtest: create
[138.809195] Subtest create: SUCCESS (0.000s)
[138.867479] [148/171] (859s left) vgem_basic (debugfs)
[138.991998] Starting subtest: debugfs
[138.993185] Subtest debugfs: SUCCESS (0.001s)
[139.050448] [149/171] (859s left) vgem_basic (dmabuf-export)
[139.177797] Starting subtest: dmabuf-export
[139.180059] Subtest dmabuf-export: SUCCESS (0.002s)
[139.251395] [150/171] (859s left) vgem_basic (dmabuf-fence)
[139.377094] Starting subtest: dmabuf-fence
[139.378233] Subtest dmabuf-fence: SUCCESS (0.001s)
[139.435290] [151/171] (859s left) vgem_basic (dmabuf-fence-before)
[139.560338] Starting subtest: dmabuf-fence-before
[139.561452] Subtest dmabuf-fence-before: SUCCESS (0.001s)
[139.620094] [152/171] (859s left) vgem_basic (dmabuf-mmap)
[139.744073] Starting subtest: dmabuf-mmap
[139.762972] Subtest dmabuf-mmap: SUCCESS (0.021s)
[139.821269] [153/171] (859s left) vgem_basic (mmap)
[139.944339] Starting subtest: mmap
[139.956643] Subtest mmap: SUCCESS (0.014s)
[140.021598] [154/171] (858s left) vgem_basic (second-client)
[140.144745] Starting subtest: second-client
[140.179972] Subtest second-client: SUCCESS (0.033s)
[140.240474] [155/171] (858s left) vgem_basic (sysfs)
[140.363610] Starting subtest: sysfs
[140.364776] Subtest sysfs: SUCCESS (0.001s)
[140.422798] [156/171] (858s left) core_hotunplug (unbind-rebind)
[140.595280] Starting subtest: unbind-rebind
[141.386894] Subtest unbind-rebind: SUCCESS (0.790s)
[141.427311] [157/171] (857s left) vgem_basic (unload)
[141.646621] Starting subtest: unload
[170.593508] Subtest unload: SUCCESS (28.948s)
[170.697662] [158/171] (828s left) i915_module_load (reload)
[170.820513] Starting subtest: reload
[172.725898] Subtest reload: SUCCESS (1.903s)
[172.762268] [159/171] (826s left) gem_lmem_swapping (basic)
[172.934890] Subtest basic: SKIP (0.000s)
[172.967590] [160/171] (826s left) gem_lmem_swapping (parallel-random-engines)
[173.134186] Subtest parallel-random-engines: SKIP (0.000s)
[173.191286] [161/171] (825s left) gem_lmem_swapping (random-engines)
[173.379940] Subtest random-engines: SKIP (0.000s)
[173.420598] [162/171] (825s left) gem_lmem_swapping (verify-random)
[173.554428] Subtest verify-random: SKIP (0.000s)
[173.586951] [163/171] (825s left) i915_pm_rpm (module-reload)
[184.917887] Subtest module-reload: SKIP (0.000s)
[184.942919] [164/171] (814s left) i915_selftest (live)
[185.755149] Starting subtest: live
[185.757355] Starting dynamic subtest: sanitycheck
[186.493660] Dynamic subtest sanitycheck: SUCCESS (0.740s)
[186.505420] Starting dynamic subtest: uncore
[187.133890] Dynamic subtest uncore: SUCCESS (0.639s)
[187.144977] Starting dynamic subtest: workarounds
[187.795709] Dynamic subtest workarounds: SUCCESS (0.661s)
[187.806828] Starting dynamic subtest: gt_engines
[188.488968] Dynamic subtest gt_engines: SUCCESS (0.690s)
[188.497725] Starting dynamic subtest: gt_timelines
[191.430045] Dynamic subtest gt_timelines: SUCCESS (2.940s)
[191.439594] Starting dynamic subtest: gt_contexts
[192.104927] Dynamic subtest gt_contexts: SUCCESS (0.676s)
[192.115452] Starting dynamic subtest: gt_lrc
[192.759682] Dynamic subtest gt_lrc: SUCCESS (0.654s)
[192.769880] Starting dynamic subtest: gt_mocs
[193.437973] Dynamic subtest gt_mocs: SUCCESS (0.676s)
[193.447993] Starting dynamic subtest: gt_pm
[194.585944] Dynamic subtest gt_pm: SUCCESS (1.147s)
[194.595614] Starting dynamic subtest: gt_heartbeat
[195.292553] Dynamic subtest gt_heartbeat: SUCCESS (0.706s)
[195.302830] Starting dynamic subtest: gt_tlb
[195.947671] Dynamic subtest gt_tlb: SUCCESS (0.655s)
[195.958412] Starting dynamic subtest: requests
[199.175057] Dynamic subtest requests: SUCCESS (3.226s)
[199.185725] Starting dynamic subtest: migrate
[199.851231] Dynamic subtest migrate: SUCCESS (0.674s)
[199.862242] Starting dynamic subtest: active
[200.553062] Dynamic subtest active: SUCCESS (0.701s)
[200.564204] Starting dynamic subtest: objects
[201.563491] Dynamic subtest objects: SUCCESS (1.009s)
[201.574562] Starting dynamic subtest: mman
[206.492196] Dynamic subtest mman: SUCCESS (4.928s)
[206.502988] Starting dynamic subtest: dmabuf
[207.222988] Dynamic subtest dmabuf: SUCCESS (0.729s)
[207.232763] Starting dynamic subtest: vma
[207.883675] Dynamic subtest vma: SUCCESS (0.661s)
[207.894826] Starting dynamic subtest: coherency
[209.664059] Dynamic subtest coherency: SUCCESS (1.779s)
[209.674872] Starting dynamic subtest: gtt
[213.856152] Dynamic subtest gtt: SUCCESS (4.191s)
[213.866695] Starting dynamic subtest: gem
[214.541969] Dynamic subtest gem: SUCCESS (0.685s)
[214.553299] Starting dynamic subtest: evict
[215.199796] Dynamic subtest evict: SUCCESS (0.657s)
[215.210448] Starting dynamic subtest: hugepages
[215.842195] Dynamic subtest hugepages: SUCCESS (0.641s)
[215.853403] Starting dynamic subtest: gem_contexts
[216.471319] Dynamic subtest gem_contexts: SUCCESS (0.629s)
[216.481440] Starting dynamic subtest: client
[217.098124] Dynamic subtest client: SUCCESS (0.626s)
[217.111999] Starting dynamic subtest: gem_migrate
[217.746617] Dynamic subtest gem_migrate: SUCCESS (0.647s)
[217.757822] Starting dynamic subtest: reset
[218.721124] Dynamic subtest reset: SUCCESS (0.973s)
[218.732716] Starting dynamic subtest: memory_region
[219.375850] Dynamic subtest memory_region: SUCCESS (0.654s)
[219.386657] Starting dynamic subtest: hangcheck
[221.059504] Dynamic subtest hangcheck: SUCCESS (1.680s)
[221.068299] Starting dynamic subtest: execlists
[221.724806] Dynamic subtest execlists: SUCCESS (0.667s)
[221.736632] Starting dynamic subtest: ring_submission
[222.395177] Dynamic subtest ring_submission: SUCCESS (0.669s)
[222.404941] Starting dynamic subtest: perf
[223.063820] Dynamic subtest perf: SUCCESS (0.668s)
[223.074130] Starting dynamic subtest: slpc
[223.742815] Dynamic subtest slpc: SUCCESS (0.678s)
[223.754795] Starting dynamic subtest: guc
[224.380323] Dynamic subtest guc: SUCCESS (0.636s)
[224.390219] Starting dynamic subtest: guc_multi_lrc
[225.038848] Dynamic subtest guc_multi_lrc: SUCCESS (0.658s)
[225.050111] Starting dynamic subtest: guc_hang
[225.710613] Dynamic subtest guc_hang: SUCCESS (0.671s)
[225.722401] Starting dynamic subtest: late_gt_pm
[226.353991] Dynamic subtest late_gt_pm: SUCCESS (0.642s)
[226.355246] Subtest live: SUCCESS (40.601s)
[226.492562] [165/171] (772s left) dmabuf (all-tests)
[226.621171] Starting subtest: all-tests
[226.629159] Starting dynamic subtest: sanitycheck
[226.681544] Dynamic subtest sanitycheck: SUCCESS (0.058s)
[226.694243] Starting dynamic subtest: dma_fence
[226.856370] Dynamic subtest dma_fence: SUCCESS (0.172s)
[226.873816] Starting dynamic subtest: dma_fence_chain
[244.383786] Dynamic subtest dma_fence_chain: SUCCESS (17.523s)
[244.396679] Starting dynamic subtest: dma_fence_unwrap
[244.437733] Dynamic subtest dma_fence_unwrap: SUCCESS (0.054s)
[244.447245] Starting dynamic subtest: dma_resv
[244.504179] Dynamic subtest dma_resv: SUCCESS (0.066s)
[244.506851] Subtest all-tests: SUCCESS (17.882s)
[244.526513] [166/171] (754s left) i915_suspend (basic-s2idle-without-i915)
[244.646961] Starting subtest: basic-s2idle-without-i915
[263.525070] Subtest basic-s2idle-without-i915: SUCCESS (18.878s)
[266.158781] [167/171] (735s left) i915_suspend (basic-s3-without-i915)
[266.290640] Starting subtest: basic-s3-without-i915
[283.231021] Subtest basic-s3-without-i915: SUCCESS (2.316s)
[285.623366] [168/171] (733s left) gem_exec_suspend (basic-s0)
[285.773731] Starting subtest: basic-S0
[285.775606] Starting dynamic subtest: smem
[303.160095] Dynamic subtest smem: SUCCESS (17.389s)
[303.161200] Subtest basic-S0: SUCCESS (17.390s)
[306.354477] [169/171] (715s left) gem_exec_suspend (basic-s3)
[306.496555] Starting subtest: basic-S3
[306.498678] Starting dynamic subtest: smem
[324.901473] Dynamic subtest smem: SUCCESS (1.911s)
[324.903957] Subtest basic-S3: SUCCESS (1.913s)
[328.099970] [170/171] (713s left) kms_chamelium_hpd (common-hpd-after-suspend)
[328.260622] Subtest common-hpd-after-suspend: SKIP (0.000s)
[328.307379] [171/171] (713s left) kms_pipe_crc_basic (suspend-read-crc)
[328.467582] Starting subtest: suspend-read-crc
[328.470619] Starting dynamic subtest: pipe-A-VGA-1
[346.037313] Dynamic subtest pipe-A-VGA-1: SUCCESS (1.789s)
[346.056657] Starting dynamic subtest: pipe-B-VGA-1
[364.001701] Dynamic subtest pipe-B-VGA-1: SUCCESS (1.833s)
[364.004236] Subtest suspend-read-crc: SUCCESS (3.634s)
[367.149108] Closing watchdogs
Done.