[59.355941] Initializing watchdogs
[59.355989]   /dev/watchdog0
[59.370268] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:7d55 Intel Meteorlake (Gen12) Meteor Lake-P [Intel Arc Graphics]
[59.374709] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[59.377143] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[59.380592] [001/133] (960s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-mmap-gtt)
[59.501371] Starting subtest: psr-2p-primscrn-spr-indfb-draw-mmap-gtt
[59.505803] Subtest psr-2p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[59.633104] [002/133] (960s left) gem_exec_suspend (basic-s3-devices)
[59.698843] Starting subtest: basic-S3-devices
[59.700861] Starting dynamic subtest: smem
[70.869218] Dynamic subtest smem: SUCCESS (11.205s)
[70.872074] Subtest basic-S3-devices: SUCCESS (11.206s)
[75.082774] [003/133] (948s left) gem_render_copy (y-tiled-ccs-to-yf-tiled)
[75.158375] Starting subtest: y-tiled-ccs-to-yf-tiled
[75.163028] Subtest y-tiled-ccs-to-yf-tiled: SKIP (0.000s)
[75.374636] [004/133] (948s left) kms_ccs (ccs-on-another-bo-y-tiled-gen12-mc-ccs)
[75.483147] Starting subtest: ccs-on-another-bo-y-tiled-gen12-mc-ccs
[75.485452] Starting dynamic subtest: pipe-A-eDP-1
[75.509061] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[75.520713] Starting dynamic subtest: pipe-B-eDP-1
[75.541169] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[75.548293] Starting dynamic subtest: pipe-C-eDP-1
[75.569087] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[75.576092] Starting dynamic subtest: pipe-D-eDP-1
[75.597682] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[75.601798] Subtest ccs-on-another-bo-y-tiled-gen12-mc-ccs: SKIP (0.003s)
[77.792137] [005/133] (946s left) kms_flip (bo-too-big)
[77.888789] Starting subtest: bo-too-big
[77.891152] Starting dynamic subtest: A-eDP1
[79.227192] Dynamic subtest A-eDP1: SUCCESS (1.338s)
[79.240879] Starting dynamic subtest: B-eDP1
[80.550290] Dynamic subtest B-eDP1: SUCCESS (1.322s)
[80.568098] Starting dynamic subtest: C-eDP1
[81.880385] Dynamic subtest C-eDP1: SUCCESS (1.329s)
[81.890568] Starting dynamic subtest: D-eDP1
[83.206538] Dynamic subtest D-eDP1: SUCCESS (1.327s)
[83.209087] Subtest bo-too-big: SUCCESS (5.324s)
[84.435852] [006/133] (939s left) syncobj_timeline (multi-wait-available-unsubmitted-signaled)
[84.502696] Starting subtest: multi-wait-available-unsubmitted-signaled
[84.504993] Subtest multi-wait-available-unsubmitted-signaled: SUCCESS (0.000s)
[84.619167] [007/133] (939s left) kms_lease (lease-uevent)
[84.710971] Starting subtest: lease-uevent
[85.731573] Subtest lease-uevent: SUCCESS (1.019s)
[85.832915] [008/133] (938s left) gem_exec_fence (syncobj-timeline-wait)
[86.417970] Starting subtest: syncobj-timeline-wait
[87.908704] Subtest syncobj-timeline-wait: SUCCESS (1.494s)
[88.184943] [FACT gem_exec_fence (syncobj-timeline-wait)] new: kernel.kmod_is_loaded.vgem: true
[88.188517] [009/133] (936s left) kms_chamelium_color (gamma)
[88.286348] Subtest gamma: SKIP (0.000s)
[88.330180] [010/133] (935s left) prime_mmap (test_errors)
[88.383589] Starting subtest: test_errors
[88.385825] Starting dynamic subtest: test_errors-smem
[88.475587] Dynamic subtest test_errors-smem: SUCCESS (0.093s)
[88.478144] Subtest test_errors: SUCCESS (0.094s)
[88.598080] [011/133] (935s left) i915_drm_fdinfo (idle)
[88.635432] Starting subtest: idle
[88.637297] Starting dynamic subtest: rcs0
[89.226942] Dynamic subtest rcs0: SUCCESS (0.593s)
[89.236696] Starting dynamic subtest: bcs0
[89.732670] Dynamic subtest bcs0: SUCCESS (0.503s)
[89.743355] Starting dynamic subtest: vcs0
[90.236763] Dynamic subtest vcs0: SUCCESS (0.504s)
[90.247179] Starting dynamic subtest: vcs1
[90.741695] Dynamic subtest vcs1: SUCCESS (0.504s)
[90.751511] Starting dynamic subtest: vecs0
[91.245997] Dynamic subtest vecs0: SUCCESS (0.504s)
[91.256765] Starting dynamic subtest: ccs0
[91.748719] Dynamic subtest ccs0: SUCCESS (0.503s)
[91.750847] Subtest idle: SUCCESS (3.115s)
[91.849057] [012/133] (932s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-mmap-cpu)
[91.960301] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-mmap-cpu
[91.964653] Subtest fbc-2p-scndscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[92.078601] [013/133] (932s left) kms_invalid_mode (zero-hdisplay)
[92.180786] Starting subtest: zero-hdisplay
[92.183148] Starting dynamic subtest: pipe-A-eDP-1
[92.470732] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.292s)
[92.480211] Starting dynamic subtest: pipe-B-eDP-1
[92.482336] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[92.490153] Starting dynamic subtest: pipe-C-eDP-1
[92.492321] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[92.499827] Starting dynamic subtest: pipe-D-eDP-1
[92.501811] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[92.503780] Subtest zero-hdisplay: SUCCESS (0.297s)
[93.359895] [014/133] (931s left) kms_plane_scaling (planes-downscale-factor-0-75-unity-scaling)
[93.459439] Starting subtest: planes-downscale-factor-0-75-unity-scaling
[93.461754] Starting dynamic subtest: pipe-A
[93.523241] Dynamic subtest pipe-A: SUCCESS (0.065s)
[93.537388] Starting dynamic subtest: pipe-B
[94.665891] Dynamic subtest pipe-B: SUCCESS (1.142s)
[94.676503] Starting dynamic subtest: pipe-C
[95.774279] Dynamic subtest pipe-C: SUCCESS (1.107s)
[95.786852] Starting dynamic subtest: pipe-D
[96.921424] Dynamic subtest pipe-D: SUCCESS (1.147s)
[96.923815] Subtest planes-downscale-factor-0-75-unity-scaling: SUCCESS (3.465s)
[98.091535] [015/133] (926s left) drm_read (fault-buffer)
[98.259932] Starting subtest: fault-buffer
[98.262423] Subtest fault-buffer: SUCCESS (0.000s)
[98.420595] [016/133] (926s left) gem_ccs (suspend-resume)
[98.491012] Starting subtest: suspend-resume
[98.495311] Subtest suspend-resume: SKIP (0.000s)
[98.617569] [017/133] (925s left) kms_ccs (bad-rotation-90-4-tiled-dg2-rc-ccs)
[98.710749] Starting subtest: bad-rotation-90-4-tiled-dg2-rc-ccs
[98.713053] Starting dynamic subtest: pipe-A-eDP-1
[98.736045] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[98.745340] Starting dynamic subtest: pipe-B-eDP-1
[98.767112] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[98.775488] Starting dynamic subtest: pipe-C-eDP-1
[98.797730] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[98.806814] Starting dynamic subtest: pipe-D-eDP-1
[98.828895] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[98.833040] Subtest bad-rotation-90-4-tiled-dg2-rc-ccs: SKIP (0.003s)
[100.977832] [018/133] (923s left) gem_close (many-handles-one-vma)
[101.045051] Starting subtest: many-handles-one-vma
[101.069898] Subtest many-handles-one-vma: SUCCESS (0.025s)
[101.235624] [019/133] (923s left) gem_busy (extended)
[101.421792] Starting subtest: extended
[101.424226] Starting dynamic subtest: rcs0
[101.523432] Dynamic subtest rcs0: SUCCESS (0.102s)
[101.534415] Starting dynamic subtest: bcs0
[101.565338] Dynamic subtest bcs0: SUCCESS (0.041s)
[101.574499] Starting dynamic subtest: vcs0
[102.933086] Dynamic subtest vcs0: SUCCESS (1.365s)
[102.944330] Starting dynamic subtest: vcs1
[104.918140] Dynamic subtest vcs1: SUCCESS (1.985s)
[104.928865] Starting dynamic subtest: vecs0
[106.954526] Dynamic subtest vecs0: SUCCESS (1.982s)
[106.965429] Starting dynamic subtest: ccs0
[106.967416] Dynamic subtest ccs0: SUCCESS (0.046s)
[106.969382] Subtest extended: SUCCESS (5.526s)
[107.224501] [020/133] (917s left) kms_vblank (ts-continuation-suspend)
[107.324967] Starting subtest: ts-continuation-suspend
[107.327328] Starting dynamic subtest: pipe-A-eDP-1
[124.241922] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.975s)
[124.258315] Starting dynamic subtest: pipe-D-eDP-1
[142.249178] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.589s)
[142.251486] Subtest ts-continuation-suspend: SUCCESS (4.567s)
[148.147998] [021/133] (881s left) perf_pmu (semaphore-wait-idle)
[148.192296] Starting subtest: semaphore-wait-idle
[148.194591] Starting dynamic subtest: rcs0
[148.723092] Dynamic subtest rcs0: SUCCESS (0.539s)
[148.732908] Starting dynamic subtest: bcs0
[149.224311] Dynamic subtest bcs0: SUCCESS (0.531s)
[149.235253] Starting dynamic subtest: vcs0
[149.735447] Dynamic subtest vcs0: SUCCESS (0.529s)
[149.746445] Starting dynamic subtest: vcs1
[150.246761] Dynamic subtest vcs1: SUCCESS (0.527s)
[150.256240] Starting dynamic subtest: vecs0
[150.757922] Dynamic subtest vecs0: SUCCESS (0.525s)
[150.768656] Starting dynamic subtest: ccs0
[151.270605] Dynamic subtest ccs0: SUCCESS (0.526s)
[151.273228] Subtest semaphore-wait-idle: SUCCESS (3.183s)
[151.407276] [022/133] (878s left) kms_debugfs (display-off-read-all)
[151.510377] Starting subtest: display-off-read-all
[151.800072] Subtest display-off-read-all: SUCCESS (0.296s)
[152.673968] [023/133] (877s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-blt)
[152.769570] Starting subtest: fbc-rgb101010-draw-blt
[157.283179] Subtest fbc-rgb101010-draw-blt: SUCCESS (4.592s)
[158.418075] [024/133] (871s left) gem_ctx_param (invalid-get-no-zeromap)
[158.475261] Starting subtest: invalid-get-no-zeromap
[158.477612] Subtest invalid-get-no-zeromap: SUCCESS (0.001s)
[158.591894] [025/133] (871s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-mmap-gtt)
[158.691158] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-mmap-gtt
[158.695225] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[158.792938] [026/133] (871s left) gem_exec_big (single)
[158.852314] Starting subtest: single
[161.142897] Subtest single: SUCCESS (2.309s)
[161.411854] [027/133] (868s left) kms_frontbuffer_tracking (psr-rgb101010-draw-mmap-gtt)
[161.569664] Starting subtest: psr-rgb101010-draw-mmap-gtt
[161.573770] Subtest psr-rgb101010-draw-mmap-gtt: SKIP (0.000s)
[161.699354] [028/133] (868s left) gem_exec_flush (basic-uc-prw-default)
[161.764616] Starting subtest: basic-uc-prw-default
[167.191665] Subtest basic-uc-prw-default: SUCCESS (5.455s)
[167.403374] [029/133] (862s left) kms_frontbuffer_tracking (fbc-1p-shrfb-fliptrack-mmap-gtt)
[167.508582] Starting subtest: fbc-1p-shrfb-fliptrack-mmap-gtt
[167.512532] Subtest fbc-1p-shrfb-fliptrack-mmap-gtt: SKIP (0.000s)
[167.622722] [030/133] (862s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-shrfb-draw-render)
[167.725838] Starting subtest: psr-1p-offscreen-pri-shrfb-draw-render
[174.662417] Subtest psr-1p-offscreen-pri-shrfb-draw-render: SUCCESS (6.957s)
[174.843944] [031/133] (855s left) gem_exec_create (forked)
[174.922422] Starting subtest: forked
[174.924906] Starting dynamic subtest: smem
[196.266625] Dynamic subtest smem: SUCCESS (21.345s)
[196.269390] Subtest forked: SUCCESS (21.346s)
[196.489289] [032/133] (833s left) kms_feature_discovery (display-1x)
[196.590219] Starting subtest: display-1x
[196.592422] Subtest display-1x: SUCCESS (0.000s)
[196.693842] [033/133] (833s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-wc)
[196.802337] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-wc
[196.806600] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[196.944309] [034/133] (833s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-move)
[197.060973] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-move
[197.065431] Subtest fbcpsr-2p-primscrn-cur-indfb-move: SKIP (0.000s)
[197.197281] [035/133] (833s left) gem_render_copy_redux (interruptible)
[197.278163] Starting subtest: interruptible
[197.539674] Subtest interruptible: SUCCESS (0.262s)
[197.667917] [036/133] (832s left) i915_pm_rpm (system-suspend-execbuf)
[199.412762] Starting subtest: system-suspend-execbuf
[257.529728] Subtest system-suspend-execbuf: SUCCESS (43.398s)
[257.937613] [037/133] (772s left) kms_frontbuffer_tracking (psr-2p-scndscrn-indfb-plflip-blt)
[258.041582] Starting subtest: psr-2p-scndscrn-indfb-plflip-blt
[258.045943] Subtest psr-2p-scndscrn-indfb-plflip-blt: SKIP (0.000s)
[258.161636] [038/133] (772s left) gem_request_retire (retire-vma-not-inactive)
[258.232298] Starting subtest: retire-vma-not-inactive
[258.290464] Subtest retire-vma-not-inactive: SUCCESS (0.057s)
[258.460415] [039/133] (772s left) i915_pm_rps (thresholds-idle)
[258.529029] Starting subtest: thresholds-idle
[258.533590] Subtest thresholds-idle: SKIP (0.001s)
[258.666215] [040/133] (771s left) gem_ctx_persistence (legacy-engines-queued)
[258.737253] Starting subtest: legacy-engines-queued
[258.739146] Starting dynamic subtest: render
[258.835098] Dynamic subtest render: SUCCESS (0.100s)
[258.846883] Starting dynamic subtest: bsd1
[260.295788] Dynamic subtest bsd1: SUCCESS (1.456s)
[260.307989] Starting dynamic subtest: bsd2
[262.277935] Dynamic subtest bsd2: SUCCESS (1.980s)
[262.289924] Starting dynamic subtest: blt
[262.317762] Dynamic subtest blt: SUCCESS (0.040s)
[262.327318] Starting dynamic subtest: vebox
[264.261766] Dynamic subtest vebox: SUCCESS (1.940s)
[264.264707] Subtest legacy-engines-queued: SUCCESS (5.525s)
[264.366673] [041/133] (766s left) i915_hangman (gt-error-state-capture)
[264.445001] Starting subtest: gt-error-state-capture
[264.447269] Starting dynamic subtest: rcs0
[275.272834] Dynamic subtest rcs0: SUCCESS (10.828s)
[275.285218] Starting dynamic subtest: bcs0
[287.238273] Dynamic subtest bcs0: SUCCESS (11.966s)
[287.250637] Starting dynamic subtest: vcs0
[299.272777] Dynamic subtest vcs0: SUCCESS (12.034s)
[299.287174] Starting dynamic subtest: vcs1
[311.238338] Dynamic subtest vcs1: SUCCESS (11.971s)
[311.250522] Starting dynamic subtest: vecs0
[321.286662] Dynamic subtest vecs0: SUCCESS (10.047s)
[321.299101] Starting dynamic subtest: ccs0
[331.269831] Dynamic subtest ccs0: SUCCESS (9.979s)
[331.272569] Subtest gt-error-state-capture: SUCCESS (66.835s)
[331.378687] [042/133] (699s left) kms_cursor_crc (cursor-rapid-movement-128x42)
[331.631492] Starting subtest: cursor-rapid-movement-128x42
[331.683233] Subtest cursor-rapid-movement-128x42: SKIP (0.050s)
[331.951736] [043/133] (698s left) gem_partial_pwrite_pread (writes-after-reads-uncached)
[332.022638] Subtest writes-after-reads-uncached: SKIP (0.000s)
[332.112852] [044/133] (698s left) gem_mmap_wc (coherency)
[332.170606] Subtest coherency: SKIP (0.000s)
[332.239049] [045/133] (698s left) syncobj_timeline (single-wait-all-for-submit-signaled)
[332.305694] Starting subtest: single-wait-all-for-submit-signaled
[332.307580] Subtest single-wait-all-for-submit-signaled: SUCCESS (0.000s)
[332.431671] [046/133] (698s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-render)
[332.535374] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-render
[336.203402] Subtest fbc-1p-primscrn-cur-indfb-draw-render: SUCCESS (3.670s)
[337.411386] [047/133] (693s left) kms_psr (fbc-psr-primary-mmap-cpu)
[337.509312] Starting subtest: fbc-psr-primary-mmap-cpu
[337.511670] Starting dynamic subtest: eDP-1
[337.515761] Dynamic subtest eDP-1: SKIP (0.000s)
[337.519920] Subtest fbc-psr-primary-mmap-cpu: SKIP (0.001s)
[337.609049] [048/133] (693s left) kms_invalid_mode (bad-vsync-start)
[337.699910] Starting subtest: bad-vsync-start
[337.702232] Starting dynamic subtest: pipe-A-eDP-1
[337.992762] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.292s)
[338.003010] Starting dynamic subtest: pipe-B-eDP-1
[338.005182] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[338.015277] Starting dynamic subtest: pipe-C-eDP-1
[338.017187] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[338.025881] Starting dynamic subtest: pipe-D-eDP-1
[338.028133] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[338.030247] Subtest bad-vsync-start: SUCCESS (0.297s)
[338.828242] [049/133] (692s left) gem_exec_reloc (basic-wc-gtt)
[338.883839] Subtest basic-wc-gtt: SKIP (0.000s)
[338.959282] [050/133] (692s left) gem_mmap_gtt (cpuset-medium-copy-xy)
[339.013735] Subtest cpuset-medium-copy-XY: SKIP (0.000s)
[339.080608] [051/133] (691s left) kms_prop_blob (blob-multiple)
[339.135266] Starting subtest: blob-multiple
[339.137581] Subtest blob-multiple: SUCCESS (0.002s)
[339.281190] [052/133] (691s left) api_intel_allocator (open-vm)
[339.339469] Starting subtest: open-vm
[339.344116] Subtest open-vm: SUCCESS (0.003s)
[339.502501] [053/133] (691s left) kms_getfb (getfb-repeated-different-handles)
[339.600168] Starting subtest: getfb-repeated-different-handles
[339.602605] Subtest getfb-repeated-different-handles: SUCCESS (0.000s)
[339.745885] [054/133] (691s left) kms_content_protection (legacy-hdcp14)
[339.892752] Starting subtest: legacy-hdcp14
[339.896620] Subtest legacy-hdcp14: SKIP (0.000s)
[340.064504] [055/133] (691s left) kms_chamelium_hpd (hdmi-hpd-after-suspend)
[340.454684] Subtest hdmi-hpd-after-suspend: SKIP (0.000s)
[341.315741] [056/133] (689s left) kms_flip (blocking-absolute-wf_vblank)
[341.422593] Starting subtest: blocking-absolute-wf_vblank
[341.424985] Starting dynamic subtest: A-eDP1
[350.224999] Dynamic subtest A-eDP1: SUCCESS (8.769s)
[350.236908] Starting dynamic subtest: B-eDP1
[358.956083] Dynamic subtest B-eDP1: SUCCESS (8.727s)
[358.966941] Starting dynamic subtest: C-eDP1
[367.683046] Dynamic subtest C-eDP1: SUCCESS (8.717s)
[367.694529] Starting dynamic subtest: D-eDP1
[376.416195] Dynamic subtest D-eDP1: SUCCESS (8.732s)
[376.418660] Subtest blocking-absolute-wf_vblank: SUCCESS (34.956s)
[377.609046] [057/133] (653s left) gem_mmap_offset (bad-object)
[377.672309] Starting subtest: bad-object
[377.674733] Subtest bad-object: SUCCESS (0.002s)
[377.819777] [058/133] (653s left) kms_psr (psr2-no-drrs)
[377.914080] Starting subtest: psr2-no-drrs
[377.916319] Starting dynamic subtest: eDP-1
[379.547165] Dynamic subtest eDP-1: SUCCESS (1.633s)
[379.549423] Subtest psr2-no-drrs: SUCCESS (1.634s)
[380.370100] [059/133] (651s left) gem_fenced_exec_thrash (no-spare-fences-interruptible)
[380.430497] Subtest no-spare-fences-interruptible: SKIP (0.000s)
[380.522500] [060/133] (650s left) kms_vblank (wait-idle)
[380.619107] Starting subtest: wait-idle
[380.621308] Starting dynamic subtest: pipe-A-eDP-1
[382.385007] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.767s)
[382.400649] Starting dynamic subtest: pipe-D-eDP-1
[384.798897] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.409s)
[384.800834] Subtest wait-idle: SUCCESS (4.179s)
[385.645333] [061/133] (645s left) gem_exec_whisper (basic-contexts-all)
[385.722764] Starting subtest: basic-contexts-all
[396.697153] Subtest basic-contexts-all: SUCCESS (10.973s)
[396.906391] [062/133] (634s left) kms_big_fb (x-tiled-16bpp-rotate-0)
[397.023819] Starting subtest: x-tiled-16bpp-rotate-0
[398.413710] Subtest x-tiled-16bpp-rotate-0: SUCCESS (1.390s)
[398.568720] [063/133] (632s left) kms_atomic (plane-primary-overlay-mutable-zpos)
[398.675506] Starting subtest: plane-primary-overlay-mutable-zpos
[402.156894] Subtest plane-primary-overlay-mutable-zpos: SKIP (3.481s)
[403.361167] [064/133] (628s left) gen9_exec_parse (bb-start-cmd)
[403.424248] Subtest bb-start-cmd: SKIP (0.000s)
[403.513803] [065/133] (628s left) kms_cursor_crc (cursor-alpha-opaque)
[403.618588] Starting subtest: cursor-alpha-opaque
[403.620448] Starting dynamic subtest: pipe-A-eDP-1
[404.241392] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.622s)
[404.251880] Starting dynamic subtest: pipe-D-eDP-1
[405.501832] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.259s)
[405.504108] Subtest cursor-alpha-opaque: SUCCESS (1.883s)
[406.320305] [066/133] (625s left) kms_cursor_crc (cursor-sliding-64x64)
[406.504103] Starting subtest: cursor-sliding-64x64
[406.508897] Starting dynamic subtest: pipe-A-eDP-1
[409.752738] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.244s)
[409.781119] Starting dynamic subtest: pipe-D-eDP-1
[413.679193] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.906s)
[413.681716] Subtest cursor-sliding-64x64: SUCCESS (7.176s)
[414.575776] [067/133] (617s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-render)
[414.684203] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-render
[421.473470] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-render: SUCCESS (6.796s)
[421.655771] [068/133] (610s left) gem_ctx_shared (exec-single-timeline)
[421.711764] Starting subtest: exec-single-timeline
[421.714076] Starting dynamic subtest: rcs0
[422.788991] Dynamic subtest rcs0: SUCCESS (1.075s)
[422.801796] Starting dynamic subtest: bcs0
[423.877018] Dynamic subtest bcs0: SUCCESS (1.086s)
[423.890039] Starting dynamic subtest: vcs0
[424.965636] Dynamic subtest vcs0: SUCCESS (1.086s)
[424.978718] Starting dynamic subtest: vcs1
[426.053539] Dynamic subtest vcs1: SUCCESS (1.086s)
[426.066403] Starting dynamic subtest: vecs0
[427.142103] Dynamic subtest vecs0: SUCCESS (1.086s)
[427.155447] Starting dynamic subtest: ccs0
[428.230123] Dynamic subtest ccs0: SUCCESS (1.085s)
[428.233221] Subtest exec-single-timeline: SUCCESS (6.520s)
[428.491514] [069/133] (603s left) kms_plane_scaling (plane-downscale-factor-0-75-with-pixel-format)
[428.598623] Starting subtest: plane-downscale-factor-0-75-with-pixel-format
[428.600840] Starting dynamic subtest: pipe-A
[429.822417] Dynamic subtest pipe-A: SUCCESS (1.224s)
[429.838270] Starting dynamic subtest: pipe-B
[432.104459] Dynamic subtest pipe-B: SUCCESS (2.281s)
[432.116226] Starting dynamic subtest: pipe-C
[433.301762] Dynamic subtest pipe-C: SUCCESS (1.196s)
[433.313037] Starting dynamic subtest: pipe-D
[434.503858] Dynamic subtest pipe-D: SUCCESS (1.200s)
[434.506274] Subtest plane-downscale-factor-0-75-with-pixel-format: SUCCESS (5.908s)
[435.727152] [070/133] (596s left) gem_wait (write-busy)
[435.794841] Starting subtest: write-busy
[435.797148] Starting dynamic subtest: all-engines
[436.392289] Dynamic subtest all-engines: SUCCESS (0.597s)
[436.411236] Starting dynamic subtest: rcs0
[436.947874] Dynamic subtest rcs0: SUCCESS (0.554s)
[436.967250] Starting dynamic subtest: bcs0
[437.498173] Dynamic subtest bcs0: SUCCESS (0.550s)
[437.514070] Starting dynamic subtest: vcs0
[439.272093] Dynamic subtest vcs0: SUCCESS (1.771s)
[439.289388] Starting dynamic subtest: vcs1
[441.319420] Dynamic subtest vcs1: SUCCESS (2.045s)
[441.336404] Starting dynamic subtest: vecs0
[443.303545] Dynamic subtest vecs0: SUCCESS (1.982s)
[443.319988] Starting dynamic subtest: ccs0
[443.854750] Dynamic subtest ccs0: SUCCESS (0.550s)
[443.857316] Subtest write-busy: SUCCESS (8.063s)
[444.080416] [071/133] (587s left) kms_big_fb (y-tiled-8bpp-rotate-0)
[444.200368] Starting subtest: y-tiled-8bpp-rotate-0
[444.204732] Subtest y-tiled-8bpp-rotate-0: SKIP (0.000s)
[444.308214] [072/133] (587s left) kms_cursor_legacy (basic-busy-flip-before-cursor-legacy)
[444.421802] Starting subtest: basic-busy-flip-before-cursor-legacy
[444.426343] Subtest basic-busy-flip-before-cursor-legacy: SKIP (0.000s)
[444.593644] [073/133] (587s left) gem_basic (bad-close)
[444.644743] Starting subtest: bad-close
[444.648524] Subtest bad-close: SUCCESS (0.000s)
[444.773014] [074/133] (587s left) kms_big_fb (linear-16bpp-rotate-0)
[444.875246] Starting subtest: linear-16bpp-rotate-0
[446.223071] Subtest linear-16bpp-rotate-0: SUCCESS (1.347s)
[446.399852] [075/133] (585s left) kms_psr2_sf (pr-overlay-plane-update-continuous-sf)
[451.417289] Starting subtest: pr-overlay-plane-update-continuous-sf
[451.422108] Subtest pr-overlay-plane-update-continuous-sf: SKIP (0.003s)
[452.274281] [076/133] (579s left) drm_read (short-buffer-wakeup)
[452.420403] Starting subtest: short-buffer-wakeup
[484.645884] Subtest short-buffer-wakeup: SUCCESS (32.215s)
[484.815239] [077/133] (547s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-pwrite)
[484.912686] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-pwrite
[492.082906] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-pwrite: SUCCESS (7.172s)
[492.263828] [078/133] (539s left) kms_psr (fbc-pr-cursor-render)
[492.367205] Starting subtest: fbc-pr-cursor-render
[492.371481] Subtest fbc-pr-cursor-render: SKIP (0.000s)
[492.468287] [079/133] (539s left) kms_ccs (crc-primary-suspend-y-tiled-gen12-mc-ccs)
[492.557685] Starting subtest: crc-primary-suspend-y-tiled-gen12-mc-ccs
[492.560000] Starting dynamic subtest: pipe-A-eDP-1
[492.568913] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[492.578838] Starting dynamic subtest: pipe-B-eDP-1
[492.587973] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[492.597825] Starting dynamic subtest: pipe-C-eDP-1
[492.606412] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[492.616015] Starting dynamic subtest: pipe-D-eDP-1
[492.624560] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[492.628795] Subtest crc-primary-suspend-y-tiled-gen12-mc-ccs: SKIP (0.005s)
[494.854089] [080/133] (537s left) kms_ccs (random-ccs-data-4-tiled-mtl-mc-ccs)
[494.938047] Starting subtest: random-ccs-data-4-tiled-mtl-mc-ccs
[494.940112] Starting dynamic subtest: pipe-A-eDP-1
[496.224714] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.287s)
[496.235174] Starting dynamic subtest: pipe-B-eDP-1
[498.598311] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.372s)
[498.608021] Starting dynamic subtest: pipe-C-eDP-1
[500.892736] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.292s)
[500.903167] Starting dynamic subtest: pipe-D-eDP-1
[503.236189] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.342s)
[503.238406] Subtest random-ccs-data-4-tiled-mtl-mc-ccs: SUCCESS (8.300s)
[504.467817] [081/133] (527s left) sw_sync (sync_multi_timeline_wait)
[504.514339] Starting subtest: sync_multi_timeline_wait
[504.516788] Subtest sync_multi_timeline_wait: SUCCESS (0.000s)
[504.607363] [082/133] (527s left) sysfs_heartbeat_interval (idempotent)
[504.664171] Starting subtest: idempotent
[504.666365] Starting dynamic subtest: vecs0
[504.668637] Dynamic subtest vecs0: SUCCESS (0.001s)
[504.679688] Starting dynamic subtest: ccs0
[504.681489] Dynamic subtest ccs0: SUCCESS (0.001s)
[504.690667] Starting dynamic subtest: vcs0
[504.692489] Dynamic subtest vcs0: SUCCESS (0.000s)
[504.701364] Starting dynamic subtest: bcs0
[504.703186] Dynamic subtest bcs0: SUCCESS (0.001s)
[504.712046] Starting dynamic subtest: rcs0
[504.713894] Dynamic subtest rcs0: SUCCESS (0.000s)
[504.722531] Starting dynamic subtest: vcs1
[504.724372] Dynamic subtest vcs1: SUCCESS (0.000s)
[504.726292] Subtest idempotent: SUCCESS (0.008s)
[504.838614] [083/133] (527s left) syncobj_eventfd (invalid-bad-pad)
[504.893572] Starting subtest: invalid-bad-pad
[504.895770] Subtest invalid-bad-pad: SUCCESS (0.000s)
[505.027394] [084/133] (527s left) kms_busy (extended-pageflip-hang-newfb)
[505.134507] Starting subtest: extended-pageflip-hang-newfb
[505.136801] Starting dynamic subtest: pipe-A
[531.145908] Dynamic subtest pipe-A: SUCCESS (26.009s)
[531.156118] Starting dynamic subtest: pipe-D
[546.117764] Dynamic subtest pipe-D: SUCCESS (14.971s)
[546.120006] Subtest extended-pageflip-hang-newfb: SUCCESS (40.985s)
[546.936963] [085/133] (485s left) kms_psr2_sf (psr2-cursor-plane-update-sf)
[551.997912] Starting subtest: psr2-cursor-plane-update-sf
[552.000210] Starting dynamic subtest: pipe-A-eDP-1
[553.301308] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.302s)
[553.311952] Starting dynamic subtest: pipe-B-eDP-1
[554.627077] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.324s)
[554.629412] Subtest psr2-cursor-plane-update-sf: SUCCESS (2.631s)
[555.548821] [086/133] (477s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-0-async-flip)
[555.654992] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-0-async-flip
[556.301385] Subtest x-tiled-max-hw-stride-32bpp-rotate-0-async-flip: SUCCESS (0.648s)
[556.488710] [087/133] (476s left) gem_exec_balancer (busy)
[556.548755] Starting subtest: busy
[558.295141] Subtest busy: SUCCESS (1.745s)
[558.642187] [088/133] (474s left) kms_frontbuffer_tracking (fbc-2p-primscrn-shrfb-msflip-blt)
[558.752564] Starting subtest: fbc-2p-primscrn-shrfb-msflip-blt
[558.756410] Subtest fbc-2p-primscrn-shrfb-msflip-blt: SKIP (0.000s)
[558.884018] [089/133] (473s left) vgem_slow (nohang)
[558.922356] Starting subtest: nohang
[569.337143] Subtest nohang: SUCCESS (10.366s)
[569.385109] [090/133] (463s left) gem_spin_batch (resubmit-new-all)
[569.447259] Starting subtest: resubmit-new-all
[569.449563] Starting dynamic subtest: rcs0
[569.472215] Dynamic subtest rcs0: SUCCESS (0.024s)
[569.483894] Starting dynamic subtest: bcs0
[569.488403] Dynamic subtest bcs0: SUCCESS (0.015s)
[569.497506] Starting dynamic subtest: vcs0
[569.502475] Dynamic subtest vcs0: SUCCESS (0.014s)
[569.511835] Starting dynamic subtest: vcs1
[569.520057] Dynamic subtest vcs1: SUCCESS (0.016s)
[569.529396] Starting dynamic subtest: vecs0
[569.533633] Dynamic subtest vecs0: SUCCESS (0.013s)
[569.542784] Starting dynamic subtest: ccs0
[569.550953] Dynamic subtest ccs0: SUCCESS (0.017s)
[569.553048] Subtest resubmit-new-all: SUCCESS (0.104s)
[571.371547] [091/133] (461s left) gem_render_copy (mixed-tiled-to-y-tiled-ccs)
[571.446485] Starting subtest: mixed-tiled-to-y-tiled-ccs
[571.450769] Subtest mixed-tiled-to-y-tiled-ccs: SKIP (0.000s)
[571.658256] [092/133] (461s left) syncobj_timeline (invalid-signal-illegal-point)
[571.716186] Starting subtest: invalid-signal-illegal-point
[571.718528] Subtest invalid-signal-illegal-point: SUCCESS (0.000s)
[571.852210] [093/133] (461s left) gem_exec_schedule (preempt-contexts)
[571.924233] Starting subtest: preempt-contexts
[571.926191] Starting dynamic subtest: rcs0
[572.006330] Dynamic subtest rcs0: SUCCESS (0.088s)
[572.017307] Starting dynamic subtest: bcs0
[572.092791] Dynamic subtest bcs0: SUCCESS (0.086s)
[572.103680] Starting dynamic subtest: vcs0
[572.159316] Dynamic subtest vcs0: SUCCESS (0.065s)
[572.172258] Starting dynamic subtest: vcs1
[572.211830] Dynamic subtest vcs1: SUCCESS (0.053s)
[572.221747] Starting dynamic subtest: vecs0
[572.273531] Dynamic subtest vecs0: SUCCESS (0.061s)
[572.283468] Starting dynamic subtest: ccs0
[572.360365] Dynamic subtest ccs0: SUCCESS (0.086s)
[572.362638] Subtest preempt-contexts: SUCCESS (0.442s)
[573.427739] [094/133] (459s left) gem_pwrite_snooped
[573.569288] [095/133] (459s left) kms_tiled_display (basic-test-pattern)
[573.683593] Subtest basic-test-pattern: SKIP (0.000s)
[573.730588] [096/133] (459s left) kms_frontbuffer_tracking (psr-shrfb-scaledprimary)
[573.836999] Starting subtest: psr-shrfb-scaledprimary
[579.604095] Subtest psr-shrfb-scaledprimary: SUCCESS (5.768s)
[579.766852] [097/133] (453s left) kms_frontbuffer_tracking (fbcpsr-1p-shrfb-fliptrack-mmap-gtt)
[579.870650] Starting subtest: fbcpsr-1p-shrfb-fliptrack-mmap-gtt
[579.874702] Subtest fbcpsr-1p-shrfb-fliptrack-mmap-gtt: SKIP (0.000s)
[580.001316] [098/133] (453s left) gem_pwrite (basic-self)
[580.059595] Subtest basic-self: SKIP (0.000s)
[580.128320] [099/133] (453s left) kms_pm_rpm (dpms-mode-unset-non-lpsp)
[582.455697] Starting subtest: dpms-mode-unset-non-lpsp
[583.595720] Subtest dpms-mode-unset-non-lpsp: SKIP (1.143s)
[583.997164] [100/133] (449s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip)
[584.101671] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip
[584.105973] Subtest yf-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip: SKIP (0.000s)
[584.227200] [101/133] (448s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-render)
[584.333913] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-render
[584.338142] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-render: SKIP (0.000s)
[584.451973] [102/133] (448s left) kms_color_pipeline (plane-lut1d-ctm3x4-lut1d)
[584.556921] Starting subtest: plane-lut1d-ctm3x4-lut1d
[584.573416] Starting dynamic subtest: pipe-A-eDP-1
[585.230880] Dynamic subtest pipe-A-eDP-1: FAIL (0.331s)
[585.947890] Starting dynamic subtest: pipe-B-eDP-1
[586.786663] Dynamic subtest pipe-B-eDP-1: FAIL (0.312s)
[587.369648] Starting dynamic subtest: pipe-C-eDP-1
[588.179957] Dynamic subtest pipe-C-eDP-1: FAIL (0.235s)
[588.689322] Starting dynamic subtest: pipe-D-eDP-1
[589.515896] Dynamic subtest pipe-D-eDP-1: FAIL (0.247s)
[589.517914] Subtest plane-lut1d-ctm3x4-lut1d: FAIL (4.649s)
[590.101600] [103/133] (443s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-render)
[590.212260] Starting subtest: psr-1p-primscrn-spr-indfb-draw-render
[596.991397] Subtest psr-1p-primscrn-spr-indfb-draw-render: SUCCESS (6.784s)
[597.142543] [104/133] (436s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-onoff)
[597.237779] Starting subtest: psr-1p-primscrn-cur-indfb-onoff
[604.269423] Subtest psr-1p-primscrn-cur-indfb-onoff: SUCCESS (7.036s)
[604.431173] [105/133] (428s left) gem_exec_schedule (preempt-queue-contexts-chain)
[604.502751] Subtest preempt-queue-contexts-chain: SKIP (0.000s)
[604.813597] [106/133] (428s left) api_intel_bb (object-noreloc-keep-cache-simple)
[604.869050] Starting subtest: object-noreloc-keep-cache-simple
[604.871053] Subtest object-noreloc-keep-cache-simple: SUCCESS (0.005s)
[604.997861] [107/133] (428s left) gem_mmap (bad-object)
[605.064647] Subtest bad-object: SKIP (0.000s)
[605.147331] [108/133] (428s left) kms_flip_scaled_crc (flip-32bpp-yftileccs-to-64bpp-yftile-upscaling)
[605.240233] Starting subtest: flip-32bpp-yftileccs-to-64bpp-yftile-upscaling
[605.242511] Starting dynamic subtest: pipe-A-default-mode
[605.526238] Dynamic subtest pipe-A-default-mode: SKIP (0.285s)
[605.530598] Subtest flip-32bpp-yftileccs-to-64bpp-yftile-upscaling: SKIP (0.286s)
[606.382873] [109/133] (427s left) kms_addfb_basic (bo-too-small-due-to-tiling)
[606.485450] Starting subtest: bo-too-small-due-to-tiling
[606.489792] Subtest bo-too-small-due-to-tiling: SKIP (0.000s)
[606.594694] [110/133] (427s left) kms_psr (pr-sprite-blt)
[606.680337] Starting subtest: pr-sprite-blt
[606.684670] Subtest pr-sprite-blt: SKIP (0.000s)
[606.777393] [111/133] (426s left) kms_draw_crc (fill-fb)
[606.882107] Starting subtest: fill-fb
[607.344445] Subtest fill-fb: SUCCESS (0.464s)
[607.488894] [112/133] (426s left) perf_pmu (busy-idle)
[607.527948] Starting subtest: busy-idle
[607.529998] Starting dynamic subtest: rcs0
[608.255040] Dynamic subtest rcs0: SUCCESS (0.726s)
[608.267506] Starting dynamic subtest: bcs0
[608.928084] Dynamic subtest bcs0: SUCCESS (0.671s)
[608.940503] Starting dynamic subtest: vcs0
[610.279138] Dynamic subtest vcs0: SUCCESS (1.348s)
[610.289962] Starting dynamic subtest: vcs1
[612.327758] Dynamic subtest vcs1: SUCCESS (2.046s)
[612.340299] Starting dynamic subtest: vecs0
[614.312478] Dynamic subtest vecs0: SUCCESS (1.982s)
[614.325335] Starting dynamic subtest: ccs0
[614.991340] Dynamic subtest ccs0: SUCCESS (0.677s)
[614.993866] Subtest busy-idle: SUCCESS (7.465s)
[615.144399] [113/133] (418s left) kms_ccs (crc-sprite-planes-basic-4-tiled-dg2-mc-ccs)
[615.244323] Starting subtest: crc-sprite-planes-basic-4-tiled-dg2-mc-ccs
[615.246475] Starting dynamic subtest: pipe-A-eDP-1
[615.303978] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[615.315185] Starting dynamic subtest: pipe-B-eDP-1
[615.372563] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[615.384220] Starting dynamic subtest: pipe-C-eDP-1
[615.440843] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[615.451835] Starting dynamic subtest: pipe-D-eDP-1
[615.509144] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[615.513473] Subtest crc-sprite-planes-basic-4-tiled-dg2-mc-ccs: SKIP (0.009s)
[617.574823] [114/133] (416s left) gem_exec_flush (basic-batch-kernel-default-uc)
[617.636146] Starting subtest: basic-batch-kernel-default-uc
[624.651232] Subtest basic-batch-kernel-default-uc: SUCCESS (7.017s)
[624.866960] [115/133] (408s left) gem_mmap_wc (write-read-distinct)
[624.935288] Subtest write-read-distinct: SKIP (0.000s)
[625.013846] [116/133] (408s left) kms_plane_lowres (tiling-x)
[625.110536] Starting subtest: tiling-x
[625.112795] Starting dynamic subtest: pipe-A-eDP-1
[625.117271] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[625.416760] Starting dynamic subtest: pipe-B-eDP-1
[625.421501] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[625.441149] Starting dynamic subtest: pipe-C-eDP-1
[625.446080] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[625.461292] Starting dynamic subtest: pipe-D-eDP-1
[625.465893] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[625.470329] Subtest tiling-x: SKIP (0.304s)
[626.300250] [117/133] (407s left) sw_sync (alloc_merge_fence)
[626.348291] Starting subtest: alloc_merge_fence
[626.350563] Subtest alloc_merge_fence: SUCCESS (0.000s)
[626.440161] [118/133] (407s left) kms_pm_backlight (fade)
[626.548071] Starting subtest: fade
[626.596417] Starting dynamic subtest: eDP-1
[629.281384] Dynamic subtest eDP-1: SUCCESS (2.684s)
[629.283653] Subtest fade: SUCCESS (2.734s)
[630.127451] [119/133] (403s left) kms_flip_scaled_crc (flip-64bpp-xtile-to-32bpp-xtile-downscaling)
[630.235368] Starting subtest: flip-64bpp-xtile-to-32bpp-xtile-downscaling
[630.237559] Starting dynamic subtest: pipe-A-default-mode
[631.361366] Dynamic subtest pipe-A-default-mode: SKIP (1.123s)
[631.365492] Subtest flip-64bpp-xtile-to-32bpp-xtile-downscaling: SKIP (1.124s)
[631.567138] [120/133] (402s left) syncobj_wait (multi-wait-all-for-submit-unsubmitted-signaled)
[631.634472] Starting subtest: multi-wait-all-for-submit-unsubmitted-signaled
[631.739625] Subtest multi-wait-all-for-submit-unsubmitted-signaled: SUCCESS (0.106s)
[631.839630] [121/133] (402s left) kms_psr (psr-cursor-mmap-cpu)
[631.937764] Starting subtest: psr-cursor-mmap-cpu
[631.940317] Starting dynamic subtest: eDP-1
[633.633120] Dynamic subtest eDP-1: SUCCESS (1.694s)
[633.635437] Subtest psr-cursor-mmap-cpu: SUCCESS (1.696s)
[634.520216] [122/133] (399s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-180-async-flip)
[634.632564] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-180-async-flip
[635.278845] Subtest 4-tiled-max-hw-stride-32bpp-rotate-180-async-flip: SUCCESS (0.648s)
[635.499326] [123/133] (398s left) gem_exec_whisper (basic-queues-priority-all)
[635.579145] Starting subtest: basic-queues-priority-all
[657.806334] Subtest basic-queues-priority-all: SUCCESS (22.227s)
[658.016139] [124/133] (376s left) syncobj_timeline (etime-single-wait-all-submitted)
[658.075186] Starting subtest: etime-single-wait-all-submitted
[658.179734] Subtest etime-single-wait-all-submitted: SUCCESS (0.105s)
[658.284719] [125/133] (375s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-onoff)
[658.392834] Starting subtest: fbc-2p-primscrn-spr-indfb-onoff
[658.397206] Subtest fbc-2p-primscrn-spr-indfb-onoff: SKIP (0.000s)
[658.511554] [126/133] (375s left) kms_async_flips (async-flip-dpms)
[658.592276] Starting subtest: async-flip-dpms
[658.967598] Starting dynamic subtest: pipe-A-eDP-1
[662.809722] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.842s)
[663.188552] Starting dynamic subtest: pipe-B-eDP-1
[665.969091] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.788s)
[666.358410] Starting dynamic subtest: pipe-C-eDP-1
[669.144909] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.793s)
[669.531941] Starting dynamic subtest: pipe-D-eDP-1
[672.326826] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.805s)
[672.329092] Subtest async-flip-dpms: SUCCESS (13.739s)
[673.535785] [127/133] (360s left) gem_exec_reloc (basic-cpu-read-noreloc)
[673.594360] Subtest basic-cpu-read-noreloc: SKIP (0.000s)
[673.681754] [128/133] (360s left) syncobj_wait (invalid-reset-illegal-handle)
[673.744087] Starting subtest: invalid-reset-illegal-handle
[673.746371] Subtest invalid-reset-illegal-handle: SUCCESS (0.000s)
[673.879020] [129/133] (360s left) syncobj_wait (multi-wait-all-for-submit-unsubmitted-submitted)
[673.933776] Starting subtest: multi-wait-all-for-submit-unsubmitted-submitted
[674.036497] Subtest multi-wait-all-for-submit-unsubmitted-submitted: SUCCESS (0.102s)
[674.137860] [130/133] (360s left) gem_tiled_swapping (non-threaded)
[674.206292] Subtest non-threaded: SKIP (0.000s)
[674.278509] [131/133] (360s left) gem_exec_fence (syncobj-timeline-chain-engines)
[674.840346] Starting subtest: syncobj-timeline-chain-engines
[674.957671] Subtest syncobj-timeline-chain-engines: SUCCESS (0.117s)
[676.464528] [132/133] (358s left) kms_cursor_legacy (flip-vs-cursor-legacy)
[676.594507] Starting subtest: flip-vs-cursor-legacy
[683.638336] Subtest flip-vs-cursor-legacy: SUCCESS (7.046s)
[684.451880] [133/133] (350s left) syncobj_basic (illegal-fd-to-handle)
[684.516954] Starting subtest: illegal-fd-to-handle
[684.519123] Subtest illegal-fd-to-handle: SUCCESS (0.000s)
[684.646206] 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.