[51.291304] Initializing watchdogs
[51.291366]   /dev/watchdog0
[51.307137] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:9a49 Intel Tigerlake (Gen12) TigerLake-LP GT2 [Iris Xe Graphics]
[51.313261] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[51.315745] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[51.317596] [001/133] (960s left) kms_atomic_transition (plane-all-transition-fencing)
[51.414777] Starting subtest: plane-all-transition-fencing
[51.415496] Starting dynamic subtest: pipe-A-HDMI-A-1
[53.402424] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (1.987s)
[53.477052] Starting dynamic subtest: pipe-B-HDMI-A-1
[55.574570] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (2.102s)
[55.640463] Subtest plane-all-transition-fencing: SUCCESS (4.225s)
[55.784292] [002/133] (956s left) kms_ccs (bad-rotation-90-4-tiled-lnl-ccs)
[55.879755] Starting subtest: bad-rotation-90-4-tiled-lnl-ccs
[55.881188] Subtest bad-rotation-90-4-tiled-lnl-ccs: SKIP (0.000s)
[56.043763] [003/133] (955s left) kms_lease (lease-get)
[56.135873] Starting subtest: lease-get
[56.136627] Starting dynamic subtest: pipe-A-HDMI-A-1
[56.137403] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.001s)
[56.146503] Starting dynamic subtest: pipe-B-HDMI-A-1
[56.147300] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.001s)
[56.153397] Starting dynamic subtest: pipe-C-HDMI-A-1
[56.154100] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.001s)
[56.161086] Starting dynamic subtest: pipe-D-HDMI-A-1
[56.161806] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.001s)
[56.162492] Subtest lease-get: SUCCESS (0.010s)
[56.213605] [004/133] (955s left) gem_exec_whisper (basic-contexts-forked-all)
[56.261078] Starting subtest: basic-contexts-forked-all
[59.722564] Subtest basic-contexts-forked-all: SUCCESS (3.452s)
[59.889357] [005/133] (952s left) perf_pmu (pmu-read)
[59.924748] Starting subtest: pmu-read
[59.927964] Subtest pmu-read: SUCCESS (0.003s)
[59.994028] [006/133] (952s left) kms_prime (basic-modeset-hybrid)
[60.093487] Subtest basic-modeset-hybrid: SKIP (0.000s)
[60.205356] [FACT kms_prime (basic-modeset-hybrid)] new: kernel.kmod_is_loaded.vgem: true
[60.206945] [007/133] (951s left) syncobj_timeline (multi-wait-for-submit-available-unsubmitted-submitted)
[60.243184] Starting subtest: multi-wait-for-submit-available-unsubmitted-submitted
[60.243930] Subtest multi-wait-for-submit-available-unsubmitted-submitted: SUCCESS (0.001s)
[60.302227] [008/133] (951s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-gtt)
[60.393685] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-gtt
[60.395055] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[60.486600] [009/133] (951s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-mmap-wc)
[60.578375] Starting subtest: psr-2p-primscrn-pri-indfb-draw-mmap-wc
[60.579772] Subtest psr-2p-primscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[60.691830] [010/133] (951s left) kms_ccs (ccs-on-another-bo-yf-tiled-ccs)
[60.780809] Starting subtest: ccs-on-another-bo-yf-tiled-ccs
[60.781529] Starting dynamic subtest: pipe-A-HDMI-A-1
[60.788671] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.000s)
[60.795590] Starting dynamic subtest: pipe-B-HDMI-A-1
[60.802606] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.000s)
[60.809342] Starting dynamic subtest: pipe-C-HDMI-A-1
[60.816396] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.000s)
[60.822995] Starting dynamic subtest: pipe-D-HDMI-A-1
[60.830074] Dynamic subtest pipe-D-HDMI-A-1: SKIP (0.000s)
[60.831409] Subtest ccs-on-another-bo-yf-tiled-ccs: SKIP (0.005s)
[61.031829] [011/133] (951s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-mmap-cpu)
[61.123605] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-mmap-cpu
[61.125005] Subtest fbc-2p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[61.236562] [012/133] (951s left) gem_partial_pwrite_pread (reads-uncached)
[61.274427] Starting subtest: reads-uncached
[63.008565] Subtest reads-uncached: SUCCESS (1.734s)
[63.124403] [013/133] (949s left) gem_eio (in-flight-immediate)
[63.168130] Starting subtest: in-flight-immediate
[65.353041] Subtest in-flight-immediate: SUCCESS (2.184s)
[65.472992] [014/133] (946s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-blt)
[65.577141] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-blt
[66.811183] Subtest fbc-1p-primscrn-cur-indfb-draw-blt: SUCCESS (1.248s)
[67.107815] [015/133] (945s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-blt)
[67.232115] Starting subtest: fbcpsr-rgb565-draw-blt
[67.234439] Subtest fbcpsr-rgb565-draw-blt: SKIP (0.000s)
[67.542753] [016/133] (944s left) gem_exec_capture (capture-recoverable)
[67.632273] Starting subtest: capture-recoverable
[67.634241] Subtest capture-recoverable: SKIP (0.000s)
[67.786276] [017/133] (944s left) kms_draw_crc (draw-method-mmap-gtt)
[67.935412] Starting subtest: draw-method-mmap-gtt
[67.936223] Starting dynamic subtest: xrgb8888-untiled
[68.086487] Dynamic subtest xrgb8888-untiled: SUCCESS (0.152s)
[68.094186] Starting dynamic subtest: rgb565-untiled
[68.237137] Dynamic subtest rgb565-untiled: SUCCESS (0.149s)
[68.253162] Starting dynamic subtest: xrgb2101010-untiled
[68.386751] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.149s)
[68.401190] Starting dynamic subtest: xbgr16161616f-untiled
[68.536685] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.148s)
[68.550038] Starting dynamic subtest: xrgb8888-xtiled
[68.611966] Dynamic subtest xrgb8888-xtiled: SUCCESS (0.074s)
[68.628320] Starting dynamic subtest: rgb565-xtiled
[68.686978] Dynamic subtest rgb565-xtiled: SUCCESS (0.074s)
[68.701816] Starting dynamic subtest: xrgb2101010-xtiled
[68.761745] Dynamic subtest xrgb2101010-xtiled: SUCCESS (0.074s)
[68.777876] Starting dynamic subtest: xbgr16161616f-xtiled
[68.836778] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (0.074s)
[68.850039] Starting dynamic subtest: xrgb8888-ytiled
[68.920402] Dynamic subtest xrgb8888-ytiled: SUCCESS (0.083s)
[68.933014] Starting dynamic subtest: rgb565-ytiled
[69.003720] Dynamic subtest rgb565-ytiled: SUCCESS (0.082s)
[69.019768] Starting dynamic subtest: xrgb2101010-ytiled
[69.078360] Dynamic subtest xrgb2101010-ytiled: SUCCESS (0.074s)
[69.093020] Starting dynamic subtest: xbgr16161616f-ytiled
[69.186866] Dynamic subtest xbgr16161616f-ytiled: SUCCESS (0.107s)
[69.188046] Subtest draw-method-mmap-gtt: SUCCESS (1.253s)
[69.294213] [018/133] (943s left) kms_flip (nonexisting-fb)
[69.385141] Starting subtest: nonexisting-fb
[69.387005] Starting dynamic subtest: A-HDMI-A1
[69.604072] Dynamic subtest A-HDMI-A1: SUCCESS (0.217s)
[69.612046] Starting dynamic subtest: B-HDMI-A1
[69.759997] Dynamic subtest B-HDMI-A1: SUCCESS (0.155s)
[69.769254] Starting dynamic subtest: C-HDMI-A1
[69.922027] Dynamic subtest C-HDMI-A1: SUCCESS (0.161s)
[69.930330] Starting dynamic subtest: D-HDMI-A1
[70.077168] Dynamic subtest D-HDMI-A1: SUCCESS (0.154s)
[70.079204] Subtest nonexisting-fb: SUCCESS (0.695s)
[70.242249] [019/133] (942s left) gem_exec_schedule (preempt-self)
[70.289667] Starting subtest: preempt-self
[70.290421] Starting dynamic subtest: rcs0
[70.301885] Dynamic subtest rcs0: SUCCESS (0.011s)
[70.309953] Starting dynamic subtest: bcs0
[70.314060] Dynamic subtest bcs0: SUCCESS (0.012s)
[70.322054] Starting dynamic subtest: vcs0
[70.326283] Dynamic subtest vcs0: SUCCESS (0.012s)
[70.337604] Starting dynamic subtest: vcs1
[70.342463] Dynamic subtest vcs1: SUCCESS (0.015s)
[70.351421] Starting dynamic subtest: vecs0
[70.354350] Dynamic subtest vecs0: SUCCESS (0.011s)
[70.355089] Subtest preempt-self: SUCCESS (0.065s)
[70.651600] [020/133] (942s left) sysfs_timeslice_duration (idempotent)
[70.689035] Starting subtest: idempotent
[70.689809] Starting dynamic subtest: vecs0
[70.690537] Dynamic subtest vecs0: SUCCESS (0.001s)
[70.698068] Starting dynamic subtest: vcs0
[70.698782] Dynamic subtest vcs0: SUCCESS (0.000s)
[70.706074] Starting dynamic subtest: bcs0
[70.706779] Dynamic subtest bcs0: SUCCESS (0.000s)
[70.714103] Starting dynamic subtest: rcs0
[70.714819] Dynamic subtest rcs0: SUCCESS (0.000s)
[70.722182] Starting dynamic subtest: vcs1
[70.722905] Dynamic subtest vcs1: SUCCESS (0.000s)
[70.723661] Subtest idempotent: SUCCESS (0.006s)
[70.756126] [021/133] (941s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-mmap-gtt)
[70.848537] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-mmap-gtt
[70.850039] Subtest psr-1p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[70.953556] [022/133] (941s left) sw_sync (alloc_timeline)
[70.985274] Starting subtest: alloc_timeline
[70.986017] Subtest alloc_timeline: SUCCESS (0.000s)
[71.048918] [023/133] (941s left) gem_exec_reloc (basic-cpu-wc-active)
[71.086552] Starting subtest: basic-cpu-wc-active
[71.218375] Subtest basic-cpu-wc-active: SUCCESS (0.123s)
[71.339739] [024/133] (941s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-blt)
[71.430597] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-blt
[71.431964] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-blt: SKIP (0.000s)
[71.535367] [025/133] (941s left) gem_exec_reloc (basic-gtt-active)
[71.574702] Starting subtest: basic-gtt-active
[71.708131] Subtest basic-gtt-active: SUCCESS (0.125s)
[71.822835] [026/133] (941s left) kms_atomic (plane-primary-overlay-mutable-zpos)
[71.909844] Starting subtest: plane-primary-overlay-mutable-zpos
[72.365281] Subtest plane-primary-overlay-mutable-zpos: SKIP (0.455s)
[72.546895] [027/133] (940s left) kms_psr2_sf (psr2-cursor-plane-move-continuous-exceed-fully-sf)
[72.636718] Subtest psr2-cursor-plane-move-continuous-exceed-fully-sf: SKIP (0.000s)
[72.684427] [028/133] (940s left) kms_psr (fbc-pr-cursor-blt)
[72.773994] Subtest fbc-pr-cursor-blt: SKIP (0.000s)
[72.816822] [029/133] (940s left) kms_atomic_transition (plane-primary-toggle-with-vblank-wait)
[72.903690] Starting subtest: plane-primary-toggle-with-vblank-wait
[72.904385] Starting dynamic subtest: pipe-A-HDMI-A-1
[73.026362] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.122s)
[73.108726] Starting dynamic subtest: pipe-B-HDMI-A-1
[73.266194] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.165s)
[73.315039] Subtest plane-primary-toggle-with-vblank-wait: SUCCESS (0.411s)
[73.483689] [030/133] (939s left) kms_frontbuffer_tracking (psr-rgb565-draw-mmap-gtt)
[73.576680] Starting subtest: psr-rgb565-draw-mmap-gtt
[73.578132] Subtest psr-rgb565-draw-mmap-gtt: SKIP (0.000s)
[73.686500] [031/133] (939s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-0)
[73.785606] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-0
[74.379398] Subtest x-tiled-max-hw-stride-64bpp-rotate-0: SUCCESS (0.594s)
[74.512710] [032/133] (938s left) kms_plane_scaling (invalid-num-scalers)
[74.600844] Starting subtest: invalid-num-scalers
[74.610288] Starting dynamic subtest: pipe-A-HDMI-A-1-invalid-num-scalers
[74.632141] Dynamic subtest pipe-A-HDMI-A-1-invalid-num-scalers: SUCCESS (0.021s)
[74.648763] Starting dynamic subtest: pipe-B-HDMI-A-1-invalid-num-scalers
[74.681498] Dynamic subtest pipe-B-HDMI-A-1-invalid-num-scalers: SUCCESS (0.039s)
[74.697801] Starting dynamic subtest: pipe-C-HDMI-A-1-invalid-num-scalers
[74.730279] Dynamic subtest pipe-C-HDMI-A-1-invalid-num-scalers: SUCCESS (0.039s)
[74.749789] Starting dynamic subtest: pipe-D-HDMI-A-1-invalid-num-scalers
[74.781779] Dynamic subtest pipe-D-HDMI-A-1-invalid-num-scalers: SUCCESS (0.041s)
[74.782537] Subtest invalid-num-scalers: SUCCESS (0.181s)
[74.900362] [033/133] (938s left) i915_pm_rpm (system-suspend-devices)
[76.297888] Starting subtest: system-suspend-devices
[84.240643] Subtest system-suspend-devices: SUCCESS (7.943s)
[92.453463] [034/133] (928s left) gem_mmap_gtt (cpuset-basic-small-copy-xy)
[92.490072] Starting subtest: cpuset-basic-small-copy-XY
[97.966044] Subtest cpuset-basic-small-copy-XY: SUCCESS (5.475s)
[98.033083] [035/133] (923s left) syncobj_timeline (single-wait-all-signaled)
[98.122485] Starting subtest: single-wait-all-signaled
[98.123265] Subtest single-wait-all-signaled: SUCCESS (0.001s)
[98.185942] [036/133] (923s left) kms_force_connector_basic (force-edid)
[98.316248] Starting subtest: force-edid
[98.461390] Subtest force-edid: SUCCESS (0.150s)
[98.619706] [037/133] (922s left) gem_huc_copy (huc-copy)
[98.660884] Starting subtest: huc-copy
[98.662383] Subtest huc-copy: SKIP (0.000s)
[98.755650] [038/133] (922s left) kms_chamelium_frames (hdmi-cmp-planar-formats)
[98.899183] Subtest hdmi-cmp-planar-formats: SKIP (0.000s)
[98.999051] [039/133] (922s left) gem_exec_reloc (basic-range)
[99.038481] Starting subtest: basic-range
[99.065296] Subtest basic-range: SUCCESS (0.027s)
[99.194323] [040/133] (922s left) vgem_slow (nohang)
[99.228177] Starting subtest: nohang
[109.669848] Subtest nohang: SUCCESS (10.430s)
[109.737893] [041/133] (911s left) kms_content_protection (suspend-resume)
[109.838184] Starting subtest: suspend-resume
[109.843446] Subtest suspend-resume: SKIP (0.004s)
[109.937758] [042/133] (911s left) kms_dirtyfb (fbc-dirtyfb-ioctl)
[110.025963] Starting subtest: fbc-dirtyfb-ioctl
[110.027794] Starting dynamic subtest: A-HDMI-A-1
[111.258274] Dynamic subtest A-HDMI-A-1: SUCCESS (1.230s)
[111.259047] Subtest fbc-dirtyfb-ioctl: SUCCESS (1.232s)
[111.394967] [043/133] (910s left) gem_create (create-size-update)
[111.433233] Starting subtest: create-size-update
[111.433991] Subtest create-size-update: SUCCESS (0.000s)
[111.644273] [044/133] (910s left) syncobj_wait (multi-wait-all-for-submit-submitted-signaled)
[111.679812] Starting subtest: multi-wait-all-for-submit-submitted-signaled
[111.780642] Subtest multi-wait-all-for-submit-submitted-signaled: SUCCESS (0.101s)
[111.859988] [045/133] (909s left) syncobj_wait (wait-for-submit-complex)
[111.894280] Starting subtest: wait-for-submit-complex
[111.955940] Subtest wait-for-submit-complex: SUCCESS (0.062s)
[112.034293] [046/133] (909s left) i915_suspend (fence-restore-tiled2untiled)
[112.067702] Starting subtest: fence-restore-tiled2untiled
[132.101226] Subtest fence-restore-tiled2untiled: SUCCESS (5.171s)
[141.211277] [047/133] (889s left) kms_ccs (crc-sprite-planes-basic-4-tiled-bmg-ccs)
[141.305689] Starting subtest: crc-sprite-planes-basic-4-tiled-bmg-ccs
[141.307200] Subtest crc-sprite-planes-basic-4-tiled-bmg-ccs: SKIP (0.000s)
[141.466719] [048/133] (889s left) api_intel_bb (blit-noreloc-keep-cache)
[141.501590] Starting subtest: blit-noreloc-keep-cache
[141.508755] Subtest blit-noreloc-keep-cache: SUCCESS (0.007s)
[141.628533] [049/133] (889s left) kms_async_flips (async-flip-dpms)
[141.715817] Starting subtest: async-flip-dpms
[141.839075] Starting dynamic subtest: pipe-A-HDMI-A-1
[144.291868] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (2.451s)
[144.445444] Starting dynamic subtest: pipe-B-HDMI-A-1
[146.855382] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (2.417s)
[147.007336] Starting dynamic subtest: pipe-C-HDMI-A-1
[149.431796] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (2.432s)
[149.581243] Starting dynamic subtest: pipe-D-HDMI-A-1
[152.009622] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (2.434s)
[152.010409] Subtest async-flip-dpms: SUCCESS (10.292s)
[152.277681] [050/133] (878s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-mmap-gtt)
[152.376695] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-mmap-gtt
[153.637601] Subtest fbc-1p-primscrn-pri-shrfb-draw-mmap-gtt: SUCCESS (1.262s)
[153.753836] [051/133] (877s left) gem_exec_schedule (fifo)
[153.798940] Starting subtest: fifo
[153.799676] Starting dynamic subtest: rcs0
[153.858091] Dynamic subtest rcs0: SUCCESS (0.058s)
[153.875391] Starting dynamic subtest: bcs0
[153.925680] Dynamic subtest bcs0: SUCCESS (0.066s)
[153.940577] Starting dynamic subtest: vcs0
[153.989504] Dynamic subtest vcs0: SUCCESS (0.061s)
[154.004433] Starting dynamic subtest: vcs1
[154.052488] Dynamic subtest vcs1: SUCCESS (0.061s)
[154.067182] Starting dynamic subtest: vecs0
[154.115961] Dynamic subtest vecs0: SUCCESS (0.061s)
[154.117104] Subtest fifo: SUCCESS (0.318s)
[154.433962] [052/133] (876s left) kms_psr (pr-cursor-mmap-gtt)
[154.524280] Subtest pr-cursor-mmap-gtt: SKIP (0.000s)
[154.571332] [053/133] (876s left) gem_exec_reloc (basic-cpu-read-noreloc)
[154.610623] Starting subtest: basic-cpu-read-noreloc
[154.612346] Subtest basic-cpu-read-noreloc: SUCCESS (0.003s)
[154.725192] [054/133] (876s left) gem_userptr_blits (sd-probe)
[154.764696] Starting subtest: sd-probe
[154.765422] Subtest sd-probe: SUCCESS (0.000s)
[154.897028] [055/133] (876s left) kms_cursor_crc (cursor-offscreen-512x170)
[154.989590] Starting subtest: cursor-offscreen-512x170
[154.990969] Subtest cursor-offscreen-512x170: SKIP (0.001s)
[155.095772] [056/133] (876s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-pwrite)
[155.187983] Starting subtest: psr-2p-primscrn-cur-indfb-draw-pwrite
[155.189391] Subtest psr-2p-primscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[155.296710] [057/133] (875s left) kms_vblank (wait-idle-hang)
[155.384750] Starting subtest: wait-idle-hang
[155.386591] Starting dynamic subtest: pipe-A-HDMI-A-1
[169.623487] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (14.236s)
[169.636490] Starting dynamic subtest: pipe-D-HDMI-A-1
[183.449217] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (13.822s)
[183.451599] Subtest wait-idle-hang: SUCCESS (28.064s)
[183.611459] [058/133] (847s left) syncobj_timeline (etime-single-wait-all-for-submit-available-unsubmitted)
[183.647474] Starting subtest: etime-single-wait-all-for-submit-available-unsubmitted
[183.761891] Subtest etime-single-wait-all-for-submit-available-unsubmitted: SUCCESS (0.105s)
[183.852403] [059/133] (847s left) kms_atomic_interruptible (legacy-cursor)
[183.941355] Starting subtest: legacy-cursor
[183.943119] Starting dynamic subtest: pipe-A-HDMI-A-1
[190.173031] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (6.228s)
[190.173730] Subtest legacy-cursor: SUCCESS (6.230s)
[190.320115] [060/133] (841s left) kms_flip_scaled_crc (flip-32bpp-4tile-to-64bpp-4tile-upscaling)
[190.416814] Starting subtest: flip-32bpp-4tile-to-64bpp-4tile-upscaling
[190.418225] Subtest flip-32bpp-4tile-to-64bpp-4tile-upscaling: SKIP (0.000s)
[190.473692] [061/133] (840s left) kms_color_pipeline (plane-ctm3x4)
[190.564209] Starting subtest: plane-ctm3x4
[190.645362] Starting dynamic subtest: pipe-A-plane-0
[190.727929] Dynamic subtest pipe-A-plane-0: SUCCESS (0.082s)
[190.747037] Starting dynamic subtest: pipe-A-plane-1
[190.803005] Dynamic subtest pipe-A-plane-1: SUCCESS (0.073s)
[190.821390] Starting dynamic subtest: pipe-A-plane-2
[190.879336] Dynamic subtest pipe-A-plane-2: SUCCESS (0.072s)
[191.092645] Starting dynamic subtest: pipe-B-plane-0
[191.148991] Dynamic subtest pipe-B-plane-0: SUCCESS (0.066s)
[191.163174] Starting dynamic subtest: pipe-B-plane-1
[191.223864] Dynamic subtest pipe-B-plane-1: SUCCESS (0.073s)
[191.241251] Starting dynamic subtest: pipe-B-plane-2
[191.298931] Dynamic subtest pipe-B-plane-2: SUCCESS (0.073s)
[191.527987] Starting dynamic subtest: pipe-C-plane-0
[191.585663] Dynamic subtest pipe-C-plane-0: SUCCESS (0.066s)
[191.602353] Starting dynamic subtest: pipe-C-plane-1
[191.660362] Dynamic subtest pipe-C-plane-1: SUCCESS (0.073s)
[191.676633] Starting dynamic subtest: pipe-C-plane-2
[191.743879] Dynamic subtest pipe-C-plane-2: SUCCESS (0.081s)
[191.944215] Starting dynamic subtest: pipe-D-plane-0
[192.003353] Dynamic subtest pipe-D-plane-0: SUCCESS (0.067s)
[192.018728] Starting dynamic subtest: pipe-D-plane-1
[192.079331] Dynamic subtest pipe-D-plane-1: SUCCESS (0.073s)
[192.092834] Starting dynamic subtest: pipe-D-plane-2
[192.159917] Dynamic subtest pipe-D-plane-2: SUCCESS (0.081s)
[192.207953] Subtest plane-ctm3x4: SUCCESS (1.644s)
[192.327341] [062/133] (839s left) kms_psr (psr-cursor-blt)
[192.420412] Subtest psr-cursor-blt: SKIP (0.000s)
[192.462165] [063/133] (839s left) gem_mmap_gtt (hang-busy)
[192.495595] Starting subtest: hang-busy
[227.975758] Subtest hang-busy: SUCCESS (35.473s)
[228.090030] [064/133] (803s left) syncobj_timeline (invalid-single-wait-all-unsubmitted)
[228.124888] Starting subtest: invalid-single-wait-all-unsubmitted
[228.125594] Subtest invalid-single-wait-all-unsubmitted: SUCCESS (0.000s)
[228.193599] [065/133] (803s left) gem_exec_nop (basic-sequential)
[228.236799] Starting subtest: basic-sequential
[231.581016] Subtest basic-sequential: SUCCESS (3.343s)
[231.791660] [066/133] (799s left) gem_render_copy (y-tiled-ccs-to-yf-tiled-mc-ccs)
[231.831730] Starting subtest: y-tiled-ccs-to-yf-tiled-mc-ccs
[231.832479] Starting dynamic subtest: smem
[231.912332] Dynamic subtest smem: SUCCESS (0.080s)
[231.913058] Subtest y-tiled-ccs-to-yf-tiled-mc-ccs: SUCCESS (0.081s)
[232.112545] [067/133] (799s left) kms_frontbuffer_tracking (psr-farfromfence-mmap-gtt)
[232.208788] Starting subtest: psr-farfromfence-mmap-gtt
[232.210955] Subtest psr-farfromfence-mmap-gtt: SKIP (0.000s)
[232.297944] [068/133] (799s left) kms_plane (pixel-format-4-tiled-mtl-mc-ccs-modifier-source-clamping)
[232.389179] Starting subtest: pixel-format-4-tiled-mtl-mc-ccs-modifier-source-clamping
[232.390666] Subtest pixel-format-4-tiled-mtl-mc-ccs-modifier-source-clamping: SKIP (0.000s)
[232.452049] [069/133] (799s left) gem_ctx_shared (q-smoketest)
[232.496673] Starting subtest: Q-smoketest
[232.497390] Starting dynamic subtest: rcs0
[237.930089] Dynamic subtest rcs0: SUCCESS (5.418s)
[237.941024] Starting dynamic subtest: bcs0
[243.382869] Dynamic subtest bcs0: SUCCESS (5.426s)
[243.393946] Starting dynamic subtest: vcs0
[248.800939] Dynamic subtest vcs0: SUCCESS (5.417s)
[248.812986] Starting dynamic subtest: vcs1
[254.219785] Dynamic subtest vcs1: SUCCESS (5.417s)
[254.230712] Starting dynamic subtest: vecs0
[259.641372] Dynamic subtest vecs0: SUCCESS (5.420s)
[259.642375] Subtest Q-smoketest: SUCCESS (27.104s)
[259.794301] [070/133] (771s left) gem_pxp (verify-pxp-key-change-after-suspend-resume)
[259.898176] Starting subtest: verify-pxp-key-change-after-suspend-resume
[266.603612] Subtest verify-pxp-key-change-after-suspend-resume: SUCCESS (6.707s)
[275.771063] [071/133] (765s left) kms_flip (absolute-wf_vblank)
[275.880487] Starting subtest: absolute-wf_vblank
[275.882271] Starting dynamic subtest: A-HDMI-A1
[283.611341] Dynamic subtest A-HDMI-A1: SUCCESS (7.706s)
[283.620035] Starting dynamic subtest: B-HDMI-A1
[291.287085] Dynamic subtest B-HDMI-A1: SUCCESS (7.663s)
[291.295912] Starting dynamic subtest: C-HDMI-A1
[298.943824] Dynamic subtest C-HDMI-A1: SUCCESS (7.657s)
[298.952473] Starting dynamic subtest: D-HDMI-A1
[306.604891] Dynamic subtest D-HDMI-A1: SUCCESS (7.658s)
[306.605677] Subtest absolute-wf_vblank: SUCCESS (30.699s)
[306.735299] [072/133] (734s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-shrfb-draw-mmap-gtt)
[306.855322] Starting subtest: fbc-1p-offscreen-pri-shrfb-draw-mmap-gtt
[307.945551] Subtest fbc-1p-offscreen-pri-shrfb-draw-mmap-gtt: SUCCESS (1.091s)
[308.066112] [073/133] (732s left) kms_pm_rpm (fences-dpms)
[309.470929] Starting subtest: fences-dpms
[314.087183] Subtest fences-dpms: SUCCESS (4.608s)
[314.183060] [074/133] (726s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-mmap-gtt)
[314.278535] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-mmap-gtt
[314.280137] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[314.380966] [075/133] (726s left) kms_ccs (crc-primary-suspend-4-tiled-bmg-ccs)
[314.469094] Starting subtest: crc-primary-suspend-4-tiled-bmg-ccs
[314.470550] Subtest crc-primary-suspend-4-tiled-bmg-ccs: SKIP (0.000s)
[314.644428] [076/133] (726s left) i915_drm_fdinfo (all-busy-check-all)
[314.684102] Starting subtest: all-busy-check-all
[315.201646] Subtest all-busy-check-all: SUCCESS (0.517s)
[315.275907] [077/133] (725s left) kms_plane_scaling (planes-upscale-factor-0-25)
[315.366409] Starting subtest: planes-upscale-factor-0-25
[315.367179] Starting dynamic subtest: pipe-A
[315.430903] Dynamic subtest pipe-A: SUCCESS (0.065s)
[315.441664] Starting dynamic subtest: pipe-B
[315.565271] Dynamic subtest pipe-B: SUCCESS (0.133s)
[315.578284] Starting dynamic subtest: pipe-C
[315.699081] Dynamic subtest pipe-C: SUCCESS (0.133s)
[315.709737] Starting dynamic subtest: pipe-D
[315.851198] Dynamic subtest pipe-D: SUCCESS (0.151s)
[315.851904] Subtest planes-upscale-factor-0-25: SUCCESS (0.486s)
[316.048551] [078/133] (725s left) kms_big_fb (linear-max-hw-stride-64bpp-rotate-180)
[316.151716] Starting subtest: linear-max-hw-stride-64bpp-rotate-180
[316.702785] Subtest linear-max-hw-stride-64bpp-rotate-180: SUCCESS (0.551s)
[316.816532] [079/133] (724s left) sw_sync (sync_multi_timeline_wait)
[316.849799] Starting subtest: sync_multi_timeline_wait
[316.850538] Subtest sync_multi_timeline_wait: SUCCESS (0.000s)
[316.910680] [080/133] (724s left) kms_chamelium_color (ctm-negative)
[316.998682] Subtest ctm-negative: SKIP (0.000s)
[317.044681] [081/133] (724s left) gem_exec_fence (syncobj-signal)
[317.384522] Starting subtest: syncobj-signal
[317.387038] Subtest syncobj-signal: SUCCESS (0.003s)
[317.687294] [082/133] (723s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-0-hflip)
[317.784902] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-0-hflip
[317.786298] Subtest yf-tiled-max-hw-stride-64bpp-rotate-0-hflip: SKIP (0.000s)
[317.863147] [083/133] (723s left) gem_pxp (create-regular-context-2)
[317.900836] Starting subtest: create-regular-context-2
[317.901566] Subtest create-regular-context-2: SUCCESS (0.000s)
[317.983006] [084/133] (723s left) kms_cursor_legacy (cursora-vs-flipb-atomic)
[318.071885] Starting subtest: cursorA-vs-flipB-atomic
[318.074523] Subtest cursorA-vs-flipB-atomic: SKIP (0.001s)
[318.132090] [085/133] (723s left) kms_cursor_crc (cursor-rapid-movement-32x10)
[318.221373] Starting subtest: cursor-rapid-movement-32x10
[318.274037] Subtest cursor-rapid-movement-32x10: SKIP (0.051s)
[318.356881] [086/133] (723s left) gem_eio (unwedge-stress)
[318.400670] Starting subtest: unwedge-stress
[318.401384] Starting dynamic subtest: render
[335.755777] Dynamic subtest render: SUCCESS (17.354s)
[335.770621] Starting dynamic subtest: bsd1
[353.746295] Dynamic subtest bsd1: SUCCESS (17.988s)
[353.758849] Starting dynamic subtest: bsd2
[371.733660] Dynamic subtest bsd2: SUCCESS (17.986s)
[371.743920] Starting dynamic subtest: blt
[389.781986] Dynamic subtest blt: SUCCESS (18.047s)
[389.792253] Starting dynamic subtest: vebox
[407.767138] Dynamic subtest vebox: SUCCESS (17.984s)
[407.767849] Subtest unwedge-stress: SUCCESS (89.367s)
[407.887465] [087/133] (633s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-180-hflip)
[407.987191] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-180-hflip
[407.988666] Subtest yf-tiled-max-hw-stride-64bpp-rotate-180-hflip: SKIP (0.000s)
[408.087660] [088/133] (633s left) gem_ctx_param (invalid-param-set)
[408.123331] Starting subtest: invalid-param-set
[408.124174] Subtest invalid-param-set: SUCCESS (0.000s)
[408.197033] [089/133] (633s left) kms_frontbuffer_tracking (fbc-suspend)
[408.287570] Starting subtest: fbc-suspend
[444.361826] Subtest fbc-suspend: SUCCESS (5.259s)
[450.596431] [090/133] (597s left) gem_mmap_gtt (basic-read-write-distinct)
[450.639855] Starting subtest: basic-read-write-distinct
[450.642871] Subtest basic-read-write-distinct: SUCCESS (0.003s)
[450.735846] [091/133] (597s left) kms_psr (psr-primary-mmap-gtt)
[450.825767] Subtest psr-primary-mmap-gtt: SKIP (0.000s)
[450.871500] [092/133] (596s left) i915_pm_freq_api (freq-reset)
[450.909264] Subtest freq-reset: SKIP (0.000s)
[450.954477] [093/133] (596s left) kms_cursor_legacy (cursor-vs-flip-atomic-transitions)
[451.044072] Starting subtest: cursor-vs-flip-atomic-transitions
[480.959872] Subtest cursor-vs-flip-atomic-transitions: SUCCESS (29.905s)
[481.121179] [094/133] (566s left) syncobj_eventfd (invalid-illegal-eventfd)
[481.159908] Starting subtest: invalid-illegal-eventfd
[481.160727] Subtest invalid-illegal-eventfd: SUCCESS (0.000s)
[481.239267] [095/133] (566s left) kms_sequence (queue-busy)
[481.331889] Starting subtest: queue-busy
[481.332697] Starting dynamic subtest: pipe-A-HDMI-A-1
[482.633831] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (1.300s)
[482.646195] Starting dynamic subtest: pipe-B-HDMI-A-1
[483.914729] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (1.279s)
[483.924295] Starting dynamic subtest: pipe-C-HDMI-A-1
[485.207469] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (1.292s)
[485.221935] Starting dynamic subtest: pipe-D-HDMI-A-1
[486.482818] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (1.272s)
[486.483573] Subtest queue-busy: SUCCESS (5.151s)
[486.606402] [096/133] (561s left) gem_ctx_persistence (saturated-hostile-nopreempt)
[486.648559] Starting subtest: saturated-hostile-nopreempt
[486.649376] Starting dynamic subtest: rcs0
[487.396123] Dynamic subtest rcs0: SUCCESS (0.738s)
[487.412265] Starting dynamic subtest: bcs0
[488.164366] Dynamic subtest bcs0: SUCCESS (0.766s)
[488.183128] Starting dynamic subtest: vcs0
[488.895500] Dynamic subtest vcs0: SUCCESS (0.729s)
[488.908021] Starting dynamic subtest: vcs1
[489.641371] Dynamic subtest vcs1: SUCCESS (0.743s)
[489.653940] Starting dynamic subtest: vecs0
[490.402062] Dynamic subtest vecs0: SUCCESS (0.758s)
[490.403086] Subtest saturated-hostile-nopreempt: SUCCESS (3.745s)
[490.514011] [097/133] (557s left) gem_softpin (allocator-basic-reserve)
[490.552010] Starting subtest: allocator-basic-reserve
[490.637140] Subtest allocator-basic-reserve: SUCCESS (0.085s)
[490.748215] [098/133] (557s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-blt)
[490.841819] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-blt
[490.843282] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-blt: SKIP (0.000s)
[490.942227] [099/133] (557s left) kms_psr (fbc-psr2-cursor-blt)
[491.029695] Subtest fbc-psr2-cursor-blt: SKIP (0.000s)
[491.075298] [100/133] (557s left) fbdev (unaligned-write)
[491.117552] Starting subtest: unaligned-write
[491.243215] Subtest unaligned-write: SUCCESS (0.117s)
[491.289079] [101/133] (556s left) gem_exec_reloc (basic-gtt-wc-noreloc)
[491.327734] Starting subtest: basic-gtt-wc-noreloc
[491.332392] Subtest basic-gtt-wc-noreloc: SUCCESS (0.005s)
[491.452985] [102/133] (556s left) kms_prop_blob (blob-prop-validate)
[491.488015] Starting subtest: blob-prop-validate
[491.488727] Subtest blob-prop-validate: SUCCESS (0.000s)
[491.574848] [103/133] (556s left) gem_exec_balancer (full-pulse)
[491.616686] Starting subtest: full-pulse
[493.212688] Subtest full-pulse: SUCCESS (1.595s)
[493.406582] [104/133] (554s left) dumb_buffer (map-uaf)
[493.440725] Starting subtest: map-uaf
[493.445598] Subtest map-uaf: SUCCESS (0.006s)
[493.529334] [105/133] (554s left) api_intel_bb (object-noreloc-keep-cache-simple)
[493.563823] Starting subtest: object-noreloc-keep-cache-simple
[493.566276] Subtest object-noreloc-keep-cache-simple: SUCCESS (0.003s)
[493.679529] [106/133] (554s left) kms_setmode (basic-clone-single-crtc)
[493.713917] Starting subtest: basic-clone-single-crtc
[493.716137] Subtest basic-clone-single-crtc: SKIP (0.000s)
[493.803870] [107/133] (554s left) gem_exec_schedule (preempt-queue-contexts)
[493.850019] Starting subtest: preempt-queue-contexts
[493.850762] Starting dynamic subtest: rcs0
[494.184619] Dynamic subtest rcs0: SUCCESS (0.325s)
[494.197836] Starting dynamic subtest: bcs0
[494.518784] Dynamic subtest bcs0: SUCCESS (0.333s)
[494.529052] Starting dynamic subtest: vcs0
[494.847175] Dynamic subtest vcs0: SUCCESS (0.326s)
[494.857446] Starting dynamic subtest: vcs1
[495.176970] Dynamic subtest vcs1: SUCCESS (0.328s)
[495.189441] Starting dynamic subtest: vecs0
[495.497070] Dynamic subtest vecs0: SUCCESS (0.319s)
[495.497852] Subtest preempt-queue-contexts: SUCCESS (1.639s)
[495.813492] [108/133] (552s left) gem_exec_reloc (basic-write-cpu-noreloc)
[495.852615] Starting subtest: basic-write-cpu-noreloc
[495.855334] Subtest basic-write-cpu-noreloc: SUCCESS (0.003s)
[495.971639] [109/133] (552s left) gem_softpin (evict-snoop)
[496.012353] Starting subtest: evict-snoop
[496.013858] Subtest evict-snoop: SKIP (0.000s)
[496.075741] [110/133] (552s left) kms_big_fb (linear-16bpp-rotate-270)
[496.173533] Starting subtest: linear-16bpp-rotate-270
[496.266775] Subtest linear-16bpp-rotate-270: SKIP (0.092s)
[496.363944] [111/133] (552s left) kms_plane_alpha_blend (coverage-7efc)
[496.455017] Starting subtest: coverage-7efc
[496.522289] Starting dynamic subtest: pipe-A-HDMI-A-1
[496.824777] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.302s)
[496.868231] Starting dynamic subtest: pipe-D-HDMI-A-1
[497.342806] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.486s)
[497.343602] Subtest coverage-7efc: SUCCESS (0.888s)
[497.526021] [112/133] (551s left) kms_invalid_mode (clock-too-high)
[497.619587] Starting subtest: clock-too-high
[497.620318] Starting dynamic subtest: pipe-A-HDMI-A-1
[497.678273] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.058s)
[497.689363] Starting dynamic subtest: pipe-B-HDMI-A-1
[497.690192] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.009s)
[497.699752] Starting dynamic subtest: pipe-C-HDMI-A-1
[497.700460] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.009s)
[497.712303] Starting dynamic subtest: pipe-D-HDMI-A-1
[497.713017] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.009s)
[497.713737] Subtest clock-too-high: SUCCESS (0.093s)
[497.851736] [113/133] (550s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-wc)
[497.946047] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-wc
[497.947513] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[498.050302] [114/133] (550s left) gem_partial_pwrite_pread (write)
[498.088370] Starting subtest: write
[508.231849] Subtest write: SUCCESS (10.143s)
[508.343527] [115/133] (540s left) gen7_exec_parse (oacontrol-tracking)
[508.381182] Subtest oacontrol-tracking: SKIP (0.000s)
[508.428037] [116/133] (540s left) prime_busy (hang)
[508.466509] Starting subtest: hang
[508.468338] Starting dynamic subtest: rcs0
[522.470082] Dynamic subtest rcs0: SUCCESS (13.964s)
[522.479219] Starting dynamic subtest: bcs0
[529.251466] Dynamic subtest bcs0: SUCCESS (6.782s)
[529.260693] Starting dynamic subtest: vcs0
[536.227646] Dynamic subtest vcs0: SUCCESS (6.974s)
[536.236788] Starting dynamic subtest: vcs1
[543.269552] Dynamic subtest vcs1: SUCCESS (7.038s)
[543.278515] Starting dynamic subtest: vecs0
[550.244225] Dynamic subtest vecs0: SUCCESS (6.975s)
[550.245142] Subtest hang: SUCCESS (41.740s)
[550.324739] [117/133] (498s left) kms_rotation_crc (primary-y-tiled-reflect-x-0)
[550.418131] Starting subtest: primary-y-tiled-reflect-x-0
[555.157712] Subtest primary-y-tiled-reflect-x-0: SUCCESS (4.741s)
[555.371050] [118/133] (493s left) kms_plane (pixel-format-4-tiled-bmg-ccs-modifier-source-clamping)
[555.465955] Starting subtest: pixel-format-4-tiled-bmg-ccs-modifier-source-clamping
[555.467394] Subtest pixel-format-4-tiled-bmg-ccs-modifier-source-clamping: SKIP (0.000s)
[555.531098] [119/133] (493s left) kms_busy (extended-modeset-hang-oldfb)
[555.625220] Starting subtest: extended-modeset-hang-oldfb
[555.627099] Starting dynamic subtest: pipe-A
[566.165146] Dynamic subtest pipe-A: SUCCESS (10.538s)
[566.176351] Starting dynamic subtest: pipe-D
[576.912771] Dynamic subtest pipe-D: SUCCESS (10.744s)
[576.913599] Subtest extended-modeset-hang-oldfb: SUCCESS (21.288s)
[577.051221] [120/133] (471s left) kms_flip (2x-blocking-wf_vblank)
[577.149708] Starting subtest: 2x-blocking-wf_vblank
[577.158414] Subtest 2x-blocking-wf_vblank: SKIP (0.009s)
[577.246006] [121/133] (471s left) kms_chamelium_hpd (vga-hpd)
[577.393018] Subtest vga-hpd: SKIP (0.000s)
[577.493777] [122/133] (471s left) kms_frontbuffer_tracking (fbc-rgb565-draw-blt)
[577.592656] Starting subtest: fbc-rgb565-draw-blt
[578.873071] Subtest fbc-rgb565-draw-blt: SUCCESS (1.280s)
[579.005967] [123/133] (470s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-180)
[579.108447] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-180
[579.109849] Subtest 4-tiled-max-hw-stride-32bpp-rotate-180: SKIP (0.000s)
[579.206131] [124/133] (469s left) gem_mmap_wc (read-write)
[579.241773] Starting subtest: read-write
[579.244355] Subtest read-write: SUCCESS (0.003s)
[579.367316] [125/133] (469s left) gem_workarounds (reset-fd)
[579.415529] Starting subtest: reset-fd
[579.426313] Subtest reset-fd: SUCCESS (0.011s)
[579.539713] [126/133] (469s left) kms_setmode (invalid-clone-exclusive-crtc)
[579.573690] Starting subtest: invalid-clone-exclusive-crtc
[579.575732] Subtest invalid-clone-exclusive-crtc: SKIP (0.000s)
[579.645547] [127/133] (469s left) gem_eio (wait-wedge-1us)
[579.688167] Starting subtest: wait-wedge-1us
[579.940068] Subtest wait-wedge-1us: SUCCESS (0.252s)
[580.060874] [128/133] (469s left) kms_cursor_legacy (forked-bo)
[580.151180] Starting subtest: forked-bo
[580.151960] Starting dynamic subtest: pipe-A
[585.596952] Dynamic subtest pipe-A: SUCCESS (5.412s)
[585.607921] Starting dynamic subtest: pipe-B
[591.023334] Dynamic subtest pipe-B: SUCCESS (5.425s)
[591.038125] Starting dynamic subtest: pipe-C
[596.455046] Dynamic subtest pipe-C: SUCCESS (5.430s)
[596.470732] Starting dynamic subtest: pipe-D
[601.887601] Dynamic subtest pipe-D: SUCCESS (5.430s)
[601.907545] Starting dynamic subtest: all-pipes
[607.299190] Dynamic subtest all-pipes: SUCCESS (5.438s)
[607.301297] Subtest forked-bo: SUCCESS (27.143s)
[607.382332] [129/133] (442s left) kms_flip_scaled_crc (flip-64bpp-linear-to-16bpp-linear-upscaling)
[607.475021] Starting subtest: flip-64bpp-linear-to-16bpp-linear-upscaling
[607.475768] Starting dynamic subtest: pipe-A-valid-mode
[608.379283] Dynamic subtest pipe-A-valid-mode: SUCCESS (0.903s)
[608.380050] Subtest flip-64bpp-linear-to-16bpp-linear-upscaling: SUCCESS (0.904s)
[608.515711] [130/133] (440s left) perf_pmu (busy-double-start)
[608.556108] Starting subtest: busy-double-start
[608.556851] Starting dynamic subtest: rcs0
[612.108377] Dynamic subtest rcs0: SUCCESS (3.551s)
[612.122216] Starting dynamic subtest: bcs0
[615.654376] Dynamic subtest bcs0: SUCCESS (3.543s)
[615.668048] Starting dynamic subtest: vcs0
[619.199507] Dynamic subtest vcs0: SUCCESS (3.542s)
[619.213563] Starting dynamic subtest: vcs1
[622.742345] Dynamic subtest vcs1: SUCCESS (3.540s)
[622.756511] Starting dynamic subtest: vecs0
[626.292374] Dynamic subtest vecs0: SUCCESS (3.548s)
[626.293572] Subtest busy-double-start: SUCCESS (17.736s)
[626.378881] [131/133] (423s left) gem_ctx_persistence (engines-persistence)
[626.416772] Starting subtest: engines-persistence
[626.417560] Starting dynamic subtest: rcs0
[627.170466] Dynamic subtest rcs0: SUCCESS (0.753s)
[627.183700] Starting dynamic subtest: bcs0
[627.940385] Dynamic subtest bcs0: SUCCESS (0.767s)
[627.953565] Starting dynamic subtest: vcs0
[628.712433] Dynamic subtest vcs0: SUCCESS (0.769s)
[628.725917] Starting dynamic subtest: vcs1
[629.475421] Dynamic subtest vcs1: SUCCESS (0.760s)
[629.488533] Starting dynamic subtest: vecs0
[630.241397] Dynamic subtest vecs0: SUCCESS (0.763s)
[630.244830] Subtest engines-persistence: SUCCESS (3.825s)
[630.316697] [132/133] (419s left) kms_psr (fbc-psr2-sprite-render)
[630.408686] Subtest fbc-psr2-sprite-render: SKIP (0.000s)
[630.455997] [133/133] (419s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-mmap-cpu)
[630.548191] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-mmap-cpu
[630.549675] Subtest psr-2p-scndscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[630.653570] Closing watchdogs
results: parsing output: 0/ for test: kms_atomic_transition
results: parsing output: 1/ for test: kms_ccs
results: parsing output: 2/ for test: kms_lease
results: parsing output: 3/ for test: gem_exec_whisper
results: parsing output: 4/ for test: perf_pmu
results: parsing output: 5/ for test: kms_prime
results: parsing output: 6/ for test: syncobj_timeline
results: parsing output: 7/ for test: kms_frontbuffer_tracking
results: parsing output: 8/ for test: kms_frontbuffer_tracking
results: parsing output: 9/ for test: kms_ccs
results: parsing output: 10/ for test: kms_frontbuffer_tracking
results: parsing output: 11/ for test: gem_partial_pwrite_pread
results: parsing output: 12/ for test: gem_eio
results: parsing output: 13/ for test: kms_frontbuffer_tracking
results: parsing output: 14/ for test: kms_frontbuffer_tracking
results: parsing output: 15/ for test: gem_exec_capture
results: parsing output: 16/ for test: kms_draw_crc
results: parsing output: 17/ for test: kms_flip
results: parsing output: 18/ for test: gem_exec_schedule
results: parsing output: 19/ for test: sysfs_timeslice_duration
results: parsing output: 20/ for test: kms_frontbuffer_tracking
results: parsing output: 21/ for test: sw_sync
results: parsing output: 22/ for test: gem_exec_reloc
results: parsing output: 23/ for test: kms_frontbuffer_tracking
results: parsing output: 24/ for test: gem_exec_reloc
results: parsing output: 25/ for test: kms_atomic
results: parsing output: 26/ for test: kms_psr2_sf
results: parsing output: 27/ for test: kms_psr
results: parsing output: 28/ for test: kms_atomic_transition
results: parsing output: 29/ for test: kms_frontbuffer_tracking
results: parsing output: 30/ for test: kms_big_fb
results: parsing output: 31/ for test: kms_plane_scaling
results: parsing output: 32/ for test: i915_pm_rpm
results: parsing output: 33/ for test: gem_mmap_gtt
results: parsing output: 34/ for test: syncobj_timeline
results: parsing output: 35/ for test: kms_force_connector_basic
results: parsing output: 36/ for test: gem_huc_copy
results: parsing output: 37/ for test: kms_chamelium_frames
results: parsing output: 38/ for test: gem_exec_reloc
results: parsing output: 39/ for test: vgem_slow
results: parsing output: 40/ for test: kms_content_protection
results: parsing output: 41/ for test: kms_dirtyfb
results: parsing output: 42/ for test: gem_create
results: parsing output: 43/ for test: syncobj_wait
results: parsing output: 44/ for test: syncobj_wait
results: parsing output: 45/ for test: i915_suspend
results: parsing output: 46/ for test: kms_ccs
results: parsing output: 47/ for test: api_intel_bb
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_exec_schedule
results: parsing output: 51/ for test: kms_psr
results: parsing output: 52/ for test: gem_exec_reloc
results: parsing output: 53/ for test: gem_userptr_blits
results: parsing output: 54/ for test: kms_cursor_crc
results: parsing output: 55/ for test: kms_frontbuffer_tracking
results: parsing output: 56/ for test: kms_vblank
results: parsing output: 57/ for test: syncobj_timeline
results: parsing output: 58/ for test: kms_atomic_interruptible
results: parsing output: 59/ for test: kms_flip_scaled_crc
results: parsing output: 60/ for test: kms_color_pipeline
results: parsing output: 61/ for test: kms_psr
results: parsing output: 62/ for test: gem_mmap_gtt
results: parsing output: 63/ for test: syncobj_timeline
results: parsing output: 64/ for test: gem_exec_nop
results: parsing output: 65/ for test: gem_render_copy
results: parsing output: 66/ for test: kms_frontbuffer_tracking
results: parsing output: 67/ for test: kms_plane
results: parsing output: 68/ for test: gem_ctx_shared
results: parsing output: 69/ for test: gem_pxp
results: parsing output: 70/ for test: kms_flip
results: parsing output: 71/ for test: kms_frontbuffer_tracking
results: parsing output: 72/ for test: kms_pm_rpm
results: parsing output: 73/ for test: kms_frontbuffer_tracking
results: parsing output: 74/ for test: kms_ccs
results: parsing output: 75/ for test: i915_drm_fdinfo
results: parsing output: 76/ for test: kms_plane_scaling
results: parsing output: 77/ for test: kms_big_fb
results: parsing output: 78/ for test: sw_sync
results: parsing output: 79/ for test: kms_chamelium_color
results: parsing output: 80/ for test: gem_exec_fence
results: parsing output: 81/ for test: kms_big_fb
results: parsing output: 82/ for test: gem_pxp
results: parsing output: 83/ for test: kms_cursor_legacy
results: parsing output: 84/ for test: kms_cursor_crc
results: parsing output: 85/ for test: gem_eio
results: parsing output: 86/ for test: kms_big_fb
results: parsing output: 87/ for test: gem_ctx_param
results: parsing output: 88/ for test: kms_frontbuffer_tracking
results: parsing output: 89/ for test: gem_mmap_gtt
results: parsing output: 90/ for test: kms_psr
results: parsing output: 91/ for test: i915_pm_freq_api
results: parsing output: 92/ for test: kms_cursor_legacy
results: parsing output: 93/ for test: syncobj_eventfd
results: parsing output: 94/ for test: kms_sequence
results: parsing output: 95/ for test: gem_ctx_persistence
results: parsing output: 96/ for test: gem_softpin
results: parsing output: 97/ for test: kms_frontbuffer_tracking
results: parsing output: 98/ for test: kms_psr
results: parsing output: 99/ for test: fbdev
results: parsing output: 100/ for test: gem_exec_reloc
results: parsing output: 101/ for test: kms_prop_blob
results: parsing output: 102/ for test: gem_exec_balancer
results: parsing output: 103/ for test: dumb_buffer
results: parsing output: 104/ for test: api_intel_bb
results: parsing output: 105/ for test: kms_setmode
results: parsing output: 106/ for test: gem_exec_schedule
results: parsing output: 107/ for test: gem_exec_reloc
results: parsing output: 108/ for test: gem_softpin
results: parsing output: 109/ for test: kms_big_fb
results: parsing output: 110/ for test: kms_plane_alpha_blend
results: parsing output: 111/ for test: kms_invalid_mode
results: parsing output: 112/ for test: kms_frontbuffer_tracking
results: parsing output: 113/ for test: gem_partial_pwrite_pread
results: parsing output: 114/ for test: gen7_exec_parse
results: parsing output: 115/ for test: prime_busy
results: parsing output: 116/ for test: kms_rotation_crc
results: parsing output: 117/ for test: kms_plane
results: parsing output: 118/ for test: kms_busy
results: parsing output: 119/ for test: kms_flip
results: parsing output: 120/ for test: kms_chamelium_hpd
results: parsing output: 121/ for test: kms_frontbuffer_tracking
results: parsing output: 122/ for test: kms_big_fb
results: parsing output: 123/ for test: gem_mmap_wc
results: parsing output: 124/ for test: gem_workarounds
results: parsing output: 125/ for test: kms_setmode
results: parsing output: 126/ for test: gem_eio
results: parsing output: 127/ for test: kms_cursor_legacy
results: parsing output: 128/ for test: kms_flip_scaled_crc
results: parsing output: 129/ for test: perf_pmu
results: parsing output: 130/ for test: gem_ctx_persistence
results: parsing output: 131/ for test: kms_psr
results: parsing output: 132/ for test: kms_frontbuffer_tracking
Done.