[61.578968] Initializing watchdogs
[61.579180]   /dev/watchdog0
[61.592170] [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.596406] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[61.598888] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[61.602212] [001/134] (960s left) kms_pm_rpm (dpms-mode-unset-non-lpsp)
[63.179607] Starting subtest: dpms-mode-unset-non-lpsp
[64.326845] Subtest dpms-mode-unset-non-lpsp: SKIP (1.145s)
[64.719930] [002/134] (957s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-pwrite)
[64.825265] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-pwrite
[64.829528] Subtest psr-2p-scndscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[64.938955] [003/134] (957s left) gem_lmem_swapping (heavy-multi)
[64.984458] Subtest heavy-multi: SKIP (0.000s)
[65.019125] [004/134] (957s left) kms_plane (plane-position-hole)
[65.111179] Starting subtest: plane-position-hole
[65.665349] Starting dynamic subtest: pipe-A-plane-1
[66.982699] Dynamic subtest pipe-A-plane-1: SUCCESS (1.317s)
[66.992739] Starting dynamic subtest: pipe-A-plane-2
[68.324549] Dynamic subtest pipe-A-plane-2: SUCCESS (1.340s)
[68.333590] Starting dynamic subtest: pipe-A-plane-3
[69.609137] Dynamic subtest pipe-A-plane-3: SUCCESS (1.284s)
[69.617800] Starting dynamic subtest: pipe-A-plane-4
[70.862504] Dynamic subtest pipe-A-plane-4: SUCCESS (1.253s)
[70.871322] Starting dynamic subtest: pipe-A-plane-5
[70.886664] Dynamic subtest pipe-A-plane-5: SUCCESS (0.023s)
[72.115682] Starting dynamic subtest: pipe-B-plane-1
[73.422489] Dynamic subtest pipe-B-plane-1: SUCCESS (1.312s)
[73.429231] Starting dynamic subtest: pipe-B-plane-2
[74.743897] Dynamic subtest pipe-B-plane-2: SUCCESS (1.321s)
[74.752399] Starting dynamic subtest: pipe-B-plane-3
[75.978452] Dynamic subtest pipe-B-plane-3: SUCCESS (1.235s)
[75.988670] Starting dynamic subtest: pipe-B-plane-4
[77.205723] Dynamic subtest pipe-B-plane-4: SUCCESS (1.227s)
[77.214824] Starting dynamic subtest: pipe-B-plane-5
[77.230485] Dynamic subtest pipe-B-plane-5: SUCCESS (0.023s)
[77.232377] Subtest plane-position-hole: SUCCESS (12.119s)
[78.004765] [005/134] (944s left) gem_exec_reloc (basic-cpu-wc-active)
[78.085108] Subtest basic-cpu-wc-active: SKIP (0.000s)
[78.164856] [006/134] (944s left) kms_psr2_sf (fbc-psr2-overlay-plane-update-continuous-sf)
[83.182658] Starting subtest: fbc-psr2-overlay-plane-update-continuous-sf
[83.184656] Starting dynamic subtest: pipe-A-eDP-1
[83.959438] Dynamic subtest pipe-A-eDP-1: SKIP (0.774s)
[83.967810] Starting dynamic subtest: pipe-B-eDP-1
[85.089200] Dynamic subtest pipe-B-eDP-1: SKIP (1.129s)
[85.093604] Subtest fbc-psr2-overlay-plane-update-continuous-sf: SKIP (1.907s)
[86.282801] [007/134] (936s left) kms_cdclk (plane-scaling)
[86.388660] Starting subtest: plane-scaling
[86.390822] Starting dynamic subtest: pipe-A-eDP-1
[86.686986] Dynamic subtest pipe-A-eDP-1: SKIP (0.295s)
[86.694472] Starting dynamic subtest: pipe-B-eDP-1
[86.698817] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[86.708855] Starting dynamic subtest: pipe-C-eDP-1
[86.712992] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[86.720055] Starting dynamic subtest: pipe-D-eDP-1
[86.724749] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[86.729109] Subtest plane-scaling: SKIP (0.301s)
[87.527523] [008/134] (934s left) gem_mmap_gtt (fault-concurrent-x)
[87.601423] Subtest fault-concurrent-X: SKIP (0.000s)
[87.672734] [009/134] (934s left) kms_psr (fbc-psr-basic)
[87.768123] Starting subtest: fbc-psr-basic
[87.770264] Starting dynamic subtest: eDP-1
[87.774620] Dynamic subtest eDP-1: SKIP (0.000s)
[87.779063] Subtest fbc-psr-basic: SKIP (0.001s)
[87.847313] [010/134] (934s left) gem_exec_schedule (semaphore-user)
[87.927478] Starting subtest: semaphore-user
[87.977253] Subtest semaphore-user: SUCCESS (0.057s)
[89.987541] [011/134] (932s left) api_intel_bb (add-remove-objects)
[90.054112] Starting subtest: add-remove-objects
[90.059827] Subtest add-remove-objects: SUCCESS (0.006s)
[90.174056] [012/134] (932s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-180-async-flip)
[90.287961] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-180-async-flip
[90.292062] Subtest y-tiled-max-hw-stride-64bpp-rotate-180-async-flip: SKIP (0.000s)
[90.410383] [013/134] (932s left) kms_cursor_legacy (flip-vs-cursor-atomic-transitions-varying-size)
[90.543858] Starting subtest: flip-vs-cursor-atomic-transitions-varying-size
[99.420208] Subtest flip-vs-cursor-atomic-transitions-varying-size: SUCCESS (8.877s)
[100.250072] [014/134] (922s left) kms_setmode (invalid-clone-exclusive-crtc)
[100.304824] Starting subtest: invalid-clone-exclusive-crtc
[100.311189] Subtest invalid-clone-exclusive-crtc: SKIP (0.000s)
[100.426184] [015/134] (922s left) i915_query (query-topology-kernel-writes)
[100.486312] Starting subtest: query-topology-kernel-writes
[100.488299] Subtest query-topology-kernel-writes: SUCCESS (0.000s)
[100.605602] [016/134] (922s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-mmap-gtt)
[100.712343] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-mmap-gtt
[100.716717] Subtest psr-2p-scndscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[100.826611] [017/134] (921s left) kms_frontbuffer_tracking (psr-2p-primscrn-shrfb-plflip-blt)
[100.919402] Starting subtest: psr-2p-primscrn-shrfb-plflip-blt
[100.923393] Subtest psr-2p-primscrn-shrfb-plflip-blt: SKIP (0.000s)
[101.039490] [018/134] (921s left) kms_dsc (dsc-with-output-formats)
[101.128151] Starting subtest: dsc-with-output-formats
[101.149834] Subtest dsc-with-output-formats: SKIP (0.001s)
[101.225679] [019/134] (921s left) kms_ccs (crc-primary-suspend-y-tiled-gen12-rc-ccs-cc)
[101.329168] Starting subtest: crc-primary-suspend-y-tiled-gen12-rc-ccs-cc
[101.331012] Starting dynamic subtest: pipe-A-eDP-1
[101.338401] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[101.348646] Starting dynamic subtest: pipe-B-eDP-1
[101.356375] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[101.364702] Starting dynamic subtest: pipe-C-eDP-1
[101.371911] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[101.377908] Starting dynamic subtest: pipe-D-eDP-1
[101.384921] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[101.388329] Subtest crc-primary-suspend-y-tiled-gen12-rc-ccs-cc: SKIP (0.003s)
[103.619109] [020/134] (919s left) gem_ctx_shared (q-smoketest-all)
[103.684803] Starting subtest: Q-smoketest-all
[136.072063] Subtest Q-smoketest-all: SUCCESS (32.338s)
[137.061079] [021/134] (885s left) kms_joiner (basic-big-joiner)
[137.162849] Starting subtest: basic-big-joiner
[137.167093] Subtest basic-big-joiner: SKIP (0.000s)
[137.233522] [022/134] (885s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-mmap-cpu)
[137.334461] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-mmap-cpu
[140.929674] Subtest fbc-1p-primscrn-cur-indfb-draw-mmap-cpu: SUCCESS (3.598s)
[142.122973] [023/134] (880s left) kms_multipipe_modeset (basic-max-pipe-crc-check)
[142.217351] Starting subtest: basic-max-pipe-crc-check
[142.221572] Subtest basic-max-pipe-crc-check: SKIP (0.000s)
[142.264371] [024/134] (880s left) kms_frontbuffer_tracking (fbcpsr-1p-pri-indfb-multidraw)
[142.369109] Starting subtest: fbcpsr-1p-pri-indfb-multidraw
[165.121261] Subtest fbcpsr-1p-pri-indfb-multidraw: SUCCESS (22.756s)
[165.282347] [025/134] (857s left) kms_atomic_interruptible (legacy-pageflip)
[165.396455] Starting subtest: legacy-pageflip
[165.398431] Starting dynamic subtest: pipe-A-eDP-1
[172.839702] Dynamic subtest pipe-A-eDP-1: SUCCESS (7.439s)
[172.842082] Subtest legacy-pageflip: SUCCESS (7.442s)
[173.687129] [026/134] (849s left) gem_exec_suspend (basic-s3-devices)
[173.754288] Starting subtest: basic-S3-devices
[173.756479] Starting dynamic subtest: smem
[184.917317] Dynamic subtest smem: SUCCESS (11.163s)
[184.919960] Subtest basic-S3-devices: SUCCESS (11.165s)
[185.124072] [027/134] (837s left) kms_properties (colorop-properties-legacy)
[185.242550] Starting subtest: colorop-properties-legacy
[185.244943] Starting dynamic subtest: pipe-A-eDP-1
[185.615121] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.371s)
[185.623594] Starting dynamic subtest: pipe-B-eDP-1
[186.636790] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.021s)
[186.645636] Starting dynamic subtest: pipe-C-eDP-1
[187.651119] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.012s)
[187.659064] Starting dynamic subtest: pipe-D-eDP-1
[188.675117] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.025s)
[188.677475] Subtest colorop-properties-legacy: SUCCESS (3.435s)
[189.495358] [028/134] (833s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-pwrite)
[189.598150] Starting subtest: fbc-rgb101010-draw-pwrite
[194.981951] Subtest fbc-rgb101010-draw-pwrite: SUCCESS (5.386s)
[196.194974] [029/134] (826s left) kms_plane_multiple (2x-tiling-yf)
[196.289376] Starting subtest: 2x-tiling-yf
[196.293536] Subtest 2x-tiling-yf: SKIP (0.000s)
[196.372104] [030/134] (826s left) i915_query (query-garbage)
[196.427182] Starting subtest: query-garbage
[196.429079] Subtest query-garbage: SUCCESS (0.000s)
[196.517214] [031/134] (826s left) gem_exec_schedule (noreorder)
[196.702540] Starting subtest: noreorder
[196.704514] Starting dynamic subtest: rcs0
[196.763905] Dynamic subtest rcs0: SUCCESS (0.064s)
[196.775225] Starting dynamic subtest: vcs0
[197.894684] Dynamic subtest vcs0: SUCCESS (1.127s)
[197.906155] Starting dynamic subtest: vcs1
[199.906581] Dynamic subtest vcs1: SUCCESS (2.010s)
[199.917522] Starting dynamic subtest: vecs0
[201.955089] Dynamic subtest vecs0: SUCCESS (2.047s)
[201.966176] Starting dynamic subtest: ccs0
[202.038359] Dynamic subtest ccs0: SUCCESS (0.081s)
[202.041030] Subtest noreorder: SUCCESS (5.339s)
[202.235175] [032/134] (821s left) syncobj_timeline (wait-all-for-submit-complex)
[202.286738] Starting subtest: wait-all-for-submit-complex
[202.500335] Subtest wait-all-for-submit-complex: SUCCESS (0.214s)
[202.586220] [033/134] (820s left) kms_plane (pixel-format-x-tiled-modifier-source-clamping)
[202.682066] Starting subtest: pixel-format-x-tiled-modifier-source-clamping
[202.707046] Starting dynamic subtest: pipe-A-plane-0
[203.318193] Dynamic subtest pipe-A-plane-0: SUCCESS (0.611s)
[203.326191] Starting dynamic subtest: pipe-A-plane-3
[203.706569] Dynamic subtest pipe-A-plane-3: SUCCESS (0.388s)
[203.714687] Starting dynamic subtest: pipe-A-plane-5
[203.718195] Dynamic subtest pipe-A-plane-5: SKIP (0.000s)
[204.859060] Starting dynamic subtest: pipe-B-plane-0
[205.519739] Dynamic subtest pipe-B-plane-0: SUCCESS (0.667s)
[205.532070] Starting dynamic subtest: pipe-B-plane-3
[205.952291] Dynamic subtest pipe-B-plane-3: SUCCESS (0.431s)
[205.960515] Starting dynamic subtest: pipe-B-plane-5
[205.964205] Dynamic subtest pipe-B-plane-5: SKIP (0.000s)
[206.265979] Subtest pixel-format-x-tiled-modifier-source-clamping: SUCCESS (3.585s)
[207.137978] [034/134] (816s left) kms_ccs (crc-primary-basic-4-tiled-bmg-ccs)
[207.231198] Starting subtest: crc-primary-basic-4-tiled-bmg-ccs
[207.235707] Subtest crc-primary-basic-4-tiled-bmg-ccs: SKIP (0.000s)
[208.362235] [035/134] (815s left) kms_universal_plane (universal-plane-sanity)
[208.451420] Starting subtest: universal-plane-sanity
[208.453788] Starting dynamic subtest: pipe-A-eDP-1
[209.052821] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.603s)
[209.061996] Starting dynamic subtest: pipe-B-eDP-1
[210.267945] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.210s)
[210.276878] Starting dynamic subtest: pipe-C-eDP-1
[211.481534] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.215s)
[211.490378] Starting dynamic subtest: pipe-D-eDP-1
[212.711396] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.228s)
[212.713707] Subtest universal-plane-sanity: SUCCESS (4.262s)
[213.576996] [036/134] (809s left) gem_ccs (suspend-resume)
[213.646983] Starting subtest: suspend-resume
[213.651231] Subtest suspend-resume: SKIP (0.000s)
[213.773296] [037/134] (809s left) gem_tiled_blits (normal)
[213.835449] Subtest normal: SKIP (0.000s)
[213.896290] [038/134] (809s left) kms_color_pipeline (plane-lut1d-ctm3x4-lut1d)
[213.988217] Starting subtest: plane-lut1d-ctm3x4-lut1d
[214.004031] Starting dynamic subtest: pipe-A-eDP-1
[214.682497] Dynamic subtest pipe-A-eDP-1: FAIL (0.323s)
[215.355779] Starting dynamic subtest: pipe-B-eDP-1
[216.187577] Dynamic subtest pipe-B-eDP-1: FAIL (0.290s)
[216.690245] Starting dynamic subtest: pipe-C-eDP-1
[217.560225] Dynamic subtest pipe-C-eDP-1: FAIL (0.290s)
[218.023409] Starting dynamic subtest: pipe-D-eDP-1
[218.851715] Dynamic subtest pipe-D-eDP-1: FAIL (0.256s)
[218.854039] Subtest plane-lut1d-ctm3x4-lut1d: FAIL (4.586s)
[219.406657] [039/134] (804s left) kms_dirtyfb (fbc-dirtyfb-ioctl)
[219.508331] Starting subtest: fbc-dirtyfb-ioctl
[219.510561] Starting dynamic subtest: A-eDP-1
[222.078714] Dynamic subtest A-eDP-1: SUCCESS (2.571s)
[222.080912] Subtest fbc-dirtyfb-ioctl: SUCCESS (2.572s)
[222.970284] [040/134] (800s left) core_sysfs (read-all-entries)
[223.032996] Starting subtest: read-all-entries
[223.035364] Subtest read-all-entries: SUCCESS (0.003s)
[223.145817] [041/134] (800s left) kms_scaling_modes (scaling-mode-full)
[223.243955] Starting subtest: scaling-mode-full
[223.246255] Starting dynamic subtest: pipe-A-eDP-1
[223.336830] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.094s)
[223.345557] Starting dynamic subtest: pipe-B-eDP-1
[224.486092] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.147s)
[224.494066] Starting dynamic subtest: pipe-C-eDP-1
[225.592765] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.106s)
[225.600890] Starting dynamic subtest: pipe-D-eDP-1
[226.717823] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.123s)
[226.720221] Subtest scaling-mode-full: SUCCESS (3.476s)
[227.885675] [042/134] (795s left) gem_caching (reads)
[227.942308] Subtest reads: SKIP (0.000s)
[228.010972] [043/134] (795s left) kms_flip_scaled_crc (flip-64bpp-yftile-to-32bpp-yftile-upscaling)
[228.107335] Starting subtest: flip-64bpp-yftile-to-32bpp-yftile-upscaling
[228.109631] Starting dynamic subtest: pipe-A-default-mode
[228.409952] Dynamic subtest pipe-A-default-mode: SKIP (0.300s)
[228.414570] Subtest flip-64bpp-yftile-to-32bpp-yftile-upscaling: SKIP (0.301s)
[229.223460] [044/134] (794s left) kms_big_fb (linear-max-hw-stride-64bpp-rotate-0)
[229.339595] Starting subtest: linear-max-hw-stride-64bpp-rotate-0
[230.386833] Subtest linear-max-hw-stride-64bpp-rotate-0: SUCCESS (1.046s)
[230.590162] [045/134] (793s left) gem_exec_balancer (nohangcheck)
[230.848107] Starting subtest: nohangcheck
[231.700785] Subtest nohangcheck: SUCCESS (0.852s)
[231.860758] [046/134] (791s left) kms_vblank (ts-continuation-idle-hang)
[231.957016] Starting subtest: ts-continuation-idle-hang
[231.959249] Starting dynamic subtest: pipe-A-eDP-1
[258.655550] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.695s)
[258.669532] Starting dynamic subtest: pipe-D-eDP-1
[283.674651] Dynamic subtest pipe-D-eDP-1: SUCCESS (25.016s)
[283.677058] Subtest ts-continuation-idle-hang: SUCCESS (51.716s)
[284.493292] [047/134] (739s left) gem_exec_reloc (basic-concurrent16)
[284.552068] Subtest basic-concurrent16: SKIP (0.000s)
[284.633117] [048/134] (739s left) syncobj_timeline (multi-wait-all-for-submit-available-submitted-signaled)
[284.684632] Starting subtest: multi-wait-all-for-submit-available-submitted-signaled
[284.686817] Subtest multi-wait-all-for-submit-available-submitted-signaled: SUCCESS (0.000s)
[284.812956] [049/134] (739s left) kms_flip (plain-flip-ts-check-interruptible)
[284.902840] Starting subtest: plain-flip-ts-check-interruptible
[284.904953] Starting dynamic subtest: A-eDP1
[293.767433] Dynamic subtest A-eDP1: SUCCESS (8.863s)
[293.778369] Starting dynamic subtest: B-eDP1
[302.601212] Dynamic subtest B-eDP1: SUCCESS (8.832s)
[302.612297] Starting dynamic subtest: C-eDP1
[311.421864] Dynamic subtest C-eDP1: SUCCESS (8.819s)
[311.429877] Starting dynamic subtest: D-eDP1
[320.255748] Dynamic subtest D-eDP1: SUCCESS (8.831s)
[320.261367] Subtest plain-flip-ts-check-interruptible: SUCCESS (35.357s)
[321.450396] [050/134] (702s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-16bpp-4tile-downscaling)
[321.553822] Starting subtest: flip-64bpp-4tile-to-16bpp-4tile-downscaling
[321.556077] Starting dynamic subtest: pipe-A-default-mode
[322.684145] Dynamic subtest pipe-A-default-mode: SKIP (1.128s)
[322.688330] Subtest flip-64bpp-4tile-to-16bpp-4tile-downscaling: SKIP (1.129s)
[322.864638] [051/134] (701s left) gem_flink_race (flink_close)
[322.900106] Starting subtest: flink_close
[328.011015] Subtest flink_close: SUCCESS (5.112s)
[328.097622] [052/134] (695s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-180-async-flip)
[328.203975] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-180-async-flip
[329.006089] Subtest 4-tiled-max-hw-stride-64bpp-rotate-180-async-flip: SUCCESS (0.803s)
[329.214183] [053/134] (694s left) kms_properties (connector-properties-atomic)
[329.323088] Starting subtest: connector-properties-atomic
[329.325267] Starting dynamic subtest: pipe-A-eDP-1
[337.133812] Dynamic subtest pipe-A-eDP-1: SUCCESS (7.809s)
[337.142372] Starting dynamic subtest: pipe-None-DP-1
[337.146370] Dynamic subtest pipe-None-DP-1: SUCCESS (0.001s)
[337.153832] Starting dynamic subtest: pipe-None-HDMI-A-1
[337.157764] Dynamic subtest pipe-None-HDMI-A-1: SUCCESS (0.001s)
[337.165467] Starting dynamic subtest: pipe-None-DP-2
[337.169648] Dynamic subtest pipe-None-DP-2: SUCCESS (0.001s)
[337.177523] Starting dynamic subtest: pipe-None-HDMI-A-2
[337.181671] Dynamic subtest pipe-None-HDMI-A-2: SUCCESS (0.001s)
[337.189065] Starting dynamic subtest: pipe-None-DP-3
[337.193142] Dynamic subtest pipe-None-DP-3: SUCCESS (0.001s)
[337.200379] Starting dynamic subtest: pipe-None-DP-4
[337.204592] Dynamic subtest pipe-None-DP-4: SUCCESS (0.001s)
[337.206779] Subtest connector-properties-atomic: SUCCESS (7.820s)
[338.007260] [054/134] (686s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-mmap-wc)
[338.108248] Starting subtest: fbcpsr-rgb565-draw-mmap-wc
[344.873478] Subtest fbcpsr-rgb565-draw-mmap-wc: SUCCESS (6.766s)
[345.002616] [055/134] (679s left) perf_pmu (busy-double-start)
[345.049898] Starting subtest: busy-double-start
[345.052153] Starting dynamic subtest: rcs0
[348.685800] Dynamic subtest rcs0: FAIL (3.571s)
[348.695660] Starting dynamic subtest: bcs0
[352.228840] Dynamic subtest bcs0: SUCCESS (3.607s)
[352.240066] Starting dynamic subtest: vcs0
[356.482766] Dynamic subtest vcs0: SUCCESS (4.251s)
[356.494194] Starting dynamic subtest: vcs1
[360.468772] Dynamic subtest vcs1: SUCCESS (3.983s)
[360.479352] Starting dynamic subtest: vecs0
[364.475724] Dynamic subtest vecs0: SUCCESS (4.006s)
[364.487276] Starting dynamic subtest: ccs0
[368.111506] Dynamic subtest ccs0: FAIL (3.564s)
[368.113774] Subtest busy-double-start: FAIL (22.992s)
[368.189631] [056/134] (656s left) kms_frontbuffer_tracking (fbc-2p-primscrn-shrfb-plflip-blt)
[368.298158] Starting subtest: fbc-2p-primscrn-shrfb-plflip-blt
[368.302164] Subtest fbc-2p-primscrn-shrfb-plflip-blt: SKIP (0.000s)
[368.433988] [057/134] (655s left) prime_busy (hang-wait)
[368.483497] Starting subtest: hang-wait
[368.485719] Starting dynamic subtest: rcs0
[394.355880] Dynamic subtest rcs0: SUCCESS (25.867s)
[394.371075] Starting dynamic subtest: bcs0
[401.510923] Dynamic subtest bcs0: SUCCESS (7.152s)
[401.521248] Starting dynamic subtest: vcs0
[408.487069] Dynamic subtest vcs0: SUCCESS (6.977s)
[408.495088] Starting dynamic subtest: vcs1
[415.522081] Dynamic subtest vcs1: SUCCESS (7.033s)
[415.530454] Starting dynamic subtest: vecs0
[422.494814] Dynamic subtest vecs0: SUCCESS (6.969s)
[422.505215] Starting dynamic subtest: ccs0
[436.401754] Dynamic subtest ccs0: SUCCESS (13.903s)
[436.404096] Subtest hang-wait: SUCCESS (67.914s)
[436.557178] [058/134] (587s left) gem_exec_store (cachelines)
[436.626063] Starting subtest: cachelines
[436.628504] Starting dynamic subtest: rcs0
[436.737239] Dynamic subtest rcs0: SUCCESS (0.111s)
[436.747815] Starting dynamic subtest: bcs0
[436.808032] Dynamic subtest bcs0: SUCCESS (0.069s)
[436.818889] Starting dynamic subtest: vcs0
[436.875131] Dynamic subtest vcs0: SUCCESS (0.065s)
[436.886053] Starting dynamic subtest: vcs1
[436.947969] Dynamic subtest vcs1: SUCCESS (0.071s)
[436.958672] Starting dynamic subtest: vecs0
[437.019985] Dynamic subtest vecs0: SUCCESS (0.070s)
[437.030620] Starting dynamic subtest: ccs0
[437.082025] Dynamic subtest ccs0: SUCCESS (0.060s)
[437.084515] Subtest cachelines: SUCCESS (0.458s)
[437.280252] [059/134] (587s left) gem_exec_balancer (parallel-keep-submit-fence)
[437.569983] Starting subtest: parallel-keep-submit-fence
[438.703641] Subtest parallel-keep-submit-fence: SUCCESS (1.133s)
[438.829298] [060/134] (585s left) i915_drm_fdinfo (context-close-stress)
[438.870921] Starting subtest: context-close-stress
[449.613660] Subtest context-close-stress: SUCCESS (10.743s)
[449.698583] [061/134] (574s left) kms_getfb (getfb-handle-closed)
[449.994024] Starting subtest: getfb-handle-closed
[449.996312] Subtest getfb-handle-closed: SUCCESS (0.000s)
[450.136863] [062/134] (574s left) kms_rotation_crc (primary-x-tiled-reflect-x-180)
[450.232354] Starting subtest: primary-x-tiled-reflect-x-180
[457.316194] Subtest primary-x-tiled-reflect-x-180: SUCCESS (7.085s)
[458.472700] [063/134] (566s left) kms_frontbuffer_tracking (pipe-fbc-rte)
[458.566751] Starting subtest: pipe-fbc-rte
[458.573736] Starting dynamic subtest: pipe-B-eDP-1
[464.042032] Dynamic subtest pipe-B-eDP-1: SUCCESS (5.479s)
[464.049709] Subtest pipe-fbc-rte: SUCCESS (5.481s)
[466.387573] [064/134] (558s left) kms_flip (bo-too-big-interruptible)
[466.490405] Starting subtest: bo-too-big-interruptible
[466.492717] Starting dynamic subtest: A-eDP1
[467.737610] Dynamic subtest A-eDP1: SUCCESS (1.246s)
[467.747488] Starting dynamic subtest: B-eDP1
[468.971155] Dynamic subtest B-eDP1: SUCCESS (1.233s)
[468.981454] Starting dynamic subtest: C-eDP1
[470.220154] Dynamic subtest C-eDP1: SUCCESS (1.248s)
[470.228817] Starting dynamic subtest: D-eDP1
[471.462255] Dynamic subtest D-eDP1: SUCCESS (1.240s)
[471.464962] Subtest bo-too-big-interruptible: SUCCESS (4.975s)
[472.675776] [065/134] (551s left) gem_softpin (reverse)
[472.752471] Starting subtest: reverse
[472.757881] Subtest reverse: SUCCESS (0.004s)
[472.901371] [066/134] (551s left) prime_vgem (basic-read)
[473.074788] Starting subtest: basic-read
[473.082740] Subtest basic-read: SKIP (0.006s)
[473.207946] [FACT prime_vgem (basic-read)] new: kernel.kmod_is_loaded.vgem: true
[473.212202] [067/134] (551s left) perf_pmu (pmu-read)
[473.250319] Starting subtest: pmu-read
[473.252578] Subtest pmu-read: SUCCESS (0.002s)
[473.406562] [068/134] (551s left) prime_self_import (basic-llseek-size)
[473.444631] Starting subtest: basic-llseek-size
[473.468422] Subtest basic-llseek-size: SUCCESS (0.027s)
[473.582428] [069/134] (551s left) kms_getfb (getfb2-accept-nv12)
[473.669547] Starting subtest: getfb2-accept-nv12
[473.671544] Subtest getfb2-accept-nv12: SUCCESS (0.001s)
[473.803019] [070/134] (551s left) kms_cursor_legacy (basic-busy-flip-before-cursor-atomic)
[473.932054] Starting subtest: basic-busy-flip-before-cursor-atomic
[473.936051] Subtest basic-busy-flip-before-cursor-atomic: SKIP (0.000s)
[474.083793] [071/134] (550s left) sysfs_heartbeat_interval (invalid)
[474.149451] Starting subtest: invalid
[474.151392] Starting dynamic subtest: vecs0
[474.153199] Dynamic subtest vecs0: SUCCESS (0.000s)
[474.161441] Starting dynamic subtest: ccs0
[474.163183] Dynamic subtest ccs0: SUCCESS (0.000s)
[474.170941] Starting dynamic subtest: vcs0
[474.172823] Dynamic subtest vcs0: SUCCESS (0.000s)
[474.180481] Starting dynamic subtest: bcs0
[474.182282] Dynamic subtest bcs0: SUCCESS (0.000s)
[474.190028] Starting dynamic subtest: rcs0
[474.191781] Dynamic subtest rcs0: SUCCESS (0.000s)
[474.199301] Starting dynamic subtest: vcs1
[474.201121] Dynamic subtest vcs1: SUCCESS (0.000s)
[474.202925] Subtest invalid: SUCCESS (0.005s)
[474.268251] [072/134] (550s left) prime_mmap (test_forked_cpu_write)
[474.321695] Starting subtest: test_forked_cpu_write
[474.323390] Starting dynamic subtest: test_forked_cpu_write-smem
[474.328825] Dynamic subtest test_forked_cpu_write-smem: SUCCESS (0.007s)
[474.330671] Subtest test_forked_cpu_write: SUCCESS (0.008s)
[474.458888] [073/134] (550s left) sw_sync (sync_busy_fork_unixsocket)
[474.494583] Starting subtest: sync_busy_fork_unixsocket
[474.500744] Subtest sync_busy_fork_unixsocket: SUCCESS (0.007s)
[474.577303] [074/134] (550s left) gem_render_copy (linear-to-vebox-yf-tiled)
[474.646842] Starting subtest: linear-to-vebox-yf-tiled
[474.650538] Subtest linear-to-vebox-yf-tiled: SKIP (0.000s)
[474.838974] [075/134] (550s left) kms_pm_rpm (modeset-lpsp)
[477.080979] Starting subtest: modeset-lpsp
[478.533056] Subtest modeset-lpsp: SUCCESS (1.453s)
[478.633325] [076/134] (546s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-blt)
[478.716799] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-blt
[485.970150] Subtest psr-1p-primscrn-pri-shrfb-draw-blt: SUCCESS (7.256s)
[486.117789] [077/134] (538s left) gem_userptr_blits (sync-unmap-cycles)
[486.186371] Starting subtest: sync-unmap-cycles
[491.567982] Subtest sync-unmap-cycles: SUCCESS (5.380s)
[491.740629] [078/134] (533s left) kms_big_fb (y-tiled-8bpp-rotate-270)
[491.847217] Starting subtest: y-tiled-8bpp-rotate-270
[491.850905] Subtest y-tiled-8bpp-rotate-270: SKIP (0.000s)
[491.967378] [079/134] (533s left) kms_plane_scaling (planes-upscale-factor-0-25)
[492.060475] Starting subtest: planes-upscale-factor-0-25
[492.062440] Starting dynamic subtest: pipe-A
[492.121185] Dynamic subtest pipe-A: SUCCESS (0.062s)
[492.129308] Starting dynamic subtest: pipe-B
[493.232216] Dynamic subtest pipe-B: SUCCESS (1.108s)
[493.243437] Starting dynamic subtest: pipe-C
[494.354399] Dynamic subtest pipe-C: SUCCESS (1.121s)
[494.364412] Starting dynamic subtest: pipe-D
[495.473940] Dynamic subtest pipe-D: SUCCESS (1.119s)
[495.476264] Subtest planes-upscale-factor-0-25: SUCCESS (3.415s)
[496.659243] [080/134] (528s left) kms_async_flips (alternate-sync-async-flip)
[496.752680] Starting subtest: alternate-sync-async-flip
[497.124965] Starting dynamic subtest: pipe-A-eDP-1
[499.937628] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.814s)
[500.310744] Starting dynamic subtest: pipe-B-eDP-1
[503.059184] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.755s)
[503.447521] Starting dynamic subtest: pipe-C-eDP-1
[506.191160] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.751s)
[506.561862] Starting dynamic subtest: pipe-D-eDP-1
[509.319441] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.769s)
[509.321502] Subtest alternate-sync-async-flip: SUCCESS (12.570s)
[510.495910] [081/134] (514s left) kms_ccs (crc-primary-suspend-4-tiled-dg2-rc-ccs-cc)
[510.605424] Starting subtest: crc-primary-suspend-4-tiled-dg2-rc-ccs-cc
[510.607635] Starting dynamic subtest: pipe-A-eDP-1
[510.616538] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[510.627978] Starting dynamic subtest: pipe-B-eDP-1
[510.637892] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[510.652543] Starting dynamic subtest: pipe-C-eDP-1
[510.661560] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[510.671865] Starting dynamic subtest: pipe-D-eDP-1
[510.680401] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[510.684726] Subtest crc-primary-suspend-4-tiled-dg2-rc-ccs-cc: SKIP (0.005s)
[512.782400] [082/134] (512s left) gen9_exec_parse (bb-secure)
[512.840638] Subtest bb-secure: SKIP (0.000s)
[512.904211] [083/134] (512s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-pwrite)
[513.000631] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-pwrite
[522.101203] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-pwrite: SUCCESS (9.102s)
[522.236518] [084/134] (503s left) gem_exec_fence (submit67)
[522.424675] Starting subtest: submit67
[522.429507] Subtest submit67: SKIP (0.000s)
[524.047652] [085/134] (501s left) gem_ctx_persistence (engines-queued)
[524.122643] Starting subtest: engines-queued
[524.125064] Starting dynamic subtest: rcs0
[524.226325] Dynamic subtest rcs0: SUCCESS (0.102s)
[524.238825] Starting dynamic subtest: bcs0
[524.298402] Dynamic subtest bcs0: SUCCESS (0.070s)
[524.310063] Starting dynamic subtest: vcs0
[525.878518] Dynamic subtest vcs0: SUCCESS (1.576s)
[525.889528] Starting dynamic subtest: vcs1
[527.860784] Dynamic subtest vcs1: SUCCESS (1.979s)
[527.872323] Starting dynamic subtest: vecs0
[529.907392] Dynamic subtest vecs0: SUCCESS (2.044s)
[529.918962] Starting dynamic subtest: ccs0
[530.086874] Dynamic subtest ccs0: SUCCESS (0.178s)
[530.089463] Subtest engines-queued: SUCCESS (5.964s)
[530.233668] [086/134] (495s left) kms_chamelium_color (ctm-red-to-blue)
[530.325219] Subtest ctm-red-to-blue: SKIP (0.000s)
[530.375376] [087/134] (495s left) kms_psr2_su (page_flip-p010)
[530.443613] Subtest page_flip-P010: SKIP (0.000s)
[530.506077] [088/134] (495s left) kms_flip_scaled_crc (flip-32bpp-4tile-to-64bpp-4tile-downscaling)
[530.604997] Starting subtest: flip-32bpp-4tile-to-64bpp-4tile-downscaling
[530.607117] Starting dynamic subtest: pipe-A-default-mode
[531.734911] Dynamic subtest pipe-A-default-mode: SKIP (1.126s)
[531.739010] Subtest flip-32bpp-4tile-to-64bpp-4tile-downscaling: SKIP (1.127s)
[531.924308] [089/134] (493s left) i915_drm_fdinfo (virtual-idle)
[531.959690] Starting subtest: virtual-idle
[535.034634] Subtest virtual-idle: SUCCESS (3.074s)
[535.134196] [090/134] (490s left) gem_render_copy (y-tiled-mc-ccs-to-vebox-y-tiled)
[535.202070] Starting subtest: y-tiled-mc-ccs-to-vebox-y-tiled
[535.206226] Subtest y-tiled-mc-ccs-to-vebox-y-tiled: SKIP (0.000s)
[535.416683] [091/134] (490s left) kms_ccs (bad-rotation-90-4-tiled-lnl-ccs)
[535.519277] Starting subtest: bad-rotation-90-4-tiled-lnl-ccs
[535.523923] Subtest bad-rotation-90-4-tiled-lnl-ccs: SKIP (0.000s)
[536.642598] [092/134] (489s left) kms_cursor_crc (cursor-onscreen-256x85)
[536.915928] Starting subtest: cursor-onscreen-256x85
[536.961388] Subtest cursor-onscreen-256x85: SKIP (0.044s)
[537.189394] [093/134] (488s left) kms_cursor_crc (cursor-rapid-movement-512x512)
[537.465484] Starting subtest: cursor-rapid-movement-512x512
[537.469923] Subtest cursor-rapid-movement-512x512: SKIP (0.001s)
[537.665248] [094/134] (488s left) i915_suspend (forcewake)
[537.713274] Starting subtest: forcewake
[569.633888] Subtest forcewake: SUCCESS (2.235s)
[570.766289] [095/134] (456s left) syncobj_timeline (signal-array)
[570.842623] Starting subtest: signal-array
[570.845109] Subtest signal-array: SUCCESS (0.000s)
[570.956192] [096/134] (455s left) gem_exec_params (batch-first)
[571.015430] Starting subtest: batch-first
[571.018438] Subtest batch-first: SUCCESS (0.006s)
[571.159305] [097/134] (455s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-pwrite)
[571.254841] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-pwrite
[571.258971] Subtest fbc-2p-primscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[571.385070] [098/134] (455s left) kms_psr (psr2-primary-mmap-gtt)
[571.481175] Starting subtest: psr2-primary-mmap-gtt
[571.483547] Starting dynamic subtest: eDP-1
[572.888952] Dynamic subtest eDP-1: SKIP (1.402s)
[572.893842] Subtest psr2-primary-mmap-gtt: SKIP (1.404s)
[573.041093] [099/134] (454s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-pwrite)
[573.137256] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-pwrite
[573.141288] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[573.312470] [100/134] (453s left) kms_frontbuffer_tracking (fbc-rgb565-draw-mmap-gtt)
[573.416273] Starting subtest: fbc-rgb565-draw-mmap-gtt
[573.420553] Subtest fbc-rgb565-draw-mmap-gtt: SKIP (0.000s)
[573.541667] [101/134] (453s left) kms_pipe_stress (stress-xrgb8888-xtiled)
[573.634441] Starting subtest: stress-xrgb8888-xtiled
[579.473384] Subtest stress-xrgb8888-xtiled: SUCCESS (5.832s)
[579.535843] [102/134] (447s left) gem_exec_params (rel-constants-invalid)
[579.597281] Starting subtest: rel-constants-invalid
[579.599187] Subtest rel-constants-invalid: SUCCESS (0.000s)
[579.711572] [103/134] (447s left) gem_eio (in-flight-external)
[579.941196] Starting subtest: in-flight-external
[581.637502] Subtest in-flight-external: SUCCESS (1.692s)
[581.801209] [104/134] (445s left) gem_wait (busy)
[581.865849] Starting subtest: busy
[581.868592] Starting dynamic subtest: all-engines
[583.614192] Dynamic subtest all-engines: SUCCESS (1.746s)
[583.626778] Starting dynamic subtest: rcs0
[584.154923] Dynamic subtest rcs0: SUCCESS (0.539s)
[584.166718] Starting dynamic subtest: bcs0
[584.695255] Dynamic subtest bcs0: SUCCESS (0.539s)
[584.706694] Starting dynamic subtest: vcs0
[586.559181] Dynamic subtest vcs0: SUCCESS (1.860s)
[586.571300] Starting dynamic subtest: vcs1
[588.606420] Dynamic subtest vcs1: SUCCESS (2.043s)
[588.617528] Starting dynamic subtest: vecs0
[590.590453] Dynamic subtest vecs0: SUCCESS (1.981s)
[590.602465] Starting dynamic subtest: ccs0
[591.132336] Dynamic subtest ccs0: SUCCESS (0.540s)
[591.134749] Subtest busy: SUCCESS (9.263s)
[591.338064] [105/134] (435s left) fbdev (pan)
[591.384226] Starting subtest: pan
[591.410615] Subtest pan: SUCCESS (0.029s)
[591.502552] [106/134] (435s left) kms_chamelium_hpd (hdmi-hpd-storm)
[591.884545] Subtest hdmi-hpd-storm: SKIP (0.000s)
[592.741599] [107/134] (434s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-mmap-cpu)
[592.841362] Starting subtest: psr-1p-primscrn-spr-indfb-draw-mmap-cpu
[599.462655] Subtest psr-1p-primscrn-spr-indfb-draw-mmap-cpu: SUCCESS (6.621s)
[599.602757] [108/134] (427s left) kms_async_flips (test-time-stamp-atomic)
[599.703737] Starting subtest: test-time-stamp-atomic
[600.077975] Starting dynamic subtest: pipe-A-eDP-1
[600.889052] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.809s)
[601.285184] Starting dynamic subtest: pipe-B-eDP-1
[602.038157] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.759s)
[602.402680] Starting dynamic subtest: pipe-C-eDP-1
[603.171939] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.776s)
[603.540963] Starting dynamic subtest: pipe-D-eDP-1
[604.306769] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.773s)
[604.309176] Subtest test-time-stamp-atomic: SUCCESS (4.602s)
[605.476028] [109/134] (422s left) kms_psr (pr-sprite-mmap-gtt)
[605.582548] Starting subtest: pr-sprite-mmap-gtt
[605.586818] Subtest pr-sprite-mmap-gtt: SKIP (0.000s)
[605.669257] [110/134] (421s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-move)
[605.778366] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-move
[605.782742] Subtest fbcpsr-2p-primscrn-spr-indfb-move: SKIP (0.000s)
[605.904075] [111/134] (421s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-180)
[606.018382] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-180
[607.042310] Subtest 4-tiled-max-hw-stride-32bpp-rotate-180: SUCCESS (1.024s)
[607.209828] [112/134] (420s left) gem_exec_schedule (smoketest-all)
[607.277038] Starting subtest: smoketest-all
[639.664989] Subtest smoketest-all: SUCCESS (32.334s)
[640.591896] [113/134] (387s left) vgem_basic (create)
[640.631797] Starting subtest: create
[640.634187] Subtest create: SUCCESS (0.000s)
[640.718430] [114/134] (386s left) gem_ctx_isolation (dirty-create)
[640.782751] Starting subtest: dirty-create
[640.785097] Starting dynamic subtest: rcs0
[641.027223] Dynamic subtest rcs0: SUCCESS (0.244s)
[641.039597] Starting dynamic subtest: bcs0
[641.290160] Dynamic subtest bcs0: SUCCESS (0.262s)
[641.302005] Starting dynamic subtest: vcs0
[641.547919] Dynamic subtest vcs0: SUCCESS (0.257s)
[641.559266] Starting dynamic subtest: vcs1
[642.793201] Dynamic subtest vcs1: SUCCESS (1.244s)
[642.804854] Starting dynamic subtest: vecs0
[644.849876] Dynamic subtest vecs0: SUCCESS (2.054s)
[644.861545] Starting dynamic subtest: ccs0
[646.753156] Dynamic subtest ccs0: SUCCESS (1.902s)
[646.755525] Subtest dirty-create: SUCCESS (5.969s)
[647.028481] [115/134] (380s left) kms_content_protection (uevent-hdcp14)
[647.181982] Starting subtest: uevent-hdcp14
[647.186494] Subtest uevent-hdcp14: SKIP (0.000s)
[647.347946] [116/134] (380s left) syncobj_timeline (etime-multi-wait-for-submit-unsubmitted-submitted)
[647.420680] Starting subtest: etime-multi-wait-for-submit-unsubmitted-submitted
[647.522536] Subtest etime-multi-wait-for-submit-unsubmitted-submitted: SUCCESS (0.102s)
[647.626603] [117/134] (380s left) kms_big_fb (yf-tiled-32bpp-rotate-180)
[647.734732] Starting subtest: yf-tiled-32bpp-rotate-180
[647.739217] Subtest yf-tiled-32bpp-rotate-180: SKIP (0.000s)
[647.856606] [118/134] (380s left) gem_sync (basic-many-each)
[647.922285] Starting subtest: basic-many-each
[650.208173] Subtest basic-many-each: SUCCESS (2.291s)
[650.404547] [119/134] (377s left) kms_cursor_edge_walk (256x256-right-edge)
[650.504056] Starting subtest: 256x256-right-edge
[650.506531] Starting dynamic subtest: pipe-A-eDP-1
[653.924704] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.419s)
[653.935025] Starting dynamic subtest: pipe-D-eDP-1
[657.042269] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.114s)
[657.044501] Subtest 256x256-right-edge: SUCCESS (6.536s)
[657.873891] [120/134] (370s left) kms_cursor_legacy (basic-flip-before-cursor-atomic)
[658.005770] Starting subtest: basic-flip-before-cursor-atomic
[658.921119] Subtest basic-flip-before-cursor-atomic: SUCCESS (0.913s)
[659.803177] [121/134] (368s left) kms_flip (nonblocking-read)
[659.903454] Starting subtest: nonblocking-read
[659.905666] Subtest nonblocking-read: SUCCESS (0.000s)
[660.027921] [122/134] (368s left) kms_big_fb (yf-tiled-64bpp-rotate-180)
[660.131306] Starting subtest: yf-tiled-64bpp-rotate-180
[660.135259] Subtest yf-tiled-64bpp-rotate-180: SKIP (0.000s)
[660.250918] [123/134] (367s left) gem_exec_reloc (basic-wc-gtt-active)
[660.308867] Subtest basic-wc-gtt-active: SKIP (0.000s)
[660.385355] [124/134] (367s left) gem_mmap_wc (write-prefaulted)
[660.439717] Subtest write-prefaulted: SKIP (0.000s)
[660.504440] [125/134] (367s left) api_intel_bb (full-batch)
[660.565149] Starting subtest: full-batch
[660.567655] Subtest full-batch: SUCCESS (0.005s)
[660.733415] [126/134] (367s left) gem_eio (in-flight-internal-10ms)
[660.970197] Starting subtest: in-flight-internal-10ms
[662.675113] Subtest in-flight-internal-10ms: SUCCESS (1.705s)
[662.829009] [127/134] (365s left) kms_frontbuffer_tracking (fbcpsr-2p-pri-indfb-multidraw)
[662.933558] Starting subtest: fbcpsr-2p-pri-indfb-multidraw
[662.937888] Subtest fbcpsr-2p-pri-indfb-multidraw: SKIP (0.000s)
[663.066531] [128/134] (365s left) kms_cursor_legacy (cursora-vs-flipa-toggle)
[663.177858] Starting subtest: cursorA-vs-flipA-toggle
[674.297745] Subtest cursorA-vs-flipA-toggle: SUCCESS (11.121s)
[675.134741] [129/134] (353s left) syncobj_timeline (etime-multi-wait-all-submitted)
[675.187395] Starting subtest: etime-multi-wait-all-submitted
[675.291003] Subtest etime-multi-wait-all-submitted: SUCCESS (0.103s)
[675.379612] [130/134] (352s left) gem_exec_reloc (basic-cpu-noreloc)
[675.436715] Subtest basic-cpu-noreloc: SKIP (0.000s)
[675.529290] [131/134] (352s left) gem_mmap (bad-offset)
[675.594046] Subtest bad-offset: SKIP (0.000s)
[675.660479] [132/134] (352s left) kms_cursor_legacy (2x-long-nonblocking-modeset-vs-cursor-atomic)
[675.780677] Starting subtest: 2x-long-nonblocking-modeset-vs-cursor-atomic
[675.785179] Subtest 2x-long-nonblocking-modeset-vs-cursor-atomic: SKIP (0.001s)
[675.939028] [133/134] (352s left) i915_pm_rc6_residency (rc6-idle)
[675.992991] Starting subtest: rc6-idle
[676.030699] Starting dynamic subtest: gt0-rcs0
[700.243122] Dynamic subtest gt0-rcs0: SUCCESS (24.215s)
[700.254209] Starting dynamic subtest: gt0-bcs0
[724.583343] Dynamic subtest gt0-bcs0: SUCCESS (24.336s)
[724.594194] Starting dynamic subtest: gt0-ccs0
[748.859007] Dynamic subtest gt0-ccs0: SUCCESS (24.272s)
[748.870744] Starting dynamic subtest: gt1-vcs0
[755.033681] Dynamic subtest gt1-vcs0: SUCCESS (6.169s)
[755.046176] Starting dynamic subtest: gt1-vecs0
[761.206798] Dynamic subtest gt1-vecs0: SUCCESS (6.169s)
[761.209606] Subtest rc6-idle: SUCCESS (85.213s)
[761.308725] [134/134] (267s left) kms_psr (fbc-psr2-primary-page-flip)
[761.433058] Starting subtest: fbc-psr2-primary-page-flip
[761.435375] Starting dynamic subtest: eDP-1
[761.439866] Dynamic subtest eDP-1: SKIP (0.000s)
[761.444121] Subtest fbc-psr2-primary-page-flip: SKIP (0.003s)
[761.520507] Closing watchdogs
results: parsing output: 0/ for test: kms_pm_rpm
results: parsing output: 1/ for test: kms_frontbuffer_tracking
results: parsing output: 2/ for test: gem_lmem_swapping
results: parsing output: 3/ for test: kms_plane
results: parsing output: 4/ for test: gem_exec_reloc
results: parsing output: 5/ for test: kms_psr2_sf
results: parsing output: 6/ for test: kms_cdclk
results: parsing output: 7/ for test: gem_mmap_gtt
results: parsing output: 8/ for test: kms_psr
results: parsing output: 9/ for test: gem_exec_schedule
results: parsing output: 10/ for test: api_intel_bb
results: parsing output: 11/ for test: kms_big_fb
results: parsing output: 12/ for test: kms_cursor_legacy
results: parsing output: 13/ for test: kms_setmode
results: parsing output: 14/ for test: i915_query
results: parsing output: 15/ for test: kms_frontbuffer_tracking
results: parsing output: 16/ for test: kms_frontbuffer_tracking
results: parsing output: 17/ for test: kms_dsc
results: parsing output: 18/ for test: kms_ccs
results: parsing output: 19/ for test: gem_ctx_shared
results: parsing output: 20/ for test: kms_joiner
results: parsing output: 21/ for test: kms_frontbuffer_tracking
results: parsing output: 22/ for test: kms_multipipe_modeset
results: parsing output: 23/ for test: kms_frontbuffer_tracking
results: parsing output: 24/ for test: kms_atomic_interruptible
results: parsing output: 25/ for test: gem_exec_suspend
results: parsing output: 26/ for test: kms_properties
results: parsing output: 27/ for test: kms_frontbuffer_tracking
results: parsing output: 28/ for test: kms_plane_multiple
results: parsing output: 29/ for test: i915_query
results: parsing output: 30/ for test: gem_exec_schedule
results: parsing output: 31/ for test: syncobj_timeline
results: parsing output: 32/ for test: kms_plane
results: parsing output: 33/ for test: kms_ccs
results: parsing output: 34/ for test: kms_universal_plane
results: parsing output: 35/ for test: gem_ccs
results: parsing output: 36/ for test: gem_tiled_blits
results: parsing output: 37/ for test: kms_color_pipeline
results: parsing output: 38/ for test: kms_dirtyfb
results: parsing output: 39/ for test: core_sysfs
results: parsing output: 40/ for test: kms_scaling_modes
results: parsing output: 41/ for test: gem_caching
results: parsing output: 42/ for test: kms_flip_scaled_crc
results: parsing output: 43/ for test: kms_big_fb
results: parsing output: 44/ for test: gem_exec_balancer
results: parsing output: 45/ for test: kms_vblank
results: parsing output: 46/ for test: gem_exec_reloc
results: parsing output: 47/ for test: syncobj_timeline
results: parsing output: 48/ for test: kms_flip
results: parsing output: 49/ for test: kms_flip_scaled_crc
results: parsing output: 50/ for test: gem_flink_race
results: parsing output: 51/ for test: kms_big_fb
results: parsing output: 52/ for test: kms_properties
results: parsing output: 53/ for test: kms_frontbuffer_tracking
results: parsing output: 54/ for test: perf_pmu
results: parsing output: 55/ for test: kms_frontbuffer_tracking
results: parsing output: 56/ for test: prime_busy
results: parsing output: 57/ for test: gem_exec_store
results: parsing output: 58/ for test: gem_exec_balancer
results: parsing output: 59/ for test: i915_drm_fdinfo
results: parsing output: 60/ for test: kms_getfb
results: parsing output: 61/ for test: kms_rotation_crc
results: parsing output: 62/ for test: kms_frontbuffer_tracking
results: parsing output: 63/ for test: kms_flip
results: parsing output: 64/ for test: gem_softpin
results: parsing output: 65/ for test: prime_vgem
results: parsing output: 66/ for test: perf_pmu
results: parsing output: 67/ for test: prime_self_import
results: parsing output: 68/ for test: kms_getfb
results: parsing output: 69/ for test: kms_cursor_legacy
results: parsing output: 70/ for test: sysfs_heartbeat_interval
results: parsing output: 71/ for test: prime_mmap
results: parsing output: 72/ for test: sw_sync
results: parsing output: 73/ for test: gem_render_copy
results: parsing output: 74/ for test: kms_pm_rpm
results: parsing output: 75/ for test: kms_frontbuffer_tracking
results: parsing output: 76/ for test: gem_userptr_blits
results: parsing output: 77/ for test: kms_big_fb
results: parsing output: 78/ for test: kms_plane_scaling
results: parsing output: 79/ for test: kms_async_flips
results: parsing output: 80/ for test: kms_ccs
results: parsing output: 81/ for test: gen9_exec_parse
results: parsing output: 82/ for test: kms_frontbuffer_tracking
results: parsing output: 83/ for test: gem_exec_fence
results: parsing output: 84/ for test: gem_ctx_persistence
results: parsing output: 85/ for test: kms_chamelium_color
results: parsing output: 86/ for test: kms_psr2_su
results: parsing output: 87/ for test: kms_flip_scaled_crc
results: parsing output: 88/ for test: i915_drm_fdinfo
results: parsing output: 89/ for test: gem_render_copy
results: parsing output: 90/ for test: kms_ccs
results: parsing output: 91/ for test: kms_cursor_crc
results: parsing output: 92/ for test: kms_cursor_crc
results: parsing output: 93/ for test: i915_suspend
results: parsing output: 94/ for test: syncobj_timeline
results: parsing output: 95/ for test: gem_exec_params
results: parsing output: 96/ for test: kms_frontbuffer_tracking
results: parsing output: 97/ for test: kms_psr
results: parsing output: 98/ for test: kms_frontbuffer_tracking
results: parsing output: 99/ for test: kms_frontbuffer_tracking
results: parsing output: 100/ for test: kms_pipe_stress
results: parsing output: 101/ for test: gem_exec_params
results: parsing output: 102/ for test: gem_eio
results: parsing output: 103/ for test: gem_wait
results: parsing output: 104/ for test: fbdev
results: parsing output: 105/ for test: kms_chamelium_hpd
results: parsing output: 106/ for test: kms_frontbuffer_tracking
results: parsing output: 107/ for test: kms_async_flips
results: parsing output: 108/ for test: kms_psr
results: parsing output: 109/ for test: kms_frontbuffer_tracking
results: parsing output: 110/ for test: kms_big_fb
results: parsing output: 111/ for test: gem_exec_schedule
results: parsing output: 112/ for test: vgem_basic
results: parsing output: 113/ for test: gem_ctx_isolation
results: parsing output: 114/ for test: kms_content_protection
results: parsing output: 115/ for test: syncobj_timeline
results: parsing output: 116/ for test: kms_big_fb
results: parsing output: 117/ for test: gem_sync
results: parsing output: 118/ for test: kms_cursor_edge_walk
results: parsing output: 119/ for test: kms_cursor_legacy
results: parsing output: 120/ for test: kms_flip
results: parsing output: 121/ for test: kms_big_fb
results: parsing output: 122/ for test: gem_exec_reloc
results: parsing output: 123/ for test: gem_mmap_wc
results: parsing output: 124/ for test: api_intel_bb
results: parsing output: 125/ for test: gem_eio
results: parsing output: 126/ for test: kms_frontbuffer_tracking
results: parsing output: 127/ for test: kms_cursor_legacy
results: parsing output: 128/ for test: syncobj_timeline
results: parsing output: 129/ for test: gem_exec_reloc
results: parsing output: 130/ for test: gem_mmap
results: parsing output: 131/ for test: kms_cursor_legacy
results: parsing output: 132/ for test: i915_pm_rc6_residency
results: parsing output: 133/ for test: kms_psr
Done.