[59.938880] Initializing watchdogs
[59.938988]   /dev/watchdog0
[59.954695] [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.959374] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[59.961431] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[59.963360] [001/133] (960s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-mmap-gtt)
[60.072574] Starting subtest: psr-2p-primscrn-spr-indfb-draw-mmap-gtt
[60.074566] Subtest psr-2p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[60.195336] [002/133] (960s left) gem_exec_suspend (basic-s3-devices)
[60.251625] Starting subtest: basic-S3-devices
[60.252651] Starting dynamic subtest: smem
[71.894895] Dynamic subtest smem: SUCCESS (11.616s)
[71.896491] Subtest basic-S3-devices: SUCCESS (11.617s)
[76.102404] [003/133] (948s left) gem_render_copy (y-tiled-ccs-to-yf-tiled)
[76.160136] Starting subtest: y-tiled-ccs-to-yf-tiled
[76.161979] Subtest y-tiled-ccs-to-yf-tiled: SKIP (0.000s)
[76.355867] [004/133] (948s left) kms_ccs (ccs-on-another-bo-y-tiled-gen12-mc-ccs)
[76.455142] Starting subtest: ccs-on-another-bo-y-tiled-gen12-mc-ccs
[76.456077] Starting dynamic subtest: pipe-A-eDP-1
[76.465126] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[76.471926] Starting dynamic subtest: pipe-B-eDP-1
[76.491712] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[76.497667] Starting dynamic subtest: pipe-C-eDP-1
[76.505603] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[76.511584] Starting dynamic subtest: pipe-D-eDP-1
[76.519964] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[76.521614] Subtest ccs-on-another-bo-y-tiled-gen12-mc-ccs: SKIP (0.003s)
[78.674668] [005/133] (945s left) kms_flip (bo-too-big)
[78.771471] Starting subtest: bo-too-big
[78.773751] Starting dynamic subtest: A-eDP1
[80.122420] Dynamic subtest A-eDP1: SUCCESS (1.348s)
[80.134152] Starting dynamic subtest: B-eDP1
[81.442127] Dynamic subtest B-eDP1: SUCCESS (1.318s)
[81.450531] Starting dynamic subtest: C-eDP1
[82.773862] Dynamic subtest C-eDP1: SUCCESS (1.331s)
[82.782329] Starting dynamic subtest: D-eDP1
[84.108541] Dynamic subtest D-eDP1: SUCCESS (1.334s)
[84.110846] Subtest bo-too-big: SUCCESS (5.337s)
[85.324978] [006/133] (939s left) syncobj_timeline (multi-wait-available-unsubmitted-signaled)
[85.384186] Starting subtest: multi-wait-available-unsubmitted-signaled
[85.385131] Subtest multi-wait-available-unsubmitted-signaled: SUCCESS (0.000s)
[85.515557] [007/133] (939s left) kms_lease (lease-uevent)
[85.600573] Starting subtest: lease-uevent
[86.615509] Subtest lease-uevent: SUCCESS (1.013s)
[86.705680] [008/133] (937s left) gem_exec_fence (syncobj-timeline-wait)
[87.291503] Starting subtest: syncobj-timeline-wait
[88.932629] Subtest syncobj-timeline-wait: SUCCESS (1.642s)
[91.024584] [FACT gem_exec_fence (syncobj-timeline-wait)] new: kernel.kmod_is_loaded.vgem: true
[91.026203] [009/133] (933s left) kms_chamelium_color (gamma)
[91.122405] Subtest gamma: SKIP (0.000s)
[91.159192] [010/133] (933s left) prime_mmap (test_errors)
[91.215112] Starting subtest: test_errors
[91.216039] Starting dynamic subtest: test_errors-smem
[91.310643] Dynamic subtest test_errors-smem: SUCCESS (0.096s)
[91.311848] Subtest test_errors: SUCCESS (0.096s)
[91.451353] [011/133] (933s left) i915_drm_fdinfo (idle)
[91.486835] Starting subtest: idle
[91.487820] Starting dynamic subtest: rcs0
[92.070869] Dynamic subtest rcs0: SUCCESS (0.583s)
[92.080792] Starting dynamic subtest: bcs0
[92.577564] Dynamic subtest bcs0: SUCCESS (0.503s)
[92.587185] Starting dynamic subtest: vcs0
[93.081951] Dynamic subtest vcs0: SUCCESS (0.503s)
[93.090474] Starting dynamic subtest: vcs1
[93.587373] Dynamic subtest vcs1: SUCCESS (0.504s)
[93.595327] Starting dynamic subtest: vecs0
[94.091918] Dynamic subtest vecs0: SUCCESS (0.503s)
[94.099970] Starting dynamic subtest: ccs0
[94.596590] Dynamic subtest ccs0: SUCCESS (0.504s)
[94.598325] Subtest idle: SUCCESS (3.107s)
[94.687284] [012/133] (930s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-mmap-cpu)
[94.792365] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-mmap-cpu
[94.794258] Subtest fbc-2p-scndscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[94.917600] [013/133] (929s left) kms_invalid_mode (zero-hdisplay)
[95.007453] Starting subtest: zero-hdisplay
[95.008560] Starting dynamic subtest: pipe-A-eDP-1
[95.290062] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.282s)
[95.297814] Starting dynamic subtest: pipe-B-eDP-1
[95.298942] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[95.305084] Starting dynamic subtest: pipe-C-eDP-1
[95.305957] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[95.312138] Starting dynamic subtest: pipe-D-eDP-1
[95.312969] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[95.313838] Subtest zero-hdisplay: SUCCESS (0.286s)
[96.154729] [014/133] (928s left) kms_plane_scaling (planes-downscale-factor-0-75-unity-scaling)
[96.239885] Starting subtest: planes-downscale-factor-0-75-unity-scaling
[96.240762] Starting dynamic subtest: pipe-A
[96.304926] Dynamic subtest pipe-A: SUCCESS (0.065s)
[96.313222] Starting dynamic subtest: pipe-B
[97.466792] Dynamic subtest pipe-B: SUCCESS (1.160s)
[97.484408] Starting dynamic subtest: pipe-C
[98.578883] Dynamic subtest pipe-C: SUCCESS (1.111s)
[98.591401] Starting dynamic subtest: pipe-D
[99.724216] Dynamic subtest pipe-D: SUCCESS (1.145s)
[99.725167] Subtest planes-downscale-factor-0-75-unity-scaling: SUCCESS (3.485s)
[100.891674] [015/133] (924s left) drm_read (fault-buffer)
[101.042704] Starting subtest: fault-buffer
[101.043952] Subtest fault-buffer: SUCCESS (0.000s)
[101.207923] [016/133] (923s left) gem_ccs (suspend-resume)
[101.268648] Starting subtest: suspend-resume
[101.270371] Subtest suspend-resume: SKIP (0.000s)
[101.413205] [017/133] (923s left) kms_ccs (bad-rotation-90-4-tiled-dg2-rc-ccs)
[101.508519] Starting subtest: bad-rotation-90-4-tiled-dg2-rc-ccs
[101.509564] Starting dynamic subtest: pipe-A-eDP-1
[101.518621] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[101.526501] Starting dynamic subtest: pipe-B-eDP-1
[101.535244] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[101.541820] Starting dynamic subtest: pipe-C-eDP-1
[101.550263] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[101.556961] Starting dynamic subtest: pipe-D-eDP-1
[101.565571] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[101.567230] Subtest bad-rotation-90-4-tiled-dg2-rc-ccs: SKIP (0.003s)
[103.663022] [018/133] (921s left) gem_close (many-handles-one-vma)
[103.718129] Starting subtest: many-handles-one-vma
[103.744553] Subtest many-handles-one-vma: SUCCESS (0.027s)
[103.894590] [019/133] (921s left) gem_busy (extended)
[104.079608] Starting subtest: extended
[104.080764] Starting dynamic subtest: rcs0
[104.201666] Dynamic subtest rcs0: SUCCESS (0.122s)
[104.211770] Starting dynamic subtest: bcs0
[104.244508] Dynamic subtest bcs0: SUCCESS (0.042s)
[104.254045] Starting dynamic subtest: vcs0
[105.942305] Dynamic subtest vcs0: SUCCESS (1.694s)
[105.952121] Starting dynamic subtest: vcs1
[107.926500] Dynamic subtest vcs1: SUCCESS (1.983s)
[107.936774] Starting dynamic subtest: vecs0
[109.910372] Dynamic subtest vecs0: SUCCESS (1.982s)
[109.920545] Starting dynamic subtest: ccs0
[109.953397] Dynamic subtest ccs0: SUCCESS (0.045s)
[109.954611] Subtest extended: SUCCESS (5.874s)
[110.210807] [020/133] (914s left) kms_vblank (ts-continuation-suspend)
[110.293064] Starting subtest: ts-continuation-suspend
[110.294223] Starting dynamic subtest: pipe-A-eDP-1
[126.605920] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.915s)
[126.615650] Starting dynamic subtest: pipe-D-eDP-1
[144.596780] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.571s)
[144.597642] Subtest ts-continuation-suspend: SUCCESS (4.490s)
[151.428626] [021/133] (879s left) perf_pmu (semaphore-wait-idle)
[151.479536] Starting subtest: semaphore-wait-idle
[151.480732] Starting dynamic subtest: rcs0
[152.014463] Dynamic subtest rcs0: SUCCESS (0.518s)
[152.025291] Starting dynamic subtest: bcs0
[152.542773] Dynamic subtest bcs0: SUCCESS (0.513s)
[152.553406] Starting dynamic subtest: vcs0
[153.070215] Dynamic subtest vcs0: SUCCESS (0.514s)
[153.079925] Starting dynamic subtest: vcs1
[153.595853] Dynamic subtest vcs1: SUCCESS (0.512s)
[153.606068] Starting dynamic subtest: vecs0
[154.119128] Dynamic subtest vecs0: SUCCESS (0.512s)
[154.128620] Starting dynamic subtest: ccs0
[154.643057] Dynamic subtest ccs0: SUCCESS (0.512s)
[154.644431] Subtest semaphore-wait-idle: SUCCESS (3.090s)
[155.816820] [022/133] (875s left) kms_debugfs (display-off-read-all)
[155.921159] Starting subtest: display-off-read-all
[156.213269] Subtest display-off-read-all: SUCCESS (0.288s)
[157.043064] [023/133] (874s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-blt)
[157.142463] Starting subtest: fbc-rgb101010-draw-blt
[161.815360] Subtest fbc-rgb101010-draw-blt: SUCCESS (4.626s)
[163.000129] [024/133] (868s left) gem_ctx_param (invalid-get-no-zeromap)
[163.057425] Starting subtest: invalid-get-no-zeromap
[163.058424] Subtest invalid-get-no-zeromap: SUCCESS (0.001s)
[163.187822] [025/133] (868s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-mmap-gtt)
[163.281744] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-mmap-gtt
[163.283563] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[163.402317] [026/133] (867s left) gem_exec_big (single)
[163.468469] Starting subtest: single
[165.805846] Subtest single: SUCCESS (2.322s)
[166.041421] [027/133] (865s left) kms_frontbuffer_tracking (psr-rgb101010-draw-mmap-gtt)
[166.167859] Starting subtest: psr-rgb101010-draw-mmap-gtt
[166.169761] Subtest psr-rgb101010-draw-mmap-gtt: SKIP (0.000s)
[166.300288] [028/133] (865s left) gem_exec_flush (basic-uc-prw-default)
[166.374029] Starting subtest: basic-uc-prw-default
[171.854741] Subtest basic-uc-prw-default: SUCCESS (5.463s)
[172.059337] [029/133] (859s left) kms_frontbuffer_tracking (fbc-1p-shrfb-fliptrack-mmap-gtt)
[172.151644] Starting subtest: fbc-1p-shrfb-fliptrack-mmap-gtt
[172.153383] Subtest fbc-1p-shrfb-fliptrack-mmap-gtt: SKIP (0.000s)
[172.277233] [030/133] (859s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-shrfb-draw-render)
[172.372955] Starting subtest: psr-1p-offscreen-pri-shrfb-draw-render
[179.323848] Subtest psr-1p-offscreen-pri-shrfb-draw-render: SUCCESS (6.939s)
[179.482315] [031/133] (851s left) gem_exec_create (forked)
[179.547797] Starting subtest: forked
[179.548999] Starting dynamic subtest: smem
[200.717321] Dynamic subtest smem: SUCCESS (21.163s)
[200.718664] Subtest forked: SUCCESS (21.164s)
[200.922358] [032/133] (830s left) kms_feature_discovery (display-1x)
[201.040802] Starting subtest: display-1x
[201.041720] Subtest display-1x: SUCCESS (0.000s)
[201.130849] [033/133] (830s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-wc)
[201.233803] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-wc
[201.235620] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[201.361868] [034/133] (830s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-move)
[201.456465] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-move
[201.458213] Subtest fbcpsr-2p-primscrn-cur-indfb-move: SKIP (0.000s)
[201.585638] [035/133] (830s left) gem_render_copy_redux (interruptible)
[201.639004] Starting subtest: interruptible
[201.898791] Subtest interruptible: SUCCESS (0.260s)
[202.052533] [036/133] (829s left) i915_pm_rpm (system-suspend-execbuf)
[203.889011] Starting subtest: system-suspend-execbuf
[261.849529] Subtest system-suspend-execbuf: SUCCESS (42.805s)
[262.236018] [037/133] (769s left) kms_frontbuffer_tracking (psr-2p-scndscrn-indfb-plflip-blt)
[262.329191] Starting subtest: psr-2p-scndscrn-indfb-plflip-blt
[262.331052] Subtest psr-2p-scndscrn-indfb-plflip-blt: SKIP (0.000s)
[262.456697] [038/133] (769s left) gem_request_retire (retire-vma-not-inactive)
[262.514802] Starting subtest: retire-vma-not-inactive
[262.573892] Subtest retire-vma-not-inactive: SUCCESS (0.058s)
[262.744281] [039/133] (769s left) i915_pm_rps (thresholds-idle)
[262.797604] Starting subtest: thresholds-idle
[262.799674] Subtest thresholds-idle: SKIP (0.000s)
[262.938355] [040/133] (768s left) gem_ctx_persistence (legacy-engines-queued)
[263.008539] Starting subtest: legacy-engines-queued
[263.009461] Starting dynamic subtest: render
[263.128942] Dynamic subtest render: SUCCESS (0.121s)
[263.140936] Starting dynamic subtest: bsd1
[264.646904] Dynamic subtest bsd1: SUCCESS (1.513s)
[264.657068] Starting dynamic subtest: bsd2
[266.625556] Dynamic subtest bsd2: SUCCESS (1.978s)
[266.637330] Starting dynamic subtest: blt
[266.655989] Dynamic subtest blt: SUCCESS (0.029s)
[266.663448] Starting dynamic subtest: vebox
[268.612533] Dynamic subtest vebox: SUCCESS (1.952s)
[268.614303] Subtest legacy-engines-queued: SUCCESS (5.601s)
[268.711279] [041/133] (763s left) i915_hangman (gt-error-state-capture)
[268.779452] Starting subtest: gt-error-state-capture
[268.780397] Starting dynamic subtest: rcs0
[280.645863] Dynamic subtest rcs0: SUCCESS (11.859s)
[280.657814] Starting dynamic subtest: bcs0
[292.613459] Dynamic subtest bcs0: SUCCESS (11.960s)
[292.625364] Starting dynamic subtest: vcs0
[304.645884] Dynamic subtest vcs0: SUCCESS (12.024s)
[304.657255] Starting dynamic subtest: vcs1
[316.548082] Dynamic subtest vcs1: SUCCESS (11.895s)
[316.559074] Starting dynamic subtest: vecs0
[326.596815] Dynamic subtest vecs0: SUCCESS (10.046s)
[326.607746] Starting dynamic subtest: ccs0
[338.629424] Dynamic subtest ccs0: SUCCESS (12.034s)
[338.630714] Subtest gt-error-state-capture: SUCCESS (69.829s)
[338.785554] [042/133] (693s left) kms_cursor_crc (cursor-rapid-movement-128x42)
[339.014931] Starting subtest: cursor-rapid-movement-128x42
[339.054271] Subtest cursor-rapid-movement-128x42: SKIP (0.038s)
[339.286020] [043/133] (692s left) gem_partial_pwrite_pread (writes-after-reads-uncached)
[339.331454] Subtest writes-after-reads-uncached: SKIP (0.000s)
[339.402171] [044/133] (692s left) gem_mmap_wc (coherency)
[339.450642] Subtest coherency: SKIP (0.000s)
[339.505353] [045/133] (692s left) syncobj_timeline (single-wait-all-for-submit-signaled)
[339.556173] Starting subtest: single-wait-all-for-submit-signaled
[339.557223] Subtest single-wait-all-for-submit-signaled: SUCCESS (0.000s)
[339.675917] [046/133] (692s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-render)
[339.771258] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-render
[343.454397] Subtest fbc-1p-primscrn-cur-indfb-draw-render: SUCCESS (3.685s)
[344.872994] [047/133] (687s left) kms_psr (fbc-psr-primary-mmap-cpu)
[344.965543] Starting subtest: fbc-psr-primary-mmap-cpu
[344.966348] Starting dynamic subtest: eDP-1
[344.968062] Dynamic subtest eDP-1: SKIP (0.000s)
[344.969650] Subtest fbc-psr-primary-mmap-cpu: SKIP (0.001s)
[345.061969] [048/133] (686s left) kms_invalid_mode (bad-vsync-start)
[345.146526] Starting subtest: bad-vsync-start
[345.147401] Starting dynamic subtest: pipe-A-eDP-1
[345.428357] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.282s)
[345.436752] Starting dynamic subtest: pipe-B-eDP-1
[345.437626] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[345.445321] Starting dynamic subtest: pipe-C-eDP-1
[345.446201] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[345.454214] Starting dynamic subtest: pipe-D-eDP-1
[345.455077] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[345.455898] Subtest bad-vsync-start: SUCCESS (0.287s)
[346.299379] [049/133] (685s left) gem_exec_reloc (basic-wc-gtt)
[346.368488] Subtest basic-wc-gtt: SKIP (0.000s)
[346.453685] [050/133] (685s left) gem_mmap_gtt (cpuset-medium-copy-xy)
[346.508617] Subtest cpuset-medium-copy-XY: SKIP (0.000s)
[346.577951] [051/133] (685s left) kms_prop_blob (blob-multiple)
[346.635997] Starting subtest: blob-multiple
[346.636883] Subtest blob-multiple: SUCCESS (0.002s)
[346.768263] [052/133] (685s left) api_intel_allocator (open-vm)
[346.839408] Starting subtest: open-vm
[346.845139] Subtest open-vm: SUCCESS (0.006s)
[346.987233] [053/133] (685s left) kms_getfb (getfb-repeated-different-handles)
[347.079426] Starting subtest: getfb-repeated-different-handles
[347.080358] Subtest getfb-repeated-different-handles: SUCCESS (0.000s)
[347.205054] [054/133] (685s left) kms_content_protection (legacy-hdcp14)
[347.349561] Starting subtest: legacy-hdcp14
[347.351543] Subtest legacy-hdcp14: SKIP (0.000s)
[347.508249] [055/133] (684s left) kms_chamelium_hpd (hdmi-hpd-after-suspend)
[347.925045] Subtest hdmi-hpd-after-suspend: SKIP (0.000s)
[348.691392] [056/133] (683s left) kms_flip (blocking-absolute-wf_vblank)
[348.785236] Starting subtest: blocking-absolute-wf_vblank
[348.786258] Starting dynamic subtest: A-eDP1
[357.568336] Dynamic subtest A-eDP1: SUCCESS (8.782s)
[357.578702] Starting dynamic subtest: B-eDP1
[366.301814] Dynamic subtest B-eDP1: SUCCESS (8.732s)
[366.313238] Starting dynamic subtest: C-eDP1
[375.023627] Dynamic subtest C-eDP1: SUCCESS (8.719s)
[375.033534] Starting dynamic subtest: D-eDP1
[383.751217] Dynamic subtest D-eDP1: SUCCESS (8.725s)
[383.755332] Subtest blocking-absolute-wf_vblank: SUCCESS (34.966s)
[384.974280] [057/133] (647s left) gem_mmap_offset (bad-object)
[385.031441] Starting subtest: bad-object
[385.032406] Subtest bad-object: SUCCESS (0.001s)
[385.164617] [058/133] (647s left) kms_psr (psr2-no-drrs)
[385.259907] Starting subtest: psr2-no-drrs
[385.260894] Starting dynamic subtest: eDP-1
[386.845095] Dynamic subtest eDP-1: SUCCESS (1.584s)
[386.846099] Subtest psr2-no-drrs: SUCCESS (1.585s)
[387.664585] [059/133] (644s left) gem_fenced_exec_thrash (no-spare-fences-interruptible)
[387.726592] Subtest no-spare-fences-interruptible: SKIP (0.000s)
[387.786355] [060/133] (644s left) kms_vblank (wait-idle)
[387.885903] Starting subtest: wait-idle
[387.886873] Starting dynamic subtest: pipe-A-eDP-1
[389.659144] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.772s)
[389.669284] Starting dynamic subtest: pipe-D-eDP-1
[392.091101] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.428s)
[392.092063] Subtest wait-idle: SUCCESS (4.203s)
[392.940026] [061/133] (639s left) gem_exec_whisper (basic-contexts-all)
[393.010391] Starting subtest: basic-contexts-all
[404.614222] Subtest basic-contexts-all: SUCCESS (11.597s)
[404.818192] [062/133] (627s left) kms_big_fb (x-tiled-16bpp-rotate-0)
[404.917356] Starting subtest: x-tiled-16bpp-rotate-0
[406.152083] Subtest x-tiled-16bpp-rotate-0: SUCCESS (1.235s)
[406.305029] [063/133] (626s left) kms_atomic (plane-primary-overlay-mutable-zpos)
[406.403955] Starting subtest: plane-primary-overlay-mutable-zpos
[409.860303] Subtest plane-primary-overlay-mutable-zpos: SKIP (3.455s)
[411.065687] [064/133] (621s left) gen9_exec_parse (bb-start-cmd)
[411.132598] Subtest bb-start-cmd: SKIP (0.000s)
[411.196833] [065/133] (621s left) kms_cursor_crc (cursor-alpha-opaque)
[411.295491] Starting subtest: cursor-alpha-opaque
[411.296414] Starting dynamic subtest: pipe-A-eDP-1
[411.899079] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.604s)
[411.907602] Starting dynamic subtest: pipe-D-eDP-1
[413.137613] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.236s)
[413.138515] Subtest cursor-alpha-opaque: SUCCESS (1.843s)
[413.947671] [066/133] (618s left) kms_cursor_crc (cursor-sliding-64x64)
[414.138725] Starting subtest: cursor-sliding-64x64
[414.144398] Starting dynamic subtest: pipe-A-eDP-1
[417.391179] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.246s)
[417.418990] Starting dynamic subtest: pipe-D-eDP-1
[421.312692] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.899s)
[421.313544] Subtest cursor-sliding-64x64: SUCCESS (7.171s)
[422.214267] [067/133] (610s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-render)
[422.309491] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-render
[429.024062] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-render: SUCCESS (6.713s)
[429.181803] [068/133] (603s left) gem_ctx_shared (exec-single-timeline)
[429.248524] Starting subtest: exec-single-timeline
[429.249514] Starting dynamic subtest: rcs0
[430.274883] Dynamic subtest rcs0: SUCCESS (1.025s)
[430.286128] Starting dynamic subtest: bcs0
[431.363461] Dynamic subtest bcs0: SUCCESS (1.085s)
[431.374665] Starting dynamic subtest: vcs0
[432.453155] Dynamic subtest vcs0: SUCCESS (1.086s)
[432.464837] Starting dynamic subtest: vcs1
[433.539825] Dynamic subtest vcs1: SUCCESS (1.084s)
[433.550756] Starting dynamic subtest: vecs0
[434.627303] Dynamic subtest vecs0: SUCCESS (1.084s)
[434.637734] Starting dynamic subtest: ccs0
[435.716521] Dynamic subtest ccs0: SUCCESS (1.087s)
[435.717725] Subtest exec-single-timeline: SUCCESS (6.467s)
[436.786932] [069/133] (595s left) kms_plane_scaling (plane-downscale-factor-0-75-with-pixel-format)
[436.881577] Starting subtest: plane-downscale-factor-0-75-with-pixel-format
[436.882446] Starting dynamic subtest: pipe-A
[438.011615] Dynamic subtest pipe-A: SUCCESS (1.130s)
[438.022348] Starting dynamic subtest: pipe-B
[440.197529] Dynamic subtest pipe-B: SUCCESS (2.184s)
[440.206847] Starting dynamic subtest: pipe-C
[441.351036] Dynamic subtest pipe-C: SUCCESS (1.152s)
[441.360768] Starting dynamic subtest: pipe-D
[442.489406] Dynamic subtest pipe-D: SUCCESS (1.131s)
[442.510348] Subtest plane-downscale-factor-0-75-with-pixel-format: SUCCESS (5.601s)
[443.696061] [070/133] (589s left) gem_wait (write-busy)
[443.757748] Starting subtest: write-busy
[443.758807] Starting dynamic subtest: all-engines
[444.405730] Dynamic subtest all-engines: SUCCESS (0.647s)
[444.420986] Starting dynamic subtest: rcs0
[444.960780] Dynamic subtest rcs0: SUCCESS (0.552s)
[444.976506] Starting dynamic subtest: bcs0
[445.510920] Dynamic subtest bcs0: SUCCESS (0.549s)
[445.526650] Starting dynamic subtest: vcs0
[446.693996] Dynamic subtest vcs0: SUCCESS (1.179s)
[446.708676] Starting dynamic subtest: vcs1
[448.678546] Dynamic subtest vcs1: SUCCESS (1.981s)
[448.693970] Starting dynamic subtest: vecs0
[450.662742] Dynamic subtest vecs0: SUCCESS (1.980s)
[450.677982] Starting dynamic subtest: ccs0
[451.215431] Dynamic subtest ccs0: SUCCESS (0.552s)
[451.217067] Subtest write-busy: SUCCESS (7.455s)
[451.433697] [071/133] (581s left) kms_big_fb (y-tiled-8bpp-rotate-0)
[451.537147] Starting subtest: y-tiled-8bpp-rotate-0
[451.538973] Subtest y-tiled-8bpp-rotate-0: SKIP (0.000s)
[451.686003] [072/133] (581s left) kms_cursor_legacy (basic-busy-flip-before-cursor-legacy)
[451.803061] Starting subtest: basic-busy-flip-before-cursor-legacy
[451.804855] Subtest basic-busy-flip-before-cursor-legacy: SKIP (0.000s)
[451.973610] [073/133] (580s left) gem_basic (bad-close)
[452.035080] Starting subtest: bad-close
[452.037185] Subtest bad-close: SUCCESS (0.000s)
[452.161631] [074/133] (580s left) kms_big_fb (linear-16bpp-rotate-0)
[452.254920] Starting subtest: linear-16bpp-rotate-0
[453.544534] Subtest linear-16bpp-rotate-0: SUCCESS (1.291s)
[453.716009] [075/133] (579s left) kms_psr2_sf (pr-overlay-plane-update-continuous-sf)
[458.757008] Starting subtest: pr-overlay-plane-update-continuous-sf
[458.759024] Subtest pr-overlay-plane-update-continuous-sf: SKIP (0.002s)
[459.642892] [076/133] (573s left) drm_read (short-buffer-wakeup)
[459.787154] Starting subtest: short-buffer-wakeup
[491.998719] Subtest short-buffer-wakeup: SUCCESS (32.215s)
[492.171060] [077/133] (540s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-pwrite)
[492.252265] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-pwrite
[499.194208] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-pwrite: SUCCESS (6.942s)
[499.359231] [078/133] (533s left) kms_psr (fbc-pr-cursor-render)
[499.450483] Starting subtest: fbc-pr-cursor-render
[499.452024] Subtest fbc-pr-cursor-render: SKIP (0.000s)
[499.540638] [079/133] (533s left) kms_ccs (crc-primary-suspend-y-tiled-gen12-mc-ccs)
[499.635801] Starting subtest: crc-primary-suspend-y-tiled-gen12-mc-ccs
[499.636591] Starting dynamic subtest: pipe-A-eDP-1
[499.639904] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[499.648289] Starting dynamic subtest: pipe-B-eDP-1
[499.651541] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[499.659656] Starting dynamic subtest: pipe-C-eDP-1
[499.662952] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[499.670916] Starting dynamic subtest: pipe-D-eDP-1
[499.674119] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[499.675691] Subtest crc-primary-suspend-y-tiled-gen12-mc-ccs: SKIP (0.005s)
[501.826425] [080/133] (531s left) kms_ccs (random-ccs-data-4-tiled-mtl-mc-ccs)
[501.924185] Starting subtest: random-ccs-data-4-tiled-mtl-mc-ccs
[501.925153] Starting dynamic subtest: pipe-A-eDP-1
[503.197922] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.274s)
[503.207930] Starting dynamic subtest: pipe-B-eDP-1
[505.558875] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.359s)
[505.568533] Starting dynamic subtest: pipe-C-eDP-1
[507.901761] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.341s)
[507.911282] Starting dynamic subtest: pipe-D-eDP-1
[510.242061] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.339s)
[510.243025] Subtest random-ccs-data-4-tiled-mtl-mc-ccs: SUCCESS (8.319s)
[511.476681] [081/133] (521s left) sw_sync (sync_multi_timeline_wait)
[511.506362] Starting subtest: sync_multi_timeline_wait
[511.507334] Subtest sync_multi_timeline_wait: SUCCESS (0.000s)
[511.577030] [082/133] (521s left) sysfs_heartbeat_interval (idempotent)
[511.637462] Starting subtest: idempotent
[511.638524] Starting dynamic subtest: vecs0
[511.639511] Dynamic subtest vecs0: SUCCESS (0.001s)
[511.648959] Starting dynamic subtest: ccs0
[511.649865] Dynamic subtest ccs0: SUCCESS (0.001s)
[511.658048] Starting dynamic subtest: vcs0
[511.659162] Dynamic subtest vcs0: SUCCESS (0.000s)
[511.668781] Starting dynamic subtest: bcs0
[511.669675] Dynamic subtest bcs0: SUCCESS (0.001s)
[511.677754] Starting dynamic subtest: rcs0
[511.678568] Dynamic subtest rcs0: SUCCESS (0.001s)
[511.686583] Starting dynamic subtest: vcs1
[511.687416] Dynamic subtest vcs1: SUCCESS (0.000s)
[511.688316] Subtest idempotent: SUCCESS (0.008s)
[511.776177] [083/133] (521s left) syncobj_eventfd (invalid-bad-pad)
[511.835799] Starting subtest: invalid-bad-pad
[511.836907] Subtest invalid-bad-pad: SUCCESS (0.000s)
[511.946010] [084/133] (521s left) kms_busy (extended-pageflip-hang-newfb)
[512.044065] Starting subtest: extended-pageflip-hang-newfb
[512.045006] Starting dynamic subtest: pipe-A
[538.425516] Dynamic subtest pipe-A: SUCCESS (26.379s)
[538.435202] Starting dynamic subtest: pipe-D
[563.457532] Dynamic subtest pipe-D: SUCCESS (25.025s)
[563.458585] Subtest extended-pageflip-hang-newfb: SUCCESS (51.409s)
[564.323782] [085/133] (469s left) kms_psr2_sf (psr2-cursor-plane-update-sf)
[569.307389] Starting subtest: psr2-cursor-plane-update-sf
[569.310387] Starting dynamic subtest: pipe-A-eDP-1
[570.607302] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.299s)
[570.618266] Starting dynamic subtest: pipe-B-eDP-1
[571.932163] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.321s)
[571.933063] Subtest psr2-cursor-plane-update-sf: SUCCESS (2.624s)
[572.827285] [086/133] (460s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-0-async-flip)
[572.926956] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-0-async-flip
[573.585687] Subtest x-tiled-max-hw-stride-32bpp-rotate-0-async-flip: SUCCESS (0.659s)
[573.766532] [087/133] (459s left) gem_exec_balancer (busy)
[573.821289] Starting subtest: busy
[575.680535] Subtest busy: SUCCESS (1.856s)
[576.021508] [088/133] (457s left) kms_frontbuffer_tracking (fbc-2p-primscrn-shrfb-msflip-blt)
[576.113706] Starting subtest: fbc-2p-primscrn-shrfb-msflip-blt
[576.115540] Subtest fbc-2p-primscrn-shrfb-msflip-blt: SKIP (0.000s)
[576.242808] [089/133] (457s left) vgem_slow (nohang)
[576.274911] Starting subtest: nohang
[586.563743] Subtest nohang: SUCCESS (10.285s)
[586.647866] [090/133] (446s left) gem_spin_batch (resubmit-new-all)
[586.709117] Starting subtest: resubmit-new-all
[586.710005] Starting dynamic subtest: rcs0
[586.734021] Dynamic subtest rcs0: SUCCESS (0.026s)
[586.743966] Starting dynamic subtest: bcs0
[586.755964] Dynamic subtest bcs0: SUCCESS (0.021s)
[586.764554] Starting dynamic subtest: vcs0
[586.776043] Dynamic subtest vcs0: SUCCESS (0.019s)
[586.785904] Starting dynamic subtest: vcs1
[586.794636] Dynamic subtest vcs1: SUCCESS (0.017s)
[586.802869] Starting dynamic subtest: vecs0
[586.812688] Dynamic subtest vecs0: SUCCESS (0.017s)
[586.820878] Starting dynamic subtest: ccs0
[586.829016] Dynamic subtest ccs0: SUCCESS (0.016s)
[586.829959] Subtest resubmit-new-all: SUCCESS (0.122s)
[588.710794] [091/133] (444s left) gem_render_copy (mixed-tiled-to-y-tiled-ccs)
[588.776048] Starting subtest: mixed-tiled-to-y-tiled-ccs
[588.778014] Subtest mixed-tiled-to-y-tiled-ccs: SKIP (0.000s)
[588.983213] [092/133] (444s left) syncobj_timeline (invalid-signal-illegal-point)
[589.035081] Starting subtest: invalid-signal-illegal-point
[589.036010] Subtest invalid-signal-illegal-point: SUCCESS (0.000s)
[589.150951] [093/133] (444s left) gem_exec_schedule (preempt-contexts)
[589.203514] Starting subtest: preempt-contexts
[589.204330] Starting dynamic subtest: rcs0
[589.292746] Dynamic subtest rcs0: SUCCESS (0.089s)
[589.302533] Starting dynamic subtest: bcs0
[589.390142] Dynamic subtest bcs0: SUCCESS (0.096s)
[589.402022] Starting dynamic subtest: vcs0
[589.454742] Dynamic subtest vcs0: SUCCESS (0.063s)
[589.463925] Starting dynamic subtest: vcs1
[589.515222] Dynamic subtest vcs1: SUCCESS (0.060s)
[589.524007] Starting dynamic subtest: vecs0
[589.572833] Dynamic subtest vecs0: SUCCESS (0.057s)
[589.581298] Starting dynamic subtest: ccs0
[589.654509] Dynamic subtest ccs0: SUCCESS (0.081s)
[589.655458] Subtest preempt-contexts: SUCCESS (0.451s)
[590.766307] [094/133] (442s left) gem_pwrite_snooped
[590.896850] [095/133] (442s left) kms_tiled_display (basic-test-pattern)
[591.012546] Subtest basic-test-pattern: SKIP (0.000s)
[591.052779] [096/133] (442s left) kms_frontbuffer_tracking (psr-shrfb-scaledprimary)
[591.144268] Starting subtest: psr-shrfb-scaledprimary
[596.895454] Subtest psr-shrfb-scaledprimary: SUCCESS (5.751s)
[597.012049] [097/133] (436s left) kms_frontbuffer_tracking (fbcpsr-1p-shrfb-fliptrack-mmap-gtt)
[597.107381] Starting subtest: fbcpsr-1p-shrfb-fliptrack-mmap-gtt
[597.109217] Subtest fbcpsr-1p-shrfb-fliptrack-mmap-gtt: SKIP (0.000s)
[597.219991] [098/133] (436s left) gem_pwrite (basic-self)
[597.283080] Subtest basic-self: SKIP (0.000s)
[597.353798] [099/133] (436s left) kms_pm_rpm (dpms-mode-unset-non-lpsp)
[598.862021] Starting subtest: dpms-mode-unset-non-lpsp
[600.013302] Subtest dpms-mode-unset-non-lpsp: SKIP (1.151s)
[600.399249] [100/133] (433s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip)
[600.510973] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip
[600.513124] Subtest yf-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip: SKIP (0.000s)
[600.644892] [101/133] (433s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-render)
[600.739577] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-render
[600.741192] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-render: SKIP (0.000s)
[600.865888] [102/133] (433s left) kms_color_pipeline (plane-lut1d-ctm3x4-lut1d)
[600.983766] Starting subtest: plane-lut1d-ctm3x4-lut1d
[600.997171] Starting dynamic subtest: pipe-A-eDP-1
[601.468182] Dynamic subtest pipe-A-eDP-1: FAIL (0.323s)
[602.377731] Starting dynamic subtest: pipe-B-eDP-1
[602.855343] Dynamic subtest pipe-B-eDP-1: FAIL (0.291s)
[603.707631] Starting dynamic subtest: pipe-C-eDP-1
[604.175074] Dynamic subtest pipe-C-eDP-1: FAIL (0.258s)
[605.036421] Starting dynamic subtest: pipe-D-eDP-1
[605.485423] Dynamic subtest pipe-D-eDP-1: FAIL (0.235s)
[605.555102] Subtest plane-lut1d-ctm3x4-lut1d: FAIL (4.571s)
[606.437233] [103/133] (427s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-render)
[606.536922] Starting subtest: psr-1p-primscrn-spr-indfb-draw-render
[613.306310] Subtest psr-1p-primscrn-spr-indfb-draw-render: SUCCESS (6.768s)
[613.451710] [104/133] (420s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-onoff)
[613.543265] Starting subtest: psr-1p-primscrn-cur-indfb-onoff
[620.549677] Subtest psr-1p-primscrn-cur-indfb-onoff: SUCCESS (7.005s)
[620.731131] [105/133] (413s left) gem_exec_schedule (preempt-queue-contexts-chain)
[620.797904] Subtest preempt-queue-contexts-chain: SKIP (0.000s)
[621.104186] [106/133] (412s left) api_intel_bb (object-noreloc-keep-cache-simple)
[621.171537] Starting subtest: object-noreloc-keep-cache-simple
[621.177575] Subtest object-noreloc-keep-cache-simple: SUCCESS (0.008s)
[621.339880] [107/133] (412s left) gem_mmap (bad-object)
[621.397980] Subtest bad-object: SKIP (0.000s)
[621.467566] [108/133] (412s left) kms_flip_scaled_crc (flip-32bpp-yftileccs-to-64bpp-yftile-upscaling)
[621.564897] Starting subtest: flip-32bpp-yftileccs-to-64bpp-yftile-upscaling
[621.565793] Starting dynamic subtest: pipe-A-default-mode
[621.855955] Dynamic subtest pipe-A-default-mode: SKIP (0.289s)
[621.857618] Subtest flip-32bpp-yftileccs-to-64bpp-yftile-upscaling: SKIP (0.291s)
[622.717661] [109/133] (411s left) kms_addfb_basic (bo-too-small-due-to-tiling)
[622.819488] Starting subtest: bo-too-small-due-to-tiling
[622.821424] Subtest bo-too-small-due-to-tiling: SKIP (0.000s)
[622.964862] [110/133] (411s left) kms_psr (pr-sprite-blt)
[623.056582] Starting subtest: pr-sprite-blt
[623.058297] Subtest pr-sprite-blt: SKIP (0.000s)
[623.148648] [111/133] (411s left) kms_draw_crc (fill-fb)
[623.240006] Starting subtest: fill-fb
[623.770753] Subtest fill-fb: SUCCESS (0.531s)
[623.876685] [112/133] (410s left) perf_pmu (busy-idle)
[623.915723] Starting subtest: busy-idle
[623.916673] Starting dynamic subtest: rcs0
[624.630339] Dynamic subtest rcs0: SUCCESS (0.715s)
[624.642692] Starting dynamic subtest: bcs0
[625.311422] Dynamic subtest bcs0: SUCCESS (0.678s)
[625.323283] Starting dynamic subtest: vcs0
[626.663242] Dynamic subtest vcs0: SUCCESS (1.346s)
[626.673016] Starting dynamic subtest: vcs1
[628.647124] Dynamic subtest vcs1: SUCCESS (1.980s)
[628.658048] Starting dynamic subtest: vecs0
[630.695362] Dynamic subtest vecs0: SUCCESS (2.044s)
[630.706676] Starting dynamic subtest: ccs0
[631.371310] Dynamic subtest ccs0: SUCCESS (0.675s)
[631.375046] Subtest busy-idle: SUCCESS (7.456s)
[631.498925] [113/133] (402s left) kms_ccs (crc-sprite-planes-basic-4-tiled-dg2-mc-ccs)
[631.591906] Starting subtest: crc-sprite-planes-basic-4-tiled-dg2-mc-ccs
[631.592962] Starting dynamic subtest: pipe-A-eDP-1
[631.616073] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[631.626350] Starting dynamic subtest: pipe-B-eDP-1
[631.647880] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[631.657230] Starting dynamic subtest: pipe-C-eDP-1
[631.678623] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[631.686713] Starting dynamic subtest: pipe-D-eDP-1
[631.707712] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[631.709330] Subtest crc-sprite-planes-basic-4-tiled-dg2-mc-ccs: SKIP (0.009s)
[633.780345] [114/133] (400s left) gem_exec_flush (basic-batch-kernel-default-uc)
[633.845405] Starting subtest: basic-batch-kernel-default-uc
[640.875877] Subtest basic-batch-kernel-default-uc: SUCCESS (7.028s)
[641.089582] [115/133] (393s left) gem_mmap_wc (write-read-distinct)
[641.153706] Subtest write-read-distinct: SKIP (0.000s)
[641.219350] [116/133] (393s left) kms_plane_lowres (tiling-x)
[641.322638] Starting subtest: tiling-x
[641.323539] Starting dynamic subtest: pipe-A-eDP-1
[641.325493] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[641.619740] Starting dynamic subtest: pipe-B-eDP-1
[641.621555] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[641.629868] Starting dynamic subtest: pipe-C-eDP-1
[641.631844] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[641.640562] Starting dynamic subtest: pipe-D-eDP-1
[641.642659] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[641.644329] Subtest tiling-x: SKIP (0.295s)
[642.510894] [117/133] (392s left) sw_sync (alloc_merge_fence)
[642.539547] Starting subtest: alloc_merge_fence
[642.540410] Subtest alloc_merge_fence: SUCCESS (0.000s)
[642.608069] [118/133] (391s left) kms_pm_backlight (fade)
[642.691931] Starting subtest: fade
[642.743217] Starting dynamic subtest: eDP-1
[645.432972] Dynamic subtest eDP-1: SUCCESS (2.688s)
[645.434031] Subtest fade: SUCCESS (2.741s)
[646.248552] [119/133] (388s left) kms_flip_scaled_crc (flip-64bpp-xtile-to-32bpp-xtile-downscaling)
[646.331566] Starting subtest: flip-64bpp-xtile-to-32bpp-xtile-downscaling
[646.332596] Starting dynamic subtest: pipe-A-default-mode
[647.492889] Dynamic subtest pipe-A-default-mode: SKIP (1.160s)
[647.494649] Subtest flip-64bpp-xtile-to-32bpp-xtile-downscaling: SKIP (1.161s)
[647.661348] [120/133] (386s left) syncobj_wait (multi-wait-all-for-submit-unsubmitted-signaled)
[647.711876] Starting subtest: multi-wait-all-for-submit-unsubmitted-signaled
[647.818860] Subtest multi-wait-all-for-submit-unsubmitted-signaled: SUCCESS (0.105s)
[647.911561] [121/133] (386s left) kms_psr (psr-cursor-mmap-cpu)
[648.005041] Starting subtest: psr-cursor-mmap-cpu
[648.006019] Starting dynamic subtest: eDP-1
[649.754312] Dynamic subtest eDP-1: SUCCESS (1.748s)
[649.755265] Subtest psr-cursor-mmap-cpu: SUCCESS (1.749s)
[650.637156] [122/133] (384s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-180-async-flip)
[650.743343] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-180-async-flip
[651.391561] Subtest 4-tiled-max-hw-stride-32bpp-rotate-180-async-flip: SUCCESS (0.648s)
[651.591214] [123/133] (383s left) gem_exec_whisper (basic-queues-priority-all)
[651.652855] Starting subtest: basic-queues-priority-all
[674.110196] Subtest basic-queues-priority-all: SUCCESS (22.448s)
[674.315066] [124/133] (360s left) syncobj_timeline (etime-single-wait-all-submitted)
[674.367819] Starting subtest: etime-single-wait-all-submitted
[674.474294] Subtest etime-single-wait-all-submitted: SUCCESS (0.104s)
[674.570341] [125/133] (360s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-onoff)
[674.655351] Starting subtest: fbc-2p-primscrn-spr-indfb-onoff
[674.657107] Subtest fbc-2p-primscrn-spr-indfb-onoff: SKIP (0.000s)
[674.769776] [126/133] (360s left) kms_async_flips (async-flip-dpms)
[674.848534] Starting subtest: async-flip-dpms
[675.229363] Starting dynamic subtest: pipe-A-eDP-1
[679.036194] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.806s)
[679.408751] Starting dynamic subtest: pipe-B-eDP-1
[682.197559] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.798s)
[682.571303] Starting dynamic subtest: pipe-C-eDP-1
[685.372231] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.808s)
[685.746958] Starting dynamic subtest: pipe-D-eDP-1
[688.540469] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.800s)
[688.541412] Subtest async-flip-dpms: SUCCESS (13.690s)
[689.739322] [127/133] (345s left) gem_exec_reloc (basic-cpu-read-noreloc)
[689.805278] Subtest basic-cpu-read-noreloc: SKIP (0.000s)
[689.876668] [128/133] (345s left) syncobj_wait (invalid-reset-illegal-handle)
[689.929219] Starting subtest: invalid-reset-illegal-handle
[689.930135] Subtest invalid-reset-illegal-handle: SUCCESS (0.000s)
[690.053166] [129/133] (344s left) syncobj_wait (multi-wait-all-for-submit-unsubmitted-submitted)
[690.103128] Starting subtest: multi-wait-all-for-submit-unsubmitted-submitted
[690.211326] Subtest multi-wait-all-for-submit-unsubmitted-submitted: SUCCESS (0.105s)
[690.303238] [130/133] (344s left) gem_tiled_swapping (non-threaded)
[690.360381] Subtest non-threaded: SKIP (0.000s)
[690.422786] [131/133] (344s left) gem_exec_fence (syncobj-timeline-chain-engines)
[691.013284] Starting subtest: syncobj-timeline-chain-engines
[691.135961] Subtest syncobj-timeline-chain-engines: SUCCESS (0.123s)
[692.784095] [132/133] (342s left) kms_cursor_legacy (flip-vs-cursor-legacy)
[692.908465] Starting subtest: flip-vs-cursor-legacy
[700.011460] Subtest flip-vs-cursor-legacy: SUCCESS (7.100s)
[700.859414] [133/133] (334s left) syncobj_basic (illegal-fd-to-handle)
[700.919942] Starting subtest: illegal-fd-to-handle
[700.920841] Subtest illegal-fd-to-handle: SUCCESS (0.000s)
[701.046679] 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.