[59.499973] Initializing watchdogs
[59.500028]   /dev/watchdog0
[59.513599] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:7d55 Intel Meteorlake (Gen12) Meteor Lake-P [Intel Arc Graphics]
[59.517880] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[59.519988] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[59.523194] [001/131] (960s left) kms_async_flips (async-flip-dpms)
[59.641824] Starting subtest: async-flip-dpms
[60.021489] Starting dynamic subtest: pipe-A-eDP-1
[63.846192] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.804s)
[64.224060] Starting dynamic subtest: pipe-B-eDP-1
[67.104546] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.877s)
[67.507038] Starting dynamic subtest: pipe-C-eDP-1
[70.291818] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.784s)
[70.670272] Starting dynamic subtest: pipe-D-eDP-1
[73.452873] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.785s)
[73.455262] Subtest async-flip-dpms: SUCCESS (13.770s)
[74.659772] [002/131] (945s left) kms_big_fb (y-tiled-8bpp-rotate-180)
[74.768494] Starting subtest: y-tiled-8bpp-rotate-180
[74.772667] Subtest y-tiled-8bpp-rotate-180: SKIP (0.000s)
[74.875878] [003/131] (945s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-pwrite)
[74.977449] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-pwrite
[74.981576] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[75.080708] [004/131] (945s left) gem_exec_create (basic)
[75.153998] Starting subtest: basic
[75.156488] Starting dynamic subtest: smem
[78.934729] Dynamic subtest smem: SUCCESS (3.775s)
[78.937870] Subtest basic: SUCCESS (3.776s)
[79.114280] [005/131] (941s left) gem_fenced_exec_thrash (no-spare-fences-interruptible)
[79.168359] Subtest no-spare-fences-interruptible: SKIP (0.000s)
[79.229625] [006/131] (940s left) gem_mmap (short-mmap)
[79.280768] Subtest short-mmap: SKIP (0.000s)
[79.341508] [007/131] (940s left) kms_ccs (crc-sprite-planes-basic-4-tiled-mtl-rc-ccs-cc)
[79.434750] Starting subtest: crc-sprite-planes-basic-4-tiled-mtl-rc-ccs-cc
[79.436656] Starting dynamic subtest: pipe-A-eDP-1
[79.948764] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.486s)
[79.957693] Starting dynamic subtest: pipe-B-eDP-1
[81.418770] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.466s)
[81.427495] Starting dynamic subtest: pipe-C-eDP-1
[82.790614] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.371s)
[82.800121] Starting dynamic subtest: pipe-D-eDP-1
[84.209996] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.418s)
[84.212369] Subtest crc-sprite-planes-basic-4-tiled-mtl-rc-ccs-cc: SUCCESS (4.744s)
[85.382716] [008/131] (934s left) gem_userptr_blits (create-destroy-sync)
[85.448353] Starting subtest: create-destroy-sync
[90.457821] Subtest create-destroy-sync: SUCCESS (5.008s)
[90.569363] [009/131] (929s left) kms_pipe_crc_basic (nonblocking-crc)
[90.667046] Starting subtest: nonblocking-crc
[90.669441] Starting dynamic subtest: pipe-A-eDP-1
[91.399786] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.733s)
[91.409946] Starting dynamic subtest: pipe-B-eDP-1
[92.797120] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.396s)
[92.811230] Starting dynamic subtest: pipe-C-eDP-1
[94.199871] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.398s)
[94.208181] Starting dynamic subtest: pipe-D-eDP-1
[95.529314] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.330s)
[95.531286] Subtest nonblocking-crc: SUCCESS (4.861s)
[96.334576] [010/131] (924s left) gem_spin_batch (resubmit-new-all)
[96.392225] Starting subtest: resubmit-new-all
[96.394673] Starting dynamic subtest: rcs0
[96.407152] Dynamic subtest rcs0: SUCCESS (0.015s)
[96.416937] Starting dynamic subtest: bcs0
[96.419331] Dynamic subtest bcs0: SUCCESS (0.011s)
[96.426672] Starting dynamic subtest: vcs0
[96.429150] Dynamic subtest vcs0: SUCCESS (0.009s)
[96.437322] Starting dynamic subtest: vcs1
[96.439579] Dynamic subtest vcs1: SUCCESS (0.011s)
[96.447056] Starting dynamic subtest: vecs0
[96.451584] Dynamic subtest vecs0: SUCCESS (0.010s)
[96.458954] Starting dynamic subtest: ccs0
[96.461550] Dynamic subtest ccs0: SUCCESS (0.009s)
[96.463565] Subtest resubmit-new-all: SUCCESS (0.068s)
[97.915293] [011/131] (922s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip)
[98.016209] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip
[98.020476] Subtest yf-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip: SKIP (0.000s)
[98.112142] [012/131] (922s left) template (a)
[98.164666] Starting subtest: A
[98.166993] Subtest A: SUCCESS (0.000s)
[98.263870] [013/131] (922s left) kms_atomic_interruptible (legacy-setmode)
[98.363290] Starting subtest: legacy-setmode
[98.365638] Starting dynamic subtest: pipe-A-eDP-1
[105.225759] Dynamic subtest pipe-A-eDP-1: SUCCESS (6.857s)
[105.227699] Subtest legacy-setmode: SUCCESS (6.858s)
[106.021696] [014/131] (914s left) gem_render_copy (y-tiled-mc-ccs-to-y-tiled-ccs)
[106.075131] Starting subtest: y-tiled-mc-ccs-to-y-tiled-ccs
[106.079776] Subtest y-tiled-mc-ccs-to-y-tiled-ccs: SKIP (0.000s)
[106.261104] [015/131] (914s left) gem_workarounds (suspend-resume-context)
[106.331916] Starting subtest: suspend-resume-context
[122.015972] Subtest suspend-resume-context: SUCCESS (2.079s)
[122.145466] [016/131] (898s left) kms_addfb_basic (unused-handle)
[122.212858] Starting subtest: unused-handle
[122.214893] Subtest unused-handle: SUCCESS (0.000s)
[122.344754] [017/131] (898s left) syncobj_timeline (multi-wait-available-submitted)
[122.400439] Starting subtest: multi-wait-available-submitted
[122.403021] Subtest multi-wait-available-submitted: SUCCESS (0.001s)
[122.490096] [018/131] (898s left) prime_busy (before-wait)
[122.548163] Starting subtest: before-wait
[122.553232] Starting dynamic subtest: rcs0
[122.595731] Dynamic subtest rcs0: SUCCESS (0.042s)
[122.606807] Starting dynamic subtest: bcs0
[122.636532] Dynamic subtest bcs0: SUCCESS (0.039s)
[122.645147] Starting dynamic subtest: vcs0
[122.677583] Dynamic subtest vcs0: SUCCESS (0.039s)
[122.686193] Starting dynamic subtest: vcs1
[122.719458] Dynamic subtest vcs1: SUCCESS (0.039s)
[122.728338] Starting dynamic subtest: vecs0
[122.761225] Dynamic subtest vecs0: SUCCESS (0.039s)
[122.769914] Starting dynamic subtest: ccs0
[122.802400] Dynamic subtest ccs0: SUCCESS (0.039s)
[122.914127] Subtest before-wait: SUCCESS (0.347s)
[123.002083] [019/131] (897s left) gem_pxp (verify-pxp-key-change-after-suspend-resume)
[123.128035] Starting subtest: verify-pxp-key-change-after-suspend-resume
[130.298050] Subtest verify-pxp-key-change-after-suspend-resume: SUCCESS (6.962s)
[130.415429] [020/131] (890s left) kms_hdr (invalid-hdr)
[130.515876] Starting subtest: invalid-hdr
[132.613474] Starting dynamic subtest: pipe-A-eDP-1
[135.522982] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.875s)
[135.525240] Subtest invalid-hdr: SUCCESS (4.938s)
[135.647343] [021/131] (885s left) i915_query (query-topology-garbage-items)
[135.698369] Starting subtest: query-topology-garbage-items
[135.700804] Subtest query-topology-garbage-items: SUCCESS (0.000s)
[135.808241] [022/131] (885s left) kms_lease (page-flip-implicit-plane)
[135.906273] Starting subtest: page-flip-implicit-plane
[135.908580] Starting dynamic subtest: pipe-A-eDP-1
[137.420885] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.499s)
[137.430495] Starting dynamic subtest: pipe-B-eDP-1
[138.598867] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.169s)
[138.608579] Starting dynamic subtest: pipe-C-eDP-1
[139.719302] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.111s)
[139.728335] Starting dynamic subtest: pipe-D-eDP-1
[140.865573] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.136s)
[140.867901] Subtest page-flip-implicit-plane: SUCCESS (4.921s)
[141.702883] [023/131] (879s left) kms_content_protection (type1)
[141.847038] Starting subtest: type1
[141.851763] Subtest type1: SKIP (0.000s)
[141.968544] [024/131] (878s left) syncobj_timeline (wait-zero-handles)
[142.026377] Starting subtest: wait-zero-handles
[142.028685] Subtest wait-zero-handles: SUCCESS (0.000s)
[142.140521] [025/131] (878s left) gem_exec_whisper (basic-fds-forked-all)
[142.206058] Starting subtest: basic-fds-forked-all
[161.844408] Subtest basic-fds-forked-all: SUCCESS (19.599s)
[162.027356] [026/131] (858s left) kms_flip (2x-blocking-absolute-wf_vblank)
[162.134270] Starting subtest: 2x-blocking-absolute-wf_vblank
[162.142747] Subtest 2x-blocking-absolute-wf_vblank: SKIP (0.010s)
[162.270281] [027/131] (858s left) kms_feature_discovery (display-1x)
[162.355651] Starting subtest: display-1x
[162.357902] Subtest display-1x: SUCCESS (0.000s)
[162.425822] [028/131] (858s left) kms_psr2_sf (fbc-pr-overlay-primary-update-sf-dmg-area)
[162.518704] Starting subtest: fbc-pr-overlay-primary-update-sf-dmg-area
[162.522668] Subtest fbc-pr-overlay-primary-update-sf-dmg-area: SKIP (0.000s)
[162.596038] [029/131] (858s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-indfb-pgflip-blt)
[162.692725] Starting subtest: fbcpsr-1p-primscrn-indfb-pgflip-blt
[169.878204] Subtest fbcpsr-1p-primscrn-indfb-pgflip-blt: SUCCESS (7.197s)
[170.013615] [030/131] (851s left) kms_big_fb (yf-tiled-16bpp-rotate-90)
[170.126046] Starting subtest: yf-tiled-16bpp-rotate-90
[170.130538] Subtest yf-tiled-16bpp-rotate-90: SKIP (0.000s)
[170.216220] [031/131] (850s left) kms_color (ctm-red-to-blue)
[170.302595] Starting subtest: ctm-red-to-blue
[170.304573] Starting dynamic subtest: pipe-A-eDP-1
[171.839850] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.539s)
[171.849490] Starting dynamic subtest: pipe-B-eDP-1
[172.772990] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.935s)
[172.782970] Starting dynamic subtest: pipe-C-eDP-1
[174.154872] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.381s)
[174.164157] Starting dynamic subtest: pipe-D-eDP-1
[175.473255] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.317s)
[175.475335] Subtest ctm-red-to-blue: SUCCESS (5.175s)
[176.280765] [032/131] (844s left) api_intel_allocator (reopen-fork)
[176.335650] Starting subtest: reopen-fork
[179.667587] Subtest reopen-fork: SUCCESS (3.333s)
[179.742340] [033/131] (841s left) gem_exec_fence (syncobj-timeline-wait)
[180.384544] Starting subtest: syncobj-timeline-wait
[181.500180] Subtest syncobj-timeline-wait: SUCCESS (1.116s)
[181.729715] [FACT gem_exec_fence (syncobj-timeline-wait)] new: kernel.kmod_is_loaded.vgem: true
[181.733307] [034/131] (839s left) kms_flip_scaled_crc (flip-32bpp-xtile-to-64bpp-xtile-downscaling)
[181.840526] Starting subtest: flip-32bpp-xtile-to-64bpp-xtile-downscaling
[181.842661] Starting dynamic subtest: pipe-A-default-mode
[183.027138] Dynamic subtest pipe-A-default-mode: SKIP (1.186s)
[183.031815] Subtest flip-32bpp-xtile-to-64bpp-xtile-downscaling: SKIP (1.187s)
[183.197423] [035/131] (838s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-mmap-cpu)
[183.295220] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-mmap-cpu
[183.299714] Subtest fbc-2p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[183.390951] [036/131] (837s left) kms_frontbuffer_tracking (psr-rgb565-draw-pwrite)
[183.485945] Starting subtest: psr-rgb565-draw-pwrite
[190.505651] Subtest psr-rgb565-draw-pwrite: SUCCESS (7.024s)
[190.606953] [037/131] (830s left) kms_psr (psr2-no-drrs)
[190.707647] Starting subtest: psr2-no-drrs
[190.709946] Starting dynamic subtest: eDP-1
[192.292938] Dynamic subtest eDP-1: SUCCESS (1.587s)
[192.295300] Subtest psr2-no-drrs: SUCCESS (1.588s)
[193.096443] [038/131] (828s left) gem_exec_fence (syncobj-channel)
[193.515391] Starting subtest: syncobj-channel
[194.533387] Subtest syncobj-channel: SUCCESS (1.014s)
[194.840336] [039/131] (826s left) gem_flink_basic (bad-flink)
[194.897809] Starting subtest: bad-flink
[194.900229] Subtest bad-flink: SUCCESS (0.000s)
[195.002236] [040/131] (826s left) gem_exec_params (dr4-dirt)
[195.065392] Starting subtest: DR4-dirt
[195.067879] Subtest DR4-dirt: SUCCESS (0.000s)
[195.163975] [041/131] (826s left) kms_big_fb (x-tiled-64bpp-rotate-270)
[195.266402] Starting subtest: x-tiled-64bpp-rotate-270
[195.291693] Subtest x-tiled-64bpp-rotate-270: SKIP (0.024s)
[195.405859] [042/131] (826s left) gem_ctx_shared (create-shared-gtt)
[195.459598] Starting subtest: create-shared-gtt
[197.612579] Subtest create-shared-gtt: SUCCESS (2.152s)
[197.976341] [043/131] (823s left) gem_barrier_race (remote-request)
[198.035296] Starting subtest: remote-request
[198.037694] Starting dynamic subtest: rcs0
[203.218555] Dynamic subtest rcs0: SUCCESS (5.182s)
[203.221997] Subtest remote-request: SUCCESS (5.183s)
[203.378847] [044/131] (818s left) kms_frontbuffer_tracking (psr-2p-scndscrn-indfb-plflip-blt)
[203.472778] Starting subtest: psr-2p-scndscrn-indfb-plflip-blt
[203.476120] Subtest psr-2p-scndscrn-indfb-plflip-blt: SKIP (0.000s)
[203.566705] [045/131] (818s left) kms_psr (fbc-psr2-basic)
[203.664257] Starting subtest: fbc-psr2-basic
[203.666279] Starting dynamic subtest: eDP-1
[203.669913] Dynamic subtest eDP-1: SKIP (0.000s)
[203.673410] Subtest fbc-psr2-basic: SKIP (0.001s)
[203.761257] [046/131] (818s left) syncobj_wait (multi-wait-all-for-submit-signaled)
[203.816391] Starting subtest: multi-wait-all-for-submit-signaled
[203.818436] Subtest multi-wait-all-for-submit-signaled: SUCCESS (0.000s)
[203.908314] [047/131] (817s left) kms_draw_crc (fill-fb)
[204.005855] Starting subtest: fill-fb
[204.428494] Subtest fill-fb: SUCCESS (0.421s)
[204.534963] [048/131] (817s left) kms_big_fb (linear-64bpp-rotate-180)
[204.644593] Starting subtest: linear-64bpp-rotate-180
[206.126359] Subtest linear-64bpp-rotate-180: SUCCESS (1.480s)
[206.301020] [049/131] (815s left) kms_flip (flip-vs-modeset-vs-hang)
[206.404962] Starting subtest: flip-vs-modeset-vs-hang
[206.407421] Starting dynamic subtest: A-eDP1
[245.969377] Dynamic subtest A-eDP1: SUCCESS (39.563s)
[245.985522] Starting dynamic subtest: D-eDP1
[295.951786] Dynamic subtest D-eDP1: SUCCESS (49.975s)
[295.954539] Subtest flip-vs-modeset-vs-hang: SUCCESS (89.543s)
[296.320166] [050/131] (725s left) i915_drm_fdinfo (most-busy-idle-check-all)
[296.363865] Starting subtest: most-busy-idle-check-all
[296.365879] Starting dynamic subtest: rcs0
[296.370686] Dynamic subtest rcs0: SKIP (0.003s)
[296.381787] Starting dynamic subtest: bcs0
[296.386228] Dynamic subtest bcs0: SKIP (0.000s)
[296.394768] Starting dynamic subtest: vcs0
[296.399290] Dynamic subtest vcs0: SKIP (0.000s)
[296.408028] Starting dynamic subtest: vcs1
[296.412445] Dynamic subtest vcs1: SKIP (0.000s)
[296.421066] Starting dynamic subtest: vecs0
[296.425472] Dynamic subtest vecs0: SKIP (0.000s)
[296.434027] Starting dynamic subtest: ccs0
[296.438408] Dynamic subtest ccs0: SKIP (0.000s)
[296.442703] Subtest most-busy-idle-check-all: SKIP (0.009s)
[296.480301] [051/131] (725s left) gem_exec_balancer (full)
[296.565920] Starting subtest: full
[301.392380] Subtest full: SUCCESS (4.825s)
[301.714132] [052/131] (720s left) kms_flip (2x-wf_vblank-ts-check-interruptible)
[301.809432] Starting subtest: 2x-wf_vblank-ts-check-interruptible
[301.821487] Subtest 2x-wf_vblank-ts-check-interruptible: SKIP (0.011s)
[301.901781] [053/131] (720s left) kms_psr (pr-cursor-render)
[302.004420] Starting subtest: pr-cursor-render
[302.008714] Subtest pr-cursor-render: SKIP (0.000s)
[302.090677] [054/131] (720s left) kms_flip (plain-flip-interruptible)
[302.184292] Starting subtest: plain-flip-interruptible
[302.186564] Starting dynamic subtest: A-eDP1
[303.829451] Dynamic subtest A-eDP1: SUCCESS (1.643s)
[303.841330] Starting dynamic subtest: B-eDP1
[305.468670] Dynamic subtest B-eDP1: SUCCESS (1.638s)
[305.480270] Starting dynamic subtest: C-eDP1
[307.089706] Dynamic subtest C-eDP1: SUCCESS (1.619s)
[307.103226] Starting dynamic subtest: D-eDP1
[308.717181] Dynamic subtest D-eDP1: SUCCESS (1.624s)
[308.723578] Subtest plain-flip-interruptible: SUCCESS (6.539s)
[309.898242] [055/131] (712s left) syncobj_timeline (etime-multi-wait-all-for-submit-submitted)
[309.948404] Starting subtest: etime-multi-wait-all-for-submit-submitted
[310.050185] Subtest etime-multi-wait-all-for-submit-submitted: SUCCESS (0.102s)
[310.129400] [056/131] (712s left) kms_ccs (random-ccs-data-4-tiled-mtl-rc-ccs)
[310.218899] Starting subtest: random-ccs-data-4-tiled-mtl-rc-ccs
[310.221184] Starting dynamic subtest: pipe-A-eDP-1
[310.945087] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.719s)
[310.954014] Starting dynamic subtest: pipe-B-eDP-1
[312.733724] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.783s)
[312.745724] Starting dynamic subtest: pipe-C-eDP-1
[314.523061] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.792s)
[314.533889] Starting dynamic subtest: pipe-D-eDP-1
[316.256012] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.732s)
[316.258017] Subtest random-ccs-data-4-tiled-mtl-rc-ccs: SUCCESS (6.030s)
[317.430781] [057/131] (704s left) gem_fenced_exec_thrash (no-spare-fences)
[317.498651] Subtest no-spare-fences: SKIP (0.000s)
[317.575109] [058/131] (704s left) kms_ccs (crc-primary-suspend-y-tiled-ccs)
[317.671825] Starting subtest: crc-primary-suspend-y-tiled-ccs
[317.674084] Starting dynamic subtest: pipe-A-eDP-1
[317.683133] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[317.697407] Starting dynamic subtest: pipe-B-eDP-1
[317.706422] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[317.715245] Starting dynamic subtest: pipe-C-eDP-1
[317.723635] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[317.732194] Starting dynamic subtest: pipe-D-eDP-1
[317.740622] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[317.744626] Subtest crc-primary-suspend-y-tiled-ccs: SKIP (0.005s)
[319.989477] [059/131] (702s left) kms_invalid_mode (bad-vsync-end)
[320.100204] Starting subtest: bad-vsync-end
[320.102562] Starting dynamic subtest: pipe-A-eDP-1
[320.384578] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.285s)
[320.394038] Starting dynamic subtest: pipe-B-eDP-1
[320.395987] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[320.404965] Starting dynamic subtest: pipe-C-eDP-1
[320.407198] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[320.416101] Starting dynamic subtest: pipe-D-eDP-1
[320.418356] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[320.420648] Subtest bad-vsync-end: SUCCESS (0.291s)
[321.216999] [060/131] (701s left) kms_psr2_sf (psr2-overlay-primary-update-sf-dmg-area)
[321.316731] Starting subtest: psr2-overlay-primary-update-sf-dmg-area
[321.319203] Starting dynamic subtest: pipe-A-eDP-1
[327.194391] Dynamic subtest pipe-A-eDP-1: SUCCESS (5.879s)
[327.204214] Starting dynamic subtest: pipe-B-eDP-1
[333.859519] Dynamic subtest pipe-B-eDP-1: SUCCESS (6.663s)
[333.861950] Subtest psr2-overlay-primary-update-sf-dmg-area: SUCCESS (12.545s)
[334.730276] [061/131] (687s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-pwrite)
[334.832659] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-pwrite
[334.836953] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[334.928401] [062/131] (687s left) syncobj_wait (wait-all-complex)
[334.981525] Starting subtest: wait-all-complex
[335.196540] Subtest wait-all-complex: SUCCESS (0.215s)
[335.284696] [063/131] (687s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-pwrite)
[335.382577] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-pwrite
[342.413959] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-pwrite: SUCCESS (7.033s)
[342.538538] [064/131] (680s left) kms_cursor_legacy (short-flip-before-cursor-atomic-transitions)
[342.666063] Starting subtest: short-flip-before-cursor-atomic-transitions
[343.615944] Subtest short-flip-before-cursor-atomic-transitions: SUCCESS (0.950s)
[344.471978] [065/131] (678s left) kms_plane (pixel-format-y-tiled-gen12-rc-ccs-cc-modifier)
[344.564734] Starting subtest: pixel-format-y-tiled-gen12-rc-ccs-cc-modifier
[344.569055] Subtest pixel-format-y-tiled-gen12-rc-ccs-cc-modifier: SKIP (0.000s)
[344.647989] [066/131] (677s left) syncobj_timeline (wait-any-complex)
[344.697851] Starting subtest: wait-any-complex
[344.758396] Subtest wait-any-complex: SUCCESS (0.062s)
[344.833129] [067/131] (677s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-mmap-cpu)
[344.937593] Starting subtest: fbc-rgb101010-draw-mmap-cpu
[349.548785] Subtest fbc-rgb101010-draw-mmap-cpu: SUCCESS (4.613s)
[350.689290] [068/131] (672s left) gen9_exec_parse (bb-start-cmd)
[350.752729] Subtest bb-start-cmd: SKIP (0.000s)
[350.813777] [069/131] (671s left) kms_rotation_crc (bad-pixel-format)
[350.904478] Starting subtest: bad-pixel-format
[350.908989] Subtest bad-pixel-format: SKIP (0.001s)
[350.987378] [070/131] (671s left) gem_exec_capture (capture-invisible)
[351.041778] Starting subtest: capture-invisible
[351.044124] Starting dynamic subtest: smem0
[351.048583] Dynamic subtest smem0: SKIP (0.000s)
[351.052664] Subtest capture-invisible: SKIP (0.001s)
[351.145271] [071/131] (671s left) i915_hangman (error-state-basic)
[351.207213] Starting subtest: error-state-basic
[351.363795] Subtest error-state-basic: SUCCESS (0.157s)
[351.439819] [072/131] (671s left) kms_frontbuffer_tracking (psr-1p-primscrn-shrfb-plflip-blt)
[351.528215] Starting subtest: psr-1p-primscrn-shrfb-plflip-blt
[359.050002] Subtest psr-1p-primscrn-shrfb-plflip-blt: SUCCESS (7.526s)
[359.179163] [073/131] (663s left) kms_async_flips (test-time-stamp-atomic)
[359.274330] Starting subtest: test-time-stamp-atomic
[359.661138] Starting dynamic subtest: pipe-A-eDP-1
[360.482639] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.819s)
[360.863590] Starting dynamic subtest: pipe-B-eDP-1
[361.624623] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.766s)
[362.020415] Starting dynamic subtest: pipe-C-eDP-1
[362.777961] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.766s)
[363.145685] Starting dynamic subtest: pipe-D-eDP-1
[363.913693] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.777s)
[363.916033] Subtest test-time-stamp-atomic: SUCCESS (4.640s)
[365.110862] [074/131] (657s left) gem_exec_params (no-bsd)
[365.170565] Starting subtest: no-bsd
[365.175104] Subtest no-bsd: SUCCESS (0.002s)
[366.596511] [075/131] (656s left) gem_exercise_blt (fast-copy)
[366.643286] Starting subtest: fast-copy
[366.645624] Starting dynamic subtest: linear-smem-smem
[366.668944] Dynamic subtest linear-smem-smem: SUCCESS (0.025s)
[366.680923] Starting dynamic subtest: xmajor-smem-smem
[366.686891] Dynamic subtest xmajor-smem-smem: SUCCESS (0.017s)
[366.696384] Starting dynamic subtest: tile4-smem-smem
[366.703559] Dynamic subtest tile4-smem-smem: SUCCESS (0.016s)
[366.712869] Starting dynamic subtest: tile64-smem-smem
[366.720415] Dynamic subtest tile64-smem-smem: SUCCESS (0.016s)
[366.722702] Subtest fast-copy: SUCCESS (0.077s)
[366.830899] [076/131] (656s left) gem_mmap_offset (ptrace)
[366.889557] Starting subtest: ptrace
[366.891816] Starting dynamic subtest: smem0-wb
[366.908652] Dynamic subtest smem0-wb: SUCCESS (0.018s)
[366.924937] Starting dynamic subtest: smem0-wc
[366.933642] Dynamic subtest smem0-wc: SUCCESS (0.024s)
[366.942926] Starting dynamic subtest: smem0-uc
[366.953946] Dynamic subtest smem0-uc: SUCCESS (0.020s)
[366.956276] Subtest ptrace: SUCCESS (0.067s)
[367.060489] [077/131] (656s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling)
[367.167841] Starting subtest: flip-64bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling
[367.172053] Subtest flip-64bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling: SKIP (0.000s)
[367.240391] [078/131] (655s left) kms_ccs (bad-pixel-format-y-tiled-gen12-rc-ccs)
[367.336584] Starting subtest: bad-pixel-format-y-tiled-gen12-rc-ccs
[367.339192] Starting dynamic subtest: pipe-A-eDP-1
[367.371812] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[367.382907] Starting dynamic subtest: pipe-B-eDP-1
[367.403161] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[367.411831] Starting dynamic subtest: pipe-C-eDP-1
[367.431848] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[367.440307] Starting dynamic subtest: pipe-D-eDP-1
[367.460768] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[367.464963] Subtest bad-pixel-format-y-tiled-gen12-rc-ccs: SKIP (0.005s)
[369.556932] [079/131] (653s left) gem_exec_reloc (basic-gtt-wc-noreloc)
[369.607204] Subtest basic-gtt-wc-noreloc: SKIP (0.000s)
[369.677318] [080/131] (653s left) syncobj_basic (bad-pad-fd-to-handle)
[369.728139] Starting subtest: bad-pad-fd-to-handle
[369.730372] Subtest bad-pad-fd-to-handle: SUCCESS (0.000s)
[369.831847] [081/131] (653s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-mmap-cpu)
[369.926599] Starting subtest: psr-1p-primscrn-pri-indfb-draw-mmap-cpu
[376.979805] Subtest psr-1p-primscrn-pri-indfb-draw-mmap-cpu: SUCCESS (7.056s)
[377.080067] [082/131] (646s left) syncobj_timeline (etime-multi-wait-available-unsubmitted)
[377.146427] Starting subtest: etime-multi-wait-available-unsubmitted
[377.250805] Subtest etime-multi-wait-available-unsubmitted: SUCCESS (0.104s)
[377.343488] [083/131] (646s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-180-hflip)
[377.438600] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-180-hflip
[377.443152] Subtest y-tiled-max-hw-stride-32bpp-rotate-180-hflip: SKIP (0.000s)
[377.534183] [084/131] (645s left) api_intel_bb (misplaced-blitter)
[377.597652] Starting subtest: misplaced-blitter
[377.603323] Subtest misplaced-blitter: SUCCESS (0.007s)
[377.732594] [085/131] (645s left) syncobj_timeline (multi-wait-all-available-submitted-signaled)
[377.783069] Starting subtest: multi-wait-all-available-submitted-signaled
[377.785343] Subtest multi-wait-all-available-submitted-signaled: SUCCESS (0.000s)
[377.873936] [086/131] (645s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-onoff)
[377.968976] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-onoff
[377.973052] Subtest fbcpsr-2p-scndscrn-spr-indfb-onoff: SKIP (0.000s)
[378.062817] [087/131] (645s left) gem_vm_create (isolation)
[378.122076] Starting subtest: isolation
[378.131734] Subtest isolation: SUCCESS (0.009s)
[378.242972] [088/131] (645s left) kms_plane_multiple (tiling-4)
[378.329017] Starting subtest: tiling-4
[378.330722] Starting dynamic subtest: pipe-A-eDP-1
[382.208183] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.879s)
[382.218584] Starting dynamic subtest: pipe-B-eDP-1
[386.555383] Dynamic subtest pipe-B-eDP-1: SUCCESS (4.344s)
[386.565312] Starting dynamic subtest: pipe-C-eDP-1
[390.888942] Dynamic subtest pipe-C-eDP-1: SUCCESS (4.333s)
[390.899436] Starting dynamic subtest: pipe-D-eDP-1
[395.227787] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.337s)
[395.230156] Subtest tiling-4: SUCCESS (16.899s)
[396.031821] [089/131] (627s left) gem_exec_reloc (basic-gtt-wc)
[396.091745] Subtest basic-gtt-wc: SKIP (0.000s)
[396.170151] [090/131] (627s left) kms_pm_rpm (dpms-lpsp)
[397.702020] Starting subtest: dpms-lpsp
[398.415901] Subtest dpms-lpsp: SUCCESS (0.716s)
[398.530754] [091/131] (625s left) gem_mmap_gtt (isolation)
[398.592529] Subtest isolation: SKIP (0.000s)
[398.663316] [092/131] (625s left) prime_vgem (coherency-gtt)
[398.725035] Starting subtest: coherency-gtt
[398.729442] Subtest coherency-gtt: SKIP (0.000s)
[398.827974] [093/131] (624s left) kms_cursor_legacy (forked-bo)
[398.941066] Starting subtest: forked-bo
[398.943364] Starting dynamic subtest: pipe-A
[404.397415] Dynamic subtest pipe-A: SUCCESS (5.453s)
[404.419455] Starting dynamic subtest: pipe-B
[409.867748] Dynamic subtest pipe-B: SUCCESS (5.468s)
[409.879656] Starting dynamic subtest: pipe-C
[415.336749] Dynamic subtest pipe-C: SUCCESS (5.466s)
[415.348707] Starting dynamic subtest: pipe-D
[420.816174] Dynamic subtest pipe-D: SUCCESS (5.476s)
[420.828129] Starting dynamic subtest: all-pipes
[426.300721] Dynamic subtest all-pipes: SUCCESS (5.482s)
[426.303192] Subtest forked-bo: SUCCESS (27.358s)
[426.452548] [094/131] (597s left) kms_frontbuffer_tracking (fbc-rgb565-draw-pwrite)
[426.570508] Starting subtest: fbc-rgb565-draw-pwrite
[431.089883] Subtest fbc-rgb565-draw-pwrite: SUCCESS (4.523s)
[432.258554] [095/131] (591s left) kms_cursor_legacy (basic-flip-after-cursor-atomic)
[432.373025] Starting subtest: basic-flip-after-cursor-atomic
[433.289922] Subtest basic-flip-after-cursor-atomic: SUCCESS (0.916s)
[434.090000] [096/131] (589s left) kms_plane_scaling (plane-upscale-factor-0-25-with-rotation)
[434.192813] Starting subtest: plane-upscale-factor-0-25-with-rotation
[434.195133] Starting dynamic subtest: pipe-A
[434.417733] Dynamic subtest pipe-A: SUCCESS (0.227s)
[434.427403] Starting dynamic subtest: pipe-B
[435.661381] Dynamic subtest pipe-B: SUCCESS (1.243s)
[435.673526] Starting dynamic subtest: pipe-C
[437.001577] Dynamic subtest pipe-C: SUCCESS (1.339s)
[437.011373] Starting dynamic subtest: pipe-D
[438.335200] Dynamic subtest pipe-D: SUCCESS (1.332s)
[438.337890] Subtest plane-upscale-factor-0-25-with-rotation: SUCCESS (4.146s)
[439.514598] [097/131] (584s left) sw_sync (sync_multi_consumer)
[439.554799] Starting subtest: sync_multi_consumer
[439.983690] Subtest sync_multi_consumer: SUCCESS (0.429s)
[440.042898] [098/131] (583s left) kms_ccs (crc-primary-basic-4-tiled-lnl-ccs)
[440.132765] Starting subtest: crc-primary-basic-4-tiled-lnl-ccs
[440.137256] Subtest crc-primary-basic-4-tiled-lnl-ccs: SKIP (0.000s)
[441.248355] [099/131] (582s left) kms_vblank (wait-forked)
[441.339150] Starting subtest: wait-forked
[441.341305] Starting dynamic subtest: pipe-A-eDP-1
[443.148018] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.810s)
[443.169475] Starting dynamic subtest: pipe-D-eDP-1
[445.650696] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.497s)
[445.653047] Subtest wait-forked: SUCCESS (4.313s)
[446.546230] [100/131] (577s left) kms_flip_scaled_crc (flip-64bpp-yftile-to-32bpp-yftile-upscaling)
[446.639783] Starting subtest: flip-64bpp-yftile-to-32bpp-yftile-upscaling
[446.644119] Subtest flip-64bpp-yftile-to-32bpp-yftile-upscaling: SKIP (0.000s)
[446.715097] [101/131] (577s left) gem_ctx_param (basic-default)
[446.768397] Starting subtest: basic-default
[446.770812] Subtest basic-default: SUCCESS (0.000s)
[446.862013] [102/131] (577s left) kms_psr (fbc-psr-sprite-mmap-gtt)
[446.954781] Starting subtest: fbc-psr-sprite-mmap-gtt
[446.957093] Starting dynamic subtest: eDP-1
[446.961485] Dynamic subtest eDP-1: SKIP (0.000s)
[446.965984] Subtest fbc-psr-sprite-mmap-gtt: SKIP (0.001s)
[447.029584] [103/131] (577s left) kms_cursor_crc (cursor-sliding-128x42)
[447.262102] Starting subtest: cursor-sliding-128x42
[447.310605] Subtest cursor-sliding-128x42: SKIP (0.044s)
[447.533916] [104/131] (576s left) syncobj_basic (illegal-fd-to-handle)
[447.582939] Starting subtest: illegal-fd-to-handle
[447.584936] Subtest illegal-fd-to-handle: SUCCESS (0.000s)
[447.682931] [105/131] (576s left) kms_chamelium_hpd (vga-hpd-with-enabled-mode)
[448.066446] Subtest vga-hpd-with-enabled-mode: SKIP (0.000s)
[448.847999] [106/131] (575s left) kms_big_fb (4-tiled-addfb-size-overflow)
[448.950680] Starting subtest: 4-tiled-addfb-size-overflow
[448.952834] Subtest 4-tiled-addfb-size-overflow: SUCCESS (0.000s)
[449.053121] [107/131] (575s left) gem_lmem_swapping (random-engines)
[449.098570] Subtest random-engines: SKIP (0.000s)
[449.136094] [108/131] (575s left) gem_exec_schedule (u-submit-early-slice)
[449.199671] Starting subtest: u-submit-early-slice
[449.201580] Starting dynamic subtest: rcs0
[449.234558] Dynamic subtest rcs0: SUCCESS (0.042s)
[449.244123] Starting dynamic subtest: bcs0
[449.270542] Dynamic subtest bcs0: SUCCESS (0.035s)
[449.279968] Starting dynamic subtest: vcs0
[449.311306] Dynamic subtest vcs0: SUCCESS (0.040s)
[449.323952] Starting dynamic subtest: vcs1
[449.350162] Dynamic subtest vcs1: SUCCESS (0.039s)
[449.359775] Starting dynamic subtest: vecs0
[449.386946] Dynamic subtest vecs0: SUCCESS (0.036s)
[449.396780] Starting dynamic subtest: ccs0
[449.430657] Dynamic subtest ccs0: SUCCESS (0.043s)
[449.433150] Subtest u-submit-early-slice: SUCCESS (0.239s)
[450.591689] [109/131] (573s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-mmap-gtt)
[450.688856] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-mmap-gtt
[450.692798] Subtest psr-2p-scndscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[450.790807] [110/131] (573s left) perf (unprivileged-single-ctx-counters)
[450.868414] Starting subtest: unprivileged-single-ctx-counters
[450.873045] Subtest unprivileged-single-ctx-counters: SKIP (0.000s)
[450.915342] [111/131] (573s left) kms_cursor_edge_walk (256x256-left-edge)
[451.007337] Starting subtest: 256x256-left-edge
[451.009492] Starting dynamic subtest: pipe-A-eDP-1
[454.454269] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.445s)
[454.468382] Starting dynamic subtest: pipe-D-eDP-1
[457.576632] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.122s)
[457.578963] Subtest 256x256-left-edge: SUCCESS (6.570s)
[458.380480] [112/131] (566s left) gem_exec_schedule (preempt)
[458.448745] Starting subtest: preempt
[458.450775] Starting dynamic subtest: rcs0
[458.461007] Dynamic subtest rcs0: SUCCESS (0.021s)
[458.473722] Starting dynamic subtest: bcs0
[458.479563] Dynamic subtest bcs0: SUCCESS (0.018s)
[458.489389] Starting dynamic subtest: vcs0
[458.499366] Dynamic subtest vcs0: SUCCESS (0.019s)
[458.509284] Starting dynamic subtest: vcs1
[458.522629] Dynamic subtest vcs1: SUCCESS (0.022s)
[458.532617] Starting dynamic subtest: vecs0
[458.543615] Dynamic subtest vecs0: SUCCESS (0.020s)
[458.553782] Starting dynamic subtest: ccs0
[458.564368] Dynamic subtest ccs0: SUCCESS (0.020s)
[458.566688] Subtest preempt: SUCCESS (0.126s)
[460.617962] [113/131] (564s left) kms_plane (plane-panning-bottom-right)
[460.736639] Starting subtest: plane-panning-bottom-right
[460.738982] Starting dynamic subtest: pipe-A
[462.461575] Dynamic subtest pipe-A: SUCCESS (1.723s)
[462.472042] Starting dynamic subtest: pipe-B
[464.882787] Dynamic subtest pipe-B: SUCCESS (2.421s)
[464.885136] Subtest plane-panning-bottom-right: SUCCESS (4.148s)
[465.708089] [114/131] (558s left) kms_cursor_crc (cursor-offscreen-64x21)
[465.906017] Starting subtest: cursor-offscreen-64x21
[465.952601] Subtest cursor-offscreen-64x21: SKIP (0.042s)
[466.191671] [115/131] (558s left) kms_sequence (queue-busy)
[466.287592] Starting subtest: queue-busy
[466.289876] Starting dynamic subtest: pipe-A-eDP-1
[468.225201] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.936s)
[468.235387] Starting dynamic subtest: pipe-B-eDP-1
[470.805698] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.581s)
[470.815733] Starting dynamic subtest: pipe-C-eDP-1
[473.414622] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.606s)
[473.425212] Starting dynamic subtest: pipe-D-eDP-1
[476.030957] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.616s)
[476.033375] Subtest queue-busy: SUCCESS (9.744s)
[476.917678] [116/131] (547s left) gem_basic (bad-close)
[476.982019] Starting subtest: bad-close
[476.986595] Subtest bad-close: SUCCESS (0.000s)
[477.092871] [117/131] (547s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-mmap-gtt)
[477.192137] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-mmap-gtt
[477.196309] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[477.282380] [118/131] (547s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-fullscreen)
[477.380294] Starting subtest: psr-2p-primscrn-spr-indfb-fullscreen
[477.384389] Subtest psr-2p-primscrn-spr-indfb-fullscreen: SKIP (0.000s)
[477.494439] [119/131] (547s left) kms_pm_rpm (modeset-pc8-residency-stress)
[479.621819] Starting subtest: modeset-pc8-residency-stress
[479.627219] Subtest modeset-pc8-residency-stress: SKIP (0.000s)
[479.998198] [120/131] (544s left) kms_psr (psr-primary-mmap-gtt)
[480.094409] Starting subtest: psr-primary-mmap-gtt
[480.096625] Starting dynamic subtest: eDP-1
[481.488259] Dynamic subtest eDP-1: SKIP (1.391s)
[481.496590] Subtest psr-primary-mmap-gtt: SKIP (1.394s)
[481.624300] [121/131] (543s left) gem_create (create-ext-placement-sanity-check)
[481.794030] Starting subtest: create-ext-placement-sanity-check
[481.796338] Subtest create-ext-placement-sanity-check: SUCCESS (0.004s)
[481.894142] [122/131] (543s left) device_reset (cold-reset-bound)
[481.949595] Starting subtest: cold-reset-bound
[481.954100] Subtest cold-reset-bound: SKIP (0.000s)
[482.021534] [123/131] (543s left) kms_chamelium_edid (dp-edid-change-during-suspend)
[482.415935] Subtest dp-edid-change-during-suspend: SKIP (0.000s)
[483.226506] [124/131] (541s left) i915_pm_rpm (gem-execbuf)
[484.758475] Starting subtest: gem-execbuf
[484.761527] Starting dynamic subtest: smem0
[486.814190] Dynamic subtest smem0: SUCCESS (2.055s)
[486.816473] Subtest gem-execbuf: SUCCESS (2.057s)
[486.901462] [125/131] (538s left) kms_cursor_legacy (short-flip-before-cursor-atomic-transitions-varying-size)
[487.011118] Starting subtest: short-flip-before-cursor-atomic-transitions-varying-size
[487.982001] Subtest short-flip-before-cursor-atomic-transitions-varying-size: SUCCESS (0.969s)
[488.801411] [126/131] (536s left) perf (gen12-mi-rpc)
[488.895474] Starting subtest: gen12-mi-rpc
[488.898068] Starting dynamic subtest: rcs0
[488.917670] Dynamic subtest rcs0: SUCCESS (0.019s)
[488.919853] Subtest gen12-mi-rpc: SUCCESS (0.020s)
[488.977649] [127/131] (536s left) kms_psr2_sf (fbc-psr2-overlay-plane-move-continuous-exceed-fully-sf)
[489.103227] Starting subtest: fbc-psr2-overlay-plane-move-continuous-exceed-fully-sf
[489.105543] Starting dynamic subtest: pipe-A-eDP-1
[489.191059] Dynamic subtest pipe-A-eDP-1: SKIP (0.088s)
[489.202128] Starting dynamic subtest: pipe-B-eDP-1
[490.380302] Dynamic subtest pipe-B-eDP-1: SKIP (1.188s)
[490.384904] Subtest fbc-psr2-overlay-plane-move-continuous-exceed-fully-sf: SKIP (1.279s)
[491.568980] [128/131] (533s left) gem_userptr_blits (coherency-sync)
[491.637309] Starting subtest: coherency-sync
[492.116760] Subtest coherency-sync: SKIP (0.442s)
[492.242043] [129/131] (533s left) perf_pmu (most-busy-idle-check-all)
[492.334550] Starting subtest: most-busy-idle-check-all
[492.336719] Starting dynamic subtest: rcs0
[493.495146] Dynamic subtest rcs0: SUCCESS (1.159s)
[493.507568] Starting dynamic subtest: bcs0
[495.542793] Dynamic subtest bcs0: SUCCESS (2.044s)
[495.555295] Starting dynamic subtest: vcs0
[497.527212] Dynamic subtest vcs0: SUCCESS (1.981s)
[497.539815] Starting dynamic subtest: vcs1
[499.511245] Dynamic subtest vcs1: SUCCESS (1.981s)
[499.524381] Starting dynamic subtest: vecs0
[501.495377] Dynamic subtest vecs0: SUCCESS (1.980s)
[501.508444] Starting dynamic subtest: ccs0
[503.543452] Dynamic subtest ccs0: SUCCESS (2.045s)
[503.546521] Subtest most-busy-idle-check-all: SUCCESS (11.208s)
[503.674027] [130/131] (521s left) gem_ctx_persistence (engines-mixed)
[503.738219] Starting subtest: engines-mixed
[503.740261] Starting dynamic subtest: rcs0
[503.814848] Dynamic subtest rcs0: SUCCESS (0.079s)
[503.831319] Starting dynamic subtest: bcs0
[503.883895] Dynamic subtest bcs0: SUCCESS (0.065s)
[503.896229] Starting dynamic subtest: vcs0
[503.927092] Dynamic subtest vcs0: SUCCESS (0.042s)
[503.937714] Starting dynamic subtest: vcs1
[503.984092] Dynamic subtest vcs1: SUCCESS (0.056s)
[503.995602] Starting dynamic subtest: vecs0
[504.035054] Dynamic subtest vecs0: SUCCESS (0.049s)
[504.045587] Starting dynamic subtest: ccs0
[504.088452] Dynamic subtest ccs0: SUCCESS (0.051s)
[504.091716] Subtest engines-mixed: SUCCESS (0.354s)
[504.165951] [131/131] (521s left) gem_mmap_gtt (big-copy-xy)
[504.233554] Subtest big-copy-XY: SKIP (0.000s)
[504.299942] Closing watchdogs
results: parsing output: 0/ for test: kms_async_flips
results: parsing output: 1/ for test: kms_big_fb
results: parsing output: 2/ for test: kms_frontbuffer_tracking
results: parsing output: 3/ for test: gem_exec_create
results: parsing output: 4/ for test: gem_fenced_exec_thrash
results: parsing output: 5/ for test: gem_mmap
results: parsing output: 6/ for test: kms_ccs
results: parsing output: 7/ for test: gem_userptr_blits
results: parsing output: 8/ for test: kms_pipe_crc_basic
results: parsing output: 9/ for test: gem_spin_batch
results: parsing output: 10/ for test: kms_big_fb
results: parsing output: 11/ for test: template
results: parsing output: 12/ for test: kms_atomic_interruptible
results: parsing output: 13/ for test: gem_render_copy
results: parsing output: 14/ for test: gem_workarounds
results: parsing output: 15/ for test: kms_addfb_basic
results: parsing output: 16/ for test: syncobj_timeline
results: parsing output: 17/ for test: prime_busy
results: parsing output: 18/ for test: gem_pxp
results: parsing output: 19/ for test: kms_hdr
results: parsing output: 20/ for test: i915_query
results: parsing output: 21/ for test: kms_lease
results: parsing output: 22/ for test: kms_content_protection
results: parsing output: 23/ for test: syncobj_timeline
results: parsing output: 24/ for test: gem_exec_whisper
results: parsing output: 25/ for test: kms_flip
results: parsing output: 26/ for test: kms_feature_discovery
results: parsing output: 27/ for test: kms_psr2_sf
results: parsing output: 28/ for test: kms_frontbuffer_tracking
results: parsing output: 29/ for test: kms_big_fb
results: parsing output: 30/ for test: kms_color
results: parsing output: 31/ for test: api_intel_allocator
results: parsing output: 32/ for test: gem_exec_fence
results: parsing output: 33/ for test: kms_flip_scaled_crc
results: parsing output: 34/ for test: kms_frontbuffer_tracking
results: parsing output: 35/ for test: kms_frontbuffer_tracking
results: parsing output: 36/ for test: kms_psr
results: parsing output: 37/ for test: gem_exec_fence
results: parsing output: 38/ for test: gem_flink_basic
results: parsing output: 39/ for test: gem_exec_params
results: parsing output: 40/ for test: kms_big_fb
results: parsing output: 41/ for test: gem_ctx_shared
results: parsing output: 42/ for test: gem_barrier_race
results: parsing output: 43/ for test: kms_frontbuffer_tracking
results: parsing output: 44/ for test: kms_psr
results: parsing output: 45/ for test: syncobj_wait
results: parsing output: 46/ for test: kms_draw_crc
results: parsing output: 47/ for test: kms_big_fb
results: parsing output: 48/ for test: kms_flip
results: parsing output: 49/ for test: i915_drm_fdinfo
results: parsing output: 50/ for test: gem_exec_balancer
results: parsing output: 51/ for test: kms_flip
results: parsing output: 52/ for test: kms_psr
results: parsing output: 53/ for test: kms_flip
results: parsing output: 54/ for test: syncobj_timeline
results: parsing output: 55/ for test: kms_ccs
results: parsing output: 56/ for test: gem_fenced_exec_thrash
results: parsing output: 57/ for test: kms_ccs
results: parsing output: 58/ for test: kms_invalid_mode
results: parsing output: 59/ for test: kms_psr2_sf
results: parsing output: 60/ for test: kms_frontbuffer_tracking
results: parsing output: 61/ for test: syncobj_wait
results: parsing output: 62/ for test: kms_frontbuffer_tracking
results: parsing output: 63/ for test: kms_cursor_legacy
results: parsing output: 64/ for test: kms_plane
results: parsing output: 65/ for test: syncobj_timeline
results: parsing output: 66/ for test: kms_frontbuffer_tracking
results: parsing output: 67/ for test: gen9_exec_parse
results: parsing output: 68/ for test: kms_rotation_crc
results: parsing output: 69/ for test: gem_exec_capture
results: parsing output: 70/ for test: i915_hangman
results: parsing output: 71/ for test: kms_frontbuffer_tracking
results: parsing output: 72/ for test: kms_async_flips
results: parsing output: 73/ for test: gem_exec_params
results: parsing output: 74/ for test: gem_exercise_blt
results: parsing output: 75/ for test: gem_mmap_offset
results: parsing output: 76/ for test: kms_flip_scaled_crc
results: parsing output: 77/ for test: kms_ccs
results: parsing output: 78/ for test: gem_exec_reloc
results: parsing output: 79/ for test: syncobj_basic
results: parsing output: 80/ for test: kms_frontbuffer_tracking
results: parsing output: 81/ for test: syncobj_timeline
results: parsing output: 82/ for test: kms_big_fb
results: parsing output: 83/ for test: api_intel_bb
results: parsing output: 84/ for test: syncobj_timeline
results: parsing output: 85/ for test: kms_frontbuffer_tracking
results: parsing output: 86/ for test: gem_vm_create
results: parsing output: 87/ for test: kms_plane_multiple
results: parsing output: 88/ for test: gem_exec_reloc
results: parsing output: 89/ for test: kms_pm_rpm
results: parsing output: 90/ for test: gem_mmap_gtt
results: parsing output: 91/ for test: prime_vgem
results: parsing output: 92/ for test: kms_cursor_legacy
results: parsing output: 93/ for test: kms_frontbuffer_tracking
results: parsing output: 94/ for test: kms_cursor_legacy
results: parsing output: 95/ for test: kms_plane_scaling
results: parsing output: 96/ for test: sw_sync
results: parsing output: 97/ for test: kms_ccs
results: parsing output: 98/ for test: kms_vblank
results: parsing output: 99/ for test: kms_flip_scaled_crc
results: parsing output: 100/ for test: gem_ctx_param
results: parsing output: 101/ for test: kms_psr
results: parsing output: 102/ for test: kms_cursor_crc
results: parsing output: 103/ for test: syncobj_basic
results: parsing output: 104/ for test: kms_chamelium_hpd
results: parsing output: 105/ for test: kms_big_fb
results: parsing output: 106/ for test: gem_lmem_swapping
results: parsing output: 107/ for test: gem_exec_schedule
results: parsing output: 108/ for test: kms_frontbuffer_tracking
results: parsing output: 109/ for test: perf
results: parsing output: 110/ for test: kms_cursor_edge_walk
results: parsing output: 111/ for test: gem_exec_schedule
results: parsing output: 112/ for test: kms_plane
results: parsing output: 113/ for test: kms_cursor_crc
results: parsing output: 114/ for test: kms_sequence
results: parsing output: 115/ for test: gem_basic
results: parsing output: 116/ for test: kms_frontbuffer_tracking
results: parsing output: 117/ for test: kms_frontbuffer_tracking
results: parsing output: 118/ for test: kms_pm_rpm
results: parsing output: 119/ for test: kms_psr
results: parsing output: 120/ for test: gem_create
results: parsing output: 121/ for test: device_reset
results: parsing output: 122/ for test: kms_chamelium_edid
results: parsing output: 123/ for test: i915_pm_rpm
results: parsing output: 124/ for test: kms_cursor_legacy
results: parsing output: 125/ for test: perf
results: parsing output: 126/ for test: kms_psr2_sf
results: parsing output: 127/ for test: gem_userptr_blits
results: parsing output: 128/ for test: perf_pmu
results: parsing output: 129/ for test: gem_ctx_persistence
results: parsing output: 130/ for test: gem_mmap_gtt
Done.