[59.599370] Initializing watchdogs
[59.599419]   /dev/watchdog0
[59.617120] [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.621651] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[59.623930] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[59.627181] [001/133] (960s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-mmap-gtt)
[59.757419] Starting subtest: psr-2p-primscrn-spr-indfb-draw-mmap-gtt
[59.761510] Subtest psr-2p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[59.883182] [002/133] (960s left) gem_exec_suspend (basic-s3-devices)
[59.947070] Starting subtest: basic-S3-devices
[59.949323] Starting dynamic subtest: smem
[71.893919] Dynamic subtest smem: SUCCESS (11.961s)
[71.896947] Subtest basic-S3-devices: SUCCESS (11.962s)
[76.167706] [003/133] (948s left) gem_render_copy (y-tiled-ccs-to-yf-tiled)
[76.254511] Starting subtest: y-tiled-ccs-to-yf-tiled
[76.259316] Subtest y-tiled-ccs-to-yf-tiled: SKIP (0.000s)
[76.465570] [004/133] (947s left) kms_ccs (ccs-on-another-bo-y-tiled-gen12-mc-ccs)
[76.571873] Starting subtest: ccs-on-another-bo-y-tiled-gen12-mc-ccs
[76.574266] Starting dynamic subtest: pipe-A-eDP-1
[76.596816] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[76.606133] Starting dynamic subtest: pipe-B-eDP-1
[76.627567] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[76.635297] Starting dynamic subtest: pipe-C-eDP-1
[76.656739] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[76.664662] Starting dynamic subtest: pipe-D-eDP-1
[76.686605] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[76.690673] Subtest ccs-on-another-bo-y-tiled-gen12-mc-ccs: SKIP (0.003s)
[78.900920] [005/133] (945s left) kms_flip (bo-too-big)
[78.992070] Starting subtest: bo-too-big
[78.994357] Starting dynamic subtest: A-eDP1
[80.328126] Dynamic subtest A-eDP1: SUCCESS (1.335s)
[80.338252] Starting dynamic subtest: B-eDP1
[81.938311] Dynamic subtest B-eDP1: SUCCESS (1.609s)
[81.947777] Starting dynamic subtest: C-eDP1
[83.202820] Dynamic subtest C-eDP1: SUCCESS (1.263s)
[83.213555] Starting dynamic subtest: D-eDP1
[84.532704] Dynamic subtest D-eDP1: SUCCESS (1.329s)
[84.535093] Subtest bo-too-big: SUCCESS (5.542s)
[85.754129] [006/133] (938s left) syncobj_timeline (multi-wait-available-unsubmitted-signaled)
[85.823860] Starting subtest: multi-wait-available-unsubmitted-signaled
[85.826091] Subtest multi-wait-available-unsubmitted-signaled: SUCCESS (0.001s)
[85.944667] [007/133] (938s left) kms_lease (lease-uevent)
[86.036740] Starting subtest: lease-uevent
[87.050443] Subtest lease-uevent: SUCCESS (1.014s)
[87.152962] [008/133] (937s left) gem_exec_fence (syncobj-timeline-wait)
[87.742129] Starting subtest: syncobj-timeline-wait
[88.962353] Subtest syncobj-timeline-wait: SUCCESS (1.220s)
[91.022473] [FACT gem_exec_fence (syncobj-timeline-wait)] new: kernel.kmod_is_loaded.vgem: true
[91.026108] [009/133] (933s left) kms_chamelium_color (gamma)
[91.130212] Subtest gamma: SKIP (0.000s)
[91.175213] [010/133] (933s left) prime_mmap (test_errors)
[91.229809] Starting subtest: test_errors
[91.232045] Starting dynamic subtest: test_errors-smem
[91.322613] Dynamic subtest test_errors-smem: SUCCESS (0.094s)
[91.325090] Subtest test_errors: SUCCESS (0.095s)
[91.449167] [011/133] (933s left) i915_drm_fdinfo (idle)
[91.488412] Starting subtest: idle
[91.490716] Starting dynamic subtest: rcs0
[92.071464] Dynamic subtest rcs0: SUCCESS (0.584s)
[92.080791] Starting dynamic subtest: bcs0
[92.578057] Dynamic subtest bcs0: SUCCESS (0.504s)
[92.586967] Starting dynamic subtest: vcs0
[93.083249] Dynamic subtest vcs0: SUCCESS (0.504s)
[93.093903] Starting dynamic subtest: vcs1
[93.589362] Dynamic subtest vcs1: SUCCESS (0.504s)
[93.600497] Starting dynamic subtest: vecs0
[94.094316] Dynamic subtest vecs0: SUCCESS (0.504s)
[94.105605] Starting dynamic subtest: ccs0
[94.598968] Dynamic subtest ccs0: SUCCESS (0.504s)
[94.601552] Subtest idle: SUCCESS (3.112s)
[94.700635] [012/133] (929s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-mmap-cpu)
[94.798168] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-mmap-cpu
[94.802178] Subtest fbc-2p-scndscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[94.933503] [013/133] (929s left) kms_invalid_mode (zero-hdisplay)
[95.026013] Starting subtest: zero-hdisplay
[95.028182] Starting dynamic subtest: pipe-A-eDP-1
[95.308204] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.283s)
[95.319074] Starting dynamic subtest: pipe-B-eDP-1
[95.321181] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[95.328425] Starting dynamic subtest: pipe-C-eDP-1
[95.330738] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[95.338630] Starting dynamic subtest: pipe-D-eDP-1
[95.340939] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[95.343332] Subtest zero-hdisplay: SUCCESS (0.287s)
[96.194779] [014/133] (928s left) kms_plane_scaling (planes-downscale-factor-0-75-unity-scaling)
[96.298667] Starting subtest: planes-downscale-factor-0-75-unity-scaling
[96.300984] Starting dynamic subtest: pipe-A
[96.363185] Dynamic subtest pipe-A: SUCCESS (0.067s)
[96.373638] Starting dynamic subtest: pipe-B
[97.494284] Dynamic subtest pipe-B: SUCCESS (1.130s)
[97.505956] Starting dynamic subtest: pipe-C
[98.601816] Dynamic subtest pipe-C: SUCCESS (1.107s)
[98.611436] Starting dynamic subtest: pipe-D
[99.744192] Dynamic subtest pipe-D: SUCCESS (1.142s)
[99.746705] Subtest planes-downscale-factor-0-75-unity-scaling: SUCCESS (3.448s)
[100.916560] [015/133] (923s left) drm_read (fault-buffer)
[101.055621] Starting subtest: fault-buffer
[101.058356] Subtest fault-buffer: SUCCESS (0.000s)
[101.241204] [016/133] (923s left) gem_ccs (suspend-resume)
[101.307622] Starting subtest: suspend-resume
[101.312040] Subtest suspend-resume: SKIP (0.000s)
[101.431055] [017/133] (923s left) kms_ccs (bad-rotation-90-4-tiled-dg2-rc-ccs)
[101.519110] Starting subtest: bad-rotation-90-4-tiled-dg2-rc-ccs
[101.521567] Starting dynamic subtest: pipe-A-eDP-1
[101.543903] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[101.554258] Starting dynamic subtest: pipe-B-eDP-1
[101.574546] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[101.582452] Starting dynamic subtest: pipe-C-eDP-1
[101.603257] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[101.610795] Starting dynamic subtest: pipe-D-eDP-1
[101.633846] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[101.638352] Subtest bad-rotation-90-4-tiled-dg2-rc-ccs: SKIP (0.003s)
[103.686817] [018/133] (921s left) gem_close (many-handles-one-vma)
[103.739838] Starting subtest: many-handles-one-vma
[103.763814] Subtest many-handles-one-vma: SUCCESS (0.025s)
[103.904696] [019/133] (921s left) gem_busy (extended)
[104.089656] Starting subtest: extended
[104.092062] Starting dynamic subtest: rcs0
[104.199400] Dynamic subtest rcs0: SUCCESS (0.110s)
[104.209404] Starting dynamic subtest: bcs0
[104.246172] Dynamic subtest bcs0: SUCCESS (0.043s)
[104.254162] Starting dynamic subtest: vcs0
[105.877922] Dynamic subtest vcs0: SUCCESS (1.632s)
[105.887071] Starting dynamic subtest: vcs1
[107.926034] Dynamic subtest vcs1: SUCCESS (2.047s)
[107.937244] Starting dynamic subtest: vecs0
[109.961059] Dynamic subtest vecs0: SUCCESS (1.982s)
[109.971449] Starting dynamic subtest: ccs0
[109.973461] Dynamic subtest ccs0: SUCCESS (0.047s)
[109.975474] Subtest extended: SUCCESS (5.867s)
[110.220577] [020/133] (914s left) kms_vblank (ts-continuation-suspend)
[110.324819] Starting subtest: ts-continuation-suspend
[110.326786] Starting dynamic subtest: pipe-A-eDP-1
[126.889548] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.943s)
[126.903813] Starting dynamic subtest: pipe-D-eDP-1
[144.904748] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.575s)
[144.907096] Subtest ts-continuation-suspend: SUCCESS (4.521s)
[156.800679] [021/133] (879s left) perf_pmu (semaphore-wait-idle)
[156.854331] Starting subtest: semaphore-wait-idle
[156.856714] Starting dynamic subtest: rcs0
[157.375837] Dynamic subtest rcs0: SUCCESS (0.520s)
[157.385958] Starting dynamic subtest: bcs0
[157.891431] Dynamic subtest bcs0: SUCCESS (0.517s)
[157.901068] Starting dynamic subtest: vcs0
[158.404250] Dynamic subtest vcs0: SUCCESS (0.519s)
[158.414602] Starting dynamic subtest: vcs1
[158.918508] Dynamic subtest vcs1: SUCCESS (0.520s)
[158.928363] Starting dynamic subtest: vecs0
[159.443656] Dynamic subtest vecs0: SUCCESS (0.518s)
[159.453454] Starting dynamic subtest: ccs0
[159.943738] Dynamic subtest ccs0: SUCCESS (0.518s)
[159.946103] Subtest semaphore-wait-idle: SUCCESS (3.121s)
[161.097457] [022/133] (875s left) kms_debugfs (display-off-read-all)
[161.204133] Starting subtest: display-off-read-all
[161.498994] Subtest display-off-read-all: SUCCESS (0.300s)
[162.305677] [023/133] (873s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-blt)
[162.406538] Starting subtest: fbc-rgb101010-draw-blt
[166.997638] Subtest fbc-rgb101010-draw-blt: SUCCESS (4.627s)
[168.196561] [024/133] (868s left) gem_ctx_param (invalid-get-no-zeromap)
[168.260150] Starting subtest: invalid-get-no-zeromap
[168.262542] Subtest invalid-get-no-zeromap: SUCCESS (0.001s)
[168.395781] [025/133] (867s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-mmap-gtt)
[168.501084] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-mmap-gtt
[168.505517] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[168.618991] [026/133] (867s left) gem_exec_big (single)
[168.679071] Starting subtest: single
[171.000921] Subtest single: SUCCESS (2.328s)
[171.256070] [027/133] (865s left) kms_frontbuffer_tracking (psr-rgb101010-draw-mmap-gtt)
[171.419912] Starting subtest: psr-rgb101010-draw-mmap-gtt
[171.424034] Subtest psr-rgb101010-draw-mmap-gtt: SKIP (0.000s)
[171.556574] [028/133] (864s left) gem_exec_flush (basic-uc-prw-default)
[171.630819] Starting subtest: basic-uc-prw-default
[177.106822] Subtest basic-uc-prw-default: SUCCESS (5.459s)
[177.290961] [029/133] (859s left) kms_frontbuffer_tracking (fbc-1p-shrfb-fliptrack-mmap-gtt)
[177.389939] Starting subtest: fbc-1p-shrfb-fliptrack-mmap-gtt
[177.394433] Subtest fbc-1p-shrfb-fliptrack-mmap-gtt: SKIP (0.000s)
[177.524886] [030/133] (858s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-shrfb-draw-render)
[177.620343] Starting subtest: psr-1p-offscreen-pri-shrfb-draw-render
[184.542644] Subtest psr-1p-offscreen-pri-shrfb-draw-render: SUCCESS (6.936s)
[184.700124] [031/133] (851s left) gem_exec_create (forked)
[184.771799] Starting subtest: forked
[184.774190] Starting dynamic subtest: smem
[205.955410] Dynamic subtest smem: SUCCESS (21.195s)
[205.958281] Subtest forked: SUCCESS (21.196s)
[206.166367] [032/133] (830s left) kms_feature_discovery (display-1x)
[206.267010] Starting subtest: display-1x
[206.269334] Subtest display-1x: SUCCESS (0.000s)
[206.366531] [033/133] (830s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-wc)
[206.462611] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-wc
[206.466888] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[206.603321] [034/133] (830s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-move)
[206.689603] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-move
[206.693735] Subtest fbcpsr-2p-primscrn-cur-indfb-move: SKIP (0.000s)
[206.797885] [035/133] (829s left) gem_render_copy_redux (interruptible)
[206.855678] Starting subtest: interruptible
[207.134050] Subtest interruptible: SUCCESS (0.279s)
[207.286011] [036/133] (829s left) i915_pm_rpm (system-suspend-execbuf)
[209.145111] Starting subtest: system-suspend-execbuf
[267.166953] Subtest system-suspend-execbuf: SUCCESS (43.158s)
[267.576495] [037/133] (769s left) kms_frontbuffer_tracking (psr-2p-scndscrn-indfb-plflip-blt)
[267.676988] Starting subtest: psr-2p-scndscrn-indfb-plflip-blt
[267.681441] Subtest psr-2p-scndscrn-indfb-plflip-blt: SKIP (0.000s)
[267.813424] [038/133] (769s left) gem_request_retire (retire-vma-not-inactive)
[267.869567] Starting subtest: retire-vma-not-inactive
[267.929038] Subtest retire-vma-not-inactive: SUCCESS (0.057s)
[268.090238] [039/133] (768s left) i915_pm_rps (thresholds-idle)
[268.157717] Starting subtest: thresholds-idle
[268.162012] Subtest thresholds-idle: SKIP (0.000s)
[268.295338] [040/133] (768s left) gem_ctx_persistence (legacy-engines-queued)
[268.369316] Starting subtest: legacy-engines-queued
[268.371825] Starting dynamic subtest: render
[268.472249] Dynamic subtest render: SUCCESS (0.102s)
[268.484260] Starting dynamic subtest: bsd1
[269.934941] Dynamic subtest bsd1: SUCCESS (1.459s)
[269.946664] Starting dynamic subtest: bsd2
[271.917139] Dynamic subtest bsd2: SUCCESS (1.979s)
[271.936135] Starting dynamic subtest: blt
[271.957831] Dynamic subtest blt: SUCCESS (0.040s)
[271.966718] Starting dynamic subtest: vebox
[273.901021] Dynamic subtest vebox: SUCCESS (1.940s)
[273.904290] Subtest legacy-engines-queued: SUCCESS (5.530s)
[274.004305] [041/133] (762s left) i915_hangman (gt-error-state-capture)
[274.101502] Starting subtest: gt-error-state-capture
[274.103984] Starting dynamic subtest: rcs0
[285.936134] Dynamic subtest rcs0: SUCCESS (11.834s)
[285.949463] Starting dynamic subtest: bcs0
[296.940994] Dynamic subtest bcs0: SUCCESS (11.006s)
[296.953368] Starting dynamic subtest: vcs0
[307.885731] Dynamic subtest vcs0: SUCCESS (10.946s)
[307.898954] Starting dynamic subtest: vcs1
[319.853159] Dynamic subtest vcs1: SUCCESS (11.970s)
[319.866495] Starting dynamic subtest: vecs0
[329.901113] Dynamic subtest vecs0: SUCCESS (10.050s)
[329.913189] Starting dynamic subtest: ccs0
[341.933507] Dynamic subtest ccs0: SUCCESS (12.024s)
[341.936213] Subtest gt-error-state-capture: SUCCESS (67.841s)
[342.089781] [042/133] (694s left) kms_cursor_crc (cursor-rapid-movement-128x42)
[342.321309] Starting subtest: cursor-rapid-movement-128x42
[342.370494] Subtest cursor-rapid-movement-128x42: SKIP (0.043s)
[342.616045] [043/133] (694s left) gem_partial_pwrite_pread (writes-after-reads-uncached)
[342.677953] Subtest writes-after-reads-uncached: SKIP (0.000s)
[342.740856] [044/133] (694s left) gem_mmap_wc (coherency)
[342.800680] Subtest coherency: SKIP (0.000s)
[342.867211] [045/133] (694s left) syncobj_timeline (single-wait-all-for-submit-signaled)
[342.940624] Starting subtest: single-wait-all-for-submit-signaled
[342.942988] Subtest single-wait-all-for-submit-signaled: SUCCESS (0.000s)
[343.059167] [046/133] (694s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-render)
[343.160191] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-render
[346.861719] Subtest fbc-1p-primscrn-cur-indfb-draw-render: SUCCESS (3.705s)
[348.032477] [047/133] (689s left) kms_psr (fbc-psr-primary-mmap-cpu)
[348.124337] Starting subtest: fbc-psr-primary-mmap-cpu
[348.126692] Starting dynamic subtest: eDP-1
[348.130898] Dynamic subtest eDP-1: SKIP (0.000s)
[348.135140] Subtest fbc-psr-primary-mmap-cpu: SKIP (0.001s)
[348.221247] [048/133] (689s left) kms_invalid_mode (bad-vsync-start)
[348.327241] Starting subtest: bad-vsync-start
[348.329413] Starting dynamic subtest: pipe-A-eDP-1
[348.623538] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.297s)
[348.634257] Starting dynamic subtest: pipe-B-eDP-1
[348.636466] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[348.645843] Starting dynamic subtest: pipe-C-eDP-1
[348.648204] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[348.657433] Starting dynamic subtest: pipe-D-eDP-1
[348.659586] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[348.661735] Subtest bad-vsync-start: SUCCESS (0.302s)
[349.453945] [049/133] (687s left) gem_exec_reloc (basic-wc-gtt)
[349.522940] Subtest basic-wc-gtt: SKIP (0.000s)
[349.617643] [050/133] (687s left) gem_mmap_gtt (cpuset-medium-copy-xy)
[349.682424] Subtest cpuset-medium-copy-XY: SKIP (0.000s)
[349.759661] [051/133] (687s left) kms_prop_blob (blob-multiple)
[349.820801] Starting subtest: blob-multiple
[349.823176] Subtest blob-multiple: SUCCESS (0.002s)
[349.949428] [052/133] (687s left) api_intel_allocator (open-vm)
[350.014574] Starting subtest: open-vm
[350.016970] Subtest open-vm: SUCCESS (0.003s)
[350.178698] [053/133] (687s left) kms_getfb (getfb-repeated-different-handles)
[350.282926] Starting subtest: getfb-repeated-different-handles
[350.285060] Subtest getfb-repeated-different-handles: SUCCESS (0.000s)
[350.417095] [054/133] (687s left) kms_content_protection (legacy-hdcp14)
[350.570816] Starting subtest: legacy-hdcp14
[350.574504] Subtest legacy-hdcp14: SKIP (0.000s)
[350.731241] [055/133] (686s left) kms_chamelium_hpd (hdmi-hpd-after-suspend)
[351.124814] Subtest hdmi-hpd-after-suspend: SKIP (0.000s)
[351.944565] [056/133] (685s left) kms_flip (blocking-absolute-wf_vblank)
[352.045404] Starting subtest: blocking-absolute-wf_vblank
[352.047602] Starting dynamic subtest: A-eDP1
[360.841284] Dynamic subtest A-eDP1: SUCCESS (8.760s)
[360.852101] Starting dynamic subtest: B-eDP1
[369.541209] Dynamic subtest B-eDP1: SUCCESS (8.733s)
[369.552553] Starting dynamic subtest: C-eDP1
[378.296926] Dynamic subtest C-eDP1: SUCCESS (8.710s)
[378.308264] Starting dynamic subtest: D-eDP1
[387.027142] Dynamic subtest D-eDP1: SUCCESS (8.726s)
[387.029793] Subtest blocking-absolute-wf_vblank: SUCCESS (34.938s)
[388.230843] [057/133] (649s left) gem_mmap_offset (bad-object)
[388.288418] Starting subtest: bad-object
[388.290615] Subtest bad-object: SUCCESS (0.001s)
[388.402690] [058/133] (649s left) kms_psr (psr2-no-drrs)
[388.502030] Starting subtest: psr2-no-drrs
[388.504270] Starting dynamic subtest: eDP-1
[390.060680] Dynamic subtest eDP-1: SUCCESS (1.558s)
[390.063203] Subtest psr2-no-drrs: SUCCESS (1.559s)
[390.882817] [059/133] (646s left) gem_fenced_exec_thrash (no-spare-fences-interruptible)
[390.957515] Subtest no-spare-fences-interruptible: SKIP (0.000s)
[391.043158] [060/133] (646s left) kms_vblank (wait-idle)
[391.142494] Starting subtest: wait-idle
[391.144798] Starting dynamic subtest: pipe-A-eDP-1
[392.896505] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.753s)
[392.911837] Starting dynamic subtest: pipe-D-eDP-1
[395.310979] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.413s)
[395.312893] Subtest wait-idle: SUCCESS (4.169s)
[396.156702] [061/133] (641s left) gem_exec_whisper (basic-contexts-all)
[396.224592] Starting subtest: basic-contexts-all
[407.207846] Subtest basic-contexts-all: SUCCESS (10.984s)
[407.424020] [062/133] (630s left) kms_big_fb (x-tiled-16bpp-rotate-0)
[407.553271] Starting subtest: x-tiled-16bpp-rotate-0
[408.910982] Subtest x-tiled-16bpp-rotate-0: SUCCESS (1.358s)
[409.086749] [063/133] (628s left) kms_atomic (plane-primary-overlay-mutable-zpos)
[409.182371] Starting subtest: plane-primary-overlay-mutable-zpos
[412.680302] Subtest plane-primary-overlay-mutable-zpos: SKIP (3.497s)
[413.898524] [064/133] (624s left) gen9_exec_parse (bb-start-cmd)
[413.969082] Subtest bb-start-cmd: SKIP (0.000s)
[414.039265] [065/133] (623s left) kms_cursor_crc (cursor-alpha-opaque)
[414.138187] Starting subtest: cursor-alpha-opaque
[414.140444] Starting dynamic subtest: pipe-A-eDP-1
[414.755205] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.618s)
[414.766310] Starting dynamic subtest: pipe-D-eDP-1
[416.047115] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.291s)
[416.049478] Subtest cursor-alpha-opaque: SUCCESS (1.911s)
[416.874086] [066/133] (621s left) kms_cursor_crc (cursor-sliding-64x64)
[417.054182] Starting subtest: cursor-sliding-64x64
[417.058864] Starting dynamic subtest: pipe-A-eDP-1
[420.286391] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.227s)
[420.318813] Starting dynamic subtest: pipe-D-eDP-1
[424.146936] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.838s)
[424.149422] Subtest cursor-sliding-64x64: SUCCESS (7.094s)
[425.048005] [067/133] (613s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-render)
[425.157148] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-render
[431.933265] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-render: SUCCESS (6.783s)
[432.072335] [068/133] (606s left) gem_ctx_shared (exec-single-timeline)
[432.142099] Starting subtest: exec-single-timeline
[432.144512] Starting dynamic subtest: rcs0
[433.195972] Dynamic subtest rcs0: SUCCESS (1.051s)
[433.209120] Starting dynamic subtest: bcs0
[434.309966] Dynamic subtest bcs0: SUCCESS (1.085s)
[434.324221] Starting dynamic subtest: vcs0
[435.372880] Dynamic subtest vcs0: SUCCESS (1.087s)
[435.386389] Starting dynamic subtest: vcs1
[436.460446] Dynamic subtest vcs1: SUCCESS (1.085s)
[436.473155] Starting dynamic subtest: vecs0
[437.548969] Dynamic subtest vecs0: SUCCESS (1.085s)
[437.561783] Starting dynamic subtest: ccs0
[438.639017] Dynamic subtest ccs0: SUCCESS (1.088s)
[438.641861] Subtest exec-single-timeline: SUCCESS (6.498s)
[438.858761] [069/133] (599s left) kms_plane_scaling (plane-downscale-factor-0-75-with-pixel-format)
[438.959075] Starting subtest: plane-downscale-factor-0-75-with-pixel-format
[438.961340] Starting dynamic subtest: pipe-A
[440.197722] Dynamic subtest pipe-A: SUCCESS (1.241s)
[440.210175] Starting dynamic subtest: pipe-B
[442.511293] Dynamic subtest pipe-B: SUCCESS (2.312s)
[442.520650] Starting dynamic subtest: pipe-C
[443.662742] Dynamic subtest pipe-C: SUCCESS (1.151s)
[443.672985] Starting dynamic subtest: pipe-D
[444.909519] Dynamic subtest pipe-D: SUCCESS (1.246s)
[444.911782] Subtest plane-downscale-factor-0-75-with-pixel-format: SUCCESS (5.954s)
[446.115098] [070/133] (592s left) gem_wait (write-busy)
[446.193734] Starting subtest: write-busy
[446.195924] Starting dynamic subtest: all-engines
[446.832424] Dynamic subtest all-engines: SUCCESS (0.638s)
[446.850437] Starting dynamic subtest: rcs0
[447.390043] Dynamic subtest rcs0: SUCCESS (0.556s)
[447.408500] Starting dynamic subtest: bcs0
[447.941280] Dynamic subtest bcs0: SUCCESS (0.550s)
[447.959198] Starting dynamic subtest: vcs0
[449.934491] Dynamic subtest vcs0: SUCCESS (1.991s)
[449.951782] Starting dynamic subtest: vcs1
[451.918799] Dynamic subtest vcs1: SUCCESS (1.981s)
[451.935161] Starting dynamic subtest: vecs0
[453.966724] Dynamic subtest vecs0: SUCCESS (2.045s)
[453.983098] Starting dynamic subtest: ccs0
[454.516591] Dynamic subtest ccs0: SUCCESS (0.549s)
[454.518966] Subtest write-busy: SUCCESS (8.326s)
[454.738548] [071/133] (583s left) kms_big_fb (y-tiled-8bpp-rotate-0)
[454.846782] Starting subtest: y-tiled-8bpp-rotate-0
[454.851065] Subtest y-tiled-8bpp-rotate-0: SKIP (0.000s)
[454.985149] [072/133] (583s left) kms_cursor_legacy (basic-busy-flip-before-cursor-legacy)
[455.106756] Starting subtest: basic-busy-flip-before-cursor-legacy
[455.111272] Subtest basic-busy-flip-before-cursor-legacy: SKIP (0.000s)
[455.281247] [073/133] (583s left) gem_basic (bad-close)
[455.342495] Starting subtest: bad-close
[455.347060] Subtest bad-close: SUCCESS (0.000s)
[455.480238] [074/133] (582s left) kms_big_fb (linear-16bpp-rotate-0)
[455.593178] Starting subtest: linear-16bpp-rotate-0
[457.017190] Subtest linear-16bpp-rotate-0: SUCCESS (1.424s)
[457.198020] [075/133] (581s left) kms_psr2_sf (pr-overlay-plane-update-continuous-sf)
[462.177110] Starting subtest: pr-overlay-plane-update-continuous-sf
[462.181896] Subtest pr-overlay-plane-update-continuous-sf: SKIP (0.002s)
[463.050102] [076/133] (575s left) drm_read (short-buffer-wakeup)
[463.207605] Starting subtest: short-buffer-wakeup
[495.430570] Subtest short-buffer-wakeup: SUCCESS (32.215s)
[495.616814] [077/133] (542s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-pwrite)
[495.730955] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-pwrite
[502.828322] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-pwrite: SUCCESS (7.100s)
[503.017493] [078/133] (535s left) kms_psr (fbc-pr-cursor-render)
[503.123198] Starting subtest: fbc-pr-cursor-render
[503.127416] Subtest fbc-pr-cursor-render: SKIP (0.000s)
[503.230860] [079/133] (535s left) kms_ccs (crc-primary-suspend-y-tiled-gen12-mc-ccs)
[503.335611] Starting subtest: crc-primary-suspend-y-tiled-gen12-mc-ccs
[503.337839] Starting dynamic subtest: pipe-A-eDP-1
[503.346828] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[503.357921] Starting dynamic subtest: pipe-B-eDP-1
[503.366893] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[503.376715] Starting dynamic subtest: pipe-C-eDP-1
[503.384936] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[503.393959] Starting dynamic subtest: pipe-D-eDP-1
[503.402252] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[503.406242] Subtest crc-primary-suspend-y-tiled-gen12-mc-ccs: SKIP (0.005s)
[505.595334] [080/133] (533s left) kms_ccs (random-ccs-data-4-tiled-mtl-mc-ccs)
[505.696073] Starting subtest: random-ccs-data-4-tiled-mtl-mc-ccs
[505.698267] Starting dynamic subtest: pipe-A-eDP-1
[506.969512] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.275s)
[506.979658] Starting dynamic subtest: pipe-B-eDP-1
[509.324010] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.353s)
[509.334433] Starting dynamic subtest: pipe-C-eDP-1
[511.657741] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.332s)
[511.668378] Starting dynamic subtest: pipe-D-eDP-1
[513.981041] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.322s)
[513.983394] Subtest random-ccs-data-4-tiled-mtl-mc-ccs: SUCCESS (8.287s)
[515.211443] [081/133] (523s left) sw_sync (sync_multi_timeline_wait)
[515.252234] Starting subtest: sync_multi_timeline_wait
[515.254459] Subtest sync_multi_timeline_wait: SUCCESS (0.000s)
[515.337287] [082/133] (523s left) sysfs_heartbeat_interval (idempotent)
[515.398521] Starting subtest: idempotent
[515.400983] Starting dynamic subtest: vecs0
[515.403407] Dynamic subtest vecs0: SUCCESS (0.001s)
[515.414555] Starting dynamic subtest: ccs0
[515.416673] Dynamic subtest ccs0: SUCCESS (0.001s)
[515.425677] Starting dynamic subtest: vcs0
[515.427510] Dynamic subtest vcs0: SUCCESS (0.000s)
[515.436413] Starting dynamic subtest: bcs0
[515.438210] Dynamic subtest bcs0: SUCCESS (0.001s)
[515.447060] Starting dynamic subtest: rcs0
[515.448989] Dynamic subtest rcs0: SUCCESS (0.000s)
[515.458102] Starting dynamic subtest: vcs1
[515.460154] Dynamic subtest vcs1: SUCCESS (0.000s)
[515.462356] Subtest idempotent: SUCCESS (0.008s)
[515.541995] [083/133] (523s left) syncobj_eventfd (invalid-bad-pad)
[515.599516] Starting subtest: invalid-bad-pad
[515.601693] Subtest invalid-bad-pad: SUCCESS (0.000s)
[515.724993] [084/133] (523s left) kms_busy (extended-pageflip-hang-newfb)
[515.831085] Starting subtest: extended-pageflip-hang-newfb
[515.833424] Starting dynamic subtest: pipe-A
[541.791577] Dynamic subtest pipe-A: SUCCESS (25.960s)
[541.806904] Starting dynamic subtest: pipe-D
[556.706952] Dynamic subtest pipe-D: SUCCESS (14.913s)
[556.709239] Subtest extended-pageflip-hang-newfb: SUCCESS (40.879s)
[557.572802] [085/133] (481s left) kms_psr2_sf (psr2-cursor-plane-update-sf)
[562.626739] Starting subtest: psr2-cursor-plane-update-sf
[562.631918] Starting dynamic subtest: pipe-A-eDP-1
[563.920691] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.288s)
[563.931590] Starting dynamic subtest: pipe-B-eDP-1
[565.260814] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.339s)
[565.263149] Subtest psr2-cursor-plane-update-sf: SUCCESS (2.633s)
[566.158592] [086/133] (472s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-0-async-flip)
[566.265707] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-0-async-flip
[566.911924] Subtest x-tiled-max-hw-stride-32bpp-rotate-0-async-flip: SUCCESS (0.648s)
[567.098057] [087/133] (471s left) gem_exec_balancer (busy)
[567.159009] Starting subtest: busy
[569.006659] Subtest busy: SUCCESS (1.846s)
[569.369005] [088/133] (469s left) kms_frontbuffer_tracking (fbc-2p-primscrn-shrfb-msflip-blt)
[569.469374] Starting subtest: fbc-2p-primscrn-shrfb-msflip-blt
[569.473667] Subtest fbc-2p-primscrn-shrfb-msflip-blt: SKIP (0.000s)
[569.593853] [089/133] (469s left) vgem_slow (nohang)
[569.643458] Starting subtest: nohang
[579.691942] Subtest nohang: SUCCESS (10.050s)
[579.787431] [090/133] (459s left) gem_spin_batch (resubmit-new-all)
[579.853708] Starting subtest: resubmit-new-all
[579.856083] Starting dynamic subtest: rcs0
[579.880478] Dynamic subtest rcs0: SUCCESS (0.026s)
[579.892125] Starting dynamic subtest: bcs0
[579.903412] Dynamic subtest bcs0: SUCCESS (0.022s)
[579.920243] Starting dynamic subtest: vcs0
[579.922898] Dynamic subtest vcs0: SUCCESS (0.016s)
[579.934310] Starting dynamic subtest: vcs1
[579.938934] Dynamic subtest vcs1: SUCCESS (0.017s)
[579.948612] Starting dynamic subtest: vecs0
[579.955178] Dynamic subtest vecs0: SUCCESS (0.017s)
[579.968361] Starting dynamic subtest: ccs0
[579.978236] Dynamic subtest ccs0: SUCCESS (0.022s)
[579.980495] Subtest resubmit-new-all: SUCCESS (0.125s)
[581.015322] [091/133] (458s left) gem_render_copy (mixed-tiled-to-y-tiled-ccs)
[581.083350] Starting subtest: mixed-tiled-to-y-tiled-ccs
[581.087599] Subtest mixed-tiled-to-y-tiled-ccs: SKIP (0.000s)
[581.298751] [092/133] (457s left) syncobj_timeline (invalid-signal-illegal-point)
[581.352072] Starting subtest: invalid-signal-illegal-point
[581.354405] Subtest invalid-signal-illegal-point: SUCCESS (0.000s)
[581.492911] [093/133] (457s left) gem_exec_schedule (preempt-contexts)
[581.576305] Starting subtest: preempt-contexts
[581.578549] Starting dynamic subtest: rcs0
[581.666129] Dynamic subtest rcs0: SUCCESS (0.097s)
[581.677449] Starting dynamic subtest: bcs0
[581.760807] Dynamic subtest bcs0: SUCCESS (0.094s)
[581.771864] Starting dynamic subtest: vcs0
[581.833744] Dynamic subtest vcs0: SUCCESS (0.072s)
[581.844322] Starting dynamic subtest: vcs1
[581.886054] Dynamic subtest vcs1: SUCCESS (0.050s)
[581.896470] Starting dynamic subtest: vecs0
[581.945449] Dynamic subtest vecs0: SUCCESS (0.060s)
[581.955577] Starting dynamic subtest: ccs0
[582.032657] Dynamic subtest ccs0: SUCCESS (0.086s)
[582.034804] Subtest preempt-contexts: SUCCESS (0.464s)
[583.065596] [094/133] (456s left) gem_pwrite_snooped
[583.209644] [095/133] (456s left) kms_tiled_display (basic-test-pattern)
[583.333430] Subtest basic-test-pattern: SKIP (0.000s)
[583.401270] [096/133] (455s left) kms_frontbuffer_tracking (psr-shrfb-scaledprimary)
[583.501652] Starting subtest: psr-shrfb-scaledprimary
[589.311831] Subtest psr-shrfb-scaledprimary: SUCCESS (5.813s)
[589.484127] [097/133] (449s left) kms_frontbuffer_tracking (fbcpsr-1p-shrfb-fliptrack-mmap-gtt)
[589.588677] Starting subtest: fbcpsr-1p-shrfb-fliptrack-mmap-gtt
[589.592698] Subtest fbcpsr-1p-shrfb-fliptrack-mmap-gtt: SKIP (0.000s)
[589.713302] [098/133] (449s left) gem_pwrite (basic-self)
[589.774711] Subtest basic-self: SKIP (0.000s)
[589.843304] [099/133] (449s left) kms_pm_rpm (dpms-mode-unset-non-lpsp)
[592.070132] Starting subtest: dpms-mode-unset-non-lpsp
[593.222571] Subtest dpms-mode-unset-non-lpsp: SKIP (1.152s)
[593.622482] [100/133] (445s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip)
[593.724182] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip
[593.728643] Subtest yf-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip: SKIP (0.000s)
[593.844759] [101/133] (445s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-render)
[593.945842] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-render
[593.949871] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-render: SKIP (0.000s)
[594.085867] [102/133] (445s left) kms_color_pipeline (plane-lut1d-ctm3x4-lut1d)
[594.179400] Starting subtest: plane-lut1d-ctm3x4-lut1d
[594.195253] Starting dynamic subtest: pipe-A-eDP-1
[594.851241] Dynamic subtest pipe-A-eDP-1: FAIL (0.340s)
[595.583729] Starting dynamic subtest: pipe-B-eDP-1
[596.416814] Dynamic subtest pipe-B-eDP-1: FAIL (0.302s)
[596.917892] Starting dynamic subtest: pipe-C-eDP-1
[597.759188] Dynamic subtest pipe-C-eDP-1: FAIL (0.257s)
[598.247285] Starting dynamic subtest: pipe-D-eDP-1
[599.088846] Dynamic subtest pipe-D-eDP-1: FAIL (0.258s)
[599.091174] Subtest plane-lut1d-ctm3x4-lut1d: FAIL (4.608s)
[599.641651] [103/133] (440s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-render)
[599.754753] Starting subtest: psr-1p-primscrn-spr-indfb-draw-render
[606.546836] Subtest psr-1p-primscrn-spr-indfb-draw-render: SUCCESS (6.794s)
[606.726375] [104/133] (432s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-onoff)
[606.830965] Starting subtest: psr-1p-primscrn-cur-indfb-onoff
[613.936107] Subtest psr-1p-primscrn-cur-indfb-onoff: SUCCESS (7.108s)
[614.088336] [105/133] (425s left) gem_exec_schedule (preempt-queue-contexts-chain)
[614.169452] Subtest preempt-queue-contexts-chain: SKIP (0.000s)
[614.481763] [106/133] (425s left) api_intel_bb (object-noreloc-keep-cache-simple)
[614.535139] Starting subtest: object-noreloc-keep-cache-simple
[614.539742] Subtest object-noreloc-keep-cache-simple: SUCCESS (0.005s)
[614.652631] [107/133] (425s left) gem_mmap (bad-object)
[614.703935] Subtest bad-object: SKIP (0.000s)
[614.769814] [108/133] (425s left) kms_flip_scaled_crc (flip-32bpp-yftileccs-to-64bpp-yftile-upscaling)
[614.875011] Starting subtest: flip-32bpp-yftileccs-to-64bpp-yftile-upscaling
[614.877224] Starting dynamic subtest: pipe-A-default-mode
[615.164095] Dynamic subtest pipe-A-default-mode: SKIP (0.286s)
[615.168751] Subtest flip-32bpp-yftileccs-to-64bpp-yftile-upscaling: SKIP (0.288s)
[616.020017] [109/133] (423s left) kms_addfb_basic (bo-too-small-due-to-tiling)
[616.115534] Starting subtest: bo-too-small-due-to-tiling
[616.120023] Subtest bo-too-small-due-to-tiling: SKIP (0.000s)
[616.238328] [110/133] (423s left) kms_psr (pr-sprite-blt)
[616.342073] Starting subtest: pr-sprite-blt
[616.346418] Subtest pr-sprite-blt: SKIP (0.000s)
[616.443642] [111/133] (423s left) kms_draw_crc (fill-fb)
[616.533292] Starting subtest: fill-fb
[616.994580] Subtest fill-fb: SUCCESS (0.464s)
[617.135143] [112/133] (422s left) perf_pmu (busy-idle)
[617.178899] Starting subtest: busy-idle
[617.180954] Starting dynamic subtest: rcs0
[617.896999] Dynamic subtest rcs0: SUCCESS (0.717s)
[617.907510] Starting dynamic subtest: bcs0
[618.571071] Dynamic subtest bcs0: SUCCESS (0.672s)
[618.581901] Starting dynamic subtest: vcs0
[619.982816] Dynamic subtest vcs0: SUCCESS (1.408s)
[619.995328] Starting dynamic subtest: vcs1
[621.967715] Dynamic subtest vcs1: SUCCESS (1.982s)
[621.980096] Starting dynamic subtest: vecs0
[623.951328] Dynamic subtest vecs0: SUCCESS (1.981s)
[623.964316] Starting dynamic subtest: ccs0
[624.628880] Dynamic subtest ccs0: SUCCESS (0.677s)
[624.631456] Subtest busy-idle: SUCCESS (7.452s)
[624.785978] [113/133] (415s left) kms_ccs (crc-sprite-planes-basic-4-tiled-dg2-mc-ccs)
[624.879270] Starting subtest: crc-sprite-planes-basic-4-tiled-dg2-mc-ccs
[624.881540] Starting dynamic subtest: pipe-A-eDP-1
[624.941461] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[624.953516] Starting dynamic subtest: pipe-B-eDP-1
[625.012593] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[625.024122] Starting dynamic subtest: pipe-C-eDP-1
[625.080886] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[625.091887] Starting dynamic subtest: pipe-D-eDP-1
[625.149395] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[625.153524] Subtest crc-sprite-planes-basic-4-tiled-dg2-mc-ccs: SKIP (0.009s)
[627.173986] [114/133] (412s left) gem_exec_flush (basic-batch-kernel-default-uc)
[627.242266] Starting subtest: basic-batch-kernel-default-uc
[634.388208] Subtest basic-batch-kernel-default-uc: SUCCESS (7.148s)
[634.604240] [115/133] (405s left) gem_mmap_wc (write-read-distinct)
[634.663929] Subtest write-read-distinct: SKIP (0.000s)
[634.736932] [116/133] (405s left) kms_plane_lowres (tiling-x)
[634.841549] Starting subtest: tiling-x
[634.843692] Starting dynamic subtest: pipe-A-eDP-1
[634.847952] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[635.143938] Starting dynamic subtest: pipe-B-eDP-1
[635.148676] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[635.160643] Starting dynamic subtest: pipe-C-eDP-1
[635.165424] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[635.174692] Starting dynamic subtest: pipe-D-eDP-1
[635.178938] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[635.183066] Subtest tiling-x: SKIP (0.294s)
[635.998551] [117/133] (404s left) sw_sync (alloc_merge_fence)
[636.032027] Starting subtest: alloc_merge_fence
[636.034247] Subtest alloc_merge_fence: SUCCESS (0.000s)
[636.114636] [118/133] (404s left) kms_pm_backlight (fade)
[636.208886] Starting subtest: fade
[636.258877] Starting dynamic subtest: eDP-1
[638.928977] Dynamic subtest eDP-1: SUCCESS (2.668s)
[638.931324] Subtest fade: SUCCESS (2.720s)
[639.832649] [119/133] (400s left) kms_flip_scaled_crc (flip-64bpp-xtile-to-32bpp-xtile-downscaling)
[639.936575] Starting subtest: flip-64bpp-xtile-to-32bpp-xtile-downscaling
[639.938848] Starting dynamic subtest: pipe-A-default-mode
[641.064188] Dynamic subtest pipe-A-default-mode: SKIP (1.124s)
[641.070403] Subtest flip-64bpp-xtile-to-32bpp-xtile-downscaling: SKIP (1.126s)
[641.256613] [120/133] (399s left) syncobj_wait (multi-wait-all-for-submit-unsubmitted-signaled)
[641.319940] Starting subtest: multi-wait-all-for-submit-unsubmitted-signaled
[641.428706] Subtest multi-wait-all-for-submit-unsubmitted-signaled: SUCCESS (0.105s)
[641.527318] [121/133] (398s left) kms_psr (psr-cursor-mmap-cpu)
[641.630254] Starting subtest: psr-cursor-mmap-cpu
[641.632481] Starting dynamic subtest: eDP-1
[643.314636] Dynamic subtest eDP-1: SUCCESS (1.683s)
[643.316567] Subtest psr-cursor-mmap-cpu: SUCCESS (1.684s)
[644.204973] [122/133] (396s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-180-async-flip)
[644.323337] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-180-async-flip
[644.980491] Subtest 4-tiled-max-hw-stride-32bpp-rotate-180-async-flip: SUCCESS (0.659s)
[645.199148] [123/133] (395s left) gem_exec_whisper (basic-queues-priority-all)
[645.263177] Starting subtest: basic-queues-priority-all
[669.250409] Subtest basic-queues-priority-all: SUCCESS (23.936s)
[669.403468] [124/133] (371s left) syncobj_timeline (etime-single-wait-all-submitted)
[669.458172] Starting subtest: etime-single-wait-all-submitted
[669.563656] Subtest etime-single-wait-all-submitted: SUCCESS (0.104s)
[669.671461] [125/133] (370s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-onoff)
[669.767919] Starting subtest: fbc-2p-primscrn-spr-indfb-onoff
[669.772026] Subtest fbc-2p-primscrn-spr-indfb-onoff: SKIP (0.000s)
[669.898688] [126/133] (370s left) kms_async_flips (async-flip-dpms)
[669.985846] Starting subtest: async-flip-dpms
[670.367963] Starting dynamic subtest: pipe-A-eDP-1
[674.195697] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.827s)
[674.587490] Starting dynamic subtest: pipe-B-eDP-1
[677.381129] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.803s)
[677.772010] Starting dynamic subtest: pipe-C-eDP-1
[680.550989] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.787s)
[680.937596] Starting dynamic subtest: pipe-D-eDP-1
[683.726105] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.796s)
[683.728342] Subtest async-flip-dpms: SUCCESS (13.744s)
[684.926286] [127/133] (355s left) gem_exec_reloc (basic-cpu-read-noreloc)
[684.990611] Subtest basic-cpu-read-noreloc: SKIP (0.000s)
[685.064333] [128/133] (355s left) syncobj_wait (invalid-reset-illegal-handle)
[685.127052] Starting subtest: invalid-reset-illegal-handle
[685.129295] Subtest invalid-reset-illegal-handle: SUCCESS (0.000s)
[685.246767] [129/133] (355s left) syncobj_wait (multi-wait-all-for-submit-unsubmitted-submitted)
[685.298765] Starting subtest: multi-wait-all-for-submit-unsubmitted-submitted
[685.403304] Subtest multi-wait-all-for-submit-unsubmitted-submitted: SUCCESS (0.103s)
[685.504671] [130/133] (355s left) gem_tiled_swapping (non-threaded)
[685.562888] Subtest non-threaded: SKIP (0.000s)
[685.633073] [131/133] (355s left) gem_exec_fence (syncobj-timeline-chain-engines)
[686.233429] Starting subtest: syncobj-timeline-chain-engines
[686.348522] Subtest syncobj-timeline-chain-engines: SUCCESS (0.115s)
[688.090249] [132/133] (352s left) kms_cursor_legacy (flip-vs-cursor-legacy)
[688.228917] Starting subtest: flip-vs-cursor-legacy
[695.287688] Subtest flip-vs-cursor-legacy: SUCCESS (7.060s)
[696.171243] [133/133] (344s left) syncobj_basic (illegal-fd-to-handle)
[696.242795] Starting subtest: illegal-fd-to-handle
[696.245020] Subtest illegal-fd-to-handle: SUCCESS (0.000s)
[696.372536] 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.