[56.204010] Initializing watchdogs
[56.204058]   /dev/watchdog0
[56.218498] [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]
[56.222907] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[56.225141] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[56.228954] [001/156] (960s left) kms_plane (pixel-format-4-tiled-mtl-rc-ccs-modifier)
[56.348944] Starting subtest: pixel-format-4-tiled-mtl-rc-ccs-modifier
[56.387770] Starting dynamic subtest: pipe-A-plane-0
[56.696695] Dynamic subtest pipe-A-plane-0: SUCCESS (0.300s)
[56.706097] Starting dynamic subtest: pipe-A-plane-3
[56.936461] Dynamic subtest pipe-A-plane-3: SUCCESS (0.232s)
[56.946026] Starting dynamic subtest: pipe-A-plane-5
[56.951150] Dynamic subtest pipe-A-plane-5: SKIP (0.000s)
[58.373505] Starting dynamic subtest: pipe-B-plane-0
[58.661480] Dynamic subtest pipe-B-plane-0: SUCCESS (0.289s)
[58.671897] Starting dynamic subtest: pipe-B-plane-3
[58.900401] Dynamic subtest pipe-B-plane-3: SUCCESS (0.233s)
[58.907932] Starting dynamic subtest: pipe-B-plane-5
[58.914808] Dynamic subtest pipe-B-plane-5: SKIP (0.000s)
[59.224186] Subtest pixel-format-4-tiled-mtl-rc-ccs-modifier: SUCCESS (2.808s)
[60.101600] [002/156] (956s left) kms_setmode (invalid-clone-single-crtc-stealing)
[60.172134] Starting subtest: invalid-clone-single-crtc-stealing
[60.178886] Subtest invalid-clone-single-crtc-stealing: SKIP (0.000s)
[60.272607] [003/156] (956s left) syncobj_timeline (invalid-transfer-illegal-handle)
[60.335795] Starting subtest: invalid-transfer-illegal-handle
[60.338076] Subtest invalid-transfer-illegal-handle: SUCCESS (0.000s)
[60.439506] [004/156] (956s left) kms_frontbuffer_tracking (fbchdr-1p-offscreen-pri-indfb-draw-mmap-cpu)
[60.540735] Starting subtest: fbchdr-1p-offscreen-pri-indfb-draw-mmap-cpu
[60.544960] Subtest fbchdr-1p-offscreen-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[60.633099] [005/156] (956s left) syncobj_timeline (single-wait-signaled)
[60.685170] Starting subtest: single-wait-signaled
[60.687609] Subtest single-wait-signaled: SUCCESS (0.000s)
[60.801592] [006/156] (956s left) kms_addfb_basic (basic-x-tiled-legacy)
[60.854860] Starting subtest: basic-x-tiled-legacy
[60.859077] Subtest basic-x-tiled-legacy: SKIP (0.000s)
[60.998624] [007/156] (955s left) syncobj_wait (invalid-reset-bad-pad)
[61.046896] Starting subtest: invalid-reset-bad-pad
[61.048993] Subtest invalid-reset-bad-pad: SUCCESS (0.000s)
[61.160931] [008/156] (955s left) gem_ctx_freq (sysfs)
[61.219233] Starting subtest: sysfs
[61.221335] Starting dynamic subtest: gt0
[66.743367] Dynamic subtest gt0: SUCCESS (5.467s)
[66.751199] Starting dynamic subtest: gt1
[108.290321] Dynamic subtest gt1: SUCCESS (41.481s)
[108.292984] Subtest sysfs: SUCCESS (46.949s)
[108.434386] [009/156] (908s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling)
[108.543855] Starting subtest: flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling
[108.547935] Subtest flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling: SKIP (0.000s)
[108.613937] [010/156] (908s left) syncobj_timeline (etime-multi-wait-for-submit-available-unsubmitted)
[108.665085] Starting subtest: etime-multi-wait-for-submit-available-unsubmitted
[108.765617] Subtest etime-multi-wait-for-submit-available-unsubmitted: SUCCESS (0.102s)
[108.850632] [011/156] (908s left) prime_mmap_coherency (write)
[108.907353] Starting subtest: write
[114.284151] Subtest write: SUCCESS (5.374s)
[114.426997] [012/156] (902s left) gem_render_copy (y-tiled-ccs-to-x-tiled)
[114.496647] Starting subtest: y-tiled-ccs-to-x-tiled
[114.501484] Subtest y-tiled-ccs-to-x-tiled: SKIP (0.000s)
[114.678690] [013/156] (902s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-mmap-cpu)
[114.789135] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-mmap-cpu
[121.893908] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-mmap-cpu: SUCCESS (7.109s)
[122.006320] [014/156] (895s left) kms_plane_scaling (intel-max-src-size)
[122.104996] Starting subtest: intel-max-src-size
[122.111573] Subtest intel-max-src-size: SKIP (0.000s)
[122.189886] [015/156] (895s left) perf (oa-formats)
[122.306293] Starting subtest: oa-formats
[122.308746] Starting dynamic subtest: 0-rcs0
[122.322573] Dynamic subtest 0-rcs0: SUCCESS (0.018s)
[122.330803] Starting dynamic subtest: 1-vcs0
[122.344714] Dynamic subtest 1-vcs0: SUCCESS (0.022s)
[122.346974] Subtest oa-formats: SUCCESS (0.040s)
[122.389083] [016/156] (894s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-shrfb-pgflip-blt)
[122.486424] Starting subtest: fbcpsr-2p-scndscrn-shrfb-pgflip-blt
[122.490530] Subtest fbcpsr-2p-scndscrn-shrfb-pgflip-blt: SKIP (0.000s)
[122.586171] [017/156] (894s left) gem_exec_fence (syncobj-repeat)
[123.060810] Starting subtest: syncobj-repeat
[123.240645] Subtest syncobj-repeat: SUCCESS (0.178s)
[124.343671] [FACT gem_exec_fence (syncobj-repeat)] new: kernel.kmod_is_loaded.vgem: true
[124.347505] [018/156] (893s left) gem_fenced_exec_thrash (no-spare-fences)
[124.407595] Subtest no-spare-fences: SKIP (0.000s)
[124.473564] [019/156] (892s left) kms_hdr (static-toggle-dpms)
[124.556734] Starting subtest: static-toggle-dpms
[124.559089] Starting dynamic subtest: pipe-A-eDP-1-XRGB2101010
[124.563473] Dynamic subtest pipe-A-eDP-1-XRGB2101010: SKIP (0.000s)
[124.572828] Starting dynamic subtest: pipe-A-eDP-1-XRGB16161616F
[124.577081] Dynamic subtest pipe-A-eDP-1-XRGB16161616F: SKIP (0.000s)
[124.581310] Subtest static-toggle-dpms: SKIP (0.002s)
[124.626203] [020/156] (892s left) gem_exec_params (no-bsd)
[124.673864] Starting subtest: no-bsd
[124.678748] Subtest no-bsd: SUCCESS (0.002s)
[126.352825] [021/156] (891s left) kms_content_protection (dp-mst-lic-type-1)
[126.503234] Starting subtest: dp-mst-lic-type-1
[126.507730] Subtest dp-mst-lic-type-1: SKIP (0.000s)
[126.630168] [022/156] (890s left) kms_frontbuffer_tracking (psrhdr-1p-primscrn-pri-shrfb-draw-pwrite)
[126.733674] Starting subtest: psrhdr-1p-primscrn-pri-shrfb-draw-pwrite
[126.737974] Subtest psrhdr-1p-primscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[126.814445] [023/156] (890s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-mmap-cpu)
[126.907448] Starting subtest: psr-2p-primscrn-spr-indfb-draw-mmap-cpu
[126.911605] Subtest psr-2p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[126.990994] [024/156] (890s left) kms_chamelium_frames (dp-frame-dump)
[127.373119] Subtest dp-frame-dump: SKIP (0.000s)
[128.162384] [025/156] (889s left) kms_frontbuffer_tracking (fbchdr-suspend)
[128.265343] Starting subtest: fbchdr-suspend
[128.269722] Subtest fbchdr-suspend: SKIP (0.000s)
[128.359855] [026/156] (889s left) kms_frontbuffer_tracking (psrhdr-2p-primscrn-pri-indfb-draw-mmap-gtt)
[128.460964] Starting subtest: psrhdr-2p-primscrn-pri-indfb-draw-mmap-gtt
[128.465267] Subtest psrhdr-2p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[128.552888] [027/156] (889s left) kms_cursor_legacy (nonblocking-modeset-vs-cursor-atomic)
[128.675346] Starting subtest: nonblocking-modeset-vs-cursor-atomic
[130.157916] Subtest nonblocking-modeset-vs-cursor-atomic: SUCCESS (1.483s)
[131.041140] [028/156] (886s left) kms_big_fb (y-tiled-16bpp-rotate-270)
[131.150731] Starting subtest: y-tiled-16bpp-rotate-270
[131.154966] Subtest y-tiled-16bpp-rotate-270: SKIP (0.000s)
[131.245210] [029/156] (886s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-pwrite)
[131.337051] Starting subtest: psr-1p-primscrn-spr-indfb-draw-pwrite
[138.242891] Subtest psr-1p-primscrn-spr-indfb-draw-pwrite: SUCCESS (6.911s)
[138.366373] [030/156] (879s left) gem_watchdog (default-physical)
[138.438644] Starting subtest: default-physical
[140.193485] Subtest default-physical: SUCCESS (1.766s)
[140.282282] [031/156] (877s left) syncobj_wait (invalid-multi-wait-all-unsubmitted-submitted-signaled)
[140.341276] Starting subtest: invalid-multi-wait-all-unsubmitted-submitted-signaled
[140.343611] Subtest invalid-multi-wait-all-unsubmitted-submitted-signaled: SUCCESS (0.000s)
[140.425257] [032/156] (877s left) gem_mmap_offset (perf)
[140.481749] Starting subtest: perf
[140.484024] Starting dynamic subtest: smem0
[140.849969] Dynamic subtest smem0: SUCCESS (0.366s)
[140.852406] Subtest perf: SUCCESS (0.366s)
[140.975822] [033/156] (877s left) syncobj_timeline (multi-wait-for-submit-submitted-signaled)
[141.032936] Starting subtest: multi-wait-for-submit-submitted-signaled
[141.035331] Subtest multi-wait-for-submit-submitted-signaled: SUCCESS (0.000s)
[141.129133] [034/156] (876s left) kms_color (gamma)
[141.230808] Starting subtest: gamma
[141.232983] Starting dynamic subtest: pipe-A-eDP-1
[142.747991] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.515s)
[142.758939] Starting dynamic subtest: pipe-B-eDP-1
[143.694436] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.947s)
[143.702718] Starting dynamic subtest: pipe-C-eDP-1
[145.091843] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.399s)
[145.101549] Starting dynamic subtest: pipe-D-eDP-1
[146.498284] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.405s)
[146.500836] Subtest gamma: SUCCESS (5.268s)
[147.316237] [035/156] (870s left) kms_frontbuffer_tracking (hdr-1p-primscrn-spr-indfb-move)
[147.432671] Starting subtest: hdr-1p-primscrn-spr-indfb-move
[147.436952] Subtest hdr-1p-primscrn-spr-indfb-move: SKIP (0.000s)
[147.519232] [036/156] (870s left) gem_mmap_wc (read)
[147.572076] Subtest read: SKIP (0.000s)
[147.632937] [037/156] (870s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-pwrite)
[147.733451] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-pwrite
[153.099567] Subtest fbc-1p-primscrn-pri-indfb-draw-pwrite: SUCCESS (5.371s)
[154.237569] [038/156] (863s left) kms_flip_scaled_crc (flip-32bpp-linear-to-64bpp-linear-upscaling)
[154.335896] Starting subtest: flip-32bpp-linear-to-64bpp-linear-upscaling
[154.338417] Starting dynamic subtest: pipe-A-default-mode
[157.067455] Dynamic subtest pipe-A-default-mode: SUCCESS (2.728s)
[157.069418] Subtest flip-32bpp-linear-to-64bpp-linear-upscaling: SUCCESS (2.730s)
[157.926297] [039/156] (860s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-primscrn-pri-indfb-draw-mmap-gtt)
[158.022768] Starting subtest: fbcpsrhdr-1p-primscrn-pri-indfb-draw-mmap-gtt
[158.027484] Subtest fbcpsrhdr-1p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[158.120310] [040/156] (860s left) gem_exec_balancer (busy)
[158.184483] Starting subtest: busy
[160.313326] Subtest busy: SUCCESS (2.129s)
[160.644860] [041/156] (857s left) kms_vblank (query-idle-hang)
[160.736902] Starting subtest: query-idle-hang
[160.739168] Starting dynamic subtest: pipe-A-eDP-1
[187.085955] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.347s)
[187.101969] Starting dynamic subtest: pipe-D-eDP-1
[202.056647] Dynamic subtest pipe-D-eDP-1: SUCCESS (14.968s)
[202.058807] Subtest query-idle-hang: SUCCESS (41.319s)
[202.869627] [042/156] (815s left) gem_fence_thrash (bo-write-verify-threaded-none)
[202.904689] Starting subtest: bo-write-verify-threaded-none
[202.923838] Subtest bo-write-verify-threaded-none: SKIP (0.014s)
[202.980312] [043/156] (815s left) gem_render_copy_redux (flink-interruptible)
[203.030504] Starting subtest: flink-interruptible
[203.796782] Subtest flink-interruptible: SUCCESS (0.766s)
[203.923912] [044/156] (814s left) prime_self_import (basic-with_one_bo)
[203.956348] Starting subtest: basic-with_one_bo
[203.976023] Subtest basic-with_one_bo: SUCCESS (0.020s)
[204.088659] [045/156] (814s left) kms_frontbuffer_tracking (fbchdr-2p-scndscrn-cur-indfb-onoff)
[204.191829] Starting subtest: fbchdr-2p-scndscrn-cur-indfb-onoff
[204.195454] Subtest fbchdr-2p-scndscrn-cur-indfb-onoff: SKIP (0.000s)
[204.271406] [046/156] (814s left) kms_ccs (crc-primary-basic-y-tiled-ccs)
[204.359144] Starting subtest: crc-primary-basic-y-tiled-ccs
[204.360938] Starting dynamic subtest: pipe-A-eDP-1
[204.379677] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[204.389603] Starting dynamic subtest: pipe-B-eDP-1
[204.407071] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[204.414829] Starting dynamic subtest: pipe-C-eDP-1
[204.432565] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[204.441465] Starting dynamic subtest: pipe-D-eDP-1
[204.459742] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[204.463307] Subtest crc-primary-basic-y-tiled-ccs: SKIP (0.004s)
[206.625705] [047/156] (811s left) gem_exec_parallel (userptr)
[206.694452] Starting subtest: userptr
[206.696899] Starting dynamic subtest: rcs0
[208.128063] Dynamic subtest rcs0: SUCCESS (1.433s)
[208.139735] Starting dynamic subtest: bcs0
[209.580631] Dynamic subtest bcs0: SUCCESS (1.450s)
[209.590771] Starting dynamic subtest: vcs0
[211.330156] Dynamic subtest vcs0: SUCCESS (1.748s)
[211.339851] Starting dynamic subtest: vcs1
[213.251426] Dynamic subtest vcs1: SUCCESS (1.919s)
[213.263058] Starting dynamic subtest: vecs0
[215.235741] Dynamic subtest vecs0: SUCCESS (1.982s)
[215.251287] Starting dynamic subtest: ccs0
[216.709984] Dynamic subtest ccs0: SUCCESS (1.474s)
[216.712520] Subtest userptr: SUCCESS (10.016s)
[216.911928] [048/156] (801s left) gem_exec_schedule (preempt-other)
[216.977285] Starting subtest: preempt-other
[216.979206] Starting dynamic subtest: rcs0
[217.100925] Dynamic subtest rcs0: SUCCESS (0.124s)
[217.113218] Starting dynamic subtest: bcs0
[217.214371] Dynamic subtest bcs0: SUCCESS (0.114s)
[217.226881] Starting dynamic subtest: vcs0
[217.334345] Dynamic subtest vcs0: SUCCESS (0.119s)
[217.342793] Starting dynamic subtest: vcs1
[217.443131] Dynamic subtest vcs1: SUCCESS (0.109s)
[217.457736] Starting dynamic subtest: vecs0
[217.556656] Dynamic subtest vecs0: SUCCESS (0.111s)
[217.567784] Starting dynamic subtest: ccs0
[217.681555] Dynamic subtest ccs0: SUCCESS (0.124s)
[217.683823] Subtest preempt-other: SUCCESS (0.705s)
[218.387976] [049/156] (800s left) syncobj_wait (reset-signaled)
[218.451200] Starting subtest: reset-signaled
[218.453479] Subtest reset-signaled: SUCCESS (0.000s)
[218.549996] [050/156] (800s left) core_hotunplug (unbind-rebind)
[218.643060] Starting subtest: unbind-rebind
[224.650791] Subtest unbind-rebind: SUCCESS (6.010s)
[224.691089] [051/156] (794s left) i915_pm_rc6_residency (rc6-accuracy)
[226.278305] Starting subtest: rc6-accuracy
[226.280468] Starting dynamic subtest: gt0
[229.450383] Dynamic subtest gt0: SUCCESS (3.169s)
[229.459504] Starting dynamic subtest: gt1
[232.621373] Dynamic subtest gt1: SUCCESS (3.168s)
[232.623990] Subtest rc6-accuracy: SUCCESS (6.342s)
[232.695519] [052/156] (786s left) gem_exec_whisper (basic-queues)
[232.752875] Starting subtest: basic-queues
[239.646644] Subtest basic-queues: SUCCESS (6.889s)
[239.830820] [053/156] (778s left) gem_render_copy (x-tiled-to-vebox-y-tiled)
[239.894655] Starting subtest: x-tiled-to-vebox-y-tiled
[239.899268] Subtest x-tiled-to-vebox-y-tiled: SKIP (0.000s)
[240.079224] [054/156] (778s left) kms_psr2_sf (pr-overlay-plane-move-continuous-exceed-fully-sf)
[240.187639] Starting subtest: pr-overlay-plane-move-continuous-exceed-fully-sf
[240.192081] Subtest pr-overlay-plane-move-continuous-exceed-fully-sf: SKIP (0.000s)
[240.267007] [055/156] (778s left) kms_frontbuffer_tracking (hdr-suspend)
[240.370236] Starting subtest: hdr-suspend
[240.374174] Subtest hdr-suspend: SKIP (0.000s)
[240.471625] [056/156] (778s left) kms_sequence (get-idle)
[240.566136] Starting subtest: get-idle
[240.568301] Starting dynamic subtest: pipe-A-eDP-1
[242.389320] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.824s)
[242.400488] Starting dynamic subtest: pipe-B-eDP-1
[244.925503] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.534s)
[244.935965] Starting dynamic subtest: pipe-C-eDP-1
[247.425798] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.498s)
[247.437475] Starting dynamic subtest: pipe-D-eDP-1
[249.843621] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.419s)
[249.846055] Subtest get-idle: SUCCESS (9.279s)
[250.663392] [057/156] (768s left) kms_frontbuffer_tracking (hdr-2p-primscrn-spr-indfb-fullscreen)
[250.760604] Starting subtest: hdr-2p-primscrn-spr-indfb-fullscreen
[250.764827] Subtest hdr-2p-primscrn-spr-indfb-fullscreen: SKIP (0.000s)
[250.854165] [058/156] (768s left) kms_frontbuffer_tracking (hdr-2p-scndscrn-spr-indfb-draw-mmap-wc)
[250.951797] Starting subtest: hdr-2p-scndscrn-spr-indfb-draw-mmap-wc
[250.956226] Subtest hdr-2p-scndscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[251.037962] [059/156] (767s left) kms_flip (bo-too-big-interruptible)
[251.131290] Starting subtest: bo-too-big-interruptible
[251.133516] Starting dynamic subtest: A-eDP1
[252.408948] Dynamic subtest A-eDP1: SUCCESS (1.277s)
[252.418861] Starting dynamic subtest: B-eDP1
[253.742669] Dynamic subtest B-eDP1: SUCCESS (1.330s)
[253.752358] Starting dynamic subtest: C-eDP1
[255.077841] Dynamic subtest C-eDP1: SUCCESS (1.336s)
[255.090102] Starting dynamic subtest: D-eDP1
[256.404877] Dynamic subtest D-eDP1: SUCCESS (1.326s)
[256.407620] Subtest bo-too-big-interruptible: SUCCESS (5.277s)
[257.611820] [060/156] (761s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-fullscreen)
[257.705314] Starting subtest: fbc-1p-primscrn-spr-indfb-fullscreen
[261.640365] Subtest fbc-1p-primscrn-spr-indfb-fullscreen: SUCCESS (3.939s)
[262.808384] [061/156] (756s left) perf_pmu (rc6)
[262.843232] Starting subtest: rc6
[262.845544] Starting dynamic subtest: gt0
[269.228113] Dynamic subtest gt0: SUCCESS (6.383s)
[269.240558] Starting dynamic subtest: runtime-pm-gt0
[276.947029] Dynamic subtest runtime-pm-gt0: SUCCESS (7.716s)
[276.958962] Starting dynamic subtest: runtime-pm-long-gt0
[289.385440] Dynamic subtest runtime-pm-long-gt0: SUCCESS (12.436s)
[289.396929] Starting dynamic subtest: other-idle-gt0
[295.730164] Dynamic subtest other-idle-gt0: SUCCESS (6.341s)
[295.740673] Starting dynamic subtest: gt1
[302.072124] Dynamic subtest gt1: SUCCESS (6.339s)
[302.082174] Starting dynamic subtest: runtime-pm-gt1
[309.548278] Dynamic subtest runtime-pm-gt1: SUCCESS (7.474s)
[309.560543] Starting dynamic subtest: runtime-pm-long-gt1
[322.052299] Dynamic subtest runtime-pm-long-gt1: SUCCESS (12.501s)
[322.064568] Starting dynamic subtest: other-idle-gt1
[328.395318] Dynamic subtest other-idle-gt1: SUCCESS (6.340s)
[328.398084] Subtest rc6: SUCCESS (65.548s)
[329.531720] [062/156] (689s left) kms_frontbuffer_tracking (psr-suspend)
[329.631803] Starting subtest: psr-suspend
[367.817309] Subtest psr-suspend: SUCCESS (8.134s)
[367.899477] [063/156] (651s left) kms_frontbuffer_tracking (fbchdr-2p-primscrn-pri-shrfb-draw-mmap-cpu)
[368.000534] Starting subtest: fbchdr-2p-primscrn-pri-shrfb-draw-mmap-cpu
[368.005108] Subtest fbchdr-2p-primscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[368.076799] [064/156] (651s left) syncobj_wait (single-wait-all-for-submit-submitted)
[368.125129] Starting subtest: single-wait-all-for-submit-submitted
[368.234843] Subtest single-wait-all-for-submit-submitted: SUCCESS (0.104s)
[368.293612] [065/156] (651s left) drm_read (short-buffer-nonblock)
[368.436433] Starting subtest: short-buffer-nonblock
[368.438889] Subtest short-buffer-nonblock: SUCCESS (0.000s)
[368.548637] [066/156] (650s left) kms_cursor_legacy (forked-move)
[368.659029] Starting subtest: forked-move
[368.661022] Starting dynamic subtest: pipe-A
[374.263469] Dynamic subtest pipe-A: SUCCESS (5.453s)
[374.285272] Starting dynamic subtest: pipe-B
[379.816948] Dynamic subtest pipe-B: SUCCESS (5.479s)
[379.828930] Starting dynamic subtest: pipe-C
[385.331164] Dynamic subtest pipe-C: SUCCESS (5.476s)
[385.343101] Starting dynamic subtest: pipe-D
[390.839433] Dynamic subtest pipe-D: SUCCESS (5.487s)
[390.851482] Starting dynamic subtest: all-pipes
[396.358278] Dynamic subtest all-pipes: SUCCESS (5.506s)
[396.361093] Subtest forked-move: SUCCESS (27.411s)
[396.490824] [067/156] (622s left) gem_create (hog-create)
[396.538876] Starting subtest: hog-create
[396.541018] Starting dynamic subtest: smem0
[430.288199] Dynamic subtest smem0: SUCCESS (33.751s)
[430.291029] Subtest hog-create: SUCCESS (33.754s)
[430.452065] [068/156] (588s left) kms_psr (fbc-pr-cursor-mmap-gtt)
[430.550419] Starting subtest: fbc-pr-cursor-mmap-gtt
[430.554704] Subtest fbc-pr-cursor-mmap-gtt: SKIP (0.000s)
[430.607409] [069/156] (588s left) kms_flip (2x-blocking-absolute-wf_vblank)
[430.705622] Starting subtest: 2x-blocking-absolute-wf_vblank
[430.716299] Subtest 2x-blocking-absolute-wf_vblank: SKIP (0.010s)
[430.794422] [070/156] (588s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-primscrn-spr-indfb-draw-mmap-gtt)
[430.887434] Starting subtest: fbcpsrhdr-2p-primscrn-spr-indfb-draw-mmap-gtt
[430.891714] Subtest fbcpsrhdr-2p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[430.960729] [071/156] (588s left) kms_frontbuffer_tracking (fbchdr-2p-scndscrn-spr-indfb-onoff)
[431.059262] Starting subtest: fbchdr-2p-scndscrn-spr-indfb-onoff
[431.063779] Subtest fbchdr-2p-scndscrn-spr-indfb-onoff: SKIP (0.000s)
[431.127343] [072/156] (588s left) perf (non-system-wide-paranoid)
[431.216450] Starting subtest: non-system-wide-paranoid
[431.240494] Subtest non-system-wide-paranoid: SUCCESS (0.025s)
[431.292635] [073/156] (588s left) gem_gpgpu_fill (basic)
[431.355728] Starting subtest: basic
[431.358105] Starting dynamic subtest: smem
[431.365633] Dynamic subtest smem: SUCCESS (0.011s)
[431.367747] Subtest basic: SUCCESS (0.011s)
[431.482892] [074/156] (588s left) api_intel_bb (bb-with-allocator)
[431.532669] Starting subtest: bb-with-allocator
[431.539939] Subtest bb-with-allocator: SUCCESS (0.008s)
[431.632555] [075/156] (588s left) gem_workarounds (reset-context)
[431.698558] Starting subtest: reset-context
[431.867531] Subtest reset-context: SUCCESS (0.167s)
[431.956871] [076/156] (587s left) kms_psr (fbc-psr-cursor-plane-move)
[432.039560] Starting subtest: fbc-psr-cursor-plane-move
[432.041448] Starting dynamic subtest: eDP-1
[432.044831] Dynamic subtest eDP-1: SKIP (0.000s)
[432.048225] Subtest fbc-psr-cursor-plane-move: SKIP (0.001s)
[432.088661] [077/156] (587s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-mmap-cpu)
[432.198493] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-mmap-cpu
[432.201942] Subtest psr-2p-scndscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[432.266734] [078/156] (587s left) kms_frontbuffer_tracking (hdr-2p-scndscrn-indfb-plflip-blt)
[432.372011] Starting subtest: hdr-2p-scndscrn-indfb-plflip-blt
[432.375235] Subtest hdr-2p-scndscrn-indfb-plflip-blt: SKIP (0.000s)
[432.447476] [079/156] (587s left) kms_frontbuffer_tracking (fbchdr-1p-primscrn-pri-shrfb-draw-pwrite)
[432.544184] Starting subtest: fbchdr-1p-primscrn-pri-shrfb-draw-pwrite
[432.547637] Subtest fbchdr-1p-primscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[432.601654] [080/156] (587s left) gem_userptr_blits (readonly-pwrite-unsync)
[432.664832] Subtest readonly-pwrite-unsync: SKIP (0.000s)
[432.765502] [081/156] (587s left) kms_addfb_basic (unused-pitches)
[432.819679] Starting subtest: unused-pitches
[432.821565] Subtest unused-pitches: SUCCESS (0.000s)
[432.943902] [082/156] (587s left) kms_atomic_transition (plane-toggle-modeset-transition)
[433.026819] Starting subtest: plane-toggle-modeset-transition
[433.028442] Starting dynamic subtest: pipe-A-eDP-1
[445.822436] Dynamic subtest pipe-A-eDP-1: SUCCESS (12.792s)
[445.833576] Starting dynamic subtest: pipe-B-eDP-1
[458.245160] Dynamic subtest pipe-B-eDP-1: SUCCESS (12.416s)
[458.247644] Subtest plane-toggle-modeset-transition: SUCCESS (25.213s)
[459.050210] [083/156] (560s left) kms_pm_dc (dc5-retention-flops)
[460.151548] Starting subtest: dc5-retention-flops
[460.155474] Subtest dc5-retention-flops: SKIP (0.000s)
[460.199896] [084/156] (559s left) kms_cursor_crc (cursor-onscreen-32x10)
[460.353189] Starting subtest: cursor-onscreen-32x10
[460.399631] Subtest cursor-onscreen-32x10: SKIP (0.041s)
[460.656757] [085/156] (559s left) kms_chamelium_audio (dp-audio-edid)
[461.050085] Subtest dp-audio-edid: SKIP (0.000s)
[461.876754] [086/156] (558s left) kms_psr2_sf (fbc-psr2-overlay-plane-move-continuous-sf)
[461.978062] Starting subtest: fbc-psr2-overlay-plane-move-continuous-sf
[461.980369] Starting dynamic subtest: pipe-A-eDP-1
[462.075176] Dynamic subtest pipe-A-eDP-1: SKIP (0.100s)
[462.088635] Starting dynamic subtest: pipe-B-eDP-1
[463.276564] Dynamic subtest pipe-B-eDP-1: SKIP (1.199s)
[463.281013] Subtest fbc-psr2-overlay-plane-move-continuous-sf: SKIP (1.301s)
[464.448207] [087/156] (555s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-180-async-flip)
[464.548128] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-180-async-flip
[465.205381] Subtest 4-tiled-max-hw-stride-32bpp-rotate-180-async-flip: SUCCESS (0.659s)
[465.356991] [088/156] (554s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling)
[465.448418] Starting subtest: flip-64bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling
[465.452513] Subtest flip-64bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling: SKIP (0.000s)
[465.495167] [089/156] (554s left) sysfs_timeslice_duration (duration)
[465.543116] Starting subtest: duration
[465.545430] Starting dynamic subtest: vecs0
[479.176504] Dynamic subtest vecs0: SUCCESS (13.631s)
[479.191881] Starting dynamic subtest: ccs0
[492.325196] Dynamic subtest ccs0: SUCCESS (13.145s)
[492.337421] Starting dynamic subtest: vcs0
[506.179937] Dynamic subtest vcs0: SUCCESS (13.849s)
[506.192120] Starting dynamic subtest: bcs0
[519.319876] Dynamic subtest bcs0: SUCCESS (13.137s)
[519.335709] Starting dynamic subtest: rcs0
[532.473272] Dynamic subtest rcs0: SUCCESS (13.148s)
[532.486890] Starting dynamic subtest: vcs1
[546.180739] Dynamic subtest vcs1: SUCCESS (13.700s)
[546.183549] Subtest duration: SUCCESS (80.626s)
[546.236596] [090/156] (474s left) gem_render_copy_redux (normal)
[546.293481] Starting subtest: normal
[546.700052] Subtest normal: SUCCESS (0.406s)
[546.784689] [091/156] (473s left) core_getclient (basic)
[546.836536] Starting subtest: basic
[546.838422] Subtest basic: SUCCESS (0.000s)
[546.914083] [092/156] (473s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-scndscrn-cur-indfb-draw-render)
[547.008617] Starting subtest: fbcpsrhdr-2p-scndscrn-cur-indfb-draw-render
[547.013020] Subtest fbcpsrhdr-2p-scndscrn-cur-indfb-draw-render: SKIP (0.000s)
[547.083907] [093/156] (473s left) kms_flip (blocking-absolute-wf_vblank-interruptible)
[547.171656] Starting subtest: blocking-absolute-wf_vblank-interruptible
[547.173904] Starting dynamic subtest: A-eDP1
[555.919592] Dynamic subtest A-eDP1: SUCCESS (8.744s)
[555.931279] Starting dynamic subtest: B-eDP1
[564.655455] Dynamic subtest B-eDP1: SUCCESS (8.731s)
[564.668305] Starting dynamic subtest: C-eDP1
[573.371565] Dynamic subtest C-eDP1: SUCCESS (8.712s)
[573.383240] Starting dynamic subtest: D-eDP1
[582.108407] Dynamic subtest D-eDP1: SUCCESS (8.734s)
[582.110896] Subtest blocking-absolute-wf_vblank-interruptible: SUCCESS (34.930s)
[583.309597] [094/156] (437s left) kms_addfb_basic (unused-offsets)
[583.366077] Starting subtest: unused-offsets
[583.368258] Subtest unused-offsets: SUCCESS (0.000s)
[583.483441] [095/156] (437s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-pri-indfb-multidraw)
[583.587108] Starting subtest: fbcpsrhdr-1p-pri-indfb-multidraw
[583.591483] Subtest fbcpsrhdr-1p-pri-indfb-multidraw: SKIP (0.000s)
[583.647756] [096/156] (436s left) kms_prime (d3hot)
[583.730351] Subtest D3hot: SKIP (0.000s)
[583.778166] [097/156] (436s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-mmap-gtt)
[583.867872] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-mmap-gtt
[583.872060] Subtest fbc-2p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[583.944159] [098/156] (436s left) kms_psr (psr-primary-page-flip)
[584.039607] Starting subtest: psr-primary-page-flip
[584.041928] Starting dynamic subtest: eDP-1
[585.825529] Dynamic subtest eDP-1: SUCCESS (1.784s)
[585.827712] Subtest psr-primary-page-flip: SUCCESS (1.785s)
[586.668955] [099/156] (434s left) kms_atomic_transition (modeset-transition-nonblocking-fencing)
[586.774767] Starting subtest: modeset-transition-nonblocking-fencing
[586.777009] Starting dynamic subtest: 1x-outputs
[597.918127] Dynamic subtest 1x-outputs: SUCCESS (11.146s)
[597.920644] Subtest modeset-transition-nonblocking-fencing: SUCCESS (11.148s)
[598.757555] [100/156] (421s left) kms_psr (psr2-cursor-plane-onoff)
[598.860972] Starting subtest: psr2-cursor-plane-onoff
[598.863158] Starting dynamic subtest: eDP-1
[600.565890] Dynamic subtest eDP-1: SUCCESS (1.702s)
[600.568246] Subtest psr2-cursor-plane-onoff: SUCCESS (1.703s)
[601.430217] [101/156] (419s left) i915_hangman (gt-engine-error)
[601.491241] Starting subtest: gt-engine-error
[601.493218] Starting dynamic subtest: rcs0
[603.270467] Dynamic subtest rcs0: SUCCESS (1.780s)
[603.285517] Starting dynamic subtest: bcs0
[605.251978] Dynamic subtest bcs0: SUCCESS (1.979s)
[605.266399] Starting dynamic subtest: vcs0
[607.236438] Dynamic subtest vcs0: SUCCESS (1.983s)
[607.249687] Starting dynamic subtest: vcs1
[609.221724] Dynamic subtest vcs1: SUCCESS (1.983s)
[609.234487] Starting dynamic subtest: vecs0
[611.267654] Dynamic subtest vecs0: SUCCESS (2.044s)
[611.279201] Starting dynamic subtest: ccs0
[613.252599] Dynamic subtest ccs0: SUCCESS (1.982s)
[613.255178] Subtest gt-engine-error: SUCCESS (11.766s)
[613.311051] [102/156] (407s left) gem_ctx_persistence (heartbeat-stop)
[613.372686] Starting subtest: heartbeat-stop
[613.377463] Subtest heartbeat-stop: SKIP (0.000s)
[613.458275] [103/156] (407s left) i915_drm_fdinfo (idle)
[613.499155] Starting subtest: idle
[613.501154] Starting dynamic subtest: rcs0
[614.070809] Dynamic subtest rcs0: SUCCESS (0.571s)
[614.083543] Starting dynamic subtest: bcs0
[614.577173] Dynamic subtest bcs0: SUCCESS (0.503s)
[614.590537] Starting dynamic subtest: vcs0
[615.083383] Dynamic subtest vcs0: SUCCESS (0.503s)
[615.096162] Starting dynamic subtest: vcs1
[615.589417] Dynamic subtest vcs1: SUCCESS (0.503s)
[615.600163] Starting dynamic subtest: vecs0
[616.095625] Dynamic subtest vecs0: SUCCESS (0.503s)
[616.106268] Starting dynamic subtest: ccs0
[616.602725] Dynamic subtest ccs0: SUCCESS (0.504s)
[616.605606] Subtest idle: SUCCESS (3.105s)
[616.659584] [104/156] (404s left) kms_plane (pixel-format-4-tiled-dg2-mc-ccs-modifier)
[616.755486] Starting subtest: pixel-format-4-tiled-dg2-mc-ccs-modifier
[616.759666] Subtest pixel-format-4-tiled-dg2-mc-ccs-modifier: SKIP (0.000s)
[616.802969] [105/156] (404s left) gem_partial_pwrite_pread (write-uncached)
[616.867897] Subtest write-uncached: SKIP (0.000s)
[616.957580] [106/156] (404s left) gem_exec_schedule (submit-early-slice)
[617.033462] Starting subtest: submit-early-slice
[617.035302] Starting dynamic subtest: rcs0
[617.069312] Dynamic subtest rcs0: SUCCESS (0.044s)
[617.079762] Starting dynamic subtest: bcs0
[617.114674] Dynamic subtest bcs0: SUCCESS (0.044s)
[617.130021] Starting dynamic subtest: vcs0
[617.155798] Dynamic subtest vcs0: SUCCESS (0.040s)
[617.166064] Starting dynamic subtest: vcs1
[617.197389] Dynamic subtest vcs1: SUCCESS (0.041s)
[617.209608] Starting dynamic subtest: vecs0
[617.235140] Dynamic subtest vecs0: SUCCESS (0.037s)
[617.247702] Starting dynamic subtest: ccs0
[617.279246] Dynamic subtest ccs0: SUCCESS (0.043s)
[617.282003] Subtest submit-early-slice: SUCCESS (0.255s)
[618.344616] [107/156] (402s left) kms_cursor_legacy (cursora-vs-flipb-atomic)
[618.457431] Starting subtest: cursorA-vs-flipB-atomic
[618.462111] Subtest cursorA-vs-flipB-atomic: SKIP (0.001s)
[618.582107] [108/156] (402s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-scndscrn-spr-indfb-draw-blt)
[618.677693] Starting subtest: fbcpsrhdr-2p-scndscrn-spr-indfb-draw-blt
[618.681542] Subtest fbcpsrhdr-2p-scndscrn-spr-indfb-draw-blt: SKIP (0.000s)
[618.753130] [109/156] (402s left) kms_frontbuffer_tracking (hdr-1p-primscrn-pri-indfb-draw-mmap-cpu)
[618.851642] Starting subtest: hdr-1p-primscrn-pri-indfb-draw-mmap-cpu
[618.855605] Subtest hdr-1p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[618.919769] [110/156] (402s left) i915_pm_sseu (full-enable)
[618.986376] Subtest full-enable: SKIP (0.000s)
[619.067851] [111/156] (402s left) gem_softpin (evict-prime)
[619.117219] Starting subtest: evict-prime
[619.119651] Starting dynamic subtest: rcs0
[620.273216] Dynamic subtest rcs0: SUCCESS (1.156s)
[620.288313] Starting dynamic subtest: bcs0
[621.408142] Dynamic subtest bcs0: SUCCESS (1.133s)
[621.421465] Starting dynamic subtest: vcs0
[623.275840] Dynamic subtest vcs0: SUCCESS (1.865s)
[623.290208] Starting dynamic subtest: vcs1
[625.266219] Dynamic subtest vcs1: SUCCESS (1.989s)
[625.280182] Starting dynamic subtest: vecs0
[627.246334] Dynamic subtest vecs0: SUCCESS (1.978s)
[627.260587] Starting dynamic subtest: ccs0
[628.364309] Dynamic subtest ccs0: SUCCESS (1.118s)
[628.379694] Starting dynamic subtest: all
[630.243947] Dynamic subtest all: SUCCESS (1.877s)
[630.246737] Subtest evict-prime: SUCCESS (11.128s)
[630.301759] [112/156] (390s left) kms_dsc (dsc-with-output-formats)
[630.396198] Starting subtest: dsc-with-output-formats
[630.417296] Subtest dsc-with-output-formats: SKIP (0.000s)
[630.460517] [113/156] (390s left) gem_ctx_sseu (invalid-sseu)
[630.518785] Subtest invalid-sseu: SKIP (0.000s)
[630.585821] [114/156] (390s left) gen9_exec_parse (basic-rejected)
[630.631561] Subtest basic-rejected: SKIP (0.000s)
[630.703302] [115/156] (390s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-blt)
[630.796424] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-blt
[630.800596] Subtest fbc-2p-primscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[630.883035] [116/156] (390s left) syncobj_timeline (etime-single-wait-all-available-unsubmitted)
[630.943065] Starting subtest: etime-single-wait-all-available-unsubmitted
[631.049841] Subtest etime-single-wait-all-available-unsubmitted: SUCCESS (0.108s)
[631.108558] [117/156] (390s left) kms_ccs (crc-sprite-planes-basic-4-tiled-dg2-mc-ccs)
[631.196705] Starting subtest: crc-sprite-planes-basic-4-tiled-dg2-mc-ccs
[631.199022] Starting dynamic subtest: pipe-A-eDP-1
[631.258255] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[631.268442] Starting dynamic subtest: pipe-B-eDP-1
[631.326401] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[631.338084] Starting dynamic subtest: pipe-C-eDP-1
[631.395066] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[631.405986] Starting dynamic subtest: pipe-D-eDP-1
[631.462049] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[631.466055] Subtest crc-sprite-planes-basic-4-tiled-dg2-mc-ccs: SKIP (0.008s)
[633.482630] [118/156] (388s left) gem_bad_reloc (negative-reloc)
[633.540549] Subtest negative-reloc: SKIP (0.000s)
[633.612017] [119/156] (387s left) kms_big_fb (yf-tiled-32bpp-rotate-0)
[633.728330] Starting subtest: yf-tiled-32bpp-rotate-0
[633.732543] Subtest yf-tiled-32bpp-rotate-0: SKIP (0.000s)
[633.803490] [120/156] (387s left) kms_lease (simple-lease)
[633.889360] Starting subtest: simple-lease
[633.891563] Starting dynamic subtest: pipe-A-eDP-1
[634.389432] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.499s)
[634.402469] Starting dynamic subtest: pipe-B-eDP-1
[635.833843] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.445s)
[635.847196] Starting dynamic subtest: pipe-C-eDP-1
[637.342577] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.504s)
[637.352526] Starting dynamic subtest: pipe-D-eDP-1
[638.748517] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.407s)
[638.750903] Subtest simple-lease: SUCCESS (4.862s)
[639.545207] [121/156] (382s left) kms_pm_backlight (fade-with-suspend)
[639.640527] Starting subtest: fade-with-suspend
[655.225392] Starting dynamic subtest: eDP-1
[658.242780] Dynamic subtest eDP-1: SUCCESS (2.928s)
[658.245364] Subtest fade-with-suspend: SUCCESS (4.135s)
[659.146392] [122/156] (362s left) gem_lmem_swapping (verify-random-ccs)
[659.194915] Subtest verify-random-ccs: SKIP (0.000s)
[659.248461] [123/156] (362s left) gem_userptr_blits (access-control)
[659.318285] Starting subtest: access-control
[659.323558] Subtest access-control: SKIP (0.000s)
[659.431951] [124/156] (362s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-primscrn-indfb-plflip-blt)
[659.527509] Starting subtest: fbcpsrhdr-2p-primscrn-indfb-plflip-blt
[659.532814] Subtest fbcpsrhdr-2p-primscrn-indfb-plflip-blt: SKIP (0.000s)
[659.607567] [125/156] (362s left) kms_frontbuffer_tracking (psrhdr-rgb565-draw-mmap-gtt)
[659.713667] Starting subtest: psrhdr-rgb565-draw-mmap-gtt
[659.718392] Subtest psrhdr-rgb565-draw-mmap-gtt: SKIP (0.000s)
[659.782605] [126/156] (362s left) perf_pmu (init-busy)
[659.821580] Starting subtest: init-busy
[659.824216] Starting dynamic subtest: rcs0
[659.826988] Dynamic subtest rcs0: SUCCESS (0.001s)
[659.837463] Starting dynamic subtest: bcs0
[659.839614] Dynamic subtest bcs0: SUCCESS (0.001s)
[659.849330] Starting dynamic subtest: vcs0
[659.851402] Dynamic subtest vcs0: SUCCESS (0.001s)
[659.861405] Starting dynamic subtest: vcs1
[659.863711] Dynamic subtest vcs1: SUCCESS (0.001s)
[659.873564] Starting dynamic subtest: vecs0
[659.876381] Dynamic subtest vecs0: SUCCESS (0.001s)
[659.889809] Starting dynamic subtest: ccs0
[659.892360] Dynamic subtest ccs0: SUCCESS (0.001s)
[659.894815] Subtest init-busy: SUCCESS (0.008s)
[659.944003] [127/156] (361s left) kms_atomic_transition (plane-all-transition)
[660.037983] Starting subtest: plane-all-transition
[660.040752] Starting dynamic subtest: pipe-A-eDP-1
[662.586024] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.495s)
[662.904858] Starting dynamic subtest: pipe-B-eDP-1
[666.227405] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.287s)
[666.533568] Subtest plane-all-transition: SUCCESS (6.383s)
[667.349686] [128/156] (354s left) kms_frontbuffer_tracking (psrhdr-1p-primscrn-pri-indfb-draw-mmap-cpu)
[667.451255] Starting subtest: psrhdr-1p-primscrn-pri-indfb-draw-mmap-cpu
[667.456518] Subtest psrhdr-1p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[667.528686] [129/156] (354s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-pwrite)
[667.631487] Starting subtest: fbcpsr-rgb101010-draw-pwrite
[672.731191] Subtest fbcpsr-rgb101010-draw-pwrite: SUCCESS (5.069s)
[672.814596] [130/156] (349s left) kms_ccs (crc-primary-suspend-4-tiled-bmg-ccs)
[672.902463] Starting subtest: crc-primary-suspend-4-tiled-bmg-ccs
[672.907418] Subtest crc-primary-suspend-4-tiled-bmg-ccs: SKIP (0.000s)
[674.040711] [131/156] (348s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-0-hflip)
[674.141412] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-0-hflip
[674.146874] Subtest yf-tiled-max-hw-stride-64bpp-rotate-0-hflip: SKIP (0.000s)
[674.209060] [132/156] (347s left) kms_frontbuffer_tracking (psrhdr-2p-scndscrn-cur-indfb-draw-mmap-wc)
[674.308611] Starting subtest: psrhdr-2p-scndscrn-cur-indfb-draw-mmap-wc
[674.313812] Subtest psrhdr-2p-scndscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[674.366898] [133/156] (347s left) kms_frontbuffer_tracking (psr-rgb101010-draw-pwrite)
[674.467588] Starting subtest: psr-rgb101010-draw-pwrite
[682.203849] Subtest psr-rgb101010-draw-pwrite: SUCCESS (7.718s)
[682.297829] [134/156] (339s left) gem_exec_fence (invalid-fence-array)
[682.762042] Starting subtest: invalid-fence-array
[682.769020] Subtest invalid-fence-array: SUCCESS (0.004s)
[684.723466] [135/156] (337s left) gem_pxp (display-protected-crc)
[684.834030] Starting subtest: display-protected-crc
[686.982553] Subtest display-protected-crc: SUCCESS (2.147s)
[687.083134] [136/156] (335s left) gem_render_copy (y-tiled-mc-ccs-to-vebox-yf-tiled)
[687.146727] Starting subtest: y-tiled-mc-ccs-to-vebox-yf-tiled
[687.151930] Subtest y-tiled-mc-ccs-to-vebox-yf-tiled: SKIP (0.000s)
[687.307466] [137/156] (335s left) kms_chamelium_hpd (vga-hpd-for-each-pipe)
[687.689878] Subtest vga-hpd-for-each-pipe: SKIP (0.000s)
[688.536811] [138/156] (333s left) kms_frontbuffer_tracking (psr-1p-primscrn-indfb-msflip-blt)
[688.632805] Starting subtest: psr-1p-primscrn-indfb-msflip-blt
[695.992578] Subtest psr-1p-primscrn-indfb-msflip-blt: SUCCESS (7.361s)
[696.100728] [139/156] (326s left) kms_invalid_mode (overflow-vrefresh)
[696.204651] Starting subtest: overflow-vrefresh
[696.207309] Starting dynamic subtest: pipe-A-eDP-1
[696.485525] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.285s)
[696.499711] Starting dynamic subtest: pipe-B-eDP-1
[696.502016] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[696.512622] Starting dynamic subtest: pipe-C-eDP-1
[696.515335] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[696.528762] Starting dynamic subtest: pipe-D-eDP-1
[696.531653] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[696.534235] Subtest overflow-vrefresh: SUCCESS (0.291s)
[697.295170] [140/156] (325s left) kms_frontbuffer_tracking (hdr-1p-offscreen-pri-shrfb-draw-mmap-wc)
[697.394214] Starting subtest: hdr-1p-offscreen-pri-shrfb-draw-mmap-wc
[697.399586] Subtest hdr-1p-offscreen-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[697.468705] [141/156] (325s left) kms_cursor_edge_walk (128x128-top-edge)
[697.561726] Starting subtest: 128x128-top-edge
[697.564392] Starting dynamic subtest: pipe-A-eDP-1
[701.089022] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.526s)
[701.102991] Starting dynamic subtest: pipe-D-eDP-1
[704.307265] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.214s)
[704.309936] Subtest 128x128-top-edge: SUCCESS (6.743s)
[705.103403] [142/156] (317s left) perf (gen12-invalid-class-instance)
[705.168646] Starting subtest: gen12-invalid-class-instance
[705.179706] Subtest gen12-invalid-class-instance: SUCCESS (0.010s)
[705.231957] [143/156] (317s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-mmap-gtt)
[705.324672] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-mmap-gtt
[705.329115] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[705.386001] [144/156] (317s left) kms_psr (psr-primary-blt)
[705.481115] Starting subtest: psr-primary-blt
[705.483811] Starting dynamic subtest: eDP-1
[707.217889] Dynamic subtest eDP-1: SUCCESS (1.733s)
[707.220493] Subtest psr-primary-blt: SUCCESS (1.734s)
[708.064601] [145/156] (314s left) prime_vgem (coherency-gtt)
[708.134775] Starting subtest: coherency-gtt
[708.140369] Subtest coherency-gtt: SKIP (0.000s)
[708.213602] [146/156] (314s left) kms_big_fb (linear-8bpp-rotate-0)
[708.313793] Starting subtest: linear-8bpp-rotate-0
[709.640287] Subtest linear-8bpp-rotate-0: SUCCESS (1.325s)
[709.743256] [147/156] (313s left) kms_big_fb (x-tiled-16bpp-rotate-0)
[709.835717] Starting subtest: x-tiled-16bpp-rotate-0
[711.127357] Subtest x-tiled-16bpp-rotate-0: SUCCESS (1.291s)
[711.229763] [148/156] (311s left) gem_fence_thrash (bo-write-verify-none)
[711.267831] Starting subtest: bo-write-verify-none
[711.282572] Subtest bo-write-verify-none: SKIP (0.014s)
[711.347041] [149/156] (311s left) kms_cursor_crc (cursor-random-128x42)
[711.572396] Starting subtest: cursor-random-128x42
[711.623898] Subtest cursor-random-128x42: SKIP (0.046s)
[711.823746] [150/156] (311s left) kms_psr (fbc-psr2-dpms)
[711.915751] Starting subtest: fbc-psr2-dpms
[711.917820] Starting dynamic subtest: eDP-1
[711.921844] Dynamic subtest eDP-1: SKIP (0.000s)
[711.926319] Subtest fbc-psr2-dpms: SKIP (0.001s)
[711.968183] [151/156] (310s left) kms_pipe_crc_basic (suspend-read-crc)
[712.052009] Starting subtest: suspend-read-crc
[712.054471] Starting dynamic subtest: pipe-A-eDP-1
[730.126707] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.557s)
[730.139127] Starting dynamic subtest: pipe-B-eDP-1
[748.159266] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.273s)
[748.174347] Starting dynamic subtest: pipe-C-eDP-1
[766.111572] Dynamic subtest pipe-C-eDP-1: SUCCESS (3.114s)
[766.125184] Starting dynamic subtest: pipe-D-eDP-1
[784.097018] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.060s)
[784.099463] Subtest suspend-read-crc: SUCCESS (12.010s)
[784.901690] [152/156] (238s left) kms_ccs (bad-rotation-90-4-tiled-lnl-ccs)
[785.013644] Starting subtest: bad-rotation-90-4-tiled-lnl-ccs
[785.018187] Subtest bad-rotation-90-4-tiled-lnl-ccs: SKIP (0.000s)
[786.128001] [153/156] (236s left) syncobj_eventfd (invalid-bad-pad)
[786.181084] Starting subtest: invalid-bad-pad
[786.183434] Subtest invalid-bad-pad: SUCCESS (0.000s)
[786.270554] [154/156] (236s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-mmap-gtt)
[786.373509] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-mmap-gtt
[786.377479] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[786.458237] [155/156] (236s left) kms_properties (invalid-properties-atomic)
[786.550687] Starting subtest: invalid-properties-atomic
[786.843123] Subtest invalid-properties-atomic: SUCCESS (0.294s)
[786.894605] [156/156] (236s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-180-hflip)
[786.987647] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-180-hflip
[786.991976] Subtest y-tiled-max-hw-stride-32bpp-rotate-180-hflip: SKIP (0.000s)
[787.056149] Closing watchdogs
results: parsing output: 0/ for test: kms_plane
results: parsing output: 1/ for test: kms_setmode
results: parsing output: 2/ for test: syncobj_timeline
results: parsing output: 3/ for test: kms_frontbuffer_tracking
results: parsing output: 4/ for test: syncobj_timeline
results: parsing output: 5/ for test: kms_addfb_basic
results: parsing output: 6/ for test: syncobj_wait
results: parsing output: 7/ for test: gem_ctx_freq
results: parsing output: 8/ for test: kms_flip_scaled_crc
results: parsing output: 9/ for test: syncobj_timeline
results: parsing output: 10/ for test: prime_mmap_coherency
results: parsing output: 11/ for test: gem_render_copy
results: parsing output: 12/ for test: kms_frontbuffer_tracking
results: parsing output: 13/ for test: kms_plane_scaling
results: parsing output: 14/ for test: perf
results: parsing output: 15/ for test: kms_frontbuffer_tracking
results: parsing output: 16/ for test: gem_exec_fence
results: parsing output: 17/ for test: gem_fenced_exec_thrash
results: parsing output: 18/ for test: kms_hdr
results: parsing output: 19/ for test: gem_exec_params
results: parsing output: 20/ for test: kms_content_protection
results: parsing output: 21/ for test: kms_frontbuffer_tracking
results: parsing output: 22/ for test: kms_frontbuffer_tracking
results: parsing output: 23/ for test: kms_chamelium_frames
results: parsing output: 24/ for test: kms_frontbuffer_tracking
results: parsing output: 25/ for test: kms_frontbuffer_tracking
results: parsing output: 26/ for test: kms_cursor_legacy
results: parsing output: 27/ for test: kms_big_fb
results: parsing output: 28/ for test: kms_frontbuffer_tracking
results: parsing output: 29/ for test: gem_watchdog
results: parsing output: 30/ for test: syncobj_wait
results: parsing output: 31/ for test: gem_mmap_offset
results: parsing output: 32/ for test: syncobj_timeline
results: parsing output: 33/ for test: kms_color
results: parsing output: 34/ for test: kms_frontbuffer_tracking
results: parsing output: 35/ for test: gem_mmap_wc
results: parsing output: 36/ for test: kms_frontbuffer_tracking
results: parsing output: 37/ for test: kms_flip_scaled_crc
results: parsing output: 38/ for test: kms_frontbuffer_tracking
results: parsing output: 39/ for test: gem_exec_balancer
results: parsing output: 40/ for test: kms_vblank
results: parsing output: 41/ for test: gem_fence_thrash
results: parsing output: 42/ for test: gem_render_copy_redux
results: parsing output: 43/ for test: prime_self_import
results: parsing output: 44/ for test: kms_frontbuffer_tracking
results: parsing output: 45/ for test: kms_ccs
results: parsing output: 46/ for test: gem_exec_parallel
results: parsing output: 47/ for test: gem_exec_schedule
results: parsing output: 48/ for test: syncobj_wait
results: parsing output: 49/ for test: core_hotunplug
results: parsing output: 50/ for test: i915_pm_rc6_residency
results: parsing output: 51/ for test: gem_exec_whisper
results: parsing output: 52/ for test: gem_render_copy
results: parsing output: 53/ for test: kms_psr2_sf
results: parsing output: 54/ for test: kms_frontbuffer_tracking
results: parsing output: 55/ for test: kms_sequence
results: parsing output: 56/ for test: kms_frontbuffer_tracking
results: parsing output: 57/ for test: kms_frontbuffer_tracking
results: parsing output: 58/ for test: kms_flip
results: parsing output: 59/ for test: kms_frontbuffer_tracking
results: parsing output: 60/ for test: perf_pmu
results: parsing output: 61/ for test: kms_frontbuffer_tracking
results: parsing output: 62/ for test: kms_frontbuffer_tracking
results: parsing output: 63/ for test: syncobj_wait
results: parsing output: 64/ for test: drm_read
results: parsing output: 65/ for test: kms_cursor_legacy
results: parsing output: 66/ for test: gem_create
results: parsing output: 67/ for test: kms_psr
results: parsing output: 68/ for test: kms_flip
results: parsing output: 69/ for test: kms_frontbuffer_tracking
results: parsing output: 70/ for test: kms_frontbuffer_tracking
results: parsing output: 71/ for test: perf
results: parsing output: 72/ for test: gem_gpgpu_fill
results: parsing output: 73/ for test: api_intel_bb
results: parsing output: 74/ for test: gem_workarounds
results: parsing output: 75/ for test: kms_psr
results: parsing output: 76/ for test: kms_frontbuffer_tracking
results: parsing output: 77/ for test: kms_frontbuffer_tracking
results: parsing output: 78/ for test: kms_frontbuffer_tracking
results: parsing output: 79/ for test: gem_userptr_blits
results: parsing output: 80/ for test: kms_addfb_basic
results: parsing output: 81/ for test: kms_atomic_transition
results: parsing output: 82/ for test: kms_pm_dc
results: parsing output: 83/ for test: kms_cursor_crc
results: parsing output: 84/ for test: kms_chamelium_audio
results: parsing output: 85/ for test: kms_psr2_sf
results: parsing output: 86/ for test: kms_big_fb
results: parsing output: 87/ for test: kms_flip_scaled_crc
results: parsing output: 88/ for test: sysfs_timeslice_duration
results: parsing output: 89/ for test: gem_render_copy_redux
results: parsing output: 90/ for test: core_getclient
results: parsing output: 91/ for test: kms_frontbuffer_tracking
results: parsing output: 92/ for test: kms_flip
results: parsing output: 93/ for test: kms_addfb_basic
results: parsing output: 94/ for test: kms_frontbuffer_tracking
results: parsing output: 95/ for test: kms_prime
results: parsing output: 96/ for test: kms_frontbuffer_tracking
results: parsing output: 97/ for test: kms_psr
results: parsing output: 98/ for test: kms_atomic_transition
results: parsing output: 99/ for test: kms_psr
results: parsing output: 100/ for test: i915_hangman
results: parsing output: 101/ for test: gem_ctx_persistence
results: parsing output: 102/ for test: i915_drm_fdinfo
results: parsing output: 103/ for test: kms_plane
results: parsing output: 104/ for test: gem_partial_pwrite_pread
results: parsing output: 105/ for test: gem_exec_schedule
results: parsing output: 106/ for test: kms_cursor_legacy
results: parsing output: 107/ for test: kms_frontbuffer_tracking
results: parsing output: 108/ for test: kms_frontbuffer_tracking
results: parsing output: 109/ for test: i915_pm_sseu
results: parsing output: 110/ for test: gem_softpin
results: parsing output: 111/ for test: kms_dsc
results: parsing output: 112/ for test: gem_ctx_sseu
results: parsing output: 113/ for test: gen9_exec_parse
results: parsing output: 114/ for test: kms_frontbuffer_tracking
results: parsing output: 115/ for test: syncobj_timeline
results: parsing output: 116/ for test: kms_ccs
results: parsing output: 117/ for test: gem_bad_reloc
results: parsing output: 118/ for test: kms_big_fb
results: parsing output: 119/ for test: kms_lease
results: parsing output: 120/ for test: kms_pm_backlight
results: parsing output: 121/ for test: gem_lmem_swapping
results: parsing output: 122/ for test: gem_userptr_blits
results: parsing output: 123/ for test: kms_frontbuffer_tracking
results: parsing output: 124/ for test: kms_frontbuffer_tracking
results: parsing output: 125/ for test: perf_pmu
results: parsing output: 126/ for test: kms_atomic_transition
results: parsing output: 127/ for test: kms_frontbuffer_tracking
results: parsing output: 128/ for test: kms_frontbuffer_tracking
results: parsing output: 129/ for test: kms_ccs
results: parsing output: 130/ for test: kms_big_fb
results: parsing output: 131/ for test: kms_frontbuffer_tracking
results: parsing output: 132/ for test: kms_frontbuffer_tracking
results: parsing output: 133/ for test: gem_exec_fence
results: parsing output: 134/ for test: gem_pxp
results: parsing output: 135/ for test: gem_render_copy
results: parsing output: 136/ for test: kms_chamelium_hpd
results: parsing output: 137/ for test: kms_frontbuffer_tracking
results: parsing output: 138/ for test: kms_invalid_mode
results: parsing output: 139/ for test: kms_frontbuffer_tracking
results: parsing output: 140/ for test: kms_cursor_edge_walk
results: parsing output: 141/ for test: perf
results: parsing output: 142/ for test: kms_frontbuffer_tracking
results: parsing output: 143/ for test: kms_psr
results: parsing output: 144/ for test: prime_vgem
results: parsing output: 145/ for test: kms_big_fb
results: parsing output: 146/ for test: kms_big_fb
results: parsing output: 147/ for test: gem_fence_thrash
results: parsing output: 148/ for test: kms_cursor_crc
results: parsing output: 149/ for test: kms_psr
results: parsing output: 150/ for test: kms_pipe_crc_basic
results: parsing output: 151/ for test: kms_ccs
results: parsing output: 152/ for test: syncobj_eventfd
results: parsing output: 153/ for test: kms_frontbuffer_tracking
results: parsing output: 154/ for test: kms_properties
results: parsing output: 155/ for test: kms_big_fb
Done.