[59.200503] Initializing watchdogs
[59.200597]   /dev/watchdog0
[59.216322] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:7d55 Intel Meteorlake (Gen12) Meteor Lake-P [Intel Arc Graphics]
[59.220708] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[59.223065] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[59.226412] [001/155] (960s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-pri-indfb-multidraw)
[59.370049] Starting subtest: fbcpsrhdr-1p-pri-indfb-multidraw
[59.374336] Subtest fbcpsrhdr-1p-pri-indfb-multidraw: SKIP (0.000s)
[59.454375] [002/155] (960s left) gem_exec_fence (submit)
[59.640590] Starting subtest: submit
[59.645805] Subtest submit: SKIP (0.000s)
[61.401262] [FACT gem_exec_fence (submit)] new: kernel.kmod_is_loaded.vgem: true
[61.405558] [003/155] (958s left) kms_psr2_sf (psr2-cursor-plane-update-sf)
[61.515085] Starting subtest: psr2-cursor-plane-update-sf
[61.517408] Starting dynamic subtest: pipe-A-eDP-1
[62.859719] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.347s)
[62.870635] Starting dynamic subtest: pipe-B-eDP-1
[63.710296] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.853s)
[63.712704] Subtest psr2-cursor-plane-update-sf: SUCCESS (2.204s)
[64.575041] [004/155] (955s left) kms_frontbuffer_tracking (fbchdr-2p-primscrn-pri-shrfb-draw-pwrite)
[64.688390] Starting subtest: fbchdr-2p-primscrn-pri-shrfb-draw-pwrite
[64.692670] Subtest fbchdr-2p-primscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[64.785420] [005/155] (955s left) kms_ccs (bad-rotation-90-4-tiled-dg2-mc-ccs)
[64.871809] Starting subtest: bad-rotation-90-4-tiled-dg2-mc-ccs
[64.874113] Starting dynamic subtest: pipe-A-eDP-1
[64.896666] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[64.905085] Starting dynamic subtest: pipe-B-eDP-1
[64.927248] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[64.935182] Starting dynamic subtest: pipe-C-eDP-1
[64.956805] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[64.964865] Starting dynamic subtest: pipe-D-eDP-1
[64.987084] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[64.991245] Subtest bad-rotation-90-4-tiled-dg2-mc-ccs: SKIP (0.003s)
[67.130337] [006/155] (952s left) gem_exec_params (invalid-bsd-ring)
[67.179795] Starting subtest: invalid-bsd-ring
[67.182188] Subtest invalid-bsd-ring: SUCCESS (0.000s)
[67.275557] [007/155] (952s left) kms_feature_discovery (dp-mst)
[67.361772] Starting subtest: dp-mst
[67.366734] Subtest dp-mst: SKIP (0.000s)
[67.433502] [008/155] (952s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-primscrn-cur-indfb-draw-mmap-wc)
[67.532095] Starting subtest: fbcpsrhdr-2p-primscrn-cur-indfb-draw-mmap-wc
[67.536114] Subtest fbcpsrhdr-2p-primscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[67.622700] [009/155] (952s left) kms_frontbuffer_tracking (psrhdr-1p-primscrn-shrfb-pgflip-blt)
[67.717777] Starting subtest: psrhdr-1p-primscrn-shrfb-pgflip-blt
[67.721866] Subtest psrhdr-1p-primscrn-shrfb-pgflip-blt: SKIP (0.000s)
[67.807961] [010/155] (952s left) gem_mmap_wc (bad-object)
[67.867469] Subtest bad-object: SKIP (0.000s)
[67.928243] [011/155] (952s left) gem_exec_reloc (basic-cpu-gtt-noreloc)
[67.983770] Subtest basic-cpu-gtt-noreloc: SKIP (0.000s)
[68.052485] [012/155] (952s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-mmap-cpu)
[68.149491] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-mmap-cpu
[75.322451] Subtest psr-1p-primscrn-pri-shrfb-draw-mmap-cpu: SUCCESS (7.182s)
[75.437982] [013/155] (944s left) gem_exec_schedule (wide)
[75.622451] Starting subtest: wide
[75.629234] Starting dynamic subtest: rcs0
[85.696247] Dynamic subtest rcs0: SUCCESS (10.076s)
[85.711998] Starting dynamic subtest: vcs0
[96.835354] Dynamic subtest vcs0: SUCCESS (11.141s)
[96.850877] Starting dynamic subtest: vcs1
[106.610159] Dynamic subtest vcs1: SUCCESS (9.775s)
[106.619068] Starting dynamic subtest: vecs0
[118.233262] Dynamic subtest vecs0: SUCCESS (11.624s)
[118.242560] Starting dynamic subtest: ccs0
[130.495061] Dynamic subtest ccs0: SUCCESS (12.260s)
[130.497634] Subtest wide: SUCCESS (54.878s)
[132.726219] [014/155] (887s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-blt)
[132.827353] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-blt
[132.831641] Subtest psr-2p-scndscrn-pri-indfb-draw-blt: SKIP (0.000s)
[132.932417] [015/155] (887s left) gem_vm_create (invalid-create)
[132.999679] Starting subtest: invalid-create
[133.002166] Subtest invalid-create: SUCCESS (0.002s)
[133.115850] [016/155] (887s left) kms_plane_cursor (primary)
[133.211491] Starting subtest: primary
[133.215867] Starting dynamic subtest: pipe-A-eDP-1-size-64
[135.798549] Dynamic subtest pipe-A-eDP-1-size-64: SUCCESS (2.588s)
[135.823711] Starting dynamic subtest: pipe-A-eDP-1-size-128
[138.400549] Dynamic subtest pipe-A-eDP-1-size-128: SUCCESS (2.585s)
[138.423066] Starting dynamic subtest: pipe-A-eDP-1-size-256
[141.000664] Dynamic subtest pipe-A-eDP-1-size-256: SUCCESS (2.583s)
[141.317485] Starting dynamic subtest: pipe-B-eDP-1-size-64
[144.671215] Dynamic subtest pipe-B-eDP-1-size-64: SUCCESS (3.363s)
[144.694975] Starting dynamic subtest: pipe-B-eDP-1-size-128
[147.273190] Dynamic subtest pipe-B-eDP-1-size-128: SUCCESS (2.583s)
[147.298078] Starting dynamic subtest: pipe-B-eDP-1-size-256
[149.873609] Dynamic subtest pipe-B-eDP-1-size-256: SUCCESS (2.584s)
[150.190779] Starting dynamic subtest: pipe-C-eDP-1-size-64
[153.121464] Dynamic subtest pipe-C-eDP-1-size-64: SUCCESS (2.942s)
[153.147470] Starting dynamic subtest: pipe-C-eDP-1-size-128
[155.399384] Dynamic subtest pipe-C-eDP-1-size-128: SUCCESS (2.259s)
[155.424972] Starting dynamic subtest: pipe-C-eDP-1-size-256
[157.632421] Dynamic subtest pipe-C-eDP-1-size-256: SUCCESS (2.214s)
[157.954061] Starting dynamic subtest: pipe-D-eDP-1-size-64
[160.975911] Dynamic subtest pipe-D-eDP-1-size-64: SUCCESS (3.034s)
[161.002936] Starting dynamic subtest: pipe-D-eDP-1-size-128
[163.209284] Dynamic subtest pipe-D-eDP-1-size-128: SUCCESS (2.213s)
[163.235954] Starting dynamic subtest: pipe-D-eDP-1-size-256
[165.454219] Dynamic subtest pipe-D-eDP-1-size-256: SUCCESS (2.226s)
[165.762871] Subtest primary: SUCCESS (32.550s)
[166.671578] [017/155] (853s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-render)
[166.772862] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-render
[166.777093] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-render: SKIP (0.000s)
[166.866477] [018/155] (853s left) kms_frontbuffer_tracking (fbc-rgb565-draw-mmap-wc)
[166.975735] Starting subtest: fbc-rgb565-draw-mmap-wc
[170.987660] Subtest fbc-rgb565-draw-mmap-wc: SUCCESS (4.017s)
[172.188602] [019/155] (848s left) kms_frontbuffer_tracking (psrhdr-2p-scndscrn-cur-indfb-onoff)
[172.291748] Starting subtest: psrhdr-2p-scndscrn-cur-indfb-onoff
[172.296120] Subtest psrhdr-2p-scndscrn-cur-indfb-onoff: SKIP (0.000s)
[172.394562] [020/155] (848s left) i915_hangman (error-state-basic)
[172.451226] Starting subtest: error-state-basic
[172.610417] Subtest error-state-basic: SUCCESS (0.160s)
[172.691954] [021/155] (847s left) kms_cursor_edge_walk (256x256-top-edge)
[172.779139] Starting subtest: 256x256-top-edge
[172.781375] Starting dynamic subtest: pipe-A-eDP-1
[176.220371] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.442s)
[176.230099] Starting dynamic subtest: pipe-D-eDP-1
[179.363009] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.140s)
[179.365255] Subtest 256x256-top-edge: SUCCESS (6.585s)
[180.176634] [022/155] (840s left) kms_flip (2x-flip-vs-blocking-wf-vblank)
[180.266420] Starting subtest: 2x-flip-vs-blocking-wf-vblank
[180.275945] Subtest 2x-flip-vs-blocking-wf-vblank: SKIP (0.011s)
[180.366377] [023/155] (840s left) kms_big_fb (linear-8bpp-rotate-90)
[180.466832] Starting subtest: linear-8bpp-rotate-90
[180.487779] Subtest linear-8bpp-rotate-90: SKIP (0.020s)
[180.591414] [024/155] (840s left) drm_buddy (drm_buddy)
[180.627975] Starting subtest: drm_buddy
[180.632609] Subtest drm_buddy: SKIP (0.001s)
[180.681564] [025/155] (840s left) kms_pm_rpm (modeset-lpsp)
[182.421077] Starting subtest: modeset-lpsp
[183.896889] Subtest modeset-lpsp: SUCCESS (1.476s)
[184.020360] [026/155] (836s left) kms_lease (lease-unleased-connector)
[184.115947] Starting subtest: lease-unleased-connector
[184.118201] Starting dynamic subtest: pipe-A-eDP-1
[184.120374] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.006s)
[184.129776] Starting dynamic subtest: pipe-B-eDP-1
[184.132108] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.009s)
[184.141664] Starting dynamic subtest: pipe-C-eDP-1
[184.143907] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.006s)
[184.153232] Starting dynamic subtest: pipe-D-eDP-1
[184.155442] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.007s)
[184.157653] Subtest lease-unleased-connector: SUCCESS (0.033s)
[184.247160] [027/155] (836s left) kms_psr (fbc-psr-primary-blt)
[184.339582] Starting subtest: fbc-psr-primary-blt
[184.341690] Starting dynamic subtest: eDP-1
[184.345849] Dynamic subtest eDP-1: SKIP (0.000s)
[184.350108] Subtest fbc-psr-primary-blt: SKIP (0.001s)
[184.412705] [028/155] (836s left) kms_frontbuffer_tracking (hdr-1p-primscrn-indfb-pgflip-blt)
[184.503411] Starting subtest: hdr-1p-primscrn-indfb-pgflip-blt
[184.507344] Subtest hdr-1p-primscrn-indfb-pgflip-blt: SKIP (0.000s)
[184.617634] [029/155] (836s left) gem_exec_fence (concurrent)
[184.788553] Starting subtest: concurrent
[184.793264] Subtest concurrent: SKIP (0.000s)
[186.388825] [030/155] (834s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-blt)
[186.495140] Starting subtest: fbcpsr-rgb565-draw-blt
[193.620372] Subtest fbcpsr-rgb565-draw-blt: SUCCESS (7.129s)
[193.772032] [031/155] (827s left) gem_pwrite_snooped
[193.917586] [032/155] (827s left) prime_self_import (reimport-vs-gem_close-race)
[193.950309] Starting subtest: reimport-vs-gem_close-race
[199.055476] Subtest reimport-vs-gem_close-race: SUCCESS (5.105s)
[199.132112] [033/155] (821s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-render)
[199.238588] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-render
[199.242672] Subtest fbc-2p-primscrn-cur-indfb-draw-render: SKIP (0.000s)
[199.339996] [034/155] (821s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-blt)
[199.444257] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-blt
[206.318230] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-blt: SUCCESS (6.880s)
[206.455922] [035/155] (814s left) api_intel_allocator (execbuf-with-allocator)
[206.511563] Starting subtest: execbuf-with-allocator
[206.517333] Subtest execbuf-with-allocator: SUCCESS (0.007s)
[206.660485] [036/155] (814s left) gem_partial_pwrite_pread (writes-after-reads)
[206.721851] Subtest writes-after-reads: SKIP (0.000s)
[206.802367] [037/155] (814s left) gem_tiled_swapping (non-threaded)
[206.853807] Subtest non-threaded: SKIP (0.000s)
[206.921193] [038/155] (814s left) kms_frontbuffer_tracking (psrhdr-1p-offscreen-pri-shrfb-draw-mmap-gtt)
[207.016067] Starting subtest: psrhdr-1p-offscreen-pri-shrfb-draw-mmap-gtt
[207.020267] Subtest psrhdr-1p-offscreen-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[207.100702] [039/155] (814s left) gem_ctx_isolation (preservation-s3)
[207.165259] Starting subtest: preservation-S3
[207.167412] Starting dynamic subtest: rcs0
[223.098029] Dynamic subtest rcs0: SUCCESS (2.137s)
[223.108801] Starting dynamic subtest: bcs0
[239.099332] Dynamic subtest bcs0: SUCCESS (1.339s)
[239.110955] Starting dynamic subtest: vcs0
[255.102183] Dynamic subtest vcs0: SUCCESS (2.752s)
[255.113407] Starting dynamic subtest: vcs1
[273.106527] Dynamic subtest vcs1: SUCCESS (4.979s)
[273.117518] Starting dynamic subtest: vecs0
[291.094314] Dynamic subtest vecs0: SUCCESS (4.988s)
[291.105394] Starting dynamic subtest: ccs0
[309.092799] Dynamic subtest ccs0: SUCCESS (3.206s)
[309.095153] Subtest preservation-S3: SUCCESS (19.407s)
[309.341410] [040/155] (712s left) gem_create (create-valid-nonaligned)
[309.401273] Starting subtest: create-valid-nonaligned
[309.403229] Subtest create-valid-nonaligned: SUCCESS (0.000s)
[309.585998] [041/155] (711s left) gem_create (create-clear)
[309.649364] Starting subtest: create-clear
[309.652392] Starting dynamic subtest: smem0
[342.397832] Dynamic subtest smem0: SUCCESS (32.772s)
[342.400614] Subtest create-clear: SUCCESS (32.773s)
[342.597518] [042/155] (678s left) kms_cursor_legacy (cursorb-vs-flipa-atomic-transitions-varying-size)
[342.727333] Starting subtest: cursorB-vs-flipA-atomic-transitions-varying-size
[342.731988] Subtest cursorB-vs-flipA-atomic-transitions-varying-size: SKIP (0.001s)
[342.871294] [043/155] (678s left) kms_flip (2x-busy-flip)
[342.962492] Starting subtest: 2x-busy-flip
[342.974184] Subtest 2x-busy-flip: SKIP (0.011s)
[343.058718] [044/155] (678s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip)
[343.163721] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip
[343.168180] Subtest y-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip: SKIP (0.000s)
[343.259456] [045/155] (678s left) kms_cursor_legacy (cursora-vs-flipa-atomic)
[343.381177] Starting subtest: cursorA-vs-flipA-atomic
[354.515347] Subtest cursorA-vs-flipA-atomic: SUCCESS (11.134s)
[355.337363] [046/155] (666s left) gem_userptr_blits (dmabuf-unsync)
[355.403241] Subtest dmabuf-unsync: SKIP (0.000s)
[355.541107] [047/155] (666s left) gem_eio (wait-1us)
[355.768153] Starting subtest: wait-1us
[356.129749] Subtest wait-1us: SUCCESS (0.363s)
[356.286439] [048/155] (665s left) kms_frontbuffer_tracking (psrhdr-rgb565-draw-mmap-gtt)
[356.376724] Starting subtest: psrhdr-rgb565-draw-mmap-gtt
[356.380122] Subtest psrhdr-rgb565-draw-mmap-gtt: SKIP (0.000s)
[356.476166] [049/155] (665s left) perf (disabled-read-error)
[356.602481] Starting subtest: disabled-read-error
[356.615423] Subtest disabled-read-error: SUCCESS (0.014s)
[356.655457] [050/155] (665s left) gem_exec_whisper (basic-queues-priority)
[356.724459] Starting subtest: basic-queues-priority
[379.919591] Subtest basic-queues-priority: SUCCESS (23.196s)
[380.122982] [051/155] (641s left) kms_ccs (crc-sprite-planes-basic-4-tiled-mtl-rc-ccs-cc)
[380.218834] Starting subtest: crc-sprite-planes-basic-4-tiled-mtl-rc-ccs-cc
[380.220681] Starting dynamic subtest: pipe-A-eDP-1
[380.762082] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.515s)
[380.773419] Starting dynamic subtest: pipe-B-eDP-1
[382.202169] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.438s)
[382.217126] Starting dynamic subtest: pipe-C-eDP-1
[383.597307] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.394s)
[383.612187] Starting dynamic subtest: pipe-D-eDP-1
[385.039183] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.443s)
[385.041222] Subtest crc-sprite-planes-basic-4-tiled-mtl-rc-ccs-cc: SUCCESS (4.794s)
[386.251758] [052/155] (635s left) kms_invalid_mode (bad-hsync-end)
[386.351195] Starting subtest: bad-hsync-end
[386.353447] Starting dynamic subtest: pipe-A-eDP-1
[386.635218] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.286s)
[386.646683] Starting dynamic subtest: pipe-B-eDP-1
[386.649007] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[386.659628] Starting dynamic subtest: pipe-C-eDP-1
[386.661536] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[386.672166] Starting dynamic subtest: pipe-D-eDP-1
[386.674298] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[386.676503] Subtest bad-hsync-end: SUCCESS (0.292s)
[387.483743] [053/155] (634s left) kms_frontbuffer_tracking (psr-rgb565-draw-pwrite)
[387.585951] Starting subtest: psr-rgb565-draw-pwrite
[394.737309] Subtest psr-rgb565-draw-pwrite: SUCCESS (7.160s)
[394.856885] [054/155] (627s left) syncobj_timeline (host-signal-points)
[394.908681] Starting subtest: host-signal-points
[394.912967] Subtest host-signal-points: SUCCESS (0.005s)
[395.002273] [055/155] (626s left) kms_chamelium_hpd (hdmi-hpd-fast)
[395.381153] Subtest hdmi-hpd-fast: SKIP (0.000s)
[396.239944] [056/155] (625s left) gem_eio (kms)
[396.513392] Starting subtest: kms
[416.448497] Subtest kms: SUCCESS (19.932s)
[417.645106] [057/155] (604s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-mmap-wc)
[417.742897] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-mmap-wc
[417.747340] Subtest psr-2p-primscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[417.861394] [058/155] (604s left) gem_fence_thrash (bo-write-verify-x)
[417.897966] Starting subtest: bo-write-verify-x
[417.926270] Subtest bo-write-verify-x: SKIP (0.027s)
[417.984210] [059/155] (604s left) kms_atomic_transition (plane-all-transition-nonblocking)
[418.084169] Starting subtest: plane-all-transition-nonblocking
[418.086485] Starting dynamic subtest: pipe-A-eDP-1
[420.579901] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.496s)
[420.890507] Starting dynamic subtest: pipe-B-eDP-1
[424.162186] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.281s)
[424.462994] Subtest plane-all-transition-nonblocking: SUCCESS (6.379s)
[425.280461] [060/155] (596s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-render)
[425.389711] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-render
[425.394090] Subtest fbc-2p-scndscrn-pri-indfb-draw-render: SKIP (0.000s)
[425.497650] [061/155] (596s left) gem_media_vme
[425.625208] [062/155] (596s left) kms_ccs (bad-aux-stride-yf-tiled-ccs)
[425.717915] Starting subtest: bad-aux-stride-yf-tiled-ccs
[425.720397] Starting dynamic subtest: pipe-A-eDP-1
[425.743709] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[425.757663] Starting dynamic subtest: pipe-B-eDP-1
[425.779224] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[425.790007] Starting dynamic subtest: pipe-C-eDP-1
[425.812136] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[425.827868] Starting dynamic subtest: pipe-D-eDP-1
[425.850272] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[425.854578] Subtest bad-aux-stride-yf-tiled-ccs: SKIP (0.004s)
[428.044167] [063/155] (594s left) perf (gen8-unprivileged-single-ctx-counters)
[428.134216] Starting subtest: gen8-unprivileged-single-ctx-counters
[428.139101] Subtest gen8-unprivileged-single-ctx-counters: SKIP (0.000s)
[428.181029] [064/155] (594s left) kms_plane (pixel-format-x-tiled-modifier-source-clamping)
[428.271286] Starting subtest: pixel-format-x-tiled-modifier-source-clamping
[428.299398] Starting dynamic subtest: pipe-A-plane-0
[428.676563] Dynamic subtest pipe-A-plane-0: SUCCESS (0.377s)
[428.689886] Starting dynamic subtest: pipe-A-plane-3
[428.985584] Dynamic subtest pipe-A-plane-3: SUCCESS (0.310s)
[430.124865] Starting dynamic subtest: pipe-B-plane-0
[430.527774] Dynamic subtest pipe-B-plane-0: SUCCESS (0.411s)
[430.539420] Starting dynamic subtest: pipe-B-plane-3
[430.859710] Dynamic subtest pipe-B-plane-3: SUCCESS (0.332s)
[431.171581] Subtest pixel-format-x-tiled-modifier-source-clamping: SUCCESS (2.902s)
[431.989285] [065/155] (590s left) kms_frontbuffer_tracking (hdr-1p-primscrn-spr-indfb-draw-blt)
[432.103546] Starting subtest: hdr-1p-primscrn-spr-indfb-draw-blt
[432.107977] Subtest hdr-1p-primscrn-spr-indfb-draw-blt: SKIP (0.000s)
[432.194446] [066/155] (590s left) kms_plane_scaling (plane-upscale-factor-0-25-with-rotation)
[432.295928] Starting subtest: plane-upscale-factor-0-25-with-rotation
[432.298199] Starting dynamic subtest: pipe-A
[432.520613] Dynamic subtest pipe-A: SUCCESS (0.227s)
[432.531649] Starting dynamic subtest: pipe-B
[433.869831] Dynamic subtest pipe-B: SUCCESS (1.348s)
[433.881080] Starting dynamic subtest: pipe-C
[435.207343] Dynamic subtest pipe-C: SUCCESS (1.337s)
[435.218467] Starting dynamic subtest: pipe-D
[436.547231] Dynamic subtest pipe-D: SUCCESS (1.339s)
[436.549597] Subtest plane-upscale-factor-0-25-with-rotation: SUCCESS (4.255s)
[437.725925] [067/155] (584s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-0-async-flip)
[437.827746] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-0-async-flip
[437.832256] Subtest yf-tiled-max-hw-stride-64bpp-rotate-0-async-flip: SKIP (0.000s)
[437.923930] [068/155] (584s left) kms_cursor_legacy (short-busy-flip-before-cursor-toggle)
[438.042457] Starting subtest: short-busy-flip-before-cursor-toggle
[438.047055] Subtest short-busy-flip-before-cursor-toggle: SKIP (0.000s)
[438.189902] [069/155] (584s left) sriov_basic (enable-vfs-bind-unbind-each)
[438.232930] Starting subtest: enable-vfs-bind-unbind-each
[438.235212] Starting dynamic subtest: numvfs-1
[438.239634] Dynamic subtest numvfs-1: SKIP (0.001s)
[438.251940] Starting dynamic subtest: numvfs-2
[438.256195] Dynamic subtest numvfs-2: SKIP (0.001s)
[438.266888] Starting dynamic subtest: numvfs-3
[438.270886] Dynamic subtest numvfs-3: SKIP (0.002s)
[438.285110] Starting dynamic subtest: numvfs-4
[438.289565] Dynamic subtest numvfs-4: SKIP (0.001s)
[438.300870] Starting dynamic subtest: numvfs-5
[438.305023] Dynamic subtest numvfs-5: SKIP (0.001s)
[438.316463] Starting dynamic subtest: numvfs-6
[438.320427] Dynamic subtest numvfs-6: SKIP (0.001s)
[438.330630] Starting dynamic subtest: numvfs-7
[438.334495] Dynamic subtest numvfs-7: SKIP (0.001s)
[438.345083] Starting dynamic subtest: numvfs-random
[438.348950] Dynamic subtest numvfs-random: SKIP (0.001s)
[438.352787] Subtest enable-vfs-bind-unbind-each: SKIP (0.014s)
[438.391602] [070/155] (584s left) kms_frontbuffer_tracking (fbchdr-1p-primscrn-spr-indfb-draw-blt)
[438.487382] Starting subtest: fbchdr-1p-primscrn-spr-indfb-draw-blt
[438.491532] Subtest fbchdr-1p-primscrn-spr-indfb-draw-blt: SKIP (0.000s)
[438.588347] [071/155] (584s left) kms_psr2_sf (fbc-pr-plane-move-sf-dmg-area)
[438.689323] Starting subtest: fbc-pr-plane-move-sf-dmg-area
[438.692865] Subtest fbc-pr-plane-move-sf-dmg-area: SKIP (0.000s)
[438.759777] [072/155] (584s left) kms_chamelium_frames (hdmi-crc-fast)
[439.138304] Subtest hdmi-crc-fast: SKIP (0.000s)
[439.933447] [073/155] (582s left) kms_psr (fbc-psr2-cursor-mmap-gtt)
[440.028864] Starting subtest: fbc-psr2-cursor-mmap-gtt
[440.031083] Starting dynamic subtest: eDP-1
[440.035346] Dynamic subtest eDP-1: SKIP (0.000s)
[440.039608] Subtest fbc-psr2-cursor-mmap-gtt: SKIP (0.001s)
[440.102367] [074/155] (582s left) kms_frontbuffer_tracking (psrhdr-1p-primscrn-cur-indfb-draw-mmap-wc)
[440.207765] Starting subtest: psrhdr-1p-primscrn-cur-indfb-draw-mmap-wc
[440.212112] Subtest psrhdr-1p-primscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[440.305178] [075/155] (582s left) kms_frontbuffer_tracking (hdr-2p-scndscrn-spr-indfb-draw-mmap-gtt)
[440.407352] Starting subtest: hdr-2p-scndscrn-spr-indfb-draw-mmap-gtt
[440.411462] Subtest hdr-2p-scndscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[440.507083] [076/155] (582s left) kms_psr (pr-primary-render)
[440.604255] Starting subtest: pr-primary-render
[440.608352] Subtest pr-primary-render: SKIP (0.000s)
[440.697286] [077/155] (582s left) gem_exec_reloc (basic-wc-read-active)
[440.753379] Subtest basic-wc-read-active: SKIP (0.000s)
[440.834885] [078/155] (582s left) kms_hdmi_inject (inject-audio)
[441.177345] Starting subtest: inject-audio
[441.469671] Subtest inject-audio: SUCCESS (0.297s)
[442.014584] [079/155] (581s left) i915_pm_rps (thresholds)
[442.078972] Starting subtest: thresholds
[442.083130] Subtest thresholds: SKIP (0.001s)
[442.176650] [080/155] (580s left) gem_tiled_blits (basic)
[442.232876] Subtest basic: SKIP (0.000s)
[442.302260] [081/155] (580s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-mmap-cpu)
[442.397899] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-mmap-cpu
[442.402086] Subtest fbc-2p-scndscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[442.493472] [082/155] (580s left) gem_ctx_persistence (hostile)
[442.554486] Starting subtest: hostile
[452.056463] Subtest hostile: SUCCESS (9.498s)
[452.172887] [083/155] (571s left) kms_plane_multiple (2x-tiling-y)
[452.277994] Starting subtest: 2x-tiling-y
[452.282093] Subtest 2x-tiling-y: SKIP (0.000s)
[452.366274] [084/155] (570s left) gem_mmap_gtt (fault-concurrent)
[452.431438] Subtest fault-concurrent: SKIP (0.000s)
[452.489852] [085/155] (570s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-scndscrn-indfb-msflip-blt)
[452.590133] Starting subtest: fbcpsrhdr-2p-scndscrn-indfb-msflip-blt
[452.594371] Subtest fbcpsrhdr-2p-scndscrn-indfb-msflip-blt: SKIP (0.000s)
[452.689688] [086/155] (570s left) gen9_exec_parse (bb-secure)
[452.755401] Subtest bb-secure: SKIP (0.000s)
[452.830237] [087/155] (570s left) kms_plane_scaling (invalid-num-scalers)
[452.925954] Starting subtest: invalid-num-scalers
[452.928263] Starting dynamic subtest: pipe-A-eDP-1-invalid-num-scalers
[452.944637] Dynamic subtest pipe-A-eDP-1-invalid-num-scalers: SUCCESS (0.019s)
[452.958397] Starting dynamic subtest: pipe-B-eDP-1-invalid-num-scalers
[452.980725] Dynamic subtest pipe-B-eDP-1-invalid-num-scalers: SUCCESS (0.034s)
[452.992214] Starting dynamic subtest: pipe-C-eDP-1-invalid-num-scalers
[453.016889] Dynamic subtest pipe-C-eDP-1-invalid-num-scalers: SUCCESS (0.034s)
[453.028094] Starting dynamic subtest: pipe-D-eDP-1-invalid-num-scalers
[453.053280] Dynamic subtest pipe-D-eDP-1-invalid-num-scalers: SUCCESS (0.034s)
[453.055129] Subtest invalid-num-scalers: SUCCESS (0.127s)
[453.149935] [088/155] (570s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-primscrn-pri-indfb-draw-mmap-cpu)
[453.243469] Starting subtest: fbcpsrhdr-1p-primscrn-pri-indfb-draw-mmap-cpu
[453.246795] Subtest fbcpsrhdr-1p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[453.354781] [089/155] (570s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-render)
[453.451977] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-render
[460.177887] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-render: SUCCESS (6.730s)
[460.328011] [090/155] (563s left) kms_frontbuffer_tracking (hdr-2p-primscrn-pri-shrfb-draw-blt)
[460.437138] Starting subtest: hdr-2p-primscrn-pri-shrfb-draw-blt
[460.441499] Subtest hdr-2p-primscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[460.523499] [091/155] (563s left) gem_ccs (block-copy-compressed)
[460.578022] Starting subtest: block-copy-compressed
[460.582596] Subtest block-copy-compressed: SKIP (0.000s)
[460.715733] [092/155] (562s left) kms_psr (fbc-pr-cursor-blt)
[460.808913] Starting subtest: fbc-pr-cursor-blt
[460.813385] Subtest fbc-pr-cursor-blt: SKIP (0.000s)
[460.886281] [093/155] (562s left) gem_workarounds (reset-context)
[460.950464] Starting subtest: reset-context
[461.096610] Subtest reset-context: SUCCESS (0.146s)
[461.221019] [094/155] (562s left) gem_exec_balancer (bonded-dual)
[461.286170] Starting subtest: bonded-dual
[461.290062] Subtest bonded-dual: SKIP (0.000s)
[461.574475] [095/155] (562s left) gem_exec_nop (basic-series)
[461.638231] Starting subtest: basic-series
[476.277973] Subtest basic-series: SUCCESS (14.651s)
[476.514828] [096/155] (547s left) kms_frontbuffer_tracking (psrhdr-2p-primscrn-pri-shrfb-draw-render)
[476.615274] Starting subtest: psrhdr-2p-primscrn-pri-shrfb-draw-render
[476.619340] Subtest psrhdr-2p-primscrn-pri-shrfb-draw-render: SKIP (0.000s)
[476.705580] [097/155] (547s left) perf_pmu (init-busy)
[476.743881] Starting subtest: init-busy
[476.746178] Starting dynamic subtest: rcs0
[476.748432] Dynamic subtest rcs0: SUCCESS (0.001s)
[476.760191] Starting dynamic subtest: bcs0
[476.762090] Dynamic subtest bcs0: SUCCESS (0.000s)
[476.772619] Starting dynamic subtest: vcs0
[476.774541] Dynamic subtest vcs0: SUCCESS (0.001s)
[476.784905] Starting dynamic subtest: vcs1
[476.786866] Dynamic subtest vcs1: SUCCESS (0.001s)
[476.797933] Starting dynamic subtest: vecs0
[476.800107] Dynamic subtest vecs0: SUCCESS (0.000s)
[476.810972] Starting dynamic subtest: ccs0
[476.812839] Dynamic subtest ccs0: SUCCESS (0.000s)
[476.814711] Subtest init-busy: SUCCESS (0.007s)
[476.857371] [098/155] (547s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-mmap-wc)
[476.954006] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-mmap-wc
[483.662707] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-mmap-wc: SUCCESS (6.714s)
[483.801072] [099/155] (540s left) kms_vblank (wait-idle-hang)
[483.896546] Starting subtest: wait-idle-hang
[483.898433] Starting dynamic subtest: pipe-A-eDP-1
[510.586397] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.695s)
[510.603231] Starting dynamic subtest: pipe-D-eDP-1
[535.602704] Dynamic subtest pipe-D-eDP-1: SUCCESS (25.021s)
[535.605400] Subtest wait-idle-hang: SUCCESS (51.720s)
[536.447185] [100/155] (487s left) kms_frontbuffer_tracking (hdr-2p-scndscrn-pri-indfb-draw-mmap-cpu)
[536.549901] Starting subtest: hdr-2p-scndscrn-pri-indfb-draw-mmap-cpu
[536.554153] Subtest hdr-2p-scndscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[536.668282] [101/155] (487s left) kms_ccs (random-ccs-data-y-tiled-ccs)
[536.759120] Starting subtest: random-ccs-data-y-tiled-ccs
[536.761451] Starting dynamic subtest: pipe-A-eDP-1
[536.786720] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[536.803462] Starting dynamic subtest: pipe-B-eDP-1
[536.827699] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[536.838381] Starting dynamic subtest: pipe-C-eDP-1
[536.862615] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[536.874718] Starting dynamic subtest: pipe-D-eDP-1
[536.898407] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[536.902717] Subtest random-ccs-data-y-tiled-ccs: SKIP (0.004s)
[539.272607] [102/155] (484s left) i915_drm_fdinfo (busy-check-all)
[539.313243] Starting subtest: busy-check-all
[539.315318] Starting dynamic subtest: rcs0
[539.320618] Dynamic subtest rcs0: SKIP (0.004s)
[539.333603] Starting dynamic subtest: bcs0
[539.338145] Dynamic subtest bcs0: SKIP (0.000s)
[539.349411] Starting dynamic subtest: vcs0
[539.353427] Dynamic subtest vcs0: SKIP (0.000s)
[539.364247] Starting dynamic subtest: vcs1
[539.368197] Dynamic subtest vcs1: SKIP (0.000s)
[539.379213] Starting dynamic subtest: vecs0
[539.383104] Dynamic subtest vecs0: SKIP (0.000s)
[539.393414] Starting dynamic subtest: ccs0
[539.397424] Dynamic subtest ccs0: SKIP (0.000s)
[539.401409] Subtest busy-check-all: SKIP (0.010s)
[539.440321] [103/155] (484s left) syncobj_basic (bad-flags-handle-to-fd)
[539.500768] Starting subtest: bad-flags-handle-to-fd
[539.503114] Subtest bad-flags-handle-to-fd: SUCCESS (0.000s)
[539.606046] [104/155] (484s left) kms_content_protection (dp-mst-type-1)
[539.749993] Starting subtest: dp-mst-type-1
[539.755061] Subtest dp-mst-type-1: SKIP (0.000s)
[539.890789] [105/155] (484s left) kms_big_fb (4-tiled-16bpp-rotate-0)
[540.006341] Starting subtest: 4-tiled-16bpp-rotate-0
[541.354077] Subtest 4-tiled-16bpp-rotate-0: SUCCESS (1.347s)
[541.479508] [106/155] (482s left) gem_exec_params (invalid-fence-in)
[541.538887] Starting subtest: invalid-fence-in
[541.540993] Subtest invalid-fence-in: SUCCESS (0.000s)
[541.650844] [107/155] (482s left) gem_mmap_gtt (flink-race)
[541.706570] Subtest flink-race: SKIP (0.000s)
[541.770634] [108/155] (482s left) syncobj_timeline (invalid-signal-illegal-point)
[541.819380] Starting subtest: invalid-signal-illegal-point
[541.821572] Subtest invalid-signal-illegal-point: SUCCESS (0.000s)
[541.933119] [109/155] (482s left) kms_frontbuffer_tracking (fbchdr-1p-primscrn-indfb-pgflip-blt)
[542.036968] Starting subtest: fbchdr-1p-primscrn-indfb-pgflip-blt
[542.040761] Subtest fbchdr-1p-primscrn-indfb-pgflip-blt: SKIP (0.000s)
[542.138558] [110/155] (482s left) kms_panel_fitting (legacy)
[542.234099] Starting subtest: legacy
[542.236030] Starting dynamic subtest: pipe-A-eDP-1
[542.771375] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.537s)
[542.803172] Starting dynamic subtest: pipe-B-eDP-1
[544.359872] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.568s)
[544.392086] Starting dynamic subtest: pipe-C-eDP-1
[545.923121] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.542s)
[545.951451] Starting dynamic subtest: pipe-D-eDP-1
[547.426405] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.483s)
[547.428634] Subtest legacy: SUCCESS (5.190s)
[548.669505] [111/155] (475s left) i915_suspend (debugfs-reader)
[548.720005] Starting subtest: debugfs-reader
[567.033085] Subtest debugfs-reader: SUCCESS (3.134s)
[567.213292] [112/155] (457s left) kms_psr (psr-cursor-plane-move)
[567.311145] Starting subtest: psr-cursor-plane-move
[567.313422] Starting dynamic subtest: eDP-1
[569.063900] Dynamic subtest eDP-1: SUCCESS (1.755s)
[569.066420] Subtest psr-cursor-plane-move: SUCCESS (1.756s)
[569.900046] [113/155] (454s left) gem_exec_schedule (pi-ringfull)
[570.080922] Starting subtest: pi-ringfull
[570.082926] Starting dynamic subtest: rcs0
[570.109418] Dynamic subtest rcs0: SUCCESS (0.030s)
[570.124956] Starting dynamic subtest: bcs0
[570.139559] Dynamic subtest bcs0: SUCCESS (0.029s)
[570.155664] Starting dynamic subtest: vcs0
[570.169300] Dynamic subtest vcs0: SUCCESS (0.029s)
[570.185193] Starting dynamic subtest: vcs1
[570.198593] Dynamic subtest vcs1: SUCCESS (0.029s)
[570.214609] Starting dynamic subtest: vecs0
[570.226795] Dynamic subtest vecs0: SUCCESS (0.027s)
[570.243146] Starting dynamic subtest: ccs0
[570.255807] Dynamic subtest ccs0: SUCCESS (0.028s)
[570.258029] Subtest pi-ringfull: SUCCESS (0.178s)
[570.493714] [114/155] (454s left) syncobj_timeline (etime-multi-wait-all-for-submit-unsubmitted-signaled)
[570.555579] Starting subtest: etime-multi-wait-all-for-submit-unsubmitted-signaled
[570.665373] Subtest etime-multi-wait-all-for-submit-unsubmitted-signaled: SUCCESS (0.108s)
[570.743422] [115/155] (454s left) gem_ctx_param (get-priority-new-ctx)
[570.795993] Starting subtest: get-priority-new-ctx
[570.798295] Subtest get-priority-new-ctx: SUCCESS (0.001s)
[570.917153] [116/155] (453s left) api_intel_bb (lot-of-buffers)
[570.968176] Starting subtest: lot-of-buffers
[572.022912] Subtest lot-of-buffers: SUCCESS (1.057s)
[572.535446] [117/155] (452s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-180)
[572.649415] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-180
[573.693623] Subtest 4-tiled-max-hw-stride-32bpp-rotate-180: SUCCESS (1.046s)
[573.805787] [118/155] (451s left) kms_ccs (crc-primary-basic-4-tiled-lnl-ccs)
[573.897837] Starting subtest: crc-primary-basic-4-tiled-lnl-ccs
[573.901595] Subtest crc-primary-basic-4-tiled-lnl-ccs: SKIP (0.000s)
[575.025085] [119/155] (449s left) kms_prime (basic-crc-hybrid)
[575.111286] Subtest basic-crc-hybrid: SKIP (0.000s)
[575.231989] [120/155] (449s left) kms_ccs (crc-primary-suspend-4-tiled-mtl-rc-ccs-cc)
[575.324720] Starting subtest: crc-primary-suspend-4-tiled-mtl-rc-ccs-cc
[575.326899] Starting dynamic subtest: pipe-A-eDP-1
[591.271861] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.415s)
[591.284176] Starting dynamic subtest: pipe-B-eDP-1
[608.257998] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.384s)
[608.270025] Starting dynamic subtest: pipe-C-eDP-1
[625.223623] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.371s)
[625.235659] Starting dynamic subtest: pipe-D-eDP-1
[642.203012] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.382s)
[642.205492] Subtest crc-primary-suspend-4-tiled-mtl-rc-ccs-cc: SUCCESS (8.558s)
[643.397381] [121/155] (381s left) syncobj_timeline (multi-wait-for-submit-submitted-signaled)
[643.461749] Starting subtest: multi-wait-for-submit-submitted-signaled
[643.464180] Subtest multi-wait-for-submit-submitted-signaled: SUCCESS (0.000s)
[643.582898] [122/155] (381s left) prime_vgem (basic-gtt)
[643.648873] Starting subtest: basic-gtt
[643.653486] Subtest basic-gtt: SKIP (0.000s)
[643.755329] [123/155] (381s left) gem_exec_fence (syncobj-timeline-wait)
[644.327021] Starting subtest: syncobj-timeline-wait
[645.367051] Subtest syncobj-timeline-wait: SUCCESS (1.041s)
[645.610409] [124/155] (379s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip)
[645.706150] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip
[646.529579] Subtest x-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip: SUCCESS (0.826s)
[646.707492] [125/155] (378s left) gem_userptr_blits (map-fixed-invalidate-overlap-busy)
[646.773803] Starting subtest: map-fixed-invalidate-overlap-busy
[646.778450] Subtest map-fixed-invalidate-overlap-busy: SKIP (0.000s)
[646.924435] [126/155] (378s left) gem_softpin (32b-excludes-last-page)
[646.988735] Starting subtest: 32b-excludes-last-page
[646.995097] Subtest 32b-excludes-last-page: SUCCESS (0.003s)
[647.141411] [127/155] (378s left) gem_exec_schedule (semaphore-codependency)
[647.211248] Starting subtest: semaphore-codependency
[647.219523] Subtest semaphore-codependency: SUCCESS (0.012s)
[647.565096] [128/155] (377s left) gem_pxp (hw-rejects-pxp-context)
[647.683522] Starting subtest: hw-rejects-pxp-context
[647.687897] Subtest hw-rejects-pxp-context: SKIP (0.000s)
[647.802529] [129/155] (377s left) gem_spin_batch (spin-all-new)
[647.858891] Starting subtest: spin-all-new
[647.874416] Subtest spin-all-new: SUCCESS (0.014s)
[649.430273] [130/155] (375s left) kms_cursor_crc (cursor-offscreen-512x512)
[649.709178] Starting subtest: cursor-offscreen-512x512
[649.714067] Subtest cursor-offscreen-512x512: SKIP (0.001s)
[649.883816] [131/155] (375s left) syncobj_timeline (wait-all-for-submit-complex)
[649.933094] Starting subtest: wait-all-for-submit-complex
[650.148090] Subtest wait-all-for-submit-complex: SUCCESS (0.214s)
[650.238950] [132/155] (375s left) kms_color_pipeline (plane-lut1d-post-ctm3x4)
[650.335464] Starting subtest: plane-lut1d-post-ctm3x4
[650.481027] Starting dynamic subtest: pipe-A-plane-0
[650.658245] Dynamic subtest pipe-A-plane-0: SUCCESS (0.178s)
[650.670581] Starting dynamic subtest: pipe-A-plane-1
[650.847407] Dynamic subtest pipe-A-plane-1: SUCCESS (0.188s)
[650.861879] Starting dynamic subtest: pipe-A-plane-2
[651.013450] Dynamic subtest pipe-A-plane-2: SUCCESS (0.166s)
[652.278770] Starting dynamic subtest: pipe-B-plane-0
[652.446266] Dynamic subtest pipe-B-plane-0: SUCCESS (0.177s)
[652.460502] Starting dynamic subtest: pipe-B-plane-1
[652.602852] Dynamic subtest pipe-B-plane-1: SUCCESS (0.155s)
[652.620416] Starting dynamic subtest: pipe-B-plane-2
[652.790734] Dynamic subtest pipe-B-plane-2: SUCCESS (0.187s)
[654.038754] Starting dynamic subtest: pipe-C-plane-0
[654.172639] Dynamic subtest pipe-C-plane-0: SUCCESS (0.144s)
[654.184868] Starting dynamic subtest: pipe-C-plane-1
[654.328003] Dynamic subtest pipe-C-plane-1: SUCCESS (0.155s)
[654.341999] Starting dynamic subtest: pipe-C-plane-2
[654.494502] Dynamic subtest pipe-C-plane-2: SUCCESS (0.166s)
[655.758766] Starting dynamic subtest: pipe-D-plane-0
[655.912049] Dynamic subtest pipe-D-plane-0: SUCCESS (0.164s)
[655.925931] Starting dynamic subtest: pipe-D-plane-1
[656.078340] Dynamic subtest pipe-D-plane-1: SUCCESS (0.166s)
[656.089922] Starting dynamic subtest: pipe-D-plane-2
[656.234228] Dynamic subtest pipe-D-plane-2: SUCCESS (0.155s)
[656.522373] Subtest plane-lut1d-post-ctm3x4: SUCCESS (6.191s)
[657.387954] [133/155] (368s left) kms_universal_plane (cursor-fb-leak)
[657.498306] Starting subtest: cursor-fb-leak
[657.500284] Starting dynamic subtest: pipe-A-eDP-1
[657.830730] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.334s)
[657.846645] Starting dynamic subtest: pipe-B-eDP-1
[659.186872] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.354s)
[659.203660] Starting dynamic subtest: pipe-C-eDP-1
[660.550357] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.361s)
[660.567257] Starting dynamic subtest: pipe-D-eDP-1
[661.938392] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.386s)
[661.940849] Subtest cursor-fb-leak: SUCCESS (4.445s)
[663.184571] [134/155] (362s left) gem_mmap_gtt (basic-small-copy)
[663.245519] Subtest basic-small-copy: SKIP (0.000s)
[663.320427] [135/155] (362s left) kms_big_fb (x-tiled-64bpp-rotate-180)
[663.411754] Starting subtest: x-tiled-64bpp-rotate-180
[664.956013] Subtest x-tiled-64bpp-rotate-180: SUCCESS (1.545s)
[665.159237] [136/155] (360s left) kms_cursor_crc (cursor-random-32x32)
[665.299275] Starting subtest: cursor-random-32x32
[665.349799] Subtest cursor-random-32x32: SKIP (0.045s)
[665.629570] [137/155] (360s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-move)
[665.735285] Starting subtest: psr-2p-primscrn-cur-indfb-move
[665.739378] Subtest psr-2p-primscrn-cur-indfb-move: SKIP (0.000s)
[665.822116] [138/155] (359s left) gem_tiled_fence_blits (basic)
[665.880714] Subtest basic: SKIP (0.000s)
[665.948421] [139/155] (359s left) kms_psr_stress_test (invalidate-primary-flip-overlay)
[666.033469] Starting subtest: invalidate-primary-flip-overlay
[676.765879] Subtest invalidate-primary-flip-overlay: SUCCESS (10.736s)
[676.908781] [140/155] (348s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-cpu)
[677.005728] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-cpu
[677.009057] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[677.097703] [141/155] (348s left) kms_frontbuffer_tracking (fbchdr-2p-scndscrn-spr-indfb-draw-mmap-wc)
[677.200386] Starting subtest: fbchdr-2p-scndscrn-spr-indfb-draw-mmap-wc
[677.203908] Subtest fbchdr-2p-scndscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[677.319805] [142/155] (348s left) perf_pmu (busy-double-start)
[677.358774] Starting subtest: busy-double-start
[677.360801] Starting dynamic subtest: rcs0
[681.004697] Dynamic subtest rcs0: FAIL (3.590s)
[681.018661] Starting dynamic subtest: bcs0
[684.535212] Dynamic subtest bcs0: SUCCESS (3.582s)
[684.549528] Starting dynamic subtest: vcs0
[688.880857] Dynamic subtest vcs0: SUCCESS (4.344s)
[688.894937] Starting dynamic subtest: vcs1
[692.898170] Dynamic subtest vcs1: SUCCESS (4.015s)
[692.911072] Starting dynamic subtest: vecs0
[696.871316] Dynamic subtest vecs0: SUCCESS (3.971s)
[696.885767] Starting dynamic subtest: ccs0
[700.508584] Dynamic subtest ccs0: FAIL (3.568s)
[700.510524] Subtest busy-double-start: FAIL (23.082s)
[700.559289] [143/155] (325s left) kms_async_flips (alternate-sync-async-flip)
[700.657439] Starting subtest: alternate-sync-async-flip
[701.039942] Starting dynamic subtest: pipe-A-eDP-1
[703.824216] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.785s)
[704.208776] Starting dynamic subtest: pipe-B-eDP-1
[707.029656] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.835s)
[707.415466] Starting dynamic subtest: pipe-C-eDP-1
[710.220214] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.815s)
[710.587798] Starting dynamic subtest: pipe-D-eDP-1
[713.420653] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.844s)
[713.422759] Subtest alternate-sync-async-flip: SUCCESS (12.770s)
[714.676280] [144/155] (311s left) kms_flip (2x-flip-vs-suspend-interruptible)
[714.782716] Starting subtest: 2x-flip-vs-suspend-interruptible
[714.787219] Subtest 2x-flip-vs-suspend-interruptible: SKIP (0.002s)
[714.896271] [145/155] (311s left) kms_joiner (basic-ultra-joiner)
[714.993277] Starting subtest: basic-ultra-joiner
[714.997457] Subtest basic-ultra-joiner: SKIP (0.000s)
[715.076993] [146/155] (311s left) kms_frontbuffer_tracking (fbc-farfromfence-mmap-gtt)
[715.185797] Starting subtest: fbc-farfromfence-mmap-gtt
[715.190191] Subtest fbc-farfromfence-mmap-gtt: SKIP (0.000s)
[715.310609] [147/155] (310s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-mmap-cpu)
[715.414416] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-mmap-cpu
[718.970103] Subtest fbc-1p-primscrn-cur-indfb-draw-mmap-cpu: SUCCESS (3.565s)
[720.171633] [148/155] (306s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-primscrn-shrfb-pgflip-blt)
[720.270791] Starting subtest: fbcpsrhdr-2p-primscrn-shrfb-pgflip-blt
[720.274763] Subtest fbcpsrhdr-2p-primscrn-shrfb-pgflip-blt: SKIP (0.000s)
[720.365835] [149/155] (305s left) kms_frontbuffer_tracking (fbc-2p-primscrn-shrfb-pgflip-blt)
[720.471837] Starting subtest: fbc-2p-primscrn-shrfb-pgflip-blt
[720.476203] Subtest fbc-2p-primscrn-shrfb-pgflip-blt: SKIP (0.000s)
[720.581782] [150/155] (305s left) kms_frontbuffer_tracking (fbchdr-2p-scndscrn-cur-indfb-move)
[720.686986] Starting subtest: fbchdr-2p-scndscrn-cur-indfb-move
[720.691094] Subtest fbchdr-2p-scndscrn-cur-indfb-move: SKIP (0.000s)
[720.789533] [151/155] (305s left) prime_mmap (test_invalid_sync_flags)
[720.840066] Starting subtest: test_invalid_sync_flags
[720.842456] Starting dynamic subtest: test_invalid_sync_flags-smem
[720.844547] Dynamic subtest test_invalid_sync_flags-smem: SUCCESS (0.000s)
[720.846566] Subtest test_invalid_sync_flags: SUCCESS (0.001s)
[720.942513] [152/155] (305s left) perf (invalid-remove-userspace-config)
[721.035773] Starting subtest: invalid-remove-userspace-config
[721.049427] Subtest invalid-remove-userspace-config: SUCCESS (0.011s)
[721.094403] [153/155] (305s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling)
[721.187578] Starting subtest: flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling
[721.190979] Subtest flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling: SKIP (0.000s)
[721.274048] [154/155] (305s left) kms_frontbuffer_tracking (fbcpsrhdr-suspend)
[721.385529] Starting subtest: fbcpsrhdr-suspend
[721.389043] Subtest fbcpsrhdr-suspend: SKIP (0.000s)
[721.486164] [155/155] (305s left) kms_frontbuffer_tracking (fbcpsrhdr-rgb101010-draw-mmap-gtt)
[721.582956] Starting subtest: fbcpsrhdr-rgb101010-draw-mmap-gtt
[721.586564] Subtest fbcpsrhdr-rgb101010-draw-mmap-gtt: SKIP (0.000s)
[721.683005] Closing watchdogs
results: parsing output: 0/ for test: kms_frontbuffer_tracking
results: parsing output: 1/ for test: gem_exec_fence
results: parsing output: 2/ for test: kms_psr2_sf
results: parsing output: 3/ for test: kms_frontbuffer_tracking
results: parsing output: 4/ for test: kms_ccs
results: parsing output: 5/ for test: gem_exec_params
results: parsing output: 6/ for test: kms_feature_discovery
results: parsing output: 7/ for test: kms_frontbuffer_tracking
results: parsing output: 8/ for test: kms_frontbuffer_tracking
results: parsing output: 9/ for test: gem_mmap_wc
results: parsing output: 10/ for test: gem_exec_reloc
results: parsing output: 11/ for test: kms_frontbuffer_tracking
results: parsing output: 12/ for test: gem_exec_schedule
results: parsing output: 13/ for test: kms_frontbuffer_tracking
results: parsing output: 14/ for test: gem_vm_create
results: parsing output: 15/ for test: kms_plane_cursor
results: parsing output: 16/ for test: kms_frontbuffer_tracking
results: parsing output: 17/ for test: kms_frontbuffer_tracking
results: parsing output: 18/ for test: kms_frontbuffer_tracking
results: parsing output: 19/ for test: i915_hangman
results: parsing output: 20/ for test: kms_cursor_edge_walk
results: parsing output: 21/ for test: kms_flip
results: parsing output: 22/ for test: kms_big_fb
results: parsing output: 23/ for test: drm_buddy
results: parsing output: 24/ for test: kms_pm_rpm
results: parsing output: 25/ for test: kms_lease
results: parsing output: 26/ for test: kms_psr
results: parsing output: 27/ for test: kms_frontbuffer_tracking
results: parsing output: 28/ for test: gem_exec_fence
results: parsing output: 29/ for test: kms_frontbuffer_tracking
results: parsing output: 30/ for test: gem_pwrite_snooped
results: parsing output: 31/ for test: prime_self_import
results: parsing output: 32/ for test: kms_frontbuffer_tracking
results: parsing output: 33/ for test: kms_frontbuffer_tracking
results: parsing output: 34/ for test: api_intel_allocator
results: parsing output: 35/ for test: gem_partial_pwrite_pread
results: parsing output: 36/ for test: gem_tiled_swapping
results: parsing output: 37/ for test: kms_frontbuffer_tracking
results: parsing output: 38/ for test: gem_ctx_isolation
results: parsing output: 39/ for test: gem_create
results: parsing output: 40/ for test: gem_create
results: parsing output: 41/ for test: kms_cursor_legacy
results: parsing output: 42/ for test: kms_flip
results: parsing output: 43/ for test: kms_big_fb
results: parsing output: 44/ for test: kms_cursor_legacy
results: parsing output: 45/ for test: gem_userptr_blits
results: parsing output: 46/ for test: gem_eio
results: parsing output: 47/ for test: kms_frontbuffer_tracking
results: parsing output: 48/ for test: perf
results: parsing output: 49/ for test: gem_exec_whisper
results: parsing output: 50/ for test: kms_ccs
results: parsing output: 51/ for test: kms_invalid_mode
results: parsing output: 52/ for test: kms_frontbuffer_tracking
results: parsing output: 53/ for test: syncobj_timeline
results: parsing output: 54/ for test: kms_chamelium_hpd
results: parsing output: 55/ for test: gem_eio
results: parsing output: 56/ for test: kms_frontbuffer_tracking
results: parsing output: 57/ for test: gem_fence_thrash
results: parsing output: 58/ for test: kms_atomic_transition
results: parsing output: 59/ for test: kms_frontbuffer_tracking
results: parsing output: 60/ for test: gem_media_vme
results: parsing output: 61/ for test: kms_ccs
results: parsing output: 62/ for test: perf
results: parsing output: 63/ for test: kms_plane
results: parsing output: 64/ for test: kms_frontbuffer_tracking
results: parsing output: 65/ for test: kms_plane_scaling
results: parsing output: 66/ for test: kms_big_fb
results: parsing output: 67/ for test: kms_cursor_legacy
results: parsing output: 68/ for test: sriov_basic
results: parsing output: 69/ for test: kms_frontbuffer_tracking
results: parsing output: 70/ for test: kms_psr2_sf
results: parsing output: 71/ for test: kms_chamelium_frames
results: parsing output: 72/ for test: kms_psr
results: parsing output: 73/ for test: kms_frontbuffer_tracking
results: parsing output: 74/ for test: kms_frontbuffer_tracking
results: parsing output: 75/ for test: kms_psr
results: parsing output: 76/ for test: gem_exec_reloc
results: parsing output: 77/ for test: kms_hdmi_inject
results: parsing output: 78/ for test: i915_pm_rps
results: parsing output: 79/ for test: gem_tiled_blits
results: parsing output: 80/ for test: kms_frontbuffer_tracking
results: parsing output: 81/ for test: gem_ctx_persistence
results: parsing output: 82/ for test: kms_plane_multiple
results: parsing output: 83/ for test: gem_mmap_gtt
results: parsing output: 84/ for test: kms_frontbuffer_tracking
results: parsing output: 85/ for test: gen9_exec_parse
results: parsing output: 86/ for test: kms_plane_scaling
results: parsing output: 87/ for test: kms_frontbuffer_tracking
results: parsing output: 88/ for test: kms_frontbuffer_tracking
results: parsing output: 89/ for test: kms_frontbuffer_tracking
results: parsing output: 90/ for test: gem_ccs
results: parsing output: 91/ for test: kms_psr
results: parsing output: 92/ for test: gem_workarounds
results: parsing output: 93/ for test: gem_exec_balancer
results: parsing output: 94/ for test: gem_exec_nop
results: parsing output: 95/ for test: kms_frontbuffer_tracking
results: parsing output: 96/ for test: perf_pmu
results: parsing output: 97/ for test: kms_frontbuffer_tracking
results: parsing output: 98/ for test: kms_vblank
results: parsing output: 99/ for test: kms_frontbuffer_tracking
results: parsing output: 100/ for test: kms_ccs
results: parsing output: 101/ for test: i915_drm_fdinfo
results: parsing output: 102/ for test: syncobj_basic
results: parsing output: 103/ for test: kms_content_protection
results: parsing output: 104/ for test: kms_big_fb
results: parsing output: 105/ for test: gem_exec_params
results: parsing output: 106/ for test: gem_mmap_gtt
results: parsing output: 107/ for test: syncobj_timeline
results: parsing output: 108/ for test: kms_frontbuffer_tracking
results: parsing output: 109/ for test: kms_panel_fitting
results: parsing output: 110/ for test: i915_suspend
results: parsing output: 111/ for test: kms_psr
results: parsing output: 112/ for test: gem_exec_schedule
results: parsing output: 113/ for test: syncobj_timeline
results: parsing output: 114/ for test: gem_ctx_param
results: parsing output: 115/ for test: api_intel_bb
results: parsing output: 116/ for test: kms_big_fb
results: parsing output: 117/ for test: kms_ccs
results: parsing output: 118/ for test: kms_prime
results: parsing output: 119/ for test: kms_ccs
results: parsing output: 120/ for test: syncobj_timeline
results: parsing output: 121/ for test: prime_vgem
results: parsing output: 122/ for test: gem_exec_fence
results: parsing output: 123/ for test: kms_big_fb
results: parsing output: 124/ for test: gem_userptr_blits
results: parsing output: 125/ for test: gem_softpin
results: parsing output: 126/ for test: gem_exec_schedule
results: parsing output: 127/ for test: gem_pxp
results: parsing output: 128/ for test: gem_spin_batch
results: parsing output: 129/ for test: kms_cursor_crc
results: parsing output: 130/ for test: syncobj_timeline
results: parsing output: 131/ for test: kms_color_pipeline
results: parsing output: 132/ for test: kms_universal_plane
results: parsing output: 133/ for test: gem_mmap_gtt
results: parsing output: 134/ for test: kms_big_fb
results: parsing output: 135/ for test: kms_cursor_crc
results: parsing output: 136/ for test: kms_frontbuffer_tracking
results: parsing output: 137/ for test: gem_tiled_fence_blits
results: parsing output: 138/ for test: kms_psr_stress_test
results: parsing output: 139/ for test: kms_frontbuffer_tracking
results: parsing output: 140/ for test: kms_frontbuffer_tracking
results: parsing output: 141/ for test: perf_pmu
results: parsing output: 142/ for test: kms_async_flips
results: parsing output: 143/ for test: kms_flip
results: parsing output: 144/ for test: kms_joiner
results: parsing output: 145/ for test: kms_frontbuffer_tracking
results: parsing output: 146/ for test: kms_frontbuffer_tracking
results: parsing output: 147/ for test: kms_frontbuffer_tracking
results: parsing output: 148/ for test: kms_frontbuffer_tracking
results: parsing output: 149/ for test: kms_frontbuffer_tracking
results: parsing output: 150/ for test: prime_mmap
results: parsing output: 151/ for test: perf
results: parsing output: 152/ for test: kms_flip_scaled_crc
results: parsing output: 153/ for test: kms_frontbuffer_tracking
results: parsing output: 154/ for test: kms_frontbuffer_tracking
Done.