[61.521547] Initializing watchdogs
[61.521593]   /dev/watchdog0
[61.538106] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:7d55 Intel Meteorlake (Gen12) Meteor Lake-P [Intel Arc Graphics]
[61.542420] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[61.544981] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[61.548309] [001/133] (960s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-mmap-gtt)
[61.676421] Starting subtest: psr-2p-primscrn-spr-indfb-draw-mmap-gtt
[61.680412] Subtest psr-2p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[61.801984] [002/133] (960s left) gem_exec_suspend (basic-s3-devices)
[61.879302] Starting subtest: basic-S3-devices
[61.881618] Starting dynamic subtest: smem
[73.876426] Dynamic subtest smem: SUCCESS (11.990s)
[73.878629] Subtest basic-S3-devices: SUCCESS (11.991s)
[74.079701] [003/133] (948s left) gem_render_copy (y-tiled-ccs-to-yf-tiled)
[74.155332] Starting subtest: y-tiled-ccs-to-yf-tiled
[74.159259] Subtest y-tiled-ccs-to-yf-tiled: SKIP (0.000s)
[74.358035] [004/133] (947s left) kms_ccs (ccs-on-another-bo-y-tiled-gen12-mc-ccs)
[74.461199] Starting subtest: ccs-on-another-bo-y-tiled-gen12-mc-ccs
[74.463555] Starting dynamic subtest: pipe-A-eDP-1
[74.486826] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[74.498042] Starting dynamic subtest: pipe-B-eDP-1
[74.521311] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[74.530394] Starting dynamic subtest: pipe-C-eDP-1
[74.551860] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[74.558801] Starting dynamic subtest: pipe-D-eDP-1
[74.580788] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[74.585593] Subtest ccs-on-another-bo-y-tiled-gen12-mc-ccs: SKIP (0.003s)
[76.719355] [005/133] (945s left) kms_flip (bo-too-big)
[76.823336] Starting subtest: bo-too-big
[76.825615] Starting dynamic subtest: A-eDP1
[78.137473] Dynamic subtest A-eDP1: SUCCESS (1.316s)
[78.147960] Starting dynamic subtest: B-eDP1
[79.461304] Dynamic subtest B-eDP1: SUCCESS (1.323s)
[79.468956] Starting dynamic subtest: C-eDP1
[80.717256] Dynamic subtest C-eDP1: SUCCESS (1.254s)
[80.728330] Starting dynamic subtest: D-eDP1
[82.055885] Dynamic subtest D-eDP1: SUCCESS (1.339s)
[82.058331] Subtest bo-too-big: SUCCESS (5.238s)
[83.279449] [006/133] (938s left) syncobj_timeline (multi-wait-available-unsubmitted-signaled)
[83.347179] Starting subtest: multi-wait-available-unsubmitted-signaled
[83.349655] Subtest multi-wait-available-unsubmitted-signaled: SUCCESS (0.000s)
[83.480595] [007/133] (938s left) kms_lease (lease-uevent)
[83.590246] Starting subtest: lease-uevent
[84.608808] Subtest lease-uevent: SUCCESS (1.018s)
[84.713928] [008/133] (937s left) gem_exec_fence (syncobj-timeline-wait)
[85.311462] Starting subtest: syncobj-timeline-wait
[86.927040] Subtest syncobj-timeline-wait: SUCCESS (1.616s)
[88.996060] [FACT gem_exec_fence (syncobj-timeline-wait)] new: kernel.kmod_is_loaded.vgem: true
[88.999339] [009/133] (933s left) kms_chamelium_color (gamma)
[89.101464] Subtest gamma: SKIP (0.000s)
[89.145807] [010/133] (933s left) prime_mmap (test_errors)
[89.205286] Starting subtest: test_errors
[89.207259] Starting dynamic subtest: test_errors-smem
[89.296404] Dynamic subtest test_errors-smem: SUCCESS (0.091s)
[89.299090] Subtest test_errors: SUCCESS (0.091s)
[89.422543] [011/133] (933s left) i915_drm_fdinfo (idle)
[89.462657] Starting subtest: idle
[89.464551] Starting dynamic subtest: rcs0
[90.061993] Dynamic subtest rcs0: SUCCESS (0.600s)
[90.073213] Starting dynamic subtest: bcs0
[90.568538] Dynamic subtest bcs0: SUCCESS (0.504s)
[90.579778] Starting dynamic subtest: vcs0
[91.073360] Dynamic subtest vcs0: SUCCESS (0.504s)
[91.084048] Starting dynamic subtest: vcs1
[91.578705] Dynamic subtest vcs1: SUCCESS (0.504s)
[91.589361] Starting dynamic subtest: vecs0
[92.083470] Dynamic subtest vecs0: SUCCESS (0.504s)
[92.094823] Starting dynamic subtest: ccs0
[92.588600] Dynamic subtest ccs0: SUCCESS (0.504s)
[92.591516] Subtest idle: SUCCESS (3.125s)
[92.688069] [012/133] (929s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-mmap-cpu)
[92.797314] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-mmap-cpu
[92.801738] Subtest fbc-2p-scndscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[92.929493] [013/133] (929s left) kms_invalid_mode (zero-hdisplay)
[93.027394] Starting subtest: zero-hdisplay
[93.029799] Starting dynamic subtest: pipe-A-eDP-1
[93.315827] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.288s)
[93.325391] Starting dynamic subtest: pipe-B-eDP-1
[93.327285] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[93.335076] Starting dynamic subtest: pipe-C-eDP-1
[93.337358] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[93.346862] Starting dynamic subtest: pipe-D-eDP-1
[93.349415] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[93.351884] Subtest zero-hdisplay: SUCCESS (0.293s)
[94.211280] [014/133] (928s left) kms_plane_scaling (planes-downscale-factor-0-75-unity-scaling)
[94.312107] Starting subtest: planes-downscale-factor-0-75-unity-scaling
[94.314464] Starting dynamic subtest: pipe-A
[94.377498] Dynamic subtest pipe-A: SUCCESS (0.065s)
[94.387612] Starting dynamic subtest: pipe-B
[95.508908] Dynamic subtest pipe-B: SUCCESS (1.131s)
[95.519303] Starting dynamic subtest: pipe-C
[96.617047] Dynamic subtest pipe-C: SUCCESS (1.106s)
[96.627015] Starting dynamic subtest: pipe-D
[97.753530] Dynamic subtest pipe-D: SUCCESS (1.137s)
[97.755774] Subtest planes-downscale-factor-0-75-unity-scaling: SUCCESS (3.441s)
[98.925102] [015/133] (923s left) drm_read (fault-buffer)
[99.081911] Starting subtest: fault-buffer
[99.084303] Subtest fault-buffer: SUCCESS (0.000s)
[99.240076] [016/133] (923s left) gem_ccs (suspend-resume)
[99.289177] Starting subtest: suspend-resume
[99.293714] Subtest suspend-resume: SKIP (0.000s)
[99.427577] [017/133] (923s left) kms_ccs (bad-rotation-90-4-tiled-dg2-rc-ccs)
[99.514840] Starting subtest: bad-rotation-90-4-tiled-dg2-rc-ccs
[99.517098] Starting dynamic subtest: pipe-A-eDP-1
[99.539627] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[99.549565] Starting dynamic subtest: pipe-B-eDP-1
[99.570893] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[99.578230] Starting dynamic subtest: pipe-C-eDP-1
[99.599936] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[99.607278] Starting dynamic subtest: pipe-D-eDP-1
[99.630174] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[99.634547] Subtest bad-rotation-90-4-tiled-dg2-rc-ccs: SKIP (0.003s)
[101.691215] [018/133] (921s left) gem_close (many-handles-one-vma)
[101.760184] Starting subtest: many-handles-one-vma
[101.783581] Subtest many-handles-one-vma: SUCCESS (0.024s)
[101.898302] [019/133] (920s left) gem_busy (extended)
[102.067296] Starting subtest: extended
[102.069697] Starting dynamic subtest: rcs0
[102.166641] Dynamic subtest rcs0: SUCCESS (0.099s)
[102.177480] Starting dynamic subtest: bcs0
[102.208811] Dynamic subtest bcs0: SUCCESS (0.041s)
[102.218867] Starting dynamic subtest: vcs0
[103.891465] Dynamic subtest vcs0: SUCCESS (1.681s)
[103.901484] Starting dynamic subtest: vcs1
[105.877557] Dynamic subtest vcs1: SUCCESS (1.984s)
[105.887763] Starting dynamic subtest: vecs0
[107.924953] Dynamic subtest vecs0: SUCCESS (2.046s)
[107.934723] Starting dynamic subtest: ccs0
[107.968872] Dynamic subtest ccs0: SUCCESS (0.045s)
[107.971523] Subtest extended: SUCCESS (5.902s)
[108.256840] [020/133] (914s left) kms_vblank (ts-continuation-suspend)
[108.345361] Starting subtest: ts-continuation-suspend
[108.347726] Starting dynamic subtest: pipe-A-eDP-1
[125.105156] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.513s)
[125.119838] Starting dynamic subtest: pipe-D-eDP-1
[142.104326] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.198s)
[142.106399] Subtest ts-continuation-suspend: SUCCESS (3.714s)
[142.925114] [021/133] (879s left) perf_pmu (semaphore-wait-idle)
[142.973734] Starting subtest: semaphore-wait-idle
[142.976206] Starting dynamic subtest: rcs0
[143.490565] Dynamic subtest rcs0: SUCCESS (0.514s)
[143.503025] Starting dynamic subtest: bcs0
[144.004862] Dynamic subtest bcs0: SUCCESS (0.511s)
[144.014635] Starting dynamic subtest: vcs0
[144.518797] Dynamic subtest vcs0: SUCCESS (0.511s)
[144.530613] Starting dynamic subtest: vcs1
[145.032729] Dynamic subtest vcs1: SUCCESS (0.511s)
[145.044134] Starting dynamic subtest: vecs0
[145.546253] Dynamic subtest vecs0: SUCCESS (0.511s)
[145.560934] Starting dynamic subtest: ccs0
[146.062407] Dynamic subtest ccs0: SUCCESS (0.514s)
[146.065396] Subtest semaphore-wait-idle: SUCCESS (3.080s)
[146.202750] [022/133] (876s left) kms_debugfs (display-off-read-all)
[146.313452] Starting subtest: display-off-read-all
[146.605293] Subtest display-off-read-all: SUCCESS (0.290s)
[147.470189] [023/133] (875s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-blt)
[147.578344] Starting subtest: fbc-rgb101010-draw-blt
[152.158551] Subtest fbc-rgb101010-draw-blt: SUCCESS (4.576s)
[153.377912] [024/133] (869s left) gem_ctx_param (invalid-get-no-zeromap)
[153.432340] Starting subtest: invalid-get-no-zeromap
[153.434817] Subtest invalid-get-no-zeromap: SUCCESS (0.001s)
[153.576183] [025/133] (869s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-mmap-gtt)
[153.676231] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-mmap-gtt
[153.680441] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[153.788902] [026/133] (869s left) gem_exec_big (single)
[153.851039] Starting subtest: single
[156.203702] Subtest single: SUCCESS (2.349s)
[156.462552] [027/133] (866s left) kms_frontbuffer_tracking (psr-rgb101010-draw-mmap-gtt)
[156.627516] Starting subtest: psr-rgb101010-draw-mmap-gtt
[156.631923] Subtest psr-rgb101010-draw-mmap-gtt: SKIP (0.000s)
[156.765990] [028/133] (866s left) gem_exec_flush (basic-uc-prw-default)
[156.834345] Starting subtest: basic-uc-prw-default
[162.294906] Subtest basic-uc-prw-default: SUCCESS (5.457s)
[162.504607] [029/133] (860s left) kms_frontbuffer_tracking (fbc-1p-shrfb-fliptrack-mmap-gtt)
[162.611402] Starting subtest: fbc-1p-shrfb-fliptrack-mmap-gtt
[162.616068] Subtest fbc-1p-shrfb-fliptrack-mmap-gtt: SKIP (0.000s)
[162.746891] [030/133] (860s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-shrfb-draw-render)
[162.848639] Starting subtest: psr-1p-offscreen-pri-shrfb-draw-render
[169.651645] Subtest psr-1p-offscreen-pri-shrfb-draw-render: SUCCESS (6.801s)
[169.803637] [031/133] (853s left) gem_exec_create (forked)
[169.880957] Starting subtest: forked
[169.883408] Starting dynamic subtest: smem
[191.914129] Dynamic subtest smem: SUCCESS (22.020s)
[191.916958] Subtest forked: SUCCESS (22.021s)
[192.128557] [032/133] (831s left) kms_feature_discovery (display-1x)
[192.230335] Starting subtest: display-1x
[192.232642] Subtest display-1x: SUCCESS (0.000s)
[192.329852] [033/133] (831s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-wc)
[192.427871] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-wc
[192.432003] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[192.557781] [034/133] (830s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-move)
[192.660121] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-move
[192.664081] Subtest fbcpsr-2p-primscrn-cur-indfb-move: SKIP (0.000s)
[192.815987] [035/133] (830s left) gem_render_copy_redux (interruptible)
[192.884580] Starting subtest: interruptible
[193.135802] Subtest interruptible: SUCCESS (0.252s)
[193.293552] [036/133] (830s left) i915_pm_rpm (system-suspend-execbuf)
[195.038001] Starting subtest: system-suspend-execbuf
[253.736180] Subtest system-suspend-execbuf: SUCCESS (43.997s)
[254.116300] [037/133] (769s left) kms_frontbuffer_tracking (psr-2p-scndscrn-indfb-plflip-blt)
[254.218393] Starting subtest: psr-2p-scndscrn-indfb-plflip-blt
[254.222859] Subtest psr-2p-scndscrn-indfb-plflip-blt: SKIP (0.000s)
[254.362362] [038/133] (769s left) gem_request_retire (retire-vma-not-inactive)
[254.425858] Starting subtest: retire-vma-not-inactive
[254.487277] Subtest retire-vma-not-inactive: SUCCESS (0.059s)
[254.650228] [039/133] (768s left) i915_pm_rps (thresholds-idle)
[254.720259] Starting subtest: thresholds-idle
[254.724945] Subtest thresholds-idle: SKIP (0.000s)
[254.847896] [040/133] (768s left) gem_ctx_persistence (legacy-engines-queued)
[254.913895] Starting subtest: legacy-engines-queued
[254.916328] Starting dynamic subtest: render
[255.019034] Dynamic subtest render: SUCCESS (0.104s)
[255.031376] Starting dynamic subtest: bsd1
[256.587944] Dynamic subtest bsd1: SUCCESS (1.565s)
[256.599752] Starting dynamic subtest: bsd2
[258.569129] Dynamic subtest bsd2: SUCCESS (1.979s)
[258.580245] Starting dynamic subtest: blt
[258.647996] Dynamic subtest blt: SUCCESS (0.078s)
[258.659016] Starting dynamic subtest: vebox
[260.555028] Dynamic subtest vebox: SUCCESS (1.903s)
[260.558120] Subtest legacy-engines-queued: SUCCESS (5.640s)
[260.659456] [041/133] (763s left) i915_hangman (gt-error-state-capture)
[260.725140] Starting subtest: gt-error-state-capture
[260.727503] Starting dynamic subtest: rcs0
[272.586601] Dynamic subtest rcs0: SUCCESS (11.858s)
[272.598988] Starting dynamic subtest: bcs0
[284.555154] Dynamic subtest bcs0: SUCCESS (11.962s)
[284.566775] Starting dynamic subtest: vcs0
[296.522984] Dynamic subtest vcs0: SUCCESS (11.962s)
[296.535379] Starting dynamic subtest: vcs1
[307.530478] Dynamic subtest vcs1: SUCCESS (11.002s)
[307.542941] Starting dynamic subtest: vecs0
[318.537918] Dynamic subtest vecs0: SUCCESS (11.009s)
[318.550274] Starting dynamic subtest: ccs0
[330.570751] Dynamic subtest ccs0: SUCCESS (12.032s)
[330.573873] Subtest gt-error-state-capture: SUCCESS (69.836s)
[330.673406] [042/133] (693s left) kms_cursor_crc (cursor-rapid-movement-128x42)
[330.904143] Starting subtest: cursor-rapid-movement-128x42
[330.953784] Subtest cursor-rapid-movement-128x42: SKIP (0.044s)
[331.188563] [043/133] (692s left) gem_partial_pwrite_pread (writes-after-reads-uncached)
[331.261166] Subtest writes-after-reads-uncached: SKIP (0.000s)
[331.345633] [044/133] (692s left) gem_mmap_wc (coherency)
[331.399141] Subtest coherency: SKIP (0.000s)
[331.466055] [045/133] (692s left) syncobj_timeline (single-wait-all-for-submit-signaled)
[331.533872] Starting subtest: single-wait-all-for-submit-signaled
[331.536031] Subtest single-wait-all-for-submit-signaled: SUCCESS (0.000s)
[331.646546] [046/133] (692s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-render)
[331.738900] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-render
[335.391160] Subtest fbc-1p-primscrn-cur-indfb-draw-render: SUCCESS (3.655s)
[336.619944] [047/133] (687s left) kms_psr (fbc-psr-primary-mmap-cpu)
[336.726130] Starting subtest: fbc-psr-primary-mmap-cpu
[336.727957] Starting dynamic subtest: eDP-1
[336.731897] Dynamic subtest eDP-1: SKIP (0.000s)
[336.735879] Subtest fbc-psr-primary-mmap-cpu: SKIP (0.001s)
[336.824107] [048/133] (687s left) kms_invalid_mode (bad-vsync-start)
[336.929968] Starting subtest: bad-vsync-start
[336.932637] Starting dynamic subtest: pipe-A-eDP-1
[337.219450] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.288s)
[337.230071] Starting dynamic subtest: pipe-B-eDP-1
[337.232150] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[337.241201] Starting dynamic subtest: pipe-C-eDP-1
[337.243834] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[337.258846] Starting dynamic subtest: pipe-D-eDP-1
[337.261234] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[337.263749] Subtest bad-vsync-start: SUCCESS (0.293s)
[338.041934] [049/133] (685s left) gem_exec_reloc (basic-wc-gtt)
[338.111972] Subtest basic-wc-gtt: SKIP (0.000s)
[338.186036] [050/133] (685s left) gem_mmap_gtt (cpuset-medium-copy-xy)
[338.246151] Subtest cpuset-medium-copy-XY: SKIP (0.000s)
[338.317267] [051/133] (685s left) kms_prop_blob (blob-multiple)
[338.373968] Starting subtest: blob-multiple
[338.376272] Subtest blob-multiple: SUCCESS (0.002s)
[338.503190] [052/133] (685s left) api_intel_allocator (open-vm)
[338.557896] Starting subtest: open-vm
[338.563684] Subtest open-vm: SUCCESS (0.006s)
[338.714328] [053/133] (685s left) kms_getfb (getfb-repeated-different-handles)
[338.804107] Starting subtest: getfb-repeated-different-handles
[338.806271] Subtest getfb-repeated-different-handles: SUCCESS (0.000s)
[338.930380] [054/133] (685s left) kms_content_protection (legacy-hdcp14)
[339.074120] Starting subtest: legacy-hdcp14
[339.078208] Subtest legacy-hdcp14: SKIP (0.000s)
[339.234363] [055/133] (685s left) kms_chamelium_hpd (hdmi-hpd-after-suspend)
[339.626161] Subtest hdmi-hpd-after-suspend: SKIP (0.000s)
[340.448166] [056/133] (683s left) kms_flip (blocking-absolute-wf_vblank)
[340.537831] Starting subtest: blocking-absolute-wf_vblank
[340.540265] Starting dynamic subtest: A-eDP1
[349.305330] Dynamic subtest A-eDP1: SUCCESS (8.769s)
[349.314285] Starting dynamic subtest: B-eDP1
[358.046862] Dynamic subtest B-eDP1: SUCCESS (8.738s)
[358.061433] Starting dynamic subtest: C-eDP1
[366.779336] Dynamic subtest C-eDP1: SUCCESS (8.730s)
[366.788853] Starting dynamic subtest: D-eDP1
[375.510937] Dynamic subtest D-eDP1: SUCCESS (8.727s)
[375.516127] Subtest blocking-absolute-wf_vblank: SUCCESS (34.977s)
[376.750069] [057/133] (647s left) gem_mmap_offset (bad-object)
[376.817374] Starting subtest: bad-object
[376.819598] Subtest bad-object: SUCCESS (0.001s)
[376.951415] [058/133] (647s left) kms_psr (psr2-no-drrs)
[377.061753] Starting subtest: psr2-no-drrs
[377.064282] Starting dynamic subtest: eDP-1
[378.685171] Dynamic subtest eDP-1: SUCCESS (1.624s)
[378.687519] Subtest psr2-no-drrs: SUCCESS (1.625s)
[379.508769] [059/133] (644s left) gem_fenced_exec_thrash (no-spare-fences-interruptible)
[379.570114] Subtest no-spare-fences-interruptible: SKIP (0.000s)
[379.629152] [060/133] (644s left) kms_vblank (wait-idle)
[379.716967] Starting subtest: wait-idle
[379.718811] Starting dynamic subtest: pipe-A-eDP-1
[381.484502] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.768s)
[381.498839] Starting dynamic subtest: pipe-D-eDP-1
[383.920535] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.433s)
[383.923028] Subtest wait-idle: SUCCESS (4.204s)
[384.770997] [061/133] (639s left) gem_exec_whisper (basic-contexts-all)
[384.839820] Starting subtest: basic-contexts-all
[395.728836] Subtest basic-contexts-all: SUCCESS (10.884s)
[395.937336] [062/133] (628s left) kms_big_fb (x-tiled-16bpp-rotate-0)
[396.059535] Starting subtest: x-tiled-16bpp-rotate-0
[397.337462] Subtest x-tiled-16bpp-rotate-0: SUCCESS (1.278s)
[397.508882] [063/133] (627s left) kms_atomic (plane-primary-overlay-mutable-zpos)
[397.599543] Starting subtest: plane-primary-overlay-mutable-zpos
[400.999153] Subtest plane-primary-overlay-mutable-zpos: SKIP (3.398s)
[402.212462] [064/133] (622s left) gen9_exec_parse (bb-start-cmd)
[402.265593] Subtest bb-start-cmd: SKIP (0.000s)
[402.341223] [065/133] (622s left) kms_cursor_crc (cursor-alpha-opaque)
[402.426092] Starting subtest: cursor-alpha-opaque
[402.427969] Starting dynamic subtest: pipe-A-eDP-1
[403.052904] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.626s)
[403.062471] Starting dynamic subtest: pipe-D-eDP-1
[404.369002] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.316s)
[404.371426] Subtest cursor-alpha-opaque: SUCCESS (1.945s)
[405.186102] [066/133] (619s left) kms_cursor_crc (cursor-sliding-64x64)
[405.358783] Starting subtest: cursor-sliding-64x64
[405.360892] Starting dynamic subtest: pipe-A-eDP-1
[408.602418] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.242s)
[408.633581] Starting dynamic subtest: pipe-D-eDP-1
[412.464999] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.839s)
[412.467416] Subtest cursor-sliding-64x64: SUCCESS (7.106s)
[413.354734] [067/133] (611s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-render)
[413.453401] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-render
[420.204559] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-render: SUCCESS (6.749s)
[420.376608] [068/133] (604s left) gem_ctx_shared (exec-single-timeline)
[420.455638] Starting subtest: exec-single-timeline
[420.458058] Starting dynamic subtest: rcs0
[421.512726] Dynamic subtest rcs0: SUCCESS (1.055s)
[421.529887] Starting dynamic subtest: bcs0
[422.601061] Dynamic subtest bcs0: SUCCESS (1.085s)
[422.614050] Starting dynamic subtest: vcs0
[423.689721] Dynamic subtest vcs0: SUCCESS (1.086s)
[423.703681] Starting dynamic subtest: vcs1
[424.776997] Dynamic subtest vcs1: SUCCESS (1.085s)
[424.789709] Starting dynamic subtest: vecs0
[425.865585] Dynamic subtest vecs0: SUCCESS (1.085s)
[425.878534] Starting dynamic subtest: ccs0
[426.952982] Dynamic subtest ccs0: SUCCESS (1.084s)
[426.955955] Subtest exec-single-timeline: SUCCESS (6.496s)
[427.705175] [069/133] (597s left) kms_plane_scaling (plane-downscale-factor-0-75-with-pixel-format)
[427.798936] Starting subtest: plane-downscale-factor-0-75-with-pixel-format
[427.801254] Starting dynamic subtest: pipe-A
[428.959474] Dynamic subtest pipe-A: SUCCESS (1.163s)
[428.970608] Starting dynamic subtest: pipe-B
[431.197247] Dynamic subtest pipe-B: SUCCESS (2.235s)
[431.208177] Starting dynamic subtest: pipe-C
[432.349957] Dynamic subtest pipe-C: SUCCESS (1.150s)
[432.360121] Starting dynamic subtest: pipe-D
[433.579753] Dynamic subtest pipe-D: SUCCESS (1.229s)
[433.582154] Subtest plane-downscale-factor-0-75-with-pixel-format: SUCCESS (5.782s)
[434.790664] [070/133] (590s left) gem_wait (write-busy)
[434.864558] Starting subtest: write-busy
[434.866960] Starting dynamic subtest: all-engines
[435.507786] Dynamic subtest all-engines: SUCCESS (0.643s)
[435.525849] Starting dynamic subtest: rcs0
[436.068092] Dynamic subtest rcs0: SUCCESS (0.559s)
[436.088689] Starting dynamic subtest: bcs0
[436.620723] Dynamic subtest bcs0: SUCCESS (0.551s)
[436.636727] Starting dynamic subtest: vcs0
[438.571804] Dynamic subtest vcs0: SUCCESS (1.949s)
[438.589130] Starting dynamic subtest: vcs1
[440.619610] Dynamic subtest vcs1: SUCCESS (2.045s)
[440.635395] Starting dynamic subtest: vecs0
[442.603714] Dynamic subtest vecs0: SUCCESS (1.982s)
[442.619872] Starting dynamic subtest: ccs0
[443.154166] Dynamic subtest ccs0: SUCCESS (0.550s)
[443.156598] Subtest write-busy: SUCCESS (8.292s)
[443.381908] [071/133] (581s left) kms_big_fb (y-tiled-8bpp-rotate-0)
[443.497504] Starting subtest: y-tiled-8bpp-rotate-0
[443.501613] Subtest y-tiled-8bpp-rotate-0: SKIP (0.000s)
[443.611539] [072/133] (581s left) kms_cursor_legacy (basic-busy-flip-before-cursor-legacy)
[443.737514] Starting subtest: basic-busy-flip-before-cursor-legacy
[443.742634] Subtest basic-busy-flip-before-cursor-legacy: SKIP (0.000s)
[443.905159] [073/133] (581s left) gem_basic (bad-close)
[443.956141] Starting subtest: bad-close
[443.960483] Subtest bad-close: SUCCESS (0.000s)
[444.075503] [074/133] (581s left) kms_big_fb (linear-16bpp-rotate-0)
[444.173552] Starting subtest: linear-16bpp-rotate-0
[445.606600] Subtest linear-16bpp-rotate-0: SUCCESS (1.435s)
[445.730413] [075/133] (579s left) kms_psr2_sf (pr-overlay-plane-update-continuous-sf)
[450.813750] Starting subtest: pr-overlay-plane-update-continuous-sf
[450.821173] Subtest pr-overlay-plane-update-continuous-sf: SKIP (0.004s)
[451.703509] [076/133] (573s left) drm_read (short-buffer-wakeup)
[451.879298] Starting subtest: short-buffer-wakeup
[484.089215] Subtest short-buffer-wakeup: SUCCESS (32.216s)
[484.274776] [077/133] (540s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-pwrite)
[484.379310] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-pwrite
[491.480287] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-pwrite: SUCCESS (7.103s)
[491.644031] [078/133] (533s left) kms_psr (fbc-pr-cursor-render)
[491.753364] Starting subtest: fbc-pr-cursor-render
[491.757733] Subtest fbc-pr-cursor-render: SKIP (0.000s)
[491.867056] [079/133] (533s left) kms_ccs (crc-primary-suspend-y-tiled-gen12-mc-ccs)
[491.959147] Starting subtest: crc-primary-suspend-y-tiled-gen12-mc-ccs
[491.961250] Starting dynamic subtest: pipe-A-eDP-1
[491.969921] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[491.980403] Starting dynamic subtest: pipe-B-eDP-1
[491.989373] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[491.998903] Starting dynamic subtest: pipe-C-eDP-1
[492.007055] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[492.015763] Starting dynamic subtest: pipe-D-eDP-1
[492.023782] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[492.027723] Subtest crc-primary-suspend-y-tiled-gen12-mc-ccs: SKIP (0.004s)
[494.173390] [080/133] (531s left) kms_ccs (random-ccs-data-4-tiled-mtl-mc-ccs)
[494.269378] Starting subtest: random-ccs-data-4-tiled-mtl-mc-ccs
[494.271762] Starting dynamic subtest: pipe-A-eDP-1
[495.490936] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.221s)
[495.504731] Starting dynamic subtest: pipe-B-eDP-1
[497.773438] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.279s)
[497.783129] Starting dynamic subtest: pipe-C-eDP-1
[500.079168] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.304s)
[500.089302] Starting dynamic subtest: pipe-D-eDP-1
[502.338190] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.254s)
[502.340519] Subtest random-ccs-data-4-tiled-mtl-mc-ccs: SUCCESS (8.066s)
[503.548125] [081/133] (521s left) sw_sync (sync_multi_timeline_wait)
[503.596813] Starting subtest: sync_multi_timeline_wait
[503.598667] Subtest sync_multi_timeline_wait: SUCCESS (0.000s)
[503.679857] [082/133] (521s left) sysfs_heartbeat_interval (idempotent)
[503.744653] Starting subtest: idempotent
[503.746930] Starting dynamic subtest: vecs0
[503.749151] Dynamic subtest vecs0: SUCCESS (0.001s)
[503.760320] Starting dynamic subtest: ccs0
[503.762481] Dynamic subtest ccs0: SUCCESS (0.001s)
[503.771498] Starting dynamic subtest: vcs0
[503.773633] Dynamic subtest vcs0: SUCCESS (0.000s)
[503.782157] Starting dynamic subtest: bcs0
[503.784170] Dynamic subtest bcs0: SUCCESS (0.001s)
[503.792951] Starting dynamic subtest: rcs0
[503.795139] Dynamic subtest rcs0: SUCCESS (0.000s)
[503.804255] Starting dynamic subtest: vcs1
[503.806335] Dynamic subtest vcs1: SUCCESS (0.000s)
[503.808419] Subtest idempotent: SUCCESS (0.008s)
[503.897496] [083/133] (521s left) syncobj_eventfd (invalid-bad-pad)
[503.963128] Starting subtest: invalid-bad-pad
[503.965384] Subtest invalid-bad-pad: SUCCESS (0.000s)
[504.099224] [084/133] (521s left) kms_busy (extended-pageflip-hang-newfb)
[504.200850] Starting subtest: extended-pageflip-hang-newfb
[504.203355] Starting dynamic subtest: pipe-A
[530.369282] Dynamic subtest pipe-A: SUCCESS (26.163s)
[530.379135] Starting dynamic subtest: pipe-D
[555.388815] Dynamic subtest pipe-D: SUCCESS (25.014s)
[555.391324] Subtest extended-pageflip-hang-newfb: SUCCESS (51.181s)
[556.277551] [085/133] (469s left) kms_psr2_sf (psr2-cursor-plane-update-sf)
[561.329348] Starting subtest: psr2-cursor-plane-update-sf
[561.331719] Starting dynamic subtest: pipe-A-eDP-1
[562.631894] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.302s)
[562.642008] Starting dynamic subtest: pipe-B-eDP-1
[563.944017] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.306s)
[563.946200] Subtest psr2-cursor-plane-update-sf: SUCCESS (2.613s)
[564.847935] [086/133] (460s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-0-async-flip)
[564.955382] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-0-async-flip
[565.623674] Subtest x-tiled-max-hw-stride-32bpp-rotate-0-async-flip: SUCCESS (0.670s)
[565.824665] [087/133] (459s left) gem_exec_balancer (busy)
[565.893912] Starting subtest: busy
[567.614723] Subtest busy: SUCCESS (1.718s)
[567.964252] [088/133] (457s left) kms_frontbuffer_tracking (fbc-2p-primscrn-shrfb-msflip-blt)
[568.058848] Starting subtest: fbc-2p-primscrn-shrfb-msflip-blt
[568.063329] Subtest fbc-2p-primscrn-shrfb-msflip-blt: SKIP (0.000s)
[568.182624] [089/133] (457s left) vgem_slow (nohang)
[568.230621] Starting subtest: nohang
[578.313773] Subtest nohang: SUCCESS (10.081s)
[578.406714] [090/133] (447s left) gem_spin_batch (resubmit-new-all)
[578.477566] Starting subtest: resubmit-new-all
[578.480001] Starting dynamic subtest: rcs0
[578.500140] Dynamic subtest rcs0: SUCCESS (0.022s)
[578.512095] Starting dynamic subtest: bcs0
[578.516551] Dynamic subtest bcs0: SUCCESS (0.016s)
[578.526456] Starting dynamic subtest: vcs0
[578.531601] Dynamic subtest vcs0: SUCCESS (0.014s)
[578.542901] Starting dynamic subtest: vcs1
[578.553055] Dynamic subtest vcs1: SUCCESS (0.021s)
[578.567568] Starting dynamic subtest: vecs0
[578.575772] Dynamic subtest vecs0: SUCCESS (0.022s)
[578.590717] Starting dynamic subtest: ccs0
[578.598402] Dynamic subtest ccs0: SUCCESS (0.021s)
[578.600756] Subtest resubmit-new-all: SUCCESS (0.121s)
[579.692240] [091/133] (446s left) gem_render_copy (mixed-tiled-to-y-tiled-ccs)
[579.764813] Starting subtest: mixed-tiled-to-y-tiled-ccs
[579.769594] Subtest mixed-tiled-to-y-tiled-ccs: SKIP (0.000s)
[579.976431] [092/133] (445s left) syncobj_timeline (invalid-signal-illegal-point)
[580.035527] Starting subtest: invalid-signal-illegal-point
[580.037783] Subtest invalid-signal-illegal-point: SUCCESS (0.000s)
[580.155060] [093/133] (445s left) gem_exec_schedule (preempt-contexts)
[580.228957] Starting subtest: preempt-contexts
[580.230980] Starting dynamic subtest: rcs0
[580.309344] Dynamic subtest rcs0: SUCCESS (0.087s)
[580.319976] Starting dynamic subtest: bcs0
[580.388818] Dynamic subtest bcs0: SUCCESS (0.079s)
[580.399359] Starting dynamic subtest: vcs0
[580.457303] Dynamic subtest vcs0: SUCCESS (0.068s)
[580.468132] Starting dynamic subtest: vcs1
[580.512916] Dynamic subtest vcs1: SUCCESS (0.055s)
[580.523902] Starting dynamic subtest: vecs0
[580.569577] Dynamic subtest vecs0: SUCCESS (0.055s)
[580.579309] Starting dynamic subtest: ccs0
[580.649540] Dynamic subtest ccs0: SUCCESS (0.080s)
[580.651946] Subtest preempt-contexts: SUCCESS (0.428s)
[581.755462] [094/133] (444s left) gem_pwrite_snooped
[581.928206] [095/133] (444s left) kms_tiled_display (basic-test-pattern)
[582.044862] Subtest basic-test-pattern: SKIP (0.000s)
[582.093479] [096/133] (443s left) kms_frontbuffer_tracking (psr-shrfb-scaledprimary)
[582.204279] Starting subtest: psr-shrfb-scaledprimary
[588.088418] Subtest psr-shrfb-scaledprimary: SUCCESS (5.884s)
[588.239490] [097/133] (437s left) kms_frontbuffer_tracking (fbcpsr-1p-shrfb-fliptrack-mmap-gtt)
[588.339319] Starting subtest: fbcpsr-1p-shrfb-fliptrack-mmap-gtt
[588.343538] Subtest fbcpsr-1p-shrfb-fliptrack-mmap-gtt: SKIP (0.000s)
[588.479236] [098/133] (437s left) gem_pwrite (basic-self)
[588.546698] Subtest basic-self: SKIP (0.000s)
[588.613231] [099/133] (437s left) kms_pm_rpm (dpms-mode-unset-non-lpsp)
[590.762931] Starting subtest: dpms-mode-unset-non-lpsp
[591.924558] Subtest dpms-mode-unset-non-lpsp: SKIP (1.163s)
[592.314568] [100/133] (433s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip)
[592.453875] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip
[592.458293] Subtest yf-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip: SKIP (0.000s)
[592.596244] [101/133] (433s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-render)
[592.690225] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-render
[592.694196] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-render: SKIP (0.000s)
[592.825575] [102/133] (433s left) kms_color_pipeline (plane-lut1d-ctm3x4-lut1d)
[592.919873] Starting subtest: plane-lut1d-ctm3x4-lut1d
[592.933307] Starting dynamic subtest: pipe-A-eDP-1
[593.566121] Dynamic subtest pipe-A-eDP-1: FAIL (0.307s)
[594.357019] Starting dynamic subtest: pipe-B-eDP-1
[595.167136] Dynamic subtest pipe-B-eDP-1: FAIL (0.280s)
[595.685319] Starting dynamic subtest: pipe-C-eDP-1
[596.499359] Dynamic subtest pipe-C-eDP-1: FAIL (0.235s)
[597.019535] Starting dynamic subtest: pipe-D-eDP-1
[597.836070] Dynamic subtest pipe-D-eDP-1: FAIL (0.235s)
[597.838417] Subtest plane-lut1d-ctm3x4-lut1d: FAIL (4.623s)
[598.422384] [103/133] (427s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-render)
[598.519795] Starting subtest: psr-1p-primscrn-spr-indfb-draw-render
[605.335848] Subtest psr-1p-primscrn-spr-indfb-draw-render: SUCCESS (6.817s)
[605.500467] [104/133] (420s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-onoff)
[605.609438] Starting subtest: psr-1p-primscrn-cur-indfb-onoff
[612.597608] Subtest psr-1p-primscrn-cur-indfb-onoff: SUCCESS (6.991s)
[612.776031] [105/133] (413s left) gem_exec_schedule (preempt-queue-contexts-chain)
[612.860847] Subtest preempt-queue-contexts-chain: SKIP (0.000s)
[613.173287] [106/133] (413s left) api_intel_bb (object-noreloc-keep-cache-simple)
[613.225436] Starting subtest: object-noreloc-keep-cache-simple
[613.228811] Subtest object-noreloc-keep-cache-simple: SUCCESS (0.006s)
[613.380893] [107/133] (413s left) gem_mmap (bad-object)
[613.448127] Subtest bad-object: SKIP (0.000s)
[613.522638] [108/133] (413s left) kms_flip_scaled_crc (flip-32bpp-yftileccs-to-64bpp-yftile-upscaling)
[613.615452] Starting subtest: flip-32bpp-yftileccs-to-64bpp-yftile-upscaling
[613.617768] Starting dynamic subtest: pipe-A-default-mode
[613.911653] Dynamic subtest pipe-A-default-mode: SKIP (0.293s)
[613.916406] Subtest flip-32bpp-yftileccs-to-64bpp-yftile-upscaling: SKIP (0.295s)
[614.766981] [109/133] (411s left) kms_addfb_basic (bo-too-small-due-to-tiling)
[614.854138] Starting subtest: bo-too-small-due-to-tiling
[614.858660] Subtest bo-too-small-due-to-tiling: SKIP (0.000s)
[614.977611] [110/133] (411s left) kms_psr (pr-sprite-blt)
[615.079224] Starting subtest: pr-sprite-blt
[615.083705] Subtest pr-sprite-blt: SKIP (0.000s)
[615.175557] [111/133] (411s left) kms_draw_crc (fill-fb)
[615.264341] Starting subtest: fill-fb
[615.692538] Subtest fill-fb: SUCCESS (0.430s)
[615.837724] [112/133] (410s left) perf_pmu (busy-idle)
[615.879111] Starting subtest: busy-idle
[615.880886] Starting dynamic subtest: rcs0
[616.590761] Dynamic subtest rcs0: SUCCESS (0.710s)
[616.602700] Starting dynamic subtest: bcs0
[617.264444] Dynamic subtest bcs0: SUCCESS (0.671s)
[617.276212] Starting dynamic subtest: vcs0
[618.602936] Dynamic subtest vcs0: SUCCESS (1.335s)
[618.614200] Starting dynamic subtest: vcs1
[620.587920] Dynamic subtest vcs1: SUCCESS (1.982s)
[620.601316] Starting dynamic subtest: vecs0
[622.571158] Dynamic subtest vecs0: SUCCESS (1.979s)
[622.584367] Starting dynamic subtest: ccs0
[623.240352] Dynamic subtest ccs0: SUCCESS (0.668s)
[623.242828] Subtest busy-idle: SUCCESS (7.361s)
[623.383645] [113/133] (403s left) kms_ccs (crc-sprite-planes-basic-4-tiled-dg2-mc-ccs)
[623.493180] Starting subtest: crc-sprite-planes-basic-4-tiled-dg2-mc-ccs
[623.495462] Starting dynamic subtest: pipe-A-eDP-1
[623.554638] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[623.565316] Starting dynamic subtest: pipe-B-eDP-1
[623.630508] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[623.641675] Starting dynamic subtest: pipe-C-eDP-1
[623.699628] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[623.710542] Starting dynamic subtest: pipe-D-eDP-1
[623.768814] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[623.773428] Subtest crc-sprite-planes-basic-4-tiled-dg2-mc-ccs: SKIP (0.009s)
[625.823395] [114/133] (401s left) gem_exec_flush (basic-batch-kernel-default-uc)
[625.892146] Starting subtest: basic-batch-kernel-default-uc
[633.476405] Subtest basic-batch-kernel-default-uc: SUCCESS (7.584s)
[633.691405] [115/133] (393s left) gem_mmap_wc (write-read-distinct)
[633.747745] Subtest write-read-distinct: SKIP (0.000s)
[633.802222] [116/133] (393s left) kms_plane_lowres (tiling-x)
[633.896305] Starting subtest: tiling-x
[633.898644] Starting dynamic subtest: pipe-A-eDP-1
[633.903231] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[634.195591] Starting dynamic subtest: pipe-B-eDP-1
[634.200494] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[634.211904] Starting dynamic subtest: pipe-C-eDP-1
[634.216623] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[634.226368] Starting dynamic subtest: pipe-D-eDP-1
[634.230884] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[634.235245] Subtest tiling-x: SKIP (0.300s)
[635.056528] [117/133] (391s left) sw_sync (alloc_merge_fence)
[635.091273] Starting subtest: alloc_merge_fence
[635.093829] Subtest alloc_merge_fence: SUCCESS (0.000s)
[635.161748] [118/133] (391s left) kms_pm_backlight (fade)
[635.261326] Starting subtest: fade
[635.312866] Starting dynamic subtest: eDP-1
[637.987978] Dynamic subtest eDP-1: SUCCESS (2.676s)
[637.990304] Subtest fade: SUCCESS (2.727s)
[638.883867] [119/133] (388s left) kms_flip_scaled_crc (flip-64bpp-xtile-to-32bpp-xtile-downscaling)
[638.970264] Starting subtest: flip-64bpp-xtile-to-32bpp-xtile-downscaling
[638.972601] Starting dynamic subtest: pipe-A-default-mode
[640.130443] Dynamic subtest pipe-A-default-mode: SKIP (1.157s)
[640.134269] Subtest flip-64bpp-xtile-to-32bpp-xtile-downscaling: SKIP (1.158s)
[640.309661] [120/133] (386s left) syncobj_wait (multi-wait-all-for-submit-unsubmitted-signaled)
[640.358457] Starting subtest: multi-wait-all-for-submit-unsubmitted-signaled
[640.464102] Subtest multi-wait-all-for-submit-unsubmitted-signaled: SUCCESS (0.106s)
[640.567751] [121/133] (386s left) kms_psr (psr-cursor-mmap-cpu)
[640.664792] Starting subtest: psr-cursor-mmap-cpu
[640.667026] Starting dynamic subtest: eDP-1
[642.390938] Dynamic subtest eDP-1: SUCCESS (1.725s)
[642.393274] Subtest psr-cursor-mmap-cpu: SUCCESS (1.727s)
[643.287351] [122/133] (383s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-180-async-flip)
[643.384015] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-180-async-flip
[644.086055] Subtest 4-tiled-max-hw-stride-32bpp-rotate-180-async-flip: SUCCESS (0.703s)
[644.310070] [123/133] (382s left) gem_exec_whisper (basic-queues-priority-all)
[644.372966] Starting subtest: basic-queues-priority-all
[667.956292] Subtest basic-queues-priority-all: SUCCESS (23.574s)
[668.165238] [124/133] (359s left) syncobj_timeline (etime-single-wait-all-submitted)
[668.247868] Starting subtest: etime-single-wait-all-submitted
[668.350678] Subtest etime-single-wait-all-submitted: SUCCESS (0.102s)
[668.453358] [125/133] (358s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-onoff)
[668.553791] Starting subtest: fbc-2p-primscrn-spr-indfb-onoff
[668.558035] Subtest fbc-2p-primscrn-spr-indfb-onoff: SKIP (0.000s)
[668.694675] [126/133] (358s left) kms_async_flips (async-flip-dpms)
[668.806997] Starting subtest: async-flip-dpms
[669.180773] Starting dynamic subtest: pipe-A-eDP-1
[672.982305] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.800s)
[673.360299] Starting dynamic subtest: pipe-B-eDP-1
[676.129488] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.775s)
[676.522736] Starting dynamic subtest: pipe-C-eDP-1
[679.292587] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.777s)
[679.678307] Starting dynamic subtest: pipe-D-eDP-1
[682.458210] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.788s)
[682.460534] Subtest async-flip-dpms: SUCCESS (13.651s)
[683.653753] [127/133] (343s left) gem_exec_reloc (basic-cpu-read-noreloc)
[683.724325] Subtest basic-cpu-read-noreloc: SKIP (0.000s)
[683.811953] [128/133] (343s left) syncobj_wait (invalid-reset-illegal-handle)
[683.869549] Starting subtest: invalid-reset-illegal-handle
[683.871452] Subtest invalid-reset-illegal-handle: SUCCESS (0.000s)
[684.004101] [129/133] (343s left) syncobj_wait (multi-wait-all-for-submit-unsubmitted-submitted)
[684.054046] Starting subtest: multi-wait-all-for-submit-unsubmitted-submitted
[684.160061] Subtest multi-wait-all-for-submit-unsubmitted-submitted: SUCCESS (0.105s)
[684.262065] [130/133] (343s left) gem_tiled_swapping (non-threaded)
[684.318579] Subtest non-threaded: SKIP (0.000s)
[684.386675] [131/133] (343s left) gem_exec_fence (syncobj-timeline-chain-engines)
[684.932514] Starting subtest: syncobj-timeline-chain-engines
[685.051024] Subtest syncobj-timeline-chain-engines: SUCCESS (0.119s)
[686.668130] [132/133] (340s left) kms_cursor_legacy (flip-vs-cursor-legacy)
[686.790383] Starting subtest: flip-vs-cursor-legacy
[693.788498] Subtest flip-vs-cursor-legacy: SUCCESS (6.997s)
[694.683825] [133/133] (332s left) syncobj_basic (illegal-fd-to-handle)
[694.741816] Starting subtest: illegal-fd-to-handle
[694.744246] Subtest illegal-fd-to-handle: SUCCESS (0.000s)
[694.877146] Closing watchdogs
results: parsing output: 0/ for test: kms_frontbuffer_tracking
results: parsing output: 1/ for test: gem_exec_suspend
results: parsing output: 2/ for test: gem_render_copy
results: parsing output: 3/ for test: kms_ccs
results: parsing output: 4/ for test: kms_flip
results: parsing output: 5/ for test: syncobj_timeline
results: parsing output: 6/ for test: kms_lease
results: parsing output: 7/ for test: gem_exec_fence
results: parsing output: 8/ for test: kms_chamelium_color
results: parsing output: 9/ for test: prime_mmap
results: parsing output: 10/ for test: i915_drm_fdinfo
results: parsing output: 11/ for test: kms_frontbuffer_tracking
results: parsing output: 12/ for test: kms_invalid_mode
results: parsing output: 13/ for test: kms_plane_scaling
results: parsing output: 14/ for test: drm_read
results: parsing output: 15/ for test: gem_ccs
results: parsing output: 16/ for test: kms_ccs
results: parsing output: 17/ for test: gem_close
results: parsing output: 18/ for test: gem_busy
results: parsing output: 19/ for test: kms_vblank
results: parsing output: 20/ for test: perf_pmu
results: parsing output: 21/ for test: kms_debugfs
results: parsing output: 22/ for test: kms_frontbuffer_tracking
results: parsing output: 23/ for test: gem_ctx_param
results: parsing output: 24/ for test: kms_frontbuffer_tracking
results: parsing output: 25/ for test: gem_exec_big
results: parsing output: 26/ for test: kms_frontbuffer_tracking
results: parsing output: 27/ for test: gem_exec_flush
results: parsing output: 28/ for test: kms_frontbuffer_tracking
results: parsing output: 29/ for test: kms_frontbuffer_tracking
results: parsing output: 30/ for test: gem_exec_create
results: parsing output: 31/ for test: kms_feature_discovery
results: parsing output: 32/ for test: kms_frontbuffer_tracking
results: parsing output: 33/ for test: kms_frontbuffer_tracking
results: parsing output: 34/ for test: gem_render_copy_redux
results: parsing output: 35/ for test: i915_pm_rpm
results: parsing output: 36/ for test: kms_frontbuffer_tracking
results: parsing output: 37/ for test: gem_request_retire
results: parsing output: 38/ for test: i915_pm_rps
results: parsing output: 39/ for test: gem_ctx_persistence
results: parsing output: 40/ for test: i915_hangman
results: parsing output: 41/ for test: kms_cursor_crc
results: parsing output: 42/ for test: gem_partial_pwrite_pread
results: parsing output: 43/ for test: gem_mmap_wc
results: parsing output: 44/ for test: syncobj_timeline
results: parsing output: 45/ for test: kms_frontbuffer_tracking
results: parsing output: 46/ for test: kms_psr
results: parsing output: 47/ for test: kms_invalid_mode
results: parsing output: 48/ for test: gem_exec_reloc
results: parsing output: 49/ for test: gem_mmap_gtt
results: parsing output: 50/ for test: kms_prop_blob
results: parsing output: 51/ for test: api_intel_allocator
results: parsing output: 52/ for test: kms_getfb
results: parsing output: 53/ for test: kms_content_protection
results: parsing output: 54/ for test: kms_chamelium_hpd
results: parsing output: 55/ for test: kms_flip
results: parsing output: 56/ for test: gem_mmap_offset
results: parsing output: 57/ for test: kms_psr
results: parsing output: 58/ for test: gem_fenced_exec_thrash
results: parsing output: 59/ for test: kms_vblank
results: parsing output: 60/ for test: gem_exec_whisper
results: parsing output: 61/ for test: kms_big_fb
results: parsing output: 62/ for test: kms_atomic
results: parsing output: 63/ for test: gen9_exec_parse
results: parsing output: 64/ for test: kms_cursor_crc
results: parsing output: 65/ for test: kms_cursor_crc
results: parsing output: 66/ for test: kms_frontbuffer_tracking
results: parsing output: 67/ for test: gem_ctx_shared
results: parsing output: 68/ for test: kms_plane_scaling
results: parsing output: 69/ for test: gem_wait
results: parsing output: 70/ for test: kms_big_fb
results: parsing output: 71/ for test: kms_cursor_legacy
results: parsing output: 72/ for test: gem_basic
results: parsing output: 73/ for test: kms_big_fb
results: parsing output: 74/ for test: kms_psr2_sf
results: parsing output: 75/ for test: drm_read
results: parsing output: 76/ for test: kms_frontbuffer_tracking
results: parsing output: 77/ for test: kms_psr
results: parsing output: 78/ for test: kms_ccs
results: parsing output: 79/ for test: kms_ccs
results: parsing output: 80/ for test: sw_sync
results: parsing output: 81/ for test: sysfs_heartbeat_interval
results: parsing output: 82/ for test: syncobj_eventfd
results: parsing output: 83/ for test: kms_busy
results: parsing output: 84/ for test: kms_psr2_sf
results: parsing output: 85/ for test: kms_big_fb
results: parsing output: 86/ for test: gem_exec_balancer
results: parsing output: 87/ for test: kms_frontbuffer_tracking
results: parsing output: 88/ for test: vgem_slow
results: parsing output: 89/ for test: gem_spin_batch
results: parsing output: 90/ for test: gem_render_copy
results: parsing output: 91/ for test: syncobj_timeline
results: parsing output: 92/ for test: gem_exec_schedule
results: parsing output: 93/ for test: gem_pwrite_snooped
results: parsing output: 94/ for test: kms_tiled_display
results: parsing output: 95/ for test: kms_frontbuffer_tracking
results: parsing output: 96/ for test: kms_frontbuffer_tracking
results: parsing output: 97/ for test: gem_pwrite
results: parsing output: 98/ for test: kms_pm_rpm
results: parsing output: 99/ for test: kms_big_fb
results: parsing output: 100/ for test: kms_frontbuffer_tracking
results: parsing output: 101/ for test: kms_color_pipeline
results: parsing output: 102/ for test: kms_frontbuffer_tracking
results: parsing output: 103/ for test: kms_frontbuffer_tracking
results: parsing output: 104/ for test: gem_exec_schedule
results: parsing output: 105/ for test: api_intel_bb
results: parsing output: 106/ for test: gem_mmap
results: parsing output: 107/ for test: kms_flip_scaled_crc
results: parsing output: 108/ for test: kms_addfb_basic
results: parsing output: 109/ for test: kms_psr
results: parsing output: 110/ for test: kms_draw_crc
results: parsing output: 111/ for test: perf_pmu
results: parsing output: 112/ for test: kms_ccs
results: parsing output: 113/ for test: gem_exec_flush
results: parsing output: 114/ for test: gem_mmap_wc
results: parsing output: 115/ for test: kms_plane_lowres
results: parsing output: 116/ for test: sw_sync
results: parsing output: 117/ for test: kms_pm_backlight
results: parsing output: 118/ for test: kms_flip_scaled_crc
results: parsing output: 119/ for test: syncobj_wait
results: parsing output: 120/ for test: kms_psr
results: parsing output: 121/ for test: kms_big_fb
results: parsing output: 122/ for test: gem_exec_whisper
results: parsing output: 123/ for test: syncobj_timeline
results: parsing output: 124/ for test: kms_frontbuffer_tracking
results: parsing output: 125/ for test: kms_async_flips
results: parsing output: 126/ for test: gem_exec_reloc
results: parsing output: 127/ for test: syncobj_wait
results: parsing output: 128/ for test: syncobj_wait
results: parsing output: 129/ for test: gem_tiled_swapping
results: parsing output: 130/ for test: gem_exec_fence
results: parsing output: 131/ for test: kms_cursor_legacy
results: parsing output: 132/ for test: syncobj_basic
Done.