[55.580131] Initializing watchdogs
[55.580178]   /dev/watchdog0
[55.593292] [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]
[55.597726] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[55.599846] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[55.603055] [001/131] (960s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-mmap-wc)
[55.725102] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-mmap-wc
[55.729262] Subtest fbc-2p-scndscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[55.847233] [002/131] (960s left) i915_drm_fdinfo (isolation)
[55.883591] Starting subtest: isolation
[55.885818] Starting dynamic subtest: rcs0
[55.904540] Dynamic subtest rcs0: SKIP (0.019s)
[55.910949] Starting dynamic subtest: bcs0
[55.927833] Dynamic subtest bcs0: SKIP (0.023s)
[55.935916] Starting dynamic subtest: vcs0
[55.940375] Dynamic subtest vcs0: SKIP (0.001s)
[55.950218] Starting dynamic subtest: vcs1
[55.954318] Dynamic subtest vcs1: SKIP (0.000s)
[55.960763] Starting dynamic subtest: vecs0
[55.965146] Dynamic subtest vecs0: SKIP (0.000s)
[55.971408] Starting dynamic subtest: ccs0
[55.975743] Dynamic subtest ccs0: SKIP (0.000s)
[55.980190] Subtest isolation: SKIP (0.046s)
[56.010858] [003/131] (960s left) kms_pm_rpm (modeset-lpsp)
[58.157752] Starting subtest: modeset-lpsp
[59.625481] Subtest modeset-lpsp: SUCCESS (1.486s)
[59.707263] [004/131] (956s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-fullscreen)
[59.798785] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-fullscreen
[59.803114] Subtest fbcpsr-2p-scndscrn-spr-indfb-fullscreen: SKIP (0.000s)
[59.904486] [005/131] (956s left) kms_plane_scaling (plane-upscale-factor-0-25-with-pixel-format)
[59.988309] Starting subtest: plane-upscale-factor-0-25-with-pixel-format
[59.990684] Starting dynamic subtest: pipe-A
[61.037720] Dynamic subtest pipe-A: SUCCESS (1.058s)
[61.045570] Starting dynamic subtest: pipe-B
[63.168756] Dynamic subtest pipe-B: SUCCESS (2.144s)
[63.176665] Starting dynamic subtest: pipe-C
[64.366810] Dynamic subtest pipe-C: SUCCESS (1.203s)
[64.375481] Starting dynamic subtest: pipe-D
[65.512017] Dynamic subtest pipe-D: SUCCESS (1.150s)
[65.514281] Subtest plane-upscale-factor-0-25-with-pixel-format: SUCCESS (5.557s)
[66.711706] [006/131] (949s left) kms_flip (basic-flip-vs-dpms)
[66.811602] Starting subtest: basic-flip-vs-dpms
[66.813813] Starting dynamic subtest: A-eDP1
[69.392683] Dynamic subtest A-eDP1: SUCCESS (2.587s)
[69.399598] Starting dynamic subtest: B-eDP1
[71.545953] Dynamic subtest B-eDP1: SUCCESS (2.159s)
[71.553584] Starting dynamic subtest: C-eDP1
[73.617379] Dynamic subtest C-eDP1: SUCCESS (2.073s)
[73.624881] Starting dynamic subtest: D-eDP1
[75.672559] Dynamic subtest D-eDP1: SUCCESS (2.056s)
[75.674942] Subtest basic-flip-vs-dpms: SUCCESS (8.882s)
[76.491047] [007/131] (939s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-mmap-cpu)
[76.585627] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-mmap-cpu
[76.590161] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[76.715788] [008/131] (939s left) syncobj_eventfd (invalid-illegal-handle)
[76.774098] Starting subtest: invalid-illegal-handle
[76.776081] Subtest invalid-illegal-handle: SUCCESS (0.000s)
[76.885019] [009/131] (939s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-render)
[76.980306] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-render
[76.984695] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-render: SKIP (0.000s)
[77.095509] [010/131] (939s left) sw_sync (timeline_closed)
[77.130841] Starting subtest: timeline_closed
[77.133105] Subtest timeline_closed: SUCCESS (0.000s)
[77.204758] [011/131] (939s left) kms_psr2_sf (fbc-psr2-cursor-plane-update-sf)
[82.259515] Starting subtest: fbc-psr2-cursor-plane-update-sf
[82.262062] Starting dynamic subtest: pipe-A-eDP-1
[83.067166] Dynamic subtest pipe-A-eDP-1: SKIP (0.803s)
[83.075122] Starting dynamic subtest: pipe-B-eDP-1
[84.200580] Dynamic subtest pipe-B-eDP-1: SKIP (1.132s)
[84.205011] Subtest fbc-psr2-cursor-plane-update-sf: SKIP (1.939s)
[85.386256] [012/131] (931s left) kms_flip_scaled_crc (flip-64bpp-xtile-to-32bpp-xtile-downscaling)
[85.487415] Starting subtest: flip-64bpp-xtile-to-32bpp-xtile-downscaling
[85.489653] Starting dynamic subtest: pipe-A-default-mode
[86.636061] Dynamic subtest pipe-A-default-mode: SKIP (1.147s)
[86.640536] Subtest flip-64bpp-xtile-to-32bpp-xtile-downscaling: SKIP (1.149s)
[86.802106] [013/131] (929s left) syncobj_basic (bad-flags-fd-to-handle)
[86.867222] Starting subtest: bad-flags-fd-to-handle
[86.869608] Subtest bad-flags-fd-to-handle: SUCCESS (0.000s)
[86.987833] [014/131] (929s left) gem_exec_params (mmapped)
[87.042825] Starting subtest: mmapped
[87.047504] Subtest mmapped: SUCCESS (0.003s)
[87.199370] [015/131] (929s left) kms_atomic_transition (modeset-transition-nonblocking-fencing)
[87.290784] Starting subtest: modeset-transition-nonblocking-fencing
[87.292768] Starting dynamic subtest: 1x-outputs
[98.084303] Dynamic subtest 1x-outputs: SUCCESS (10.792s)
[98.086830] Subtest modeset-transition-nonblocking-fencing: SUCCESS (10.793s)
[98.974446] [016/131] (917s left) kms_rotation_crc (primary-x-tiled-reflect-x-0)
[99.073937] Starting subtest: primary-x-tiled-reflect-x-0
[105.959197] Subtest primary-x-tiled-reflect-x-0: SUCCESS (6.885s)
[107.225297] [017/131] (909s left) kms_cursor_crc (cursor-random-512x170)
[107.495207] Starting subtest: cursor-random-512x170
[107.499741] Subtest cursor-random-512x170: SKIP (0.001s)
[107.676243] [018/131] (909s left) kms_ccs (crc-primary-suspend-4-tiled-dg2-mc-ccs)
[107.771189] Starting subtest: crc-primary-suspend-4-tiled-dg2-mc-ccs
[107.773410] Starting dynamic subtest: pipe-A-eDP-1
[107.782333] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[107.790945] Starting dynamic subtest: pipe-B-eDP-1
[107.799791] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[107.806654] Starting dynamic subtest: pipe-C-eDP-1
[107.815275] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[107.821944] Starting dynamic subtest: pipe-D-eDP-1
[107.830097] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[107.834048] Subtest crc-primary-suspend-4-tiled-dg2-mc-ccs: SKIP (0.003s)
[110.005456] [019/131] (906s left) kms_chamelium_hpd (hdmi-hpd-for-each-pipe)
[110.407728] Subtest hdmi-hpd-for-each-pipe: SKIP (0.000s)
[111.209279] [020/131] (905s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-mmap-cpu)
[111.303373] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-mmap-cpu
[111.307677] Subtest psr-2p-scndscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[111.414978] [021/131] (905s left) syncobj_wait (wait-all-complex)
[111.471835] Starting subtest: wait-all-complex
[111.684756] Subtest wait-all-complex: SUCCESS (0.212s)
[111.766379] [022/131] (905s left) gem_partial_pwrite_pread (reads)
[111.812371] Subtest reads: SKIP (0.000s)
[111.892085] [023/131] (905s left) kms_async_flips (crc)
[111.982341] Starting subtest: crc
[112.355813] Starting dynamic subtest: pipe-A-eDP-1
[115.232233] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.874s)
[115.601030] Starting dynamic subtest: pipe-B-eDP-1
[118.473520] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.878s)
[118.855067] Starting dynamic subtest: pipe-C-eDP-1
[121.790138] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.942s)
[122.150720] Starting dynamic subtest: pipe-D-eDP-1
[125.003303] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.859s)
[125.005607] Subtest crc: SUCCESS (13.021s)
[126.192078] [024/131] (890s left) gem_spin_batch (resubmit-all)
[126.243786] Starting subtest: resubmit-all
[126.246106] Starting dynamic subtest: rcs0
[126.254260] Dynamic subtest rcs0: SUCCESS (0.010s)
[126.263639] Starting dynamic subtest: bcs0
[126.266575] Dynamic subtest bcs0: SUCCESS (0.002s)
[126.276606] Starting dynamic subtest: vcs0
[126.278463] Dynamic subtest vcs0: SUCCESS (0.002s)
[126.284982] Starting dynamic subtest: vcs1
[126.286816] Dynamic subtest vcs1: SUCCESS (0.002s)
[126.293306] Starting dynamic subtest: vecs0
[126.295173] Dynamic subtest vecs0: SUCCESS (0.002s)
[126.302621] Starting dynamic subtest: ccs0
[126.304542] Dynamic subtest ccs0: SUCCESS (0.002s)
[126.306418] Subtest resubmit-all: SUCCESS (0.022s)
[127.954934] [025/131] (889s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip)
[128.060666] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip
[128.895746] Subtest x-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip: SUCCESS (0.837s)
[129.100746] [026/131] (887s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-180-hflip)
[129.205887] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-180-hflip
[130.139620] Subtest 4-tiled-max-hw-stride-32bpp-rotate-180-hflip: SUCCESS (0.933s)
[130.296747] [027/131] (886s left) kms_cursor_crc (cursor-sliding-128x42)
[130.517558] Starting subtest: cursor-sliding-128x42
[130.561273] Subtest cursor-sliding-128x42: SKIP (0.038s)
[130.783060] [028/131] (886s left) syncobj_wait (reset-unsignaled)
[130.843916] Starting subtest: reset-unsignaled
[130.845759] Subtest reset-unsignaled: SUCCESS (0.000s)
[130.961036] [029/131] (886s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-pwrite)
[131.051228] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-pwrite
[131.054837] Subtest fbc-2p-primscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[131.179943] [030/131] (886s left) kms_frontbuffer_tracking (psr-modesetfrombusy)
[131.272882] Starting subtest: psr-modesetfrombusy
[137.411068] Subtest psr-modesetfrombusy: SUCCESS (6.143s)
[137.568132] [031/131] (879s left) i915_query (query-topology-matches-eu-total)
[137.635415] Starting subtest: query-topology-matches-eu-total
[137.637289] Subtest query-topology-matches-eu-total: SUCCESS (0.000s)
[137.768027] [032/131] (879s left) kms_chamelium_edid (dp-edid-resolution-list)
[138.165802] Subtest dp-edid-resolution-list: SKIP (0.000s)
[138.935262] [033/131] (878s left) gem_lmem_swapping (parallel-random-engines)
[138.978078] Subtest parallel-random-engines: SKIP (0.000s)
[139.015547] [034/131] (878s left) kms_atomic_interruptible (legacy-setmode)
[139.099321] Starting subtest: legacy-setmode
[139.101637] Starting dynamic subtest: pipe-A-eDP-1
[145.995724] Dynamic subtest pipe-A-eDP-1: SUCCESS (6.896s)
[145.998117] Subtest legacy-setmode: SUCCESS (6.897s)
[146.888421] [035/131] (870s left) api_intel_bb (intel-bb-blit-none)
[146.948192] Starting subtest: intel-bb-blit-none
[150.676882] Subtest intel-bb-blit-none: SUCCESS (3.729s)
[150.838754] [036/131] (866s left) kms_ccs (missing-ccs-buffer-4-tiled-mtl-mc-ccs)
[150.936744] Starting subtest: missing-ccs-buffer-4-tiled-mtl-mc-ccs
[150.938791] Starting dynamic subtest: pipe-A-eDP-1
[150.958174] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.019s)
[150.966357] Starting dynamic subtest: pipe-B-eDP-1
[150.985530] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.019s)
[150.992785] Starting dynamic subtest: pipe-C-eDP-1
[151.011943] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.019s)
[151.018991] Starting dynamic subtest: pipe-D-eDP-1
[151.038840] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.019s)
[151.041101] Subtest missing-ccs-buffer-4-tiled-mtl-mc-ccs: SUCCESS (0.081s)
[153.252367] [037/131] (864s left) kms_plane_alpha_blend (alpha-transparent-fb)
[153.335962] Starting subtest: alpha-transparent-fb
[153.614652] Starting dynamic subtest: pipe-A-eDP-1
[154.227849] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.612s)
[154.235942] Starting dynamic subtest: pipe-D-eDP-1
[155.559686] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.329s)
[155.562203] Subtest alpha-transparent-fb: SUCCESS (2.224s)
[156.429194] [038/131] (861s left) kms_ccs (bad-rotation-90-4-tiled-mtl-rc-ccs)
[156.532215] Starting subtest: bad-rotation-90-4-tiled-mtl-rc-ccs
[156.534598] Starting dynamic subtest: pipe-A-eDP-1
[156.674377] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.132s)
[156.683655] Starting dynamic subtest: pipe-B-eDP-1
[156.704398] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[156.711312] Starting dynamic subtest: pipe-C-eDP-1
[156.730067] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[156.736754] Starting dynamic subtest: pipe-D-eDP-1
[156.755646] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.002s)
[156.757537] Subtest bad-rotation-90-4-tiled-mtl-rc-ccs: SUCCESS (0.141s)
[158.981870] [039/131] (858s left) gen9_exec_parse (basic-rejected-ctx-param)
[159.044183] Subtest basic-rejected-ctx-param: SKIP (0.000s)
[159.125348] [040/131] (858s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-0-async-flip)
[159.225609] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-0-async-flip
[159.229972] Subtest yf-tiled-max-hw-stride-64bpp-rotate-0-async-flip: SKIP (0.000s)
[159.333494] [041/131] (858s left) kms_writeback (writeback-pixel-formats)
[159.424279] Subtest writeback-pixel-formats: SKIP (0.000s)
[159.463803] [042/131] (858s left) kms_atomic_transition (plane-all-transition-nonblocking-fencing)
[159.567431] Starting subtest: plane-all-transition-nonblocking-fencing
[159.569804] Starting dynamic subtest: pipe-A-eDP-1
[162.063053] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.498s)
[162.386535] Starting dynamic subtest: pipe-B-eDP-1
[165.619373] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.241s)
[165.917730] Subtest plane-all-transition-nonblocking-fencing: SUCCESS (6.351s)
[166.752903] [043/131] (850s left) kms_flip (dpms-vs-vblank-race-interruptible)
[166.851477] Starting subtest: dpms-vs-vblank-race-interruptible
[166.853887] Starting dynamic subtest: A-eDP1
[170.822290] Dynamic subtest A-eDP1: SUCCESS (3.968s)
[170.831714] Starting dynamic subtest: B-eDP1
[175.454730] Dynamic subtest B-eDP1: SUCCESS (4.632s)
[175.462133] Starting dynamic subtest: C-eDP1
[180.055241] Dynamic subtest C-eDP1: SUCCESS (4.599s)
[180.064117] Starting dynamic subtest: D-eDP1
[184.599348] Dynamic subtest D-eDP1: SUCCESS (4.543s)
[184.601739] Subtest dpms-vs-vblank-race-interruptible: SUCCESS (17.750s)
[185.494423] [044/131] (832s left) syncobj_wait (wait-for-submit-snapshot)
[185.562893] Starting subtest: wait-for-submit-snapshot
[185.643271] Subtest wait-for-submit-snapshot: SUCCESS (0.081s)
[185.740794] [045/131] (832s left) gem_sync (basic-store-each)
[185.819556] Starting subtest: basic-store-each
[188.379502] Subtest basic-store-each: SUCCESS (2.572s)
[188.570955] [046/131] (829s left) kms_flip (wf_vblank-ts-check-interruptible)
[188.668851] Starting subtest: wf_vblank-ts-check-interruptible
[188.671211] Starting dynamic subtest: A-eDP1
[197.524680] Dynamic subtest A-eDP1: SUCCESS (8.855s)
[197.532821] Starting dynamic subtest: B-eDP1
[206.449955] Dynamic subtest B-eDP1: SUCCESS (8.923s)
[206.458074] Starting dynamic subtest: C-eDP1
[215.366286] Dynamic subtest C-eDP1: SUCCESS (8.915s)
[215.379530] Starting dynamic subtest: D-eDP1
[224.224033] Dynamic subtest D-eDP1: SUCCESS (8.857s)
[224.226389] Subtest wf_vblank-ts-check-interruptible: SUCCESS (35.558s)
[225.469850] [047/131] (792s left) i915_power (sanity)
[225.527692] Starting subtest: sanity
[225.532075] Subtest sanity: SKIP (0.000s)
[225.651069] [048/131] (792s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-blt)
[225.739311] Starting subtest: psr-1p-primscrn-cur-indfb-draw-blt
[232.418988] Subtest psr-1p-primscrn-cur-indfb-draw-blt: SUCCESS (6.682s)
[232.575073] [049/131] (785s left) kms_big_fb (y-tiled-16bpp-rotate-90)
[232.674598] Starting subtest: y-tiled-16bpp-rotate-90
[232.678815] Subtest y-tiled-16bpp-rotate-90: SKIP (0.000s)
[232.807757] [050/131] (785s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-blt)
[232.897063] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-blt
[237.313688] Subtest fbc-1p-primscrn-pri-indfb-draw-blt: SUCCESS (4.421s)
[238.512121] [051/131] (779s left) gem_exec_balancer (bonded-true-hang)
[238.764637] Starting subtest: bonded-true-hang
[238.770517] Subtest bonded-true-hang: SKIP (0.000s)
[238.879896] [052/131] (779s left) kms_sharpness_filter (filter-rotations)
[238.973332] Starting subtest: filter-rotations
[238.995545] Subtest filter-rotations: SKIP (0.001s)
[239.057929] [053/131] (779s left) gem_softpin (noreloc)
[239.105698] Starting subtest: noreloc
[244.516065] Subtest noreloc: SUCCESS (5.408s)
[244.682059] [054/131] (773s left) i915_hangman (gt-engine-hang)
[244.743782] Starting subtest: gt-engine-hang
[244.745988] Starting dynamic subtest: rcs0
[245.875089] Dynamic subtest rcs0: SUCCESS (1.129s)
[245.885791] Starting dynamic subtest: bcs0
[247.858982] Dynamic subtest bcs0: SUCCESS (1.981s)
[247.870065] Starting dynamic subtest: vcs0
[249.842551] Dynamic subtest vcs0: SUCCESS (1.981s)
[249.851405] Starting dynamic subtest: vcs1
[251.891255] Dynamic subtest vcs1: SUCCESS (2.045s)
[251.904567] Starting dynamic subtest: vecs0
[253.874442] Dynamic subtest vecs0: SUCCESS (1.980s)
[253.885239] Starting dynamic subtest: ccs0
[255.859711] Dynamic subtest ccs0: SUCCESS (1.983s)
[255.862717] Subtest gt-engine-hang: SUCCESS (11.116s)
[255.950425] [055/131] (762s left) prime_mmap (test_correct)
[256.014991] Starting subtest: test_correct
[256.017018] Starting dynamic subtest: test_correct-smem
[256.042905] Dynamic subtest test_correct-smem: SUCCESS (0.030s)
[256.045417] Subtest test_correct: SUCCESS (0.031s)
[256.164797] [056/131] (762s left) perf_pmu (event-wait)
[256.204590] Starting subtest: event-wait
[256.206965] Starting dynamic subtest: rcs0
[256.211404] Dynamic subtest rcs0: SKIP (0.000s)
[256.215505] Subtest event-wait: SKIP (0.001s)
[256.328295] [057/131] (761s left) kms_psr (fbc-psr-primary-mmap-cpu)
[256.424813] Starting subtest: fbc-psr-primary-mmap-cpu
[256.426819] Starting dynamic subtest: eDP-1
[256.431065] Dynamic subtest eDP-1: SKIP (0.000s)
[256.435259] Subtest fbc-psr-primary-mmap-cpu: SKIP (0.001s)
[256.506279] [058/131] (761s left) gem_exec_balancer (parallel-contexts)
[256.766250] Starting subtest: parallel-contexts
[259.244586] Subtest parallel-contexts: SUCCESS (2.478s)
[259.394842] [059/131] (758s left) gem_exec_schedule (wide)
[259.576621] Starting subtest: wide
[259.579254] Starting dynamic subtest: rcs0
[271.091776] Dynamic subtest rcs0: SUCCESS (11.515s)
[271.102586] Starting dynamic subtest: vcs0
[281.275747] Dynamic subtest vcs0: SUCCESS (10.182s)
[281.287364] Starting dynamic subtest: vcs1
[291.323989] Dynamic subtest vcs1: SUCCESS (10.046s)
[291.333875] Starting dynamic subtest: vecs0
[302.032485] Dynamic subtest vecs0: SUCCESS (10.706s)
[302.042813] Starting dynamic subtest: ccs0
[314.285581] Dynamic subtest ccs0: SUCCESS (12.251s)
[314.288090] Subtest wide: SUCCESS (54.707s)
[315.825031] [FACT gem_exec_schedule (wide)] new: kernel.kmod_is_loaded.vgem: true
[315.828372] [060/131] (702s left) gem_exec_fence (syncobj-timeline-multiple-ext-nodes)
[316.388830] Starting subtest: syncobj-timeline-multiple-ext-nodes
[316.395646] Subtest syncobj-timeline-multiple-ext-nodes: SUCCESS (0.006s)
[318.030653] [061/131] (700s left) tools_test (sysfs_l3_parity)
[318.084221] Starting subtest: sysfs_l3_parity
[318.136384] Subtest sysfs_l3_parity: SKIP (0.063s)
[318.203910] [062/131] (700s left) gem_mmap_gtt (basic-read)
[318.268099] Subtest basic-read: SKIP (0.000s)
[318.337512] [063/131] (700s left) gem_basic (create-fd-close)
[318.390443] Starting subtest: create-fd-close
[318.395018] Subtest create-fd-close: SUCCESS (0.000s)
[318.527151] [064/131] (699s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-mmap-cpu)
[318.632609] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-mmap-cpu
[318.636732] Subtest psr-2p-primscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[318.725348] [065/131] (699s left) kms_cursor_crc (cursor-dpms)
[318.855509] Starting subtest: cursor-dpms
[318.857721] Starting dynamic subtest: pipe-A-eDP-1
[321.873637] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.015s)
[321.882415] Starting dynamic subtest: pipe-D-eDP-1
[325.449658] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.573s)
[325.451688] Subtest cursor-dpms: SUCCESS (6.592s)
[326.297552] [066/131] (692s left) drm_read (short-buffer-nonblock)
[326.451301] Starting subtest: short-buffer-nonblock
[326.453723] Subtest short-buffer-nonblock: SUCCESS (0.000s)
[326.590445] [067/131] (692s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-indfb-draw-blt)
[326.683899] Starting subtest: fbc-1p-offscreen-pri-indfb-draw-blt
[330.838297] Subtest fbc-1p-offscreen-pri-indfb-draw-blt: SUCCESS (4.158s)
[331.979560] [068/131] (686s left) kms_plane_scaling (plane-downscale-factor-0-5-with-rotation)
[332.082546] Starting subtest: plane-downscale-factor-0-5-with-rotation
[332.084913] Starting dynamic subtest: pipe-A
[332.099492] Dynamic subtest pipe-A: SKIP (0.014s)
[332.107895] Starting dynamic subtest: pipe-B
[332.128559] Dynamic subtest pipe-B: SKIP (0.026s)
[332.136969] Starting dynamic subtest: pipe-C
[332.154385] Dynamic subtest pipe-C: SKIP (0.027s)
[332.162379] Starting dynamic subtest: pipe-D
[332.180180] Dynamic subtest pipe-D: SKIP (0.026s)
[332.183919] Subtest plane-downscale-factor-0-5-with-rotation: SKIP (0.096s)
[332.292069] [069/131] (686s left) gem_mmap_gtt (basic-short)
[332.348692] Subtest basic-short: SKIP (0.000s)
[332.408181] [070/131] (686s left) syncobj_timeline (invalid-multi-wait-unsubmitted)
[332.465721] Starting subtest: invalid-multi-wait-unsubmitted
[332.468012] Subtest invalid-multi-wait-unsubmitted: SUCCESS (0.000s)
[332.571432] [071/131] (686s left) gem_create (create-massive)
[332.623136] Starting subtest: create-massive
[332.625056] Subtest create-massive: SUCCESS (0.000s)
[332.829472] [072/131] (685s left) perf (gen12-invalid-class-instance)
[332.979530] Starting subtest: gen12-invalid-class-instance
[332.991344] Subtest gen12-invalid-class-instance: SUCCESS (0.010s)
[333.034270] [073/131] (685s left) gem_lmem_swapping (parallel-random)
[333.076902] Subtest parallel-random: SKIP (0.000s)
[333.122934] [074/131] (685s left) kms_invalid_mode (bad-vsync-end)
[333.212179] Starting subtest: bad-vsync-end
[333.214425] Starting dynamic subtest: pipe-A-eDP-1
[333.510939] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.296s)
[333.520141] Starting dynamic subtest: pipe-B-eDP-1
[333.522519] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[333.530158] Starting dynamic subtest: pipe-C-eDP-1
[333.532488] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[333.539660] Starting dynamic subtest: pipe-D-eDP-1
[333.541641] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[333.543594] Subtest bad-vsync-end: SUCCESS (0.302s)
[334.318875] [075/131] (684s left) syncobj_timeline (wait-any-snapshot)
[334.377273] Starting subtest: wait-any-snapshot
[334.457190] Subtest wait-any-snapshot: SUCCESS (0.081s)
[334.547225] [076/131] (684s left) syncobj_wait (multi-wait-all-signaled)
[334.610459] Starting subtest: multi-wait-all-signaled
[334.612656] Subtest multi-wait-all-signaled: SUCCESS (0.001s)
[334.735252] [077/131] (684s left) gem_exec_reloc (basic-range-active)
[334.802131] Subtest basic-range-active: SKIP (0.000s)
[334.883834] [078/131] (684s left) api_intel_bb (blit-noreloc-keep-cache)
[334.944210] Starting subtest: blit-noreloc-keep-cache
[334.955553] Subtest blit-noreloc-keep-cache: SUCCESS (0.012s)
[335.104813] [079/131] (683s left) kms_feature_discovery (chamelium)
[335.185171] Starting subtest: chamelium
[335.189639] Subtest chamelium: SKIP (0.000s)
[335.278825] [080/131] (683s left) kms_getfb (getfb2-handle-zero)
[335.376503] Starting subtest: getfb2-handle-zero
[335.378472] Subtest getfb2-handle-zero: SUCCESS (0.000s)
[335.520523] [081/131] (683s left) kms_psr (fbc-pr-no-drrs)
[335.612505] Starting subtest: fbc-pr-no-drrs
[335.616128] Subtest fbc-pr-no-drrs: SKIP (0.000s)
[335.706420] [082/131] (683s left) kms_psr2_sf (psr2-overlay-plane-update-sf-dmg-area)
[340.692297] Starting subtest: psr2-overlay-plane-update-sf-dmg-area
[340.694661] Starting dynamic subtest: pipe-A-eDP-1
[347.332949] Dynamic subtest pipe-A-eDP-1: SUCCESS (6.638s)
[347.341254] Starting dynamic subtest: pipe-B-eDP-1
[353.971453] Dynamic subtest pipe-B-eDP-1: SUCCESS (6.636s)
[353.973828] Subtest psr2-overlay-plane-update-sf-dmg-area: SUCCESS (13.279s)
[354.867802] [083/131] (664s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-mmap-wc)
[354.973980] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-mmap-wc
[361.342900] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-mmap-wc: SUCCESS (6.371s)
[361.474674] [084/131] (657s left) kms_ccs (crc-primary-rotation-180-4-tiled-dg2-rc-ccs)
[361.575540] Starting subtest: crc-primary-rotation-180-4-tiled-dg2-rc-ccs
[361.577921] Starting dynamic subtest: pipe-A-eDP-1
[361.600384] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[361.611173] Starting dynamic subtest: pipe-B-eDP-1
[361.632396] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[361.639870] Starting dynamic subtest: pipe-C-eDP-1
[361.661378] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[361.668643] Starting dynamic subtest: pipe-D-eDP-1
[361.690474] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[361.694794] Subtest crc-primary-rotation-180-4-tiled-dg2-rc-ccs: SKIP (0.006s)
[363.820430] [085/131] (655s left) kms_pwrite_crc
[365.462600] [086/131] (653s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-blt)
[365.570650] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-blt
[365.575185] Subtest fbc-2p-scndscrn-cur-indfb-draw-blt: SKIP (0.000s)
[365.692904] [087/131] (653s left) kms_psr (fbc-psr2-cursor-plane-onoff)
[365.786300] Starting subtest: fbc-psr2-cursor-plane-onoff
[365.788483] Starting dynamic subtest: eDP-1
[365.792870] Dynamic subtest eDP-1: SKIP (0.000s)
[365.797250] Subtest fbc-psr2-cursor-plane-onoff: SKIP (0.001s)
[365.868768] [088/131] (653s left) kms_atomic_interruptible (legacy-pageflip)
[365.971189] Starting subtest: legacy-pageflip
[365.973419] Starting dynamic subtest: pipe-A-eDP-1
[373.364036] Dynamic subtest pipe-A-eDP-1: SUCCESS (7.392s)
[373.366396] Subtest legacy-pageflip: SUCCESS (7.393s)
[374.196756] [089/131] (645s left) kms_pm_rpm (system-suspend-modeset)
[376.018133] Starting subtest: system-suspend-modeset
[396.054595] Subtest system-suspend-modeset: SUCCESS (4.841s)
[396.454431] [090/131] (623s left) kms_psr (psr-dpms)
[396.567436] Starting subtest: psr-dpms
[396.569782] Starting dynamic subtest: eDP-1
[399.501608] Dynamic subtest eDP-1: SUCCESS (2.983s)
[399.504067] Subtest psr-dpms: SUCCESS (2.984s)
[400.365025] [091/131] (619s left) i915_pm_rpm (system-suspend)
[402.280514] Starting subtest: system-suspend
[420.217409] Subtest system-suspend: SUCCESS (2.918s)
[420.606588] [092/131] (598s left) gem_exec_reloc (basic-wc-active)
[420.669267] Subtest basic-wc-active: SKIP (0.000s)
[420.744485] [093/131] (598s left) syncobj_wait (single-wait-all-for-submit-signaled)
[420.795575] Starting subtest: single-wait-all-for-submit-signaled
[420.797690] Subtest single-wait-all-for-submit-signaled: SUCCESS (0.000s)
[420.910403] [094/131] (598s left) kms_cursor_legacy (basic-busy-flip-before-cursor-varying-size)
[421.024747] Starting subtest: basic-busy-flip-before-cursor-varying-size
[421.028980] Subtest basic-busy-flip-before-cursor-varying-size: SKIP (0.000s)
[421.188521] [095/131] (598s left) gem_eio (throttle)
[421.404058] Starting subtest: throttle
[421.789991] Subtest throttle: SUCCESS (0.393s)
[421.953013] [096/131] (597s left) gem_exec_schedule (semaphore-noskip)
[422.032127] Starting subtest: semaphore-noskip
[422.458061] Subtest semaphore-noskip: SUCCESS (0.441s)
[422.828708] [097/131] (596s left) gem_mmap_offset (pf-nonblock)
[422.889056] Starting subtest: pf-nonblock
[422.894000] Subtest pf-nonblock: SUCCESS (0.007s)
[423.037295] [098/131] (596s left) syncobj_timeline (multi-wait-for-submit-available-unsubmitted-submitted)
[423.086905] Starting subtest: multi-wait-for-submit-available-unsubmitted-submitted
[423.089136] Subtest multi-wait-for-submit-available-unsubmitted-submitted: SUCCESS (0.000s)
[423.228989] [099/131] (596s left) kms_plane_cursor (primary)
[423.320696] Starting subtest: primary
[423.325009] Starting dynamic subtest: pipe-A-eDP-1-size-64
[425.939494] Dynamic subtest pipe-A-eDP-1-size-64: SUCCESS (2.654s)
[425.968606] Starting dynamic subtest: pipe-A-eDP-1-size-128
[428.601774] Dynamic subtest pipe-A-eDP-1-size-128: SUCCESS (2.671s)
[428.627849] Starting dynamic subtest: pipe-A-eDP-1-size-256
[431.219335] Dynamic subtest pipe-A-eDP-1-size-256: SUCCESS (2.617s)
[431.529962] Starting dynamic subtest: pipe-B-eDP-1-size-64
[434.919366] Dynamic subtest pipe-B-eDP-1-size-64: SUCCESS (3.415s)
[434.945709] Starting dynamic subtest: pipe-B-eDP-1-size-128
[437.667421] Dynamic subtest pipe-B-eDP-1-size-128: SUCCESS (2.738s)
[437.691072] Starting dynamic subtest: pipe-B-eDP-1-size-256
[440.284226] Dynamic subtest pipe-B-eDP-1-size-256: SUCCESS (2.604s)
[440.606079] Starting dynamic subtest: pipe-C-eDP-1-size-64
[443.550145] Dynamic subtest pipe-C-eDP-1-size-64: SUCCESS (2.956s)
[443.574416] Starting dynamic subtest: pipe-C-eDP-1-size-128
[445.723589] Dynamic subtest pipe-C-eDP-1-size-128: SUCCESS (2.157s)
[445.750418] Starting dynamic subtest: pipe-C-eDP-1-size-256
[447.964448] Dynamic subtest pipe-C-eDP-1-size-256: SUCCESS (2.224s)
[448.289478] Starting dynamic subtest: pipe-D-eDP-1-size-64
[451.245431] Dynamic subtest pipe-D-eDP-1-size-64: SUCCESS (2.968s)
[451.276253] Starting dynamic subtest: pipe-D-eDP-1-size-128
[453.419988] Dynamic subtest pipe-D-eDP-1-size-128: SUCCESS (2.157s)
[453.446205] Starting dynamic subtest: pipe-D-eDP-1-size-256
[455.522572] Dynamic subtest pipe-D-eDP-1-size-256: SUCCESS (2.081s)
[455.831637] Subtest primary: SUCCESS (32.639s)
[456.718432] [100/131] (563s left) prime_vgem (busy)
[456.790339] Starting subtest: busy
[456.792436] Starting dynamic subtest: rcs0
[456.856876] Dynamic subtest rcs0: SUCCESS (0.068s)
[456.870781] Starting dynamic subtest: bcs0
[456.923761] Dynamic subtest bcs0: SUCCESS (0.065s)
[456.933141] Starting dynamic subtest: vcs0
[456.970644] Dynamic subtest vcs0: SUCCESS (0.046s)
[456.980573] Starting dynamic subtest: vcs1
[457.017551] Dynamic subtest vcs1: SUCCESS (0.046s)
[457.026921] Starting dynamic subtest: vecs0
[457.063181] Dynamic subtest vecs0: SUCCESS (0.045s)
[457.072713] Starting dynamic subtest: ccs0
[457.109060] Dynamic subtest ccs0: SUCCESS (0.045s)
[457.111286] Subtest busy: SUCCESS (0.321s)
[457.277931] [101/131] (562s left) gem_softpin (evict-active)
[457.347233] Starting subtest: evict-active
[457.355170] Subtest evict-active: SUCCESS (0.008s)
[457.496229] [102/131] (562s left) kms_vblank (wait-busy)
[457.603861] Starting subtest: wait-busy
[457.606101] Starting dynamic subtest: pipe-A-eDP-1
[459.489360] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.886s)
[459.505934] Starting dynamic subtest: pipe-D-eDP-1
[462.085881] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.591s)
[462.088281] Subtest wait-busy: SUCCESS (4.480s)
[462.897092] [103/131] (557s left) gem_mmap_gtt (isolation)
[462.961311] Subtest isolation: SKIP (0.000s)
[463.024837] [104/131] (557s left) kms_lease (possible-crtcs-filtering)
[463.128859] Starting subtest: possible-crtcs-filtering
[463.133691] Subtest possible-crtcs-filtering: SUCCESS (0.006s)
[463.248392] [105/131] (556s left) syncobj_timeline (invalid-signal-bad-pad)
[463.306444] Starting subtest: invalid-signal-bad-pad
[463.308746] Subtest invalid-signal-bad-pad: SUCCESS (0.000s)
[463.450136] [106/131] (556s left) kms_flip_scaled_crc (flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling)
[463.546876] Starting subtest: flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling
[463.549185] Starting dynamic subtest: pipe-A-default-mode
[463.857848] Dynamic subtest pipe-A-default-mode: SKIP (0.309s)
[463.862703] Subtest flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling: SKIP (0.310s)
[464.727030] [107/131] (555s left) sysfs_defaults (readonly)
[464.786550] Starting subtest: readonly
[464.788852] Starting dynamic subtest: vecs0
[464.791281] Dynamic subtest vecs0: SUCCESS (0.000s)
[464.800937] Starting dynamic subtest: ccs0
[464.803180] Dynamic subtest ccs0: SUCCESS (0.000s)
[464.812348] Starting dynamic subtest: vcs0
[464.814689] Dynamic subtest vcs0: SUCCESS (0.000s)
[464.823516] Starting dynamic subtest: bcs0
[464.825727] Dynamic subtest bcs0: SUCCESS (0.000s)
[464.834176] Starting dynamic subtest: rcs0
[464.836275] Dynamic subtest rcs0: SUCCESS (0.000s)
[464.844647] Starting dynamic subtest: vcs1
[464.846800] Dynamic subtest vcs1: SUCCESS (0.000s)
[464.848629] Subtest readonly: SUCCESS (0.005s)
[464.929932] [108/131] (555s left) kms_psr (psr2-primary-blt)
[465.031686] Starting subtest: psr2-primary-blt
[465.034001] Starting dynamic subtest: eDP-1
[466.723796] Dynamic subtest eDP-1: SUCCESS (1.691s)
[466.726250] Subtest psr2-primary-blt: SUCCESS (1.693s)
[467.608510] [109/131] (552s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-blt)
[467.710757] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-blt
[474.887648] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-blt: SUCCESS (7.177s)
[475.076752] [110/131] (545s left) gem_ctx_persistence (many-contexts)
[475.136369] Starting subtest: many-contexts
[520.345445] Subtest many-contexts: SUCCESS (45.218s)
[520.441483] [111/131] (499s left) kms_color (degamma)
[520.540527] Starting subtest: degamma
[520.542738] Starting dynamic subtest: pipe-A-eDP-1
[521.234506] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.693s)
[521.244878] Starting dynamic subtest: pipe-B-eDP-1
[522.609058] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.374s)
[522.618733] Starting dynamic subtest: pipe-C-eDP-1
[523.986299] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.377s)
[523.996445] Starting dynamic subtest: pipe-D-eDP-1
[525.346832] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.359s)
[525.349329] Subtest degamma: SUCCESS (4.806s)
[526.161559] [112/131] (494s left) gem_pipe_control_store_loop (fresh-buffer)
[526.224270] Starting subtest: fresh-buffer
[528.377784] Subtest fresh-buffer: SUCCESS (2.151s)
[528.538608] [113/131] (491s left) kms_ccs (random-ccs-data-y-tiled-ccs)
[528.625797] Starting subtest: random-ccs-data-y-tiled-ccs
[528.628081] Starting dynamic subtest: pipe-A-eDP-1
[528.652803] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[528.664621] Starting dynamic subtest: pipe-B-eDP-1
[528.687667] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[528.697185] Starting dynamic subtest: pipe-C-eDP-1
[528.721635] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[528.733023] Starting dynamic subtest: pipe-D-eDP-1
[528.757480] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[528.761707] Subtest random-ccs-data-y-tiled-ccs: SKIP (0.005s)
[530.846601] [114/131] (489s left) gem_ctx_param (vm)
[530.905348] Starting subtest: vm
[530.944423] Subtest vm: SUCCESS (0.039s)
[531.110675] [115/131] (489s left) kms_flip (2x-absolute-wf_vblank)
[531.208826] Starting subtest: 2x-absolute-wf_vblank
[531.217178] Subtest 2x-absolute-wf_vblank: SKIP (0.010s)
[531.349335] [116/131] (489s left) gem_ccs (block-copy-compressed)
[531.410739] Starting subtest: block-copy-compressed
[531.414780] Subtest block-copy-compressed: SKIP (0.000s)
[531.541778] [117/131] (489s left) kms_rotation_crc (multiplane-rotation-cropping-top)
[531.640038] Starting subtest: multiplane-rotation-cropping-top
[538.831569] Subtest multiplane-rotation-cropping-top: SUCCESS (7.193s)
[538.971600] [118/131] (481s left) prime_self_import (basic-llseek-bad)
[539.006144] Starting subtest: basic-llseek-bad
[539.025638] Subtest basic-llseek-bad: SUCCESS (0.020s)
[539.165900] [119/131] (481s left) core_getversion (all-cards)
[539.198698] Starting subtest: all-cards
[539.206700] Subtest all-cards: SUCCESS (0.011s)
[539.243043] [120/131] (481s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-180-async-flip)
[539.336205] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-180-async-flip
[540.138814] Subtest 4-tiled-max-hw-stride-64bpp-rotate-180-async-flip: SUCCESS (0.803s)
[540.355632] [121/131] (480s left) gem_ringfill (basic-all)
[546.207755] Starting subtest: basic-all
[547.373912] Subtest basic-all: SUCCESS (1.166s)
[547.539736] [122/131] (473s left) kms_big_fb (linear-max-hw-stride-32bpp-rotate-180)
[547.645242] Starting subtest: linear-max-hw-stride-32bpp-rotate-180
[548.690084] Subtest linear-max-hw-stride-32bpp-rotate-180: SUCCESS (1.046s)
[548.834670] [123/131] (472s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-180-async-flip)
[548.937818] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-180-async-flip
[548.941274] Subtest y-tiled-max-hw-stride-64bpp-rotate-180-async-flip: SKIP (0.000s)
[549.068830] [124/131] (471s left) gem_pxp (verify-pxp-stale-buf-execution)
[549.186962] Starting subtest: verify-pxp-stale-buf-execution
[550.243453] Subtest verify-pxp-stale-buf-execution: SUCCESS (1.057s)
[550.391906] [125/131] (470s left) gem_sync (basic-each)
[550.468504] Starting subtest: basic-each
[553.142716] Subtest basic-each: SUCCESS (2.684s)
[553.351424] [126/131] (467s left) gem_render_copy_redux (flink)
[553.409932] Starting subtest: flink
[554.592134] Subtest flink: SUCCESS (1.182s)
[554.753855] [127/131] (466s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-mmap-wc)
[554.853454] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-mmap-wc
[554.856979] Subtest fbc-2p-primscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[554.980956] [128/131] (466s left) gem_spin_batch (user-each)
[555.035418] Starting subtest: user-each
[558.307512] Subtest user-each: SUCCESS (3.265s)
[560.271550] [129/131] (460s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-blt)
[560.377992] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-blt
[567.197939] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-blt: SUCCESS (6.822s)
[567.372722] [130/131] (453s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-mmap-wc)
[567.472038] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-mmap-wc
[574.352066] Subtest psr-1p-primscrn-pri-shrfb-draw-mmap-wc: SUCCESS (6.882s)
[574.491247] [131/131] (446s left) gem_exec_schedule (independent)
[574.565651] Starting subtest: independent
[574.567652] Starting dynamic subtest: rcs0
[576.156342] Dynamic subtest rcs0: SUCCESS (1.599s)
[576.168997] Starting dynamic subtest: vcs0
[578.242075] Dynamic subtest vcs0: SUCCESS (2.084s)
[578.253293] Starting dynamic subtest: vcs1
[580.229428] Dynamic subtest vcs1: SUCCESS (1.986s)
[580.242476] Starting dynamic subtest: vecs0
[582.190560] Dynamic subtest vecs0: SUCCESS (1.958s)
[582.202808] Starting dynamic subtest: ccs0
[584.220469] Dynamic subtest ccs0: SUCCESS (2.028s)
[584.223494] Subtest independent: SUCCESS (9.666s)
[584.534461] Closing watchdogs
results: parsing output: 0/ for test: kms_frontbuffer_tracking
results: parsing output: 1/ for test: i915_drm_fdinfo
results: parsing output: 2/ for test: kms_pm_rpm
results: parsing output: 3/ for test: kms_frontbuffer_tracking
results: parsing output: 4/ for test: kms_plane_scaling
results: parsing output: 5/ for test: kms_flip
results: parsing output: 6/ for test: kms_frontbuffer_tracking
results: parsing output: 7/ for test: syncobj_eventfd
results: parsing output: 8/ for test: kms_frontbuffer_tracking
results: parsing output: 9/ for test: sw_sync
results: parsing output: 10/ for test: kms_psr2_sf
results: parsing output: 11/ for test: kms_flip_scaled_crc
results: parsing output: 12/ for test: syncobj_basic
results: parsing output: 13/ for test: gem_exec_params
results: parsing output: 14/ for test: kms_atomic_transition
results: parsing output: 15/ for test: kms_rotation_crc
results: parsing output: 16/ for test: kms_cursor_crc
results: parsing output: 17/ for test: kms_ccs
results: parsing output: 18/ for test: kms_chamelium_hpd
results: parsing output: 19/ for test: kms_frontbuffer_tracking
results: parsing output: 20/ for test: syncobj_wait
results: parsing output: 21/ for test: gem_partial_pwrite_pread
results: parsing output: 22/ for test: kms_async_flips
results: parsing output: 23/ for test: gem_spin_batch
results: parsing output: 24/ for test: kms_big_fb
results: parsing output: 25/ for test: kms_big_fb
results: parsing output: 26/ for test: kms_cursor_crc
results: parsing output: 27/ for test: syncobj_wait
results: parsing output: 28/ for test: kms_frontbuffer_tracking
results: parsing output: 29/ for test: kms_frontbuffer_tracking
results: parsing output: 30/ for test: i915_query
results: parsing output: 31/ for test: kms_chamelium_edid
results: parsing output: 32/ for test: gem_lmem_swapping
results: parsing output: 33/ for test: kms_atomic_interruptible
results: parsing output: 34/ for test: api_intel_bb
results: parsing output: 35/ for test: kms_ccs
results: parsing output: 36/ for test: kms_plane_alpha_blend
results: parsing output: 37/ for test: kms_ccs
results: parsing output: 38/ for test: gen9_exec_parse
results: parsing output: 39/ for test: kms_big_fb
results: parsing output: 40/ for test: kms_writeback
results: parsing output: 41/ for test: kms_atomic_transition
results: parsing output: 42/ for test: kms_flip
results: parsing output: 43/ for test: syncobj_wait
results: parsing output: 44/ for test: gem_sync
results: parsing output: 45/ for test: kms_flip
results: parsing output: 46/ for test: i915_power
results: parsing output: 47/ for test: kms_frontbuffer_tracking
results: parsing output: 48/ for test: kms_big_fb
results: parsing output: 49/ for test: kms_frontbuffer_tracking
results: parsing output: 50/ for test: gem_exec_balancer
results: parsing output: 51/ for test: kms_sharpness_filter
results: parsing output: 52/ for test: gem_softpin
results: parsing output: 53/ for test: i915_hangman
results: parsing output: 54/ for test: prime_mmap
results: parsing output: 55/ for test: perf_pmu
results: parsing output: 56/ for test: kms_psr
results: parsing output: 57/ for test: gem_exec_balancer
results: parsing output: 58/ for test: gem_exec_schedule
results: parsing output: 59/ for test: gem_exec_fence
results: parsing output: 60/ for test: tools_test
results: parsing output: 61/ for test: gem_mmap_gtt
results: parsing output: 62/ for test: gem_basic
results: parsing output: 63/ for test: kms_frontbuffer_tracking
results: parsing output: 64/ for test: kms_cursor_crc
results: parsing output: 65/ for test: drm_read
results: parsing output: 66/ for test: kms_frontbuffer_tracking
results: parsing output: 67/ for test: kms_plane_scaling
results: parsing output: 68/ for test: gem_mmap_gtt
results: parsing output: 69/ for test: syncobj_timeline
results: parsing output: 70/ for test: gem_create
results: parsing output: 71/ for test: perf
results: parsing output: 72/ for test: gem_lmem_swapping
results: parsing output: 73/ for test: kms_invalid_mode
results: parsing output: 74/ for test: syncobj_timeline
results: parsing output: 75/ for test: syncobj_wait
results: parsing output: 76/ for test: gem_exec_reloc
results: parsing output: 77/ for test: api_intel_bb
results: parsing output: 78/ for test: kms_feature_discovery
results: parsing output: 79/ for test: kms_getfb
results: parsing output: 80/ for test: kms_psr
results: parsing output: 81/ for test: kms_psr2_sf
results: parsing output: 82/ for test: kms_frontbuffer_tracking
results: parsing output: 83/ for test: kms_ccs
results: parsing output: 84/ for test: kms_pwrite_crc
results: parsing output: 85/ for test: kms_frontbuffer_tracking
results: parsing output: 86/ for test: kms_psr
results: parsing output: 87/ for test: kms_atomic_interruptible
results: parsing output: 88/ for test: kms_pm_rpm
results: parsing output: 89/ for test: kms_psr
results: parsing output: 90/ for test: i915_pm_rpm
results: parsing output: 91/ for test: gem_exec_reloc
results: parsing output: 92/ for test: syncobj_wait
results: parsing output: 93/ for test: kms_cursor_legacy
results: parsing output: 94/ for test: gem_eio
results: parsing output: 95/ for test: gem_exec_schedule
results: parsing output: 96/ for test: gem_mmap_offset
results: parsing output: 97/ for test: syncobj_timeline
results: parsing output: 98/ for test: kms_plane_cursor
results: parsing output: 99/ for test: prime_vgem
results: parsing output: 100/ for test: gem_softpin
results: parsing output: 101/ for test: kms_vblank
results: parsing output: 102/ for test: gem_mmap_gtt
results: parsing output: 103/ for test: kms_lease
results: parsing output: 104/ for test: syncobj_timeline
results: parsing output: 105/ for test: kms_flip_scaled_crc
results: parsing output: 106/ for test: sysfs_defaults
results: parsing output: 107/ for test: kms_psr
results: parsing output: 108/ for test: kms_frontbuffer_tracking
results: parsing output: 109/ for test: gem_ctx_persistence
results: parsing output: 110/ for test: kms_color
results: parsing output: 111/ for test: gem_pipe_control_store_loop
results: parsing output: 112/ for test: kms_ccs
results: parsing output: 113/ for test: gem_ctx_param
results: parsing output: 114/ for test: kms_flip
results: parsing output: 115/ for test: gem_ccs
results: parsing output: 116/ for test: kms_rotation_crc
results: parsing output: 117/ for test: prime_self_import
results: parsing output: 118/ for test: core_getversion
results: parsing output: 119/ for test: kms_big_fb
results: parsing output: 120/ for test: gem_ringfill
results: parsing output: 121/ for test: kms_big_fb
results: parsing output: 122/ for test: kms_big_fb
results: parsing output: 123/ for test: gem_pxp
results: parsing output: 124/ for test: gem_sync
results: parsing output: 125/ for test: gem_render_copy_redux
results: parsing output: 126/ for test: kms_frontbuffer_tracking
results: parsing output: 127/ for test: gem_spin_batch
results: parsing output: 128/ for test: kms_frontbuffer_tracking
results: parsing output: 129/ for test: kms_frontbuffer_tracking
results: parsing output: 130/ for test: gem_exec_schedule
Done.