[58.659148] Initializing watchdogs
[58.659194]   /dev/watchdog0
[58.672663] [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]
[58.676863] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[58.679073] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[58.682494] [001/133] (960s left) kms_chamelium_hpd (vga-hpd-without-ddc)
[59.091714] Subtest vga-hpd-without-ddc: SKIP (0.000s)
[59.888147] [002/133] (959s left) gem_pwrite (basic-self)
[59.953275] Subtest basic-self: SKIP (0.000s)
[60.004686] [003/133] (959s left) kms_psr (fbc-psr2-sprite-plane-onoff)
[60.102706] Starting subtest: fbc-psr2-sprite-plane-onoff
[60.104933] Starting dynamic subtest: eDP-1
[60.109299] Dynamic subtest eDP-1: SKIP (0.000s)
[60.113685] Subtest fbc-psr2-sprite-plane-onoff: SKIP (0.000s)
[60.177555] [004/133] (959s left) kms_psr (psr2-no-drrs)
[60.260453] Starting subtest: psr2-no-drrs
[60.262757] Starting dynamic subtest: eDP-1
[61.864614] Dynamic subtest eDP-1: SUCCESS (1.614s)
[61.866861] Subtest psr2-no-drrs: SUCCESS (1.615s)
[62.658720] [005/133] (956s left) gem_mmap_wc (write)
[62.725587] Subtest write: SKIP (0.000s)
[62.785830] [006/133] (956s left) kms_frontbuffer_tracking (fbc-tiling-4)
[62.881761] Starting subtest: fbc-tiling-4
[67.557164] Subtest fbc-tiling-4: SUCCESS (4.697s)
[68.742538] [007/133] (950s left) kms_rotation_crc (multiplane-rotation-cropping-bottom)
[68.839540] Starting subtest: multiplane-rotation-cropping-bottom
[86.209632] Subtest multiplane-rotation-cropping-bottom: SUCCESS (17.382s)
[86.323951] [008/133] (933s left) gem_mmap_wc (read-write)
[86.377109] Subtest read-write: SKIP (0.000s)
[86.433186] [009/133] (933s left) gem_exec_params (cliprects_ptr-dirt)
[86.499878] Starting subtest: cliprects_ptr-dirt
[86.501908] Subtest cliprects_ptr-dirt: SUCCESS (0.000s)
[86.592920] [010/133] (932s left) kms_getfb (getfb2-handle-zero)
[86.695491] Starting subtest: getfb2-handle-zero
[86.697480] Subtest getfb2-handle-zero: SUCCESS (0.000s)
[86.796695] [011/133] (932s left) kms_psr (pr-suspend)
[86.892722] Starting subtest: pr-suspend
[86.896244] Subtest pr-suspend: SKIP (0.000s)
[86.963162] [012/133] (932s left) api_intel_bb (simple-bb)
[87.023463] Starting subtest: simple-bb
[87.027650] Subtest simple-bb: SUCCESS (0.005s)
[87.112177] [013/133] (932s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-pwrite)
[87.211935] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-pwrite
[87.215695] Subtest fbc-2p-scndscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[87.314950] [014/133] (932s left) gem_exec_alignment (pi-isolated)
[87.381969] Starting subtest: pi-isolated
[137.493745] Subtest pi-isolated: SUCCESS (50.105s)
[138.641274] [015/133] (881s left) perf_pmu (init-busy)
[138.711643] Starting subtest: init-busy
[138.713908] Starting dynamic subtest: rcs0
[138.716354] Dynamic subtest rcs0: SUCCESS (0.002s)
[138.725053] Starting dynamic subtest: bcs0
[138.727096] Dynamic subtest bcs0: SUCCESS (0.001s)
[138.733835] Starting dynamic subtest: vcs0
[138.735718] Dynamic subtest vcs0: SUCCESS (0.001s)
[138.742448] Starting dynamic subtest: vcs1
[138.744374] Dynamic subtest vcs1: SUCCESS (0.001s)
[138.752441] Starting dynamic subtest: vecs0
[138.754610] Dynamic subtest vecs0: SUCCESS (0.000s)
[138.762135] Starting dynamic subtest: ccs0
[138.763976] Dynamic subtest ccs0: SUCCESS (0.000s)
[138.765901] Subtest init-busy: SUCCESS (0.006s)
[138.813720] [016/133] (880s left) gem_exec_flush (basic-batch-kernel-default-wb)
[138.877411] Starting subtest: basic-batch-kernel-default-wb
[145.162073] Subtest basic-batch-kernel-default-wb: SUCCESS (6.284s)
[145.362618] [017/133] (874s left) kms_ccs (crc-primary-suspend-4-tiled-lnl-ccs)
[145.466766] Starting subtest: crc-primary-suspend-4-tiled-lnl-ccs
[145.471342] Subtest crc-primary-suspend-4-tiled-lnl-ccs: SKIP (0.000s)
[146.546283] [018/133] (873s left) syncobj_timeline (multi-wait-available-unsubmitted-submitted)
[146.616494] Starting subtest: multi-wait-available-unsubmitted-submitted
[146.619076] Subtest multi-wait-available-unsubmitted-submitted: SUCCESS (0.001s)
[146.702384] [019/133] (873s left) kms_atomic_transition (plane-all-modeset-transition-fencing)
[146.794940] Starting subtest: plane-all-modeset-transition-fencing
[146.799137] Subtest plane-all-modeset-transition-fencing: SKIP (0.000s)
[146.889571] [020/133] (873s left) gem_exec_create (madvise)
[146.956617] Starting subtest: madvise
[146.959034] Starting dynamic subtest: smem
[167.962469] Dynamic subtest smem: SUCCESS (21.005s)
[167.964970] Subtest madvise: SUCCESS (21.005s)
[168.853980] [021/133] (851s left) syncobj_timeline (invalid-multi-wait-all-unsubmitted-submitted-signaled)
[168.906817] Starting subtest: invalid-multi-wait-all-unsubmitted-submitted-signaled
[168.909174] Subtest invalid-multi-wait-all-unsubmitted-submitted-signaled: SUCCESS (0.000s)
[168.995597] [022/133] (851s left) gem_busy (extended)
[169.175253] Starting subtest: extended
[169.177501] Starting dynamic subtest: rcs0
[169.265554] Dynamic subtest rcs0: SUCCESS (0.092s)
[169.275679] Starting dynamic subtest: bcs0
[169.312061] Dynamic subtest bcs0: SUCCESS (0.045s)
[169.321508] Starting dynamic subtest: vcs0
[170.902553] Dynamic subtest vcs0: SUCCESS (1.587s)
[170.913713] Starting dynamic subtest: vcs1
[172.886473] Dynamic subtest vcs1: SUCCESS (1.982s)
[172.897022] Starting dynamic subtest: vecs0
[174.934778] Dynamic subtest vecs0: SUCCESS (2.045s)
[174.945710] Starting dynamic subtest: ccs0
[174.983363] Dynamic subtest ccs0: SUCCESS (0.048s)
[174.985896] Subtest extended: SUCCESS (5.811s)
[175.217768] [023/133] (844s left) kms_setmode (basic)
[175.275699] Starting subtest: basic
[175.629556] Starting dynamic subtest: pipe-A-eDP-1
[177.671760] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.038s)
[178.015799] Starting dynamic subtest: pipe-B-eDP-1
[180.103419] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.090s)
[180.418239] Subtest basic: SUCCESS (5.140s)
[181.252326] [024/133] (838s left) kms_cursor_crc (cursor-sliding-128x42)
[181.464184] Starting subtest: cursor-sliding-128x42
[181.513232] Subtest cursor-sliding-128x42: SKIP (0.045s)
[181.695375] [025/133] (838s left) kms_flip (flip-vs-panning)
[181.801477] Starting subtest: flip-vs-panning
[181.803750] Starting dynamic subtest: A-eDP1
[190.561175] Dynamic subtest A-eDP1: SUCCESS (8.761s)
[190.571197] Starting dynamic subtest: B-eDP1
[199.288318] Dynamic subtest B-eDP1: SUCCESS (8.725s)
[199.297932] Starting dynamic subtest: C-eDP1
[207.999843] Dynamic subtest C-eDP1: SUCCESS (8.709s)
[208.009081] Starting dynamic subtest: D-eDP1
[216.743117] Dynamic subtest D-eDP1: SUCCESS (8.743s)
[216.746956] Subtest flip-vs-panning: SUCCESS (34.947s)
[217.907927] [026/133] (802s left) kms_frontbuffer_tracking (psr-1p-primscrn-shrfb-plflip-blt)
[218.022027] Starting subtest: psr-1p-primscrn-shrfb-plflip-blt
[225.522306] Subtest psr-1p-primscrn-shrfb-plflip-blt: SUCCESS (7.505s)
[225.647184] [027/133] (794s left) gem_workarounds (suspend-resume-context)
[225.717609] Starting subtest: suspend-resume-context
[242.130557] Subtest suspend-resume-context: SUCCESS (1.303s)
[243.256346] [028/133] (777s left) kms_plane (pixel-format-4-tiled-mtl-rc-ccs-modifier-source-clamping)
[243.365795] Starting subtest: pixel-format-4-tiled-mtl-rc-ccs-modifier-source-clamping
[243.390784] Starting dynamic subtest: pipe-A-plane-0
[243.667606] Dynamic subtest pipe-A-plane-0: SUCCESS (0.289s)
[243.675821] Starting dynamic subtest: pipe-A-plane-3
[243.891875] Dynamic subtest pipe-A-plane-3: SUCCESS (0.232s)
[244.979135] Starting dynamic subtest: pipe-B-plane-0
[245.273863] Dynamic subtest pipe-B-plane-0: SUCCESS (0.311s)
[245.283131] Starting dynamic subtest: pipe-B-plane-3
[245.498964] Dynamic subtest pipe-B-plane-3: SUCCESS (0.231s)
[245.809061] Subtest pixel-format-4-tiled-mtl-rc-ccs-modifier-source-clamping: SUCCESS (2.536s)
[246.599675] [029/133] (774s left) kms_chamelium_color (degamma)
[246.690013] Subtest degamma: SKIP (0.000s)
[246.734937] [030/133] (774s left) gem_vm_create (isolation)
[246.790946] Starting subtest: isolation
[246.800220] Subtest isolation: SUCCESS (0.010s)
[246.917743] [031/133] (774s left) syncobj_wait (wait-delayed-signal)
[246.972953] Starting subtest: wait-delayed-signal
[247.074707] Subtest wait-delayed-signal: SUCCESS (0.105s)
[247.151356] [032/133] (774s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-indfb-msflip-blt)
[247.257753] Starting subtest: fbcpsr-1p-primscrn-indfb-msflip-blt
[254.407826] Subtest fbcpsr-1p-primscrn-indfb-msflip-blt: SUCCESS (7.273s)
[254.527002] [033/133] (766s left) kms_flip_scaled_crc (flip-32bpp-4tile-to-64bpp-4tile-upscaling)
[254.629477] Starting subtest: flip-32bpp-4tile-to-64bpp-4tile-upscaling
[254.631639] Starting dynamic subtest: pipe-A-default-mode
[257.342760] Dynamic subtest pipe-A-default-mode: SUCCESS (2.737s)
[257.345812] Subtest flip-32bpp-4tile-to-64bpp-4tile-upscaling: SUCCESS (2.738s)
[258.199713] [034/133] (763s left) kms_prop_blob (invalid-set-prop)
[258.268218] Starting subtest: invalid-set-prop
[258.270994] Subtest invalid-set-prop: SUCCESS (0.000s)
[258.364884] [035/133] (763s left) gem_exec_schedule (noreorder-priority)
[258.546229] Starting subtest: noreorder-priority
[258.549251] Starting dynamic subtest: rcs0
[259.677580] Dynamic subtest rcs0: SUCCESS (1.138s)
[259.689801] Starting dynamic subtest: vcs0
[261.019989] Dynamic subtest vcs0: SUCCESS (1.346s)
[261.032806] Starting dynamic subtest: vcs1
[262.977979] Dynamic subtest vcs1: SUCCESS (1.964s)
[262.990447] Starting dynamic subtest: vecs0
[265.051516] Dynamic subtest vecs0: SUCCESS (2.077s)
[265.063771] Starting dynamic subtest: ccs0
[266.186467] Dynamic subtest ccs0: SUCCESS (1.137s)
[266.189187] Subtest noreorder-priority: SUCCESS (7.672s)
[266.368717] [036/133] (755s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-render)
[266.475075] Starting subtest: fbcpsr-rgb101010-draw-render
[273.204048] Subtest fbcpsr-rgb101010-draw-render: SUCCESS (6.745s)
[273.309674] [037/133] (748s left) kms_frontbuffer_tracking (fbc-2p-shrfb-fliptrack-mmap-gtt)
[273.415695] Starting subtest: fbc-2p-shrfb-fliptrack-mmap-gtt
[273.420813] Subtest fbc-2p-shrfb-fliptrack-mmap-gtt: SKIP (0.000s)
[273.515221] [038/133] (748s left) kms_psr (fbc-pr-cursor-plane-move)
[273.615265] Starting subtest: fbc-pr-cursor-plane-move
[273.620143] Subtest fbc-pr-cursor-plane-move: SKIP (0.000s)
[273.687324] [039/133] (747s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-mmap-cpu)
[273.794499] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-mmap-cpu
[277.359893] Subtest fbc-1p-primscrn-cur-indfb-draw-mmap-cpu: SUCCESS (3.569s)
[278.478407] [040/133] (743s left) syncobj_wait (single-wait-submitted)
[278.537054] Starting subtest: single-wait-submitted
[278.639230] Subtest single-wait-submitted: SUCCESS (0.104s)
[278.715559] [041/133] (743s left) kms_psr (fbc-psr2-cursor-plane-onoff)
[278.806951] Starting subtest: fbc-psr2-cursor-plane-onoff
[278.809543] Starting dynamic subtest: eDP-1
[278.814018] Dynamic subtest eDP-1: SKIP (0.000s)
[278.818908] Subtest fbc-psr2-cursor-plane-onoff: SKIP (0.001s)
[278.882894] [042/133] (742s left) gem_ctx_persistence (legacy-engines-mixed)
[278.952201] Starting subtest: legacy-engines-mixed
[278.954588] Starting dynamic subtest: render
[279.024147] Dynamic subtest render: SUCCESS (0.075s)
[279.043221] Starting dynamic subtest: bsd1
[279.071086] Dynamic subtest bsd1: SUCCESS (0.044s)
[279.082368] Starting dynamic subtest: bsd2
[279.116763] Dynamic subtest bsd2: SUCCESS (0.044s)
[279.126731] Starting dynamic subtest: blt
[279.163221] Dynamic subtest blt: SUCCESS (0.041s)
[279.173841] Starting dynamic subtest: vebox
[279.217234] Dynamic subtest vebox: SUCCESS (0.055s)
[279.220007] Subtest legacy-engines-mixed: SUCCESS (0.270s)
[279.295771] [043/133] (742s left) kms_ccs (crc-sprite-planes-basic-y-tiled-gen12-rc-ccs)
[279.385038] Starting subtest: crc-sprite-planes-basic-y-tiled-gen12-rc-ccs
[279.387934] Starting dynamic subtest: pipe-A-eDP-1
[279.448863] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[279.459007] Starting dynamic subtest: pipe-B-eDP-1
[279.517564] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[279.526007] Starting dynamic subtest: pipe-C-eDP-1
[279.583018] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[279.592142] Starting dynamic subtest: pipe-D-eDP-1
[279.649199] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[279.653567] Subtest crc-sprite-planes-basic-y-tiled-gen12-rc-ccs: SKIP (0.008s)
[281.558741] [044/133] (740s left) kms_plane_lowres (tiling-x)
[281.648612] Starting subtest: tiling-x
[281.650917] Starting dynamic subtest: pipe-A-eDP-1
[281.655652] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[281.965587] Starting dynamic subtest: pipe-B-eDP-1
[281.970144] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[281.978830] Starting dynamic subtest: pipe-C-eDP-1
[281.983627] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[281.993147] Starting dynamic subtest: pipe-D-eDP-1
[281.998120] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[282.003061] Subtest tiling-x: SKIP (0.314s)
[282.796360] [045/133] (739s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-onoff)
[282.886781] Starting subtest: fbc-2p-primscrn-spr-indfb-onoff
[282.891829] Subtest fbc-2p-primscrn-spr-indfb-onoff: SKIP (0.000s)
[282.966242] [046/133] (738s left) kms_frontbuffer_tracking (fbc-2p-rte)
[283.056385] Starting subtest: fbc-2p-rte
[283.061514] Subtest fbc-2p-rte: SKIP (0.000s)
[283.150949] [047/133] (738s left) kms_cursor_legacy (flip-vs-cursor-busy-crc-legacy)
[283.260993] Starting subtest: flip-vs-cursor-busy-crc-legacy
[284.066137] Subtest flip-vs-cursor-busy-crc-legacy: SUCCESS (0.805s)
[284.933188] [048/133] (737s left) gem_ctx_bad_destroy (invalid-pad)
[285.003116] Starting subtest: invalid-pad
[285.006131] Subtest invalid-pad: SUCCESS (0.000s)
[285.089220] [049/133] (736s left) kms_flip (2x-dpms-vs-vblank-race-interruptible)
[285.185516] Starting subtest: 2x-dpms-vs-vblank-race-interruptible
[285.196014] Subtest 2x-dpms-vs-vblank-race-interruptible: SKIP (0.010s)
[285.269622] [050/133] (736s left) kms_feature_discovery (display-3x)
[285.366012] Starting subtest: display-3x
[285.370816] Subtest display-3x: SKIP (0.000s)
[285.436510] [051/133] (736s left) i915_hangman (detector)
[285.501601] Starting subtest: detector
[285.503806] Starting dynamic subtest: rcs0
[296.954149] Dynamic subtest rcs0: SUCCESS (11.454s)
[296.966068] Starting dynamic subtest: bcs0
[307.963935] Dynamic subtest bcs0: SUCCESS (11.010s)
[307.975766] Starting dynamic subtest: vcs0
[319.930097] Dynamic subtest vcs0: SUCCESS (11.967s)
[319.941779] Starting dynamic subtest: vcs1
[329.913818] Dynamic subtest vcs1: SUCCESS (9.984s)
[329.925529] Starting dynamic subtest: vecs0
[339.964001] Dynamic subtest vecs0: SUCCESS (10.047s)
[339.976000] Starting dynamic subtest: ccs0
[351.994129] Dynamic subtest ccs0: SUCCESS (12.024s)
[351.997118] Subtest detector: SUCCESS (66.503s)
[352.118788] [052/133] (670s left) kms_ccs (bad-rotation-90-y-tiled-ccs)
[352.228969] Starting subtest: bad-rotation-90-y-tiled-ccs
[352.231790] Starting dynamic subtest: pipe-A-eDP-1
[352.257229] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[352.266214] Starting dynamic subtest: pipe-B-eDP-1
[352.290766] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[352.299990] Starting dynamic subtest: pipe-C-eDP-1
[352.325595] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[352.335769] Starting dynamic subtest: pipe-D-eDP-1
[352.361325] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[352.366063] Subtest bad-rotation-90-y-tiled-ccs: SKIP (0.014s)
[354.501967] [053/133] (667s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip)
[354.598490] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip
[355.455965] Subtest 4-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip: SUCCESS (0.859s)
[355.602401] [054/133] (666s left) kms_atomic (plane-primary-overlay-mutable-zpos)
[355.694505] Starting subtest: plane-primary-overlay-mutable-zpos
[359.109924] Subtest plane-primary-overlay-mutable-zpos: SKIP (3.413s)
[360.287912] [055/133] (662s left) gem_spin_batch (engines)
[360.345005] Starting subtest: engines
[360.347625] Starting dynamic subtest: rcs0
[363.583918] Dynamic subtest rcs0: SUCCESS (3.237s)
[363.594784] Starting dynamic subtest: bcs0
[366.823027] Dynamic subtest bcs0: SUCCESS (3.236s)
[366.833792] Starting dynamic subtest: vcs0
[370.061145] Dynamic subtest vcs0: SUCCESS (3.234s)
[370.071363] Starting dynamic subtest: vcs1
[373.295980] Dynamic subtest vcs1: SUCCESS (3.233s)
[373.308248] Starting dynamic subtest: vecs0
[376.536523] Dynamic subtest vecs0: SUCCESS (3.237s)
[376.549096] Starting dynamic subtest: ccs0
[379.777078] Dynamic subtest ccs0: SUCCESS (3.238s)
[379.779965] Subtest engines: SUCCESS (19.432s)
[380.014633] [056/133] (642s left) gem_exec_fence (syncobj-timeline-repeat)
[380.656229] Starting subtest: syncobj-timeline-repeat
[380.975632] Subtest syncobj-timeline-repeat: SUCCESS (0.319s)
[382.067564] [FACT gem_exec_fence (syncobj-timeline-repeat)] new: kernel.kmod_is_loaded.vgem: true
[382.074129] [057/133] (640s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-indfb-msflip-blt)
[382.168662] Starting subtest: fbc-2p-scndscrn-indfb-msflip-blt
[382.173638] Subtest fbc-2p-scndscrn-indfb-msflip-blt: SKIP (0.000s)
[382.272085] [058/133] (640s left) gem_exec_flush (basic-wb-rw-default)
[382.334925] Starting subtest: basic-wb-rw-default
[387.801271] Subtest basic-wb-rw-default: SUCCESS (5.469s)
[387.991644] [059/133] (634s left) kms_vblank (wait-idle)
[388.084212] Starting subtest: wait-idle
[388.087104] Starting dynamic subtest: pipe-A-eDP-1
[389.840138] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.755s)
[389.862478] Starting dynamic subtest: pipe-D-eDP-1
[392.335801] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.492s)
[392.338329] Subtest wait-idle: SUCCESS (4.252s)
[393.146358] [060/133] (629s left) kms_cursor_crc (cursor-offscreen-512x170)
[393.444731] Starting subtest: cursor-offscreen-512x170
[393.449883] Subtest cursor-offscreen-512x170: SKIP (0.001s)
[393.573274] [061/133] (628s left) kms_sequence (queue-busy)
[393.652581] Starting subtest: queue-busy
[393.654905] Starting dynamic subtest: pipe-A-eDP-1
[395.592899] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.937s)
[395.603465] Starting dynamic subtest: pipe-B-eDP-1
[398.244191] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.651s)
[398.255926] Starting dynamic subtest: pipe-C-eDP-1
[400.856770] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.612s)
[400.867028] Starting dynamic subtest: pipe-D-eDP-1
[403.383222] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.523s)
[403.386076] Subtest queue-busy: SUCCESS (9.730s)
[404.180112] [062/133] (618s left) kms_rotation_crc (primary-yf-tiled-reflect-x-0)
[404.278180] Starting subtest: primary-yf-tiled-reflect-x-0
[404.339221] Subtest primary-yf-tiled-reflect-x-0: SKIP (0.060s)
[404.445145] [063/133] (618s left) perf_pmu (semaphore-wait)
[404.483186] Starting subtest: semaphore-wait
[404.485734] Starting dynamic subtest: rcs0
[404.995195] Dynamic subtest rcs0: SUCCESS (0.513s)
[405.007966] Starting dynamic subtest: bcs0
[405.510207] Dynamic subtest bcs0: SUCCESS (0.512s)
[405.522973] Starting dynamic subtest: vcs0
[406.024268] Dynamic subtest vcs0: SUCCESS (0.510s)
[406.034889] Starting dynamic subtest: vcs1
[406.536895] Dynamic subtest vcs1: SUCCESS (0.510s)
[406.553861] Starting dynamic subtest: vecs0
[407.052242] Dynamic subtest vecs0: SUCCESS (0.512s)
[407.065266] Starting dynamic subtest: ccs0
[407.572509] Dynamic subtest ccs0: SUCCESS (0.516s)
[407.575505] Subtest semaphore-wait: SUCCESS (3.093s)
[409.077044] [064/133] (613s left) i915_query (query-regions-unallocated)
[409.137207] Starting subtest: query-regions-unallocated
[409.140210] Subtest query-regions-unallocated: SUCCESS (0.000s)
[409.252260] [065/133] (613s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-pwrite)
[409.341815] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-pwrite
[409.346582] Subtest psr-2p-scndscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[409.441426] [066/133] (613s left) syncobj_timeline (single-wait-for-submit-signaled)
[409.500992] Starting subtest: single-wait-for-submit-signaled
[409.503869] Subtest single-wait-for-submit-signaled: SUCCESS (0.000s)
[409.601594] [067/133] (613s left) gem_exec_schedule (u-independent)
[409.681971] Starting subtest: u-independent
[409.684602] Starting dynamic subtest: rcs0
[411.038632] Dynamic subtest rcs0: SUCCESS (1.371s)
[411.052008] Starting dynamic subtest: vcs0
[413.027130] Dynamic subtest vcs0: SUCCESS (1.986s)
[413.039205] Starting dynamic subtest: vcs1
[415.016484] Dynamic subtest vcs1: SUCCESS (1.986s)
[415.028851] Starting dynamic subtest: vecs0
[417.001942] Dynamic subtest vecs0: SUCCESS (1.983s)
[417.015010] Starting dynamic subtest: ccs0
[419.036371] Dynamic subtest ccs0: SUCCESS (2.032s)
[419.039216] Subtest u-independent: SUCCESS (9.372s)
[419.339458] [068/133] (603s left) gem_ctx_exec (basic-norecovery)
[419.397176] Starting subtest: basic-norecovery
[419.747076] Subtest basic-norecovery: SUCCESS (0.349s)
[419.896006] [069/133] (603s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-mmap-cpu)
[420.010669] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-mmap-cpu
[420.015058] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[420.103850] [070/133] (602s left) kms_addfb_basic (bad-pitch-63)
[420.158040] Starting subtest: bad-pitch-63
[420.160226] Subtest bad-pitch-63: SUCCESS (0.000s)
[420.275650] [071/133] (602s left) kms_big_fb (4-tiled-addfb-size-overflow)
[420.368837] Starting subtest: 4-tiled-addfb-size-overflow
[420.371052] Subtest 4-tiled-addfb-size-overflow: SUCCESS (0.000s)
[420.464699] [072/133] (602s left) kms_plane_scaling (planes-upscale-factor-0-25-downscale-factor-0-5)
[420.555330] Starting subtest: planes-upscale-factor-0-25-downscale-factor-0-5
[420.557610] Starting dynamic subtest: pipe-A
[420.574891] Dynamic subtest pipe-A: SKIP (0.016s)
[420.586862] Starting dynamic subtest: pipe-B
[420.604494] Dynamic subtest pipe-B: SKIP (0.029s)
[420.614081] Starting dynamic subtest: pipe-C
[420.635110] Dynamic subtest pipe-C: SKIP (0.029s)
[420.644771] Starting dynamic subtest: pipe-D
[420.661672] Dynamic subtest pipe-D: SKIP (0.029s)
[420.665738] Subtest planes-upscale-factor-0-25-downscale-factor-0-5: SKIP (0.105s)
[420.759268] [073/133] (602s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-fullscreen)
[420.854072] Starting subtest: psr-2p-scndscrn-spr-indfb-fullscreen
[420.859076] Subtest psr-2p-scndscrn-spr-indfb-fullscreen: SKIP (0.000s)
[420.941889] [074/133] (602s left) kms_content_protection (dp-mst-type-0)
[421.080082] Starting subtest: dp-mst-type-0
[421.085207] Subtest dp-mst-type-0: SKIP (0.000s)
[421.217771] [075/133] (601s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-indfb-plflip-blt)
[421.313990] Starting subtest: fbcpsr-2p-scndscrn-indfb-plflip-blt
[421.317943] Subtest fbcpsr-2p-scndscrn-indfb-plflip-blt: SKIP (0.000s)
[421.402773] [076/133] (601s left) gem_exec_whisper (basic-queues-all)
[421.467691] Starting subtest: basic-queues-all
[431.550353] Subtest basic-queues-all: SUCCESS (10.081s)
[431.736534] [077/133] (591s left) syncobj_timeline (device-submit-unordered)
[431.782921] Starting subtest: device-submit-unordered
[431.785065] Subtest device-submit-unordered: SUCCESS (0.000s)
[431.884563] [078/133] (591s left) kms_frontbuffer_tracking (fbcpsr-2p-pri-indfb-multidraw)
[431.989954] Starting subtest: fbcpsr-2p-pri-indfb-multidraw
[431.994838] Subtest fbcpsr-2p-pri-indfb-multidraw: SKIP (0.000s)
[432.074094] [079/133] (591s left) i915_pm_rps (basic-api)
[432.133596] Starting subtest: basic-api
[432.138878] Subtest basic-api: SKIP (0.001s)
[432.252585] [080/133] (591s left) kms_psr2_sf (fbc-psr2-overlay-plane-move-continuous-sf)
[432.352468] Starting subtest: fbc-psr2-overlay-plane-move-continuous-sf
[432.354838] Starting dynamic subtest: pipe-A-eDP-1
[432.451093] Dynamic subtest pipe-A-eDP-1: SKIP (0.099s)
[432.463229] Starting dynamic subtest: pipe-B-eDP-1
[433.555530] Dynamic subtest pipe-B-eDP-1: SKIP (1.102s)
[433.561018] Subtest fbc-psr2-overlay-plane-move-continuous-sf: SKIP (1.204s)
[434.747247] [081/133] (588s left) kms_big_fb (x-tiled-32bpp-rotate-180)
[434.844594] Starting subtest: x-tiled-32bpp-rotate-180
[436.411448] Subtest x-tiled-32bpp-rotate-180: SUCCESS (1.568s)
[436.533603] [082/133] (586s left) gem_exec_balancer (persistence)
[436.797906] Starting subtest: persistence
[437.683235] Subtest persistence: SUCCESS (0.887s)
[437.795381] [083/133] (585s left) dmabuf_sync_file (import-basic)
[437.850000] Starting subtest: import-basic
[437.852656] Subtest import-basic: SUCCESS (0.003s)
[437.908932] [084/133] (585s left) kms_vrr (negative-basic)
[438.003846] Starting subtest: negative-basic
[438.011208] Starting dynamic subtest: pipe-A-eDP-1
[443.430085] Dynamic subtest pipe-A-eDP-1: SUCCESS (5.420s)
[443.734047] Subtest negative-basic: SUCCESS (5.734s)
[444.584910] [085/133] (579s left) gem_mmap_wc (read-write-distinct)
[444.637701] Subtest read-write-distinct: SKIP (0.000s)
[444.702667] [086/133] (578s left) sysfs_heartbeat_interval (invalid)
[444.761934] Starting subtest: invalid
[444.764740] Starting dynamic subtest: vecs0
[444.767342] Dynamic subtest vecs0: SUCCESS (0.000s)
[444.779059] Starting dynamic subtest: ccs0
[444.781352] Dynamic subtest ccs0: SUCCESS (0.000s)
[444.790969] Starting dynamic subtest: vcs0
[444.792876] Dynamic subtest vcs0: SUCCESS (0.000s)
[444.802503] Starting dynamic subtest: bcs0
[444.804911] Dynamic subtest bcs0: SUCCESS (0.000s)
[444.814754] Starting dynamic subtest: rcs0
[444.817042] Dynamic subtest rcs0: SUCCESS (0.000s)
[444.825874] Starting dynamic subtest: vcs1
[444.827859] Dynamic subtest vcs1: SUCCESS (0.000s)
[444.830179] Subtest invalid: SUCCESS (0.005s)
[444.868413] [087/133] (578s left) kms_cursor_edge_walk (128x128-top-edge)
[444.959991] Starting subtest: 128x128-top-edge
[444.962946] Starting dynamic subtest: pipe-A-eDP-1
[448.453970] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.494s)
[448.464756] Starting dynamic subtest: pipe-D-eDP-1
[451.588110] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.129s)
[451.590804] Subtest 128x128-top-edge: SUCCESS (6.627s)
[452.403793] [088/133] (571s left) gem_exec_params (rel-constants-invalid-ring)
[452.466734] Starting subtest: rel-constants-invalid-ring
[452.469229] Subtest rel-constants-invalid-ring: SUCCESS (0.000s)
[452.573962] [089/133] (571s left) gem_exec_params (readonly)
[452.630204] Starting subtest: readonly
[452.632737] Subtest readonly: SUCCESS (0.003s)
[452.737022] [090/133] (571s left) gem_render_copy (yf-tiled-mc-ccs-to-vebox-y-tiled)
[452.785965] Starting subtest: yf-tiled-mc-ccs-to-vebox-y-tiled
[452.790944] Subtest yf-tiled-mc-ccs-to-vebox-y-tiled: SKIP (0.000s)
[452.983903] [091/133] (570s left) kms_async_flips (basic-modeset-with-all-modifiers-formats)
[453.080934] Starting subtest: basic-modeset-with-all-modifiers-formats
[453.450707] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-XRGB8888
[454.265880] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-XRGB8888: SUCCESS (0.816s)
[454.275394] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-XRGB2101010
[454.287592] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-XRGB2101010: SUCCESS (0.022s)
[454.297191] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-XRGB16161616F
[454.309611] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-XRGB16161616F: SUCCESS (0.022s)
[454.319262] Starting dynamic subtest: pipe-A-eDP-1-4-RGB565
[454.476755] Dynamic subtest pipe-A-eDP-1-4-RGB565: SUCCESS (0.166s)
[454.486210] Starting dynamic subtest: pipe-A-eDP-1-4-XRGB8888
[454.499512] Dynamic subtest pipe-A-eDP-1-4-XRGB8888: SUCCESS (0.022s)
[454.510413] Starting dynamic subtest: pipe-A-eDP-1-4-XRGB2101010
[454.521988] Dynamic subtest pipe-A-eDP-1-4-XRGB2101010: SUCCESS (0.021s)
[454.537905] Starting dynamic subtest: pipe-A-eDP-1-4-XRGB16161616F
[454.545504] Dynamic subtest pipe-A-eDP-1-4-XRGB16161616F: SUCCESS (0.020s)
[454.566500] Starting dynamic subtest: pipe-A-eDP-1-4-YUYV
[454.569310] Dynamic subtest pipe-A-eDP-1-4-YUYV: SUCCESS (0.020s)
[454.589986] Starting dynamic subtest: pipe-A-eDP-1-4-Y210
[454.593047] Dynamic subtest pipe-A-eDP-1-4-Y210: SUCCESS (0.020s)
[454.605499] Starting dynamic subtest: pipe-A-eDP-1-4-XYUV8888
[454.611614] Dynamic subtest pipe-A-eDP-1-4-XYUV8888: SUCCESS (0.021s)
[454.621197] Starting dynamic subtest: pipe-A-eDP-1-4-XV30
[454.632295] Dynamic subtest pipe-A-eDP-1-4-XV30: SUCCESS (0.021s)
[454.644909] Starting dynamic subtest: pipe-A-eDP-1-4-XV36
[454.654151] Dynamic subtest pipe-A-eDP-1-4-XV36: SUCCESS (0.021s)
[454.667201] Starting dynamic subtest: pipe-A-eDP-1-x-RGB565
[454.821117] Dynamic subtest pipe-A-eDP-1-x-RGB565: SUCCESS (0.165s)
[454.832245] Starting dynamic subtest: pipe-A-eDP-1-x-XRGB8888
[454.843536] Dynamic subtest pipe-A-eDP-1-x-XRGB8888: SUCCESS (0.021s)
[454.853208] Starting dynamic subtest: pipe-A-eDP-1-x-XRGB2101010
[454.865837] Dynamic subtest pipe-A-eDP-1-x-XRGB2101010: SUCCESS (0.021s)
[454.877342] Starting dynamic subtest: pipe-A-eDP-1-x-XRGB16161616F
[454.888076] Dynamic subtest pipe-A-eDP-1-x-XRGB16161616F: SUCCESS (0.022s)
[454.898135] Starting dynamic subtest: pipe-A-eDP-1-x-YUYV
[454.910218] Dynamic subtest pipe-A-eDP-1-x-YUYV: SUCCESS (0.022s)
[454.920115] Starting dynamic subtest: pipe-A-eDP-1-x-Y210
[454.932201] Dynamic subtest pipe-A-eDP-1-x-Y210: SUCCESS (0.021s)
[454.942130] Starting dynamic subtest: pipe-A-eDP-1-x-XYUV8888
[454.954712] Dynamic subtest pipe-A-eDP-1-x-XYUV8888: SUCCESS (0.022s)
[454.964610] Starting dynamic subtest: pipe-A-eDP-1-x-XV30
[454.978074] Dynamic subtest pipe-A-eDP-1-x-XV30: SUCCESS (0.021s)
[454.987762] Starting dynamic subtest: pipe-A-eDP-1-x-XV36
[454.998672] Dynamic subtest pipe-A-eDP-1-x-XV36: SUCCESS (0.022s)
[455.010094] Starting dynamic subtest: pipe-A-eDP-1-linear-RGB565
[455.165427] Dynamic subtest pipe-A-eDP-1-linear-RGB565: SUCCESS (0.166s)
[455.175070] Starting dynamic subtest: pipe-A-eDP-1-linear-XRGB8888
[455.187596] Dynamic subtest pipe-A-eDP-1-linear-XRGB8888: SUCCESS (0.021s)
[455.197054] Starting dynamic subtest: pipe-A-eDP-1-linear-XRGB2101010
[455.210118] Dynamic subtest pipe-A-eDP-1-linear-XRGB2101010: SUCCESS (0.022s)
[455.219801] Starting dynamic subtest: pipe-A-eDP-1-linear-XRGB16161616F
[455.232705] Dynamic subtest pipe-A-eDP-1-linear-XRGB16161616F: SUCCESS (0.022s)
[455.242334] Starting dynamic subtest: pipe-A-eDP-1-linear-YUYV
[455.254680] Dynamic subtest pipe-A-eDP-1-linear-YUYV: SUCCESS (0.021s)
[455.264103] Starting dynamic subtest: pipe-A-eDP-1-linear-Y210
[455.276826] Dynamic subtest pipe-A-eDP-1-linear-Y210: SUCCESS (0.022s)
[455.286832] Starting dynamic subtest: pipe-A-eDP-1-linear-XYUV8888
[455.299337] Dynamic subtest pipe-A-eDP-1-linear-XYUV8888: SUCCESS (0.022s)
[455.308720] Starting dynamic subtest: pipe-A-eDP-1-linear-XV30
[455.321706] Dynamic subtest pipe-A-eDP-1-linear-XV30: SUCCESS (0.022s)
[455.331346] Starting dynamic subtest: pipe-A-eDP-1-linear-XV36
[455.343662] Dynamic subtest pipe-A-eDP-1-linear-XV36: SUCCESS (0.021s)
[455.746107] Subtest basic-modeset-with-all-modifiers-formats: SUCCESS (2.667s)
[456.553122] [092/133] (567s left) gen9_exec_parse (bb-oversize)
[456.607193] Subtest bb-oversize: SKIP (0.000s)
[456.680946] [093/133] (567s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-32bpp-ytileccs-upscaling)
[456.766051] Starting subtest: flip-32bpp-ytile-to-32bpp-ytileccs-upscaling
[456.771223] Subtest flip-32bpp-ytile-to-32bpp-ytileccs-upscaling: SKIP (0.000s)
[456.862694] [094/133] (567s left) syncobj_timeline (invalid-signal-zero-handles)
[456.919873] Starting subtest: invalid-signal-zero-handles
[456.922496] Subtest invalid-signal-zero-handles: SUCCESS (0.000s)
[457.032447] [095/133] (566s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-mmap-gtt)
[457.132316] Starting subtest: fbc-rgb101010-draw-mmap-gtt
[457.137805] Subtest fbc-rgb101010-draw-mmap-gtt: SKIP (0.000s)
[457.226842] [096/133] (566s left) kms_pm_backlight (fade)
[457.317228] Starting subtest: fade
[457.375248] Starting dynamic subtest: eDP-1
[459.860150] Dynamic subtest eDP-1: SUCCESS (2.487s)
[459.863135] Subtest fade: SUCCESS (2.545s)
[460.669583] [097/133] (563s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-0)
[460.757089] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-0
[460.762437] Subtest y-tiled-max-hw-stride-32bpp-rotate-0: SKIP (0.000s)
[460.875073] [098/133] (563s left) gem_ccs (suspend-resume)
[460.939091] Starting subtest: suspend-resume
[460.944438] Subtest suspend-resume: SKIP (0.000s)
[461.038976] [099/133] (563s left) gem_partial_pwrite_pread (reads)
[461.108018] Subtest reads: SKIP (0.000s)
[461.168498] [100/133] (563s left) kms_lease (lease-revoke)
[461.268546] Starting subtest: lease-revoke
[461.271014] Starting dynamic subtest: pipe-A-eDP-1
[461.297752] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.032s)
[461.309712] Starting dynamic subtest: pipe-B-eDP-1
[461.328059] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.029s)
[461.338660] Starting dynamic subtest: pipe-C-eDP-1
[461.358244] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.029s)
[461.367887] Starting dynamic subtest: pipe-D-eDP-1
[461.391079] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.031s)
[461.393721] Subtest lease-revoke: SUCCESS (0.126s)
[461.508307] [101/133] (562s left) kms_atomic_transition (plane-all-modeset-transition-internal-panels)
[461.613862] Starting subtest: plane-all-modeset-transition-internal-panels
[461.616478] Starting dynamic subtest: pipe-A-eDP-1
[462.906419] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.291s)
[463.183872] Starting dynamic subtest: pipe-B-eDP-1
[464.236441] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.062s)
[464.517403] Subtest plane-all-modeset-transition-internal-panels: SUCCESS (2.903s)
[465.359851] [102/133] (558s left) kms_ccs (bad-rotation-90-4-tiled-mtl-rc-ccs)
[465.457575] Starting subtest: bad-rotation-90-4-tiled-mtl-rc-ccs
[465.459866] Starting dynamic subtest: pipe-A-eDP-1
[465.599650] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.132s)
[465.609984] Starting dynamic subtest: pipe-B-eDP-1
[465.633949] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[465.644285] Starting dynamic subtest: pipe-C-eDP-1
[465.667125] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.002s)
[465.678727] Starting dynamic subtest: pipe-D-eDP-1
[465.702087] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.002s)
[465.704919] Subtest bad-rotation-90-4-tiled-mtl-rc-ccs: SUCCESS (0.141s)
[467.831725] [103/133] (556s left) kms_plane_alpha_blend (alpha-basic)
[467.920001] Starting subtest: alpha-basic
[468.219937] Starting dynamic subtest: pipe-A-eDP-1
[470.129197] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.906s)
[470.154393] Starting dynamic subtest: pipe-D-eDP-1
[472.787072] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.640s)
[472.790009] Subtest alpha-basic: SUCCESS (4.868s)
[473.606760] [104/133] (550s left) gem_exec_balancer (bonded-true-hang)
[473.870836] Starting subtest: bonded-true-hang
[473.876044] Subtest bonded-true-hang: SKIP (0.000s)
[473.961575] [105/133] (550s left) kms_prime (basic-crc-vgem)
[474.046672] Starting subtest: basic-crc-vgem
[474.049124] Starting dynamic subtest: second-to-first
[475.073767] Dynamic subtest second-to-first: SUCCESS (1.030s)
[475.076227] Subtest basic-crc-vgem: SUCCESS (1.031s)
[475.166297] [106/133] (549s left) kms_frontbuffer_tracking (psr-2p-primscrn-shrfb-pgflip-blt)
[475.277235] Starting subtest: psr-2p-primscrn-shrfb-pgflip-blt
[475.281913] Subtest psr-2p-primscrn-shrfb-pgflip-blt: SKIP (0.000s)
[475.381628] [107/133] (549s left) gem_pxp (protected-encrypted-src-copy-not-readible)
[475.500586] Starting subtest: protected-encrypted-src-copy-not-readible
[475.613025] Subtest protected-encrypted-src-copy-not-readible: SUCCESS (0.113s)
[475.721425] [108/133] (548s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-0)
[475.826198] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-0
[475.831211] Subtest y-tiled-max-hw-stride-64bpp-rotate-0: SKIP (0.000s)
[475.927360] [109/133] (548s left) i915_drm_fdinfo (memory-info-resident)
[475.983026] Starting subtest: memory-info-resident
[475.986021] Starting dynamic subtest: smem0
[478.255688] Dynamic subtest smem0: SUCCESS (2.275s)
[478.258232] Subtest memory-info-resident: SUCCESS (2.277s)
[478.336089] [110/133] (546s left) syncobj_wait (multi-wait-for-submit-submitted-signaled)
[478.387451] Starting subtest: multi-wait-for-submit-submitted-signaled
[478.389860] Subtest multi-wait-for-submit-submitted-signaled: SUCCESS (0.000s)
[478.483472] [111/133] (546s left) kms_invalid_mode (overflow-vrefresh)
[478.577647] Starting subtest: overflow-vrefresh
[478.579552] Starting dynamic subtest: pipe-A-eDP-1
[478.862673] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.286s)
[478.872784] Starting dynamic subtest: pipe-B-eDP-1
[478.875061] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[478.885230] Starting dynamic subtest: pipe-C-eDP-1
[478.887919] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[478.897809] Starting dynamic subtest: pipe-D-eDP-1
[478.900204] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[478.903138] Subtest overflow-vrefresh: SUCCESS (0.292s)
[479.710080] [112/133] (545s left) kms_hdmi_inject (inject-4k)
[480.050660] Starting subtest: inject-4k
[480.364099] Subtest inject-4k: SUCCESS (0.315s)
[480.882575] [113/133] (543s left) gem_exec_reloc (basic-cpu-active)
[480.940047] Subtest basic-cpu-active: SKIP (0.000s)
[481.006257] [114/133] (543s left) gem_mmap_gtt (close-race)
[481.058487] Subtest close-race: SKIP (0.000s)
[481.122143] [115/133] (543s left) kms_addfb_basic (tile-pitch-mismatch)
[481.182655] Starting subtest: tile-pitch-mismatch
[481.187031] Subtest tile-pitch-mismatch: SKIP (0.000s)
[481.323454] [116/133] (543s left) kms_color_pipeline (plane-lut1d-ctm3x4-lut1d)
[481.424577] Starting subtest: plane-lut1d-ctm3x4-lut1d
[481.615201] Starting dynamic subtest: pipe-A-plane-0
[481.770920] Dynamic subtest pipe-A-plane-0: SUCCESS (0.156s)
[481.781428] Starting dynamic subtest: pipe-A-plane-1
[481.914498] Dynamic subtest pipe-A-plane-1: SUCCESS (0.142s)
[481.924058] Starting dynamic subtest: pipe-A-plane-2
[482.059360] Dynamic subtest pipe-A-plane-2: SUCCESS (0.144s)
[483.210737] Starting dynamic subtest: pipe-B-plane-0
[483.391125] Dynamic subtest pipe-B-plane-0: SUCCESS (0.189s)
[483.402438] Starting dynamic subtest: pipe-B-plane-1
[483.524754] Dynamic subtest pipe-B-plane-1: SUCCESS (0.133s)
[483.535235] Starting dynamic subtest: pipe-B-plane-2
[483.657899] Dynamic subtest pipe-B-plane-2: SUCCESS (0.133s)
[484.820541] Starting dynamic subtest: pipe-C-plane-0
[484.967245] Dynamic subtest pipe-C-plane-0: SUCCESS (0.155s)
[484.981902] Starting dynamic subtest: pipe-C-plane-1
[485.112207] Dynamic subtest pipe-C-plane-1: SUCCESS (0.144s)
[485.123747] Starting dynamic subtest: pipe-C-plane-2
[485.267922] Dynamic subtest pipe-C-plane-2: SUCCESS (0.155s)
[486.522993] Starting dynamic subtest: pipe-D-plane-0
[486.659056] Dynamic subtest pipe-D-plane-0: SUCCESS (0.144s)
[486.669640] Starting dynamic subtest: pipe-D-plane-1
[486.816085] Dynamic subtest pipe-D-plane-1: SUCCESS (0.155s)
[486.826520] Starting dynamic subtest: pipe-D-plane-2
[486.959075] Dynamic subtest pipe-D-plane-2: SUCCESS (0.144s)
[487.258825] Subtest plane-lut1d-ctm3x4-lut1d: SUCCESS (5.831s)
[488.058650] [117/133] (536s left) kms_flip (2x-wf_vblank-ts-check)
[488.158132] Starting subtest: 2x-wf_vblank-ts-check
[488.168196] Subtest 2x-wf_vblank-ts-check: SKIP (0.010s)
[488.247282] [118/133] (536s left) gem_mmap_wc (write-cpu-read-wc)
[488.322221] Subtest write-cpu-read-wc: SKIP (0.000s)
[488.383417] [119/133] (536s left) gem_render_copy (y-tiled-ccs-to-y-tiled)
[488.442930] Starting subtest: y-tiled-ccs-to-y-tiled
[488.448706] Subtest y-tiled-ccs-to-y-tiled: SKIP (0.000s)
[488.640479] [120/133] (536s left) i915_query (query-topology-matches-eu-total)
[488.708903] Starting subtest: query-topology-matches-eu-total
[488.711887] Subtest query-topology-matches-eu-total: SUCCESS (0.000s)
[488.817181] [121/133] (536s left) kms_cursor_legacy (cursorb-vs-flipa-atomic-transitions-varying-size)
[488.933890] Starting subtest: cursorB-vs-flipA-atomic-transitions-varying-size
[488.938475] Subtest cursorB-vs-flipA-atomic-transitions-varying-size: SKIP (0.001s)
[489.078507] [122/133] (536s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-pwrite)
[489.185783] Starting subtest: psr-1p-primscrn-pri-indfb-draw-pwrite
[496.772078] Subtest psr-1p-primscrn-pri-indfb-draw-pwrite: SUCCESS (7.594s)
[496.887983] [123/133] (528s left) kms_big_fb (yf-tiled-64bpp-rotate-270)
[496.991795] Starting subtest: yf-tiled-64bpp-rotate-270
[496.996896] Subtest yf-tiled-64bpp-rotate-270: SKIP (0.000s)
[497.095915] [124/133] (528s left) gem_mmap_offset (oob-read)
[497.149906] Starting subtest: oob-read
[497.152226] Subtest oob-read: SUCCESS (0.000s)
[497.246380] [125/133] (528s left) api_intel_bb (add-remove-objects)
[497.301377] Starting subtest: add-remove-objects
[497.305993] Subtest add-remove-objects: SUCCESS (0.007s)
[497.421078] [126/133] (527s left) kms_big_fb (yf-tiled-16bpp-rotate-270)
[497.520792] Starting subtest: yf-tiled-16bpp-rotate-270
[497.525424] Subtest yf-tiled-16bpp-rotate-270: SKIP (0.000s)
[497.618941] [127/133] (527s left) kms_dirtyfb (fbc-dirtyfb-ioctl)
[497.709219] Starting subtest: fbc-dirtyfb-ioctl
[497.711773] Starting dynamic subtest: A-eDP-1
[500.274484] Dynamic subtest A-eDP-1: SUCCESS (2.566s)
[500.276966] Subtest fbc-dirtyfb-ioctl: SUCCESS (2.567s)
[501.153210] [128/133] (524s left) kms_cdclk (mode-transition)
[501.251485] Starting subtest: mode-transition
[501.253762] Starting dynamic subtest: pipe-A-eDP-1
[501.551596] Dynamic subtest pipe-A-eDP-1: SKIP (0.297s)
[501.563981] Starting dynamic subtest: pipe-B-eDP-1
[501.568708] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[501.579500] Starting dynamic subtest: pipe-C-eDP-1
[501.584536] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[501.594201] Starting dynamic subtest: pipe-D-eDP-1
[501.599119] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[501.603886] Subtest mode-transition: SKIP (0.305s)
[502.341908] [129/133] (523s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-mmap-wc)
[502.440091] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-mmap-wc
[502.445103] Subtest fbc-2p-scndscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[502.524955] [130/133] (523s left) gem_tiled_partial_pwrite_pread (writes-after-reads)
[502.589234] Subtest writes-after-reads: SKIP (0.000s)
[502.647866] [131/133] (522s left) kms_plane_scaling (plane-scaler-unity-scaling-with-modifiers)
[502.735877] Starting subtest: plane-scaler-unity-scaling-with-modifiers
[502.737905] Starting dynamic subtest: pipe-A
[503.072935] Dynamic subtest pipe-A: SUCCESS (0.340s)
[503.083183] Starting dynamic subtest: pipe-B
[504.511013] Dynamic subtest pipe-B: SUCCESS (1.437s)
[504.520865] Starting dynamic subtest: pipe-C
[505.935910] Dynamic subtest pipe-C: SUCCESS (1.422s)
[505.949118] Starting dynamic subtest: pipe-D
[507.325709] Dynamic subtest pipe-D: SUCCESS (1.389s)
[507.328015] Subtest plane-scaler-unity-scaling-with-modifiers: SUCCESS (4.593s)
[508.446373] [132/133] (517s left) kms_addfb_basic (too-wide)
[508.551234] Starting subtest: too-wide
[508.553708] Subtest too-wide: SUCCESS (0.000s)
[508.635069] [133/133] (517s left) gem_exec_whisper (basic-contexts-forked-all)
[508.705525] Starting subtest: basic-contexts-forked-all
[533.073731] Subtest basic-contexts-forked-all: SUCCESS (24.363s)
[533.258915] 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.