[62.101755] Initializing watchdogs
[62.101895]   /dev/watchdog0
[62.118587] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:7d55 Intel Meteorlake (Gen12) Meteor Lake-P [Intel Arc Graphics]
[62.126295] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[62.128911] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[62.131059] [001/156] (960s left) kms_frontbuffer_tracking (psr-shrfb-scaledprimary)
[62.237311] Starting subtest: psr-shrfb-scaledprimary
[68.042285] Subtest psr-shrfb-scaledprimary: SUCCESS (5.806s)
[68.171927] [002/156] (954s left) gem_exec_schedule (u-submit-golden-slice)
[68.232533] Starting subtest: u-submit-golden-slice
[68.233554] Starting dynamic subtest: rcs0
[68.269833] Dynamic subtest rcs0: SUCCESS (0.037s)
[68.279875] Starting dynamic subtest: bcs0
[68.298718] Dynamic subtest bcs0: SUCCESS (0.028s)
[68.306991] Starting dynamic subtest: vcs0
[68.329782] Dynamic subtest vcs0: SUCCESS (0.031s)
[68.336763] Starting dynamic subtest: vcs1
[68.369298] Dynamic subtest vcs1: SUCCESS (0.039s)
[68.377978] Starting dynamic subtest: vecs0
[68.402578] Dynamic subtest vecs0: SUCCESS (0.033s)
[68.409617] Starting dynamic subtest: ccs0
[68.437179] Dynamic subtest ccs0: SUCCESS (0.034s)
[68.437988] Subtest u-submit-golden-slice: SUCCESS (0.205s)
[69.422526] [003/156] (953s left) syncobj_wait (wait-all-delayed-signal)
[69.466930] Starting subtest: wait-all-delayed-signal
[69.571072] Subtest wait-all-delayed-signal: SUCCESS (0.103s)
[69.638186] [004/156] (953s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-render)
[69.728322] Starting subtest: psr-2p-primscrn-cur-indfb-draw-render
[69.729891] Subtest psr-2p-primscrn-cur-indfb-draw-render: SKIP (0.000s)
[69.834019] [005/156] (952s left) kms_frontbuffer_tracking (psrhdr-2p-primscrn-cur-indfb-onoff)
[69.927023] Starting subtest: psrhdr-2p-primscrn-cur-indfb-onoff
[69.929073] Subtest psrhdr-2p-primscrn-cur-indfb-onoff: SKIP (0.000s)
[70.011411] [006/156] (952s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-mmap-cpu)
[70.108403] Starting subtest: psr-1p-primscrn-pri-indfb-draw-mmap-cpu
[77.592124] Subtest psr-1p-primscrn-pri-indfb-draw-mmap-cpu: SUCCESS (7.486s)
[77.683797] [007/156] (945s left) kms_plane_scaling (planes-upscale-20x20-downscale-factor-0-5)
[77.776719] Starting subtest: planes-upscale-20x20-downscale-factor-0-5
[77.777724] Starting dynamic subtest: pipe-A
[77.795964] Dynamic subtest pipe-A: SKIP (0.018s)
[77.803161] Starting dynamic subtest: pipe-B
[77.831247] Dynamic subtest pipe-B: SKIP (0.035s)
[77.838771] Starting dynamic subtest: pipe-C
[77.866343] Dynamic subtest pipe-C: SKIP (0.035s)
[77.873024] Starting dynamic subtest: pipe-D
[77.902607] Dynamic subtest pipe-D: SKIP (0.036s)
[77.904257] Subtest planes-upscale-20x20-downscale-factor-0-5: SKIP (0.125s)
[78.007184] [008/156] (944s left) kms_chamelium_edid (hdmi-edid-stress-resolution-non-4k)
[78.380540] Subtest hdmi-edid-stress-resolution-non-4k: SKIP (0.000s)
[79.212681] [009/156] (943s left) gem_lmem_swapping (heavy-verify-random)
[79.252359] Subtest heavy-verify-random: SKIP (0.000s)
[79.285507] [010/156] (943s left) kms_frontbuffer_tracking (fbchdr-1p-offscreen-pri-indfb-draw-blt)
[79.377324] Starting subtest: fbchdr-1p-offscreen-pri-indfb-draw-blt
[79.378868] Subtest fbchdr-1p-offscreen-pri-indfb-draw-blt: SKIP (0.000s)
[79.484498] [011/156] (943s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-primscrn-spr-indfb-move)
[79.575601] Starting subtest: fbcpsrhdr-1p-primscrn-spr-indfb-move
[79.577463] Subtest fbcpsrhdr-1p-primscrn-spr-indfb-move: SKIP (0.000s)
[79.687690] [012/156] (943s left) kms_flip (2x-flip-vs-fences)
[79.772985] Starting subtest: 2x-flip-vs-fences
[79.774976] Subtest 2x-flip-vs-fences: SKIP (0.000s)
[79.878708] [013/156] (943s left) gem_render_copy (y-tiled-ccs-to-y-tiled-ccs)
[79.935141] Starting subtest: y-tiled-ccs-to-y-tiled-ccs
[79.936891] Subtest y-tiled-ccs-to-y-tiled-ccs: SKIP (0.000s)
[80.121818] [014/156] (942s left) gem_mmap_offset (partial-remap)
[80.167882] Starting subtest: partial-remap
[80.169071] Starting dynamic subtest: smem0
[80.172500] Dynamic subtest smem0: SUCCESS (0.004s)
[80.173411] Subtest partial-remap: SUCCESS (0.004s)
[80.281881] [015/156] (942s left) vgem_basic (dmabuf-fence)
[80.348057] Starting subtest: dmabuf-fence
[80.349214] Subtest dmabuf-fence: SUCCESS (0.001s)
[80.415480] [FACT vgem_basic (dmabuf-fence)] new: kernel.kmod_is_loaded.vgem: true
[80.417169] [016/156] (942s left) kms_flip (2x-single-buffer-flip-vs-dpms-off-vs-modeset-interruptible)
[80.502164] Starting subtest: 2x-single-buffer-flip-vs-dpms-off-vs-modeset-interruptible
[80.514501] Subtest 2x-single-buffer-flip-vs-dpms-off-vs-modeset-interruptible: SKIP (0.011s)
[80.594603] [017/156] (942s left) gem_ctx_engines (execute-one)
[80.653435] Starting subtest: execute-one
[82.979930] Subtest execute-one: SUCCESS (2.327s)
[83.343941] [018/156] (939s left) kms_frontbuffer_tracking (basic)
[83.440746] Starting subtest: basic
[86.773516] Subtest basic: SUCCESS (3.335s)
[86.874688] [019/156] (936s left) kms_big_fb (4-tiled-8bpp-rotate-0)
[86.968494] Starting subtest: 4-tiled-8bpp-rotate-0
[88.226200] Subtest 4-tiled-8bpp-rotate-0: SUCCESS (1.258s)
[88.344705] [020/156] (934s left) syncobj_timeline (signal)
[88.398142] Starting subtest: signal
[88.398974] Subtest signal: SUCCESS (0.001s)
[88.488736] [021/156] (934s left) perf_pmu (semaphore-busy)
[88.529682] Starting subtest: semaphore-busy
[88.530867] Starting dynamic subtest: rcs0
[90.165197] Dynamic subtest rcs0: SUCCESS (1.631s)
[90.172879] Starting dynamic subtest: bcs0
[91.797723] Dynamic subtest bcs0: SUCCESS (1.632s)
[91.805145] Starting dynamic subtest: vcs0
[95.837997] Dynamic subtest vcs0: SUCCESS (4.038s)
[95.847848] Starting dynamic subtest: vcs1
[101.853468] Dynamic subtest vcs1: SUCCESS (6.013s)
[101.863233] Starting dynamic subtest: vecs0
[107.869199] Dynamic subtest vecs0: SUCCESS (6.014s)
[107.879208] Starting dynamic subtest: ccs0
[110.944809] Dynamic subtest ccs0: SUCCESS (3.075s)
[110.946792] Subtest semaphore-busy: SUCCESS (22.414s)
[111.058874] [022/156] (912s left) gem_exec_fence (submit3)
[111.235090] Starting subtest: submit3
[111.236797] Subtest submit3: SKIP (0.000s)
[113.393427] [023/156] (909s left) kms_ccs (bad-aux-stride-y-tiled-ccs)
[113.485996] Starting subtest: bad-aux-stride-y-tiled-ccs
[113.486868] Starting dynamic subtest: pipe-A-eDP-1
[113.503440] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[113.513222] Starting dynamic subtest: pipe-B-eDP-1
[113.521727] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[113.529600] Starting dynamic subtest: pipe-C-eDP-1
[113.537856] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[113.545119] Starting dynamic subtest: pipe-D-eDP-1
[113.553306] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[113.555049] Subtest bad-aux-stride-y-tiled-ccs: SKIP (0.003s)
[115.800742] [024/156] (907s left) kms_ccs (crc-primary-basic-4-tiled-dg2-rc-ccs-cc)
[115.894546] Starting subtest: crc-primary-basic-4-tiled-dg2-rc-ccs-cc
[115.895509] Starting dynamic subtest: pipe-A-eDP-1
[115.904281] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[115.912825] Starting dynamic subtest: pipe-B-eDP-1
[115.921214] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[115.928567] Starting dynamic subtest: pipe-C-eDP-1
[115.936954] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[115.944290] Starting dynamic subtest: pipe-D-eDP-1
[115.953850] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[115.955656] Subtest crc-primary-basic-4-tiled-dg2-rc-ccs-cc: SKIP (0.004s)
[118.152178] [025/156] (905s left) kms_ccs (missing-ccs-buffer-yf-tiled-ccs)
[118.237369] Starting subtest: missing-ccs-buffer-yf-tiled-ccs
[118.238254] Starting dynamic subtest: pipe-A-eDP-1
[118.246552] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[118.254985] Starting dynamic subtest: pipe-B-eDP-1
[118.263339] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[118.270594] Starting dynamic subtest: pipe-C-eDP-1
[118.286553] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[118.293607] Starting dynamic subtest: pipe-D-eDP-1
[118.301368] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[118.302906] Subtest missing-ccs-buffer-yf-tiled-ccs: SKIP (0.003s)
[120.737296] [026/156] (902s left) kms_ccs (crc-primary-suspend-y-tiled-gen12-rc-ccs-cc)
[120.831087] Starting subtest: crc-primary-suspend-y-tiled-gen12-rc-ccs-cc
[120.832098] Starting dynamic subtest: pipe-A-eDP-1
[120.836682] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[120.846231] Starting dynamic subtest: pipe-B-eDP-1
[120.849868] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[120.857285] Starting dynamic subtest: pipe-C-eDP-1
[120.861680] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[120.870928] Starting dynamic subtest: pipe-D-eDP-1
[120.874543] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[120.876275] Subtest crc-primary-suspend-y-tiled-gen12-rc-ccs-cc: SKIP (0.004s)
[123.100808] [027/156] (900s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-mmap-cpu)
[123.197515] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-mmap-cpu
[123.199275] Subtest fbc-2p-scndscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[123.285555] [028/156] (900s left) gem_userptr_blits (process-exit-busy)
[123.342758] Starting subtest: process-exit-busy
[123.356466] Subtest process-exit-busy: SUCCESS (0.014s)
[123.486169] [029/156] (900s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-primscrn-pri-shrfb-draw-pwrite)
[123.572346] Starting subtest: fbcpsrhdr-1p-primscrn-pri-shrfb-draw-pwrite
[123.574053] Subtest fbcpsrhdr-1p-primscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[123.663180] [030/156] (899s left) kms_flip (flip-vs-panning-vs-hang)
[123.748849] Starting subtest: flip-vs-panning-vs-hang
[123.749827] Starting dynamic subtest: A-eDP1
[175.819525] Dynamic subtest A-eDP1: SUCCESS (52.070s)
[175.827395] Starting dynamic subtest: D-eDP1
[225.865823] Dynamic subtest D-eDP1: SUCCESS (50.044s)
[225.869642] Subtest flip-vs-panning-vs-hang: SUCCESS (102.119s)
[227.094802] [031/156] (796s left) kms_frontbuffer_tracking (hdr-2p-scndscrn-shrfb-msflip-blt)
[227.198046] Starting subtest: hdr-2p-scndscrn-shrfb-msflip-blt
[227.199852] Subtest hdr-2p-scndscrn-shrfb-msflip-blt: SKIP (0.000s)
[227.316114] [032/156] (796s left) kms_frontbuffer_tracking (fbcpsr-2p-pri-indfb-multidraw)
[227.409579] Starting subtest: fbcpsr-2p-pri-indfb-multidraw
[227.411485] Subtest fbcpsr-2p-pri-indfb-multidraw: SKIP (0.000s)
[227.523512] [033/156] (796s left) gem_render_copy (yf-tiled-ccs-to-y-tiled)
[227.583452] Starting subtest: yf-tiled-ccs-to-y-tiled
[227.585394] Subtest yf-tiled-ccs-to-y-tiled: SKIP (0.000s)
[227.786742] [034/156] (795s left) kms_big_fb (x-tiled-64bpp-rotate-270)
[227.880588] Starting subtest: x-tiled-64bpp-rotate-270
[227.900118] Subtest x-tiled-64bpp-rotate-270: SKIP (0.019s)
[228.023116] [035/156] (795s left) syncobj_timeline (wait-delayed-signal)
[228.071608] Starting subtest: wait-delayed-signal
[228.175830] Subtest wait-delayed-signal: SUCCESS (0.104s)
[228.259817] [036/156] (795s left) kms_cursor_legacy (short-flip-before-cursor-atomic-transitions-varying-size)
[228.371431] Starting subtest: short-flip-before-cursor-atomic-transitions-varying-size
[229.333630] Subtest short-flip-before-cursor-atomic-transitions-varying-size: SUCCESS (0.960s)
[230.137662] [037/156] (793s left) syncobj_wait (single-wait-for-submit-unsubmitted)
[230.195332] Starting subtest: single-wait-for-submit-unsubmitted
[230.303371] Subtest single-wait-for-submit-unsubmitted: SUCCESS (0.107s)
[230.376211] [038/156] (793s left) kms_busy (extended-modeset-hang-oldfb)
[230.465684] Starting subtest: extended-modeset-hang-oldfb
[230.466772] Starting dynamic subtest: pipe-A
[242.298899] Dynamic subtest pipe-A: SUCCESS (11.831s)
[242.307593] Starting dynamic subtest: pipe-D
[254.789607] Dynamic subtest pipe-D: SUCCESS (12.489s)
[254.790933] Subtest extended-modeset-hang-oldfb: SUCCESS (24.325s)
[255.664773] [039/156] (768s left) core_setmaster_vs_auth
[255.809456] [040/156] (768s left) kms_psr (fbc-psr2-cursor-plane-onoff)
[255.904955] Starting subtest: fbc-psr2-cursor-plane-onoff
[255.905776] Starting dynamic subtest: eDP-1
[255.907520] Dynamic subtest eDP-1: SKIP (0.000s)
[255.909310] Subtest fbc-psr2-cursor-plane-onoff: SKIP (0.001s)
[255.973754] [041/156] (767s left) kms_frontbuffer_tracking (psrhdr-rgb565-draw-pwrite)
[256.074509] Starting subtest: psrhdr-rgb565-draw-pwrite
[256.076380] Subtest psrhdr-rgb565-draw-pwrite: SKIP (0.000s)
[256.156690] [042/156] (767s left) api_intel_allocator (two-level-inception-interruptible)
[256.201638] Starting subtest: two-level-inception-interruptible
[261.652057] Subtest two-level-inception-interruptible: SUCCESS (5.406s)
[261.732989] [043/156] (762s left) sw_sync (alloc_timeline)
[261.766771] Starting subtest: alloc_timeline
[261.767711] Subtest alloc_timeline: SUCCESS (0.000s)
[261.817864] [044/156] (762s left) kms_flip (modeset-vs-vblank-race-interruptible)
[261.926926] Starting subtest: modeset-vs-vblank-race-interruptible
[261.928492] Starting dynamic subtest: A-eDP1
[266.691648] Dynamic subtest A-eDP1: SUCCESS (4.763s)
[266.703774] Starting dynamic subtest: B-eDP1
[271.765249] Dynamic subtest B-eDP1: SUCCESS (5.071s)
[271.778277] Starting dynamic subtest: C-eDP1
[276.462589] Dynamic subtest C-eDP1: SUCCESS (4.695s)
[276.472146] Starting dynamic subtest: D-eDP1
[281.099548] Dynamic subtest D-eDP1: SUCCESS (4.635s)
[281.102417] Subtest modeset-vs-vblank-race-interruptible: SUCCESS (19.175s)
[282.250117] [045/156] (741s left) kms_invalid_mode (clock-too-high)
[282.349650] Starting subtest: clock-too-high
[282.350766] Starting dynamic subtest: pipe-A-eDP-1
[282.635258] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.292s)
[282.645211] Starting dynamic subtest: pipe-B-eDP-1
[282.646900] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[282.654152] Starting dynamic subtest: pipe-C-eDP-1
[282.655848] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[282.663420] Starting dynamic subtest: pipe-D-eDP-1
[282.665233] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[282.666073] Subtest clock-too-high: SUCCESS (0.298s)
[283.493262] [046/156] (740s left) kms_flip (2x-flip-vs-rmfb-interruptible)
[283.584073] Starting subtest: 2x-flip-vs-rmfb-interruptible
[283.594985] Subtest 2x-flip-vs-rmfb-interruptible: SKIP (0.011s)
[283.690936] [047/156] (740s left) kms_chamelium_color (ctm-0-50)
[283.771405] Subtest ctm-0-50: SKIP (0.000s)
[283.810365] [048/156] (740s left) kms_frontbuffer_tracking (fbchdr-2p-pri-indfb-multidraw)
[283.903762] Starting subtest: fbchdr-2p-pri-indfb-multidraw
[283.905358] Subtest fbchdr-2p-pri-indfb-multidraw: SKIP (0.000s)
[284.001088] [049/156] (740s left) kms_pm_rpm (pc8-residency)
[285.521169] Starting subtest: pc8-residency
[285.524415] Subtest pc8-residency: SKIP (0.000s)
[286.254797] [050/156] (738s left) syncobj_eventfd (timeline-wait-signaled)
[286.299502] Starting subtest: timeline-wait-signaled
[286.300414] Subtest timeline-wait-signaled: SUCCESS (0.000s)
[286.381968] [051/156] (737s left) gem_exec_params (larger-than-life-batch)
[286.435897] Starting subtest: larger-than-life-batch
[288.740078] Subtest larger-than-life-batch: SUCCESS (2.305s)
[289.360513] [052/156] (735s left) i915_pm_rps (min-max-config-loaded)
[289.492255] Starting subtest: min-max-config-loaded
[289.494079] Subtest min-max-config-loaded: SKIP (0.001s)
[289.591558] [053/156] (734s left) gem_mmap_gtt (basic-small-bo-tiledx)
[289.640518] Subtest basic-small-bo-tiledX: SKIP (0.000s)
[289.695611] [054/156] (734s left) gem_ctx_sseu (mmap-args)
[289.742497] Subtest mmap-args: SKIP (0.000s)
[289.815440] [055/156] (734s left) kms_flip (2x-flip-vs-absolute-wf_vblank-interruptible)
[289.919991] Starting subtest: 2x-flip-vs-absolute-wf_vblank-interruptible
[289.931154] Subtest 2x-flip-vs-absolute-wf_vblank-interruptible: SKIP (0.011s)
[290.003140] [056/156] (734s left) gem_ctx_persistence (heartbeat-stop)
[290.057249] Starting subtest: heartbeat-stop
[290.058798] Subtest heartbeat-stop: SKIP (0.000s)
[290.155999] [057/156] (734s left) kms_flip (flip-vs-wf_vblank-interruptible)
[290.239167] Starting subtest: flip-vs-wf_vblank-interruptible
[290.241526] Starting dynamic subtest: A-eDP1
[292.176376] Dynamic subtest A-eDP1: SUCCESS (1.934s)
[292.186375] Starting dynamic subtest: B-eDP1
[294.107132] Dynamic subtest B-eDP1: SUCCESS (1.930s)
[294.119424] Starting dynamic subtest: C-eDP1
[296.022551] Dynamic subtest C-eDP1: SUCCESS (1.913s)
[296.032240] Starting dynamic subtest: D-eDP1
[297.952694] Dynamic subtest D-eDP1: SUCCESS (1.927s)
[297.953720] Subtest flip-vs-wf_vblank-interruptible: SUCCESS (7.713s)
[299.164653] [058/156] (725s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-render)
[299.253958] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-render
[299.255680] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-render: SKIP (0.000s)
[299.362614] [059/156] (725s left) i915_drm_fdinfo (basics)
[299.397352] Starting subtest: basics
[299.398390] Subtest basics: SUCCESS (0.000s)
[299.457553] [060/156] (725s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-blt)
[299.551924] Starting subtest: fbc-rgb101010-draw-blt
[302.080855] Subtest fbc-rgb101010-draw-blt: SUCCESS (2.531s)
[303.266430] [061/156] (721s left) kms_cursor_crc (cursor-sliding-128x128)
[303.472956] Starting subtest: cursor-sliding-128x128
[303.475990] Starting dynamic subtest: pipe-A-eDP-1
[306.708048] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.233s)
[306.740695] Starting dynamic subtest: pipe-D-eDP-1
[310.681712] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.947s)
[310.682625] Subtest cursor-sliding-128x128: SUCCESS (7.208s)
[311.528169] [062/156] (713s left) perf (blocking)
[311.673655] Starting subtest: blocking
[311.674526] Starting dynamic subtest: 0-rcs0
[321.700648] Dynamic subtest 0-rcs0: SUCCESS (10.016s)
[321.711579] Starting dynamic subtest: 1-vcs0
[331.758287] Dynamic subtest 1-vcs0: SUCCESS (10.019s)
[331.759199] Subtest blocking: SUCCESS (20.037s)
[331.788737] [063/156] (692s left) kms_psr (psr2-cursor-mmap-cpu)
[331.884419] Starting subtest: psr2-cursor-mmap-cpu
[331.885693] Starting dynamic subtest: eDP-1
[333.605693] Dynamic subtest eDP-1: SUCCESS (1.719s)
[333.606900] Subtest psr2-cursor-mmap-cpu: SUCCESS (1.720s)
[334.477152] [064/156] (690s left) syncobj_wait (multi-wait-for-submit-submitted)
[334.528763] Starting subtest: multi-wait-for-submit-submitted
[334.631830] Subtest multi-wait-for-submit-submitted: SUCCESS (0.102s)
[334.717695] [065/156] (690s left) syncobj_eventfd (binary-wait-before-signal)
[334.766124] Starting subtest: binary-wait-before-signal
[334.796288] Subtest binary-wait-before-signal: SUCCESS (0.031s)
[334.879310] [066/156] (689s left) sysfs_heartbeat_interval (nopreempt)
[334.940633] Starting subtest: nopreempt
[334.941886] Starting dynamic subtest: vecs0
[344.353764] Dynamic subtest vecs0: SUCCESS (9.400s)
[344.364745] Starting dynamic subtest: ccs0
[348.332898] Dynamic subtest ccs0: SUCCESS (3.985s)
[348.341788] Starting dynamic subtest: vcs0
[358.298770] Dynamic subtest vcs0: SUCCESS (9.965s)
[358.311694] Starting dynamic subtest: bcs0
[362.183774] Dynamic subtest bcs0: SUCCESS (3.882s)
[362.197132] Starting dynamic subtest: rcs0
[366.243847] Dynamic subtest rcs0: SUCCESS (4.059s)
[366.265105] Starting dynamic subtest: vcs1
[374.306723] Dynamic subtest vcs1: SUCCESS (8.052s)
[374.307938] Subtest nopreempt: SUCCESS (39.356s)
[374.372775] [067/156] (650s left) kms_big_fb (linear-32bpp-rotate-180)
[374.470431] Starting subtest: linear-32bpp-rotate-180
[376.038306] Subtest linear-32bpp-rotate-180: SUCCESS (1.568s)
[376.167710] [068/156] (648s left) kms_cursor_legacy (single-bo)
[376.284210] Starting subtest: single-bo
[376.285125] Starting dynamic subtest: pipe-A
[381.711284] Dynamic subtest pipe-A: SUCCESS (5.379s)
[381.722552] Starting dynamic subtest: pipe-B
[387.093444] Dynamic subtest pipe-B: SUCCESS (5.379s)
[387.104500] Starting dynamic subtest: pipe-C
[392.475024] Dynamic subtest pipe-C: SUCCESS (5.379s)
[392.486198] Starting dynamic subtest: pipe-D
[397.858387] Dynamic subtest pipe-D: SUCCESS (5.379s)
[397.869858] Starting dynamic subtest: all-pipes
[403.246761] Dynamic subtest all-pipes: SUCCESS (5.385s)
[403.247960] Subtest single-bo: SUCCESS (26.917s)
[403.344951] [069/156] (621s left) gem_ctx_freq (sysfs)
[403.399192] Starting subtest: sysfs
[403.400576] Starting dynamic subtest: gt0
[408.909725] Dynamic subtest gt0: SUCCESS (5.510s)
[408.923281] Starting dynamic subtest: gt1
[450.339501] Dynamic subtest gt1: SUCCESS (41.416s)
[450.340829] Subtest sysfs: SUCCESS (46.931s)
[450.435846] [070/156] (574s left) kms_color (invalid-ctm-matrix-sizes)
[450.529227] Starting subtest: invalid-ctm-matrix-sizes
[450.529999] Starting dynamic subtest: pipe-A
[450.530823] Dynamic subtest pipe-A: SUCCESS (0.002s)
[450.539935] Starting dynamic subtest: pipe-B
[450.540845] Dynamic subtest pipe-B: SUCCESS (0.003s)
[450.549413] Starting dynamic subtest: pipe-C
[450.550308] Dynamic subtest pipe-C: SUCCESS (0.003s)
[450.559120] Starting dynamic subtest: pipe-D
[450.560038] Dynamic subtest pipe-D: SUCCESS (0.004s)
[450.560887] Subtest invalid-ctm-matrix-sizes: SUCCESS (0.015s)
[450.611122] [071/156] (574s left) kms_pm_dc (dc5-retention-flops)
[451.703601] Starting subtest: dc5-retention-flops
[451.705398] Subtest dc5-retention-flops: SKIP (0.000s)
[451.785848] [072/156] (573s left) kms_frontbuffer_tracking (hdr-1p-offscreen-pri-shrfb-draw-mmap-cpu)
[451.891636] Starting subtest: hdr-1p-offscreen-pri-shrfb-draw-mmap-cpu
[451.893421] Subtest hdr-1p-offscreen-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[452.002386] [073/156] (573s left) prime_mmap_coherency (ioctl-errors)
[452.053166] Starting subtest: ioctl-errors
[466.209646] Subtest ioctl-errors: SUCCESS (14.156s)
[466.398286] [074/156] (558s left) kms_lease (lease-revoke)
[466.561289] Starting subtest: lease-revoke
[466.562181] Starting dynamic subtest: pipe-A-eDP-1
[466.611511] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.048s)
[466.623304] Starting dynamic subtest: pipe-B-eDP-1
[466.638340] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.027s)
[466.648475] Starting dynamic subtest: pipe-C-eDP-1
[466.667031] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.028s)
[466.677601] Starting dynamic subtest: pipe-D-eDP-1
[466.693669] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.025s)
[466.694794] Subtest lease-revoke: SUCCESS (0.133s)
[466.811164] [075/156] (558s left) kms_flip (basic-flip-vs-wf_vblank)
[466.906857] Starting subtest: basic-flip-vs-wf_vblank
[466.908978] Starting dynamic subtest: A-eDP1
[468.910174] Dynamic subtest A-eDP1: SUCCESS (2.001s)
[468.922216] Starting dynamic subtest: B-eDP1
[470.850084] Dynamic subtest B-eDP1: SUCCESS (1.939s)
[470.861548] Starting dynamic subtest: C-eDP1
[472.765563] Dynamic subtest C-eDP1: SUCCESS (1.911s)
[472.775579] Starting dynamic subtest: D-eDP1
[474.693933] Dynamic subtest D-eDP1: SUCCESS (1.924s)
[474.697799] Subtest basic-flip-vs-wf_vblank: SUCCESS (7.789s)
[475.907440] [076/156] (549s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-scndscrn-pri-shrfb-draw-pwrite)
[475.994463] Starting subtest: fbcpsrhdr-2p-scndscrn-pri-shrfb-draw-pwrite
[475.996121] Subtest fbcpsrhdr-2p-scndscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[476.093928] [077/156] (549s left) kms_frontbuffer_tracking (hdr-2p-primscrn-cur-indfb-draw-pwrite)
[476.183751] Starting subtest: hdr-2p-primscrn-cur-indfb-draw-pwrite
[476.185417] Subtest hdr-2p-primscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[476.282064] [078/156] (549s left) kms_plane (pixel-format-4-tiled-bmg-ccs-modifier)
[476.376586] Starting subtest: pixel-format-4-tiled-bmg-ccs-modifier
[476.378464] Subtest pixel-format-4-tiled-bmg-ccs-modifier: SKIP (0.000s)
[476.460953] [079/156] (548s left) kms_frontbuffer_tracking (hdr-1p-primscrn-pri-shrfb-draw-pwrite)
[476.554268] Starting subtest: hdr-1p-primscrn-pri-shrfb-draw-pwrite
[476.557297] Subtest hdr-1p-primscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[476.641449] [080/156] (548s left) api_intel_bb (purge-bb)
[476.682459] Starting subtest: purge-bb
[476.685486] Subtest purge-bb: SUCCESS (0.004s)
[476.792783] [081/156] (548s left) kms_psr2_sf (fbc-pr-plane-move-sf-dmg-area)
[476.875271] Starting subtest: fbc-pr-plane-move-sf-dmg-area
[476.877055] Subtest fbc-pr-plane-move-sf-dmg-area: SKIP (0.000s)
[476.956856] [082/156] (548s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-pwrite)
[477.059235] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-pwrite
[477.060944] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[477.149334] [083/156] (548s left) kms_frontbuffer_tracking (fbc-rgb565-draw-pwrite)
[477.237923] Starting subtest: fbc-rgb565-draw-pwrite
[481.908425] Subtest fbc-rgb565-draw-pwrite: SUCCESS (4.673s)
[483.103046] [084/156] (542s left) kms_plane (plane-position-hole-dpms)
[483.201479] Starting subtest: plane-position-hole-dpms
[483.716163] Starting dynamic subtest: pipe-A-plane-1
[486.086393] Dynamic subtest pipe-A-plane-1: SUCCESS (2.370s)
[486.096476] Starting dynamic subtest: pipe-A-plane-2
[488.364412] Dynamic subtest pipe-A-plane-2: SUCCESS (2.277s)
[488.375846] Starting dynamic subtest: pipe-A-plane-3
[490.636434] Dynamic subtest pipe-A-plane-3: SUCCESS (2.270s)
[490.646579] Starting dynamic subtest: pipe-A-plane-4
[493.005652] Dynamic subtest pipe-A-plane-4: SUCCESS (2.369s)
[493.014978] Starting dynamic subtest: pipe-A-plane-5
[493.029131] Dynamic subtest pipe-A-plane-5: SUCCESS (0.024s)
[494.192618] Starting dynamic subtest: pipe-B-plane-1
[496.501073] Dynamic subtest pipe-B-plane-1: SUCCESS (2.318s)
[496.510724] Starting dynamic subtest: pipe-B-plane-2
[498.786024] Dynamic subtest pipe-B-plane-2: SUCCESS (2.284s)
[498.795269] Starting dynamic subtest: pipe-B-plane-3
[501.067368] Dynamic subtest pipe-B-plane-3: SUCCESS (2.280s)
[501.077657] Starting dynamic subtest: pipe-B-plane-4
[503.346461] Dynamic subtest pipe-B-plane-4: SUCCESS (2.276s)
[503.355734] Starting dynamic subtest: pipe-B-plane-5
[503.371273] Dynamic subtest pipe-B-plane-5: SUCCESS (0.025s)
[503.372085] Subtest plane-position-hole-dpms: SUCCESS (20.169s)
[504.158450] [085/156] (521s left) syncobj_timeline (multi-wait-available-submitted)
[504.227825] Starting subtest: multi-wait-available-submitted
[504.228764] Subtest multi-wait-available-submitted: SUCCESS (0.000s)
[504.312385] [086/156] (521s left) syncobj_wait (wait-all-snapshot)
[504.366045] Starting subtest: wait-all-snapshot
[504.447250] Subtest wait-all-snapshot: SUCCESS (0.081s)
[504.518384] [087/156] (521s left) kms_cursor_crc (cursor-alpha-transparent)
[504.609798] Starting subtest: cursor-alpha-transparent
[504.610836] Starting dynamic subtest: pipe-A-eDP-1
[505.219070] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.608s)
[505.228392] Starting dynamic subtest: pipe-D-eDP-1
[506.526764] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.306s)
[506.527763] Subtest cursor-alpha-transparent: SUCCESS (1.917s)
[507.398672] [088/156] (518s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-offscreen-pri-indfb-draw-render)
[507.482360] Starting subtest: fbcpsrhdr-1p-offscreen-pri-indfb-draw-render
[507.483983] Subtest fbcpsrhdr-1p-offscreen-pri-indfb-draw-render: SKIP (0.000s)
[507.575508] [089/156] (518s left) gem_exec_reloc (basic-gtt-read-active)
[507.631666] Subtest basic-gtt-read-active: SKIP (0.000s)
[507.690930] [090/156] (518s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-primscrn-spr-indfb-move)
[507.785206] Starting subtest: fbcpsrhdr-2p-primscrn-spr-indfb-move
[507.786764] Subtest fbcpsrhdr-2p-primscrn-spr-indfb-move: SKIP (0.000s)
[507.877894] [091/156] (517s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-shrfb-draw-mmap-wc)
[507.966330] Starting subtest: psr-1p-offscreen-pri-shrfb-draw-mmap-wc
[514.946776] Subtest psr-1p-offscreen-pri-shrfb-draw-mmap-wc: SUCCESS (6.979s)
[515.077568] [092/156] (510s left) kms_vblank (wait-busy)
[515.160175] Starting subtest: wait-busy
[515.161080] Starting dynamic subtest: pipe-A-eDP-1
[517.036685] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.876s)
[517.048050] Starting dynamic subtest: pipe-D-eDP-1
[519.602473] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.563s)
[519.603391] Subtest wait-busy: SUCCESS (4.442s)
[520.404364] [093/156] (505s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-mmap-gtt)
[520.502198] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-mmap-gtt
[520.503839] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[520.615756] [094/156] (505s left) kms_frontbuffer_tracking (psr-rgb101010-draw-blt)
[520.705861] Starting subtest: psr-rgb101010-draw-blt
[528.172344] Subtest psr-rgb101010-draw-blt: SUCCESS (7.467s)
[528.305657] [095/156] (497s left) kms_frontbuffer_tracking (psrhdr-2p-scndscrn-pri-indfb-draw-mmap-gtt)
[528.401632] Starting subtest: psrhdr-2p-scndscrn-pri-indfb-draw-mmap-gtt
[528.403252] Subtest psrhdr-2p-scndscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[528.498874] [096/156] (497s left) kms_frontbuffer_tracking (psr-2p-scndscrn-indfb-msflip-blt)
[528.600253] Starting subtest: psr-2p-scndscrn-indfb-msflip-blt
[528.601907] Subtest psr-2p-scndscrn-indfb-msflip-blt: SKIP (0.000s)
[528.699306] [097/156] (497s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-0)
[528.802386] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-0
[529.802943] Subtest x-tiled-max-hw-stride-64bpp-rotate-0: SUCCESS (1.001s)
[529.924734] [098/156] (496s left) kms_frontbuffer_tracking (fbcpsrhdr-rgb101010-draw-pwrite)
[530.022727] Starting subtest: fbcpsrhdr-rgb101010-draw-pwrite
[530.024534] Subtest fbcpsrhdr-rgb101010-draw-pwrite: SKIP (0.000s)
[530.117294] [099/156] (495s left) syncobj_basic (bad-flags-fd-to-handle)
[530.161021] Starting subtest: bad-flags-fd-to-handle
[530.161806] Subtest bad-flags-fd-to-handle: SUCCESS (0.000s)
[530.259420] [100/156] (495s left) kms_chamelium_hpd (hdmi-hpd)
[530.628271] Subtest hdmi-hpd: SKIP (0.000s)
[531.455902] [101/156] (494s left) kms_psr (psr-sprite-blt)
[531.558576] Starting subtest: psr-sprite-blt
[531.559607] Starting dynamic subtest: eDP-1
[533.296482] Dynamic subtest eDP-1: SUCCESS (1.737s)
[533.297395] Subtest psr-sprite-blt: SUCCESS (1.738s)
[534.140832] [102/156] (491s left) kms_frontbuffer_tracking (hdr-rgb565-draw-blt)
[534.239613] Starting subtest: hdr-rgb565-draw-blt
[534.241262] Subtest hdr-rgb565-draw-blt: SKIP (0.000s)
[534.334844] [103/156] (491s left) kms_frontbuffer_tracking (fbchdr-2p-scndscrn-indfb-plflip-blt)
[534.418230] Starting subtest: fbchdr-2p-scndscrn-indfb-plflip-blt
[534.419901] Subtest fbchdr-2p-scndscrn-indfb-plflip-blt: SKIP (0.000s)
[534.517430] [104/156] (491s left) gem_eio (wait-10ms)
[534.748313] Starting subtest: wait-10ms
[535.118511] Subtest wait-10ms: SUCCESS (0.371s)
[535.253550] [105/156] (490s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-fullscreen)
[535.351168] Starting subtest: fbc-2p-primscrn-spr-indfb-fullscreen
[535.354410] Subtest fbc-2p-primscrn-spr-indfb-fullscreen: SKIP (0.000s)
[535.444237] [106/156] (490s left) i915_query (engine-info-invalid)
[535.493050] Starting subtest: engine-info-invalid
[535.494043] Subtest engine-info-invalid: SUCCESS (0.000s)
[535.593164] [107/156] (490s left) gem_mmap_gtt (basic-small-copy)
[535.642223] Subtest basic-small-copy: SKIP (0.000s)
[535.703280] [108/156] (490s left) gem_ctx_bad_destroy (double-destroy)
[535.756777] Starting subtest: double-destroy
[535.758172] Subtest double-destroy: SUCCESS (0.000s)
[535.831545] [109/156] (490s left) kms_frontbuffer_tracking (psrhdr-1p-primscrn-pri-indfb-draw-mmap-wc)
[535.911883] Starting subtest: psrhdr-1p-primscrn-pri-indfb-draw-mmap-wc
[535.913993] Subtest psrhdr-1p-primscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[536.010123] [110/156] (490s left) kms_psr (psr-primary-mmap-gtt)
[536.108373] Starting subtest: psr-primary-mmap-gtt
[536.109360] Starting dynamic subtest: eDP-1
[537.554456] Dynamic subtest eDP-1: SKIP (1.436s)
[537.556412] Subtest psr-primary-mmap-gtt: SKIP (1.438s)
[537.680922] [111/156] (488s left) kms_plane (pixel-format-yf-tiled-modifier)
[537.766034] Starting subtest: pixel-format-yf-tiled-modifier
[537.767799] Subtest pixel-format-yf-tiled-modifier: SKIP (0.000s)
[537.841422] [112/156] (488s left) kms_frontbuffer_tracking (psr-2p-primscrn-indfb-plflip-blt)
[537.936463] Starting subtest: psr-2p-primscrn-indfb-plflip-blt
[537.938215] Subtest psr-2p-primscrn-indfb-plflip-blt: SKIP (0.000s)
[538.025252] [113/156] (488s left) gem_exec_reloc (basic-write-wc)
[538.083306] Subtest basic-write-wc: SKIP (0.000s)
[538.152510] [114/156] (488s left) syncobj_timeline (invalid-multi-wait-all-unsubmitted-submitted-signaled)
[538.200908] Starting subtest: invalid-multi-wait-all-unsubmitted-submitted-signaled
[538.201891] Subtest invalid-multi-wait-all-unsubmitted-submitted-signaled: SUCCESS (0.000s)
[538.287963] [115/156] (488s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip)
[538.374260] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip
[538.376119] Subtest y-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip: SKIP (0.000s)
[538.486570] [116/156] (488s left) gem_ccs (block-copy-compressed)
[538.536112] Starting subtest: block-copy-compressed
[538.537885] Subtest block-copy-compressed: SKIP (0.000s)
[538.639169] [117/156] (488s left) kms_psr (fbc-psr-suspend)
[538.721310] Starting subtest: fbc-psr-suspend
[538.722129] Starting dynamic subtest: eDP-1
[538.723791] Dynamic subtest eDP-1: SKIP (0.000s)
[538.725408] Subtest fbc-psr-suspend: SKIP (0.001s)
[538.804045] [118/156] (487s left) kms_feature_discovery (display-1x)
[538.893623] Starting subtest: display-1x
[538.894558] Subtest display-1x: SUCCESS (0.000s)
[538.965784] [119/156] (487s left) gem_softpin (evict-prime)
[539.019584] Starting subtest: evict-prime
[539.020457] Starting dynamic subtest: rcs0
[540.179916] Dynamic subtest rcs0: SUCCESS (1.159s)
[540.194417] Starting dynamic subtest: bcs0
[541.318765] Dynamic subtest bcs0: SUCCESS (1.137s)
[541.332156] Starting dynamic subtest: vcs0
[543.343268] Dynamic subtest vcs0: SUCCESS (2.013s)
[543.353737] Starting dynamic subtest: vcs1
[545.313986] Dynamic subtest vcs1: SUCCESS (1.969s)
[545.326778] Starting dynamic subtest: vecs0
[547.295806] Dynamic subtest vecs0: SUCCESS (1.979s)
[547.309709] Starting dynamic subtest: ccs0
[548.411154] Dynamic subtest ccs0: SUCCESS (1.123s)
[548.421320] Starting dynamic subtest: all
[550.311487] Dynamic subtest all: SUCCESS (1.889s)
[550.312789] Subtest evict-prime: SUCCESS (11.283s)
[550.404241] [120/156] (476s left) core_setmaster (master-drop-set-shared-fd)
[550.488755] Starting subtest: master-drop-set-shared-fd
[550.510544] Subtest master-drop-set-shared-fd: SUCCESS (0.022s)
[550.542553] [121/156] (476s left) gem_softpin (evict-snoop-interruptible)
[550.598941] Starting subtest: evict-snoop-interruptible
[550.601200] Subtest evict-snoop-interruptible: SKIP (0.000s)
[550.709973] [122/156] (476s left) gem_userptr_blits (nohangcheck)
[550.791971] Starting subtest: nohangcheck
[551.113350] Subtest nohangcheck: SUCCESS (0.321s)
[551.242597] [123/156] (475s left) kms_content_protection (type1)
[551.380352] Starting subtest: type1
[551.382578] Subtest type1: SKIP (0.000s)
[551.503929] [124/156] (475s left) kms_vblank (query-forked-busy-hang)
[551.594734] Starting subtest: query-forked-busy-hang
[551.595837] Starting dynamic subtest: pipe-A-eDP-1
[557.697976] Dynamic subtest pipe-A-eDP-1: SUCCESS (6.102s)
[557.710358] Starting dynamic subtest: pipe-D-eDP-1
[564.684601] Dynamic subtest pipe-D-eDP-1: SUCCESS (6.984s)
[564.686384] Subtest query-forked-busy-hang: SUCCESS (13.090s)
[565.543030] [125/156] (461s left) kms_frontbuffer_tracking (fbchdr-1p-offscreen-pri-shrfb-draw-pwrite)
[565.641682] Starting subtest: fbchdr-1p-offscreen-pri-shrfb-draw-pwrite
[565.643432] Subtest fbchdr-1p-offscreen-pri-shrfb-draw-pwrite: SKIP (0.000s)
[565.744136] [126/156] (461s left) kms_plane_alpha_blend (alpha-basic)
[565.833549] Starting subtest: alpha-basic
[566.123055] Starting dynamic subtest: pipe-A-eDP-1
[568.044705] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.921s)
[568.074434] Starting dynamic subtest: pipe-D-eDP-1
[570.725721] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.660s)
[570.726833] Subtest alpha-basic: SUCCESS (4.893s)
[571.591704] [127/156] (455s left) kms_frontbuffer_tracking (psrhdr-2p-primscrn-indfb-pgflip-blt)
[571.680219] Starting subtest: psrhdr-2p-primscrn-indfb-pgflip-blt
[571.681853] Subtest psrhdr-2p-primscrn-indfb-pgflip-blt: SKIP (0.000s)
[571.779793] [128/156] (455s left) kms_frontbuffer_tracking (fbchdr-1p-primscrn-spr-indfb-draw-mmap-cpu)
[571.865886] Starting subtest: fbchdr-1p-primscrn-spr-indfb-draw-mmap-cpu
[571.867724] Subtest fbchdr-1p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[571.970675] [129/156] (455s left) gem_exec_whisper (basic-fds-priority)
[572.025698] Starting subtest: basic-fds-priority
[595.660379] Subtest basic-fds-priority: SUCCESS (23.633s)
[595.854588] [130/156] (431s left) gem_mmap_wc (write-cpu-read-wc-unflushed)
[595.909397] Subtest write-cpu-read-wc-unflushed: SKIP (0.000s)
[595.978120] [131/156] (431s left) gem_mmap (bad-object)
[596.024404] Subtest bad-object: SKIP (0.000s)
[596.078934] [132/156] (431s left) kms_flip_scaled_crc (flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling)
[596.180235] Starting subtest: flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling
[596.182020] Subtest flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling: SKIP (0.000s)
[596.253948] [133/156] (430s left) kms_addfb_basic (bo-too-small)
[596.341347] Starting subtest: bo-too-small
[596.342226] Subtest bo-too-small: SUCCESS (0.000s)
[596.444446] [134/156] (430s left) i915_fb_tiling (basic-x-tiling)
[596.497040] Subtest basic-x-tiling: SKIP (0.000s)
[596.549288] [135/156] (430s left) gem_exec_balancer (busy)
[596.597200] Starting subtest: busy
[598.284273] Subtest busy: SUCCESS (1.677s)
[598.603648] [136/156] (428s left) gem_exec_schedule (out-order)
[598.665027] Starting subtest: out-order
[598.666467] Starting dynamic subtest: rcs0
[598.768596] Dynamic subtest rcs0: SUCCESS (0.103s)
[598.781583] Starting dynamic subtest: vcs0
[598.851468] Dynamic subtest vcs0: SUCCESS (0.083s)
[598.863357] Starting dynamic subtest: vcs1
[598.961898] Dynamic subtest vcs1: SUCCESS (0.109s)
[598.974621] Starting dynamic subtest: vecs0
[599.065375] Dynamic subtest vecs0: SUCCESS (0.102s)
[599.077926] Starting dynamic subtest: ccs0
[599.205756] Dynamic subtest ccs0: SUCCESS (0.139s)
[599.207463] Subtest out-order: SUCCESS (0.541s)
[600.441201] [137/156] (426s left) kms_frontbuffer_tracking (fbchdr-2p-shrfb-fliptrack-mmap-gtt)
[600.533884] Starting subtest: fbchdr-2p-shrfb-fliptrack-mmap-gtt
[600.535765] Subtest fbchdr-2p-shrfb-fliptrack-mmap-gtt: SKIP (0.000s)
[600.626654] [138/156] (426s left) kms_async_flips (test-time-stamp)
[600.726023] Starting subtest: test-time-stamp
[601.098728] Starting dynamic subtest: pipe-A-eDP-1
[601.901829] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.802s)
[602.277745] Starting dynamic subtest: pipe-B-eDP-1
[603.049520] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.778s)
[603.428735] Starting dynamic subtest: pipe-C-eDP-1
[604.192973] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.774s)
[604.571350] Starting dynamic subtest: pipe-D-eDP-1
[605.336369] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.772s)
[605.337522] Subtest test-time-stamp: SUCCESS (4.610s)
[606.504648] [139/156] (420s left) kms_addfb_basic (addfb25-y-tiled-small-legacy)
[606.609952] Starting subtest: addfb25-y-tiled-small-legacy
[606.611789] Subtest addfb25-y-tiled-small-legacy: SKIP (0.000s)
[606.718295] [140/156] (420s left) kms_frontbuffer_tracking (hdr-2p-primscrn-spr-indfb-draw-mmap-wc)
[606.815896] Starting subtest: hdr-2p-primscrn-spr-indfb-draw-mmap-wc
[606.817685] Subtest hdr-2p-primscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[606.908337] [141/156] (420s left) kms_cursor_edge_walk (256x256-top-bottom)
[606.998229] Starting subtest: 256x256-top-bottom
[606.999080] Starting dynamic subtest: pipe-A-eDP-1
[610.478769] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.479s)
[610.488232] Starting dynamic subtest: pipe-D-eDP-1
[613.623160] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.144s)
[613.624067] Subtest 256x256-top-bottom: SUCCESS (6.625s)
[614.429052] [142/156] (413s left) kms_addfb_basic (too-high)
[614.521504] Starting subtest: too-high
[614.522587] Subtest too-high: SUCCESS (0.001s)
[614.625540] [143/156] (412s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-mmap-cpu)
[614.721911] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-mmap-cpu
[621.292473] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-mmap-cpu: SUCCESS (6.571s)
[621.424706] [144/156] (406s left) kms_big_fb (yf-tiled-addfb-size-offset-overflow)
[621.525360] Starting subtest: yf-tiled-addfb-size-offset-overflow
[621.527398] Subtest yf-tiled-addfb-size-offset-overflow: SKIP (0.000s)
[621.625536] [145/156] (406s left) gem_mmap_gtt (basic-copy)
[621.668567] Subtest basic-copy: SKIP (0.000s)
[621.729009] [146/156] (405s left) kms_frontbuffer_tracking (fbc-2p-primscrn-shrfb-pgflip-blt)
[621.831021] Starting subtest: fbc-2p-primscrn-shrfb-pgflip-blt
[621.833579] Subtest fbc-2p-primscrn-shrfb-pgflip-blt: SKIP (0.000s)
[621.947016] [147/156] (405s left) kms_psr2_sf (psr2-overlay-plane-move-continuous-sf)
[622.039793] Starting subtest: psr2-overlay-plane-move-continuous-sf
[622.040795] Starting dynamic subtest: pipe-A-eDP-1
[628.023356] Dynamic subtest pipe-A-eDP-1: SUCCESS (5.984s)
[628.035554] Starting dynamic subtest: pipe-B-eDP-1
[634.748493] Dynamic subtest pipe-B-eDP-1: SUCCESS (6.724s)
[634.749341] Subtest psr2-overlay-plane-move-continuous-sf: SUCCESS (12.711s)
[635.625187] [148/156] (392s left) kms_psr2_sf (psr2-overlay-primary-update-sf-dmg-area)
[635.717282] Starting subtest: psr2-overlay-primary-update-sf-dmg-area
[635.718072] Starting dynamic subtest: pipe-A-eDP-1
[641.627232] Dynamic subtest pipe-A-eDP-1: SUCCESS (5.910s)
[641.636928] Starting dynamic subtest: pipe-B-eDP-1
[648.282987] Dynamic subtest pipe-B-eDP-1: SUCCESS (6.655s)
[648.283885] Subtest psr2-overlay-primary-update-sf-dmg-area: SUCCESS (12.567s)
[649.148830] [149/156] (378s left) gem_pxp (create-regular-buffer)
[649.272056] Starting subtest: create-regular-buffer
[649.273466] Subtest create-regular-buffer: SUCCESS (0.000s)
[649.375393] [150/156] (378s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-32bpp-4tile-upscaling)
[649.457728] Starting subtest: flip-64bpp-4tile-to-32bpp-4tile-upscaling
[649.458655] Starting dynamic subtest: pipe-A-default-mode
[652.200497] Dynamic subtest pipe-A-default-mode: SUCCESS (2.742s)
[652.201795] Subtest flip-64bpp-4tile-to-32bpp-4tile-upscaling: SUCCESS (2.744s)
[653.045575] [151/156] (374s left) perf (non-zero-reason)
[653.151845] Starting subtest: non-zero-reason
[653.153032] Starting dynamic subtest: 0-rcs0
[658.854458] Dynamic subtest 0-rcs0: SUCCESS (5.655s)
[658.867795] Starting dynamic subtest: 1-vcs0
[662.887079] Dynamic subtest 1-vcs0: SUCCESS (4.031s)
[662.888025] Subtest non-zero-reason: SUCCESS (9.689s)
[662.920842] [152/156] (364s left) gem_media_vme
[663.039989] [153/156] (364s left) kms_frontbuffer_tracking (psrhdr-2p-scndscrn-shrfb-pgflip-blt)
[663.142804] Starting subtest: psrhdr-2p-scndscrn-shrfb-pgflip-blt
[663.144445] Subtest psrhdr-2p-scndscrn-shrfb-pgflip-blt: SKIP (0.000s)
[663.257894] [154/156] (364s left) gen9_exec_parse (bb-chained)
[663.308844] Subtest bb-chained: SKIP (0.000s)
[663.377106] [155/156] (364s left) kms_frontbuffer_tracking (fbchdr-modesetfrombusy)
[663.463589] Starting subtest: fbchdr-modesetfrombusy
[663.465286] Subtest fbchdr-modesetfrombusy: SKIP (0.000s)
[663.571083] [156/156] (364s left) gem_exec_big (single)
[663.615590] Starting subtest: single
[666.965503] Subtest single: FAIL (3.323s)
[667.021224] Closing watchdogs
results: parsing output: 0/ for test: kms_frontbuffer_tracking
results: parsing output: 1/ for test: gem_exec_schedule
results: parsing output: 2/ for test: syncobj_wait
results: parsing output: 3/ for test: kms_frontbuffer_tracking
results: parsing output: 4/ for test: kms_frontbuffer_tracking
results: parsing output: 5/ for test: kms_frontbuffer_tracking
results: parsing output: 6/ for test: kms_plane_scaling
results: parsing output: 7/ for test: kms_chamelium_edid
results: parsing output: 8/ for test: gem_lmem_swapping
results: parsing output: 9/ for test: kms_frontbuffer_tracking
results: parsing output: 10/ for test: kms_frontbuffer_tracking
results: parsing output: 11/ for test: kms_flip
results: parsing output: 12/ for test: gem_render_copy
results: parsing output: 13/ for test: gem_mmap_offset
results: parsing output: 14/ for test: vgem_basic
results: parsing output: 15/ for test: kms_flip
results: parsing output: 16/ for test: gem_ctx_engines
results: parsing output: 17/ for test: kms_frontbuffer_tracking
results: parsing output: 18/ for test: kms_big_fb
results: parsing output: 19/ for test: syncobj_timeline
results: parsing output: 20/ for test: perf_pmu
results: parsing output: 21/ for test: gem_exec_fence
results: parsing output: 22/ for test: kms_ccs
results: parsing output: 23/ for test: kms_ccs
results: parsing output: 24/ for test: kms_ccs
results: parsing output: 25/ for test: kms_ccs
results: parsing output: 26/ for test: kms_frontbuffer_tracking
results: parsing output: 27/ for test: gem_userptr_blits
results: parsing output: 28/ for test: kms_frontbuffer_tracking
results: parsing output: 29/ for test: kms_flip
results: parsing output: 30/ for test: kms_frontbuffer_tracking
results: parsing output: 31/ for test: kms_frontbuffer_tracking
results: parsing output: 32/ for test: gem_render_copy
results: parsing output: 33/ for test: kms_big_fb
results: parsing output: 34/ for test: syncobj_timeline
results: parsing output: 35/ for test: kms_cursor_legacy
results: parsing output: 36/ for test: syncobj_wait
results: parsing output: 37/ for test: kms_busy
results: parsing output: 38/ for test: core_setmaster_vs_auth
results: parsing output: 39/ for test: kms_psr
results: parsing output: 40/ for test: kms_frontbuffer_tracking
results: parsing output: 41/ for test: api_intel_allocator
results: parsing output: 42/ for test: sw_sync
results: parsing output: 43/ for test: kms_flip
results: parsing output: 44/ for test: kms_invalid_mode
results: parsing output: 45/ for test: kms_flip
results: parsing output: 46/ for test: kms_chamelium_color
results: parsing output: 47/ for test: kms_frontbuffer_tracking
results: parsing output: 48/ for test: kms_pm_rpm
results: parsing output: 49/ for test: syncobj_eventfd
results: parsing output: 50/ for test: gem_exec_params
results: parsing output: 51/ for test: i915_pm_rps
results: parsing output: 52/ for test: gem_mmap_gtt
results: parsing output: 53/ for test: gem_ctx_sseu
results: parsing output: 54/ for test: kms_flip
results: parsing output: 55/ for test: gem_ctx_persistence
results: parsing output: 56/ for test: kms_flip
results: parsing output: 57/ for test: kms_frontbuffer_tracking
results: parsing output: 58/ for test: i915_drm_fdinfo
results: parsing output: 59/ for test: kms_frontbuffer_tracking
results: parsing output: 60/ for test: kms_cursor_crc
results: parsing output: 61/ for test: perf
results: parsing output: 62/ for test: kms_psr
results: parsing output: 63/ for test: syncobj_wait
results: parsing output: 64/ for test: syncobj_eventfd
results: parsing output: 65/ for test: sysfs_heartbeat_interval
results: parsing output: 66/ for test: kms_big_fb
results: parsing output: 67/ for test: kms_cursor_legacy
results: parsing output: 68/ for test: gem_ctx_freq
results: parsing output: 69/ for test: kms_color
results: parsing output: 70/ for test: kms_pm_dc
results: parsing output: 71/ for test: kms_frontbuffer_tracking
results: parsing output: 72/ for test: prime_mmap_coherency
results: parsing output: 73/ for test: kms_lease
results: parsing output: 74/ for test: kms_flip
results: parsing output: 75/ for test: kms_frontbuffer_tracking
results: parsing output: 76/ for test: kms_frontbuffer_tracking
results: parsing output: 77/ for test: kms_plane
results: parsing output: 78/ for test: kms_frontbuffer_tracking
results: parsing output: 79/ for test: api_intel_bb
results: parsing output: 80/ for test: kms_psr2_sf
results: parsing output: 81/ for test: kms_frontbuffer_tracking
results: parsing output: 82/ for test: kms_frontbuffer_tracking
results: parsing output: 83/ for test: kms_plane
results: parsing output: 84/ for test: syncobj_timeline
results: parsing output: 85/ for test: syncobj_wait
results: parsing output: 86/ for test: kms_cursor_crc
results: parsing output: 87/ for test: kms_frontbuffer_tracking
results: parsing output: 88/ for test: gem_exec_reloc
results: parsing output: 89/ for test: kms_frontbuffer_tracking
results: parsing output: 90/ for test: kms_frontbuffer_tracking
results: parsing output: 91/ for test: kms_vblank
results: parsing output: 92/ for test: kms_frontbuffer_tracking
results: parsing output: 93/ for test: kms_frontbuffer_tracking
results: parsing output: 94/ for test: kms_frontbuffer_tracking
results: parsing output: 95/ for test: kms_frontbuffer_tracking
results: parsing output: 96/ for test: kms_big_fb
results: parsing output: 97/ for test: kms_frontbuffer_tracking
results: parsing output: 98/ for test: syncobj_basic
results: parsing output: 99/ for test: kms_chamelium_hpd
results: parsing output: 100/ for test: kms_psr
results: parsing output: 101/ for test: kms_frontbuffer_tracking
results: parsing output: 102/ for test: kms_frontbuffer_tracking
results: parsing output: 103/ for test: gem_eio
results: parsing output: 104/ for test: kms_frontbuffer_tracking
results: parsing output: 105/ for test: i915_query
results: parsing output: 106/ for test: gem_mmap_gtt
results: parsing output: 107/ for test: gem_ctx_bad_destroy
results: parsing output: 108/ for test: kms_frontbuffer_tracking
results: parsing output: 109/ for test: kms_psr
results: parsing output: 110/ for test: kms_plane
results: parsing output: 111/ for test: kms_frontbuffer_tracking
results: parsing output: 112/ for test: gem_exec_reloc
results: parsing output: 113/ for test: syncobj_timeline
results: parsing output: 114/ for test: kms_big_fb
results: parsing output: 115/ for test: gem_ccs
results: parsing output: 116/ for test: kms_psr
results: parsing output: 117/ for test: kms_feature_discovery
results: parsing output: 118/ for test: gem_softpin
results: parsing output: 119/ for test: core_setmaster
results: parsing output: 120/ for test: gem_softpin
results: parsing output: 121/ for test: gem_userptr_blits
results: parsing output: 122/ for test: kms_content_protection
results: parsing output: 123/ for test: kms_vblank
results: parsing output: 124/ for test: kms_frontbuffer_tracking
results: parsing output: 125/ for test: kms_plane_alpha_blend
results: parsing output: 126/ for test: kms_frontbuffer_tracking
results: parsing output: 127/ for test: kms_frontbuffer_tracking
results: parsing output: 128/ for test: gem_exec_whisper
results: parsing output: 129/ for test: gem_mmap_wc
results: parsing output: 130/ for test: gem_mmap
results: parsing output: 131/ for test: kms_flip_scaled_crc
results: parsing output: 132/ for test: kms_addfb_basic
results: parsing output: 133/ for test: i915_fb_tiling
results: parsing output: 134/ for test: gem_exec_balancer
results: parsing output: 135/ for test: gem_exec_schedule
results: parsing output: 136/ for test: kms_frontbuffer_tracking
results: parsing output: 137/ for test: kms_async_flips
results: parsing output: 138/ for test: kms_addfb_basic
results: parsing output: 139/ for test: kms_frontbuffer_tracking
results: parsing output: 140/ for test: kms_cursor_edge_walk
results: parsing output: 141/ for test: kms_addfb_basic
results: parsing output: 142/ for test: kms_frontbuffer_tracking
results: parsing output: 143/ for test: kms_big_fb
results: parsing output: 144/ for test: gem_mmap_gtt
results: parsing output: 145/ for test: kms_frontbuffer_tracking
results: parsing output: 146/ for test: kms_psr2_sf
results: parsing output: 147/ for test: kms_psr2_sf
results: parsing output: 148/ for test: gem_pxp
results: parsing output: 149/ for test: kms_flip_scaled_crc
results: parsing output: 150/ for test: perf
results: parsing output: 151/ for test: gem_media_vme
results: parsing output: 152/ for test: kms_frontbuffer_tracking
results: parsing output: 153/ for test: gen9_exec_parse
results: parsing output: 154/ for test: kms_frontbuffer_tracking
results: parsing output: 155/ for test: gem_exec_big
Done.