[57.362482] Initializing watchdogs
[57.362532]   /dev/watchdog0
[57.377631] [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]
[57.382783] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[57.385634] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[57.389073] [001/154] (960s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-mmap-wc)
[57.547431] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-mmap-wc
[57.552019] Subtest psr-2p-scndscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[57.630596] [002/154] (960s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-primscrn-spr-indfb-onoff)
[57.743738] Starting subtest: fbcpsrhdr-1p-primscrn-spr-indfb-onoff
[57.748249] Subtest fbcpsrhdr-1p-primscrn-spr-indfb-onoff: SKIP (0.000s)
[57.839942] [003/154] (960s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-primscrn-indfb-msflip-blt)
[57.937856] Starting subtest: fbcpsrhdr-1p-primscrn-indfb-msflip-blt
[57.942302] Subtest fbcpsrhdr-1p-primscrn-indfb-msflip-blt: SKIP (0.000s)
[58.024764] [004/154] (959s left) core_debugfs (read-all-entries)
[58.087719] Starting subtest: read-all-entries
[58.186522] Subtest read-all-entries: SUCCESS (0.098s)
[58.252031] [005/154] (959s left) syncobj_wait (invalid-multi-wait-unsubmitted-signaled)
[58.311780] Starting subtest: invalid-multi-wait-unsubmitted-signaled
[58.314115] Subtest invalid-multi-wait-unsubmitted-signaled: SUCCESS (0.000s)
[58.410592] [006/154] (959s left) kms_flip_scaled_crc (flip-32bpp-ytileccs-to-64bpp-ytile-downscaling)
[58.511254] Starting subtest: flip-32bpp-ytileccs-to-64bpp-ytile-downscaling
[58.514995] Subtest flip-32bpp-ytileccs-to-64bpp-ytile-downscaling: SKIP (0.000s)
[58.579402] [007/154] (959s left) kms_getfb (getfb-handle-closed)
[58.674198] Starting subtest: getfb-handle-closed
[58.676323] Subtest getfb-handle-closed: SUCCESS (0.000s)
[58.769586] [008/154] (959s left) kms_flip_scaled_crc (flip-64bpp-yftile-to-16bpp-yftile-upscaling)
[58.866102] Starting subtest: flip-64bpp-yftile-to-16bpp-yftile-upscaling
[58.869600] Subtest flip-64bpp-yftile-to-16bpp-yftile-upscaling: SKIP (0.000s)
[58.961715] [009/154] (959s left) perf (disabled-read-error)
[59.089345] Starting subtest: disabled-read-error
[59.103552] Subtest disabled-read-error: SUCCESS (0.016s)
[59.148395] [010/154] (959s left) gem_userptr_blits (invalid-mmap-offset-unsync)
[59.219682] Subtest invalid-mmap-offset-unsync: SKIP (0.000s)
[59.352653] [011/154] (958s left) kms_frontbuffer_tracking (hdr-1p-primscrn-pri-shrfb-draw-render)
[59.454149] Starting subtest: hdr-1p-primscrn-pri-shrfb-draw-render
[59.457750] Subtest hdr-1p-primscrn-pri-shrfb-draw-render: SKIP (0.000s)
[59.537548] [012/154] (958s left) kms_frontbuffer_tracking (psrhdr-2p-scndscrn-spr-indfb-draw-blt)
[59.647297] Starting subtest: psrhdr-2p-scndscrn-spr-indfb-draw-blt
[59.650912] Subtest psrhdr-2p-scndscrn-spr-indfb-draw-blt: SKIP (0.000s)
[59.753146] [013/154] (958s left) kms_flip (2x-flip-vs-absolute-wf_vblank-interruptible)
[59.852651] Starting subtest: 2x-flip-vs-absolute-wf_vblank-interruptible
[59.865784] Subtest 2x-flip-vs-absolute-wf_vblank-interruptible: SKIP (0.011s)
[59.943647] [014/154] (958s left) gem_eio (create)
[60.091120] Starting subtest: create
[60.257092] Subtest create: SUCCESS (0.165s)
[60.374173] [015/154] (958s left) gem_exec_flush (basic-wb-pro-default)
[60.435348] Starting subtest: basic-wb-pro-default
[65.906400] Subtest basic-wb-pro-default: SUCCESS (5.471s)
[66.093806] [016/154] (952s left) i915_hangman (detector)
[66.161460] Starting subtest: detector
[66.163783] Starting dynamic subtest: rcs0
[76.259920] Dynamic subtest rcs0: SUCCESS (10.098s)
[76.271502] Starting dynamic subtest: bcs0
[88.292585] Dynamic subtest bcs0: SUCCESS (12.032s)
[88.303732] Starting dynamic subtest: vcs0
[100.196406] Dynamic subtest vcs0: SUCCESS (11.902s)
[100.208799] Starting dynamic subtest: vcs1
[110.243319] Dynamic subtest vcs1: SUCCESS (10.046s)
[110.254303] Starting dynamic subtest: vecs0
[122.213253] Dynamic subtest vecs0: SUCCESS (11.968s)
[122.224642] Starting dynamic subtest: ccs0
[132.260892] Dynamic subtest ccs0: SUCCESS (10.046s)
[132.263391] Subtest detector: SUCCESS (66.099s)
[132.397279] [017/154] (886s left) perf_pmu (init-busy)
[132.436030] Starting subtest: init-busy
[132.438404] Starting dynamic subtest: rcs0
[132.440704] Dynamic subtest rcs0: SUCCESS (0.002s)
[132.449278] Starting dynamic subtest: bcs0
[132.451406] Dynamic subtest bcs0: SUCCESS (0.001s)
[132.459607] Starting dynamic subtest: vcs0
[132.461682] Dynamic subtest vcs0: SUCCESS (0.001s)
[132.469551] Starting dynamic subtest: vcs1
[132.471668] Dynamic subtest vcs1: SUCCESS (0.000s)
[132.479453] Starting dynamic subtest: vecs0
[132.481579] Dynamic subtest vecs0: SUCCESS (0.000s)
[132.489670] Starting dynamic subtest: ccs0
[132.491511] Dynamic subtest ccs0: SUCCESS (0.001s)
[132.493320] Subtest init-busy: SUCCESS (0.007s)
[132.568633] [018/154] (885s left) gem_eio (wait-wedge-10ms)
[132.744984] Starting subtest: wait-wedge-10ms
[134.339130] Subtest wait-wedge-10ms: SUCCESS (1.594s)
[134.470753] [019/154] (884s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-mmap-wc)
[134.579041] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-mmap-wc
[134.583444] Subtest fbc-2p-scndscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[134.691692] [020/154] (883s left) gem_mmap_wc (write-wc-read-gtt)
[134.752266] Subtest write-wc-read-gtt: SKIP (0.000s)
[134.808911] [021/154] (883s left) kms_big_fb (y-tiled-8bpp-rotate-180)
[134.918054] Starting subtest: y-tiled-8bpp-rotate-180
[134.922224] Subtest y-tiled-8bpp-rotate-180: SKIP (0.000s)
[135.003370] [022/154] (883s left) kms_flip (basic-flip-vs-dpms)
[135.089278] Starting subtest: basic-flip-vs-dpms
[135.091733] Starting dynamic subtest: A-eDP1
[137.702123] Dynamic subtest A-eDP1: SUCCESS (2.610s)
[137.712825] Starting dynamic subtest: B-eDP1
[139.870416] Dynamic subtest B-eDP1: SUCCESS (2.166s)
[139.880039] Starting dynamic subtest: C-eDP1
[142.043702] Dynamic subtest C-eDP1: SUCCESS (2.172s)
[142.054078] Starting dynamic subtest: D-eDP1
[144.297165] Dynamic subtest D-eDP1: SUCCESS (2.253s)
[144.299740] Subtest basic-flip-vs-dpms: SUCCESS (9.212s)
[145.198096] [023/154] (873s left) i915_drm_fdinfo (virtual-busy-hang)
[145.235817] Starting subtest: virtual-busy-hang
[145.240650] Subtest virtual-busy-hang: SKIP (0.000s)
[145.304467] [024/154] (873s left) gem_exec_schedule (preempt-queue-chain)
[145.379562] Subtest preempt-queue-chain: SKIP (0.000s)
[145.661628] [025/154] (873s left) syncobj_timeline (multi-wait-all-for-submit-signaled)
[145.719726] Starting subtest: multi-wait-all-for-submit-signaled
[145.722353] Subtest multi-wait-all-for-submit-signaled: SUCCESS (0.001s)
[145.835660] [026/154] (872s left) kms_frontbuffer_tracking (fbcpsrhdr-shrfb-scaledprimary)
[145.942952] Starting subtest: fbcpsrhdr-shrfb-scaledprimary
[145.947493] Subtest fbcpsrhdr-shrfb-scaledprimary: SKIP (0.000s)
[146.031146] [027/154] (872s left) gem_spin_batch (resubmit-new)
[146.092388] Starting subtest: resubmit-new
[146.094824] Starting dynamic subtest: rcs0
[146.100218] Dynamic subtest rcs0: SUCCESS (0.008s)
[146.111645] Starting dynamic subtest: bcs0
[146.113875] Dynamic subtest bcs0: SUCCESS (0.004s)
[146.123134] Starting dynamic subtest: vcs0
[146.125481] Dynamic subtest vcs0: SUCCESS (0.005s)
[146.133787] Starting dynamic subtest: vcs1
[146.135717] Dynamic subtest vcs1: SUCCESS (0.004s)
[146.144623] Starting dynamic subtest: vecs0
[146.146577] Dynamic subtest vecs0: SUCCESS (0.004s)
[146.154805] Starting dynamic subtest: ccs0
[146.156738] Dynamic subtest ccs0: SUCCESS (0.005s)
[146.158611] Subtest resubmit-new: SUCCESS (0.033s)
[147.374599] [028/154] (871s left) kms_frontbuffer_tracking (hdr-2p-primscrn-pri-indfb-draw-mmap-cpu)
[147.475282] Starting subtest: hdr-2p-primscrn-pri-indfb-draw-mmap-cpu
[147.479367] Subtest hdr-2p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[147.574824] [029/154] (871s left) kms_dsc (dsc-with-bpc)
[147.666518] Starting subtest: dsc-with-bpc
[147.698556] Subtest dsc-with-bpc: SKIP (0.001s)
[147.735864] [030/154] (871s left) kms_frontbuffer_tracking (fbchdr-1p-primscrn-pri-shrfb-draw-render)
[147.829687] Starting subtest: fbchdr-1p-primscrn-pri-shrfb-draw-render
[147.834138] Subtest fbchdr-1p-primscrn-pri-shrfb-draw-render: SKIP (0.000s)
[147.926855] [031/154] (871s left) i915_pm_rpm (system-suspend-execbuf)
[149.470898] Starting subtest: system-suspend-execbuf
[208.028493] Subtest system-suspend-execbuf: SUCCESS (43.079s)
[208.416728] [032/154] (810s left) prime_mmap_kms (buffer-sharing)
[208.514892] Starting subtest: buffer-sharing
[208.983646] Subtest buffer-sharing: SUCCESS (0.468s)
[209.834756] [033/154] (809s left) gen9_exec_parse (allowed-single)
[209.893704] Subtest allowed-single: SKIP (0.000s)
[209.978749] [034/154] (809s left) kms_pm_rpm (cursor-dpms)
[211.905034] Starting subtest: cursor-dpms
[211.910054] Subtest cursor-dpms: SKIP (0.000s)
[212.308194] [035/154] (806s left) drm_read (empty-nonblock)
[212.459958] Starting subtest: empty-nonblock
[212.462381] Subtest empty-nonblock: SUCCESS (0.000s)
[212.583650] [036/154] (806s left) kms_plane_multiple (2x-tiling-4)
[212.675823] Starting subtest: 2x-tiling-4
[212.680151] Subtest 2x-tiling-4: SKIP (0.000s)
[212.748564] [037/154] (806s left) kms_cursor_crc (cursor-random-128x128)
[212.965724] Starting subtest: cursor-random-128x128
[212.968185] Starting dynamic subtest: pipe-A-eDP-1
[216.314718] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.350s)
[216.349460] Starting dynamic subtest: pipe-D-eDP-1
[220.326176] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.986s)
[220.328584] Subtest cursor-random-128x128: SUCCESS (7.363s)
[221.172565] [038/154] (798s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-cpu)
[221.280936] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-cpu
[221.285186] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[221.404394] [039/154] (797s left) gem_madvise (dontneed-after-mmap)
[221.439633] Starting subtest: dontneed-after-mmap
[221.463677] Subtest dontneed-after-mmap: SUCCESS (0.024s)
[221.590157] [040/154] (797s left) gem_mmap_gtt (flink-race)
[221.647138] Subtest flink-race: SKIP (0.000s)
[221.705716] [041/154] (797s left) kms_flip (2x-flip-vs-panning-vs-hang)
[221.797163] Starting subtest: 2x-flip-vs-panning-vs-hang
[221.801651] Subtest 2x-flip-vs-panning-vs-hang: SKIP (0.002s)
[221.901184] [042/154] (797s left) gem_readwrite (read-bad-handle)
[221.951136] Subtest read-bad-handle: SKIP (0.000s)
[222.022437] [043/154] (797s left) kms_ccs (bad-rotation-90-4-tiled-mtl-rc-ccs)
[222.110837] Starting subtest: bad-rotation-90-4-tiled-mtl-rc-ccs
[222.112931] Starting dynamic subtest: pipe-A-eDP-1
[222.262245] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.142s)
[222.274093] Starting dynamic subtest: pipe-B-eDP-1
[222.291024] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[222.300152] Starting dynamic subtest: pipe-C-eDP-1
[222.316517] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.002s)
[222.325264] Starting dynamic subtest: pipe-D-eDP-1
[222.341591] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.002s)
[222.343252] Subtest bad-rotation-90-4-tiled-mtl-rc-ccs: SUCCESS (0.150s)
[224.534903] [044/154] (795s left) dumb_buffer (map-valid)
[224.581727] Starting subtest: map-valid
[224.583992] Subtest map-valid: SUCCESS (0.000s)
[224.698611] [045/154] (794s left) kms_ccs (crc-primary-suspend-4-tiled-bmg-ccs)
[224.802919] Starting subtest: crc-primary-suspend-4-tiled-bmg-ccs
[224.807469] Subtest crc-primary-suspend-4-tiled-bmg-ccs: SKIP (0.000s)
[225.979835] [046/154] (793s left) kms_psr2_sf (fbc-pr-overlay-primary-update-sf-dmg-area)
[226.084847] Starting subtest: fbc-pr-overlay-primary-update-sf-dmg-area
[226.089374] Subtest fbc-pr-overlay-primary-update-sf-dmg-area: SKIP (0.000s)
[226.153338] [047/154] (793s left) perf_pmu (busy-check-all)
[226.191252] Starting subtest: busy-check-all
[226.193253] Starting dynamic subtest: rcs0
[226.740581] Dynamic subtest rcs0: SUCCESS (0.550s)
[226.754325] Starting dynamic subtest: bcs0
[227.291748] Dynamic subtest bcs0: SUCCESS (0.551s)
[227.304482] Starting dynamic subtest: vcs0
[228.812133] Dynamic subtest vcs0: SUCCESS (1.518s)
[228.826242] Starting dynamic subtest: vcs1
[230.796956] Dynamic subtest vcs1: SUCCESS (1.983s)
[230.810147] Starting dynamic subtest: vecs0
[232.780072] Dynamic subtest vecs0: SUCCESS (1.982s)
[232.792788] Starting dynamic subtest: ccs0
[233.332429] Dynamic subtest ccs0: SUCCESS (0.552s)
[233.335732] Subtest busy-check-all: SUCCESS (7.144s)
[233.428597] [048/154] (786s left) kms_lease (setcrtc-implicit-plane)
[233.527526] Starting subtest: setcrtc-implicit-plane
[233.529867] Starting dynamic subtest: pipe-A-eDP-1
[233.984054] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.457s)
[233.995895] Starting dynamic subtest: pipe-B-eDP-1
[235.115968] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.131s)
[235.127094] Starting dynamic subtest: pipe-C-eDP-1
[236.210258] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.093s)
[236.221619] Starting dynamic subtest: pipe-D-eDP-1
[237.348245] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.136s)
[237.350790] Subtest setcrtc-implicit-plane: SUCCESS (3.822s)
[238.209376] [049/154] (781s left) syncobj_timeline (single-wait-all-signaled)
[238.284102] Starting subtest: single-wait-all-signaled
[238.286583] Subtest single-wait-all-signaled: SUCCESS (0.000s)
[238.395985] [050/154] (781s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-shrfb-plflip-blt)
[238.493751] Starting subtest: fbcpsr-1p-primscrn-shrfb-plflip-blt
[245.964093] Subtest fbcpsr-1p-primscrn-shrfb-plflip-blt: SUCCESS (7.477s)
[246.123553] [051/154] (773s left) kms_cursor_crc (cursor-random-64x21)
[246.316033] Starting subtest: cursor-random-64x21
[246.362719] Subtest cursor-random-64x21: SKIP (0.042s)
[246.603682] [052/154] (773s left) kms_frontbuffer_tracking (fbchdr-2p-primscrn-spr-indfb-move)
[246.694537] Starting subtest: fbchdr-2p-primscrn-spr-indfb-move
[246.698528] Subtest fbchdr-2p-primscrn-spr-indfb-move: SKIP (0.000s)
[246.775679] [053/154] (773s left) gem_compute (compute-square)
[246.837288] Starting subtest: compute-square
[246.839977] Subtest compute-square: SUCCESS (0.006s)
[246.941512] [054/154] (773s left) gem_exec_fence (syncobj-timeline-wait)
[247.522379] Starting subtest: syncobj-timeline-wait
[248.798807] Subtest syncobj-timeline-wait: SUCCESS (1.276s)
[249.037237] [FACT gem_exec_fence (syncobj-timeline-wait)] new: kernel.kmod_is_loaded.vgem: true
[249.040617] [055/154] (771s left) kms_chamelium_hpd (hdmi-hpd-after-suspend)
[249.426803] Subtest hdmi-hpd-after-suspend: SKIP (0.000s)
[250.242043] [056/154] (769s left) kms_chamelium_color (ctm-0-50)
[250.349991] Subtest ctm-0-50: SKIP (0.000s)
[250.395185] [057/154] (769s left) kms_frontbuffer_tracking (fbchdr-2p-scndscrn-pri-shrfb-draw-render)
[250.492676] Starting subtest: fbchdr-2p-scndscrn-pri-shrfb-draw-render
[250.496863] Subtest fbchdr-2p-scndscrn-pri-shrfb-draw-render: SKIP (0.000s)
[250.598212] [058/154] (769s left) kms_dirtyfb (default-dirtyfb-ioctl)
[250.688706] Starting subtest: default-dirtyfb-ioctl
[250.690892] Starting dynamic subtest: A-eDP-1
[252.291410] Dynamic subtest A-eDP-1: SUCCESS (1.602s)
[252.293473] Subtest default-dirtyfb-ioctl: SUCCESS (1.603s)
[253.096687] [059/154] (767s left) gem_workarounds (reset)
[253.170541] Starting subtest: reset
[253.324842] Subtest reset: SUCCESS (0.156s)
[253.445528] [060/154] (766s left) kms_frontbuffer_tracking (fbchdr-rgb565-draw-mmap-gtt)
[253.543680] Starting subtest: fbchdr-rgb565-draw-mmap-gtt
[253.547998] Subtest fbchdr-rgb565-draw-mmap-gtt: SKIP (0.000s)
[253.666953] [061/154] (766s left) kms_draw_crc (fill-fb)
[253.768627] Starting subtest: fill-fb
[254.253647] Subtest fill-fb: SUCCESS (0.487s)
[254.359293] [062/154] (766s left) kms_frontbuffer_tracking (psrhdr-2p-scndscrn-cur-indfb-onoff)
[254.451982] Starting subtest: psrhdr-2p-scndscrn-cur-indfb-onoff
[254.455432] Subtest psrhdr-2p-scndscrn-cur-indfb-onoff: SKIP (0.000s)
[254.542727] [063/154] (765s left) syncobj_basic (bad-destroy-pad)
[254.605574] Starting subtest: bad-destroy-pad
[254.607439] Subtest bad-destroy-pad: SUCCESS (0.000s)
[254.699812] [064/154] (765s left) gem_exec_schedule (u-submit-golden-slice)
[254.758275] Starting subtest: u-submit-golden-slice
[254.760199] Starting dynamic subtest: rcs0
[254.791583] Dynamic subtest rcs0: SUCCESS (0.038s)
[254.804759] Starting dynamic subtest: bcs0
[254.828174] Dynamic subtest bcs0: SUCCESS (0.036s)
[254.838673] Starting dynamic subtest: vcs0
[254.861502] Dynamic subtest vcs0: SUCCESS (0.033s)
[254.872045] Starting dynamic subtest: vcs1
[254.896038] Dynamic subtest vcs1: SUCCESS (0.034s)
[254.907884] Starting dynamic subtest: vecs0
[254.928571] Dynamic subtest vecs0: SUCCESS (0.032s)
[254.939057] Starting dynamic subtest: ccs0
[254.961551] Dynamic subtest ccs0: SUCCESS (0.032s)
[254.964040] Subtest u-submit-golden-slice: SUCCESS (0.208s)
[256.865692] [065/154] (763s left) i915_query (query-regions-sanity-check)
[256.929829] Starting subtest: query-regions-sanity-check
[256.938667] Subtest query-regions-sanity-check: SUCCESS (0.011s)
[257.067725] [066/154] (763s left) kms_ccs (crc-sprite-planes-basic-y-tiled-ccs)
[257.172619] Starting subtest: crc-sprite-planes-basic-y-tiled-ccs
[257.175388] Starting dynamic subtest: pipe-A-eDP-1
[257.236047] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[257.248522] Starting dynamic subtest: pipe-B-eDP-1
[257.307043] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[257.321195] Starting dynamic subtest: pipe-C-eDP-1
[257.379531] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[257.390861] Starting dynamic subtest: pipe-D-eDP-1
[257.447399] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[257.451503] Subtest crc-sprite-planes-basic-y-tiled-ccs: SKIP (0.008s)
[259.453971] [067/154] (761s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-indfb-draw-pwrite)
[259.560566] Starting subtest: psr-1p-offscreen-pri-indfb-draw-pwrite
[266.858249] Subtest psr-1p-offscreen-pri-indfb-draw-pwrite: SUCCESS (7.300s)
[266.974268] [068/154] (753s left) kms_pm_rpm (system-suspend-idle)
[269.007392] Starting subtest: system-suspend-idle
[288.372984] Subtest system-suspend-idle: SUCCESS (4.278s)
[288.761611] [069/154] (731s left) prime_busy (before-wait)
[288.827469] Starting subtest: before-wait
[288.833348] Starting dynamic subtest: rcs0
[288.859760] Dynamic subtest rcs0: SUCCESS (0.030s)
[288.870401] Starting dynamic subtest: bcs0
[288.900008] Dynamic subtest bcs0: SUCCESS (0.039s)
[288.910357] Starting dynamic subtest: vcs0
[288.939150] Dynamic subtest vcs0: SUCCESS (0.039s)
[288.949073] Starting dynamic subtest: vcs1
[288.978467] Dynamic subtest vcs1: SUCCESS (0.039s)
[288.988341] Starting dynamic subtest: vecs0
[289.018551] Dynamic subtest vecs0: SUCCESS (0.039s)
[289.028486] Starting dynamic subtest: ccs0
[289.057713] Dynamic subtest ccs0: SUCCESS (0.038s)
[289.165724] Subtest before-wait: SUCCESS (0.337s)
[289.247466] [070/154] (731s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-pwrite)
[289.344217] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-pwrite
[289.348780] Subtest psr-2p-scndscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[289.434289] [071/154] (731s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-mmap-gtt)
[289.537666] Starting subtest: psr-1p-primscrn-spr-indfb-draw-mmap-gtt
[289.542105] Subtest psr-1p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[289.644480] [072/154] (731s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-16bpp-ytile-upscaling)
[289.744271] Starting subtest: flip-64bpp-ytile-to-16bpp-ytile-upscaling
[289.748610] Subtest flip-64bpp-ytile-to-16bpp-ytile-upscaling: SKIP (0.000s)
[289.817901] [073/154] (731s left) syncobj_timeline (etime-multi-wait-all-for-submit-unsubmitted-signaled)
[289.881701] Starting subtest: etime-multi-wait-all-for-submit-unsubmitted-signaled
[289.987400] Subtest etime-multi-wait-all-for-submit-unsubmitted-signaled: SUCCESS (0.103s)
[290.065300] [074/154] (730s left) kms_plane_scaling (planes-upscale-20x20-downscale-factor-0-5)
[290.156321] Starting subtest: planes-upscale-20x20-downscale-factor-0-5
[290.158717] Starting dynamic subtest: pipe-A
[290.178320] Dynamic subtest pipe-A: SKIP (0.018s)
[290.189768] Starting dynamic subtest: pipe-B
[290.213543] Dynamic subtest pipe-B: SKIP (0.034s)
[290.224214] Starting dynamic subtest: pipe-C
[290.245251] Dynamic subtest pipe-C: SKIP (0.032s)
[290.255608] Starting dynamic subtest: pipe-D
[290.277783] Dynamic subtest pipe-D: SKIP (0.032s)
[290.281514] Subtest planes-upscale-20x20-downscale-factor-0-5: SKIP (0.118s)
[290.377845] [075/154] (730s left) prime_udl
[290.452914] [076/154] (730s left) kms_frontbuffer_tracking (fbcpsrhdr-modesetfrombusy)
[290.556218] Starting subtest: fbcpsrhdr-modesetfrombusy
[290.560147] Subtest fbcpsrhdr-modesetfrombusy: SKIP (0.000s)
[290.670800] [077/154] (730s left) gem_exec_whisper (basic-contexts-all)
[290.728523] Starting subtest: basic-contexts-all
[302.815895] Subtest basic-contexts-all: SUCCESS (12.088s)
[302.995366] [078/154] (718s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-0-hflip)
[303.096941] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-0-hflip
[304.198689] Subtest 4-tiled-max-hw-stride-32bpp-rotate-0-hflip: SUCCESS (1.103s)
[304.313142] [079/154] (716s left) kms_chamelium_edid (dp-edid-stress-resolution-non-4k)
[304.694488] Subtest dp-edid-stress-resolution-non-4k: SKIP (0.000s)
[305.555374] [080/154] (715s left) gem_ctx_persistence (legacy-engines-mixed-process)
[305.607634] Starting subtest: legacy-engines-mixed-process
[305.609803] Starting dynamic subtest: render
[306.878583] Dynamic subtest render: SUCCESS (1.271s)
[306.890175] Starting dynamic subtest: bsd1
[308.867960] Dynamic subtest bsd1: SUCCESS (1.988s)
[308.881146] Starting dynamic subtest: bsd2
[310.930826] Dynamic subtest bsd2: SUCCESS (2.061s)
[310.943101] Starting dynamic subtest: blt
[312.905694] Dynamic subtest blt: SUCCESS (1.973s)
[312.918145] Starting dynamic subtest: vebox
[314.886974] Dynamic subtest vebox: SUCCESS (1.980s)
[314.889743] Subtest legacy-engines-mixed-process: SUCCESS (9.282s)
[314.969401] [081/154] (706s left) kms_frontbuffer_tracking (hdr-rgb101010-draw-mmap-cpu)
[315.080677] Starting subtest: hdr-rgb101010-draw-mmap-cpu
[315.084783] Subtest hdr-rgb101010-draw-mmap-cpu: SKIP (0.000s)
[315.171251] [082/154] (706s left) kms_ccs (crc-primary-basic-yf-tiled-ccs)
[315.273284] Starting subtest: crc-primary-basic-yf-tiled-ccs
[315.275551] Starting dynamic subtest: pipe-A-eDP-1
[315.298655] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[315.311178] Starting dynamic subtest: pipe-B-eDP-1
[315.333586] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[315.344008] Starting dynamic subtest: pipe-C-eDP-1
[315.365721] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[315.376148] Starting dynamic subtest: pipe-D-eDP-1
[315.398152] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[315.402173] Subtest crc-primary-basic-yf-tiled-ccs: SKIP (0.006s)
[317.526866] [083/154] (703s left) gem_exec_balancer (bonded-semaphore)
[317.585016] Starting subtest: bonded-semaphore
[317.589172] Subtest bonded-semaphore: SKIP (0.000s)
[317.896604] [084/154] (703s left) gem_exec_reloc (basic-write-read)
[317.954000] Subtest basic-write-read: SKIP (0.000s)
[318.030282] [085/154] (703s left) kms_ccs (bad-aux-stride-yf-tiled-ccs)
[318.125888] Starting subtest: bad-aux-stride-yf-tiled-ccs
[318.128262] Starting dynamic subtest: pipe-A-eDP-1
[318.151146] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[318.164553] Starting dynamic subtest: pipe-B-eDP-1
[318.185196] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[318.195797] Starting dynamic subtest: pipe-C-eDP-1
[318.216426] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[318.226378] Starting dynamic subtest: pipe-D-eDP-1
[318.248587] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[318.252690] Subtest bad-aux-stride-yf-tiled-ccs: SKIP (0.004s)
[320.402747] [086/154] (700s left) gem_render_copy (linear)
[320.461067] Starting subtest: linear
[320.463505] Starting dynamic subtest: smem
[320.502986] Dynamic subtest smem: SUCCESS (0.041s)
[320.505569] Subtest linear: SUCCESS (0.042s)
[320.735700] [087/154] (700s left) syncobj_wait (wait-for-submit-delayed-submit)
[320.779558] Starting subtest: wait-for-submit-delayed-submit
[320.881781] Subtest wait-for-submit-delayed-submit: SUCCESS (0.103s)
[320.958762] [088/154] (700s left) gem_mmap_gtt (fault-concurrent-x)
[321.003442] Subtest fault-concurrent-X: SKIP (0.000s)
[321.068056] [089/154] (700s left) prime_vgem (basic-gtt)
[321.142095] Starting subtest: basic-gtt
[321.146582] Subtest basic-gtt: SKIP (0.000s)
[321.241828] [090/154] (700s left) kms_joiner (basic-ultra-joiner)
[321.338418] Starting subtest: basic-ultra-joiner
[321.342814] Subtest basic-ultra-joiner: SKIP (0.000s)
[321.407681] [091/154] (700s left) gem_lmem_swapping (heavy-verify-multi)
[321.446133] Subtest heavy-verify-multi: SKIP (0.000s)
[321.494683] [092/154] (700s left) kms_sequence (get-idle)
[321.585375] Starting subtest: get-idle
[321.587779] Starting dynamic subtest: pipe-A-eDP-1
[323.388173] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.802s)
[323.399583] Starting dynamic subtest: pipe-B-eDP-1
[325.886306] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.496s)
[325.897397] Starting dynamic subtest: pipe-C-eDP-1
[328.403603] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.517s)
[328.415589] Starting dynamic subtest: pipe-D-eDP-1
[330.831981] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.427s)
[330.834306] Subtest get-idle: SUCCESS (9.248s)
[331.646466] [093/154] (690s left) kms_pipe_crc_basic (nonblocking-crc)
[331.751199] Starting subtest: nonblocking-crc
[331.753572] Starting dynamic subtest: pipe-A-eDP-1
[332.486113] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.734s)
[332.498031] Starting dynamic subtest: pipe-B-eDP-1
[333.962736] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.475s)
[333.975279] Starting dynamic subtest: pipe-C-eDP-1
[335.346969] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.382s)
[335.358754] Starting dynamic subtest: pipe-D-eDP-1
[336.694187] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.347s)
[336.696619] Subtest nonblocking-crc: SUCCESS (4.944s)
[337.584302] [094/154] (684s left) prime_mmap (test_userptr)
[337.645709] Starting subtest: test_userptr
[337.647776] Starting dynamic subtest: test_userptr-smem
[337.649839] Dynamic subtest test_userptr-smem: SUCCESS (0.000s)
[337.651863] Subtest test_userptr: SUCCESS (0.001s)
[337.761384] [095/154] (684s left) kms_async_flips (test-time-stamp)
[337.861034] Starting subtest: test-time-stamp
[338.237497] Starting dynamic subtest: pipe-A-eDP-1
[339.087735] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.850s)
[339.481138] Starting dynamic subtest: pipe-B-eDP-1
[340.326452] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.854s)
[340.713979] Starting dynamic subtest: pipe-C-eDP-1
[341.564883] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.856s)
[341.935157] Starting dynamic subtest: pipe-D-eDP-1
[342.697112] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.768s)
[342.699527] Subtest test-time-stamp: SUCCESS (4.837s)
[343.871249] [096/154] (677s left) kms_frontbuffer_tracking (fbchdr-1p-primscrn-indfb-plflip-blt)
[343.965559] Starting subtest: fbchdr-1p-primscrn-indfb-plflip-blt
[343.970085] Subtest fbchdr-1p-primscrn-indfb-plflip-blt: SKIP (0.000s)
[344.084214] [097/154] (677s left) kms_addfb_basic (addfb25-y-tiled-legacy)
[344.183570] Starting subtest: addfb25-y-tiled-legacy
[344.185674] Subtest addfb25-y-tiled-legacy: SUCCESS (0.000s)
[344.277247] [098/154] (677s left) kms_frontbuffer_tracking (psrhdr-2p-primscrn-pri-shrfb-draw-mmap-gtt)
[344.383580] Starting subtest: psrhdr-2p-primscrn-pri-shrfb-draw-mmap-gtt
[344.387632] Subtest psrhdr-2p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[344.494393] [099/154] (677s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-scndscrn-pri-shrfb-draw-render)
[344.599302] Starting subtest: fbcpsrhdr-2p-scndscrn-pri-shrfb-draw-render
[344.603565] Subtest fbcpsrhdr-2p-scndscrn-pri-shrfb-draw-render: SKIP (0.000s)
[344.696106] [100/154] (677s left) syncobj_timeline (invalid-multi-wait-unsubmitted-submitted-signaled)
[344.748996] Starting subtest: invalid-multi-wait-unsubmitted-submitted-signaled
[344.751113] Subtest invalid-multi-wait-unsubmitted-submitted-signaled: SUCCESS (0.000s)
[344.845632] [101/154] (677s left) core_setmaster (master-drop-set-shared-fd)
[344.923482] Starting subtest: master-drop-set-shared-fd
[344.942255] Subtest master-drop-set-shared-fd: SUCCESS (0.021s)
[344.982611] [102/154] (677s left) kms_cursor_legacy (cursora-vs-flipa-varying-size)
[345.095458] Starting subtest: cursorA-vs-flipA-varying-size
[356.264457] Subtest cursorA-vs-flipA-varying-size: SUCCESS (11.168s)
[357.099782] [103/154] (665s left) kms_frontbuffer_tracking (hdr-2p-scndscrn-indfb-msflip-blt)
[357.199393] Starting subtest: hdr-2p-scndscrn-indfb-msflip-blt
[357.203690] Subtest hdr-2p-scndscrn-indfb-msflip-blt: SKIP (0.000s)
[357.294978] [104/154] (664s left) kms_scaling_modes (scaling-mode-full)
[357.395159] Starting subtest: scaling-mode-full
[357.396991] Starting dynamic subtest: pipe-A-eDP-1
[357.487537] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.094s)
[357.501355] Starting dynamic subtest: pipe-B-eDP-1
[358.637412] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.147s)
[358.651960] Starting dynamic subtest: pipe-C-eDP-1
[359.841123] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.200s)
[359.855372] Starting dynamic subtest: pipe-D-eDP-1
[360.988225] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.144s)
[360.990597] Subtest scaling-mode-full: SUCCESS (3.596s)
[362.163645] [105/154] (660s left) prime_self_import (reimport-vs-gem_close-race)
[362.200705] Starting subtest: reimport-vs-gem_close-race
[367.309029] Subtest reimport-vs-gem_close-race: SUCCESS (5.108s)
[367.390110] [106/154] (654s left) api_intel_allocator (execbuf-with-allocator)
[367.443560] Starting subtest: execbuf-with-allocator
[367.452160] Subtest execbuf-with-allocator: SUCCESS (0.011s)
[367.571328] [107/154] (654s left) gem_partial_pwrite_pread (reads-snoop)
[367.644673] Subtest reads-snoop: SKIP (0.000s)
[367.722507] [108/154] (654s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-0-hflip)
[367.835251] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-0-hflip
[367.839303] Subtest yf-tiled-max-hw-stride-32bpp-rotate-0-hflip: SKIP (0.000s)
[367.937231] [109/154] (654s left) gem_render_copy (yf-tiled-ccs-to-yf-tiled-ccs)
[367.999784] Starting subtest: yf-tiled-ccs-to-yf-tiled-ccs
[368.004249] Subtest yf-tiled-ccs-to-yf-tiled-ccs: SKIP (0.000s)
[368.197622] [110/154] (654s left) gem_eio (suspend)
[368.421705] Starting subtest: suspend
[380.630823] Subtest suspend: SUCCESS (12.212s)
[380.774139] [111/154] (641s left) kms_addfb_basic (small-bo)
[380.878621] Starting subtest: small-bo
[380.880743] Subtest small-bo: SUCCESS (0.000s)
[380.990239] [112/154] (641s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-mmap-wc)
[381.094547] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-mmap-wc
[381.098823] Subtest fbc-2p-primscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[381.192728] [113/154] (641s left) kms_plane (pixel-format-y-tiled-modifier)
[381.285037] Starting subtest: pixel-format-y-tiled-modifier
[381.289007] Subtest pixel-format-y-tiled-modifier: SKIP (0.000s)
[381.359142] [114/154] (641s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-render)
[381.458500] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-render
[381.461911] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-render: SKIP (0.000s)
[381.559783] [115/154] (641s left) kms_psr (fbc-psr2-sprite-mmap-cpu)
[381.652385] Starting subtest: fbc-psr2-sprite-mmap-cpu
[381.654152] Starting dynamic subtest: eDP-1
[381.657483] Dynamic subtest eDP-1: SKIP (0.000s)
[381.660740] Subtest fbc-psr2-sprite-mmap-cpu: SKIP (0.001s)
[381.729425] [116/154] (640s left) gem_partial_pwrite_pread (writes-after-reads)
[381.782279] Subtest writes-after-reads: SKIP (0.000s)
[381.855325] [117/154] (640s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-mmap-gtt)
[381.949539] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-mmap-gtt
[381.952963] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[382.065307] [118/154] (640s left) kms_plane_scaling (plane-scaler-unity-scaling-with-pixel-format)
[382.159620] Starting subtest: plane-scaler-unity-scaling-with-pixel-format
[382.161651] Starting dynamic subtest: pipe-A
[383.331718] Dynamic subtest pipe-A: SUCCESS (1.174s)
[383.344654] Starting dynamic subtest: pipe-B
[385.532358] Dynamic subtest pipe-B: SUCCESS (2.200s)
[385.543405] Starting dynamic subtest: pipe-C
[386.716439] Dynamic subtest pipe-C: SUCCESS (1.183s)
[386.728410] Starting dynamic subtest: pipe-D
[387.950532] Dynamic subtest pipe-D: SUCCESS (1.232s)
[387.953025] Subtest plane-scaler-unity-scaling-with-pixel-format: SUCCESS (5.793s)
[389.142175] [119/154] (633s left) kms_psr (fbc-pr-cursor-mmap-cpu)
[389.246455] Starting subtest: fbc-pr-cursor-mmap-cpu
[389.251029] Subtest fbc-pr-cursor-mmap-cpu: SKIP (0.000s)
[389.331356] [120/154] (633s left) kms_content_protection (atomic-hdcp14)
[389.467359] Starting subtest: atomic-hdcp14
[389.471901] Subtest atomic-hdcp14: SKIP (0.000s)
[389.589683] [121/154] (633s left) gem_render_copy (y-tiled-ccs-to-yf-tiled-mc-ccs)
[389.657736] Starting subtest: y-tiled-ccs-to-yf-tiled-mc-ccs
[389.662163] Subtest y-tiled-ccs-to-yf-tiled-mc-ccs: SKIP (0.000s)
[389.854839] [122/154] (633s left) kms_psr (pr-cursor-plane-move)
[389.942218] Starting subtest: pr-cursor-plane-move
[389.946679] Subtest pr-cursor-plane-move: SKIP (0.000s)
[390.018291] [123/154] (632s left) kms_vrr (flip-basic-fastset)
[390.116996] Starting subtest: flip-basic-fastset
[390.123057] Subtest flip-basic-fastset: SKIP (0.000s)
[390.192391] [124/154] (632s left) kms_force_connector_basic (force-connector-state)
[390.266341] Starting subtest: force-connector-state
[390.880163] Subtest force-connector-state: SUCCESS (0.614s)
[391.809215] [125/154] (631s left) kms_psr (psr-cursor-mmap-gtt)
[391.902240] Starting subtest: psr-cursor-mmap-gtt
[391.904569] Starting dynamic subtest: eDP-1
[393.637456] Dynamic subtest eDP-1: SUCCESS (1.736s)
[393.639761] Subtest psr-cursor-mmap-gtt: SUCCESS (1.737s)
[394.488682] [126/154] (628s left) gem_exec_balancer (parallel-keep-in-fence)
[394.747276] Starting subtest: parallel-keep-in-fence
[395.992207] Subtest parallel-keep-in-fence: SUCCESS (1.245s)
[396.107697] [127/154] (627s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-blt)
[396.211996] Starting subtest: psr-1p-primscrn-cur-indfb-draw-blt
[402.958327] Subtest psr-1p-primscrn-cur-indfb-draw-blt: SUCCESS (6.751s)
[403.083839] [128/154] (620s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-primscrn-spr-indfb-draw-blt)
[403.191544] Starting subtest: fbcpsrhdr-2p-primscrn-spr-indfb-draw-blt
[403.195525] Subtest fbcpsrhdr-2p-primscrn-spr-indfb-draw-blt: SKIP (0.000s)
[403.309195] [129/154] (619s left) syncobj_wait (single-wait-submitted)
[403.371251] Starting subtest: single-wait-submitted
[403.474997] Subtest single-wait-submitted: SUCCESS (0.104s)
[403.554915] [130/154] (619s left) kms_psr2_sf (psr2-overlay-plane-update-sf-dmg-area)
[403.659161] Starting subtest: psr2-overlay-plane-update-sf-dmg-area
[403.661434] Starting dynamic subtest: pipe-A-eDP-1
[409.419209] Dynamic subtest pipe-A-eDP-1: SUCCESS (5.766s)
[409.431310] Starting dynamic subtest: pipe-B-eDP-1
[415.928769] Dynamic subtest pipe-B-eDP-1: SUCCESS (6.506s)
[415.931063] Subtest psr2-overlay-plane-update-sf-dmg-area: SUCCESS (12.276s)
[416.761095] [131/154] (606s left) kms_big_fb (yf-tiled-32bpp-rotate-180)
[416.862770] Starting subtest: yf-tiled-32bpp-rotate-180
[416.867267] Subtest yf-tiled-32bpp-rotate-180: SKIP (0.000s)
[416.982210] [132/154] (606s left) syncobj_timeline (multi-wait-for-submit-available-unsubmitted-signaled)
[417.030719] Starting subtest: multi-wait-for-submit-available-unsubmitted-signaled
[417.032989] Subtest multi-wait-for-submit-available-unsubmitted-signaled: SUCCESS (0.000s)
[417.127380] [133/154] (606s left) kms_cursor_legacy (cursora-vs-flipa-atomic-transitions-varying-size)
[417.241730] Starting subtest: cursorA-vs-flipA-atomic-transitions-varying-size
[428.418395] Subtest cursorA-vs-flipA-atomic-transitions-varying-size: SUCCESS (11.175s)
[429.271588] [134/154] (594s left) tools_test (tools_test)
[429.328330] Starting subtest: tools_test
[429.383658] Subtest tools_test: SUCCESS (0.068s)
[429.459523] [135/154] (594s left) gem_mmap_gtt (basic-small-bo)
[429.514097] Subtest basic-small-bo: SKIP (0.000s)
[429.574445] [136/154] (593s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-pwrite)
[429.669565] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-pwrite
[439.138156] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-pwrite: SUCCESS (9.473s)
[439.291512] [137/154] (584s left) kms_frontbuffer_tracking (psrhdr-1p-primscrn-pri-indfb-draw-mmap-cpu)
[439.399966] Starting subtest: psrhdr-1p-primscrn-pri-indfb-draw-mmap-cpu
[439.404210] Subtest psrhdr-1p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[439.521161] [138/154] (584s left) gem_ctx_isolation (dirty-switch)
[439.572761] Starting subtest: dirty-switch
[439.575021] Starting dynamic subtest: rcs0
[439.782690] Dynamic subtest rcs0: SUCCESS (0.209s)
[439.796161] Starting dynamic subtest: bcs0
[440.002513] Dynamic subtest bcs0: SUCCESS (0.218s)
[440.015315] Starting dynamic subtest: vcs0
[440.239300] Dynamic subtest vcs0: SUCCESS (0.237s)
[440.250664] Starting dynamic subtest: vcs1
[442.062043] Dynamic subtest vcs1: SUCCESS (1.821s)
[442.073347] Starting dynamic subtest: vecs0
[444.108268] Dynamic subtest vecs0: SUCCESS (2.045s)
[444.121916] Starting dynamic subtest: ccs0
[446.100779] Dynamic subtest ccs0: SUCCESS (1.992s)
[446.103307] Subtest dirty-switch: SUCCESS (6.529s)
[446.355535] [139/154] (577s left) kms_psr (fbc-psr-sprite-plane-onoff)
[446.447633] Starting subtest: fbc-psr-sprite-plane-onoff
[446.450040] Starting dynamic subtest: eDP-1
[446.454168] Dynamic subtest eDP-1: SKIP (0.000s)
[446.458224] Subtest fbc-psr-sprite-plane-onoff: SKIP (0.001s)
[446.538516] [140/154] (577s left) kms_getfb (getfb2-handle-closed)
[446.632424] Starting subtest: getfb2-handle-closed
[446.634687] Subtest getfb2-handle-closed: SUCCESS (0.000s)
[446.759119] [141/154] (577s left) kms_big_fb (x-tiled-32bpp-rotate-90)
[446.864914] Starting subtest: x-tiled-32bpp-rotate-90
[446.884494] Subtest x-tiled-32bpp-rotate-90: SKIP (0.019s)
[447.000376] [142/154] (576s left) gem_sync (basic-each)
[447.084738] Starting subtest: basic-each
[449.437174] Subtest basic-each: SUCCESS (2.363s)
[449.624677] [143/154] (574s left) kms_frontbuffer_tracking (fbc-rgb565-draw-mmap-cpu)
[449.727912] Starting subtest: fbc-rgb565-draw-mmap-cpu
[453.737133] Subtest fbc-rgb565-draw-mmap-cpu: SUCCESS (4.016s)
[454.861644] [144/154] (569s left) kms_color (deep-color)
[454.969021] Starting subtest: deep-color
[456.094962] Starting dynamic subtest: pipe-A-eDP-1-gamma
[456.819797] Dynamic subtest pipe-A-eDP-1-gamma: SUCCESS (0.727s)
[456.835029] Starting dynamic subtest: pipe-A-eDP-1-degamma
[458.293951] Dynamic subtest pipe-A-eDP-1-degamma: SUCCESS (1.473s)
[458.307243] Starting dynamic subtest: pipe-A-eDP-1-ctm
[459.775505] Dynamic subtest pipe-A-eDP-1-ctm: SUCCESS (1.478s)
[460.606146] Starting dynamic subtest: pipe-B-eDP-1-gamma
[461.310767] Dynamic subtest pipe-B-eDP-1-gamma: SUCCESS (0.715s)
[461.322591] Starting dynamic subtest: pipe-B-eDP-1-degamma
[462.772157] Dynamic subtest pipe-B-eDP-1-degamma: SUCCESS (1.459s)
[462.783170] Starting dynamic subtest: pipe-B-eDP-1-ctm
[464.259488] Dynamic subtest pipe-B-eDP-1-ctm: SUCCESS (1.484s)
[465.097373] Starting dynamic subtest: pipe-C-eDP-1-gamma
[465.783458] Dynamic subtest pipe-C-eDP-1-gamma: SUCCESS (0.696s)
[465.795089] Starting dynamic subtest: pipe-C-eDP-1-degamma
[467.227237] Dynamic subtest pipe-C-eDP-1-degamma: SUCCESS (1.441s)
[467.239184] Starting dynamic subtest: pipe-C-eDP-1-ctm
[468.628270] Dynamic subtest pipe-C-eDP-1-ctm: SUCCESS (1.401s)
[469.402004] Starting dynamic subtest: pipe-D-eDP-1-gamma
[470.108749] Dynamic subtest pipe-D-eDP-1-gamma: SUCCESS (0.716s)
[470.120313] Starting dynamic subtest: pipe-D-eDP-1-degamma
[471.524183] Dynamic subtest pipe-D-eDP-1-degamma: SUCCESS (1.417s)
[471.536990] Starting dynamic subtest: pipe-D-eDP-1-ctm
[472.928506] Dynamic subtest pipe-D-eDP-1-ctm: SUCCESS (1.401s)
[472.930484] Subtest deep-color: SUCCESS (17.961s)
[473.760635] [145/154] (550s left) kms_big_fb (linear-addfb)
[473.860795] Starting subtest: linear-addfb
[473.863144] Subtest linear-addfb: SUCCESS (0.000s)
[473.961547] [146/154] (550s left) kms_frontbuffer_tracking (psrhdr-1p-primscrn-spr-indfb-move)
[474.062986] Starting subtest: psrhdr-1p-primscrn-spr-indfb-move
[474.067140] Subtest psrhdr-1p-primscrn-spr-indfb-move: SKIP (0.000s)
[474.160595] [147/154] (549s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-render)
[474.255897] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-render
[474.259913] Subtest psr-2p-primscrn-pri-shrfb-draw-render: SKIP (0.000s)
[474.366911] [148/154] (549s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-gtt)
[474.475576] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-gtt
[474.479886] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[474.581309] [149/154] (549s left) kms_cursor_edge_walk (128x128-top-bottom)
[474.668880] Starting subtest: 128x128-top-bottom
[474.670752] Starting dynamic subtest: pipe-A-eDP-1
[478.192287] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.523s)
[478.204109] Starting dynamic subtest: pipe-D-eDP-1
[481.365416] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.173s)
[481.367826] Subtest 128x128-top-bottom: SUCCESS (6.699s)
[482.250802] [150/154] (541s left) kms_frontbuffer_tracking (fbchdr-2p-primscrn-pri-shrfb-draw-mmap-cpu)
[482.353144] Starting subtest: fbchdr-2p-primscrn-pri-shrfb-draw-mmap-cpu
[482.357526] Subtest fbchdr-2p-primscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[482.439104] [151/154] (541s left) gem_exec_fence (syncobj-export)
[482.893864] Starting subtest: syncobj-export
[482.900048] Subtest syncobj-export: SUCCESS (0.005s)
[483.961205] [152/154] (540s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-onoff)
[484.057101] Starting subtest: fbc-2p-scndscrn-cur-indfb-onoff
[484.061145] Subtest fbc-2p-scndscrn-cur-indfb-onoff: SKIP (0.000s)
[484.159233] [153/154] (540s left) gem_softpin (invalid)
[484.219431] Starting subtest: invalid
[484.227832] Subtest invalid: SUCCESS (0.008s)
[484.359385] [154/154] (539s left) kms_frontbuffer_tracking (hdr-2p-primscrn-cur-indfb-onoff)
[484.462219] Starting subtest: hdr-2p-primscrn-cur-indfb-onoff
[484.466397] Subtest hdr-2p-primscrn-cur-indfb-onoff: SKIP (0.000s)
[484.556790] Closing watchdogs
results: parsing output: 0/ for test: kms_frontbuffer_tracking
results: parsing output: 1/ for test: kms_frontbuffer_tracking
results: parsing output: 2/ for test: kms_frontbuffer_tracking
results: parsing output: 3/ for test: core_debugfs
results: parsing output: 4/ for test: syncobj_wait
results: parsing output: 5/ for test: kms_flip_scaled_crc
results: parsing output: 6/ for test: kms_getfb
results: parsing output: 7/ for test: kms_flip_scaled_crc
results: parsing output: 8/ for test: perf
results: parsing output: 9/ for test: gem_userptr_blits
results: parsing output: 10/ for test: kms_frontbuffer_tracking
results: parsing output: 11/ for test: kms_frontbuffer_tracking
results: parsing output: 12/ for test: kms_flip
results: parsing output: 13/ for test: gem_eio
results: parsing output: 14/ for test: gem_exec_flush
results: parsing output: 15/ for test: i915_hangman
results: parsing output: 16/ for test: perf_pmu
results: parsing output: 17/ for test: gem_eio
results: parsing output: 18/ for test: kms_frontbuffer_tracking
results: parsing output: 19/ for test: gem_mmap_wc
results: parsing output: 20/ for test: kms_big_fb
results: parsing output: 21/ for test: kms_flip
results: parsing output: 22/ for test: i915_drm_fdinfo
results: parsing output: 23/ for test: gem_exec_schedule
results: parsing output: 24/ for test: syncobj_timeline
results: parsing output: 25/ for test: kms_frontbuffer_tracking
results: parsing output: 26/ for test: gem_spin_batch
results: parsing output: 27/ for test: kms_frontbuffer_tracking
results: parsing output: 28/ for test: kms_dsc
results: parsing output: 29/ for test: kms_frontbuffer_tracking
results: parsing output: 30/ for test: i915_pm_rpm
results: parsing output: 31/ for test: prime_mmap_kms
results: parsing output: 32/ for test: gen9_exec_parse
results: parsing output: 33/ for test: kms_pm_rpm
results: parsing output: 34/ for test: drm_read
results: parsing output: 35/ for test: kms_plane_multiple
results: parsing output: 36/ for test: kms_cursor_crc
results: parsing output: 37/ for test: kms_frontbuffer_tracking
results: parsing output: 38/ for test: gem_madvise
results: parsing output: 39/ for test: gem_mmap_gtt
results: parsing output: 40/ for test: kms_flip
results: parsing output: 41/ for test: gem_readwrite
results: parsing output: 42/ for test: kms_ccs
results: parsing output: 43/ for test: dumb_buffer
results: parsing output: 44/ for test: kms_ccs
results: parsing output: 45/ for test: kms_psr2_sf
results: parsing output: 46/ for test: perf_pmu
results: parsing output: 47/ for test: kms_lease
results: parsing output: 48/ for test: syncobj_timeline
results: parsing output: 49/ for test: kms_frontbuffer_tracking
results: parsing output: 50/ for test: kms_cursor_crc
results: parsing output: 51/ for test: kms_frontbuffer_tracking
results: parsing output: 52/ for test: gem_compute
results: parsing output: 53/ for test: gem_exec_fence
results: parsing output: 54/ for test: kms_chamelium_hpd
results: parsing output: 55/ for test: kms_chamelium_color
results: parsing output: 56/ for test: kms_frontbuffer_tracking
results: parsing output: 57/ for test: kms_dirtyfb
results: parsing output: 58/ for test: gem_workarounds
results: parsing output: 59/ for test: kms_frontbuffer_tracking
results: parsing output: 60/ for test: kms_draw_crc
results: parsing output: 61/ for test: kms_frontbuffer_tracking
results: parsing output: 62/ for test: syncobj_basic
results: parsing output: 63/ for test: gem_exec_schedule
results: parsing output: 64/ for test: i915_query
results: parsing output: 65/ for test: kms_ccs
results: parsing output: 66/ for test: kms_frontbuffer_tracking
results: parsing output: 67/ for test: kms_pm_rpm
results: parsing output: 68/ for test: prime_busy
results: parsing output: 69/ for test: kms_frontbuffer_tracking
results: parsing output: 70/ for test: kms_frontbuffer_tracking
results: parsing output: 71/ for test: kms_flip_scaled_crc
results: parsing output: 72/ for test: syncobj_timeline
results: parsing output: 73/ for test: kms_plane_scaling
results: parsing output: 74/ for test: prime_udl
results: parsing output: 75/ for test: kms_frontbuffer_tracking
results: parsing output: 76/ for test: gem_exec_whisper
results: parsing output: 77/ for test: kms_big_fb
results: parsing output: 78/ for test: kms_chamelium_edid
results: parsing output: 79/ for test: gem_ctx_persistence
results: parsing output: 80/ for test: kms_frontbuffer_tracking
results: parsing output: 81/ for test: kms_ccs
results: parsing output: 82/ for test: gem_exec_balancer
results: parsing output: 83/ for test: gem_exec_reloc
results: parsing output: 84/ for test: kms_ccs
results: parsing output: 85/ for test: gem_render_copy
results: parsing output: 86/ for test: syncobj_wait
results: parsing output: 87/ for test: gem_mmap_gtt
results: parsing output: 88/ for test: prime_vgem
results: parsing output: 89/ for test: kms_joiner
results: parsing output: 90/ for test: gem_lmem_swapping
results: parsing output: 91/ for test: kms_sequence
results: parsing output: 92/ for test: kms_pipe_crc_basic
results: parsing output: 93/ for test: prime_mmap
results: parsing output: 94/ for test: kms_async_flips
results: parsing output: 95/ for test: kms_frontbuffer_tracking
results: parsing output: 96/ for test: kms_addfb_basic
results: parsing output: 97/ for test: kms_frontbuffer_tracking
results: parsing output: 98/ for test: kms_frontbuffer_tracking
results: parsing output: 99/ for test: syncobj_timeline
results: parsing output: 100/ for test: core_setmaster
results: parsing output: 101/ for test: kms_cursor_legacy
results: parsing output: 102/ for test: kms_frontbuffer_tracking
results: parsing output: 103/ for test: kms_scaling_modes
results: parsing output: 104/ for test: prime_self_import
results: parsing output: 105/ for test: api_intel_allocator
results: parsing output: 106/ for test: gem_partial_pwrite_pread
results: parsing output: 107/ for test: kms_big_fb
results: parsing output: 108/ for test: gem_render_copy
results: parsing output: 109/ for test: gem_eio
results: parsing output: 110/ for test: kms_addfb_basic
results: parsing output: 111/ for test: kms_frontbuffer_tracking
results: parsing output: 112/ for test: kms_plane
results: parsing output: 113/ for test: kms_frontbuffer_tracking
results: parsing output: 114/ for test: kms_psr
results: parsing output: 115/ for test: gem_partial_pwrite_pread
results: parsing output: 116/ for test: kms_frontbuffer_tracking
results: parsing output: 117/ for test: kms_plane_scaling
results: parsing output: 118/ for test: kms_psr
results: parsing output: 119/ for test: kms_content_protection
results: parsing output: 120/ for test: gem_render_copy
results: parsing output: 121/ for test: kms_psr
results: parsing output: 122/ for test: kms_vrr
results: parsing output: 123/ for test: kms_force_connector_basic
results: parsing output: 124/ for test: kms_psr
results: parsing output: 125/ for test: gem_exec_balancer
results: parsing output: 126/ for test: kms_frontbuffer_tracking
results: parsing output: 127/ for test: kms_frontbuffer_tracking
results: parsing output: 128/ for test: syncobj_wait
results: parsing output: 129/ for test: kms_psr2_sf
results: parsing output: 130/ for test: kms_big_fb
results: parsing output: 131/ for test: syncobj_timeline
results: parsing output: 132/ for test: kms_cursor_legacy
results: parsing output: 133/ for test: tools_test
results: parsing output: 134/ for test: gem_mmap_gtt
results: parsing output: 135/ for test: kms_frontbuffer_tracking
results: parsing output: 136/ for test: kms_frontbuffer_tracking
results: parsing output: 137/ for test: gem_ctx_isolation
results: parsing output: 138/ for test: kms_psr
results: parsing output: 139/ for test: kms_getfb
results: parsing output: 140/ for test: kms_big_fb
results: parsing output: 141/ for test: gem_sync
results: parsing output: 142/ for test: kms_frontbuffer_tracking
results: parsing output: 143/ for test: kms_color
results: parsing output: 144/ for test: kms_big_fb
results: parsing output: 145/ for test: kms_frontbuffer_tracking
results: parsing output: 146/ for test: kms_frontbuffer_tracking
results: parsing output: 147/ for test: kms_frontbuffer_tracking
results: parsing output: 148/ for test: kms_cursor_edge_walk
results: parsing output: 149/ for test: kms_frontbuffer_tracking
results: parsing output: 150/ for test: gem_exec_fence
results: parsing output: 151/ for test: kms_frontbuffer_tracking
results: parsing output: 152/ for test: gem_softpin
results: parsing output: 153/ for test: kms_frontbuffer_tracking
Done.