[56.753025] Initializing watchdogs
[56.753075]   /dev/watchdog0
[56.766926] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:7d55 Intel Meteorlake (Gen12) Meteor Lake-P [Intel Arc Graphics]
[56.771148] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[56.773523] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[56.776726] [001/154] (960s left) api_intel_bb (render-ccs)
[56.847758] Starting subtest: render-ccs
[57.194507] Subtest render-ccs: SUCCESS (0.358s)
[57.316830] [002/154] (959s left) kms_scaling_modes (scaling-mode-center)
[57.411328] Starting subtest: scaling-mode-center
[57.413771] Starting dynamic subtest: pipe-A-eDP-1
[57.523644] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.118s)
[57.534256] Starting dynamic subtest: pipe-B-eDP-1
[58.707784] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.218s)
[58.714954] Starting dynamic subtest: pipe-C-eDP-1
[59.885326] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.206s)
[59.894238] Starting dynamic subtest: pipe-D-eDP-1
[61.005096] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.142s)
[61.007666] Subtest scaling-mode-center: SUCCESS (3.687s)
[62.146142] [003/154] (955s left) kms_addfb_basic (bad-pitch-32)
[62.208838] Starting subtest: bad-pitch-32
[62.211236] Subtest bad-pitch-32: SUCCESS (0.000s)
[62.352395] [004/154] (955s left) kms_ccs (crc-primary-basic-y-tiled-gen12-rc-ccs-cc)
[62.445634] Starting subtest: crc-primary-basic-y-tiled-gen12-rc-ccs-cc
[62.448152] Starting dynamic subtest: pipe-A-eDP-1
[62.470800] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[62.480117] Starting dynamic subtest: pipe-B-eDP-1
[62.501196] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[62.508633] Starting dynamic subtest: pipe-C-eDP-1
[62.530161] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[62.538549] Starting dynamic subtest: pipe-D-eDP-1
[62.561120] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[62.565204] Subtest crc-primary-basic-y-tiled-gen12-rc-ccs-cc: SKIP (0.004s)
[64.671628] [005/154] (952s left) kms_frontbuffer_tracking (psrhdr-1p-primscrn-pri-indfb-draw-render)
[64.777267] Starting subtest: psrhdr-1p-primscrn-pri-indfb-draw-render
[64.781106] Subtest psrhdr-1p-primscrn-pri-indfb-draw-render: SKIP (0.000s)
[64.881866] [006/154] (952s left) kms_atomic_transition (plane-all-transition-nonblocking-fencing)
[64.976717] Starting subtest: plane-all-transition-nonblocking-fencing
[64.978940] Starting dynamic subtest: pipe-A-eDP-1
[67.446328] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.496s)
[67.752141] Starting dynamic subtest: pipe-B-eDP-1
[70.966490] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.244s)
[71.263419] Subtest plane-all-transition-nonblocking-fencing: SUCCESS (6.337s)
[72.084093] [007/154] (945s left) kms_atomic (plane-invalid-params-fence)
[72.185840] Starting subtest: plane-invalid-params-fence
[72.188188] Starting dynamic subtest: pipe-A-eDP-1
[72.567373] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.384s)
[72.570216] Subtest plane-invalid-params-fence: SUCCESS (0.385s)
[73.413878] [008/154] (944s left) kms_frontbuffer_tracking (psr-rgb565-draw-blt)
[73.548255] Starting subtest: psr-rgb565-draw-blt
[80.671166] Subtest psr-rgb565-draw-blt: SUCCESS (7.145s)
[80.795830] [009/154] (936s left) kms_rotation_crc (bad-pixel-format)
[80.895348] Starting subtest: bad-pixel-format
[80.899945] Subtest bad-pixel-format: SKIP (0.001s)
[80.962792] [010/154] (936s left) vgem_basic (busy-fence)
[81.043843] Starting subtest: busy-fence
[81.045673] Subtest busy-fence: SUCCESS (0.001s)
[81.096099] [FACT vgem_basic (busy-fence)] new: kernel.kmod_is_loaded.vgem: true
[81.099172] [011/154] (936s left) gem_lmem_swapping (heavy-verify-multi)
[81.142142] Subtest heavy-verify-multi: SKIP (0.000s)
[81.185608] [012/154] (936s left) kms_plane (pixel-format-4-tiled-dg2-rc-ccs-cc-modifier-source-clamping)
[81.275402] Starting subtest: pixel-format-4-tiled-dg2-rc-ccs-cc-modifier-source-clamping
[81.279839] Subtest pixel-format-4-tiled-dg2-rc-ccs-cc-modifier-source-clamping: SKIP (0.000s)
[81.350019] [013/154] (936s left) gem_exec_store (dword)
[81.415858] Starting subtest: dword
[81.418199] Starting dynamic subtest: rcs0
[81.481833] Dynamic subtest rcs0: SUCCESS (0.067s)
[81.494151] Starting dynamic subtest: bcs0
[81.521909] Dynamic subtest bcs0: SUCCESS (0.040s)
[81.531695] Starting dynamic subtest: vcs0
[81.562343] Dynamic subtest vcs0: SUCCESS (0.040s)
[81.573990] Starting dynamic subtest: vcs1
[81.605288] Dynamic subtest vcs1: SUCCESS (0.042s)
[81.614171] Starting dynamic subtest: vecs0
[81.647110] Dynamic subtest vecs0: SUCCESS (0.041s)
[81.656876] Starting dynamic subtest: ccs0
[81.691084] Dynamic subtest ccs0: SUCCESS (0.043s)
[81.693144] Subtest dword: SUCCESS (0.278s)
[81.872135] [014/154] (935s left) syncobj_timeline (multi-wait-submitted-signaled)
[81.925407] Starting subtest: multi-wait-submitted-signaled
[81.927739] Subtest multi-wait-submitted-signaled: SUCCESS (0.001s)
[82.051362] [015/154] (935s left) kms_frontbuffer_tracking (hdr-2p-scndscrn-cur-indfb-draw-pwrite)
[82.151018] Starting subtest: hdr-2p-scndscrn-cur-indfb-draw-pwrite
[82.155176] Subtest hdr-2p-scndscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[82.261294] [016/154] (935s left) kms_frontbuffer_tracking (hdr-2p-primscrn-pri-indfb-draw-mmap-cpu)
[82.364492] Starting subtest: hdr-2p-primscrn-pri-indfb-draw-mmap-cpu
[82.368725] Subtest hdr-2p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[82.442386] [017/154] (935s left) syncobj_wait (invalid-wait-illegal-handle)
[82.489993] Starting subtest: invalid-wait-illegal-handle
[82.492322] Subtest invalid-wait-illegal-handle: SUCCESS (0.000s)
[82.588416] [018/154] (935s left) kms_content_protection (dp-mst-lic-type-0-hdcp14)
[82.723431] Starting subtest: dp-mst-lic-type-0-hdcp14
[82.728073] Subtest dp-mst-lic-type-0-hdcp14: SKIP (0.000s)
[82.841861] [019/154] (935s left) perf (gen12-invalid-class-instance)
[82.962686] Starting subtest: gen12-invalid-class-instance
[82.973115] Subtest gen12-invalid-class-instance: SUCCESS (0.010s)
[83.014835] [020/154] (934s left) kms_cursor_crc (cursor-rapid-movement-256x256)
[83.244316] Starting subtest: cursor-rapid-movement-256x256
[83.248189] Starting dynamic subtest: pipe-A-eDP-1
[83.823349] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.575s)
[83.856958] Starting dynamic subtest: pipe-D-eDP-1
[85.024363] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.176s)
[85.026706] Subtest cursor-rapid-movement-256x256: SUCCESS (1.780s)
[85.878890] [021/154] (932s left) gem_mmap_offset (pf-nonblock)
[85.932054] Starting subtest: pf-nonblock
[85.938669] Subtest pf-nonblock: SUCCESS (0.007s)
[86.070782] [022/154] (932s left) kms_frontbuffer_tracking (fbchdr-1p-primscrn-spr-indfb-draw-blt)
[86.178377] Starting subtest: fbchdr-1p-primscrn-spr-indfb-draw-blt
[86.182633] Subtest fbchdr-1p-primscrn-spr-indfb-draw-blt: SKIP (0.000s)
[86.282910] [023/154] (931s left) prime_vgem (wait)
[86.349350] Starting subtest: wait
[86.351653] Starting dynamic subtest: rcs0
[86.388253] Dynamic subtest rcs0: SUCCESS (0.039s)
[86.396201] Starting dynamic subtest: bcs0
[86.466175] Dynamic subtest bcs0: SUCCESS (0.077s)
[86.474517] Starting dynamic subtest: vcs0
[86.511690] Dynamic subtest vcs0: SUCCESS (0.045s)
[86.519331] Starting dynamic subtest: vcs1
[86.555534] Dynamic subtest vcs1: SUCCESS (0.043s)
[86.563200] Starting dynamic subtest: vecs0
[86.601061] Dynamic subtest vecs0: SUCCESS (0.045s)
[86.608964] Starting dynamic subtest: ccs0
[86.648267] Dynamic subtest ccs0: SUCCESS (0.047s)
[86.650810] Subtest wait: SUCCESS (0.300s)
[86.781464] [024/154] (931s left) kms_cursor_crc (cursor-onscreen-64x64)
[86.949262] Starting subtest: cursor-onscreen-64x64
[86.951080] Starting dynamic subtest: pipe-A-eDP-1
[89.818521] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.861s)
[89.844747] Starting dynamic subtest: pipe-D-eDP-1
[92.133019] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.294s)
[92.135535] Subtest cursor-onscreen-64x64: SUCCESS (5.183s)
[93.021251] [025/154] (925s left) kms_frontbuffer_tracking (fbchdr-2p-pri-indfb-multidraw)
[93.112986] Starting subtest: fbchdr-2p-pri-indfb-multidraw
[93.117202] Subtest fbchdr-2p-pri-indfb-multidraw: SKIP (0.000s)
[93.201646] [026/154] (925s left) gem_eio (in-flight-internal-10ms)
[93.415369] Starting subtest: in-flight-internal-10ms
[95.363893] Subtest in-flight-internal-10ms: SUCCESS (1.948s)
[95.493989] [027/154] (922s left) kms_plane_scaling (planes-upscale-factor-0-25)
[95.591064] Starting subtest: planes-upscale-factor-0-25
[95.593588] Starting dynamic subtest: pipe-A
[95.652889] Dynamic subtest pipe-A: SUCCESS (0.063s)
[95.663152] Starting dynamic subtest: pipe-B
[96.831753] Dynamic subtest pipe-B: SUCCESS (1.178s)
[96.843288] Starting dynamic subtest: pipe-C
[97.936111] Dynamic subtest pipe-C: SUCCESS (1.104s)
[97.945817] Starting dynamic subtest: pipe-D
[99.058717] Dynamic subtest pipe-D: SUCCESS (1.122s)
[99.061064] Subtest planes-upscale-factor-0-25: SUCCESS (3.469s)
[100.208250] [028/154] (918s left) kms_frontbuffer_tracking (fbchdr-2p-scndscrn-cur-indfb-draw-pwrite)
[100.314624] Starting subtest: fbchdr-2p-scndscrn-cur-indfb-draw-pwrite
[100.318670] Subtest fbchdr-2p-scndscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[100.411745] [029/154] (917s left) gem_ctx_sseu (invalid-sseu)
[100.478597] Subtest invalid-sseu: SKIP (0.000s)
[100.556296] [030/154] (917s left) kms_frontbuffer_tracking (fbchdr-1p-offscreen-pri-shrfb-draw-render)
[100.660284] Starting subtest: fbchdr-1p-offscreen-pri-shrfb-draw-render
[100.664590] Subtest fbchdr-1p-offscreen-pri-shrfb-draw-render: SKIP (0.000s)
[100.748392] [031/154] (917s left) gem_exec_capture (capture-invisible)
[100.803903] Starting subtest: capture-invisible
[100.806250] Starting dynamic subtest: smem0
[100.810770] Dynamic subtest smem0: SKIP (0.000s)
[100.817653] Subtest capture-invisible: SKIP (0.000s)
[100.931643] [032/154] (917s left) kms_psr (psr2-sprite-mmap-cpu)
[101.027327] Starting subtest: psr2-sprite-mmap-cpu
[101.029654] Starting dynamic subtest: eDP-1
[102.806196] Dynamic subtest eDP-1: SUCCESS (1.778s)
[102.808420] Subtest psr2-sprite-mmap-cpu: SUCCESS (1.778s)
[103.675435] [033/154] (914s left) kms_hdr (bpc-switch-dpms)
[103.773824] Starting subtest: bpc-switch-dpms
[103.776121] Starting dynamic subtest: pipe-A-eDP-1-XRGB2101010
[109.373474] Dynamic subtest pipe-A-eDP-1-XRGB2101010: SUCCESS (5.599s)
[109.383996] Starting dynamic subtest: pipe-A-eDP-1-XRGB16161616F
[114.938526] Dynamic subtest pipe-A-eDP-1-XRGB16161616F: SUCCESS (5.563s)
[114.940998] Subtest bpc-switch-dpms: SUCCESS (11.165s)
[115.069715] [034/154] (903s left) syncobj_timeline (invalid-transfer-illegal-handle)
[115.131427] Starting subtest: invalid-transfer-illegal-handle
[115.133679] Subtest invalid-transfer-illegal-handle: SUCCESS (0.000s)
[115.232989] [035/154] (903s left) kms_flip (2x-blocking-absolute-wf_vblank-interruptible)
[115.325473] Starting subtest: 2x-blocking-absolute-wf_vblank-interruptible
[115.336497] Subtest 2x-blocking-absolute-wf_vblank-interruptible: SKIP (0.010s)
[115.418295] [036/154] (903s left) syncobj_timeline (32bits-limit)
[115.470619] Starting subtest: 32bits-limit
[115.472955] Subtest 32bits-limit: SUCCESS (0.001s)
[115.592796] [037/154] (903s left) gem_exec_balancer (bonded-semaphore)
[115.650861] Starting subtest: bonded-semaphore
[115.656024] Subtest bonded-semaphore: SKIP (0.000s)
[115.975850] [038/154] (902s left) i915_query (query-regions-sanity-check)
[116.029634] Starting subtest: query-regions-sanity-check
[116.040927] Subtest query-regions-sanity-check: SUCCESS (0.013s)
[116.188185] [039/154] (902s left) kms_pipe_crc_basic (hang-read-crc)
[116.270157] Starting subtest: hang-read-crc
[116.272498] Starting dynamic subtest: pipe-A-eDP-1
[118.378657] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.107s)
[118.388167] Starting dynamic subtest: pipe-B-eDP-1
[121.143456] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.765s)
[121.153345] Starting dynamic subtest: pipe-C-eDP-1
[123.784493] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.638s)
[123.793765] Starting dynamic subtest: pipe-D-eDP-1
[126.451496] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.665s)
[126.453854] Subtest hang-read-crc: SUCCESS (10.180s)
[127.262220] [040/154] (891s left) gem_exec_reloc (basic-gtt-read)
[127.331350] Subtest basic-gtt-read: SKIP (0.000s)
[127.406710] [041/154] (891s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-mmap-gtt)
[127.497901] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-mmap-gtt
[127.502064] Subtest fbc-2p-scndscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[127.597411] [042/154] (891s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-primscrn-pri-shrfb-draw-pwrite)
[127.695462] Starting subtest: fbcpsrhdr-1p-primscrn-pri-shrfb-draw-pwrite
[127.699661] Subtest fbcpsrhdr-1p-primscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[127.796892] [043/154] (891s left) syncobj_timeline (etime-multi-wait-for-submit-unsubmitted)
[127.843949] Starting subtest: etime-multi-wait-for-submit-unsubmitted
[127.947518] Subtest etime-multi-wait-for-submit-unsubmitted: SUCCESS (0.103s)
[128.022386] [044/154] (890s left) gem_softpin (noreloc)
[128.073927] Starting subtest: noreloc
[133.551605] Subtest noreloc: SUCCESS (5.415s)
[133.619403] [045/154] (885s left) gem_ctx_persistence (engines-hostile-preempt)
[133.686493] Starting subtest: engines-hostile-preempt
[133.688948] Starting dynamic subtest: rcs0
[133.781833] Dynamic subtest rcs0: SUCCESS (0.095s)
[133.793456] Starting dynamic subtest: bcs0
[133.839979] Dynamic subtest bcs0: SUCCESS (0.056s)
[133.850134] Starting dynamic subtest: vcs0
[135.285310] Dynamic subtest vcs0: SUCCESS (1.442s)
[135.295451] Starting dynamic subtest: vcs1
[137.253985] Dynamic subtest vcs1: SUCCESS (1.966s)
[137.266032] Starting dynamic subtest: vecs0
[139.319384] Dynamic subtest vecs0: SUCCESS (2.005s)
[139.331784] Starting dynamic subtest: ccs0
[139.334222] Dynamic subtest ccs0: SUCCESS (0.060s)
[139.336680] Subtest engines-hostile-preempt: SUCCESS (5.637s)
[139.429469] [046/154] (879s left) gem_exec_fence (basic-busy-all)
[139.490926] Starting subtest: basic-busy-all
[139.583059] Subtest basic-busy-all: SUCCESS (0.093s)
[141.392534] [047/154] (877s left) gem_eio (in-flight-internal-immediate)
[141.634590] Starting subtest: in-flight-internal-immediate
[143.378415] Subtest in-flight-internal-immediate: SUCCESS (1.742s)
[143.521585] [048/154] (875s left) kms_getfb (getfb-handle-closed)
[143.625496] Starting subtest: getfb-handle-closed
[143.627810] Subtest getfb-handle-closed: SUCCESS (0.000s)
[143.747572] [049/154] (875s left) kms_psr (fbc-psr2-sprite-mmap-cpu)
[143.846086] Starting subtest: fbc-psr2-sprite-mmap-cpu
[143.848359] Starting dynamic subtest: eDP-1
[143.852710] Dynamic subtest eDP-1: SKIP (0.000s)
[143.857098] Subtest fbc-psr2-sprite-mmap-cpu: SKIP (0.001s)
[143.928550] [050/154] (875s left) syncobj_wait (multi-wait-all-for-submit-submitted)
[143.984142] Starting subtest: multi-wait-all-for-submit-submitted
[144.093445] Subtest multi-wait-all-for-submit-submitted: SUCCESS (0.107s)
[144.169414] [051/154] (875s left) gem_eio (wait-wedge-1us)
[144.380694] Starting subtest: wait-wedge-1us
[145.353642] Subtest wait-wedge-1us: SUCCESS (0.971s)
[145.494473] [052/154] (873s left) kms_psr (fbc-pr-sprite-mmap-gtt)
[145.592403] Starting subtest: fbc-pr-sprite-mmap-gtt
[145.597081] Subtest fbc-pr-sprite-mmap-gtt: SKIP (0.000s)
[145.664341] [053/154] (873s left) kms_big_fb (x-tiled-32bpp-rotate-180)
[145.776253] Starting subtest: x-tiled-32bpp-rotate-180
[147.200776] Subtest x-tiled-32bpp-rotate-180: SUCCESS (1.426s)
[147.345919] [054/154] (872s left) kms_frontbuffer_tracking (fbc-2p-indfb-fliptrack-mmap-gtt)
[147.442959] Starting subtest: fbc-2p-indfb-fliptrack-mmap-gtt
[147.446417] Subtest fbc-2p-indfb-fliptrack-mmap-gtt: SKIP (0.000s)
[147.532595] [055/154] (871s left) kms_big_fb (y-tiled-32bpp-rotate-0)
[147.639905] Starting subtest: y-tiled-32bpp-rotate-0
[147.643910] Subtest y-tiled-32bpp-rotate-0: SKIP (0.000s)
[147.739102] [056/154] (871s left) prime_vgem (basic-fence-mmap)
[147.808149] Starting subtest: basic-fence-mmap
[147.811930] Subtest basic-fence-mmap: SKIP (0.000s)
[147.904735] [057/154] (871s left) gem_partial_pwrite_pread (reads-uncached)
[147.973086] Subtest reads-uncached: SKIP (0.000s)
[148.050939] [058/154] (871s left) gem_vm_create (execbuf)
[148.107699] Starting subtest: execbuf
[148.118577] Subtest execbuf: SUCCESS (0.011s)
[148.238362] [059/154] (871s left) kms_rotation_crc (primary-yf-tiled-reflect-x-270)
[148.328466] Starting subtest: primary-yf-tiled-reflect-x-270
[148.332150] Subtest primary-yf-tiled-reflect-x-270: SKIP (0.001s)
[148.398113] [060/154] (871s left) gem_flink_basic (bad-flink)
[148.449075] Starting subtest: bad-flink
[148.451066] Subtest bad-flink: SUCCESS (0.000s)
[148.562338] [061/154] (871s left) kms_frontbuffer_tracking (psrhdr-2p-primscrn-spr-indfb-onoff)
[148.658766] Starting subtest: psrhdr-2p-primscrn-spr-indfb-onoff
[148.662419] Subtest psrhdr-2p-primscrn-spr-indfb-onoff: SKIP (0.000s)
[148.759315] [062/154] (870s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip)
[148.865052] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip
[149.523398] Subtest 4-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip: SUCCESS (0.659s)
[149.687838] [063/154] (870s left) gem_mmap_wc (read-write)
[149.745118] Subtest read-write: SKIP (0.000s)
[149.800318] [064/154] (869s left) gem_ctx_exec (basic-invalid-context)
[149.846915] Starting subtest: basic-invalid-context
[149.851751] Subtest basic-invalid-context: SUCCESS (0.004s)
[149.974600] [065/154] (869s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-onoff)
[150.087292] Starting subtest: fbc-2p-primscrn-cur-indfb-onoff
[150.091587] Subtest fbc-2p-primscrn-cur-indfb-onoff: SKIP (0.000s)
[150.197353] [066/154] (869s left) i915_pm_rps (thresholds)
[150.247691] Starting subtest: thresholds
[150.252265] Subtest thresholds: SKIP (0.001s)
[150.352482] [067/154] (869s left) gem_render_copy (yf-tiled-mc-ccs-to-vebox-yf-tiled)
[150.402993] Starting subtest: yf-tiled-mc-ccs-to-vebox-yf-tiled
[150.407585] Subtest yf-tiled-mc-ccs-to-vebox-yf-tiled: SKIP (0.000s)
[150.609029] [068/154] (869s left) kms_flip_scaled_crc (flip-32bpp-yftile-to-64bpp-yftile-upscaling)
[150.695429] Starting subtest: flip-32bpp-yftile-to-64bpp-yftile-upscaling
[150.699930] Subtest flip-32bpp-yftile-to-64bpp-yftile-upscaling: SKIP (0.000s)
[150.765593] [069/154] (869s left) kms_frontbuffer_tracking (psrhdr-rgb565-draw-mmap-gtt)
[150.864173] Starting subtest: psrhdr-rgb565-draw-mmap-gtt
[150.868660] Subtest psrhdr-rgb565-draw-mmap-gtt: SKIP (0.000s)
[150.960314] [070/154] (869s left) kms_color (ctm-blue-to-red)
[151.050968] Starting subtest: ctm-blue-to-red
[151.053208] Starting dynamic subtest: pipe-A-eDP-1
[151.752679] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.701s)
[151.761799] Starting dynamic subtest: pipe-B-eDP-1
[153.151450] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.399s)
[153.161351] Starting dynamic subtest: pipe-C-eDP-1
[154.535457] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.381s)
[154.545166] Starting dynamic subtest: pipe-D-eDP-1
[155.873631] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.339s)
[155.876090] Subtest ctm-blue-to-red: SUCCESS (4.823s)
[156.679866] [071/154] (863s left) gem_render_copy_redux (flink-interruptible)
[156.732808] Starting subtest: flink-interruptible
[157.587368] Subtest flink-interruptible: SUCCESS (0.855s)
[157.704655] [072/154] (862s left) kms_psr (fbc-psr-suspend)
[157.797538] Starting subtest: fbc-psr-suspend
[157.799581] Starting dynamic subtest: eDP-1
[157.803246] Dynamic subtest eDP-1: SKIP (0.000s)
[157.806792] Subtest fbc-psr-suspend: SKIP (0.001s)
[157.867452] [073/154] (862s left) gem_exec_flush (basic-wb-prw-default)
[157.922489] Starting subtest: basic-wb-prw-default
[163.405837] Subtest basic-wb-prw-default: SUCCESS (5.459s)
[163.566032] [074/154] (856s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-mmap-wc)
[163.671589] Starting subtest: psr-2p-primscrn-spr-indfb-draw-mmap-wc
[163.676069] Subtest psr-2p-primscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[163.772561] [075/154] (856s left) kms_async_flips (async-flip-with-page-flip-events-tiled)
[163.865520] Starting subtest: async-flip-with-page-flip-events-tiled
[164.239779] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs
[167.110193] Dynamic subtest pipe-A-eDP-1-4-rc-ccs: SUCCESS (2.817s)
[167.126182] Starting dynamic subtest: pipe-A-eDP-1-4
[169.283104] Dynamic subtest pipe-A-eDP-1-4: SUCCESS (2.173s)
[169.292836] Starting dynamic subtest: pipe-A-eDP-1-4
[171.241124] Dynamic subtest pipe-A-eDP-1-4: SUCCESS (2.008s)
[171.250166] Starting dynamic subtest: pipe-A-eDP-1-x
[173.472052] Dynamic subtest pipe-A-eDP-1-x: SUCCESS (2.178s)
[173.789193] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs
[176.642079] Dynamic subtest pipe-B-eDP-1-4-rc-ccs: SUCCESS (2.810s)
[176.653178] Starting dynamic subtest: pipe-B-eDP-1-4
[178.829356] Dynamic subtest pipe-B-eDP-1-4: SUCCESS (2.184s)
[178.841477] Starting dynamic subtest: pipe-B-eDP-1-4
[180.787226] Dynamic subtest pipe-B-eDP-1-4: SUCCESS (2.009s)
[180.797971] Starting dynamic subtest: pipe-B-eDP-1-x
[183.029199] Dynamic subtest pipe-B-eDP-1-x: SUCCESS (2.189s)
[183.343824] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs
[186.179009] Dynamic subtest pipe-C-eDP-1-4-rc-ccs: SUCCESS (2.792s)
[186.189615] Starting dynamic subtest: pipe-C-eDP-1-4
[188.353216] Dynamic subtest pipe-C-eDP-1-4: SUCCESS (2.173s)
[188.361605] Starting dynamic subtest: pipe-C-eDP-1-4
[190.312914] Dynamic subtest pipe-C-eDP-1-4: SUCCESS (2.009s)
[190.324992] Starting dynamic subtest: pipe-C-eDP-1-x
[192.541081] Dynamic subtest pipe-C-eDP-1-x: SUCCESS (2.177s)
[192.869225] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs
[195.665449] Dynamic subtest pipe-D-eDP-1-4-rc-ccs: SUCCESS (2.801s)
[195.674753] Starting dynamic subtest: pipe-D-eDP-1-4
[197.892020] Dynamic subtest pipe-D-eDP-1-4: SUCCESS (2.173s)
[197.901777] Starting dynamic subtest: pipe-D-eDP-1-4
[199.849416] Dynamic subtest pipe-D-eDP-1-4: SUCCESS (2.009s)
[199.864346] Starting dynamic subtest: pipe-D-eDP-1-x
[202.080140] Dynamic subtest pipe-D-eDP-1-x: SUCCESS (2.177s)
[202.082722] Subtest async-flip-with-page-flip-events-tiled: SUCCESS (38.162s)
[203.265917] [076/154] (816s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-pwrite)
[203.373105] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-pwrite
[208.723869] Subtest fbc-1p-primscrn-pri-indfb-draw-pwrite: SUCCESS (5.357s)
[209.857451] [077/154] (810s left) kms_frontbuffer_tracking (psrhdr-2p-primscrn-shrfb-pgflip-blt)
[209.959689] Starting subtest: psrhdr-2p-primscrn-shrfb-pgflip-blt
[209.963684] Subtest psrhdr-2p-primscrn-shrfb-pgflip-blt: SKIP (0.000s)
[210.069453] [078/154] (810s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-0)
[210.167430] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-0
[210.171758] Subtest yf-tiled-max-hw-stride-32bpp-rotate-0: SKIP (0.000s)
[210.257522] [079/154] (810s left) kms_frontbuffer_tracking (fbc-shrfb-scaledprimary)
[210.350751] Starting subtest: fbc-shrfb-scaledprimary
[213.238755] Subtest fbc-shrfb-scaledprimary: SUCCESS (2.892s)
[214.400697] [080/154] (806s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-shrfb-fliptrack-mmap-gtt)
[214.497027] Starting subtest: fbcpsrhdr-1p-shrfb-fliptrack-mmap-gtt
[214.501560] Subtest fbcpsrhdr-1p-shrfb-fliptrack-mmap-gtt: SKIP (0.000s)
[214.601670] [081/154] (805s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-shrfb-pgflip-blt)
[214.705814] Starting subtest: fbcpsr-2p-scndscrn-shrfb-pgflip-blt
[214.710176] Subtest fbcpsr-2p-scndscrn-shrfb-pgflip-blt: SKIP (0.000s)
[214.817872] [082/154] (805s left) kms_vblank (accuracy-idle)
[214.920189] Starting subtest: accuracy-idle
[214.922391] Starting dynamic subtest: pipe-A-eDP-1
[216.678579] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.757s)
[216.693295] Starting dynamic subtest: pipe-D-eDP-1
[219.118232] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.439s)
[219.120628] Subtest accuracy-idle: SUCCESS (4.200s)
[219.938293] [083/154] (800s left) kms_busy (extended-pageflip-hang-newfb)
[220.023195] Starting subtest: extended-pageflip-hang-newfb
[220.025496] Starting dynamic subtest: pipe-A
[246.104376] Dynamic subtest pipe-A: SUCCESS (26.078s)
[246.114689] Starting dynamic subtest: pipe-D
[261.091521] Dynamic subtest pipe-D: SUCCESS (14.984s)
[261.093840] Subtest extended-pageflip-hang-newfb: SUCCESS (41.067s)
[261.897756] [084/154] (758s left) kms_setmode (invalid-clone-single-crtc-stealing)
[261.946080] Starting subtest: invalid-clone-single-crtc-stealing
[261.952318] Subtest invalid-clone-single-crtc-stealing: SKIP (0.000s)
[262.041132] [085/154] (758s left) kms_frontbuffer_tracking (hdr-1p-primscrn-pri-shrfb-draw-mmap-cpu)
[262.129980] Starting subtest: hdr-1p-primscrn-pri-shrfb-draw-mmap-cpu
[262.134194] Subtest hdr-1p-primscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[262.218788] [086/154] (758s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-pwrite)
[262.333623] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-pwrite
[270.972410] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-pwrite: SUCCESS (8.645s)
[271.109061] [087/154] (749s left) gem_fenced_exec_thrash (no-spare-fences-interruptible)
[271.179125] Subtest no-spare-fences-interruptible: SKIP (0.000s)
[271.242316] [088/154] (749s left) gem_exec_fence (nb-await)
[271.419945] Starting subtest: nb-await
[271.422516] Starting dynamic subtest: rcs0
[271.487384] Dynamic subtest rcs0: SUCCESS (0.067s)
[271.499134] Starting dynamic subtest: bcs0
[271.546378] Dynamic subtest bcs0: SUCCESS (0.056s)
[271.559073] Starting dynamic subtest: vcs0
[271.606403] Dynamic subtest vcs0: SUCCESS (0.058s)
[271.618059] Starting dynamic subtest: vcs1
[271.665282] Dynamic subtest vcs1: SUCCESS (0.057s)
[271.675720] Starting dynamic subtest: vecs0
[271.726373] Dynamic subtest vecs0: SUCCESS (0.058s)
[271.737926] Starting dynamic subtest: ccs0
[271.783838] Dynamic subtest ccs0: SUCCESS (0.056s)
[271.786688] Subtest nb-await: SUCCESS (0.365s)
[273.364910] [089/154] (747s left) kms_frontbuffer_tracking (fbchdr-2p-scndscrn-pri-shrfb-draw-render)
[273.463552] Starting subtest: fbchdr-2p-scndscrn-pri-shrfb-draw-render
[273.467832] Subtest fbchdr-2p-scndscrn-pri-shrfb-draw-render: SKIP (0.000s)
[273.555175] [090/154] (747s left) kms_frontbuffer_tracking (fbcpsr-1p-shrfb-fliptrack-mmap-gtt)
[273.657810] Starting subtest: fbcpsr-1p-shrfb-fliptrack-mmap-gtt
[273.661742] Subtest fbcpsr-1p-shrfb-fliptrack-mmap-gtt: SKIP (0.000s)
[273.742966] [091/154] (747s left) kms_flip (2x-plain-flip-ts-check-interruptible)
[273.832315] Starting subtest: 2x-plain-flip-ts-check-interruptible
[273.843379] Subtest 2x-plain-flip-ts-check-interruptible: SKIP (0.010s)
[273.932097] [092/154] (746s left) gem_spin_batch (spin-all-new)
[273.983920] Starting subtest: spin-all-new
[274.002469] Subtest spin-all-new: SUCCESS (0.017s)
[275.389916] [093/154] (745s left) kms_ccs (bad-pixel-format-4-tiled-dg2-mc-ccs)
[275.500289] Starting subtest: bad-pixel-format-4-tiled-dg2-mc-ccs
[275.502479] Starting dynamic subtest: pipe-A-eDP-1
[275.525427] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[275.536257] Starting dynamic subtest: pipe-B-eDP-1
[275.557085] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[275.565628] Starting dynamic subtest: pipe-C-eDP-1
[275.586581] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[275.594933] Starting dynamic subtest: pipe-D-eDP-1
[275.616307] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[275.620310] Subtest bad-pixel-format-4-tiled-dg2-mc-ccs: SKIP (0.004s)
[277.798493] [094/154] (743s left) kms_psr (pr-primary-blt)
[277.892182] Starting subtest: pr-primary-blt
[277.896744] Subtest pr-primary-blt: SKIP (0.000s)
[277.966780] [095/154] (743s left) kms_frontbuffer_tracking (psrhdr-1p-primscrn-spr-indfb-draw-blt)
[278.059523] Starting subtest: psrhdr-1p-primscrn-spr-indfb-draw-blt
[278.063802] Subtest psrhdr-1p-primscrn-spr-indfb-draw-blt: SKIP (0.000s)
[278.163744] [096/154] (742s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-fullscreen)
[278.263801] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-fullscreen
[278.267823] Subtest fbcpsr-2p-primscrn-spr-indfb-fullscreen: SKIP (0.000s)
[278.363645] [097/154] (742s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-onoff)
[278.460528] Starting subtest: psr-1p-primscrn-spr-indfb-onoff
[285.509916] Subtest psr-1p-primscrn-spr-indfb-onoff: SUCCESS (7.056s)
[285.643849] [098/154] (735s left) kms_frontbuffer_tracking (hdr-2p-primscrn-cur-indfb-onoff)
[285.743517] Starting subtest: hdr-2p-primscrn-cur-indfb-onoff
[285.747751] Subtest hdr-2p-primscrn-cur-indfb-onoff: SKIP (0.000s)
[285.846242] [099/154] (735s left) kms_frontbuffer_tracking (hdr-2p-scndscrn-spr-indfb-draw-pwrite)
[285.937576] Starting subtest: hdr-2p-scndscrn-spr-indfb-draw-pwrite
[285.941591] Subtest hdr-2p-scndscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[286.029313] [100/154] (735s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-mmap-cpu)
[286.128586] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-mmap-cpu
[290.415570] Subtest fbc-1p-primscrn-pri-shrfb-draw-mmap-cpu: SUCCESS (4.293s)
[291.616692] [101/154] (729s left) gen9_exec_parse (bb-chained)
[291.682085] Subtest bb-chained: SKIP (0.000s)
[291.763579] [102/154] (729s left) kms_fb_coherency (memset-crc)
[291.857885] Starting subtest: memset-crc
[291.860167] Starting dynamic subtest: mmap-offset-wc
[292.253936] Dynamic subtest mmap-offset-wc: SUCCESS (0.397s)
[292.557576] Starting dynamic subtest: mmap-offset-uc
[298.667501] Dynamic subtest mmap-offset-uc: SUCCESS (6.118s)
[298.964235] Subtest memset-crc: SUCCESS (7.108s)
[299.785672] [103/154] (721s left) sw_sync (sync_merge_invalid)
[299.825338] Starting subtest: sync_merge_invalid
[299.839505] Subtest sync_merge_invalid: SUCCESS (0.015s)
[299.906303] [104/154] (721s left) kms_plane (pixel-format-4-tiled-mtl-rc-ccs-cc-modifier)
[300.000452] Starting subtest: pixel-format-4-tiled-mtl-rc-ccs-cc-modifier
[300.028382] Starting dynamic subtest: pipe-A-plane-0
[300.317271] Dynamic subtest pipe-A-plane-0: SUCCESS (0.289s)
[300.329374] Starting dynamic subtest: pipe-A-plane-3
[300.550607] Dynamic subtest pipe-A-plane-3: SUCCESS (0.233s)
[300.562777] Starting dynamic subtest: pipe-A-plane-5
[300.568689] Dynamic subtest pipe-A-plane-5: SKIP (0.000s)
[301.682474] Starting dynamic subtest: pipe-B-plane-0
[301.975098] Dynamic subtest pipe-B-plane-0: SUCCESS (0.300s)
[301.984682] Starting dynamic subtest: pipe-B-plane-3
[302.219859] Dynamic subtest pipe-B-plane-3: SUCCESS (0.243s)
[302.228704] Starting dynamic subtest: pipe-B-plane-5
[302.233093] Dynamic subtest pipe-B-plane-5: SKIP (0.000s)
[302.534429] Subtest pixel-format-4-tiled-mtl-rc-ccs-cc-modifier: SUCCESS (2.534s)
[303.354639] [105/154] (718s left) kms_ccs (crc-sprite-planes-basic-4-tiled-dg2-rc-ccs)
[303.463849] Starting subtest: crc-sprite-planes-basic-4-tiled-dg2-rc-ccs
[303.466559] Starting dynamic subtest: pipe-A-eDP-1
[303.526396] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[303.534949] Starting dynamic subtest: pipe-B-eDP-1
[303.592016] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[303.602614] Starting dynamic subtest: pipe-C-eDP-1
[303.659646] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[303.669854] Starting dynamic subtest: pipe-D-eDP-1
[303.724792] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[303.728781] Subtest crc-sprite-planes-basic-4-tiled-dg2-rc-ccs: SKIP (0.008s)
[305.717121] [106/154] (715s left) kms_cursor_legacy (flip-vs-cursor-crc-atomic)
[305.829882] Starting subtest: flip-vs-cursor-crc-atomic
[306.532968] Subtest flip-vs-cursor-crc-atomic: SUCCESS (0.703s)
[307.339456] [107/154] (714s left) gem_exec_schedule (implicit-write-read)
[307.402967] Starting subtest: implicit-write-read
[307.405468] Starting dynamic subtest: rcs0
[307.499887] Dynamic subtest rcs0: SUCCESS (0.107s)
[307.510410] Starting dynamic subtest: vcs0
[307.582434] Dynamic subtest vcs0: SUCCESS (0.082s)
[307.593807] Starting dynamic subtest: vcs1
[307.660803] Dynamic subtest vcs1: SUCCESS (0.077s)
[307.673047] Starting dynamic subtest: vecs0
[307.744497] Dynamic subtest vecs0: SUCCESS (0.083s)
[307.756916] Starting dynamic subtest: ccs0
[307.843238] Dynamic subtest ccs0: SUCCESS (0.098s)
[307.845928] Subtest implicit-write-read: SUCCESS (0.452s)
[309.401802] [108/154] (712s left) gem_lmem_swapping (verify-random-ccs)
[309.445220] Subtest verify-random-ccs: SKIP (0.000s)
[309.485367] [109/154] (712s left) kms_chamelium_frames (hdmi-frame-dump)
[309.870255] Subtest hdmi-frame-dump: SKIP (0.000s)
[310.658620] [110/154] (711s left) i915_drm_fdinfo (most-busy-check-all)
[310.700141] Starting subtest: most-busy-check-all
[310.702356] Starting dynamic subtest: rcs0
[310.707152] Dynamic subtest rcs0: SKIP (0.004s)
[310.717267] Starting dynamic subtest: bcs0
[310.721494] Dynamic subtest bcs0: SKIP (0.000s)
[310.732090] Starting dynamic subtest: vcs0
[310.736084] Dynamic subtest vcs0: SKIP (0.000s)
[310.744451] Starting dynamic subtest: vcs1
[310.748321] Dynamic subtest vcs1: SKIP (0.000s)
[310.756858] Starting dynamic subtest: vecs0
[310.760849] Dynamic subtest vecs0: SKIP (0.000s)
[310.768863] Starting dynamic subtest: ccs0
[310.772937] Dynamic subtest ccs0: SKIP (0.000s)
[310.776998] Subtest most-busy-check-all: SKIP (0.009s)
[310.814447] [111/154] (710s left) kms_rotation_crc (sprite-rotation-90-pos-100-0)
[310.928250] Starting subtest: sprite-rotation-90-pos-100-0
[310.932922] Subtest sprite-rotation-90-pos-100-0: SKIP (0.001s)
[311.014297] [112/154] (710s left) syncobj_timeline (single-wait-signaled)
[311.069233] Starting subtest: single-wait-signaled
[311.071705] Subtest single-wait-signaled: SUCCESS (0.000s)
[311.170130] [113/154] (710s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-onoff)
[311.271706] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-onoff
[318.348026] Subtest fbcpsr-1p-primscrn-spr-indfb-onoff: SUCCESS (7.082s)
[318.505579] [114/154] (703s left) kms_vblank (wait-busy)
[318.602259] Starting subtest: wait-busy
[318.604680] Starting dynamic subtest: pipe-A-eDP-1
[320.477536] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.874s)
[320.494514] Starting dynamic subtest: pipe-D-eDP-1
[323.061686] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.584s)
[323.064090] Subtest wait-busy: SUCCESS (4.462s)
[323.871255] [115/154] (697s left) gem_exec_schedule (deep)
[324.059653] Starting subtest: deep
[324.062089] Starting dynamic subtest: rcs0
[329.369882] Dynamic subtest rcs0: SKIP (5.305s)
[329.379115] Starting dynamic subtest: vcs0
[340.210913] Dynamic subtest vcs0: SUCCESS (10.842s)
[340.222059] Starting dynamic subtest: vcs1
[351.459315] Dynamic subtest vcs1: SUCCESS (11.247s)
[351.476417] Starting dynamic subtest: vecs0
[364.212723] Dynamic subtest vecs0: SUCCESS (12.751s)
[364.224080] Starting dynamic subtest: ccs0
[377.340560] Dynamic subtest ccs0: SUCCESS (13.126s)
[377.343751] Subtest deep: SUCCESS (53.277s)
[378.890621] [116/154] (643s left) fbdev (unaligned-write)
[378.940058] Starting subtest: unaligned-write
[379.041388] Subtest unaligned-write: SUCCESS (0.100s)
[379.128780] [117/154] (642s left) kms_plane_scaling (intel-max-src-size)
[379.219984] Starting subtest: intel-max-src-size
[379.226766] Subtest intel-max-src-size: SKIP (0.000s)
[379.321400] [118/154] (642s left) kms_psr2_sf (psr2-cursor-plane-move-continuous-exceed-sf)
[379.416111] Starting subtest: psr2-cursor-plane-move-continuous-exceed-sf
[379.418366] Starting dynamic subtest: pipe-A-eDP-1
[390.095905] Dynamic subtest pipe-A-eDP-1: SUCCESS (10.685s)
[390.106865] Starting dynamic subtest: pipe-B-eDP-1
[401.477297] Dynamic subtest pipe-B-eDP-1: SUCCESS (11.377s)
[401.479149] Subtest psr2-cursor-plane-move-continuous-exceed-sf: SUCCESS (22.066s)
[402.317719] [119/154] (619s left) gem_softpin (invalid)
[402.378291] Starting subtest: invalid
[402.384240] Subtest invalid: SUCCESS (0.006s)
[402.507628] [120/154] (619s left) gem_exec_schedule (submit-early-slice)
[402.578316] Starting subtest: submit-early-slice
[402.580474] Starting dynamic subtest: rcs0
[402.617364] Dynamic subtest rcs0: SUCCESS (0.044s)
[402.627498] Starting dynamic subtest: bcs0
[402.666096] Dynamic subtest bcs0: SUCCESS (0.048s)
[402.678768] Starting dynamic subtest: vcs0
[402.717334] Dynamic subtest vcs0: SUCCESS (0.051s)
[402.726630] Starting dynamic subtest: vcs1
[402.766740] Dynamic subtest vcs1: SUCCESS (0.048s)
[402.775995] Starting dynamic subtest: vecs0
[402.810813] Dynamic subtest vecs0: SUCCESS (0.043s)
[402.820123] Starting dynamic subtest: ccs0
[402.857843] Dynamic subtest ccs0: SUCCESS (0.046s)
[402.860164] Subtest submit-early-slice: SUCCESS (0.285s)
[404.380333] [121/154] (617s left) gem_pxp (verify-pxp-stale-buf-execution)
[404.496623] Starting subtest: verify-pxp-stale-buf-execution
[405.565568] Subtest verify-pxp-stale-buf-execution: SUCCESS (1.071s)
[405.701567] [122/154] (616s left) kms_pipe_stress (stress-xrgb8888-untiled)
[405.811644] Starting subtest: stress-xrgb8888-untiled
[411.862511] Subtest stress-xrgb8888-untiled: SUCCESS (6.051s)
[411.913637] [123/154] (610s left) kms_cursor_edge_walk (256x256-top-edge)
[412.014976] Starting subtest: 256x256-top-edge
[412.016952] Starting dynamic subtest: pipe-A-eDP-1
[415.500365] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.487s)
[415.509446] Starting dynamic subtest: pipe-D-eDP-1
[418.640310] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.139s)
[418.642669] Subtest 256x256-top-edge: SUCCESS (6.628s)
[419.460367] [124/154] (602s left) kms_cdclk (mode-transition-all-outputs)
[419.565177] Starting subtest: mode-transition-all-outputs
[419.856423] Subtest mode-transition-all-outputs: SKIP (0.287s)
[420.678495] [125/154] (601s left) kms_frontbuffer_tracking (psrhdr-1p-offscreen-pri-indfb-draw-blt)
[420.789849] Starting subtest: psrhdr-1p-offscreen-pri-indfb-draw-blt
[420.794117] Subtest psrhdr-1p-offscreen-pri-indfb-draw-blt: SKIP (0.000s)
[420.901230] [126/154] (601s left) gem_mmap_gtt (basic-short)
[420.943902] Subtest basic-short: SKIP (0.000s)
[421.005206] [127/154] (601s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-mmap-cpu)
[421.111485] Starting subtest: fbcpsr-rgb565-draw-mmap-cpu
[427.982336] Subtest fbcpsr-rgb565-draw-mmap-cpu: SUCCESS (6.877s)
[428.107302] [128/154] (594s left) kms_frontbuffer_tracking (fbcpsrhdr-rgb101010-draw-pwrite)
[428.209926] Starting subtest: fbcpsrhdr-rgb101010-draw-pwrite
[428.214342] Subtest fbcpsrhdr-rgb101010-draw-pwrite: SKIP (0.000s)
[428.303711] [129/154] (594s left) kms_joiner (switch-modeset-ultra-joiner-big-joiner)
[428.404067] Starting subtest: switch-modeset-ultra-joiner-big-joiner
[428.408456] Subtest switch-modeset-ultra-joiner-big-joiner: SKIP (0.000s)
[428.470717] [130/154] (594s left) kms_dirtyfb (psr-dirtyfb-ioctl)
[428.569799] Starting subtest: psr-dirtyfb-ioctl
[428.571856] Starting dynamic subtest: A-eDP-1
[432.509968] Dynamic subtest A-eDP-1: SUCCESS (3.938s)
[432.512455] Subtest psr-dirtyfb-ioctl: SUCCESS (3.940s)
[433.394361] [131/154] (589s left) i915_hangman (detector)
[433.467591] Starting subtest: detector
[433.469571] Starting dynamic subtest: rcs0
[445.214050] Dynamic subtest rcs0: SUCCESS (11.745s)
[445.226383] Starting dynamic subtest: bcs0
[456.224607] Dynamic subtest bcs0: SUCCESS (11.007s)
[456.237245] Starting dynamic subtest: vcs0
[468.190093] Dynamic subtest vcs0: SUCCESS (11.961s)
[468.202274] Starting dynamic subtest: vcs1
[478.238796] Dynamic subtest vcs1: SUCCESS (10.044s)
[478.251302] Starting dynamic subtest: vecs0
[490.206720] Dynamic subtest vecs0: SUCCESS (11.964s)
[490.220836] Starting dynamic subtest: ccs0
[501.279517] Dynamic subtest ccs0: SUCCESS (11.069s)
[501.282536] Subtest detector: SUCCESS (67.810s)
[501.420841] [132/154] (521s left) kms_frontbuffer_tracking (fbchdr-tiling-y)
[501.528651] Starting subtest: fbchdr-tiling-y
[501.533116] Subtest fbchdr-tiling-y: SKIP (0.000s)
[501.636187] [133/154] (520s left) kms_flip_scaled_crc (flip-64bpp-xtile-to-16bpp-xtile-upscaling)
[501.732226] Starting subtest: flip-64bpp-xtile-to-16bpp-xtile-upscaling
[501.734509] Starting dynamic subtest: pipe-A-default-mode
[504.426042] Dynamic subtest pipe-A-default-mode: SUCCESS (2.693s)
[504.428387] Subtest flip-64bpp-xtile-to-16bpp-xtile-upscaling: SUCCESS (2.695s)
[505.290068] [134/154] (517s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-render)
[505.393884] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-render
[505.398187] Subtest psr-2p-scndscrn-pri-indfb-draw-render: SKIP (0.000s)
[505.502376] [135/154] (517s left) kms_frontbuffer_tracking (fbcpsrhdr-shrfb-scaledprimary)
[505.612254] Starting subtest: fbcpsrhdr-shrfb-scaledprimary
[505.616087] Subtest fbcpsrhdr-shrfb-scaledprimary: SKIP (0.000s)
[505.705411] [136/154] (517s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-0-async-flip)
[505.797920] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-0-async-flip
[506.477555] Subtest x-tiled-max-hw-stride-32bpp-rotate-0-async-flip: SUCCESS (0.681s)
[506.646959] [137/154] (516s left) kms_cursor_legacy (cursorb-vs-flipa-atomic-transitions-varying-size)
[506.763881] Starting subtest: cursorB-vs-flipA-atomic-transitions-varying-size
[506.768441] Subtest cursorB-vs-flipA-atomic-transitions-varying-size: SKIP (0.001s)
[506.947632] [138/154] (515s left) kms_atomic_transition (plane-toggle-modeset-transition)
[507.051282] Starting subtest: plane-toggle-modeset-transition
[507.053468] Starting dynamic subtest: pipe-A-eDP-1
[519.777312] Dynamic subtest pipe-A-eDP-1: SUCCESS (12.724s)
[519.788873] Starting dynamic subtest: pipe-B-eDP-1
[532.239330] Dynamic subtest pipe-B-eDP-1: SUCCESS (12.461s)
[532.241924] Subtest plane-toggle-modeset-transition: SUCCESS (25.190s)
[533.059308] [139/154] (489s left) kms_big_fb (linear-16bpp-rotate-270)
[533.171310] Starting subtest: linear-16bpp-rotate-270
[533.191926] Subtest linear-16bpp-rotate-270: SKIP (0.019s)
[533.309087] [140/154] (489s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-scndscrn-cur-indfb-draw-blt)
[533.408090] Starting subtest: fbcpsrhdr-2p-scndscrn-cur-indfb-draw-blt
[533.412622] Subtest fbcpsrhdr-2p-scndscrn-cur-indfb-draw-blt: SKIP (0.000s)
[533.504743] [141/154] (489s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-primscrn-shrfb-pgflip-blt)
[533.596131] Starting subtest: fbcpsrhdr-2p-primscrn-shrfb-pgflip-blt
[533.600275] Subtest fbcpsrhdr-2p-primscrn-shrfb-pgflip-blt: SKIP (0.000s)
[533.682661] [142/154] (489s left) gem_pread (uncached)
[533.733794] Subtest uncached: SKIP (0.000s)
[533.797535] [143/154] (489s left) gem_ctx_shared (create-shared-gtt)
[533.862463] Starting subtest: create-shared-gtt
[536.012519] Subtest create-shared-gtt: SUCCESS (2.152s)
[536.345910] [144/154] (486s left) api_intel_allocator (open-vm)
[536.401871] Starting subtest: open-vm
[536.405708] Subtest open-vm: SUCCESS (0.006s)
[536.533642] [145/154] (486s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-mmap-cpu)
[536.644992] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-mmap-cpu
[543.730367] Subtest psr-1p-primscrn-pri-shrfb-draw-mmap-cpu: SUCCESS (7.090s)
[543.844202] [146/154] (479s left) kms_cursor_legacy (cursora-vs-flipa-atomic)
[543.967848] Starting subtest: cursorA-vs-flipA-atomic
[555.122351] Subtest cursorA-vs-flipA-atomic: SUCCESS (11.152s)
[555.927713] [147/154] (467s left) gem_mmap_wc (write-prefaulted)
[555.981358] Subtest write-prefaulted: SKIP (0.000s)
[556.043374] [148/154] (467s left) gem_exec_reloc (basic-write-cpu)
[556.101643] Subtest basic-write-cpu: SKIP (0.000s)
[556.187412] [149/154] (467s left) kms_prop_blob (invalid-set-prop)
[556.241668] Starting subtest: invalid-set-prop
[556.243878] Subtest invalid-set-prop: SUCCESS (0.000s)
[556.348032] [150/154] (467s left) kms_ccs (crc-primary-suspend-yf-tiled-ccs)
[556.433166] Starting subtest: crc-primary-suspend-yf-tiled-ccs
[556.435484] Starting dynamic subtest: pipe-A-eDP-1
[556.444672] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[556.455257] Starting dynamic subtest: pipe-B-eDP-1
[556.464168] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[556.473777] Starting dynamic subtest: pipe-C-eDP-1
[556.482710] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[556.491420] Starting dynamic subtest: pipe-D-eDP-1
[556.500214] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[556.504588] Subtest crc-primary-suspend-yf-tiled-ccs: SKIP (0.004s)
[558.701133] [151/154] (464s left) drm_read (short-buffer-wakeup)
[558.853118] Starting subtest: short-buffer-wakeup
[591.069827] Subtest short-buffer-wakeup: SUCCESS (32.216s)
[591.224263] [152/154] (432s left) perf (invalid-oa-format-id)
[591.323899] Starting subtest: invalid-oa-format-id
[591.333530] Subtest invalid-oa-format-id: SUCCESS (0.007s)
[591.377083] [153/154] (432s left) kms_chamelium_hpd (dp-hpd-with-enabled-mode)
[591.771081] Subtest dp-hpd-with-enabled-mode: SKIP (0.000s)
[592.613597] [154/154] (430s left) perf_pmu (init-sema)
[592.654396] Starting subtest: init-sema
[592.656678] Starting dynamic subtest: rcs0
[592.658834] Dynamic subtest rcs0: SUCCESS (0.002s)
[592.669214] Starting dynamic subtest: bcs0
[592.671417] Dynamic subtest bcs0: SUCCESS (0.000s)
[592.680427] Starting dynamic subtest: vcs0
[592.682605] Dynamic subtest vcs0: SUCCESS (0.001s)
[592.690870] Starting dynamic subtest: vcs1
[592.692712] Dynamic subtest vcs1: SUCCESS (0.001s)
[592.701152] Starting dynamic subtest: vecs0
[592.702975] Dynamic subtest vecs0: SUCCESS (0.001s)
[592.711406] Starting dynamic subtest: ccs0
[592.713212] Dynamic subtest ccs0: SUCCESS (0.000s)
[592.715061] Subtest init-sema: SUCCESS (0.008s)
[592.778821] Closing watchdogs
results: parsing output: 0/ for test: api_intel_bb
results: parsing output: 1/ for test: kms_scaling_modes
results: parsing output: 2/ for test: kms_addfb_basic
results: parsing output: 3/ for test: kms_ccs
results: parsing output: 4/ for test: kms_frontbuffer_tracking
results: parsing output: 5/ for test: kms_atomic_transition
results: parsing output: 6/ for test: kms_atomic
results: parsing output: 7/ for test: kms_frontbuffer_tracking
results: parsing output: 8/ for test: kms_rotation_crc
results: parsing output: 9/ for test: vgem_basic
results: parsing output: 10/ for test: gem_lmem_swapping
results: parsing output: 11/ for test: kms_plane
results: parsing output: 12/ for test: gem_exec_store
results: parsing output: 13/ for test: syncobj_timeline
results: parsing output: 14/ for test: kms_frontbuffer_tracking
results: parsing output: 15/ for test: kms_frontbuffer_tracking
results: parsing output: 16/ for test: syncobj_wait
results: parsing output: 17/ for test: kms_content_protection
results: parsing output: 18/ for test: perf
results: parsing output: 19/ for test: kms_cursor_crc
results: parsing output: 20/ for test: gem_mmap_offset
results: parsing output: 21/ for test: kms_frontbuffer_tracking
results: parsing output: 22/ for test: prime_vgem
results: parsing output: 23/ for test: kms_cursor_crc
results: parsing output: 24/ for test: kms_frontbuffer_tracking
results: parsing output: 25/ for test: gem_eio
results: parsing output: 26/ for test: kms_plane_scaling
results: parsing output: 27/ for test: kms_frontbuffer_tracking
results: parsing output: 28/ for test: gem_ctx_sseu
results: parsing output: 29/ for test: kms_frontbuffer_tracking
results: parsing output: 30/ for test: gem_exec_capture
results: parsing output: 31/ for test: kms_psr
results: parsing output: 32/ for test: kms_hdr
results: parsing output: 33/ for test: syncobj_timeline
results: parsing output: 34/ for test: kms_flip
results: parsing output: 35/ for test: syncobj_timeline
results: parsing output: 36/ for test: gem_exec_balancer
results: parsing output: 37/ for test: i915_query
results: parsing output: 38/ for test: kms_pipe_crc_basic
results: parsing output: 39/ for test: gem_exec_reloc
results: parsing output: 40/ for test: kms_frontbuffer_tracking
results: parsing output: 41/ for test: kms_frontbuffer_tracking
results: parsing output: 42/ for test: syncobj_timeline
results: parsing output: 43/ for test: gem_softpin
results: parsing output: 44/ for test: gem_ctx_persistence
results: parsing output: 45/ for test: gem_exec_fence
results: parsing output: 46/ for test: gem_eio
results: parsing output: 47/ for test: kms_getfb
results: parsing output: 48/ for test: kms_psr
results: parsing output: 49/ for test: syncobj_wait
results: parsing output: 50/ for test: gem_eio
results: parsing output: 51/ for test: kms_psr
results: parsing output: 52/ for test: kms_big_fb
results: parsing output: 53/ for test: kms_frontbuffer_tracking
results: parsing output: 54/ for test: kms_big_fb
results: parsing output: 55/ for test: prime_vgem
results: parsing output: 56/ for test: gem_partial_pwrite_pread
results: parsing output: 57/ for test: gem_vm_create
results: parsing output: 58/ for test: kms_rotation_crc
results: parsing output: 59/ for test: gem_flink_basic
results: parsing output: 60/ for test: kms_frontbuffer_tracking
results: parsing output: 61/ for test: kms_big_fb
results: parsing output: 62/ for test: gem_mmap_wc
results: parsing output: 63/ for test: gem_ctx_exec
results: parsing output: 64/ for test: kms_frontbuffer_tracking
results: parsing output: 65/ for test: i915_pm_rps
results: parsing output: 66/ for test: gem_render_copy
results: parsing output: 67/ for test: kms_flip_scaled_crc
results: parsing output: 68/ for test: kms_frontbuffer_tracking
results: parsing output: 69/ for test: kms_color
results: parsing output: 70/ for test: gem_render_copy_redux
results: parsing output: 71/ for test: kms_psr
results: parsing output: 72/ for test: gem_exec_flush
results: parsing output: 73/ for test: kms_frontbuffer_tracking
results: parsing output: 74/ for test: kms_async_flips
results: parsing output: 75/ for test: kms_frontbuffer_tracking
results: parsing output: 76/ for test: kms_frontbuffer_tracking
results: parsing output: 77/ for test: kms_big_fb
results: parsing output: 78/ for test: kms_frontbuffer_tracking
results: parsing output: 79/ for test: kms_frontbuffer_tracking
results: parsing output: 80/ for test: kms_frontbuffer_tracking
results: parsing output: 81/ for test: kms_vblank
results: parsing output: 82/ for test: kms_busy
results: parsing output: 83/ for test: kms_setmode
results: parsing output: 84/ for test: kms_frontbuffer_tracking
results: parsing output: 85/ for test: kms_frontbuffer_tracking
results: parsing output: 86/ for test: gem_fenced_exec_thrash
results: parsing output: 87/ for test: gem_exec_fence
results: parsing output: 88/ for test: kms_frontbuffer_tracking
results: parsing output: 89/ for test: kms_frontbuffer_tracking
results: parsing output: 90/ for test: kms_flip
results: parsing output: 91/ for test: gem_spin_batch
results: parsing output: 92/ for test: kms_ccs
results: parsing output: 93/ for test: kms_psr
results: parsing output: 94/ for test: kms_frontbuffer_tracking
results: parsing output: 95/ for test: kms_frontbuffer_tracking
results: parsing output: 96/ for test: kms_frontbuffer_tracking
results: parsing output: 97/ for test: kms_frontbuffer_tracking
results: parsing output: 98/ for test: kms_frontbuffer_tracking
results: parsing output: 99/ for test: kms_frontbuffer_tracking
results: parsing output: 100/ for test: gen9_exec_parse
results: parsing output: 101/ for test: kms_fb_coherency
results: parsing output: 102/ for test: sw_sync
results: parsing output: 103/ for test: kms_plane
results: parsing output: 104/ for test: kms_ccs
results: parsing output: 105/ for test: kms_cursor_legacy
results: parsing output: 106/ for test: gem_exec_schedule
results: parsing output: 107/ for test: gem_lmem_swapping
results: parsing output: 108/ for test: kms_chamelium_frames
results: parsing output: 109/ for test: i915_drm_fdinfo
results: parsing output: 110/ for test: kms_rotation_crc
results: parsing output: 111/ for test: syncobj_timeline
results: parsing output: 112/ for test: kms_frontbuffer_tracking
results: parsing output: 113/ for test: kms_vblank
results: parsing output: 114/ for test: gem_exec_schedule
results: parsing output: 115/ for test: fbdev
results: parsing output: 116/ for test: kms_plane_scaling
results: parsing output: 117/ for test: kms_psr2_sf
results: parsing output: 118/ for test: gem_softpin
results: parsing output: 119/ for test: gem_exec_schedule
results: parsing output: 120/ for test: gem_pxp
results: parsing output: 121/ for test: kms_pipe_stress
results: parsing output: 122/ for test: kms_cursor_edge_walk
results: parsing output: 123/ for test: kms_cdclk
results: parsing output: 124/ for test: kms_frontbuffer_tracking
results: parsing output: 125/ for test: gem_mmap_gtt
results: parsing output: 126/ for test: kms_frontbuffer_tracking
results: parsing output: 127/ for test: kms_frontbuffer_tracking
results: parsing output: 128/ for test: kms_joiner
results: parsing output: 129/ for test: kms_dirtyfb
results: parsing output: 130/ for test: i915_hangman
results: parsing output: 131/ for test: kms_frontbuffer_tracking
results: parsing output: 132/ for test: kms_flip_scaled_crc
results: parsing output: 133/ for test: kms_frontbuffer_tracking
results: parsing output: 134/ for test: kms_frontbuffer_tracking
results: parsing output: 135/ for test: kms_big_fb
results: parsing output: 136/ for test: kms_cursor_legacy
results: parsing output: 137/ for test: kms_atomic_transition
results: parsing output: 138/ for test: kms_big_fb
results: parsing output: 139/ for test: kms_frontbuffer_tracking
results: parsing output: 140/ for test: kms_frontbuffer_tracking
results: parsing output: 141/ for test: gem_pread
results: parsing output: 142/ for test: gem_ctx_shared
results: parsing output: 143/ for test: api_intel_allocator
results: parsing output: 144/ for test: kms_frontbuffer_tracking
results: parsing output: 145/ for test: kms_cursor_legacy
results: parsing output: 146/ for test: gem_mmap_wc
results: parsing output: 147/ for test: gem_exec_reloc
results: parsing output: 148/ for test: kms_prop_blob
results: parsing output: 149/ for test: kms_ccs
results: parsing output: 150/ for test: drm_read
results: parsing output: 151/ for test: perf
results: parsing output: 152/ for test: kms_chamelium_hpd
results: parsing output: 153/ for test: perf_pmu
Done.