[60.075447] Initializing watchdogs
[60.075495]   /dev/watchdog0
[60.090411] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:7d55 Intel Meteorlake (Gen12) Meteor Lake-P [Intel Arc Graphics]
[60.094892] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[60.097122] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[60.098794] [001/133] (960s left) kms_chamelium_hpd (vga-hpd-without-ddc)
[61.265553] Subtest vga-hpd-without-ddc: SKIP (0.000s)
[61.567456] [002/133] (959s left) gem_pwrite (basic-self)
[61.615683] Subtest basic-self: SKIP (0.000s)
[61.665314] [003/133] (958s left) kms_psr (fbc-psr2-sprite-plane-onoff)
[61.760492] Starting subtest: fbc-psr2-sprite-plane-onoff
[61.761386] Starting dynamic subtest: eDP-1
[61.763126] Dynamic subtest eDP-1: SKIP (0.000s)
[61.764816] Subtest fbc-psr2-sprite-plane-onoff: SKIP (0.001s)
[61.852337] [004/133] (958s left) kms_psr (psr2-no-drrs)
[61.940906] Starting subtest: psr2-no-drrs
[61.941737] Starting dynamic subtest: eDP-1
[63.569715] Dynamic subtest eDP-1: SUCCESS (1.628s)
[63.570622] Subtest psr2-no-drrs: SUCCESS (1.629s)
[64.380801] [005/133] (956s left) gem_mmap_wc (write)
[64.435116] Subtest write: SKIP (0.000s)
[64.488780] [006/133] (956s left) kms_frontbuffer_tracking (fbc-tiling-4)
[64.598447] Starting subtest: fbc-tiling-4
[69.091244] Subtest fbc-tiling-4: SUCCESS (4.493s)
[70.250455] [007/133] (950s left) kms_rotation_crc (multiplane-rotation-cropping-bottom)
[70.339053] Starting subtest: multiplane-rotation-cropping-bottom
[87.754885] Subtest multiplane-rotation-cropping-bottom: SUCCESS (17.416s)
[87.862777] [008/133] (932s left) gem_mmap_wc (read-write)
[87.931655] Subtest read-write: SKIP (0.000s)
[87.995859] [009/133] (932s left) gem_exec_params (cliprects_ptr-dirt)
[88.042410] Starting subtest: cliprects_ptr-dirt
[88.043383] Subtest cliprects_ptr-dirt: SUCCESS (0.000s)
[88.126761] [010/133] (932s left) kms_getfb (getfb2-handle-zero)
[88.225270] Starting subtest: getfb2-handle-zero
[88.226147] Subtest getfb2-handle-zero: SUCCESS (0.000s)
[88.319145] [011/133] (932s left) kms_psr (pr-suspend)
[88.403376] Starting subtest: pr-suspend
[88.405290] Subtest pr-suspend: SKIP (0.000s)
[88.469603] [012/133] (932s left) api_intel_bb (simple-bb)
[88.525398] Starting subtest: simple-bb
[88.529742] Subtest simple-bb: SUCCESS (0.005s)
[88.634153] [013/133] (932s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-pwrite)
[88.716404] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-pwrite
[88.718231] Subtest fbc-2p-scndscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[88.820912] [014/133] (932s left) gem_exec_alignment (pi-isolated)
[88.870180] Starting subtest: pi-isolated
[141.619492] Subtest pi-isolated: SUCCESS (52.747s)
[143.297461] [015/133] (877s left) perf_pmu (init-busy)
[143.381672] Starting subtest: init-busy
[143.382529] Starting dynamic subtest: rcs0
[143.383401] Dynamic subtest rcs0: SUCCESS (0.001s)
[143.390026] Starting dynamic subtest: bcs0
[143.390893] Dynamic subtest bcs0: SUCCESS (0.000s)
[143.397183] Starting dynamic subtest: vcs0
[143.397993] Dynamic subtest vcs0: SUCCESS (0.001s)
[143.404291] Starting dynamic subtest: vcs1
[143.405113] Dynamic subtest vcs1: SUCCESS (0.000s)
[143.411205] Starting dynamic subtest: vecs0
[143.412410] Dynamic subtest vecs0: SUCCESS (0.000s)
[143.418624] Starting dynamic subtest: ccs0
[143.419501] Dynamic subtest ccs0: SUCCESS (0.000s)
[143.420353] Subtest init-busy: SUCCESS (0.006s)
[143.501787] [016/133] (877s left) gem_exec_flush (basic-batch-kernel-default-wb)
[143.563873] Starting subtest: basic-batch-kernel-default-wb
[150.254516] Subtest basic-batch-kernel-default-wb: SUCCESS (6.689s)
[150.460709] [017/133] (870s left) kms_ccs (crc-primary-suspend-4-tiled-lnl-ccs)
[150.560957] Starting subtest: crc-primary-suspend-4-tiled-lnl-ccs
[150.563120] Subtest crc-primary-suspend-4-tiled-lnl-ccs: SKIP (0.000s)
[151.657454] [018/133] (869s left) syncobj_timeline (multi-wait-available-unsubmitted-submitted)
[151.716865] Starting subtest: multi-wait-available-unsubmitted-submitted
[151.717904] Subtest multi-wait-available-unsubmitted-submitted: SUCCESS (0.001s)
[151.826752] [019/133] (869s left) kms_atomic_transition (plane-all-modeset-transition-fencing)
[151.904530] Starting subtest: plane-all-modeset-transition-fencing
[151.906472] Subtest plane-all-modeset-transition-fencing: SKIP (0.000s)
[151.970032] [020/133] (869s left) gem_exec_create (madvise)
[152.026250] Starting subtest: madvise
[152.027182] Starting dynamic subtest: smem
[172.182355] Dynamic subtest smem: SUCCESS (20.155s)
[172.183439] Subtest madvise: SUCCESS (20.156s)
[173.849341] [021/133] (847s left) syncobj_timeline (invalid-multi-wait-all-unsubmitted-submitted-signaled)
[173.892796] Starting subtest: invalid-multi-wait-all-unsubmitted-submitted-signaled
[173.893784] Subtest invalid-multi-wait-all-unsubmitted-submitted-signaled: SUCCESS (0.000s)
[173.981603] [022/133] (847s left) gem_busy (extended)
[174.178871] Starting subtest: extended
[174.179992] Starting dynamic subtest: rcs0
[174.267998] Dynamic subtest rcs0: SUCCESS (0.091s)
[174.277576] Starting dynamic subtest: bcs0
[174.312736] Dynamic subtest bcs0: SUCCESS (0.043s)
[174.321591] Starting dynamic subtest: vcs0
[175.905819] Dynamic subtest vcs0: SUCCESS (1.581s)
[175.913576] Starting dynamic subtest: vcs1
[177.889546] Dynamic subtest vcs1: SUCCESS (1.982s)
[177.896644] Starting dynamic subtest: vecs0
[179.938071] Dynamic subtest vecs0: SUCCESS (2.045s)
[179.945576] Starting dynamic subtest: ccs0
[179.974315] Dynamic subtest ccs0: SUCCESS (0.046s)
[179.975262] Subtest extended: SUCCESS (5.798s)
[180.206814] [023/133] (841s left) kms_setmode (basic)
[180.255330] Starting subtest: basic
[180.613799] Starting dynamic subtest: pipe-A-eDP-1
[182.682605] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.059s)
[183.022027] Starting dynamic subtest: pipe-B-eDP-1
[185.115254] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.090s)
[185.416299] Subtest basic: SUCCESS (5.159s)
[186.237418] [024/133] (835s left) kms_cursor_crc (cursor-sliding-128x42)
[186.447409] Starting subtest: cursor-sliding-128x42
[186.495615] Subtest cursor-sliding-128x42: SKIP (0.046s)
[186.674651] [025/133] (834s left) kms_flip (flip-vs-panning)
[186.765938] Starting subtest: flip-vs-panning
[186.768179] Starting dynamic subtest: A-eDP1
[195.470290] Dynamic subtest A-eDP1: SUCCESS (8.703s)
[195.479750] Starting dynamic subtest: B-eDP1
[204.208963] Dynamic subtest B-eDP1: SUCCESS (8.737s)
[204.218946] Starting dynamic subtest: C-eDP1
[212.925386] Dynamic subtest C-eDP1: SUCCESS (8.714s)
[212.934067] Starting dynamic subtest: D-eDP1
[221.655042] Dynamic subtest D-eDP1: SUCCESS (8.729s)
[221.659194] Subtest flip-vs-panning: SUCCESS (34.894s)
[222.812078] [026/133] (798s left) kms_frontbuffer_tracking (psr-1p-primscrn-shrfb-plflip-blt)
[222.902533] Starting subtest: psr-1p-primscrn-shrfb-plflip-blt
[230.420974] Subtest psr-1p-primscrn-shrfb-plflip-blt: SUCCESS (7.521s)
[230.523669] [027/133] (790s left) gem_workarounds (suspend-resume-context)
[230.592601] Starting subtest: suspend-resume-context
[247.183087] Subtest suspend-resume-context: SUCCESS (1.683s)
[255.373149] [028/133] (774s left) kms_plane (pixel-format-4-tiled-mtl-rc-ccs-modifier-source-clamping)
[255.460950] Starting subtest: pixel-format-4-tiled-mtl-rc-ccs-modifier-source-clamping
[255.489493] Starting dynamic subtest: pipe-A-plane-0
[255.778327] Dynamic subtest pipe-A-plane-0: SUCCESS (0.289s)
[255.785722] Starting dynamic subtest: pipe-A-plane-3
[256.011744] Dynamic subtest pipe-A-plane-3: SUCCESS (0.233s)
[257.155805] Starting dynamic subtest: pipe-B-plane-0
[257.446700] Dynamic subtest pipe-B-plane-0: SUCCESS (0.300s)
[257.455624] Starting dynamic subtest: pipe-B-plane-3
[257.702153] Dynamic subtest pipe-B-plane-3: SUCCESS (0.253s)
[258.014129] Subtest pixel-format-4-tiled-mtl-rc-ccs-modifier-source-clamping: SUCCESS (2.552s)
[258.828747] [029/133] (770s left) kms_chamelium_color (degamma)
[258.908536] Subtest degamma: SKIP (0.000s)
[258.948142] [030/133] (770s left) gem_vm_create (isolation)
[258.996400] Starting subtest: isolation
[259.004619] Subtest isolation: SUCCESS (0.008s)
[259.124580] [031/133] (770s left) syncobj_wait (wait-delayed-signal)
[259.171757] Starting subtest: wait-delayed-signal
[259.275148] Subtest wait-delayed-signal: SUCCESS (0.102s)
[259.359073] [032/133] (770s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-indfb-msflip-blt)
[259.444140] Starting subtest: fbcpsr-1p-primscrn-indfb-msflip-blt
[266.806891] Subtest fbcpsr-1p-primscrn-indfb-msflip-blt: SUCCESS (7.362s)
[266.928354] [033/133] (762s left) kms_flip_scaled_crc (flip-32bpp-4tile-to-64bpp-4tile-upscaling)
[267.038013] Starting subtest: flip-32bpp-4tile-to-64bpp-4tile-upscaling
[267.039917] Starting dynamic subtest: pipe-A-default-mode
[269.796334] Dynamic subtest pipe-A-default-mode: SUCCESS (2.755s)
[269.797356] Subtest flip-32bpp-4tile-to-64bpp-4tile-upscaling: SUCCESS (2.758s)
[270.671207] [034/133] (759s left) kms_prop_blob (invalid-set-prop)
[270.720170] Starting subtest: invalid-set-prop
[270.721085] Subtest invalid-set-prop: SUCCESS (0.000s)
[270.806295] [035/133] (758s left) gem_exec_schedule (noreorder-priority)
[270.972906] Starting subtest: noreorder-priority
[270.973807] Starting dynamic subtest: rcs0
[272.104376] Dynamic subtest rcs0: SUCCESS (1.134s)
[272.114674] Starting dynamic subtest: vcs0
[273.815401] Dynamic subtest vcs0: SUCCESS (1.699s)
[273.825425] Starting dynamic subtest: vcs1
[275.806427] Dynamic subtest vcs1: SUCCESS (1.988s)
[275.816536] Starting dynamic subtest: vecs0
[277.851672] Dynamic subtest vecs0: SUCCESS (2.043s)
[277.863036] Starting dynamic subtest: ccs0
[278.984712] Dynamic subtest ccs0: SUCCESS (1.139s)
[278.986386] Subtest noreorder-priority: SUCCESS (8.014s)
[279.161494] [036/133] (750s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-render)
[279.263789] Starting subtest: fbcpsr-rgb101010-draw-render
[286.044065] Subtest fbcpsr-rgb101010-draw-render: SUCCESS (6.781s)
[286.172561] [037/133] (743s left) kms_frontbuffer_tracking (fbc-2p-shrfb-fliptrack-mmap-gtt)
[286.264836] Starting subtest: fbc-2p-shrfb-fliptrack-mmap-gtt
[286.266672] Subtest fbc-2p-shrfb-fliptrack-mmap-gtt: SKIP (0.000s)
[286.346843] [038/133] (743s left) kms_psr (fbc-pr-cursor-plane-move)
[286.429493] Starting subtest: fbc-pr-cursor-plane-move
[286.431372] Subtest fbc-pr-cursor-plane-move: SKIP (0.000s)
[286.495438] [039/133] (743s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-mmap-cpu)
[286.602088] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-mmap-cpu
[290.201057] Subtest fbc-1p-primscrn-cur-indfb-draw-mmap-cpu: SUCCESS (3.600s)
[291.319146] [040/133] (738s left) syncobj_wait (single-wait-submitted)
[291.363499] Starting subtest: single-wait-submitted
[291.482005] Subtest single-wait-submitted: SUCCESS (0.107s)
[291.541254] [041/133] (738s left) kms_psr (fbc-psr2-cursor-plane-onoff)
[291.622518] Starting subtest: fbc-psr2-cursor-plane-onoff
[291.623445] Starting dynamic subtest: eDP-1
[291.625172] Dynamic subtest eDP-1: SKIP (0.000s)
[291.626922] Subtest fbc-psr2-cursor-plane-onoff: SKIP (0.001s)
[291.704758] [042/133] (738s left) gem_ctx_persistence (legacy-engines-mixed)
[291.751896] Starting subtest: legacy-engines-mixed
[291.752852] Starting dynamic subtest: render
[291.822919] Dynamic subtest render: SUCCESS (0.070s)
[291.834571] Starting dynamic subtest: bsd1
[291.875883] Dynamic subtest bsd1: SUCCESS (0.050s)
[291.887621] Starting dynamic subtest: bsd2
[291.901333] Dynamic subtest bsd2: SUCCESS (0.023s)
[291.908798] Starting dynamic subtest: blt
[291.989884] Dynamic subtest blt: SUCCESS (0.087s)
[292.001769] Starting dynamic subtest: vebox
[292.014200] Dynamic subtest vebox: SUCCESS (0.022s)
[292.015089] Subtest legacy-engines-mixed: SUCCESS (0.263s)
[292.135213] [043/133] (737s left) kms_ccs (crc-sprite-planes-basic-y-tiled-gen12-rc-ccs)
[292.232463] Starting subtest: crc-sprite-planes-basic-y-tiled-gen12-rc-ccs
[292.233360] Starting dynamic subtest: pipe-A-eDP-1
[292.255490] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[292.263982] Starting dynamic subtest: pipe-B-eDP-1
[292.285460] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[292.293003] Starting dynamic subtest: pipe-C-eDP-1
[292.312862] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[292.320866] Starting dynamic subtest: pipe-D-eDP-1
[292.343305] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[292.344902] Subtest crc-sprite-planes-basic-y-tiled-gen12-rc-ccs: SKIP (0.009s)
[294.492273] [044/133] (735s left) kms_plane_lowres (tiling-x)
[294.572515] Starting subtest: tiling-x
[294.573607] Starting dynamic subtest: pipe-A-eDP-1
[294.575299] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[294.868379] Starting dynamic subtest: pipe-B-eDP-1
[294.870965] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[294.878469] Starting dynamic subtest: pipe-C-eDP-1
[294.880404] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[294.887611] Starting dynamic subtest: pipe-D-eDP-1
[294.889385] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[294.891031] Subtest tiling-x: SKIP (0.296s)
[295.705484] [045/133] (734s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-onoff)
[295.797813] Starting subtest: fbc-2p-primscrn-spr-indfb-onoff
[295.799713] Subtest fbc-2p-primscrn-spr-indfb-onoff: SKIP (0.000s)
[295.895999] [046/133] (734s left) kms_frontbuffer_tracking (fbc-2p-rte)
[295.990887] Starting subtest: fbc-2p-rte
[295.992537] Subtest fbc-2p-rte: SKIP (0.000s)
[296.083052] [047/133] (734s left) kms_cursor_legacy (flip-vs-cursor-busy-crc-legacy)
[296.190260] Starting subtest: flip-vs-cursor-busy-crc-legacy
[297.012951] Subtest flip-vs-cursor-busy-crc-legacy: SUCCESS (0.822s)
[297.836991] [048/133] (732s left) gem_ctx_bad_destroy (invalid-pad)
[297.891180] Starting subtest: invalid-pad
[297.892355] Subtest invalid-pad: SUCCESS (0.000s)
[297.958805] [049/133] (732s left) kms_flip (2x-dpms-vs-vblank-race-interruptible)
[298.039624] Starting subtest: 2x-dpms-vs-vblank-race-interruptible
[298.051492] Subtest 2x-dpms-vs-vblank-race-interruptible: SKIP (0.011s)
[298.124913] [050/133] (732s left) kms_feature_discovery (display-3x)
[298.218491] Starting subtest: display-3x
[298.220158] Subtest display-3x: SKIP (0.000s)
[298.287221] [051/133] (732s left) i915_hangman (detector)
[298.347783] Starting subtest: detector
[298.348685] Starting dynamic subtest: rcs0
[308.796939] Dynamic subtest rcs0: SUCCESS (10.438s)
[308.807996] Starting dynamic subtest: bcs0
[320.763830] Dynamic subtest bcs0: SUCCESS (11.963s)
[320.774271] Starting dynamic subtest: vcs0
[332.730817] Dynamic subtest vcs0: SUCCESS (11.965s)
[332.745413] Starting dynamic subtest: vcs1
[343.739564] Dynamic subtest vcs1: SUCCESS (11.005s)
[343.749790] Starting dynamic subtest: vecs0
[354.810577] Dynamic subtest vecs0: SUCCESS (11.068s)
[354.821802] Starting dynamic subtest: ccs0
[365.818379] Dynamic subtest ccs0: SUCCESS (11.005s)
[365.819828] Subtest detector: SUCCESS (67.460s)
[365.885206] [052/133] (664s left) kms_ccs (bad-rotation-90-y-tiled-ccs)
[365.983235] Starting subtest: bad-rotation-90-y-tiled-ccs
[365.984088] Starting dynamic subtest: pipe-A-eDP-1
[365.992732] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[366.000535] Starting dynamic subtest: pipe-B-eDP-1
[366.008687] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[366.015987] Starting dynamic subtest: pipe-C-eDP-1
[366.024272] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[366.031470] Starting dynamic subtest: pipe-D-eDP-1
[366.039673] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[366.041515] Subtest bad-rotation-90-y-tiled-ccs: SKIP (0.005s)
[368.304324] [053/133] (662s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip)
[368.399739] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip
[369.236510] Subtest 4-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip: SUCCESS (0.837s)
[369.388808] [054/133] (660s left) kms_atomic (plane-primary-overlay-mutable-zpos)
[369.480155] Starting subtest: plane-primary-overlay-mutable-zpos
[372.930353] Subtest plane-primary-overlay-mutable-zpos: SKIP (3.449s)
[374.121925] [055/133] (656s left) gem_spin_batch (engines)
[374.184069] Starting subtest: engines
[374.185164] Starting dynamic subtest: rcs0
[377.432358] Dynamic subtest rcs0: SUCCESS (3.237s)
[377.442219] Starting dynamic subtest: bcs0
[380.708057] Dynamic subtest bcs0: SUCCESS (3.235s)
[380.718595] Starting dynamic subtest: vcs0
[383.945674] Dynamic subtest vcs0: SUCCESS (3.236s)
[383.955743] Starting dynamic subtest: vcs1
[387.186430] Dynamic subtest vcs1: SUCCESS (3.237s)
[387.196590] Starting dynamic subtest: vecs0
[390.423631] Dynamic subtest vecs0: SUCCESS (3.235s)
[390.434136] Starting dynamic subtest: ccs0
[393.665781] Dynamic subtest ccs0: SUCCESS (3.238s)
[393.667024] Subtest engines: SUCCESS (19.435s)
[393.862427] [056/133] (636s left) gem_exec_fence (syncobj-timeline-repeat)
[394.499693] Starting subtest: syncobj-timeline-repeat
[394.752973] Subtest syncobj-timeline-repeat: SUCCESS (0.255s)
[395.853701] [FACT gem_exec_fence (syncobj-timeline-repeat)] new: kernel.kmod_is_loaded.vgem: true
[395.855891] [057/133] (634s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-indfb-msflip-blt)
[395.949393] Starting subtest: fbc-2p-scndscrn-indfb-msflip-blt
[395.951088] Subtest fbc-2p-scndscrn-indfb-msflip-blt: SKIP (0.000s)
[396.041956] [058/133] (634s left) gem_exec_flush (basic-wb-rw-default)
[396.097480] Starting subtest: basic-wb-rw-default
[401.552488] Subtest basic-wb-rw-default: SUCCESS (5.455s)
[401.737830] [059/133] (628s left) kms_vblank (wait-idle)
[401.834576] Starting subtest: wait-idle
[401.835567] Starting dynamic subtest: pipe-A-eDP-1
[403.588303] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.753s)
[403.598880] Starting dynamic subtest: pipe-D-eDP-1
[406.044126] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.453s)
[406.045086] Subtest wait-idle: SUCCESS (4.209s)
[406.885592] [060/133] (623s left) kms_cursor_crc (cursor-offscreen-512x170)
[407.170897] Starting subtest: cursor-offscreen-512x170
[407.172754] Subtest cursor-offscreen-512x170: SKIP (0.001s)
[407.316622] [061/133] (623s left) kms_sequence (queue-busy)
[407.395464] Starting subtest: queue-busy
[407.396364] Starting dynamic subtest: pipe-A-eDP-1
[409.329635] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.934s)
[409.338678] Starting dynamic subtest: pipe-B-eDP-1
[411.987858] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.657s)
[411.997768] Starting dynamic subtest: pipe-C-eDP-1
[414.593594] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.603s)
[414.601565] Starting dynamic subtest: pipe-D-eDP-1
[417.130177] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.535s)
[417.130997] Subtest queue-busy: SUCCESS (9.735s)
[417.929083] [062/133] (612s left) kms_rotation_crc (primary-yf-tiled-reflect-x-0)
[418.012668] Starting subtest: primary-yf-tiled-reflect-x-0
[418.072463] Subtest primary-yf-tiled-reflect-x-0: SKIP (0.059s)
[418.185384] [063/133] (612s left) perf_pmu (semaphore-wait)
[418.221167] Starting subtest: semaphore-wait
[418.222255] Starting dynamic subtest: rcs0
[418.744070] Dynamic subtest rcs0: SUCCESS (0.513s)
[418.757678] Starting dynamic subtest: bcs0
[419.258034] Dynamic subtest bcs0: SUCCESS (0.511s)
[419.268378] Starting dynamic subtest: vcs0
[419.770981] Dynamic subtest vcs0: SUCCESS (0.510s)
[419.781943] Starting dynamic subtest: vcs1
[420.284053] Dynamic subtest vcs1: SUCCESS (0.510s)
[420.293446] Starting dynamic subtest: vecs0
[420.797130] Dynamic subtest vecs0: SUCCESS (0.510s)
[420.806446] Starting dynamic subtest: ccs0
[421.313510] Dynamic subtest ccs0: SUCCESS (0.513s)
[421.314593] Subtest semaphore-wait: SUCCESS (3.085s)
[422.887574] [064/133] (607s left) i915_query (query-regions-unallocated)
[422.930917] Starting subtest: query-regions-unallocated
[422.931898] Subtest query-regions-unallocated: SUCCESS (0.000s)
[423.033660] [065/133] (607s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-pwrite)
[423.130152] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-pwrite
[423.131988] Subtest psr-2p-scndscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[423.223803] [066/133] (607s left) syncobj_timeline (single-wait-for-submit-signaled)
[423.277859] Starting subtest: single-wait-for-submit-signaled
[423.280442] Subtest single-wait-for-submit-signaled: SUCCESS (0.000s)
[423.384133] [067/133] (607s left) gem_exec_schedule (u-independent)
[423.443328] Starting subtest: u-independent
[423.444197] Starting dynamic subtest: rcs0
[424.796757] Dynamic subtest rcs0: SUCCESS (1.344s)
[424.808482] Starting dynamic subtest: vcs0
[426.861173] Dynamic subtest vcs0: SUCCESS (2.062s)
[426.873468] Starting dynamic subtest: vcs1
[428.852417] Dynamic subtest vcs1: SUCCESS (1.989s)
[428.863711] Starting dynamic subtest: vecs0
[430.828557] Dynamic subtest vecs0: SUCCESS (1.974s)
[430.840457] Starting dynamic subtest: ccs0
[432.796816] Dynamic subtest ccs0: SUCCESS (1.965s)
[432.797960] Subtest u-independent: SUCCESS (9.345s)
[433.086944] [068/133] (597s left) gem_ctx_exec (basic-norecovery)
[433.141553] Starting subtest: basic-norecovery
[433.495771] Subtest basic-norecovery: SUCCESS (0.353s)
[433.633280] [069/133] (597s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-mmap-cpu)
[433.721793] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-mmap-cpu
[433.723465] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[433.804564] [070/133] (597s left) kms_addfb_basic (bad-pitch-63)
[433.843517] Starting subtest: bad-pitch-63
[433.844575] Subtest bad-pitch-63: SUCCESS (0.000s)
[433.972642] [071/133] (596s left) kms_big_fb (4-tiled-addfb-size-overflow)
[434.067117] Starting subtest: 4-tiled-addfb-size-overflow
[434.068203] Subtest 4-tiled-addfb-size-overflow: SUCCESS (0.000s)
[434.146554] [072/133] (596s left) kms_plane_scaling (planes-upscale-factor-0-25-downscale-factor-0-5)
[434.238331] Starting subtest: planes-upscale-factor-0-25-downscale-factor-0-5
[434.239570] Starting dynamic subtest: pipe-A
[434.258834] Dynamic subtest pipe-A: SKIP (0.018s)
[434.270431] Starting dynamic subtest: pipe-B
[434.289000] Dynamic subtest pipe-B: SKIP (0.030s)
[434.297694] Starting dynamic subtest: pipe-C
[434.319935] Dynamic subtest pipe-C: SKIP (0.030s)
[434.328635] Starting dynamic subtest: pipe-D
[434.351231] Dynamic subtest pipe-D: SKIP (0.030s)
[434.352955] Subtest planes-upscale-factor-0-25-downscale-factor-0-5: SKIP (0.111s)
[434.455965] [073/133] (596s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-fullscreen)
[434.546877] Starting subtest: psr-2p-scndscrn-spr-indfb-fullscreen
[434.548527] Subtest psr-2p-scndscrn-spr-indfb-fullscreen: SKIP (0.000s)
[434.627491] [074/133] (596s left) kms_content_protection (dp-mst-type-0)
[434.759195] Starting subtest: dp-mst-type-0
[434.761298] Subtest dp-mst-type-0: SKIP (0.000s)
[434.893706] [075/133] (596s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-indfb-plflip-blt)
[434.981775] Starting subtest: fbcpsr-2p-scndscrn-indfb-plflip-blt
[434.983472] Subtest fbcpsr-2p-scndscrn-indfb-plflip-blt: SKIP (0.000s)
[435.067822] [076/133] (596s left) gem_exec_whisper (basic-queues-all)
[435.127052] Starting subtest: basic-queues-all
[445.798769] Subtest basic-queues-all: SUCCESS (10.669s)
[445.980038] [077/133] (585s left) syncobj_timeline (device-submit-unordered)
[446.033502] Starting subtest: device-submit-unordered
[446.034463] Subtest device-submit-unordered: SUCCESS (0.000s)
[446.126506] [078/133] (585s left) kms_frontbuffer_tracking (fbcpsr-2p-pri-indfb-multidraw)
[446.226091] Starting subtest: fbcpsr-2p-pri-indfb-multidraw
[446.227839] Subtest fbcpsr-2p-pri-indfb-multidraw: SKIP (0.000s)
[446.315471] [079/133] (584s left) i915_pm_rps (basic-api)
[446.372548] Starting subtest: basic-api
[446.374427] Subtest basic-api: SKIP (0.001s)
[446.463657] [080/133] (584s left) kms_psr2_sf (fbc-psr2-overlay-plane-move-continuous-sf)
[446.546759] Starting subtest: fbc-psr2-overlay-plane-move-continuous-sf
[446.547614] Starting dynamic subtest: pipe-A-eDP-1
[446.635291] Dynamic subtest pipe-A-eDP-1: SKIP (0.089s)
[446.644413] Starting dynamic subtest: pipe-B-eDP-1
[447.803570] Dynamic subtest pipe-B-eDP-1: SKIP (1.167s)
[447.805371] Subtest fbc-psr2-overlay-plane-move-continuous-sf: SKIP (1.258s)
[448.990843] [081/133] (582s left) kms_big_fb (x-tiled-32bpp-rotate-180)
[449.102231] Starting subtest: x-tiled-32bpp-rotate-180
[450.571016] Subtest x-tiled-32bpp-rotate-180: SUCCESS (1.469s)
[450.689593] [082/133] (580s left) gem_exec_balancer (persistence)
[450.947937] Starting subtest: persistence
[451.930951] Subtest persistence: SUCCESS (0.980s)
[452.026378] [083/133] (579s left) dmabuf_sync_file (import-basic)
[452.071379] Starting subtest: import-basic
[452.072219] Subtest import-basic: SUCCESS (0.001s)
[452.122455] [084/133] (579s left) kms_vrr (negative-basic)
[452.222650] Starting subtest: negative-basic
[452.225184] Starting dynamic subtest: pipe-A-eDP-1
[457.694604] Dynamic subtest pipe-A-eDP-1: SUCCESS (5.420s)
[457.932180] Subtest negative-basic: SUCCESS (5.709s)
[458.812947] [085/133] (572s left) gem_mmap_wc (read-write-distinct)
[458.864035] Subtest read-write-distinct: SKIP (0.000s)
[458.923740] [086/133] (572s left) sysfs_heartbeat_interval (invalid)
[458.974813] Starting subtest: invalid
[458.975713] Starting dynamic subtest: vecs0
[458.976636] Dynamic subtest vecs0: SUCCESS (0.000s)
[458.985272] Starting dynamic subtest: ccs0
[458.986121] Dynamic subtest ccs0: SUCCESS (0.000s)
[458.994345] Starting dynamic subtest: vcs0
[458.995189] Dynamic subtest vcs0: SUCCESS (0.000s)
[459.003349] Starting dynamic subtest: bcs0
[459.004175] Dynamic subtest bcs0: SUCCESS (0.000s)
[459.012285] Starting dynamic subtest: rcs0
[459.013231] Dynamic subtest rcs0: SUCCESS (0.000s)
[459.021404] Starting dynamic subtest: vcs1
[459.022289] Dynamic subtest vcs1: SUCCESS (0.000s)
[459.023199] Subtest invalid: SUCCESS (0.005s)
[459.072084] [087/133] (572s left) kms_cursor_edge_walk (128x128-top-edge)
[459.158649] Starting subtest: 128x128-top-edge
[459.159609] Starting dynamic subtest: pipe-A-eDP-1
[462.571777] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.412s)
[462.580324] Starting dynamic subtest: pipe-D-eDP-1
[465.701839] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.129s)
[465.702724] Subtest 128x128-top-edge: SUCCESS (6.544s)
[466.497358] [088/133] (565s left) gem_exec_params (rel-constants-invalid-ring)
[466.552894] Starting subtest: rel-constants-invalid-ring
[466.553986] Subtest rel-constants-invalid-ring: SUCCESS (0.000s)
[466.665452] [089/133] (564s left) gem_exec_params (readonly)
[466.718207] Starting subtest: readonly
[466.719383] Subtest readonly: SUCCESS (0.002s)
[466.840985] [090/133] (564s left) gem_render_copy (yf-tiled-mc-ccs-to-vebox-y-tiled)
[466.893040] Starting subtest: yf-tiled-mc-ccs-to-vebox-y-tiled
[466.894801] Subtest yf-tiled-mc-ccs-to-vebox-y-tiled: SKIP (0.000s)
[467.083716] [091/133] (564s left) kms_async_flips (basic-modeset-with-all-modifiers-formats)
[467.162351] Starting subtest: basic-modeset-with-all-modifiers-formats
[467.536144] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-XRGB8888
[468.283036] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-XRGB8888: SUCCESS (0.747s)
[468.292224] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-XRGB2101010
[468.305190] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-XRGB2101010: SUCCESS (0.021s)
[468.313650] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-XRGB16161616F
[468.327474] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-XRGB16161616F: SUCCESS (0.022s)
[468.335675] Starting dynamic subtest: pipe-A-eDP-1-4-RGB565
[468.472033] Dynamic subtest pipe-A-eDP-1-4-RGB565: SUCCESS (0.144s)
[468.481150] Starting dynamic subtest: pipe-A-eDP-1-4-XRGB8888
[468.494207] Dynamic subtest pipe-A-eDP-1-4-XRGB8888: SUCCESS (0.021s)
[468.502383] Starting dynamic subtest: pipe-A-eDP-1-4-XRGB2101010
[468.516578] Dynamic subtest pipe-A-eDP-1-4-XRGB2101010: SUCCESS (0.022s)
[468.525054] Starting dynamic subtest: pipe-A-eDP-1-4-XRGB16161616F
[468.538800] Dynamic subtest pipe-A-eDP-1-4-XRGB16161616F: SUCCESS (0.021s)
[468.547161] Starting dynamic subtest: pipe-A-eDP-1-4-YUYV
[468.560987] Dynamic subtest pipe-A-eDP-1-4-YUYV: SUCCESS (0.021s)
[468.569445] Starting dynamic subtest: pipe-A-eDP-1-4-Y210
[468.583286] Dynamic subtest pipe-A-eDP-1-4-Y210: SUCCESS (0.021s)
[468.591648] Starting dynamic subtest: pipe-A-eDP-1-4-XYUV8888
[468.605442] Dynamic subtest pipe-A-eDP-1-4-XYUV8888: SUCCESS (0.021s)
[468.613888] Starting dynamic subtest: pipe-A-eDP-1-4-XV30
[468.627744] Dynamic subtest pipe-A-eDP-1-4-XV30: SUCCESS (0.021s)
[468.636188] Starting dynamic subtest: pipe-A-eDP-1-4-XV36
[468.649951] Dynamic subtest pipe-A-eDP-1-4-XV36: SUCCESS (0.021s)
[468.658672] Starting dynamic subtest: pipe-A-eDP-1-x-RGB565
[468.816544] Dynamic subtest pipe-A-eDP-1-x-RGB565: SUCCESS (0.166s)
[468.829063] Starting dynamic subtest: pipe-A-eDP-1-x-XRGB8888
[468.838712] Dynamic subtest pipe-A-eDP-1-x-XRGB8888: SUCCESS (0.020s)
[468.847137] Starting dynamic subtest: pipe-A-eDP-1-x-XRGB2101010
[468.861546] Dynamic subtest pipe-A-eDP-1-x-XRGB2101010: SUCCESS (0.021s)
[468.877484] Starting dynamic subtest: pipe-A-eDP-1-x-XRGB16161616F
[468.883177] Dynamic subtest pipe-A-eDP-1-x-XRGB16161616F: SUCCESS (0.021s)
[468.891991] Starting dynamic subtest: pipe-A-eDP-1-x-YUYV
[468.905345] Dynamic subtest pipe-A-eDP-1-x-YUYV: SUCCESS (0.021s)
[468.913663] Starting dynamic subtest: pipe-A-eDP-1-x-Y210
[468.927749] Dynamic subtest pipe-A-eDP-1-x-Y210: SUCCESS (0.022s)
[468.936138] Starting dynamic subtest: pipe-A-eDP-1-x-XYUV8888
[468.949966] Dynamic subtest pipe-A-eDP-1-x-XYUV8888: SUCCESS (0.021s)
[468.958276] Starting dynamic subtest: pipe-A-eDP-1-x-XV30
[468.972160] Dynamic subtest pipe-A-eDP-1-x-XV30: SUCCESS (0.022s)
[468.980478] Starting dynamic subtest: pipe-A-eDP-1-x-XV36
[468.994448] Dynamic subtest pipe-A-eDP-1-x-XV36: SUCCESS (0.021s)
[469.002924] Starting dynamic subtest: pipe-A-eDP-1-linear-RGB565
[469.161247] Dynamic subtest pipe-A-eDP-1-linear-RGB565: SUCCESS (0.166s)
[469.169862] Starting dynamic subtest: pipe-A-eDP-1-linear-XRGB8888
[469.183524] Dynamic subtest pipe-A-eDP-1-linear-XRGB8888: SUCCESS (0.021s)
[469.191636] Starting dynamic subtest: pipe-A-eDP-1-linear-XRGB2101010
[469.205802] Dynamic subtest pipe-A-eDP-1-linear-XRGB2101010: SUCCESS (0.021s)
[469.213909] Starting dynamic subtest: pipe-A-eDP-1-linear-XRGB16161616F
[469.228016] Dynamic subtest pipe-A-eDP-1-linear-XRGB16161616F: SUCCESS (0.021s)
[469.236093] Starting dynamic subtest: pipe-A-eDP-1-linear-YUYV
[469.250221] Dynamic subtest pipe-A-eDP-1-linear-YUYV: SUCCESS (0.022s)
[469.258239] Starting dynamic subtest: pipe-A-eDP-1-linear-Y210
[469.272482] Dynamic subtest pipe-A-eDP-1-linear-Y210: SUCCESS (0.021s)
[469.280563] Starting dynamic subtest: pipe-A-eDP-1-linear-XYUV8888
[469.294777] Dynamic subtest pipe-A-eDP-1-linear-XYUV8888: SUCCESS (0.022s)
[469.303013] Starting dynamic subtest: pipe-A-eDP-1-linear-XV30
[469.316957] Dynamic subtest pipe-A-eDP-1-linear-XV30: SUCCESS (0.021s)
[469.325234] Starting dynamic subtest: pipe-A-eDP-1-linear-XV36
[469.339065] Dynamic subtest pipe-A-eDP-1-linear-XV36: SUCCESS (0.021s)
[469.726606] Subtest basic-modeset-with-all-modifiers-formats: SUCCESS (2.565s)
[470.571403] [092/133] (561s left) gen9_exec_parse (bb-oversize)
[470.630612] Subtest bb-oversize: SKIP (0.000s)
[470.696715] [093/133] (561s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-32bpp-ytileccs-upscaling)
[470.789235] Starting subtest: flip-32bpp-ytile-to-32bpp-ytileccs-upscaling
[470.790947] Subtest flip-32bpp-ytile-to-32bpp-ytileccs-upscaling: SKIP (0.000s)
[470.863130] [094/133] (560s left) syncobj_timeline (invalid-signal-zero-handles)
[470.926918] Starting subtest: invalid-signal-zero-handles
[470.927859] Subtest invalid-signal-zero-handles: SUCCESS (0.000s)
[471.039891] [095/133] (560s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-mmap-gtt)
[471.129037] Starting subtest: fbc-rgb101010-draw-mmap-gtt
[471.131077] Subtest fbc-rgb101010-draw-mmap-gtt: SKIP (0.000s)
[471.239425] [096/133] (560s left) kms_pm_backlight (fade)
[471.321495] Starting subtest: fade
[471.372757] Starting dynamic subtest: eDP-1
[473.855724] Dynamic subtest eDP-1: SUCCESS (2.482s)
[473.857130] Subtest fade: SUCCESS (2.534s)
[474.696505] [097/133] (557s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-0)
[474.790540] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-0
[474.792075] Subtest y-tiled-max-hw-stride-32bpp-rotate-0: SKIP (0.000s)
[474.890906] [098/133] (557s left) gem_ccs (suspend-resume)
[474.943690] Starting subtest: suspend-resume
[474.945630] Subtest suspend-resume: SKIP (0.000s)
[475.046329] [099/133] (556s left) gem_partial_pwrite_pread (reads)
[475.113612] Subtest reads: SKIP (0.000s)
[475.178505] [100/133] (556s left) kms_lease (lease-revoke)
[475.262551] Starting subtest: lease-revoke
[475.263439] Starting dynamic subtest: pipe-A-eDP-1
[475.296334] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.033s)
[475.306667] Starting dynamic subtest: pipe-B-eDP-1
[475.322706] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.027s)
[475.333450] Starting dynamic subtest: pipe-C-eDP-1
[475.356264] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.031s)
[475.365014] Starting dynamic subtest: pipe-D-eDP-1
[475.385325] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.028s)
[475.386247] Subtest lease-revoke: SUCCESS (0.123s)
[475.496336] [101/133] (556s left) kms_atomic_transition (plane-all-modeset-transition-internal-panels)
[475.593616] Starting subtest: plane-all-modeset-transition-internal-panels
[475.594575] Starting dynamic subtest: pipe-A-eDP-1
[476.960958] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.357s)
[477.234007] Starting dynamic subtest: pipe-B-eDP-1
[478.285121] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.052s)
[478.551314] Subtest plane-all-modeset-transition-internal-panels: SUCCESS (2.958s)
[479.382917] [102/133] (552s left) kms_ccs (bad-rotation-90-4-tiled-mtl-rc-ccs)
[479.477444] Starting subtest: bad-rotation-90-4-tiled-mtl-rc-ccs
[479.478392] Starting dynamic subtest: pipe-A-eDP-1
[479.623284] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.141s)
[479.634428] Starting dynamic subtest: pipe-B-eDP-1
[479.642506] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[479.651242] Starting dynamic subtest: pipe-C-eDP-1
[479.658893] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.002s)
[479.667357] Starting dynamic subtest: pipe-D-eDP-1
[479.674677] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.002s)
[479.675508] Subtest bad-rotation-90-4-tiled-mtl-rc-ccs: SUCCESS (0.150s)
[481.940103] [103/133] (550s left) kms_plane_alpha_blend (alpha-basic)
[482.032798] Starting subtest: alpha-basic
[482.324576] Starting dynamic subtest: pipe-A-eDP-1
[484.233735] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.909s)
[484.262625] Starting dynamic subtest: pipe-D-eDP-1
[486.939602] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.684s)
[486.940485] Subtest alpha-basic: SUCCESS (4.907s)
[487.804075] [104/133] (544s left) gem_exec_balancer (bonded-true-hang)
[488.077599] Starting subtest: bonded-true-hang
[488.080168] Subtest bonded-true-hang: SKIP (0.000s)
[488.171551] [105/133] (543s left) kms_prime (basic-crc-vgem)
[488.253061] Starting subtest: basic-crc-vgem
[488.253916] Starting dynamic subtest: second-to-first
[489.236575] Dynamic subtest second-to-first: SUCCESS (0.984s)
[489.239577] Subtest basic-crc-vgem: SUCCESS (0.986s)
[489.324941] [106/133] (542s left) kms_frontbuffer_tracking (psr-2p-primscrn-shrfb-pgflip-blt)
[489.439054] Starting subtest: psr-2p-primscrn-shrfb-pgflip-blt
[489.440745] Subtest psr-2p-primscrn-shrfb-pgflip-blt: SKIP (0.000s)
[489.537898] [107/133] (542s left) gem_pxp (protected-encrypted-src-copy-not-readible)
[489.653164] Starting subtest: protected-encrypted-src-copy-not-readible
[489.774135] Subtest protected-encrypted-src-copy-not-readible: SUCCESS (0.112s)
[489.874620] [108/133] (542s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-0)
[489.964289] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-0
[489.965951] Subtest y-tiled-max-hw-stride-64bpp-rotate-0: SKIP (0.000s)
[490.063415] [109/133] (542s left) i915_drm_fdinfo (memory-info-resident)
[490.094523] Starting subtest: memory-info-resident
[490.095437] Starting dynamic subtest: smem0
[492.814956] Dynamic subtest smem0: SUCCESS (2.720s)
[492.816184] Subtest memory-info-resident: SUCCESS (2.721s)
[492.889365] [110/133] (539s left) syncobj_wait (multi-wait-for-submit-submitted-signaled)
[492.943427] Starting subtest: multi-wait-for-submit-submitted-signaled
[492.944328] Subtest multi-wait-for-submit-submitted-signaled: SUCCESS (0.000s)
[493.045998] [111/133] (539s left) kms_invalid_mode (overflow-vrefresh)
[493.154023] Starting subtest: overflow-vrefresh
[493.154902] Starting dynamic subtest: pipe-A-eDP-1
[493.452564] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.298s)
[493.461644] Starting dynamic subtest: pipe-B-eDP-1
[493.462605] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[493.470601] Starting dynamic subtest: pipe-C-eDP-1
[493.471573] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[493.480161] Starting dynamic subtest: pipe-D-eDP-1
[493.480986] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[493.481844] Subtest overflow-vrefresh: SUCCESS (0.304s)
[494.266685] [112/133] (538s left) kms_hdmi_inject (inject-4k)
[494.607452] Starting subtest: inject-4k
[494.924155] Subtest inject-4k: SUCCESS (0.317s)
[495.522649] [113/133] (536s left) gem_exec_reloc (basic-cpu-active)
[495.582351] Subtest basic-cpu-active: SKIP (0.000s)
[495.648534] [114/133] (536s left) gem_mmap_gtt (close-race)
[495.701978] Subtest close-race: SKIP (0.000s)
[495.762499] [115/133] (536s left) kms_addfb_basic (tile-pitch-mismatch)
[495.813255] Starting subtest: tile-pitch-mismatch
[495.815008] Subtest tile-pitch-mismatch: SKIP (0.000s)
[495.942805] [116/133] (536s left) kms_color_pipeline (plane-lut1d-ctm3x4-lut1d)
[496.042329] Starting subtest: plane-lut1d-ctm3x4-lut1d
[496.189991] Starting dynamic subtest: pipe-A-plane-0
[496.356302] Dynamic subtest pipe-A-plane-0: SUCCESS (0.166s)
[496.366276] Starting dynamic subtest: pipe-A-plane-1
[496.545258] Dynamic subtest pipe-A-plane-1: SUCCESS (0.188s)
[496.556940] Starting dynamic subtest: pipe-A-plane-2
[496.712004] Dynamic subtest pipe-A-plane-2: SUCCESS (0.166s)
[497.946147] Starting dynamic subtest: pipe-B-plane-0
[498.104341] Dynamic subtest pipe-B-plane-0: SUCCESS (0.166s)
[498.113672] Starting dynamic subtest: pipe-B-plane-1
[498.270153] Dynamic subtest pipe-B-plane-1: SUCCESS (0.165s)
[498.279008] Starting dynamic subtest: pipe-B-plane-2
[498.425902] Dynamic subtest pipe-B-plane-2: SUCCESS (0.155s)
[499.688617] Starting dynamic subtest: pipe-C-plane-0
[499.812832] Dynamic subtest pipe-C-plane-0: SUCCESS (0.133s)
[499.822045] Starting dynamic subtest: pipe-C-plane-1
[499.979409] Dynamic subtest pipe-C-plane-1: SUCCESS (0.166s)
[499.990066] Starting dynamic subtest: pipe-C-plane-2
[500.135047] Dynamic subtest pipe-C-plane-2: SUCCESS (0.155s)
[501.371139] Starting dynamic subtest: pipe-D-plane-0
[501.506091] Dynamic subtest pipe-D-plane-0: SUCCESS (0.144s)
[501.516638] Starting dynamic subtest: pipe-D-plane-1
[501.650704] Dynamic subtest pipe-D-plane-1: SUCCESS (0.144s)
[501.659374] Starting dynamic subtest: pipe-D-plane-2
[501.795005] Dynamic subtest pipe-D-plane-2: SUCCESS (0.143s)
[502.081431] Subtest plane-lut1d-ctm3x4-lut1d: SUCCESS (6.038s)
[502.880302] [117/133] (529s left) kms_flip (2x-wf_vblank-ts-check)
[502.976367] Starting subtest: 2x-wf_vblank-ts-check
[502.987442] Subtest 2x-wf_vblank-ts-check: SKIP (0.011s)
[503.070003] [118/133] (529s left) gem_mmap_wc (write-cpu-read-wc)
[503.121264] Subtest write-cpu-read-wc: SKIP (0.000s)
[503.174492] [119/133] (529s left) gem_render_copy (y-tiled-ccs-to-y-tiled)
[503.225753] Starting subtest: y-tiled-ccs-to-y-tiled
[503.227340] Subtest y-tiled-ccs-to-y-tiled: SKIP (0.000s)
[503.404272] [120/133] (529s left) i915_query (query-topology-matches-eu-total)
[503.452454] Starting subtest: query-topology-matches-eu-total
[503.453399] Subtest query-topology-matches-eu-total: SUCCESS (0.000s)
[503.537945] [121/133] (529s left) kms_cursor_legacy (cursorb-vs-flipa-atomic-transitions-varying-size)
[503.639341] Starting subtest: cursorB-vs-flipA-atomic-transitions-varying-size
[503.642343] Subtest cursorB-vs-flipA-atomic-transitions-varying-size: SKIP (0.001s)
[503.793361] [122/133] (528s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-pwrite)
[503.882131] Starting subtest: psr-1p-primscrn-pri-indfb-draw-pwrite
[511.503066] Subtest psr-1p-primscrn-pri-indfb-draw-pwrite: SUCCESS (7.621s)
[511.599569] [123/133] (521s left) kms_big_fb (yf-tiled-64bpp-rotate-270)
[511.708495] Starting subtest: yf-tiled-64bpp-rotate-270
[511.710327] Subtest yf-tiled-64bpp-rotate-270: SKIP (0.000s)
[511.805655] [124/133] (521s left) gem_mmap_offset (oob-read)
[511.858487] Starting subtest: oob-read
[511.859393] Subtest oob-read: SUCCESS (0.000s)
[511.949582] [125/133] (520s left) api_intel_bb (add-remove-objects)
[512.004705] Starting subtest: add-remove-objects
[512.010253] Subtest add-remove-objects: SUCCESS (0.007s)
[512.128377] [126/133] (520s left) kms_big_fb (yf-tiled-16bpp-rotate-270)
[512.222843] Starting subtest: yf-tiled-16bpp-rotate-270
[512.224616] Subtest yf-tiled-16bpp-rotate-270: SKIP (0.000s)
[512.321368] [127/133] (520s left) kms_dirtyfb (fbc-dirtyfb-ioctl)
[512.406512] Starting subtest: fbc-dirtyfb-ioctl
[512.407489] Starting dynamic subtest: A-eDP-1
[515.048838] Dynamic subtest A-eDP-1: SUCCESS (2.641s)
[515.049864] Subtest fbc-dirtyfb-ioctl: SUCCESS (2.643s)
[515.883674] [128/133] (517s left) kms_cdclk (mode-transition)
[515.973322] Starting subtest: mode-transition
[515.974150] Starting dynamic subtest: pipe-A-eDP-1
[516.260189] Dynamic subtest pipe-A-eDP-1: SKIP (0.287s)
[516.269651] Starting dynamic subtest: pipe-B-eDP-1
[516.271534] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[516.280063] Starting dynamic subtest: pipe-C-eDP-1
[516.282285] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[516.291034] Starting dynamic subtest: pipe-D-eDP-1
[516.293333] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[516.295148] Subtest mode-transition: SKIP (0.294s)
[517.076015] [129/133] (515s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-mmap-wc)
[517.164905] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-mmap-wc
[517.166673] Subtest fbc-2p-scndscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[517.256530] [130/133] (515s left) gem_tiled_partial_pwrite_pread (writes-after-reads)
[517.324841] Subtest writes-after-reads: SKIP (0.000s)
[517.378809] [131/133] (515s left) kms_plane_scaling (plane-scaler-unity-scaling-with-modifiers)
[517.463362] Starting subtest: plane-scaler-unity-scaling-with-modifiers
[517.464127] Starting dynamic subtest: pipe-A
[517.813378] Dynamic subtest pipe-A: SUCCESS (0.350s)
[517.823390] Starting dynamic subtest: pipe-B
[519.249207] Dynamic subtest pipe-B: SUCCESS (1.435s)
[519.259338] Starting dynamic subtest: pipe-C
[520.645573] Dynamic subtest pipe-C: SUCCESS (1.395s)
[520.655593] Starting dynamic subtest: pipe-D
[522.051179] Dynamic subtest pipe-D: SUCCESS (1.404s)
[522.054361] Subtest plane-scaler-unity-scaling-with-modifiers: SUCCESS (4.590s)
[523.294472] [132/133] (509s left) kms_addfb_basic (too-wide)
[523.383154] Starting subtest: too-wide
[523.383974] Subtest too-wide: SUCCESS (0.000s)
[523.462654] [133/133] (509s left) gem_exec_whisper (basic-contexts-forked-all)
[523.524519] Starting subtest: basic-contexts-forked-all
[546.062364] Subtest basic-contexts-forked-all: SUCCESS (22.489s)
[546.195205] Closing watchdogs
results: parsing output: 0/ for test: kms_chamelium_hpd
results: parsing output: 1/ for test: gem_pwrite
results: parsing output: 2/ for test: kms_psr
results: parsing output: 3/ for test: kms_psr
results: parsing output: 4/ for test: gem_mmap_wc
results: parsing output: 5/ for test: kms_frontbuffer_tracking
results: parsing output: 6/ for test: kms_rotation_crc
results: parsing output: 7/ for test: gem_mmap_wc
results: parsing output: 8/ for test: gem_exec_params
results: parsing output: 9/ for test: kms_getfb
results: parsing output: 10/ for test: kms_psr
results: parsing output: 11/ for test: api_intel_bb
results: parsing output: 12/ for test: kms_frontbuffer_tracking
results: parsing output: 13/ for test: gem_exec_alignment
results: parsing output: 14/ for test: perf_pmu
results: parsing output: 15/ for test: gem_exec_flush
results: parsing output: 16/ for test: kms_ccs
results: parsing output: 17/ for test: syncobj_timeline
results: parsing output: 18/ for test: kms_atomic_transition
results: parsing output: 19/ for test: gem_exec_create
results: parsing output: 20/ for test: syncobj_timeline
results: parsing output: 21/ for test: gem_busy
results: parsing output: 22/ for test: kms_setmode
results: parsing output: 23/ for test: kms_cursor_crc
results: parsing output: 24/ for test: kms_flip
results: parsing output: 25/ for test: kms_frontbuffer_tracking
results: parsing output: 26/ for test: gem_workarounds
results: parsing output: 27/ for test: kms_plane
results: parsing output: 28/ for test: kms_chamelium_color
results: parsing output: 29/ for test: gem_vm_create
results: parsing output: 30/ for test: syncobj_wait
results: parsing output: 31/ for test: kms_frontbuffer_tracking
results: parsing output: 32/ for test: kms_flip_scaled_crc
results: parsing output: 33/ for test: kms_prop_blob
results: parsing output: 34/ for test: gem_exec_schedule
results: parsing output: 35/ for test: kms_frontbuffer_tracking
results: parsing output: 36/ for test: kms_frontbuffer_tracking
results: parsing output: 37/ for test: kms_psr
results: parsing output: 38/ for test: kms_frontbuffer_tracking
results: parsing output: 39/ for test: syncobj_wait
results: parsing output: 40/ for test: kms_psr
results: parsing output: 41/ for test: gem_ctx_persistence
results: parsing output: 42/ for test: kms_ccs
results: parsing output: 43/ for test: kms_plane_lowres
results: parsing output: 44/ for test: kms_frontbuffer_tracking
results: parsing output: 45/ for test: kms_frontbuffer_tracking
results: parsing output: 46/ for test: kms_cursor_legacy
results: parsing output: 47/ for test: gem_ctx_bad_destroy
results: parsing output: 48/ for test: kms_flip
results: parsing output: 49/ for test: kms_feature_discovery
results: parsing output: 50/ for test: i915_hangman
results: parsing output: 51/ for test: kms_ccs
results: parsing output: 52/ for test: kms_big_fb
results: parsing output: 53/ for test: kms_atomic
results: parsing output: 54/ for test: gem_spin_batch
results: parsing output: 55/ for test: gem_exec_fence
results: parsing output: 56/ for test: kms_frontbuffer_tracking
results: parsing output: 57/ for test: gem_exec_flush
results: parsing output: 58/ for test: kms_vblank
results: parsing output: 59/ for test: kms_cursor_crc
results: parsing output: 60/ for test: kms_sequence
results: parsing output: 61/ for test: kms_rotation_crc
results: parsing output: 62/ for test: perf_pmu
results: parsing output: 63/ for test: i915_query
results: parsing output: 64/ for test: kms_frontbuffer_tracking
results: parsing output: 65/ for test: syncobj_timeline
results: parsing output: 66/ for test: gem_exec_schedule
results: parsing output: 67/ for test: gem_ctx_exec
results: parsing output: 68/ for test: kms_frontbuffer_tracking
results: parsing output: 69/ for test: kms_addfb_basic
results: parsing output: 70/ for test: kms_big_fb
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_content_protection
results: parsing output: 74/ for test: kms_frontbuffer_tracking
results: parsing output: 75/ for test: gem_exec_whisper
results: parsing output: 76/ for test: syncobj_timeline
results: parsing output: 77/ for test: kms_frontbuffer_tracking
results: parsing output: 78/ for test: i915_pm_rps
results: parsing output: 79/ for test: kms_psr2_sf
results: parsing output: 80/ for test: kms_big_fb
results: parsing output: 81/ for test: gem_exec_balancer
results: parsing output: 82/ for test: dmabuf_sync_file
results: parsing output: 83/ for test: kms_vrr
results: parsing output: 84/ for test: gem_mmap_wc
results: parsing output: 85/ for test: sysfs_heartbeat_interval
results: parsing output: 86/ for test: kms_cursor_edge_walk
results: parsing output: 87/ for test: gem_exec_params
results: parsing output: 88/ for test: gem_exec_params
results: parsing output: 89/ for test: gem_render_copy
results: parsing output: 90/ for test: kms_async_flips
results: parsing output: 91/ for test: gen9_exec_parse
results: parsing output: 92/ for test: kms_flip_scaled_crc
results: parsing output: 93/ for test: syncobj_timeline
results: parsing output: 94/ for test: kms_frontbuffer_tracking
results: parsing output: 95/ for test: kms_pm_backlight
results: parsing output: 96/ for test: kms_big_fb
results: parsing output: 97/ for test: gem_ccs
results: parsing output: 98/ for test: gem_partial_pwrite_pread
results: parsing output: 99/ for test: kms_lease
results: parsing output: 100/ for test: kms_atomic_transition
results: parsing output: 101/ for test: kms_ccs
results: parsing output: 102/ for test: kms_plane_alpha_blend
results: parsing output: 103/ for test: gem_exec_balancer
results: parsing output: 104/ for test: kms_prime
results: parsing output: 105/ for test: kms_frontbuffer_tracking
results: parsing output: 106/ for test: gem_pxp
results: parsing output: 107/ for test: kms_big_fb
results: parsing output: 108/ for test: i915_drm_fdinfo
results: parsing output: 109/ for test: syncobj_wait
results: parsing output: 110/ for test: kms_invalid_mode
results: parsing output: 111/ for test: kms_hdmi_inject
results: parsing output: 112/ for test: gem_exec_reloc
results: parsing output: 113/ for test: gem_mmap_gtt
results: parsing output: 114/ for test: kms_addfb_basic
results: parsing output: 115/ for test: kms_color_pipeline
results: parsing output: 116/ for test: kms_flip
results: parsing output: 117/ for test: gem_mmap_wc
results: parsing output: 118/ for test: gem_render_copy
results: parsing output: 119/ for test: i915_query
results: parsing output: 120/ for test: kms_cursor_legacy
results: parsing output: 121/ for test: kms_frontbuffer_tracking
results: parsing output: 122/ for test: kms_big_fb
results: parsing output: 123/ for test: gem_mmap_offset
results: parsing output: 124/ for test: api_intel_bb
results: parsing output: 125/ for test: kms_big_fb
results: parsing output: 126/ for test: kms_dirtyfb
results: parsing output: 127/ for test: kms_cdclk
results: parsing output: 128/ for test: kms_frontbuffer_tracking
results: parsing output: 129/ for test: gem_tiled_partial_pwrite_pread
results: parsing output: 130/ for test: kms_plane_scaling
results: parsing output: 131/ for test: kms_addfb_basic
results: parsing output: 132/ for test: gem_exec_whisper
Done.