[61.671911] Initializing watchdogs
[61.671961]   /dev/watchdog0
[61.686720] [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]
[61.691287] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[61.693509] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[61.697418] [001/133] (960s left) kms_pipe_crc_basic (compare-crc-sanitycheck-nv12)
[61.822241] Starting subtest: compare-crc-sanitycheck-nv12
[61.824609] Starting dynamic subtest: pipe-A-eDP-1
[62.555906] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.733s)
[62.563204] Starting dynamic subtest: pipe-B-eDP-1
[63.889247] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.335s)
[63.898765] Starting dynamic subtest: pipe-C-eDP-1
[65.166069] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.278s)
[65.175139] Starting dynamic subtest: pipe-D-eDP-1
[66.406499] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.240s)
[66.408845] Subtest compare-crc-sanitycheck-nv12: SUCCESS (4.589s)
[67.250171] [002/133] (955s left) kms_ccs (crc-sprite-planes-basic-y-tiled-gen12-mc-ccs)
[67.531387] Starting subtest: crc-sprite-planes-basic-y-tiled-gen12-mc-ccs
[67.533543] Starting dynamic subtest: pipe-A-eDP-1
[67.597801] Dynamic subtest pipe-A-eDP-1: SKIP (0.004s)
[67.607152] Starting dynamic subtest: pipe-B-eDP-1
[67.668467] Dynamic subtest pipe-B-eDP-1: SKIP (0.004s)
[67.677234] Starting dynamic subtest: pipe-C-eDP-1
[67.738648] Dynamic subtest pipe-C-eDP-1: SKIP (0.004s)
[67.746733] Starting dynamic subtest: pipe-D-eDP-1
[67.803594] Dynamic subtest pipe-D-eDP-1: SKIP (0.003s)
[67.807806] Subtest crc-sprite-planes-basic-y-tiled-gen12-mc-ccs: SKIP (0.019s)
[69.794729] [003/133] (952s left) kms_ccs (crc-primary-basic-4-tiled-mtl-mc-ccs)
[69.882278] Starting subtest: crc-primary-basic-4-tiled-mtl-mc-ccs
[69.884584] Starting dynamic subtest: pipe-A-eDP-1
[72.124096] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.243s)
[72.132839] Starting dynamic subtest: pipe-B-eDP-1
[74.523735] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.399s)
[74.531606] Starting dynamic subtest: pipe-C-eDP-1
[76.638742] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.116s)
[76.646557] Starting dynamic subtest: pipe-D-eDP-1
[78.827207] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.188s)
[78.829195] Subtest crc-primary-basic-4-tiled-mtl-mc-ccs: SUCCESS (8.949s)
[80.018374] [004/133] (942s left) gem_exec_fence (syncobj-wait)
[80.474586] Starting subtest: syncobj-wait
[81.900956] Subtest syncobj-wait: SUCCESS (1.425s)
[83.963629] [FACT gem_exec_fence (syncobj-wait)] new: kernel.kmod_is_loaded.vgem: true
[83.967036] [005/133] (938s left) kms_big_fb (yf-tiled-8bpp-rotate-270)
[84.068354] Starting subtest: yf-tiled-8bpp-rotate-270
[84.072365] Subtest yf-tiled-8bpp-rotate-270: SKIP (0.000s)
[84.167260] [006/133] (938s left) kms_plane (pixel-format-4-tiled-mtl-rc-ccs-cc-modifier-source-clamping)
[84.267020] Starting subtest: pixel-format-4-tiled-mtl-rc-ccs-cc-modifier-source-clamping
[84.292815] Starting dynamic subtest: pipe-A-plane-0
[84.592940] Dynamic subtest pipe-A-plane-0: SUCCESS (0.300s)
[84.600485] Starting dynamic subtest: pipe-A-plane-3
[84.837285] Dynamic subtest pipe-A-plane-3: SUCCESS (0.243s)
[85.908607] Starting dynamic subtest: pipe-B-plane-0
[86.202613] Dynamic subtest pipe-B-plane-0: SUCCESS (0.300s)
[86.211126] Starting dynamic subtest: pipe-B-plane-3
[86.435640] Dynamic subtest pipe-B-plane-3: SUCCESS (0.233s)
[86.759582] Subtest pixel-format-4-tiled-mtl-rc-ccs-cc-modifier-source-clamping: SUCCESS (2.492s)
[87.592258] [007/133] (934s left) kms_prop_blob (invalid-set-prop-any)
[87.647279] Starting subtest: invalid-set-prop-any
[87.649284] Subtest invalid-set-prop-any: SUCCESS (0.000s)
[87.765747] [008/133] (934s left) kms_cursor_crc (cursor-random-256x256)
[88.013836] Starting subtest: cursor-random-256x256
[88.016176] Starting dynamic subtest: pipe-A-eDP-1
[91.349597] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.330s)
[91.378999] Starting dynamic subtest: pipe-D-eDP-1
[95.424551] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.055s)
[95.426786] Subtest cursor-random-256x256: SUCCESS (7.412s)
[96.249946] [009/133] (926s left) kms_psr (psr2-sprite-render)
[96.349812] Starting subtest: psr2-sprite-render
[96.352095] Starting dynamic subtest: eDP-1
[98.061779] Dynamic subtest eDP-1: SUCCESS (1.712s)
[98.064175] Subtest psr2-sprite-render: SUCCESS (1.713s)
[98.925856] [010/133] (923s left) kms_pm_rpm (pm-caching)
[101.054923] Starting subtest: pm-caching
[101.060194] Subtest pm-caching: SKIP (0.000s)
[101.434498] [011/133] (921s left) syncobj_timeline (single-wait-all-for-submit-available-signaled)
[101.481455] Starting subtest: single-wait-all-for-submit-available-signaled
[101.483512] Subtest single-wait-all-for-submit-available-signaled: SUCCESS (0.000s)
[101.561820] [012/133] (921s left) gem_workarounds (reset)
[101.628115] Starting subtest: reset
[101.809193] Subtest reset: SUCCESS (0.183s)
[101.945781] [013/133] (920s left) kms_flip (modeset-vs-vblank-race-interruptible)
[102.041393] Starting subtest: modeset-vs-vblank-race-interruptible
[102.043638] Starting dynamic subtest: A-eDP1
[106.729968] Dynamic subtest A-eDP1: SUCCESS (4.687s)
[106.741572] Starting dynamic subtest: B-eDP1
[111.392475] Dynamic subtest B-eDP1: SUCCESS (4.660s)
[111.402361] Starting dynamic subtest: C-eDP1
[116.256669] Dynamic subtest C-eDP1: SUCCESS (4.861s)
[116.271030] Starting dynamic subtest: D-eDP1
[120.787596] Dynamic subtest D-eDP1: SUCCESS (4.528s)
[120.793692] Subtest modeset-vs-vblank-race-interruptible: SUCCESS (18.751s)
[121.961669] [014/133] (900s left) kms_dsc (dsc-with-formats)
[122.063898] Starting subtest: dsc-with-formats
[122.103634] Subtest dsc-with-formats: SKIP (0.001s)
[122.141505] [015/133] (900s left) fbdev (unaligned-write)
[122.191288] Starting subtest: unaligned-write
[122.328382] Subtest unaligned-write: SUCCESS (0.138s)
[122.387728] [016/133] (900s left) vgem_basic (unload)
[122.429937] Starting subtest: unload
[151.456721] Subtest unload: SUCCESS (29.029s)
[151.554626] [017/133] (871s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-mmap-cpu)
[151.656850] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-mmap-cpu
[158.362620] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-mmap-cpu: SUCCESS (6.707s)
[158.494421] [018/133] (864s left) kms_plane (pixel-format-4-tiled-bmg-ccs-modifier)
[158.591190] Starting subtest: pixel-format-4-tiled-bmg-ccs-modifier
[158.595203] Subtest pixel-format-4-tiled-bmg-ccs-modifier: SKIP (0.000s)
[158.671568] [019/133] (864s left) gem_exec_fence (syncobj-channel)
[159.081124] Starting subtest: syncobj-channel
[160.106789] Subtest syncobj-channel: SUCCESS (1.022s)
[161.001370] [020/133] (861s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-mmap-wc)
[161.110358] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-mmap-wc
[164.636985] Subtest fbc-1p-primscrn-cur-indfb-draw-mmap-wc: SUCCESS (3.531s)
[165.796942] [021/133] (857s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-indfb-draw-mmap-wc)
[165.899082] Starting subtest: psr-1p-offscreen-pri-indfb-draw-mmap-wc
[172.595539] Subtest psr-1p-offscreen-pri-indfb-draw-mmap-wc: SUCCESS (6.699s)
[172.715058] [022/133] (850s left) gem_create (create-ext-placement-sanity-check)
[172.893958] Starting subtest: create-ext-placement-sanity-check
[172.896517] Subtest create-ext-placement-sanity-check: SUCCESS (0.004s)
[173.012650] [023/133] (850s left) kms_plane (plane-position-hole)
[173.113543] Starting subtest: plane-position-hole
[173.672669] Starting dynamic subtest: pipe-A-plane-1
[175.006457] Dynamic subtest pipe-A-plane-1: SUCCESS (1.334s)
[175.015183] Starting dynamic subtest: pipe-A-plane-2
[176.284745] Dynamic subtest pipe-A-plane-2: SUCCESS (1.277s)
[176.293742] Starting dynamic subtest: pipe-A-plane-3
[177.564333] Dynamic subtest pipe-A-plane-3: SUCCESS (1.279s)
[177.573554] Starting dynamic subtest: pipe-A-plane-4
[178.918300] Dynamic subtest pipe-A-plane-4: SUCCESS (1.354s)
[178.927297] Starting dynamic subtest: pipe-A-plane-5
[178.943514] Dynamic subtest pipe-A-plane-5: SUCCESS (0.024s)
[180.126307] Starting dynamic subtest: pipe-B-plane-1
[181.478663] Dynamic subtest pipe-B-plane-1: SUCCESS (1.355s)
[181.487551] Starting dynamic subtest: pipe-B-plane-2
[182.772326] Dynamic subtest pipe-B-plane-2: SUCCESS (1.293s)
[182.780725] Starting dynamic subtest: pipe-B-plane-3
[184.093217] Dynamic subtest pipe-B-plane-3: SUCCESS (1.322s)
[184.102783] Starting dynamic subtest: pipe-B-plane-4
[185.350691] Dynamic subtest pipe-B-plane-4: SUCCESS (1.256s)
[185.360733] Starting dynamic subtest: pipe-B-plane-5
[185.376369] Dynamic subtest pipe-B-plane-5: SUCCESS (0.024s)
[185.378610] Subtest plane-position-hole: SUCCESS (12.263s)
[186.221311] [024/133] (836s left) prime_mmap (test_errors)
[186.283298] Starting subtest: test_errors
[186.285256] Starting dynamic subtest: test_errors-smem
[186.380988] Dynamic subtest test_errors-smem: SUCCESS (0.098s)
[186.383796] Subtest test_errors: SUCCESS (0.100s)
[186.475222] [025/133] (836s left) kms_vblank (query-forked-hang)
[186.571751] Starting subtest: query-forked-hang
[186.574106] Starting dynamic subtest: pipe-A-eDP-1
[213.716605] Dynamic subtest pipe-A-eDP-1: SUCCESS (27.143s)
[213.730122] Starting dynamic subtest: pipe-D-eDP-1
[238.709434] Dynamic subtest pipe-D-eDP-1: SUCCESS (24.992s)
[238.717229] Subtest query-forked-hang: SUCCESS (52.139s)
[239.595181] [026/133] (783s left) perf (gen12-oa-tlb-invalidate)
[239.735119] Starting subtest: gen12-oa-tlb-invalidate
[239.736983] Starting dynamic subtest: 0-rcs0
[249.796089] Dynamic subtest 0-rcs0: SUCCESS (10.059s)
[249.804632] Starting dynamic subtest: 1-vcs0
[259.842431] Dynamic subtest 1-vcs0: SUCCESS (10.045s)
[259.845099] Subtest gen12-oa-tlb-invalidate: SUCCESS (20.107s)
[259.887143] [027/133] (763s left) kms_content_protection (legacy)
[260.046063] Starting subtest: legacy
[260.050521] Subtest legacy: SKIP (0.000s)
[260.161650] [028/133] (763s left) gem_softpin (evict-active-interruptible)
[260.217656] Starting subtest: evict-active-interruptible
[260.221615] Subtest evict-active-interruptible: SUCCESS (0.006s)
[260.340386] [029/133] (763s left) kms_color (ctm-0-75)
[260.434747] Starting subtest: ctm-0-75
[260.436992] Starting dynamic subtest: pipe-A-eDP-1
[265.432433] Dynamic subtest pipe-A-eDP-1: SUCCESS (4.999s)
[265.441750] Starting dynamic subtest: pipe-B-eDP-1
[271.150974] Dynamic subtest pipe-B-eDP-1: SUCCESS (5.718s)
[271.160054] Starting dynamic subtest: pipe-C-eDP-1
[276.452667] Dynamic subtest pipe-C-eDP-1: SUCCESS (5.299s)
[276.461424] Starting dynamic subtest: pipe-D-eDP-1
[281.772954] Dynamic subtest pipe-D-eDP-1: SUCCESS (5.317s)
[281.775123] Subtest ctm-0-75: SUCCESS (21.338s)
[282.597381] [030/133] (740s left) kms_cursor_legacy (cursor-vs-flip-atomic)
[282.727463] Starting subtest: cursor-vs-flip-atomic
[312.419148] Subtest cursor-vs-flip-atomic: SUCCESS (29.691s)
[313.220652] [031/133] (710s left) gem_fence_thrash (bo-write-verify-threaded-none)
[313.260077] Starting subtest: bo-write-verify-threaded-none
[313.284363] Subtest bo-write-verify-threaded-none: SKIP (0.020s)
[313.339831] [032/133] (710s left) gem_flink_race (flink_close)
[313.376707] Starting subtest: flink_close
[318.490472] Subtest flink_close: SUCCESS (5.113s)
[318.572210] [033/133] (704s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-mmap-cpu)
[318.692315] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-mmap-cpu
[318.696574] Subtest psr-2p-scndscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[318.805884] [034/133] (704s left) kms_psr (pr-dpms)
[318.905267] Starting subtest: pr-dpms
[318.909233] Subtest pr-dpms: SKIP (0.000s)
[318.989412] [035/133] (704s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-blt)
[319.086140] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-blt
[319.090087] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-blt: SKIP (0.000s)
[319.193820] [036/133] (704s left) kms_big_fb (x-tiled-8bpp-rotate-270)
[319.292945] Starting subtest: x-tiled-8bpp-rotate-270
[319.314277] Subtest x-tiled-8bpp-rotate-270: SKIP (0.021s)
[319.419840] [037/133] (704s left) gem_tiled_partial_pwrite_pread (writes-after-reads)
[319.476466] Subtest writes-after-reads: SKIP (0.000s)
[319.535314] [038/133] (704s left) syncobj_timeline (invalid-multi-wait-unsubmitted)
[319.593995] Starting subtest: invalid-multi-wait-unsubmitted
[319.595970] Subtest invalid-multi-wait-unsubmitted: SUCCESS (0.000s)
[319.706840] [039/133] (704s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-gtt)
[319.803519] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-gtt
[319.806882] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[319.899844] [040/133] (703s left) kms_ccs (crc-primary-rotation-180-y-tiled-ccs)
[320.002036] Starting subtest: crc-primary-rotation-180-y-tiled-ccs
[320.003899] Starting dynamic subtest: pipe-A-eDP-1
[320.023479] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[320.034392] Starting dynamic subtest: pipe-B-eDP-1
[320.051824] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[320.059505] Starting dynamic subtest: pipe-C-eDP-1
[320.077171] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[320.084597] Starting dynamic subtest: pipe-D-eDP-1
[320.102436] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[320.106013] Subtest crc-primary-rotation-180-y-tiled-ccs: SKIP (0.006s)
[322.329588] [041/133] (701s left) api_intel_bb (render)
[322.392994] Starting subtest: render
[322.395207] Starting dynamic subtest: render-none-512
[322.491685] Dynamic subtest render-none-512: SUCCESS (0.100s)
[322.500648] Starting dynamic subtest: render-none-1024
[323.162387] Dynamic subtest render-none-1024: SUCCESS (0.669s)
[323.172862] Starting dynamic subtest: render-x-512
[323.248191] Dynamic subtest render-x-512: SUCCESS (0.086s)
[323.258689] Starting dynamic subtest: render-x-1024
[323.598300] Dynamic subtest render-x-1024: SUCCESS (0.348s)
[323.608872] Starting dynamic subtest: render-y-512
[323.685038] Dynamic subtest render-y-512: SUCCESS (0.086s)
[323.694949] Starting dynamic subtest: render-y-1024
[324.038192] Dynamic subtest render-y-1024: SUCCESS (0.350s)
[324.041061] Subtest render: SUCCESS (1.646s)
[324.147416] [042/133] (699s left) syncobj_wait (wait-for-submit-snapshot)
[324.209328] Starting subtest: wait-for-submit-snapshot
[324.290486] Subtest wait-for-submit-snapshot: SUCCESS (0.082s)
[324.365299] [043/133] (699s left) gem_exec_capture (capture-recoverable)
[324.434849] Starting subtest: capture-recoverable
[324.437189] Subtest capture-recoverable: SUCCESS (0.003s)
[324.553348] [044/133] (699s left) kms_cursor_legacy (modeset-atomic-cursor-hotspot)
[324.678354] Starting subtest: modeset-atomic-cursor-hotspot
[324.682814] Subtest modeset-atomic-cursor-hotspot: SKIP (0.000s)
[324.822725] [045/133] (699s left) kms_psr (fbc-psr-sprite-mmap-cpu)
[324.915944] Starting subtest: fbc-psr-sprite-mmap-cpu
[324.918171] Starting dynamic subtest: eDP-1
[324.922380] Dynamic subtest eDP-1: SKIP (0.000s)
[324.926593] Subtest fbc-psr-sprite-mmap-cpu: SKIP (0.001s)
[325.003626] [046/133] (699s left) kms_flip (2x-flip-vs-absolute-wf_vblank)
[325.103512] Starting subtest: 2x-flip-vs-absolute-wf_vblank
[325.116562] Subtest 2x-flip-vs-absolute-wf_vblank: SKIP (0.014s)
[325.223721] [047/133] (698s left) gem_mmap_gtt (cpuset-basic-small-copy-xy)
[325.289551] Subtest cpuset-basic-small-copy-XY: SKIP (0.000s)
[325.352649] [048/133] (698s left) kms_frontbuffer_tracking (fbc-2p-primscrn-shrfb-plflip-blt)
[325.444237] Starting subtest: fbc-2p-primscrn-shrfb-plflip-blt
[325.447542] Subtest fbc-2p-primscrn-shrfb-plflip-blt: SKIP (0.000s)
[325.551710] [049/133] (698s left) kms_big_fb (linear-32bpp-rotate-180)
[325.665570] Starting subtest: linear-32bpp-rotate-180
[327.266764] Subtest linear-32bpp-rotate-180: SUCCESS (1.601s)
[327.398705] [050/133] (696s left) kms_frontbuffer_tracking (psr-rgb565-draw-mmap-cpu)
[327.509903] Starting subtest: psr-rgb565-draw-mmap-cpu
[334.221121] Subtest psr-rgb565-draw-mmap-cpu: SUCCESS (6.713s)
[334.334287] [051/133] (689s left) gem_pxp (create-valid-protected-context)
[334.452728] Starting subtest: create-valid-protected-context
[334.455248] Subtest create-valid-protected-context: SUCCESS (0.001s)
[334.576397] [052/133] (689s left) kms_cursor_crc (cursor-sliding-64x21)
[334.757064] Starting subtest: cursor-sliding-64x21
[334.807532] Subtest cursor-sliding-64x21: SKIP (0.045s)
[335.049917] [053/133] (689s left) syncobj_timeline (etime-single-wait-for-submit-submitted)
[335.102421] Starting subtest: etime-single-wait-for-submit-submitted
[335.209477] Subtest etime-single-wait-for-submit-submitted: SUCCESS (0.107s)
[335.286229] [054/133] (689s left) kms_async_flips (test-time-stamp)
[335.378579] Starting subtest: test-time-stamp
[335.757385] Starting dynamic subtest: pipe-A-eDP-1
[336.523107] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.764s)
[336.902190] Starting dynamic subtest: pipe-B-eDP-1
[337.661773] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.764s)
[338.028357] Starting dynamic subtest: pipe-C-eDP-1
[338.789679] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.767s)
[339.149771] Starting dynamic subtest: pipe-D-eDP-1
[339.915011] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.769s)
[339.917307] Subtest test-time-stamp: SUCCESS (4.538s)
[341.079338] [055/133] (683s left) syncobj_eventfd (timeline-wait)
[341.126171] Starting subtest: timeline-wait
[341.134530] Subtest timeline-wait: SUCCESS (0.010s)
[341.209736] [056/133] (683s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-32bpp-ytile-downscaling)
[341.303400] Starting subtest: flip-64bpp-ytile-to-32bpp-ytile-downscaling
[341.307769] Subtest flip-64bpp-ytile-to-32bpp-ytile-downscaling: SKIP (0.000s)
[341.375716] [057/133] (683s left) kms_flip (flip-vs-rmfb-interruptible)
[341.468131] Starting subtest: flip-vs-rmfb-interruptible
[341.470390] Starting dynamic subtest: A-eDP1
[350.157269] Dynamic subtest A-eDP1: SUCCESS (8.688s)
[350.170956] Starting dynamic subtest: B-eDP1
[358.784790] Dynamic subtest B-eDP1: SUCCESS (8.625s)
[358.793286] Starting dynamic subtest: C-eDP1
[367.400875] Dynamic subtest C-eDP1: SUCCESS (8.614s)
[367.410770] Starting dynamic subtest: D-eDP1
[376.030524] Dynamic subtest D-eDP1: SUCCESS (8.628s)
[376.036143] Subtest flip-vs-rmfb-interruptible: SUCCESS (34.569s)
[377.218900] [058/133] (647s left) kms_flip (2x-nonexisting-fb)
[377.344890] Starting subtest: 2x-nonexisting-fb
[377.354163] Subtest 2x-nonexisting-fb: SKIP (0.011s)
[377.436597] [059/133] (647s left) kms_addfb_basic (basic-y-tiled-legacy)
[377.499660] Starting subtest: basic-y-tiled-legacy
[377.503846] Subtest basic-y-tiled-legacy: SKIP (0.000s)
[377.659093] [060/133] (647s left) gem_ctx_shared (q-smoketest)
[377.726062] Starting subtest: Q-smoketest
[377.728314] Starting dynamic subtest: rcs0
[383.251848] Dynamic subtest rcs0: SUCCESS (5.481s)
[383.262151] Starting dynamic subtest: bcs0
[388.730648] Dynamic subtest bcs0: SUCCESS (5.473s)
[388.739718] Starting dynamic subtest: vcs0
[394.216537] Dynamic subtest vcs0: SUCCESS (5.483s)
[394.230554] Starting dynamic subtest: vcs1
[399.694559] Dynamic subtest vcs1: SUCCESS (5.477s)
[399.704481] Starting dynamic subtest: vecs0
[405.198346] Dynamic subtest vecs0: SUCCESS (5.500s)
[405.206882] Starting dynamic subtest: ccs0
[410.696720] Dynamic subtest ccs0: SUCCESS (5.501s)
[410.698788] Subtest Q-smoketest: SUCCESS (32.924s)
[410.841182] [061/133] (613s left) perf_pmu (busy-idle-check-all)
[410.883485] Starting subtest: busy-idle-check-all
[410.885742] Starting dynamic subtest: rcs0
[411.544662] Dynamic subtest rcs0: SUCCESS (0.662s)
[411.557175] Starting dynamic subtest: bcs0
[412.199489] Dynamic subtest bcs0: SUCCESS (0.653s)
[412.213643] Starting dynamic subtest: vcs0
[413.909787] Dynamic subtest vcs0: SUCCESS (1.706s)
[413.924047] Starting dynamic subtest: vcs1
[415.894614] Dynamic subtest vcs1: SUCCESS (1.981s)
[415.906834] Starting dynamic subtest: vecs0
[417.941505] Dynamic subtest vecs0: SUCCESS (2.044s)
[417.954900] Starting dynamic subtest: ccs0
[418.599956] Dynamic subtest ccs0: SUCCESS (0.657s)
[418.603048] Subtest busy-idle-check-all: SUCCESS (7.720s)
[418.701427] [062/133] (606s left) gem_exec_schedule (u-submit-late-slice)
[418.774097] Starting subtest: u-submit-late-slice
[418.776308] Starting dynamic subtest: rcs0
[418.825225] Dynamic subtest rcs0: SUCCESS (0.059s)
[418.834281] Starting dynamic subtest: bcs0
[418.880854] Dynamic subtest bcs0: SUCCESS (0.055s)
[418.892040] Starting dynamic subtest: vcs0
[418.931129] Dynamic subtest vcs0: SUCCESS (0.050s)
[418.944326] Starting dynamic subtest: vcs1
[418.979938] Dynamic subtest vcs1: SUCCESS (0.048s)
[418.989247] Starting dynamic subtest: vecs0
[419.029138] Dynamic subtest vecs0: SUCCESS (0.048s)
[419.042471] Starting dynamic subtest: ccs0
[419.089372] Dynamic subtest ccs0: SUCCESS (0.059s)
[419.091731] Subtest u-submit-late-slice: SUCCESS (0.324s)
[420.004201] [063/133] (604s left) kms_chamelium_hpd (vga-hpd-with-enabled-mode)
[420.388380] Subtest vga-hpd-with-enabled-mode: SKIP (0.000s)
[421.212478] [064/133] (603s left) kms_big_fb (y-tiled-8bpp-rotate-0)
[421.309054] Starting subtest: y-tiled-8bpp-rotate-0
[421.313651] Subtest y-tiled-8bpp-rotate-0: SKIP (0.000s)
[421.407887] [065/133] (603s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-indfb-msflip-blt)
[421.508844] Starting subtest: fbcpsr-2p-primscrn-indfb-msflip-blt
[421.513290] Subtest fbcpsr-2p-primscrn-indfb-msflip-blt: SKIP (0.000s)
[421.606317] [066/133] (603s left) prime_mmap (test_map_unmap)
[421.660766] Starting subtest: test_map_unmap
[421.662759] Starting dynamic subtest: test_map_unmap-smem
[421.691434] Dynamic subtest test_map_unmap-smem: SUCCESS (0.033s)
[421.693846] Subtest test_map_unmap: SUCCESS (0.034s)
[421.791228] [067/133] (603s left) gen9_exec_parse (bb-start-param)
[421.856282] Subtest bb-start-param: SKIP (0.000s)
[421.926976] [068/133] (603s left) kms_cursor_legacy (short-flip-before-cursor-toggle)
[422.059196] Starting subtest: short-flip-before-cursor-toggle
[422.978336] Subtest short-flip-before-cursor-toggle: SUCCESS (0.919s)
[423.788758] [069/133] (601s left) kms_frontbuffer_tracking (psr-suspend)
[423.887392] Starting subtest: psr-suspend
[463.461609] Subtest psr-suspend: SUCCESS (9.126s)
[469.636962] [070/133] (561s left) sw_sync (sync_multi_consumer_producer)
[469.695890] Starting subtest: sync_multi_consumer_producer
[469.987850] Subtest sync_multi_consumer_producer: SUCCESS (0.294s)
[470.053002] [071/133] (561s left) kms_plane_scaling (plane-upscale-factor-0-25-with-rotation)
[470.138371] Starting subtest: plane-upscale-factor-0-25-with-rotation
[470.140684] Starting dynamic subtest: pipe-A
[470.360116] Dynamic subtest pipe-A: SUCCESS (0.227s)
[470.370207] Starting dynamic subtest: pipe-B
[471.737446] Dynamic subtest pipe-B: SUCCESS (1.391s)
[471.750035] Starting dynamic subtest: pipe-C
[473.047763] Dynamic subtest pipe-C: SUCCESS (1.321s)
[473.064840] Starting dynamic subtest: pipe-D
[474.367924] Dynamic subtest pipe-D: SUCCESS (1.328s)
[474.370518] Subtest plane-upscale-factor-0-25-with-rotation: SUCCESS (4.275s)
[475.537300] [072/133] (555s left) kms_pipe_crc_basic (bad-source)
[475.620191] Starting subtest: bad-source
[475.622065] Subtest bad-source: SUCCESS (0.000s)
[475.695805] [073/133] (555s left) kms_psr (psr-cursor-render)
[475.779336] Starting subtest: psr-cursor-render
[475.781637] Starting dynamic subtest: eDP-1
[477.527052] Dynamic subtest eDP-1: SUCCESS (1.757s)
[477.529259] Subtest psr-cursor-render: SUCCESS (1.758s)
[478.422223] [074/133] (552s left) kms_psr2_su (page_flip-xrgb8888)
[478.475644] Subtest page_flip-XRGB8888: SKIP (0.000s)
[478.533355] [075/133] (552s left) kms_lease (atomic-implicit-crtc)
[478.627377] Starting subtest: atomic-implicit-crtc
[478.629678] Starting dynamic subtest: pipe-A-eDP-1
[478.640846] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[478.656974] Starting dynamic subtest: pipe-B-eDP-1
[478.667706] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.009s)
[478.677924] Starting dynamic subtest: pipe-C-eDP-1
[478.688171] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.009s)
[478.697710] Starting dynamic subtest: pipe-D-eDP-1
[478.707843] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.010s)
[478.709887] Subtest atomic-implicit-crtc: SUCCESS (0.035s)
[478.791981] [076/133] (552s left) kms_ccs (random-ccs-data-4-tiled-mtl-rc-ccs)
[478.885151] Starting subtest: random-ccs-data-4-tiled-mtl-rc-ccs
[478.887017] Starting dynamic subtest: pipe-A-eDP-1
[479.625427] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.736s)
[479.637665] Starting dynamic subtest: pipe-B-eDP-1
[481.425820] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.805s)
[481.441870] Starting dynamic subtest: pipe-C-eDP-1
[483.239986] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.818s)
[483.251637] Starting dynamic subtest: pipe-D-eDP-1
[485.068584] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.831s)
[485.070861] Subtest random-ccs-data-4-tiled-mtl-rc-ccs: SUCCESS (6.196s)
[486.188473] [077/133] (545s left) syncobj_wait (invalid-single-wait-all-unsubmitted)
[486.262822] Starting subtest: invalid-single-wait-all-unsubmitted
[486.265234] Subtest invalid-single-wait-all-unsubmitted: SUCCESS (0.000s)
[486.371807] [078/133] (545s left) gem_pwrite_snooped
[486.501428] [079/133] (545s left) gem_ctx_persistence (engines-queued)
[486.552647] Starting subtest: engines-queued
[486.554959] Starting dynamic subtest: rcs0
[486.642700] Dynamic subtest rcs0: SUCCESS (0.089s)
[486.655573] Starting dynamic subtest: bcs0
[486.662800] Dynamic subtest bcs0: SUCCESS (0.018s)
[486.675340] Starting dynamic subtest: vcs0
[488.296412] Dynamic subtest vcs0: SUCCESS (1.634s)
[488.308484] Starting dynamic subtest: vcs1
[490.342741] Dynamic subtest vcs1: SUCCESS (2.046s)
[490.354943] Starting dynamic subtest: vecs0
[492.326413] Dynamic subtest vecs0: SUCCESS (1.983s)
[492.339128] Starting dynamic subtest: ccs0
[492.502684] Dynamic subtest ccs0: SUCCESS (0.176s)
[492.505184] Subtest engines-queued: SUCCESS (5.958s)
[492.624554] [080/133] (538s left) kms_cursor_crc (cursor-onscreen-512x170)
[492.947267] Starting subtest: cursor-onscreen-512x170
[492.951068] Subtest cursor-onscreen-512x170: SKIP (0.001s)
[493.096597] [081/133] (538s left) gem_workarounds (suspend-resume-fd)
[493.159050] Starting subtest: suspend-resume-fd
[509.766845] Subtest suspend-resume-fd: SUCCESS (1.604s)
[517.927487] [082/133] (521s left) kms_frontbuffer_tracking (psr-2p-primscrn-shrfb-msflip-blt)
[518.047473] Starting subtest: psr-2p-primscrn-shrfb-msflip-blt
[518.052595] Subtest psr-2p-primscrn-shrfb-msflip-blt: SKIP (0.000s)
[518.142240] [083/133] (521s left) gem_spin_batch (user-each)
[518.201697] Starting subtest: user-each
[521.468226] Subtest user-each: SUCCESS (3.288s)
[523.384863] [084/133] (516s left) kms_pm_dc (dc5-retention-flops)
[524.492170] Starting subtest: dc5-retention-flops
[524.497541] Subtest dc5-retention-flops: SKIP (0.000s)
[524.565388] [085/133] (515s left) syncobj_timeline (multi-wait-for-submit-unsubmitted-submitted-signaled)
[524.622799] Starting subtest: multi-wait-for-submit-unsubmitted-submitted-signaled
[524.625339] Subtest multi-wait-for-submit-unsubmitted-submitted-signaled: SUCCESS (0.001s)
[524.724728] [086/133] (515s left) perf (rc6-disable)
[524.831049] Starting subtest: rc6-disable
[525.025010] Subtest rc6-disable: SUCCESS (0.194s)
[525.077054] [087/133] (514s left) prime_vgem (basic-blt)
[525.142704] Starting subtest: basic-blt
[525.193190] Subtest basic-blt: SUCCESS (0.051s)
[525.316273] [088/133] (514s left) syncobj_wait (wait-delayed-signal)
[525.367124] Starting subtest: wait-delayed-signal
[525.469487] Subtest wait-delayed-signal: SUCCESS (0.103s)
[525.561712] [089/133] (514s left) kms_sequence (queue-busy)
[525.669403] Starting subtest: queue-busy
[525.672244] Starting dynamic subtest: pipe-A-eDP-1
[527.598169] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.936s)
[527.610312] Starting dynamic subtest: pipe-B-eDP-1
[530.246069] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.653s)
[530.256998] Starting dynamic subtest: pipe-C-eDP-1
[532.865329] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.625s)
[532.877914] Starting dynamic subtest: pipe-D-eDP-1
[535.471120] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.608s)
[535.473875] Subtest queue-busy: SUCCESS (9.829s)
[536.344512] [090/133] (503s left) gen7_exec_parse (basic-allowed)
[536.409617] Subtest basic-allowed: SKIP (0.000s)
[536.483966] [091/133] (503s left) kms_frontbuffer_tracking (fbc-2p-primscrn-indfb-pgflip-blt)
[536.585077] Starting subtest: fbc-2p-primscrn-indfb-pgflip-blt
[536.590206] Subtest fbc-2p-primscrn-indfb-pgflip-blt: SKIP (0.000s)
[536.702396] [092/133] (503s left) syncobj_wait (single-wait-all-submitted)
[536.759242] Starting subtest: single-wait-all-submitted
[536.866893] Subtest single-wait-all-submitted: SUCCESS (0.108s)
[536.958223] [093/133] (503s left) sysfs_timeslice_duration (timeout)
[537.018198] Starting subtest: timeout
[537.021142] Starting dynamic subtest: vecs0
[546.336193] Dynamic subtest vecs0: SUCCESS (9.324s)
[546.348951] Starting dynamic subtest: ccs0
[547.553379] Dynamic subtest ccs0: SUCCESS (1.216s)
[547.565969] Starting dynamic subtest: vcs0
[557.346316] Dynamic subtest vcs0: SUCCESS (9.789s)
[557.359350] Starting dynamic subtest: bcs0
[557.953315] Dynamic subtest bcs0: SUCCESS (0.605s)
[557.965905] Starting dynamic subtest: rcs0
[559.162453] Dynamic subtest rcs0: SUCCESS (1.208s)
[559.174159] Starting dynamic subtest: vcs1
[568.356134] Dynamic subtest vcs1: SUCCESS (9.189s)
[568.359230] Subtest timeout: SUCCESS (31.344s)
[568.436818] [094/133] (471s left) gem_render_copy (y-tiled-to-vebox-y-tiled)
[568.499253] Starting subtest: y-tiled-to-vebox-y-tiled
[568.505144] Subtest y-tiled-to-vebox-y-tiled: SKIP (0.000s)
[568.706513] [095/133] (471s left) i915_drm_fdinfo (most-busy-check-all)
[568.748666] Starting subtest: most-busy-check-all
[568.751329] Starting dynamic subtest: rcs0
[568.757109] Dynamic subtest rcs0: SKIP (0.006s)
[568.769658] Starting dynamic subtest: bcs0
[568.775178] Dynamic subtest bcs0: SKIP (0.000s)
[568.785676] Starting dynamic subtest: vcs0
[568.790693] Dynamic subtest vcs0: SKIP (0.000s)
[568.800995] Starting dynamic subtest: vcs1
[568.806047] Dynamic subtest vcs1: SKIP (0.000s)
[568.816530] Starting dynamic subtest: vecs0
[568.822119] Dynamic subtest vecs0: SKIP (0.000s)
[568.832355] Starting dynamic subtest: ccs0
[568.838168] Dynamic subtest ccs0: SKIP (0.000s)
[568.843934] Subtest most-busy-check-all: SKIP (0.011s)
[568.886548] [096/133] (471s left) i915_pm_rpm (system-suspend-execbuf)
[570.532197] Starting subtest: system-suspend-execbuf
[631.314662] Subtest system-suspend-execbuf: SUCCESS (45.150s)
[631.701091] [097/133] (408s left) gem_exec_schedule (semaphore-power)
[631.885020] Subtest semaphore-power: SKIP (0.000s)
[632.076747] [098/133] (408s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-blt)
[632.182780] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-blt
[632.187995] Subtest fbc-2p-scndscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[632.294540] [099/133] (408s left) kms_big_fb (4-tiled-64bpp-rotate-270)
[632.407076] Starting subtest: 4-tiled-64bpp-rotate-270
[632.426926] Subtest 4-tiled-64bpp-rotate-270: SKIP (0.019s)
[632.555890] [100/133] (407s left) gem_mmap_offset (partial-remap)
[632.623328] Starting subtest: partial-remap
[632.626228] Starting dynamic subtest: smem0
[632.637686] Dynamic subtest smem0: SUCCESS (0.004s)
[632.640458] Subtest partial-remap: SUCCESS (0.005s)
[632.742270] [101/133] (407s left) kms_flip_scaled_crc (flip-32bpp-4tile-to-64bpp-4tile-downscaling)
[632.826520] Starting subtest: flip-32bpp-4tile-to-64bpp-4tile-downscaling
[632.828833] Starting dynamic subtest: pipe-A-default-mode
[633.960050] Dynamic subtest pipe-A-default-mode: SKIP (1.130s)
[633.964920] Subtest flip-32bpp-4tile-to-64bpp-4tile-downscaling: SKIP (1.131s)
[634.118627] [102/133] (406s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-onoff)
[634.227956] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-onoff
[634.232760] Subtest fbcpsr-2p-primscrn-spr-indfb-onoff: SKIP (0.000s)
[634.324344] [103/133] (406s left) gem_pxp (verify-pxp-stale-ctx-execution)
[634.430162] Starting subtest: verify-pxp-stale-ctx-execution
[635.494426] Subtest verify-pxp-stale-ctx-execution: SUCCESS (1.063s)
[635.628614] [104/133] (405s left) gem_exec_reloc (basic-gtt-read-active)
[635.690987] Subtest basic-gtt-read-active: SKIP (0.000s)
[635.759763] [105/133] (404s left) dmabuf_sync_file (export-multiwait)
[635.804551] Starting subtest: export-multiwait
[635.806642] Subtest export-multiwait: SUCCESS (0.000s)
[635.862564] [106/133] (404s left) kms_psr (fbc-psr2-basic)
[635.958882] Starting subtest: fbc-psr2-basic
[635.961583] Starting dynamic subtest: eDP-1
[635.966800] Dynamic subtest eDP-1: SKIP (0.000s)
[635.971981] Subtest fbc-psr2-basic: SKIP (0.001s)
[636.036485] [107/133] (404s left) i915_hangman (gt-engine-hang)
[636.106015] Starting subtest: gt-engine-hang
[636.111178] Starting dynamic subtest: rcs0
[638.084159] Dynamic subtest rcs0: SUCCESS (1.978s)
[638.098645] Starting dynamic subtest: bcs0
[640.066449] Dynamic subtest bcs0: SUCCESS (1.979s)
[640.080602] Starting dynamic subtest: vcs0
[642.050183] Dynamic subtest vcs0: SUCCESS (1.981s)
[642.064180] Starting dynamic subtest: vcs1
[644.098075] Dynamic subtest vcs1: SUCCESS (2.045s)
[644.113048] Starting dynamic subtest: vecs0
[646.083153] Dynamic subtest vecs0: SUCCESS (1.982s)
[646.096850] Starting dynamic subtest: ccs0
[648.066504] Dynamic subtest ccs0: SUCCESS (1.981s)
[648.069422] Subtest gt-engine-hang: SUCCESS (11.963s)
[648.196292] [108/133] (392s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-blt)
[648.299559] Starting subtest: psr-1p-primscrn-cur-indfb-draw-blt
[655.111717] Subtest psr-1p-primscrn-cur-indfb-draw-blt: SUCCESS (6.818s)
[655.239016] [109/133] (385s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-mmap-wc)
[655.336996] Starting subtest: psr-2p-primscrn-cur-indfb-draw-mmap-wc
[655.341754] Subtest psr-2p-primscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[655.437692] [110/133] (385s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-180-async-flip)
[655.535698] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-180-async-flip
[656.403405] Subtest x-tiled-max-hw-stride-64bpp-rotate-180-async-flip: SUCCESS (0.870s)
[656.553424] [111/133] (384s left) kms_invalid_mode (bad-hsync-start)
[656.654048] Starting subtest: bad-hsync-start
[656.656615] Starting dynamic subtest: pipe-A-eDP-1
[656.938762] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.285s)
[656.949173] Starting dynamic subtest: pipe-B-eDP-1
[656.951545] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[656.961443] Starting dynamic subtest: pipe-C-eDP-1
[656.963901] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[656.973485] Starting dynamic subtest: pipe-D-eDP-1
[656.975793] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[656.978002] Subtest bad-hsync-start: SUCCESS (0.291s)
[657.791212] [112/133] (383s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-mmap-gtt)
[657.887031] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-mmap-gtt
[657.891341] Subtest fbc-1p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[657.980466] [113/133] (383s left) kms_flip (2x-blocking-wf_vblank)
[658.073968] Starting subtest: 2x-blocking-wf_vblank
[658.087063] Subtest 2x-blocking-wf_vblank: SKIP (0.013s)
[658.182637] [114/133] (382s left) kms_ccs (bad-rotation-90-4-tiled-dg2-mc-ccs)
[658.275578] Starting subtest: bad-rotation-90-4-tiled-dg2-mc-ccs
[658.277925] Starting dynamic subtest: pipe-A-eDP-1
[658.300638] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[658.312233] Starting dynamic subtest: pipe-B-eDP-1
[658.336823] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[658.346695] Starting dynamic subtest: pipe-C-eDP-1
[658.371653] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[658.381453] Starting dynamic subtest: pipe-D-eDP-1
[658.405752] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[658.410122] Subtest bad-rotation-90-4-tiled-dg2-mc-ccs: SKIP (0.004s)
[660.553782] [115/133] (380s left) kms_busy (basic)
[660.658661] Starting subtest: basic
[660.661179] Starting dynamic subtest: flip
[661.259167] Dynamic subtest flip: SUCCESS (0.601s)
[661.270822] Starting dynamic subtest: modeset
[664.682390] Dynamic subtest modeset: SUCCESS (3.423s)
[664.685237] Subtest basic: SUCCESS (4.027s)
[665.487386] [116/133] (375s left) gem_exec_schedule (preemptive-hang)
[665.661017] Starting subtest: preemptive-hang
[665.663720] Starting dynamic subtest: rcs0
[675.279638] Dynamic subtest rcs0: SUCCESS (9.619s)
[675.291859] Starting dynamic subtest: bcs0
[684.301629] Dynamic subtest bcs0: SUCCESS (9.027s)
[684.314183] Starting dynamic subtest: vcs0
[693.260595] Dynamic subtest vcs0: SUCCESS (8.958s)
[693.272927] Starting dynamic subtest: vcs1
[702.220140] Dynamic subtest vcs1: SUCCESS (8.952s)
[702.233529] Starting dynamic subtest: vecs0
[711.239069] Dynamic subtest vecs0: SUCCESS (9.016s)
[711.250184] Starting dynamic subtest: ccs0
[720.270190] Dynamic subtest ccs0: SUCCESS (9.028s)
[720.273236] Subtest preemptive-hang: SUCCESS (54.611s)
[720.550308] [117/133] (320s left) kms_flip_scaled_crc (flip-32bpp-ytileccs-to-64bpp-ytile-upscaling)
[720.654980] Starting subtest: flip-32bpp-ytileccs-to-64bpp-ytile-upscaling
[720.660150] Subtest flip-32bpp-ytileccs-to-64bpp-ytile-upscaling: SKIP (0.000s)
[720.741097] [118/133] (320s left) gem_ctx_param (invalid-size-get)
[720.794649] Starting subtest: invalid-size-get
[720.797206] Subtest invalid-size-get: SUCCESS (0.001s)
[720.884070] [119/133] (320s left) kms_cursor_legacy (short-flip-before-cursor-atomic-transitions)
[720.999457] Starting subtest: short-flip-before-cursor-atomic-transitions
[721.961077] Subtest short-flip-before-cursor-atomic-transitions: SUCCESS (0.959s)
[722.815873] [120/133] (318s left) i915_selftest (mock)
[727.391494] Starting subtest: mock
[727.394058] Starting dynamic subtest: sanitycheck
[728.974012] Dynamic subtest sanitycheck: SUCCESS (1.582s)
[728.984021] Starting dynamic subtest: shmem
[730.579479] Dynamic subtest shmem: SUCCESS (1.603s)
[730.590000] Starting dynamic subtest: fence
[739.208159] Dynamic subtest fence: SUCCESS (8.627s)
[739.218725] Starting dynamic subtest: scatterlist
[741.777166] Dynamic subtest scatterlist: SUCCESS (2.568s)
[741.790500] Starting dynamic subtest: syncmap
[745.891627] Dynamic subtest syncmap: SUCCESS (4.113s)
[745.902078] Starting dynamic subtest: uncore
[747.447684] Dynamic subtest uncore: SUCCESS (1.554s)
[747.458015] Starting dynamic subtest: ring
[749.016596] Dynamic subtest ring: SUCCESS (1.567s)
[749.027700] Starting dynamic subtest: engine
[750.584317] Dynamic subtest engine: SUCCESS (1.566s)
[750.599172] Starting dynamic subtest: timelines
[755.949087] Dynamic subtest timelines: SUCCESS (5.363s)
[755.959299] Starting dynamic subtest: requests
[760.423071] Dynamic subtest requests: SUCCESS (4.473s)
[760.433089] Starting dynamic subtest: objects
[762.089209] Dynamic subtest objects: SUCCESS (1.665s)
[762.099248] Starting dynamic subtest: phys
[763.762812] Dynamic subtest phys: SUCCESS (1.673s)
[763.772593] Starting dynamic subtest: dmabuf
[765.423925] Dynamic subtest dmabuf: SUCCESS (1.660s)
[765.434580] Starting dynamic subtest: vma
[772.046842] Dynamic subtest vma: SUCCESS (6.623s)
[772.057170] Starting dynamic subtest: evict
[774.376871] Dynamic subtest evict: SUCCESS (2.329s)
[774.387154] Starting dynamic subtest: gtt
[778.631832] Dynamic subtest gtt: SUCCESS (4.255s)
[778.642150] Starting dynamic subtest: hugepages
[780.410908] Dynamic subtest hugepages: SUCCESS (1.778s)
[780.421584] Starting dynamic subtest: memory_region
[783.765942] Dynamic subtest memory_region: SUCCESS (3.355s)
[783.769137] Subtest mock: SUCCESS (56.383s)
[783.800879] [FACT i915_selftest (mock)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[783.801590] [FACT i915_selftest (mock)] deleted: kernel.kmod_is_loaded.i915: true
[783.805579] [121/133] (257s left) syncobj_wait (multi-wait-all-for-submit-unsubmitted)
[786.238951] Starting subtest: multi-wait-all-for-submit-unsubmitted
[786.344514] Subtest multi-wait-all-for-submit-unsubmitted: SUCCESS (0.108s)
[786.391817] [FACT syncobj_wait (multi-wait-all-for-submit-unsubmitted)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[786.393153] [FACT syncobj_wait (multi-wait-all-for-submit-unsubmitted)] new: kernel.kmod_is_loaded.i915: true
[786.397376] [122/133] (255s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-pwrite)
[786.507334] Starting subtest: fbcpsr-rgb565-draw-pwrite
[793.844728] Subtest fbcpsr-rgb565-draw-pwrite: SUCCESS (7.340s)
[793.956245] [123/133] (247s left) gem_exec_balancer (individual)
[794.030090] Starting subtest: individual
[796.131953] Subtest individual: SUCCESS (2.101s)
[796.440956] [124/133] (245s left) kms_chamelium_frames (hdmi-frame-dump)
[796.848219] Subtest hdmi-frame-dump: SKIP (0.000s)
[797.686309] [125/133] (243s left) gem_ctx_create (basic-files)
[797.747160] Starting subtest: basic-files
[799.756019] Subtest basic-files: SUCCESS (2.010s)
[801.175632] [126/133] (240s left) gem_ctx_param (basic)
[801.225771] Starting subtest: basic
[801.228486] Subtest basic: SUCCESS (0.001s)
[801.322922] [127/133] (240s left) kms_psr2_sf (fbc-psr2-overlay-plane-update-sf-dmg-area)
[801.430968] Starting subtest: fbc-psr2-overlay-plane-update-sf-dmg-area
[801.433934] Starting dynamic subtest: pipe-A-eDP-1
[801.536669] Dynamic subtest pipe-A-eDP-1: SKIP (0.111s)
[801.546918] Starting dynamic subtest: pipe-B-eDP-1
[802.691012] Dynamic subtest pipe-B-eDP-1: SKIP (1.150s)
[802.696462] Subtest fbc-psr2-overlay-plane-update-sf-dmg-area: SKIP (1.265s)
[803.877292] [128/133] (237s left) gen3_mixed_blits
[804.004879] [129/133] (237s left) prime_vgem (fence-write-hang)
[804.070298] Subtest fence-write-hang: SKIP (0.000s)
[804.178543] [130/133] (237s left) gem_ctx_persistence (saturated-hostile)
[804.240216] Starting subtest: saturated-hostile
[804.243202] Starting dynamic subtest: rcs0
[805.062177] Dynamic subtest rcs0: SUCCESS (0.822s)
[805.075413] Starting dynamic subtest: bcs0
[805.839462] Dynamic subtest bcs0: SUCCESS (0.776s)
[805.852341] Starting dynamic subtest: vcs0
[806.633677] Dynamic subtest vcs0: SUCCESS (0.793s)
[806.646480] Starting dynamic subtest: vcs1
[807.433163] Dynamic subtest vcs1: SUCCESS (0.798s)
[807.446387] Starting dynamic subtest: vecs0
[808.226801] Dynamic subtest vecs0: SUCCESS (0.792s)
[808.240165] Starting dynamic subtest: ccs0
[809.063871] Dynamic subtest ccs0: SUCCESS (0.836s)
[809.067021] Subtest saturated-hostile: SUCCESS (4.827s)
[809.203241] [131/133] (232s left) gem_render_copy (y-tiled-ccs-to-linear)
[809.264077] Starting subtest: y-tiled-ccs-to-linear
[809.270041] Subtest y-tiled-ccs-to-linear: SKIP (0.000s)
[809.453980] [132/133] (232s left) gem_lmem_swapping (heavy-random)
[809.495437] Subtest heavy-random: SKIP (0.000s)
[809.537495] [133/133] (232s left) kms_atomic_transition (plane-all-transition-nonblocking-fencing)
[809.629909] Starting subtest: plane-all-transition-nonblocking-fencing
[809.632657] Starting dynamic subtest: pipe-A-eDP-1
[812.125161] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.497s)
[812.449177] Starting dynamic subtest: pipe-B-eDP-1
[815.717734] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.284s)
[816.030089] Subtest plane-all-transition-nonblocking-fencing: SUCCESS (6.400s)
[816.847824] Closing watchdogs
results: parsing output: 0/ for test: kms_pipe_crc_basic
results: parsing output: 1/ for test: kms_ccs
results: parsing output: 2/ for test: kms_ccs
results: parsing output: 3/ for test: gem_exec_fence
results: parsing output: 4/ for test: kms_big_fb
results: parsing output: 5/ for test: kms_plane
results: parsing output: 6/ for test: kms_prop_blob
results: parsing output: 7/ for test: kms_cursor_crc
results: parsing output: 8/ for test: kms_psr
results: parsing output: 9/ for test: kms_pm_rpm
results: parsing output: 10/ for test: syncobj_timeline
results: parsing output: 11/ for test: gem_workarounds
results: parsing output: 12/ for test: kms_flip
results: parsing output: 13/ for test: kms_dsc
results: parsing output: 14/ for test: fbdev
results: parsing output: 15/ for test: vgem_basic
results: parsing output: 16/ for test: kms_frontbuffer_tracking
results: parsing output: 17/ for test: kms_plane
results: parsing output: 18/ for test: gem_exec_fence
results: parsing output: 19/ for test: kms_frontbuffer_tracking
results: parsing output: 20/ for test: kms_frontbuffer_tracking
results: parsing output: 21/ for test: gem_create
results: parsing output: 22/ for test: kms_plane
results: parsing output: 23/ for test: prime_mmap
results: parsing output: 24/ for test: kms_vblank
results: parsing output: 25/ for test: perf
results: parsing output: 26/ for test: kms_content_protection
results: parsing output: 27/ for test: gem_softpin
results: parsing output: 28/ for test: kms_color
results: parsing output: 29/ for test: kms_cursor_legacy
results: parsing output: 30/ for test: gem_fence_thrash
results: parsing output: 31/ for test: gem_flink_race
results: parsing output: 32/ for test: kms_frontbuffer_tracking
results: parsing output: 33/ for test: kms_psr
results: parsing output: 34/ for test: kms_frontbuffer_tracking
results: parsing output: 35/ for test: kms_big_fb
results: parsing output: 36/ for test: gem_tiled_partial_pwrite_pread
results: parsing output: 37/ for test: syncobj_timeline
results: parsing output: 38/ for test: kms_frontbuffer_tracking
results: parsing output: 39/ for test: kms_ccs
results: parsing output: 40/ for test: api_intel_bb
results: parsing output: 41/ for test: syncobj_wait
results: parsing output: 42/ for test: gem_exec_capture
results: parsing output: 43/ for test: kms_cursor_legacy
results: parsing output: 44/ for test: kms_psr
results: parsing output: 45/ for test: kms_flip
results: parsing output: 46/ for test: gem_mmap_gtt
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_pxp
results: parsing output: 51/ for test: kms_cursor_crc
results: parsing output: 52/ for test: syncobj_timeline
results: parsing output: 53/ for test: kms_async_flips
results: parsing output: 54/ for test: syncobj_eventfd
results: parsing output: 55/ for test: kms_flip_scaled_crc
results: parsing output: 56/ for test: kms_flip
results: parsing output: 57/ for test: kms_flip
results: parsing output: 58/ for test: kms_addfb_basic
results: parsing output: 59/ for test: gem_ctx_shared
results: parsing output: 60/ for test: perf_pmu
results: parsing output: 61/ for test: gem_exec_schedule
results: parsing output: 62/ for test: kms_chamelium_hpd
results: parsing output: 63/ for test: kms_big_fb
results: parsing output: 64/ for test: kms_frontbuffer_tracking
results: parsing output: 65/ for test: prime_mmap
results: parsing output: 66/ for test: gen9_exec_parse
results: parsing output: 67/ for test: kms_cursor_legacy
results: parsing output: 68/ for test: kms_frontbuffer_tracking
results: parsing output: 69/ for test: sw_sync
results: parsing output: 70/ for test: kms_plane_scaling
results: parsing output: 71/ for test: kms_pipe_crc_basic
results: parsing output: 72/ for test: kms_psr
results: parsing output: 73/ for test: kms_psr2_su
results: parsing output: 74/ for test: kms_lease
results: parsing output: 75/ for test: kms_ccs
results: parsing output: 76/ for test: syncobj_wait
results: parsing output: 77/ for test: gem_pwrite_snooped
results: parsing output: 78/ for test: gem_ctx_persistence
results: parsing output: 79/ for test: kms_cursor_crc
results: parsing output: 80/ for test: gem_workarounds
results: parsing output: 81/ for test: kms_frontbuffer_tracking
results: parsing output: 82/ for test: gem_spin_batch
results: parsing output: 83/ for test: kms_pm_dc
results: parsing output: 84/ for test: syncobj_timeline
results: parsing output: 85/ for test: perf
results: parsing output: 86/ for test: prime_vgem
results: parsing output: 87/ for test: syncobj_wait
results: parsing output: 88/ for test: kms_sequence
results: parsing output: 89/ for test: gen7_exec_parse
results: parsing output: 90/ for test: kms_frontbuffer_tracking
results: parsing output: 91/ for test: syncobj_wait
results: parsing output: 92/ for test: sysfs_timeslice_duration
results: parsing output: 93/ for test: gem_render_copy
results: parsing output: 94/ for test: i915_drm_fdinfo
results: parsing output: 95/ for test: i915_pm_rpm
results: parsing output: 96/ for test: gem_exec_schedule
results: parsing output: 97/ for test: kms_frontbuffer_tracking
results: parsing output: 98/ for test: kms_big_fb
results: parsing output: 99/ for test: gem_mmap_offset
results: parsing output: 100/ for test: kms_flip_scaled_crc
results: parsing output: 101/ for test: kms_frontbuffer_tracking
results: parsing output: 102/ for test: gem_pxp
results: parsing output: 103/ for test: gem_exec_reloc
results: parsing output: 104/ for test: dmabuf_sync_file
results: parsing output: 105/ for test: kms_psr
results: parsing output: 106/ for test: i915_hangman
results: parsing output: 107/ for test: kms_frontbuffer_tracking
results: parsing output: 108/ for test: kms_frontbuffer_tracking
results: parsing output: 109/ for test: kms_big_fb
results: parsing output: 110/ for test: kms_invalid_mode
results: parsing output: 111/ for test: kms_frontbuffer_tracking
results: parsing output: 112/ for test: kms_flip
results: parsing output: 113/ for test: kms_ccs
results: parsing output: 114/ for test: kms_busy
results: parsing output: 115/ for test: gem_exec_schedule
results: parsing output: 116/ for test: kms_flip_scaled_crc
results: parsing output: 117/ for test: gem_ctx_param
results: parsing output: 118/ for test: kms_cursor_legacy
results: parsing output: 119/ for test: i915_selftest
results: parsing output: 120/ for test: syncobj_wait
results: parsing output: 121/ for test: kms_frontbuffer_tracking
results: parsing output: 122/ for test: gem_exec_balancer
results: parsing output: 123/ for test: kms_chamelium_frames
results: parsing output: 124/ for test: gem_ctx_create
results: parsing output: 125/ for test: gem_ctx_param
results: parsing output: 126/ for test: kms_psr2_sf
results: parsing output: 127/ for test: gen3_mixed_blits
results: parsing output: 128/ for test: prime_vgem
results: parsing output: 129/ for test: gem_ctx_persistence
results: parsing output: 130/ for test: gem_render_copy
results: parsing output: 131/ for test: gem_lmem_swapping
results: parsing output: 132/ for test: kms_atomic_transition
Done.