[59.142055] Initializing watchdogs
[59.142198]   /dev/watchdog0
[59.160199] [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.164866] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[59.167078] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[59.168978] [001/133] (960s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-mmap-gtt)
[59.272451] Starting subtest: psr-2p-primscrn-spr-indfb-draw-mmap-gtt
[59.274011] Subtest psr-2p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[59.392427] [002/133] (960s left) gem_exec_suspend (basic-s3-devices)
[59.453151] Starting subtest: basic-S3-devices
[59.454254] Starting dynamic subtest: smem
[70.871618] Dynamic subtest smem: SUCCESS (11.416s)
[70.872977] Subtest basic-S3-devices: SUCCESS (11.417s)
[78.082527] [003/133] (948s left) gem_render_copy (y-tiled-ccs-to-yf-tiled)
[78.149418] Starting subtest: y-tiled-ccs-to-yf-tiled
[78.151076] Subtest y-tiled-ccs-to-yf-tiled: SKIP (0.000s)
[78.346210] [004/133] (948s left) kms_ccs (ccs-on-another-bo-y-tiled-gen12-mc-ccs)
[78.436987] Starting subtest: ccs-on-another-bo-y-tiled-gen12-mc-ccs
[78.437908] Starting dynamic subtest: pipe-A-eDP-1
[78.446232] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[78.454699] Starting dynamic subtest: pipe-B-eDP-1
[78.463357] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[78.469219] Starting dynamic subtest: pipe-C-eDP-1
[78.477757] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[78.483403] Starting dynamic subtest: pipe-D-eDP-1
[78.491864] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[78.493577] Subtest ccs-on-another-bo-y-tiled-gen12-mc-ccs: SKIP (0.003s)
[80.691896] [005/133] (946s left) kms_flip (bo-too-big)
[80.790917] Starting subtest: bo-too-big
[80.792843] Starting dynamic subtest: A-eDP1
[82.139331] Dynamic subtest A-eDP1: SUCCESS (1.348s)
[82.147457] Starting dynamic subtest: B-eDP1
[83.470878] Dynamic subtest B-eDP1: SUCCESS (1.332s)
[83.477557] Starting dynamic subtest: C-eDP1
[84.814144] Dynamic subtest C-eDP1: SUCCESS (1.344s)
[84.822934] Starting dynamic subtest: D-eDP1
[86.143422] Dynamic subtest D-eDP1: SUCCESS (1.329s)
[86.149034] Subtest bo-too-big: SUCCESS (5.363s)
[87.362122] [006/133] (939s left) syncobj_timeline (multi-wait-available-unsubmitted-signaled)
[87.420546] Starting subtest: multi-wait-available-unsubmitted-signaled
[87.421394] Subtest multi-wait-available-unsubmitted-signaled: SUCCESS (0.001s)
[87.554200] [007/133] (939s left) kms_lease (lease-uevent)
[87.646229] Starting subtest: lease-uevent
[88.666415] Subtest lease-uevent: SUCCESS (1.019s)
[88.762237] [008/133] (938s left) gem_exec_fence (syncobj-timeline-wait)
[89.329105] Starting subtest: syncobj-timeline-wait
[90.918295] Subtest syncobj-timeline-wait: SUCCESS (1.592s)
[92.960527] [FACT gem_exec_fence (syncobj-timeline-wait)] new: kernel.kmod_is_loaded.vgem: true
[92.962504] [009/133] (933s left) kms_chamelium_color (gamma)
[93.064920] Subtest gamma: SKIP (0.000s)
[93.103957] [010/133] (933s left) prime_mmap (test_errors)
[93.154501] Starting subtest: test_errors
[93.155489] Starting dynamic subtest: test_errors-smem
[93.249880] Dynamic subtest test_errors-smem: SUCCESS (0.096s)
[93.251336] Subtest test_errors: SUCCESS (0.096s)
[93.384258] [011/133] (933s left) i915_drm_fdinfo (idle)
[93.415123] Starting subtest: idle
[93.416168] Starting dynamic subtest: rcs0
[93.976507] Dynamic subtest rcs0: SUCCESS (0.561s)
[93.985594] Starting dynamic subtest: bcs0
[94.522844] Dynamic subtest bcs0: SUCCESS (0.543s)
[94.532062] Starting dynamic subtest: vcs0
[95.027578] Dynamic subtest vcs0: SUCCESS (0.504s)
[95.036433] Starting dynamic subtest: vcs1
[95.531696] Dynamic subtest vcs1: SUCCESS (0.503s)
[95.540422] Starting dynamic subtest: vecs0
[96.036099] Dynamic subtest vecs0: SUCCESS (0.504s)
[96.045160] Starting dynamic subtest: ccs0
[96.540962] Dynamic subtest ccs0: SUCCESS (0.503s)
[96.542351] Subtest idle: SUCCESS (3.125s)
[96.633319] [012/133] (930s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-mmap-cpu)
[96.733749] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-mmap-cpu
[96.735511] Subtest fbc-2p-scndscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[96.868250] [013/133] (930s left) kms_invalid_mode (zero-hdisplay)
[96.964738] Starting subtest: zero-hdisplay
[96.965670] Starting dynamic subtest: pipe-A-eDP-1
[97.252778] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.289s)
[97.259995] Starting dynamic subtest: pipe-B-eDP-1
[97.261194] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[97.267478] Starting dynamic subtest: pipe-C-eDP-1
[97.268401] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[97.274629] Starting dynamic subtest: pipe-D-eDP-1
[97.275556] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[97.276457] Subtest zero-hdisplay: SUCCESS (0.293s)
[98.088672] [014/133] (929s left) kms_plane_scaling (planes-downscale-factor-0-75-unity-scaling)
[98.181379] Starting subtest: planes-downscale-factor-0-75-unity-scaling
[98.182345] Starting dynamic subtest: pipe-A
[98.245322] Dynamic subtest pipe-A: SUCCESS (0.065s)
[98.255612] Starting dynamic subtest: pipe-B
[99.402139] Dynamic subtest pipe-B: SUCCESS (1.156s)
[99.411070] Starting dynamic subtest: pipe-C
[100.503836] Dynamic subtest pipe-C: SUCCESS (1.101s)
[100.520507] Starting dynamic subtest: pipe-D
[101.644429] Dynamic subtest pipe-D: SUCCESS (1.140s)
[101.645425] Subtest planes-downscale-factor-0-75-unity-scaling: SUCCESS (3.466s)
[102.814758] [015/133] (924s left) drm_read (fault-buffer)
[102.958139] Starting subtest: fault-buffer
[102.959144] Subtest fault-buffer: SUCCESS (0.001s)
[103.111530] [016/133] (924s left) gem_ccs (suspend-resume)
[103.181610] Starting subtest: suspend-resume
[103.183902] Subtest suspend-resume: SKIP (0.000s)
[103.316404] [017/133] (923s left) kms_ccs (bad-rotation-90-4-tiled-dg2-rc-ccs)
[103.390392] Starting subtest: bad-rotation-90-4-tiled-dg2-rc-ccs
[103.391399] Starting dynamic subtest: pipe-A-eDP-1
[103.400265] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[103.407582] Starting dynamic subtest: pipe-B-eDP-1
[103.416225] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[103.422816] Starting dynamic subtest: pipe-C-eDP-1
[103.431171] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[103.437321] Starting dynamic subtest: pipe-D-eDP-1
[103.445818] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[103.447730] Subtest bad-rotation-90-4-tiled-dg2-rc-ccs: SKIP (0.003s)
[105.591628] [018/133] (921s left) gem_close (many-handles-one-vma)
[105.647545] Starting subtest: many-handles-one-vma
[105.672609] Subtest many-handles-one-vma: SUCCESS (0.025s)
[105.843220] [019/133] (921s left) gem_busy (extended)
[106.031601] Starting subtest: extended
[106.032829] Starting dynamic subtest: rcs0
[106.123780] Dynamic subtest rcs0: SUCCESS (0.092s)
[106.133423] Starting dynamic subtest: bcs0
[106.166533] Dynamic subtest bcs0: SUCCESS (0.042s)
[106.175725] Starting dynamic subtest: vcs0
[107.927044] Dynamic subtest vcs0: SUCCESS (1.757s)
[107.937300] Starting dynamic subtest: vcs1
[109.911220] Dynamic subtest vcs1: SUCCESS (1.983s)
[109.921048] Starting dynamic subtest: vecs0
[111.894686] Dynamic subtest vecs0: SUCCESS (1.983s)
[111.904608] Starting dynamic subtest: ccs0
[111.938712] Dynamic subtest ccs0: SUCCESS (0.046s)
[111.939844] Subtest extended: SUCCESS (5.908s)
[112.206490] [020/133] (915s left) kms_vblank (ts-continuation-suspend)
[112.300919] Starting subtest: ts-continuation-suspend
[112.301908] Starting dynamic subtest: pipe-A-eDP-1
[129.659247] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.944s)
[129.668491] Starting dynamic subtest: pipe-D-eDP-1
[147.658688] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.537s)
[147.659813] Subtest ts-continuation-suspend: SUCCESS (4.484s)
[153.481706] [021/133] (878s left) perf_pmu (semaphore-wait-idle)
[153.517120] Starting subtest: semaphore-wait-idle
[153.518049] Starting dynamic subtest: rcs0
[154.038177] Dynamic subtest rcs0: SUCCESS (0.519s)
[154.048294] Starting dynamic subtest: bcs0
[154.552908] Dynamic subtest bcs0: SUCCESS (0.513s)
[154.562866] Starting dynamic subtest: vcs0
[155.066056] Dynamic subtest vcs0: SUCCESS (0.512s)
[155.076396] Starting dynamic subtest: vcs1
[155.580482] Dynamic subtest vcs1: SUCCESS (0.513s)
[155.590366] Starting dynamic subtest: vecs0
[156.094160] Dynamic subtest vecs0: SUCCESS (0.512s)
[156.104673] Starting dynamic subtest: ccs0
[156.609156] Dynamic subtest ccs0: SUCCESS (0.513s)
[156.610792] Subtest semaphore-wait-idle: SUCCESS (3.091s)
[157.902768] [022/133] (874s left) kms_debugfs (display-off-read-all)
[158.000135] Starting subtest: display-off-read-all
[158.284874] Subtest display-off-read-all: SUCCESS (0.285s)
[159.096504] [023/133] (873s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-blt)
[159.188127] Starting subtest: fbc-rgb101010-draw-blt
[163.816394] Subtest fbc-rgb101010-draw-blt: SUCCESS (4.628s)
[164.998012] [024/133] (867s left) gem_ctx_param (invalid-get-no-zeromap)
[165.057966] Starting subtest: invalid-get-no-zeromap
[165.060167] Subtest invalid-get-no-zeromap: SUCCESS (0.001s)
[165.183200] [025/133] (867s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-mmap-gtt)
[165.280018] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-mmap-gtt
[165.281967] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[165.395449] [026/133] (867s left) gem_exec_big (single)
[165.440333] Starting subtest: single
[167.791563] Subtest single: SUCCESS (2.348s)
[168.023780] [027/133] (864s left) kms_frontbuffer_tracking (psr-rgb101010-draw-mmap-gtt)
[168.162960] Starting subtest: psr-rgb101010-draw-mmap-gtt
[168.164770] Subtest psr-rgb101010-draw-mmap-gtt: SKIP (0.000s)
[168.281552] [028/133] (864s left) gem_exec_flush (basic-uc-prw-default)
[168.343224] Starting subtest: basic-uc-prw-default
[173.805908] Subtest basic-uc-prw-default: SUCCESS (5.462s)
[174.005854] [029/133] (858s left) kms_frontbuffer_tracking (fbc-1p-shrfb-fliptrack-mmap-gtt)
[174.103407] Starting subtest: fbc-1p-shrfb-fliptrack-mmap-gtt
[174.105202] Subtest fbc-1p-shrfb-fliptrack-mmap-gtt: SKIP (0.000s)
[174.219647] [030/133] (858s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-shrfb-draw-render)
[174.305008] Starting subtest: psr-1p-offscreen-pri-shrfb-draw-render
[181.136456] Subtest psr-1p-offscreen-pri-shrfb-draw-render: SUCCESS (6.833s)
[181.311077] [031/133] (851s left) gem_exec_create (forked)
[181.368968] Starting subtest: forked
[181.370088] Starting dynamic subtest: smem
[202.800845] Dynamic subtest smem: SUCCESS (21.440s)
[202.802403] Subtest forked: SUCCESS (21.441s)
[203.003709] [032/133] (829s left) kms_feature_discovery (display-1x)
[203.110412] Starting subtest: display-1x
[203.111414] Subtest display-1x: SUCCESS (0.000s)
[203.201995] [033/133] (829s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-wc)
[203.294175] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-wc
[203.295953] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[203.426738] [034/133] (829s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-move)
[203.536849] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-move
[203.538612] Subtest fbcpsr-2p-primscrn-cur-indfb-move: SKIP (0.000s)
[203.674084] [035/133] (829s left) gem_render_copy_redux (interruptible)
[203.730338] Starting subtest: interruptible
[203.992541] Subtest interruptible: SUCCESS (0.263s)
[204.156671] [036/133] (828s left) i915_pm_rpm (system-suspend-execbuf)
[206.004093] Starting subtest: system-suspend-execbuf
[264.843472] Subtest system-suspend-execbuf: SUCCESS (43.966s)
[265.245531] [037/133] (767s left) kms_frontbuffer_tracking (psr-2p-scndscrn-indfb-plflip-blt)
[265.346380] Starting subtest: psr-2p-scndscrn-indfb-plflip-blt
[265.349072] Subtest psr-2p-scndscrn-indfb-plflip-blt: SKIP (0.000s)
[265.493315] [038/133] (767s left) gem_request_retire (retire-vma-not-inactive)
[265.552506] Starting subtest: retire-vma-not-inactive
[265.613932] Subtest retire-vma-not-inactive: SUCCESS (0.059s)
[265.745583] [039/133] (767s left) i915_pm_rps (thresholds-idle)
[265.811892] Starting subtest: thresholds-idle
[265.814056] Subtest thresholds-idle: SKIP (0.001s)
[265.935845] [040/133] (767s left) gem_ctx_persistence (legacy-engines-queued)
[265.993347] Starting subtest: legacy-engines-queued
[265.994312] Starting dynamic subtest: render
[266.092541] Dynamic subtest render: SUCCESS (0.098s)
[266.103518] Starting dynamic subtest: bsd1
[267.648648] Dynamic subtest bsd1: SUCCESS (1.552s)
[267.658551] Starting dynamic subtest: bsd2
[269.631987] Dynamic subtest bsd2: SUCCESS (1.981s)
[269.649957] Starting dynamic subtest: blt
[269.703251] Dynamic subtest blt: SUCCESS (0.071s)
[269.722431] Starting dynamic subtest: vebox
[271.616321] Dynamic subtest vebox: SUCCESS (1.909s)
[271.617821] Subtest legacy-engines-queued: SUCCESS (5.622s)
[271.710101] [041/133] (761s left) i915_hangman (gt-error-state-capture)
[271.785341] Starting subtest: gt-error-state-capture
[271.786364] Starting dynamic subtest: rcs0
[283.647733] Dynamic subtest rcs0: SUCCESS (11.862s)
[283.659023] Starting dynamic subtest: bcs0
[295.681029] Dynamic subtest bcs0: SUCCESS (12.034s)
[295.692680] Starting dynamic subtest: vcs0
[307.584619] Dynamic subtest vcs0: SUCCESS (11.907s)
[307.596409] Starting dynamic subtest: vcs1
[318.655675] Dynamic subtest vcs1: SUCCESS (11.071s)
[318.666890] Starting dynamic subtest: vecs0
[330.624331] Dynamic subtest vecs0: SUCCESS (11.963s)
[330.635496] Starting dynamic subtest: ccs0
[342.656063] Dynamic subtest ccs0: SUCCESS (12.028s)
[342.657922] Subtest gt-error-state-capture: SUCCESS (70.875s)
[342.755110] [042/133] (690s left) kms_cursor_crc (cursor-rapid-movement-128x42)
[342.989228] Starting subtest: cursor-rapid-movement-128x42
[343.029909] Subtest cursor-rapid-movement-128x42: SKIP (0.038s)
[343.274415] [043/133] (689s left) gem_partial_pwrite_pread (writes-after-reads-uncached)
[343.330039] Subtest writes-after-reads-uncached: SKIP (0.000s)
[343.395835] [044/133] (689s left) gem_mmap_wc (coherency)
[343.452805] Subtest coherency: SKIP (0.000s)
[343.514492] [045/133] (689s left) syncobj_timeline (single-wait-all-for-submit-signaled)
[343.581896] Starting subtest: single-wait-all-for-submit-signaled
[343.582971] Subtest single-wait-all-for-submit-signaled: SUCCESS (0.000s)
[343.695659] [046/133] (689s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-render)
[343.799332] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-render
[347.548776] Subtest fbc-1p-primscrn-cur-indfb-draw-render: SUCCESS (3.751s)
[348.741321] [047/133] (684s left) kms_psr (fbc-psr-primary-mmap-cpu)
[348.835360] Starting subtest: fbc-psr-primary-mmap-cpu
[348.836211] Starting dynamic subtest: eDP-1
[348.837894] Dynamic subtest eDP-1: SKIP (0.000s)
[348.839470] Subtest fbc-psr-primary-mmap-cpu: SKIP (0.001s)
[348.929059] [048/133] (684s left) kms_invalid_mode (bad-vsync-start)
[349.013950] Starting subtest: bad-vsync-start
[349.015169] Starting dynamic subtest: pipe-A-eDP-1
[349.297569] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.284s)
[349.306166] Starting dynamic subtest: pipe-B-eDP-1
[349.307467] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[349.315531] Starting dynamic subtest: pipe-C-eDP-1
[349.316879] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[349.324808] Starting dynamic subtest: pipe-D-eDP-1
[349.326045] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[349.327302] Subtest bad-vsync-start: SUCCESS (0.289s)
[350.163637] [049/133] (683s left) gem_exec_reloc (basic-wc-gtt)
[350.226027] Subtest basic-wc-gtt: SKIP (0.000s)
[350.289141] [050/133] (683s left) gem_mmap_gtt (cpuset-medium-copy-xy)
[350.345836] Subtest cpuset-medium-copy-XY: SKIP (0.000s)
[350.411480] [051/133] (682s left) kms_prop_blob (blob-multiple)
[350.461692] Starting subtest: blob-multiple
[350.463181] Subtest blob-multiple: SUCCESS (0.002s)
[350.611529] [052/133] (682s left) api_intel_allocator (open-vm)
[350.661364] Starting subtest: open-vm
[350.663732] Subtest open-vm: SUCCESS (0.004s)
[350.804093] [053/133] (682s left) kms_getfb (getfb-repeated-different-handles)
[350.896682] Starting subtest: getfb-repeated-different-handles
[350.897638] Subtest getfb-repeated-different-handles: SUCCESS (0.000s)
[350.999017] [054/133] (682s left) kms_content_protection (legacy-hdcp14)
[351.125974] Starting subtest: legacy-hdcp14
[351.127986] Subtest legacy-hdcp14: SKIP (0.000s)
[351.291793] [055/133] (682s left) kms_chamelium_hpd (hdmi-hpd-after-suspend)
[351.672414] Subtest hdmi-hpd-after-suspend: SKIP (0.000s)
[352.456721] [056/133] (681s left) kms_flip (blocking-absolute-wf_vblank)
[352.557313] Starting subtest: blocking-absolute-wf_vblank
[352.558172] Starting dynamic subtest: A-eDP1
[361.257551] Dynamic subtest A-eDP1: SUCCESS (8.700s)
[361.268376] Starting dynamic subtest: B-eDP1
[369.984360] Dynamic subtest B-eDP1: SUCCESS (8.726s)
[369.994524] Starting dynamic subtest: C-eDP1
[378.703901] Dynamic subtest C-eDP1: SUCCESS (8.718s)
[378.719879] Starting dynamic subtest: D-eDP1
[387.434837] Dynamic subtest D-eDP1: SUCCESS (8.731s)
[387.439399] Subtest blocking-absolute-wf_vblank: SUCCESS (34.887s)
[388.672642] [057/133] (644s left) gem_mmap_offset (bad-object)
[388.738857] Starting subtest: bad-object
[388.740207] Subtest bad-object: SUCCESS (0.001s)
[388.869528] [058/133] (644s left) kms_psr (psr2-no-drrs)
[388.954722] Starting subtest: psr2-no-drrs
[388.955683] Starting dynamic subtest: eDP-1
[390.529747] Dynamic subtest eDP-1: SUCCESS (1.574s)
[390.530746] Subtest psr2-no-drrs: SUCCESS (1.575s)
[391.347950] [059/133] (642s left) gem_fenced_exec_thrash (no-spare-fences-interruptible)
[391.416552] Subtest no-spare-fences-interruptible: SKIP (0.000s)
[391.485149] [060/133] (642s left) kms_vblank (wait-idle)
[391.567755] Starting subtest: wait-idle
[391.568693] Starting dynamic subtest: pipe-A-eDP-1
[393.320297] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.753s)
[393.331677] Starting dynamic subtest: pipe-D-eDP-1
[395.778556] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.455s)
[395.779637] Subtest wait-idle: SUCCESS (4.212s)
[396.604650] [061/133] (637s left) gem_exec_whisper (basic-contexts-all)
[396.665759] Starting subtest: basic-contexts-all
[406.942799] Subtest basic-contexts-all: SUCCESS (10.275s)
[407.143112] [062/133] (626s left) kms_big_fb (x-tiled-16bpp-rotate-0)
[407.256364] Starting subtest: x-tiled-16bpp-rotate-0
[408.546731] Subtest x-tiled-16bpp-rotate-0: SUCCESS (1.291s)
[408.721839] [063/133] (625s left) kms_atomic (plane-primary-overlay-mutable-zpos)
[408.825133] Starting subtest: plane-primary-overlay-mutable-zpos
[412.233672] Subtest plane-primary-overlay-mutable-zpos: SKIP (3.408s)
[413.433544] [064/133] (620s left) gen9_exec_parse (bb-start-cmd)
[413.491100] Subtest bb-start-cmd: SKIP (0.000s)
[413.570174] [065/133] (620s left) kms_cursor_crc (cursor-alpha-opaque)
[413.667735] Starting subtest: cursor-alpha-opaque
[413.668812] Starting dynamic subtest: pipe-A-eDP-1
[414.276371] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.607s)
[414.294280] Starting dynamic subtest: pipe-D-eDP-1
[415.571462] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.295s)
[415.572428] Subtest cursor-alpha-opaque: SUCCESS (1.905s)
[416.382223] [066/133] (617s left) kms_cursor_crc (cursor-sliding-64x64)
[416.572375] Starting subtest: cursor-sliding-64x64
[416.573794] Starting dynamic subtest: pipe-A-eDP-1
[419.835136] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.262s)
[419.863568] Starting dynamic subtest: pipe-D-eDP-1
[423.742861] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.887s)
[423.744385] Subtest cursor-sliding-64x64: SUCCESS (7.173s)
[424.645200] [067/133] (609s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-render)
[424.752813] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-render
[431.411218] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-render: SUCCESS (6.662s)
[431.577531] [068/133] (602s left) gem_ctx_shared (exec-single-timeline)
[431.646555] Starting subtest: exec-single-timeline
[431.647841] Starting dynamic subtest: rcs0
[432.702056] Dynamic subtest rcs0: SUCCESS (1.053s)
[432.713858] Starting dynamic subtest: bcs0
[433.789036] Dynamic subtest bcs0: SUCCESS (1.085s)
[433.799377] Starting dynamic subtest: vcs0
[434.880570] Dynamic subtest vcs0: SUCCESS (1.090s)
[434.892612] Starting dynamic subtest: vcs1
[435.967219] Dynamic subtest vcs1: SUCCESS (1.085s)
[435.977923] Starting dynamic subtest: vecs0
[437.054916] Dynamic subtest vecs0: SUCCESS (1.085s)
[437.065021] Starting dynamic subtest: ccs0
[438.143403] Dynamic subtest ccs0: SUCCESS (1.086s)
[438.144943] Subtest exec-single-timeline: SUCCESS (6.498s)
[438.352508] [069/133] (595s left) kms_plane_scaling (plane-downscale-factor-0-75-with-pixel-format)
[438.443165] Starting subtest: plane-downscale-factor-0-75-with-pixel-format
[438.444312] Starting dynamic subtest: pipe-A
[439.682586] Dynamic subtest pipe-A: SUCCESS (1.241s)
[439.690881] Starting dynamic subtest: pipe-B
[441.880031] Dynamic subtest pipe-B: SUCCESS (2.197s)
[441.889857] Starting dynamic subtest: pipe-C
[443.062540] Dynamic subtest pipe-C: SUCCESS (1.180s)
[443.070570] Starting dynamic subtest: pipe-D
[444.211322] Dynamic subtest pipe-D: SUCCESS (1.148s)
[444.212526] Subtest plane-downscale-factor-0-75-with-pixel-format: SUCCESS (5.771s)
[445.418854] [070/133] (588s left) gem_wait (write-busy)
[445.492041] Starting subtest: write-busy
[445.493564] Starting dynamic subtest: all-engines
[446.131554] Dynamic subtest all-engines: SUCCESS (0.641s)
[446.149501] Starting dynamic subtest: rcs0
[446.687968] Dynamic subtest rcs0: SUCCESS (0.554s)
[446.703520] Starting dynamic subtest: bcs0
[447.236942] Dynamic subtest bcs0: SUCCESS (0.548s)
[447.252244] Starting dynamic subtest: vcs0
[448.674069] Dynamic subtest vcs0: SUCCESS (1.434s)
[448.690131] Starting dynamic subtest: vcs1
[450.657472] Dynamic subtest vcs1: SUCCESS (1.979s)
[450.672874] Starting dynamic subtest: vecs0
[452.705155] Dynamic subtest vecs0: SUCCESS (2.044s)
[452.720909] Starting dynamic subtest: ccs0
[453.254704] Dynamic subtest ccs0: SUCCESS (0.549s)
[453.255709] Subtest write-busy: SUCCESS (7.765s)
[453.471557] [071/133] (580s left) kms_big_fb (y-tiled-8bpp-rotate-0)
[453.576651] Starting subtest: y-tiled-8bpp-rotate-0
[453.579520] Subtest y-tiled-8bpp-rotate-0: SKIP (0.000s)
[453.692098] [072/133] (580s left) kms_cursor_legacy (basic-busy-flip-before-cursor-legacy)
[453.794529] Starting subtest: basic-busy-flip-before-cursor-legacy
[453.797099] Subtest basic-busy-flip-before-cursor-legacy: SKIP (0.000s)
[453.974560] [073/133] (580s left) gem_basic (bad-close)
[454.038591] Starting subtest: bad-close
[454.040946] Subtest bad-close: SUCCESS (0.000s)
[454.152400] [074/133] (580s left) kms_big_fb (linear-16bpp-rotate-0)
[454.242035] Starting subtest: linear-16bpp-rotate-0
[455.678336] Subtest linear-16bpp-rotate-0: SUCCESS (1.436s)
[455.825528] [075/133] (578s left) kms_psr2_sf (pr-overlay-plane-update-continuous-sf)
[460.790755] Starting subtest: pr-overlay-plane-update-continuous-sf
[460.794014] Subtest pr-overlay-plane-update-continuous-sf: SKIP (0.003s)
[461.664430] [076/133] (572s left) drm_read (short-buffer-wakeup)
[461.835789] Starting subtest: short-buffer-wakeup
[494.060949] Subtest short-buffer-wakeup: SUCCESS (32.217s)
[494.221841] [077/133] (540s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-pwrite)
[494.317839] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-pwrite
[501.317558] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-pwrite: SUCCESS (6.999s)
[501.479798] [078/133] (532s left) kms_psr (fbc-pr-cursor-render)
[501.575388] Starting subtest: fbc-pr-cursor-render
[501.577543] Subtest fbc-pr-cursor-render: SKIP (0.000s)
[501.665995] [079/133] (532s left) kms_ccs (crc-primary-suspend-y-tiled-gen12-mc-ccs)
[501.762639] Starting subtest: crc-primary-suspend-y-tiled-gen12-mc-ccs
[501.763809] Starting dynamic subtest: pipe-A-eDP-1
[501.767689] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[501.776119] Starting dynamic subtest: pipe-B-eDP-1
[501.780893] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[501.789566] Starting dynamic subtest: pipe-C-eDP-1
[501.793858] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[501.802053] Starting dynamic subtest: pipe-D-eDP-1
[501.807382] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[501.809249] Subtest crc-primary-suspend-y-tiled-gen12-mc-ccs: SKIP (0.005s)
[503.955659] [080/133] (530s left) kms_ccs (random-ccs-data-4-tiled-mtl-mc-ccs)
[504.036353] Starting subtest: random-ccs-data-4-tiled-mtl-mc-ccs
[504.037540] Starting dynamic subtest: pipe-A-eDP-1
[505.271098] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.236s)
[505.283434] Starting dynamic subtest: pipe-B-eDP-1
[507.594556] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.321s)
[507.604842] Starting dynamic subtest: pipe-C-eDP-1
[509.927537] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.331s)
[509.938569] Starting dynamic subtest: pipe-D-eDP-1
[512.241296] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.312s)
[512.242827] Subtest random-ccs-data-4-tiled-mtl-mc-ccs: SUCCESS (8.207s)
[513.482237] [081/133] (520s left) sw_sync (sync_multi_timeline_wait)
[513.512710] Starting subtest: sync_multi_timeline_wait
[513.514144] Subtest sync_multi_timeline_wait: SUCCESS (0.000s)
[513.580394] [082/133] (520s left) sysfs_heartbeat_interval (idempotent)
[513.635860] Starting subtest: idempotent
[513.637312] Starting dynamic subtest: vecs0
[513.638646] Dynamic subtest vecs0: SUCCESS (0.001s)
[513.647749] Starting dynamic subtest: ccs0
[513.648976] Dynamic subtest ccs0: SUCCESS (0.001s)
[513.657289] Starting dynamic subtest: vcs0
[513.658603] Dynamic subtest vcs0: SUCCESS (0.000s)
[513.666464] Starting dynamic subtest: bcs0
[513.667733] Dynamic subtest bcs0: SUCCESS (0.001s)
[513.676211] Starting dynamic subtest: rcs0
[513.678067] Dynamic subtest rcs0: SUCCESS (0.001s)
[513.687896] Starting dynamic subtest: vcs1
[513.689189] Dynamic subtest vcs1: SUCCESS (0.000s)
[513.690623] Subtest idempotent: SUCCESS (0.008s)
[513.771260] [083/133] (520s left) syncobj_eventfd (invalid-bad-pad)
[513.828724] Starting subtest: invalid-bad-pad
[513.829735] Subtest invalid-bad-pad: SUCCESS (0.000s)
[513.960487] [084/133] (520s left) kms_busy (extended-pageflip-hang-newfb)
[514.056180] Starting subtest: extended-pageflip-hang-newfb
[514.057370] Starting dynamic subtest: pipe-A
[540.477890] Dynamic subtest pipe-A: SUCCESS (26.421s)
[540.489172] Starting dynamic subtest: pipe-D
[555.511411] Dynamic subtest pipe-D: SUCCESS (15.028s)
[555.512653] Subtest extended-pageflip-hang-newfb: SUCCESS (41.456s)
[556.350625] [085/133] (478s left) kms_psr2_sf (psr2-cursor-plane-update-sf)
[561.429791] Starting subtest: psr2-cursor-plane-update-sf
[561.432146] Starting dynamic subtest: pipe-A-eDP-1
[562.733938] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.303s)
[562.743391] Starting dynamic subtest: pipe-B-eDP-1
[564.079573] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.343s)
[564.080660] Subtest psr2-cursor-plane-update-sf: SUCCESS (2.650s)
[564.963894] [086/133] (469s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-0-async-flip)
[565.070447] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-0-async-flip
[565.807423] Subtest x-tiled-max-hw-stride-32bpp-rotate-0-async-flip: SUCCESS (0.737s)
[565.975501] [087/133] (468s left) gem_exec_balancer (busy)
[566.042494] Starting subtest: busy
[567.710487] Subtest busy: SUCCESS (1.665s)
[568.057788] [088/133] (466s left) kms_frontbuffer_tracking (fbc-2p-primscrn-shrfb-msflip-blt)
[568.160010] Starting subtest: fbc-2p-primscrn-shrfb-msflip-blt
[568.161985] Subtest fbc-2p-primscrn-shrfb-msflip-blt: SKIP (0.000s)
[568.292786] [089/133] (466s left) vgem_slow (nohang)
[568.334175] Starting subtest: nohang
[578.366656] Subtest nohang: SUCCESS (10.031s)
[578.452946] [090/133] (456s left) gem_spin_batch (resubmit-new-all)
[578.531147] Starting subtest: resubmit-new-all
[578.532908] Starting dynamic subtest: rcs0
[578.563834] Dynamic subtest rcs0: SUCCESS (0.032s)
[578.575465] Starting dynamic subtest: bcs0
[578.588778] Dynamic subtest bcs0: SUCCESS (0.023s)
[578.597152] Starting dynamic subtest: vcs0
[578.608391] Dynamic subtest vcs0: SUCCESS (0.019s)
[578.616770] Starting dynamic subtest: vcs1
[578.630735] Dynamic subtest vcs1: SUCCESS (0.022s)
[578.638871] Starting dynamic subtest: vecs0
[578.650489] Dynamic subtest vecs0: SUCCESS (0.019s)
[578.658637] Starting dynamic subtest: ccs0
[578.669755] Dynamic subtest ccs0: SUCCESS (0.019s)
[578.670609] Subtest resubmit-new-all: SUCCESS (0.140s)
[579.741584] [091/133] (455s left) gem_render_copy (mixed-tiled-to-y-tiled-ccs)
[579.806641] Starting subtest: mixed-tiled-to-y-tiled-ccs
[579.809442] Subtest mixed-tiled-to-y-tiled-ccs: SKIP (0.000s)
[580.013573] [092/133] (454s left) syncobj_timeline (invalid-signal-illegal-point)
[580.063004] Starting subtest: invalid-signal-illegal-point
[580.064293] Subtest invalid-signal-illegal-point: SUCCESS (0.000s)
[580.202491] [093/133] (454s left) gem_exec_schedule (preempt-contexts)
[580.273909] Starting subtest: preempt-contexts
[580.275222] Starting dynamic subtest: rcs0
[580.377520] Dynamic subtest rcs0: SUCCESS (0.103s)
[580.386672] Starting dynamic subtest: bcs0
[580.470280] Dynamic subtest bcs0: SUCCESS (0.092s)
[580.478890] Starting dynamic subtest: vcs0
[580.550162] Dynamic subtest vcs0: SUCCESS (0.078s)
[580.558825] Starting dynamic subtest: vcs1
[580.612758] Dynamic subtest vcs1: SUCCESS (0.062s)
[580.621221] Starting dynamic subtest: vecs0
[580.670810] Dynamic subtest vecs0: SUCCESS (0.058s)
[580.679972] Starting dynamic subtest: ccs0
[580.769097] Dynamic subtest ccs0: SUCCESS (0.097s)
[580.770545] Subtest preempt-contexts: SUCCESS (0.496s)
[581.794059] [094/133] (453s left) gem_pwrite_snooped
[581.916373] [095/133] (453s left) kms_tiled_display (basic-test-pattern)
[582.034773] Subtest basic-test-pattern: SKIP (0.000s)
[582.075686] [096/133] (452s left) kms_frontbuffer_tracking (psr-shrfb-scaledprimary)
[582.175743] Starting subtest: psr-shrfb-scaledprimary
[587.894874] Subtest psr-shrfb-scaledprimary: SUCCESS (5.721s)
[588.049178] [097/133] (446s left) kms_frontbuffer_tracking (fbcpsr-1p-shrfb-fliptrack-mmap-gtt)
[588.148815] Starting subtest: fbcpsr-1p-shrfb-fliptrack-mmap-gtt
[588.151010] Subtest fbcpsr-1p-shrfb-fliptrack-mmap-gtt: SKIP (0.000s)
[588.271700] [098/133] (446s left) gem_pwrite (basic-self)
[588.330879] Subtest basic-self: SKIP (0.000s)
[588.402763] [099/133] (446s left) kms_pm_rpm (dpms-mode-unset-non-lpsp)
[589.925483] Starting subtest: dpms-mode-unset-non-lpsp
[591.088955] Subtest dpms-mode-unset-non-lpsp: SKIP (1.162s)
[591.456740] [100/133] (443s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip)
[591.546431] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip
[591.548854] Subtest yf-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip: SKIP (0.000s)
[591.653250] [101/133] (443s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-render)
[591.754917] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-render
[591.756575] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-render: SKIP (0.000s)
[591.885639] [102/133] (443s left) kms_color_pipeline (plane-lut1d-ctm3x4-lut1d)
[591.979325] Starting subtest: plane-lut1d-ctm3x4-lut1d
[591.993156] Starting dynamic subtest: pipe-A-eDP-1
[592.478733] Dynamic subtest pipe-A-eDP-1: FAIL (0.313s)
[593.424751] Starting dynamic subtest: pipe-B-eDP-1
[593.936535] Dynamic subtest pipe-B-eDP-1: FAIL (0.291s)
[594.751710] Starting dynamic subtest: pipe-C-eDP-1
[595.248327] Dynamic subtest pipe-C-eDP-1: FAIL (0.269s)
[596.070446] Starting dynamic subtest: pipe-D-eDP-1
[596.550887] Dynamic subtest pipe-D-eDP-1: FAIL (0.235s)
[596.585898] Subtest plane-lut1d-ctm3x4-lut1d: FAIL (4.608s)
[597.478971] [103/133] (437s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-render)
[597.571570] Starting subtest: psr-1p-primscrn-spr-indfb-draw-render
[604.308718] Subtest psr-1p-primscrn-spr-indfb-draw-render: SUCCESS (6.740s)
[604.474234] [104/133] (430s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-onoff)
[604.572685] Starting subtest: psr-1p-primscrn-cur-indfb-onoff
[611.517045] Subtest psr-1p-primscrn-cur-indfb-onoff: SUCCESS (6.946s)
[611.659226] [105/133] (423s left) gem_exec_schedule (preempt-queue-contexts-chain)
[611.729019] Subtest preempt-queue-contexts-chain: SKIP (0.000s)
[612.041527] [106/133] (423s left) api_intel_bb (object-noreloc-keep-cache-simple)
[612.103861] Starting subtest: object-noreloc-keep-cache-simple
[612.109428] Subtest object-noreloc-keep-cache-simple: SUCCESS (0.008s)
[612.268253] [107/133] (423s left) gem_mmap (bad-object)
[612.330938] Subtest bad-object: SKIP (0.000s)
[612.390670] [108/133] (423s left) kms_flip_scaled_crc (flip-32bpp-yftileccs-to-64bpp-yftile-upscaling)
[612.502373] Starting subtest: flip-32bpp-yftileccs-to-64bpp-yftile-upscaling
[612.505590] Starting dynamic subtest: pipe-A-default-mode
[612.798845] Dynamic subtest pipe-A-default-mode: SKIP (0.292s)
[612.800937] Subtest flip-32bpp-yftileccs-to-64bpp-yftile-upscaling: SKIP (0.295s)
[613.677349] [109/133] (421s left) kms_addfb_basic (bo-too-small-due-to-tiling)
[613.773477] Starting subtest: bo-too-small-due-to-tiling
[613.776061] Subtest bo-too-small-due-to-tiling: SKIP (0.000s)
[613.909263] [110/133] (421s left) kms_psr (pr-sprite-blt)
[614.011981] Starting subtest: pr-sprite-blt
[614.014285] Subtest pr-sprite-blt: SKIP (0.000s)
[614.103811] [111/133] (421s left) kms_draw_crc (fill-fb)
[614.196970] Starting subtest: fill-fb
[614.695882] Subtest fill-fb: SUCCESS (0.499s)
[614.840353] [112/133] (420s left) perf_pmu (busy-idle)
[614.883012] Starting subtest: busy-idle
[614.884186] Starting dynamic subtest: rcs0
[615.596656] Dynamic subtest rcs0: SUCCESS (0.713s)
[615.610469] Starting dynamic subtest: bcs0
[616.271158] Dynamic subtest bcs0: SUCCESS (0.672s)
[616.283624] Starting dynamic subtest: vcs0
[617.698858] Dynamic subtest vcs0: SUCCESS (1.424s)
[617.710164] Starting dynamic subtest: vcs1
[619.681583] Dynamic subtest vcs1: SUCCESS (1.979s)
[619.693453] Starting dynamic subtest: vecs0
[621.666530] Dynamic subtest vecs0: SUCCESS (1.981s)
[621.678774] Starting dynamic subtest: ccs0
[622.344994] Dynamic subtest ccs0: SUCCESS (0.678s)
[622.346549] Subtest busy-idle: SUCCESS (7.463s)
[622.475138] [113/133] (413s left) kms_ccs (crc-sprite-planes-basic-4-tiled-dg2-mc-ccs)
[622.578894] Starting subtest: crc-sprite-planes-basic-4-tiled-dg2-mc-ccs
[622.579895] Starting dynamic subtest: pipe-A-eDP-1
[622.603784] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[622.613524] Starting dynamic subtest: pipe-B-eDP-1
[622.639314] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[622.648060] Starting dynamic subtest: pipe-C-eDP-1
[622.671684] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[622.679524] Starting dynamic subtest: pipe-D-eDP-1
[622.701659] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[622.703455] Subtest crc-sprite-planes-basic-4-tiled-dg2-mc-ccs: SKIP (0.009s)
[624.818408] [114/133] (410s left) gem_exec_flush (basic-batch-kernel-default-uc)
[624.868848] Starting subtest: basic-batch-kernel-default-uc
[632.543486] Subtest basic-batch-kernel-default-uc: SUCCESS (7.675s)
[632.755008] [115/133] (402s left) gem_mmap_wc (write-read-distinct)
[632.816538] Subtest write-read-distinct: SKIP (0.000s)
[632.893145] [116/133] (402s left) kms_plane_lowres (tiling-x)
[632.990926] Starting subtest: tiling-x
[632.991953] Starting dynamic subtest: pipe-A-eDP-1
[632.993873] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[633.285065] Starting dynamic subtest: pipe-B-eDP-1
[633.291426] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[633.299819] Starting dynamic subtest: pipe-C-eDP-1
[633.302082] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[633.310882] Starting dynamic subtest: pipe-D-eDP-1
[633.313438] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[633.315456] Subtest tiling-x: SKIP (0.292s)
[634.152545] [117/133] (401s left) sw_sync (alloc_merge_fence)
[634.182913] Starting subtest: alloc_merge_fence
[634.184457] Subtest alloc_merge_fence: SUCCESS (0.000s)
[634.250591] [118/133] (401s left) kms_pm_backlight (fade)
[634.335867] Starting subtest: fade
[634.389736] Starting dynamic subtest: eDP-1
[637.069754] Dynamic subtest eDP-1: SUCCESS (2.680s)
[637.070919] Subtest fade: SUCCESS (2.734s)
[637.894093] [119/133] (397s left) kms_flip_scaled_crc (flip-64bpp-xtile-to-32bpp-xtile-downscaling)
[637.974562] Starting subtest: flip-64bpp-xtile-to-32bpp-xtile-downscaling
[637.975524] Starting dynamic subtest: pipe-A-default-mode
[639.148531] Dynamic subtest pipe-A-default-mode: SKIP (1.171s)
[639.150824] Subtest flip-64bpp-xtile-to-32bpp-xtile-downscaling: SKIP (1.173s)
[639.323925] [120/133] (396s left) syncobj_wait (multi-wait-all-for-submit-unsubmitted-signaled)
[639.379512] Starting subtest: multi-wait-all-for-submit-unsubmitted-signaled
[639.485461] Subtest multi-wait-all-for-submit-unsubmitted-signaled: SUCCESS (0.104s)
[639.579315] [121/133] (396s left) kms_psr (psr-cursor-mmap-cpu)
[639.677724] Starting subtest: psr-cursor-mmap-cpu
[639.678745] Starting dynamic subtest: eDP-1
[641.406466] Dynamic subtest eDP-1: SUCCESS (1.728s)
[641.407609] Subtest psr-cursor-mmap-cpu: SUCCESS (1.729s)
[642.294627] [122/133] (393s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-180-async-flip)
[642.402291] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-180-async-flip
[643.117153] Subtest 4-tiled-max-hw-stride-32bpp-rotate-180-async-flip: SUCCESS (0.715s)
[643.301948] [123/133] (392s left) gem_exec_whisper (basic-queues-priority-all)
[643.369286] Starting subtest: basic-queues-priority-all
[667.008203] Subtest basic-queues-priority-all: SUCCESS (23.638s)
[667.209710] [124/133] (368s left) syncobj_timeline (etime-single-wait-all-submitted)
[667.262733] Starting subtest: etime-single-wait-all-submitted
[667.373348] Subtest etime-single-wait-all-submitted: SUCCESS (0.108s)
[667.472421] [125/133] (368s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-onoff)
[667.569753] Starting subtest: fbc-2p-primscrn-spr-indfb-onoff
[667.571789] Subtest fbc-2p-primscrn-spr-indfb-onoff: SKIP (0.000s)
[667.698936] [126/133] (368s left) kms_async_flips (async-flip-dpms)
[667.785906] Starting subtest: async-flip-dpms
[668.146533] Starting dynamic subtest: pipe-A-eDP-1
[671.983896] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.838s)
[672.375860] Starting dynamic subtest: pipe-B-eDP-1
[675.166716] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.800s)
[675.565837] Starting dynamic subtest: pipe-C-eDP-1
[678.337575] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.779s)
[678.725847] Starting dynamic subtest: pipe-D-eDP-1
[681.512836] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.795s)
[681.514179] Subtest async-flip-dpms: SUCCESS (13.729s)
[682.711500] [127/133] (353s left) gem_exec_reloc (basic-cpu-read-noreloc)
[682.775038] Subtest basic-cpu-read-noreloc: SKIP (0.000s)
[682.841664] [128/133] (353s left) syncobj_wait (invalid-reset-illegal-handle)
[682.890916] Starting subtest: invalid-reset-illegal-handle
[682.892567] Subtest invalid-reset-illegal-handle: SUCCESS (0.000s)
[683.007964] [129/133] (353s left) syncobj_wait (multi-wait-all-for-submit-unsubmitted-submitted)
[683.054828] Starting subtest: multi-wait-all-for-submit-unsubmitted-submitted
[683.156012] Subtest multi-wait-all-for-submit-unsubmitted-submitted: SUCCESS (0.101s)
[683.250117] [130/133] (352s left) gem_tiled_swapping (non-threaded)
[683.295854] Subtest non-threaded: SKIP (0.000s)
[683.356087] [131/133] (352s left) gem_exec_fence (syncobj-timeline-chain-engines)
[683.903986] Starting subtest: syncobj-timeline-chain-engines
[684.050681] Subtest syncobj-timeline-chain-engines: SUCCESS (0.147s)
[685.796042] [132/133] (350s left) kms_cursor_legacy (flip-vs-cursor-legacy)
[685.923536] Starting subtest: flip-vs-cursor-legacy
[693.045790] Subtest flip-vs-cursor-legacy: SUCCESS (7.123s)
[693.941045] [133/133] (342s left) syncobj_basic (illegal-fd-to-handle)
[693.990708] Starting subtest: illegal-fd-to-handle
[693.991839] Subtest illegal-fd-to-handle: SUCCESS (0.000s)
[694.115691] 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.