[56.898369] Initializing watchdogs
[56.898480]   /dev/watchdog0
[56.913539] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:7d55 Intel Meteorlake (Gen12) Meteor Lake-P [Intel Arc Graphics]
[56.917401] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[56.919543] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[56.923466] [001/130] (960s left) kms_psr (fbc-pr-cursor-plane-move)
[57.086485] Starting subtest: fbc-pr-cursor-plane-move
[57.091225] Subtest fbc-pr-cursor-plane-move: SKIP (0.000s)
[57.151817] [002/130] (960s left) kms_psr (fbc-psr2-sprite-plane-move)
[57.261155] Starting subtest: fbc-psr2-sprite-plane-move
[57.263471] Starting dynamic subtest: eDP-1
[57.267609] Dynamic subtest eDP-1: SKIP (0.000s)
[57.271742] Subtest fbc-psr2-sprite-plane-move: SKIP (0.000s)
[57.326267] [003/130] (960s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-render)
[57.429861] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-render
[57.434608] Subtest fbc-2p-primscrn-cur-indfb-draw-render: SKIP (0.000s)
[57.537625] [004/130] (959s left) kms_psr2_su (page_flip-nv12)
[57.601571] Subtest page_flip-NV12: SKIP (0.000s)
[57.653274] [005/130] (959s left) gem_userptr_blits (sync-unmap-cycles)
[57.719463] Starting subtest: sync-unmap-cycles
[63.144678] Subtest sync-unmap-cycles: SUCCESS (5.376s)
[63.288570] [006/130] (954s left) kms_flip (flip-vs-dpms-off-vs-modeset)
[63.394543] Starting subtest: flip-vs-dpms-off-vs-modeset
[63.396613] Starting dynamic subtest: A-eDP1
[66.906702] Dynamic subtest A-eDP1: SUCCESS (3.491s)
[66.914518] Starting dynamic subtest: B-eDP1
[69.983230] Dynamic subtest B-eDP1: SUCCESS (3.069s)
[69.991833] Starting dynamic subtest: C-eDP1
[73.067994] Dynamic subtest C-eDP1: SUCCESS (3.078s)
[73.076440] Starting dynamic subtest: D-eDP1
[76.144242] Dynamic subtest D-eDP1: SUCCESS (3.070s)
[76.146626] Subtest flip-vs-dpms-off-vs-modeset: SUCCESS (12.713s)
[76.939146] [007/130] (940s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-wc)
[77.043303] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-wc
[77.047710] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[77.128349] [008/130] (940s left) syncobj_timeline (invalid-query-bad-pad)
[77.181454] Starting subtest: invalid-query-bad-pad
[77.183938] Subtest invalid-query-bad-pad: SUCCESS (0.000s)
[77.288543] [009/130] (940s left) gem_exec_reloc (basic-write-gtt-active)
[77.355683] Subtest basic-write-gtt-active: SKIP (0.000s)
[77.432945] [010/130] (940s left) gem_exec_balancer (sequential)
[77.506969] Starting subtest: sequential
[80.400855] Subtest sequential: SUCCESS (2.891s)
[80.683066] [011/130] (937s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-onoff)
[80.786713] Starting subtest: psr-2p-scndscrn-spr-indfb-onoff
[80.790963] Subtest psr-2p-scndscrn-spr-indfb-onoff: SKIP (0.000s)
[80.877225] [012/130] (936s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-0)
[80.982070] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-0
[82.177428] Subtest x-tiled-max-hw-stride-64bpp-rotate-0: SUCCESS (1.195s)
[82.302360] [013/130] (935s left) kms_pm_rpm (dpms-lpsp)
[84.142625] Starting subtest: dpms-lpsp
[84.516434] Subtest dpms-lpsp: SUCCESS (0.375s)
[84.629854] [014/130] (933s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip)
[84.733314] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip
[85.534805] Subtest 4-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip: SUCCESS (0.803s)
[85.776599] [015/130] (932s left) kms_big_fb (x-tiled-64bpp-rotate-0)
[85.890253] Starting subtest: x-tiled-64bpp-rotate-0
[88.187807] Subtest x-tiled-64bpp-rotate-0: SUCCESS (2.297s)
[88.422781] [016/130] (929s left) gem_eio (wait-10ms)
[88.661319] Starting subtest: wait-10ms
[89.029367] Subtest wait-10ms: SUCCESS (0.369s)
[89.186190] [017/130] (928s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip)
[89.293162] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip
[89.297223] Subtest yf-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip: SKIP (0.000s)
[89.401966] [018/130] (928s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-onoff)
[89.509066] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-onoff
[94.225907] Subtest fbcpsr-1p-primscrn-cur-indfb-onoff: SUCCESS (4.718s)
[94.353249] [019/130] (923s left) kms_psr (fbc-psr-primary-blt)
[94.451868] Starting subtest: fbc-psr-primary-blt
[94.454195] Starting dynamic subtest: eDP-1
[94.458617] Dynamic subtest eDP-1: SKIP (0.000s)
[94.462742] Subtest fbc-psr-primary-blt: SKIP (0.000s)
[94.515370] [020/130] (923s left) drm_read (short-buffer-nonblock)
[94.702182] Starting subtest: short-buffer-nonblock
[94.704819] Subtest short-buffer-nonblock: SUCCESS (0.000s)
[94.822358] [021/130] (923s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-render)
[94.930581] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-render
[100.112149] Subtest psr-1p-primscrn-pri-shrfb-draw-render: SUCCESS (5.184s)
[100.243155] [022/130] (917s left) gem_eio (in-flight-contexts-10ms)
[100.468597] Starting subtest: in-flight-contexts-10ms
[111.941448] Subtest in-flight-contexts-10ms: SUCCESS (11.471s)
[112.062880] [023/130] (906s left) sw_sync (sync_busy_fork_unixsocket)
[112.102124] Starting subtest: sync_busy_fork_unixsocket
[112.110245] Subtest sync_busy_fork_unixsocket: SUCCESS (0.012s)
[112.162065] [024/130] (906s left) kms_flip (2x-flip-vs-suspend-interruptible)
[112.261871] Starting subtest: 2x-flip-vs-suspend-interruptible
[112.274224] Subtest 2x-flip-vs-suspend-interruptible: SKIP (0.010s)
[112.344061] [025/130] (905s left) kms_frontbuffer_tracking (fbc-1p-indfb-fliptrack-mmap-gtt)
[112.450825] Starting subtest: fbc-1p-indfb-fliptrack-mmap-gtt
[112.455293] Subtest fbc-1p-indfb-fliptrack-mmap-gtt: SKIP (0.000s)
[112.558729] [026/130] (905s left) kms_frontbuffer_tracking (fbc-2p-rte)
[112.666747] Starting subtest: fbc-2p-rte
[112.671210] Subtest fbc-2p-rte: SKIP (0.000s)
[112.773365] [027/130] (905s left) kms_display_modes (extended-mode-basic)
[112.874101] Starting subtest: extended-mode-basic
[112.878622] Subtest extended-mode-basic: SKIP (0.000s)
[112.911946] [028/130] (905s left) kms_chamelium_frames (hdmi-frame-dump)
[113.293835] Subtest hdmi-frame-dump: SKIP (0.000s)
[114.069758] [029/130] (904s left) prime_vgem (basic-fence-blt)
[114.205458] Starting subtest: basic-fence-blt
[114.287528] Subtest basic-fence-blt: SUCCESS (0.082s)
[114.396336] [FACT prime_vgem (basic-fence-blt)] new: kernel.kmod_is_loaded.vgem: true
[114.399373] [030/130] (904s left) syncobj_wait (single-wait-submitted)
[114.461525] Starting subtest: single-wait-submitted
[114.568028] Subtest single-wait-submitted: SUCCESS (0.108s)
[114.636119] [031/130] (903s left) gem_mmap (bad-offset)
[114.688330] Subtest bad-offset: SKIP (0.000s)
[114.737268] [032/130] (903s left) prime_self_import (basic-with_one_bo_two_files)
[114.772685] Starting subtest: basic-with_one_bo_two_files
[114.789086] Subtest basic-with_one_bo_two_files: SUCCESS (0.016s)
[114.898330] [033/130] (903s left) gem_lmem_swapping (massive)
[114.939374] Subtest massive: SKIP (0.000s)
[114.979860] [034/130] (903s left) gem_close_race (multigpu-basic-process)
[115.050213] Starting subtest: multigpu-basic-process
[115.055030] Subtest multigpu-basic-process: SKIP (0.000s)
[115.252765] [035/130] (903s left) gem_pxp (reject-modify-context-protection-off-3)
[115.381253] Starting subtest: reject-modify-context-protection-off-3
[115.383797] Subtest reject-modify-context-protection-off-3: SUCCESS (0.002s)
[115.497643] [036/130] (903s left) kms_frontbuffer_tracking (psr-2p-primscrn-indfb-pgflip-blt)
[115.599500] Starting subtest: psr-2p-primscrn-indfb-pgflip-blt
[115.603747] Subtest psr-2p-primscrn-indfb-pgflip-blt: SKIP (0.000s)
[115.676403] [037/130] (903s left) kms_chamelium_audio (dp-audio)
[116.057921] Subtest dp-audio: SKIP (0.000s)
[116.895938] [038/130] (901s left) gem_ringfill (basic-all)
[122.928061] Starting subtest: basic-all
[124.097776] Subtest basic-all: SUCCESS (1.170s)
[124.246368] [039/130] (894s left) kms_pipe_crc_basic (suspend-read-crc)
[124.354753] Starting subtest: suspend-read-crc
[124.357085] Starting dynamic subtest: pipe-A-eDP-1
[141.972565] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.590s)
[141.981146] Starting dynamic subtest: pipe-B-eDP-1
[159.685014] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.749s)
[159.694670] Starting dynamic subtest: pipe-C-eDP-1
[177.663793] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.715s)
[177.677608] Starting dynamic subtest: pipe-D-eDP-1
[195.630547] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.679s)
[195.633094] Subtest suspend-read-crc: SUCCESS (10.738s)
[196.520999] [040/130] (882s left) kms_plane_multiple (tiling-x)
[196.633946] Starting subtest: tiling-x
[196.636310] Starting dynamic subtest: pipe-A-eDP-1
[200.402837] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.687s)
[200.411391] Starting dynamic subtest: pipe-B-eDP-1
[204.870278] Dynamic subtest pipe-B-eDP-1: SUCCESS (4.409s)
[204.880800] Starting dynamic subtest: pipe-C-eDP-1
[209.193323] Dynamic subtest pipe-C-eDP-1: SUCCESS (4.289s)
[209.203953] Starting dynamic subtest: pipe-D-eDP-1
[213.520947] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.309s)
[213.523300] Subtest tiling-x: SUCCESS (16.698s)
[214.339371] [041/130] (865s left) kms_flip (dpms-off-confusion)
[214.452828] Starting subtest: dpms-off-confusion
[214.455116] Starting dynamic subtest: A-eDP1
[223.147015] Dynamic subtest A-eDP1: SUCCESS (8.676s)
[223.156259] Starting dynamic subtest: B-eDP1
[231.889450] Dynamic subtest B-eDP1: SUCCESS (8.745s)
[231.898929] Starting dynamic subtest: C-eDP1
[240.595705] Dynamic subtest C-eDP1: SUCCESS (8.709s)
[240.605800] Starting dynamic subtest: D-eDP1
[249.316628] Dynamic subtest D-eDP1: SUCCESS (8.720s)
[249.321768] Subtest dpms-off-confusion: SUCCESS (34.863s)
[250.473201] [042/130] (829s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip)
[250.576954] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip
[250.581082] Subtest y-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip: SKIP (0.000s)
[250.666914] [043/130] (828s left) perf_pmu (pmu-read)
[250.708644] Starting subtest: pmu-read
[250.711032] Subtest pmu-read: SUCCESS (0.004s)
[250.824024] [044/130] (828s left) gem_exec_whisper (basic-sync)
[250.889676] Starting subtest: basic-sync
[257.255950] Subtest basic-sync: SUCCESS (6.364s)
[257.438169] [045/130] (822s left) kms_addfb_basic (legacy-format)
[257.497147] Starting subtest: legacy-format
[257.519502] Subtest legacy-format: SUCCESS (0.020s)
[257.679726] [046/130] (822s left) syncobj_wait (invalid-signal-one-illegal-handle)
[257.752221] Starting subtest: invalid-signal-one-illegal-handle
[257.754649] Subtest invalid-signal-one-illegal-handle: SUCCESS (0.000s)
[257.873518] [047/130] (821s left) kms_cursor_edge_walk (64x64-left-edge)
[257.970810] Starting subtest: 64x64-left-edge
[257.973068] Starting dynamic subtest: pipe-A-eDP-1
[261.422091] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.448s)
[261.431337] Starting dynamic subtest: pipe-D-eDP-1
[264.539535] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.115s)
[264.541797] Subtest 64x64-left-edge: SUCCESS (6.565s)
[265.343867] [048/130] (814s left) gem_mmap_offset (blt-coherency)
[265.405463] Starting subtest: blt-coherency
[265.411797] Subtest blt-coherency: SUCCESS (0.009s)
[265.551143] [049/130] (814s left) kms_hdr (bpc-switch)
[265.651586] Starting subtest: bpc-switch
[266.719292] Starting dynamic subtest: pipe-A-eDP-1
[270.099971] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.381s)
[270.102332] Subtest bpc-switch: SUCCESS (4.449s)
[270.219911] [050/130] (809s left) kms_flip (2x-plain-flip)
[270.315083] Starting subtest: 2x-plain-flip
[270.326141] Subtest 2x-plain-flip: SKIP (0.010s)
[270.399964] [051/130] (809s left) kms_ccs (crc-primary-suspend-4-tiled-dg2-rc-ccs-cc)
[270.502764] Starting subtest: crc-primary-suspend-4-tiled-dg2-rc-ccs-cc
[270.504988] Starting dynamic subtest: pipe-A-eDP-1
[270.514007] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[270.524054] Starting dynamic subtest: pipe-B-eDP-1
[270.533632] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[270.541729] Starting dynamic subtest: pipe-C-eDP-1
[270.550564] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[270.558416] Starting dynamic subtest: pipe-D-eDP-1
[270.566660] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[270.570611] Subtest crc-primary-suspend-4-tiled-dg2-rc-ccs-cc: SKIP (0.004s)
[272.699966] [052/130] (807s left) gem_userptr_blits (coherency-unsync)
[272.773649] Subtest coherency-unsync: SKIP (0.000s)
[272.889805] [053/130] (807s left) syncobj_wait (single-wait-all-for-submit-unsubmitted)
[272.948329] Starting subtest: single-wait-all-for-submit-unsubmitted
[273.057612] Subtest single-wait-all-for-submit-unsubmitted: SUCCESS (0.108s)
[273.129583] [054/130] (806s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-pwrite)
[273.232502] Starting subtest: fbc-rgb101010-draw-pwrite
[277.594450] Subtest fbc-rgb101010-draw-pwrite: SUCCESS (4.365s)
[277.707417] [055/130] (802s left) gem_exec_parallel (fds)
[277.776567] Starting subtest: fds
[277.779189] Starting dynamic subtest: rcs0
[280.199340] Dynamic subtest rcs0: SUCCESS (2.420s)
[280.214625] Starting dynamic subtest: bcs0
[283.439027] Dynamic subtest bcs0: SUCCESS (3.237s)
[283.450762] Starting dynamic subtest: vcs0
[287.451907] Dynamic subtest vcs0: SUCCESS (4.010s)
[287.467884] Starting dynamic subtest: vcs1
[291.423165] Dynamic subtest vcs1: SUCCESS (3.969s)
[291.435220] Starting dynamic subtest: vecs0
[295.442088] Dynamic subtest vecs0: SUCCESS (4.018s)
[295.453140] Starting dynamic subtest: ccs0
[298.685410] Dynamic subtest ccs0: SUCCESS (3.242s)
[298.688251] Subtest fds: SUCCESS (20.906s)
[298.872760] [056/130] (781s left) kms_psr (psr-cursor-plane-move)
[298.969893] Starting subtest: psr-cursor-plane-move
[298.972098] Starting dynamic subtest: eDP-1
[300.723208] Dynamic subtest eDP-1: SUCCESS (1.750s)
[300.725152] Subtest psr-cursor-plane-move: SUCCESS (1.751s)
[301.576216] [057/130] (778s left) gem_softpin (zero)
[301.637237] Starting subtest: zero
[301.641348] Subtest zero: SUCCESS (0.005s)
[301.751871] [058/130] (778s left) kms_plane_scaling (planes-upscale-20x20-downscale-factor-0-5)
[301.857766] Starting subtest: planes-upscale-20x20-downscale-factor-0-5
[301.860046] Starting dynamic subtest: pipe-A
[301.868915] Dynamic subtest pipe-A: SKIP (0.004s)
[301.878951] Starting dynamic subtest: pipe-B
[301.887630] Dynamic subtest pipe-B: SKIP (0.019s)
[301.896336] Starting dynamic subtest: pipe-C
[301.905107] Dynamic subtest pipe-C: SKIP (0.018s)
[301.913628] Starting dynamic subtest: pipe-D
[301.922337] Dynamic subtest pipe-D: SKIP (0.015s)
[301.926659] Subtest planes-upscale-20x20-downscale-factor-0-5: SKIP (0.058s)
[302.030297] [059/130] (778s left) kms_chamelium_hpd (vga-hpd-without-ddc)
[302.421253] Subtest vga-hpd-without-ddc: SKIP (0.000s)
[303.190700] [060/130] (777s left) i915_query (hwconfig_table)
[303.249570] Starting subtest: hwconfig_table
[303.543130] Subtest hwconfig_table: SUCCESS (0.001s)
[303.577957] [061/130] (776s left) gem_exec_params (cliprects_ptr-dirt)
[303.626252] Starting subtest: cliprects_ptr-dirt
[303.628474] Subtest cliprects_ptr-dirt: SUCCESS (0.000s)
[303.732472] [062/130] (776s left) kms_ccs (crc-sprite-planes-basic-4-tiled-mtl-mc-ccs)
[303.816574] Starting subtest: crc-sprite-planes-basic-4-tiled-mtl-mc-ccs
[303.818949] Starting dynamic subtest: pipe-A-eDP-1
[304.061815] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.211s)
[304.072806] Starting dynamic subtest: pipe-B-eDP-1
[305.278001] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.214s)
[305.288657] Starting dynamic subtest: pipe-C-eDP-1
[306.477169] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.200s)
[306.486206] Starting dynamic subtest: pipe-D-eDP-1
[307.699333] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.222s)
[307.701286] Subtest crc-sprite-planes-basic-4-tiled-mtl-mc-ccs: SUCCESS (3.851s)
[308.822121] [063/130] (771s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-mmap-gtt)
[308.928318] Starting subtest: fbcpsr-rgb101010-draw-mmap-gtt
[308.932533] Subtest fbcpsr-rgb101010-draw-mmap-gtt: SKIP (0.000s)
[309.025940] [064/130] (771s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-32bpp-4tile-upscaling)
[309.122087] Starting subtest: flip-64bpp-4tile-to-32bpp-4tile-upscaling
[309.124528] Starting dynamic subtest: pipe-A-default-mode
[311.840488] Dynamic subtest pipe-A-default-mode: SUCCESS (2.716s)
[311.842896] Subtest flip-64bpp-4tile-to-32bpp-4tile-upscaling: SUCCESS (2.718s)
[312.706642] [065/130] (767s left) kms_scaling_modes (scaling-mode-none)
[312.792645] Starting subtest: scaling-mode-none
[312.794795] Starting dynamic subtest: pipe-A-eDP-1
[312.914412] Dynamic subtest pipe-A-eDP-1: SKIP (0.118s)
[312.925704] Starting dynamic subtest: pipe-B-eDP-1
[312.962496] Dynamic subtest pipe-B-eDP-1: SKIP (0.047s)
[312.971406] Starting dynamic subtest: pipe-C-eDP-1
[313.011542] Dynamic subtest pipe-C-eDP-1: SKIP (0.048s)
[313.019988] Starting dynamic subtest: pipe-D-eDP-1
[313.060686] Dynamic subtest pipe-D-eDP-1: SKIP (0.048s)
[313.065193] Subtest scaling-mode-none: SKIP (0.266s)
[313.187528] [066/130] (767s left) kms_vblank (ts-continuation-modeset-rpm)
[313.289785] Starting subtest: ts-continuation-modeset-rpm
[313.292052] Starting dynamic subtest: pipe-A-eDP-1
[315.796731] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.504s)
[315.811671] Starting dynamic subtest: pipe-D-eDP-1
[318.020316] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.222s)
[318.022638] Subtest ts-continuation-modeset-rpm: SUCCESS (4.729s)
[318.794761] [067/130] (761s left) gem_exec_params (rs-invalid)
[318.848351] Starting subtest: rs-invalid
[318.853812] Subtest rs-invalid: SUCCESS (0.003s)
[318.983213] [068/130] (761s left) i915_hangman (engine-error-state-capture)
[319.043101] Starting subtest: engine-error-state-capture
[319.045498] Starting dynamic subtest: rcs0
[322.226070] Dynamic subtest rcs0: SUCCESS (3.149s)
[322.236991] Starting dynamic subtest: bcs0
[328.211631] Dynamic subtest bcs0: SUCCESS (6.016s)
[328.223517] Starting dynamic subtest: vcs0
[334.164168] Dynamic subtest vcs0: SUCCESS (5.949s)
[334.175681] Starting dynamic subtest: vcs1
[340.115261] Dynamic subtest vcs1: SUCCESS (5.948s)
[340.134397] Starting dynamic subtest: vecs0
[345.172970] Dynamic subtest vecs0: SUCCESS (5.056s)
[345.185172] Starting dynamic subtest: ccs0
[351.186622] Dynamic subtest ccs0: SUCCESS (6.011s)
[351.189479] Subtest engine-error-state-capture: SUCCESS (32.140s)
[351.262124] [069/130] (729s left) fbdev (nullptr)
[351.300227] Starting subtest: nullptr
[351.302415] Subtest nullptr: SUCCESS (0.000s)
[351.351216] [070/130] (729s left) syncobj_timeline (wait-any-snapshot)
[351.409591] Starting subtest: wait-any-snapshot
[351.492383] Subtest wait-any-snapshot: SUCCESS (0.081s)
[351.562172] [071/130] (729s left) gem_exec_schedule (u-semaphore-user)
[351.640121] Starting subtest: u-semaphore-user
[351.698056] Subtest u-semaphore-user: SUCCESS (0.064s)
[353.240533] [072/130] (727s left) kms_rotation_crc (primary-yf-tiled-reflect-x-0)
[353.335147] Starting subtest: primary-yf-tiled-reflect-x-0
[353.396803] Subtest primary-yf-tiled-reflect-x-0: SKIP (0.059s)
[353.490777] [073/130] (727s left) gem_exec_params (invalid-bsd1-flag-on-blt)
[353.550133] Starting subtest: invalid-bsd1-flag-on-blt
[353.552476] Subtest invalid-bsd1-flag-on-blt: SUCCESS (0.000s)
[353.653538] [074/130] (727s left) gem_ctx_persistence (legacy-engines-persistence)
[353.706783] Starting subtest: legacy-engines-persistence
[353.709126] Starting dynamic subtest: render
[354.575790] Dynamic subtest render: SUCCESS (0.868s)
[354.588314] Starting dynamic subtest: bsd1
[355.401943] Dynamic subtest bsd1: SUCCESS (0.823s)
[355.414386] Starting dynamic subtest: bsd2
[356.166726] Dynamic subtest bsd2: SUCCESS (0.763s)
[356.179358] Starting dynamic subtest: blt
[356.930672] Dynamic subtest blt: SUCCESS (0.761s)
[356.942861] Starting dynamic subtest: vebox
[357.667563] Dynamic subtest vebox: SUCCESS (0.734s)
[357.670091] Subtest legacy-engines-persistence: SUCCESS (3.960s)
[357.803291] [075/130] (722s left) gen7_exec_parse (oacontrol-tracking)
[357.866051] Subtest oacontrol-tracking: SKIP (0.000s)
[357.953750] [076/130] (722s left) kms_big_fb (4-tiled-64bpp-rotate-180)
[358.062738] Starting subtest: 4-tiled-64bpp-rotate-180
[360.327143] Subtest 4-tiled-64bpp-rotate-180: SUCCESS (2.262s)
[360.573863] [077/130] (720s left) gem_pwrite_snooped
[360.717215] [078/130] (720s left) gen9_exec_parse (bb-start-cmd)
[360.773587] Subtest bb-start-cmd: SKIP (0.000s)
[360.833414] [079/130] (720s left) gem_exec_balancer (parallel-keep-submit-fence)
[361.079786] Starting subtest: parallel-keep-submit-fence
[361.981750] Subtest parallel-keep-submit-fence: SUCCESS (0.902s)
[362.091044] [080/130] (718s left) gem_exec_fence (syncobj-timeline-repeat)
[362.654539] Starting subtest: syncobj-timeline-repeat
[362.878421] Subtest syncobj-timeline-repeat: SUCCESS (0.224s)
[364.315536] [081/130] (716s left) syncobj_timeline (etime-multi-wait-all-available-unsubmitted)
[364.373144] Starting subtest: etime-multi-wait-all-available-unsubmitted
[364.472608] Subtest etime-multi-wait-all-available-unsubmitted: SUCCESS (0.101s)
[364.543637] [082/130] (716s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-render)
[364.649843] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-render
[364.654068] Subtest fbc-2p-scndscrn-cur-indfb-draw-render: SKIP (0.000s)
[364.755465] [083/130] (716s left) kms_psr2_sf (pr-cursor-plane-move-continuous-exceed-sf)
[369.738258] Starting subtest: pr-cursor-plane-move-continuous-exceed-sf
[369.743156] Subtest pr-cursor-plane-move-continuous-exceed-sf: SKIP (0.002s)
[370.585908] [084/130] (710s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-mmap-wc)
[370.698851] Starting subtest: psr-2p-primscrn-spr-indfb-draw-mmap-wc
[370.703099] Subtest psr-2p-primscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[370.802943] [085/130] (710s left) kms_cursor_crc (cursor-onscreen-max-size)
[371.075050] Starting subtest: cursor-onscreen-max-size
[371.081577] Subtest cursor-onscreen-max-size: SKIP (0.000s)
[371.199491] [086/130] (710s left) gem_exec_reloc (basic-write-wc)
[371.257932] Subtest basic-write-wc: SKIP (0.000s)
[371.339385] [087/130] (709s left) kms_psr (psr2-no-drrs)
[371.428040] Starting subtest: psr2-no-drrs
[371.430368] Starting dynamic subtest: eDP-1
[373.045615] Dynamic subtest eDP-1: SUCCESS (1.616s)
[373.048632] Subtest psr2-no-drrs: SUCCESS (1.617s)
[373.842848] [088/130] (707s left) gem_create (create-invalid-size)
[373.900815] Starting subtest: create-invalid-size
[373.902869] Subtest create-invalid-size: SUCCESS (0.000s)
[374.080075] [089/130] (707s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-blt)
[374.182996] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-blt
[378.742004] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-blt: SUCCESS (4.562s)
[378.933188] [090/130] (702s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-mmap-gtt)
[379.041308] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-mmap-gtt
[379.045897] Subtest psr-2p-scndscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[379.151880] [091/130] (702s left) kms_pm_rpm (pm-caching)
[381.389765] Starting subtest: pm-caching
[381.395330] Subtest pm-caching: SKIP (0.000s)
[381.750836] [092/130] (699s left) gem_eio (wait-immediate)
[381.983433] Starting subtest: wait-immediate
[382.367126] Subtest wait-immediate: SUCCESS (0.384s)
[382.520502] [093/130] (698s left) kms_ccs (bad-pixel-format-4-tiled-dg2-rc-ccs)
[382.615399] Starting subtest: bad-pixel-format-4-tiled-dg2-rc-ccs
[382.618221] Starting dynamic subtest: pipe-A-eDP-1
[382.643174] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[382.657743] Starting dynamic subtest: pipe-B-eDP-1
[382.676833] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[382.685403] Starting dynamic subtest: pipe-C-eDP-1
[382.703562] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[382.711683] Starting dynamic subtest: pipe-D-eDP-1
[382.730262] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[382.733629] Subtest bad-pixel-format-4-tiled-dg2-rc-ccs: SKIP (0.004s)
[384.789083] [094/130] (696s left) kms_plane_scaling (planes-unity-scaling-downscale-factor-0-5)
[384.895908] Starting subtest: planes-unity-scaling-downscale-factor-0-5
[384.898060] Starting dynamic subtest: pipe-A
[384.906865] Dynamic subtest pipe-A: SKIP (0.004s)
[384.915738] Starting dynamic subtest: pipe-B
[384.924787] Dynamic subtest pipe-B: SKIP (0.016s)
[384.934000] Starting dynamic subtest: pipe-C
[384.943065] Dynamic subtest pipe-C: SKIP (0.018s)
[384.952417] Starting dynamic subtest: pipe-D
[384.961268] Dynamic subtest pipe-D: SKIP (0.017s)
[384.965549] Subtest planes-unity-scaling-downscale-factor-0-5: SKIP (0.058s)
[385.063000] [095/130] (696s left) kms_big_fb (yf-tiled-32bpp-rotate-90)
[385.166938] Starting subtest: yf-tiled-32bpp-rotate-90
[385.171238] Subtest yf-tiled-32bpp-rotate-90: SKIP (0.000s)
[385.273153] [096/130] (696s left) kms_chamelium_edid (dp-edid-stress-resolution-non-4k)
[385.654365] Subtest dp-edid-stress-resolution-non-4k: SKIP (0.000s)
[386.490947] [097/130] (695s left) device_reset (unbind-reset-rebind)
[386.539704] Starting subtest: unbind-reset-rebind
[391.187680] Subtest unbind-reset-rebind: SUCCESS (4.644s)
[391.227692] [098/130] (690s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-pwrite)
[391.331444] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-pwrite
[391.335755] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[391.432302] [099/130] (690s left) i915_pm_rps (waitboost)
[391.503496] Starting subtest: waitboost
[391.573465] Subtest waitboost: FAIL (0.013s)
[391.641645] [100/130] (690s left) syncobj_timeline (multi-wait-for-submit-available-unsubmitted-submitted-signa
[391.706383] Starting subtest: multi-wait-for-submit-available-unsubmitted-submitted-signaled
[391.708782] Subtest multi-wait-for-submit-available-unsubmitted-submitted-signaled: SUCCESS (0.000s)
[391.812645] [101/130] (689s left) kms_cursor_legacy (cursorb-vs-flipa-atomic-transitions)
[391.930446] Starting subtest: cursorB-vs-flipA-atomic-transitions
[391.934881] Subtest cursorB-vs-flipA-atomic-transitions: SKIP (0.001s)
[392.023219] [102/130] (689s left) kms_setmode (invalid-clone-single-crtc)
[392.081223] Starting subtest: invalid-clone-single-crtc
[392.088501] Subtest invalid-clone-single-crtc: SKIP (0.000s)
[392.169796] [103/130] (689s left) kms_cursor_crc (cursor-sliding-512x170)
[392.425401] Starting subtest: cursor-sliding-512x170
[392.429248] Subtest cursor-sliding-512x170: SKIP (0.001s)
[392.576060] [104/130] (689s left) core_getversion (basic)
[392.618789] Starting subtest: basic
[392.622428] Subtest basic: SUCCESS (0.000s)
[392.682742] [105/130] (689s left) kms_lease (lease-again)
[392.783423] Starting subtest: lease-again
[392.785383] Starting dynamic subtest: pipe-A-eDP-1
[392.787297] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.003s)
[392.797539] Starting dynamic subtest: pipe-B-eDP-1
[392.799440] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.002s)
[392.808033] Starting dynamic subtest: pipe-C-eDP-1
[392.809603] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.002s)
[392.817861] Starting dynamic subtest: pipe-D-eDP-1
[392.819424] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.002s)
[392.820995] Subtest lease-again: SUCCESS (0.012s)
[392.902494] [106/130] (688s left) prime_mmap_coherency (ioctl-errors)
[392.963418] Starting subtest: ioctl-errors
[406.031590] Subtest ioctl-errors: SUCCESS (13.064s)
[406.183253] [107/130] (675s left) gem_render_copy (yf-tiled-ccs-to-y-tiled)
[406.281755] Starting subtest: yf-tiled-ccs-to-y-tiled
[406.285598] Subtest yf-tiled-ccs-to-y-tiled: SKIP (0.000s)
[406.460059] [108/130] (675s left) prime_mmap_coherency (read)
[406.523281] Starting subtest: read
[411.914452] Subtest read: SUCCESS (5.388s)
[412.032643] [109/130] (669s left) kms_cursor_legacy (cursorb-vs-flipb-legacy)
[412.173092] Starting subtest: cursorB-vs-flipB-legacy
[412.181828] Subtest cursorB-vs-flipB-legacy: SKIP (0.001s)
[412.273996] [110/130] (669s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-pwrite)
[412.375852] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-pwrite
[416.834436] Subtest fbc-1p-primscrn-pri-indfb-draw-pwrite: SUCCESS (4.461s)
[416.947177] [111/130] (665s left) kms_frontbuffer_tracking (psr-1p-offscren-pri-indfb-draw-pwrite)
[417.062352] Starting subtest: psr-1p-offscren-pri-indfb-draw-pwrite
[421.954354] Subtest psr-1p-offscren-pri-indfb-draw-pwrite: SUCCESS (4.895s)
[422.088753] [112/130] (660s left) syncobj_timeline (invalid-transfer-non-existent-point)
[422.157623] Starting subtest: invalid-transfer-non-existent-point
[422.159949] Subtest invalid-transfer-non-existent-point: SUCCESS (0.000s)
[422.240454] [113/130] (659s left) syncobj_wait (invalid-multi-wait-all-unsubmitted-signaled)
[422.303237] Starting subtest: invalid-multi-wait-all-unsubmitted-signaled
[422.305556] Subtest invalid-multi-wait-all-unsubmitted-signaled: SUCCESS (0.000s)
[422.403303] [114/130] (659s left) kms_ccs (ccs-on-another-bo-y-tiled-gen12-rc-ccs-cc)
[422.501828] Starting subtest: ccs-on-another-bo-y-tiled-gen12-rc-ccs-cc
[422.503988] Starting dynamic subtest: pipe-A-eDP-1
[422.528371] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[422.538777] Starting dynamic subtest: pipe-B-eDP-1
[422.560773] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[422.570434] Starting dynamic subtest: pipe-C-eDP-1
[422.592500] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[422.602041] Starting dynamic subtest: pipe-D-eDP-1
[422.624398] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[422.628503] Subtest ccs-on-another-bo-y-tiled-gen12-rc-ccs-cc: SKIP (0.004s)
[424.680504] [115/130] (657s left) perf_pmu (busy-accuracy-2)
[424.722666] Starting subtest: busy-accuracy-2
[424.725132] Starting dynamic subtest: rcs0
[427.769769] Dynamic subtest rcs0: SUCCESS (3.046s)
[427.782274] Starting dynamic subtest: bcs0
[430.832998] Dynamic subtest bcs0: SUCCESS (3.062s)
[430.844780] Starting dynamic subtest: vcs0
[433.879460] Dynamic subtest vcs0: SUCCESS (3.045s)
[433.891345] Starting dynamic subtest: vcs1
[436.929639] Dynamic subtest vcs1: SUCCESS (3.049s)
[436.942422] Starting dynamic subtest: vecs0
[439.974830] Dynamic subtest vecs0: SUCCESS (3.044s)
[439.986562] Starting dynamic subtest: ccs0
[443.038190] Dynamic subtest ccs0: SUCCESS (3.062s)
[443.041285] Subtest busy-accuracy-2: SUCCESS (18.316s)
[443.159024] [116/130] (639s left) kms_hdmi_inject (inject-audio)
[443.501909] Starting subtest: inject-audio
[443.756035] Subtest inject-audio: SUCCESS (0.257s)
[444.330065] [117/130] (637s left) api_intel_allocator (simple-allocator)
[444.394763] Starting subtest: simple-allocator
[444.397012] Starting dynamic subtest: basic
[444.398897] Dynamic subtest basic: SUCCESS (0.003s)
[444.408059] Starting dynamic subtest: parallel-one
[444.559791] Dynamic subtest parallel-one: SUCCESS (0.162s)
[444.570908] Starting dynamic subtest: print
[444.573100] Dynamic subtest print: SUCCESS (0.000s)
[444.582105] Starting dynamic subtest: reuse
[444.584034] Dynamic subtest reuse: SUCCESS (0.000s)
[444.593030] Starting dynamic subtest: reserve
[444.594998] Dynamic subtest reserve: SUCCESS (0.000s)
[444.603592] Starting dynamic subtest: fork-reopen-allocator
[444.605567] Dynamic subtest fork-reopen-allocator: SUCCESS (0.015s)
[444.607490] Subtest simple-allocator: SUCCESS (0.183s)
[444.685269] [118/130] (637s left) gem_exec_schedule (semaphore-codependency)
[444.762005] Starting subtest: semaphore-codependency
[444.767008] Subtest semaphore-codependency: SUCCESS (0.012s)
[445.142640] [119/130] (637s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-onoff)
[445.239982] Starting subtest: fbc-1p-primscrn-cur-indfb-onoff
[448.116506] Subtest fbc-1p-primscrn-cur-indfb-onoff: SUCCESS (2.881s)
[448.284954] [120/130] (634s left) kms_flip (plain-flip-fb-recreate-interruptible)
[448.391823] Starting subtest: plain-flip-fb-recreate-interruptible
[448.395827] Starting dynamic subtest: A-eDP1
[457.263466] Dynamic subtest A-eDP1: SUCCESS (8.869s)
[457.273300] Starting dynamic subtest: B-eDP1
[466.161137] Dynamic subtest B-eDP1: SUCCESS (8.895s)
[466.177493] Starting dynamic subtest: C-eDP1
[475.053970] Dynamic subtest C-eDP1: SUCCESS (8.891s)
[475.066517] Starting dynamic subtest: D-eDP1
[483.949552] Dynamic subtest D-eDP1: SUCCESS (8.893s)
[483.951637] Subtest plain-flip-fb-recreate-interruptible: SUCCESS (35.558s)
[485.090804] [121/130] (597s left) gem_ctx_persistence (file)
[485.159800] Starting subtest: file
[485.304581] Subtest file: SUCCESS (0.145s)
[485.435665] [122/130] (597s left) gem_create (create-massive)
[485.497825] Starting subtest: create-massive
[485.499921] Subtest create-massive: SUCCESS (0.000s)
[485.676383] [123/130] (596s left) kms_content_protection (atomic-dpms)
[485.845931] Starting subtest: atomic-dpms
[489.149225] Subtest atomic-dpms: SKIP (3.301s)
[490.388853] [124/130] (592s left) kms_invalid_mode (overflow-vrefresh)
[490.506824] Starting subtest: overflow-vrefresh
[490.508931] Starting dynamic subtest: pipe-A-eDP-1
[490.790202] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.282s)
[490.799500] Starting dynamic subtest: pipe-B-eDP-1
[490.801390] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[490.809969] Starting dynamic subtest: pipe-C-eDP-1
[490.812652] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[490.821528] Starting dynamic subtest: pipe-D-eDP-1
[490.823539] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[490.825557] Subtest overflow-vrefresh: SUCCESS (0.288s)
[491.589914] [125/130] (590s left) gem_linear_blits (interruptible)
[491.807988] Starting subtest: interruptible
[495.328999] Subtest interruptible: SUCCESS (3.521s)
[495.480099] [126/130] (587s left) gem_basic (create-close)
[495.574432] Starting subtest: create-close
[495.578792] Subtest create-close: SUCCESS (0.000s)
[495.669880] [127/130] (586s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-render)
[495.790605] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-render
[499.272102] Subtest fbc-1p-primscrn-pri-indfb-draw-render: SUCCESS (3.486s)
[499.417403] [128/130] (583s left) gem_exec_balancer (bonded-true-hang)
[499.663912] Starting subtest: bonded-true-hang
[499.669258] Subtest bonded-true-hang: SKIP (0.000s)
[499.756070] [129/130] (582s left) gem_ctx_bad_destroy (double-destroy)
[499.808449] Starting subtest: double-destroy
[499.810933] Subtest double-destroy: SUCCESS (0.000s)
[499.876994] [130/130] (582s left) kms_vblank (wait-idle)
[499.976875] Starting subtest: wait-idle
[499.979223] Starting dynamic subtest: pipe-A-eDP-1
[501.752495] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.773s)
[501.767680] Starting dynamic subtest: pipe-D-eDP-1
[504.209578] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.454s)
[504.211980] Subtest wait-idle: SUCCESS (4.230s)
[504.990056] Closing watchdogs
Done.