[42.654601] Initializing watchdogs
[42.655132]   /dev/watchdog0
[42.688472] [001/142] (960s left) feature_discovery (display-3x)
[43.163291] Starting subtest: display-3x
[43.170743] Subtest display-3x: SKIP (0.000s)
[43.271373] [002/142] (959s left) gem_eio (create-ext)
[44.123802] Starting subtest: create-ext
[45.601318] Subtest create-ext: SUCCESS (1.481s)
[47.691854] [003/142] (955s left) gem_set_tiling_vs_pwrite
[48.198946] [004/142] (955s left) gem_exec_reloc (basic-cpu-gtt-noreloc)
[48.599057] Subtest basic-cpu-gtt-noreloc: SKIP (0.000s)
[48.722699] [005/142] (954s left) syncobj_basic (bad-create-flags)
[49.106949] Starting subtest: bad-create-flags
[49.110630] Subtest bad-create-flags: SUCCESS (0.000s)
[49.259066] [006/142] (954s left) kms_cursor_crc (cursor-dpms)
[49.842742] Starting subtest: cursor-dpms
[49.847303] Starting dynamic subtest: pipe-A-eDP-1
[54.448906] Dynamic subtest pipe-A-eDP-1: SUCCESS (4.599s)
[54.482096] Starting dynamic subtest: pipe-D-eDP-1
[59.754491] Dynamic subtest pipe-D-eDP-1: SUCCESS (5.298s)
[59.757795] Subtest cursor-dpms: SUCCESS (9.912s)
[61.205695] [007/142] (942s left) gem_exec_fence (basic-busy)
[61.791467] Starting subtest: basic-busy
[61.795246] Starting dynamic subtest: rcs0
[61.869696] Dynamic subtest rcs0: SUCCESS (0.079s)
[61.905490] Starting dynamic subtest: bcs0
[61.926362] Dynamic subtest bcs0: SUCCESS (0.055s)
[61.966547] Starting dynamic subtest: vcs0
[61.973352] Dynamic subtest vcs0: SUCCESS (0.036s)
[62.006636] Starting dynamic subtest: vcs1
[62.012528] Dynamic subtest vcs1: SUCCESS (0.036s)
[62.046073] Starting dynamic subtest: vecs0
[62.053192] Dynamic subtest vecs0: SUCCESS (0.046s)
[62.086984] Starting dynamic subtest: ccs0
[62.115598] Dynamic subtest ccs0: SUCCESS (0.068s)
[62.119263] Subtest basic-busy: SUCCESS (0.326s)
[64.120963] [008/142] (939s left) kms_chamelium_hpd (dp-hpd-fast)
[65.002968] Subtest dp-hpd-fast: SKIP (0.000s)
[65.893851] [009/142] (937s left) perf_pmu (busy-no-semaphores)
[66.225597] Starting subtest: busy-no-semaphores
[66.229685] Starting dynamic subtest: rcs0
[66.801081] Dynamic subtest rcs0: SUCCESS (0.575s)
[66.828620] Starting dynamic subtest: bcs0
[67.371915] Dynamic subtest bcs0: SUCCESS (0.569s)
[67.400374] Starting dynamic subtest: vcs0
[67.942554] Dynamic subtest vcs0: SUCCESS (0.569s)
[67.977082] Starting dynamic subtest: vcs1
[69.022286] Dynamic subtest vcs1: SUCCESS (1.080s)
[69.058279] Starting dynamic subtest: vecs0
[71.066546] Dynamic subtest vecs0: SUCCESS (2.043s)
[71.102382] Starting dynamic subtest: ccs0
[73.050106] Dynamic subtest ccs0: SUCCESS (1.983s)
[73.054101] Subtest busy-no-semaphores: SUCCESS (6.824s)
[73.259320] [010/142] (930s left) i915_pm_rpm (modeset-lpsp)
[75.702063] Starting subtest: modeset-lpsp
[80.168283] Subtest modeset-lpsp: SUCCESS (4.466s)
[80.370860] [011/142] (923s left) gem_linear_blits (normal)
[83.298416] Starting subtest: normal
[104.684836] Subtest normal: SUCCESS (21.385s)
[104.862750] [012/142] (899s left) perf (blocking)
[105.970092] Starting subtest: blocking
[105.973317] Starting dynamic subtest: 0-rcs0
[116.065036] Dynamic subtest 0-rcs0: SUCCESS (10.094s)
[116.103747] Starting dynamic subtest: 1-vecs0
[126.113652] Dynamic subtest 1-vecs0: SUCCESS (10.046s)
[126.117802] Subtest blocking: SUCCESS (20.143s)
[126.218508] [013/142] (877s left) kms_plane_scaling (plane-downscale-with-pixel-format-factor-0-25)
[126.726387] Starting subtest: plane-downscale-with-pixel-format-factor-0-25
[126.734769] Starting dynamic subtest: pipe-A-eDP-1
[126.907150] Dynamic subtest pipe-A-eDP-1: SKIP (0.172s)
[126.946492] Starting dynamic subtest: pipe-B-eDP-1
[127.175090] Dynamic subtest pipe-B-eDP-1: SKIP (0.260s)
[127.214733] Starting dynamic subtest: pipe-C-eDP-1
[127.458311] Dynamic subtest pipe-C-eDP-1: SKIP (0.273s)
[127.511229] Starting dynamic subtest: pipe-D-eDP-1
[127.718907] Dynamic subtest pipe-D-eDP-1: SKIP (0.256s)
[127.724447] Subtest plane-downscale-with-pixel-format-factor-0-25: SKIP (0.993s)
[127.900609] [014/142] (876s left) gem_exec_reloc (basic-write-wc-active)
[128.297730] Subtest basic-write-wc-active: SKIP (0.000s)
[128.422698] [015/142] (875s left) kms_ccs (pipe-a-bad-aux-stride-4_tiled_mtl_rc_ccs)
[129.466298] Starting subtest: pipe-A-bad-aux-stride-4_tiled_mtl_rc_ccs
[129.470169] Subtest pipe-A-bad-aux-stride-4_tiled_mtl_rc_ccs: SUCCESS (0.003s)
[130.770096] [016/142] (873s left) kms_big_fb (linear-addfb)
[131.311454] Starting subtest: linear-addfb
[131.315964] Subtest linear-addfb: SUCCESS (0.001s)
[131.478374] [017/142] (872s left) kms_ccs (pipe-a-random-ccs-data-y_tiled_ccs)
[132.454850] Starting subtest: pipe-A-random-ccs-data-y_tiled_ccs
[132.463645] Subtest pipe-A-random-ccs-data-y_tiled_ccs: SKIP (0.000s)
[133.833085] [018/142] (870s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-mmap-wc)
[134.326626] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-mmap-wc
[143.799943] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-mmap-wc: SUCCESS (9.473s)
[144.065923] [019/142] (860s left) gem_userptr_blits (map-fixed-invalidate-overlap-busy)
[144.521672] Starting subtest: map-fixed-invalidate-overlap-busy
[144.528371] Subtest map-fixed-invalidate-overlap-busy: SKIP (0.000s)
[144.737688] [020/142] (859s left) gem_ppgtt (shrink-vs-evict-pinned)
[145.119328] Starting subtest: shrink-vs-evict-pinned
[150.648386] Subtest shrink-vs-evict-pinned: SUCCESS (5.527s)
[150.826138] [021/142] (853s left) kms_pipe_crc_basic (nonblocking-crc-frame-sequence)
[151.322137] Starting subtest: nonblocking-crc-frame-sequence
[151.331079] Starting dynamic subtest: pipe-A-eDP-1
[152.640643] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.311s)
[152.688682] Starting dynamic subtest: pipe-B-eDP-1
[154.633289] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.983s)
[154.680930] Starting dynamic subtest: pipe-C-eDP-1
[156.357306] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.710s)
[156.404403] Starting dynamic subtest: pipe-D-eDP-1
[158.073780] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.718s)
[158.077484] Subtest nonblocking-crc-frame-sequence: SUCCESS (6.751s)
[159.023472] [022/142] (845s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-32bpp-ytile-upscaling)
[159.517132] Starting subtest: flip-64bpp-ytile-to-32bpp-ytile-upscaling
[159.525333] Starting dynamic subtest: pipe-A-default-mode
[159.934328] Dynamic subtest pipe-A-default-mode: SKIP (0.405s)
[159.941201] Subtest flip-64bpp-ytile-to-32bpp-ytile-upscaling: SKIP (0.417s)
[160.876735] [023/142] (844s left) syncobj_timeline (single-wait-all-available-signaled)
[161.245285] Starting subtest: single-wait-all-available-signaled
[161.248811] Subtest single-wait-all-available-signaled: SUCCESS (0.002s)
[161.384136] [024/142] (843s left) kms_cursor_crc (cursor-sliding-128x42)
[162.319470] Starting subtest: cursor-sliding-128x42
[162.348338] Starting dynamic subtest: pipe-A-eDP-1
[168.561744] Dynamic subtest pipe-A-eDP-1: SUCCESS (6.212s)
[168.750932] Starting dynamic subtest: pipe-D-eDP-1
[176.564210] Dynamic subtest pipe-D-eDP-1: SUCCESS (7.854s)
[176.567490] Subtest cursor-sliding-128x42: SUCCESS (14.247s)
[177.571404] [025/142] (827s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-mmap-wc)
[178.070807] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-mmap-wc
[178.076904] Subtest psr-2p-primscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[178.240241] [026/142] (826s left) gem_mmap_gtt (close-race)
[178.605178] Subtest close-race: SKIP (0.000s)
[178.721357] [027/142] (826s left) gem_eio (execbuf)
[180.322226] Starting subtest: execbuf
[182.592817] Subtest execbuf: SUCCESS (2.269s)
[184.655865] [028/142] (820s left) kms_chamelium_edid (dp-mode-timings)
[185.534709] Subtest dp-mode-timings: SKIP (0.000s)
[186.402680] [029/142] (819s left) kms_flip (plain-flip-interruptible)
[186.818613] Starting subtest: plain-flip-interruptible
[186.851286] Starting dynamic subtest: A-eDP1
[189.124217] Dynamic subtest A-eDP1: SUCCESS (2.273s)
[189.168140] Starting dynamic subtest: B-eDP1
[191.206561] Dynamic subtest B-eDP1: SUCCESS (2.078s)
[191.245903] Starting dynamic subtest: C-eDP1
[193.257476] Dynamic subtest C-eDP1: SUCCESS (2.047s)
[193.304900] Starting dynamic subtest: D-eDP1
[195.344718] Dynamic subtest D-eDP1: SUCCESS (2.081s)
[195.369359] Subtest plain-flip-interruptible: SUCCESS (8.551s)
[196.918505] [030/142] (808s left) gem_ctx_persistence (saturated-hostile)
[197.320769] Starting subtest: saturated-hostile
[197.324419] Starting dynamic subtest: rcs0
[197.451323] Dynamic subtest rcs0: SUCCESS (0.125s)
[197.494048] Starting dynamic subtest: bcs0
[197.562755] Dynamic subtest bcs0: SUCCESS (0.113s)
[197.607753] Starting dynamic subtest: vcs0
[198.463290] Dynamic subtest vcs0: FAIL (0.834s)
[198.483510] Starting dynamic subtest: vcs1
[199.302407] Dynamic subtest vcs1: FAIL (0.834s)
[199.350966] Starting dynamic subtest: vecs0
[200.155553] Dynamic subtest vecs0: FAIL (0.844s)
[200.204579] Starting dynamic subtest: ccs0
[200.231290] Dynamic subtest ccs0: SUCCESS (0.143s)
[200.235383] Subtest saturated-hostile: FAIL (2.912s)
[200.456465] [031/142] (805s left) gen3_render_linear_blits
[200.944588] [032/142] (804s left) kms_force_connector_basic (force-load-detect)
[201.336227] Starting subtest: force-load-detect
[201.344932] Subtest force-load-detect: SKIP (0.000s)
[201.581127] [033/142] (804s left) kms_ccs (pipe-a-ccs-on-another-bo-y_tiled_gen12_rc_ccs)
[202.598253] Starting subtest: pipe-A-ccs-on-another-bo-y_tiled_gen12_rc_ccs
[202.604894] Subtest pipe-A-ccs-on-another-bo-y_tiled_gen12_rc_ccs: SKIP (0.000s)
[203.968078] [034/142] (801s left) gem_exec_params (invalid-bsd2-flag-on-vebox)
[204.366827] Starting subtest: invalid-bsd2-flag-on-vebox
[204.370649] Subtest invalid-bsd2-flag-on-vebox: SUCCESS (0.001s)
[204.527802] [035/142] (801s left) kms_hdr (static-toggle-dpms)
[205.007418] Starting subtest: static-toggle-dpms
[205.014510] Subtest static-toggle-dpms: SKIP (0.001s)
[205.151829] [036/142] (800s left) syncobj_timeline (host-signal-points)
[205.515419] Starting subtest: host-signal-points
[205.550249] Subtest host-signal-points: SUCCESS (0.035s)
[205.693188] [037/142] (800s left) drm_fdinfo (virtual-busy-idle)
[206.073446] Starting subtest: virtual-busy-idle
[206.080365] Subtest virtual-busy-idle: SKIP (0.001s)
[206.217071] [038/142] (799s left) kms_ccs (pipe-b-bad-pixel-format-yf_tiled_ccs)
[207.303879] Starting subtest: pipe-B-bad-pixel-format-yf_tiled_ccs
[207.310758] Subtest pipe-B-bad-pixel-format-yf_tiled_ccs: SKIP (0.000s)
[208.576576] [039/142] (797s left) prime_vgem (basic-fence-blt)
[208.994444] Starting subtest: basic-fence-blt
[209.230894] Subtest basic-fence-blt: FAIL (0.226s)
[209.430915] [040/142] (796s left) kms_flip (plain-flip-ts-check)
[209.818970] Starting subtest: plain-flip-ts-check
[209.850225] Starting dynamic subtest: A-eDP1
[219.298214] Dynamic subtest A-eDP1: SUCCESS (9.448s)
[219.345212] Starting dynamic subtest: B-eDP1
[228.538065] Dynamic subtest B-eDP1: SUCCESS (9.235s)
[228.584228] Starting dynamic subtest: C-eDP1
[237.811600] Dynamic subtest C-eDP1: SUCCESS (9.268s)
[237.861061] Starting dynamic subtest: D-eDP1
[247.073334] Dynamic subtest D-eDP1: SUCCESS (9.253s)
[247.098916] Subtest plain-flip-ts-check: SUCCESS (37.283s)
[248.716345] [041/142] (757s left) prime_self_import (basic-llseek-size)
[249.072185] Starting subtest: basic-llseek-size
[249.085340] Subtest basic-llseek-size: SUCCESS (0.013s)
[249.253598] [042/142] (757s left) gem_render_copy (y-tiled-ccs-to-y-tiled)
[249.654973] Starting subtest: y-tiled-ccs-to-y-tiled
[249.661896] Subtest y-tiled-ccs-to-y-tiled: SKIP (0.000s)
[249.922283] [043/142] (756s left) syncobj_wait (wait-for-submit-complex)
[250.300342] Starting subtest: wait-for-submit-complex
[250.366361] Subtest wait-for-submit-complex: SUCCESS (0.065s)
[250.516473] [044/142] (756s left) i915_pm_rpm (fences-dpms)
[256.605111] Starting subtest: fences-dpms
[256.611717] Subtest fences-dpms: SKIP (0.000s)
[257.531486] [045/142] (749s left) kms_plane_scaling (plane-upscale-with-rotation-factor-0-25)
[258.010936] Starting subtest: plane-upscale-with-rotation-factor-0-25
[258.020025] Starting dynamic subtest: pipe-A-eDP-1
[258.962825] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.944s)
[259.015833] Starting dynamic subtest: pipe-B-eDP-1
[261.181761] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.207s)
[261.232062] Starting dynamic subtest: pipe-C-eDP-1
[263.467834] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.273s)
[263.524453] Starting dynamic subtest: pipe-D-eDP-1
[265.750581] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.272s)
[265.754456] Subtest plane-upscale-with-rotation-factor-0-25: SUCCESS (7.743s)
[267.209578] [046/142] (739s left) gem_exec_whisper (basic-contexts-priority-all)
[267.642563] Starting subtest: basic-contexts-priority-all
[388.696725] Per-test timeout exceeded. Killing the current test with SIGQUIT.
[392.715911] Closing watchdogs
[392.730347] Initializing watchdogs
[392.730664]   /dev/watchdog0
[392.788631] [047/142] (614s left) gem_workarounds (suspend-resume-context)
[393.270872] Starting subtest: suspend-resume-context
[410.584049] Subtest suspend-resume-context: SUCCESS (17.319s)
[410.795734] [048/142] (596s left) gem_exec_balancer (invalid-bonds)
[411.127375] Starting subtest: invalid-bonds
[411.134659] Subtest invalid-bonds: SKIP (0.003s)
[411.667693] [049/142] (595s left) kms_cursor_legacy (short-busy-flip-before-cursor-atomic-transitions)
[412.237207] Starting subtest: short-busy-flip-before-cursor-atomic-transitions
[412.244295] Subtest short-busy-flip-before-cursor-atomic-transitions: SKIP (0.000s)
[412.478717] [050/142] (594s left) kms_ccs (pipe-b-bad-rotation-90-y_tiled_gen12_rc_ccs)
[413.611306] Starting subtest: pipe-B-bad-rotation-90-y_tiled_gen12_rc_ccs
[413.617916] Subtest pipe-B-bad-rotation-90-y_tiled_gen12_rc_ccs: SKIP (0.000s)
[414.806675] [051/142] (592s left) vc4/vc4_purgeable_bo (mark-unpurgeable-purged)
[415.269877] Subtest mark-unpurgeable-purged: SKIP (0.000s)
[415.402208] [052/142] (592s left) kms_frontbuffer_tracking (fbc-suspend)
[415.906374] Starting subtest: fbc-suspend
[456.999312] Subtest fbc-suspend: SUCCESS (41.097s)
[457.285694] [053/142] (550s left) gem_watchdog (default-virtual)
[457.694436] Starting subtest: default-virtual
[463.995931] Subtest default-virtual: SUCCESS (6.304s)
[464.190875] [054/142] (543s left) kms_ccs (pipe-c-crc-primary-basic-4_tiled_dg2_rc_ccs)
[465.606733] Starting subtest: pipe-C-crc-primary-basic-4_tiled_dg2_rc_ccs
[465.613505] Subtest pipe-C-crc-primary-basic-4_tiled_dg2_rc_ccs: SKIP (0.002s)
[466.619504] [055/142] (541s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-pwrite)
[467.137795] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-pwrite
[472.758450] Subtest fbc-1p-primscrn-spr-indfb-draw-pwrite: SUCCESS (5.630s)
[473.056141] [056/142] (534s left) vc4/vc4_perfmon (create-perfmon-0)
[473.530048] Subtest create-perfmon-0: SKIP (0.000s)
[473.675278] [057/142] (534s left) gen9_exec_parse (batch-zero-length)
[474.067228] Subtest batch-zero-length: SKIP (0.000s)
[474.198765] [058/142] (533s left) kms_frontbuffer_tracking (fbc-1p-offscren-pri-shrfb-draw-mmap-gtt)
[474.708335] Starting subtest: fbc-1p-offscren-pri-shrfb-draw-mmap-gtt
[474.715684] Subtest fbc-1p-offscren-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[474.896322] [059/142] (533s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-move)
[475.417549] Starting subtest: psr-2p-scndscrn-spr-indfb-move
[475.424194] Subtest psr-2p-scndscrn-spr-indfb-move: SKIP (0.000s)
[475.594880] [060/142] (532s left) kms_vblank (pipe-b-query-forked-hang)
[476.075320] Starting subtest: pipe-B-query-forked-hang
[491.898898] Subtest pipe-B-query-forked-hang: SUCCESS (15.823s)
[492.865114] [061/142] (515s left) kms_big_fb (yf-tiled-16bpp-rotate-90)
[493.398790] Starting subtest: yf-tiled-16bpp-rotate-90
[493.404747] Subtest yf-tiled-16bpp-rotate-90: SKIP (0.000s)
[493.555520] [062/142] (514s left) gem_lmem_swapping (basic)
[493.943717] Subtest basic: SKIP (0.000s)
[494.081377] [063/142] (514s left) gem_mmap_wc (write-cpu-read-wc-unflushed)
[494.449222] Subtest write-cpu-read-wc-unflushed: SKIP (0.000s)
[494.580496] [064/142] (514s left) kms_frontbuffer_tracking (psr-1p-offscren-pri-indfb-draw-mmap-gtt)
[494.954434] Starting subtest: psr-1p-offscren-pri-indfb-draw-mmap-gtt
[494.960260] Subtest psr-1p-offscren-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[495.107622] [065/142] (513s left) vgem_basic (bad-pad)
[495.490949] Starting subtest: bad-pad
[495.495219] Subtest bad-pad: SUCCESS (0.000s)
[495.632190] [066/142] (513s left) kms_psr2_su (frontbuffer-xrgb8888)
[496.002246] Subtest frontbuffer-XRGB8888: SKIP (0.000s)
[496.129384] [067/142] (512s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-0-async-flip)
[496.645810] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-0-async-flip
[496.652504] Subtest y-tiled-max-hw-stride-64bpp-rotate-0-async-flip: SKIP (0.000s)
[496.818448] [068/142] (512s left) kms_chamelium_hpd (vga-hpd-without-ddc)
[497.705199] Subtest vga-hpd-without-ddc: SKIP (0.000s)
[498.592072] [069/142] (510s left) kms_ccs (pipe-d-bad-rotation-90-4_tiled_mtl_mc_ccs)
[500.219803] Starting subtest: pipe-D-bad-rotation-90-4_tiled_mtl_mc_ccs
[512.451062] Killing the test because the kernel is tainted.
[632.461835] Timeout. Killing the current test with SIGKILL.
[633.465867] Child refuses to die, tainted 0xc0. Aborting.
[633.467441] Closing watchdogs
[633.469720] Closing watchdogs
Done.