[35.229092] Initializing watchdogs
[35.229248]   /dev/watchdog0
[35.237958] [001/170] (960s left) i915_module_load (load)
[35.391621] Starting subtest: load
[37.066676] Subtest load: SUCCESS (1.675s)
[37.089192] [002/170] (958s left) core_auth (basic-auth)
[37.219688] Starting subtest: basic-auth
[37.222329] Subtest basic-auth: SUCCESS (0.001s)
[37.290403] [003/170] (958s left) debugfs_test (read_all_entries)
[37.436306] Starting subtest: read_all_entries
[37.522083] Subtest read_all_entries: SUCCESS (0.087s)
[37.668216] [004/170] (958s left) debugfs_test (basic-hwmon)
[37.896218] Starting subtest: basic-hwmon
[37.898393] Subtest basic-hwmon: SKIP (0.000s)
[37.994179] [005/170] (957s left) fbdev (eof)
[38.121780] Starting subtest: eof
[38.122875] Subtest eof: SUCCESS (0.000s)
[38.180282] [006/170] (957s left) fbdev (info)
[38.309280] Starting subtest: info
[38.310894] Subtest info: SUCCESS (0.000s)
[38.379585] [007/170] (957s left) fbdev (nullptr)
[38.522215] Starting subtest: nullptr
[38.524918] Subtest nullptr: SUCCESS (0.002s)
[38.581644] [008/170] (957s left) fbdev (read)
[38.723851] Starting subtest: read
[39.006846] Subtest read: SUCCESS (0.281s)
[39.065370] [009/170] (956s left) fbdev (write)
[39.208961] Starting subtest: write
[39.353107] Subtest write: SUCCESS (0.142s)
[39.417651] [010/170] (956s left) gem_basic (bad-close)
[39.557683] Starting subtest: bad-close
[39.561163] Subtest bad-close: SUCCESS (0.003s)
[39.633744] [011/170] (956s left) gem_basic (create-close)
[39.759738] Starting subtest: create-close
[39.762020] Subtest create-close: SUCCESS (0.000s)
[39.834719] [012/170] (956s left) gem_basic (create-fd-close)
[39.975551] Starting subtest: create-fd-close
[39.979142] Subtest create-fd-close: SUCCESS (0.003s)
[40.050613] [013/170] (955s left) gem_busy (busy@all-engines)
[40.186404] Starting subtest: busy
[40.187628] Starting dynamic subtest: all-engines
[40.211271] Dynamic subtest all-engines: SUCCESS (0.025s)
[40.212405] Subtest busy: SUCCESS (0.025s)
[40.520692] [014/170] (955s left) gem_close_race (basic-process)
[40.660906] Starting subtest: basic-process
[40.700434] Subtest basic-process: SUCCESS (0.041s)
[40.889623] [015/170] (955s left) gem_close_race (basic-threads)
[41.027807] Starting subtest: basic-threads
[42.162607] Subtest basic-threads: SUCCESS (1.136s)
[42.345077] [016/170] (953s left) gem_ctx_create (basic)
[42.477956] Subtest basic: SKIP (0.000s)
[42.513799] [017/170] (953s left) gem_ctx_create (basic-files)
[42.643465] Subtest basic-files: SKIP (0.000s)
[42.680482] [018/170] (953s left) gem_ctx_exec (basic)
[42.809273] Subtest basic: SKIP (0.000s)
[42.882057] [019/170] (953s left) gem_exec_basic (basic)
[43.012735] Starting subtest: basic
[43.013886] Starting dynamic subtest: rcs0-smem
[43.015066] Dynamic subtest rcs0-smem: SUCCESS (0.000s)
[43.016181] Subtest basic: SUCCESS (0.001s)
[43.198712] [020/170] (952s left) gem_exec_create (basic)
[43.329245] Starting subtest: basic
[43.330488] Starting dynamic subtest: smem
[45.365411] Dynamic subtest smem: SUCCESS (2.036s)
[45.366595] Subtest basic: SUCCESS (2.036s)
[45.538961] [021/170] (950s left) gem_exec_fence (basic-busy)
[45.808514] Starting subtest: basic-busy
[45.809643] Starting dynamic subtest: rcs0
[45.817205] Dynamic subtest rcs0: SUCCESS (0.010s)
[45.818335] Subtest basic-busy: SUCCESS (0.011s)
[46.310643] [022/170] (949s left) gem_exec_fence (basic-wait)
[46.569861] Starting subtest: basic-wait
[46.571101] Starting dynamic subtest: rcs0
[46.586168] Dynamic subtest rcs0: SUCCESS (0.018s)
[46.587295] Subtest basic-wait: SUCCESS (0.018s)
[47.028186] [023/170] (949s left) gem_exec_fence (basic-await)
[47.284847] Starting subtest: basic-await
[47.285922] Starting dynamic subtest: rcs0
[47.345928] Dynamic subtest rcs0: SUCCESS (0.062s)
[47.347091] Subtest basic-await: SUCCESS (0.062s)
[47.780629] [024/170] (948s left) gem_exec_fence (nb-await)
[48.043945] Starting subtest: nb-await
[48.045108] Starting dynamic subtest: rcs0
[48.094235] Dynamic subtest rcs0: SUCCESS (0.053s)
[48.095408] Subtest nb-await: SUCCESS (0.053s)
[48.532910] [025/170] (947s left) gem_exec_gttfill (basic)
[48.668062] Starting subtest: basic
[51.791878] Subtest basic: SUCCESS (3.123s)
[51.984947] [026/170] (944s left) gem_exec_parallel (engines)
[52.232199] Starting subtest: engines
[52.234103] Starting dynamic subtest: basic
[54.024660] Dynamic subtest basic: SUCCESS (1.790s)
[54.032403] Starting dynamic subtest: contexts
[54.034543] Dynamic subtest contexts: SKIP (0.000s)
[54.041864] Starting dynamic subtest: fds
[54.043965] Dynamic subtest fds: SKIP (0.000s)
[54.051281] Starting dynamic subtest: userptr
[55.852829] Dynamic subtest userptr: SUCCESS (1.830s)
[55.853961] Subtest engines: SUCCESS (3.621s)
[56.040533] [027/170] (940s left) gem_exec_store (basic)
[56.187079] Starting subtest: basic
[56.207490] Subtest basic: SUCCESS (0.021s)
[56.393556] [028/170] (939s left) gem_flink_basic (bad-flink)
[56.514206] Starting subtest: bad-flink
[56.515389] Subtest bad-flink: SUCCESS (0.000s)
[56.577117] [029/170] (939s left) gem_flink_basic (bad-open)
[56.697429] Starting subtest: bad-open
[56.698562] Subtest bad-open: SUCCESS (0.000s)
[56.760876] [030/170] (939s left) gem_flink_basic (basic)
[56.882125] Starting subtest: basic
[56.883283] Subtest basic: SUCCESS (0.000s)
[56.962101] [031/170] (939s left) gem_flink_basic (double-flink)
[57.088973] Starting subtest: double-flink
[57.090153] Subtest double-flink: SUCCESS (0.000s)
[57.162141] [032/170] (939s left) gem_flink_basic (flink-lifetime)
[57.280821] Starting subtest: flink-lifetime
[57.281980] Subtest flink-lifetime: SUCCESS (0.001s)
[57.349722] [033/170] (939s left) gem_huc_copy (huc-copy)
[57.475268] Subtest huc-copy: SKIP (0.000s)
[57.517379] [034/170] (938s left) gem_linear_blits (basic)
[57.883559] Starting subtest: basic
[57.893294] Subtest basic: SUCCESS (0.011s)
[57.995968] [035/170] (938s left) gem_mmap (basic)
[58.234266] Starting subtest: basic
[58.239635] Subtest basic: SUCCESS (0.001s)
[58.301944] [036/170] (938s left) gem_mmap_gtt (basic)
[58.427140] Starting subtest: basic
[58.428301] Subtest basic: SUCCESS (0.001s)
[58.503682] [037/170] (938s left) gem_render_linear_blits (basic)
[58.626853] Starting subtest: basic
[58.674341] Subtest basic: SUCCESS (0.047s)
[58.720455] [038/170] (937s left) gem_render_tiled_blits (basic)
[58.843903] Starting subtest: basic
[58.886396] Subtest basic: SUCCESS (0.041s)
[58.919729] [039/170] (937s left) gem_ringfill (basic-all)
[59.064123] Starting subtest: basic-all
[60.169392] Subtest basic-all: SUCCESS (1.105s)
[60.240354] [040/170] (936s left) gem_softpin (allocator-basic)
[60.371089] Subtest allocator-basic: SKIP (0.000s)
[60.441001] [041/170] (936s left) gem_softpin (allocator-basic-reserve)
[60.565200] Subtest allocator-basic-reserve: SKIP (0.000s)
[60.624208] [042/170] (936s left) gem_softpin (safe-alignment)
[60.750909] Starting subtest: safe-alignment
[60.752959] Subtest safe-alignment: SUCCESS (0.006s)
[60.827145] [043/170] (935s left) gem_sync (basic-all)
[60.958572] Starting subtest: basic-all
[63.054809] Subtest basic-all: SUCCESS (2.095s)
[63.234620] [044/170] (933s left) gem_sync (basic-each)
[63.365827] Starting subtest: basic-each
[65.427871] Subtest basic-each: SUCCESS (2.061s)
[65.609916] [045/170] (931s left) gem_tiled_blits (basic)
[65.969234] Starting subtest: basic
[65.988379] Subtest basic: SUCCESS (0.020s)
[66.093980] [046/170] (930s left) gem_tiled_fence_blits (basic)
[66.641969] Starting subtest: basic
[66.652592] Subtest basic: SUCCESS (0.013s)
[66.763139] [047/170] (929s left) gem_tiled_pread_basic
[67.247512] [048/170] (929s left) gem_wait (busy@all-engines)
[67.387435] Starting subtest: busy
[67.388602] Starting dynamic subtest: all-engines
[67.899372] Dynamic subtest all-engines: SUCCESS (0.512s)
[67.900423] Subtest busy: SUCCESS (0.512s)
[68.117840] [049/170] (928s left) gem_wait (wait@all-engines)
[68.258997] Starting subtest: wait
[68.261795] Starting dynamic subtest: all-engines
[69.270079] Dynamic subtest all-engines: SUCCESS (1.013s)
[69.271130] Subtest wait: SUCCESS (1.014s)
[69.472539] [050/170] (927s left) i915_getparams_basic (basic-eu-total)
[69.592318] Starting subtest: basic-eu-total
[69.595460] Subtest basic-eu-total: SUCCESS (0.000s)
[69.655671] [051/170] (927s left) i915_getparams_basic (basic-subslice-total)
[69.776254] Starting subtest: basic-subslice-total
[69.779494] Subtest basic-subslice-total: SUCCESS (0.000s)
[69.839976] [052/170] (927s left) i915_hangman (error-state-basic)
[69.965161] Starting subtest: error-state-basic
[70.078875] Subtest error-state-basic: SUCCESS (0.115s)
[70.134569] [053/170] (926s left) i915_pciid
[70.332398] [054/170] (926s left) kms_addfb_basic (addfb25-bad-modifier)
[70.456529] Starting subtest: addfb25-bad-modifier
[70.457607] Subtest addfb25-bad-modifier: SUCCESS (0.001s)
[70.569163] [055/170] (926s left) kms_addfb_basic (addfb25-framebuffer-vs-set-tiling)
[70.695369] Starting subtest: addfb25-framebuffer-vs-set-tiling
[70.696438] Subtest addfb25-framebuffer-vs-set-tiling: SUCCESS (0.000s)
[70.802251] [056/170] (926s left) kms_addfb_basic (addfb25-modifier-no-flag)
[70.927810] Starting subtest: addfb25-modifier-no-flag
[70.928956] Subtest addfb25-modifier-no-flag: SUCCESS (0.000s)
[71.019087] [057/170] (925s left) kms_addfb_basic (addfb25-x-tiled-legacy)
[71.145956] Starting subtest: addfb25-x-tiled-legacy
[71.147246] Subtest addfb25-x-tiled-legacy: SUCCESS (0.000s)
[71.255626] [058/170] (925s left) kms_addfb_basic (addfb25-x-tiled-mismatch-legacy)
[71.381745] Starting subtest: addfb25-x-tiled-mismatch-legacy
[71.382858] Subtest addfb25-x-tiled-mismatch-legacy: SUCCESS (0.000s)
[71.487974] [059/170] (925s left) kms_addfb_basic (addfb25-yf-tiled-legacy)
[71.646930] Starting subtest: addfb25-yf-tiled-legacy
[71.648332] Subtest addfb25-yf-tiled-legacy: SUCCESS (0.000s)
[71.723262] [060/170] (925s left) kms_addfb_basic (addfb25-y-tiled-legacy)
[71.881254] Starting subtest: addfb25-y-tiled-legacy
[71.882522] Subtest addfb25-y-tiled-legacy: SUCCESS (0.001s)
[71.954274] [061/170] (925s left) kms_addfb_basic (addfb25-y-tiled-small-legacy)
[72.097390] Starting subtest: addfb25-y-tiled-small-legacy
[72.099637] Subtest addfb25-y-tiled-small-legacy: SKIP (0.000s)
[72.173024] [062/170] (924s left) kms_addfb_basic (bad-pitch-0)
[72.300281] Starting subtest: bad-pitch-0
[72.301435] Subtest bad-pitch-0: SUCCESS (0.000s)
[72.407453] [063/170] (924s left) kms_addfb_basic (bad-pitch-1024)
[72.533857] Starting subtest: bad-pitch-1024
[72.535067] Subtest bad-pitch-1024: SUCCESS (0.000s)
[72.641253] [064/170] (924s left) kms_addfb_basic (bad-pitch-128)
[72.765747] Starting subtest: bad-pitch-128
[72.766988] Subtest bad-pitch-128: SUCCESS (0.000s)
[72.859292] [065/170] (924s left) kms_addfb_basic (bad-pitch-256)
[72.987260] Starting subtest: bad-pitch-256
[72.988423] Subtest bad-pitch-256: SUCCESS (0.000s)
[73.076485] [066/170] (924s left) kms_addfb_basic (bad-pitch-32)
[73.204107] Starting subtest: bad-pitch-32
[73.205256] Subtest bad-pitch-32: SUCCESS (0.000s)
[73.310767] [067/170] (923s left) kms_addfb_basic (bad-pitch-63)
[73.430085] Starting subtest: bad-pitch-63
[73.431280] Subtest bad-pitch-63: SUCCESS (0.000s)
[73.544286] [068/170] (923s left) kms_addfb_basic (bad-pitch-65536)
[73.671088] Starting subtest: bad-pitch-65536
[73.672188] Subtest bad-pitch-65536: SUCCESS (0.000s)
[73.779427] [069/170] (923s left) kms_addfb_basic (bad-pitch-999)
[73.902698] Starting subtest: bad-pitch-999
[73.908022] Subtest bad-pitch-999: SUCCESS (0.000s)
[74.012861] [070/170] (923s left) kms_addfb_basic (basic)
[74.136846] Starting subtest: basic
[74.138273] Subtest basic: SUCCESS (0.000s)
[74.246493] [071/170] (923s left) kms_addfb_basic (basic-x-tiled-legacy)
[74.371857] Starting subtest: basic-x-tiled-legacy
[74.373123] Subtest basic-x-tiled-legacy: SUCCESS (0.000s)
[74.481277] [072/170] (922s left) kms_addfb_basic (basic-y-tiled-legacy)
[74.607705] Starting subtest: basic-y-tiled-legacy
[74.608969] Subtest basic-y-tiled-legacy: SUCCESS (0.000s)
[74.715044] [073/170] (922s left) kms_addfb_basic (bo-too-small)
[74.856476] Starting subtest: bo-too-small
[74.857765] Subtest bo-too-small: SUCCESS (0.001s)
[74.931878] [074/170] (922s left) kms_addfb_basic (bo-too-small-due-to-tiling)
[75.073361] Starting subtest: bo-too-small-due-to-tiling
[75.074631] Subtest bo-too-small-due-to-tiling: SUCCESS (0.001s)
[75.149550] [075/170] (922s left) kms_addfb_basic (clobberred-modifier)
[75.275788] Starting subtest: clobberred-modifier
[75.276967] Subtest clobberred-modifier: SUCCESS (0.000s)
[75.384283] [076/170] (921s left) kms_addfb_basic (framebuffer-vs-set-tiling)
[75.509460] Starting subtest: framebuffer-vs-set-tiling
[75.510587] Subtest framebuffer-vs-set-tiling: SUCCESS (0.000s)
[75.602542] [077/170] (921s left) kms_addfb_basic (invalid-get-prop)
[75.728637] Starting subtest: invalid-get-prop
[75.729823] Subtest invalid-get-prop: SUCCESS (0.000s)
[75.838315] [078/170] (921s left) kms_addfb_basic (invalid-get-prop-any)
[75.966409] Starting subtest: invalid-get-prop-any
[75.967510] Subtest invalid-get-prop-any: SUCCESS (0.000s)
[76.070201] [079/170] (921s left) kms_addfb_basic (invalid-set-prop)
[76.197211] Starting subtest: invalid-set-prop
[76.198386] Subtest invalid-set-prop: SUCCESS (0.000s)
[76.304304] [080/170] (921s left) kms_addfb_basic (invalid-set-prop-any)
[76.430858] Starting subtest: invalid-set-prop-any
[76.431995] Subtest invalid-set-prop-any: SUCCESS (0.000s)
[76.538206] [081/170] (920s left) kms_addfb_basic (no-handle)
[76.662925] Starting subtest: no-handle
[76.664149] Subtest no-handle: SUCCESS (0.000s)
[76.755820] [082/170] (920s left) kms_addfb_basic (size-max)
[76.913900] Starting subtest: size-max
[76.915279] Subtest size-max: SUCCESS (0.001s)
[76.989111] [083/170] (920s left) kms_addfb_basic (small-bo)
[77.130640] Starting subtest: small-bo
[77.131986] Subtest small-bo: SUCCESS (0.000s)
[77.206797] [084/170] (920s left) kms_addfb_basic (tile-pitch-mismatch)
[77.330983] Starting subtest: tile-pitch-mismatch
[77.332302] Subtest tile-pitch-mismatch: SUCCESS (0.000s)
[77.424341] [085/170] (920s left) kms_addfb_basic (too-high)
[77.567304] Starting subtest: too-high
[77.570318] Subtest too-high: SUCCESS (0.003s)
[77.644108] [086/170] (919s left) kms_addfb_basic (too-wide)
[77.799955] Starting subtest: too-wide
[77.801460] Subtest too-wide: SUCCESS (0.000s)
[77.874651] [087/170] (919s left) kms_addfb_basic (unused-handle)
[78.001899] Starting subtest: unused-handle
[78.003053] Subtest unused-handle: SUCCESS (0.000s)
[78.093798] [088/170] (919s left) kms_addfb_basic (unused-modifier)
[78.219398] Starting subtest: unused-modifier
[78.220551] Subtest unused-modifier: SUCCESS (0.000s)
[78.311628] [089/170] (919s left) kms_addfb_basic (unused-offsets)
[78.436362] Starting subtest: unused-offsets
[78.437612] Subtest unused-offsets: SUCCESS (0.000s)
[78.545201] [090/170] (919s left) kms_addfb_basic (unused-pitches)
[78.671029] Starting subtest: unused-pitches
[78.672140] Subtest unused-pitches: SUCCESS (0.000s)
[78.762898] [091/170] (918s left) kms_busy (basic)
[78.920547] Starting subtest: basic
[78.922952] Starting dynamic subtest: flip
[79.491408] Dynamic subtest flip: SUCCESS (0.569s)
[79.505864] Starting dynamic subtest: modeset
[79.509965] Dynamic subtest modeset: SKIP (0.000s)
[79.522899] Subtest basic: SUCCESS (0.570s)
[79.587277] [092/170] (918s left) kms_chamelium_hpd (dp-hpd-fast)
[79.740513] Subtest dp-hpd-fast: SKIP (0.000s)
[79.785508] [093/170] (917s left) kms_chamelium_edid (dp-edid-read)
[79.943215] Subtest dp-edid-read: SKIP (0.000s)
[79.985529] [094/170] (917s left) kms_chamelium_frames (dp-crc-fast)
[80.142390] Subtest dp-crc-fast: SKIP (0.000s)
[80.187220] [095/170] (917s left) kms_chamelium_hpd (hdmi-hpd-fast)
[80.345564] Subtest hdmi-hpd-fast: SKIP (0.000s)
[80.387902] [096/170] (917s left) kms_chamelium_edid (hdmi-edid-read)
[80.545206] Subtest hdmi-edid-read: SKIP (0.000s)
[80.590414] [097/170] (917s left) kms_chamelium_frames (hdmi-crc-fast)
[80.744132] Subtest hdmi-crc-fast: SKIP (0.000s)
[80.788449] [098/170] (917s left) kms_chamelium_hpd (vga-hpd-fast)
[80.945859] Subtest vga-hpd-fast: SKIP (0.000s)
[80.989155] [099/170] (916s left) kms_chamelium_edid (vga-edid-read)
[81.147715] Subtest vga-edid-read: SKIP (0.000s)
[81.190722] [100/170] (916s left) kms_prop_blob (basic)
[81.312793] Starting subtest: basic
[81.313954] Subtest basic: SUCCESS (0.000s)
[81.373777] [101/170] (916s left) kms_cursor_legacy (basic-busy-flip-before-cursor-atomic)
[81.530386] Starting subtest: basic-busy-flip-before-cursor-atomic
[81.533998] Subtest basic-busy-flip-before-cursor-atomic: SKIP (0.003s)
[81.604749] [102/170] (916s left) kms_cursor_legacy (basic-busy-flip-before-cursor-legacy)
[81.749232] Starting subtest: basic-busy-flip-before-cursor-legacy
[82.771377] Subtest basic-busy-flip-before-cursor-legacy: SUCCESS (1.023s)
[82.891130] [103/170] (915s left) kms_cursor_legacy (basic-flip-after-cursor-atomic)
[83.049712] Starting subtest: basic-flip-after-cursor-atomic
[83.052173] Subtest basic-flip-after-cursor-atomic: SKIP (0.000s)
[83.124090] [104/170] (914s left) kms_cursor_legacy (basic-flip-after-cursor-legacy)
[83.285966] Starting subtest: basic-flip-after-cursor-legacy
[84.295839] Subtest basic-flip-after-cursor-legacy: SUCCESS (1.003s)
[84.410634] [105/170] (913s left) kms_cursor_legacy (basic-flip-after-cursor-varying-size)
[84.567846] Starting subtest: basic-flip-after-cursor-varying-size
[85.568621] Subtest basic-flip-after-cursor-varying-size: SUCCESS (1.001s)
[85.693213] [106/170] (912s left) kms_cursor_legacy (basic-flip-before-cursor-atomic)
[85.852674] Starting subtest: basic-flip-before-cursor-atomic
[85.854934] Subtest basic-flip-before-cursor-atomic: SKIP (0.000s)
[85.926221] [107/170] (912s left) kms_cursor_legacy (basic-flip-before-cursor-legacy)
[86.068930] Starting subtest: basic-flip-before-cursor-legacy
[87.076844] Subtest basic-flip-before-cursor-legacy: SUCCESS (0.999s)
[87.190217] [108/170] (910s left) kms_cursor_legacy (basic-flip-before-cursor-varying-size)
[87.347601] Starting subtest: basic-flip-before-cursor-varying-size
[88.369332] Subtest basic-flip-before-cursor-varying-size: SUCCESS (1.023s)
[88.490280] [109/170] (909s left) kms_flip (basic-flip-vs-dpms)
[88.649227] Starting subtest: basic-flip-vs-dpms
[88.650254] Starting dynamic subtest: A-VGA1
[89.928122] Dynamic subtest A-VGA1: SUCCESS (1.269s)
[89.949029] Starting dynamic subtest: B-VGA1
[91.154563] Dynamic subtest B-VGA1: SUCCESS (1.202s)
[91.155666] Subtest basic-flip-vs-dpms: SUCCESS (2.496s)
[91.306958] [110/170] (906s left) kms_flip (basic-flip-vs-modeset)
[91.466695] Starting subtest: basic-flip-vs-modeset
[91.468180] Starting dynamic subtest: A-VGA1
[92.738534] Dynamic subtest A-VGA1: SUCCESS (1.271s)
[92.749834] Starting dynamic subtest: B-VGA1
[93.989407] Dynamic subtest B-VGA1: SUCCESS (1.240s)
[93.995938] Subtest basic-flip-vs-modeset: SUCCESS (2.523s)
[94.124775] [111/170] (903s left) kms_flip (basic-flip-vs-wf_vblank)
[94.283393] Starting subtest: basic-flip-vs-wf_vblank
[94.284679] Starting dynamic subtest: A-VGA1
[95.822638] Dynamic subtest A-VGA1: SUCCESS (1.528s)
[95.838901] Starting dynamic subtest: B-VGA1
[97.327361] Dynamic subtest B-VGA1: SUCCESS (1.494s)
[97.328343] Subtest basic-flip-vs-wf_vblank: SUCCESS (3.043s)
[97.488660] [112/170] (900s left) kms_flip (basic-plain-flip)
[97.631128] Starting subtest: basic-plain-flip
[97.632250] Starting dynamic subtest: A-VGA1
[98.878264] Dynamic subtest A-VGA1: SUCCESS (1.246s)
[98.893889] Starting dynamic subtest: B-VGA1
[100.086611] Dynamic subtest B-VGA1: SUCCESS (1.208s)
[100.087851] Subtest basic-plain-flip: SUCCESS (2.456s)
[100.289948] [113/170] (897s left) kms_force_connector_basic (force-connector-state)
[100.524602] Starting subtest: force-connector-state
[100.699744] Subtest force-connector-state: SUCCESS (0.173s)
[100.930440] [114/170] (897s left) kms_force_connector_basic (force-edid)
[101.140364] Starting subtest: force-edid
[101.220882] Subtest force-edid: SUCCESS (0.081s)
[101.415765] [115/170] (896s left) kms_force_connector_basic (force-load-detect)
[101.625524] Starting subtest: force-load-detect
[101.772456] Subtest force-load-detect: SUCCESS (0.146s)
[101.970178] [116/170] (896s left) kms_force_connector_basic (prune-stale-modes)
[102.176906] Starting subtest: prune-stale-modes
[102.267664] Subtest prune-stale-modes: SUCCESS (0.090s)
[102.421967] [117/170] (895s left) kms_frontbuffer_tracking (basic)
[102.583154] Subtest basic: SKIP (0.000s)
[102.625393] [118/170] (895s left) kms_pipe_crc_basic (compare-crc-sanitycheck)
[102.781098] Starting subtest: compare-crc-sanitycheck
[102.783761] Starting dynamic subtest: pipe-A-VGA-1
[103.084657] Dynamic subtest pipe-A-VGA-1: SUCCESS (0.300s)
[103.099962] Starting dynamic subtest: pipe-B-VGA-1
[103.412239] Dynamic subtest pipe-B-VGA-1: SUCCESS (0.319s)
[103.413322] Subtest compare-crc-sanitycheck: SUCCESS (0.631s)
[103.537312] [119/170] (894s left) kms_pipe_crc_basic (hang-read-crc)
[103.695323] Starting subtest: hang-read-crc
[103.698021] Starting dynamic subtest: pipe-A-VGA-1
[104.555065] Dynamic subtest pipe-A-VGA-1: SUCCESS (0.857s)
[104.568303] Starting dynamic subtest: pipe-B-VGA-1
[105.419255] Dynamic subtest pipe-B-VGA-1: SUCCESS (0.854s)
[105.420520] Subtest hang-read-crc: SUCCESS (1.724s)
[105.523576] [120/170] (892s left) kms_pipe_crc_basic (nonblocking-crc)
[105.681827] Starting subtest: nonblocking-crc
[105.684138] Starting dynamic subtest: pipe-A-VGA-1
[106.166751] Dynamic subtest pipe-A-VGA-1: SUCCESS (0.483s)
[106.182443] Starting dynamic subtest: pipe-B-VGA-1
[106.642109] Dynamic subtest pipe-B-VGA-1: SUCCESS (0.474s)
[106.643474] Subtest nonblocking-crc: SUCCESS (0.960s)
[106.747650] [121/170] (891s left) kms_pipe_crc_basic (nonblocking-crc-frame-sequence)
[106.905953] Starting subtest: nonblocking-crc-frame-sequence
[106.907124] Starting dynamic subtest: pipe-A-VGA-1
[107.391115] Dynamic subtest pipe-A-VGA-1: SUCCESS (0.483s)
[107.405905] Starting dynamic subtest: pipe-B-VGA-1
[107.885202] Dynamic subtest pipe-B-VGA-1: SUCCESS (0.493s)
[107.887263] Subtest nonblocking-crc-frame-sequence: SUCCESS (0.979s)
[107.983143] [122/170] (890s left) kms_pipe_crc_basic (read-crc)
[108.143091] Starting subtest: read-crc
[108.145320] Starting dynamic subtest: pipe-A-VGA-1
[108.579803] Dynamic subtest pipe-A-VGA-1: SUCCESS (0.434s)
[108.594954] Starting dynamic subtest: pipe-B-VGA-1
[109.028408] Dynamic subtest pipe-B-VGA-1: SUCCESS (0.447s)
[109.029754] Subtest read-crc: SUCCESS (0.885s)
[109.151211] [123/170] (889s left) kms_pipe_crc_basic (read-crc-frame-sequence)
[109.321122] Starting subtest: read-crc-frame-sequence
[109.323848] Starting dynamic subtest: pipe-A-VGA-1
[109.724773] Dynamic subtest pipe-A-VGA-1: SUCCESS (0.400s)
[109.745775] Starting dynamic subtest: pipe-B-VGA-1
[110.188849] Dynamic subtest pipe-B-VGA-1: SUCCESS (0.462s)
[110.191731] Subtest read-crc-frame-sequence: SUCCESS (0.867s)
[110.324439] [124/170] (888s left) kms_psr (primary_page_flip)
[110.456208] Subtest primary_page_flip: SKIP (0.000s)
[110.497768] [125/170] (887s left) kms_psr (cursor_plane_move)
[110.622740] Subtest cursor_plane_move: SKIP (0.000s)
[110.663402] [126/170] (887s left) kms_psr (sprite_plane_onoff)
[110.785416] Subtest sprite_plane_onoff: SKIP (0.000s)
[110.814175] [127/170] (887s left) kms_psr (primary_mmap_gtt)
[110.940743] Subtest primary_mmap_gtt: SKIP (0.000s)
[110.994240] [128/170] (887s left) kms_setmode (basic-clone-single-crtc)
[111.120172] Starting subtest: basic-clone-single-crtc
[111.123523] Subtest basic-clone-single-crtc: SKIP (0.000s)
[111.235703] [129/170] (887s left) i915_pm_backlight (basic-brightness)
[111.388825] Subtest basic-brightness: SKIP (0.000s)
[111.432324] [130/170] (887s left) i915_pm_rpm (basic-pci-d3-state)
[122.762322] Subtest basic-pci-d3-state: SKIP (0.000s)
[122.789468] [131/170] (875s left) i915_pm_rpm (basic-rte)
[122.909117] Starting subtest: basic-rte
[134.102665] Subtest basic-rte: SKIP (11.179s)
[134.127395] [132/170] (864s left) i915_pm_rps (basic-api)
[134.256255] Subtest basic-api: SKIP (0.000s)
[134.277517] [133/170] (864s left) prime_self_import (basic-llseek-bad)
[134.398604] Starting subtest: basic-llseek-bad
[134.399778] Subtest basic-llseek-bad: SUCCESS (0.002s)
[134.477913] [134/170] (864s left) prime_self_import (basic-llseek-size)
[134.598625] Starting subtest: basic-llseek-size
[134.599935] Subtest basic-llseek-size: SUCCESS (0.003s)
[134.678051] [135/170] (864s left) prime_self_import (basic-with_fd_dup)
[134.795818] Starting subtest: basic-with_fd_dup
[134.801829] Subtest basic-with_fd_dup: SUCCESS (0.004s)
[134.878999] [136/170] (863s left) prime_self_import (basic-with_one_bo)
[135.002545] Starting subtest: basic-with_one_bo
[135.003860] Subtest basic-with_one_bo: SUCCESS (0.003s)
[135.083482] [137/170] (863s left) prime_self_import (basic-with_one_bo_two_files)
[135.204792] Starting subtest: basic-with_one_bo_two_files
[135.205887] Subtest basic-with_one_bo_two_files: SUCCESS (0.002s)
[135.280453] [138/170] (863s left) prime_self_import (basic-with_two_bos)
[135.400840] Starting subtest: basic-with_two_bos
[135.402250] Subtest basic-with_two_bos: SUCCESS (0.003s)
[135.480731] [139/170] (863s left) prime_vgem (basic-fence-flip)
[135.611922] Starting subtest: basic-fence-flip
[135.994792] Subtest basic-fence-flip: SUCCESS (0.382s)
[136.083542] [140/170] (862s left) prime_vgem (basic-fence-mmap)
[136.213685] Starting subtest: basic-fence-mmap
[136.246446] Subtest basic-fence-mmap: SUCCESS (0.037s)
[136.318412] [141/170] (862s left) prime_vgem (basic-fence-read)
[136.448677] Starting subtest: basic-fence-read
[136.507854] Subtest basic-fence-read: SUCCESS (0.062s)
[136.584751] [142/170] (862s left) prime_vgem (basic-gtt)
[136.713963] Starting subtest: basic-gtt
[136.729372] Subtest basic-gtt: SUCCESS (0.018s)
[136.801686] [143/170] (862s left) prime_vgem (basic-read)
[136.929661] Starting subtest: basic-read
[136.959361] Subtest basic-read: SUCCESS (0.029s)
[137.037090] [144/170] (861s left) prime_vgem (basic-write)
[137.163877] Starting subtest: basic-write
[137.192442] Subtest basic-write: SUCCESS (0.030s)
[137.270586] [145/170] (861s left) vgem_basic (setversion)
[137.394208] Starting subtest: setversion
[137.396519] Subtest setversion: SUCCESS (0.000s)
[137.456667] [146/170] (861s left) vgem_basic (create)
[137.578085] Starting subtest: create
[137.579156] Subtest create: SUCCESS (0.000s)
[137.637779] [147/170] (861s left) vgem_basic (debugfs)
[137.762602] Starting subtest: debugfs
[137.763813] Subtest debugfs: SUCCESS (0.001s)
[137.822386] [148/170] (861s left) vgem_basic (dmabuf-export)
[137.947390] Starting subtest: dmabuf-export
[137.948601] Subtest dmabuf-export: SUCCESS (0.002s)
[138.022874] [149/170] (860s left) vgem_basic (dmabuf-fence)
[138.147420] Starting subtest: dmabuf-fence
[138.148630] Subtest dmabuf-fence: SUCCESS (0.001s)
[138.207797] [150/170] (860s left) vgem_basic (dmabuf-fence-before)
[138.332064] Starting subtest: dmabuf-fence-before
[138.333193] Subtest dmabuf-fence-before: SUCCESS (0.000s)
[138.390772] [151/170] (860s left) vgem_basic (dmabuf-mmap)
[138.514244] Starting subtest: dmabuf-mmap
[138.535679] Subtest dmabuf-mmap: SUCCESS (0.022s)
[138.591007] [152/170] (860s left) vgem_basic (mmap)
[138.714702] Starting subtest: mmap
[138.729404] Subtest mmap: SUCCESS (0.015s)
[138.791712] [153/170] (860s left) vgem_basic (second-client)
[138.915740] Starting subtest: second-client
[138.965308] Subtest second-client: SUCCESS (0.050s)
[139.026487] [154/170] (860s left) vgem_basic (sysfs)
[139.150603] Starting subtest: sysfs
[139.151735] Subtest sysfs: SUCCESS (0.001s)
[139.210718] [155/170] (859s left) core_hotunplug (unbind-rebind)
[139.385438] Starting subtest: unbind-rebind
[140.159863] Subtest unbind-rebind: SUCCESS (0.776s)
[140.197046] [156/170] (858s left) vgem_basic (unload)
[140.477204] Starting subtest: unload
[169.416322] Subtest unload: SUCCESS (28.937s)
[169.524496] [157/170] (829s left) i915_module_load (reload)
[169.644982] Starting subtest: reload
[171.671724] Subtest reload: SUCCESS (2.028s)
[171.713310] [158/170] (827s left) gem_lmem_swapping (basic)
[171.868161] Subtest basic: SKIP (0.000s)
[171.899802] [159/170] (827s left) gem_lmem_swapping (parallel-random-engines)
[172.052857] Subtest parallel-random-engines: SKIP (0.000s)
[172.121705] [160/170] (827s left) gem_lmem_swapping (random-engines)
[172.282455] Subtest random-engines: SKIP (0.000s)
[172.320608] [161/170] (826s left) gem_lmem_swapping (verify-random)
[172.448244] Subtest verify-random: SKIP (0.000s)
[172.487009] [162/170] (826s left) i915_pm_rpm (module-reload)
[183.818693] Subtest module-reload: SKIP (0.000s)
[183.841780] [163/170] (815s left) i915_selftest (live)
[184.622077] Starting subtest: live
[184.623285] Starting dynamic subtest: sanitycheck
[185.329449] Dynamic subtest sanitycheck: SUCCESS (0.709s)
[185.338216] Starting dynamic subtest: uncore
[185.976838] Dynamic subtest uncore: SUCCESS (0.646s)
[185.985978] Starting dynamic subtest: workarounds
[186.621694] Dynamic subtest workarounds: SUCCESS (0.644s)
[186.632055] Starting dynamic subtest: gt_engines
[187.260996] Dynamic subtest gt_engines: SUCCESS (0.638s)
[187.270845] Starting dynamic subtest: gt_timelines
[190.027958] Dynamic subtest gt_timelines: SUCCESS (2.766s)
[190.037776] Starting dynamic subtest: gt_contexts
[190.674617] Dynamic subtest gt_contexts: SUCCESS (0.646s)
[190.684480] Starting dynamic subtest: gt_lrc
[191.320907] Dynamic subtest gt_lrc: SUCCESS (0.645s)
[191.330151] Starting dynamic subtest: gt_mocs
[191.931774] Dynamic subtest gt_mocs: SUCCESS (0.610s)
[191.940153] Starting dynamic subtest: gt_pm
[193.013273] Dynamic subtest gt_pm: SUCCESS (1.078s)
[193.022117] Starting dynamic subtest: gt_heartbeat
[193.666477] Dynamic subtest gt_heartbeat: SUCCESS (0.655s)
[193.676456] Starting dynamic subtest: gt_tlb
[194.309870] Dynamic subtest gt_tlb: SUCCESS (0.642s)
[194.319564] Starting dynamic subtest: requests
[197.500588] Dynamic subtest requests: SUCCESS (3.189s)
[197.509459] Starting dynamic subtest: migrate
[198.130547] Dynamic subtest migrate: SUCCESS (0.631s)
[198.138654] Starting dynamic subtest: active
[198.785838] Dynamic subtest active: SUCCESS (0.654s)
[198.797374] Starting dynamic subtest: objects
[199.771913] Dynamic subtest objects: SUCCESS (0.984s)
[199.780703] Starting dynamic subtest: mman
[204.729523] Dynamic subtest mman: SUCCESS (4.957s)
[204.737339] Starting dynamic subtest: dmabuf
[205.415611] Dynamic subtest dmabuf: SUCCESS (0.686s)
[205.424249] Starting dynamic subtest: vma
[206.084878] Dynamic subtest vma: SUCCESS (0.668s)
[206.093413] Starting dynamic subtest: coherency
[207.793601] Dynamic subtest coherency: SUCCESS (1.707s)
[207.802702] Starting dynamic subtest: gtt
[211.858892] Dynamic subtest gtt: SUCCESS (4.064s)
[211.867619] Starting dynamic subtest: gem
[212.599036] Dynamic subtest gem: SUCCESS (0.739s)
[212.607369] Starting dynamic subtest: evict
[213.223594] Dynamic subtest evict: SUCCESS (0.625s)
[213.233245] Starting dynamic subtest: hugepages
[213.856041] Dynamic subtest hugepages: SUCCESS (0.631s)
[213.865387] Starting dynamic subtest: gem_contexts
[214.485695] Dynamic subtest gem_contexts: SUCCESS (0.629s)
[214.495173] Starting dynamic subtest: client
[215.138641] Dynamic subtest client: SUCCESS (0.652s)
[215.149092] Starting dynamic subtest: gem_migrate
[215.759911] Dynamic subtest gem_migrate: SUCCESS (0.620s)
[215.769850] Starting dynamic subtest: reset
[216.724242] Dynamic subtest reset: SUCCESS (0.962s)
[216.733692] Starting dynamic subtest: memory_region
[217.357643] Dynamic subtest memory_region: SUCCESS (0.634s)
[217.367993] Starting dynamic subtest: hangcheck
[219.065924] Dynamic subtest hangcheck: SUCCESS (1.707s)
[219.074794] Starting dynamic subtest: execlists
[219.749927] Dynamic subtest execlists: SUCCESS (0.683s)
[219.759317] Starting dynamic subtest: ring_submission
[220.406716] Dynamic subtest ring_submission: SUCCESS (0.656s)
[220.416702] Starting dynamic subtest: perf
[221.054034] Dynamic subtest perf: SUCCESS (0.646s)
[221.063348] Starting dynamic subtest: slpc
[221.736904] Dynamic subtest slpc: SUCCESS (0.682s)
[221.745678] Starting dynamic subtest: guc
[222.370673] Dynamic subtest guc: SUCCESS (0.633s)
[222.380136] Starting dynamic subtest: guc_multi_lrc
[223.028150] Dynamic subtest guc_multi_lrc: SUCCESS (0.655s)
[223.037059] Starting dynamic subtest: guc_hang
[223.679731] Dynamic subtest guc_hang: SUCCESS (0.652s)
[223.689482] Starting dynamic subtest: late_gt_pm
[224.342580] Dynamic subtest late_gt_pm: SUCCESS (0.663s)
[224.344136] Subtest live: SUCCESS (39.722s)
[224.487442] [164/170] (774s left) dmabuf (all-tests)
[224.620495] Starting subtest: all-tests
[224.621613] Starting dynamic subtest: sanitycheck
[224.669283] Dynamic subtest sanitycheck: SUCCESS (0.055s)
[224.678201] Starting dynamic subtest: dma_fence
[224.845370] Dynamic subtest dma_fence: SUCCESS (0.175s)
[224.854709] Starting dynamic subtest: dma_fence_chain
[242.214022] Dynamic subtest dma_fence_chain: SUCCESS (17.365s)
[242.227495] Starting dynamic subtest: dma_fence_unwrap
[242.276326] Dynamic subtest dma_fence_unwrap: SUCCESS (0.064s)
[242.293569] Starting dynamic subtest: dma_resv
[242.346372] Dynamic subtest dma_resv: SUCCESS (0.069s)
[242.347541] Subtest all-tests: SUCCESS (17.732s)
[242.368403] [165/170] (757s left) i915_suspend (basic-s2idle-without-i915)
[242.489867] Starting subtest: basic-s2idle-without-i915
[261.428670] Subtest basic-s2idle-without-i915: SUCCESS (18.939s)
[264.139591] [166/170] (737s left) i915_suspend (basic-s3-without-i915)
[264.269566] Starting subtest: basic-s3-without-i915
[281.114317] Subtest basic-s3-without-i915: SUCCESS (2.267s)
[283.699629] [167/170] (735s left) gem_exec_suspend (basic-s0)
[283.844174] Starting subtest: basic-S0
[283.845489] Starting dynamic subtest: smem
[300.933868] Dynamic subtest smem: SUCCESS (17.089s)
[300.935014] Subtest basic-S0: SUCCESS (17.090s)
[306.125575] [168/170] (718s left) gem_exec_suspend (basic-s3)
[306.257973] Starting subtest: basic-S3
[306.259764] Starting dynamic subtest: smem
[323.899507] Dynamic subtest smem: SUCCESS (1.904s)
[323.900638] Subtest basic-S3: SUCCESS (1.905s)
[328.624416] [169/170] (715s left) kms_chamelium_hpd (common-hpd-after-suspend)
[328.781796] Subtest common-hpd-after-suspend: SKIP (0.000s)
[328.828986] [170/170] (715s left) kms_pipe_crc_basic (suspend-read-crc)
[328.983742] Starting subtest: suspend-read-crc
[328.986864] Starting dynamic subtest: pipe-A-VGA-1
[346.925787] Dynamic subtest pipe-A-VGA-1: SUCCESS (1.739s)
[346.942917] Starting dynamic subtest: pipe-B-VGA-1
[364.921112] Dynamic subtest pipe-B-VGA-1: SUCCESS (1.735s)
[364.923145] Subtest suspend-read-crc: SUCCESS (3.486s)
[370.028296] Closing watchdogs
Done.