[92.001736] Initializing watchdogs
[92.001783]   /dev/watchdog0
[92.015786] [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]
[92.019761] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[92.022029] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[92.025394] [001/130] (960s left) kms_async_flips (alternate-sync-async-flip-atomic)
[92.161084] Starting subtest: alternate-sync-async-flip-atomic
[92.542544] Starting dynamic subtest: pipe-A-eDP-1
[95.324698] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.783s)
[95.722788] Starting dynamic subtest: pipe-B-eDP-1
[98.465261] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.752s)
[98.844539] Starting dynamic subtest: pipe-C-eDP-1
[101.592173] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.754s)
[101.959768] Starting dynamic subtest: pipe-D-eDP-1
[104.719536] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.767s)
[104.721593] Subtest alternate-sync-async-flip-atomic: SUCCESS (12.561s)
[105.913439] [002/130] (946s left) i915_pm_rpm (sysfs-read)
[108.062263] Starting subtest: sysfs-read
[109.208891] Subtest sysfs-read: SUCCESS (1.148s)
[109.581889] [003/130] (943s left) gem_ctx_param (invalid-size-set)
[109.649233] Starting subtest: invalid-size-set
[109.651638] Subtest invalid-size-set: SUCCESS (0.001s)
[109.781786] [004/130] (942s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-cpu)
[109.885406] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-cpu
[109.889506] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[109.988948] [005/130] (942s left) kms_lease (lease-invalid-crtc)
[110.081251] Starting subtest: lease-invalid-crtc
[110.083507] Starting dynamic subtest: pipe-A-eDP-1
[110.086155] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s)
[110.094674] Starting dynamic subtest: pipe-B-eDP-1
[110.096858] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[110.104238] Starting dynamic subtest: pipe-C-eDP-1
[110.106103] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[110.113127] Starting dynamic subtest: pipe-D-eDP-1
[110.115250] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[110.117377] Subtest lease-invalid-crtc: SUCCESS (0.003s)
[110.187534] [006/130] (942s left) gem_mmap_offset (blt-coherency)
[110.245523] Starting subtest: blt-coherency
[110.250291] Subtest blt-coherency: SUCCESS (0.006s)
[110.419725] [007/130] (942s left) syncobj_timeline (etime-multi-wait-all-available-unsubmitted-signaled)
[110.480155] Starting subtest: etime-multi-wait-all-available-unsubmitted-signaled
[110.585725] Subtest etime-multi-wait-all-available-unsubmitted-signaled: SUCCESS (0.105s)
[110.680274] [008/130] (942s left) gem_ctx_shared (detached-shared-gtt)
[110.755610] Starting subtest: detached-shared-gtt
[112.908371] Subtest detached-shared-gtt: SUCCESS (2.151s)
[113.332416] [009/130] (939s left) kms_ccs (crc-primary-basic-4-tiled-mtl-mc-ccs)
[113.443066] Starting subtest: crc-primary-basic-4-tiled-mtl-mc-ccs
[113.445068] Starting dynamic subtest: pipe-A-eDP-1
[115.553513] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.110s)
[115.564702] Starting dynamic subtest: pipe-B-eDP-1
[117.681360] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.128s)
[117.689498] Starting dynamic subtest: pipe-C-eDP-1
[119.710412] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.027s)
[119.718262] Starting dynamic subtest: pipe-D-eDP-1
[121.887778] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.177s)
[121.889869] Subtest crc-primary-basic-4-tiled-mtl-mc-ccs: SUCCESS (8.446s)
[123.099293] [010/130] (929s left) gem_exec_schedule (wide)
[123.285844] Starting subtest: wide
[123.288404] Starting dynamic subtest: rcs0
[133.205051] Dynamic subtest rcs0: SUCCESS (9.919s)
[133.215553] Starting dynamic subtest: vcs0
[146.051145] Dynamic subtest vcs0: SUCCESS (12.845s)
[146.062200] Starting dynamic subtest: vcs1
[157.813075] Dynamic subtest vcs1: SUCCESS (11.761s)
[157.823269] Starting dynamic subtest: vecs0
[169.245171] Dynamic subtest vecs0: SUCCESS (11.430s)
[169.255420] Starting dynamic subtest: ccs0
[183.794861] Dynamic subtest ccs0: SUCCESS (14.548s)
[183.797614] Subtest wide: SUCCESS (60.508s)
[186.097802] [FACT gem_exec_schedule (wide)] new: kernel.kmod_is_loaded.vgem: true
[186.101167] [011/130] (866s left) kms_pm_rpm (drm-resources-equal)
[188.062062] Starting subtest: drm-resources-equal
[193.088068] Subtest drm-resources-equal: SUCCESS (5.028s)
[193.201418] [012/130] (859s left) syncobj_timeline (multi-wait-available-unsubmitted-submitted-signaled)
[193.262073] Starting subtest: multi-wait-available-unsubmitted-submitted-signaled
[193.264240] Subtest multi-wait-available-unsubmitted-submitted-signaled: SUCCESS (0.000s)
[193.387471] [013/130] (859s left) kms_ccs (random-ccs-data-y-tiled-gen12-rc-ccs-cc)
[193.468555] Starting subtest: random-ccs-data-y-tiled-gen12-rc-ccs-cc
[193.470674] Starting dynamic subtest: pipe-A-eDP-1
[193.494363] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[193.504975] Starting dynamic subtest: pipe-B-eDP-1
[193.528113] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[193.535429] Starting dynamic subtest: pipe-C-eDP-1
[193.559340] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[193.569211] Starting dynamic subtest: pipe-D-eDP-1
[193.594061] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[193.598562] Subtest random-ccs-data-y-tiled-gen12-rc-ccs-cc: SKIP (0.004s)
[195.789522] [014/130] (857s left) syncobj_timeline (single-wait-all-signaled)
[195.854092] Starting subtest: single-wait-all-signaled
[195.856385] Subtest single-wait-all-signaled: SUCCESS (0.000s)
[195.964166] [015/130] (857s left) kms_big_fb (yf-tiled-16bpp-rotate-90)
[196.062506] Starting subtest: yf-tiled-16bpp-rotate-90
[196.066699] Subtest yf-tiled-16bpp-rotate-90: SKIP (0.000s)
[196.184891] [016/130] (856s left) gem_ctx_bad_destroy (double-destroy)
[196.239859] Starting subtest: double-destroy
[196.242249] Subtest double-destroy: SUCCESS (0.000s)
[196.338326] [017/130] (856s left) kms_frontbuffer_tracking (psr-rgb565-draw-mmap-cpu)
[196.445151] Starting subtest: psr-rgb565-draw-mmap-cpu
[203.220918] Subtest psr-rgb565-draw-mmap-cpu: SUCCESS (6.779s)
[203.367742] [018/130] (849s left) fbdev (eof)
[203.419997] Starting subtest: eof
[203.422317] Subtest eof: SUCCESS (0.000s)
[203.512045] [019/130] (849s left) syncobj_basic (bad-fd-to-handle)
[203.568937] Starting subtest: bad-fd-to-handle
[203.571307] Subtest bad-fd-to-handle: SUCCESS (0.000s)
[203.699325] [020/130] (849s left) gem_exec_fence (basic-busy-all)
[203.769072] Starting subtest: basic-busy-all
[203.878058] Subtest basic-busy-all: SUCCESS (0.110s)
[206.039943] [021/130] (847s left) gem_exec_fence (syncobj-signal)
[206.473415] Starting subtest: syncobj-signal
[206.480654] Subtest syncobj-signal: SUCCESS (0.007s)
[208.021340] [022/130] (845s left) syncobj_timeline (invalid-single-wait-all-unsubmitted)
[208.080647] Starting subtest: invalid-single-wait-all-unsubmitted
[208.082589] Subtest invalid-single-wait-all-unsubmitted: SUCCESS (0.000s)
[208.213834] [023/130] (845s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-180-async-flip)
[208.316882] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-180-async-flip
[208.929524] Subtest 4-tiled-max-hw-stride-32bpp-rotate-180-async-flip: SUCCESS (0.614s)
[209.147795] [024/130] (844s left) gem_render_copy (yf-tiled-to-vebox-x-tiled)
[209.215364] Starting subtest: yf-tiled-to-vebox-x-tiled
[209.219518] Subtest yf-tiled-to-vebox-x-tiled: SKIP (0.000s)
[209.419187] [025/130] (844s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-pwrite)
[209.518145] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-pwrite
[216.972528] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-pwrite: SUCCESS (7.456s)
[217.121162] [026/130] (836s left) perf (invalid-create-userspace-config)
[217.264641] Starting subtest: invalid-create-userspace-config
[217.266794] Subtest invalid-create-userspace-config: SUCCESS (0.001s)
[217.307432] [027/130] (836s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-move)
[217.399640] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-move
[217.404096] Subtest fbcpsr-2p-primscrn-spr-indfb-move: SKIP (0.000s)
[217.529462] [028/130] (836s left) gem_cs_tlb (engines)
[217.595427] Starting subtest: engines
[217.597387] Starting dynamic subtest: rcs0
[219.749510] Dynamic subtest rcs0: SUCCESS (2.152s)
[219.759985] Starting dynamic subtest: bcs0
[221.901617] Dynamic subtest bcs0: SUCCESS (2.151s)
[221.911899] Starting dynamic subtest: vcs0
[224.054043] Dynamic subtest vcs0: SUCCESS (2.151s)
[224.065173] Starting dynamic subtest: vcs1
[226.207340] Dynamic subtest vcs1: SUCCESS (2.153s)
[226.217918] Starting dynamic subtest: vecs0
[228.360748] Dynamic subtest vecs0: SUCCESS (2.152s)
[228.370084] Starting dynamic subtest: ccs0
[230.513286] Dynamic subtest ccs0: SUCCESS (2.151s)
[230.515736] Subtest engines: SUCCESS (12.915s)
[230.671302] [029/130] (822s left) syncobj_timeline (etime-single-wait-submitted)
[230.723035] Starting subtest: etime-single-wait-submitted
[230.825723] Subtest etime-single-wait-submitted: SUCCESS (0.102s)
[230.930216] [030/130] (822s left) gem_spin_batch (resubmit-all)
[230.987522] Starting subtest: resubmit-all
[230.989967] Starting dynamic subtest: rcs0
[231.006194] Dynamic subtest rcs0: SUCCESS (0.018s)
[231.016863] Starting dynamic subtest: bcs0
[231.019138] Dynamic subtest bcs0: SUCCESS (0.003s)
[231.027262] Starting dynamic subtest: vcs0
[231.029190] Dynamic subtest vcs0: SUCCESS (0.003s)
[231.036577] Starting dynamic subtest: vcs1
[231.038546] Dynamic subtest vcs1: SUCCESS (0.002s)
[231.046222] Starting dynamic subtest: vecs0
[231.048300] Dynamic subtest vecs0: SUCCESS (0.002s)
[231.057666] Starting dynamic subtest: ccs0
[231.059636] Dynamic subtest ccs0: SUCCESS (0.002s)
[231.061549] Subtest resubmit-all: SUCCESS (0.034s)
[232.980322] [031/130] (820s left) kms_flip (2x-single-buffer-flip-vs-dpms-off-vs-modeset)
[233.095120] Starting subtest: 2x-single-buffer-flip-vs-dpms-off-vs-modeset
[233.110620] Subtest 2x-single-buffer-flip-vs-dpms-off-vs-modeset: SKIP (0.011s)
[233.208671] [032/130] (820s left) kms_frontbuffer_tracking (psr-2p-pri-indfb-multidraw)
[233.309668] Starting subtest: psr-2p-pri-indfb-multidraw
[233.314085] Subtest psr-2p-pri-indfb-multidraw: SKIP (0.000s)
[233.421354] [033/130] (820s left) gem_pxp (reject-modify-context-protection-off-3)
[233.543451] Starting subtest: reject-modify-context-protection-off-3
[233.545955] Subtest reject-modify-context-protection-off-3: SUCCESS (0.002s)
[233.669261] [034/130] (820s left) gem_exec_schedule (semaphore-user)
[233.734057] Starting subtest: semaphore-user
[233.783149] Subtest semaphore-user: SUCCESS (0.057s)
[234.965185] [035/130] (818s left) gem_tiled_partial_pwrite_pread (writes)
[235.026172] Subtest writes: SKIP (0.000s)
[235.110270] [036/130] (818s left) kms_cursor_crc (cursor-dpms)
[235.236592] Starting subtest: cursor-dpms
[235.238686] Starting dynamic subtest: pipe-A-eDP-1
[238.320986] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.084s)
[238.329731] Starting dynamic subtest: pipe-D-eDP-1
[241.906976] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.584s)
[241.909391] Subtest cursor-dpms: SUCCESS (6.670s)
[242.773793] [037/130] (811s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-0)
[242.878171] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-0
[242.882585] Subtest yf-tiled-max-hw-stride-32bpp-rotate-0: SKIP (0.000s)
[243.017392] [038/130] (810s left) i915_pm_freq_api (freq-reset)
[243.085650] Starting subtest: freq-reset
[243.088082] Starting dynamic subtest: gt0
[243.278954] Dynamic subtest gt0: SUCCESS (0.191s)
[243.286596] Starting dynamic subtest: gt1
[243.441770] Dynamic subtest gt1: SUCCESS (0.162s)
[243.444530] Subtest freq-reset: SUCCESS (0.355s)
[243.545515] [039/130] (810s left) kms_psr (fbc-psr2-sprite-plane-onoff)
[243.658911] Starting subtest: fbc-psr2-sprite-plane-onoff
[243.661228] Starting dynamic subtest: eDP-1
[243.665808] Dynamic subtest eDP-1: SKIP (0.000s)
[243.670216] Subtest fbc-psr2-sprite-plane-onoff: SKIP (0.003s)
[243.764958] [040/130] (810s left) perf_pmu (busy-accuracy-2)
[243.802490] Starting subtest: busy-accuracy-2
[243.804707] Starting dynamic subtest: rcs0
[246.843405] Dynamic subtest rcs0: SUCCESS (3.041s)
[246.853038] Starting dynamic subtest: bcs0
[249.900707] Dynamic subtest bcs0: SUCCESS (3.055s)
[249.910517] Starting dynamic subtest: vcs0
[252.949210] Dynamic subtest vcs0: SUCCESS (3.046s)
[252.960947] Starting dynamic subtest: vcs1
[255.996741] Dynamic subtest vcs1: SUCCESS (3.045s)
[256.008333] Starting dynamic subtest: vecs0
[259.043638] Dynamic subtest vecs0: SUCCESS (3.044s)
[259.060717] Starting dynamic subtest: ccs0
[262.105606] Dynamic subtest ccs0: SUCCESS (3.059s)
[262.107656] Subtest busy-accuracy-2: SUCCESS (18.304s)
[262.252993] [041/130] (791s left) gem_exec_balancer (bonded-true-hang)
[262.508455] Starting subtest: bonded-true-hang
[262.513883] Subtest bonded-true-hang: SKIP (0.000s)
[262.636878] [042/130] (791s left) gen9_exec_parse (valid-registers)
[262.705179] Subtest valid-registers: SKIP (0.000s)
[262.771469] [043/130] (791s left) gem_lmem_swapping (massive)
[262.813822] Subtest massive: SKIP (0.000s)
[262.860451] [044/130] (791s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-mmap-gtt)
[262.951482] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-mmap-gtt
[262.955589] Subtest psr-2p-scndscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[263.077969] [045/130] (791s left) kms_busy (extended-pageflip-modeset-hang-oldfb)
[263.172971] Starting subtest: extended-pageflip-modeset-hang-oldfb
[263.175174] Starting dynamic subtest: pipe-A
[271.080649] Dynamic subtest pipe-A: SUCCESS (7.907s)
[271.098454] Starting dynamic subtest: pipe-D
[279.666179] Dynamic subtest pipe-D: SUCCESS (8.583s)
[279.668603] Subtest extended-pageflip-modeset-hang-oldfb: SUCCESS (16.495s)
[280.537949] [046/130] (773s left) kms_vblank (wait-busy)
[280.641271] Starting subtest: wait-busy
[280.643162] Starting dynamic subtest: pipe-A-eDP-1
[282.519304] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.876s)
[282.534058] Starting dynamic subtest: pipe-D-eDP-1
[285.055780] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.537s)
[285.058456] Subtest wait-busy: SUCCESS (4.417s)
[285.879782] [047/130] (768s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-0-hflip)
[285.975732] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-0-hflip
[285.980239] Subtest y-tiled-max-hw-stride-32bpp-rotate-0-hflip: SKIP (0.000s)
[286.111488] [048/130] (768s left) gem_tiled_pread_basic
[286.252954] [049/130] (768s left) drm_read (fault-buffer)
[286.410046] Starting subtest: fault-buffer
[286.412384] Subtest fault-buffer: SUCCESS (0.000s)
[286.570452] [050/130] (767s left) perf (short-reads)
[286.677520] Starting subtest: short-reads
[286.691719] Subtest short-reads: SUCCESS (0.015s)
[286.730023] [051/130] (767s left) kms_plane_lowres (tiling-x)
[286.828529] Starting subtest: tiling-x
[286.830590] Starting dynamic subtest: pipe-A-eDP-1
[286.834865] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[287.122619] Starting dynamic subtest: pipe-B-eDP-1
[287.127166] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[287.137186] Starting dynamic subtest: pipe-C-eDP-1
[287.141644] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[287.150975] Starting dynamic subtest: pipe-D-eDP-1
[287.156091] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[287.160750] Subtest tiling-x: SKIP (0.291s)
[288.002910] [052/130] (766s left) kms_rotation_crc (sprite-rotation-90-pos-100-0)
[288.094918] Starting subtest: sprite-rotation-90-pos-100-0
[288.099170] Subtest sprite-rotation-90-pos-100-0: SKIP (0.001s)
[288.190230] [053/130] (766s left) syncobj_wait (invalid-reset-zero-handles)
[288.244769] Starting subtest: invalid-reset-zero-handles
[288.247077] Subtest invalid-reset-zero-handles: SUCCESS (0.000s)
[288.384412] [054/130] (766s left) kms_cursor_legacy (basic-busy-flip-before-cursor-legacy)
[288.508184] Starting subtest: basic-busy-flip-before-cursor-legacy
[288.512423] Subtest basic-busy-flip-before-cursor-legacy: SKIP (0.000s)
[288.678313] [055/130] (766s left) api_intel_allocator (reopen)
[288.739748] Starting subtest: reopen
[288.742079] Subtest reopen: SUCCESS (0.004s)
[288.901420] [056/130] (765s left) kms_plane_scaling (planes-upscale-20x20)
[288.996468] Starting subtest: planes-upscale-20x20
[288.998449] Starting dynamic subtest: pipe-A
[289.056561] Dynamic subtest pipe-A: SUCCESS (0.062s)
[289.066637] Starting dynamic subtest: pipe-B
[290.204622] Dynamic subtest pipe-B: SUCCESS (1.147s)
[290.224363] Starting dynamic subtest: pipe-C
[291.328343] Dynamic subtest pipe-C: SUCCESS (1.122s)
[291.338256] Starting dynamic subtest: pipe-D
[292.455136] Dynamic subtest pipe-D: SUCCESS (1.126s)
[292.457476] Subtest planes-upscale-20x20: SUCCESS (3.462s)
[293.631960] [057/130] (761s left) kms_cursor_legacy (forked-bo)
[293.759736] Starting subtest: forked-bo
[293.761725] Starting dynamic subtest: pipe-A
[299.209968] Dynamic subtest pipe-A: SUCCESS (5.448s)
[299.221171] Starting dynamic subtest: pipe-B
[304.678905] Dynamic subtest pipe-B: SUCCESS (5.467s)
[304.690329] Starting dynamic subtest: pipe-C
[310.145355] Dynamic subtest pipe-C: SUCCESS (5.464s)
[310.156542] Starting dynamic subtest: pipe-D
[315.618465] Dynamic subtest pipe-D: SUCCESS (5.470s)
[315.629349] Starting dynamic subtest: all-pipes
[321.109394] Dynamic subtest all-pipes: SUCCESS (5.488s)
[321.111919] Subtest forked-bo: SUCCESS (27.347s)
[321.277855] [058/130] (733s left) kms_atomic_interruptible (universal-setplane-cursor)
[321.398998] Starting subtest: universal-setplane-cursor
[321.401439] Starting dynamic subtest: pipe-A-eDP-1
[328.822281] Dynamic subtest pipe-A-eDP-1: SUCCESS (7.423s)
[328.824456] Subtest universal-setplane-cursor: SUCCESS (7.424s)
[329.690030] [059/130] (725s left) kms_properties (crtc-properties-atomic)
[329.797453] Starting subtest: crtc-properties-atomic
[329.799461] Starting dynamic subtest: pipe-A-eDP-1
[330.230823] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.433s)
[330.241415] Starting dynamic subtest: pipe-B-eDP-1
[331.428673] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.197s)
[331.439534] Starting dynamic subtest: pipe-C-eDP-1
[332.546205] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.115s)
[332.561064] Starting dynamic subtest: pipe-D-eDP-1
[333.670191] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.124s)
[333.672728] Subtest crtc-properties-atomic: SUCCESS (3.874s)
[334.508530] [060/130] (720s left) drm_read (short-buffer-block)
[334.664917] Starting subtest: short-buffer-block
[334.667150] Subtest short-buffer-block: SUCCESS (0.000s)
[334.813036] [061/130] (720s left) kms_frontbuffer_tracking (fbc-1p-primscrn-indfb-plflip-blt)
[334.907987] Starting subtest: fbc-1p-primscrn-indfb-plflip-blt
[339.493959] Subtest fbc-1p-primscrn-indfb-plflip-blt: SUCCESS (4.589s)
[340.712024] [062/130] (714s left) kms_rotation_crc (primary-y-tiled-reflect-x-180)
[340.814087] Starting subtest: primary-y-tiled-reflect-x-180
[340.873452] Subtest primary-y-tiled-reflect-x-180: SKIP (0.059s)
[341.002483] [063/130] (714s left) kms_cursor_legacy (short-flip-after-cursor-atomic-transitions)
[341.131773] Starting subtest: short-flip-after-cursor-atomic-transitions
[342.085186] Subtest short-flip-after-cursor-atomic-transitions: SUCCESS (0.955s)
[342.933476] [064/130] (712s left) gem_ctx_isolation (preservation)
[342.992245] Starting subtest: preservation
[342.994458] Starting dynamic subtest: rcs0
[343.138829] Dynamic subtest rcs0: SUCCESS (0.145s)
[343.151303] Starting dynamic subtest: bcs0
[343.316701] Dynamic subtest bcs0: SUCCESS (0.178s)
[343.328881] Starting dynamic subtest: vcs0
[343.474956] Dynamic subtest vcs0: SUCCESS (0.156s)
[343.488074] Starting dynamic subtest: vcs1
[345.028556] Dynamic subtest vcs1: SUCCESS (1.552s)
[345.041087] Starting dynamic subtest: vecs0
[346.995561] Dynamic subtest vecs0: SUCCESS (1.967s)
[347.007560] Starting dynamic subtest: ccs0
[349.057447] Dynamic subtest ccs0: SUCCESS (2.060s)
[349.060243] Subtest preservation: SUCCESS (6.064s)
[349.327146] [065/130] (705s left) kms_invalid_mode (overflow-vrefresh)
[349.431030] Starting subtest: overflow-vrefresh
[349.433284] Starting dynamic subtest: pipe-A-eDP-1
[349.727553] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.297s)
[349.737328] Starting dynamic subtest: pipe-B-eDP-1
[349.739467] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[349.747679] Starting dynamic subtest: pipe-C-eDP-1
[349.749822] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[349.757791] Starting dynamic subtest: pipe-D-eDP-1
[349.759723] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[349.761693] Subtest overflow-vrefresh: SUCCESS (0.304s)
[350.574815] [066/130] (704s left) kms_sequence (queue-busy)
[350.664317] Starting subtest: queue-busy
[350.666648] Starting dynamic subtest: pipe-A-eDP-1
[352.601591] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.937s)
[352.611121] Starting dynamic subtest: pipe-B-eDP-1
[355.246459] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.644s)
[355.256073] Starting dynamic subtest: pipe-C-eDP-1
[357.848605] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.601s)
[357.857980] Starting dynamic subtest: pipe-D-eDP-1
[360.371691] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.522s)
[360.374298] Subtest queue-busy: SUCCESS (9.709s)
[361.188727] [067/130] (693s left) kms_psr (psr-cursor-mmap-cpu)
[361.279259] Starting subtest: psr-cursor-mmap-cpu
[361.281456] Starting dynamic subtest: eDP-1
[362.960986] Dynamic subtest eDP-1: SUCCESS (1.683s)
[362.963650] Subtest psr-cursor-mmap-cpu: SUCCESS (1.684s)
[363.859153] [068/130] (691s left) gem_mmap_wc (fault-concurrent)
[363.910251] Subtest fault-concurrent: SKIP (0.000s)
[363.970044] [069/130] (691s left) kms_big_fb (linear-64bpp-rotate-0)
[364.088781] Starting subtest: linear-64bpp-rotate-0
[365.792851] Subtest linear-64bpp-rotate-0: SUCCESS (1.702s)
[365.988493] [070/130] (689s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-indfb-draw-mmap-wc)
[366.093500] Starting subtest: fbc-1p-offscreen-pri-indfb-draw-mmap-wc
[370.029026] Subtest fbc-1p-offscreen-pri-indfb-draw-mmap-wc: SUCCESS (3.938s)
[371.174361] [071/130] (684s left) perf_pmu (pmu-read)
[371.212076] Starting subtest: pmu-read
[371.214443] Subtest pmu-read: SUCCESS (0.002s)
[371.342590] [072/130] (684s left) gen3_render_tiledx_blits
[371.473702] [073/130] (683s left) gem_mmap (pf-nonblock)
[371.530051] Subtest pf-nonblock: SKIP (0.000s)
[371.595444] [074/130] (683s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-mmap-gtt)
[371.699327] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-mmap-gtt
[371.703201] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[371.831808] [075/130] (683s left) kms_psr2_sf (psr2-overlay-plane-move-continuous-exceed-fully-sf)
[376.802268] Starting subtest: psr2-overlay-plane-move-continuous-exceed-fully-sf
[376.804503] Starting dynamic subtest: pipe-A-eDP-1
[393.997541] Dynamic subtest pipe-A-eDP-1: SUCCESS (17.194s)
[394.011073] Starting dynamic subtest: pipe-B-eDP-1
[411.145226] Dynamic subtest pipe-B-eDP-1: SUCCESS (17.144s)
[411.147778] Subtest psr2-overlay-plane-move-continuous-exceed-fully-sf: SUCCESS (34.343s)
[411.970033] [076/130] (643s left) api_intel_bb (destroy-bb)
[412.027732] Starting subtest: destroy-bb
[412.034407] Subtest destroy-bb: SUCCESS (0.007s)
[412.214423] [077/130] (643s left) kms_content_protection (atomic)
[412.358096] Starting subtest: atomic
[412.362174] Subtest atomic: SKIP (0.000s)
[412.535111] [078/130] (643s left) kms_ccs (crc-sprite-planes-basic-4-tiled-dg2-rc-ccs-cc)
[412.633274] Starting subtest: crc-sprite-planes-basic-4-tiled-dg2-rc-ccs-cc
[412.635543] Starting dynamic subtest: pipe-A-eDP-1
[412.695571] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[412.704258] Starting dynamic subtest: pipe-B-eDP-1
[412.762625] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[412.773658] Starting dynamic subtest: pipe-C-eDP-1
[412.831838] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[412.841858] Starting dynamic subtest: pipe-D-eDP-1
[412.894666] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[412.898202] Subtest crc-sprite-planes-basic-4-tiled-dg2-rc-ccs-cc: SKIP (0.009s)
[414.850091] [079/130] (640s left) kms_rotation_crc (bad-pixel-format)
[414.952797] Starting subtest: bad-pixel-format
[414.957188] Subtest bad-pixel-format: SKIP (0.001s)
[415.049507] [080/130] (640s left) kms_psr2_sf (fbc-pr-overlay-plane-move-continuous-sf)
[420.122381] Starting subtest: fbc-pr-overlay-plane-move-continuous-sf
[420.127073] Subtest fbc-pr-overlay-plane-move-continuous-sf: SKIP (0.002s)
[420.976257] [081/130] (634s left) gem_partial_pwrite_pread (writes-after-reads-display)
[421.041137] Subtest writes-after-reads-display: SKIP (0.000s)
[421.116705] [082/130] (634s left) kms_ccs (bad-rotation-90-4-tiled-mtl-rc-ccs)
[421.227723] Starting subtest: bad-rotation-90-4-tiled-mtl-rc-ccs
[421.229590] Starting dynamic subtest: pipe-A-eDP-1
[421.369796] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.135s)
[421.380724] Starting dynamic subtest: pipe-B-eDP-1
[421.401701] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[421.410166] Starting dynamic subtest: pipe-C-eDP-1
[421.429695] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.002s)
[421.437588] Starting dynamic subtest: pipe-D-eDP-1
[421.456823] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.002s)
[421.458694] Subtest bad-rotation-90-4-tiled-mtl-rc-ccs: SUCCESS (0.145s)
[423.637471] [083/130] (632s left) kms_chamelium_hpd (dp-hpd-storm)
[424.037570] Subtest dp-hpd-storm: SKIP (0.000s)
[424.824941] [084/130] (631s left) gem_ctx_bad_destroy (invalid-pad)
[424.881104] Starting subtest: invalid-pad
[424.883631] Subtest invalid-pad: SUCCESS (0.000s)
[424.974589] [085/130] (630s left) gem_exec_schedule (pi-common)
[425.155512] Starting subtest: pi-common
[425.157604] Starting dynamic subtest: rcs0
[425.193148] Dynamic subtest rcs0: SUCCESS (0.040s)
[425.202039] Starting dynamic subtest: bcs0
[425.236864] Dynamic subtest bcs0: SUCCESS (0.043s)
[425.245922] Starting dynamic subtest: vcs0
[425.273219] Dynamic subtest vcs0: SUCCESS (0.035s)
[425.281803] Starting dynamic subtest: vcs1
[425.305818] Dynamic subtest vcs1: SUCCESS (0.032s)
[425.319189] Starting dynamic subtest: vecs0
[425.333783] Dynamic subtest vecs0: SUCCESS (0.027s)
[425.346384] Starting dynamic subtest: ccs0
[425.362738] Dynamic subtest ccs0: SUCCESS (0.028s)
[425.365097] Subtest pi-common: SUCCESS (0.211s)
[425.610874] [086/130] (630s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-blt)
[425.714787] Starting subtest: fbcpsr-rgb565-draw-blt
[432.791436] Subtest fbcpsr-rgb565-draw-blt: SUCCESS (7.078s)
[432.971973] [087/130] (623s left) gem_lmem_swapping (verify-ccs)
[433.020373] Subtest verify-ccs: SKIP (0.000s)
[433.071618] [088/130] (622s left) kms_flip (modeset-vs-vblank-race-interruptible)
[433.161273] Starting subtest: modeset-vs-vblank-race-interruptible
[433.163645] Starting dynamic subtest: A-eDP1
[437.832807] Dynamic subtest A-eDP1: SUCCESS (4.671s)
[437.844681] Starting dynamic subtest: B-eDP1
[442.459347] Dynamic subtest B-eDP1: SUCCESS (4.624s)
[442.470550] Starting dynamic subtest: C-eDP1
[447.067470] Dynamic subtest C-eDP1: SUCCESS (4.606s)
[447.078269] Starting dynamic subtest: D-eDP1
[451.697655] Dynamic subtest D-eDP1: SUCCESS (4.629s)
[451.703080] Subtest modeset-vs-vblank-race-interruptible: SUCCESS (18.540s)
[452.894193] [089/130] (603s left) kms_frontbuffer_tracking (fbc-tiling-4)
[452.989749] Starting subtest: fbc-tiling-4
[457.193035] Subtest fbc-tiling-4: SUCCESS (4.207s)
[458.398237] [090/130] (597s left) gem_ctx_persistence (legacy-engines-mixed-process)
[458.458904] Starting subtest: legacy-engines-mixed-process
[458.461307] Starting dynamic subtest: render
[459.937923] Dynamic subtest render: SUCCESS (1.478s)
[459.952046] Starting dynamic subtest: bsd1
[461.908487] Dynamic subtest bsd1: SUCCESS (1.968s)
[461.917581] Starting dynamic subtest: bsd2
[463.927713] Dynamic subtest bsd2: SUCCESS (2.017s)
[463.939830] Starting dynamic subtest: blt
[465.896611] Dynamic subtest blt: SUCCESS (1.966s)
[465.906770] Starting dynamic subtest: vebox
[467.908285] Dynamic subtest vebox: SUCCESS (2.009s)
[467.910563] Subtest legacy-engines-mixed-process: SUCCESS (9.449s)
[468.063463] [091/130] (588s left) kms_pipe_crc_basic (disable-crc-after-crtc)
[468.162224] Starting subtest: disable-crc-after-crtc
[468.164579] Starting dynamic subtest: pipe-A-eDP-1
[469.805146] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.641s)
[469.814740] Starting dynamic subtest: pipe-B-eDP-1
[472.068322] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.264s)
[472.077420] Starting dynamic subtest: pipe-C-eDP-1
[474.311748] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.242s)
[474.324089] Starting dynamic subtest: pipe-D-eDP-1
[476.593614] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.278s)
[476.595685] Subtest disable-crc-after-crtc: SUCCESS (8.431s)
[477.440423] [092/130] (578s left) kms_big_fb (x-tiled-8bpp-rotate-270)
[477.551509] Starting subtest: x-tiled-8bpp-rotate-270
[477.572541] Subtest x-tiled-8bpp-rotate-270: SKIP (0.020s)
[477.731380] [093/130] (578s left) gem_partial_pwrite_pread (reads-display)
[477.795261] Subtest reads-display: SKIP (0.000s)
[477.883733] [094/130] (578s left) gem_partial_pwrite_pread (write-display)
[477.943346] Subtest write-display: SKIP (0.000s)
[478.028991] [095/130] (578s left) gem_exec_reloc (basic-cpu-noreloc)
[478.095724] Subtest basic-cpu-noreloc: SKIP (0.000s)
[478.166393] [096/130] (578s left) kms_flip (blocking-absolute-wf_vblank-interruptible)
[478.260807] Starting subtest: blocking-absolute-wf_vblank-interruptible
[478.263056] Starting dynamic subtest: A-eDP1
[486.975894] Dynamic subtest A-eDP1: SUCCESS (8.713s)
[486.991233] Starting dynamic subtest: B-eDP1
[495.700259] Dynamic subtest B-eDP1: SUCCESS (8.722s)
[495.711452] Starting dynamic subtest: C-eDP1
[504.421688] Dynamic subtest C-eDP1: SUCCESS (8.720s)
[504.433252] Starting dynamic subtest: D-eDP1
[513.149616] Dynamic subtest D-eDP1: SUCCESS (8.725s)
[513.155627] Subtest blocking-absolute-wf_vblank-interruptible: SUCCESS (34.893s)
[514.393647] [097/130] (541s left) sw_sync (sync_multi_producer_single_consumer)
[514.435618] Starting subtest: sync_multi_producer_single_consumer
[515.511865] Subtest sync_multi_producer_single_consumer: SUCCESS (1.076s)
[515.608541] [098/130] (540s left) gen7_exec_parse (basic-allocation)
[515.663300] Subtest basic-allocation: SKIP (0.000s)
[515.741308] [099/130] (540s left) kms_atomic (crtc-invalid-params)
[515.839056] Starting subtest: crtc-invalid-params
[515.841182] Starting dynamic subtest: pipe-A-eDP-1
[516.193518] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.354s)
[516.195656] Subtest crtc-invalid-params: SUCCESS (0.355s)
[517.025546] [100/130] (539s left) gem_userptr_blits (map-fixed-invalidate-overlap)
[517.116783] Starting subtest: map-fixed-invalidate-overlap
[517.121194] Subtest map-fixed-invalidate-overlap: SKIP (0.000s)
[517.277501] [101/130] (539s left) kms_cursor_crc (cursor-sliding-256x256)
[517.569763] Starting subtest: cursor-sliding-256x256
[517.574912] Starting dynamic subtest: pipe-A-eDP-1
[520.799434] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.224s)
[520.826050] Starting dynamic subtest: pipe-D-eDP-1
[524.682595] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.861s)
[524.684952] Subtest cursor-sliding-256x256: SUCCESS (7.110s)
[525.500218] [102/130] (531s left) kms_dp_linktrain_fallback (dsc-fallback)
[525.602095] Starting subtest: dsc-fallback
[525.608590] Subtest dsc-fallback: SKIP (0.000s)
[525.701134] [103/130] (530s left) gem_softpin (softpin)
[525.774130] Starting subtest: softpin
[558.137849] Subtest softpin: SUCCESS (32.361s)
[558.297104] [104/130] (498s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-mmap-wc)
[558.403973] Starting subtest: psr-1p-primscrn-cur-indfb-draw-mmap-wc
[564.916126] Subtest psr-1p-primscrn-cur-indfb-draw-mmap-wc: SUCCESS (6.514s)
[565.060264] [105/130] (491s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-32bpp-4tile-downscaling)
[565.164276] Starting subtest: flip-64bpp-4tile-to-32bpp-4tile-downscaling
[565.166662] Starting dynamic subtest: pipe-A-default-mode
[566.373708] Dynamic subtest pipe-A-default-mode: SKIP (1.205s)
[566.378273] Subtest flip-64bpp-4tile-to-32bpp-4tile-downscaling: SKIP (1.207s)
[566.563048] [106/130] (490s left) prime_busy (hang)
[566.624131] Starting subtest: hang
[566.626330] Starting dynamic subtest: rcs0
[592.429505] Dynamic subtest rcs0: SUCCESS (25.801s)
[592.440175] Starting dynamic subtest: bcs0
[599.587202] Dynamic subtest bcs0: SUCCESS (7.159s)
[599.595447] Starting dynamic subtest: vcs0
[606.562229] Dynamic subtest vcs0: SUCCESS (6.976s)
[606.571659] Starting dynamic subtest: vcs1
[613.536919] Dynamic subtest vcs1: SUCCESS (6.972s)
[613.548935] Starting dynamic subtest: vecs0
[620.575545] Dynamic subtest vecs0: SUCCESS (7.038s)
[620.585319] Starting dynamic subtest: ccs0
[634.418071] Dynamic subtest ccs0: SUCCESS (13.838s)
[634.420486] Subtest hang: SUCCESS (67.790s)
[634.582394] [107/130] (422s left) kms_plane_scaling (plane-scaler-unity-scaling-with-pixel-format)
[634.674771] Starting subtest: plane-scaler-unity-scaling-with-pixel-format
[634.677044] Starting dynamic subtest: pipe-A
[635.824631] Dynamic subtest pipe-A: SUCCESS (1.151s)
[635.839821] Starting dynamic subtest: pipe-B
[638.106961] Dynamic subtest pipe-B: SUCCESS (2.280s)
[638.122046] Starting dynamic subtest: pipe-C
[639.338898] Dynamic subtest pipe-C: SUCCESS (1.229s)
[639.354662] Starting dynamic subtest: pipe-D
[640.569086] Dynamic subtest pipe-D: SUCCESS (1.230s)
[640.571379] Subtest plane-scaler-unity-scaling-with-pixel-format: SUCCESS (5.897s)
[641.779757] [108/130] (415s left) kms_addfb_basic (addfb25-bad-modifier)
[641.880232] Starting subtest: addfb25-bad-modifier
[641.882593] Subtest addfb25-bad-modifier: SUCCESS (0.000s)
[642.017452] [109/130] (414s left) gem_exec_balancer (parallel-ordering)
[642.278799] Starting subtest: parallel-ordering
[643.204316] Subtest parallel-ordering: SUCCESS (0.926s)
[643.368053] [110/130] (413s left) kms_flip (2x-plain-flip-fb-recreate)
[643.470550] Starting subtest: 2x-plain-flip-fb-recreate
[643.479371] Subtest 2x-plain-flip-fb-recreate: SKIP (0.010s)
[643.583250] [111/130] (413s left) gem_exec_reloc (basic-wc-cpu-noreloc)
[643.652607] Subtest basic-wc-cpu-noreloc: SKIP (0.000s)
[643.735717] [112/130] (413s left) gem_eio (in-flight-1us)
[643.922718] Starting subtest: in-flight-1us
[652.367150] Subtest in-flight-1us: SUCCESS (8.442s)
[652.567816] [113/130] (404s left) kms_flip_event_leak (basic)
[652.662733] Starting subtest: basic
[652.664641] Starting dynamic subtest: pipe-A-eDP-1
[653.088729] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.426s)
[653.099369] Starting dynamic subtest: pipe-B-eDP-1
[654.181281] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.091s)
[654.190369] Starting dynamic subtest: pipe-C-eDP-1
[655.297347] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.115s)
[655.311416] Starting dynamic subtest: pipe-D-eDP-1
[656.435964] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.136s)
[656.438689] Subtest basic: SUCCESS (3.774s)
[657.324443] [114/130] (399s left) kms_addfb_basic (clobberred-modifier)
[657.374978] Starting subtest: clobberred-modifier
[657.379508] Subtest clobberred-modifier: SKIP (0.000s)
[657.527356] [115/130] (399s left) dmabuf_sync_file (export-wait-after-attach)
[657.578108] Starting subtest: export-wait-after-attach
[657.580545] Subtest export-wait-after-attach: SUCCESS (0.001s)
[657.660871] [116/130] (399s left) kms_psr (pr-dpms)
[657.765885] Starting subtest: pr-dpms
[657.769746] Subtest pr-dpms: SKIP (0.000s)
[657.863194] [117/130] (399s left) kms_pwrite_crc
[659.557709] [118/130] (397s left) kms_cursor_crc (cursor-rapid-movement-128x128)
[659.788264] Starting subtest: cursor-rapid-movement-128x128
[659.793087] Starting dynamic subtest: pipe-A-eDP-1
[660.325082] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.534s)
[660.355604] Starting dynamic subtest: pipe-D-eDP-1
[661.530379] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.180s)
[661.532263] Subtest cursor-rapid-movement-128x128: SUCCESS (1.741s)
[662.397703] [119/130] (394s left) kms_chamelium_hpd (common-hpd-after-suspend)
[662.792326] Subtest common-hpd-after-suspend: SKIP (0.000s)
[663.585604] [120/130] (393s left) i915_query (query-topology-garbage-items)
[663.646053] Starting subtest: query-topology-garbage-items
[663.648350] Subtest query-topology-garbage-items: SUCCESS (0.000s)
[663.770122] [121/130] (393s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-indfb-draw-blt)
[663.881081] Starting subtest: psr-1p-offscreen-pri-indfb-draw-blt
[670.710569] Subtest psr-1p-offscreen-pri-indfb-draw-blt: SUCCESS (6.831s)
[670.895519] [122/130] (386s left) kms_scaling_modes (scaling-mode-center)
[671.004176] Starting subtest: scaling-mode-center
[671.006485] Starting dynamic subtest: pipe-A-eDP-1
[671.096159] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.093s)
[671.106421] Starting dynamic subtest: pipe-B-eDP-1
[672.233210] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.136s)
[672.243079] Starting dynamic subtest: pipe-C-eDP-1
[673.346213] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.112s)
[673.356876] Starting dynamic subtest: pipe-D-eDP-1
[674.480730] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.133s)
[674.482886] Subtest scaling-mode-center: SUCCESS (3.479s)
[675.702624] [123/130] (381s left) kms_pm_rpm (pm-caching)
[677.230296] Starting subtest: pm-caching
[677.235316] Subtest pm-caching: SKIP (0.000s)
[678.030734] [124/130] (379s left) kms_psr (fbc-pr-primary-mmap-gtt)
[678.111286] Starting subtest: fbc-pr-primary-mmap-gtt
[678.115272] Subtest fbc-pr-primary-mmap-gtt: SKIP (0.000s)
[678.204704] [125/130] (379s left) kms_psr (fbc-psr-basic)
[678.306319] Starting subtest: fbc-psr-basic
[678.308497] Starting dynamic subtest: eDP-1
[678.312895] Dynamic subtest eDP-1: SKIP (0.000s)
[678.317322] Subtest fbc-psr-basic: SKIP (0.001s)
[678.403424] [126/130] (379s left) gem_exec_fence (syncobj-timeline-signal)
[678.937938] Starting subtest: syncobj-timeline-signal
[678.944156] Subtest syncobj-timeline-signal: SUCCESS (0.008s)
[679.958755] [127/130] (377s left) gem_eio (wait-wedge-immediate)
[680.194465] Starting subtest: wait-wedge-immediate
[681.954855] Subtest wait-wedge-immediate: SUCCESS (1.759s)
[682.134086] [128/130] (375s left) kms_ccs (crc-primary-rotation-180-y-tiled-gen12-rc-ccs)
[682.227383] Starting subtest: crc-primary-rotation-180-y-tiled-gen12-rc-ccs
[682.229639] Starting dynamic subtest: pipe-A-eDP-1
[682.252444] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[682.261798] Starting dynamic subtest: pipe-B-eDP-1
[682.283607] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[682.292785] Starting dynamic subtest: pipe-C-eDP-1
[682.314478] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[682.323381] Starting dynamic subtest: pipe-D-eDP-1
[682.345365] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[682.349397] Subtest crc-primary-rotation-180-y-tiled-gen12-rc-ccs: SKIP (0.009s)
[684.488536] [129/130] (373s left) gen9_exec_parse (batch-zero-length)
[684.558972] Subtest batch-zero-length: SKIP (0.000s)
[684.633504] [130/130] (373s left) kms_frontbuffer_tracking (psr-2p-primscrn-indfb-plflip-blt)
[684.742594] Starting subtest: psr-2p-primscrn-indfb-plflip-blt
[684.746797] Subtest psr-2p-primscrn-indfb-plflip-blt: SKIP (0.000s)
[684.872555] Closing watchdogs
results: parsing output: 0/ for test: kms_async_flips
results: parsing output: 1/ for test: i915_pm_rpm
results: parsing output: 2/ for test: gem_ctx_param
results: parsing output: 3/ for test: kms_frontbuffer_tracking
results: parsing output: 4/ for test: kms_lease
results: parsing output: 5/ for test: gem_mmap_offset
results: parsing output: 6/ for test: syncobj_timeline
results: parsing output: 7/ for test: gem_ctx_shared
results: parsing output: 8/ for test: kms_ccs
results: parsing output: 9/ for test: gem_exec_schedule
results: parsing output: 10/ for test: kms_pm_rpm
results: parsing output: 11/ for test: syncobj_timeline
results: parsing output: 12/ for test: kms_ccs
results: parsing output: 13/ for test: syncobj_timeline
results: parsing output: 14/ for test: kms_big_fb
results: parsing output: 15/ for test: gem_ctx_bad_destroy
results: parsing output: 16/ for test: kms_frontbuffer_tracking
results: parsing output: 17/ for test: fbdev
results: parsing output: 18/ for test: syncobj_basic
results: parsing output: 19/ for test: gem_exec_fence
results: parsing output: 20/ for test: gem_exec_fence
results: parsing output: 21/ for test: syncobj_timeline
results: parsing output: 22/ for test: kms_big_fb
results: parsing output: 23/ for test: gem_render_copy
results: parsing output: 24/ for test: kms_frontbuffer_tracking
results: parsing output: 25/ for test: perf
results: parsing output: 26/ for test: kms_frontbuffer_tracking
results: parsing output: 27/ for test: gem_cs_tlb
results: parsing output: 28/ for test: syncobj_timeline
results: parsing output: 29/ for test: gem_spin_batch
results: parsing output: 30/ for test: kms_flip
results: parsing output: 31/ for test: kms_frontbuffer_tracking
results: parsing output: 32/ for test: gem_pxp
results: parsing output: 33/ for test: gem_exec_schedule
results: parsing output: 34/ for test: gem_tiled_partial_pwrite_pread
results: parsing output: 35/ for test: kms_cursor_crc
results: parsing output: 36/ for test: kms_big_fb
results: parsing output: 37/ for test: i915_pm_freq_api
results: parsing output: 38/ for test: kms_psr
results: parsing output: 39/ for test: perf_pmu
results: parsing output: 40/ for test: gem_exec_balancer
results: parsing output: 41/ for test: gen9_exec_parse
results: parsing output: 42/ for test: gem_lmem_swapping
results: parsing output: 43/ for test: kms_frontbuffer_tracking
results: parsing output: 44/ for test: kms_busy
results: parsing output: 45/ for test: kms_vblank
results: parsing output: 46/ for test: kms_big_fb
results: parsing output: 47/ for test: gem_tiled_pread_basic
results: parsing output: 48/ for test: drm_read
results: parsing output: 49/ for test: perf
results: parsing output: 50/ for test: kms_plane_lowres
results: parsing output: 51/ for test: kms_rotation_crc
results: parsing output: 52/ for test: syncobj_wait
results: parsing output: 53/ for test: kms_cursor_legacy
results: parsing output: 54/ for test: api_intel_allocator
results: parsing output: 55/ for test: kms_plane_scaling
results: parsing output: 56/ for test: kms_cursor_legacy
results: parsing output: 57/ for test: kms_atomic_interruptible
results: parsing output: 58/ for test: kms_properties
results: parsing output: 59/ for test: drm_read
results: parsing output: 60/ for test: kms_frontbuffer_tracking
results: parsing output: 61/ for test: kms_rotation_crc
results: parsing output: 62/ for test: kms_cursor_legacy
results: parsing output: 63/ for test: gem_ctx_isolation
results: parsing output: 64/ for test: kms_invalid_mode
results: parsing output: 65/ for test: kms_sequence
results: parsing output: 66/ for test: kms_psr
results: parsing output: 67/ for test: gem_mmap_wc
results: parsing output: 68/ for test: kms_big_fb
results: parsing output: 69/ for test: kms_frontbuffer_tracking
results: parsing output: 70/ for test: perf_pmu
results: parsing output: 71/ for test: gen3_render_tiledx_blits
results: parsing output: 72/ for test: gem_mmap
results: parsing output: 73/ for test: kms_frontbuffer_tracking
results: parsing output: 74/ for test: kms_psr2_sf
results: parsing output: 75/ for test: api_intel_bb
results: parsing output: 76/ for test: kms_content_protection
results: parsing output: 77/ for test: kms_ccs
results: parsing output: 78/ for test: kms_rotation_crc
results: parsing output: 79/ for test: kms_psr2_sf
results: parsing output: 80/ for test: gem_partial_pwrite_pread
results: parsing output: 81/ for test: kms_ccs
results: parsing output: 82/ for test: kms_chamelium_hpd
results: parsing output: 83/ for test: gem_ctx_bad_destroy
results: parsing output: 84/ for test: gem_exec_schedule
results: parsing output: 85/ for test: kms_frontbuffer_tracking
results: parsing output: 86/ for test: gem_lmem_swapping
results: parsing output: 87/ for test: kms_flip
results: parsing output: 88/ for test: kms_frontbuffer_tracking
results: parsing output: 89/ for test: gem_ctx_persistence
results: parsing output: 90/ for test: kms_pipe_crc_basic
results: parsing output: 91/ for test: kms_big_fb
results: parsing output: 92/ for test: gem_partial_pwrite_pread
results: parsing output: 93/ for test: gem_partial_pwrite_pread
results: parsing output: 94/ for test: gem_exec_reloc
results: parsing output: 95/ for test: kms_flip
results: parsing output: 96/ for test: sw_sync
results: parsing output: 97/ for test: gen7_exec_parse
results: parsing output: 98/ for test: kms_atomic
results: parsing output: 99/ for test: gem_userptr_blits
results: parsing output: 100/ for test: kms_cursor_crc
results: parsing output: 101/ for test: kms_dp_linktrain_fallback
results: parsing output: 102/ for test: gem_softpin
results: parsing output: 103/ for test: kms_frontbuffer_tracking
results: parsing output: 104/ for test: kms_flip_scaled_crc
results: parsing output: 105/ for test: prime_busy
results: parsing output: 106/ for test: kms_plane_scaling
results: parsing output: 107/ for test: kms_addfb_basic
results: parsing output: 108/ for test: gem_exec_balancer
results: parsing output: 109/ for test: kms_flip
results: parsing output: 110/ for test: gem_exec_reloc
results: parsing output: 111/ for test: gem_eio
results: parsing output: 112/ for test: kms_flip_event_leak
results: parsing output: 113/ for test: kms_addfb_basic
results: parsing output: 114/ for test: dmabuf_sync_file
results: parsing output: 115/ for test: kms_psr
results: parsing output: 116/ for test: kms_pwrite_crc
results: parsing output: 117/ for test: kms_cursor_crc
results: parsing output: 118/ for test: kms_chamelium_hpd
results: parsing output: 119/ for test: i915_query
results: parsing output: 120/ for test: kms_frontbuffer_tracking
results: parsing output: 121/ for test: kms_scaling_modes
results: parsing output: 122/ for test: kms_pm_rpm
results: parsing output: 123/ for test: kms_psr
results: parsing output: 124/ for test: kms_psr
results: parsing output: 125/ for test: gem_exec_fence
results: parsing output: 126/ for test: gem_eio
results: parsing output: 127/ for test: kms_ccs
results: parsing output: 128/ for test: gen9_exec_parse
results: parsing output: 129/ for test: kms_frontbuffer_tracking
Done.