[62.142273] Initializing watchdogs
[62.142332]   /dev/watchdog0
[62.156415] [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]
[62.160834] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[62.163090] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[62.166447] [001/131] (960s left) template (a)
[62.252720] Starting subtest: A
[62.255173] Subtest A: SUCCESS (0.000s)
[62.391645] [002/131] (960s left) syncobj_timeline (reset-multiple-signaled)
[62.452236] Starting subtest: reset-multiple-signaled
[62.454527] Subtest reset-multiple-signaled: SUCCESS (0.001s)
[62.567955] [003/131] (960s left) kms_big_fb (x-tiled-8bpp-rotate-180)
[62.682228] Starting subtest: x-tiled-8bpp-rotate-180
[63.926057] Subtest x-tiled-8bpp-rotate-180: SUCCESS (1.248s)
[64.114910] [004/131] (958s left) kms_addfb_basic (legacy-format)
[64.164288] Starting subtest: legacy-format
[64.193094] Subtest legacy-format: SUCCESS (0.025s)
[64.368433] [005/131] (958s left) kms_getfb (getfb-repeated-different-handles)
[64.479380] Starting subtest: getfb-repeated-different-handles
[64.481394] Subtest getfb-repeated-different-handles: SUCCESS (0.000s)
[64.628862] [006/131] (958s left) syncobj_timeline (multi-wait-all-signaled)
[64.686023] Starting subtest: multi-wait-all-signaled
[64.688052] Subtest multi-wait-all-signaled: SUCCESS (0.000s)
[64.815570] [007/131] (958s left) i915_pm_rps (thresholds-idle-park)
[64.877500] Starting subtest: thresholds-idle-park
[64.881490] Subtest thresholds-idle-park: SKIP (0.001s)
[65.020924] [008/131] (957s left) prime_mmap (test_aperture_limit)
[65.081102] Starting subtest: test_aperture_limit
[65.082891] Starting dynamic subtest: test_aperture_limit-smem
[65.090629] Dynamic subtest test_aperture_limit-smem: SKIP (0.008s)
[65.093949] Subtest test_aperture_limit: SKIP (0.008s)
[65.230389] [009/131] (957s left) sysfs_preempt_timeout (idempotent)
[65.291633] Starting subtest: idempotent
[65.293570] Starting dynamic subtest: vecs0
[65.295564] Dynamic subtest vecs0: SUCCESS (0.000s)
[65.303841] Starting dynamic subtest: ccs0
[65.305430] Dynamic subtest ccs0: SUCCESS (0.000s)
[65.311724] Starting dynamic subtest: vcs0
[65.313272] Dynamic subtest vcs0: SUCCESS (0.000s)
[65.319376] Starting dynamic subtest: bcs0
[65.321061] Dynamic subtest bcs0: SUCCESS (0.000s)
[65.327207] Starting dynamic subtest: rcs0
[65.328772] Dynamic subtest rcs0: SUCCESS (0.000s)
[65.335151] Starting dynamic subtest: vcs1
[65.336711] Dynamic subtest vcs1: SUCCESS (0.000s)
[65.338303] Subtest idempotent: SUCCESS (0.004s)
[65.437455] [010/131] (957s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-mmap-cpu)
[65.538198] Starting subtest: psr-2p-primscrn-spr-indfb-draw-mmap-cpu
[65.541816] Subtest psr-2p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[65.671175] [011/131] (957s left) kms_cursor_crc (cursor-random-max-size)
[65.966835] Starting subtest: cursor-random-max-size
[65.972410] Subtest cursor-random-max-size: SKIP (0.000s)
[66.127018] [012/131] (956s left) kms_flip_scaled_crc (flip-32bpp-yftile-to-64bpp-yftile-downscaling)
[66.227928] Starting subtest: flip-32bpp-yftile-to-64bpp-yftile-downscaling
[66.229562] Starting dynamic subtest: pipe-A-default-mode
[66.528476] Dynamic subtest pipe-A-default-mode: SKIP (0.296s)
[66.533239] Subtest flip-32bpp-yftile-to-64bpp-yftile-downscaling: SKIP (0.298s)
[67.431582] [013/131] (955s left) gen9_exec_parse (bb-start-out)
[67.540597] Subtest bb-start-out: SKIP (0.000s)
[67.854319] [014/131] (955s left) kms_frontbuffer_tracking (psr-rgb101010-draw-pwrite)
[68.149063] Starting subtest: psr-rgb101010-draw-pwrite
[75.806153] Subtest psr-rgb101010-draw-pwrite: SUCCESS (7.666s)
[75.930267] [015/131] (947s left) kms_joiner (basic-big-joiner)
[76.031596] Starting subtest: basic-big-joiner
[76.035942] Subtest basic-big-joiner: SKIP (0.000s)
[76.117709] [016/131] (947s left) gem_exec_fence (syncobj-timeline-chain-engines)
[76.676697] Starting subtest: syncobj-timeline-chain-engines
[76.785496] Subtest syncobj-timeline-chain-engines: SUCCESS (0.108s)
[78.025272] [FACT gem_exec_fence (syncobj-timeline-chain-engines)] new: kernel.kmod_is_loaded.vgem: true
[78.028273] [017/131] (945s left) i915_hangman (gt-engine-hang)
[78.102509] Starting subtest: gt-engine-hang
[78.104446] Starting dynamic subtest: rcs0
[79.864419] Dynamic subtest rcs0: SUCCESS (1.761s)
[79.878229] Starting dynamic subtest: bcs0
[81.847810] Dynamic subtest bcs0: SUCCESS (1.981s)
[81.857838] Starting dynamic subtest: vcs0
[83.893723] Dynamic subtest vcs0: SUCCESS (2.044s)
[83.904409] Starting dynamic subtest: vcs1
[85.879960] Dynamic subtest vcs1: SUCCESS (1.984s)
[85.891751] Starting dynamic subtest: vecs0
[87.862387] Dynamic subtest vecs0: SUCCESS (1.980s)
[87.873079] Starting dynamic subtest: ccs0
[89.910376] Dynamic subtest ccs0: SUCCESS (2.047s)
[89.913124] Subtest gt-engine-hang: SUCCESS (11.807s)
[90.016285] [018/131] (933s left) gem_ctx_persistence (legacy-engines-hostile-preempt)
[90.077659] Starting subtest: legacy-engines-hostile-preempt
[90.080078] Starting dynamic subtest: render
[90.183948] Dynamic subtest render: SUCCESS (0.105s)
[90.194086] Starting dynamic subtest: bsd1
[91.957587] Dynamic subtest bsd1: SUCCESS (1.770s)
[91.969997] Starting dynamic subtest: bsd2
[93.928216] Dynamic subtest bsd2: SUCCESS (1.968s)
[93.938855] Starting dynamic subtest: blt
[94.002911] Dynamic subtest blt: SUCCESS (0.074s)
[94.012875] Starting dynamic subtest: vebox
[95.916032] Dynamic subtest vebox: SUCCESS (1.910s)
[95.918746] Subtest legacy-engines-hostile-preempt: SUCCESS (5.838s)
[96.017295] [019/131] (927s left) syncobj_timeline (invalid-multi-wait-unsubmitted-signaled)
[96.074119] Starting subtest: invalid-multi-wait-unsubmitted-signaled
[96.076463] Subtest invalid-multi-wait-unsubmitted-signaled: SUCCESS (0.001s)
[96.207638] [020/131] (927s left) gem_mmap_offset (mmap-unmap)
[96.261043] Starting subtest: mmap-unmap
[96.263288] Starting dynamic subtest: smem0
[119.369113] Dynamic subtest smem0: SUCCESS (23.107s)
[119.371655] Subtest mmap-unmap: SUCCESS (23.107s)
[119.509651] [021/131] (903s left) gem_exec_reloc (basic-write-read-active)
[119.575640] Subtest basic-write-read-active: SKIP (0.000s)
[119.660092] [022/131] (903s left) vgem_basic (dmabuf-fence-before)
[119.706893] Starting subtest: dmabuf-fence-before
[119.708842] Subtest dmabuf-fence-before: SUCCESS (0.000s)
[119.797519] [023/131] (903s left) kms_vblank (wait-forked-hang)
[119.896707] Starting subtest: wait-forked-hang
[119.899044] Starting dynamic subtest: pipe-A-eDP-1
[147.675569] Dynamic subtest pipe-A-eDP-1: SUCCESS (27.778s)
[147.687800] Starting dynamic subtest: pipe-D-eDP-1
[162.652074] Dynamic subtest pipe-D-eDP-1: SUCCESS (14.973s)
[162.654078] Subtest wait-forked-hang: SUCCESS (42.755s)
[163.526936] [024/131] (860s left) gem_reg_read (timestamp-moving)
[163.596428] Starting subtest: timestamp-moving
[164.598276] Subtest timestamp-moving: SUCCESS (1.001s)
[164.693674] [025/131] (858s left) gem_exec_balancer (full)
[164.757720] Starting subtest: full
[169.772735] Subtest full: SUCCESS (5.014s)
[170.128194] [026/131] (853s left) kms_addfb_basic (invalid-set-prop-any)
[170.199140] Starting subtest: invalid-set-prop-any
[170.201429] Subtest invalid-set-prop-any: SUCCESS (0.000s)
[170.376576] [027/131] (853s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-shrfb-msflip-blt)
[170.488759] Starting subtest: fbcpsr-1p-primscrn-shrfb-msflip-blt
[177.878940] Subtest fbcpsr-1p-primscrn-shrfb-msflip-blt: SUCCESS (7.392s)
[178.072582] [028/131] (845s left) kms_ccs (crc-primary-suspend-4-tiled-mtl-mc-ccs)
[178.187170] Starting subtest: crc-primary-suspend-4-tiled-mtl-mc-ccs
[178.189440] Starting dynamic subtest: pipe-A-eDP-1
[211.093306] Dynamic subtest pipe-A-eDP-1: SUCCESS (6.683s)
[211.101861] Starting dynamic subtest: pipe-B-eDP-1
[244.027175] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.708s)
[244.036680] Starting dynamic subtest: pipe-C-eDP-1
[277.014202] Dynamic subtest pipe-C-eDP-1: SUCCESS (3.675s)
[277.027615] Starting dynamic subtest: pipe-D-eDP-1
[310.016074] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.649s)
[310.019089] Subtest crc-primary-suspend-4-tiled-mtl-mc-ccs: SUCCESS (17.721s)
[311.227541] [029/131] (712s left) kms_big_fb (y-tiled-16bpp-rotate-0)
[311.356025] Starting subtest: y-tiled-16bpp-rotate-0
[311.361043] Subtest y-tiled-16bpp-rotate-0: SKIP (0.000s)
[311.469360] [030/131] (712s left) api_intel_bb (object-reloc-purge-cache)
[311.535954] Starting subtest: object-reloc-purge-cache
[311.541254] Subtest object-reloc-purge-cache: SKIP (0.003s)
[311.678537] [031/131] (712s left) device_reset (unbind-reset-rebind)
[311.723224] Starting subtest: unbind-reset-rebind
[314.756443] Subtest unbind-reset-rebind: SUCCESS (3.064s)
[314.799356] [032/131] (709s left) kms_pm_rpm (legacy-planes)
[316.382591] Starting subtest: legacy-planes
[316.385238] Starting dynamic subtest: plane-63
[324.772087] Dynamic subtest plane-63: SUCCESS (8.432s)
[324.783505] Starting dynamic subtest: plane-93
[333.356811] Dynamic subtest plane-93: SUCCESS (8.599s)
[333.369072] Starting dynamic subtest: plane-123
[341.966273] Dynamic subtest plane-123: SUCCESS (8.614s)
[341.978231] Starting dynamic subtest: plane-133
[350.296397] Dynamic subtest plane-133: SUCCESS (8.324s)
[350.299052] Subtest legacy-planes: SUCCESS (33.980s)
[350.721733] [033/131] (673s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-pwrite)
[350.842243] Starting subtest: psr-1p-primscrn-cur-indfb-draw-pwrite
[357.628259] Subtest psr-1p-primscrn-cur-indfb-draw-pwrite: SUCCESS (6.786s)
[357.757139] [034/131] (666s left) gem_mmap_offset (ptrace)
[357.813822] Starting subtest: ptrace
[357.816460] Starting dynamic subtest: smem0-wb
[357.835298] Dynamic subtest smem0-wb: SUCCESS (0.021s)
[357.845255] Starting dynamic subtest: smem0-wc
[357.855032] Dynamic subtest smem0-wc: SUCCESS (0.019s)
[357.864435] Starting dynamic subtest: smem0-uc
[357.875565] Dynamic subtest smem0-uc: SUCCESS (0.020s)
[357.878328] Subtest ptrace: SUCCESS (0.065s)
[357.992563] [035/131] (666s left) api_intel_bb (blit-noreloc-purge-cache)
[358.058249] Starting subtest: blit-noreloc-purge-cache
[358.064831] Subtest blit-noreloc-purge-cache: SUCCESS (0.010s)
[358.213680] [036/131] (665s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-indfb-draw-mmap-wc)
[358.327071] Starting subtest: psr-1p-offscreen-pri-indfb-draw-mmap-wc
[365.015852] Subtest psr-1p-offscreen-pri-indfb-draw-mmap-wc: SUCCESS (6.693s)
[365.169159] [037/131] (658s left) kms_vblank (ts-continuation-suspend)
[365.269004] Starting subtest: ts-continuation-suspend
[365.271214] Starting dynamic subtest: pipe-A-eDP-1
[382.145346] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.539s)
[382.159469] Starting dynamic subtest: pipe-D-eDP-1
[399.132098] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.184s)
[399.134584] Subtest ts-continuation-suspend: SUCCESS (3.728s)
[399.946306] [038/131] (624s left) kms_rotation_crc (sprite-rotation-180)
[400.059448] Starting subtest: sprite-rotation-180
[406.991864] Subtest sprite-rotation-180: SUCCESS (7.004s)
[408.234127] [039/131] (615s left) kms_cursor_legacy (single-bo)
[408.357182] Starting subtest: single-bo
[408.359488] Starting dynamic subtest: pipe-A
[413.717313] Dynamic subtest pipe-A: SUCCESS (5.379s)
[413.729254] Starting dynamic subtest: pipe-B
[419.088288] Dynamic subtest pipe-B: SUCCESS (5.380s)
[419.099912] Starting dynamic subtest: pipe-C
[424.463416] Dynamic subtest pipe-C: SUCCESS (5.380s)
[424.474705] Starting dynamic subtest: pipe-D
[429.841527] Dynamic subtest pipe-D: SUCCESS (5.379s)
[429.852813] Starting dynamic subtest: all-pipes
[435.232839] Dynamic subtest all-pipes: SUCCESS (5.386s)
[435.235431] Subtest single-bo: SUCCESS (26.916s)
[435.401898] [040/131] (588s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-mmap-gtt)
[435.519123] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-mmap-gtt
[435.523707] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[435.662779] [041/131] (588s left) kms_plane_scaling (plane-scaler-with-clipping-clamping-pixel-formats)
[435.769295] Starting subtest: plane-scaler-with-clipping-clamping-pixel-formats
[435.771500] Starting dynamic subtest: pipe-A
[435.894431] Dynamic subtest pipe-A: SKIP (0.122s)
[435.904400] Starting dynamic subtest: pipe-B
[437.081659] Dynamic subtest pipe-B: SKIP (1.186s)
[437.093907] Starting dynamic subtest: pipe-C
[438.275995] Dynamic subtest pipe-C: SUCCESS (1.198s)
[438.286732] Starting dynamic subtest: pipe-D
[439.419653] Dynamic subtest pipe-D: SUCCESS (1.142s)
[439.421915] Subtest plane-scaler-with-clipping-clamping-pixel-formats: SUCCESS (3.652s)
[440.649831] [042/131] (583s left) kms_flip (2x-flip-vs-dpms-on-nop)
[440.745710] Starting subtest: 2x-flip-vs-dpms-on-nop
[440.756278] Subtest 2x-flip-vs-dpms-on-nop: SKIP (0.011s)
[440.864102] [043/131] (583s left) gem_lmem_swapping (verify-ccs)
[440.909998] Subtest verify-ccs: SKIP (0.000s)
[440.955642] [044/131] (583s left) kms_psr (psr-primary-mmap-cpu)
[441.049381] Starting subtest: psr-primary-mmap-cpu
[441.051643] Starting dynamic subtest: eDP-1
[442.804282] Dynamic subtest eDP-1: SUCCESS (1.754s)
[442.806520] Subtest psr-primary-mmap-cpu: SUCCESS (1.756s)
[443.723899] [045/131] (580s left) kms_content_protection (uevent-hdcp14)
[443.864911] Starting subtest: uevent-hdcp14
[443.869413] Subtest uevent-hdcp14: SKIP (0.000s)
[444.023834] [046/131] (580s left) gem_wait (invalid-buf)
[444.101047] Starting subtest: invalid-buf
[444.103170] Subtest invalid-buf: SUCCESS (0.000s)
[444.316518] [047/131] (580s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-render)
[444.418664] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-render
[444.422752] Subtest fbc-2p-scndscrn-pri-shrfb-draw-render: SKIP (0.000s)
[444.552677] [048/131] (580s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-cpu)
[444.650533] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-cpu
[444.654492] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[444.773763] [049/131] (579s left) kms_async_flips (test-time-stamp)
[444.872512] Starting subtest: test-time-stamp
[445.247848] Starting dynamic subtest: pipe-A-eDP-1
[446.074864] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.824s)
[446.450467] Starting dynamic subtest: pipe-B-eDP-1
[447.194164] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.748s)
[447.559962] Starting dynamic subtest: pipe-C-eDP-1
[448.328632] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.773s)
[448.693883] Starting dynamic subtest: pipe-D-eDP-1
[449.454470] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.767s)
[449.456749] Subtest test-time-stamp: SUCCESS (4.583s)
[450.642077] [050/131] (574s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-mmap-wc)
[450.743868] Starting subtest: psr-1p-primscrn-spr-indfb-draw-mmap-wc
[457.314306] Subtest psr-1p-primscrn-spr-indfb-draw-mmap-wc: SUCCESS (6.575s)
[457.463686] [051/131] (567s left) gem_ctx_exec (basic-norecovery)
[457.527614] Starting subtest: basic-norecovery
[457.893982] Subtest basic-norecovery: SUCCESS (0.369s)
[458.069811] [052/131] (566s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-blt)
[458.173469] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-blt
[465.479487] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-blt: SUCCESS (7.309s)
[465.639267] [053/131] (559s left) syncobj_timeline (etime-multi-wait-all-for-submit-available-unsubmitted-submi
[465.692130] Starting subtest: etime-multi-wait-all-for-submit-available-unsubmitted-submitted
[465.794114] Subtest etime-multi-wait-all-for-submit-available-unsubmitted-submitted: SUCCESS (0.103s)
[465.895366] [054/131] (558s left) gem_exec_whisper (basic-fds-priority-all)
[465.949988] Starting subtest: basic-fds-priority-all
[490.348317] Subtest basic-fds-priority-all: SUCCESS (24.402s)
[490.554939] [055/131] (534s left) kms_psr (fbc-psr-primary-blt)
[490.665070] Starting subtest: fbc-psr-primary-blt
[490.667258] Starting dynamic subtest: eDP-1
[490.671157] Dynamic subtest eDP-1: SKIP (0.000s)
[490.675095] Subtest fbc-psr-primary-blt: SKIP (0.001s)
[490.763342] [056/131] (534s left) gem_reg_read (bad-register)
[490.821222] Starting subtest: bad-register
[490.823719] Subtest bad-register: SUCCESS (0.000s)
[490.954614] [057/131] (534s left) kms_cursor_legacy (cursora-vs-flipa-atomic-transitions-varying-size)
[491.086559] Starting subtest: cursorA-vs-flipA-atomic-transitions-varying-size
[502.252918] Subtest cursorA-vs-flipA-atomic-transitions-varying-size: SUCCESS (11.164s)
[503.094931] [058/131] (521s left) kms_psr (pr-primary-render)
[503.191415] Starting subtest: pr-primary-render
[503.195923] Subtest pr-primary-render: SKIP (0.000s)
[503.287629] [059/131] (521s left) kms_ccs (bad-rotation-90-y-tiled-ccs)
[503.379349] Starting subtest: bad-rotation-90-y-tiled-ccs
[503.381606] Starting dynamic subtest: pipe-A-eDP-1
[503.404206] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[503.415815] Starting dynamic subtest: pipe-B-eDP-1
[503.437242] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[503.446618] Starting dynamic subtest: pipe-C-eDP-1
[503.467993] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[503.477300] Starting dynamic subtest: pipe-D-eDP-1
[503.500209] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[503.504797] Subtest bad-rotation-90-y-tiled-ccs: SKIP (0.005s)
[505.574353] [060/131] (519s left) kms_psr (fbc-psr2-primary-mmap-cpu)
[505.667282] Starting subtest: fbc-psr2-primary-mmap-cpu
[505.669476] Starting dynamic subtest: eDP-1
[505.673451] Dynamic subtest eDP-1: SKIP (0.000s)
[505.677474] Subtest fbc-psr2-primary-mmap-cpu: SKIP (0.001s)
[505.775530] [061/131] (519s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-shrfb-draw-pwrite)
[505.889985] Starting subtest: fbc-1p-offscreen-pri-shrfb-draw-pwrite
[512.934526] Subtest fbc-1p-offscreen-pri-shrfb-draw-pwrite: SUCCESS (7.048s)
[514.079927] [062/131] (511s left) gem_exec_schedule (thriceslice)
[514.149491] Starting subtest: thriceslice
[514.151739] Starting dynamic subtest: rcs0
[514.172867] Dynamic subtest rcs0: SUCCESS (0.035s)
[514.185340] Starting dynamic subtest: bcs0
[514.203423] Dynamic subtest bcs0: SUCCESS (0.029s)
[514.213056] Starting dynamic subtest: vcs0
[514.255936] Dynamic subtest vcs0: SUCCESS (0.051s)
[514.267401] Starting dynamic subtest: vcs1
[514.289073] Dynamic subtest vcs1: SUCCESS (0.031s)
[514.304557] Starting dynamic subtest: vecs0
[514.322485] Dynamic subtest vecs0: SUCCESS (0.031s)
[514.333949] Starting dynamic subtest: ccs0
[514.353434] Dynamic subtest ccs0: SUCCESS (0.029s)
[514.355737] Subtest thriceslice: SUCCESS (0.216s)
[515.434970] [063/131] (509s left) syncobj_wait (wait-for-submit-complex)
[515.498294] Starting subtest: wait-for-submit-complex
[515.559919] Subtest wait-for-submit-complex: SUCCESS (0.062s)
[515.661482] [064/131] (509s left) gem_sync (basic-many-each)
[515.730224] Starting subtest: basic-many-each
[518.070326] Subtest basic-many-each: SUCCESS (2.351s)
[518.280515] [065/131] (507s left) kms_plane_scaling (plane-upscale-factor-0-25-with-rotation)
[518.377478] Starting subtest: plane-upscale-factor-0-25-with-rotation
[518.379796] Starting dynamic subtest: pipe-A
[518.602711] Dynamic subtest pipe-A: SUCCESS (0.227s)
[518.613008] Starting dynamic subtest: pipe-B
[519.933307] Dynamic subtest pipe-B: SUCCESS (1.329s)
[519.943882] Starting dynamic subtest: pipe-C
[521.265588] Dynamic subtest pipe-C: SUCCESS (1.331s)
[521.276365] Starting dynamic subtest: pipe-D
[522.598519] Dynamic subtest pipe-D: SUCCESS (1.331s)
[522.601089] Subtest plane-upscale-factor-0-25-with-rotation: SUCCESS (4.225s)
[523.791677] [066/131] (501s left) kms_frontbuffer_tracking (fbc-1p-primscrn-indfb-plflip-blt)
[523.905640] Starting subtest: fbc-1p-primscrn-indfb-plflip-blt
[528.472884] Subtest fbc-1p-primscrn-indfb-plflip-blt: SUCCESS (4.570s)
[529.692877] [067/131] (495s left) kms_ccs (crc-primary-basic-4-tiled-dg2-rc-ccs)
[529.785312] Starting subtest: crc-primary-basic-4-tiled-dg2-rc-ccs
[529.787643] Starting dynamic subtest: pipe-A-eDP-1
[529.811457] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[529.823716] Starting dynamic subtest: pipe-B-eDP-1
[529.844840] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[529.854171] Starting dynamic subtest: pipe-C-eDP-1
[529.875537] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[529.884584] Starting dynamic subtest: pipe-D-eDP-1
[529.906285] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[529.910554] Subtest crc-primary-basic-4-tiled-dg2-rc-ccs: SKIP (0.006s)
[532.119981] [068/131] (493s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-mmap-cpu)
[532.229648] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-mmap-cpu
[532.233720] Subtest fbc-2p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[532.372846] [069/131] (493s left) gem_pread (display)
[532.433896] Subtest display: SKIP (0.000s)
[532.498452] [070/131] (493s left) gem_userptr_blits (coherency-sync)
[532.573110] Starting subtest: coherency-sync
[533.054910] Subtest coherency-sync: SKIP (0.444s)
[533.202836] [071/131] (492s left) kms_psr2_sf (fbc-pr-overlay-plane-move-continuous-exceed-fully-sf)
[538.277650] Starting subtest: fbc-pr-overlay-plane-move-continuous-exceed-fully-sf
[538.282451] Subtest fbc-pr-overlay-plane-move-continuous-exceed-fully-sf: SKIP (0.002s)
[539.160923] [072/131] (486s left) gem_softpin (evict-prime-sanity-check)
[539.217987] Starting subtest: evict-prime-sanity-check
[539.220314] Starting dynamic subtest: rcs0
[540.403318] Dynamic subtest rcs0: SUCCESS (1.185s)
[540.414528] Starting dynamic subtest: bcs0
[541.536025] Dynamic subtest bcs0: SUCCESS (1.131s)
[541.548937] Starting dynamic subtest: vcs0
[543.359273] Dynamic subtest vcs0: SUCCESS (1.820s)
[543.370096] Starting dynamic subtest: vcs1
[545.300507] Dynamic subtest vcs1: SUCCESS (1.939s)
[545.322057] Starting dynamic subtest: vecs0
[547.368291] Dynamic subtest vecs0: SUCCESS (2.064s)
[547.390076] Starting dynamic subtest: ccs0
[548.504192] Dynamic subtest ccs0: SUCCESS (1.134s)
[548.517695] Starting dynamic subtest: all
[549.659539] Dynamic subtest all: SUCCESS (1.153s)
[549.662059] Subtest evict-prime-sanity-check: SUCCESS (10.443s)
[549.763310] [073/131] (475s left) perf_pmu (init-busy)
[549.809413] Starting subtest: init-busy
[549.811656] Starting dynamic subtest: rcs0
[549.813789] Dynamic subtest rcs0: SUCCESS (0.003s)
[549.824465] Starting dynamic subtest: bcs0
[549.826584] Dynamic subtest bcs0: SUCCESS (0.000s)
[549.836745] Starting dynamic subtest: vcs0
[549.838967] Dynamic subtest vcs0: SUCCESS (0.001s)
[549.848897] Starting dynamic subtest: vcs1
[549.851075] Dynamic subtest vcs1: SUCCESS (0.001s)
[549.860876] Starting dynamic subtest: vecs0
[549.863095] Dynamic subtest vecs0: SUCCESS (0.001s)
[549.872699] Starting dynamic subtest: ccs0
[549.874960] Dynamic subtest ccs0: SUCCESS (0.000s)
[549.876856] Subtest init-busy: SUCCESS (0.009s)
[550.008980] [074/131] (475s left) gem_ctx_shared (single-timeline)
[550.081010] Starting subtest: single-timeline
[550.108283] Subtest single-timeline: SUCCESS (0.026s)
[550.375027] [075/131] (475s left) kms_getfb (getfb2-handle-zero)
[550.470452] Starting subtest: getfb2-handle-zero
[550.472787] Subtest getfb2-handle-zero: SUCCESS (0.000s)
[550.597973] [076/131] (475s left) drm_read (empty-block)
[550.782278] Starting subtest: empty-block
[551.782579] Subtest empty-block: SUCCESS (1.000s)
[551.961079] [077/131] (473s left) kms_chamelium_hpd (vga-hpd-enable-disable-mode)
[552.347519] Subtest vga-hpd-enable-disable-mode: SKIP (0.000s)
[553.150020] [078/131] (472s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-onoff)
[553.267303] Starting subtest: psr-2p-primscrn-spr-indfb-onoff
[553.271512] Subtest psr-2p-primscrn-spr-indfb-onoff: SKIP (0.000s)
[553.395144] [079/131] (472s left) kms_selftest (drm_format_helper)
[553.442405] Starting subtest: drm_format_helper
[553.502498] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_gray8
[553.645800] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_gray8: SUCCESS (0.142s)
[553.667489] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_rgb332
[553.788592] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_rgb332: SUCCESS (0.139s)
[553.811134] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_rgb565
[553.936837] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_rgb565: SUCCESS (0.147s)
[553.958204] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_xrgb1555
[554.067755] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_xrgb1555: SUCCESS (0.130s)
[554.090638] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_argb1555
[554.232165] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_argb1555: SUCCESS (0.161s)
[554.254451] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_rgba5551
[554.368052] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_rgba5551: SUCCESS (0.135s)
[554.385350] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_rgb888
[554.498818] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_rgb888: SUCCESS (0.129s)
[554.508920] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_bgr888
[554.613786] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_bgr888: SUCCESS (0.115s)
[554.625435] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_argb8888
[554.707456] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_argb8888: SUCCESS (0.093s)
[554.719064] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_xrgb2101010
[554.846488] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_xrgb2101010: SUCCESS (0.136s)
[554.858443] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_argb2101010
[554.943682] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_argb2101010: SUCCESS (0.099s)
[554.955381] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_mono
[555.082450] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_mono: SUCCESS (0.134s)
[555.093851] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_swab
[555.203352] Dynamic subtest drm_format_helper_test-drm_test_fb_swab: SUCCESS (0.121s)
[555.214797] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_xbgr8888
[555.333973] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_xbgr8888: SUCCESS (0.128s)
[555.351293] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_abgr8888
[555.461824] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_abgr8888: SUCCESS (0.128s)
[555.479385] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_clip_offset
[555.583446] Dynamic subtest drm_format_helper_test-drm_test_fb_clip_offset: SUCCESS (0.122s)
[555.594968] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_memcpy
[555.696022] Dynamic subtest drm_format_helper_test-drm_test_fb_memcpy: SUCCESS (0.113s)
[555.698345] Subtest drm_format_helper: SUCCESS (2.254s)
[555.923668] [080/131] (470s left) kms_frontbuffer_tracking (fbc-shrfb-scaledprimary)
[556.027357] Starting subtest: fbc-shrfb-scaledprimary
[559.100938] Subtest fbc-shrfb-scaledprimary: SUCCESS (3.076s)
[560.309064] [081/131] (465s left) syncobj_wait (invalid-multi-wait-all-unsubmitted-submitted)
[560.357727] Starting subtest: invalid-multi-wait-all-unsubmitted-submitted
[560.359993] Subtest invalid-multi-wait-all-unsubmitted-submitted: SUCCESS (0.000s)
[560.488911] [082/131] (465s left) kms_flip (modeset-vs-vblank-race)
[560.587986] Starting subtest: modeset-vs-vblank-race
[560.590302] Starting dynamic subtest: A-eDP1
[565.272201] Dynamic subtest A-eDP1: SUCCESS (4.687s)
[565.285327] Starting dynamic subtest: B-eDP1
[569.982315] Dynamic subtest B-eDP1: SUCCESS (4.709s)
[569.998643] Starting dynamic subtest: C-eDP1
[574.679953] Dynamic subtest C-eDP1: SUCCESS (4.695s)
[574.701431] Starting dynamic subtest: D-eDP1
[579.398629] Dynamic subtest D-eDP1: SUCCESS (4.717s)
[579.400940] Subtest modeset-vs-vblank-race: SUCCESS (18.821s)
[580.681301] [083/131] (445s left) kms_pipe_b_c_ivb (enable-pipe-c-while-b-has-3-lanes)
[580.758424] Subtest enable-pipe-C-while-B-has-3-lanes: SKIP (0.000s)
[580.829263] [084/131] (445s left) kms_pipe_crc_basic (suspend-read-crc)
[580.919472] Starting subtest: suspend-read-crc
[580.921381] Starting dynamic subtest: pipe-A-eDP-1
[598.777636] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.559s)
[598.789183] Starting dynamic subtest: pipe-B-eDP-1
[616.778624] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.232s)
[616.795279] Starting dynamic subtest: pipe-C-eDP-1
[634.690470] Dynamic subtest pipe-C-eDP-1: SUCCESS (3.134s)
[634.701743] Starting dynamic subtest: pipe-D-eDP-1
[652.701793] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.056s)
[652.704153] Subtest suspend-read-crc: SUCCESS (11.987s)
[653.526628] [085/131] (372s left) kms_cdclk (plane-scaling)
[653.618788] Starting subtest: plane-scaling
[653.620983] Starting dynamic subtest: pipe-A-eDP-1
[653.903880] Dynamic subtest pipe-A-eDP-1: SKIP (0.286s)
[653.915361] Starting dynamic subtest: pipe-B-eDP-1
[653.919922] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[653.932567] Starting dynamic subtest: pipe-C-eDP-1
[653.937426] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[653.948768] Starting dynamic subtest: pipe-D-eDP-1
[653.952846] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[653.956837] Subtest plane-scaling: SKIP (0.294s)
[654.761350] [086/131] (371s left) kms_big_fb (yf-tiled-16bpp-rotate-180)
[654.865832] Starting subtest: yf-tiled-16bpp-rotate-180
[654.870142] Subtest yf-tiled-16bpp-rotate-180: SKIP (0.000s)
[654.987059] [087/131] (371s left) kms_flip (flip-vs-dpms-off-vs-modeset)
[655.096344] Starting subtest: flip-vs-dpms-off-vs-modeset
[655.098488] Starting dynamic subtest: A-eDP1
[658.728909] Dynamic subtest A-eDP1: SUCCESS (3.664s)
[658.739625] Starting dynamic subtest: B-eDP1
[661.912017] Dynamic subtest B-eDP1: SUCCESS (3.203s)
[661.923502] Starting dynamic subtest: C-eDP1
[664.987254] Dynamic subtest C-eDP1: SUCCESS (3.086s)
[664.998597] Starting dynamic subtest: D-eDP1
[668.105111] Dynamic subtest D-eDP1: SUCCESS (3.125s)
[668.107451] Subtest flip-vs-dpms-off-vs-modeset: SUCCESS (13.086s)
[668.932107] [088/131] (357s left) gem_exec_whisper (basic-queues-forked)
[669.006679] Starting subtest: basic-queues-forked
[693.384714] Subtest basic-queues-forked: SUCCESS (24.389s)
[693.596528] [089/131] (332s left) gem_softpin (noreloc-s3)
[693.668552] Starting subtest: noreloc-S3
[713.930018] Subtest noreloc-S3: SUCCESS (5.407s)
[714.096464] [090/131] (312s left) gem_set_tiling_vs_blt (tiled-to-tiled)
[714.169763] Subtest tiled-to-tiled: SKIP (0.000s)
[714.275213] [091/131] (312s left) kms_lease (lease-invalid-crtc)
[714.378935] Starting subtest: lease-invalid-crtc
[714.381228] Starting dynamic subtest: pipe-A-eDP-1
[714.383447] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s)
[714.394493] Starting dynamic subtest: pipe-B-eDP-1
[714.396705] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[714.407095] Starting dynamic subtest: pipe-C-eDP-1
[714.408976] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[714.418777] Starting dynamic subtest: pipe-D-eDP-1
[714.420677] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[714.422570] Subtest lease-invalid-crtc: SUCCESS (0.004s)
[714.477813] [092/131] (312s left) perf (polling-parameterized)
[714.629803] Starting subtest: polling-parameterized
[734.655810] Subtest polling-parameterized: SUCCESS (20.099s)
[734.709929] [093/131] (291s left) kms_plane (plane-panning-bottom-right)
[734.823910] Starting subtest: plane-panning-bottom-right
[734.826295] Starting dynamic subtest: pipe-A
[736.565301] Dynamic subtest pipe-A: SUCCESS (1.741s)
[736.576998] Starting dynamic subtest: pipe-B
[738.951769] Dynamic subtest pipe-B: SUCCESS (2.387s)
[738.953696] Subtest plane-panning-bottom-right: SUCCESS (4.130s)
[739.839426] [094/131] (286s left) gem_exec_fence (syncobj-unused-fence)
[740.300370] Starting subtest: syncobj-unused-fence
[740.302561] Subtest syncobj-unused-fence: SUCCESS (0.005s)
[742.336441] [095/131] (284s left) dumb_buffer (map-valid)
[742.403130] Starting subtest: map-valid
[742.405357] Subtest map-valid: SUCCESS (0.000s)
[742.531920] [096/131] (284s left) kms_psr (fbc-psr2-cursor-mmap-gtt)
[742.635905] Starting subtest: fbc-psr2-cursor-mmap-gtt
[742.638145] Starting dynamic subtest: eDP-1
[742.642218] Dynamic subtest eDP-1: SKIP (0.000s)
[742.646236] Subtest fbc-psr2-cursor-mmap-gtt: SKIP (0.001s)
[742.735366] [097/131] (284s left) gem_exec_schedule (preempt-other-chain)
[742.812228] Starting subtest: preempt-other-chain
[742.814213] Starting dynamic subtest: rcs0
[742.888714] Dynamic subtest rcs0: SUCCESS (0.084s)
[742.902886] Starting dynamic subtest: bcs0
[742.970020] Dynamic subtest bcs0: SUCCESS (0.081s)
[742.980480] Starting dynamic subtest: vcs0
[743.055905] Dynamic subtest vcs0: SUCCESS (0.084s)
[743.070508] Starting dynamic subtest: vcs1
[743.137319] Dynamic subtest vcs1: SUCCESS (0.082s)
[743.148257] Starting dynamic subtest: vecs0
[743.214001] Dynamic subtest vecs0: SUCCESS (0.076s)
[743.227111] Starting dynamic subtest: ccs0
[743.293701] Dynamic subtest ccs0: SUCCESS (0.079s)
[743.295814] Subtest preempt-other-chain: SUCCESS (0.491s)
[744.326628] [098/131] (282s left) gem_render_copy (yf-tiled-ccs-to-linear)
[744.394813] Starting subtest: yf-tiled-ccs-to-linear
[744.399749] Subtest yf-tiled-ccs-to-linear: SKIP (0.000s)
[744.602360] [099/131] (282s left) kms_prop_blob (blob-multiple)
[744.669656] Starting subtest: blob-multiple
[744.672018] Subtest blob-multiple: SUCCESS (0.002s)
[744.808821] [100/131] (282s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-64bpp-ytile-downscaling)
[744.903090] Starting subtest: flip-32bpp-ytile-to-64bpp-ytile-downscaling
[744.905192] Starting dynamic subtest: pipe-A-default-mode
[745.195048] Dynamic subtest pipe-A-default-mode: SKIP (0.290s)
[745.199492] Subtest flip-32bpp-ytile-to-64bpp-ytile-downscaling: SKIP (0.292s)
[746.071825] [101/131] (280s left) gem_fenced_exec_thrash (no-spare-fences-busy-interruptible)
[746.148157] Subtest no-spare-fences-busy-interruptible: SKIP (0.000s)
[746.217771] [102/131] (280s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-180)
[746.328151] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-180
[747.307695] Subtest 4-tiled-max-hw-stride-32bpp-rotate-180: SUCCESS (0.979s)
[747.456039] [103/131] (279s left) gem_render_copy (y-tiled-to-vebox-x-tiled)
[747.515332] Starting subtest: y-tiled-to-vebox-x-tiled
[747.519803] Subtest y-tiled-to-vebox-x-tiled: SKIP (0.000s)
[747.723479] [104/131] (279s left) vgem_basic (create)
[747.767451] Starting subtest: create
[747.769514] Subtest create: SUCCESS (0.000s)
[747.848727] [105/131] (279s left) gem_exec_params (secure-non-master)
[747.908392] Starting subtest: secure-non-master
[747.912796] Subtest secure-non-master: SKIP (0.000s)
[748.042935] [106/131] (279s left) syncobj_eventfd (invalid-bad-flags)
[748.090133] Starting subtest: invalid-bad-flags
[748.092254] Subtest invalid-bad-flags: SUCCESS (0.000s)
[748.201178] [107/131] (279s left) gem_partial_pwrite_pread (writes-after-reads-uncached)
[748.253400] Subtest writes-after-reads-uncached: SKIP (0.000s)
[748.333265] [108/131] (278s left) gem_exec_fence (basic-wait)
[748.509897] Starting subtest: basic-wait
[748.512666] Starting dynamic subtest: rcs0
[748.609650] Dynamic subtest rcs0: SUCCESS (0.099s)
[748.622999] Starting dynamic subtest: bcs0
[748.668001] Dynamic subtest bcs0: SUCCESS (0.057s)
[748.681244] Starting dynamic subtest: vcs0
[748.730419] Dynamic subtest vcs0: SUCCESS (0.060s)
[748.743082] Starting dynamic subtest: vcs1
[748.793184] Dynamic subtest vcs1: SUCCESS (0.061s)
[748.805780] Starting dynamic subtest: vecs0
[748.856465] Dynamic subtest vecs0: SUCCESS (0.061s)
[748.869356] Starting dynamic subtest: ccs0
[748.918237] Dynamic subtest ccs0: SUCCESS (0.060s)
[748.920622] Subtest basic-wait: SUCCESS (0.410s)
[750.341851] [109/131] (276s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-wc)
[750.451229] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-wc
[750.455192] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[750.582016] [110/131] (276s left) kms_cursor_crc (cursor-sliding-512x512)
[750.858814] Starting subtest: cursor-sliding-512x512
[750.863326] Subtest cursor-sliding-512x512: SKIP (0.001s)
[751.055425] [111/131] (276s left) gem_exec_reloc (basic-write-cpu)
[751.116951] Subtest basic-write-cpu: SKIP (0.000s)
[751.213257] [112/131] (276s left) gem_vm_create (invalid-destroy)
[751.284196] Starting subtest: invalid-destroy
[751.288977] Subtest invalid-destroy: SUCCESS (0.002s)
[751.424884] [113/131] (276s left) gem_close_race (multigpu-basic-process)
[751.491408] Starting subtest: multigpu-basic-process
[751.495318] Subtest multigpu-basic-process: SKIP (0.000s)
[751.754654] [114/131] (275s left) kms_busy (extended-pageflip-hang-newfb)
[751.856178] Starting subtest: extended-pageflip-hang-newfb
[751.858133] Starting dynamic subtest: pipe-A
[777.993587] Dynamic subtest pipe-A: SUCCESS (26.143s)
[778.005507] Starting dynamic subtest: pipe-D
[792.996165] Dynamic subtest pipe-D: SUCCESS (15.005s)
[792.998527] Subtest extended-pageflip-hang-newfb: SUCCESS (41.153s)
[793.822129] [115/131] (233s left) gen9_exec_parse (unaligned-access)
[793.892792] Subtest unaligned-access: SKIP (0.000s)
[793.977734] [116/131] (233s left) i915_pm_rps (basic-api)
[794.038426] Starting subtest: basic-api
[794.042899] Subtest basic-api: SKIP (0.000s)
[794.169798] [117/131] (233s left) kms_color (ctm-negative)
[794.263333] Starting subtest: ctm-negative
[794.265516] Starting dynamic subtest: pipe-A-eDP-1
[794.980551] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.720s)
[794.991835] Starting dynamic subtest: pipe-B-eDP-1
[796.410630] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.430s)
[796.422110] Starting dynamic subtest: pipe-C-eDP-1
[797.784080] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.372s)
[797.801842] Starting dynamic subtest: pipe-D-eDP-1
[799.116541] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.333s)
[799.118810] Subtest ctm-negative: SUCCESS (4.858s)
[799.960895] [118/131] (227s left) kms_cursor_crc (cursor-offscreen-32x32)
[800.113853] Starting subtest: cursor-offscreen-32x32
[800.165374] Subtest cursor-offscreen-32x32: SKIP (0.043s)
[800.468779] [119/131] (227s left) kms_chamelium_frames (hdmi-frame-dump)
[800.854724] Subtest hdmi-frame-dump: SKIP (0.000s)
[801.632870] [120/131] (226s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-blt)
[801.739024] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-blt
[806.194041] Subtest fbc-1p-primscrn-pri-shrfb-draw-blt: SUCCESS (4.460s)
[807.374900] [121/131] (220s left) gem_userptr_blits (sync-unmap)
[807.451919] Starting subtest: sync-unmap
[807.463497] Subtest sync-unmap: SUCCESS (0.015s)
[807.624802] [122/131] (220s left) kms_big_fb (y-tiled-16bpp-rotate-270)
[807.742239] Starting subtest: y-tiled-16bpp-rotate-270
[807.746503] Subtest y-tiled-16bpp-rotate-270: SKIP (0.000s)
[807.883544] [123/131] (220s left) kms_addfb_basic (addfb25-modifier-no-flag)
[807.984253] Starting subtest: addfb25-modifier-no-flag
[807.986144] Subtest addfb25-modifier-no-flag: SUCCESS (0.000s)
[808.118880] [124/131] (219s left) kms_cursor_legacy (cursor-vs-flip-toggle)
[808.244795] Starting subtest: cursor-vs-flip-toggle
[839.114149] Subtest cursor-vs-flip-toggle: SUCCESS (30.861s)
[839.997746] [125/131] (188s left) kms_ccs (crc-sprite-planes-basic-4-tiled-mtl-mc-ccs)
[840.092404] Starting subtest: crc-sprite-planes-basic-4-tiled-mtl-mc-ccs
[840.094628] Starting dynamic subtest: pipe-A-eDP-1
[840.410516] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.285s)
[840.423488] Starting dynamic subtest: pipe-B-eDP-1
[841.693251] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.283s)
[841.706142] Starting dynamic subtest: pipe-C-eDP-1
[842.957131] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.262s)
[842.969620] Starting dynamic subtest: pipe-D-eDP-1
[844.195413] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.240s)
[844.197760] Subtest crc-sprite-planes-basic-4-tiled-mtl-mc-ccs: SUCCESS (4.074s)
[845.315972] [126/131] (182s left) gem_mmap_gtt (basic-small-bo-tiledy)
[845.379875] Subtest basic-small-bo-tiledY: SKIP (0.000s)
[845.449019] [127/131] (182s left) gem_mmap_wc (write-read-distinct)
[845.510802] Subtest write-read-distinct: SKIP (0.000s)
[845.579689] [128/131] (182s left) kms_flip (single-buffer-flip-vs-dpms-off-vs-modeset)
[845.681164] Starting subtest: single-buffer-flip-vs-dpms-off-vs-modeset
[845.683347] Starting dynamic subtest: A-eDP1
[849.319713] Dynamic subtest A-eDP1: SUCCESS (3.635s)
[849.333900] Starting dynamic subtest: B-eDP1
[852.527776] Dynamic subtest B-eDP1: SUCCESS (3.208s)
[852.539442] Starting dynamic subtest: C-eDP1
[855.647784] Dynamic subtest C-eDP1: SUCCESS (3.120s)
[855.662507] Starting dynamic subtest: D-eDP1
[858.754721] Dynamic subtest D-eDP1: SUCCESS (3.105s)
[858.757046] Subtest single-buffer-flip-vs-dpms-off-vs-modeset: SUCCESS (13.075s)
[859.582338] [129/131] (168s left) kms_properties (crtc-properties-legacy)
[859.682110] Starting subtest: crtc-properties-legacy
[859.684252] Starting dynamic subtest: pipe-A-eDP-1
[860.121373] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.439s)
[860.133126] Starting dynamic subtest: pipe-B-eDP-1
[861.311625] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.189s)
[861.322853] Starting dynamic subtest: pipe-C-eDP-1
[862.435749] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.124s)
[862.447385] Starting dynamic subtest: pipe-D-eDP-1
[863.550112] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.114s)
[863.552473] Subtest crtc-properties-legacy: SUCCESS (3.871s)
[864.384346] [130/131] (163s left) kms_psr2_sf (pr-overlay-primary-update-sf-dmg-area)
[869.432753] Starting subtest: pr-overlay-primary-update-sf-dmg-area
[869.437234] Subtest pr-overlay-primary-update-sf-dmg-area: SKIP (0.003s)
[870.299758] [131/131] (157s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip)
[870.411573] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip
[871.213097] Subtest 4-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip: SUCCESS (0.803s)
[871.429099] Closing watchdogs
results: parsing output: 0/ for test: template
results: parsing output: 1/ for test: syncobj_timeline
results: parsing output: 2/ for test: kms_big_fb
results: parsing output: 3/ for test: kms_addfb_basic
results: parsing output: 4/ for test: kms_getfb
results: parsing output: 5/ for test: syncobj_timeline
results: parsing output: 6/ for test: i915_pm_rps
results: parsing output: 7/ for test: prime_mmap
results: parsing output: 8/ for test: sysfs_preempt_timeout
results: parsing output: 9/ for test: kms_frontbuffer_tracking
results: parsing output: 10/ for test: kms_cursor_crc
results: parsing output: 11/ for test: kms_flip_scaled_crc
results: parsing output: 12/ for test: gen9_exec_parse
results: parsing output: 13/ for test: kms_frontbuffer_tracking
results: parsing output: 14/ for test: kms_joiner
results: parsing output: 15/ for test: gem_exec_fence
results: parsing output: 16/ for test: i915_hangman
results: parsing output: 17/ for test: gem_ctx_persistence
results: parsing output: 18/ for test: syncobj_timeline
results: parsing output: 19/ for test: gem_mmap_offset
results: parsing output: 20/ for test: gem_exec_reloc
results: parsing output: 21/ for test: vgem_basic
results: parsing output: 22/ for test: kms_vblank
results: parsing output: 23/ for test: gem_reg_read
results: parsing output: 24/ for test: gem_exec_balancer
results: parsing output: 25/ for test: kms_addfb_basic
results: parsing output: 26/ for test: kms_frontbuffer_tracking
results: parsing output: 27/ for test: kms_ccs
results: parsing output: 28/ for test: kms_big_fb
results: parsing output: 29/ for test: api_intel_bb
results: parsing output: 30/ for test: device_reset
results: parsing output: 31/ for test: kms_pm_rpm
results: parsing output: 32/ for test: kms_frontbuffer_tracking
results: parsing output: 33/ for test: gem_mmap_offset
results: parsing output: 34/ for test: api_intel_bb
results: parsing output: 35/ for test: kms_frontbuffer_tracking
results: parsing output: 36/ for test: kms_vblank
results: parsing output: 37/ for test: kms_rotation_crc
results: parsing output: 38/ for test: kms_cursor_legacy
results: parsing output: 39/ for test: kms_frontbuffer_tracking
results: parsing output: 40/ for test: kms_plane_scaling
results: parsing output: 41/ for test: kms_flip
results: parsing output: 42/ for test: gem_lmem_swapping
results: parsing output: 43/ for test: kms_psr
results: parsing output: 44/ for test: kms_content_protection
results: parsing output: 45/ for test: gem_wait
results: parsing output: 46/ for test: kms_frontbuffer_tracking
results: parsing output: 47/ for test: kms_frontbuffer_tracking
results: parsing output: 48/ for test: kms_async_flips
results: parsing output: 49/ for test: kms_frontbuffer_tracking
results: parsing output: 50/ for test: gem_ctx_exec
results: parsing output: 51/ for test: kms_frontbuffer_tracking
results: parsing output: 52/ for test: syncobj_timeline
results: parsing output: 53/ for test: gem_exec_whisper
results: parsing output: 54/ for test: kms_psr
results: parsing output: 55/ for test: gem_reg_read
results: parsing output: 56/ for test: kms_cursor_legacy
results: parsing output: 57/ for test: kms_psr
results: parsing output: 58/ for test: kms_ccs
results: parsing output: 59/ for test: kms_psr
results: parsing output: 60/ for test: kms_frontbuffer_tracking
results: parsing output: 61/ for test: gem_exec_schedule
results: parsing output: 62/ for test: syncobj_wait
results: parsing output: 63/ for test: gem_sync
results: parsing output: 64/ for test: kms_plane_scaling
results: parsing output: 65/ for test: kms_frontbuffer_tracking
results: parsing output: 66/ for test: kms_ccs
results: parsing output: 67/ for test: kms_frontbuffer_tracking
results: parsing output: 68/ for test: gem_pread
results: parsing output: 69/ for test: gem_userptr_blits
results: parsing output: 70/ for test: kms_psr2_sf
results: parsing output: 71/ for test: gem_softpin
results: parsing output: 72/ for test: perf_pmu
results: parsing output: 73/ for test: gem_ctx_shared
results: parsing output: 74/ for test: kms_getfb
results: parsing output: 75/ for test: drm_read
results: parsing output: 76/ for test: kms_chamelium_hpd
results: parsing output: 77/ for test: kms_frontbuffer_tracking
results: parsing output: 78/ for test: kms_selftest
results: parsing output: 79/ for test: kms_frontbuffer_tracking
results: parsing output: 80/ for test: syncobj_wait
results: parsing output: 81/ for test: kms_flip
results: parsing output: 82/ for test: kms_pipe_b_c_ivb
results: parsing output: 83/ for test: kms_pipe_crc_basic
results: parsing output: 84/ for test: kms_cdclk
results: parsing output: 85/ for test: kms_big_fb
results: parsing output: 86/ for test: kms_flip
results: parsing output: 87/ for test: gem_exec_whisper
results: parsing output: 88/ for test: gem_softpin
results: parsing output: 89/ for test: gem_set_tiling_vs_blt
results: parsing output: 90/ for test: kms_lease
results: parsing output: 91/ for test: perf
results: parsing output: 92/ for test: kms_plane
results: parsing output: 93/ for test: gem_exec_fence
results: parsing output: 94/ for test: dumb_buffer
results: parsing output: 95/ for test: kms_psr
results: parsing output: 96/ for test: gem_exec_schedule
results: parsing output: 97/ for test: gem_render_copy
results: parsing output: 98/ for test: kms_prop_blob
results: parsing output: 99/ for test: kms_flip_scaled_crc
results: parsing output: 100/ for test: gem_fenced_exec_thrash
results: parsing output: 101/ for test: kms_big_fb
results: parsing output: 102/ for test: gem_render_copy
results: parsing output: 103/ for test: vgem_basic
results: parsing output: 104/ for test: gem_exec_params
results: parsing output: 105/ for test: syncobj_eventfd
results: parsing output: 106/ for test: gem_partial_pwrite_pread
results: parsing output: 107/ for test: gem_exec_fence
results: parsing output: 108/ for test: kms_frontbuffer_tracking
results: parsing output: 109/ for test: kms_cursor_crc
results: parsing output: 110/ for test: gem_exec_reloc
results: parsing output: 111/ for test: gem_vm_create
results: parsing output: 112/ for test: gem_close_race
results: parsing output: 113/ for test: kms_busy
results: parsing output: 114/ for test: gen9_exec_parse
results: parsing output: 115/ for test: i915_pm_rps
results: parsing output: 116/ for test: kms_color
results: parsing output: 117/ for test: kms_cursor_crc
results: parsing output: 118/ for test: kms_chamelium_frames
results: parsing output: 119/ for test: kms_frontbuffer_tracking
results: parsing output: 120/ for test: gem_userptr_blits
results: parsing output: 121/ for test: kms_big_fb
results: parsing output: 122/ for test: kms_addfb_basic
results: parsing output: 123/ for test: kms_cursor_legacy
results: parsing output: 124/ for test: kms_ccs
results: parsing output: 125/ for test: gem_mmap_gtt
results: parsing output: 126/ for test: gem_mmap_wc
results: parsing output: 127/ for test: kms_flip
results: parsing output: 128/ for test: kms_properties
results: parsing output: 129/ for test: kms_psr2_sf
results: parsing output: 130/ for test: kms_big_fb
Done.