[57.472464] Initializing watchdogs
[57.472505]   /dev/watchdog0
[57.486908] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:7dd5 Intel Meteorlake (Gen12) Meteor Lake-P [Intel Graphics]
[57.490898] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[57.493085] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[57.496457] [001/154] (960s left) kms_psr2_sf (psr2-primary-plane-update-sf-dmg-area-big-fb)
[57.613816] Starting subtest: psr2-primary-plane-update-sf-dmg-area-big-fb
[57.616186] Starting dynamic subtest: pipe-A-eDP-1
[64.362282] Dynamic subtest pipe-A-eDP-1: SUCCESS (6.826s)
[64.373124] Starting dynamic subtest: pipe-B-eDP-1
[71.355984] Dynamic subtest pipe-B-eDP-1: SUCCESS (7.023s)
[71.358363] Subtest psr2-primary-plane-update-sf-dmg-area-big-fb: SUCCESS (13.852s)
[72.201750] [002/154] (945s left) i915_suspend (fence-restore-tiled2untiled)
[72.260057] Starting subtest: fence-restore-tiled2untiled
[72.264410] Subtest fence-restore-tiled2untiled: SKIP (0.000s)
[72.564765] [003/154] (945s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-render)
[72.751715] Starting subtest: fbcpsr-rgb565-draw-render
[79.803849] Subtest fbcpsr-rgb565-draw-render: SUCCESS (7.069s)
[79.944868] [004/154] (938s left) syncobj_timeline (wait-any-snapshot)
[80.004842] Starting subtest: wait-any-snapshot
[80.086029] Subtest wait-any-snapshot: SUCCESS (0.082s)
[80.155211] [005/154] (938s left) perf (gen8-unprivileged-single-ctx-counters)
[80.285638] Starting subtest: gen8-unprivileged-single-ctx-counters
[80.289785] Subtest gen8-unprivileged-single-ctx-counters: SKIP (0.000s)
[80.324030] [006/154] (937s left) kms_ccs (random-ccs-data-4-tiled-bmg-ccs)
[80.399815] Starting subtest: random-ccs-data-4-tiled-bmg-ccs
[80.405060] Subtest random-ccs-data-4-tiled-bmg-ccs: SKIP (0.000s)
[81.548850] [007/154] (936s left) api_intel_bb (object-noreloc-keep-cache-simple)
[81.605057] Starting subtest: object-noreloc-keep-cache-simple
[81.609729] Subtest object-noreloc-keep-cache-simple: SUCCESS (0.005s)
[81.726235] [008/154] (936s left) gem_ctx_isolation (clean)
[81.783083] Starting subtest: clean
[81.785313] Starting dynamic subtest: rcs0
[81.828439] Dynamic subtest rcs0: SUCCESS (0.045s)
[81.836220] Starting dynamic subtest: bcs0
[81.894513] Dynamic subtest bcs0: SUCCESS (0.066s)
[81.903216] Starting dynamic subtest: vcs0
[81.959892] Dynamic subtest vcs0: SUCCESS (0.065s)
[81.968243] Starting dynamic subtest: vcs1
[83.292602] Dynamic subtest vcs1: SUCCESS (1.333s)
[83.301331] Starting dynamic subtest: vecs0
[85.278183] Dynamic subtest vecs0: SUCCESS (1.985s)
[85.289071] Starting dynamic subtest: ccs0
[87.267044] Dynamic subtest ccs0: SUCCESS (1.989s)
[87.269802] Subtest clean: SUCCESS (5.486s)
[87.515844] [009/154] (930s left) gem_eio (kms)
[87.709164] Starting subtest: kms
[104.494378] Subtest kms: SUCCESS (16.785s)
[104.628433] [FACT gem_eio (kms)] new: kernel.kmod_is_loaded.vgem: true
[104.632033] [010/154] (913s left) kms_frontbuffer_tracking (fbchdr-2p-primscrn-pri-shrfb-draw-blt)
[104.722275] Starting subtest: fbchdr-2p-primscrn-pri-shrfb-draw-blt
[104.726690] Subtest fbchdr-2p-primscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[104.827828] [011/154] (913s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-primscrn-cur-indfb-onoff)
[104.918938] Starting subtest: fbcpsrhdr-1p-primscrn-cur-indfb-onoff
[104.923563] Subtest fbcpsrhdr-1p-primscrn-cur-indfb-onoff: SKIP (0.000s)
[105.023388] [012/154] (913s left) syncobj_timeline (multi-wait-all-for-submit-available-submitted-signaled)
[105.075833] Starting subtest: multi-wait-all-for-submit-available-submitted-signaled
[105.078198] Subtest multi-wait-all-for-submit-available-submitted-signaled: SUCCESS (0.001s)
[105.194842] [013/154] (913s left) syncobj_timeline (multi-wait-for-submit-available-signaled)
[105.239829] Starting subtest: multi-wait-for-submit-available-signaled
[105.242217] Subtest multi-wait-for-submit-available-signaled: SUCCESS (0.000s)
[105.335108] [014/154] (913s left) syncobj_wait (wait-for-submit-snapshot)
[105.394749] Starting subtest: wait-for-submit-snapshot
[105.475229] Subtest wait-for-submit-snapshot: SUCCESS (0.081s)
[105.548544] [015/154] (913s left) syncobj_timeline (etime-multi-wait-all-for-submit-available-unsubmitted)
[105.603158] Starting subtest: etime-multi-wait-all-for-submit-available-unsubmitted
[105.705391] Subtest etime-multi-wait-all-for-submit-available-unsubmitted: SUCCESS (0.102s)
[105.790374] [016/154] (912s left) kms_pm_rpm (cursor-dpms)
[107.397863] Starting subtest: cursor-dpms
[107.403268] Subtest cursor-dpms: SKIP (0.000s)
[108.079561] [017/154] (910s left) kms_frontbuffer_tracking (hdr-2p-primscrn-pri-shrfb-draw-mmap-cpu)
[108.158772] Starting subtest: hdr-2p-primscrn-pri-shrfb-draw-mmap-cpu
[108.163231] Subtest hdr-2p-primscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[108.270717] [018/154] (910s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-blt)
[108.362376] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-blt
[108.366337] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-blt: SKIP (0.000s)
[108.460767] [019/154] (910s left) kms_flip (plain-flip-fb-recreate)
[108.534194] Starting subtest: plain-flip-fb-recreate
[108.536660] Starting dynamic subtest: A-eDP1
[117.381783] Dynamic subtest A-eDP1: SUCCESS (8.848s)
[117.394170] Starting dynamic subtest: B-eDP1
[126.234764] Dynamic subtest B-eDP1: SUCCESS (8.852s)
[126.243616] Starting dynamic subtest: C-eDP1
[135.063129] Dynamic subtest C-eDP1: SUCCESS (8.827s)
[135.075348] Starting dynamic subtest: D-eDP1
[143.894555] Dynamic subtest D-eDP1: SUCCESS (8.831s)
[143.896513] Subtest plain-flip-fb-recreate: SUCCESS (35.366s)
[145.067121] [020/154] (873s left) gem_lmem_swapping (basic)
[145.111153] Subtest basic: SKIP (0.000s)
[145.150760] [021/154] (873s left) gem_pxp (reject-modify-context-protection-off-1)
[145.260692] Starting subtest: reject-modify-context-protection-off-1
[145.263334] Subtest reject-modify-context-protection-off-1: SUCCESS (0.002s)
[145.367376] [022/154] (873s left) i915_hangman (engine-engine-error)
[145.430867] Starting subtest: engine-engine-error
[145.433198] Starting dynamic subtest: rcs0
[147.164433] Dynamic subtest rcs0: SUCCESS (1.733s)
[147.176731] Starting dynamic subtest: bcs0
[149.212484] Dynamic subtest bcs0: SUCCESS (2.047s)
[149.224328] Starting dynamic subtest: vcs0
[151.197823] Dynamic subtest vcs0: SUCCESS (1.983s)
[151.209913] Starting dynamic subtest: vcs1
[153.180955] Dynamic subtest vcs1: SUCCESS (1.981s)
[153.192270] Starting dynamic subtest: vecs0
[155.228477] Dynamic subtest vecs0: SUCCESS (2.045s)
[155.239532] Starting dynamic subtest: ccs0
[157.212601] Dynamic subtest ccs0: SUCCESS (1.983s)
[157.215807] Subtest engine-engine-error: SUCCESS (11.781s)
[157.305216] [023/154] (861s left) syncobj_timeline (etime-multi-wait-for-submit-unsubmitted)
[157.364806] Starting subtest: etime-multi-wait-for-submit-unsubmitted
[157.475438] Subtest etime-multi-wait-for-submit-unsubmitted: SUCCESS (0.108s)
[157.551717] [024/154] (861s left) gen9_exec_parse (bb-secure)
[157.612276] Subtest bb-secure: SKIP (0.000s)
[157.684435] [025/154] (861s left) kms_dsc (dsc-with-output-formats-with-bpc)
[157.753866] Starting subtest: dsc-with-output-formats-with-bpc
[157.809707] Subtest dsc-with-output-formats-with-bpc: SKIP (0.001s)
[157.845984] [026/154] (861s left) kms_cursor_legacy (single-bo)
[157.943850] Starting subtest: single-bo
[157.946176] Starting dynamic subtest: pipe-A
[163.325921] Dynamic subtest pipe-A: SUCCESS (5.379s)
[163.337234] Starting dynamic subtest: pipe-B
[168.708308] Dynamic subtest pipe-B: SUCCESS (5.379s)
[168.719313] Starting dynamic subtest: pipe-C
[174.090729] Dynamic subtest pipe-C: SUCCESS (5.380s)
[174.104932] Starting dynamic subtest: pipe-D
[179.475052] Dynamic subtest pipe-D: SUCCESS (5.381s)
[179.488591] Starting dynamic subtest: all-pipes
[184.862598] Dynamic subtest all-pipes: SUCCESS (5.386s)
[184.865194] Subtest single-bo: SUCCESS (26.912s)
[185.016856] [027/154] (834s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-scndscrn-cur-indfb-move)
[185.091530] Starting subtest: fbcpsrhdr-2p-scndscrn-cur-indfb-move
[185.095824] Subtest fbcpsrhdr-2p-scndscrn-cur-indfb-move: SKIP (0.000s)
[185.186347] [028/154] (833s left) gem_exec_balancer (nop)
[185.247803] Starting subtest: nop
[232.072802] Subtest nop: SUCCESS (46.824s)
[232.369169] [029/154] (786s left) sw_sync (sync_merge)
[232.406174] Starting subtest: sync_merge
[232.408409] Subtest sync_merge: SUCCESS (0.000s)
[232.455832] [030/154] (786s left) gem_exec_fence (basic-busy)
[232.634091] Starting subtest: basic-busy
[232.636571] Starting dynamic subtest: rcs0
[232.702959] Dynamic subtest rcs0: SUCCESS (0.069s)
[232.712466] Starting dynamic subtest: bcs0
[232.769810] Dynamic subtest bcs0: SUCCESS (0.065s)
[232.779532] Starting dynamic subtest: vcs0
[232.827383] Dynamic subtest vcs0: SUCCESS (0.056s)
[232.838819] Starting dynamic subtest: vcs1
[232.891894] Dynamic subtest vcs1: SUCCESS (0.063s)
[232.902589] Starting dynamic subtest: vecs0
[232.953279] Dynamic subtest vecs0: SUCCESS (0.060s)
[232.963943] Starting dynamic subtest: ccs0
[233.017988] Dynamic subtest ccs0: SUCCESS (0.064s)
[233.020549] Subtest basic-busy: SUCCESS (0.385s)
[235.253868] [031/154] (783s left) kms_frontbuffer_tracking (fbcpsrhdr-modesetfrombusy)
[235.345260] Starting subtest: fbcpsrhdr-modesetfrombusy
[235.349264] Subtest fbcpsrhdr-modesetfrombusy: SKIP (0.000s)
[235.440813] [032/154] (783s left) kms_content_protection (dp-mst-lic-type-0-hdcp14)
[235.572423] Starting subtest: dp-mst-lic-type-0-hdcp14
[235.576958] Subtest dp-mst-lic-type-0-hdcp14: SKIP (0.000s)
[235.714234] [033/154] (783s left) kms_chamelium_hpd (hdmi-hpd-fast)
[236.071159] Subtest hdmi-hpd-fast: SKIP (0.000s)
[236.873466] [034/154] (782s left) kms_psr (psr-sprite-mmap-gtt)
[236.949837] Starting subtest: psr-sprite-mmap-gtt
[236.952072] Starting dynamic subtest: eDP-1
[238.393070] Dynamic subtest eDP-1: SKIP (1.440s)
[238.397840] Subtest psr-sprite-mmap-gtt: SKIP (1.442s)
[238.550946] [035/154] (780s left) gem_render_copy_redux (flink-interruptible)
[238.612497] Starting subtest: flink-interruptible
[239.387349] Subtest flink-interruptible: SUCCESS (0.775s)
[239.472321] [036/154] (779s left) kms_frontbuffer_tracking (fbchdr-1p-primscrn-cur-indfb-draw-mmap-gtt)
[239.551958] Starting subtest: fbchdr-1p-primscrn-cur-indfb-draw-mmap-gtt
[239.555498] Subtest fbchdr-1p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[239.644614] [037/154] (779s left) core_getversion (basic)
[239.681787] Starting subtest: basic
[239.685296] Subtest basic: SUCCESS (0.000s)
[239.737250] [038/154] (779s left) kms_frontbuffer_tracking (hdr-1p-offscreen-pri-shrfb-draw-mmap-wc)
[239.823650] Starting subtest: hdr-1p-offscreen-pri-shrfb-draw-mmap-wc
[239.827154] Subtest hdr-1p-offscreen-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[239.934907] [039/154] (779s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-primscrn-shrfb-plflip-blt)
[240.015775] Starting subtest: fbcpsrhdr-2p-primscrn-shrfb-plflip-blt
[240.019312] Subtest fbcpsrhdr-2p-primscrn-shrfb-plflip-blt: SKIP (0.000s)
[240.099625] [040/154] (779s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-mmap-wc)
[240.172819] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-mmap-wc
[240.176359] Subtest psr-2p-primscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[240.292105] [041/154] (779s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-pwrite)
[240.382860] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-pwrite
[249.050456] Subtest psr-1p-primscrn-pri-shrfb-draw-pwrite: SUCCESS (8.672s)
[249.165418] [042/154] (770s left) kms_vblank (ts-continuation-suspend)
[249.244064] Starting subtest: ts-continuation-suspend
[249.246370] Starting dynamic subtest: pipe-A-eDP-1
[266.123668] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.539s)
[266.137580] Starting dynamic subtest: pipe-D-eDP-1
[283.088318] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.244s)
[283.090133] Subtest ts-continuation-suspend: SUCCESS (4.786s)
[283.882012] [043/154] (735s left) perf_pmu (gt-awake)
[283.926702] Starting subtest: gt-awake
[292.355205] Subtest gt-awake: SUCCESS (8.578s)
[292.461139] [044/154] (727s left) kms_async_flips (async-flip-hang)
[292.547104] Starting subtest: async-flip-hang
[292.927056] Starting dynamic subtest: pipe-A-eDP-1
[307.849336] Dynamic subtest pipe-A-eDP-1: SUCCESS (14.984s)
[308.231906] Starting dynamic subtest: pipe-B-eDP-1
[323.875639] Dynamic subtest pipe-B-eDP-1: SUCCESS (15.653s)
[324.261632] Starting dynamic subtest: pipe-C-eDP-1
[339.867892] Dynamic subtest pipe-C-eDP-1: SUCCESS (15.615s)
[340.260782] Starting dynamic subtest: pipe-D-eDP-1
[355.862214] Dynamic subtest pipe-D-eDP-1: SUCCESS (15.613s)
[355.864775] Subtest async-flip-hang: SUCCESS (63.390s)
[357.101278] [045/154] (662s left) gem_mmap_wc (bad-size)
[357.159031] Subtest bad-size: SKIP (0.000s)
[357.221199] [046/154] (662s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-primscrn-cur-indfb-draw-render)
[357.309094] Starting subtest: fbcpsrhdr-2p-primscrn-cur-indfb-draw-render
[357.313118] Subtest fbcpsrhdr-2p-primscrn-cur-indfb-draw-render: SKIP (0.000s)
[357.407167] [047/154] (662s left) kms_rotation_crc (primary-y-tiled-reflect-x-180)
[357.474831] Starting subtest: primary-y-tiled-reflect-x-180
[357.533612] Subtest primary-y-tiled-reflect-x-180: SKIP (0.060s)
[357.636555] [048/154] (662s left) kms_ccs (bad-pixel-format-4-tiled-dg2-rc-ccs-cc)
[357.711735] Starting subtest: bad-pixel-format-4-tiled-dg2-rc-ccs-cc
[357.713934] Starting dynamic subtest: pipe-A-eDP-1
[357.736224] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[357.747645] Starting dynamic subtest: pipe-B-eDP-1
[357.768284] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[357.777962] Starting dynamic subtest: pipe-C-eDP-1
[357.798450] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[357.807591] Starting dynamic subtest: pipe-D-eDP-1
[357.830051] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[357.834101] Subtest bad-pixel-format-4-tiled-dg2-rc-ccs-cc: SKIP (0.004s)
[359.972903] [049/154] (659s left) kms_psr (pr-sprite-plane-onoff)
[360.050734] Starting subtest: pr-sprite-plane-onoff
[360.055129] Subtest pr-sprite-plane-onoff: SKIP (0.000s)
[360.135163] [050/154] (659s left) kms_ccs (random-ccs-data-4-tiled-mtl-rc-ccs)
[360.212630] Starting subtest: random-ccs-data-4-tiled-mtl-rc-ccs
[360.214437] Starting dynamic subtest: pipe-A-eDP-1
[360.916534] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.696s)
[360.927561] Starting dynamic subtest: pipe-B-eDP-1
[362.682303] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.766s)
[362.692029] Starting dynamic subtest: pipe-C-eDP-1
[364.502284] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.819s)
[364.514737] Starting dynamic subtest: pipe-D-eDP-1
[366.328954] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.826s)
[366.331205] Subtest random-ccs-data-4-tiled-mtl-rc-ccs: SUCCESS (6.111s)
[367.482668] [051/154] (652s left) gem_ctx_persistence (heartbeat-hostile)
[367.542780] Starting subtest: heartbeat-hostile
[367.547701] Subtest heartbeat-hostile: SKIP (0.000s)
[367.647987] [052/154] (652s left) kms_getfb (getfb-handle-valid)
[367.730609] Starting subtest: getfb-handle-valid
[367.733047] Subtest getfb-handle-valid: SUCCESS (0.000s)
[367.815765] [053/154] (652s left) gem_flink_race (flink_close)
[367.849338] Starting subtest: flink_close
[372.948654] Subtest flink_close: SUCCESS (5.100s)
[373.028069] [054/154] (647s left) gem_workarounds (reset)
[373.109101] Starting subtest: reset
[373.252666] Subtest reset: SUCCESS (0.146s)
[373.392402] [055/154] (646s left) kms_frontbuffer_tracking (hdr-2p-primscrn-cur-indfb-move)
[373.475010] Starting subtest: hdr-2p-primscrn-cur-indfb-move
[373.479288] Subtest hdr-2p-primscrn-cur-indfb-move: SKIP (0.000s)
[373.572563] [056/154] (646s left) kms_cursor_legacy (flip-vs-cursor-atomic-transitions)
[373.670498] Starting subtest: flip-vs-cursor-atomic-transitions
[381.505720] Subtest flip-vs-cursor-atomic-transitions: SUCCESS (7.833s)
[382.336365] [057/154] (637s left) api_intel_allocator (simple-allocator)
[382.395486] Starting subtest: simple-allocator
[382.397949] Starting dynamic subtest: basic
[382.400251] Dynamic subtest basic: SUCCESS (0.003s)
[382.413447] Starting dynamic subtest: parallel-one
[382.565955] Dynamic subtest parallel-one: SUCCESS (0.167s)
[382.578818] Starting dynamic subtest: print
[382.581100] Dynamic subtest print: SUCCESS (0.000s)
[382.591637] Starting dynamic subtest: reuse
[382.593857] Dynamic subtest reuse: SUCCESS (0.000s)
[382.603390] Starting dynamic subtest: reserve
[382.605684] Dynamic subtest reserve: SUCCESS (0.000s)
[382.615191] Starting dynamic subtest: fork-reopen-allocator
[382.617506] Dynamic subtest fork-reopen-allocator: SUCCESS (0.011s)
[382.619804] Subtest simple-allocator: SUCCESS (0.186s)
[382.705720] [058/154] (637s left) kms_frontbuffer_tracking (hdr-2p-scndscrn-cur-indfb-draw-mmap-cpu)
[382.786356] Starting subtest: hdr-2p-scndscrn-cur-indfb-draw-mmap-cpu
[382.790725] Subtest hdr-2p-scndscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[382.886842] [059/154] (637s left) vgem_basic (dmabuf-export)
[382.927459] Starting subtest: dmabuf-export
[382.949469] Subtest dmabuf-export: SUCCESS (0.026s)
[383.054092] [060/154] (637s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-pri-indfb-multidraw)
[383.145154] Starting subtest: fbcpsrhdr-1p-pri-indfb-multidraw
[383.149016] Subtest fbcpsrhdr-1p-pri-indfb-multidraw: SKIP (0.000s)
[383.240393] [061/154] (637s left) kms_frontbuffer_tracking (psrhdr-1p-offscreen-pri-indfb-draw-mmap-wc)
[383.331571] Starting subtest: psrhdr-1p-offscreen-pri-indfb-draw-mmap-wc
[383.335690] Subtest psrhdr-1p-offscreen-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[383.423651] [062/154] (637s left) kms_force_connector_basic (force-load-detect)
[383.476388] Subtest force-load-detect: SKIP (0.000s)
[383.535005] [063/154] (636s left) kms_psr (fbc-psr-cursor-plane-onoff)
[383.611472] Starting subtest: fbc-psr-cursor-plane-onoff
[383.613363] Starting dynamic subtest: eDP-1
[383.616747] Dynamic subtest eDP-1: SKIP (0.000s)
[383.620181] Subtest fbc-psr-cursor-plane-onoff: SKIP (0.001s)
[383.684218] [064/154] (636s left) kms_pipe_crc_basic (hang-read-crc)
[383.754160] Starting subtest: hang-read-crc
[383.756161] Starting dynamic subtest: pipe-A-eDP-1
[385.806606] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.049s)
[385.816736] Starting dynamic subtest: pipe-B-eDP-1
[388.681858] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.872s)
[388.692421] Starting dynamic subtest: pipe-C-eDP-1
[391.404736] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.720s)
[391.415369] Starting dynamic subtest: pipe-D-eDP-1
[394.076353] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.670s)
[394.078843] Subtest hang-read-crc: SUCCESS (10.317s)
[394.925134] [065/154] (625s left) kms_cursor_edge_walk (128x128-right-edge)
[395.002141] Starting subtest: 128x128-right-edge
[395.004567] Starting dynamic subtest: pipe-A-eDP-1
[398.457622] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.455s)
[398.468585] Starting dynamic subtest: pipe-D-eDP-1
[401.586426] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.127s)
[401.588672] Subtest 128x128-right-edge: SUCCESS (6.585s)
[402.419974] [066/154] (618s left) kms_frontbuffer_tracking (fbchdr-1p-primscrn-pri-shrfb-draw-render)
[402.510949] Starting subtest: fbchdr-1p-primscrn-pri-shrfb-draw-render
[402.514962] Subtest fbchdr-1p-primscrn-pri-shrfb-draw-render: SKIP (0.000s)
[402.604370] [067/154] (618s left) kms_ccs (ccs-on-another-bo-4-tiled-mtl-rc-ccs-cc)
[402.675185] Starting subtest: ccs-on-another-bo-4-tiled-mtl-rc-ccs-cc
[402.677516] Starting dynamic subtest: pipe-A-eDP-1
[402.698099] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[402.710535] Starting dynamic subtest: pipe-B-eDP-1
[402.730265] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[402.740254] Starting dynamic subtest: pipe-C-eDP-1
[402.759630] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[402.770928] Starting dynamic subtest: pipe-D-eDP-1
[402.790586] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[402.792792] Subtest ccs-on-another-bo-4-tiled-mtl-rc-ccs-cc: SUCCESS (0.007s)
[404.975952] [068/154] (615s left) kms_psr (fbc-psr2-sprite-render)
[405.056860] Starting subtest: fbc-psr2-sprite-render
[405.059086] Starting dynamic subtest: eDP-1
[405.063066] Dynamic subtest eDP-1: SKIP (0.000s)
[405.067082] Subtest fbc-psr2-sprite-render: SKIP (0.001s)
[405.137510] [069/154] (615s left) kms_frontbuffer_tracking (hdr-rgb565-draw-mmap-cpu)
[405.229071] Starting subtest: hdr-rgb565-draw-mmap-cpu
[405.233113] Subtest hdr-rgb565-draw-mmap-cpu: SKIP (0.000s)
[405.324411] [070/154] (615s left) kms_cursor_legacy (2x-cursor-vs-flip-atomic)
[405.431687] Starting subtest: 2x-cursor-vs-flip-atomic
[405.436311] Subtest 2x-cursor-vs-flip-atomic: SKIP (0.001s)
[405.574528] [071/154] (615s left) syncobj_basic (bad-pad-fd-to-handle)
[405.620217] Starting subtest: bad-pad-fd-to-handle
[405.622162] Subtest bad-pad-fd-to-handle: SUCCESS (0.000s)
[405.719627] [072/154] (615s left) kms_psr2_sf (psr2-overlay-plane-move-continuous-exceed-fully-sf)
[405.800804] Starting subtest: psr2-overlay-plane-move-continuous-exceed-fully-sf
[405.803153] Starting dynamic subtest: pipe-A-eDP-1
[422.271110] Dynamic subtest pipe-A-eDP-1: SUCCESS (16.473s)
[422.281704] Starting dynamic subtest: pipe-B-eDP-1
[439.436668] Dynamic subtest pipe-B-eDP-1: SUCCESS (17.165s)
[439.438981] Subtest psr2-overlay-plane-move-continuous-exceed-fully-sf: SUCCESS (33.641s)
[440.242904] [073/154] (580s left) kms_pipe_crc_basic (suspend-read-crc)
[440.315479] Starting subtest: suspend-read-crc
[440.317530] Starting dynamic subtest: pipe-A-eDP-1
[458.730118] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.605s)
[458.742501] Starting dynamic subtest: pipe-B-eDP-1
[476.707299] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.232s)
[476.722897] Starting dynamic subtest: pipe-C-eDP-1
[494.673932] Dynamic subtest pipe-C-eDP-1: SUCCESS (3.190s)
[494.684456] Starting dynamic subtest: pipe-D-eDP-1
[512.679944] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.110s)
[512.682029] Subtest suspend-read-crc: SUCCESS (12.142s)
[513.485862] [074/154] (507s left) syncobj_wait (wait-zero-handles)
[513.544598] Starting subtest: wait-zero-handles
[513.546929] Subtest wait-zero-handles: SUCCESS (0.000s)
[513.656356] [075/154] (507s left) kms_cursor_crc (cursor-random-64x21)
[513.820449] Starting subtest: cursor-random-64x21
[513.865583] Subtest cursor-random-64x21: SKIP (0.042s)
[514.096214] [076/154] (506s left) gem_tiled_partial_pwrite_pread (reads)
[514.145331] Subtest reads: SKIP (0.000s)
[514.228839] [077/154] (506s left) gem_exec_params (rel-constants-invalid-ring)
[514.289808] Starting subtest: rel-constants-invalid-ring
[514.291722] Subtest rel-constants-invalid-ring: SUCCESS (0.000s)
[514.381546] [078/154] (506s left) i915_pm_rpm (gem-execbuf-stress)
[515.968849] Starting subtest: gem-execbuf-stress
[515.971154] Starting dynamic subtest: smem0
[528.863240] Dynamic subtest smem0: SUCCESS (13.018s)
[528.875572] Starting dynamic subtest: extra-wait-smem0
[590.726246] Dynamic subtest extra-wait-smem0: SUCCESS (61.890s)
[590.729102] Subtest gem-execbuf-stress: SUCCESS (74.914s)
[591.095791] [079/154] (430s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-blt)
[591.178863] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-blt
[591.183199] Subtest psr-2p-scndscrn-spr-indfb-draw-blt: SKIP (0.000s)
[591.276303] [080/154] (429s left) kms_big_fb (4-tiled-16bpp-rotate-90)
[591.360767] Starting subtest: 4-tiled-16bpp-rotate-90
[591.380596] Subtest 4-tiled-16bpp-rotate-90: SKIP (0.019s)
[591.503944] [081/154] (429s left) gem_exec_schedule (deep)
[591.676194] Starting subtest: deep
[591.678692] Starting dynamic subtest: rcs0
[596.381951] Dynamic subtest rcs0: SKIP (4.704s)
[596.399357] Starting dynamic subtest: vcs0
[605.994661] Dynamic subtest vcs0: SUCCESS (9.617s)
[606.011232] Starting dynamic subtest: vcs1
[616.755759] Dynamic subtest vcs1: SUCCESS (10.755s)
[616.768064] Starting dynamic subtest: vecs0
[627.036707] Dynamic subtest vecs0: SUCCESS (10.274s)
[627.048788] Starting dynamic subtest: ccs0
[638.990453] Dynamic subtest ccs0: SUCCESS (11.951s)
[638.993544] Subtest deep: SUCCESS (47.307s)
[640.410072] [082/154] (380s left) kms_pm_rpm (system-suspend-modeset)
[641.919150] Starting subtest: system-suspend-modeset
[661.926722] Subtest system-suspend-modeset: SUCCESS (4.299s)
[662.309297] [083/154] (359s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-32bpp-ytileccs-downscaling)
[662.387171] Starting subtest: flip-32bpp-ytile-to-32bpp-ytileccs-downscaling
[662.392068] Subtest flip-32bpp-ytile-to-32bpp-ytileccs-downscaling: SKIP (0.000s)
[662.460604] [084/154] (358s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-indfb-pgflip-blt)
[662.531505] Starting subtest: fbcpsr-2p-scndscrn-indfb-pgflip-blt
[662.536376] Subtest fbcpsr-2p-scndscrn-indfb-pgflip-blt: SKIP (0.000s)
[662.646407] [085/154] (358s left) kms_psr (psr2-primary-blt)
[662.717286] Starting subtest: psr2-primary-blt
[662.719640] Starting dynamic subtest: eDP-1