[42.546231] Initializing watchdogs
[42.546270]   /dev/watchdog0
[42.552364] [001/143] (960s left) perf (stress-open-close)
[42.667685] Starting subtest: stress-open-close
[42.670448] Starting dynamic subtest: 0-rcs0
[44.844734] Dynamic subtest 0-rcs0: SUCCESS (2.180s)
[44.857913] Starting dynamic subtest: 1-vcs0
[47.014054] Dynamic subtest 1-vcs0: SUCCESS (2.169s)
[47.016292] Subtest stress-open-close: SUCCESS (4.349s)
[47.048987] [002/143] (956s left) kms_plane (plane-position-hole-dpms)
[47.130842] Starting subtest: plane-position-hole-dpms
[47.133492] Starting dynamic subtest: pipe-A
[57.996773] Dynamic subtest pipe-A: SUCCESS (10.864s)
[58.010242] Starting dynamic subtest: pipe-B
[69.602739] Dynamic subtest pipe-B: SUCCESS (11.604s)
[69.605794] Subtest plane-position-hole-dpms: SUCCESS (22.471s)
[70.448130] [003/143] (932s left) kms_ccs (pipe-d-bad-aux-stride-y-tiled-ccs)
[70.877449] Starting subtest: pipe-D-bad-aux-stride-y-tiled-ccs
[70.884043] Subtest pipe-D-bad-aux-stride-y-tiled-ccs: SKIP (0.000s)
[71.722399] [004/143] (931s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-mmap-cpu)
[71.794529] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-mmap-cpu
[71.798774] Subtest fbc-2p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[71.881831] [005/143] (931s left) syncobj_timeline (etime-single-wait-all-for-submit-unsubmitted)
[71.938959] Starting subtest: etime-single-wait-all-for-submit-unsubmitted
[72.045223] Subtest etime-single-wait-all-for-submit-unsubmitted: SUCCESS (0.109s)
[72.114278] [006/143] (931s left) kms_scaling_modes (scaling-mode-none)
[72.199318] Starting subtest: scaling-mode-none
[72.201896] Starting dynamic subtest: pipe-A-eDP-1
[72.332861] Dynamic subtest pipe-A-eDP-1: SKIP (0.130s)
[72.348622] Starting dynamic subtest: pipe-B-eDP-1
[72.390801] Dynamic subtest pipe-B-eDP-1: SKIP (0.057s)
[72.406477] Starting dynamic subtest: pipe-C-eDP-1
[72.420154] Dynamic subtest pipe-C-eDP-1: SKIP (0.029s)
[72.433549] Starting dynamic subtest: pipe-D-eDP-1
[72.447407] Dynamic subtest pipe-D-eDP-1: SKIP (0.026s)
[72.452675] Subtest scaling-mode-none: SKIP (0.248s)
[72.532993] [007/143] (930s left) gem_exec_capture (capture-recoverable)
[72.588237] Starting subtest: capture-recoverable
[72.590596] Subtest capture-recoverable: SUCCESS (0.003s)
[72.693396] [008/143] (930s left) gen9_exec_parse (bb-start-out)
[72.749145] Subtest bb-start-out: SKIP (0.000s)
[72.773529] [009/143] (930s left) gem_pwrite (basic-exhaustion)
[72.832735] Subtest basic-exhaustion: SKIP (0.000s)
[72.887421] [010/143] (930s left) kms_psr (fbc-psr-cursor-blt)
[72.949330] Starting subtest: fbc-psr-cursor-blt
[72.952030] Starting dynamic subtest: eDP-1
[72.956938] Dynamic subtest eDP-1: SKIP (0.000s)
[72.961335] Subtest fbc-psr-cursor-blt: SKIP (0.000s)
[73.046894] [011/143] (930s left) kms_psr (fbc-psr-sprite-plane-onoff)
[73.143337] Starting subtest: fbc-psr-sprite-plane-onoff
[73.145709] Starting dynamic subtest: eDP-1
[73.150253] Dynamic subtest eDP-1: SKIP (0.000s)
[73.154432] Subtest fbc-psr-sprite-plane-onoff: SKIP (0.000s)
[73.238316] [012/143] (930s left) gem_exec_schedule (preemptive-hang)
[73.390201] Starting subtest: preemptive-hang
[73.392895] Starting dynamic subtest: rcs0
[82.743112] Dynamic subtest rcs0: SUCCESS (9.350s)
[82.756687] Starting dynamic subtest: bcs0
[91.709696] Dynamic subtest bcs0: SUCCESS (8.967s)
[91.725504] Starting dynamic subtest: vcs0
[100.735782] Dynamic subtest vcs0: SUCCESS (9.026s)
[100.749655] Starting dynamic subtest: vcs1
[109.690057] Dynamic subtest vcs1: SUCCESS (8.955s)
[109.695155] Starting dynamic subtest: vecs0
[118.708986] Dynamic subtest vecs0: SUCCESS (9.019s)
[118.725128] Starting dynamic subtest: ccs0
[127.741042] Dynamic subtest ccs0: SUCCESS (9.031s)
[127.744170] Subtest preemptive-hang: SUCCESS (54.349s)
[127.969067] [013/143] (875s left) kms_cursor_legacy (torture-bo)
[128.075081] Starting subtest: torture-bo
[128.077598] Starting dynamic subtest: pipe-A
[135.421608] Dynamic subtest pipe-A: SUCCESS (7.339s)
[135.437788] Starting dynamic subtest: pipe-B
[141.823450] Dynamic subtest pipe-B: SUCCESS (6.405s)
[141.840348] Starting dynamic subtest: pipe-C
[148.550637] Dynamic subtest pipe-C: SUCCESS (6.726s)
[148.565816] Starting dynamic subtest: pipe-D
[155.814851] Dynamic subtest pipe-D: SUCCESS (7.264s)
[155.830451] Starting dynamic subtest: all-pipes
[162.419797] Dynamic subtest all-pipes: SUCCESS (6.604s)
[162.422561] Subtest torture-bo: SUCCESS (34.341s)
[162.578612] [014/143] (840s left) kms_psr (pr-primary-mmap-cpu)
[162.648543] Starting subtest: pr-primary-mmap-cpu
[162.653243] Subtest pr-primary-mmap-cpu: SKIP (0.000s)
[162.763253] [015/143] (840s left) gem_mmap_offset (open-flood)
[162.820128] Starting subtest: open-flood
[184.303833] Subtest open-flood: SUCCESS (21.487s)
[184.402124] [016/143] (819s left) kms_ccs (pipe-d-crc-sprite-planes-basic-4-tiled-mtl-rc-ccs)
[184.859710] Starting subtest: pipe-D-crc-sprite-planes-basic-4-tiled-mtl-rc-ccs
[186.526837] Subtest pipe-D-crc-sprite-planes-basic-4-tiled-mtl-rc-ccs: SUCCESS (1.668s)
[187.755591] [017/143] (815s left) gem_exec_reloc (basic-wc-read-active)
[187.849220] Subtest basic-wc-read-active: SKIP (0.000s)
[187.910248] [018/143] (815s left) kms_big_fb (linear-8bpp-rotate-270)
[187.979220] Starting subtest: linear-8bpp-rotate-270
[187.996942] Subtest linear-8bpp-rotate-270: SKIP (0.019s)
[188.106725] [019/143] (815s left) kms_ccs (pipe-a-bad-aux-stride-4-tiled-mtl-rc-ccs-cc)
[188.500071] Starting subtest: pipe-A-bad-aux-stride-4-tiled-mtl-rc-ccs-cc
[188.503159] Subtest pipe-A-bad-aux-stride-4-tiled-mtl-rc-ccs-cc: SUCCESS (0.000s)
[189.419214] [020/143] (814s left) v3d/v3d_submit_csd (multiple-job-submission)
[189.531459] Subtest multiple-job-submission: SKIP (0.000s)
[189.581603] [021/143] (814s left) kms_rotation_crc (exhaust-fences)
[189.656256] Starting subtest: exhaust-fences
[189.660776] Subtest exhaust-fences: SKIP (0.000s)
[189.712510] [022/143] (813s left) kms_ccs (pipe-b-bad-aux-stride-4-tiled-mtl-mc-ccs)
[190.075634] Starting subtest: pipe-B-bad-aux-stride-4-tiled-mtl-mc-ccs
[190.151971] Subtest pipe-B-bad-aux-stride-4-tiled-mtl-mc-ccs: SUCCESS (0.077s)
[190.922920] [023/143] (812s left) syncobj_wait (signal)
[190.982458] Starting subtest: signal
[190.984725] Subtest signal: SUCCESS (0.001s)
[191.065744] [024/143] (812s left) kms_flip (2x-flip-vs-expired-vblank)
[191.132244] Starting subtest: 2x-flip-vs-expired-vblank
[191.158756] Subtest 2x-flip-vs-expired-vblank: SKIP (0.026s)
[191.238155] [025/143] (812s left) prime_vgem (fence-wait)
[191.332630] Starting subtest: fence-wait
[191.335152] Starting dynamic subtest: rcs0
[192.372281] Dynamic subtest rcs0: SUCCESS (1.039s)
[192.388966] Starting dynamic subtest: bcs0
[193.420591] Dynamic subtest bcs0: SUCCESS (1.046s)
[193.435392] Starting dynamic subtest: vcs0
[194.471066] Dynamic subtest vcs0: SUCCESS (1.049s)
[194.486182] Starting dynamic subtest: vcs1
[195.518908] Dynamic subtest vcs1: SUCCESS (1.046s)
[195.533711] Starting dynamic subtest: vecs0
[196.569346] Dynamic subtest vecs0: SUCCESS (1.048s)
[196.584560] Starting dynamic subtest: ccs0
[198.504091] Dynamic subtest ccs0: SUCCESS (1.933s)
[198.507156] Subtest fence-wait: SUCCESS (7.172s)
[198.618332] [026/143] (805s left) kms_psr (fbc-pr-basic)
[198.708331] Starting subtest: fbc-pr-basic
[198.713309] Subtest fbc-pr-basic: SKIP (0.000s)
[198.830682] [027/143] (804s left) gem_pxp (regular-baseline-src-copy-readible)
[201.474432] Subtest regular-baseline-src-copy-readible: SKIP (0.000s)
[201.502222] [028/143] (802s left) kms_flip (bo-too-big-interruptible)
[201.573614] Starting subtest: bo-too-big-interruptible
[201.576257] Starting dynamic subtest: A-eDP1
[203.123496] Dynamic subtest A-eDP1: SUCCESS (1.548s)
[203.137039] Starting dynamic subtest: B-eDP1
[204.517697] Dynamic subtest B-eDP1: SUCCESS (1.393s)
[204.524734] Starting dynamic subtest: C-eDP1
[205.944551] Dynamic subtest C-eDP1: SUCCESS (1.425s)
[205.959921] Starting dynamic subtest: D-eDP1
[207.417737] Dynamic subtest D-eDP1: SUCCESS (1.473s)
[207.426563] Subtest bo-too-big-interruptible: SUCCESS (5.854s)
[208.747477] [029/143] (795s left) syncobj_wait (multi-wait-all-for-submit-submitted)
[208.791949] Starting subtest: multi-wait-all-for-submit-submitted
[208.892071] Subtest multi-wait-all-for-submit-submitted: SUCCESS (0.103s)
[208.964504] [030/143] (794s left) kms_psr2_sf (fbc-overlay-plane-move-continuous-exceed-fully-sf)
[214.230965] Starting subtest: fbc-overlay-plane-move-continuous-exceed-fully-sf
[214.233721] Starting dynamic subtest: pipe-A-eDP-1
[215.061533] Dynamic subtest pipe-A-eDP-1: SKIP (0.827s)
[215.075317] Starting dynamic subtest: pipe-B-eDP-1
[216.383389] Dynamic subtest pipe-B-eDP-1: SKIP (1.316s)
[216.388146] Subtest fbc-overlay-plane-move-continuous-exceed-fully-sf: SKIP (2.151s)
[217.644850] [031/143] (786s left) kms_vblank (wait-forked-hang)
[217.716360] Starting subtest: wait-forked-hang
[217.719119] Starting dynamic subtest: pipe-A-eDP-1
[231.379130] Dynamic subtest pipe-A-eDP-1: SUCCESS (13.664s)
[231.395671] Starting dynamic subtest: pipe-D-eDP-1
[246.348920] Dynamic subtest pipe-D-eDP-1: SUCCESS (14.963s)
[246.352155] Subtest wait-forked-hang: SUCCESS (28.636s)
[247.277422] [032/143] (756s left) gem_userptr_blits (readonly-unsync)
[247.334701] Subtest readonly-unsync: SKIP (0.000s)
[247.440427] [033/143] (756s left) gem_create (hog-create)
[247.514095] Starting subtest: hog-create
[247.516755] Starting dynamic subtest: smem0
[262.687423] Dynamic subtest smem0: FAIL (15.092s)
[262.689858] Subtest hog-create: FAIL (15.092s)
[262.821441] [034/143] (741s left) syncobj_timeline (invalid-transfer-non-existent-point)
[262.884953] Starting subtest: invalid-transfer-non-existent-point
[262.888539] Subtest invalid-transfer-non-existent-point: SUCCESS (0.000s)
[262.958987] [035/143] (741s left) kms_cursor_legacy (flip-vs-cursor-toggle)
[263.038733] Starting subtest: flip-vs-cursor-toggle
[269.222406] Subtest flip-vs-cursor-toggle: SUCCESS (6.183s)
[270.128681] [036/143] (733s left) kms_ccs (pipe-a-random-ccs-data-4-tiled-dg2-mc-ccs)
[270.511410] Starting subtest: pipe-A-random-ccs-data-4-tiled-dg2-mc-ccs
[270.520083] Subtest pipe-A-random-ccs-data-4-tiled-dg2-mc-ccs: SKIP (0.000s)
[271.406061] [037/143] (732s left) kms_pm_rpm (dpms-mode-unset-lpsp)
[273.634176] Starting subtest: dpms-mode-unset-lpsp
[282.039872] Subtest dpms-mode-unset-lpsp: SUCCESS (8.406s)
[282.841163] [038/143] (721s left) kms_cursor_legacy (cursora-vs-flipa-atomic-transitions)
[282.946795] Starting subtest: cursorA-vs-flipA-atomic-transitions
[294.122194] Subtest cursorA-vs-flipA-atomic-transitions: SUCCESS (11.175s)
[295.023898] [039/143] (709s left) kms_flip_scaled_crc (flip-32bpp-ytileccs-to-64bpp-ytile-upscaling)
[295.101344] Starting subtest: flip-32bpp-ytileccs-to-64bpp-ytile-upscaling
[295.103912] Starting dynamic subtest: pipe-A-default-mode
[295.393526] Dynamic subtest pipe-A-default-mode: SKIP (0.286s)
[295.398956] Subtest flip-32bpp-ytileccs-to-64bpp-ytile-upscaling: SKIP (0.288s)
[296.302513] [040/143] (707s left) prime_vgem (basic-gtt)
[296.403761] Starting subtest: basic-gtt
[296.409047] Subtest basic-gtt: SKIP (0.000s)
[296.495723] [041/143] (707s left) gem_exec_balancer (persistence)
[296.749573] Starting subtest: persistence
[297.293114] Subtest persistence: SUCCESS (0.544s)
[297.395591] [042/143] (706s left) debugfs_test (read_all_entries)
[297.445812] Starting subtest: read_all_entries
[297.681038] Subtest read_all_entries: SUCCESS (0.232s)
[297.755048] [043/143] (706s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-blt)
[297.856717] Starting subtest: psr-1p-primscrn-cur-indfb-draw-blt
[302.695564] Subtest psr-1p-primscrn-cur-indfb-draw-blt: SUCCESS (4.841s)
[302.804145] [044/143] (701s left) kms_invalid_mode (bad-vsync-end)
[302.883281] Starting subtest: bad-vsync-end
[302.885767] Starting dynamic subtest: pipe-A-eDP-1
[303.172732] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.288s)
[303.190506] Starting dynamic subtest: pipe-B-eDP-1
[303.193687] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[303.208577] Starting dynamic subtest: pipe-C-eDP-1
[303.211061] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[303.218034] Starting dynamic subtest: pipe-D-eDP-1
[303.220454] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[303.222843] Subtest bad-vsync-end: SUCCESS (0.300s)
[304.100197] [045/143] (700s left) gem_exec_reloc (basic-wc-gtt-active)
[304.156655] Subtest basic-wc-gtt-active: SKIP (0.000s)
[304.192707] [046/143] (700s left) kms_chamelium_edid (hdmi-mode-timings)
[304.586669] Subtest hdmi-mode-timings: SKIP (0.000s)
[305.487470] [047/143] (698s left) gem_exec_fence (submit)
[305.695854] Starting subtest: submit
[305.700849] Subtest submit: SKIP (0.000s)
[307.512475] [048/143] (696s left) kms_plane_scaling (planes-upscale-factor-0-25-downscale-factor-0-25)
[307.606429] Starting subtest: planes-upscale-factor-0-25-downscale-factor-0-25
[307.608861] Starting dynamic subtest: pipe-A-eDP-1
[307.616866] Dynamic subtest pipe-A-eDP-1: SKIP (0.008s)
[307.622950] Starting dynamic subtest: pipe-B-eDP-1
[307.650323] Dynamic subtest pipe-B-eDP-1: SKIP (0.032s)
[307.659782] Starting dynamic subtest: pipe-C-eDP-1
[307.668377] Dynamic subtest pipe-C-eDP-1: SKIP (0.016s)
[307.677550] Starting dynamic subtest: pipe-D-eDP-1
[307.686137] Dynamic subtest pipe-D-eDP-1: SKIP (0.017s)
[307.690577] Subtest planes-upscale-factor-0-25-downscale-factor-0-25: SKIP (0.079s)
[307.751735] [049/143] (696s left) kms_ccs (pipe-d-random-ccs-data-y-tiled-ccs)
[308.179062] Starting subtest: pipe-D-random-ccs-data-y-tiled-ccs
[308.186426] Subtest pipe-D-random-ccs-data-y-tiled-ccs: SKIP (0.000s)
[309.036775] [050/143] (695s left) gem_exec_capture (userptr)
[309.100048] Starting subtest: userptr
[309.929441] Subtest userptr: SUCCESS (0.834s)
[310.013120] [051/143] (694s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-indfb-msflip-blt)
[310.084081] Starting subtest: fbcpsr-1p-primscrn-indfb-msflip-blt
[315.213748] Subtest fbcpsr-1p-primscrn-indfb-msflip-blt: SUCCESS (5.130s)
[315.333082] [052/143] (689s left) gem_fence_thrash (bo-write-verify-none)
[315.378070] Starting subtest: bo-write-verify-none
[315.384789] Subtest bo-write-verify-none: SKIP (0.001s)
[315.412338] [053/143] (689s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-mmap-gtt)
[315.487756] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-mmap-gtt
[315.492577] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[315.583505] [054/143] (688s left) kms_plane_alpha_blend (alpha-transparent-fb)
[315.639383] Starting subtest: alpha-transparent-fb
[315.905957] Starting dynamic subtest: pipe-A-eDP-1
[316.509274] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.602s)
[316.523869] Starting dynamic subtest: pipe-D-eDP-1
[318.023578] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.509s)
[318.026100] Subtest alpha-transparent-fb: SUCCESS (2.383s)
[318.902466] [055/143] (685s left) gem_exec_whisper (basic-contexts-forked)
[318.979200] Starting subtest: basic-contexts-forked
[343.799751] Subtest basic-contexts-forked: SUCCESS (24.764s)
[343.934565] [056/143] (660s left) kms_ccs (pipe-d-crc-primary-basic-yf-tiled-ccs)
[344.357186] Starting subtest: pipe-D-crc-primary-basic-yf-tiled-ccs
[344.362719] Subtest pipe-D-crc-primary-basic-yf-tiled-ccs: SKIP (0.000s)
[345.197979] [057/143] (659s left) kms_rotation_crc (primary-yf-tiled-reflect-x-270)
[345.284361] Starting subtest: primary-yf-tiled-reflect-x-270
[345.288588] Subtest primary-yf-tiled-reflect-x-270: SKIP (0.001s)
[345.337714] [058/143] (659s left) kms_tiled_display (basic-test-pattern)
[345.436138] Subtest basic-test-pattern: SKIP (0.000s)
[345.452331] [059/143] (659s left) gem_eio (hibernate)
[345.669589] Starting subtest: hibernate
[359.855030] Subtest hibernate: SUCCESS (14.186s)
[364.019637] [060/143] (644s left) gem_lmem_swapping (parallel-random-verify-ccs)
[364.099836] Subtest parallel-random-verify-ccs: SKIP (0.000s)
[364.136826] [061/143] (644s left) gem_exec_reloc (basic-gtt-cpu)
[364.179274] Subtest basic-gtt-cpu: SKIP (0.000s)
[364.230430] [062/143] (644s left) sw_sync (sync_busy_fork_unixsocket)
[364.287323] Starting subtest: sync_busy_fork_unixsocket
[364.301551] Subtest sync_busy_fork_unixsocket: SUCCESS (0.016s)
[364.362674] [063/143] (644s left) gem_close (basic)
[364.426597] Starting subtest: basic
[364.429165] Subtest basic: SUCCESS (0.000s)
[364.520056] [064/143] (644s left) kms_ccs (pipe-c-crc-primary-rotation-180-4-tiled-dg2-rc-ccs-cc)
[364.912262] Starting subtest: pipe-C-crc-primary-rotation-180-4-tiled-dg2-rc-ccs-cc
[364.917954] Subtest pipe-C-crc-primary-rotation-180-4-tiled-dg2-rc-ccs-cc: SKIP (0.000s)
[365.803470] [065/143] (643s left) kms_frontbuffer_tracking (fbcpsr-2p-shrfb-fliptrack-mmap-gtt)
[365.858134] Starting subtest: fbcpsr-2p-shrfb-fliptrack-mmap-gtt
[365.862368] Subtest fbcpsr-2p-shrfb-fliptrack-mmap-gtt: SKIP (0.000s)
[365.940795] [066/143] (643s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-mmap-wc)
[366.024626] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-mmap-wc
[366.028765] Subtest fbc-2p-primscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[366.100407] [067/143] (642s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-render)
[366.181359] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-render
[366.186083] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-render: SKIP (0.000s)
[366.276260] [068/143] (642s left) gem_eio (create)
[366.492162] Starting subtest: create
[366.825130] Subtest create: SUCCESS (0.332s)
[366.925101] [069/143] (642s left) api_intel_bb (intel-bb-blit-y)
[366.990448] Starting subtest: intel-bb-blit-y
[370.633425] Subtest intel-bb-blit-y: SUCCESS (3.642s)
[370.746793] [070/143] (638s left) gem_lmem_swapping (heavy-multi)
[370.797372] Subtest heavy-multi: SKIP (0.000s)
[370.823542] [071/143] (638s left) v3d/v3d_create_bo (create-bo-invalid-flags)
[370.904996] Subtest create-bo-invalid-flags: SKIP (0.000s)
[370.952147] [072/143] (638s left) kms_addfb_basic (basic-x-tiled-legacy)
[370.989656] Starting subtest: basic-x-tiled-legacy
[370.994704] Subtest basic-x-tiled-legacy: SKIP (0.000s)
[371.087284] [073/143] (638s left) kms_hdmi_inject (inject-4k)
[371.445710] Starting subtest: inject-4k
[371.725702] Subtest inject-4k: SUCCESS (0.280s)
[372.650482] [074/143] (636s left) gem_eio (in-flight-10ms)
[372.870931] Starting subtest: in-flight-10ms
[381.646069] Subtest in-flight-10ms: SUCCESS (8.775s)
[381.791521] [075/143] (627s left) kms_color (degamma)
[381.876271] Starting subtest: degamma
[381.878669] Starting dynamic subtest: pipe-A
[383.293513] Dynamic subtest pipe-A: FAIL (1.258s)
[383.312401] Starting dynamic subtest: pipe-B
[384.831534] Dynamic subtest pipe-B: FAIL (1.526s)
[384.851750] Starting dynamic subtest: pipe-C
[386.331769] Dynamic subtest pipe-C: FAIL (1.494s)
[386.351532] Starting dynamic subtest: pipe-D
[387.764044] Dynamic subtest pipe-D: FAIL (1.432s)
[387.766652] Subtest degamma: FAIL (5.716s)
[388.022455] [076/143] (621s left) syncobj_basic (create-signaled)
[388.080094] Starting subtest: create-signaled
[388.082790] Subtest create-signaled: SUCCESS (0.000s)
[388.155124] [077/143] (621s left) gem_ctx_persistence (engines-hostile-preempt)
[388.201040] Starting subtest: engines-hostile-preempt
[388.203657] Starting dynamic subtest: rcs0
[388.240650] Dynamic subtest rcs0: SUCCESS (0.042s)
[388.258139] Starting dynamic subtest: bcs0
[388.407949] Dynamic subtest bcs0: SUCCESS (0.166s)
[388.420717] Starting dynamic subtest: vcs0
[390.421176] Dynamic subtest vcs0: SUCCESS (2.012s)
[390.436741] Starting dynamic subtest: vcs1
[392.407076] Dynamic subtest vcs1: SUCCESS (1.984s)
[392.422208] Starting dynamic subtest: vecs0
[394.408060] Dynamic subtest vecs0: SUCCESS (1.999s)
[394.427787] Starting dynamic subtest: ccs0
[394.456733] Dynamic subtest ccs0: SUCCESS (0.048s)
[394.459450] Subtest engines-hostile-preempt: SUCCESS (6.259s)
[394.540742] [078/143] (614s left) gem_softpin (evict-prime)
[394.612880] Starting subtest: evict-prime
[394.615874] Starting dynamic subtest: rcs0
[395.753725] Dynamic subtest rcs0: SUCCESS (1.141s)
[395.773074] Starting dynamic subtest: bcs0
[396.871760] Dynamic subtest bcs0: SUCCESS (1.117s)
[396.889704] Starting dynamic subtest: vcs0
[398.456575] Dynamic subtest vcs0: SUCCESS (1.582s)
[398.476853] Starting dynamic subtest: vcs1
[400.406972] Dynamic subtest vcs1: SUCCESS (1.948s)
[400.427657] Starting dynamic subtest: vecs0
[402.391993] Dynamic subtest vecs0: SUCCESS (1.983s)
[402.412798] Starting dynamic subtest: ccs0
[403.530719] Dynamic subtest ccs0: SUCCESS (1.139s)
[403.541263] Starting dynamic subtest: all
[405.400837] Dynamic subtest all: SUCCESS (1.867s)
[405.403487] Subtest evict-prime: SUCCESS (10.787s)
[405.504924] [079/143] (603s left) kms_ccs (pipe-c-bad-rotation-90-4-tiled-mtl-rc-ccs-cc)
[405.893958] Starting subtest: pipe-C-bad-rotation-90-4-tiled-mtl-rc-ccs-cc
[406.714707] Subtest pipe-C-bad-rotation-90-4-tiled-mtl-rc-ccs-cc: SUCCESS (0.817s)
[407.896082] [080/143] (601s left) kms_psr (psr2-sprite-plane-onoff)
[407.980358] Starting subtest: psr2-sprite-plane-onoff
[407.982699] Starting dynamic subtest: eDP-1
[409.830574] Dynamic subtest eDP-1: SUCCESS (1.849s)
[409.833257] Subtest psr2-sprite-plane-onoff: SUCCESS (1.851s)
[410.734699] [081/143] (598s left) kms_ccs (pipe-a-bad-rotation-90-4-tiled-dg2-rc-ccs)
[411.072544] Starting subtest: pipe-A-bad-rotation-90-4-tiled-dg2-rc-ccs
[411.077713] Subtest pipe-A-bad-rotation-90-4-tiled-dg2-rc-ccs: SKIP (0.000s)
[411.952683] [082/143] (597s left) gem_unref_active_buffers
[412.128964] [083/143] (597s left) drm_fdinfo (virtual-busy-hang-all)
[412.193110] Starting subtest: virtual-busy-hang-all
[412.197427] Subtest virtual-busy-hang-all: SKIP (0.000s)
[412.262158] [084/143] (597s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-pwrite)
[412.344702] Starting subtest: psr-2p-primscrn-spr-indfb-draw-pwrite
[412.349532] Subtest psr-2p-primscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[412.449611] [085/143] (597s left) kms_flip_scaled_crc (flip-32bpp-linear-to-64bpp-linear-downscaling)
[412.549454] Starting subtest: flip-32bpp-linear-to-64bpp-linear-downscaling
[412.554917] Starting dynamic subtest: pipe-A-default-mode
[413.781806] Dynamic subtest pipe-A-default-mode: SKIP (1.225s)
[413.786640] Subtest flip-32bpp-linear-to-64bpp-linear-downscaling: SKIP (1.230s)
[413.933042] [086/143] (595s left) syncobj_wait (single-wait-all-signaled)
[413.979938] Starting subtest: single-wait-all-signaled
[413.982371] Subtest single-wait-all-signaled: SUCCESS (0.000s)
[414.058368] [087/143] (595s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-blt)
[414.131295] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-blt
[414.135563] Subtest psr-2p-scndscrn-spr-indfb-draw-blt: SKIP (0.000s)
[414.201098] [088/143] (595s left) kms_lease (lease-uevent)
[414.245686] Starting subtest: lease-uevent
[415.260511] Subtest lease-uevent: SUCCESS (1.014s)
[415.337925] [089/143] (594s left) debugfs_test (sysfs)
[415.412325] Starting subtest: sysfs
[415.548896] Subtest sysfs: SUCCESS (0.134s)
[415.624299] [090/143] (594s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-mmap-wc)
[415.704487] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-mmap-wc
[415.708902] Subtest fbc-2p-scndscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[415.804484] [091/143] (593s left) gem_exec_schedule (implicit-read-write)
[415.880432] Starting subtest: implicit-read-write
[415.882518] Starting dynamic subtest: rcs0
[415.975991] Dynamic subtest rcs0: SUCCESS (0.113s)
[415.994551] Starting dynamic subtest: vcs0
[416.091271] Dynamic subtest vcs0: SUCCESS (0.114s)
[416.110080] Starting dynamic subtest: vcs1
[416.184999] Dynamic subtest vcs1: SUCCESS (0.092s)
[416.205959] Starting dynamic subtest: vecs0
[416.273982] Dynamic subtest vecs0: SUCCESS (0.089s)
[416.295108] Starting dynamic subtest: ccs0
[416.359884] Dynamic subtest ccs0: SUCCESS (0.085s)
[416.362438] Subtest implicit-read-write: SUCCESS (0.497s)
[417.528430] [092/143] (592s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-pwrite)
[417.579828] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-pwrite
[417.584651] Subtest fbc-2p-scndscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[417.673899] [093/143] (592s left) kms_flip (2x-wf_vblank-ts-check)
[417.730546] Starting subtest: 2x-wf_vblank-ts-check
[417.745642] Subtest 2x-wf_vblank-ts-check: SKIP (0.013s)
[417.818124] [094/143] (592s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-180)
[417.887960] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-180
[419.044588] Subtest 4-tiled-max-hw-stride-64bpp-rotate-180: SUCCESS (1.156s)
[419.202047] [095/143] (590s left) kms_ccs (pipe-a-crc-primary-basic-4-tiled-mtl-rc-ccs-cc)
[419.560154] Starting subtest: pipe-A-crc-primary-basic-4-tiled-mtl-rc-ccs-cc
[420.691955] Subtest pipe-A-crc-primary-basic-4-tiled-mtl-rc-ccs-cc: SUCCESS (1.131s)
[421.879196] [096/143] (588s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-180-async-flip)
[421.956659] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-180-async-flip
[421.961637] Subtest y-tiled-max-hw-stride-32bpp-rotate-180-async-flip: SKIP (0.000s)
[422.025661] [097/143] (587s left) kms_frontbuffer_tracking (fbcpsr-slowdraw)
[422.075677] Starting subtest: fbcpsr-slowdraw
[445.015152] Subtest fbcpsr-slowdraw: SUCCESS (22.944s)
[445.137048] [098/143] (564s left) gem_readwrite (write-bad-handle)
[445.194039] Subtest write-bad-handle: SKIP (0.000s)
[445.239152] [099/143] (564s left) kms_ccs (pipe-c-crc-sprite-planes-basic-y-tiled-ccs)
[445.657567] Starting subtest: pipe-C-crc-sprite-planes-basic-y-tiled-ccs
[445.663799] Subtest pipe-C-crc-sprite-planes-basic-y-tiled-ccs: SKIP (0.001s)
[446.505212] [100/143] (563s left) v3d/v3d_wait_bo (unused-bo-0ns)
[446.612097] Subtest unused-bo-0ns: SKIP (0.000s)
[446.672046] [101/143] (563s left) api_intel_allocator (open-vm)
[446.732654] Starting subtest: open-vm
[446.739042] Subtest open-vm: SUCCESS (0.006s)
[446.844848] [102/143] (563s left) i915_getparams_basic (basic-eu-total)
[446.905913] Starting subtest: basic-eu-total
[446.910929] Subtest basic-eu-total: SUCCESS (0.000s)
[446.981060] [103/143] (563s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-mmap-wc)
[447.085129] Starting subtest: psr-1p-primscrn-spr-indfb-draw-mmap-wc
[451.710094] Subtest psr-1p-primscrn-spr-indfb-draw-mmap-wc: SUCCESS (4.626s)
[451.823234] [104/143] (558s left) gem_render_copy (yf-tiled-to-vebox-yf-tiled)
[451.880876] Starting subtest: yf-tiled-to-vebox-yf-tiled
[451.885051] Subtest yf-tiled-to-vebox-yf-tiled: SKIP (0.000s)
[452.057999] [105/143] (558s left) kms_chamelium_hpd (dp-hpd-storm-disable)
[452.448970] Subtest dp-hpd-storm-disable: SKIP (0.000s)
[453.329333] [106/143] (556s left) kms_big_fb (x-tiled-64bpp-rotate-270)
[453.440676] Starting subtest: x-tiled-64bpp-rotate-270
[453.462757] Subtest x-tiled-64bpp-rotate-270: SKIP (0.024s)
[453.558107] [107/143] (556s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-shrfb-plflip-blt)
[453.660461] Starting subtest: fbcpsr-1p-primscrn-shrfb-plflip-blt
[459.058450] Subtest fbcpsr-1p-primscrn-shrfb-plflip-blt: SUCCESS (5.400s)
[459.204202] [108/143] (551s left) kms_cursor_crc (cursor-sliding-max-size)
[459.540208] Starting subtest: cursor-sliding-max-size
[459.547291] Subtest cursor-sliding-max-size: SKIP (0.000s)
[459.661051] [109/143] (550s left) gem_mmap_gtt (basic-read-write-distinct)
[459.705842] Subtest basic-read-write-distinct: SKIP (0.000s)
[459.719900] [110/143] (550s left) i915_pm_rpm (system-suspend)
[461.615334] Starting subtest: system-suspend
[466.033497] Subtest system-suspend: FAIL (4.329s)
[466.984879] [111/143] (543s left) kms_flip (2x-plain-flip-fb-recreate-interruptible)
[467.045040] Starting subtest: 2x-plain-flip-fb-recreate-interruptible
[467.059047] Subtest 2x-plain-flip-fb-recreate-interruptible: SKIP (0.013s)
[467.122380] [112/143] (543s left) kms_atomic (test-only)
[467.181652] Starting subtest: test-only
[467.237396] Starting dynamic subtest: pipe-A-eDP-1
[469.856542] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.620s)
[469.859948] Subtest test-only: SUCCESS (2.677s)
[470.767770] [113/143] (539s left) syncobj_timeline (signal-array)
[470.825733] Starting subtest: signal-array
[470.828643] Subtest signal-array: SUCCESS (0.000s)
[470.879353] [114/143] (539s left) syncobj_wait (wait-any-interrupted)
[470.941183] Starting subtest: wait-any-interrupted
[471.045470] Subtest wait-any-interrupted: SUCCESS (0.106s)
[471.133421] [115/143] (539s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-shrfb-msflip-blt)
[471.213640] Starting subtest: fbcpsr-2p-scndscrn-shrfb-msflip-blt
[471.218371] Subtest fbcpsr-2p-scndscrn-shrfb-msflip-blt: SKIP (0.000s)
[471.309836] [116/143] (539s left) vc4/vc4_purgeable_bo (mark-unpurgeable-twice)
[471.414499] Subtest mark-unpurgeable-twice: SKIP (0.000s)
[471.467260] [117/143] (539s left) kms_dsc (dsc-fractional-bpp)
[471.539494] Subtest dsc-fractional-bpp: SKIP (0.000s)
[471.561267] [118/143] (539s left) perf (gen12-invalid-class-instance)
[471.645645] Starting subtest: gen12-invalid-class-instance
[471.656963] Subtest gen12-invalid-class-instance: SUCCESS (0.009s)
[471.688509] [119/143] (538s left) gem_exec_gttfill (engines)
[471.771154] Starting subtest: engines
[471.773736] Starting dynamic subtest: rcs0
[494.503406] Dynamic subtest rcs0: SUCCESS (22.730s)
[494.526334] Starting dynamic subtest: bcs0
[516.963697] Dynamic subtest bcs0: SUCCESS (22.460s)
[516.985828] Starting dynamic subtest: vcs0
[539.673437] Dynamic subtest vcs0: SUCCESS (22.709s)
[539.696148] Starting dynamic subtest: vcs1
[562.096240] Dynamic subtest vcs1: SUCCESS (22.421s)
[562.118378] Starting dynamic subtest: vecs0
[584.538566] Dynamic subtest vecs0: SUCCESS (22.440s)
[584.558794] Starting dynamic subtest: ccs0
[606.930628] Dynamic subtest ccs0: SUCCESS (22.391s)
[606.933033] Subtest engines: SUCCESS (135.161s)
[607.119247] [120/143] (403s left) kms_flip (2x-single-buffer-flip-vs-dpms-off-vs-modeset)
[607.260806] Starting subtest: 2x-single-buffer-flip-vs-dpms-off-vs-modeset
[607.272681] Subtest 2x-single-buffer-flip-vs-dpms-off-vs-modeset: SKIP (0.013s)
[607.337096] [121/143] (403s left) gem_exec_params (no-blt)
[607.393951] Starting subtest: no-blt
[607.396686] Subtest no-blt: SUCCESS (0.002s)
[607.501238] [122/143] (403s left) v3d/v3d_perfmon (create-perfmon-0)
[607.620917] Subtest create-perfmon-0: SKIP (0.000s)
[607.677117] [123/143] (403s left) gem_userptr_blits (probe)
[607.754682] Starting subtest: probe
[607.876768] Subtest probe: SUCCESS (0.121s)
[607.967036] [124/143] (402s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-mmap-cpu)
[608.052646] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-mmap-cpu
[608.057162] Subtest fbc-2p-primscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[608.140358] [125/143] (402s left) kms_big_fb (yf-tiled-addfb-size-overflow)
[608.246780] Starting subtest: yf-tiled-addfb-size-overflow
[608.251547] Subtest yf-tiled-addfb-size-overflow: SKIP (0.000s)
[608.343517] [126/143] (402s left) kms_ccs (pipe-b-crc-sprite-planes-basic-y-tiled-gen12-mc-ccs)
[608.752160] Starting subtest: pipe-B-crc-sprite-planes-basic-y-tiled-gen12-mc-ccs
[608.757736] Subtest pipe-B-crc-sprite-planes-basic-y-tiled-gen12-mc-ccs: SKIP (0.001s)
[609.647744] [127/143] (401s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-mmap-wc)
[609.727256] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-mmap-wc
[609.731587] Subtest psr-2p-scndscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[609.833456] [128/143] (401s left) gem_userptr_blits (create-destroy-sync)
[609.901178] Starting subtest: create-destroy-sync
[614.922795] Subtest create-destroy-sync: SUCCESS (5.021s)
[615.033057] [129/143] (395s left) gem_ctx_persistence (legacy-engines-hang)
[615.086225] Starting subtest: legacy-engines-hang
[615.088729] Starting dynamic subtest: render
[615.193689] Dynamic subtest render: SUCCESS (0.107s)
[615.216187] Starting dynamic subtest: bsd1
[615.285547] Dynamic subtest bsd1: SUCCESS (0.090s)
[615.308311] Starting dynamic subtest: bsd2
[615.375707] Dynamic subtest bsd2: SUCCESS (0.088s)
[615.398147] Starting dynamic subtest: blt
[615.468971] Dynamic subtest blt: SUCCESS (0.091s)
[615.489856] Starting dynamic subtest: vebox
[615.559893] Dynamic subtest vebox: SUCCESS (0.089s)
[615.562468] Subtest legacy-engines-hang: SUCCESS (0.475s)
[615.647221] [130/143] (395s left) gem_basic (multigpu-create-close)
[615.707521] Starting subtest: multigpu-create-close
[615.713134] Subtest multigpu-create-close: SKIP (0.000s)
[615.772052] [131/143] (395s left) kms_properties (get_properties-sanity-atomic)
[615.843796] Starting subtest: get_properties-sanity-atomic
[615.852793] Subtest get_properties-sanity-atomic: SUCCESS (0.009s)
[615.929432] [132/143] (395s left) syncobj_timeline (single-wait-available-submitted)
[615.968474] Starting subtest: single-wait-available-submitted
[615.970739] Subtest single-wait-available-submitted: SUCCESS (0.000s)
[616.034055] [133/143] (394s left) kms_big_fb (y-tiled-32bpp-rotate-180)
[616.116408] Starting subtest: y-tiled-32bpp-rotate-180
[616.120271] Subtest y-tiled-32bpp-rotate-180: SKIP (0.000s)
[616.203307] [134/143] (394s left) kms_ccs (pipe-b-crc-primary-basic-y-tiled-gen12-rc-ccs)
[616.634088] Starting subtest: pipe-B-crc-primary-basic-y-tiled-gen12-rc-ccs
[616.640131] Subtest pipe-B-crc-primary-basic-y-tiled-gen12-rc-ccs: SKIP (0.000s)
[617.519921] [135/143] (393s left) kms_ccs (pipe-b-missing-ccs-buffer-y-tiled-gen12-mc-ccs)
[617.922253] Starting subtest: pipe-B-missing-ccs-buffer-y-tiled-gen12-mc-ccs
[617.928363] Subtest pipe-B-missing-ccs-buffer-y-tiled-gen12-mc-ccs: SKIP (0.000s)
[618.801160] [136/143] (392s left) kms_fence_pin_leak
[618.881302] [137/143] (392s left) i915_query (query-regions-sanity-check)
[618.949324] Starting subtest: query-regions-sanity-check
[618.974847] Subtest query-regions-sanity-check: SUCCESS (0.028s)
[619.080885] [138/143] (392s left) kms_cursor_crc (cursor-onscreen-64x64)
[619.275419] Starting subtest: cursor-onscreen-64x64
[619.288239] Starting dynamic subtest: pipe-A-eDP-1
[621.769814] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.481s)
[621.800950] Starting dynamic subtest: pipe-D-eDP-1
[624.933790] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.139s)
[624.936610] Subtest cursor-onscreen-64x64: SUCCESS (5.656s)
[625.813759] [139/143] (385s left) syncobj_wait (single-wait-all-for-submit-unsubmitted)
[625.871750] Starting subtest: single-wait-all-for-submit-unsubmitted
[625.972048] Subtest single-wait-all-for-submit-unsubmitted: SUCCESS (0.102s)
[626.043980] [140/143] (385s left) kms_plane_scaling (plane-scaler-with-clipping-clamping-modifiers)
[626.117831] Starting subtest: plane-scaler-with-clipping-clamping-modifiers
[626.120406] Starting dynamic subtest: pipe-A-eDP-1
[626.909358] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.794s)
[626.929927] Starting dynamic subtest: pipe-B-eDP-1
[628.817197] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.905s)
[628.833480] Starting dynamic subtest: pipe-C-eDP-1
[630.777862] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.956s)
[630.798185] Starting dynamic subtest: pipe-D-eDP-1
[632.641559] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.860s)
[632.643934] Subtest plane-scaler-with-clipping-clamping-modifiers: SUCCESS (6.528s)
[633.910054] [141/143] (377s left) syncobj_eventfd (timeline-wait-before-signal)
[633.973715] Starting subtest: timeline-wait-before-signal
[634.003044] Subtest timeline-wait-before-signal: SUCCESS (0.032s)
[634.080682] [142/143] (377s left) kms_prop_blob (invalid-set-prop)
[634.121587] Starting subtest: invalid-set-prop
[634.124050] Subtest invalid-set-prop: SUCCESS (0.000s)
[634.187841] [143/143] (377s left) kms_content_protection (dp-mst-type-1)
[634.323502] Starting subtest: dp-mst-type-1
[634.328227] Subtest dp-mst-type-1: SKIP (0.000s)
[634.439501] Closing watchdogs
Done.