[60.230235] Initializing watchdogs
[60.230301]   /dev/watchdog0
[60.246838] [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.251902] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[60.254268] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[60.257243] [001/133] (960s left) gem_ctx_persistence (engines-cleanup)
[60.354119] Starting subtest: engines-cleanup
[60.356146] Starting dynamic subtest: rcs0
[60.410168] Dynamic subtest rcs0: SUCCESS (0.059s)
[60.419853] Starting dynamic subtest: bcs0
[60.481777] Dynamic subtest bcs0: SUCCESS (0.071s)
[60.488947] Starting dynamic subtest: vcs0
[60.526916] Dynamic subtest vcs0: SUCCESS (0.045s)
[60.535817] Starting dynamic subtest: vcs1
[60.568707] Dynamic subtest vcs1: SUCCESS (0.041s)
[60.578466] Starting dynamic subtest: vecs0
[60.613706] Dynamic subtest vecs0: SUCCESS (0.045s)
[60.621818] Starting dynamic subtest: ccs0
[60.635541] Dynamic subtest ccs0: SUCCESS (0.021s)
[60.639135] Subtest engines-cleanup: SUCCESS (0.286s)
[60.763559] [002/133] (960s left) kms_big_fb (x-tiled-8bpp-rotate-270)
[60.878732] Starting subtest: x-tiled-8bpp-rotate-270
[60.914690] Subtest x-tiled-8bpp-rotate-270: SKIP (0.036s)
[61.021195] [003/133] (959s left) kms_universal_plane (cursor-fb-leak)
[61.110065] Starting subtest: cursor-fb-leak
[61.112077] Starting dynamic subtest: pipe-A-eDP-1
[61.451948] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.344s)
[61.464266] Starting dynamic subtest: pipe-B-eDP-1
[62.807248] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.358s)
[62.816659] Starting dynamic subtest: pipe-C-eDP-1
[64.118947] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.315s)
[64.127364] Starting dynamic subtest: pipe-D-eDP-1
[65.463510] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.347s)
[65.465891] Subtest cursor-fb-leak: SUCCESS (4.371s)
[66.607870] [004/133] (954s left) gem_ctx_param (invalid-size-set)
[66.658688] Starting subtest: invalid-size-set
[66.661074] Subtest invalid-size-set: SUCCESS (0.001s)
[66.784672] [005/133] (954s left) kms_flip (flip-vs-suspend)
[66.905260] Starting subtest: flip-vs-suspend
[66.907110] Starting dynamic subtest: A-eDP1
[100.864640] Dynamic subtest A-eDP1: SUCCESS (4.582s)
[100.878333] Starting dynamic subtest: B-eDP1
[134.880146] Dynamic subtest B-eDP1: SUCCESS (4.208s)
[134.889351] Starting dynamic subtest: C-eDP1
[168.883190] Dynamic subtest C-eDP1: SUCCESS (4.176s)
[168.891956] Starting dynamic subtest: D-eDP1
[202.876845] Dynamic subtest D-eDP1: SUCCESS (4.196s)
[202.881895] Subtest flip-vs-suspend: SUCCESS (17.170s)
[210.066949] [006/133] (816s left) core_debugfs (read-all-entries)
[210.142115] Starting subtest: read-all-entries
[210.236979] Subtest read-all-entries: SUCCESS (0.099s)
[210.300175] [007/133] (816s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-pwrite)
[210.406048] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-pwrite
[210.414228] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[210.505016] [008/133] (816s left) gem_exec_fence (expired-history)
[210.942700] Starting subtest: expired-history
[218.357257] Subtest expired-history: SUCCESS (7.557s)
[219.070224] [FACT gem_exec_fence (expired-history)] new: kernel.kmod_is_loaded.vgem: true
[219.073054] [009/133] (808s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-0-hflip)
[219.184151] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-0-hflip
[220.186651] Subtest 4-tiled-max-hw-stride-32bpp-rotate-0-hflip: SUCCESS (1.013s)
[220.321891] [010/133] (806s left) gen9_exec_parse (batch-without-end)
[220.387010] Subtest batch-without-end: SKIP (0.000s)
[220.435840] [011/133] (806s left) gem_sync (basic-all)
[220.509135] Starting subtest: basic-all
[223.678860] Subtest basic-all: SUCCESS (3.198s)
[223.868865] [012/133] (803s left) gem_render_copy (x-tiled-to-vebox-yf-tiled)
[223.931439] Starting subtest: x-tiled-to-vebox-yf-tiled
[223.935513] Subtest x-tiled-to-vebox-yf-tiled: SKIP (0.000s)
[224.117268] [013/133] (803s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-180-async-flip)
[224.224250] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-180-async-flip
[224.228536] Subtest y-tiled-max-hw-stride-32bpp-rotate-180-async-flip: SKIP (0.000s)
[224.354259] [014/133] (802s left) perf (invalid-oa-format-id)
[224.478307] Starting subtest: invalid-oa-format-id
[224.488968] Subtest invalid-oa-format-id: SUCCESS (0.011s)
[224.540217] [015/133] (802s left) gem_softpin (evict-prime)
[224.596500] Starting subtest: evict-prime
[224.598920] Starting dynamic subtest: rcs0
[225.735717] Dynamic subtest rcs0: SUCCESS (1.143s)
[225.745292] Starting dynamic subtest: bcs0
[226.852599] Dynamic subtest bcs0: SUCCESS (1.122s)
[226.863232] Starting dynamic subtest: vcs0
[228.676038] Dynamic subtest vcs0: SUCCESS (1.827s)
[228.687995] Starting dynamic subtest: vcs1
[230.723912] Dynamic subtest vcs1: SUCCESS (2.052s)
[230.734913] Starting dynamic subtest: vecs0
[232.703060] Dynamic subtest vecs0: SUCCESS (1.982s)
[232.714527] Starting dynamic subtest: ccs0
[233.827713] Dynamic subtest ccs0: SUCCESS (1.126s)
[233.837882] Starting dynamic subtest: all
[235.710693] Dynamic subtest all: SUCCESS (1.886s)
[235.713738] Subtest evict-prime: SUCCESS (11.146s)
[235.792674] [016/133] (791s left) kms_plane (pixel-format-linear-modifier-source-clamping)
[235.887120] Starting subtest: pixel-format-linear-modifier-source-clamping
[235.913274] Starting dynamic subtest: pipe-A-plane-0
[239.546224] Dynamic subtest pipe-A-plane-0: SUCCESS (3.633s)
[239.555326] Starting dynamic subtest: pipe-A-plane-3
[241.248165] Dynamic subtest pipe-A-plane-3: SUCCESS (1.700s)
[242.370234] Starting dynamic subtest: pipe-B-plane-0
[246.006482] Dynamic subtest pipe-B-plane-0: SUCCESS (3.644s)
[246.016756] Starting dynamic subtest: pipe-B-plane-3
[247.705565] Dynamic subtest pipe-B-plane-3: SUCCESS (1.698s)
[248.013504] Subtest pixel-format-linear-modifier-source-clamping: SUCCESS (12.129s)
[248.848470] [017/133] (778s left) kms_pm_rpm (basic-rte)
[248.888734] Starting subtest: basic-rte
[252.263022] Subtest basic-rte: SUCCESS (3.376s)
[254.073097] [018/133] (773s left) kms_psr (psr2-cursor-mmap-gtt)
[254.172512] Starting subtest: psr2-cursor-mmap-gtt
[254.174911] Starting dynamic subtest: eDP-1
[255.847751] Dynamic subtest eDP-1: SUCCESS (1.675s)
[255.850097] Subtest psr2-cursor-mmap-gtt: SUCCESS (1.676s)
[256.737554] [019/133] (770s left) kms_frontbuffer_tracking (psr-rgb565-draw-mmap-cpu)
[256.839940] Starting subtest: psr-rgb565-draw-mmap-cpu
[263.632596] Subtest psr-rgb565-draw-mmap-cpu: SUCCESS (6.798s)
[263.745349] [020/133] (763s left) syncobj_timeline (etime-single-wait-all-for-submit-unsubmitted)
[263.804569] Starting subtest: etime-single-wait-all-for-submit-unsubmitted
[263.907231] Subtest etime-single-wait-all-for-submit-unsubmitted: SUCCESS (0.102s)
[263.984781] [021/133] (763s left) kms_vblank (ts-continuation-idle-hang)
[264.075499] Starting subtest: ts-continuation-idle-hang
[264.077867] Starting dynamic subtest: pipe-A-eDP-1
[290.557857] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.490s)
[290.573970] Starting dynamic subtest: pipe-D-eDP-1
[315.528502] Dynamic subtest pipe-D-eDP-1: SUCCESS (24.963s)
[315.530459] Subtest ts-continuation-idle-hang: SUCCESS (51.457s)
[316.353526] [022/133] (711s left) gem_eio (wait-1us)
[316.566862] Starting subtest: wait-1us
[316.870546] Subtest wait-1us: SUCCESS (0.303s)
[317.015125] [023/133] (710s left) kms_mmap_write_crc (main)
[317.118612] Starting subtest: main
[317.120919] Starting dynamic subtest: pipe-A-eDP-1
[320.643486] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.522s)
[320.645343] Subtest main: SUCCESS (3.523s)
[321.473583] [024/133] (706s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-render)
[321.591945] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-render
[325.993690] Subtest fbc-1p-primscrn-pri-shrfb-draw-render: SUCCESS (4.408s)
[327.175568] [025/133] (700s left) kms_pipe_b_c_ivb (from-pipe-c-to-b-with-3-lanes)
[327.241264] Subtest from-pipe-C-to-B-with-3-lanes: SKIP (0.000s)
[327.312178] [026/133] (700s left) kms_atomic (plane-primary-legacy)
[327.405519] Starting subtest: plane-primary-legacy
[327.407856] Starting dynamic subtest: pipe-A-eDP-1
[327.853651] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.449s)
[327.856027] Subtest plane-primary-legacy: SUCCESS (0.450s)
[328.701965] [027/133] (699s left) kms_addfb_basic (addfb25-y-tiled-legacy)
[328.801150] Starting subtest: addfb25-y-tiled-legacy
[328.803389] Subtest addfb25-y-tiled-legacy: SUCCESS (0.000s)
[328.906970] [028/133] (698s left) kms_ccs (bad-pixel-format-4-tiled-dg2-rc-ccs)
[328.994101] Starting subtest: bad-pixel-format-4-tiled-dg2-rc-ccs
[328.996252] Starting dynamic subtest: pipe-A-eDP-1
[329.017667] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[329.029031] Starting dynamic subtest: pipe-B-eDP-1
[329.049310] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[329.058266] Starting dynamic subtest: pipe-C-eDP-1
[329.078903] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[329.087469] Starting dynamic subtest: pipe-D-eDP-1
[329.108384] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[329.112282] Subtest bad-pixel-format-4-tiled-dg2-rc-ccs: SKIP (0.004s)
[331.259374] [029/133] (696s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-pwrite)
[331.361828] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-pwrite
[331.365973] Subtest fbc-2p-scndscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[331.463389] [030/133] (696s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-blt)
[331.554514] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-blt
[331.558781] Subtest fbc-2p-scndscrn-pri-indfb-draw-blt: SKIP (0.000s)
[331.638903] [031/133] (696s left) kms_psr (psr-sprite-plane-onoff)
[331.720932] Starting subtest: psr-sprite-plane-onoff
[331.723155] Starting dynamic subtest: eDP-1
[333.502147] Dynamic subtest eDP-1: SUCCESS (1.780s)
[333.504492] Subtest psr-sprite-plane-onoff: SUCCESS (1.781s)
[334.322544] [032/133] (693s left) kms_chamelium_hpd (dp-hpd-for-each-pipe)
[334.705143] Subtest dp-hpd-for-each-pipe: SKIP (0.000s)
[335.522602] [033/133] (692s left) gem_exec_schedule (preempt-user)
[335.586048] Starting subtest: preempt-user
[335.588286] Starting dynamic subtest: rcs0
[335.606007] Dynamic subtest rcs0: SUCCESS (0.027s)
[335.617008] Starting dynamic subtest: bcs0
[335.626169] Dynamic subtest bcs0: SUCCESS (0.020s)
[335.634992] Starting dynamic subtest: vcs0
[335.647728] Dynamic subtest vcs0: SUCCESS (0.021s)
[335.656454] Starting dynamic subtest: vcs1
[335.668891] Dynamic subtest vcs1: SUCCESS (0.021s)
[335.677796] Starting dynamic subtest: vecs0
[335.690420] Dynamic subtest vecs0: SUCCESS (0.021s)
[335.699288] Starting dynamic subtest: ccs0
[335.713970] Dynamic subtest ccs0: SUCCESS (0.023s)
[335.716235] Subtest preempt-user: SUCCESS (0.136s)
[336.780403] [034/133] (691s left) i915_hangman (engine-engine-hang)
[336.841196] Starting subtest: engine-engine-hang
[336.843062] Starting dynamic subtest: rcs0
[338.717243] Dynamic subtest rcs0: SUCCESS (1.877s)
[338.729773] Starting dynamic subtest: bcs0
[340.701236] Dynamic subtest bcs0: SUCCESS (1.981s)
[340.714749] Starting dynamic subtest: vcs0
[342.686174] Dynamic subtest vcs0: SUCCESS (1.982s)
[342.700193] Starting dynamic subtest: vcs1
[344.668749] Dynamic subtest vcs1: SUCCESS (1.980s)
[344.681222] Starting dynamic subtest: vecs0
[346.716977] Dynamic subtest vecs0: SUCCESS (2.045s)
[346.729148] Starting dynamic subtest: ccs0
[348.700734] Dynamic subtest ccs0: SUCCESS (1.982s)
[348.703355] Subtest engine-engine-hang: SUCCESS (11.863s)
[348.797539] [035/133] (679s left) i915_pm_rps (waitboost)
[348.857113] Starting subtest: waitboost
[354.954183] Subtest waitboost: SUCCESS (6.100s)
[355.078785] [036/133] (673s left) gem_mmap_offset (oob-read)
[355.135491] Starting subtest: oob-read
[355.137832] Subtest oob-read: SUCCESS (0.000s)
[355.220293] [037/133] (673s left) gem_ccs (block-copy-compressed)
[355.271171] Starting subtest: block-copy-compressed
[355.275738] Subtest block-copy-compressed: SKIP (0.000s)
[355.370010] [038/133] (672s left) gem_softpin (overlap)
[355.429748] Starting subtest: overlap
[356.364174] Subtest overlap: SUCCESS (0.933s)
[356.492624] [039/133] (671s left) perf_pmu (idle-no-semaphores)
[356.533571] Starting subtest: idle-no-semaphores
[356.535765] Starting dynamic subtest: rcs0
[357.080895] Dynamic subtest rcs0: SUCCESS (0.547s)
[357.092169] Starting dynamic subtest: bcs0
[357.596883] Dynamic subtest bcs0: SUCCESS (0.513s)
[357.609523] Starting dynamic subtest: vcs0
[358.126592] Dynamic subtest vcs0: SUCCESS (0.525s)
[358.138951] Starting dynamic subtest: vcs1
[358.642189] Dynamic subtest vcs1: SUCCESS (0.512s)
[358.653995] Starting dynamic subtest: vecs0
[359.157580] Dynamic subtest vecs0: SUCCESS (0.513s)
[359.170011] Starting dynamic subtest: ccs0
[359.672949] Dynamic subtest ccs0: SUCCESS (0.512s)
[359.675747] Subtest idle-no-semaphores: SUCCESS (3.142s)
[359.767786] [040/133] (668s left) kms_feature_discovery (display-1x)
[359.871972] Starting subtest: display-1x
[359.874261] Subtest display-1x: SUCCESS (0.000s)
[359.947344] [041/133] (668s left) kms_cursor_crc (cursor-rapid-movement-64x64)
[360.137573] Starting subtest: cursor-rapid-movement-64x64
[360.142055] Starting dynamic subtest: pipe-A-eDP-1
[360.688343] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.543s)
[360.717462] Starting dynamic subtest: pipe-D-eDP-1
[361.871239] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.162s)
[361.873657] Subtest cursor-rapid-movement-64x64: SUCCESS (1.733s)
[362.741284] [042/133] (665s left) i915_pm_rpm (system-suspend-execbuf)
[364.878521] Starting subtest: system-suspend-execbuf
[423.417274] Subtest system-suspend-execbuf: SUCCESS (43.326s)
[423.807305] [043/133] (604s left) gem_mmap_gtt (cpuset-medium-copy)
[423.869065] Subtest cpuset-medium-copy: SKIP (0.000s)
[423.934884] [044/133] (604s left) gem_pwrite_snooped
[424.074675] [045/133] (604s left) kms_plane_scaling (planes-downscale-factor-0-75-upscale-factor-0-25)
[424.163845] Starting subtest: planes-downscale-factor-0-75-upscale-factor-0-25
[424.165979] Starting dynamic subtest: pipe-A
[424.226982] Dynamic subtest pipe-A: SUCCESS (0.065s)
[424.236295] Starting dynamic subtest: pipe-B
[425.411547] Dynamic subtest pipe-B: SUCCESS (1.183s)
[425.423120] Starting dynamic subtest: pipe-C
[426.537706] Dynamic subtest pipe-C: SUCCESS (1.123s)
[426.553639] Starting dynamic subtest: pipe-D
[427.669448] Dynamic subtest pipe-D: SUCCESS (1.129s)
[427.671778] Subtest planes-downscale-factor-0-75-upscale-factor-0-25: SUCCESS (3.506s)
[428.851863] [046/133] (599s left) kms_psr2_su (page_flip-xrgb8888)
[428.920989] Subtest page_flip-XRGB8888: SKIP (0.000s)
[428.986664] [047/133] (599s left) kms_flip (basic-flip-vs-dpms)
[429.075244] Starting subtest: basic-flip-vs-dpms
[429.077487] Starting dynamic subtest: A-eDP1
[431.634787] Dynamic subtest A-eDP1: SUCCESS (2.560s)
[431.647821] Starting dynamic subtest: B-eDP1
[433.801612] Dynamic subtest B-eDP1: SUCCESS (2.161s)
[433.812002] Starting dynamic subtest: C-eDP1
[435.891814] Dynamic subtest C-eDP1: SUCCESS (2.090s)
[435.902099] Starting dynamic subtest: D-eDP1
[437.957047] Dynamic subtest D-eDP1: SUCCESS (2.063s)
[437.962521] Subtest basic-flip-vs-dpms: SUCCESS (8.887s)
[438.765380] [048/133] (589s left) gem_exec_balancer (invalid-balancer)
[438.824494] Starting subtest: invalid-balancer
[439.985205] Subtest invalid-balancer: SUCCESS (1.159s)
[440.293220] [049/133] (588s left) kms_setmode (basic-clone-single-crtc)
[440.340387] Starting subtest: basic-clone-single-crtc
[440.346683] Subtest basic-clone-single-crtc: SKIP (0.000s)
[440.436268] [050/133] (588s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-0)
[440.550643] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-0
[440.554982] Subtest yf-tiled-max-hw-stride-32bpp-rotate-0: SKIP (0.000s)
[440.648201] [051/133] (588s left) kms_flip (2x-flip-vs-absolute-wf_vblank-interruptible)
[440.741842] Starting subtest: 2x-flip-vs-absolute-wf_vblank-interruptible
[440.754211] Subtest 2x-flip-vs-absolute-wf_vblank-interruptible: SKIP (0.011s)
[440.832336] [052/133] (588s left) syncobj_timeline (invalid-multi-wait-unsubmitted-submitted-signaled)
[440.897670] Starting subtest: invalid-multi-wait-unsubmitted-submitted-signaled
[440.899932] Subtest invalid-multi-wait-unsubmitted-submitted-signaled: SUCCESS (0.001s)
[440.995741] [053/133] (587s left) kms_ccs (crc-primary-basic-4-tiled-dg2-rc-ccs-cc)
[441.092144] Starting subtest: crc-primary-basic-4-tiled-dg2-rc-ccs-cc
[441.094581] Starting dynamic subtest: pipe-A-eDP-1
[441.117774] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[441.130619] Starting dynamic subtest: pipe-B-eDP-1
[441.152265] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[441.161324] Starting dynamic subtest: pipe-C-eDP-1
[441.182891] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[441.191677] Starting dynamic subtest: pipe-D-eDP-1
[441.209582] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[441.213159] Subtest crc-primary-basic-4-tiled-dg2-rc-ccs-cc: SKIP (0.006s)
[443.331008] [054/133] (585s left) kms_content_protection (uevent)
[443.475070] Starting subtest: uevent
[443.479830] Subtest uevent: SKIP (0.000s)
[443.602138] [055/133] (585s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-blt)
[443.703574] Starting subtest: psr-1p-primscrn-pri-indfb-draw-blt
[451.078313] Subtest psr-1p-primscrn-pri-indfb-draw-blt: SUCCESS (7.379s)
[451.210728] [056/133] (577s left) kms_plane (plane-position-hole-dpms)
[451.311074] Starting subtest: plane-position-hole-dpms
[451.844450] Starting dynamic subtest: pipe-A-plane-1
[454.303989] Dynamic subtest pipe-A-plane-1: SUCCESS (2.457s)
[454.314121] Starting dynamic subtest: pipe-A-plane-2
[456.732120] Dynamic subtest pipe-A-plane-2: SUCCESS (2.431s)
[456.742556] Starting dynamic subtest: pipe-A-plane-3
[459.114548] Dynamic subtest pipe-A-plane-3: SUCCESS (2.380s)
[459.124842] Starting dynamic subtest: pipe-A-plane-4
[461.475294] Dynamic subtest pipe-A-plane-4: SUCCESS (2.360s)
[461.485373] Starting dynamic subtest: pipe-A-plane-5
[461.499298] Dynamic subtest pipe-A-plane-5: SUCCESS (0.023s)
[462.667466] Starting dynamic subtest: pipe-B-plane-1
[465.088740] Dynamic subtest pipe-B-plane-1: SUCCESS (2.430s)
[465.098760] Starting dynamic subtest: pipe-B-plane-2
[467.444725] Dynamic subtest pipe-B-plane-2: SUCCESS (2.355s)
[467.454867] Starting dynamic subtest: pipe-B-plane-3
[469.811599] Dynamic subtest pipe-B-plane-3: SUCCESS (2.367s)
[469.823798] Starting dynamic subtest: pipe-B-plane-4
[472.179977] Dynamic subtest pipe-B-plane-4: SUCCESS (2.370s)
[472.190681] Starting dynamic subtest: pipe-B-plane-5
[472.206731] Dynamic subtest pipe-B-plane-5: SUCCESS (0.024s)
[472.208995] Subtest plane-position-hole-dpms: SUCCESS (20.901s)
[472.982856] [057/133] (556s left) gem_mmap_gtt (big-copy)
[473.048969] Subtest big-copy: SKIP (0.000s)
[473.104363] [058/133] (556s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-cpu)
[473.210619] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-cpu
[473.215379] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[473.321349] [059/133] (555s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-mmap-gtt)
[473.432146] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-mmap-gtt
[473.436369] Subtest fbc-1p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[473.534556] [060/133] (555s left) kms_ccs (crc-primary-suspend-y-tiled-ccs)
[473.640870] Starting subtest: crc-primary-suspend-y-tiled-ccs
[473.642975] Starting dynamic subtest: pipe-A-eDP-1
[473.651517] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[473.661464] Starting dynamic subtest: pipe-B-eDP-1
[473.670437] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[473.680554] Starting dynamic subtest: pipe-C-eDP-1
[473.688813] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[473.697442] Starting dynamic subtest: pipe-D-eDP-1
[473.705546] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[473.709472] Subtest crc-primary-suspend-y-tiled-ccs: SKIP (0.005s)
[475.859674] [061/133] (553s left) kms_chamelium_audio (dp-audio-edid)
[476.260240] Subtest dp-audio-edid: SKIP (0.000s)
[477.072286] [062/133] (552s left) perf_pmu (interrupts)
[477.112141] Starting subtest: interrupts
[478.215218] Subtest interrupts: SUCCESS (1.102s)
[478.336944] [063/133] (551s left) syncobj_wait (single-wait-all-for-submit-signaled)
[478.397590] Starting subtest: single-wait-all-for-submit-signaled
[478.399871] Subtest single-wait-all-for-submit-signaled: SUCCESS (0.000s)
[478.499289] [064/133] (550s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-blt)
[478.589868] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-blt
[478.593749] Subtest fbc-2p-primscrn-spr-indfb-draw-blt: SKIP (0.000s)
[478.688611] [065/133] (550s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-16bpp-ytile-downscaling)
[478.783069] Starting subtest: flip-64bpp-ytile-to-16bpp-ytile-downscaling
[478.787262] Subtest flip-64bpp-ytile-to-16bpp-ytile-downscaling: SKIP (0.000s)
[478.863442] [066/133] (550s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-onoff)
[478.958005] Starting subtest: fbc-2p-scndscrn-cur-indfb-onoff
[478.961935] Subtest fbc-2p-scndscrn-cur-indfb-onoff: SKIP (0.000s)
[479.053934] [067/133] (550s left) gem_exec_schedule (fairslice)
[479.121944] Starting subtest: fairslice
[479.123828] Starting dynamic subtest: rcs0
[481.136124] Dynamic subtest rcs0: SUCCESS (2.017s)
[481.151789] Starting dynamic subtest: bcs0
[483.154970] Dynamic subtest bcs0: SUCCESS (2.018s)
[483.167399] Starting dynamic subtest: vcs0
[485.171139] Dynamic subtest vcs0: SUCCESS (2.017s)
[485.182123] Starting dynamic subtest: vcs1
[487.190751] Dynamic subtest vcs1: SUCCESS (2.018s)
[487.201526] Starting dynamic subtest: vecs0
[489.209130] Dynamic subtest vecs0: SUCCESS (2.015s)
[489.220357] Starting dynamic subtest: ccs0
[491.227532] Dynamic subtest ccs0: SUCCESS (2.019s)
[491.229593] Subtest fairslice: SUCCESS (12.109s)
[491.543720] [068/133] (538s left) gem_userptr_blits (vma-merge)
[491.639245] Starting subtest: vma-merge
[491.686331] Subtest vma-merge: SUCCESS (0.049s)
[491.815641] [069/133] (537s left) gem_workarounds (suspend-resume-fd)
[491.891393] Starting subtest: suspend-resume-fd
[508.843808] Subtest suspend-resume-fd: SUCCESS (1.582s)
[515.010551] [070/133] (520s left) kms_flip (absolute-wf_vblank-interruptible)
[515.126833] Starting subtest: absolute-wf_vblank-interruptible
[515.129153] Starting dynamic subtest: A-eDP1
[523.833070] Dynamic subtest A-eDP1: SUCCESS (8.870s)
[523.842908] Starting dynamic subtest: B-eDP1
[532.491460] Dynamic subtest B-eDP1: SUCCESS (8.719s)
[532.501981] Starting dynamic subtest: C-eDP1
[541.192565] Dynamic subtest C-eDP1: SUCCESS (8.723s)
[541.206495] Starting dynamic subtest: D-eDP1
[549.910236] Dynamic subtest D-eDP1: SUCCESS (8.722s)
[549.916249] Subtest absolute-wf_vblank-interruptible: SUCCESS (35.047s)
[551.137592] [071/133] (484s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-render)
[551.240483] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-render
[551.244759] Subtest psr-2p-scndscrn-cur-indfb-draw-render: SKIP (0.000s)
[551.348552] [072/133] (484s left) kms_flip (2x-plain-flip)
[551.440048] Starting subtest: 2x-plain-flip
[551.448826] Subtest 2x-plain-flip: SKIP (0.011s)
[551.562346] [073/133] (484s left) gem_workarounds (reset)
[551.641024] Starting subtest: reset
[551.802438] Subtest reset: SUCCESS (0.163s)
[551.954373] [074/133] (483s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-pwrite)
[552.054741] Starting subtest: fbcpsr-rgb565-draw-pwrite
[559.063943] Subtest fbcpsr-rgb565-draw-pwrite: SUCCESS (7.011s)
[559.191370] [075/133] (476s left) prime_mmap (test_reprime)
[559.261278] Starting subtest: test_reprime
[559.263511] Starting dynamic subtest: test_reprime-smem
[559.292525] Dynamic subtest test_reprime-smem: SUCCESS (0.032s)
[559.295147] Subtest test_reprime: SUCCESS (0.033s)
[559.394986] [076/133] (476s left) gem_exec_reloc (basic-gtt-cpu)
[559.456479] Subtest basic-gtt-cpu: SKIP (0.000s)
[559.534992] [077/133] (476s left) sw_sync (sync_busy_fork_unixsocket)
[559.576959] Starting subtest: sync_busy_fork_unixsocket
[559.584344] Subtest sync_busy_fork_unixsocket: SUCCESS (0.008s)
[559.648441] [078/133] (476s left) gem_exec_whisper (basic-sync-all)
[559.719011] Starting subtest: basic-sync-all
[567.373769] Subtest basic-sync-all: SUCCESS (7.653s)
[567.562409] [079/133] (468s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-indfb-draw-render)
[567.675216] Starting subtest: psr-1p-offscreen-pri-indfb-draw-render
[574.605831] Subtest psr-1p-offscreen-pri-indfb-draw-render: SUCCESS (6.933s)
[574.756305] [080/133] (461s left) gem_exec_fence (syncobj-backward-timeline-chain-engines)
[575.357028] Starting subtest: syncobj-backward-timeline-chain-engines
[575.494367] Subtest syncobj-backward-timeline-chain-engines: SUCCESS (0.137s)
[576.608266] [081/133] (459s left) kms_setmode (invalid-clone-single-crtc)
[576.665397] Starting subtest: invalid-clone-single-crtc
[576.672227] Subtest invalid-clone-single-crtc: SKIP (0.000s)
[576.778863] [082/133] (459s left) api_intel_allocator (two-level-inception-interruptible)
[576.840359] Starting subtest: two-level-inception-interruptible
[582.247580] Subtest two-level-inception-interruptible: SUCCESS (5.408s)
[582.388927] [083/133] (453s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-gtt)
[582.498498] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-gtt
[582.503003] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[582.626546] [084/133] (453s left) kms_psr2_sf (fbc-pr-plane-move-sf-dmg-area)
[582.741301] Starting subtest: fbc-pr-plane-move-sf-dmg-area
[582.745388] Subtest fbc-pr-plane-move-sf-dmg-area: SKIP (0.000s)
[582.818188] [085/133] (453s left) gem_pxp (create-protected-buffer)
[582.951217] Starting subtest: create-protected-buffer
[582.953560] Subtest create-protected-buffer: SUCCESS (0.000s)
[583.085439] [086/133] (453s left) kms_big_fb (x-tiled-addfb-size-overflow)
[583.215705] Starting subtest: x-tiled-addfb-size-overflow
[583.218150] Subtest x-tiled-addfb-size-overflow: SUCCESS (0.000s)
[583.348188] [087/133] (453s left) kms_plane (pixel-format-4-tiled-dg2-mc-ccs-modifier)
[583.454470] Starting subtest: pixel-format-4-tiled-dg2-mc-ccs-modifier
[583.457911] Subtest pixel-format-4-tiled-dg2-mc-ccs-modifier: SKIP (0.000s)
[583.534519] [088/133] (453s left) kms_force_connector_basic (force-edid)
[583.619301] Starting subtest: force-edid
[583.988117] Subtest force-edid: SUCCESS (0.371s)
[584.136148] [089/133] (452s left) gem_userptr_blits (readonly-unsync)
[584.216303] Subtest readonly-unsync: SKIP (0.000s)
[584.348985] [090/133] (452s left) kms_color (ctm-0-50)
[584.449202] Starting subtest: ctm-0-50
[584.450856] Starting dynamic subtest: pipe-A-eDP-1
[587.930619] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.479s)
[587.941626] Starting dynamic subtest: pipe-B-eDP-1
[592.171143] Dynamic subtest pipe-B-eDP-1: SUCCESS (4.244s)
[592.183497] Starting dynamic subtest: pipe-C-eDP-1
[596.290263] Dynamic subtest pipe-C-eDP-1: SUCCESS (4.120s)
[596.300979] Starting dynamic subtest: pipe-D-eDP-1
[600.305961] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.015s)
[600.308311] Subtest ctm-0-50: SUCCESS (15.862s)
[601.107079] [091/133] (435s left) gem_ctx_persistence (legacy-engines-cleanup)
[601.162921] Starting subtest: legacy-engines-cleanup
[601.165120] Starting dynamic subtest: render
[601.225509] Dynamic subtest render: SUCCESS (0.062s)
[601.238748] Starting dynamic subtest: bsd1
[601.282649] Dynamic subtest bsd1: SUCCESS (0.054s)
[601.294865] Starting dynamic subtest: bsd2
[601.301341] Dynamic subtest bsd2: SUCCESS (0.016s)
[601.310958] Starting dynamic subtest: blt
[601.356239] Dynamic subtest blt: SUCCESS (0.054s)
[601.366382] Starting dynamic subtest: vebox
[601.430446] Dynamic subtest vebox: SUCCESS (0.072s)
[601.433005] Subtest legacy-engines-cleanup: SUCCESS (0.269s)
[601.511972] [092/133] (435s left) gem_exec_reloc (basic-write-gtt-noreloc)
[601.579269] Subtest basic-write-gtt-noreloc: SKIP (0.000s)
[601.650949] [093/133] (435s left) gem_render_copy (yf-tiled-ccs-to-y-tiled-ccs)
[601.712147] Starting subtest: yf-tiled-ccs-to-y-tiled-ccs
[601.716285] Subtest yf-tiled-ccs-to-y-tiled-ccs: SKIP (0.000s)
[601.898050] [094/133] (434s left) i915_drm_fdinfo (virtual-busy-all)
[601.943769] Starting subtest: virtual-busy-all
[601.948145] Subtest virtual-busy-all: SKIP (0.000s)
[602.017949] [095/133] (434s left) syncobj_timeline (etime-multi-wait-all-available-unsubmitted-signaled)
[602.073154] Starting subtest: etime-multi-wait-all-available-unsubmitted-signaled
[602.176921] Subtest etime-multi-wait-all-available-unsubmitted-signaled: SUCCESS (0.101s)
[602.254419] [096/133] (434s left) gem_eio (create-ext)
[602.486395] Starting subtest: create-ext
[602.851320] Subtest create-ext: SUCCESS (0.365s)
[602.995702] [097/133] (433s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-render)
[603.095826] Starting subtest: psr-2p-primscrn-spr-indfb-draw-render
[603.099809] Subtest psr-2p-primscrn-spr-indfb-draw-render: SKIP (0.000s)
[603.210710] [098/133] (433s left) kms_cursor_crc (cursor-alpha-transparent)
[603.303100] Starting subtest: cursor-alpha-transparent
[603.304945] Starting dynamic subtest: pipe-A-eDP-1
[603.926592] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.622s)
[603.936417] Starting dynamic subtest: pipe-D-eDP-1
[605.222672] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.297s)
[605.225026] Subtest cursor-alpha-transparent: SUCCESS (1.922s)
[606.098661] [099/133] (430s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-pwrite)
[606.201421] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-pwrite
[613.050053] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-pwrite: SUCCESS (6.853s)
[613.188987] [100/133] (423s left) kms_vrr (seamless-rr-switch-drrs)
[613.277972] Starting subtest: seamless-rr-switch-drrs
[613.284240] Subtest seamless-rr-switch-drrs: SKIP (0.000s)
[613.353707] [101/133] (423s left) kms_chamelium_edid (dp-edid-stress-resolution-4k)
[613.732028] Subtest dp-edid-stress-resolution-4k: SKIP (0.000s)
[614.567234] [102/133] (422s left) kms_lease (master-vs-lease)
[614.666917] Starting subtest: master-vs-lease
[614.669060] Subtest master-vs-lease: SUCCESS (0.002s)
[614.775823] [103/133] (422s left) kms_getfb (getfb-addfb-different-handles)
[614.865719] Starting subtest: getfb-addfb-different-handles
[614.867910] Subtest getfb-addfb-different-handles: SUCCESS (0.000s)
[614.961439] [104/133] (422s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-pwrite)
[615.057949] Starting subtest: psr-2p-primscrn-cur-indfb-draw-pwrite
[615.061893] Subtest psr-2p-primscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[615.156322] [105/133] (422s left) kms_joiner (invalid-modeset-force-big-joiner)
[615.255622] Starting subtest: invalid-modeset-force-big-joiner
[615.260038] Subtest invalid-modeset-force-big-joiner: SKIP (0.000s)
[615.337017] [106/133] (421s left) gem_exec_store (pages)
[615.402365] Starting subtest: pages
[615.404558] Starting dynamic subtest: rcs0
[615.496832] Dynamic subtest rcs0: SUCCESS (0.096s)
[615.509914] Starting dynamic subtest: bcs0
[615.575916] Dynamic subtest bcs0: SUCCESS (0.078s)
[615.587716] Starting dynamic subtest: vcs0
[615.644367] Dynamic subtest vcs0: SUCCESS (0.067s)
[615.653448] Starting dynamic subtest: vcs1
[615.716169] Dynamic subtest vcs1: SUCCESS (0.071s)
[615.725308] Starting dynamic subtest: vecs0
[615.782399] Dynamic subtest vecs0: SUCCESS (0.065s)
[615.791446] Starting dynamic subtest: ccs0
[615.851702] Dynamic subtest ccs0: SUCCESS (0.068s)
[615.853754] Subtest pages: SUCCESS (0.453s)
[616.036650] [107/133] (421s left) kms_flip_scaled_crc (flip-32bpp-ytileccs-to-64bpp-ytile-upscaling)
[616.130238] Starting subtest: flip-32bpp-ytileccs-to-64bpp-ytile-upscaling
[616.134399] Subtest flip-32bpp-ytileccs-to-64bpp-ytile-upscaling: SKIP (0.000s)
[616.244232] [108/133] (421s left) kms_psr (fbc-psr-sprite-plane-move)
[616.338979] Starting subtest: fbc-psr-sprite-plane-move
[616.341132] Starting dynamic subtest: eDP-1
[616.345075] Dynamic subtest eDP-1: SKIP (0.000s)
[616.349059] Subtest fbc-psr-sprite-plane-move: SKIP (0.001s)
[616.415708] [109/133] (421s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-180-hflip)
[616.514258] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-180-hflip
[617.527645] Subtest 4-tiled-max-hw-stride-64bpp-rotate-180-hflip: SUCCESS (1.013s)
[617.641879] [110/133] (419s left) syncobj_wait (wait-zero-handles)
[617.692846] Starting subtest: wait-zero-handles
[617.695112] Subtest wait-zero-handles: SUCCESS (0.000s)
[617.780539] [111/133] (419s left) kms_cursor_legacy (cursor-vs-flip-toggle)
[617.899161] Starting subtest: cursor-vs-flip-toggle
[649.151796] Subtest cursor-vs-flip-toggle: SUCCESS (31.246s)
[649.998172] [112/133] (387s left) gem_ctx_engines (execute-one)
[650.065347] Starting subtest: execute-one
[652.991993] Subtest execute-one: SUCCESS (2.927s)
[653.182559] [113/133] (384s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-shrfb-pgflip-blt)
[653.287440] Starting subtest: fbcpsr-1p-primscrn-shrfb-pgflip-blt
[660.526043] Subtest fbcpsr-1p-primscrn-shrfb-pgflip-blt: SUCCESS (7.242s)
[660.651964] [114/133] (377s left) dmabuf_sync_file (export-before-signal)
[660.702846] Starting subtest: export-before-signal
[660.705121] Subtest export-before-signal: SUCCESS (0.001s)
[660.768188] [115/133] (377s left) kms_cursor_edge_walk (256x256-top-bottom)
[660.862772] Starting subtest: 256x256-top-bottom
[660.864899] Starting dynamic subtest: pipe-A-eDP-1
[664.325875] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.463s)
[664.336052] Starting dynamic subtest: pipe-D-eDP-1
[667.502806] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.174s)
[667.504786] Subtest 256x256-top-bottom: SUCCESS (6.640s)
[668.389789] [116/133] (369s left) kms_psr2_sf (pr-plane-move-sf-dmg-area)
[668.481542] Starting subtest: pr-plane-move-sf-dmg-area
[668.485909] Subtest pr-plane-move-sf-dmg-area: SKIP (0.000s)
[668.552009] [117/133] (369s left) syncobj_timeline (single-wait-for-submit-signaled)
[668.620732] Starting subtest: single-wait-for-submit-signaled
[668.623057] Subtest single-wait-for-submit-signaled: SUCCESS (0.000s)
[668.724052] [118/133] (369s left) gem_workarounds (basic-read-context)
[668.782351] Starting subtest: basic-read-context
[668.794779] Subtest basic-read-context: SUCCESS (0.012s)
[668.936751] [119/133] (369s left) kms_psr (pr-cursor-mmap-cpu)
[669.039115] Starting subtest: pr-cursor-mmap-cpu
[669.043512] Subtest pr-cursor-mmap-cpu: SKIP (0.000s)
[669.113517] [120/133] (368s left) kms_psr (fbc-psr2-basic)
[669.206927] Starting subtest: fbc-psr2-basic
[669.209107] Starting dynamic subtest: eDP-1
[669.213076] Dynamic subtest eDP-1: SKIP (0.000s)
[669.217075] Subtest fbc-psr2-basic: SKIP (0.001s)
[669.293815] [121/133] (368s left) kms_ccs (crc-sprite-planes-basic-4-tiled-mtl-rc-ccs-cc)
[669.389465] Starting subtest: crc-sprite-planes-basic-4-tiled-mtl-rc-ccs-cc
[669.391397] Starting dynamic subtest: pipe-A-eDP-1
[669.883598] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.471s)
[669.894610] Starting dynamic subtest: pipe-B-eDP-1
[671.344124] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.453s)
[671.356675] Starting dynamic subtest: pipe-C-eDP-1
[672.742812] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.396s)
[672.752635] Starting dynamic subtest: pipe-D-eDP-1
[674.143691] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.403s)
[674.145623] Subtest crc-sprite-planes-basic-4-tiled-mtl-rc-ccs-cc: SUCCESS (4.729s)
[675.284215] [122/133] (362s left) gem_ctx_param (non-root-set)
[675.332889] Starting subtest: non-root-set
[675.356280] Subtest non-root-set: SUCCESS (0.024s)
[675.455423] [123/133] (362s left) gem_pread (display)
[675.529112] Subtest display: SKIP (0.000s)
[675.591115] [124/133] (362s left) gem_exec_schedule (preempt-other-chain)
[675.661244] Starting subtest: preempt-other-chain
[675.663425] Starting dynamic subtest: rcs0
[675.739059] Dynamic subtest rcs0: SUCCESS (0.085s)
[675.753558] Starting dynamic subtest: bcs0
[675.824746] Dynamic subtest bcs0: SUCCESS (0.085s)
[675.835108] Starting dynamic subtest: vcs0
[675.912183] Dynamic subtest vcs0: SUCCESS (0.087s)
[675.923282] Starting dynamic subtest: vcs1
[676.000413] Dynamic subtest vcs1: SUCCESS (0.087s)
[676.015654] Starting dynamic subtest: vecs0
[676.079785] Dynamic subtest vecs0: SUCCESS (0.079s)
[676.095436] Starting dynamic subtest: ccs0
[676.161050] Dynamic subtest ccs0: SUCCESS (0.081s)
[676.164052] Subtest preempt-other-chain: SUCCESS (0.508s)
[677.657406] [125/133] (360s left) prime_busy (hang)
[677.717264] Starting subtest: hang
[677.719482] Starting dynamic subtest: rcs0
[704.087875] Dynamic subtest rcs0: SUCCESS (26.371s)
[704.099473] Starting dynamic subtest: bcs0
[711.240332] Dynamic subtest bcs0: SUCCESS (7.156s)
[711.252787] Starting dynamic subtest: vcs0
[718.222032] Dynamic subtest vcs0: SUCCESS (6.978s)
[718.233652] Starting dynamic subtest: vcs1
[725.256100] Dynamic subtest vcs1: SUCCESS (7.035s)
[725.272438] Starting dynamic subtest: vecs0
[732.224064] Dynamic subtest vecs0: SUCCESS (6.973s)
[732.236585] Starting dynamic subtest: ccs0
[746.072569] Dynamic subtest ccs0: SUCCESS (13.845s)
[746.075052] Subtest hang: SUCCESS (68.365s)
[746.203060] [126/133] (292s left) kms_pm_rpm (system-suspend-modeset)
[747.774043] Starting subtest: system-suspend-modeset
[768.393296] Subtest system-suspend-modeset: SUCCESS (5.030s)
[771.778359] [127/133] (269s left) kms_properties (invalid-properties-legacy)
[771.882970] Starting subtest: invalid-properties-legacy
[771.988312] Subtest invalid-properties-legacy: SUCCESS (0.105s)
[772.062904] [128/133] (269s left) gem_fence_thrash (bo-write-verify-y)
[772.116263] Starting subtest: bo-write-verify-y
[772.139383] Subtest bo-write-verify-y: SKIP (0.022s)
[772.205407] [129/133] (269s left) syncobj_timeline (multi-wait-for-submit-available-unsubmitted-submitted)
[772.261502] Starting subtest: multi-wait-for-submit-available-unsubmitted-submitted
[772.263731] Subtest multi-wait-for-submit-available-unsubmitted-submitted: SUCCESS (0.000s)
[772.369548] [130/133] (269s left) kms_cursor_legacy (single-bo)
[772.476585] Starting subtest: single-bo
[772.478882] Starting dynamic subtest: pipe-A
[777.877644] Dynamic subtest pipe-A: SUCCESS (5.380s)
[777.889309] Starting dynamic subtest: pipe-B
[783.269334] Dynamic subtest pipe-B: SUCCESS (5.380s)
[783.281337] Starting dynamic subtest: pipe-C
[788.657510] Dynamic subtest pipe-C: SUCCESS (5.380s)
[788.669125] Starting dynamic subtest: pipe-D
[794.043900] Dynamic subtest pipe-D: SUCCESS (5.380s)
[794.055436] Starting dynamic subtest: all-pipes
[799.434452] Dynamic subtest all-pipes: SUCCESS (5.386s)
[799.436715] Subtest single-bo: SUCCESS (26.919s)
[799.592308] [131/133] (241s left) gem_exec_params (invalid-bsd1-flag-on-blt)
[799.672502] Starting subtest: invalid-bsd1-flag-on-blt
[799.674977] Subtest invalid-bsd1-flag-on-blt: SUCCESS (0.000s)
[799.794090] [132/133] (241s left) gem_close_race (basic-threads)
[799.865244] Starting subtest: basic-threads
[801.193503] Subtest basic-threads: SUCCESS (1.330s)
[801.398651] [133/133] (240s left) kms_big_fb (y-tiled-32bpp-rotate-0)
[801.509606] Starting subtest: y-tiled-32bpp-rotate-0
[801.513161] Subtest y-tiled-32bpp-rotate-0: SKIP (0.000s)
[801.624123] Closing watchdogs
results: parsing output: 0/ for test: gem_ctx_persistence
results: parsing output: 1/ for test: kms_big_fb
results: parsing output: 2/ for test: kms_universal_plane
results: parsing output: 3/ for test: gem_ctx_param
results: parsing output: 4/ for test: kms_flip
results: parsing output: 5/ for test: core_debugfs
results: parsing output: 6/ for test: kms_frontbuffer_tracking
results: parsing output: 7/ for test: gem_exec_fence
results: parsing output: 8/ for test: kms_big_fb
results: parsing output: 9/ for test: gen9_exec_parse
results: parsing output: 10/ for test: gem_sync
results: parsing output: 11/ for test: gem_render_copy
results: parsing output: 12/ for test: kms_big_fb
results: parsing output: 13/ for test: perf
results: parsing output: 14/ for test: gem_softpin
results: parsing output: 15/ for test: kms_plane
results: parsing output: 16/ for test: kms_pm_rpm
results: parsing output: 17/ for test: kms_psr
results: parsing output: 18/ for test: kms_frontbuffer_tracking
results: parsing output: 19/ for test: syncobj_timeline
results: parsing output: 20/ for test: kms_vblank
results: parsing output: 21/ for test: gem_eio
results: parsing output: 22/ for test: kms_mmap_write_crc
results: parsing output: 23/ for test: kms_frontbuffer_tracking
results: parsing output: 24/ for test: kms_pipe_b_c_ivb
results: parsing output: 25/ for test: kms_atomic
results: parsing output: 26/ for test: kms_addfb_basic
results: parsing output: 27/ for test: kms_ccs
results: parsing output: 28/ for test: kms_frontbuffer_tracking
results: parsing output: 29/ for test: kms_frontbuffer_tracking
results: parsing output: 30/ for test: kms_psr
results: parsing output: 31/ for test: kms_chamelium_hpd
results: parsing output: 32/ for test: gem_exec_schedule
results: parsing output: 33/ for test: i915_hangman
results: parsing output: 34/ for test: i915_pm_rps
results: parsing output: 35/ for test: gem_mmap_offset
results: parsing output: 36/ for test: gem_ccs
results: parsing output: 37/ for test: gem_softpin
results: parsing output: 38/ for test: perf_pmu
results: parsing output: 39/ for test: kms_feature_discovery
results: parsing output: 40/ for test: kms_cursor_crc
results: parsing output: 41/ for test: i915_pm_rpm
results: parsing output: 42/ for test: gem_mmap_gtt
results: parsing output: 43/ for test: gem_pwrite_snooped
results: parsing output: 44/ for test: kms_plane_scaling
results: parsing output: 45/ for test: kms_psr2_su
results: parsing output: 46/ for test: kms_flip
results: parsing output: 47/ for test: gem_exec_balancer
results: parsing output: 48/ for test: kms_setmode
results: parsing output: 49/ for test: kms_big_fb
results: parsing output: 50/ for test: kms_flip
results: parsing output: 51/ for test: syncobj_timeline
results: parsing output: 52/ for test: kms_ccs
results: parsing output: 53/ for test: kms_content_protection
results: parsing output: 54/ for test: kms_frontbuffer_tracking
results: parsing output: 55/ for test: kms_plane
results: parsing output: 56/ for test: gem_mmap_gtt
results: parsing output: 57/ for test: kms_frontbuffer_tracking
results: parsing output: 58/ for test: kms_frontbuffer_tracking
results: parsing output: 59/ for test: kms_ccs
results: parsing output: 60/ for test: kms_chamelium_audio
results: parsing output: 61/ for test: perf_pmu
results: parsing output: 62/ for test: syncobj_wait
results: parsing output: 63/ for test: kms_frontbuffer_tracking
results: parsing output: 64/ for test: kms_flip_scaled_crc
results: parsing output: 65/ for test: kms_frontbuffer_tracking
results: parsing output: 66/ for test: gem_exec_schedule
results: parsing output: 67/ for test: gem_userptr_blits
results: parsing output: 68/ for test: gem_workarounds
results: parsing output: 69/ for test: kms_flip
results: parsing output: 70/ for test: kms_frontbuffer_tracking
results: parsing output: 71/ for test: kms_flip
results: parsing output: 72/ for test: gem_workarounds
results: parsing output: 73/ for test: kms_frontbuffer_tracking
results: parsing output: 74/ for test: prime_mmap
results: parsing output: 75/ for test: gem_exec_reloc
results: parsing output: 76/ for test: sw_sync
results: parsing output: 77/ for test: gem_exec_whisper
results: parsing output: 78/ for test: kms_frontbuffer_tracking
results: parsing output: 79/ for test: gem_exec_fence
results: parsing output: 80/ for test: kms_setmode
results: parsing output: 81/ for test: api_intel_allocator
results: parsing output: 82/ for test: kms_frontbuffer_tracking
results: parsing output: 83/ for test: kms_psr2_sf
results: parsing output: 84/ for test: gem_pxp
results: parsing output: 85/ for test: kms_big_fb
results: parsing output: 86/ for test: kms_plane
results: parsing output: 87/ for test: kms_force_connector_basic
results: parsing output: 88/ for test: gem_userptr_blits
results: parsing output: 89/ for test: kms_color
results: parsing output: 90/ for test: gem_ctx_persistence
results: parsing output: 91/ for test: gem_exec_reloc
results: parsing output: 92/ for test: gem_render_copy
results: parsing output: 93/ for test: i915_drm_fdinfo
results: parsing output: 94/ for test: syncobj_timeline
results: parsing output: 95/ for test: gem_eio
results: parsing output: 96/ for test: kms_frontbuffer_tracking
results: parsing output: 97/ for test: kms_cursor_crc
results: parsing output: 98/ for test: kms_frontbuffer_tracking
results: parsing output: 99/ for test: kms_vrr
results: parsing output: 100/ for test: kms_chamelium_edid
results: parsing output: 101/ for test: kms_lease
results: parsing output: 102/ for test: kms_getfb
results: parsing output: 103/ for test: kms_frontbuffer_tracking
results: parsing output: 104/ for test: kms_joiner
results: parsing output: 105/ for test: gem_exec_store
results: parsing output: 106/ for test: kms_flip_scaled_crc
results: parsing output: 107/ for test: kms_psr
results: parsing output: 108/ for test: kms_big_fb
results: parsing output: 109/ for test: syncobj_wait
results: parsing output: 110/ for test: kms_cursor_legacy
results: parsing output: 111/ for test: gem_ctx_engines
results: parsing output: 112/ for test: kms_frontbuffer_tracking
results: parsing output: 113/ for test: dmabuf_sync_file
results: parsing output: 114/ for test: kms_cursor_edge_walk
results: parsing output: 115/ for test: kms_psr2_sf
results: parsing output: 116/ for test: syncobj_timeline
results: parsing output: 117/ for test: gem_workarounds
results: parsing output: 118/ for test: kms_psr
results: parsing output: 119/ for test: kms_psr
results: parsing output: 120/ for test: kms_ccs
results: parsing output: 121/ for test: gem_ctx_param
results: parsing output: 122/ for test: gem_pread
results: parsing output: 123/ for test: gem_exec_schedule
results: parsing output: 124/ for test: prime_busy
results: parsing output: 125/ for test: kms_pm_rpm
results: parsing output: 126/ for test: kms_properties
results: parsing output: 127/ for test: gem_fence_thrash
results: parsing output: 128/ for test: syncobj_timeline
results: parsing output: 129/ for test: kms_cursor_legacy
results: parsing output: 130/ for test: gem_exec_params
results: parsing output: 131/ for test: gem_close_race
results: parsing output: 132/ for test: kms_big_fb
Done.