[60.000356] Initializing watchdogs
[60.000413]   /dev/watchdog0
[60.014181] [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]
[60.018579] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[60.021071] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[60.024802] [001/132] (960s left) gem_softpin (evict-snoop)
[60.112667] Starting subtest: evict-snoop
[60.117201] Subtest evict-snoop: SKIP (0.000s)
[60.184380] [002/132] (960s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-pwrite)
[60.279353] Starting subtest: fbcpsr-rgb101010-draw-pwrite
[67.295175] Subtest fbcpsr-rgb101010-draw-pwrite: SUCCESS (7.019s)
[67.577553] [003/132] (953s left) prime_mmap (test_aperture_limit)
[67.658799] Starting subtest: test_aperture_limit
[67.661157] Starting dynamic subtest: test_aperture_limit-smem
[67.675492] Dynamic subtest test_aperture_limit-smem: SKIP (0.014s)
[67.679883] Subtest test_aperture_limit: SKIP (0.015s)
[67.903157] [004/132] (952s left) kms_hdmi_inject (inject-audio)
[68.385523] Starting subtest: inject-audio
[68.661296] Subtest inject-audio: SUCCESS (0.278s)
[69.248488] [005/132] (951s left) gem_ctx_persistence (saturated-hostile)
[69.314073] Starting subtest: saturated-hostile
[69.316404] Starting dynamic subtest: rcs0
[70.129086] Dynamic subtest rcs0: SUCCESS (0.816s)
[70.140567] Starting dynamic subtest: bcs0
[70.914116] Dynamic subtest bcs0: SUCCESS (0.783s)
[70.923506] Starting dynamic subtest: vcs0
[71.704372] Dynamic subtest vcs0: SUCCESS (0.790s)
[71.715195] Starting dynamic subtest: vcs1
[72.502755] Dynamic subtest vcs1: SUCCESS (0.798s)
[72.513466] Starting dynamic subtest: vecs0
[73.294462] Dynamic subtest vecs0: SUCCESS (0.791s)
[73.304778] Starting dynamic subtest: ccs0
[74.108984] Dynamic subtest ccs0: SUCCESS (0.814s)
[74.111769] Subtest saturated-hostile: SUCCESS (4.797s)
[74.187897] [006/132] (946s left) kms_cursor_legacy (basic-busy-flip-before-cursor-legacy)
[74.314328] Starting subtest: basic-busy-flip-before-cursor-legacy
[74.318746] Subtest basic-busy-flip-before-cursor-legacy: SKIP (0.000s)
[74.453260] [007/132] (946s left) perf (oa-formats)
[74.563248] Starting subtest: oa-formats
[74.565394] Starting dynamic subtest: 0-rcs0
[74.578190] Dynamic subtest 0-rcs0: SUCCESS (0.017s)
[74.587375] Starting dynamic subtest: 1-vcs0
[74.599829] Dynamic subtest 1-vcs0: SUCCESS (0.021s)
[74.602176] Subtest oa-formats: SUCCESS (0.039s)
[74.645842] [008/132] (946s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip)
[74.743280] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip
[75.377878] Subtest 4-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip: SUCCESS (0.637s)
[75.546106] [009/132] (945s left) kms_getfb (getfb2-into-addfb2)
[75.644857] Starting subtest: getfb2-into-addfb2
[75.647456] Subtest getfb2-into-addfb2: SUCCESS (0.000s)
[75.735164] [010/132] (945s left) gem_mmap (basic-small-bo)
[75.792212] Subtest basic-small-bo: SKIP (0.000s)
[75.844908] [011/132] (945s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-mmap-wc)
[75.939825] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-mmap-wc
[75.944080] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[76.024128] [012/132] (944s left) gem_ringfill (engines-basic)
[81.882241] Starting subtest: engines-basic
[81.884953] Starting dynamic subtest: rcs0
[81.948346] Dynamic subtest rcs0: SUCCESS (0.067s)
[81.959024] Starting dynamic subtest: bcs0
[81.991881] Dynamic subtest bcs0: SUCCESS (0.043s)
[82.001266] Starting dynamic subtest: vcs0
[82.034074] Dynamic subtest vcs0: SUCCESS (0.041s)
[82.043271] Starting dynamic subtest: vcs1
[82.076984] Dynamic subtest vcs1: SUCCESS (0.042s)
[82.086520] Starting dynamic subtest: vecs0
[82.120149] Dynamic subtest vecs0: SUCCESS (0.042s)
[82.128810] Starting dynamic subtest: ccs0
[82.164981] Dynamic subtest ccs0: SUCCESS (0.044s)
[82.167506] Subtest engines-basic: SUCCESS (0.285s)
[82.237837] [FACT gem_ringfill (engines-basic)] new: kernel.kmod_is_loaded.vgem: true
[82.240909] [013/132] (938s left) gem_exec_balancer (indices)
[82.306048] Starting subtest: indices
[84.852646] Subtest indices: SUCCESS (2.542s)
[85.155193] [014/132] (935s left) gem_ctx_engines (execute-oneforall)
[85.226407] Starting subtest: execute-oneforall
[86.168270] Subtest execute-oneforall: SUCCESS (0.940s)
[87.077171] [015/132] (934s left) gem_exec_schedule (preempt-contexts)
[87.154972] Starting subtest: preempt-contexts
[87.157333] Starting dynamic subtest: rcs0
[87.248076] Dynamic subtest rcs0: SUCCESS (0.100s)
[87.258017] Starting dynamic subtest: bcs0
[87.333999] Dynamic subtest bcs0: SUCCESS (0.085s)
[87.347140] Starting dynamic subtest: vcs0
[87.403035] Dynamic subtest vcs0: SUCCESS (0.069s)
[87.414252] Starting dynamic subtest: vcs1
[87.466445] Dynamic subtest vcs1: SUCCESS (0.063s)
[87.476662] Starting dynamic subtest: vecs0
[87.536777] Dynamic subtest vecs0: SUCCESS (0.069s)
[87.546432] Starting dynamic subtest: ccs0
[87.610711] Dynamic subtest ccs0: SUCCESS (0.074s)
[87.612976] Subtest preempt-contexts: SUCCESS (0.463s)
[88.997220] [016/132] (932s left) gem_exec_store (basic)
[89.058490] Starting subtest: basic
[89.188040] Subtest basic: SUCCESS (0.130s)
[89.374911] [017/132] (931s left) kms_ccs (crc-primary-rotation-180-4-tiled-lnl-ccs)
[89.467731] Starting subtest: crc-primary-rotation-180-4-tiled-lnl-ccs
[89.472234] Subtest crc-primary-rotation-180-4-tiled-lnl-ccs: SKIP (0.000s)
[90.639168] [018/132] (930s left) syncobj_timeline (multi-wait-for-submit-unsubmitted-submitted-signaled)
[90.698046] Starting subtest: multi-wait-for-submit-unsubmitted-submitted-signaled
[90.700129] Subtest multi-wait-for-submit-unsubmitted-submitted-signaled: SUCCESS (0.001s)
[90.790314] [019/132] (930s left) gem_pxp (verify-pxp-stale-ctx-execution)
[90.900338] Starting subtest: verify-pxp-stale-ctx-execution
[91.960523] Subtest verify-pxp-stale-ctx-execution: SUCCESS (1.062s)
[92.073525] [020/132] (929s left) kms_ccs (bad-aux-stride-4-tiled-mtl-mc-ccs)
[92.170535] Starting subtest: bad-aux-stride-4-tiled-mtl-mc-ccs
[92.172727] Starting dynamic subtest: pipe-A-eDP-1
[92.228060] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.058s)
[92.237720] Starting dynamic subtest: pipe-B-eDP-1
[92.288472] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.060s)
[92.297328] Starting dynamic subtest: pipe-C-eDP-1
[92.351354] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.062s)
[92.360902] Starting dynamic subtest: pipe-D-eDP-1
[92.413515] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.059s)
[92.415863] Subtest bad-aux-stride-4-tiled-mtl-mc-ccs: SUCCESS (0.242s)
[94.632749] [021/132] (926s left) kms_psr (pr-cursor-render)
[94.721199] Starting subtest: pr-cursor-render
[94.725770] Subtest pr-cursor-render: SKIP (0.000s)
[94.805542] [022/132] (926s left) kms_chamelium_hpd (vga-hpd-without-ddc)
[95.215467] Subtest vga-hpd-without-ddc: SKIP (0.000s)
[96.006254] [023/132] (925s left) syncobj_basic (bad-handle-to-fd)
[96.062702] Starting subtest: bad-handle-to-fd
[96.065109] Subtest bad-handle-to-fd: SUCCESS (0.000s)
[96.156857] [024/132] (925s left) syncobj_wait (wait-any-snapshot)
[96.215872] Starting subtest: wait-any-snapshot
[96.295802] Subtest wait-any-snapshot: SUCCESS (0.081s)
[96.370712] [025/132] (925s left) kms_fbcon_fbt (fbc-suspend)
[96.432035] Starting subtest: fbc-suspend
[146.092817] Subtest fbc-suspend: SUCCESS (19.330s)
[147.438576] [026/132] (874s left) kms_cursor_crc (cursor-random-128x42)
[147.673526] Starting subtest: cursor-random-128x42
[147.724759] Subtest cursor-random-128x42: SKIP (0.043s)
[147.939948] [027/132] (873s left) gem_exec_params (rel-constants-invalid)
[147.996259] Starting subtest: rel-constants-invalid
[147.998620] Subtest rel-constants-invalid: SUCCESS (0.000s)
[148.090604] [028/132] (873s left) perf (buffer-fill)
[148.171038] Starting subtest: buffer-fill
[148.173512] Starting dynamic subtest: 0-rcs0
[150.422528] Dynamic subtest 0-rcs0: SUCCESS (2.246s)
[150.432123] Starting dynamic subtest: 1-vcs1
[154.861278] Dynamic subtest 1-vcs1: SUCCESS (4.433s)
[154.864043] Subtest buffer-fill: SUCCESS (6.681s)
[154.904301] [029/132] (866s left) kms_content_protection (atomic-hdcp14)
[155.053515] Starting subtest: atomic-hdcp14
[155.058046] Subtest atomic-hdcp14: SKIP (0.000s)
[155.176885] [030/132] (866s left) perf (mi-rpc)
[155.271827] Starting subtest: mi-rpc
[155.276674] Subtest mi-rpc: SKIP (0.000s)
[155.319865] [031/132] (866s left) kms_chamelium_color (gamma)
[155.404457] Subtest gamma: SKIP (0.000s)
[155.452172] [032/132] (866s left) gem_exec_fence (invalid-timeline-fence-array)
[156.001690] Starting subtest: invalid-timeline-fence-array
[156.007217] Subtest invalid-timeline-fence-array: SUCCESS (0.006s)
[157.288402] [033/132] (864s left) gem_render_copy (y-tiled-ccs-to-linear)
[157.355235] Starting subtest: y-tiled-ccs-to-linear
[157.359836] Subtest y-tiled-ccs-to-linear: SKIP (0.000s)
[157.539057] [034/132] (864s left) gem_media_vme
[157.679637] [035/132] (864s left) perf (global-sseu-config-invalid)
[157.777441] Starting subtest: global-sseu-config-invalid
[157.781681] Subtest global-sseu-config-invalid: SKIP (0.000s)
[157.822867] [036/132] (864s left) kms_cursor_crc (cursor-offscreen-512x512)
[158.098279] Starting subtest: cursor-offscreen-512x512
[158.102770] Subtest cursor-offscreen-512x512: SKIP (0.001s)
[158.289255] [037/132] (863s left) kms_psr (fbc-psr2-cursor-blt)
[158.379564] Starting subtest: fbc-psr2-cursor-blt
[158.381462] Starting dynamic subtest: eDP-1
[158.385434] Dynamic subtest eDP-1: SKIP (0.000s)
[158.389386] Subtest fbc-psr2-cursor-blt: SKIP (0.000s)
[158.449322] [038/132] (863s left) perf (i915-ref-count)
[158.522863] Starting subtest: i915-ref-count
[158.560033] Subtest i915-ref-count: SUCCESS (0.036s)
[158.632406] [039/132] (863s left) gem_ctx_exec (basic-nohangcheck)
[158.704900] Starting subtest: basic-nohangcheck
[158.939444] Subtest basic-nohangcheck: SUCCESS (0.234s)
[159.050398] [040/132] (863s left) kms_dirtyfb (default-dirtyfb-ioctl)
[159.150470] Starting subtest: default-dirtyfb-ioctl
[159.152395] Starting dynamic subtest: A-eDP-1
[160.715100] Dynamic subtest A-eDP-1: SUCCESS (1.562s)
[160.717054] Subtest default-dirtyfb-ioctl: SUCCESS (1.563s)
[161.549193] [041/132] (860s left) gem_softpin (allocator-nopin-reserve)
[161.618316] Starting subtest: allocator-nopin-reserve
[161.725402] Subtest allocator-nopin-reserve: SUCCESS (0.106s)
[161.850398] [042/132] (860s left) gen7_exec_parse (oacontrol-tracking)
[161.902840] Subtest oacontrol-tracking: SKIP (0.000s)
[161.984769] [043/132] (860s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-fullscreen)
[162.077215] Starting subtest: psr-1p-primscrn-spr-indfb-fullscreen
[168.710614] Subtest psr-1p-primscrn-spr-indfb-fullscreen: SUCCESS (6.631s)
[168.834237] [044/132] (853s left) kms_cursor_legacy (cursora-vs-flipa-atomic)
[168.958847] Starting subtest: cursorA-vs-flipA-atomic
[180.092238] Subtest cursorA-vs-flipA-atomic: SUCCESS (11.132s)
[180.963801] [045/132] (841s left) kms_joiner (basic-force-big-joiner)
[181.066885] Starting subtest: basic-force-big-joiner
[181.071141] Subtest basic-force-big-joiner: SKIP (0.000s)
[181.151295] [046/132] (841s left) kms_frontbuffer_tracking (psr-suspend)
[181.239157] Starting subtest: psr-suspend
[219.354207] Subtest psr-suspend: SUCCESS (7.815s)
[219.473699] [047/132] (802s left) kms_atomic_interruptible (legacy-cursor)
[219.595025] Starting subtest: legacy-cursor
[219.597873] Starting dynamic subtest: pipe-A-eDP-1
[226.999008] Dynamic subtest pipe-A-eDP-1: SUCCESS (7.384s)
[227.001332] Subtest legacy-cursor: SUCCESS (7.386s)
[227.840886] [048/132] (794s left) kms_addfb_basic (too-wide)
[227.965951] Starting subtest: too-wide
[227.967812] Subtest too-wide: SUCCESS (0.000s)
[228.061276] [049/132] (794s left) kms_psr2_sf (pr-primary-plane-update-sf-dmg-area-big-fb)
[228.154871] Starting subtest: pr-primary-plane-update-sf-dmg-area-big-fb
[228.159068] Subtest pr-primary-plane-update-sf-dmg-area-big-fb: SKIP (0.000s)
[228.226260] [050/132] (794s left) kms_plane (pixel-format-4-tiled-modifier-source-clamping)
[228.307957] Starting subtest: pixel-format-4-tiled-modifier-source-clamping
[228.334392] Starting dynamic subtest: pipe-A-plane-0
[229.034837] Dynamic subtest pipe-A-plane-0: SUCCESS (0.700s)
[229.042938] Starting dynamic subtest: pipe-A-plane-3
[229.446596] Dynamic subtest pipe-A-plane-3: SUCCESS (0.411s)
[230.587812] Starting dynamic subtest: pipe-B-plane-0
[231.246590] Dynamic subtest pipe-B-plane-0: SUCCESS (0.667s)
[231.255771] Starting dynamic subtest: pipe-B-plane-3
[231.668356] Dynamic subtest pipe-B-plane-3: SUCCESS (0.421s)
[231.981056] Subtest pixel-format-4-tiled-modifier-source-clamping: SUCCESS (3.668s)
[232.823607] [051/132] (789s left) gem_exec_params (invalid-fence-in-submit)
[232.884591] Starting subtest: invalid-fence-in-submit
[232.889448] Subtest invalid-fence-in-submit: SUCCESS (0.003s)
[233.003758] [052/132] (789s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-blt)
[233.098582] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-blt
[233.102776] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-blt: SKIP (0.000s)
[233.181992] [053/132] (789s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-blt)
[233.281582] Starting subtest: psr-1p-primscrn-pri-indfb-draw-blt
[240.518923] Subtest psr-1p-primscrn-pri-indfb-draw-blt: SUCCESS (7.234s)
[240.638968] [054/132] (782s left) kms_ccs (ccs-on-another-bo-y-tiled-gen12-mc-ccs)
[240.739299] Starting subtest: ccs-on-another-bo-y-tiled-gen12-mc-ccs
[240.741643] Starting dynamic subtest: pipe-A-eDP-1
[240.764850] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[240.776208] Starting dynamic subtest: pipe-B-eDP-1
[240.797807] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[240.806628] Starting dynamic subtest: pipe-C-eDP-1
[240.828164] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[240.836379] Starting dynamic subtest: pipe-D-eDP-1
[240.857744] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[240.862177] Subtest ccs-on-another-bo-y-tiled-gen12-mc-ccs: SKIP (0.004s)
[242.935570] [055/132] (779s left) i915_pm_rps (fence-order)
[243.000402] Starting subtest: fence-order
[245.927494] Subtest fence-order: SUCCESS (2.923s)
[246.057090] [056/132] (776s left) kms_pipe_crc_basic (compare-crc-sanitycheck-nv12)
[246.158032] Starting subtest: compare-crc-sanitycheck-nv12
[246.160007] Starting dynamic subtest: pipe-A-eDP-1
[246.830255] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.671s)
[246.840672] Starting dynamic subtest: pipe-B-eDP-1
[248.093633] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.263s)
[248.104835] Starting dynamic subtest: pipe-C-eDP-1
[249.336898] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.239s)
[249.347361] Starting dynamic subtest: pipe-D-eDP-1
[250.555356] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.219s)
[250.558144] Subtest compare-crc-sanitycheck-nv12: SUCCESS (4.397s)
[251.364804] [057/132] (771s left) kms_psr2_sf (psr2-overlay-plane-move-continuous-exceed-fully-sf)
[251.478322] Starting subtest: psr2-overlay-plane-move-continuous-exceed-fully-sf
[251.480755] Starting dynamic subtest: pipe-A-eDP-1
[267.950145] Dynamic subtest pipe-A-eDP-1: SUCCESS (16.474s)
[267.961603] Starting dynamic subtest: pipe-B-eDP-1
[285.111934] Dynamic subtest pipe-B-eDP-1: SUCCESS (17.155s)
[285.114341] Subtest psr2-overlay-plane-move-continuous-exceed-fully-sf: SUCCESS (33.632s)
[285.943325] [058/132] (736s left) kms_flip_scaled_crc (flip-64bpp-xtile-to-16bpp-xtile-downscaling)
[286.044249] Starting subtest: flip-64bpp-xtile-to-16bpp-xtile-downscaling
[286.046605] Starting dynamic subtest: pipe-A-default-mode
[287.173398] Dynamic subtest pipe-A-default-mode: SKIP (1.128s)
[287.177786] Subtest flip-64bpp-xtile-to-16bpp-xtile-downscaling: SKIP (1.129s)
[287.305189] [059/132] (735s left) prime_vgem (basic-gtt)
[287.390260] Starting subtest: basic-gtt
[287.394920] Subtest basic-gtt: SKIP (0.000s)
[287.495084] [060/132] (735s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-0-hflip)
[287.600458] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-0-hflip
[288.593663] Subtest x-tiled-max-hw-stride-64bpp-rotate-0-hflip: SUCCESS (0.993s)
[288.714182] [061/132] (734s left) drm_read (invalid-buffer)
[288.903589] Starting subtest: invalid-buffer
[288.905575] Subtest invalid-buffer: SUCCESS (0.000s)
[289.038216] [062/132] (733s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-180-async-flip)
[289.132303] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-180-async-flip
[289.136070] Subtest yf-tiled-max-hw-stride-64bpp-rotate-180-async-flip: SKIP (0.000s)
[289.237715] [063/132] (733s left) kms_addfb_basic (addfb25-x-tiled-mismatch-legacy)
[289.330668] Subtest addfb25-x-tiled-mismatch-legacy: SKIP (0.000s)
[289.423279] [064/132] (733s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-mmap-gtt)
[289.525445] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-mmap-gtt
[289.529171] Subtest fbc-1p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[289.630283] [065/132] (733s left) perf (low-oa-exponent-permissions)
[289.727136] Starting subtest: low-oa-exponent-permissions
[289.759224] Subtest low-oa-exponent-permissions: SUCCESS (0.032s)
[289.804632] [066/132] (733s left) syncobj_timeline (etime-multi-wait-all-available-unsubmitted)
[289.868536] Starting subtest: etime-multi-wait-all-available-unsubmitted
[289.972732] Subtest etime-multi-wait-all-available-unsubmitted: SUCCESS (0.104s)
[290.048242] [067/132] (733s left) kms_flip (2x-wf_vblank-ts-check-interruptible)
[290.142708] Starting subtest: 2x-wf_vblank-ts-check-interruptible
[290.155084] Subtest 2x-wf_vblank-ts-check-interruptible: SKIP (0.011s)
[290.233725] [068/132] (733s left) kms_psr (psr-cursor-mmap-gtt)
[290.334948] Starting subtest: psr-cursor-mmap-gtt
[290.337161] Starting dynamic subtest: eDP-1
[292.018517] Dynamic subtest eDP-1: SUCCESS (1.681s)
[292.020874] Subtest psr-cursor-mmap-gtt: SUCCESS (1.682s)
[292.845508] [069/132] (730s left) i915_drm_fdinfo (busy-check-all)
[292.890962] Starting subtest: busy-check-all
[292.893545] Starting dynamic subtest: rcs0
[292.898341] Dynamic subtest rcs0: SKIP (0.004s)
[292.908878] Starting dynamic subtest: bcs0
[292.913151] Dynamic subtest bcs0: SKIP (0.000s)
[292.921879] Starting dynamic subtest: vcs0
[292.926417] Dynamic subtest vcs0: SKIP (0.000s)
[292.934841] Starting dynamic subtest: vcs1
[292.939230] Dynamic subtest vcs1: SKIP (0.000s)
[292.947649] Starting dynamic subtest: vecs0
[292.952076] Dynamic subtest vecs0: SKIP (0.000s)
[292.960558] Starting dynamic subtest: ccs0
[292.964960] Dynamic subtest ccs0: SKIP (0.000s)
[292.969343] Subtest busy-check-all: SKIP (0.011s)
[293.005521] [070/132] (730s left) perf_pmu (busy-idle-check-all)
[293.055439] Starting subtest: busy-idle-check-all
[293.057662] Starting dynamic subtest: rcs0
[293.716946] Dynamic subtest rcs0: SUCCESS (0.663s)
[293.728695] Starting dynamic subtest: bcs0
[294.367639] Dynamic subtest bcs0: SUCCESS (0.648s)
[294.381563] Starting dynamic subtest: vcs0
[295.075235] Dynamic subtest vcs0: FAIL (0.633s)
[295.085930] Starting dynamic subtest: vcs1
[295.707981] Dynamic subtest vcs1: FAIL (0.622s)
[295.718413] Starting dynamic subtest: vecs0
[296.330667] Dynamic subtest vecs0: FAIL (0.623s)
[296.341705] Starting dynamic subtest: ccs0
[296.955607] Dynamic subtest ccs0: FAIL (0.622s)
[296.957613] Subtest busy-idle-check-all: FAIL (3.820s)
[297.558041] [071/132] (725s left) syncobj_wait (invalid-multi-wait-unsubmitted-submitted-signaled)
[297.625244] Starting subtest: invalid-multi-wait-unsubmitted-submitted-signaled
[297.627567] Subtest invalid-multi-wait-unsubmitted-submitted-signaled: SUCCESS (0.000s)
[297.738259] [072/132] (725s left) kms_plane_scaling (planes-downscale-factor-0-75-upscale-factor-0-25)
[297.839959] Starting subtest: planes-downscale-factor-0-75-upscale-factor-0-25
[297.842174] Starting dynamic subtest: pipe-A
[297.903209] Dynamic subtest pipe-A: SUCCESS (0.065s)
[297.914700] Starting dynamic subtest: pipe-B
[299.040872] Dynamic subtest pipe-B: SUCCESS (1.136s)
[299.052146] Starting dynamic subtest: pipe-C
[300.120130] Dynamic subtest pipe-C: SUCCESS (1.077s)
[300.130908] Starting dynamic subtest: pipe-D
[301.213675] Dynamic subtest pipe-D: SUCCESS (1.093s)
[301.216069] Subtest planes-downscale-factor-0-75-upscale-factor-0-25: SUCCESS (3.375s)
[302.364656] [073/132] (721s left) kms_chamelium_audio (dp-audio)
[302.745216] Subtest dp-audio: SKIP (0.000s)
[303.525225] [074/132] (720s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-180-hflip)
[303.624186] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-180-hflip
[303.629215] Subtest yf-tiled-max-hw-stride-32bpp-rotate-180-hflip: SKIP (0.000s)
[303.719371] [075/132] (719s left) gem_ctx_shared (q-in-order)
[303.795367] Starting subtest: Q-in-order
[303.797713] Starting dynamic subtest: rcs0
[303.908836] Dynamic subtest rcs0: SUCCESS (0.111s)
[303.927195] Starting dynamic subtest: vcs0
[303.992038] Dynamic subtest vcs0: SUCCESS (0.084s)
[304.010154] Starting dynamic subtest: vcs1
[304.074508] Dynamic subtest vcs1: SUCCESS (0.082s)
[304.091565] Starting dynamic subtest: vecs0
[304.147032] Dynamic subtest vecs0: SUCCESS (0.071s)
[304.163668] Starting dynamic subtest: ccs0
[304.226185] Dynamic subtest ccs0: SUCCESS (0.078s)
[304.229010] Subtest Q-in-order: SUCCESS (0.432s)
[305.583754] [076/132] (718s left) kms_ccs (bad-pixel-format-4-tiled-mtl-rc-ccs-cc)
[305.684102] Starting subtest: bad-pixel-format-4-tiled-mtl-rc-ccs-cc
[305.686331] Starting dynamic subtest: pipe-A-eDP-1
[305.707000] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s)
[305.716566] Starting dynamic subtest: pipe-B-eDP-1
[305.736985] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[305.746440] Starting dynamic subtest: pipe-C-eDP-1
[305.765767] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[305.776793] Starting dynamic subtest: pipe-D-eDP-1
[305.796840] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[305.799356] Subtest bad-pixel-format-4-tiled-mtl-rc-ccs-cc: SUCCESS (0.007s)
[307.960726] [077/132] (715s left) sysfs_preempt_timeout (timeout)
[308.007066] Starting subtest: timeout
[308.009360] Starting dynamic subtest: vecs0
[317.511162] Dynamic subtest vecs0: SUCCESS (9.499s)
[317.523145] Starting dynamic subtest: ccs0
[318.781390] Dynamic subtest ccs0: SUCCESS (1.269s)
[318.795006] Starting dynamic subtest: vcs0
[328.527604] Dynamic subtest vcs0: SUCCESS (9.747s)
[328.538674] Starting dynamic subtest: bcs0
[329.786486] Dynamic subtest bcs0: SUCCESS (1.259s)
[329.795475] Starting dynamic subtest: rcs0
[331.052435] Dynamic subtest rcs0: SUCCESS (1.262s)
[331.064374] Starting dynamic subtest: vcs1
[340.489355] Dynamic subtest vcs1: SUCCESS (9.435s)
[340.491953] Subtest timeout: SUCCESS (32.483s)
[340.600319] [078/132] (683s left) kms_pm_backlight (fade-with-suspend)
[340.709007] Starting subtest: fade-with-suspend
[357.083471] Starting dynamic subtest: eDP-1
[359.569143] Dynamic subtest eDP-1: SUCCESS (2.483s)
[359.571468] Subtest fade-with-suspend: SUCCESS (3.929s)
[360.419089] [079/132] (663s left) kms_frontbuffer_tracking (psr-2p-primscrn-indfb-plflip-blt)
[360.523488] Starting subtest: psr-2p-primscrn-indfb-plflip-blt
[360.527960] Subtest psr-2p-primscrn-indfb-plflip-blt: SKIP (0.000s)
[360.617365] [080/132] (663s left) kms_flip (flip-vs-panning-interruptible)
[360.721922] Starting subtest: flip-vs-panning-interruptible
[360.724346] Starting dynamic subtest: A-eDP1
[369.380773] Dynamic subtest A-eDP1: SUCCESS (8.641s)
[369.394305] Starting dynamic subtest: B-eDP1
[378.121902] Dynamic subtest B-eDP1: SUCCESS (8.729s)
[378.133683] Starting dynamic subtest: C-eDP1
[386.804352] Dynamic subtest C-eDP1: SUCCESS (8.674s)
[386.814565] Starting dynamic subtest: D-eDP1
[395.504479] Dynamic subtest D-eDP1: SUCCESS (8.700s)
[395.508729] Subtest flip-vs-panning-interruptible: SUCCESS (34.757s)
[396.741847] [081/132] (627s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-blt)
[396.861821] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-blt
[403.662260] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-blt: SUCCESS (6.803s)
[403.838359] [082/132] (620s left) gem_mmap_wc (write-cpu-read-wc)
[403.904605] Subtest write-cpu-read-wc: SKIP (0.000s)
[403.959445] [083/132] (620s left) gem_exec_schedule (u-fairslice)
[404.021088] Starting subtest: u-fairslice
[404.022984] Starting dynamic subtest: rcs0
[406.040550] Dynamic subtest rcs0: SUCCESS (2.021s)
[406.052430] Starting dynamic subtest: bcs0
[408.058083] Dynamic subtest bcs0: SUCCESS (2.020s)
[408.067632] Starting dynamic subtest: vcs0
[410.080376] Dynamic subtest vcs0: SUCCESS (2.018s)
[410.090922] Starting dynamic subtest: vcs1
[412.099065] Dynamic subtest vcs1: SUCCESS (2.018s)
[412.109549] Starting dynamic subtest: vecs0
[414.118320] Dynamic subtest vecs0: SUCCESS (2.017s)
[414.129228] Starting dynamic subtest: ccs0
[416.137450] Dynamic subtest ccs0: SUCCESS (2.019s)
[416.139474] Subtest u-fairslice: SUCCESS (12.118s)
[416.457559] [084/132] (607s left) core_setmaster (master-drop-set-shared-fd)
[416.547211] Starting subtest: master-drop-set-shared-fd
[416.569531] Subtest master-drop-set-shared-fd: SUCCESS (0.021s)
[416.634508] [085/132] (607s left) prime_vgem (basic-read)
[416.722957] Starting subtest: basic-read
[416.731562] Subtest basic-read: SKIP (0.007s)
[416.841705] [086/132] (607s left) gem_exec_suspend (basic-s3)
[416.900118] Starting subtest: basic-S3
[416.902066] Starting dynamic subtest: smem
[436.798357] Dynamic subtest smem: SUCCESS (6.542s)
[436.801773] Subtest basic-S3: SUCCESS (6.544s)
[436.989231] [087/132] (587s left) kms_atomic_transition (modeset-transition-nonblocking-fencing)
[437.088285] Starting subtest: modeset-transition-nonblocking-fencing
[437.090596] Starting dynamic subtest: 1x-outputs
[448.195528] Dynamic subtest 1x-outputs: SUCCESS (11.083s)
[448.198057] Subtest modeset-transition-nonblocking-fencing: SUCCESS (11.084s)
[449.015237] [088/132] (575s left) kms_sequence (get-forked)
[449.115859] Starting subtest: get-forked
[449.117989] Starting dynamic subtest: pipe-A-eDP-1
[450.997778] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.880s)
[451.008795] Starting dynamic subtest: pipe-B-eDP-1
[453.548262] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.545s)
[453.559108] Starting dynamic subtest: pipe-C-eDP-1
[456.111576] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.562s)
[456.122220] Starting dynamic subtest: pipe-D-eDP-1
[458.616163] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.499s)
[458.618178] Subtest get-forked: SUCCESS (9.491s)
[459.425253] [089/132] (564s left) kms_ccs (missing-ccs-buffer-4-tiled-mtl-rc-ccs-cc)
[459.537191] Starting subtest: missing-ccs-buffer-4-tiled-mtl-rc-ccs-cc
[459.539533] Starting dynamic subtest: pipe-A-eDP-1
[459.560620] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s)
[459.572988] Starting dynamic subtest: pipe-B-eDP-1
[459.592712] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[459.601562] Starting dynamic subtest: pipe-C-eDP-1
[459.621036] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[459.629658] Starting dynamic subtest: pipe-D-eDP-1
[459.649093] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[459.651048] Subtest missing-ccs-buffer-4-tiled-mtl-rc-ccs-cc: SUCCESS (0.006s)
[461.819494] [090/132] (562s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-mmap-wc)
[461.910901] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-mmap-wc
[461.915384] Subtest fbc-2p-scndscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[462.039014] [091/132] (562s left) gem_lmem_swapping (massive-random)
[462.087038] Subtest massive-random: SKIP (0.000s)
[462.136372] [092/132] (562s left) gem_exec_capture (capture)
[462.191096] Starting subtest: capture
[462.193487] Starting dynamic subtest: rcs0-smem
[463.027677] Dynamic subtest rcs0-smem: SUCCESS (0.835s)
[463.038994] Starting dynamic subtest: bcs0-smem
[464.086169] Dynamic subtest bcs0-smem: SUCCESS (1.057s)
[464.095198] Starting dynamic subtest: vcs0-smem
[464.913632] Dynamic subtest vcs0-smem: SUCCESS (0.827s)
[464.922736] Starting dynamic subtest: vcs1-smem
[465.743627] Dynamic subtest vcs1-smem: SUCCESS (0.829s)
[465.752997] Starting dynamic subtest: vecs0-smem
[467.135707] Dynamic subtest vecs0-smem: FAIL (1.325s)
[467.145467] Starting dynamic subtest: ccs0-smem
[468.389204] Dynamic subtest ccs0-smem: SUCCESS (1.319s)
[468.391102] Subtest capture: FAIL (6.197s)
[468.498832] [093/132] (555s left) kms_frontbuffer_tracking (psr-2p-scndscrn-indfb-msflip-blt)
[468.604562] Starting subtest: psr-2p-scndscrn-indfb-msflip-blt
[468.608880] Subtest psr-2p-scndscrn-indfb-msflip-blt: SKIP (0.000s)
[468.697196] [094/132] (555s left) kms_fbcon_fbt (psr-suspend)
[468.752167] Starting subtest: psr-suspend
[518.007375] Subtest psr-suspend: SUCCESS (19.940s)
[518.081990] [095/132] (506s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-shrfb-msflip-blt)
[518.199093] Starting subtest: fbcpsr-1p-primscrn-shrfb-msflip-blt
[525.422435] Subtest fbcpsr-1p-primscrn-shrfb-msflip-blt: SUCCESS (7.211s)
[525.544576] [096/132] (498s left) kms_big_fb (linear-64bpp-rotate-180)
[525.647960] Starting subtest: linear-64bpp-rotate-180
[527.286254] Subtest linear-64bpp-rotate-180: SUCCESS (1.635s)
[527.478661] [097/132] (497s left) kms_flip (2x-busy-flip)
[527.583666] Starting subtest: 2x-busy-flip
[527.592638] Subtest 2x-busy-flip: SKIP (0.010s)
[527.685732] [098/132] (496s left) syncobj_timeline (etime-multi-wait-all-submitted)
[527.745665] Starting subtest: etime-multi-wait-all-submitted
[527.855371] Subtest etime-multi-wait-all-submitted: SUCCESS (0.107s)
[527.937366] [099/132] (496s left) kms_vblank (ts-continuation-modeset-rpm)
[528.032135] Starting subtest: ts-continuation-modeset-rpm
[528.034087] Starting dynamic subtest: pipe-A-eDP-1
[530.574063] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.538s)
[530.589389] Starting dynamic subtest: pipe-D-eDP-1
[532.762299] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.185s)
[532.764681] Subtest ts-continuation-modeset-rpm: SUCCESS (4.727s)
[533.621548] [100/132] (491s left) gem_pread (self)
[533.676322] Subtest self: SKIP (0.000s)
[533.736585] [101/132] (491s left) kms_flip (2x-flip-vs-dpms-off-vs-modeset-interruptible)
[533.817712] Starting subtest: 2x-flip-vs-dpms-off-vs-modeset-interruptible
[533.830030] Subtest 2x-flip-vs-dpms-off-vs-modeset-interruptible: SKIP (0.010s)
[533.942992] [102/132] (490s left) kms_plane (plane-position-hole-dpms)
[534.037300] Starting subtest: plane-position-hole-dpms
[534.563750] Starting dynamic subtest: pipe-A-plane-1
[536.985417] Dynamic subtest pipe-A-plane-1: SUCCESS (2.419s)
[536.995900] Starting dynamic subtest: pipe-A-plane-2
[539.334386] Dynamic subtest pipe-A-plane-2: SUCCESS (2.348s)
[539.344142] Starting dynamic subtest: pipe-A-plane-3
[541.640040] Dynamic subtest pipe-A-plane-3: SUCCESS (2.303s)
[541.650159] Starting dynamic subtest: pipe-A-plane-4
[544.052150] Dynamic subtest pipe-A-plane-4: SUCCESS (2.409s)
[544.061946] Starting dynamic subtest: pipe-A-plane-5
[544.075397] Dynamic subtest pipe-A-plane-5: SUCCESS (0.023s)
[545.311790] Starting dynamic subtest: pipe-B-plane-1
[547.675085] Dynamic subtest pipe-B-plane-1: SUCCESS (2.378s)
[547.684744] Starting dynamic subtest: pipe-B-plane-2
[550.028202] Dynamic subtest pipe-B-plane-2: SUCCESS (2.352s)
[550.037774] Starting dynamic subtest: pipe-B-plane-3
[552.331469] Dynamic subtest pipe-B-plane-3: SUCCESS (2.304s)
[552.341916] Starting dynamic subtest: pipe-B-plane-4
[554.628457] Dynamic subtest pipe-B-plane-4: SUCCESS (2.297s)
[554.639592] Starting dynamic subtest: pipe-B-plane-5
[554.657730] Dynamic subtest pipe-B-plane-5: SUCCESS (0.027s)
[554.660049] Subtest plane-position-hole-dpms: SUCCESS (20.619s)
[555.436855] [103/132] (469s left) kms_cursor_edge_walk (128x128-top-edge)
[555.548801] Starting subtest: 128x128-top-edge
[555.551036] Starting dynamic subtest: pipe-A-eDP-1
[559.067315] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.518s)
[559.076821] Starting dynamic subtest: pipe-D-eDP-1
[562.227886] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.160s)
[562.230086] Subtest 128x128-top-edge: SUCCESS (6.681s)
[563.030201] [104/132] (461s left) syncobj_timeline (invalid-wait-illegal-handle)
[563.099259] Starting subtest: invalid-wait-illegal-handle
[563.101419] Subtest invalid-wait-illegal-handle: SUCCESS (0.000s)
[563.206661] [105/132] (461s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-blt)
[563.307199] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-blt
[566.948990] Subtest fbc-1p-primscrn-cur-indfb-draw-blt: SUCCESS (3.645s)
[568.149513] [106/132] (456s left) i915_query (query-regions-sanity-check)
[568.220652] Starting subtest: query-regions-sanity-check
[568.231966] Subtest query-regions-sanity-check: SUCCESS (0.013s)
[568.357506] [107/132] (456s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling)
[568.446532] Starting subtest: flip-64bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling
[568.450686] Subtest flip-64bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling: SKIP (0.000s)
[568.522242] [108/132] (456s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-mmap-gtt)
[568.630110] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-mmap-gtt
[568.634150] Subtest fbc-2p-scndscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[568.717890] [109/132] (456s left) i915_pm_freq_api (freq-reset)
[568.787472] Starting subtest: freq-reset
[568.789745] Starting dynamic subtest: gt0
[568.982334] Dynamic subtest gt0: SUCCESS (0.194s)
[568.993541] Starting dynamic subtest: gt1
[569.139996] Dynamic subtest gt1: SUCCESS (0.156s)
[569.142975] Subtest freq-reset: SUCCESS (0.351s)
[569.216383] [110/132] (455s left) perf_pmu (semaphore-wait)
[569.255162] Starting subtest: semaphore-wait
[569.257069] Starting dynamic subtest: rcs0
[569.765274] Dynamic subtest rcs0: SUCCESS (0.512s)
[569.778662] Starting dynamic subtest: bcs0
[570.279352] Dynamic subtest bcs0: SUCCESS (0.511s)
[570.292507] Starting dynamic subtest: vcs0
[570.793710] Dynamic subtest vcs0: SUCCESS (0.510s)
[570.804660] Starting dynamic subtest: vcs1
[571.309406] Dynamic subtest vcs1: SUCCESS (0.512s)
[571.321916] Starting dynamic subtest: vecs0
[571.824948] Dynamic subtest vecs0: SUCCESS (0.512s)
[571.837895] Starting dynamic subtest: ccs0
[572.340522] Dynamic subtest ccs0: SUCCESS (0.512s)
[572.343670] Subtest semaphore-wait: SUCCESS (3.089s)
[572.469384] [111/132] (452s left) syncobj_timeline (wait-all-delayed-signal)
[572.533203] Starting subtest: wait-all-delayed-signal
[572.637227] Subtest wait-all-delayed-signal: SUCCESS (0.103s)
[572.733885] [112/132] (452s left) gem_basic (multigpu-create-close)
[572.792802] Starting subtest: multigpu-create-close
[572.797358] Subtest multigpu-create-close: SKIP (0.000s)
[572.897464] [113/132] (452s left) kms_psr (fbc-psr2-suspend)
[572.991936] Starting subtest: fbc-psr2-suspend
[572.994221] Starting dynamic subtest: eDP-1
[572.998279] Dynamic subtest eDP-1: SKIP (0.000s)
[573.002308] Subtest fbc-psr2-suspend: SKIP (0.001s)
[573.068624] [114/132] (452s left) api_intel_allocator (fork-simple-once)
[573.125393] Starting subtest: fork-simple-once
[573.142435] Subtest fork-simple-once: SUCCESS (0.019s)
[573.262794] [115/132] (452s left) core_debugfs (read-all-entries)
[573.315576] Starting subtest: read-all-entries
[573.409220] Subtest read-all-entries: SUCCESS (0.094s)
[573.478793] [116/132] (451s left) gem_mmap_offset (partial-unmap)
[573.527471] Starting subtest: partial-unmap
[573.529698] Starting dynamic subtest: smem0
[574.013595] Dynamic subtest smem0: SUCCESS (0.489s)
[574.016043] Subtest partial-unmap: SUCCESS (0.489s)
[574.119058] [117/132] (451s left) kms_frontbuffer_tracking (fbc-1p-pri-indfb-multidraw)
[574.223820] Starting subtest: fbc-1p-pri-indfb-multidraw
[587.111064] Subtest fbc-1p-pri-indfb-multidraw: SUCCESS (12.888s)
[588.455112] [118/132] (437s left) kms_flip_scaled_crc (flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling)
[588.546113] Starting subtest: flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling
[588.550579] Subtest flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling: SKIP (0.000s)
[588.622652] [119/132] (436s left) gem_partial_pwrite_pread (reads-uncached)
[588.682552] Subtest reads-uncached: SKIP (0.000s)
[588.760960] [120/132] (436s left) kms_addfb_basic (unused-handle)
[588.820515] Starting subtest: unused-handle
[588.822841] Subtest unused-handle: SUCCESS (0.000s)
[588.950574] [121/132] (436s left) kms_plane_lowres (tiling-4)
[589.034954] Starting subtest: tiling-4
[589.037260] Starting dynamic subtest: pipe-A-eDP-1
[589.041797] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[589.338223] Starting dynamic subtest: pipe-B-eDP-1
[589.342904] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[589.352831] Starting dynamic subtest: pipe-C-eDP-1
[589.357500] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[589.367155] Starting dynamic subtest: pipe-D-eDP-1
[589.371582] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[589.376151] Subtest tiling-4: SKIP (0.296s)
[590.124732] [122/132] (435s left) kms_psr (psr-primary-page-flip)
[590.228921] Starting subtest: psr-primary-page-flip
[590.231246] Starting dynamic subtest: eDP-1
[591.988525] Dynamic subtest eDP-1: SUCCESS (1.758s)
[591.990460] Subtest psr-primary-page-flip: SUCCESS (1.759s)
[592.822483] [123/132] (432s left) gem_exec_reloc (basic-write-read-noreloc)
[592.889054] Subtest basic-write-read-noreloc: SKIP (0.000s)
[592.971972] [124/132] (432s left) gem_render_linear_blits (basic)
[593.036747] Starting subtest: basic
[593.055653] Subtest basic: SUCCESS (0.019s)
[593.155251] [125/132] (432s left) kms_lease (cursor-implicit-plane)
[593.249748] Starting subtest: cursor-implicit-plane
[593.252062] Starting dynamic subtest: pipe-A-eDP-1
[593.711633] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.461s)
[593.721538] Starting dynamic subtest: pipe-B-eDP-1
[594.801713] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.089s)
[594.814667] Starting dynamic subtest: pipe-C-eDP-1
[595.897228] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.092s)
[595.910345] Starting dynamic subtest: pipe-D-eDP-1
[596.994046] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.095s)
[596.996259] Subtest cursor-implicit-plane: SUCCESS (3.743s)
[597.816020] [126/132] (428s left) kms_cursor_legacy (flip-vs-cursor-legacy)
[597.936686] Starting subtest: flip-vs-cursor-legacy
[605.352042] Subtest flip-vs-cursor-legacy: SUCCESS (7.414s)
[606.223762] [127/132] (419s left) kms_fb_coherency (memset-crc)
[606.322563] Starting subtest: memset-crc
[606.324951] Starting dynamic subtest: mmap-offset-wc
[606.695450] Dynamic subtest mmap-offset-wc: SUCCESS (0.375s)
[606.992025] Starting dynamic subtest: mmap-offset-uc
[613.022358] Dynamic subtest mmap-offset-uc: SUCCESS (6.045s)
[613.312270] Subtest memset-crc: SUCCESS (6.991s)
[614.120640] [128/132] (411s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-onoff)
[614.222801] Starting subtest: psr-2p-scndscrn-spr-indfb-onoff
[614.226852] Subtest psr-2p-scndscrn-spr-indfb-onoff: SKIP (0.000s)
[614.317380] [129/132] (411s left) gem_wait (busy)
[614.388084] Starting subtest: busy
[614.390370] Starting dynamic subtest: all-engines
[616.081834] Dynamic subtest all-engines: SUCCESS (1.692s)
[616.095572] Starting dynamic subtest: rcs0
[616.622868] Dynamic subtest rcs0: SUCCESS (0.540s)
[616.635751] Starting dynamic subtest: bcs0
[617.162182] Dynamic subtest bcs0: SUCCESS (0.539s)
[617.173463] Starting dynamic subtest: vcs0
[619.027066] Dynamic subtest vcs0: SUCCESS (1.863s)
[619.039102] Starting dynamic subtest: vcs1
[621.073380] Dynamic subtest vcs1: SUCCESS (2.045s)
[621.085393] Starting dynamic subtest: vecs0
[623.058301] Dynamic subtest vecs0: SUCCESS (1.982s)
[623.071062] Starting dynamic subtest: ccs0
[623.600441] Dynamic subtest ccs0: SUCCESS (0.541s)
[623.602957] Subtest busy: SUCCESS (9.214s)
[623.797400] [130/132] (402s left) kms_psr2_sf (fbc-psr2-cursor-plane-move-continuous-exceed-sf)
[623.911414] Starting subtest: fbc-psr2-cursor-plane-move-continuous-exceed-sf
[623.913667] Starting dynamic subtest: pipe-A-eDP-1
[623.984889] Dynamic subtest pipe-A-eDP-1: SKIP (0.077s)
[623.997581] Starting dynamic subtest: pipe-B-eDP-1
[625.074248] Dynamic subtest pipe-B-eDP-1: SKIP (1.087s)
[625.078711] Subtest fbc-psr2-cursor-plane-move-continuous-exceed-sf: SKIP (1.167s)
[626.328145] [131/132] (399s left) kms_big_fb (x-tiled-8bpp-rotate-180)
[626.433369] Starting subtest: x-tiled-8bpp-rotate-180
[627.670219] Subtest x-tiled-8bpp-rotate-180: SUCCESS (1.237s)
[627.801795] [132/132] (398s left) kms_color_pipeline (plane-lut1d-lut1d)
[627.896057] Starting subtest: plane-lut1d-lut1d
[628.065522] Starting dynamic subtest: pipe-A-plane-0
[628.219948] Dynamic subtest pipe-A-plane-0: SUCCESS (0.155s)
[628.229316] Starting dynamic subtest: pipe-A-plane-1
[628.364475] Dynamic subtest pipe-A-plane-1: SUCCESS (0.143s)
[628.373996] Starting dynamic subtest: pipe-A-plane-2
[628.508847] Dynamic subtest pipe-A-plane-2: SUCCESS (0.144s)
[629.674790] Starting dynamic subtest: pipe-B-plane-0
[629.857021] Dynamic subtest pipe-B-plane-0: SUCCESS (0.189s)
[629.867219] Starting dynamic subtest: pipe-B-plane-1
[629.988752] Dynamic subtest pipe-B-plane-1: SUCCESS (0.132s)
[629.998569] Starting dynamic subtest: pipe-B-plane-2
[630.122434] Dynamic subtest pipe-B-plane-2: SUCCESS (0.133s)
[631.278523] Starting dynamic subtest: pipe-C-plane-0
[631.403298] Dynamic subtest pipe-C-plane-0: SUCCESS (0.133s)
[631.413670] Starting dynamic subtest: pipe-C-plane-1
[631.536358] Dynamic subtest pipe-C-plane-1: SUCCESS (0.133s)
[631.546737] Starting dynamic subtest: pipe-C-plane-2
[631.692594] Dynamic subtest pipe-C-plane-2: SUCCESS (0.155s)
[632.876995] Starting dynamic subtest: pipe-D-plane-0
[633.012795] Dynamic subtest pipe-D-plane-0: SUCCESS (0.144s)
[633.022615] Starting dynamic subtest: pipe-D-plane-1
[633.179553] Dynamic subtest pipe-D-plane-1: SUCCESS (0.166s)
[633.196847] Starting dynamic subtest: pipe-D-plane-2
[633.346190] Dynamic subtest pipe-D-plane-2: SUCCESS (0.165s)
[633.632208] Subtest plane-lut1d-lut1d: SUCCESS (5.737s)
[634.512421] Closing watchdogs
results: parsing output: 0/ for test: gem_softpin
results: parsing output: 1/ for test: kms_frontbuffer_tracking
results: parsing output: 2/ for test: prime_mmap
results: parsing output: 3/ for test: kms_hdmi_inject
results: parsing output: 4/ for test: gem_ctx_persistence
results: parsing output: 5/ for test: kms_cursor_legacy
results: parsing output: 6/ for test: perf
results: parsing output: 7/ for test: kms_big_fb
results: parsing output: 8/ for test: kms_getfb
results: parsing output: 9/ for test: gem_mmap
results: parsing output: 10/ for test: kms_frontbuffer_tracking
results: parsing output: 11/ for test: gem_ringfill
results: parsing output: 12/ for test: gem_exec_balancer
results: parsing output: 13/ for test: gem_ctx_engines
results: parsing output: 14/ for test: gem_exec_schedule
results: parsing output: 15/ for test: gem_exec_store
results: parsing output: 16/ for test: kms_ccs
results: parsing output: 17/ for test: syncobj_timeline
results: parsing output: 18/ for test: gem_pxp
results: parsing output: 19/ for test: kms_ccs
results: parsing output: 20/ for test: kms_psr
results: parsing output: 21/ for test: kms_chamelium_hpd
results: parsing output: 22/ for test: syncobj_basic
results: parsing output: 23/ for test: syncobj_wait
results: parsing output: 24/ for test: kms_fbcon_fbt
results: parsing output: 25/ for test: kms_cursor_crc
results: parsing output: 26/ for test: gem_exec_params
results: parsing output: 27/ for test: perf
results: parsing output: 28/ for test: kms_content_protection
results: parsing output: 29/ for test: perf
results: parsing output: 30/ for test: kms_chamelium_color
results: parsing output: 31/ for test: gem_exec_fence
results: parsing output: 32/ for test: gem_render_copy
results: parsing output: 33/ for test: gem_media_vme
results: parsing output: 34/ for test: perf
results: parsing output: 35/ for test: kms_cursor_crc
results: parsing output: 36/ for test: kms_psr
results: parsing output: 37/ for test: perf
results: parsing output: 38/ for test: gem_ctx_exec
results: parsing output: 39/ for test: kms_dirtyfb
results: parsing output: 40/ for test: gem_softpin
results: parsing output: 41/ for test: gen7_exec_parse
results: parsing output: 42/ for test: kms_frontbuffer_tracking
results: parsing output: 43/ for test: kms_cursor_legacy
results: parsing output: 44/ for test: kms_joiner
results: parsing output: 45/ for test: kms_frontbuffer_tracking
results: parsing output: 46/ for test: kms_atomic_interruptible
results: parsing output: 47/ for test: kms_addfb_basic
results: parsing output: 48/ for test: kms_psr2_sf
results: parsing output: 49/ for test: kms_plane
results: parsing output: 50/ for test: gem_exec_params
results: parsing output: 51/ for test: kms_frontbuffer_tracking
results: parsing output: 52/ for test: kms_frontbuffer_tracking
results: parsing output: 53/ for test: kms_ccs
results: parsing output: 54/ for test: i915_pm_rps
results: parsing output: 55/ for test: kms_pipe_crc_basic
results: parsing output: 56/ for test: kms_psr2_sf
results: parsing output: 57/ for test: kms_flip_scaled_crc
results: parsing output: 58/ for test: prime_vgem
results: parsing output: 59/ for test: kms_big_fb
results: parsing output: 60/ for test: drm_read
results: parsing output: 61/ for test: kms_big_fb
results: parsing output: 62/ for test: kms_addfb_basic
results: parsing output: 63/ for test: kms_frontbuffer_tracking
results: parsing output: 64/ for test: perf
results: parsing output: 65/ for test: syncobj_timeline
results: parsing output: 66/ for test: kms_flip
results: parsing output: 67/ for test: kms_psr
results: parsing output: 68/ for test: i915_drm_fdinfo
results: parsing output: 69/ for test: perf_pmu
results: parsing output: 70/ for test: syncobj_wait
results: parsing output: 71/ for test: kms_plane_scaling
results: parsing output: 72/ for test: kms_chamelium_audio
results: parsing output: 73/ for test: kms_big_fb
results: parsing output: 74/ for test: gem_ctx_shared
results: parsing output: 75/ for test: kms_ccs
results: parsing output: 76/ for test: sysfs_preempt_timeout
results: parsing output: 77/ for test: kms_pm_backlight
results: parsing output: 78/ for test: kms_frontbuffer_tracking
results: parsing output: 79/ for test: kms_flip
results: parsing output: 80/ for test: kms_frontbuffer_tracking
results: parsing output: 81/ for test: gem_mmap_wc
results: parsing output: 82/ for test: gem_exec_schedule
results: parsing output: 83/ for test: core_setmaster
results: parsing output: 84/ for test: prime_vgem
results: parsing output: 85/ for test: gem_exec_suspend
results: parsing output: 86/ for test: kms_atomic_transition
results: parsing output: 87/ for test: kms_sequence
results: parsing output: 88/ for test: kms_ccs
results: parsing output: 89/ for test: kms_frontbuffer_tracking
results: parsing output: 90/ for test: gem_lmem_swapping
results: parsing output: 91/ for test: gem_exec_capture
results: parsing output: 92/ for test: kms_frontbuffer_tracking
results: parsing output: 93/ for test: kms_fbcon_fbt
results: parsing output: 94/ for test: kms_frontbuffer_tracking
results: parsing output: 95/ for test: kms_big_fb
results: parsing output: 96/ for test: kms_flip
results: parsing output: 97/ for test: syncobj_timeline
results: parsing output: 98/ for test: kms_vblank
results: parsing output: 99/ for test: gem_pread
results: parsing output: 100/ for test: kms_flip
results: parsing output: 101/ for test: kms_plane
results: parsing output: 102/ for test: kms_cursor_edge_walk
results: parsing output: 103/ for test: syncobj_timeline
results: parsing output: 104/ for test: kms_frontbuffer_tracking
results: parsing output: 105/ for test: i915_query
results: parsing output: 106/ for test: kms_flip_scaled_crc
results: parsing output: 107/ for test: kms_frontbuffer_tracking
results: parsing output: 108/ for test: i915_pm_freq_api
results: parsing output: 109/ for test: perf_pmu
results: parsing output: 110/ for test: syncobj_timeline
results: parsing output: 111/ for test: gem_basic
results: parsing output: 112/ for test: kms_psr
results: parsing output: 113/ for test: api_intel_allocator
results: parsing output: 114/ for test: core_debugfs
results: parsing output: 115/ for test: gem_mmap_offset
results: parsing output: 116/ for test: kms_frontbuffer_tracking
results: parsing output: 117/ for test: kms_flip_scaled_crc
results: parsing output: 118/ for test: gem_partial_pwrite_pread
results: parsing output: 119/ for test: kms_addfb_basic
results: parsing output: 120/ for test: kms_plane_lowres
results: parsing output: 121/ for test: kms_psr
results: parsing output: 122/ for test: gem_exec_reloc
results: parsing output: 123/ for test: gem_render_linear_blits
results: parsing output: 124/ for test: kms_lease
results: parsing output: 125/ for test: kms_cursor_legacy
results: parsing output: 126/ for test: kms_fb_coherency
results: parsing output: 127/ for test: kms_frontbuffer_tracking
results: parsing output: 128/ for test: gem_wait
results: parsing output: 129/ for test: kms_psr2_sf
results: parsing output: 130/ for test: kms_big_fb
results: parsing output: 131/ for test: kms_color_pipeline
Done.