[60.681450] Initializing watchdogs
[60.681496]   /dev/watchdog0
[60.694897] [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]
[60.698980] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[60.701118] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[60.704451] [001/130] (960s left) kms_async_flips (alternate-sync-async-flip-atomic)
[60.834699] Starting subtest: alternate-sync-async-flip-atomic
[61.207089] Starting dynamic subtest: pipe-A-eDP-1
[63.953946] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.749s)
[64.337257] Starting dynamic subtest: pipe-B-eDP-1
[67.091207] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.759s)
[67.483030] Starting dynamic subtest: pipe-C-eDP-1
[70.235190] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.759s)
[70.602532] Starting dynamic subtest: pipe-D-eDP-1
[73.366837] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.770s)
[73.369060] Subtest alternate-sync-async-flip-atomic: SUCCESS (12.534s)
[74.547365] [002/130] (946s left) i915_pm_rpm (sysfs-read)
[76.105347] Starting subtest: sysfs-read
[77.260653] Subtest sysfs-read: SUCCESS (1.154s)
[77.628393] [003/130] (943s left) gem_ctx_param (invalid-size-set)
[77.688502] Starting subtest: invalid-size-set
[77.690997] Subtest invalid-size-set: SUCCESS (0.001s)
[77.807430] [004/130] (943s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-cpu)
[77.908705] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-cpu
[77.913077] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[78.030063] [005/130] (943s left) kms_lease (lease-invalid-crtc)
[78.132808] Starting subtest: lease-invalid-crtc
[78.135059] Starting dynamic subtest: pipe-A-eDP-1
[78.137369] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s)
[78.145726] Starting dynamic subtest: pipe-B-eDP-1
[78.147886] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[78.154780] Starting dynamic subtest: pipe-C-eDP-1
[78.156613] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[78.163616] Starting dynamic subtest: pipe-D-eDP-1
[78.165710] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[78.167806] Subtest lease-invalid-crtc: SUCCESS (0.003s)
[78.228975] [006/130] (943s left) gem_mmap_offset (blt-coherency)
[78.282102] Starting subtest: blt-coherency
[78.286967] Subtest blt-coherency: SUCCESS (0.007s)
[78.428598] [007/130] (942s left) syncobj_timeline (etime-multi-wait-all-available-unsubmitted-signaled)
[78.480212] Starting subtest: etime-multi-wait-all-available-unsubmitted-signaled
[78.584969] Subtest etime-multi-wait-all-available-unsubmitted-signaled: SUCCESS (0.104s)
[78.680623] [008/130] (942s left) gem_ctx_shared (detached-shared-gtt)
[78.748303] Starting subtest: detached-shared-gtt
[80.903727] Subtest detached-shared-gtt: SUCCESS (2.154s)
[81.362462] [009/130] (940s left) kms_ccs (crc-primary-basic-4-tiled-mtl-mc-ccs)
[81.460169] Starting subtest: crc-primary-basic-4-tiled-mtl-mc-ccs
[81.462528] Starting dynamic subtest: pipe-A-eDP-1
[83.549037] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.090s)
[83.556602] Starting dynamic subtest: pipe-B-eDP-1
[85.735268] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.185s)
[85.745048] Starting dynamic subtest: pipe-C-eDP-1
[87.753833] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.016s)
[87.763278] Starting dynamic subtest: pipe-D-eDP-1
[89.809918] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.056s)
[89.812320] Subtest crc-primary-basic-4-tiled-mtl-mc-ccs: SUCCESS (8.351s)
[91.067427] [010/130] (930s left) gem_exec_schedule (wide)
[91.253897] Starting subtest: wide
[91.256292] Starting dynamic subtest: rcs0
[100.926814] Dynamic subtest rcs0: SUCCESS (9.671s)
[100.935935] Starting dynamic subtest: vcs0
[111.473808] Dynamic subtest vcs0: SUCCESS (10.546s)
[111.483098] Starting dynamic subtest: vcs1
[120.608992] Dynamic subtest vcs1: SUCCESS (9.135s)
[120.618582] Starting dynamic subtest: vecs0
[132.491316] Dynamic subtest vecs0: SUCCESS (11.882s)
[132.501099] Starting dynamic subtest: ccs0
[146.816120] Dynamic subtest ccs0: SUCCESS (14.323s)
[146.818541] Subtest wide: SUCCESS (55.560s)
[149.536365] [FACT gem_exec_schedule (wide)] new: kernel.kmod_is_loaded.vgem: true
[149.539734] [011/130] (872s left) kms_pm_rpm (drm-resources-equal)
[151.065938] Starting subtest: drm-resources-equal
[156.422690] Subtest drm-resources-equal: SUCCESS (5.357s)
[156.531202] [012/130] (865s left) syncobj_timeline (multi-wait-available-unsubmitted-submitted-signaled)
[156.592291] Starting subtest: multi-wait-available-unsubmitted-submitted-signaled
[156.594584] Subtest multi-wait-available-unsubmitted-submitted-signaled: SUCCESS (0.000s)
[156.725352] [013/130] (864s left) kms_ccs (random-ccs-data-y-tiled-gen12-rc-ccs-cc)
[156.828270] Starting subtest: random-ccs-data-y-tiled-gen12-rc-ccs-cc
[156.830379] Starting dynamic subtest: pipe-A-eDP-1
[156.854538] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[156.864088] Starting dynamic subtest: pipe-B-eDP-1
[156.887835] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[156.896739] Starting dynamic subtest: pipe-C-eDP-1
[156.919151] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[156.926845] Starting dynamic subtest: pipe-D-eDP-1
[156.951224] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[156.955707] Subtest random-ccs-data-y-tiled-gen12-rc-ccs-cc: SKIP (0.004s)
[159.063724] [014/130] (862s left) syncobj_timeline (single-wait-all-signaled)
[159.119818] Starting subtest: single-wait-all-signaled
[159.121984] Subtest single-wait-all-signaled: SUCCESS (0.000s)
[159.244460] [015/130] (862s left) kms_big_fb (yf-tiled-16bpp-rotate-90)
[159.338047] Starting subtest: yf-tiled-16bpp-rotate-90
[159.342447] Subtest yf-tiled-16bpp-rotate-90: SKIP (0.000s)
[159.454514] [016/130] (862s left) gem_ctx_bad_destroy (double-destroy)
[159.519579] Starting subtest: double-destroy
[159.521909] Subtest double-destroy: SUCCESS (0.000s)
[159.619835] [017/130] (862s left) kms_frontbuffer_tracking (psr-rgb565-draw-mmap-cpu)
[159.737439] Starting subtest: psr-rgb565-draw-mmap-cpu
[166.718947] Subtest psr-rgb565-draw-mmap-cpu: SUCCESS (6.982s)
[166.887726] [018/130] (854s left) fbdev (eof)
[166.927732] Starting subtest: eof
[166.930116] Subtest eof: SUCCESS (0.000s)
[167.037292] [019/130] (854s left) syncobj_basic (bad-fd-to-handle)
[167.095449] Starting subtest: bad-fd-to-handle
[167.097428] Subtest bad-fd-to-handle: SUCCESS (0.000s)
[167.224791] [020/130] (854s left) gem_exec_fence (basic-busy-all)
[167.292162] Starting subtest: basic-busy-all
[167.413999] Subtest basic-busy-all: SUCCESS (0.123s)
[169.036244] [021/130] (852s left) gem_exec_fence (syncobj-signal)
[169.472649] Starting subtest: syncobj-signal
[169.482449] Subtest syncobj-signal: SUCCESS (0.010s)
[170.986528] [022/130] (851s left) syncobj_timeline (invalid-single-wait-all-unsubmitted)
[171.041928] Starting subtest: invalid-single-wait-all-unsubmitted
[171.044223] Subtest invalid-single-wait-all-unsubmitted: SUCCESS (0.000s)
[171.189979] [023/130] (850s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-180-async-flip)
[171.301298] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-180-async-flip
[171.914695] Subtest 4-tiled-max-hw-stride-32bpp-rotate-180-async-flip: SUCCESS (0.615s)
[172.098403] [024/130] (850s left) gem_render_copy (yf-tiled-to-vebox-x-tiled)
[172.168687] Starting subtest: yf-tiled-to-vebox-x-tiled
[172.173274] Subtest yf-tiled-to-vebox-x-tiled: SKIP (0.000s)
[172.374885] [025/130] (849s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-pwrite)
[172.460056] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-pwrite
[179.948446] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-pwrite: SUCCESS (7.490s)
[180.093020] [026/130] (842s left) perf (invalid-create-userspace-config)
[180.253536] Starting subtest: invalid-create-userspace-config
[180.255802] Subtest invalid-create-userspace-config: SUCCESS (0.001s)
[180.294366] [027/130] (841s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-move)
[180.394379] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-move
[180.398781] Subtest fbcpsr-2p-primscrn-spr-indfb-move: SKIP (0.000s)
[180.527810] [028/130] (841s left) gem_cs_tlb (engines)
[180.595686] Starting subtest: engines
[180.598015] Starting dynamic subtest: rcs0
[182.750737] Dynamic subtest rcs0: SUCCESS (2.152s)
[182.760373] Starting dynamic subtest: bcs0
[184.904018] Dynamic subtest bcs0: SUCCESS (2.151s)
[184.914440] Starting dynamic subtest: vcs0
[187.057271] Dynamic subtest vcs0: SUCCESS (2.152s)
[187.067111] Starting dynamic subtest: vcs1
[189.209989] Dynamic subtest vcs1: SUCCESS (2.152s)
[189.220698] Starting dynamic subtest: vecs0
[191.363903] Dynamic subtest vecs0: SUCCESS (2.153s)
[191.373993] Starting dynamic subtest: ccs0
[193.517785] Dynamic subtest ccs0: SUCCESS (2.154s)
[193.519830] Subtest engines: SUCCESS (12.918s)
[193.691309] [029/130] (828s left) syncobj_timeline (etime-single-wait-submitted)
[193.747419] Starting subtest: etime-single-wait-submitted
[193.856321] Subtest etime-single-wait-submitted: SUCCESS (0.108s)
[193.962637] [030/130] (828s left) gem_spin_batch (resubmit-all)
[194.044602] Starting subtest: resubmit-all
[194.047117] Starting dynamic subtest: rcs0
[194.079362] Dynamic subtest rcs0: SUCCESS (0.034s)
[194.089054] Starting dynamic subtest: bcs0
[194.090967] Dynamic subtest bcs0: SUCCESS (0.004s)
[194.099444] Starting dynamic subtest: vcs0
[194.101659] Dynamic subtest vcs0: SUCCESS (0.004s)
[194.109722] Starting dynamic subtest: vcs1
[194.111790] Dynamic subtest vcs1: SUCCESS (0.005s)
[194.119445] Starting dynamic subtest: vecs0
[194.121604] Dynamic subtest vecs0: SUCCESS (0.003s)
[194.128917] Starting dynamic subtest: ccs0
[194.131076] Dynamic subtest ccs0: SUCCESS (0.004s)
[194.133165] Subtest resubmit-all: SUCCESS (0.063s)
[195.924039] [031/130] (826s left) kms_flip (2x-single-buffer-flip-vs-dpms-off-vs-modeset)
[196.023047] Starting subtest: 2x-single-buffer-flip-vs-dpms-off-vs-modeset
[196.032312] Subtest 2x-single-buffer-flip-vs-dpms-off-vs-modeset: SKIP (0.010s)
[196.136178] [032/130] (826s left) kms_frontbuffer_tracking (psr-2p-pri-indfb-multidraw)
[196.227715] Starting subtest: psr-2p-pri-indfb-multidraw
[196.231885] Subtest psr-2p-pri-indfb-multidraw: SKIP (0.000s)
[196.369421] [033/130] (826s left) gem_pxp (reject-modify-context-protection-off-3)
[196.487072] Starting subtest: reject-modify-context-protection-off-3
[196.489588] Subtest reject-modify-context-protection-off-3: SUCCESS (0.002s)
[196.631640] [034/130] (825s left) gem_exec_schedule (semaphore-user)
[196.716962] Starting subtest: semaphore-user
[196.766416] Subtest semaphore-user: SUCCESS (0.057s)
[197.972443] [035/130] (824s left) gem_tiled_partial_pwrite_pread (writes)
[198.046499] Subtest writes: SKIP (0.000s)
[198.135476] [036/130] (824s left) kms_cursor_crc (cursor-dpms)
[198.264669] Starting subtest: cursor-dpms
[198.267014] Starting dynamic subtest: pipe-A-eDP-1
[201.316820] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.051s)
[201.325120] Starting dynamic subtest: pipe-D-eDP-1
[204.891809] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.573s)
[204.894199] Subtest cursor-dpms: SUCCESS (6.626s)
[205.756562] [037/130] (816s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-0)
[205.857756] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-0
[205.862214] Subtest yf-tiled-max-hw-stride-32bpp-rotate-0: SKIP (0.000s)
[205.973094] [038/130] (816s left) i915_pm_freq_api (freq-reset)
[206.034627] Starting subtest: freq-reset
[206.037039] Starting dynamic subtest: gt0
[206.224962] Dynamic subtest gt0: SUCCESS (0.189s)
[206.234487] Starting dynamic subtest: gt1
[206.388775] Dynamic subtest gt1: SUCCESS (0.162s)
[206.391774] Subtest freq-reset: SUCCESS (0.353s)
[206.487069] [039/130] (816s left) kms_psr (fbc-psr2-sprite-plane-onoff)
[206.577218] Starting subtest: fbc-psr2-sprite-plane-onoff
[206.579409] Starting dynamic subtest: eDP-1
[206.583437] Dynamic subtest eDP-1: SKIP (0.000s)
[206.587528] Subtest fbc-psr2-sprite-plane-onoff: SKIP (0.001s)
[206.677155] [040/130] (816s left) perf_pmu (busy-accuracy-2)
[206.721229] Starting subtest: busy-accuracy-2
[206.723538] Starting dynamic subtest: rcs0
[209.767589] Dynamic subtest rcs0: SUCCESS (3.045s)
[209.778643] Starting dynamic subtest: bcs0
[212.825276] Dynamic subtest bcs0: SUCCESS (3.055s)
[212.834029] Starting dynamic subtest: vcs0
[215.869334] Dynamic subtest vcs0: SUCCESS (3.041s)
[215.879764] Starting dynamic subtest: vcs1
[218.916270] Dynamic subtest vcs1: SUCCESS (3.045s)
[218.925673] Starting dynamic subtest: vecs0
[221.965413] Dynamic subtest vecs0: SUCCESS (3.047s)
[221.975928] Starting dynamic subtest: ccs0
[225.026111] Dynamic subtest ccs0: SUCCESS (3.058s)
[225.028722] Subtest busy-accuracy-2: SUCCESS (18.306s)
[225.182795] [041/130] (797s left) gem_exec_balancer (bonded-true-hang)
[225.450883] Starting subtest: bonded-true-hang
[225.455916] Subtest bonded-true-hang: SKIP (0.000s)
[225.578598] [042/130] (797s left) gen9_exec_parse (valid-registers)
[225.639474] Subtest valid-registers: SKIP (0.000s)
[225.731434] [043/130] (797s left) gem_lmem_swapping (massive)
[225.770381] Subtest massive: SKIP (0.000s)
[225.812233] [044/130] (797s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-mmap-gtt)
[225.923587] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-mmap-gtt
[225.927576] Subtest psr-2p-scndscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[226.062383] [045/130] (796s left) kms_busy (extended-pageflip-modeset-hang-oldfb)
[226.153213] Starting subtest: extended-pageflip-modeset-hang-oldfb
[226.155428] Starting dynamic subtest: pipe-A
[234.043245] Dynamic subtest pipe-A: SUCCESS (7.886s)
[234.052371] Starting dynamic subtest: pipe-D
[242.632778] Dynamic subtest pipe-D: SUCCESS (8.589s)
[242.635188] Subtest extended-pageflip-modeset-hang-oldfb: SUCCESS (16.480s)
[243.509566] [046/130] (779s left) kms_vblank (wait-busy)
[243.614167] Starting subtest: wait-busy
[243.616091] Starting dynamic subtest: pipe-A-eDP-1
[245.499973] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.885s)
[245.513804] Starting dynamic subtest: pipe-D-eDP-1
[248.057074] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.555s)
[248.059341] Subtest wait-busy: SUCCESS (4.444s)
[248.879821] [047/130] (774s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-0-hflip)
[248.980116] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-0-hflip
[248.984438] Subtest y-tiled-max-hw-stride-32bpp-rotate-0-hflip: SKIP (0.000s)
[249.160153] [048/130] (773s left) gem_tiled_pread_basic
[249.297953] [049/130] (773s left) drm_read (fault-buffer)
[249.437372] Starting subtest: fault-buffer
[249.439583] Subtest fault-buffer: SUCCESS (0.001s)
[249.623952] [050/130] (773s left) perf (short-reads)
[249.730492] Starting subtest: short-reads
[249.745817] Subtest short-reads: SUCCESS (0.015s)
[249.782275] [051/130] (773s left) kms_plane_lowres (tiling-x)
[249.871995] Starting subtest: tiling-x
[249.873528] Starting dynamic subtest: pipe-A-eDP-1
[249.877160] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[250.167558] Starting dynamic subtest: pipe-B-eDP-1
[250.172191] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[250.180767] Starting dynamic subtest: pipe-C-eDP-1
[250.185993] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[250.194667] Starting dynamic subtest: pipe-D-eDP-1
[250.199408] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[250.203498] Subtest tiling-x: SKIP (0.294s)
[251.007973] [052/130] (772s left) kms_rotation_crc (sprite-rotation-90-pos-100-0)
[251.108150] Starting subtest: sprite-rotation-90-pos-100-0
[251.112483] Subtest sprite-rotation-90-pos-100-0: SKIP (0.001s)
[251.210167] [053/130] (772s left) syncobj_wait (invalid-reset-zero-handles)
[251.273475] Starting subtest: invalid-reset-zero-handles
[251.275690] Subtest invalid-reset-zero-handles: SUCCESS (0.000s)
[251.390271] [054/130] (771s left) kms_cursor_legacy (basic-busy-flip-before-cursor-legacy)
[251.506623] Starting subtest: basic-busy-flip-before-cursor-legacy
[251.511291] Subtest basic-busy-flip-before-cursor-legacy: SKIP (0.000s)
[251.710386] [055/130] (771s left) api_intel_allocator (reopen)
[251.769780] Starting subtest: reopen
[251.775127] Subtest reopen: SUCCESS (0.005s)
[251.923620] [056/130] (771s left) kms_plane_scaling (planes-upscale-20x20)
[251.999675] Starting subtest: planes-upscale-20x20
[252.001633] Starting dynamic subtest: pipe-A
[252.060028] Dynamic subtest pipe-A: SUCCESS (0.062s)
[252.070959] Starting dynamic subtest: pipe-B
[253.213961] Dynamic subtest pipe-B: SUCCESS (1.153s)
[253.227423] Starting dynamic subtest: pipe-C
[254.316109] Dynamic subtest pipe-C: SUCCESS (1.101s)
[254.327051] Starting dynamic subtest: pipe-D
[255.455539] Dynamic subtest pipe-D: SUCCESS (1.138s)
[255.458222] Subtest planes-upscale-20x20: SUCCESS (3.460s)
[256.648189] [057/130] (766s left) kms_cursor_legacy (forked-bo)
[256.781849] Starting subtest: forked-bo
[256.784207] Starting dynamic subtest: pipe-A
[262.235031] Dynamic subtest pipe-A: SUCCESS (5.451s)
[262.246858] Starting dynamic subtest: pipe-B
[267.701490] Dynamic subtest pipe-B: SUCCESS (5.464s)
[267.713559] Starting dynamic subtest: pipe-C
[273.185991] Dynamic subtest pipe-C: SUCCESS (5.481s)
[273.200585] Starting dynamic subtest: pipe-D
[278.692413] Dynamic subtest pipe-D: SUCCESS (5.503s)
[278.707098] Starting dynamic subtest: all-pipes
[284.211273] Dynamic subtest all-pipes: SUCCESS (5.517s)
[284.213636] Subtest forked-bo: SUCCESS (27.427s)
[284.411263] [058/130] (739s left) kms_atomic_interruptible (universal-setplane-cursor)
[284.524175] Starting subtest: universal-setplane-cursor
[284.526434] Starting dynamic subtest: pipe-A-eDP-1
[291.930140] Dynamic subtest pipe-A-eDP-1: SUCCESS (7.404s)
[291.932466] Subtest universal-setplane-cursor: SUCCESS (7.406s)
[292.828645] [059/130] (730s left) kms_properties (crtc-properties-atomic)
[292.922953] Starting subtest: crtc-properties-atomic
[292.925301] Starting dynamic subtest: pipe-A-eDP-1
[293.362931] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.439s)
[293.374670] Starting dynamic subtest: pipe-B-eDP-1
[294.553886] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.189s)
[294.562790] Starting dynamic subtest: pipe-C-eDP-1
[295.683707] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.128s)
[295.692716] Starting dynamic subtest: pipe-D-eDP-1
[296.817772] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.130s)
[296.820160] Subtest crtc-properties-atomic: SUCCESS (3.895s)
[297.676785] [060/130] (726s left) drm_read (short-buffer-block)
[297.831185] Starting subtest: short-buffer-block
[297.833677] Subtest short-buffer-block: SUCCESS (0.000s)
[297.992698] [061/130] (725s left) kms_frontbuffer_tracking (fbc-1p-primscrn-indfb-plflip-blt)
[298.101099] Starting subtest: fbc-1p-primscrn-indfb-plflip-blt
[302.687938] Subtest fbc-1p-primscrn-indfb-plflip-blt: SUCCESS (4.591s)
[303.829603] [062/130] (719s left) kms_rotation_crc (primary-y-tiled-reflect-x-180)
[303.935151] Starting subtest: primary-y-tiled-reflect-x-180
[303.994418] Subtest primary-y-tiled-reflect-x-180: SKIP (0.059s)
[304.117336] [063/130] (719s left) kms_cursor_legacy (short-flip-after-cursor-atomic-transitions)
[304.234992] Starting subtest: short-flip-after-cursor-atomic-transitions
[305.196188] Subtest short-flip-after-cursor-atomic-transitions: SUCCESS (0.961s)
[306.057454] [064/130] (717s left) gem_ctx_isolation (preservation)
[306.120727] Starting subtest: preservation
[306.123423] Starting dynamic subtest: rcs0
[306.255681] Dynamic subtest rcs0: SUCCESS (0.134s)
[306.266308] Starting dynamic subtest: bcs0
[306.412406] Dynamic subtest bcs0: SUCCESS (0.156s)
[306.423828] Starting dynamic subtest: vcs0
[306.581640] Dynamic subtest vcs0: SUCCESS (0.168s)
[306.591436] Starting dynamic subtest: vcs1
[308.060265] Dynamic subtest vcs1: SUCCESS (1.477s)
[308.072101] Starting dynamic subtest: vecs0
[310.053775] Dynamic subtest vecs0: SUCCESS (1.992s)
[310.065714] Starting dynamic subtest: ccs0
[312.053336] Dynamic subtest ccs0: SUCCESS (1.998s)
[312.055921] Subtest preservation: SUCCESS (5.932s)
[312.331697] [065/130] (711s left) kms_invalid_mode (overflow-vrefresh)
[312.445857] Starting subtest: overflow-vrefresh
[312.448082] Starting dynamic subtest: pipe-A-eDP-1
[312.725417] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.283s)
[312.738199] Starting dynamic subtest: pipe-B-eDP-1
[312.740596] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[312.749200] Starting dynamic subtest: pipe-C-eDP-1
[312.751138] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[312.758824] Starting dynamic subtest: pipe-D-eDP-1
[312.760837] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[312.762772] Subtest overflow-vrefresh: SUCCESS (0.288s)
[313.579177] [066/130] (710s left) kms_sequence (queue-busy)
[313.683494] Starting subtest: queue-busy
[313.685766] Starting dynamic subtest: pipe-A-eDP-1
[315.607836] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.925s)
[315.617973] Starting dynamic subtest: pipe-B-eDP-1
[318.237675] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.629s)
[318.247214] Starting dynamic subtest: pipe-C-eDP-1
[320.875701] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.637s)
[320.885745] Starting dynamic subtest: pipe-D-eDP-1
[323.488653] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.611s)
[323.491060] Subtest queue-busy: SUCCESS (9.807s)
[324.300910] [067/130] (699s left) kms_psr (psr-cursor-mmap-cpu)
[324.404494] Starting subtest: psr-cursor-mmap-cpu
[324.406927] Starting dynamic subtest: eDP-1
[326.083042] Dynamic subtest eDP-1: SUCCESS (1.679s)
[326.085363] Subtest psr-cursor-mmap-cpu: SUCCESS (1.680s)
[326.987649] [068/130] (697s left) gem_mmap_wc (fault-concurrent)
[327.045726] Subtest fault-concurrent: SKIP (0.000s)
[327.105479] [069/130] (696s left) kms_big_fb (linear-64bpp-rotate-0)
[327.219055] Starting subtest: linear-64bpp-rotate-0
[328.696610] Subtest linear-64bpp-rotate-0: SUCCESS (1.478s)
[328.884870] [070/130] (695s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-indfb-draw-mmap-wc)
[329.000837] Starting subtest: fbc-1p-offscreen-pri-indfb-draw-mmap-wc
[332.912814] Subtest fbc-1p-offscreen-pri-indfb-draw-mmap-wc: SUCCESS (3.913s)
[334.070027] [071/130] (690s left) perf_pmu (pmu-read)
[334.113213] Starting subtest: pmu-read
[334.115333] Subtest pmu-read: SUCCESS (0.002s)
[334.235379] [072/130] (689s left) gen3_render_tiledx_blits
[334.362245] [073/130] (689s left) gem_mmap (pf-nonblock)
[334.431069] Subtest pf-nonblock: SKIP (0.000s)
[334.504060] [074/130] (689s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-mmap-gtt)
[334.611743] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-mmap-gtt
[334.615849] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[334.748062] [075/130] (689s left) kms_psr2_sf (psr2-overlay-plane-move-continuous-exceed-fully-sf)
[339.746249] Starting subtest: psr2-overlay-plane-move-continuous-exceed-fully-sf
[339.748542] Starting dynamic subtest: pipe-A-eDP-1
[356.912526] Dynamic subtest pipe-A-eDP-1: SUCCESS (17.162s)
[356.924605] Starting dynamic subtest: pipe-B-eDP-1
[374.063376] Dynamic subtest pipe-B-eDP-1: SUCCESS (17.149s)
[374.065582] Subtest psr2-overlay-plane-move-continuous-exceed-fully-sf: SUCCESS (34.316s)
[374.873201] [076/130] (649s left) api_intel_bb (destroy-bb)
[374.935042] Starting subtest: destroy-bb
[374.942335] Subtest destroy-bb: SUCCESS (0.007s)
[375.063110] [077/130] (649s left) kms_content_protection (atomic)
[375.188080] Starting subtest: atomic
[375.192564] Subtest atomic: SKIP (0.000s)
[375.357124] [078/130] (649s left) kms_ccs (crc-sprite-planes-basic-4-tiled-dg2-rc-ccs-cc)
[375.446231] Starting subtest: crc-sprite-planes-basic-4-tiled-dg2-rc-ccs-cc
[375.448511] Starting dynamic subtest: pipe-A-eDP-1
[375.504425] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[375.515165] Starting dynamic subtest: pipe-B-eDP-1
[375.571983] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[375.582102] Starting dynamic subtest: pipe-C-eDP-1
[375.638867] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[375.648787] Starting dynamic subtest: pipe-D-eDP-1
[375.706654] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[375.711083] Subtest crc-sprite-planes-basic-4-tiled-dg2-rc-ccs-cc: SKIP (0.009s)
[377.641269] [079/130] (646s left) kms_rotation_crc (bad-pixel-format)
[377.733615] Starting subtest: bad-pixel-format
[377.738210] Subtest bad-pixel-format: SKIP (0.001s)
[377.829749] [080/130] (646s left) kms_psr2_sf (fbc-pr-overlay-plane-move-continuous-sf)
[382.835638] Starting subtest: fbc-pr-overlay-plane-move-continuous-sf
[382.840103] Subtest fbc-pr-overlay-plane-move-continuous-sf: SKIP (0.002s)
[383.685345] [081/130] (640s left) gem_partial_pwrite_pread (writes-after-reads-display)
[383.749752] Subtest writes-after-reads-display: SKIP (0.000s)
[383.846563] [082/130] (640s left) kms_ccs (bad-rotation-90-4-tiled-mtl-rc-ccs)
[383.941121] Starting subtest: bad-rotation-90-4-tiled-mtl-rc-ccs
[383.943264] Starting dynamic subtest: pipe-A-eDP-1
[384.079198] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.130s)
[384.089891] Starting dynamic subtest: pipe-B-eDP-1
[384.110511] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[384.119686] Starting dynamic subtest: pipe-C-eDP-1
[384.139194] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.002s)
[384.147077] Starting dynamic subtest: pipe-D-eDP-1
[384.166640] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.002s)
[384.168597] Subtest bad-rotation-90-4-tiled-mtl-rc-ccs: SUCCESS (0.140s)
[386.355487] [083/130] (638s left) kms_chamelium_hpd (dp-hpd-storm)
[386.749945] Subtest dp-hpd-storm: SKIP (0.000s)
[387.538901] [084/130] (637s left) gem_ctx_bad_destroy (invalid-pad)
[387.605143] Starting subtest: invalid-pad
[387.607556] Subtest invalid-pad: SUCCESS (0.000s)
[387.699296] [085/130] (637s left) gem_exec_schedule (pi-common)
[387.887669] Starting subtest: pi-common
[387.889596] Starting dynamic subtest: rcs0
[387.923393] Dynamic subtest rcs0: SUCCESS (0.037s)
[387.931826] Starting dynamic subtest: bcs0
[387.960633] Dynamic subtest bcs0: SUCCESS (0.036s)
[387.969029] Starting dynamic subtest: vcs0
[387.990888] Dynamic subtest vcs0: SUCCESS (0.029s)
[387.999423] Starting dynamic subtest: vcs1
[388.022365] Dynamic subtest vcs1: SUCCESS (0.030s)
[388.034121] Starting dynamic subtest: vecs0
[388.050292] Dynamic subtest vecs0: SUCCESS (0.027s)
[388.062094] Starting dynamic subtest: ccs0
[388.078174] Dynamic subtest ccs0: SUCCESS (0.027s)
[388.080274] Subtest pi-common: SUCCESS (0.193s)
[388.331471] [086/130] (636s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-blt)
[388.433040] Starting subtest: fbcpsr-rgb565-draw-blt
[395.513069] Subtest fbcpsr-rgb565-draw-blt: SUCCESS (7.082s)
[395.660234] [087/130] (629s left) gem_lmem_swapping (verify-ccs)
[395.706131] Subtest verify-ccs: SKIP (0.000s)
[395.745395] [088/130] (629s left) kms_flip (modeset-vs-vblank-race-interruptible)
[395.843335] Starting subtest: modeset-vs-vblank-race-interruptible
[395.845677] Starting dynamic subtest: A-eDP1
[400.510533] Dynamic subtest A-eDP1: SUCCESS (4.666s)
[400.522950] Starting dynamic subtest: B-eDP1
[405.138861] Dynamic subtest B-eDP1: SUCCESS (4.626s)
[405.149083] Starting dynamic subtest: C-eDP1
[409.724572] Dynamic subtest C-eDP1: SUCCESS (4.584s)
[409.737688] Starting dynamic subtest: D-eDP1
[414.263273] Dynamic subtest D-eDP1: SUCCESS (4.537s)
[414.269177] Subtest modeset-vs-vblank-race-interruptible: SUCCESS (18.426s)
[415.554474] [089/130] (609s left) kms_frontbuffer_tracking (fbc-tiling-4)
[415.663282] Starting subtest: fbc-tiling-4
[419.834264] Subtest fbc-tiling-4: SUCCESS (4.175s)
[421.047729] [090/130] (603s left) gem_ctx_persistence (legacy-engines-mixed-process)
[421.108354] Starting subtest: legacy-engines-mixed-process
[421.110780] Starting dynamic subtest: render
[422.951869] Dynamic subtest render: SUCCESS (1.843s)
[422.963357] Starting dynamic subtest: bsd1
[424.945777] Dynamic subtest bsd1: SUCCESS (1.991s)
[424.959682] Starting dynamic subtest: bsd2
[426.902679] Dynamic subtest bsd2: SUCCESS (1.954s)
[426.912663] Starting dynamic subtest: blt
[428.910823] Dynamic subtest blt: SUCCESS (2.006s)
[428.921285] Starting dynamic subtest: vebox
[430.894927] Dynamic subtest vebox: SUCCESS (1.982s)
[430.897408] Subtest legacy-engines-mixed-process: SUCCESS (9.787s)
[430.996996] [091/130] (593s left) kms_pipe_crc_basic (disable-crc-after-crtc)
[431.108928] Starting subtest: disable-crc-after-crtc
[431.111381] Starting dynamic subtest: pipe-A-eDP-1
[432.748481] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.639s)
[432.758321] Starting dynamic subtest: pipe-B-eDP-1
[435.012967] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.262s)
[435.022248] Starting dynamic subtest: pipe-C-eDP-1
[437.272670] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.257s)
[437.282644] Starting dynamic subtest: pipe-D-eDP-1
[439.536292] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.263s)
[439.538454] Subtest disable-crc-after-crtc: SUCCESS (8.428s)
[440.386816] [092/130] (584s left) kms_big_fb (x-tiled-8bpp-rotate-270)
[440.493135] Starting subtest: x-tiled-8bpp-rotate-270
[440.516066] Subtest x-tiled-8bpp-rotate-270: SKIP (0.022s)
[440.675140] [093/130] (584s left) gem_partial_pwrite_pread (reads-display)
[440.737161] Subtest reads-display: SKIP (0.000s)
[440.820674] [094/130] (584s left) gem_partial_pwrite_pread (write-display)
[440.873642] Subtest write-display: SKIP (0.000s)
[440.953681] [095/130] (584s left) gem_exec_reloc (basic-cpu-noreloc)
[441.018812] Subtest basic-cpu-noreloc: SKIP (0.000s)
[441.102345] [096/130] (584s left) kms_flip (blocking-absolute-wf_vblank-interruptible)
[441.211965] Starting subtest: blocking-absolute-wf_vblank-interruptible
[441.214157] Starting dynamic subtest: A-eDP1
[449.920065] Dynamic subtest A-eDP1: SUCCESS (8.707s)
[449.933226] Starting dynamic subtest: B-eDP1
[458.656815] Dynamic subtest B-eDP1: SUCCESS (8.733s)
[458.673519] Starting dynamic subtest: C-eDP1
[467.369216] Dynamic subtest C-eDP1: SUCCESS (8.710s)
[467.379086] Starting dynamic subtest: D-eDP1
[476.100389] Dynamic subtest D-eDP1: SUCCESS (8.729s)
[476.105433] Subtest blocking-absolute-wf_vblank-interruptible: SUCCESS (34.892s)
[477.343503] [097/130] (547s left) sw_sync (sync_multi_producer_single_consumer)
[477.375674] Starting subtest: sync_multi_producer_single_consumer
[478.452752] Subtest sync_multi_producer_single_consumer: SUCCESS (1.075s)
[478.550280] [098/130] (546s left) gen7_exec_parse (basic-allocation)
[478.620824] Subtest basic-allocation: SKIP (0.000s)
[478.716908] [099/130] (546s left) kms_atomic (crtc-invalid-params)
[478.819357] Starting subtest: crtc-invalid-params
[478.821723] Starting dynamic subtest: pipe-A-eDP-1
[479.182069] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.362s)
[479.183945] Subtest crtc-invalid-params: SUCCESS (0.364s)
[480.075247] [100/130] (545s left) gem_userptr_blits (map-fixed-invalidate-overlap)
[480.141048] Starting subtest: map-fixed-invalidate-overlap
[480.145553] Subtest map-fixed-invalidate-overlap: SKIP (0.000s)
[480.284796] [101/130] (545s left) kms_cursor_crc (cursor-sliding-256x256)
[480.538590] Starting subtest: cursor-sliding-256x256
[480.543503] Starting dynamic subtest: pipe-A-eDP-1
[483.765919] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.220s)
[483.791848] Starting dynamic subtest: pipe-D-eDP-1
[487.646707] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.860s)
[487.648956] Subtest cursor-sliding-256x256: SUCCESS (7.106s)
[488.544510] [102/130] (536s left) kms_dp_linktrain_fallback (dsc-fallback)
[488.648426] Starting subtest: dsc-fallback
[488.654982] Subtest dsc-fallback: SKIP (0.000s)
[488.744346] [103/130] (536s left) gem_softpin (softpin)
[488.802059] Starting subtest: softpin
[521.243842] Subtest softpin: SUCCESS (32.437s)
[521.403578] [104/130] (504s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-mmap-wc)
[521.510671] Starting subtest: psr-1p-primscrn-cur-indfb-draw-mmap-wc
[528.024033] Subtest psr-1p-primscrn-cur-indfb-draw-mmap-wc: SUCCESS (6.516s)
[528.172256] [105/130] (497s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-32bpp-4tile-downscaling)
[528.272287] Starting subtest: flip-64bpp-4tile-to-32bpp-4tile-downscaling
[528.274512] Starting dynamic subtest: pipe-A-default-mode
[529.388268] Dynamic subtest pipe-A-default-mode: SKIP (1.113s)
[529.392340] Subtest flip-64bpp-4tile-to-32bpp-4tile-downscaling: SKIP (1.115s)
[529.580504] [106/130] (496s left) prime_busy (hang)
[529.641324] Starting subtest: hang
[529.643713] Starting dynamic subtest: rcs0
[555.437552] Dynamic subtest rcs0: SUCCESS (25.791s)
[555.447495] Starting dynamic subtest: bcs0
[562.595501] Dynamic subtest bcs0: SUCCESS (7.156s)
[562.606693] Starting dynamic subtest: vcs0
[569.564920] Dynamic subtest vcs0: SUCCESS (6.971s)
[569.576833] Starting dynamic subtest: vcs1
[576.547213] Dynamic subtest vcs1: SUCCESS (6.978s)
[576.555611] Starting dynamic subtest: vecs0
[583.582665] Dynamic subtest vecs0: SUCCESS (7.035s)
[583.591305] Starting dynamic subtest: ccs0
[597.421368] Dynamic subtest ccs0: SUCCESS (13.836s)
[597.423918] Subtest hang: SUCCESS (67.774s)
[597.585395] [107/130] (428s left) kms_plane_scaling (plane-scaler-unity-scaling-with-pixel-format)
[597.684073] Starting subtest: plane-scaler-unity-scaling-with-pixel-format
[597.686390] Starting dynamic subtest: pipe-A
[598.798965] Dynamic subtest pipe-A: SUCCESS (1.117s)
[598.809306] Starting dynamic subtest: pipe-B
[601.024622] Dynamic subtest pipe-B: SUCCESS (2.225s)
[601.033620] Starting dynamic subtest: pipe-C
[602.248142] Dynamic subtest pipe-C: SUCCESS (1.222s)
[602.258657] Starting dynamic subtest: pipe-D
[603.481018] Dynamic subtest pipe-D: SUCCESS (1.230s)
[603.483373] Subtest plane-scaler-unity-scaling-with-pixel-format: SUCCESS (5.799s)
[604.707566] [108/130] (420s left) kms_addfb_basic (addfb25-bad-modifier)
[604.814394] Starting subtest: addfb25-bad-modifier
[604.816563] Subtest addfb25-bad-modifier: SUCCESS (0.000s)
[604.941248] [109/130] (420s left) gem_exec_balancer (parallel-ordering)
[605.202880] Starting subtest: parallel-ordering
[606.110864] Subtest parallel-ordering: SUCCESS (0.912s)
[606.281837] [110/130] (419s left) kms_flip (2x-plain-flip-fb-recreate)
[606.377292] Starting subtest: 2x-plain-flip-fb-recreate
[606.385282] Subtest 2x-plain-flip-fb-recreate: SKIP (0.010s)
[606.531629] [111/130] (419s left) gem_exec_reloc (basic-wc-cpu-noreloc)
[606.591198] Subtest basic-wc-cpu-noreloc: SKIP (0.000s)
[606.668458] [112/130] (419s left) gem_eio (in-flight-1us)
[606.859083] Starting subtest: in-flight-1us
[615.429588] Subtest in-flight-1us: SUCCESS (8.570s)
[615.644270] [113/130] (410s left) kms_flip_event_leak (basic)
[615.735094] Starting subtest: basic
[615.736943] Starting dynamic subtest: pipe-A-eDP-1
[616.153232] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.419s)
[616.162744] Starting dynamic subtest: pipe-B-eDP-1
[617.316784] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.160s)
[617.326239] Starting dynamic subtest: pipe-C-eDP-1
[618.447515] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.129s)
[618.456811] Starting dynamic subtest: pipe-D-eDP-1
[619.558012] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.110s)
[619.560387] Subtest basic: SUCCESS (3.824s)
[620.445447] [114/130] (405s left) kms_addfb_basic (clobberred-modifier)
[620.515088] Starting subtest: clobberred-modifier
[620.519340] Subtest clobberred-modifier: SKIP (0.000s)
[620.673508] [115/130] (405s left) dmabuf_sync_file (export-wait-after-attach)
[620.715438] Starting subtest: export-wait-after-attach
[620.717703] Subtest export-wait-after-attach: SUCCESS (0.001s)
[620.798779] [116/130] (405s left) kms_psr (pr-dpms)
[620.901063] Starting subtest: pr-dpms
[620.905218] Subtest pr-dpms: SKIP (0.000s)
[620.999190] [117/130] (405s left) kms_pwrite_crc
[622.669615] [118/130] (403s left) kms_cursor_crc (cursor-rapid-movement-128x128)
[622.886847] Starting subtest: cursor-rapid-movement-128x128
[622.892799] Starting dynamic subtest: pipe-A-eDP-1
[623.431242] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.539s)
[623.460177] Starting dynamic subtest: pipe-D-eDP-1
[624.669041] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.215s)
[624.671209] Subtest cursor-rapid-movement-128x128: SUCCESS (1.779s)
[625.546108] [119/130] (400s left) kms_chamelium_hpd (common-hpd-after-suspend)
[625.934801] Subtest common-hpd-after-suspend: SKIP (0.000s)
[626.729997] [120/130] (399s left) i915_query (query-topology-garbage-items)
[626.799064] Starting subtest: query-topology-garbage-items
[626.801745] Subtest query-topology-garbage-items: SUCCESS (0.000s)
[626.939622] [121/130] (399s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-indfb-draw-blt)
[627.036692] Starting subtest: psr-1p-offscreen-pri-indfb-draw-blt
[633.887701] Subtest psr-1p-offscreen-pri-indfb-draw-blt: SUCCESS (6.852s)
[634.053555] [122/130] (392s left) kms_scaling_modes (scaling-mode-center)
[634.159524] Starting subtest: scaling-mode-center
[634.161955] Starting dynamic subtest: pipe-A-eDP-1
[634.254743] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.094s)
[634.266919] Starting dynamic subtest: pipe-B-eDP-1
[635.399950] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.144s)
[635.410485] Starting dynamic subtest: pipe-C-eDP-1
[636.513207] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.112s)
[636.524835] Starting dynamic subtest: pipe-D-eDP-1
[637.649874] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.134s)
[637.652201] Subtest scaling-mode-center: SUCCESS (3.491s)
[638.931554] [123/130] (387s left) kms_pm_rpm (pm-caching)
[641.063995] Starting subtest: pm-caching
[641.068951] Subtest pm-caching: SKIP (0.000s)
[641.449326] [124/130] (384s left) kms_psr (fbc-pr-primary-mmap-gtt)
[641.547417] Starting subtest: fbc-pr-primary-mmap-gtt
[641.552052] Subtest fbc-pr-primary-mmap-gtt: SKIP (0.000s)
[641.645240] [125/130] (384s left) kms_psr (fbc-psr-basic)
[641.763256] Starting subtest: fbc-psr-basic
[641.765610] Starting dynamic subtest: eDP-1
[641.770312] Dynamic subtest eDP-1: SKIP (0.000s)
[641.774427] Subtest fbc-psr-basic: SKIP (0.003s)
[641.871293] [126/130] (384s left) gem_exec_fence (syncobj-timeline-signal)
[642.419834] Starting subtest: syncobj-timeline-signal
[642.425924] Subtest syncobj-timeline-signal: SUCCESS (0.007s)
[644.053867] [127/130] (382s left) gem_eio (wait-wedge-immediate)
[644.262518] Starting subtest: wait-wedge-immediate
[645.985421] Subtest wait-wedge-immediate: SUCCESS (1.722s)
[646.162603] [128/130] (380s left) kms_ccs (crc-primary-rotation-180-y-tiled-gen12-rc-ccs)
[646.252406] Starting subtest: crc-primary-rotation-180-y-tiled-gen12-rc-ccs
[646.254677] Starting dynamic subtest: pipe-A-eDP-1
[646.277927] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[646.289780] Starting dynamic subtest: pipe-B-eDP-1
[646.311633] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[646.320267] Starting dynamic subtest: pipe-C-eDP-1
[646.342054] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[646.350472] Starting dynamic subtest: pipe-D-eDP-1
[646.372386] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[646.376611] Subtest crc-primary-rotation-180-y-tiled-gen12-rc-ccs: SKIP (0.005s)
[648.423528] [129/130] (378s left) gen9_exec_parse (batch-zero-length)
[648.496816] Subtest batch-zero-length: SKIP (0.000s)
[648.582532] [130/130] (378s left) kms_frontbuffer_tracking (psr-2p-primscrn-indfb-plflip-blt)
[648.678612] Starting subtest: psr-2p-primscrn-indfb-plflip-blt
[648.683036] Subtest psr-2p-primscrn-indfb-plflip-blt: SKIP (0.000s)
[648.839432] 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.