[56.618042] Initializing watchdogs
[56.618093]   /dev/watchdog0
[56.633593] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:7d55 Intel Meteorlake (Gen12) Meteor Lake-P [Intel Arc Graphics]
[56.638449] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[56.640944] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[56.644410] [001/155] (960s left) kms_ccs (crc-primary-rotation-180-4-tiled-dg2-mc-ccs)
[56.760801] Starting subtest: crc-primary-rotation-180-4-tiled-dg2-mc-ccs
[56.763072] Starting dynamic subtest: pipe-A-eDP-1
[56.785610] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[56.794778] Starting dynamic subtest: pipe-B-eDP-1
[56.816399] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[56.823457] Starting dynamic subtest: pipe-C-eDP-1
[56.844853] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[56.853436] Starting dynamic subtest: pipe-D-eDP-1
[56.876525] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[56.880993] Subtest crc-primary-rotation-180-4-tiled-dg2-mc-ccs: SKIP (0.005s)
[59.067244] [002/155] (958s left) kms_psr2_sf (fbc-psr2-overlay-plane-move-continuous-exceed-fully-sf)
[59.166575] Starting subtest: fbc-psr2-overlay-plane-move-continuous-exceed-fully-sf
[59.168942] Starting dynamic subtest: pipe-A-eDP-1
[59.276376] Dynamic subtest pipe-A-eDP-1: SKIP (0.113s)
[59.286647] Starting dynamic subtest: pipe-B-eDP-1
[60.438908] Dynamic subtest pipe-B-eDP-1: SKIP (1.158s)
[60.443384] Subtest fbc-psr2-overlay-plane-move-continuous-exceed-fully-sf: SKIP (1.273s)
[61.628559] [003/155] (955s left) kms_big_fb (x-tiled-16bpp-rotate-90)
[61.724280] Starting subtest: x-tiled-16bpp-rotate-90
[61.744664] Subtest x-tiled-16bpp-rotate-90: SKIP (0.020s)
[61.857756] [004/155] (955s left) kms_pm_rpm (modeset-lpsp-stress-no-wait)
[63.509346] Starting subtest: modeset-lpsp-stress-no-wait
[73.819235] Subtest modeset-lpsp-stress-no-wait: SUCCESS (10.313s)
[73.891464] [005/155] (943s left) kms_flip (2x-absolute-wf_vblank)
[73.998339] Starting subtest: 2x-absolute-wf_vblank
[74.007576] Subtest 2x-absolute-wf_vblank: SKIP (0.011s)
[74.112286] [006/155] (943s left) kms_cursor_legacy (cursorb-vs-flipb-toggle)
[74.223771] Starting subtest: cursorB-vs-flipB-toggle
[74.228909] Subtest cursorB-vs-flipB-toggle: SKIP (0.001s)
[74.368616] [007/155] (943s left) kms_psr2_sf (pr-primary-plane-update-sf-dmg-area)
[74.467293] Starting subtest: pr-primary-plane-update-sf-dmg-area
[74.471862] Subtest pr-primary-plane-update-sf-dmg-area: SKIP (0.000s)
[74.531973] [008/155] (942s left) kms_flip (flip-vs-absolute-wf_vblank)
[74.619248] Starting subtest: flip-vs-absolute-wf_vblank
[74.621427] Starting dynamic subtest: A-eDP1
[83.510112] Dynamic subtest A-eDP1: SUCCESS (8.891s)
[83.519512] Starting dynamic subtest: B-eDP1
[92.444449] Dynamic subtest B-eDP1: SUCCESS (8.933s)
[92.455093] Starting dynamic subtest: C-eDP1
[101.357954] Dynamic subtest C-eDP1: SUCCESS (8.911s)
[101.366906] Starting dynamic subtest: D-eDP1
[110.286842] Dynamic subtest D-eDP1: SUCCESS (8.925s)
[110.288939] Subtest flip-vs-absolute-wf_vblank: SUCCESS (35.669s)
[111.516072] [009/155] (905s left) kms_psr (psr2-basic)
[111.620478] Starting subtest: psr2-basic
[111.622741] Starting dynamic subtest: eDP-1
[113.209038] Dynamic subtest eDP-1: SUCCESS (1.590s)
[113.211511] Subtest psr2-basic: SUCCESS (1.591s)
[114.096543] [010/155] (903s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-wc)
[114.204116] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-wc
[114.208408] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[114.293712] [011/155] (903s left) gem_busy (semaphore)
[114.484176] Subtest semaphore: SKIP (0.000s)
[114.705242] [012/155] (902s left) gem_exec_create (forked)
[114.770726] Starting subtest: forked
[114.773095] Starting dynamic subtest: smem
[136.254797] Dynamic subtest smem: SUCCESS (21.481s)
[136.258051] Subtest forked: SUCCESS (21.482s)
[136.436802] [013/155] (881s left) gem_ringfill (basic-all)
[142.269471] Starting subtest: basic-all
[143.425599] Subtest basic-all: SUCCESS (1.156s)
[143.560843] [FACT gem_ringfill (basic-all)] new: kernel.kmod_is_loaded.vgem: true
[143.564071] [014/155] (874s left) gem_mmap_offset (bad-object)
[143.607940] Starting subtest: bad-object
[143.610051] Subtest bad-object: SUCCESS (0.001s)
[143.707049] [015/155] (873s left) sysfs_heartbeat_interval (invalid)
[143.764296] Starting subtest: invalid
[143.766992] Starting dynamic subtest: vecs0
[143.769385] Dynamic subtest vecs0: SUCCESS (0.000s)
[143.778759] Starting dynamic subtest: ccs0
[143.781033] Dynamic subtest ccs0: SUCCESS (0.000s)
[143.789117] Starting dynamic subtest: vcs0
[143.791333] Dynamic subtest vcs0: SUCCESS (0.000s)
[143.799496] Starting dynamic subtest: bcs0
[143.801710] Dynamic subtest bcs0: SUCCESS (0.000s)
[143.809920] Starting dynamic subtest: rcs0
[143.811787] Dynamic subtest rcs0: SUCCESS (0.000s)
[143.820072] Starting dynamic subtest: vcs1
[143.822273] Dynamic subtest vcs1: SUCCESS (0.000s)
[143.824477] Subtest invalid: SUCCESS (0.004s)
[143.876599] [016/155] (873s left) api_intel_allocator (standalone)
[143.924786] Starting subtest: standalone
[143.939698] Subtest standalone: SUCCESS (0.018s)
[144.057022] [017/155] (873s left) kms_plane (pixel-format-y-tiled-gen12-rc-ccs-modifier)
[144.154409] Starting subtest: pixel-format-y-tiled-gen12-rc-ccs-modifier
[144.159074] Subtest pixel-format-y-tiled-gen12-rc-ccs-modifier: SKIP (0.000s)
[144.240262] [018/155] (873s left) gem_exec_whisper (basic-fds-all)
[144.305420] Starting subtest: basic-fds-all
[155.571765] Subtest basic-fds-all: SUCCESS (11.265s)
[155.769857] [019/155] (862s left) syncobj_timeline (invalid-multi-wait-all-unsubmitted-signaled)
[155.831096] Starting subtest: invalid-multi-wait-all-unsubmitted-signaled
[155.833563] Subtest invalid-multi-wait-all-unsubmitted-signaled: SUCCESS (0.000s)
[155.942095] [020/155] (861s left) kms_ccs (bad-pixel-format-y-tiled-ccs)
[156.024818] Starting subtest: bad-pixel-format-y-tiled-ccs
[156.027200] Starting dynamic subtest: pipe-A-eDP-1
[156.050254] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[156.061096] Starting dynamic subtest: pipe-B-eDP-1
[156.082452] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[156.090917] Starting dynamic subtest: pipe-C-eDP-1
[156.112761] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[156.121059] Starting dynamic subtest: pipe-D-eDP-1
[156.142067] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[156.146346] Subtest bad-pixel-format-y-tiled-ccs: SKIP (0.003s)
[158.358598] [021/155] (859s left) syncobj_wait (wait-all-for-submit-snapshot)
[158.409045] Starting subtest: wait-all-for-submit-snapshot
[158.491565] Subtest wait-all-for-submit-snapshot: SUCCESS (0.082s)
[158.569073] [022/155] (859s left) kms_vblank (wait-idle)
[158.662538] Starting subtest: wait-idle
[158.664982] Starting dynamic subtest: pipe-A-eDP-1
[160.428674] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.765s)
[160.444467] Starting dynamic subtest: pipe-D-eDP-1
[162.920611] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.490s)
[162.923089] Subtest wait-idle: SUCCESS (4.258s)
[163.740099] [023/155] (854s left) kms_psr (psr-basic)
[163.845419] Starting subtest: psr-basic
[163.847680] Starting dynamic subtest: eDP-1
[165.531789] Dynamic subtest eDP-1: SUCCESS (1.685s)
[165.534054] Subtest psr-basic: SUCCESS (1.686s)
[166.413579] [024/155] (851s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-indfb-msflip-blt)
[166.520663] Starting subtest: fbcpsr-2p-primscrn-indfb-msflip-blt
[166.524716] Subtest fbcpsr-2p-primscrn-indfb-msflip-blt: SKIP (0.000s)
[166.617727] [025/155] (851s left) kms_flip (modeset-vs-vblank-race-interruptible)
[166.720527] Starting subtest: modeset-vs-vblank-race-interruptible
[166.722873] Starting dynamic subtest: A-eDP1
[171.548109] Dynamic subtest A-eDP1: SUCCESS (4.825s)
[171.557165] Starting dynamic subtest: B-eDP1
[176.292227] Dynamic subtest B-eDP1: SUCCESS (4.742s)
[176.303138] Starting dynamic subtest: C-eDP1
[181.022370] Dynamic subtest C-eDP1: SUCCESS (4.729s)
[181.032449] Starting dynamic subtest: D-eDP1
[185.647342] Dynamic subtest D-eDP1: SUCCESS (4.624s)
[185.652227] Subtest modeset-vs-vblank-race-interruptible: SUCCESS (18.931s)
[186.806415] [026/155] (831s left) gem_softpin (evict-prime-sanity-check)
[186.862068] Starting subtest: evict-prime-sanity-check
[186.864418] Starting dynamic subtest: rcs0
[187.993318] Dynamic subtest rcs0: SUCCESS (1.131s)
[188.004854] Starting dynamic subtest: bcs0
[189.121287] Dynamic subtest bcs0: SUCCESS (1.126s)
[189.133852] Starting dynamic subtest: vcs0
[190.239738] Dynamic subtest vcs0: SUCCESS (1.117s)
[190.250353] Starting dynamic subtest: vcs1
[192.311821] Dynamic subtest vcs1: SUCCESS (2.070s)
[192.324944] Starting dynamic subtest: vecs0
[194.275279] Dynamic subtest vecs0: SUCCESS (1.962s)
[194.289613] Starting dynamic subtest: ccs0
[195.417745] Dynamic subtest ccs0: SUCCESS (1.142s)
[195.426329] Starting dynamic subtest: all
[196.530926] Dynamic subtest all: SUCCESS (1.112s)
[196.533296] Subtest evict-prime-sanity-check: SUCCESS (9.669s)
[196.615584] [027/155] (821s left) gem_softpin (evict-active-interruptible)
[196.676086] Starting subtest: evict-active-interruptible
[196.685966] Subtest evict-active-interruptible: SUCCESS (0.010s)
[196.809997] [028/155] (821s left) kms_big_fb (4-tiled-64bpp-rotate-0)
[196.909625] Starting subtest: 4-tiled-64bpp-rotate-0
[198.577874] Subtest 4-tiled-64bpp-rotate-0: SUCCESS (1.668s)
[198.742237] [029/155] (819s left) kms_frontbuffer_tracking (hdr-2p-scndscrn-pri-indfb-draw-mmap-gtt)
[198.848992] Starting subtest: hdr-2p-scndscrn-pri-indfb-draw-mmap-gtt
[198.852954] Subtest hdr-2p-scndscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[198.941187] [030/155] (819s left) syncobj_timeline (etime-multi-wait-all-available-unsubmitted-submitted-signal
[198.992170] Starting subtest: etime-multi-wait-all-available-unsubmitted-submitted-signaled
[199.094304] Subtest etime-multi-wait-all-available-unsubmitted-submitted-signaled: SUCCESS (0.101s)
[199.172099] [031/155] (819s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-primscrn-pri-indfb-draw-blt)
[199.272567] Starting subtest: fbcpsrhdr-1p-primscrn-pri-indfb-draw-blt
[199.276338] Subtest fbcpsrhdr-1p-primscrn-pri-indfb-draw-blt: SKIP (0.000s)
[199.365806] [032/155] (819s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-blt)
[199.471927] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-blt
[199.475573] Subtest psr-2p-scndscrn-pri-indfb-draw-blt: SKIP (0.000s)
[199.550996] [033/155] (818s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-16bpp-ytile-downscaling)
[199.640301] Starting subtest: flip-64bpp-ytile-to-16bpp-ytile-downscaling
[199.643634] Subtest flip-64bpp-ytile-to-16bpp-ytile-downscaling: SKIP (0.000s)
[199.723929] [034/155] (818s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-render)
[199.836065] Starting subtest: fbc-rgb101010-draw-render
[202.317487] Subtest fbc-rgb101010-draw-render: SUCCESS (2.486s)
[203.511363] [035/155] (815s left) kms_color (invalid-degamma-lut-sizes)
[203.608038] Starting subtest: invalid-degamma-lut-sizes
[203.610305] Starting dynamic subtest: pipe-A
[203.899756] Dynamic subtest pipe-A: SUCCESS (0.291s)
[203.909126] Starting dynamic subtest: pipe-B
[203.911437] Dynamic subtest pipe-B: SUCCESS (0.000s)
[203.920094] Starting dynamic subtest: pipe-C
[203.922409] Dynamic subtest pipe-C: SUCCESS (0.000s)
[203.931212] Starting dynamic subtest: pipe-D
[203.933728] Dynamic subtest pipe-D: SUCCESS (0.000s)
[203.935704] Subtest invalid-degamma-lut-sizes: SUCCESS (0.294s)
[204.729609] [036/155] (813s left) gem_exec_schedule (preempt-queue)
[204.793608] Subtest preempt-queue: SKIP (0.000s)
[205.084091] [037/155] (813s left) kms_big_fb (x-tiled-addfb-size-overflow)
[205.184577] Starting subtest: x-tiled-addfb-size-overflow
[205.186937] Subtest x-tiled-addfb-size-overflow: SUCCESS (0.000s)
[205.288167] [038/155] (813s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-move)
[205.382321] Starting subtest: psr-2p-primscrn-spr-indfb-move
[205.386371] Subtest psr-2p-primscrn-spr-indfb-move: SKIP (0.000s)
[205.481916] [039/155] (813s left) kms_draw_crc (draw-method-pwrite)
[205.581601] Starting subtest: draw-method-pwrite
[205.583719] Starting dynamic subtest: xrgb8888-untiled
[206.202740] Dynamic subtest xrgb8888-untiled: SUCCESS (0.622s)
[206.211745] Starting dynamic subtest: rgb565-untiled
[206.680819] Dynamic subtest rgb565-untiled: SUCCESS (0.477s)
[206.690089] Starting dynamic subtest: xrgb2101010-untiled
[207.258933] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.577s)
[207.268306] Starting dynamic subtest: xbgr16161616f-untiled
[208.058614] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.799s)
[208.070141] Starting dynamic subtest: xrgb8888-xtiled
[209.958465] Dynamic subtest xrgb8888-xtiled: SUCCESS (1.899s)
[209.967670] Starting dynamic subtest: rgb565-xtiled
[211.092078] Dynamic subtest rgb565-xtiled: SUCCESS (1.133s)
[211.100793] Starting dynamic subtest: xrgb2101010-xtiled
[212.958679] Dynamic subtest xrgb2101010-xtiled: SUCCESS (1.866s)
[212.967897] Starting dynamic subtest: xbgr16161616f-xtiled
[216.414684] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (3.455s)
[216.423871] Starting dynamic subtest: xrgb8888-4tiled
[217.569887] Dynamic subtest xrgb8888-4tiled: SUCCESS (1.155s)
[217.579184] Starting dynamic subtest: rgb565-4tiled
[218.158904] Dynamic subtest rgb565-4tiled: SUCCESS (0.587s)
[218.168346] Starting dynamic subtest: xrgb2101010-4tiled
[219.316597] Dynamic subtest xrgb2101010-4tiled: SUCCESS (1.155s)
[219.325233] Starting dynamic subtest: xbgr16161616f-4tiled
[222.425330] Dynamic subtest xbgr16161616f-4tiled: SUCCESS (3.110s)
[222.427709] Subtest draw-method-pwrite: SUCCESS (16.845s)
[222.543315] [040/155] (796s left) kms_flip (2x-flip-vs-dpms-on-nop)
[222.638568] Starting subtest: 2x-flip-vs-dpms-on-nop
[222.647968] Subtest 2x-flip-vs-dpms-on-nop: SKIP (0.011s)
[222.755824] [041/155] (796s left) kms_psr (fbc-psr-suspend)
[222.853093] Starting subtest: fbc-psr-suspend
[222.855356] Starting dynamic subtest: eDP-1
[222.859688] Dynamic subtest eDP-1: SKIP (0.000s)
[222.864189] Subtest fbc-psr-suspend: SKIP (0.001s)
[222.926939] [042/155] (795s left) gem_ctx_create (basic)
[222.990838] Starting subtest: basic
[222.993135] Subtest basic: SUCCESS (0.000s)
[223.172395] [043/155] (795s left) perf (rc6-disable)
[223.294639] Starting subtest: rc6-disable
[223.469050] Subtest rc6-disable: SUCCESS (0.176s)
[223.519571] [044/155] (795s left) prime_mmap (test_forked)
[223.567845] Starting subtest: test_forked
[223.569703] Starting dynamic subtest: test_forked-smem
[223.608765] Dynamic subtest test_forked-smem: SUCCESS (0.042s)
[223.611789] Subtest test_forked: SUCCESS (0.043s)
[223.703986] [045/155] (795s left) kms_frontbuffer_tracking (fbcpsr-2p-indfb-fliptrack-mmap-gtt)
[223.800791] Starting subtest: fbcpsr-2p-indfb-fliptrack-mmap-gtt
[223.805273] Subtest fbcpsr-2p-indfb-fliptrack-mmap-gtt: SKIP (0.000s)
[223.898349] [046/155] (795s left) kms_big_fb (4-tiled-16bpp-rotate-270)
[223.992957] Starting subtest: 4-tiled-16bpp-rotate-270
[224.014625] Subtest 4-tiled-16bpp-rotate-270: SKIP (0.021s)
[224.140613] [047/155] (794s left) syncobj_timeline (wait-delayed-signal)
[224.195548] Starting subtest: wait-delayed-signal
[224.295659] Subtest wait-delayed-signal: SUCCESS (0.104s)
[224.387015] [048/155] (794s left) gem_exec_balancer (bonded-chain)
[224.443311] Starting subtest: bonded-chain
[231.495099] Subtest bonded-chain: SUCCESS (7.049s)
[231.833471] [049/155] (787s left) kms_psr (fbc-psr2-suspend)
[231.932992] Starting subtest: fbc-psr2-suspend
[231.935322] Starting dynamic subtest: eDP-1
[231.939428] Dynamic subtest eDP-1: SKIP (0.000s)
[231.943612] Subtest fbc-psr2-suspend: SKIP (0.001s)
[232.008205] [050/155] (787s left) gem_pxp (hw-rejects-pxp-context)
[232.138812] Starting subtest: hw-rejects-pxp-context
[232.144042] Subtest hw-rejects-pxp-context: SKIP (0.000s)
[232.255914] [051/155] (786s left) kms_cursor_crc (cursor-sliding-128x128)
[232.457488] Starting subtest: cursor-sliding-128x128
[232.462418] Starting dynamic subtest: pipe-A-eDP-1
[235.716441] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.253s)
[235.746800] Starting dynamic subtest: pipe-D-eDP-1
[239.646816] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.906s)
[239.649065] Subtest cursor-sliding-128x128: SUCCESS (7.187s)
[240.495164] [052/155] (778s left) kms_ccs (random-ccs-data-4-tiled-lnl-ccs)
[240.589671] Starting subtest: random-ccs-data-4-tiled-lnl-ccs
[240.594235] Subtest random-ccs-data-4-tiled-lnl-ccs: SKIP (0.000s)
[241.732128] [053/155] (777s left) gem_set_tiling_vs_blt (untiled-to-tiled)
[241.792442] Subtest untiled-to-tiled: SKIP (0.000s)
[241.860774] [054/155] (777s left) kms_plane (pixel-format-4-tiled-dg2-rc-ccs-modifier-source-clamping)
[241.962734] Starting subtest: pixel-format-4-tiled-dg2-rc-ccs-modifier-source-clamping
[241.966809] Subtest pixel-format-4-tiled-dg2-rc-ccs-modifier-source-clamping: SKIP (0.000s)
[242.033622] [055/155] (777s left) gem_mmap_gtt (big-bo)
[242.095647] Subtest big-bo: SKIP (0.000s)
[242.161656] [056/155] (777s left) kms_frontbuffer_tracking (fbchdr-2p-scndscrn-pri-shrfb-draw-mmap-gtt)
[242.262184] Starting subtest: fbchdr-2p-scndscrn-pri-shrfb-draw-mmap-gtt
[242.266349] Subtest fbchdr-2p-scndscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[242.369903] [057/155] (777s left) kms_big_fb (linear-16bpp-rotate-90)
[242.475930] Starting subtest: linear-16bpp-rotate-90
[242.495572] Subtest linear-16bpp-rotate-90: SKIP (0.019s)
[242.612710] [058/155] (776s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip)
[242.723352] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip
[242.727073] Subtest yf-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip: SKIP (0.000s)
[242.822972] [059/155] (776s left) gem_exec_fence (syncobj-backward-timeline-chain-engines)
[243.390099] Starting subtest: syncobj-backward-timeline-chain-engines
[243.496270] Subtest syncobj-backward-timeline-chain-engines: SUCCESS (0.107s)
[244.378135] [060/155] (775s left) kms_cursor_legacy (single-move)
[244.505433] Starting subtest: single-move
[244.507685] Starting dynamic subtest: pipe-A
[249.888455] Dynamic subtest pipe-A: SUCCESS (5.379s)
[249.902808] Starting dynamic subtest: pipe-B
[255.271180] Dynamic subtest pipe-B: SUCCESS (5.380s)
[255.282495] Starting dynamic subtest: pipe-C
[260.653035] Dynamic subtest pipe-C: SUCCESS (5.380s)
[260.663937] Starting dynamic subtest: pipe-D
[266.035503] Dynamic subtest pipe-D: SUCCESS (5.379s)
[266.046250] Starting dynamic subtest: all-pipes
[271.423365] Dynamic subtest all-pipes: SUCCESS (5.385s)
[271.425949] Subtest single-move: SUCCESS (26.916s)
[271.570242] [061/155] (748s left) syncobj_wait (multi-wait-for-submit-signaled)
[271.629476] Starting subtest: multi-wait-for-submit-signaled
[271.631710] Subtest multi-wait-for-submit-signaled: SUCCESS (0.000s)
[271.735782] [062/155] (747s left) i915_drm_fdinfo (virtual-busy-idle)
[271.771394] Starting subtest: virtual-busy-idle
[271.775866] Subtest virtual-busy-idle: SKIP (0.000s)
[271.841412] [063/155] (747s left) api_intel_bb (intel-bb-blit-y)
[271.898392] Starting subtest: intel-bb-blit-y
[275.507612] Subtest intel-bb-blit-y: SUCCESS (3.609s)
[275.644551] [064/155] (744s left) gem_exec_balancer (nop)
[275.704740] Starting subtest: nop
[322.355190] Subtest nop: SUCCESS (46.648s)
[322.652993] [065/155] (697s left) kms_frontbuffer_tracking (psrhdr-2p-scndscrn-shrfb-pgflip-blt)
[322.754789] Starting subtest: psrhdr-2p-scndscrn-shrfb-pgflip-blt
[322.759165] Subtest psrhdr-2p-scndscrn-shrfb-pgflip-blt: SKIP (0.000s)
[322.853196] [066/155] (696s left) perf_pmu (busy)
[322.894654] Starting subtest: busy
[322.896583] Starting dynamic subtest: rcs0
[323.482574] Dynamic subtest rcs0: SUCCESS (0.589s)
[323.494545] Starting dynamic subtest: bcs0
[324.048465] Dynamic subtest bcs0: SUCCESS (0.564s)
[324.060642] Starting dynamic subtest: vcs0
[325.309062] Dynamic subtest vcs0: SUCCESS (1.259s)
[325.320855] Starting dynamic subtest: vcs1
[327.291474] Dynamic subtest vcs1: SUCCESS (1.979s)
[327.303751] Starting dynamic subtest: vecs0
[329.276417] Dynamic subtest vecs0: SUCCESS (1.982s)
[329.289066] Starting dynamic subtest: ccs0
[329.847581] Dynamic subtest ccs0: SUCCESS (0.570s)
[329.850069] Subtest busy: SUCCESS (6.955s)
[329.941160] [067/155] (689s left) kms_async_flips (alternate-sync-async-flip)
[330.035063] Starting subtest: alternate-sync-async-flip
[330.427518] Starting dynamic subtest: pipe-A-eDP-1
[333.220140] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.794s)
[333.622621] Starting dynamic subtest: pipe-B-eDP-1
[336.372844] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.758s)
[336.752980] Starting dynamic subtest: pipe-C-eDP-1
[339.505743] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.763s)
[339.881384] Starting dynamic subtest: pipe-D-eDP-1
[342.636199] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.766s)
[342.638156] Subtest alternate-sync-async-flip: SUCCESS (12.603s)
[343.812660] [068/155] (676s left) gem_userptr_blits (access-control)
[343.891557] Starting subtest: access-control
[343.895660] Subtest access-control: SKIP (0.000s)
[344.008376] [069/155] (675s left) gem_exec_schedule (u-semaphore-resolve)
[344.079522] Starting subtest: u-semaphore-resolve
[344.111753] Subtest u-semaphore-resolve: SUCCESS (0.038s)
[344.451265] [070/155] (675s left) kms_frontbuffer_tracking (psrhdr-2p-scndscrn-indfb-pgflip-blt)
[344.542761] Starting subtest: psrhdr-2p-scndscrn-indfb-pgflip-blt
[344.546828] Subtest psrhdr-2p-scndscrn-indfb-pgflip-blt: SKIP (0.000s)
[344.637687] [071/155] (675s left) kms_ccs (crc-sprite-planes-basic-4-tiled-mtl-rc-ccs)
[344.739249] Starting subtest: crc-sprite-planes-basic-4-tiled-mtl-rc-ccs
[344.741626] Starting dynamic subtest: pipe-A-eDP-1
[345.307133] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.539s)
[345.317774] Starting dynamic subtest: pipe-B-eDP-1
[346.857744] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.552s)
[346.871094] Starting dynamic subtest: pipe-C-eDP-1
[348.286863] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.426s)
[348.298617] Starting dynamic subtest: pipe-D-eDP-1
[349.736167] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.450s)
[349.738417] Subtest crc-sprite-planes-basic-4-tiled-mtl-rc-ccs: SUCCESS (4.972s)
[350.873714] [072/155] (669s left) kms_invalid_mode (bad-hsync-start)
[350.969633] Starting subtest: bad-hsync-start
[350.971774] Starting dynamic subtest: pipe-A-eDP-1
[351.260357] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.293s)
[351.269942] Starting dynamic subtest: pipe-B-eDP-1
[351.271927] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[351.280634] Starting dynamic subtest: pipe-C-eDP-1
[351.283057] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[351.292170] Starting dynamic subtest: pipe-D-eDP-1
[351.294442] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[351.296710] Subtest bad-hsync-start: SUCCESS (0.299s)
[352.093385] [073/155] (668s left) gem_watchdog (default-virtual)
[352.169580] Starting subtest: default-virtual
[358.448496] Subtest default-virtual: SUCCESS (6.287s)
[358.548345] [074/155] (661s left) prime_busy (before)
[358.607436] Starting subtest: before
[358.609306] Starting dynamic subtest: rcs0
[358.653299] Dynamic subtest rcs0: SUCCESS (0.044s)
[358.665235] Starting dynamic subtest: bcs0
[358.725601] Dynamic subtest bcs0: SUCCESS (0.070s)
[358.736621] Starting dynamic subtest: vcs0
[358.766597] Dynamic subtest vcs0: SUCCESS (0.041s)
[358.776218] Starting dynamic subtest: vcs1
[358.808071] Dynamic subtest vcs1: SUCCESS (0.041s)
[358.817234] Starting dynamic subtest: vecs0
[358.849390] Dynamic subtest vecs0: SUCCESS (0.040s)
[358.858219] Starting dynamic subtest: ccs0
[358.891581] Dynamic subtest ccs0: SUCCESS (0.041s)
[359.000726] Subtest before: SUCCESS (0.393s)
[359.075306] [075/155] (661s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-mmap-cpu)
[359.172650] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-mmap-cpu
[359.177117] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[359.271461] [076/155] (660s left) kms_frontbuffer_tracking (psrhdr-2p-primscrn-spr-indfb-draw-mmap-cpu)
[359.373068] Starting subtest: psrhdr-2p-primscrn-spr-indfb-draw-mmap-cpu
[359.377463] Subtest psrhdr-2p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[359.475795] [077/155] (660s left) i915_query (query-regions-sanity-check)
[359.530206] Starting subtest: query-regions-sanity-check
[359.540077] Subtest query-regions-sanity-check: SUCCESS (0.012s)
[359.670045] [078/155] (660s left) kms_frontbuffer_tracking (hdr-1p-primscrn-spr-indfb-draw-pwrite)
[359.777924] Starting subtest: hdr-1p-primscrn-spr-indfb-draw-pwrite
[359.782694] Subtest hdr-1p-primscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[359.866948] [079/155] (660s left) i915_pm_rps (min-max-config-idle)
[359.921896] Starting subtest: min-max-config-idle
[359.926094] Subtest min-max-config-idle: SKIP (0.001s)
[360.027063] [080/155] (660s left) kms_sequence (queue-busy)
[360.116710] Starting subtest: queue-busy
[360.118348] Starting dynamic subtest: pipe-A-eDP-1
[362.056807] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.939s)
[362.066770] Starting dynamic subtest: pipe-B-eDP-1
[364.698657] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.641s)
[364.709509] Starting dynamic subtest: pipe-C-eDP-1
[367.301275] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.601s)
[367.311799] Starting dynamic subtest: pipe-D-eDP-1
[369.948273] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.645s)
[369.950570] Subtest queue-busy: SUCCESS (9.831s)
[370.821589] [081/155] (649s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-cpu)
[370.914284] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-cpu
[370.918640] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[371.007848] [082/155] (649s left) gem_pxp (create-regular-context-2)
[371.057818] Starting subtest: create-regular-context-2
[371.060182] Subtest create-regular-context-2: SUCCESS (0.001s)
[371.157325] [083/155] (649s left) kms_cursor_edge_walk (256x256-left-edge)
[371.248477] Starting subtest: 256x256-left-edge
[371.250894] Starting dynamic subtest: pipe-A-eDP-1
[374.694410] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.446s)
[374.705704] Starting dynamic subtest: pipe-D-eDP-1
[377.911597] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.218s)
[377.913980] Subtest 256x256-left-edge: SUCCESS (6.667s)
[378.728227] [084/155] (641s left) perf (disabled-read-error)
[378.834209] Starting subtest: disabled-read-error
[378.843755] Subtest disabled-read-error: SUCCESS (0.013s)
[378.894416] [085/155] (641s left) kms_frontbuffer_tracking (psr-rgb101010-draw-render)
[378.997749] Starting subtest: psr-rgb101010-draw-render
[386.362986] Subtest psr-rgb101010-draw-render: SUCCESS (7.372s)
[386.475233] [086/155] (634s left) kms_frontbuffer_tracking (psrhdr-2p-pri-indfb-multidraw)
[386.578267] Starting subtest: psrhdr-2p-pri-indfb-multidraw
[386.582566] Subtest psrhdr-2p-pri-indfb-multidraw: SKIP (0.000s)
[386.677728] [087/155] (634s left) gem_exec_create (basic)
[386.742494] Starting subtest: basic
[386.744816] Starting dynamic subtest: smem
[390.267880] Dynamic subtest smem: SUCCESS (3.523s)
[390.270755] Subtest basic: SUCCESS (3.525s)
[390.470501] [088/155] (630s left) gem_lmem_swapping (heavy-multi)
[390.517907] Subtest heavy-multi: SKIP (0.000s)
[390.566687] [089/155] (630s left) gem_exec_reloc (basic-write-wc-noreloc)
[390.621903] Subtest basic-write-wc-noreloc: SKIP (0.000s)
[390.697435] [090/155] (630s left) kms_frontbuffer_tracking (fbcpsr-tiling-y)
[390.799134] Starting subtest: fbcpsr-tiling-y
[390.803341] Subtest fbcpsr-tiling-y: SKIP (0.000s)
[390.895767] [091/155] (629s left) kms_chamelium_frames (hdmi-frame-dump)
[391.299618] Subtest hdmi-frame-dump: SKIP (0.000s)
[392.155934] [092/155] (628s left) kms_frontbuffer_tracking (fbcpsr-1p-indfb-fliptrack-mmap-gtt)
[392.261275] Starting subtest: fbcpsr-1p-indfb-fliptrack-mmap-gtt
[392.265850] Subtest fbcpsr-1p-indfb-fliptrack-mmap-gtt: SKIP (0.000s)
[392.364801] [093/155] (628s left) kms_frontbuffer_tracking (psrhdr-1p-primscrn-cur-indfb-draw-mmap-cpu)
[392.466827] Starting subtest: psrhdr-1p-primscrn-cur-indfb-draw-mmap-cpu
[392.471122] Subtest psrhdr-1p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[392.553908] [094/155] (628s left) kms_frontbuffer_tracking (psrhdr-1p-offscreen-pri-shrfb-draw-blt)
[392.660150] Starting subtest: psrhdr-1p-offscreen-pri-shrfb-draw-blt
[392.664468] Subtest psrhdr-1p-offscreen-pri-shrfb-draw-blt: SKIP (0.000s)
[392.751282] [095/155] (628s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-180-async-flip)
[392.860103] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-180-async-flip
[392.864282] Subtest y-tiled-max-hw-stride-32bpp-rotate-180-async-flip: SKIP (0.000s)
[392.963827] [096/155] (628s left) kms_lease (lease-unleased-connector)
[393.048630] Starting subtest: lease-unleased-connector
[393.050690] Starting dynamic subtest: pipe-A-eDP-1
[393.055068] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.007s)
[393.065342] Starting dynamic subtest: pipe-B-eDP-1
[393.067273] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.009s)
[393.076596] Starting dynamic subtest: pipe-C-eDP-1
[393.078559] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.007s)
[393.087702] Starting dynamic subtest: pipe-D-eDP-1
[393.089450] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.007s)
[393.091216] Subtest lease-unleased-connector: SUCCESS (0.036s)
[393.193932] [097/155] (627s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-mmap-gtt)
[393.296688] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-mmap-gtt
[393.300231] Subtest fbc-1p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[393.412758] [098/155] (627s left) gem_mmap_gtt (big-bo-tiledx)
[393.472611] Subtest big-bo-tiledX: SKIP (0.000s)
[393.538929] [099/155] (627s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-scndscrn-pri-shrfb-draw-mmap-gtt)
[393.649084] Starting subtest: fbcpsrhdr-2p-scndscrn-pri-shrfb-draw-mmap-gtt
[393.652476] Subtest fbcpsrhdr-2p-scndscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[393.753053] [100/155] (627s left) syncobj_timeline (multi-wait-all-for-submit-available-submitted-signaled)
[393.810396] Starting subtest: multi-wait-all-for-submit-available-submitted-signaled
[393.812397] Subtest multi-wait-all-for-submit-available-submitted-signaled: SUCCESS (0.000s)
[393.922058] [101/155] (627s left) kms_pm_rpm (modeset-lpsp)
[395.442730] Starting subtest: modeset-lpsp
[396.929982] Subtest modeset-lpsp: SUCCESS (1.486s)
[397.051658] [102/155] (624s left) gem_ctx_param (invalid-size-get)
[397.107007] Starting subtest: invalid-size-get
[397.109204] Subtest invalid-size-get: SUCCESS (0.001s)
[397.207149] [103/155] (624s left) kms_frontbuffer_tracking (psr-1p-pri-indfb-multidraw)
[397.310473] Starting subtest: psr-1p-pri-indfb-multidraw
[420.672306] Subtest psr-1p-pri-indfb-multidraw: SUCCESS (23.367s)
[420.786248] [104/155] (600s left) gem_tiling_max_stride
[420.896075] [105/155] (600s left) kms_cursor_legacy (basic-busy-flip-before-cursor-legacy)
[421.010955] Starting subtest: basic-busy-flip-before-cursor-legacy
[421.014763] Subtest basic-busy-flip-before-cursor-legacy: SKIP (0.000s)
[421.155809] [106/155] (600s left) kms_ccs (crc-primary-rotation-180-4-tiled-bmg-ccs)
[421.240387] Starting subtest: crc-primary-rotation-180-4-tiled-bmg-ccs
[421.244161] Subtest crc-primary-rotation-180-4-tiled-bmg-ccs: SKIP (0.000s)
[422.348996] [107/155] (599s left) kms_atomic_transition (plane-all-modeset-transition-internal-panels)
[422.444353] Starting subtest: plane-all-modeset-transition-internal-panels
[422.446282] Starting dynamic subtest: pipe-A-eDP-1
[423.789315] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.345s)
[424.069723] Starting dynamic subtest: pipe-B-eDP-1
[425.113203] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.054s)
[425.381746] Subtest plane-all-modeset-transition-internal-panels: SUCCESS (2.938s)
[426.224182] [108/155] (595s left) gem_ctx_persistence (legacy-engines-cleanup)
[426.293058] Starting subtest: legacy-engines-cleanup
[426.294933] Starting dynamic subtest: render
[426.358730] Dynamic subtest render: SUCCESS (0.068s)
[426.371300] Starting dynamic subtest: bsd1
[426.408762] Dynamic subtest bsd1: SUCCESS (0.047s)
[426.419023] Starting dynamic subtest: bsd2
[426.461561] Dynamic subtest bsd2: SUCCESS (0.050s)
[426.472798] Starting dynamic subtest: blt
[426.509874] Dynamic subtest blt: SUCCESS (0.046s)
[426.521748] Starting dynamic subtest: vebox
[426.526843] Dynamic subtest vebox: SUCCESS (0.014s)
[426.529585] Subtest legacy-engines-cleanup: SUCCESS (0.237s)
[426.640095] [109/155] (594s left) gem_eio (hibernate)
[426.878668] Starting subtest: hibernate
[442.664251] Subtest hibernate: SUCCESS (15.785s)
[450.825285] [110/155] (578s left) kms_frontbuffer_tracking (hdr-2p-scndscrn-spr-indfb-fullscreen)
[450.934816] Starting subtest: hdr-2p-scndscrn-spr-indfb-fullscreen
[450.939115] Subtest hdr-2p-scndscrn-spr-indfb-fullscreen: SKIP (0.000s)
[451.028513] [111/155] (578s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-mmap-wc)
[451.119114] Starting subtest: psr-2p-primscrn-cur-indfb-draw-mmap-wc
[451.123268] Subtest psr-2p-primscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[451.226571] [112/155] (578s left) gem_exec_parallel (basic)
[451.306228] Starting subtest: basic
[451.308868] Starting dynamic subtest: rcs0
[452.816360] Dynamic subtest rcs0: SUCCESS (1.512s)
[452.830233] Starting dynamic subtest: bcs0
[454.296801] Dynamic subtest bcs0: SUCCESS (1.479s)
[454.309908] Starting dynamic subtest: vcs0
[456.316523] Dynamic subtest vcs0: SUCCESS (2.016s)
[456.329845] Starting dynamic subtest: vcs1
[458.298771] Dynamic subtest vcs1: SUCCESS (1.980s)
[458.310060] Starting dynamic subtest: vecs0
[460.282861] Dynamic subtest vecs0: SUCCESS (1.984s)
[460.293616] Starting dynamic subtest: ccs0
[461.786237] Dynamic subtest ccs0: SUCCESS (1.502s)
[461.788730] Subtest basic: SUCCESS (10.484s)
[461.989759] [113/155] (567s left) perf_pmu (all-busy-idle-check-all)
[462.042591] Starting subtest: all-busy-idle-check-all
[463.291707] Subtest all-busy-idle-check-all: SUCCESS (1.248s)
[463.390414] [114/155] (566s left) prime_mmap (test_refcounting)
[463.449448] Starting subtest: test_refcounting
[463.453885] Starting dynamic subtest: test_refcounting-smem
[463.480458] Dynamic subtest test_refcounting-smem: SUCCESS (0.035s)
[463.482803] Subtest test_refcounting: SUCCESS (0.036s)
[463.605478] [115/155] (566s left) kms_atomic_interruptible (legacy-dpms)
[463.710066] Starting subtest: legacy-dpms
[463.712449] Starting dynamic subtest: pipe-A-eDP-1
[471.194474] Dynamic subtest pipe-A-eDP-1: SUCCESS (7.483s)
[471.196765] Subtest legacy-dpms: SUCCESS (7.484s)
[472.019434] [116/155] (557s left) kms_big_fb (y-tiled-addfb-size-overflow)
[472.111564] Starting subtest: y-tiled-addfb-size-overflow
[472.115699] Subtest y-tiled-addfb-size-overflow: SKIP (0.000s)
[472.222832] [117/155] (557s left) kms_content_protection (lic-type-0)
[472.371550] Starting subtest: lic-type-0
[472.376066] Subtest lic-type-0: SKIP (0.000s)
[472.505453] [118/155] (557s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-primscrn-spr-indfb-move)
[472.607821] Starting subtest: fbcpsrhdr-2p-primscrn-spr-indfb-move
[472.611955] Subtest fbcpsrhdr-2p-primscrn-spr-indfb-move: SKIP (0.000s)
[472.709964] [119/155] (557s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-blt)
[472.815947] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-blt
[480.149333] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-blt: SUCCESS (7.339s)
[480.289410] [120/155] (549s left) kms_frontbuffer_tracking (hdr-2p-primscrn-pri-indfb-draw-mmap-cpu)
[480.391396] Starting subtest: hdr-2p-primscrn-pri-indfb-draw-mmap-cpu
[480.395716] Subtest hdr-2p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[480.485351] [121/155] (549s left) kms_frontbuffer_tracking (fbchdr-1p-offscreen-pri-indfb-draw-pwrite)
[480.579218] Starting subtest: fbchdr-1p-offscreen-pri-indfb-draw-pwrite
[480.583070] Subtest fbchdr-1p-offscreen-pri-indfb-draw-pwrite: SKIP (0.000s)
[480.669609] [122/155] (549s left) sw_sync (sync_expired_merge)
[480.705687] Starting subtest: sync_expired_merge
[481.780413] Subtest sync_expired_merge: SUCCESS (1.074s)
[481.866808] [123/155] (548s left) gem_ccs (suspend-resume)
[481.923054] Starting subtest: suspend-resume
[481.927606] Subtest suspend-resume: SKIP (0.000s)
[482.045542] [124/155] (548s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-indfb-draw-blt)
[482.148633] Starting subtest: fbc-1p-offscreen-pri-indfb-draw-blt
[486.263968] Subtest fbc-1p-offscreen-pri-indfb-draw-blt: SUCCESS (4.122s)
[487.449555] [125/155] (542s left) gem_exec_parallel (engines)
[487.523460] Starting subtest: engines
[487.525675] Starting dynamic subtest: basic
[489.276427] Dynamic subtest basic: SUCCESS (1.754s)
[489.289992] Starting dynamic subtest: contexts
[493.748236] Dynamic subtest contexts: SUCCESS (4.469s)
[493.759484] Starting dynamic subtest: fds
[497.563924] Dynamic subtest fds: SUCCESS (3.814s)
[497.575070] Starting dynamic subtest: userptr
[499.283210] Dynamic subtest userptr: SUCCESS (1.718s)
[499.285759] Subtest engines: SUCCESS (11.761s)
[499.479437] [126/155] (530s left) kms_frontbuffer_tracking (hdr-1p-primscrn-pri-shrfb-draw-blt)
[499.588290] Starting subtest: hdr-1p-primscrn-pri-shrfb-draw-blt
[499.592270] Subtest hdr-1p-primscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[499.698013] [127/155] (530s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-scndscrn-spr-indfb-draw-render)
[499.792095] Starting subtest: fbcpsrhdr-2p-scndscrn-spr-indfb-draw-render
[499.796660] Subtest fbcpsrhdr-2p-scndscrn-spr-indfb-draw-render: SKIP (0.000s)
[499.885326] [128/155] (530s left) gem_userptr_blits (create-destroy-sync)
[499.946720] Starting subtest: create-destroy-sync
[504.958085] Subtest create-destroy-sync: SUCCESS (5.012s)
[505.108450] [129/155] (525s left) kms_cursor_crc (cursor-onscreen-128x42)
[505.332846] Starting subtest: cursor-onscreen-128x42
[505.386990] Subtest cursor-onscreen-128x42: SKIP (0.051s)
[505.600697] [130/155] (524s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-mmap-wc)
[505.700795] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-mmap-wc
[505.705095] Subtest fbc-2p-scndscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[505.804979] [131/155] (524s left) kms_addfb_basic (invalid-get-prop)
[505.861506] Starting subtest: invalid-get-prop
[505.863687] Subtest invalid-get-prop: SUCCESS (0.000s)
[505.997749] [132/155] (524s left) prime_self_import (basic-with_one_bo)
[506.040224] Starting subtest: basic-with_one_bo
[506.066728] Subtest basic-with_one_bo: SUCCESS (0.027s)
[506.179931] [133/155] (524s left) kms_psr_stress_test (invalidate-primary-flip-overlay)
[506.267378] Starting subtest: invalidate-primary-flip-overlay
[517.090868] Subtest invalidate-primary-flip-overlay: SUCCESS (10.823s)
[517.191926] [134/155] (513s left) gem_mmap_gtt (fault-concurrent-y)
[517.242024] Subtest fault-concurrent-Y: SKIP (0.000s)
[517.300620] [135/155] (513s left) kms_psr (fbc-pr-cursor-plane-onoff)
[517.394208] Starting subtest: fbc-pr-cursor-plane-onoff
[517.397924] Subtest fbc-pr-cursor-plane-onoff: SKIP (0.000s)
[517.467512] [136/155] (513s left) kms_rotation_crc (primary-x-tiled-reflect-x-0)
[517.557042] Starting subtest: primary-x-tiled-reflect-x-0
[524.506105] Subtest primary-x-tiled-reflect-x-0: SUCCESS (6.950s)
[525.695577] [137/155] (505s left) core_setmaster (master-drop-set-shared-fd)
[525.781807] Starting subtest: master-drop-set-shared-fd
[525.799078] Subtest master-drop-set-shared-fd: SUCCESS (0.021s)
[525.842874] [138/155] (505s left) kms_pipe_crc_basic (read-crc-frame-sequence)
[525.950675] Starting subtest: read-crc-frame-sequence
[525.952809] Starting dynamic subtest: pipe-A-eDP-1
[526.655107] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.705s)
[526.667160] Starting dynamic subtest: pipe-B-eDP-1
[528.073559] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.417s)
[528.086389] Starting dynamic subtest: pipe-C-eDP-1
[529.470102] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.392s)
[529.481475] Starting dynamic subtest: pipe-D-eDP-1
[530.795032] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.324s)
[530.797367] Subtest read-crc-frame-sequence: SUCCESS (4.843s)
[531.631180] [139/155] (499s left) kms_flip (flip-vs-expired-vblank)
[531.736038] Starting subtest: flip-vs-expired-vblank
[531.738380] Starting dynamic subtest: A-eDP1
[540.418367] Dynamic subtest A-eDP1: SUCCESS (8.684s)
[540.431921] Starting dynamic subtest: B-eDP1
[549.072541] Dynamic subtest B-eDP1: SUCCESS (8.650s)
[549.089751] Starting dynamic subtest: C-eDP1
[557.788747] Dynamic subtest C-eDP1: SUCCESS (8.713s)
[557.803593] Starting dynamic subtest: D-eDP1
[566.419495] Dynamic subtest D-eDP1: SUCCESS (8.629s)
[566.425099] Subtest flip-vs-expired-vblank: SUCCESS (34.691s)
[567.597533] [140/155] (463s left) kms_chamelium_hpd (dp-hpd)
[568.005886] Subtest dp-hpd: SKIP (0.000s)
[568.804965] [141/155] (462s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-primscrn-indfb-pgflip-blt)
[568.907641] Starting subtest: fbcpsrhdr-2p-primscrn-indfb-pgflip-blt
[568.911697] Subtest fbcpsrhdr-2p-primscrn-indfb-pgflip-blt: SKIP (0.000s)
[569.005843] [142/155] (462s left) gen9_exec_parse (basic-rejected)
[569.071809] Subtest basic-rejected: SKIP (0.000s)
[569.149041] [143/155] (461s left) gem_mmap_wc (fault-concurrent)
[569.202558] Subtest fault-concurrent: SKIP (0.000s)
[569.266573] [144/155] (461s left) kms_frontbuffer_tracking (fbchdr-2p-indfb-fliptrack-mmap-gtt)
[569.373647] Starting subtest: fbchdr-2p-indfb-fliptrack-mmap-gtt
[569.377795] Subtest fbchdr-2p-indfb-fliptrack-mmap-gtt: SKIP (0.000s)
[569.488578] [145/155] (461s left) syncobj_timeline (reset-signaled)
[569.547781] Starting subtest: reset-signaled
[569.550138] Subtest reset-signaled: SUCCESS (0.000s)
[569.651921] [146/155] (461s left) kms_frontbuffer_tracking (fbchdr-2p-primscrn-pri-shrfb-draw-mmap-wc)
[569.761457] Starting subtest: fbchdr-2p-primscrn-pri-shrfb-draw-mmap-wc
[569.765017] Subtest fbchdr-2p-primscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[569.878396] [147/155] (461s left) gem_mmap (short-mmap)
[569.938628] Subtest short-mmap: SKIP (0.000s)
[569.996735] [148/155] (461s left) gem_ctx_param (invalid-set-no-zeromap)
[570.051582] Starting subtest: invalid-set-no-zeromap
[570.053612] Subtest invalid-set-no-zeromap: SUCCESS (0.000s)
[570.133752] [149/155] (461s left) perf (polling-parameterized)
[570.227379] Starting subtest: polling-parameterized
[590.245117] Subtest polling-parameterized: SUCCESS (20.015s)
[590.324299] [150/155] (441s left) kms_frontbuffer_tracking (fbchdr-2p-scndscrn-cur-indfb-onoff)
[590.424145] Starting subtest: fbchdr-2p-scndscrn-cur-indfb-onoff
[590.428253] Subtest fbchdr-2p-scndscrn-cur-indfb-onoff: SKIP (0.000s)
[590.528440] [151/155] (440s left) kms_plane_scaling (plane-upscale-factor-0-25-with-rotation)
[590.622021] Starting subtest: plane-upscale-factor-0-25-with-rotation
[590.624279] Starting dynamic subtest: pipe-A
[590.846398] Dynamic subtest pipe-A: SUCCESS (0.226s)
[590.857728] Starting dynamic subtest: pipe-B
[592.200237] Dynamic subtest pipe-B: SUCCESS (1.353s)
[592.211791] Starting dynamic subtest: pipe-C
[593.534138] Dynamic subtest pipe-C: SUCCESS (1.333s)
[593.547382] Starting dynamic subtest: pipe-D
[594.860120] Dynamic subtest pipe-D: SUCCESS (1.325s)
[594.862304] Subtest plane-upscale-factor-0-25-with-rotation: SUCCESS (4.242s)
[596.041877] [152/155] (435s left) gen9_exec_parse (valid-registers)
[596.111439] Subtest valid-registers: SKIP (0.000s)
[596.203314] [153/155] (435s left) kms_plane (plane-panning-top-left)
[596.300158] Starting subtest: plane-panning-top-left
[596.302490] Starting dynamic subtest: pipe-A
[598.027049] Dynamic subtest pipe-A: SUCCESS (1.725s)
[598.039109] Starting dynamic subtest: pipe-B
[600.481221] Dynamic subtest pipe-B: SUCCESS (2.454s)
[600.483551] Subtest plane-panning-top-left: SUCCESS (4.182s)
[601.367564] [154/155] (430s left) kms_invalid_mode (bad-vtotal)
[601.464596] Starting subtest: bad-vtotal
[601.466825] Starting dynamic subtest: pipe-A-eDP-1
[601.757326] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.295s)
[601.770922] Starting dynamic subtest: pipe-B-eDP-1
[601.773325] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[601.784249] Starting dynamic subtest: pipe-C-eDP-1
[601.786630] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[601.797328] Starting dynamic subtest: pipe-D-eDP-1
[601.799675] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[601.802054] Subtest bad-vtotal: SUCCESS (0.301s)
[602.605559] [155/155] (429s left) gem_exec_balancer (semaphore)
[602.659298] Starting subtest: semaphore
[604.277304] Subtest semaphore: SUCCESS (1.616s)
[604.595198] Closing watchdogs
results: parsing output: 0/ for test: kms_ccs
results: parsing output: 1/ for test: kms_psr2_sf
results: parsing output: 2/ for test: kms_big_fb
results: parsing output: 3/ for test: kms_pm_rpm
results: parsing output: 4/ for test: kms_flip
results: parsing output: 5/ for test: kms_cursor_legacy
results: parsing output: 6/ for test: kms_psr2_sf
results: parsing output: 7/ for test: kms_flip
results: parsing output: 8/ for test: kms_psr
results: parsing output: 9/ for test: kms_frontbuffer_tracking
results: parsing output: 10/ for test: gem_busy
results: parsing output: 11/ for test: gem_exec_create
results: parsing output: 12/ for test: gem_ringfill
results: parsing output: 13/ for test: gem_mmap_offset
results: parsing output: 14/ for test: sysfs_heartbeat_interval
results: parsing output: 15/ for test: api_intel_allocator
results: parsing output: 16/ for test: kms_plane
results: parsing output: 17/ for test: gem_exec_whisper
results: parsing output: 18/ for test: syncobj_timeline
results: parsing output: 19/ for test: kms_ccs
results: parsing output: 20/ for test: syncobj_wait
results: parsing output: 21/ for test: kms_vblank
results: parsing output: 22/ for test: kms_psr
results: parsing output: 23/ for test: kms_frontbuffer_tracking
results: parsing output: 24/ for test: kms_flip
results: parsing output: 25/ for test: gem_softpin
results: parsing output: 26/ for test: gem_softpin
results: parsing output: 27/ for test: kms_big_fb
results: parsing output: 28/ for test: kms_frontbuffer_tracking
results: parsing output: 29/ for test: syncobj_timeline
results: parsing output: 30/ for test: kms_frontbuffer_tracking
results: parsing output: 31/ for test: kms_frontbuffer_tracking
results: parsing output: 32/ for test: kms_flip_scaled_crc
results: parsing output: 33/ for test: kms_frontbuffer_tracking
results: parsing output: 34/ for test: kms_color
results: parsing output: 35/ for test: gem_exec_schedule
results: parsing output: 36/ for test: kms_big_fb
results: parsing output: 37/ for test: kms_frontbuffer_tracking
results: parsing output: 38/ for test: kms_draw_crc
results: parsing output: 39/ for test: kms_flip
results: parsing output: 40/ for test: kms_psr
results: parsing output: 41/ for test: gem_ctx_create
results: parsing output: 42/ for test: perf
results: parsing output: 43/ for test: prime_mmap
results: parsing output: 44/ for test: kms_frontbuffer_tracking
results: parsing output: 45/ for test: kms_big_fb
results: parsing output: 46/ for test: syncobj_timeline
results: parsing output: 47/ for test: gem_exec_balancer
results: parsing output: 48/ for test: kms_psr
results: parsing output: 49/ for test: gem_pxp
results: parsing output: 50/ for test: kms_cursor_crc
results: parsing output: 51/ for test: kms_ccs
results: parsing output: 52/ for test: gem_set_tiling_vs_blt
results: parsing output: 53/ for test: kms_plane
results: parsing output: 54/ for test: gem_mmap_gtt
results: parsing output: 55/ for test: kms_frontbuffer_tracking
results: parsing output: 56/ for test: kms_big_fb
results: parsing output: 57/ for test: kms_big_fb
results: parsing output: 58/ for test: gem_exec_fence
results: parsing output: 59/ for test: kms_cursor_legacy
results: parsing output: 60/ for test: syncobj_wait
results: parsing output: 61/ for test: i915_drm_fdinfo
results: parsing output: 62/ for test: api_intel_bb
results: parsing output: 63/ for test: gem_exec_balancer
results: parsing output: 64/ for test: kms_frontbuffer_tracking
results: parsing output: 65/ for test: perf_pmu
results: parsing output: 66/ for test: kms_async_flips
results: parsing output: 67/ for test: gem_userptr_blits
results: parsing output: 68/ for test: gem_exec_schedule
results: parsing output: 69/ for test: kms_frontbuffer_tracking
results: parsing output: 70/ for test: kms_ccs
results: parsing output: 71/ for test: kms_invalid_mode
results: parsing output: 72/ for test: gem_watchdog
results: parsing output: 73/ for test: prime_busy
results: parsing output: 74/ for test: kms_frontbuffer_tracking
results: parsing output: 75/ for test: kms_frontbuffer_tracking
results: parsing output: 76/ for test: i915_query
results: parsing output: 77/ for test: kms_frontbuffer_tracking
results: parsing output: 78/ for test: i915_pm_rps
results: parsing output: 79/ for test: kms_sequence
results: parsing output: 80/ for test: kms_frontbuffer_tracking
results: parsing output: 81/ for test: gem_pxp
results: parsing output: 82/ for test: kms_cursor_edge_walk
results: parsing output: 83/ for test: perf
results: parsing output: 84/ for test: kms_frontbuffer_tracking
results: parsing output: 85/ for test: kms_frontbuffer_tracking
results: parsing output: 86/ for test: gem_exec_create
results: parsing output: 87/ for test: gem_lmem_swapping
results: parsing output: 88/ for test: gem_exec_reloc
results: parsing output: 89/ for test: kms_frontbuffer_tracking
results: parsing output: 90/ for test: kms_chamelium_frames
results: parsing output: 91/ for test: kms_frontbuffer_tracking
results: parsing output: 92/ for test: kms_frontbuffer_tracking
results: parsing output: 93/ for test: kms_frontbuffer_tracking
results: parsing output: 94/ for test: kms_big_fb
results: parsing output: 95/ for test: kms_lease
results: parsing output: 96/ for test: kms_frontbuffer_tracking
results: parsing output: 97/ for test: gem_mmap_gtt
results: parsing output: 98/ for test: kms_frontbuffer_tracking
results: parsing output: 99/ for test: syncobj_timeline
results: parsing output: 100/ for test: kms_pm_rpm
results: parsing output: 101/ for test: gem_ctx_param
results: parsing output: 102/ for test: kms_frontbuffer_tracking
results: parsing output: 103/ for test: gem_tiling_max_stride
results: parsing output: 104/ for test: kms_cursor_legacy
results: parsing output: 105/ for test: kms_ccs
results: parsing output: 106/ for test: kms_atomic_transition
results: parsing output: 107/ for test: gem_ctx_persistence
results: parsing output: 108/ for test: gem_eio
results: parsing output: 109/ for test: kms_frontbuffer_tracking
results: parsing output: 110/ for test: kms_frontbuffer_tracking
results: parsing output: 111/ for test: gem_exec_parallel
results: parsing output: 112/ for test: perf_pmu
results: parsing output: 113/ for test: prime_mmap
results: parsing output: 114/ for test: kms_atomic_interruptible
results: parsing output: 115/ for test: kms_big_fb
results: parsing output: 116/ for test: kms_content_protection
results: parsing output: 117/ for test: kms_frontbuffer_tracking
results: parsing output: 118/ for test: kms_frontbuffer_tracking
results: parsing output: 119/ for test: kms_frontbuffer_tracking
results: parsing output: 120/ for test: kms_frontbuffer_tracking
results: parsing output: 121/ for test: sw_sync
results: parsing output: 122/ for test: gem_ccs
results: parsing output: 123/ for test: kms_frontbuffer_tracking
results: parsing output: 124/ for test: gem_exec_parallel
results: parsing output: 125/ for test: kms_frontbuffer_tracking
results: parsing output: 126/ for test: kms_frontbuffer_tracking
results: parsing output: 127/ for test: gem_userptr_blits
results: parsing output: 128/ for test: kms_cursor_crc
results: parsing output: 129/ for test: kms_frontbuffer_tracking
results: parsing output: 130/ for test: kms_addfb_basic
results: parsing output: 131/ for test: prime_self_import
results: parsing output: 132/ for test: kms_psr_stress_test
results: parsing output: 133/ for test: gem_mmap_gtt
results: parsing output: 134/ for test: kms_psr
results: parsing output: 135/ for test: kms_rotation_crc
results: parsing output: 136/ for test: core_setmaster
results: parsing output: 137/ for test: kms_pipe_crc_basic
results: parsing output: 138/ for test: kms_flip
results: parsing output: 139/ for test: kms_chamelium_hpd
results: parsing output: 140/ for test: kms_frontbuffer_tracking
results: parsing output: 141/ for test: gen9_exec_parse
results: parsing output: 142/ for test: gem_mmap_wc
results: parsing output: 143/ for test: kms_frontbuffer_tracking
results: parsing output: 144/ for test: syncobj_timeline
results: parsing output: 145/ for test: kms_frontbuffer_tracking
results: parsing output: 146/ for test: gem_mmap
results: parsing output: 147/ for test: gem_ctx_param
results: parsing output: 148/ for test: perf
results: parsing output: 149/ for test: kms_frontbuffer_tracking
results: parsing output: 150/ for test: kms_plane_scaling
results: parsing output: 151/ for test: gen9_exec_parse
results: parsing output: 152/ for test: kms_plane
results: parsing output: 153/ for test: kms_invalid_mode
results: parsing output: 154/ for test: gem_exec_balancer
Done.