[59.358746] Initializing watchdogs
[59.358791]   /dev/watchdog0
[59.372200] [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]
[59.376467] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[59.379073] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[59.382281] [001/130] (960s left) gem_exec_reloc (basic-write-gtt)
[59.469412] Subtest basic-write-gtt: SKIP (0.000s)
[59.538144] [002/130] (960s left) kms_ccs (missing-ccs-buffer-4-tiled-mtl-mc-ccs)
[59.636425] Starting subtest: missing-ccs-buffer-4-tiled-mtl-mc-ccs
[59.638834] Starting dynamic subtest: pipe-A-eDP-1
[59.659565] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.019s)
[59.667525] Starting dynamic subtest: pipe-B-eDP-1
[59.687246] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.019s)
[59.694055] Starting dynamic subtest: pipe-C-eDP-1
[59.714352] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.020s)
[59.721909] Starting dynamic subtest: pipe-D-eDP-1
[59.742495] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.021s)
[59.744776] Subtest missing-ccs-buffer-4-tiled-mtl-mc-ccs: SUCCESS (0.082s)
[62.007559] [003/130] (957s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-indfb-draw-pwrite)
[62.108443] Starting subtest: psr-1p-offscreen-pri-indfb-draw-pwrite
[69.431361] Subtest psr-1p-offscreen-pri-indfb-draw-pwrite: SUCCESS (7.337s)
[69.540571] [004/130] (950s left) gem_exec_params (mmapped)
[69.605304] Starting subtest: mmapped
[69.607623] Subtest mmapped: SUCCESS (0.003s)
[69.720707] [005/130] (950s left) gem_userptr_blits (coherency-sync)
[69.800899] Starting subtest: coherency-sync
[70.112119] Subtest coherency-sync: SKIP (0.271s)
[70.214936] [006/130] (949s left) kms_frontbuffer_tracking (fbcpsr-modesetfrombusy)
[70.364795] Starting subtest: fbcpsr-modesetfrombusy
[76.537120] Subtest fbcpsr-modesetfrombusy: SUCCESS (6.181s)
[76.648915] [007/130] (943s left) kms_tv_load_detect (load-detect)
[76.708917] Subtest load-detect: SKIP (0.000s)
[76.756971] [008/130] (943s left) kms_ccs (bad-rotation-90-y-tiled-gen12-rc-ccs-cc)
[76.843855] Starting subtest: bad-rotation-90-y-tiled-gen12-rc-ccs-cc
[76.845754] Starting dynamic subtest: pipe-A-eDP-1
[76.864233] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[76.871205] Starting dynamic subtest: pipe-B-eDP-1
[76.888880] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[76.895493] Starting dynamic subtest: pipe-C-eDP-1
[76.912222] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[76.918830] Starting dynamic subtest: pipe-D-eDP-1
[76.936230] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[76.939533] Subtest bad-rotation-90-y-tiled-gen12-rc-ccs-cc: SKIP (0.003s)
[79.166657] [009/130] (940s left) gem_ctx_param (invalid-get-ringsize)
[79.220757] Starting subtest: invalid-get-ringsize
[79.223156] Subtest invalid-get-ringsize: SUCCESS (0.001s)
[79.325098] [010/130] (940s left) gem_exec_fence (parallel)
[79.506645] Starting subtest: parallel
[79.509098] Starting dynamic subtest: rcs0
[81.661276] Dynamic subtest rcs0: SUCCESS (2.154s)
[81.669642] Starting dynamic subtest: bcs0
[83.815674] Dynamic subtest bcs0: SUCCESS (2.153s)
[83.823606] Starting dynamic subtest: vcs0
[85.970520] Dynamic subtest vcs0: SUCCESS (2.153s)
[85.980419] Starting dynamic subtest: vcs1
[88.126035] Dynamic subtest vcs1: SUCCESS (2.154s)
[88.135325] Starting dynamic subtest: vecs0
[90.280573] Dynamic subtest vecs0: SUCCESS (2.153s)
[90.287786] Starting dynamic subtest: ccs0
[92.431632] Dynamic subtest ccs0: SUCCESS (2.150s)
[92.433592] Subtest parallel: SUCCESS (12.919s)
[93.036102] [FACT gem_exec_fence (parallel)] new: kernel.kmod_is_loaded.vgem: true
[93.039836] [011/130] (927s left) gem_eio (wait-wedge-immediate)
[93.271975] Starting subtest: wait-wedge-immediate
[95.030857] Subtest wait-wedge-immediate: SUCCESS (1.758s)
[95.144602] [012/130] (925s left) kms_cursor_legacy (single-bo)
[95.263027] Starting subtest: single-bo
[95.265259] Starting dynamic subtest: pipe-A
[100.647698] Dynamic subtest pipe-A: SUCCESS (5.379s)
[100.658347] Starting dynamic subtest: pipe-B
[106.030923] Dynamic subtest pipe-B: SUCCESS (5.381s)
[106.041320] Starting dynamic subtest: pipe-C
[111.414054] Dynamic subtest pipe-C: SUCCESS (5.381s)
[111.424822] Starting dynamic subtest: pipe-D
[116.797041] Dynamic subtest pipe-D: SUCCESS (5.381s)
[116.808051] Starting dynamic subtest: all-pipes
[122.187052] Dynamic subtest all-pipes: SUCCESS (5.388s)
[122.189644] Subtest single-bo: SUCCESS (26.915s)
[122.340995] [013/130] (897s left) syncobj_timeline (single-wait-all-available-submitted)
[122.406873] Starting subtest: single-wait-all-available-submitted
[122.408880] Subtest single-wait-all-available-submitted: SUCCESS (0.000s)
[122.506197] [014/130] (897s left) i915_suspend (sysfs-reader)
[122.575043] Starting subtest: sysfs-reader
[141.121652] Subtest sysfs-reader: SUCCESS (3.227s)
[141.222558] [015/130] (879s left) gem_exec_params (invalid-ring)
[141.298641] Starting subtest: invalid-ring
[141.300698] Subtest invalid-ring: SUCCESS (0.000s)
[141.429907] [016/130] (879s left) gem_pxp (create-valid-protected-context)
[141.550268] Starting subtest: create-valid-protected-context
[141.552393] Subtest create-valid-protected-context: SUCCESS (0.002s)
[141.669992] [017/130] (878s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-pwrite)
[141.783317] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-pwrite
[146.100910] Subtest fbc-1p-primscrn-spr-indfb-draw-pwrite: SUCCESS (4.369s)
[147.254328] [018/130] (873s left) perf_pmu (rc6-all-gts)
[147.303567] Starting subtest: rc6-all-gts
[153.674214] Subtest rc6-all-gts: SUCCESS (6.404s)
[154.568532] [019/130] (866s left) kms_cursor_crc (cursor-onscreen-32x32)
[154.726640] Starting subtest: cursor-onscreen-32x32
[154.773506] Subtest cursor-onscreen-32x32: SKIP (0.043s)
[155.065339] [020/130] (865s left) kms_plane_scaling (planes-downscale-factor-0-5-upscale-20x20)
[155.163621] Starting subtest: planes-downscale-factor-0-5-upscale-20x20
[155.165638] Starting dynamic subtest: pipe-A
[155.185172] Dynamic subtest pipe-A: SKIP (0.018s)
[155.194612] Starting dynamic subtest: pipe-B
[155.219235] Dynamic subtest pipe-B: SKIP (0.034s)
[155.230224] Starting dynamic subtest: pipe-C
[155.253456] Dynamic subtest pipe-C: SKIP (0.034s)
[155.262347] Starting dynamic subtest: pipe-D
[155.281771] Dynamic subtest pipe-D: SKIP (0.030s)
[155.284867] Subtest planes-downscale-factor-0-5-upscale-20x20: SKIP (0.117s)
[155.427369] [021/130] (865s left) kms_plane_cursor (primary)
[155.520655] Starting subtest: primary
[155.524266] Starting dynamic subtest: pipe-A-eDP-1-size-64
[158.124479] Dynamic subtest pipe-A-eDP-1-size-64: SUCCESS (2.612s)
[158.148601] Starting dynamic subtest: pipe-A-eDP-1-size-128
[160.786598] Dynamic subtest pipe-A-eDP-1-size-128: SUCCESS (2.651s)
[160.810600] Starting dynamic subtest: pipe-A-eDP-1-size-256
[163.384679] Dynamic subtest pipe-A-eDP-1-size-256: SUCCESS (2.583s)
[163.709620] Starting dynamic subtest: pipe-B-eDP-1-size-64
[166.962413] Dynamic subtest pipe-B-eDP-1-size-64: SUCCESS (3.275s)
[166.988845] Starting dynamic subtest: pipe-B-eDP-1-size-128
[169.528108] Dynamic subtest pipe-B-eDP-1-size-128: SUCCESS (2.550s)
[169.553274] Starting dynamic subtest: pipe-B-eDP-1-size-256
[172.127165] Dynamic subtest pipe-B-eDP-1-size-256: SUCCESS (2.583s)
[172.452364] Starting dynamic subtest: pipe-C-eDP-1-size-64
[175.317376] Dynamic subtest pipe-C-eDP-1-size-64: SUCCESS (2.878s)
[175.344198] Starting dynamic subtest: pipe-C-eDP-1-size-128
[177.539068] Dynamic subtest pipe-C-eDP-1-size-128: SUCCESS (2.203s)
[177.565435] Starting dynamic subtest: pipe-C-eDP-1-size-256
[179.737572] Dynamic subtest pipe-C-eDP-1-size-256: SUCCESS (2.180s)
[180.054223] Starting dynamic subtest: pipe-D-eDP-1-size-64
[182.979662] Dynamic subtest pipe-D-eDP-1-size-64: SUCCESS (2.937s)
[183.006638] Starting dynamic subtest: pipe-D-eDP-1-size-128
[185.190318] Dynamic subtest pipe-D-eDP-1-size-128: SUCCESS (2.191s)
[185.217371] Starting dynamic subtest: pipe-D-eDP-1-size-256
[187.422624] Dynamic subtest pipe-D-eDP-1-size-256: SUCCESS (2.215s)
[187.732132] Subtest primary: SUCCESS (32.242s)
[188.592279] [022/130] (832s left) gem_softpin (allocator-basic-reserve)
[188.663805] Starting subtest: allocator-basic-reserve
[188.731313] Subtest allocator-basic-reserve: SUCCESS (0.067s)
[188.840293] [023/130] (831s left) kms_flip (plain-flip-ts-check)
[188.941814] Starting subtest: plain-flip-ts-check
[188.946620] Starting dynamic subtest: A-eDP1
[197.894015] Dynamic subtest A-eDP1: SUCCESS (8.953s)
[197.906570] Starting dynamic subtest: B-eDP1
[206.741803] Dynamic subtest B-eDP1: SUCCESS (8.849s)
[206.753099] Starting dynamic subtest: C-eDP1
[215.650286] Dynamic subtest C-eDP1: SUCCESS (8.911s)
[215.660931] Starting dynamic subtest: D-eDP1
[224.478324] Dynamic subtest D-eDP1: SUCCESS (8.832s)
[224.483495] Subtest plain-flip-ts-check: SUCCESS (35.560s)
[225.648047] [024/130] (795s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-mmap-gtt)
[225.749802] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-mmap-gtt
[225.754067] Subtest fbc-1p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[225.840159] [025/130] (795s left) gen9_exec_parse (valid-registers)
[225.910449] Subtest valid-registers: SKIP (0.000s)
[225.976311] [026/130] (794s left) kms_atomic_transition (modeset-transition)
[226.062111] Starting subtest: modeset-transition
[226.063971] Starting dynamic subtest: 1x-outputs
[236.886915] Dynamic subtest 1x-outputs: SUCCESS (10.829s)
[236.889342] Subtest modeset-transition: SUCCESS (10.831s)
[237.753730] [027/130] (783s left) sw_sync (timeline_closed)
[237.793229] Starting subtest: timeline_closed
[237.795431] Subtest timeline_closed: SUCCESS (0.000s)
[237.852624] [028/130] (783s left) syncobj_eventfd (timeline-wait-signaled)
[237.902307] Starting subtest: timeline-wait-signaled
[237.904110] Subtest timeline-wait-signaled: SUCCESS (0.000s)
[237.996463] [029/130] (783s left) kms_lease (lease-revoke)
[238.088932] Starting subtest: lease-revoke
[238.091238] Starting dynamic subtest: pipe-A-eDP-1
[238.121170] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.031s)
[238.131338] Starting dynamic subtest: pipe-B-eDP-1
[238.147799] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.026s)
[238.158060] Starting dynamic subtest: pipe-C-eDP-1
[238.176677] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.027s)
[238.186380] Starting dynamic subtest: pipe-D-eDP-1
[238.204427] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.027s)
[238.206553] Subtest lease-revoke: SUCCESS (0.118s)
[238.329364] [030/130] (782s left) perf_pmu (all-busy-check-all)
[238.369996] Starting subtest: all-busy-check-all
[240.248851] Subtest all-busy-check-all: SUCCESS (1.876s)
[240.357333] [031/130] (780s left) kms_vblank (wait-forked-busy-hang)
[240.448197] Starting subtest: wait-forked-busy-hang
[240.450428] Starting dynamic subtest: pipe-A-eDP-1
[266.997535] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.543s)
[267.012937] Starting dynamic subtest: pipe-D-eDP-1
[281.975775] Dynamic subtest pipe-D-eDP-1: SUCCESS (14.975s)
[281.978079] Subtest wait-forked-busy-hang: SUCCESS (41.522s)
[282.822065] [032/130] (738s left) gem_exec_capture (pi)
[282.882030] Starting subtest: pi
[282.884492] Starting dynamic subtest: rcs0
[286.923911] Dynamic subtest rcs0: SUCCESS (4.045s)
[286.934157] Starting dynamic subtest: bcs0
[290.858677] Dynamic subtest bcs0: SUCCESS (3.935s)
[290.868363] Starting dynamic subtest: vcs0
[294.772093] Dynamic subtest vcs0: SUCCESS (3.912s)
[294.785897] Starting dynamic subtest: vcs1
[298.644638] Dynamic subtest vcs1: SUCCESS (3.872s)
[298.656987] Starting dynamic subtest: vecs0
[302.559666] Dynamic subtest vecs0: SUCCESS (3.915s)
[302.569220] Starting dynamic subtest: ccs0
[306.455422] Dynamic subtest ccs0: SUCCESS (3.894s)
[306.458239] Subtest pi: SUCCESS (23.581s)
[306.534521] [033/130] (714s left) kms_psr2_sf (pr-primary-plane-update-sf-dmg-area)
[306.702723] Starting subtest: pr-primary-plane-update-sf-dmg-area
[306.707114] Subtest pr-primary-plane-update-sf-dmg-area: SKIP (0.000s)
[306.782778] [034/130] (714s left) kms_properties (get_properties-sanity-atomic)
[306.865102] Starting subtest: get_properties-sanity-atomic
[306.867412] Subtest get_properties-sanity-atomic: SUCCESS (0.002s)
[306.940341] [035/130] (714s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-render)
[307.036477] Starting subtest: psr-1p-primscrn-pri-indfb-draw-render
[314.313985] Subtest psr-1p-primscrn-pri-indfb-draw-render: SUCCESS (7.284s)
[314.432601] [036/130] (706s left) gem_lmem_swapping (parallel-random)
[314.484293] Subtest parallel-random: SKIP (0.000s)
[314.529778] [037/130] (706s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-mmap-cpu)
[314.625486] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-mmap-cpu
[321.182899] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-mmap-cpu: SUCCESS (6.563s)
[321.309023] [038/130] (700s left) kms_feature_discovery (display-4x)
[321.405464] Starting subtest: display-4x
[321.409562] Subtest display-4x: SKIP (0.000s)
[321.480009] [039/130] (700s left) kms_psr (fbc-psr-cursor-render)
[321.573051] Starting subtest: fbc-psr-cursor-render
[321.575340] Starting dynamic subtest: eDP-1
[321.579438] Dynamic subtest eDP-1: SKIP (0.000s)
[321.583690] Subtest fbc-psr-cursor-render: SKIP (0.001s)
[321.661610] [040/130] (699s left) gem_madvise (dontneed-before-pwrite)
[321.700477] Starting subtest: dontneed-before-pwrite
[321.719196] Subtest dontneed-before-pwrite: SKIP (0.016s)
[321.777434] [041/130] (699s left) gem_render_copy (y-tiled-to-vebox-y-tiled)
[321.837764] Starting subtest: y-tiled-to-vebox-y-tiled
[321.842369] Subtest y-tiled-to-vebox-y-tiled: SKIP (0.000s)
[322.022031] [042/130] (699s left) kms_big_fb (yf-tiled-64bpp-rotate-270)
[322.123801] Starting subtest: yf-tiled-64bpp-rotate-270
[322.128115] Subtest yf-tiled-64bpp-rotate-270: SKIP (0.000s)
[322.218640] [043/130] (699s left) kms_frontbuffer_tracking (psr-2p-primscrn-shrfb-plflip-blt)
[322.308744] Starting subtest: psr-2p-primscrn-shrfb-plflip-blt
[322.313212] Subtest psr-2p-primscrn-shrfb-plflip-blt: SKIP (0.000s)
[322.411114] [044/130] (699s left) kms_cursor_crc (cursor-random-512x170)
[322.684913] Starting subtest: cursor-random-512x170
[322.689399] Subtest cursor-random-512x170: SKIP (0.001s)
[322.810180] [045/130] (698s left) kms_cursor_legacy (2x-long-cursor-vs-flip-atomic)
[322.926396] Starting subtest: 2x-long-cursor-vs-flip-atomic
[322.930767] Subtest 2x-long-cursor-vs-flip-atomic: SKIP (0.001s)
[323.084358] [046/130] (698s left) kms_cursor_legacy (long-nonblocking-modeset-vs-cursor-atomic)
[323.201177] Starting subtest: long-nonblocking-modeset-vs-cursor-atomic
[340.615980] Subtest long-nonblocking-modeset-vs-cursor-atomic: SUCCESS (17.419s)
[341.401610] [047/130] (680s left) kms_sequence (queue-busy)
[341.510374] Starting subtest: queue-busy
[341.512763] Starting dynamic subtest: pipe-A-eDP-1
[343.456770] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.946s)
[343.467746] Starting dynamic subtest: pipe-B-eDP-1
[346.034758] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.578s)
[346.047077] Starting dynamic subtest: pipe-C-eDP-1
[348.632197] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.597s)
[348.642868] Starting dynamic subtest: pipe-D-eDP-1
[351.168802] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.538s)
[351.171089] Subtest queue-busy: SUCCESS (9.664s)
[351.975132] [048/130] (669s left) gem_mmap (short-mmap)
[352.034282] Subtest short-mmap: SKIP (0.000s)
[352.102431] [049/130] (669s left) gem_mmap_gtt (zero-extend)
[352.173363] Subtest zero-extend: SKIP (0.000s)
[352.237593] [050/130] (669s left) i915_pm_rc6_residency (rc6-accuracy)
[352.297590] Starting subtest: rc6-accuracy
[352.299574] Starting dynamic subtest: gt0
[355.469037] Dynamic subtest gt0: SUCCESS (3.169s)
[355.479007] Starting dynamic subtest: gt1
[358.640074] Dynamic subtest gt1: SUCCESS (3.169s)
[358.642650] Subtest rc6-accuracy: SUCCESS (6.344s)
[358.714243] [051/130] (663s left) syncobj_wait (multi-wait-submitted-signaled)
[358.772331] Starting subtest: multi-wait-submitted-signaled
[358.774492] Subtest multi-wait-submitted-signaled: SUCCESS (0.000s)
[358.876499] [052/130] (663s left) kms_big_fb (4-tiled-64bpp-rotate-180)
[358.977718] Starting subtest: 4-tiled-64bpp-rotate-180
[360.556343] Subtest 4-tiled-64bpp-rotate-180: SUCCESS (1.580s)
[360.726096] [053/130] (661s left) kms_flip (dpms-vs-vblank-race)
[360.836244] Starting subtest: dpms-vs-vblank-race
[360.838254] Starting dynamic subtest: A-eDP1
[365.776605] Dynamic subtest A-eDP1: SUCCESS (4.940s)
[365.787871] Starting dynamic subtest: B-eDP1
[370.407357] Dynamic subtest B-eDP1: SUCCESS (4.627s)
[370.420439] Starting dynamic subtest: C-eDP1
[373.912093] Dynamic subtest C-eDP1: SUCCESS (3.503s)
[373.932726] Starting dynamic subtest: D-eDP1
[377.509472] Dynamic subtest D-eDP1: SUCCESS (3.594s)
[377.515745] Subtest dpms-vs-vblank-race: SUCCESS (16.675s)
[378.384443] [054/130] (643s left) kms_plane (pixel-format-y-tiled-ccs-modifier-source-clamping)
[378.479996] Starting subtest: pixel-format-y-tiled-ccs-modifier-source-clamping
[378.484276] Subtest pixel-format-y-tiled-ccs-modifier-source-clamping: SKIP (0.000s)
[378.555362] [055/130] (643s left) gem_eio (in-flight-external)
[378.782427] Starting subtest: in-flight-external
[380.284732] Subtest in-flight-external: SUCCESS (1.500s)
[380.421382] [056/130] (641s left) vgem_basic (dmabuf-mmap)
[380.472182] Starting subtest: dmabuf-mmap
[380.501284] Subtest dmabuf-mmap: SUCCESS (0.031s)
[380.564362] [057/130] (641s left) gen9_exec_parse (bb-secure)
[380.625331] Subtest bb-secure: SKIP (0.000s)
[380.694914] [058/130] (641s left) kms_content_protection (uevent)
[380.832024] Starting subtest: uevent
[380.836970] Subtest uevent: SKIP (0.000s)
[380.947829] [059/130] (641s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-32bpp-4tile-upscaling)
[381.026319] Starting subtest: flip-64bpp-4tile-to-32bpp-4tile-upscaling
[381.028441] Starting dynamic subtest: pipe-A-default-mode
[383.749581] Dynamic subtest pipe-A-default-mode: SUCCESS (2.723s)
[383.751829] Subtest flip-64bpp-4tile-to-32bpp-4tile-upscaling: SUCCESS (2.725s)
[384.585299] [060/130] (637s left) kms_psr (psr-dpms)
[384.684997] Starting subtest: psr-dpms
[384.687372] Starting dynamic subtest: eDP-1
[387.609558] Dynamic subtest eDP-1: SUCCESS (2.922s)
[387.611824] Subtest psr-dpms: SUCCESS (2.924s)
[388.474287] [061/130] (633s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-pwrite)
[388.585429] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-pwrite
[388.589444] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[388.691080] [062/130] (633s left) gem_busy (busy)
[388.753372] Starting subtest: busy
[388.755673] Starting dynamic subtest: all-engines
[388.812052] Dynamic subtest all-engines: SUCCESS (0.059s)
[388.822750] Starting dynamic subtest: rcs0
[390.207450] Dynamic subtest rcs0: SUCCESS (1.393s)
[390.219383] Starting dynamic subtest: bcs0
[390.266157] Dynamic subtest bcs0: SUCCESS (0.056s)
[390.277181] Starting dynamic subtest: vcs0
[390.305004] Dynamic subtest vcs0: SUCCESS (0.039s)
[390.314201] Starting dynamic subtest: vcs1
[392.254155] Dynamic subtest vcs1: SUCCESS (1.943s)
[392.267731] Starting dynamic subtest: vecs0
[394.237451] Dynamic subtest vecs0: SUCCESS (1.982s)
[394.249036] Starting dynamic subtest: ccs0
[396.241698] Dynamic subtest ccs0: SUCCESS (1.980s)
[396.243908] Subtest busy: SUCCESS (7.462s)
[396.566647] [063/130] (625s left) gem_create (create-ext-placement-each)
[396.740910] Starting subtest: create-ext-placement-each
[396.743323] Subtest create-ext-placement-each: SUCCESS (0.000s)
[396.865748] [064/130] (625s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-180-hflip)
[396.963353] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-180-hflip
[398.067733] Subtest x-tiled-max-hw-stride-32bpp-rotate-180-hflip: SUCCESS (1.104s)
[398.179226] [065/130] (624s left) gem_sync (basic-store-each)
[398.246995] Starting subtest: basic-store-each
[400.645182] Subtest basic-store-each: SUCCESS (2.402s)
[400.830960] [066/130] (621s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-onoff)
[400.931465] Starting subtest: fbc-2p-primscrn-cur-indfb-onoff
[400.935498] Subtest fbc-2p-primscrn-cur-indfb-onoff: SKIP (0.000s)
[401.020253] [067/130] (621s left) gem_ctx_shared (q-smoketest)
[401.083255] Starting subtest: Q-smoketest
[401.085673] Starting dynamic subtest: rcs0
[406.642807] Dynamic subtest rcs0: SUCCESS (5.513s)
[406.660646] Starting dynamic subtest: bcs0
[412.154154] Dynamic subtest bcs0: SUCCESS (5.508s)
[412.166223] Starting dynamic subtest: vcs0
[417.637573] Dynamic subtest vcs0: SUCCESS (5.482s)
[417.650078] Starting dynamic subtest: vcs1
[423.130170] Dynamic subtest vcs1: SUCCESS (5.489s)
[423.145225] Starting dynamic subtest: vecs0
[428.617110] Dynamic subtest vecs0: SUCCESS (5.482s)
[428.628430] Starting dynamic subtest: ccs0
[434.143695] Dynamic subtest ccs0: SUCCESS (5.528s)
[434.145800] Subtest Q-smoketest: SUCCESS (33.010s)
[434.300414] [068/130] (588s left) gem_media_fill (media-fill)
[434.382628] Subtest media-fill: SKIP (0.000s)
[434.523662] [069/130] (588s left) gem_tiled_partial_pwrite_pread (reads)
[434.583072] Subtest reads: SKIP (0.000s)
[434.654742] [070/130] (588s left) device_reset (cold-reset-bound)
[434.715578] Starting subtest: cold-reset-bound
[434.719846] Subtest cold-reset-bound: SKIP (0.000s)
[434.806731] [071/130] (588s left) gem_exec_reloc (basic-range)
[434.865222] Subtest basic-range: SKIP (0.000s)
[434.935643] [072/130] (587s left) kms_plane_scaling (plane-scaler-with-clipping-clamping-modifiers)
[435.028990] Starting subtest: plane-scaler-with-clipping-clamping-modifiers
[435.031315] Starting dynamic subtest: pipe-A
[435.367336] Dynamic subtest pipe-A: SUCCESS (0.340s)
[435.377161] Starting dynamic subtest: pipe-B
[436.755084] Dynamic subtest pipe-B: SUCCESS (1.386s)
[436.766798] Starting dynamic subtest: pipe-C
[438.193980] Dynamic subtest pipe-C: SUCCESS (1.438s)
[438.203620] Starting dynamic subtest: pipe-D
[439.669401] Dynamic subtest pipe-D: SUCCESS (1.475s)
[439.671738] Subtest plane-scaler-with-clipping-clamping-modifiers: SUCCESS (4.643s)
[440.806736] [073/130] (582s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-render)
[440.906008] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-render
[447.782516] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-render: SUCCESS (6.878s)
[447.908101] [074/130] (575s left) kms_ccs (crc-primary-rotation-180-4-tiled-mtl-rc-ccs-cc)
[448.004150] Starting subtest: crc-primary-rotation-180-4-tiled-mtl-rc-ccs-cc
[448.006312] Starting dynamic subtest: pipe-A-eDP-1
[448.829968] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.820s)
[448.840170] Starting dynamic subtest: pipe-B-eDP-1
[450.411493] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.578s)
[450.424857] Starting dynamic subtest: pipe-C-eDP-1
[451.987498] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.574s)
[451.998610] Starting dynamic subtest: pipe-D-eDP-1
[453.606596] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.618s)
[453.608899] Subtest crc-primary-rotation-180-4-tiled-mtl-rc-ccs-cc: SUCCESS (5.595s)
[454.790301] [075/130] (568s left) syncobj_timeline (invalid-multi-wait-unsubmitted)
[454.851376] Starting subtest: invalid-multi-wait-unsubmitted
[454.853715] Subtest invalid-multi-wait-unsubmitted: SUCCESS (0.000s)
[454.953333] [076/130] (568s left) kms_psr (pr-dpms)
[455.036375] Starting subtest: pr-dpms
[455.040697] Subtest pr-dpms: SKIP (0.000s)
[455.110725] [077/130] (567s left) perf (rc6-disable)
[455.257101] Starting subtest: rc6-disable
[455.430013] Subtest rc6-disable: SUCCESS (0.172s)
[455.475631] [078/130] (567s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip)
[455.591871] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip
[456.393601] Subtest 4-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip: SUCCESS (0.803s)
[456.567573] [079/130] (566s left) prime_busy (after-wait)
[456.629681] Starting subtest: after-wait
[456.635642] Starting dynamic subtest: rcs0
[456.665339] Dynamic subtest rcs0: SUCCESS (0.033s)
[456.677109] Starting dynamic subtest: bcs0
[456.710761] Dynamic subtest bcs0: SUCCESS (0.045s)
[456.720928] Starting dynamic subtest: vcs0
[456.751560] Dynamic subtest vcs0: SUCCESS (0.040s)
[456.762972] Starting dynamic subtest: vcs1
[456.792801] Dynamic subtest vcs1: SUCCESS (0.040s)
[456.803279] Starting dynamic subtest: vecs0
[456.833429] Dynamic subtest vecs0: SUCCESS (0.040s)
[456.843260] Starting dynamic subtest: ccs0
[456.874902] Dynamic subtest ccs0: SUCCESS (0.040s)
[456.983420] Subtest after-wait: SUCCESS (0.352s)
[457.062573] [080/130] (566s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-0-async-flip)
[457.160630] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-0-async-flip
[457.164935] Subtest y-tiled-max-hw-stride-32bpp-rotate-0-async-flip: SKIP (0.000s)
[457.265083] [081/130] (565s left) gem_mmap_wc (write-cpu-read-wc-unflushed)
[457.332878] Subtest write-cpu-read-wc-unflushed: SKIP (0.000s)
[457.394010] [082/130] (565s left) gem_exec_balancer (bonded-dual)
[457.449459] Starting subtest: bonded-dual
[457.453998] Subtest bonded-dual: SKIP (0.000s)
[457.746523] [083/130] (565s left) kms_ccs (bad-aux-stride-4-tiled-mtl-rc-ccs)
[457.847974] Starting subtest: bad-aux-stride-4-tiled-mtl-rc-ccs
[457.850216] Starting dynamic subtest: pipe-A-eDP-1
[457.870221] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[457.881001] Starting dynamic subtest: pipe-B-eDP-1
[457.899425] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[457.908999] Starting dynamic subtest: pipe-C-eDP-1
[457.927512] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[457.938255] Starting dynamic subtest: pipe-D-eDP-1
[457.956582] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[457.958412] Subtest bad-aux-stride-4-tiled-mtl-rc-ccs: SUCCESS (0.007s)
[460.148074] [084/130] (563s left) gem_linear_blits (basic)
[460.391264] Starting subtest: basic
[460.399514] Subtest basic: SUCCESS (0.009s)
[460.534444] [085/130] (562s left) kms_cursor_crc (cursor-sliding-256x256)
[460.804923] Starting subtest: cursor-sliding-256x256
[460.810215] Starting dynamic subtest: pipe-A-eDP-1
[464.111764] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.303s)
[464.145354] Starting dynamic subtest: pipe-D-eDP-1
[468.023177] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.886s)
[468.025081] Subtest cursor-sliding-256x256: SUCCESS (7.216s)
[468.900987] [086/130] (554s left) api_intel_allocator (simple-allocator)
[468.961412] Starting subtest: simple-allocator
[468.963691] Starting dynamic subtest: basic
[468.965978] Dynamic subtest basic: SUCCESS (0.004s)
[468.980000] Starting dynamic subtest: parallel-one
[469.166713] Dynamic subtest parallel-one: SUCCESS (0.202s)
[469.176598] Starting dynamic subtest: print
[469.178816] Dynamic subtest print: SUCCESS (0.000s)
[469.188188] Starting dynamic subtest: reuse
[469.190407] Dynamic subtest reuse: SUCCESS (0.000s)
[469.199362] Starting dynamic subtest: reserve
[469.201540] Dynamic subtest reserve: SUCCESS (0.000s)
[469.210630] Starting dynamic subtest: fork-reopen-allocator
[469.212812] Dynamic subtest fork-reopen-allocator: SUCCESS (0.013s)
[469.214985] Subtest simple-allocator: SUCCESS (0.226s)
[469.303630] [087/130] (554s left) kms_psr (fbc-pr-primary-page-flip)
[469.400180] Starting subtest: fbc-pr-primary-page-flip
[469.404429] Subtest fbc-pr-primary-page-flip: SKIP (0.000s)
[469.475457] [088/130] (554s left) kms_joiner (basic-force-big-joiner)
[469.566907] Starting subtest: basic-force-big-joiner
[469.570624] Subtest basic-force-big-joiner: SKIP (0.000s)
[469.631839] [089/130] (553s left) gem_partial_pwrite_pread (reads-display)
[469.693171] Subtest reads-display: SKIP (0.000s)
[469.770410] [090/130] (553s left) kms_color (ctm-0-25)
[469.873260] Starting subtest: ctm-0-25
[469.875223] Starting dynamic subtest: pipe-A-eDP-1
[473.402269] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.530s)
[473.412499] Starting dynamic subtest: pipe-B-eDP-1
[477.616894] Dynamic subtest pipe-B-eDP-1: SUCCESS (4.214s)
[477.627300] Starting dynamic subtest: pipe-C-eDP-1
[481.672739] Dynamic subtest pipe-C-eDP-1: SUCCESS (4.055s)
[481.683185] Starting dynamic subtest: pipe-D-eDP-1
[485.661233] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.989s)
[485.663365] Subtest ctm-0-25: SUCCESS (15.792s)
[486.486590] [091/130] (537s left) kms_pm_lpsp (kms-lpsp)
[487.603631] Starting subtest: kms-lpsp
[487.605975] Starting dynamic subtest: pipe-A-eDP-1
[487.749296] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.149s)
[488.044786] Subtest kms-lpsp: SUCCESS (0.445s)
[488.913427] [092/130] (534s left) gem_tiled_partial_pwrite_pread (writes-after-reads)
[488.967196] Subtest writes-after-reads: SKIP (0.000s)
[489.052072] [093/130] (534s left) kms_frontbuffer_tracking (psr-rgb101010-draw-blt)
[489.152346] Starting subtest: psr-rgb101010-draw-blt
[496.462016] Subtest psr-rgb101010-draw-blt: SUCCESS (7.313s)
[496.600112] [094/130] (527s left) kms_prop_blob (blob-prop-core)
[496.656859] Starting subtest: blob-prop-core
[496.659101] Subtest blob-prop-core: SUCCESS (0.000s)
[496.748369] [095/130] (527s left) syncobj_timeline (invalid-multi-wait-all-unsubmitted-submitted)
[496.821008] Starting subtest: invalid-multi-wait-all-unsubmitted-submitted
[496.823446] Subtest invalid-multi-wait-all-unsubmitted-submitted: SUCCESS (0.000s)
[496.932964] [096/130] (526s left) kms_ccs (bad-rotation-90-4-tiled-mtl-rc-ccs)
[497.027107] Starting subtest: bad-rotation-90-4-tiled-mtl-rc-ccs
[497.029033] Starting dynamic subtest: pipe-A-eDP-1
[497.165433] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.129s)
[497.179064] Starting dynamic subtest: pipe-B-eDP-1
[497.198978] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[497.208524] Starting dynamic subtest: pipe-C-eDP-1
[497.228100] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.002s)
[497.237548] Starting dynamic subtest: pipe-D-eDP-1
[497.256833] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.002s)
[497.259108] Subtest bad-rotation-90-4-tiled-mtl-rc-ccs: SUCCESS (0.139s)
[499.431643] [097/130] (524s left) kms_frontbuffer_tracking (fbcpsr-1p-indfb-fliptrack-mmap-gtt)
[499.557077] Starting subtest: fbcpsr-1p-indfb-fliptrack-mmap-gtt
[499.561181] Subtest fbcpsr-1p-indfb-fliptrack-mmap-gtt: SKIP (0.000s)
[499.666254] [098/130] (524s left) kms_getfb (getfb-handle-valid)
[499.765309] Starting subtest: getfb-handle-valid
[499.767450] Subtest getfb-handle-valid: SUCCESS (0.000s)
[499.859969] [099/130] (524s left) gem_exec_reloc (basic-wc-active)
[499.930674] Subtest basic-wc-active: SKIP (0.000s)
[500.008425] [100/130] (524s left) gem_exec_params (rel-constants-invalid-rel-gen5)
[500.069968] Starting subtest: rel-constants-invalid-rel-gen5
[500.072350] Subtest rel-constants-invalid-rel-gen5: SUCCESS (0.000s)
[500.171475] [101/130] (523s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-onoff)
[500.272385] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-onoff
[500.276199] Subtest fbcpsr-2p-scndscrn-cur-indfb-onoff: SKIP (0.000s)
[500.355107] [102/130] (523s left) kms_chamelium_hpd (hdmi-hpd-after-suspend)
[500.730259] Subtest hdmi-hpd-after-suspend: SKIP (0.000s)
[501.537552] [103/130] (522s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-mmap-gtt)
[501.651971] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-mmap-gtt
[501.656299] Subtest psr-2p-scndscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[501.777905] [104/130] (522s left) kms_pipe_stress (stress-xrgb8888-yftiled)
[501.877245] Starting subtest: stress-xrgb8888-yftiled
[501.881350] Subtest stress-xrgb8888-yftiled: SKIP (0.000s)
[501.963682] [105/130] (522s left) gem_render_copy (yf-tiled-ccs-to-yf-tiled)
[502.034515] Starting subtest: yf-tiled-ccs-to-yf-tiled
[502.038707] Subtest yf-tiled-ccs-to-yf-tiled: SKIP (0.000s)
[502.220590] [106/130] (522s left) syncobj_wait (wait-zero-handles)
[502.274702] Starting subtest: wait-zero-handles
[502.276605] Subtest wait-zero-handles: SUCCESS (0.000s)
[502.367454] [107/130] (521s left) kms_chamelium_edid (hdmi-edid-stress-resolution-non-4k)
[502.752179] Subtest hdmi-edid-stress-resolution-non-4k: SKIP (0.000s)
[503.574364] [108/130] (520s left) tools_test (sysfs_l3_parity)
[503.626193] Starting subtest: sysfs_l3_parity
[503.703102] Subtest sysfs_l3_parity: SKIP (0.087s)
[503.763739] [109/130] (520s left) core_getclient (basic)
[503.834958] Starting subtest: basic
[503.837388] Subtest basic: SUCCESS (0.000s)
[503.955355] [110/130] (520s left) i915_drm_fdinfo (virtual-busy-hang-all)
[504.001689] Starting subtest: virtual-busy-hang-all
[504.005738] Subtest virtual-busy-hang-all: SKIP (0.000s)
[504.070936] [111/130] (520s left) gem_ctx_param (root-set)
[504.130148] Starting subtest: root-set
[504.132565] Subtest root-set: SUCCESS (0.001s)
[504.232407] [112/130] (520s left) gem_exec_reloc (basic-write-cpu-active)
[504.282451] Subtest basic-write-cpu-active: SKIP (0.000s)
[504.355353] [113/130] (520s left) kms_flip_scaled_crc (flip-32bpp-yftile-to-64bpp-yftile-downscaling)
[504.440475] Starting subtest: flip-32bpp-yftile-to-64bpp-yftile-downscaling
[504.444645] Subtest flip-32bpp-yftile-to-64bpp-yftile-downscaling: SKIP (0.000s)
[504.517032] [114/130] (520s left) gem_ctx_persistence (legacy-engines-mixed)
[504.573266] Starting subtest: legacy-engines-mixed
[504.575211] Starting dynamic subtest: render
[504.621274] Dynamic subtest render: SUCCESS (0.048s)
[504.633014] Starting dynamic subtest: bsd1
[504.686392] Dynamic subtest bsd1: SUCCESS (0.064s)
[504.698256] Starting dynamic subtest: bsd2
[504.724323] Dynamic subtest bsd2: SUCCESS (0.036s)
[504.734208] Starting dynamic subtest: blt
[504.768423] Dynamic subtest blt: SUCCESS (0.043s)
[504.781350] Starting dynamic subtest: vebox
[504.813246] Dynamic subtest vebox: SUCCESS (0.042s)
[504.815202] Subtest legacy-engines-mixed: SUCCESS (0.241s)
[504.891274] [115/130] (519s left) syncobj_timeline (multi-wait-for-submit-available-unsubmitted-signaled)
[504.940725] Starting subtest: multi-wait-for-submit-available-unsubmitted-signaled
[504.942686] Subtest multi-wait-for-submit-available-unsubmitted-signaled: SUCCESS (0.000s)
[505.027943] [116/130] (519s left) kms_rotation_crc (bad-pixel-format)
[505.114754] Starting subtest: bad-pixel-format
[505.118341] Subtest bad-pixel-format: SKIP (0.001s)
[505.204528] [117/130] (519s left) gem_mmap_gtt (medium-copy)
[505.266549] Subtest medium-copy: SKIP (0.000s)
[505.321675] [118/130] (519s left) gem_exec_schedule (noreorder-corked)
[505.512906] Starting subtest: noreorder-corked
[505.515705] Starting dynamic subtest: rcs0
[506.643508] Dynamic subtest rcs0: SUCCESS (1.132s)
[506.655258] Starting dynamic subtest: vcs0
[508.188901] Dynamic subtest vcs0: SUCCESS (1.542s)
[508.200477] Starting dynamic subtest: vcs1
[510.238008] Dynamic subtest vcs1: SUCCESS (2.047s)
[510.250924] Starting dynamic subtest: vecs0
[512.236791] Dynamic subtest vecs0: SUCCESS (1.997s)
[512.249952] Starting dynamic subtest: ccs0
[513.385112] Dynamic subtest ccs0: SUCCESS (1.148s)
[513.387917] Subtest noreorder-corked: SUCCESS (7.876s)
[513.572240] [119/130] (511s left) gem_userptr_blits (probe)
[513.661292] Starting subtest: probe
[513.735551] Subtest probe: SUCCESS (0.074s)
[513.845217] [120/130] (511s left) kms_addfb_basic (basic-x-tiled-legacy)
[513.907609] Starting subtest: basic-x-tiled-legacy
[513.911692] Subtest basic-x-tiled-legacy: SKIP (0.000s)
[514.073508] [121/130] (510s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-render)
[514.173951] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-render
[521.456276] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-render: SUCCESS (7.286s)
[521.604156] [122/130] (503s left) kms_chamelium_audio (hdmi-audio-edid)
[521.990538] Subtest hdmi-audio-edid: SKIP (0.000s)
[522.764879] [123/130] (502s left) kms_big_fb (x-tiled-64bpp-rotate-0)
[522.865256] Starting subtest: x-tiled-64bpp-rotate-0
[524.476985] Subtest x-tiled-64bpp-rotate-0: SUCCESS (1.612s)
[524.631398] [124/130] (500s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-mmap-cpu)
[524.724130] Starting subtest: psr-1p-primscrn-spr-indfb-draw-mmap-cpu
[531.278044] Subtest psr-1p-primscrn-spr-indfb-draw-mmap-cpu: SUCCESS (6.559s)
[531.433192] [125/130] (493s left) gem_exec_store (cachelines)
[531.525037] Starting subtest: cachelines
[531.527425] Starting dynamic subtest: rcs0
[531.594057] Dynamic subtest rcs0: SUCCESS (0.071s)
[531.608577] Starting dynamic subtest: bcs0
[531.647959] Dynamic subtest bcs0: SUCCESS (0.052s)
[531.660354] Starting dynamic subtest: vcs0
[531.708525] Dynamic subtest vcs0: SUCCESS (0.059s)
[531.720886] Starting dynamic subtest: vcs1
[531.767347] Dynamic subtest vcs1: SUCCESS (0.057s)
[531.779266] Starting dynamic subtest: vecs0
[531.823450] Dynamic subtest vecs0: SUCCESS (0.054s)
[531.836922] Starting dynamic subtest: ccs0
[531.878984] Dynamic subtest ccs0: SUCCESS (0.054s)
[531.881605] Subtest cachelines: SUCCESS (0.357s)
[532.076869] [126/130] (493s left) kms_psr2_sf (psr2-primary-plane-update-sf-dmg-area)
[532.193369] Starting subtest: psr2-primary-plane-update-sf-dmg-area
[532.195617] Starting dynamic subtest: pipe-A-eDP-1
[538.092781] Dynamic subtest pipe-A-eDP-1: SUCCESS (5.903s)
[538.103891] Starting dynamic subtest: pipe-B-eDP-1
[544.743760] Dynamic subtest pipe-B-eDP-1: SUCCESS (6.651s)
[544.746047] Subtest psr2-primary-plane-update-sf-dmg-area: SUCCESS (12.556s)
[545.617937] [127/130] (479s left) kms_psr (psr2-sprite-mmap-gtt)
[545.718323] Starting subtest: psr2-sprite-mmap-gtt
[545.720558] Starting dynamic subtest: eDP-1
[547.131378] Dynamic subtest eDP-1: SKIP (1.410s)
[547.135968] Subtest psr2-sprite-mmap-gtt: SKIP (1.412s)
[547.298280] [128/130] (477s left) gem_exec_schedule (thriceslice)
[547.367623] Starting subtest: thriceslice
[547.369893] Starting dynamic subtest: rcs0
[547.387182] Dynamic subtest rcs0: SUCCESS (0.030s)
[547.401442] Starting dynamic subtest: bcs0
[547.415860] Dynamic subtest bcs0: SUCCESS (0.028s)
[547.425664] Starting dynamic subtest: vcs0
[547.447326] Dynamic subtest vcs0: SUCCESS (0.030s)
[547.465291] Starting dynamic subtest: vcs1
[547.499831] Dynamic subtest vcs1: SUCCESS (0.050s)
[547.512724] Starting dynamic subtest: vecs0
[547.529649] Dynamic subtest vecs0: SUCCESS (0.028s)
[547.539527] Starting dynamic subtest: ccs0
[547.561143] Dynamic subtest ccs0: SUCCESS (0.030s)
[547.563484] Subtest thriceslice: SUCCESS (0.205s)
[549.281094] [129/130] (476s left) sw_sync (sync_busy)
[549.320678] Starting subtest: sync_busy
[549.322781] Subtest sync_busy: SUCCESS (0.002s)
[549.381069] [130/130] (475s left) kms_vrr (seamless-rr-switch-vrr)
[549.487984] Starting subtest: seamless-rr-switch-vrr
[549.494288] Subtest seamless-rr-switch-vrr: SKIP (0.000s)
[549.557417] Closing watchdogs
results: parsing output: 0/ for test: gem_exec_reloc
results: parsing output: 1/ for test: kms_ccs
results: parsing output: 2/ for test: kms_frontbuffer_tracking
results: parsing output: 3/ for test: gem_exec_params
results: parsing output: 4/ for test: gem_userptr_blits
results: parsing output: 5/ for test: kms_frontbuffer_tracking
results: parsing output: 6/ for test: kms_tv_load_detect
results: parsing output: 7/ for test: kms_ccs
results: parsing output: 8/ for test: gem_ctx_param
results: parsing output: 9/ for test: gem_exec_fence
results: parsing output: 10/ for test: gem_eio
results: parsing output: 11/ for test: kms_cursor_legacy
results: parsing output: 12/ for test: syncobj_timeline
results: parsing output: 13/ for test: i915_suspend
results: parsing output: 14/ for test: gem_exec_params
results: parsing output: 15/ for test: gem_pxp
results: parsing output: 16/ for test: kms_frontbuffer_tracking
results: parsing output: 17/ for test: perf_pmu
results: parsing output: 18/ for test: kms_cursor_crc
results: parsing output: 19/ for test: kms_plane_scaling
results: parsing output: 20/ for test: kms_plane_cursor
results: parsing output: 21/ for test: gem_softpin
results: parsing output: 22/ for test: kms_flip
results: parsing output: 23/ for test: kms_frontbuffer_tracking
results: parsing output: 24/ for test: gen9_exec_parse
results: parsing output: 25/ for test: kms_atomic_transition
results: parsing output: 26/ for test: sw_sync
results: parsing output: 27/ for test: syncobj_eventfd
results: parsing output: 28/ for test: kms_lease
results: parsing output: 29/ for test: perf_pmu
results: parsing output: 30/ for test: kms_vblank
results: parsing output: 31/ for test: gem_exec_capture
results: parsing output: 32/ for test: kms_psr2_sf
results: parsing output: 33/ for test: kms_properties
results: parsing output: 34/ for test: kms_frontbuffer_tracking
results: parsing output: 35/ for test: gem_lmem_swapping
results: parsing output: 36/ for test: kms_frontbuffer_tracking
results: parsing output: 37/ for test: kms_feature_discovery
results: parsing output: 38/ for test: kms_psr
results: parsing output: 39/ for test: gem_madvise
results: parsing output: 40/ for test: gem_render_copy
results: parsing output: 41/ for test: kms_big_fb
results: parsing output: 42/ for test: kms_frontbuffer_tracking
results: parsing output: 43/ for test: kms_cursor_crc
results: parsing output: 44/ for test: kms_cursor_legacy
results: parsing output: 45/ for test: kms_cursor_legacy
results: parsing output: 46/ for test: kms_sequence
results: parsing output: 47/ for test: gem_mmap
results: parsing output: 48/ for test: gem_mmap_gtt
results: parsing output: 49/ for test: i915_pm_rc6_residency
results: parsing output: 50/ for test: syncobj_wait
results: parsing output: 51/ for test: kms_big_fb
results: parsing output: 52/ for test: kms_flip
results: parsing output: 53/ for test: kms_plane
results: parsing output: 54/ for test: gem_eio
results: parsing output: 55/ for test: vgem_basic
results: parsing output: 56/ for test: gen9_exec_parse
results: parsing output: 57/ for test: kms_content_protection
results: parsing output: 58/ for test: kms_flip_scaled_crc
results: parsing output: 59/ for test: kms_psr
results: parsing output: 60/ for test: kms_frontbuffer_tracking
results: parsing output: 61/ for test: gem_busy
results: parsing output: 62/ for test: gem_create
results: parsing output: 63/ for test: kms_big_fb
results: parsing output: 64/ for test: gem_sync
results: parsing output: 65/ for test: kms_frontbuffer_tracking
results: parsing output: 66/ for test: gem_ctx_shared
results: parsing output: 67/ for test: gem_media_fill
results: parsing output: 68/ for test: gem_tiled_partial_pwrite_pread
results: parsing output: 69/ for test: device_reset
results: parsing output: 70/ for test: gem_exec_reloc
results: parsing output: 71/ for test: kms_plane_scaling
results: parsing output: 72/ for test: kms_frontbuffer_tracking
results: parsing output: 73/ for test: kms_ccs
results: parsing output: 74/ for test: syncobj_timeline
results: parsing output: 75/ for test: kms_psr
results: parsing output: 76/ for test: perf
results: parsing output: 77/ for test: kms_big_fb
results: parsing output: 78/ for test: prime_busy
results: parsing output: 79/ for test: kms_big_fb
results: parsing output: 80/ for test: gem_mmap_wc
results: parsing output: 81/ for test: gem_exec_balancer
results: parsing output: 82/ for test: kms_ccs
results: parsing output: 83/ for test: gem_linear_blits
results: parsing output: 84/ for test: kms_cursor_crc
results: parsing output: 85/ for test: api_intel_allocator
results: parsing output: 86/ for test: kms_psr
results: parsing output: 87/ for test: kms_joiner
results: parsing output: 88/ for test: gem_partial_pwrite_pread
results: parsing output: 89/ for test: kms_color
results: parsing output: 90/ for test: kms_pm_lpsp
results: parsing output: 91/ for test: gem_tiled_partial_pwrite_pread
results: parsing output: 92/ for test: kms_frontbuffer_tracking
results: parsing output: 93/ for test: kms_prop_blob
results: parsing output: 94/ for test: syncobj_timeline
results: parsing output: 95/ for test: kms_ccs
results: parsing output: 96/ for test: kms_frontbuffer_tracking
results: parsing output: 97/ for test: kms_getfb
results: parsing output: 98/ for test: gem_exec_reloc
results: parsing output: 99/ for test: gem_exec_params
results: parsing output: 100/ for test: kms_frontbuffer_tracking
results: parsing output: 101/ for test: kms_chamelium_hpd
results: parsing output: 102/ for test: kms_frontbuffer_tracking
results: parsing output: 103/ for test: kms_pipe_stress
results: parsing output: 104/ for test: gem_render_copy
results: parsing output: 105/ for test: syncobj_wait
results: parsing output: 106/ for test: kms_chamelium_edid
results: parsing output: 107/ for test: tools_test
results: parsing output: 108/ for test: core_getclient
results: parsing output: 109/ for test: i915_drm_fdinfo
results: parsing output: 110/ for test: gem_ctx_param
results: parsing output: 111/ for test: gem_exec_reloc
results: parsing output: 112/ for test: kms_flip_scaled_crc
results: parsing output: 113/ for test: gem_ctx_persistence
results: parsing output: 114/ for test: syncobj_timeline
results: parsing output: 115/ for test: kms_rotation_crc
results: parsing output: 116/ for test: gem_mmap_gtt
results: parsing output: 117/ for test: gem_exec_schedule
results: parsing output: 118/ for test: gem_userptr_blits
results: parsing output: 119/ for test: kms_addfb_basic
results: parsing output: 120/ for test: kms_frontbuffer_tracking
results: parsing output: 121/ for test: kms_chamelium_audio
results: parsing output: 122/ for test: kms_big_fb
results: parsing output: 123/ for test: kms_frontbuffer_tracking
results: parsing output: 124/ for test: gem_exec_store
results: parsing output: 125/ for test: kms_psr2_sf
results: parsing output: 126/ for test: kms_psr
results: parsing output: 127/ for test: gem_exec_schedule
results: parsing output: 128/ for test: sw_sync
results: parsing output: 129/ for test: kms_vrr
Done.