[58.742609] Initializing watchdogs
[58.742656]   /dev/watchdog0
[58.756804] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:7d55 Intel Meteorlake (Gen12) Meteor Lake-P [Intel Arc Graphics]
[58.761022] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[58.763156] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[58.766387] [001/133] (960s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-mmap-gtt)
[58.905513] Starting subtest: psr-2p-primscrn-spr-indfb-draw-mmap-gtt
[58.909695] Subtest psr-2p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[59.028167] [002/133] (960s left) gem_exec_suspend (basic-s3-devices)
[59.095062] Starting subtest: basic-S3-devices
[59.097384] Starting dynamic subtest: smem
[70.935054] Dynamic subtest smem: SUCCESS (11.840s)
[70.937963] Subtest basic-S3-devices: SUCCESS (11.841s)
[71.138058] [003/133] (948s left) gem_render_copy (y-tiled-ccs-to-yf-tiled)
[71.217873] Starting subtest: y-tiled-ccs-to-yf-tiled
[71.222583] Subtest y-tiled-ccs-to-yf-tiled: SKIP (0.000s)
[71.427696] [004/133] (947s left) kms_ccs (ccs-on-another-bo-y-tiled-gen12-mc-ccs)
[71.522936] Starting subtest: ccs-on-another-bo-y-tiled-gen12-mc-ccs
[71.525338] Starting dynamic subtest: pipe-A-eDP-1
[71.547946] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[71.558669] Starting dynamic subtest: pipe-B-eDP-1
[71.579256] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[71.586057] Starting dynamic subtest: pipe-C-eDP-1
[71.606279] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[71.613113] Starting dynamic subtest: pipe-D-eDP-1
[71.633704] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[71.637814] Subtest ccs-on-another-bo-y-tiled-gen12-mc-ccs: SKIP (0.003s)
[73.830643] [005/133] (945s left) kms_flip (bo-too-big)
[73.920429] Starting subtest: bo-too-big
[73.922805] Starting dynamic subtest: A-eDP1
[75.258565] Dynamic subtest A-eDP1: SUCCESS (1.337s)
[75.268160] Starting dynamic subtest: B-eDP1
[76.589722] Dynamic subtest B-eDP1: SUCCESS (1.329s)
[76.599823] Starting dynamic subtest: C-eDP1
[77.921315] Dynamic subtest C-eDP1: SUCCESS (1.331s)
[77.931559] Starting dynamic subtest: D-eDP1
[79.252719] Dynamic subtest D-eDP1: SUCCESS (1.330s)
[79.258100] Subtest bo-too-big: SUCCESS (5.339s)
[80.481070] [006/133] (938s left) syncobj_timeline (multi-wait-available-unsubmitted-signaled)
[80.535664] Starting subtest: multi-wait-available-unsubmitted-signaled
[80.537558] Subtest multi-wait-available-unsubmitted-signaled: SUCCESS (0.000s)
[80.655310] [007/133] (938s left) kms_lease (lease-uevent)
[80.735128] Starting subtest: lease-uevent
[81.753190] Subtest lease-uevent: SUCCESS (1.018s)
[81.885313] [008/133] (937s left) gem_exec_fence (syncobj-timeline-wait)
[82.463303] Starting subtest: syncobj-timeline-wait
[83.977383] Subtest syncobj-timeline-wait: SUCCESS (1.517s)
[86.014654] [FACT gem_exec_fence (syncobj-timeline-wait)] new: kernel.kmod_is_loaded.vgem: true
[86.018038] [009/133] (933s left) kms_chamelium_color (gamma)
[86.117389] Subtest gamma: SKIP (0.000s)
[86.161866] [010/133] (933s left) prime_mmap (test_errors)
[86.217824] Starting subtest: test_errors
[86.220103] Starting dynamic subtest: test_errors-smem
[86.362497] Dynamic subtest test_errors-smem: SUCCESS (0.145s)
[86.365124] Subtest test_errors: SUCCESS (0.145s)
[86.503912] [011/133] (933s left) i915_drm_fdinfo (idle)
[86.540882] Starting subtest: idle
[86.543368] Starting dynamic subtest: rcs0
[87.128876] Dynamic subtest rcs0: SUCCESS (0.588s)
[87.139529] Starting dynamic subtest: bcs0
[87.636082] Dynamic subtest bcs0: SUCCESS (0.504s)
[87.645761] Starting dynamic subtest: vcs0
[88.141568] Dynamic subtest vcs0: SUCCESS (0.504s)
[88.151032] Starting dynamic subtest: vcs1
[88.646381] Dynamic subtest vcs1: SUCCESS (0.503s)
[88.655291] Starting dynamic subtest: vecs0
[89.149877] Dynamic subtest vecs0: SUCCESS (0.503s)
[89.159712] Starting dynamic subtest: ccs0
[89.657526] Dynamic subtest ccs0: SUCCESS (0.504s)
[89.660047] Subtest idle: SUCCESS (3.113s)
[89.752983] [012/133] (929s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-mmap-cpu)
[89.860162] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-mmap-cpu
[89.864139] Subtest fbc-2p-scndscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[89.991695] [013/133] (929s left) kms_invalid_mode (zero-hdisplay)
[90.093345] Starting subtest: zero-hdisplay
[90.095557] Starting dynamic subtest: pipe-A-eDP-1
[90.378991] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.286s)
[90.388211] Starting dynamic subtest: pipe-B-eDP-1
[90.390329] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[90.397699] Starting dynamic subtest: pipe-C-eDP-1
[90.399857] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[90.406808] Starting dynamic subtest: pipe-D-eDP-1
[90.408702] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[90.410909] Subtest zero-hdisplay: SUCCESS (0.291s)
[91.218164] [014/133] (928s left) kms_plane_scaling (planes-downscale-factor-0-75-unity-scaling)
[91.319848] Starting subtest: planes-downscale-factor-0-75-unity-scaling
[91.322229] Starting dynamic subtest: pipe-A
[91.382931] Dynamic subtest pipe-A: SUCCESS (0.065s)
[91.391249] Starting dynamic subtest: pipe-B
[92.527544] Dynamic subtest pipe-B: SUCCESS (1.144s)
[92.539035] Starting dynamic subtest: pipe-C
[93.633984] Dynamic subtest pipe-C: SUCCESS (1.106s)
[93.643765] Starting dynamic subtest: pipe-D
[94.763805] Dynamic subtest pipe-D: SUCCESS (1.129s)
[94.766281] Subtest planes-downscale-factor-0-75-unity-scaling: SUCCESS (3.446s)
[95.956110] [015/133] (923s left) drm_read (fault-buffer)
[96.108142] Starting subtest: fault-buffer
[96.110546] Subtest fault-buffer: SUCCESS (0.001s)
[96.295374] [016/133] (923s left) gem_ccs (suspend-resume)
[96.357767] Starting subtest: suspend-resume
[96.362037] Subtest suspend-resume: SKIP (0.000s)
[96.515770] [017/133] (923s left) kms_ccs (bad-rotation-90-4-tiled-dg2-rc-ccs)
[96.616266] Starting subtest: bad-rotation-90-4-tiled-dg2-rc-ccs
[96.618733] Starting dynamic subtest: pipe-A-eDP-1
[96.642999] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[96.651429] Starting dynamic subtest: pipe-B-eDP-1
[96.673106] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[96.680647] Starting dynamic subtest: pipe-C-eDP-1
[96.701726] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[96.709500] Starting dynamic subtest: pipe-D-eDP-1
[96.732083] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[96.736177] Subtest bad-rotation-90-4-tiled-dg2-rc-ccs: SKIP (0.007s)
[98.901815] [018/133] (921s left) gem_close (many-handles-one-vma)
[98.983286] Starting subtest: many-handles-one-vma
[99.008903] Subtest many-handles-one-vma: SUCCESS (0.025s)
[99.165644] [019/133] (920s left) gem_busy (extended)
[99.333650] Starting subtest: extended
[99.335894] Starting dynamic subtest: rcs0
[99.435685] Dynamic subtest rcs0: SUCCESS (0.102s)
[99.445686] Starting dynamic subtest: bcs0
[99.477431] Dynamic subtest bcs0: SUCCESS (0.041s)
[99.486801] Starting dynamic subtest: vcs0
[100.885450] Dynamic subtest vcs0: SUCCESS (1.405s)
[100.897292] Starting dynamic subtest: vcs1
[102.933816] Dynamic subtest vcs1: SUCCESS (2.047s)
[102.944217] Starting dynamic subtest: vecs0
[104.917138] Dynamic subtest vecs0: SUCCESS (1.983s)
[104.928080] Starting dynamic subtest: ccs0
[104.962736] Dynamic subtest ccs0: SUCCESS (0.046s)
[104.965095] Subtest extended: SUCCESS (5.630s)
[105.237353] [020/133] (914s left) kms_vblank (ts-continuation-suspend)
[105.340142] Starting subtest: ts-continuation-suspend
[105.342416] Starting dynamic subtest: pipe-A-eDP-1
[121.751016] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.527s)
[121.765287] Starting dynamic subtest: pipe-D-eDP-1
[138.729041] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.194s)
[138.731300] Subtest ts-continuation-suspend: SUCCESS (3.723s)
[139.557904] [021/133] (880s left) perf_pmu (semaphore-wait-idle)
[139.603929] Starting subtest: semaphore-wait-idle
[139.606136] Starting dynamic subtest: rcs0
[140.118466] Dynamic subtest rcs0: SUCCESS (0.514s)
[140.130584] Starting dynamic subtest: bcs0
[140.632349] Dynamic subtest bcs0: SUCCESS (0.512s)
[140.641971] Starting dynamic subtest: vcs0
[141.143027] Dynamic subtest vcs0: SUCCESS (0.510s)
[141.155594] Starting dynamic subtest: vcs1
[141.654366] Dynamic subtest vcs1: SUCCESS (0.509s)
[141.666015] Starting dynamic subtest: vecs0
[142.167798] Dynamic subtest vecs0: SUCCESS (0.511s)
[142.179474] Starting dynamic subtest: ccs0
[142.681787] Dynamic subtest ccs0: SUCCESS (0.512s)
[142.684743] Subtest semaphore-wait-idle: SUCCESS (3.077s)
[142.840591] [022/133] (877s left) kms_debugfs (display-off-read-all)
[142.947895] Starting subtest: display-off-read-all
[143.246904] Subtest display-off-read-all: SUCCESS (0.300s)
[144.090052] [023/133] (876s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-blt)
[144.189871] Starting subtest: fbc-rgb101010-draw-blt
[148.785876] Subtest fbc-rgb101010-draw-blt: SUCCESS (4.598s)
[149.992898] [024/133] (870s left) gem_ctx_param (invalid-get-no-zeromap)
[150.049642] Starting subtest: invalid-get-no-zeromap
[150.052347] Subtest invalid-get-no-zeromap: SUCCESS (0.001s)
[150.187607] [025/133] (870s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-mmap-gtt)
[150.288144] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-mmap-gtt
[150.292162] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[150.404066] [026/133] (869s left) gem_exec_big (single)
[150.468309] Starting subtest: single
[152.838362] Subtest single: SUCCESS (2.368s)
[153.074295] [027/133] (867s left) kms_frontbuffer_tracking (psr-rgb101010-draw-mmap-gtt)
[153.229490] Starting subtest: psr-rgb101010-draw-mmap-gtt
[153.233653] Subtest psr-rgb101010-draw-mmap-gtt: SKIP (0.000s)
[153.353058] [028/133] (866s left) gem_exec_flush (basic-uc-prw-default)
[153.422826] Starting subtest: basic-uc-prw-default
[158.887857] Subtest basic-uc-prw-default: SUCCESS (5.465s)
[159.097525] [029/133] (861s left) kms_frontbuffer_tracking (fbc-1p-shrfb-fliptrack-mmap-gtt)
[159.210388] Starting subtest: fbc-1p-shrfb-fliptrack-mmap-gtt
[159.215042] Subtest fbc-1p-shrfb-fliptrack-mmap-gtt: SKIP (0.000s)
[159.344630] [030/133] (861s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-shrfb-draw-render)
[159.446930] Starting subtest: psr-1p-offscreen-pri-shrfb-draw-render
[166.223489] Subtest psr-1p-offscreen-pri-shrfb-draw-render: SUCCESS (6.778s)
[166.393739] [031/133] (854s left) gem_exec_create (forked)
[166.469584] Starting subtest: forked
[166.471767] Starting dynamic subtest: smem
[186.643768] Dynamic subtest smem: SUCCESS (20.173s)
[186.646161] Subtest forked: SUCCESS (20.174s)
[186.853206] [032/133] (833s left) kms_feature_discovery (display-1x)
[186.960701] Starting subtest: display-1x
[186.963065] Subtest display-1x: SUCCESS (0.000s)
[187.058422] [033/133] (833s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-wc)
[187.166406] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-wc
[187.170630] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[187.288042] [034/133] (833s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-move)
[187.396441] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-move
[187.400602] Subtest fbcpsr-2p-primscrn-cur-indfb-move: SKIP (0.000s)
[187.533764] [035/133] (833s left) gem_render_copy_redux (interruptible)
[187.609226] Starting subtest: interruptible
[187.853594] Subtest interruptible: SUCCESS (0.247s)
[188.021801] [036/133] (832s left) i915_pm_rpm (system-suspend-execbuf)
[189.772282] Starting subtest: system-suspend-execbuf
[248.304388] Subtest system-suspend-execbuf: SUCCESS (42.946s)
[248.713447] [037/133] (771s left) kms_frontbuffer_tracking (psr-2p-scndscrn-indfb-plflip-blt)
[248.824580] Starting subtest: psr-2p-scndscrn-indfb-plflip-blt
[248.829018] Subtest psr-2p-scndscrn-indfb-plflip-blt: SKIP (0.000s)
[248.954344] [038/133] (771s left) gem_request_retire (retire-vma-not-inactive)
[249.019417] Starting subtest: retire-vma-not-inactive
[249.077479] Subtest retire-vma-not-inactive: SUCCESS (0.058s)
[249.253921] [039/133] (771s left) i915_pm_rps (thresholds-idle)
[249.318513] Starting subtest: thresholds-idle
[249.323217] Subtest thresholds-idle: SKIP (0.000s)
[249.461947] [040/133] (771s left) gem_ctx_persistence (legacy-engines-queued)
[249.523108] Starting subtest: legacy-engines-queued
[249.525506] Starting dynamic subtest: render
[249.642352] Dynamic subtest render: SUCCESS (0.119s)
[249.655079] Starting dynamic subtest: bsd1
[251.120333] Dynamic subtest bsd1: SUCCESS (1.474s)
[251.131094] Starting dynamic subtest: bsd2
[253.102309] Dynamic subtest bsd2: SUCCESS (1.979s)
[253.114251] Starting dynamic subtest: blt
[253.166835] Dynamic subtest blt: SUCCESS (0.064s)
[253.178013] Starting dynamic subtest: vebox
[255.086123] Dynamic subtest vebox: SUCCESS (1.915s)
[255.088925] Subtest legacy-engines-queued: SUCCESS (5.562s)
[255.189520] [041/133] (765s left) i915_hangman (gt-error-state-capture)
[255.267633] Starting subtest: gt-error-state-capture
[255.269795] Starting dynamic subtest: rcs0
[267.118140] Dynamic subtest rcs0: SUCCESS (11.847s)
[267.133221] Starting dynamic subtest: bcs0
[279.150377] Dynamic subtest bcs0: SUCCESS (12.029s)
[279.162464] Starting dynamic subtest: vcs0
[290.095027] Dynamic subtest vcs0: SUCCESS (10.941s)
[290.106594] Starting dynamic subtest: vcs1
[302.062019] Dynamic subtest vcs1: SUCCESS (11.963s)
[302.074857] Starting dynamic subtest: vecs0
[313.134887] Dynamic subtest vecs0: SUCCESS (11.073s)
[313.147624] Starting dynamic subtest: ccs0
[325.102554] Dynamic subtest ccs0: SUCCESS (11.967s)
[325.105385] Subtest gt-error-state-capture: SUCCESS (69.829s)
[325.210132] [042/133] (695s left) kms_cursor_crc (cursor-rapid-movement-128x42)
[325.422858] Starting subtest: cursor-rapid-movement-128x42
[325.469941] Subtest cursor-rapid-movement-128x42: SKIP (0.041s)
[325.721354] [043/133] (695s left) gem_partial_pwrite_pread (writes-after-reads-uncached)
[325.790346] Subtest writes-after-reads-uncached: SKIP (0.000s)
[325.850699] [044/133] (695s left) gem_mmap_wc (coherency)
[325.908283] Subtest coherency: SKIP (0.000s)
[325.971869] [045/133] (695s left) syncobj_timeline (single-wait-all-for-submit-signaled)
[326.042677] Starting subtest: single-wait-all-for-submit-signaled
[326.045264] Subtest single-wait-all-for-submit-signaled: SUCCESS (0.000s)
[326.181306] [046/133] (694s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-render)
[326.276934] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-render
[329.982598] Subtest fbc-1p-primscrn-cur-indfb-draw-render: SUCCESS (3.708s)
[331.208759] [047/133] (689s left) kms_psr (fbc-psr-primary-mmap-cpu)
[331.294999] Starting subtest: fbc-psr-primary-mmap-cpu
[331.297166] Starting dynamic subtest: eDP-1
[331.301391] Dynamic subtest eDP-1: SKIP (0.000s)
[331.305706] Subtest fbc-psr-primary-mmap-cpu: SKIP (0.001s)
[331.393383] [048/133] (689s left) kms_invalid_mode (bad-vsync-start)
[331.494871] Starting subtest: bad-vsync-start
[331.497199] Starting dynamic subtest: pipe-A-eDP-1
[331.774874] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.283s)
[331.785825] Starting dynamic subtest: pipe-B-eDP-1
[331.788095] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[331.796834] Starting dynamic subtest: pipe-C-eDP-1
[331.799311] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[331.814806] Starting dynamic subtest: pipe-D-eDP-1
[331.817241] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[331.819587] Subtest bad-vsync-start: SUCCESS (0.287s)
[332.636140] [049/133] (688s left) gem_exec_reloc (basic-wc-gtt)
[332.702438] Subtest basic-wc-gtt: SKIP (0.000s)
[332.783382] [050/133] (688s left) gem_mmap_gtt (cpuset-medium-copy-xy)
[332.845331] Subtest cpuset-medium-copy-XY: SKIP (0.000s)
[332.914124] [051/133] (688s left) kms_prop_blob (blob-multiple)
[332.978276] Starting subtest: blob-multiple
[332.980633] Subtest blob-multiple: SUCCESS (0.002s)
[333.109406] [052/133] (688s left) api_intel_allocator (open-vm)
[333.177368] Starting subtest: open-vm
[333.179785] Subtest open-vm: SUCCESS (0.003s)
[333.335636] [053/133] (688s left) kms_getfb (getfb-repeated-different-handles)
[333.441401] Starting subtest: getfb-repeated-different-handles
[333.443629] Subtest getfb-repeated-different-handles: SUCCESS (0.000s)
[333.579836] [054/133] (687s left) kms_content_protection (legacy-hdcp14)
[333.720319] Starting subtest: legacy-hdcp14
[333.724071] Subtest legacy-hdcp14: SKIP (0.000s)
[333.877958] [055/133] (687s left) kms_chamelium_hpd (hdmi-hpd-after-suspend)
[334.277186] Subtest hdmi-hpd-after-suspend: SKIP (0.000s)
[335.124553] [056/133] (686s left) kms_flip (blocking-absolute-wf_vblank)
[335.221678] Starting subtest: blocking-absolute-wf_vblank
[335.224103] Starting dynamic subtest: A-eDP1
[344.000913] Dynamic subtest A-eDP1: SUCCESS (8.778s)
[344.013760] Starting dynamic subtest: B-eDP1
[352.735007] Dynamic subtest B-eDP1: SUCCESS (8.733s)
[352.746493] Starting dynamic subtest: C-eDP1
[361.459622] Dynamic subtest C-eDP1: SUCCESS (8.723s)
[361.469666] Starting dynamic subtest: D-eDP1
[370.187896] Dynamic subtest D-eDP1: SUCCESS (8.725s)
[370.192890] Subtest blocking-absolute-wf_vblank: SUCCESS (34.971s)
[371.445746] [057/133] (650s left) gem_mmap_offset (bad-object)
[371.505924] Starting subtest: bad-object
[371.508278] Subtest bad-object: SUCCESS (0.001s)
[371.653344] [058/133] (649s left) kms_psr (psr2-no-drrs)
[371.774571] Starting subtest: psr2-no-drrs
[371.776888] Starting dynamic subtest: eDP-1
[373.385272] Dynamic subtest eDP-1: SUCCESS (1.610s)
[373.387963] Subtest psr2-no-drrs: SUCCESS (1.611s)
[374.209180] [059/133] (647s left) gem_fenced_exec_thrash (no-spare-fences-interruptible)
[374.273881] Subtest no-spare-fences-interruptible: SKIP (0.000s)
[374.365660] [060/133] (647s left) kms_vblank (wait-idle)
[374.466104] Starting subtest: wait-idle
[374.468345] Starting dynamic subtest: pipe-A-eDP-1
[376.233827] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.768s)
[376.249029] Starting dynamic subtest: pipe-D-eDP-1
[378.728977] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.490s)
[378.731185] Subtest wait-idle: SUCCESS (4.262s)
[379.577418] [061/133] (642s left) gem_exec_whisper (basic-contexts-all)
[379.645334] Starting subtest: basic-contexts-all
[390.658006] Subtest basic-contexts-all: SUCCESS (11.007s)
[390.871361] [062/133] (630s left) kms_big_fb (x-tiled-16bpp-rotate-0)
[390.985792] Starting subtest: x-tiled-16bpp-rotate-0
[392.352125] Subtest x-tiled-16bpp-rotate-0: SUCCESS (1.368s)
[392.523007] [063/133] (629s left) kms_atomic (plane-primary-overlay-mutable-zpos)
[392.623717] Starting subtest: plane-primary-overlay-mutable-zpos
[396.089551] Subtest plane-primary-overlay-mutable-zpos: SKIP (3.465s)
[397.291877] [064/133] (624s left) gen9_exec_parse (bb-start-cmd)
[397.361221] Subtest bb-start-cmd: SKIP (0.000s)
[397.444955] [065/133] (624s left) kms_cursor_crc (cursor-alpha-opaque)
[397.541726] Starting subtest: cursor-alpha-opaque
[397.543571] Starting dynamic subtest: pipe-A-eDP-1
[398.186351] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.643s)
[398.196830] Starting dynamic subtest: pipe-D-eDP-1
[399.455902] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.269s)
[399.458245] Subtest cursor-alpha-opaque: SUCCESS (1.916s)
[400.364416] [066/133] (621s left) kms_cursor_crc (cursor-sliding-64x64)
[400.567870] Starting subtest: cursor-sliding-64x64
[400.573386] Starting dynamic subtest: pipe-A-eDP-1
[403.804698] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.229s)
[403.834444] Starting dynamic subtest: pipe-D-eDP-1
[407.742328] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.916s)
[407.744224] Subtest cursor-sliding-64x64: SUCCESS (7.173s)
[408.624488] [067/133] (613s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-render)
[408.725632] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-render
[415.491399] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-render: SUCCESS (6.768s)
[415.662414] [068/133] (606s left) gem_ctx_shared (exec-single-timeline)
[415.725625] Starting subtest: exec-single-timeline
[415.728024] Starting dynamic subtest: rcs0
[416.812353] Dynamic subtest rcs0: SUCCESS (1.084s)
[416.825604] Starting dynamic subtest: bcs0
[417.899996] Dynamic subtest bcs0: SUCCESS (1.084s)
[417.912548] Starting dynamic subtest: vcs0
[418.989626] Dynamic subtest vcs0: SUCCESS (1.087s)
[419.001934] Starting dynamic subtest: vcs1
[420.077644] Dynamic subtest vcs1: SUCCESS (1.085s)
[420.090543] Starting dynamic subtest: vecs0
[421.165297] Dynamic subtest vecs0: SUCCESS (1.084s)
[421.181697] Starting dynamic subtest: ccs0
[422.252964] Dynamic subtest ccs0: SUCCESS (1.085s)
[422.255789] Subtest exec-single-timeline: SUCCESS (6.527s)
[423.253997] [069/133] (598s left) kms_plane_scaling (plane-downscale-factor-0-75-with-pixel-format)
[423.355020] Starting subtest: plane-downscale-factor-0-75-with-pixel-format
[423.357281] Starting dynamic subtest: pipe-A
[424.581970] Dynamic subtest pipe-A: SUCCESS (1.229s)
[424.591159] Starting dynamic subtest: pipe-B
[426.864231] Dynamic subtest pipe-B: SUCCESS (2.281s)
[426.873700] Starting dynamic subtest: pipe-C
[428.013140] Dynamic subtest pipe-C: SUCCESS (1.147s)
[428.023240] Starting dynamic subtest: pipe-D
[429.148143] Dynamic subtest pipe-D: SUCCESS (1.134s)
[429.150454] Subtest plane-downscale-factor-0-75-with-pixel-format: SUCCESS (5.795s)
[430.360080] [070/133] (591s left) gem_wait (write-busy)
[430.444266] Starting subtest: write-busy
[430.446496] Starting dynamic subtest: all-engines
[431.110444] Dynamic subtest all-engines: SUCCESS (0.667s)
[431.129026] Starting dynamic subtest: rcs0
[431.667569] Dynamic subtest rcs0: SUCCESS (0.555s)
[431.683305] Starting dynamic subtest: bcs0
[432.217609] Dynamic subtest bcs0: SUCCESS (0.549s)
[432.233825] Starting dynamic subtest: vcs0
[434.127146] Dynamic subtest vcs0: SUCCESS (1.907s)
[434.143327] Starting dynamic subtest: vcs1
[436.175595] Dynamic subtest vcs1: SUCCESS (2.046s)
[436.191407] Starting dynamic subtest: vecs0
[438.159354] Dynamic subtest vecs0: SUCCESS (1.981s)
[438.175011] Starting dynamic subtest: ccs0
[438.709084] Dynamic subtest ccs0: SUCCESS (0.549s)
[438.711536] Subtest write-busy: SUCCESS (8.268s)
[438.941355] [071/133] (583s left) kms_big_fb (y-tiled-8bpp-rotate-0)
[439.052189] Starting subtest: y-tiled-8bpp-rotate-0
[439.056950] Subtest y-tiled-8bpp-rotate-0: SKIP (0.000s)
[439.179872] [072/133] (583s left) kms_cursor_legacy (basic-busy-flip-before-cursor-legacy)
[439.292829] Starting subtest: basic-busy-flip-before-cursor-legacy
[439.297326] Subtest basic-busy-flip-before-cursor-legacy: SKIP (0.000s)
[439.463956] [073/133] (582s left) gem_basic (bad-close)
[439.517062] Starting subtest: bad-close
[439.521394] Subtest bad-close: SUCCESS (0.000s)
[439.660881] [074/133] (582s left) kms_big_fb (linear-16bpp-rotate-0)
[439.769011] Starting subtest: linear-16bpp-rotate-0
[441.056798] Subtest linear-16bpp-rotate-0: SUCCESS (1.289s)
[441.226024] [075/133] (581s left) kms_psr2_sf (pr-overlay-plane-update-continuous-sf)
[446.207540] Starting subtest: pr-overlay-plane-update-continuous-sf
[446.212139] Subtest pr-overlay-plane-update-continuous-sf: SKIP (0.002s)
[447.084104] [076/133] (575s left) drm_read (short-buffer-wakeup)
[447.238186] Starting subtest: short-buffer-wakeup
[479.455906] Subtest short-buffer-wakeup: SUCCESS (32.215s)
[479.623222] [077/133] (542s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-pwrite)
[479.730419] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-pwrite
[486.630516] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-pwrite: SUCCESS (6.901s)
[486.795272] [078/133] (535s left) kms_psr (fbc-pr-cursor-render)
[486.891234] Starting subtest: fbc-pr-cursor-render
[486.895212] Subtest fbc-pr-cursor-render: SKIP (0.000s)
[486.988882] [079/133] (535s left) kms_ccs (crc-primary-suspend-y-tiled-gen12-mc-ccs)
[487.070016] Starting subtest: crc-primary-suspend-y-tiled-gen12-mc-ccs
[487.072261] Starting dynamic subtest: pipe-A-eDP-1
[487.081277] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[487.091752] Starting dynamic subtest: pipe-B-eDP-1
[487.100770] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[487.110253] Starting dynamic subtest: pipe-C-eDP-1
[487.118978] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[487.128039] Starting dynamic subtest: pipe-D-eDP-1
[487.136742] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[487.141254] Subtest crc-primary-suspend-y-tiled-gen12-mc-ccs: SKIP (0.004s)
[489.326210] [080/133] (533s left) kms_ccs (random-ccs-data-4-tiled-mtl-mc-ccs)
[489.417152] Starting subtest: random-ccs-data-4-tiled-mtl-mc-ccs
[489.419273] Starting dynamic subtest: pipe-A-eDP-1
[490.635758] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.220s)
[490.645002] Starting dynamic subtest: pipe-B-eDP-1
[492.920553] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.283s)
[492.930283] Starting dynamic subtest: pipe-C-eDP-1
[495.315103] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.393s)
[495.325080] Starting dynamic subtest: pipe-D-eDP-1
[497.569028] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.253s)
[497.571361] Subtest random-ccs-data-4-tiled-mtl-mc-ccs: SUCCESS (8.155s)
[498.748938] [081/133] (523s left) sw_sync (sync_multi_timeline_wait)
[498.786866] Starting subtest: sync_multi_timeline_wait
[498.789108] Subtest sync_multi_timeline_wait: SUCCESS (0.000s)
[498.866216] [082/133] (523s left) sysfs_heartbeat_interval (idempotent)
[498.936460] Starting subtest: idempotent
[498.938802] Starting dynamic subtest: vecs0
[498.941205] Dynamic subtest vecs0: SUCCESS (0.001s)
[498.953452] Starting dynamic subtest: ccs0
[498.955478] Dynamic subtest ccs0: SUCCESS (0.001s)
[498.965894] Starting dynamic subtest: vcs0
[498.967688] Dynamic subtest vcs0: SUCCESS (0.000s)
[498.976078] Starting dynamic subtest: bcs0
[498.977832] Dynamic subtest bcs0: SUCCESS (0.001s)
[498.986105] Starting dynamic subtest: rcs0
[498.988303] Dynamic subtest rcs0: SUCCESS (0.001s)
[498.997088] Starting dynamic subtest: vcs1
[498.999197] Dynamic subtest vcs1: SUCCESS (0.001s)
[499.001002] Subtest idempotent: SUCCESS (0.008s)
[499.070420] [083/133] (523s left) syncobj_eventfd (invalid-bad-pad)
[499.142697] Starting subtest: invalid-bad-pad
[499.144846] Subtest invalid-bad-pad: SUCCESS (0.000s)
[499.275904] [084/133] (523s left) kms_busy (extended-pageflip-hang-newfb)
[499.379996] Starting subtest: extended-pageflip-hang-newfb
[499.382352] Starting dynamic subtest: pipe-A
[525.934796] Dynamic subtest pipe-A: SUCCESS (26.551s)
[525.945450] Starting dynamic subtest: pipe-D
[550.958411] Dynamic subtest pipe-D: SUCCESS (25.019s)
[550.960656] Subtest extended-pageflip-hang-newfb: SUCCESS (51.575s)
[551.820285] [085/133] (470s left) kms_psr2_sf (psr2-cursor-plane-update-sf)
[556.861303] Starting subtest: psr2-cursor-plane-update-sf
[556.863511] Starting dynamic subtest: pipe-A-eDP-1
[558.172396] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.309s)
[558.182853] Starting dynamic subtest: pipe-B-eDP-1
[559.496691] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.323s)
[559.499107] Subtest psr2-cursor-plane-update-sf: SUCCESS (2.636s)
[560.393685] [086/133] (462s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-0-async-flip)
[560.495717] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-0-async-flip
[561.168444] Subtest x-tiled-max-hw-stride-32bpp-rotate-0-async-flip: SUCCESS (0.674s)
[561.387648] [087/133] (461s left) gem_exec_balancer (busy)
[561.457837] Starting subtest: busy
[563.176698] Subtest busy: SUCCESS (1.716s)
[563.544491] [088/133] (459s left) kms_frontbuffer_tracking (fbc-2p-primscrn-shrfb-msflip-blt)
[563.649286] Starting subtest: fbc-2p-primscrn-shrfb-msflip-blt
[563.654123] Subtest fbc-2p-primscrn-shrfb-msflip-blt: SKIP (0.000s)
[563.794276] [089/133] (459s left) vgem_slow (nohang)
[563.843162] Starting subtest: nohang
[574.253089] Subtest nohang: SUCCESS (10.411s)
[574.350664] [090/133] (448s left) gem_spin_batch (resubmit-new-all)
[574.429362] Starting subtest: resubmit-new-all
[574.431548] Starting dynamic subtest: rcs0
[574.447792] Dynamic subtest rcs0: SUCCESS (0.021s)
[574.457532] Starting dynamic subtest: bcs0
[574.465106] Dynamic subtest bcs0: SUCCESS (0.017s)
[574.474438] Starting dynamic subtest: vcs0
[574.480737] Dynamic subtest vcs0: SUCCESS (0.015s)
[574.492324] Starting dynamic subtest: vcs1
[574.496861] Dynamic subtest vcs1: SUCCESS (0.015s)
[574.506446] Starting dynamic subtest: vecs0
[574.518444] Dynamic subtest vecs0: SUCCESS (0.021s)
[574.527832] Starting dynamic subtest: ccs0
[574.537718] Dynamic subtest ccs0: SUCCESS (0.019s)
[574.539913] Subtest resubmit-new-all: SUCCESS (0.112s)
[576.210578] [091/133] (446s left) gem_render_copy (mixed-tiled-to-y-tiled-ccs)
[576.272787] Starting subtest: mixed-tiled-to-y-tiled-ccs
[576.276983] Subtest mixed-tiled-to-y-tiled-ccs: SKIP (0.000s)
[576.489310] [092/133] (446s left) syncobj_timeline (invalid-signal-illegal-point)
[576.558098] Starting subtest: invalid-signal-illegal-point
[576.560374] Subtest invalid-signal-illegal-point: SUCCESS (0.000s)
[576.693477] [093/133] (446s left) gem_exec_schedule (preempt-contexts)
[576.767472] Starting subtest: preempt-contexts
[576.769734] Starting dynamic subtest: rcs0
[576.851361] Dynamic subtest rcs0: SUCCESS (0.088s)
[576.861967] Starting dynamic subtest: bcs0
[576.940575] Dynamic subtest bcs0: SUCCESS (0.088s)
[576.950885] Starting dynamic subtest: vcs0
[576.999420] Dynamic subtest vcs0: SUCCESS (0.058s)
[577.012327] Starting dynamic subtest: vcs1
[577.051779] Dynamic subtest vcs1: SUCCESS (0.052s)
[577.061636] Starting dynamic subtest: vecs0
[577.118016] Dynamic subtest vecs0: SUCCESS (0.065s)
[577.128553] Starting dynamic subtest: ccs0
[577.196471] Dynamic subtest ccs0: SUCCESS (0.078s)
[577.198732] Subtest preempt-contexts: SUCCESS (0.434s)
[578.277108] [094/133] (444s left) gem_pwrite_snooped
[578.398451] [095/133] (444s left) kms_tiled_display (basic-test-pattern)
[578.513845] Subtest basic-test-pattern: SKIP (0.000s)
[578.560248] [096/133] (444s left) kms_frontbuffer_tracking (psr-shrfb-scaledprimary)
[578.650379] Starting subtest: psr-shrfb-scaledprimary
[584.498565] Subtest psr-shrfb-scaledprimary: SUCCESS (5.849s)
[584.682698] [097/133] (438s left) kms_frontbuffer_tracking (fbcpsr-1p-shrfb-fliptrack-mmap-gtt)
[584.781749] Starting subtest: fbcpsr-1p-shrfb-fliptrack-mmap-gtt
[584.786227] Subtest fbcpsr-1p-shrfb-fliptrack-mmap-gtt: SKIP (0.000s)
[584.910169] [098/133] (438s left) gem_pwrite (basic-self)
[584.970745] Subtest basic-self: SKIP (0.000s)
[585.035350] [099/133] (438s left) kms_pm_rpm (dpms-mode-unset-non-lpsp)
[587.362144] Starting subtest: dpms-mode-unset-non-lpsp
[588.507099] Subtest dpms-mode-unset-non-lpsp: SKIP (1.147s)
[588.891939] [100/133] (434s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip)
[588.998577] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip
[589.003058] Subtest yf-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip: SKIP (0.000s)
[589.125190] [101/133] (434s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-render)
[589.212907] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-render
[589.217055] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-render: SKIP (0.000s)
[589.336006] [102/133] (434s left) kms_color_pipeline (plane-lut1d-ctm3x4-lut1d)
[589.442033] Starting subtest: plane-lut1d-ctm3x4-lut1d
[589.455101] Starting dynamic subtest: pipe-A-eDP-1
[590.158328] Dynamic subtest pipe-A-eDP-1: FAIL (0.365s)
[590.867694] Starting dynamic subtest: pipe-B-eDP-1
[591.693749] Dynamic subtest pipe-B-eDP-1: FAIL (0.280s)
[592.196493] Starting dynamic subtest: pipe-C-eDP-1
[593.055349] Dynamic subtest pipe-C-eDP-1: FAIL (0.280s)
[593.525845] Starting dynamic subtest: pipe-D-eDP-1
[594.401938] Dynamic subtest pipe-D-eDP-1: FAIL (0.280s)
[594.404181] Subtest plane-lut1d-ctm3x4-lut1d: FAIL (4.647s)
[594.932531] [103/133] (428s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-render)
[595.027793] Starting subtest: psr-1p-primscrn-spr-indfb-draw-render
[601.844266] Subtest psr-1p-primscrn-spr-indfb-draw-render: SUCCESS (6.819s)
[601.992591] [104/133] (421s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-onoff)
[602.096193] Starting subtest: psr-1p-primscrn-cur-indfb-onoff
[609.102331] Subtest psr-1p-primscrn-cur-indfb-onoff: SUCCESS (7.007s)
[609.287474] [105/133] (414s left) gem_exec_schedule (preempt-queue-contexts-chain)
[609.362009] Subtest preempt-queue-contexts-chain: SKIP (0.000s)
[609.671412] [106/133] (413s left) api_intel_bb (object-noreloc-keep-cache-simple)
[609.741618] Starting subtest: object-noreloc-keep-cache-simple
[609.746699] Subtest object-noreloc-keep-cache-simple: SUCCESS (0.005s)
[609.898411] [107/133] (413s left) gem_mmap (bad-object)
[609.963566] Subtest bad-object: SKIP (0.000s)
[610.028126] [108/133] (413s left) kms_flip_scaled_crc (flip-32bpp-yftileccs-to-64bpp-yftile-upscaling)
[610.125057] Starting subtest: flip-32bpp-yftileccs-to-64bpp-yftile-upscaling
[610.127356] Starting dynamic subtest: pipe-A-default-mode
[610.427384] Dynamic subtest pipe-A-default-mode: SKIP (0.298s)
[610.432123] Subtest flip-32bpp-yftileccs-to-64bpp-yftile-upscaling: SKIP (0.299s)
[611.313684] [109/133] (412s left) kms_addfb_basic (bo-too-small-due-to-tiling)
[611.418225] Starting subtest: bo-too-small-due-to-tiling
[611.422798] Subtest bo-too-small-due-to-tiling: SKIP (0.000s)
[611.559472] [110/133] (412s left) kms_psr (pr-sprite-blt)
[611.666393] Starting subtest: pr-sprite-blt
[611.670443] Subtest pr-sprite-blt: SKIP (0.000s)
[611.762850] [111/133] (412s left) kms_draw_crc (fill-fb)
[611.851235] Starting subtest: fill-fb
[612.335022] Subtest fill-fb: SUCCESS (0.486s)
[612.463854] [112/133] (411s left) perf_pmu (busy-idle)
[612.500353] Starting subtest: busy-idle
[612.502382] Starting dynamic subtest: rcs0
[613.217009] Dynamic subtest rcs0: SUCCESS (0.716s)
[613.229330] Starting dynamic subtest: bcs0
[613.887387] Dynamic subtest bcs0: SUCCESS (0.668s)
[613.900010] Starting dynamic subtest: vcs0
[615.184524] Dynamic subtest vcs0: SUCCESS (1.293s)
[615.197451] Starting dynamic subtest: vcs1
[617.168073] Dynamic subtest vcs1: SUCCESS (1.980s)
[617.180371] Starting dynamic subtest: vecs0
[619.152369] Dynamic subtest vecs0: SUCCESS (1.981s)
[619.164590] Starting dynamic subtest: ccs0
[619.829718] Dynamic subtest ccs0: SUCCESS (0.676s)
[619.832770] Subtest busy-idle: SUCCESS (7.329s)
[619.972565] [113/133] (403s left) kms_ccs (crc-sprite-planes-basic-4-tiled-dg2-mc-ccs)
[620.082368] Starting subtest: crc-sprite-planes-basic-4-tiled-dg2-mc-ccs
[620.084733] Starting dynamic subtest: pipe-A-eDP-1
[620.143218] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[620.152203] Starting dynamic subtest: pipe-B-eDP-1
[620.208018] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[620.219577] Starting dynamic subtest: pipe-C-eDP-1
[620.278135] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[620.289021] Starting dynamic subtest: pipe-D-eDP-1
[620.345273] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[620.349623] Subtest crc-sprite-planes-basic-4-tiled-dg2-mc-ccs: SKIP (0.008s)
[622.283168] [114/133] (401s left) gem_exec_flush (basic-batch-kernel-default-uc)
[622.351243] Starting subtest: basic-batch-kernel-default-uc
[629.164912] Subtest basic-batch-kernel-default-uc: SUCCESS (6.815s)
[629.388205] [115/133] (394s left) gem_mmap_wc (write-read-distinct)
[629.453943] Subtest write-read-distinct: SKIP (0.000s)
[629.520418] [116/133] (394s left) kms_plane_lowres (tiling-x)
[629.620008] Starting subtest: tiling-x
[629.622253] Starting dynamic subtest: pipe-A-eDP-1
[629.626692] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[629.915058] Starting dynamic subtest: pipe-B-eDP-1
[629.919700] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[629.929514] Starting dynamic subtest: pipe-C-eDP-1
[629.934220] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[629.944064] Starting dynamic subtest: pipe-D-eDP-1
[629.948495] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[629.952840] Subtest tiling-x: SKIP (0.292s)
[630.808166] [117/133] (393s left) sw_sync (alloc_merge_fence)
[630.845558] Starting subtest: alloc_merge_fence
[630.847828] Subtest alloc_merge_fence: SUCCESS (0.000s)
[630.931982] [118/133] (393s left) kms_pm_backlight (fade)
[631.020113] Starting subtest: fade
[631.069335] Starting dynamic subtest: eDP-1
[633.735223] Dynamic subtest eDP-1: SUCCESS (2.665s)
[633.737603] Subtest fade: SUCCESS (2.714s)
[634.628628] [119/133] (389s left) kms_flip_scaled_crc (flip-64bpp-xtile-to-32bpp-xtile-downscaling)
[634.739805] Starting subtest: flip-64bpp-xtile-to-32bpp-xtile-downscaling
[634.742008] Starting dynamic subtest: pipe-A-default-mode
[635.861686] Dynamic subtest pipe-A-default-mode: SKIP (1.120s)
[635.865780] Subtest flip-64bpp-xtile-to-32bpp-xtile-downscaling: SKIP (1.121s)
[636.046441] [120/133] (388s left) syncobj_wait (multi-wait-all-for-submit-unsubmitted-signaled)
[636.110723] Starting subtest: multi-wait-all-for-submit-unsubmitted-signaled
[636.211083] Subtest multi-wait-all-for-submit-unsubmitted-signaled: SUCCESS (0.101s)
[636.317725] [121/133] (387s left) kms_psr (psr-cursor-mmap-cpu)
[636.412744] Starting subtest: psr-cursor-mmap-cpu
[636.414941] Starting dynamic subtest: eDP-1
[638.124994] Dynamic subtest eDP-1: SUCCESS (1.710s)
[638.127364] Subtest psr-cursor-mmap-cpu: SUCCESS (1.711s)
[639.019182] [122/133] (385s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-180-async-flip)
[639.126619] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-180-async-flip
[639.761210] Subtest 4-tiled-max-hw-stride-32bpp-rotate-180-async-flip: SUCCESS (0.637s)
[639.979389] [123/133] (384s left) gem_exec_whisper (basic-queues-priority-all)
[640.053806] Starting subtest: basic-queues-priority-all
[662.538676] Subtest basic-queues-priority-all: SUCCESS (22.478s)
[662.745863] [124/133] (361s left) syncobj_timeline (etime-single-wait-all-submitted)
[662.809941] Starting subtest: etime-single-wait-all-submitted
[662.916582] Subtest etime-single-wait-all-submitted: SUCCESS (0.107s)
[663.019527] [125/133] (361s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-onoff)
[663.131710] Starting subtest: fbc-2p-primscrn-spr-indfb-onoff
[663.136015] Subtest fbc-2p-primscrn-spr-indfb-onoff: SKIP (0.000s)
[663.240050] [126/133] (361s left) kms_async_flips (async-flip-dpms)
[663.341018] Starting subtest: async-flip-dpms
[663.724345] Starting dynamic subtest: pipe-A-eDP-1
[667.498779] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.772s)
[667.877686] Starting dynamic subtest: pipe-B-eDP-1
[670.657391] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.787s)
[671.034478] Starting dynamic subtest: pipe-C-eDP-1
[673.825604] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.798s)
[674.206772] Starting dynamic subtest: pipe-D-eDP-1
[676.972663] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.774s)
[676.975331] Subtest async-flip-dpms: SUCCESS (13.633s)
[678.164248] [127/133] (346s left) gem_exec_reloc (basic-cpu-read-noreloc)
[678.241504] Subtest basic-cpu-read-noreloc: SKIP (0.000s)
[678.325201] [128/133] (346s left) syncobj_wait (invalid-reset-illegal-handle)
[678.375523] Starting subtest: invalid-reset-illegal-handle
[678.377690] Subtest invalid-reset-illegal-handle: SUCCESS (0.000s)
[678.512607] [129/133] (346s left) syncobj_wait (multi-wait-all-for-submit-unsubmitted-submitted)
[678.572102] Starting subtest: multi-wait-all-for-submit-unsubmitted-submitted
[678.675489] Subtest multi-wait-all-for-submit-unsubmitted-submitted: SUCCESS (0.103s)
[678.781662] [130/133] (345s left) gem_tiled_swapping (non-threaded)
[678.840502] Subtest non-threaded: SKIP (0.000s)
[678.913991] [131/133] (345s left) gem_exec_fence (syncobj-timeline-chain-engines)
[679.466360] Starting subtest: syncobj-timeline-chain-engines
[679.584673] Subtest syncobj-timeline-chain-engines: SUCCESS (0.122s)
[681.301085] [132/133] (343s left) kms_cursor_legacy (flip-vs-cursor-legacy)
[681.426657] Starting subtest: flip-vs-cursor-legacy
[688.406488] Subtest flip-vs-cursor-legacy: SUCCESS (6.980s)
[689.295481] [133/133] (335s left) syncobj_basic (illegal-fd-to-handle)
[689.351196] Starting subtest: illegal-fd-to-handle
[689.353102] Subtest illegal-fd-to-handle: SUCCESS (0.000s)
[689.482604] 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.