[56.833731] Initializing watchdogs
[56.833782]   /dev/watchdog0
[56.861471] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:7d55 Intel Meteorlake (Gen12) Meteor Lake-P [Intel Arc Graphics]
[56.865970] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[56.868199] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[56.870749] [001/131] (960s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-mmap-wc)
[56.974088] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-mmap-wc
[56.975783] Subtest fbc-2p-scndscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[57.091938] [002/131] (960s left) i915_drm_fdinfo (isolation)
[57.127973] Starting subtest: isolation
[57.128903] Starting dynamic subtest: rcs0
[57.176972] Dynamic subtest rcs0: SKIP (0.047s)
[57.185069] Starting dynamic subtest: bcs0
[57.186834] Dynamic subtest bcs0: SKIP (0.001s)
[57.191918] Starting dynamic subtest: vcs0
[57.194197] Dynamic subtest vcs0: SKIP (0.000s)
[57.199269] Starting dynamic subtest: vcs1
[57.200880] Dynamic subtest vcs1: SKIP (0.000s)
[57.205953] Starting dynamic subtest: vecs0
[57.207695] Dynamic subtest vecs0: SKIP (0.000s)
[57.212790] Starting dynamic subtest: ccs0
[57.214535] Dynamic subtest ccs0: SKIP (0.000s)
[57.216150] Subtest isolation: SKIP (0.052s)
[57.252288] [003/131] (960s left) kms_pm_rpm (modeset-lpsp)
[59.091307] Starting subtest: modeset-lpsp
[60.558646] Subtest modeset-lpsp: SUCCESS (1.470s)
[60.649994] [004/131] (956s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-fullscreen)
[60.741191] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-fullscreen
[60.742817] Subtest fbcpsr-2p-scndscrn-spr-indfb-fullscreen: SKIP (0.000s)
[60.873584] [005/131] (956s left) kms_plane_scaling (plane-upscale-factor-0-25-with-pixel-format)
[60.969552] Starting subtest: plane-upscale-factor-0-25-with-pixel-format
[60.970569] Starting dynamic subtest: pipe-A
[62.026225] Dynamic subtest pipe-A: SUCCESS (1.058s)
[62.041601] Starting dynamic subtest: pipe-B
[64.119961] Dynamic subtest pipe-B: SUCCESS (2.093s)
[64.126632] Starting dynamic subtest: pipe-C
[65.322625] Dynamic subtest pipe-C: SUCCESS (1.202s)
[65.329484] Starting dynamic subtest: pipe-D
[66.455195] Dynamic subtest pipe-D: SUCCESS (1.132s)
[66.456237] Subtest plane-upscale-factor-0-25-with-pixel-format: SUCCESS (5.487s)
[67.666437] [006/131] (949s left) kms_flip (basic-flip-vs-dpms)
[67.748471] Starting subtest: basic-flip-vs-dpms
[67.750738] Starting dynamic subtest: A-eDP1
[70.348756] Dynamic subtest A-eDP1: SUCCESS (2.598s)
[70.354512] Starting dynamic subtest: B-eDP1
[72.505603] Dynamic subtest B-eDP1: SUCCESS (2.156s)
[72.511937] Starting dynamic subtest: C-eDP1
[74.563176] Dynamic subtest C-eDP1: SUCCESS (2.056s)
[74.575164] Starting dynamic subtest: D-eDP1
[76.628977] Dynamic subtest D-eDP1: SUCCESS (2.062s)
[76.630405] Subtest basic-flip-vs-dpms: SUCCESS (8.880s)
[77.430688] [007/131] (940s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-mmap-cpu)
[77.524812] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-mmap-cpu
[77.526497] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[77.650580] [008/131] (939s left) syncobj_eventfd (invalid-illegal-handle)
[77.702313] Starting subtest: invalid-illegal-handle
[77.703367] Subtest invalid-illegal-handle: SUCCESS (0.000s)
[77.820528] [009/131] (939s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-render)
[77.914041] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-render
[77.915863] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-render: SKIP (0.000s)
[78.017936] [010/131] (939s left) sw_sync (timeline_closed)
[78.044108] Starting subtest: timeline_closed
[78.045104] Subtest timeline_closed: SUCCESS (0.000s)
[78.111215] [011/131] (939s left) kms_psr2_sf (fbc-psr2-cursor-plane-update-sf)
[83.111966] Starting subtest: fbc-psr2-cursor-plane-update-sf
[83.112905] Starting dynamic subtest: pipe-A-eDP-1
[83.913044] Dynamic subtest pipe-A-eDP-1: SKIP (0.800s)
[83.922325] Starting dynamic subtest: pipe-B-eDP-1
[85.044393] Dynamic subtest pipe-B-eDP-1: SKIP (1.128s)
[85.046404] Subtest fbc-psr2-cursor-plane-update-sf: SKIP (1.932s)
[86.239370] [012/131] (931s left) kms_flip_scaled_crc (flip-64bpp-xtile-to-32bpp-xtile-downscaling)
[86.337305] Starting subtest: flip-64bpp-xtile-to-32bpp-xtile-downscaling
[86.338200] Starting dynamic subtest: pipe-A-default-mode
[87.501315] Dynamic subtest pipe-A-default-mode: SKIP (1.163s)
[87.503426] Subtest flip-64bpp-xtile-to-32bpp-xtile-downscaling: SKIP (1.164s)
[87.652321] [013/131] (930s left) syncobj_basic (bad-flags-fd-to-handle)
[87.701302] Starting subtest: bad-flags-fd-to-handle
[87.702127] Subtest bad-flags-fd-to-handle: SUCCESS (0.000s)
[87.788672] [014/131] (929s left) gem_exec_params (mmapped)
[87.843912] Starting subtest: mmapped
[87.846871] Subtest mmapped: SUCCESS (0.003s)
[87.988241] [015/131] (929s left) kms_atomic_transition (modeset-transition-nonblocking-fencing)
[88.072300] Starting subtest: modeset-transition-nonblocking-fencing
[88.073209] Starting dynamic subtest: 1x-outputs
[98.970985] Dynamic subtest 1x-outputs: SUCCESS (10.899s)
[98.972712] Subtest modeset-transition-nonblocking-fencing: SUCCESS (10.900s)
[99.827296] [016/131] (917s left) kms_rotation_crc (primary-x-tiled-reflect-x-0)
[99.922543] Starting subtest: primary-x-tiled-reflect-x-0
[106.761068] Subtest primary-x-tiled-reflect-x-0: SUCCESS (6.839s)
[107.986696] [017/131] (909s left) kms_cursor_crc (cursor-random-512x170)
[108.253058] Starting subtest: cursor-random-512x170
[108.254960] Subtest cursor-random-512x170: SKIP (0.001s)
[108.409279] [018/131] (909s left) kms_ccs (crc-primary-suspend-4-tiled-dg2-mc-ccs)
[108.484415] Starting subtest: crc-primary-suspend-4-tiled-dg2-mc-ccs
[108.485598] Starting dynamic subtest: pipe-A-eDP-1
[108.493441] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[108.500441] Starting dynamic subtest: pipe-B-eDP-1
[108.503881] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[108.509730] Starting dynamic subtest: pipe-C-eDP-1
[108.513065] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[108.518493] Starting dynamic subtest: pipe-D-eDP-1
[108.521863] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[108.523563] Subtest crc-primary-suspend-4-tiled-dg2-mc-ccs: SKIP (0.004s)
[110.674651] [019/131] (907s left) kms_chamelium_hpd (hdmi-hpd-for-each-pipe)
[111.045955] Subtest hdmi-hpd-for-each-pipe: SKIP (0.000s)
[111.853733] [020/131] (906s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-mmap-cpu)
[111.944229] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-mmap-cpu
[111.945998] Subtest psr-2p-scndscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[112.056873] [021/131] (905s left) syncobj_wait (wait-all-complex)
[112.106614] Starting subtest: wait-all-complex
[112.321754] Subtest wait-all-complex: SUCCESS (0.212s)
[112.397372] [022/131] (905s left) gem_partial_pwrite_pread (reads)
[112.459675] Subtest reads: SKIP (0.000s)
[112.536657] [023/131] (905s left) kms_async_flips (crc)
[112.619526] Starting subtest: crc
[112.997619] Starting dynamic subtest: pipe-A-eDP-1
[115.903076] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.905s)
[116.274846] Starting dynamic subtest: pipe-B-eDP-1
[119.142277] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.874s)
[119.522924] Starting dynamic subtest: pipe-C-eDP-1
[122.364218] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.847s)
[122.722640] Starting dynamic subtest: pipe-D-eDP-1
[125.595531] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.879s)
[125.596502] Subtest crc: SUCCESS (12.977s)
[126.775647] [024/131] (891s left) gem_spin_batch (resubmit-all)
[126.833809] Starting subtest: resubmit-all
[126.834809] Starting dynamic subtest: rcs0
[126.844725] Dynamic subtest rcs0: SUCCESS (0.011s)
[126.851451] Starting dynamic subtest: bcs0
[126.852266] Dynamic subtest bcs0: SUCCESS (0.002s)
[126.858453] Starting dynamic subtest: vcs0
[126.859276] Dynamic subtest vcs0: SUCCESS (0.002s)
[126.865109] Starting dynamic subtest: vcs1
[126.865903] Dynamic subtest vcs1: SUCCESS (0.002s)
[126.871525] Starting dynamic subtest: vecs0
[126.872397] Dynamic subtest vecs0: SUCCESS (0.002s)
[126.878178] Starting dynamic subtest: ccs0
[126.879044] Dynamic subtest ccs0: SUCCESS (0.002s)
[126.879904] Subtest resubmit-all: SUCCESS (0.024s)
[127.949762] [025/131] (890s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip)
[128.047030] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip
[128.842727] Subtest x-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip: SUCCESS (0.795s)
[129.019537] [026/131] (889s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-180-hflip)
[129.109563] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-180-hflip
[130.055224] Subtest 4-tiled-max-hw-stride-32bpp-rotate-180-hflip: SUCCESS (0.946s)
[130.205265] [027/131] (887s left) kms_cursor_crc (cursor-sliding-128x42)
[130.428881] Starting subtest: cursor-sliding-128x42
[130.465802] Subtest cursor-sliding-128x42: SKIP (0.035s)
[130.676362] [028/131] (887s left) syncobj_wait (reset-unsignaled)
[130.731231] Starting subtest: reset-unsignaled
[130.732148] Subtest reset-unsignaled: SUCCESS (0.000s)
[130.832112] [029/131] (887s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-pwrite)
[130.919675] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-pwrite
[130.921351] Subtest fbc-2p-primscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[131.036419] [030/131] (887s left) kms_frontbuffer_tracking (psr-modesetfrombusy)
[131.127284] Starting subtest: psr-modesetfrombusy
[137.229892] Subtest psr-modesetfrombusy: SUCCESS (6.104s)
[137.395398] [031/131] (880s left) i915_query (query-topology-matches-eu-total)
[137.445985] Starting subtest: query-topology-matches-eu-total
[137.446988] Subtest query-topology-matches-eu-total: SUCCESS (0.000s)
[137.554685] [032/131] (880s left) kms_chamelium_edid (dp-edid-resolution-list)
[137.950702] Subtest dp-edid-resolution-list: SKIP (0.000s)
[138.745295] [033/131] (879s left) gem_lmem_swapping (parallel-random-engines)
[138.778359] Subtest parallel-random-engines: SKIP (0.000s)
[138.809243] [034/131] (879s left) kms_atomic_interruptible (legacy-setmode)
[138.905245] Starting subtest: legacy-setmode
[138.906057] Starting dynamic subtest: pipe-A-eDP-1
[145.770523] Dynamic subtest pipe-A-eDP-1: SUCCESS (6.863s)
[145.771514] Subtest legacy-setmode: SUCCESS (6.864s)
[146.581743] [035/131] (871s left) api_intel_bb (intel-bb-blit-none)
[146.633025] Starting subtest: intel-bb-blit-none
[150.457666] Subtest intel-bb-blit-none: SUCCESS (3.823s)
[150.614432] [036/131] (867s left) kms_ccs (missing-ccs-buffer-4-tiled-mtl-mc-ccs)
[150.700872] Starting subtest: missing-ccs-buffer-4-tiled-mtl-mc-ccs
[150.702045] Starting dynamic subtest: pipe-A-eDP-1
[150.722617] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.021s)
[150.729785] Starting dynamic subtest: pipe-B-eDP-1
[150.743848] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.020s)
[150.750886] Starting dynamic subtest: pipe-C-eDP-1
[150.764774] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.020s)
[150.772017] Starting dynamic subtest: pipe-D-eDP-1
[150.786057] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.020s)
[150.787039] Subtest missing-ccs-buffer-4-tiled-mtl-mc-ccs: SUCCESS (0.085s)
[152.945223] [037/131] (865s left) kms_plane_alpha_blend (alpha-transparent-fb)
[153.035976] Starting subtest: alpha-transparent-fb
[153.320137] Starting dynamic subtest: pipe-A-eDP-1
[153.903268] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.583s)
[153.909439] Starting dynamic subtest: pipe-D-eDP-1
[155.257312] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.353s)
[155.258455] Subtest alpha-transparent-fb: SUCCESS (2.222s)
[156.112761] [038/131] (862s left) kms_ccs (bad-rotation-90-4-tiled-mtl-rc-ccs)
[156.198188] Starting subtest: bad-rotation-90-4-tiled-mtl-rc-ccs
[156.199079] Starting dynamic subtest: pipe-A-eDP-1
[156.338642] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.134s)
[156.346544] Starting dynamic subtest: pipe-B-eDP-1
[156.354912] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[156.362376] Starting dynamic subtest: pipe-C-eDP-1
[156.369867] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.002s)
[156.375971] Starting dynamic subtest: pipe-D-eDP-1
[156.383507] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.002s)
[156.384373] Subtest bad-rotation-90-4-tiled-mtl-rc-ccs: SUCCESS (0.143s)
[158.573316] [039/131] (859s left) gen9_exec_parse (basic-rejected-ctx-param)
[158.627987] Subtest basic-rejected-ctx-param: SKIP (0.000s)
[158.697844] [040/131] (859s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-0-async-flip)
[158.794453] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-0-async-flip
[158.796262] Subtest yf-tiled-max-hw-stride-64bpp-rotate-0-async-flip: SKIP (0.000s)
[158.909659] [041/131] (859s left) kms_writeback (writeback-pixel-formats)
[158.998759] Subtest writeback-pixel-formats: SKIP (0.000s)
[159.033477] [042/131] (859s left) kms_atomic_transition (plane-all-transition-nonblocking-fencing)
[159.113118] Starting subtest: plane-all-transition-nonblocking-fencing
[159.113993] Starting dynamic subtest: pipe-A-eDP-1
[161.612970] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.499s)
[161.929965] Starting dynamic subtest: pipe-B-eDP-1
[165.132097] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.208s)
[165.431847] Subtest plane-all-transition-nonblocking-fencing: SUCCESS (6.318s)
[166.255565] [043/131] (852s left) kms_flip (dpms-vs-vblank-race-interruptible)
[166.348137] Starting subtest: dpms-vs-vblank-race-interruptible
[166.350440] Starting dynamic subtest: A-eDP1
[171.354145] Dynamic subtest A-eDP1: SUCCESS (5.002s)
[171.362639] Starting dynamic subtest: B-eDP1
[175.986245] Dynamic subtest B-eDP1: SUCCESS (4.630s)
[175.995296] Starting dynamic subtest: C-eDP1
[180.586381] Dynamic subtest C-eDP1: SUCCESS (4.599s)
[180.593528] Starting dynamic subtest: D-eDP1
[185.218190] Dynamic subtest D-eDP1: SUCCESS (4.631s)
[185.220951] Subtest dpms-vs-vblank-race-interruptible: SUCCESS (18.871s)
[186.107991] [044/131] (832s left) syncobj_wait (wait-for-submit-snapshot)
[186.168668] Starting subtest: wait-for-submit-snapshot
[186.249407] Subtest wait-for-submit-snapshot: SUCCESS (0.081s)
[186.338522] [045/131] (832s left) gem_sync (basic-store-each)
[186.393936] Starting subtest: basic-store-each
[188.730869] Subtest basic-store-each: SUCCESS (2.337s)
[188.929043] [046/131] (829s left) kms_flip (wf_vblank-ts-check-interruptible)
[189.021467] Starting subtest: wf_vblank-ts-check-interruptible
[189.023866] Starting dynamic subtest: A-eDP1
[197.940084] Dynamic subtest A-eDP1: SUCCESS (8.916s)
[197.946408] Starting dynamic subtest: B-eDP1
[206.872704] Dynamic subtest B-eDP1: SUCCESS (8.931s)
[206.880809] Starting dynamic subtest: C-eDP1
[215.786062] Dynamic subtest C-eDP1: SUCCESS (8.911s)
[215.794337] Starting dynamic subtest: D-eDP1
[224.720843] Dynamic subtest D-eDP1: SUCCESS (8.932s)
[224.724392] Subtest wf_vblank-ts-check-interruptible: SUCCESS (35.700s)
[225.939345] [047/131] (792s left) i915_power (sanity)
[225.988621] Starting subtest: sanity
[225.991390] Subtest sanity: SKIP (0.000s)
[226.108428] [048/131] (792s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-blt)
[226.207902] Starting subtest: psr-1p-primscrn-cur-indfb-draw-blt
[232.885853] Subtest psr-1p-primscrn-cur-indfb-draw-blt: SUCCESS (6.678s)
[233.005972] [049/131] (785s left) kms_big_fb (y-tiled-16bpp-rotate-90)
[233.106169] Starting subtest: y-tiled-16bpp-rotate-90
[233.107959] Subtest y-tiled-16bpp-rotate-90: SKIP (0.000s)
[233.194179] [050/131] (785s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-blt)
[233.288644] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-blt
[237.736765] Subtest fbc-1p-primscrn-pri-indfb-draw-blt: SUCCESS (4.448s)
[238.861218] [051/131] (779s left) gem_exec_balancer (bonded-true-hang)
[239.112218] Starting subtest: bonded-true-hang
[239.114328] Subtest bonded-true-hang: SKIP (0.000s)
[239.222198] [052/131] (779s left) kms_sharpness_filter (filter-rotations)
[239.309157] Starting subtest: filter-rotations
[239.317223] Subtest filter-rotations: SKIP (0.004s)
[239.401145] [053/131] (779s left) gem_softpin (noreloc)
[239.467113] Starting subtest: noreloc
[244.876321] Subtest noreloc: SUCCESS (5.406s)
[245.007619] [054/131] (773s left) i915_hangman (gt-engine-hang)
[245.071552] Starting subtest: gt-engine-hang
[245.072523] Starting dynamic subtest: rcs0
[246.902212] Dynamic subtest rcs0: SUCCESS (1.827s)
[246.911296] Starting dynamic subtest: bcs0
[248.885644] Dynamic subtest bcs0: SUCCESS (1.980s)
[248.895212] Starting dynamic subtest: vcs0
[250.869718] Dynamic subtest vcs0: SUCCESS (1.981s)
[250.878671] Starting dynamic subtest: vcs1
[252.853993] Dynamic subtest vcs1: SUCCESS (1.981s)
[252.863710] Starting dynamic subtest: vecs0
[254.837761] Dynamic subtest vecs0: SUCCESS (1.981s)
[254.847228] Starting dynamic subtest: ccs0
[256.885880] Dynamic subtest ccs0: SUCCESS (2.045s)
[256.887517] Subtest gt-engine-hang: SUCCESS (11.813s)
[257.045341] [055/131] (761s left) prime_mmap (test_correct)
[257.092085] Starting subtest: test_correct
[257.093077] Starting dynamic subtest: test_correct-smem
[257.124405] Dynamic subtest test_correct-smem: SUCCESS (0.033s)
[257.125474] Subtest test_correct: SUCCESS (0.034s)
[257.247544] [056/131] (761s left) perf_pmu (event-wait)
[257.279775] Starting subtest: event-wait
[257.280667] Starting dynamic subtest: rcs0
[257.282481] Dynamic subtest rcs0: SKIP (0.000s)
[257.284252] Subtest event-wait: SKIP (0.001s)
[257.407429] [057/131] (761s left) kms_psr (fbc-psr-primary-mmap-cpu)
[257.507403] Starting subtest: fbc-psr-primary-mmap-cpu
[257.508308] Starting dynamic subtest: eDP-1
[257.510037] Dynamic subtest eDP-1: SKIP (0.000s)
[257.511714] Subtest fbc-psr-primary-mmap-cpu: SKIP (0.001s)
[257.599440] [058/131] (761s left) gem_exec_balancer (parallel-contexts)
[257.853929] Starting subtest: parallel-contexts
[260.295321] Subtest parallel-contexts: SUCCESS (2.441s)
[260.436239] [059/131] (758s left) gem_exec_schedule (wide)
[260.616197] Starting subtest: wide
[260.617382] Starting dynamic subtest: rcs0
[272.808231] Dynamic subtest rcs0: SUCCESS (12.190s)
[272.816790] Starting dynamic subtest: vcs0
[284.088277] Dynamic subtest vcs0: SUCCESS (11.279s)
[284.096669] Starting dynamic subtest: vcs1
[295.484458] Dynamic subtest vcs1: SUCCESS (11.394s)
[295.493904] Starting dynamic subtest: vecs0
[306.460886] Dynamic subtest vecs0: SUCCESS (10.975s)
[306.469348] Starting dynamic subtest: ccs0
[320.362436] Dynamic subtest ccs0: SUCCESS (13.900s)
[320.363578] Subtest wide: SUCCESS (59.745s)
[322.314318] [FACT gem_exec_schedule (wide)] new: kernel.kmod_is_loaded.vgem: true
[322.316748] [060/131] (696s left) gem_exec_fence (syncobj-timeline-multiple-ext-nodes)
[322.915535] Starting subtest: syncobj-timeline-multiple-ext-nodes
[322.919442] Subtest syncobj-timeline-multiple-ext-nodes: SUCCESS (0.007s)
[324.055637] [061/131] (695s left) tools_test (sysfs_l3_parity)
[324.090737] Starting subtest: sysfs_l3_parity
[324.164109] Subtest sysfs_l3_parity: SKIP (0.080s)
[324.242646] [062/131] (694s left) gem_mmap_gtt (basic-read)
[324.292116] Subtest basic-read: SKIP (0.000s)
[324.352635] [063/131] (694s left) gem_basic (create-fd-close)
[324.405838] Starting subtest: create-fd-close
[324.407648] Subtest create-fd-close: SUCCESS (0.000s)
[324.538837] [064/131] (694s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-mmap-cpu)
[324.636447] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-mmap-cpu
[324.638212] Subtest psr-2p-primscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[324.754799] [065/131] (694s left) kms_cursor_crc (cursor-dpms)
[324.885882] Starting subtest: cursor-dpms
[324.886793] Starting dynamic subtest: pipe-A-eDP-1
[327.923785] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.036s)
[327.931248] Starting dynamic subtest: pipe-D-eDP-1
[331.517250] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.591s)
[331.518178] Subtest cursor-dpms: SUCCESS (6.631s)
[332.354656] [066/131] (686s left) drm_read (short-buffer-nonblock)
[332.492552] Starting subtest: short-buffer-nonblock
[332.493581] Subtest short-buffer-nonblock: SUCCESS (0.000s)
[332.660973] [067/131] (686s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-indfb-draw-blt)
[332.752037] Starting subtest: fbc-1p-offscreen-pri-indfb-draw-blt
[336.910982] Subtest fbc-1p-offscreen-pri-indfb-draw-blt: SUCCESS (4.160s)
[338.076051] [068/131] (681s left) kms_plane_scaling (plane-downscale-factor-0-5-with-rotation)
[338.165734] Starting subtest: plane-downscale-factor-0-5-with-rotation
[338.166644] Starting dynamic subtest: pipe-A
[338.179727] Dynamic subtest pipe-A: SKIP (0.013s)
[338.186484] Starting dynamic subtest: pipe-B
[338.205421] Dynamic subtest pipe-B: SKIP (0.025s)
[338.212340] Starting dynamic subtest: pipe-C
[338.231799] Dynamic subtest pipe-C: SKIP (0.025s)
[338.241133] Starting dynamic subtest: pipe-D
[338.256458] Dynamic subtest pipe-D: SKIP (0.025s)
[338.258133] Subtest plane-downscale-factor-0-5-with-rotation: SKIP (0.090s)
[338.408575] [069/131] (681s left) gem_mmap_gtt (basic-short)
[338.471868] Subtest basic-short: SKIP (0.000s)
[338.532852] [070/131] (680s left) syncobj_timeline (invalid-multi-wait-unsubmitted)
[338.579498] Starting subtest: invalid-multi-wait-unsubmitted
[338.580581] Subtest invalid-multi-wait-unsubmitted: SUCCESS (0.000s)
[338.698457] [071/131] (680s left) gem_create (create-massive)
[338.757622] Starting subtest: create-massive
[338.758565] Subtest create-massive: SUCCESS (0.000s)
[338.946521] [072/131] (680s left) perf (gen12-invalid-class-instance)
[339.070653] Starting subtest: gen12-invalid-class-instance
[339.080213] Subtest gen12-invalid-class-instance: SUCCESS (0.010s)
[339.110554] [073/131] (680s left) gem_lmem_swapping (parallel-random)
[339.143336] Subtest parallel-random: SKIP (0.000s)
[339.176287] [074/131] (680s left) kms_invalid_mode (bad-vsync-end)
[339.259352] Starting subtest: bad-vsync-end
[339.260261] Starting dynamic subtest: pipe-A-eDP-1
[339.557097] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.298s)
[339.563910] Starting dynamic subtest: pipe-B-eDP-1
[339.564728] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[339.571153] Starting dynamic subtest: pipe-C-eDP-1
[339.571975] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[339.578364] Starting dynamic subtest: pipe-D-eDP-1
[339.579229] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[339.580102] Subtest bad-vsync-end: SUCCESS (0.304s)
[340.390586] [075/131] (679s left) syncobj_timeline (wait-any-snapshot)
[340.443234] Starting subtest: wait-any-snapshot
[340.524508] Subtest wait-any-snapshot: SUCCESS (0.081s)
[340.608450] [076/131] (679s left) syncobj_wait (multi-wait-all-signaled)
[340.663319] Starting subtest: multi-wait-all-signaled
[340.664250] Subtest multi-wait-all-signaled: SUCCESS (0.000s)
[340.791471] [077/131] (678s left) gem_exec_reloc (basic-range-active)
[340.853355] Subtest basic-range-active: SKIP (0.000s)
[340.936925] [078/131] (678s left) api_intel_bb (blit-noreloc-keep-cache)
[340.986175] Starting subtest: blit-noreloc-keep-cache
[340.996054] Subtest blit-noreloc-keep-cache: SUCCESS (0.011s)
[341.087169] [079/131] (678s left) kms_feature_discovery (chamelium)
[341.176480] Starting subtest: chamelium
[341.178451] Subtest chamelium: SKIP (0.000s)
[341.254985] [080/131] (678s left) kms_getfb (getfb2-handle-zero)
[341.341555] Starting subtest: getfb2-handle-zero
[341.342487] Subtest getfb2-handle-zero: SUCCESS (0.000s)
[341.459400] [081/131] (678s left) kms_psr (fbc-pr-no-drrs)
[341.545681] Starting subtest: fbc-pr-no-drrs
[341.547329] Subtest fbc-pr-no-drrs: SKIP (0.000s)
[341.625676] [082/131] (678s left) kms_psr2_sf (psr2-overlay-plane-update-sf-dmg-area)
[346.684550] Starting subtest: psr2-overlay-plane-update-sf-dmg-area
[346.685678] Starting dynamic subtest: pipe-A-eDP-1
[353.323726] Dynamic subtest pipe-A-eDP-1: SUCCESS (6.637s)
[353.332073] Starting dynamic subtest: pipe-B-eDP-1
[359.980158] Dynamic subtest pipe-B-eDP-1: SUCCESS (6.656s)
[359.981068] Subtest psr2-overlay-plane-update-sf-dmg-area: SUCCESS (13.297s)
[360.881096] [083/131] (658s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-mmap-wc)
[360.979514] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-mmap-wc
[367.390838] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-mmap-wc: SUCCESS (6.413s)
[367.546802] [084/131] (652s left) kms_ccs (crc-primary-rotation-180-4-tiled-dg2-rc-ccs)
[367.636560] Starting subtest: crc-primary-rotation-180-4-tiled-dg2-rc-ccs
[367.637965] Starting dynamic subtest: pipe-A-eDP-1
[367.647799] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[367.654981] Starting dynamic subtest: pipe-B-eDP-1
[367.663321] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[367.670191] Starting dynamic subtest: pipe-C-eDP-1
[367.678436] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[367.684943] Starting dynamic subtest: pipe-D-eDP-1
[367.693498] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[367.695170] Subtest crc-primary-rotation-180-4-tiled-dg2-rc-ccs: SKIP (0.006s)
[369.881793] [085/131] (650s left) kms_pwrite_crc
[371.516791] [086/131] (648s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-blt)
[371.617301] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-blt
[371.618969] Subtest fbc-2p-scndscrn-cur-indfb-draw-blt: SKIP (0.000s)
[371.740414] [087/131] (648s left) kms_psr (fbc-psr2-cursor-plane-onoff)
[371.817410] Starting subtest: fbc-psr2-cursor-plane-onoff
[371.818380] Starting dynamic subtest: eDP-1
[371.820109] Dynamic subtest eDP-1: SKIP (0.000s)
[371.821822] Subtest fbc-psr2-cursor-plane-onoff: SKIP (0.001s)
[371.893974] [088/131] (648s left) kms_atomic_interruptible (legacy-pageflip)
[371.986343] Starting subtest: legacy-pageflip
[371.987230] Starting dynamic subtest: pipe-A-eDP-1
[379.453839] Dynamic subtest pipe-A-eDP-1: SUCCESS (7.466s)
[379.454862] Subtest legacy-pageflip: SUCCESS (7.467s)
[380.309513] [089/131] (639s left) kms_pm_rpm (system-suspend-modeset)
[382.128682] Starting subtest: system-suspend-modeset
[402.147855] Subtest system-suspend-modeset: SUCCESS (4.805s)
[407.532874] [090/131] (617s left) kms_psr (psr-dpms)
[407.634518] Starting subtest: psr-dpms
[407.635387] Starting dynamic subtest: eDP-1
[410.627810] Dynamic subtest eDP-1: SUCCESS (2.990s)
[410.628735] Subtest psr-dpms: SUCCESS (2.991s)
[411.515038] [091/131] (613s left) i915_pm_rpm (system-suspend)
[413.336310] Starting subtest: system-suspend
[431.713170] Subtest system-suspend: SUCCESS (3.257s)
[438.123760] [092/131] (593s left) gem_exec_reloc (basic-wc-active)
[438.182529] Subtest basic-wc-active: SKIP (0.000s)
[438.246397] [093/131] (592s left) syncobj_wait (single-wait-all-for-submit-signaled)
[438.303919] Starting subtest: single-wait-all-for-submit-signaled
[438.304845] Subtest single-wait-all-for-submit-signaled: SUCCESS (0.000s)
[438.432514] [094/131] (592s left) kms_cursor_legacy (basic-busy-flip-before-cursor-varying-size)
[438.553736] Starting subtest: basic-busy-flip-before-cursor-varying-size
[438.555548] Subtest basic-busy-flip-before-cursor-varying-size: SKIP (0.000s)
[438.705227] [095/131] (592s left) gem_eio (throttle)
[438.945092] Starting subtest: throttle
[439.294380] Subtest throttle: SUCCESS (0.349s)
[439.437834] [096/131] (591s left) gem_exec_schedule (semaphore-noskip)
[439.503238] Starting subtest: semaphore-noskip
[439.932654] Subtest semaphore-noskip: SUCCESS (0.427s)
[440.308376] [097/131] (591s left) gem_mmap_offset (pf-nonblock)
[440.365107] Starting subtest: pf-nonblock
[440.370635] Subtest pf-nonblock: SUCCESS (0.007s)
[440.510313] [098/131] (590s left) syncobj_timeline (multi-wait-for-submit-available-unsubmitted-submitted)
[440.563570] Starting subtest: multi-wait-for-submit-available-unsubmitted-submitted
[440.564740] Subtest multi-wait-for-submit-available-unsubmitted-submitted: SUCCESS (0.000s)
[440.670386] [099/131] (590s left) kms_plane_cursor (primary)
[440.752006] Starting subtest: primary
[440.754247] Starting dynamic subtest: pipe-A-eDP-1-size-64
[443.360457] Dynamic subtest pipe-A-eDP-1-size-64: SUCCESS (2.608s)
[443.392813] Starting dynamic subtest: pipe-A-eDP-1-size-128
[446.030255] Dynamic subtest pipe-A-eDP-1-size-128: SUCCESS (2.649s)
[446.060381] Starting dynamic subtest: pipe-A-eDP-1-size-256
[448.710173] Dynamic subtest pipe-A-eDP-1-size-256: SUCCESS (2.660s)
[449.024635] Starting dynamic subtest: pipe-B-eDP-1-size-64
[452.473449] Dynamic subtest pipe-B-eDP-1-size-64: SUCCESS (3.458s)
[452.501474] Starting dynamic subtest: pipe-B-eDP-1-size-128
[455.184562] Dynamic subtest pipe-B-eDP-1-size-128: SUCCESS (2.693s)
[455.211341] Starting dynamic subtest: pipe-B-eDP-1-size-256
[457.863799] Dynamic subtest pipe-B-eDP-1-size-256: SUCCESS (2.659s)
[458.176648] Starting dynamic subtest: pipe-C-eDP-1-size-64
[460.931133] Dynamic subtest pipe-C-eDP-1-size-64: SUCCESS (2.764s)
[460.958557] Starting dynamic subtest: pipe-C-eDP-1-size-128
[463.064834] Dynamic subtest pipe-C-eDP-1-size-128: SUCCESS (2.114s)
[463.091808] Starting dynamic subtest: pipe-C-eDP-1-size-256
[465.197251] Dynamic subtest pipe-C-eDP-1-size-256: SUCCESS (2.113s)
[465.514934] Starting dynamic subtest: pipe-D-eDP-1-size-64
[468.422509] Dynamic subtest pipe-D-eDP-1-size-64: SUCCESS (2.916s)
[468.452850] Starting dynamic subtest: pipe-D-eDP-1-size-128
[470.566857] Dynamic subtest pipe-D-eDP-1-size-128: SUCCESS (2.123s)
[470.595063] Starting dynamic subtest: pipe-D-eDP-1-size-256
[472.655452] Dynamic subtest pipe-D-eDP-1-size-256: SUCCESS (2.069s)
[472.960189] Subtest primary: SUCCESS (32.200s)
[473.844398] [100/131] (557s left) prime_vgem (busy)
[473.914477] Starting subtest: busy
[473.915650] Starting dynamic subtest: rcs0
[473.977373] Dynamic subtest rcs0: SUCCESS (0.063s)
[473.985414] Starting dynamic subtest: bcs0
[474.064132] Dynamic subtest bcs0: SUCCESS (0.086s)
[474.072046] Starting dynamic subtest: vcs0
[474.111892] Dynamic subtest vcs0: SUCCESS (0.047s)
[474.119819] Starting dynamic subtest: vcs1
[474.157773] Dynamic subtest vcs1: SUCCESS (0.045s)
[474.165743] Starting dynamic subtest: vecs0
[474.201996] Dynamic subtest vecs0: SUCCESS (0.043s)
[474.209946] Starting dynamic subtest: ccs0
[474.248839] Dynamic subtest ccs0: SUCCESS (0.046s)
[474.249775] Subtest busy: SUCCESS (0.335s)
[474.408595] [101/131] (557s left) gem_softpin (evict-active)
[474.466967] Starting subtest: evict-active
[474.473375] Subtest evict-active: SUCCESS (0.006s)
[474.611878] [102/131] (556s left) kms_vblank (wait-busy)
[474.708152] Starting subtest: wait-busy
[474.709071] Starting dynamic subtest: pipe-A-eDP-1
[476.603384] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.895s)
[476.613734] Starting dynamic subtest: pipe-D-eDP-1
[479.195299] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.589s)
[479.196186] Subtest wait-busy: SUCCESS (4.488s)
[479.997310] [103/131] (551s left) gem_mmap_gtt (isolation)
[480.042798] Subtest isolation: SKIP (0.000s)
[480.100655] [104/131] (551s left) kms_lease (possible-crtcs-filtering)
[480.177831] Starting subtest: possible-crtcs-filtering
[480.183277] Subtest possible-crtcs-filtering: SUCCESS (0.005s)
[480.326231] [105/131] (551s left) syncobj_timeline (invalid-signal-bad-pad)
[480.377661] Starting subtest: invalid-signal-bad-pad
[480.378685] Subtest invalid-signal-bad-pad: SUCCESS (0.000s)
[480.486485] [106/131] (551s left) kms_flip_scaled_crc (flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling)
[480.570889] Starting subtest: flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling
[480.572128] Starting dynamic subtest: pipe-A-default-mode
[480.882947] Dynamic subtest pipe-A-default-mode: SKIP (0.310s)
[480.884836] Subtest flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling: SKIP (0.312s)
[481.741641] [107/131] (549s left) sysfs_defaults (readonly)
[481.790211] Starting subtest: readonly
[481.791345] Starting dynamic subtest: vecs0
[481.792410] Dynamic subtest vecs0: SUCCESS (0.000s)
[481.801694] Starting dynamic subtest: ccs0
[481.802630] Dynamic subtest ccs0: SUCCESS (0.000s)
[481.810412] Starting dynamic subtest: vcs0
[481.811326] Dynamic subtest vcs0: SUCCESS (0.000s)
[481.818933] Starting dynamic subtest: bcs0
[481.819832] Dynamic subtest bcs0: SUCCESS (0.000s)
[481.827328] Starting dynamic subtest: rcs0
[481.828242] Dynamic subtest rcs0: SUCCESS (0.000s)
[481.835834] Starting dynamic subtest: vcs1
[481.836702] Dynamic subtest vcs1: SUCCESS (0.000s)
[481.837624] Subtest readonly: SUCCESS (0.006s)
[481.920355] [108/131] (549s left) kms_psr (psr2-primary-blt)
[482.018093] Starting subtest: psr2-primary-blt
[482.019050] Starting dynamic subtest: eDP-1
[483.726540] Dynamic subtest eDP-1: SUCCESS (1.708s)
[483.727573] Subtest psr2-primary-blt: SUCCESS (1.709s)
[484.615394] [109/131] (547s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-blt)
[484.703963] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-blt
[491.954953] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-blt: SUCCESS (7.252s)
[492.145648] [110/131] (539s left) gem_ctx_persistence (many-contexts)
[492.205207] Starting subtest: many-contexts
[530.581740] Subtest many-contexts: SUCCESS (38.372s)
[530.668282] [111/131] (501s left) kms_color (degamma)
[530.753775] Starting subtest: degamma
[530.754728] Starting dynamic subtest: pipe-A-eDP-1
[531.428716] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.675s)
[531.436573] Starting dynamic subtest: pipe-B-eDP-1
[532.807931] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.378s)
[532.815990] Starting dynamic subtest: pipe-C-eDP-1
[534.106572] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.297s)
[534.117318] Starting dynamic subtest: pipe-D-eDP-1
[535.461014] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.353s)
[535.461932] Subtest degamma: SUCCESS (4.706s)
[536.270503] [112/131] (495s left) gem_pipe_control_store_loop (fresh-buffer)
[536.331092] Starting subtest: fresh-buffer
[538.485480] Subtest fresh-buffer: SUCCESS (2.152s)
[538.624614] [113/131] (493s left) kms_ccs (random-ccs-data-y-tiled-ccs)
[538.709932] Starting subtest: random-ccs-data-y-tiled-ccs
[538.710742] Starting dynamic subtest: pipe-A-eDP-1
[538.719589] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[538.729086] Starting dynamic subtest: pipe-B-eDP-1
[538.738407] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[538.746247] Starting dynamic subtest: pipe-C-eDP-1
[538.755404] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[538.762850] Starting dynamic subtest: pipe-D-eDP-1
[538.771608] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[538.773213] Subtest random-ccs-data-y-tiled-ccs: SKIP (0.005s)
[540.937117] [114/131] (490s left) gem_ctx_param (vm)
[540.988580] Starting subtest: vm
[541.036808] Subtest vm: SUCCESS (0.048s)
[541.192947] [115/131] (490s left) kms_flip (2x-absolute-wf_vblank)
[541.281456] Starting subtest: 2x-absolute-wf_vblank
[541.292826] Subtest 2x-absolute-wf_vblank: SKIP (0.011s)
[541.423790] [116/131] (490s left) gem_ccs (block-copy-compressed)
[541.480273] Starting subtest: block-copy-compressed
[541.482131] Subtest block-copy-compressed: SKIP (0.000s)
[541.628227] [117/131] (490s left) kms_rotation_crc (multiplane-rotation-cropping-top)
[541.716814] Starting subtest: multiplane-rotation-cropping-top
[548.900206] Subtest multiplane-rotation-cropping-top: SUCCESS (7.184s)
[549.032494] [118/131] (482s left) prime_self_import (basic-llseek-bad)
[549.060369] Starting subtest: basic-llseek-bad
[549.085239] Subtest basic-llseek-bad: SUCCESS (0.024s)
[549.208733] [119/131] (482s left) core_getversion (all-cards)
[549.238798] Starting subtest: all-cards
[549.248232] Subtest all-cards: SUCCESS (0.011s)
[549.287863] [120/131] (482s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-180-async-flip)
[549.391851] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-180-async-flip
[550.207003] Subtest 4-tiled-max-hw-stride-64bpp-rotate-180-async-flip: SUCCESS (0.815s)
[550.396943] [121/131] (481s left) gem_ringfill (basic-all)
[556.258734] Starting subtest: basic-all
[557.420104] Subtest basic-all: SUCCESS (1.160s)
[557.595323] [122/131] (474s left) kms_big_fb (linear-max-hw-stride-32bpp-rotate-180)
[557.698087] Starting subtest: linear-max-hw-stride-32bpp-rotate-180
[558.721376] Subtest linear-max-hw-stride-32bpp-rotate-180: SUCCESS (1.024s)
[558.874455] [123/131] (473s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-180-async-flip)
[558.962442] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-180-async-flip
[558.964210] Subtest y-tiled-max-hw-stride-64bpp-rotate-180-async-flip: SKIP (0.000s)
[559.090993] [124/131] (473s left) gem_pxp (verify-pxp-stale-buf-execution)
[559.195402] Starting subtest: verify-pxp-stale-buf-execution
[560.257958] Subtest verify-pxp-stale-buf-execution: SUCCESS (1.063s)
[560.429587] [125/131] (471s left) gem_sync (basic-each)
[560.492367] Starting subtest: basic-each
[563.142549] Subtest basic-each: SUCCESS (2.652s)
[563.345726] [126/131] (468s left) gem_render_copy_redux (flink)
[563.391284] Starting subtest: flink
[564.537475] Subtest flink: SUCCESS (1.149s)
[564.683246] [127/131] (467s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-mmap-wc)
[564.778595] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-mmap-wc
[564.780518] Subtest fbc-2p-primscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[564.893852] [128/131] (467s left) gem_spin_batch (user-each)
[564.958225] Starting subtest: user-each
[568.225305] Subtest user-each: SUCCESS (3.266s)
[569.368295] [129/131] (463s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-blt)
[569.461626] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-blt
[576.360612] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-blt: SUCCESS (6.897s)
[576.527693] [130/131] (455s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-mmap-wc)
[576.621889] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-mmap-wc
[583.642174] Subtest psr-1p-primscrn-pri-shrfb-draw-mmap-wc: SUCCESS (7.021s)
[583.774481] [131/131] (448s left) gem_exec_schedule (independent)
[583.831265] Starting subtest: independent
[583.832221] Starting dynamic subtest: rcs0
[585.247579] Dynamic subtest rcs0: SUCCESS (1.413s)
[585.257313] Starting dynamic subtest: vcs0
[587.263767] Dynamic subtest vcs0: SUCCESS (2.014s)
[587.274369] Starting dynamic subtest: vcs1
[589.311690] Dynamic subtest vcs1: SUCCESS (2.045s)
[589.321313] Starting dynamic subtest: vecs0
[591.289526] Dynamic subtest vecs0: SUCCESS (1.976s)
[591.300095] Starting dynamic subtest: ccs0
[593.247392] Dynamic subtest ccs0: SUCCESS (1.956s)
[593.249145] Subtest independent: SUCCESS (9.414s)
[593.563321] Closing watchdogs
results: parsing output: 0/ for test: kms_frontbuffer_tracking
results: parsing output: 1/ for test: i915_drm_fdinfo
results: parsing output: 2/ for test: kms_pm_rpm
results: parsing output: 3/ for test: kms_frontbuffer_tracking
results: parsing output: 4/ for test: kms_plane_scaling
results: parsing output: 5/ for test: kms_flip
results: parsing output: 6/ for test: kms_frontbuffer_tracking
results: parsing output: 7/ for test: syncobj_eventfd
results: parsing output: 8/ for test: kms_frontbuffer_tracking
results: parsing output: 9/ for test: sw_sync
results: parsing output: 10/ for test: kms_psr2_sf
results: parsing output: 11/ for test: kms_flip_scaled_crc
results: parsing output: 12/ for test: syncobj_basic
results: parsing output: 13/ for test: gem_exec_params
results: parsing output: 14/ for test: kms_atomic_transition
results: parsing output: 15/ for test: kms_rotation_crc
results: parsing output: 16/ for test: kms_cursor_crc
results: parsing output: 17/ for test: kms_ccs
results: parsing output: 18/ for test: kms_chamelium_hpd
results: parsing output: 19/ for test: kms_frontbuffer_tracking
results: parsing output: 20/ for test: syncobj_wait
results: parsing output: 21/ for test: gem_partial_pwrite_pread
results: parsing output: 22/ for test: kms_async_flips
results: parsing output: 23/ for test: gem_spin_batch
results: parsing output: 24/ for test: kms_big_fb
results: parsing output: 25/ for test: kms_big_fb
results: parsing output: 26/ for test: kms_cursor_crc
results: parsing output: 27/ for test: syncobj_wait
results: parsing output: 28/ for test: kms_frontbuffer_tracking
results: parsing output: 29/ for test: kms_frontbuffer_tracking
results: parsing output: 30/ for test: i915_query
results: parsing output: 31/ for test: kms_chamelium_edid
results: parsing output: 32/ for test: gem_lmem_swapping
results: parsing output: 33/ for test: kms_atomic_interruptible
results: parsing output: 34/ for test: api_intel_bb
results: parsing output: 35/ for test: kms_ccs
results: parsing output: 36/ for test: kms_plane_alpha_blend
results: parsing output: 37/ for test: kms_ccs
results: parsing output: 38/ for test: gen9_exec_parse
results: parsing output: 39/ for test: kms_big_fb
results: parsing output: 40/ for test: kms_writeback
results: parsing output: 41/ for test: kms_atomic_transition
results: parsing output: 42/ for test: kms_flip
results: parsing output: 43/ for test: syncobj_wait
results: parsing output: 44/ for test: gem_sync
results: parsing output: 45/ for test: kms_flip
results: parsing output: 46/ for test: i915_power
results: parsing output: 47/ for test: kms_frontbuffer_tracking
results: parsing output: 48/ for test: kms_big_fb
results: parsing output: 49/ for test: kms_frontbuffer_tracking
results: parsing output: 50/ for test: gem_exec_balancer
results: parsing output: 51/ for test: kms_sharpness_filter
results: parsing output: 52/ for test: gem_softpin
results: parsing output: 53/ for test: i915_hangman
results: parsing output: 54/ for test: prime_mmap
results: parsing output: 55/ for test: perf_pmu
results: parsing output: 56/ for test: kms_psr
results: parsing output: 57/ for test: gem_exec_balancer
results: parsing output: 58/ for test: gem_exec_schedule
results: parsing output: 59/ for test: gem_exec_fence
results: parsing output: 60/ for test: tools_test
results: parsing output: 61/ for test: gem_mmap_gtt
results: parsing output: 62/ for test: gem_basic
results: parsing output: 63/ for test: kms_frontbuffer_tracking
results: parsing output: 64/ for test: kms_cursor_crc
results: parsing output: 65/ for test: drm_read
results: parsing output: 66/ for test: kms_frontbuffer_tracking
results: parsing output: 67/ for test: kms_plane_scaling
results: parsing output: 68/ for test: gem_mmap_gtt
results: parsing output: 69/ for test: syncobj_timeline
results: parsing output: 70/ for test: gem_create
results: parsing output: 71/ for test: perf
results: parsing output: 72/ for test: gem_lmem_swapping
results: parsing output: 73/ for test: kms_invalid_mode
results: parsing output: 74/ for test: syncobj_timeline
results: parsing output: 75/ for test: syncobj_wait
results: parsing output: 76/ for test: gem_exec_reloc
results: parsing output: 77/ for test: api_intel_bb
results: parsing output: 78/ for test: kms_feature_discovery
results: parsing output: 79/ for test: kms_getfb
results: parsing output: 80/ for test: kms_psr
results: parsing output: 81/ for test: kms_psr2_sf
results: parsing output: 82/ for test: kms_frontbuffer_tracking
results: parsing output: 83/ for test: kms_ccs
results: parsing output: 84/ for test: kms_pwrite_crc
results: parsing output: 85/ for test: kms_frontbuffer_tracking
results: parsing output: 86/ for test: kms_psr
results: parsing output: 87/ for test: kms_atomic_interruptible
results: parsing output: 88/ for test: kms_pm_rpm
results: parsing output: 89/ for test: kms_psr
results: parsing output: 90/ for test: i915_pm_rpm
results: parsing output: 91/ for test: gem_exec_reloc
results: parsing output: 92/ for test: syncobj_wait
results: parsing output: 93/ for test: kms_cursor_legacy
results: parsing output: 94/ for test: gem_eio
results: parsing output: 95/ for test: gem_exec_schedule
results: parsing output: 96/ for test: gem_mmap_offset
results: parsing output: 97/ for test: syncobj_timeline
results: parsing output: 98/ for test: kms_plane_cursor
results: parsing output: 99/ for test: prime_vgem
results: parsing output: 100/ for test: gem_softpin
results: parsing output: 101/ for test: kms_vblank
results: parsing output: 102/ for test: gem_mmap_gtt
results: parsing output: 103/ for test: kms_lease
results: parsing output: 104/ for test: syncobj_timeline
results: parsing output: 105/ for test: kms_flip_scaled_crc
results: parsing output: 106/ for test: sysfs_defaults
results: parsing output: 107/ for test: kms_psr
results: parsing output: 108/ for test: kms_frontbuffer_tracking
results: parsing output: 109/ for test: gem_ctx_persistence
results: parsing output: 110/ for test: kms_color
results: parsing output: 111/ for test: gem_pipe_control_store_loop
results: parsing output: 112/ for test: kms_ccs
results: parsing output: 113/ for test: gem_ctx_param
results: parsing output: 114/ for test: kms_flip
results: parsing output: 115/ for test: gem_ccs
results: parsing output: 116/ for test: kms_rotation_crc
results: parsing output: 117/ for test: prime_self_import
results: parsing output: 118/ for test: core_getversion
results: parsing output: 119/ for test: kms_big_fb
results: parsing output: 120/ for test: gem_ringfill
results: parsing output: 121/ for test: kms_big_fb
results: parsing output: 122/ for test: kms_big_fb
results: parsing output: 123/ for test: gem_pxp
results: parsing output: 124/ for test: gem_sync
results: parsing output: 125/ for test: gem_render_copy_redux
results: parsing output: 126/ for test: kms_frontbuffer_tracking
results: parsing output: 127/ for test: gem_spin_batch
results: parsing output: 128/ for test: kms_frontbuffer_tracking
results: parsing output: 129/ for test: kms_frontbuffer_tracking
results: parsing output: 130/ for test: gem_exec_schedule
Done.