[61.070572] Initializing watchdogs
[61.070640]   /dev/watchdog0
[61.089213] [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]
[61.093786] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[61.096246] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[61.099636] [001/133] (960s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-move)
[61.223386] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-move
[61.227503] Subtest fbcpsr-2p-primscrn-spr-indfb-move: SKIP (0.000s)
[61.326426] [002/133] (960s left) kms_frontbuffer_tracking (psr-2p-primscrn-indfb-pgflip-blt)
[61.430569] Starting subtest: psr-2p-primscrn-indfb-pgflip-blt
[61.434720] Subtest psr-2p-primscrn-indfb-pgflip-blt: SKIP (0.000s)
[61.512218] [003/133] (960s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-180-async-flip)
[61.619154] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-180-async-flip
[62.298513] Subtest 4-tiled-max-hw-stride-32bpp-rotate-180-async-flip: SUCCESS (0.683s)
[62.487091] [004/133] (959s left) gen7_exec_parse (basic-offset)
[62.547173] Subtest basic-offset: SKIP (0.000s)
[62.613087] [005/133] (959s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-mmap-cpu)
[62.708808] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-mmap-cpu
[67.144184] Subtest fbc-1p-primscrn-pri-indfb-draw-mmap-cpu: SUCCESS (4.448s)
[68.324748] [006/133] (953s left) tools_test (tools_test)
[68.379445] Starting subtest: tools_test
[68.441911] Subtest tools_test: SUCCESS (0.078s)
[68.499751] [007/133] (953s left) kms_ccs (crc-primary-rotation-180-4-tiled-bmg-ccs)
[68.591239] Starting subtest: crc-primary-rotation-180-4-tiled-bmg-ccs
[68.595614] Subtest crc-primary-rotation-180-4-tiled-bmg-ccs: SKIP (0.000s)
[69.745342] [008/133] (952s left) kms_flip (modeset-vs-vblank-race)
[69.828707] Starting subtest: modeset-vs-vblank-race
[69.831080] Starting dynamic subtest: A-eDP1
[74.562394] Dynamic subtest A-eDP1: SUCCESS (4.736s)
[74.572742] Starting dynamic subtest: B-eDP1
[79.280900] Dynamic subtest B-eDP1: SUCCESS (4.718s)
[79.291520] Starting dynamic subtest: C-eDP1
[83.890583] Dynamic subtest C-eDP1: SUCCESS (4.609s)
[83.900569] Starting dynamic subtest: D-eDP1
[88.521163] Dynamic subtest D-eDP1: SUCCESS (4.630s)
[88.526090] Subtest modeset-vs-vblank-race: SUCCESS (18.703s)
[89.684536] [009/133] (932s left) i915_pm_rpm (reg-read-ioctl)
[91.228344] Starting subtest: reg-read-ioctl
[93.510795] Subtest reg-read-ioctl: SUCCESS (2.283s)
[93.913178] [010/133] (928s left) gem_exec_balancer (hang)
[94.179454] Starting subtest: hang
[95.889977] Subtest hang: SUCCESS (1.715s)
[96.006313] [011/133] (925s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-32bpp-ytile-downscaling)
[96.111055] Starting subtest: flip-64bpp-ytile-to-32bpp-ytile-downscaling
[96.115402] Subtest flip-64bpp-ytile-to-32bpp-ytile-downscaling: SKIP (0.000s)
[96.177939] [012/133] (925s left) perf_pmu (faulting-read)
[96.223471] Starting subtest: faulting-read
[96.225804] Starting dynamic subtest: wb
[96.228070] Dynamic subtest wb: SUCCESS (0.001s)
[96.241536] Starting dynamic subtest: wc
[96.243778] Dynamic subtest wc: SUCCESS (0.000s)
[96.251595] Starting dynamic subtest: uc
[96.253710] Dynamic subtest uc: SUCCESS (0.000s)
[96.255851] Subtest faulting-read: SUCCESS (0.002s)
[96.324216] [013/133] (925s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-pwrite)
[96.413477] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-pwrite
[96.418112] Subtest fbc-2p-scndscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[96.520946] [014/133] (925s left) kms_chamelium_hpd (hdmi-hpd-enable-disable-mode)
[96.914977] Subtest hdmi-hpd-enable-disable-mode: SKIP (0.000s)
[97.703569] [015/133] (924s left) gem_exec_schedule (pi-distinct-iova)
[97.890405] Starting subtest: pi-distinct-iova
[97.892452] Starting dynamic subtest: rcs0
[97.972777] Dynamic subtest rcs0: SUCCESS (0.085s)
[97.982833] Starting dynamic subtest: vcs0
[98.035754] Dynamic subtest vcs0: SUCCESS (0.063s)
[98.046189] Starting dynamic subtest: vcs1
[98.100048] Dynamic subtest vcs1: SUCCESS (0.064s)
[98.110889] Starting dynamic subtest: vecs0
[98.161393] Dynamic subtest vecs0: SUCCESS (0.061s)
[98.172098] Starting dynamic subtest: ccs0
[98.224904] Dynamic subtest ccs0: SUCCESS (0.063s)
[98.227374] Subtest pi-distinct-iova: SUCCESS (0.337s)
[100.021069] [016/133] (922s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-mmap-wc)
[100.128698] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-mmap-wc
[100.133354] Subtest fbc-2p-scndscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[100.242447] [017/133] (921s left) drm_read (short-buffer-block)
[100.385836] Starting subtest: short-buffer-block
[100.388262] Subtest short-buffer-block: SUCCESS (0.000s)
[100.520117] [018/133] (921s left) perf (oa-formats)
[100.645350] Starting subtest: oa-formats
[100.647574] Starting dynamic subtest: 0-rcs0
[100.658495] Dynamic subtest 0-rcs0: SUCCESS (0.014s)
[100.667684] Starting dynamic subtest: 1-vcs1
[100.684267] Dynamic subtest 1-vcs1: SUCCESS (0.025s)
[100.686591] Subtest oa-formats: SUCCESS (0.040s)
[100.734779] [019/133] (921s left) kms_frontbuffer_tracking (fbc-2p-primscrn-indfb-msflip-blt)
[100.829592] Starting subtest: fbc-2p-primscrn-indfb-msflip-blt
[100.834086] Subtest fbc-2p-primscrn-indfb-msflip-blt: SKIP (0.000s)
[100.930702] [020/133] (921s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-mmap-cpu)
[101.030055] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-mmap-cpu
[101.033458] Subtest psr-2p-scndscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[101.112721] [021/133] (921s left) kms_psr (pr-basic)
[101.206654] Starting subtest: pr-basic
[101.210323] Subtest pr-basic: SKIP (0.000s)
[101.279057] [022/133] (921s left) kms_ccs (bad-rotation-90-y-tiled-gen12-mc-ccs)
[101.370280] Starting subtest: bad-rotation-90-y-tiled-gen12-mc-ccs
[101.372065] Starting dynamic subtest: pipe-A-eDP-1
[101.390670] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[101.400846] Starting dynamic subtest: pipe-B-eDP-1
[101.418856] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[101.426448] Starting dynamic subtest: pipe-C-eDP-1
[101.443934] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[101.451177] Starting dynamic subtest: pipe-D-eDP-1
[101.468810] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[101.472124] Subtest bad-rotation-90-y-tiled-gen12-mc-ccs: SKIP (0.003s)
[103.701021] [023/133] (918s left) kms_chamelium_edid (hdmi-mode-timings)
[104.093080] Subtest hdmi-mode-timings: SKIP (0.000s)
[104.906618] [024/133] (917s left) kms_content_protection (dp-mst-lic-type-0-hdcp14)
[105.047604] Starting subtest: dp-mst-lic-type-0-hdcp14
[105.052475] Subtest dp-mst-lic-type-0-hdcp14: SKIP (0.000s)
[105.160470] [025/133] (917s left) kms_psr2_sf (fbc-pr-cursor-plane-move-continuous-exceed-sf)
[105.265823] Starting subtest: fbc-pr-cursor-plane-move-continuous-exceed-sf
[105.270396] Subtest fbc-pr-cursor-plane-move-continuous-exceed-sf: SKIP (0.000s)
[105.342833] [026/133] (917s left) kms_rotation_crc (primary-4-tiled-reflect-x-180)
[105.441975] Starting subtest: primary-4-tiled-reflect-x-180
[112.373812] Subtest primary-4-tiled-reflect-x-180: SUCCESS (6.935s)
[113.599792] [027/133] (909s left) kms_flip (2x-flip-vs-panning-interruptible)
[113.695711] Starting subtest: 2x-flip-vs-panning-interruptible
[113.707231] Subtest 2x-flip-vs-panning-interruptible: SKIP (0.011s)
[113.780168] [028/133] (908s left) kms_flip (plain-flip-fb-recreate)
[113.875248] Starting subtest: plain-flip-fb-recreate
[113.877592] Starting dynamic subtest: A-eDP1
[122.784403] Dynamic subtest A-eDP1: SUCCESS (8.909s)
[122.792719] Starting dynamic subtest: B-eDP1
[131.612185] Dynamic subtest B-eDP1: SUCCESS (8.826s)
[131.620155] Starting dynamic subtest: C-eDP1
[140.443826] Dynamic subtest C-eDP1: SUCCESS (8.830s)
[140.451563] Starting dynamic subtest: D-eDP1
[149.263113] Dynamic subtest D-eDP1: SUCCESS (8.817s)
[149.267144] Subtest plain-flip-fb-recreate: SUCCESS (35.392s)
[150.456336] [029/133] (872s left) gem_tiled_partial_pwrite_pread (writes)
[150.514223] Subtest writes: SKIP (0.000s)
[150.574475] [030/133] (872s left) gem_lmem_swapping (heavy-verify-random)
[150.614095] Subtest heavy-verify-random: SKIP (0.000s)
[150.662936] [031/133] (872s left) kms_big_fb (x-tiled-64bpp-rotate-90)
[150.762727] Starting subtest: x-tiled-64bpp-rotate-90
[150.782430] Subtest x-tiled-64bpp-rotate-90: SKIP (0.019s)
[150.911260] [032/133] (871s left) vgem_basic (debugfs)
[151.021805] Starting subtest: debugfs
[151.024091] Subtest debugfs: SUCCESS (0.002s)
[151.078546] [FACT vgem_basic (debugfs)] new: kernel.kmod_is_loaded.vgem: true
[151.081624] [033/133] (871s left) kms_atomic_interruptible (legacy-setmode)
[151.174376] Starting subtest: legacy-setmode
[151.176580] Starting dynamic subtest: pipe-A-eDP-1
[158.084417] Dynamic subtest pipe-A-eDP-1: SUCCESS (6.910s)
[158.086730] Subtest legacy-setmode: SUCCESS (6.911s)
[158.948038] [034/133] (863s left) gem_pxp (reject-modify-context-protection-off-2)
[159.077774] Starting subtest: reject-modify-context-protection-off-2
[159.080431] Subtest reject-modify-context-protection-off-2: SUCCESS (0.002s)
[159.184407] [035/133] (863s left) gem_exec_basic (basic)
[159.247873] Starting subtest: basic
[159.250279] Starting dynamic subtest: rcs0-smem
[159.252686] Dynamic subtest rcs0-smem: SUCCESS (0.003s)
[159.263150] Starting dynamic subtest: bcs0-smem
[159.265028] Dynamic subtest bcs0-smem: SUCCESS (0.001s)
[159.272807] Starting dynamic subtest: vcs0-smem
[159.274774] Dynamic subtest vcs0-smem: SUCCESS (0.001s)
[159.282394] Starting dynamic subtest: vcs1-smem
[159.284291] Dynamic subtest vcs1-smem: SUCCESS (0.001s)
[159.292476] Starting dynamic subtest: vecs0-smem
[159.294378] Dynamic subtest vecs0-smem: SUCCESS (0.001s)
[159.301634] Starting dynamic subtest: ccs0-smem
[159.303537] Dynamic subtest ccs0-smem: SUCCESS (0.001s)
[159.305443] Subtest basic: SUCCESS (0.011s)
[160.954687] [036/133] (862s left) api_intel_bb (offset-control)
[161.022296] Starting subtest: offset-control
[161.038175] Subtest offset-control: SUCCESS (0.016s)
[161.158059] [037/133] (861s left) kms_joiner (basic-max-non-joiner)
[161.254523] Starting subtest: basic-max-non-joiner
[161.258905] Subtest basic-max-non-joiner: SKIP (0.000s)
[161.322379] [038/133] (861s left) kms_addfb_basic (small-bo)
[161.423251] Starting subtest: small-bo
[161.425505] Subtest small-bo: SUCCESS (0.000s)
[161.529946] [039/133] (861s left) i915_query (query-topology-garbage-items)
[161.585911] Starting subtest: query-topology-garbage-items
[161.587875] Subtest query-topology-garbage-items: SUCCESS (0.000s)
[161.682786] [040/133] (861s left) perf (gen12-group-exclusive-stream-ctx-handle)
[161.777635] Starting subtest: gen12-group-exclusive-stream-ctx-handle
[161.801878] Subtest gen12-group-exclusive-stream-ctx-handle: SUCCESS (0.023s)
[161.839027] [041/133] (861s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-fullscreen)
[162.914490] Starting subtest: fbc-2p-primscrn-spr-indfb-fullscreen
[162.918751] Subtest fbc-2p-primscrn-spr-indfb-fullscreen: SKIP (0.000s)
[163.016144] [042/133] (860s left) gem_exec_params (cliprects-invalid)
[163.084572] Starting subtest: cliprects-invalid
[163.086964] Subtest cliprects-invalid: SUCCESS (0.000s)
[163.191292] [043/133] (860s left) kms_cursor_crc (cursor-random-64x64)
[163.362644] Starting subtest: cursor-random-64x64
[163.364925] Starting dynamic subtest: pipe-A-eDP-1
[166.685666] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.319s)
[166.711809] Starting dynamic subtest: pipe-D-eDP-1
[170.655459] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.948s)
[170.657868] Subtest cursor-random-64x64: SUCCESS (7.292s)
[171.517368] [044/133] (851s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-180-hflip)
[171.624177] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-180-hflip
[171.628482] Subtest yf-tiled-max-hw-stride-64bpp-rotate-180-hflip: SKIP (0.000s)
[171.719328] [045/133] (851s left) kms_big_fb (4-tiled-16bpp-rotate-180)
[171.815704] Starting subtest: 4-tiled-16bpp-rotate-180
[173.116238] Subtest 4-tiled-16bpp-rotate-180: SUCCESS (1.302s)
[173.229995] [046/133] (850s left) dumb_buffer (create-valid-dumb)
[173.287542] Starting subtest: create-valid-dumb
[173.289356] Subtest create-valid-dumb: SUCCESS (0.000s)
[173.389840] [047/133] (850s left) gem_softpin (zero)
[173.451153] Starting subtest: zero
[173.454826] Subtest zero: SUCCESS (0.004s)
[173.578896] [048/133] (849s left) gem_blits (basic)
[173.642437] Starting subtest: basic
[175.062936] Subtest basic: SUCCESS (1.418s)
[175.202301] [049/133] (848s left) gem_busy (close-race)
[175.269084] Starting subtest: close-race
[198.956073] Subtest close-race: SUCCESS (23.686s)
[199.332926] [050/133] (824s left) gem_exec_alignment (forked)
[199.431363] Starting subtest: forked
[236.952555] Subtest forked: SUCCESS (37.519s)
[237.797338] [051/133] (785s left) syncobj_eventfd (binary-wait-before-signal)
[237.885398] Starting subtest: binary-wait-before-signal
[237.916517] Subtest binary-wait-before-signal: SUCCESS (0.031s)
[238.007739] [052/133] (785s left) prime_mmap (test_errors)
[238.069046] Starting subtest: test_errors
[238.071669] Starting dynamic subtest: test_errors-smem
[238.181463] Dynamic subtest test_errors-smem: SUCCESS (0.113s)
[238.184434] Subtest test_errors: SUCCESS (0.114s)
[238.280952] [053/133] (785s left) gem_ctx_persistence (heartbeat-stop)
[238.340122] Starting subtest: heartbeat-stop
[238.344646] Subtest heartbeat-stop: SKIP (0.000s)
[238.436997] [054/133] (785s left) gem_ctx_param (invalid-get-ringsize)
[238.489704] Starting subtest: invalid-get-ringsize
[238.492032] Subtest invalid-get-ringsize: SUCCESS (0.001s)
[238.585334] [055/133] (785s left) i915_query (query-topology-matches-eu-total)
[238.647443] Starting subtest: query-topology-matches-eu-total
[238.649684] Subtest query-topology-matches-eu-total: SUCCESS (0.000s)
[238.773315] [056/133] (785s left) kms_cursor_edge_walk (64x64-right-edge)
[238.869943] Starting subtest: 64x64-right-edge
[238.872238] Starting dynamic subtest: pipe-A-eDP-1
[242.386025] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.516s)
[242.396095] Starting dynamic subtest: pipe-D-eDP-1
[245.502435] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.116s)
[245.504754] Subtest 64x64-right-edge: SUCCESS (6.634s)
[246.305770] [057/133] (777s left) kms_plane (plane-position-covered)
[246.403245] Starting subtest: plane-position-covered
[246.913036] Starting dynamic subtest: pipe-A-plane-1
[248.229807] Dynamic subtest pipe-A-plane-1: SUCCESS (1.314s)
[248.240072] Starting dynamic subtest: pipe-A-plane-2
[249.525794] Dynamic subtest pipe-A-plane-2: SUCCESS (1.296s)
[249.535681] Starting dynamic subtest: pipe-A-plane-3
[250.883483] Dynamic subtest pipe-A-plane-3: SUCCESS (1.359s)
[250.893502] Starting dynamic subtest: pipe-A-plane-4
[252.187716] Dynamic subtest pipe-A-plane-4: SUCCESS (1.302s)
[252.197586] Starting dynamic subtest: pipe-A-plane-5
[252.212598] Dynamic subtest pipe-A-plane-5: SUCCESS (0.024s)
[253.358049] Starting dynamic subtest: pipe-B-plane-1
[254.665896] Dynamic subtest pipe-B-plane-1: SUCCESS (1.315s)
[254.676352] Starting dynamic subtest: pipe-B-plane-2
[255.902194] Dynamic subtest pipe-B-plane-2: SUCCESS (1.238s)
[255.911589] Starting dynamic subtest: pipe-B-plane-3
[257.148231] Dynamic subtest pipe-B-plane-3: SUCCESS (1.242s)
[257.158225] Starting dynamic subtest: pipe-B-plane-4
[258.397757] Dynamic subtest pipe-B-plane-4: SUCCESS (1.250s)
[258.407051] Starting dynamic subtest: pipe-B-plane-5
[258.422842] Dynamic subtest pipe-B-plane-5: SUCCESS (0.024s)
[258.425220] Subtest plane-position-covered: SUCCESS (12.020s)
[259.197516] [058/133] (764s left) kms_frontbuffer_tracking (psr-suspend)
[259.295474] Starting subtest: psr-suspend
[298.741875] Subtest psr-suspend: SUCCESS (8.930s)
[304.897235] [059/133] (725s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-blt)
[305.016077] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-blt
[305.020485] Subtest psr-2p-scndscrn-spr-indfb-draw-blt: SKIP (0.000s)
[305.109570] [060/133] (724s left) gem_exec_schedule (fairslice)
[305.185534] Starting subtest: fairslice
[305.187504] Starting dynamic subtest: rcs0
[307.199364] Dynamic subtest rcs0: SUCCESS (2.040s)
[307.209029] Starting dynamic subtest: bcs0
[309.229957] Dynamic subtest bcs0: SUCCESS (2.030s)
[309.239808] Starting dynamic subtest: vcs0
[311.234639] Dynamic subtest vcs0: SUCCESS (2.032s)
[311.246373] Starting dynamic subtest: vcs1
[313.253580] Dynamic subtest vcs1: SUCCESS (2.029s)
[313.262975] Starting dynamic subtest: vecs0
[315.276337] Dynamic subtest vecs0: SUCCESS (2.029s)
[315.287141] Starting dynamic subtest: ccs0
[317.300831] Dynamic subtest ccs0: SUCCESS (2.032s)
[317.303146] Subtest fairslice: SUCCESS (12.198s)
[317.608116] [061/133] (712s left) sw_sync (alloc_fence_invalid_timeline)
[317.655536] Starting subtest: alloc_fence_invalid_timeline
[317.657854] Subtest alloc_fence_invalid_timeline: SUCCESS (0.000s)
[317.720846] [062/133] (712s left) gem_exec_whisper (basic-fds-forked)
[317.779684] Starting subtest: basic-fds-forked
[341.989883] Subtest basic-fds-forked: SUCCESS (24.227s)
[342.180173] [063/133] (687s left) kms_frontbuffer_tracking (fbc-2p-primscrn-shrfb-pgflip-blt)
[342.287359] Starting subtest: fbc-2p-primscrn-shrfb-pgflip-blt
[342.291394] Subtest fbc-2p-primscrn-shrfb-pgflip-blt: SKIP (0.000s)
[342.384035] [064/133] (687s left) gem_vm_create (execbuf)
[342.449524] Starting subtest: execbuf
[342.456625] Subtest execbuf: SUCCESS (0.007s)
[342.565622] [065/133] (687s left) kms_cursor_crc (cursor-onscreen-256x85)
[342.818871] Starting subtest: cursor-onscreen-256x85
[342.866754] Subtest cursor-onscreen-256x85: SKIP (0.041s)
[343.050266] [066/133] (687s left) kms_plane_alpha_blend (coverage-7efc)
[343.151027] Starting subtest: coverage-7efc
[343.451280] Starting dynamic subtest: pipe-A-eDP-1
[344.018072] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.565s)
[344.046773] Starting dynamic subtest: pipe-D-eDP-1
[345.325112] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.287s)
[345.327613] Subtest coverage-7efc: SUCCESS (2.176s)
[346.193504] [067/133] (684s left) kms_plane_scaling (planes-downscale-factor-0-5-unity-scaling)
[346.288290] Starting subtest: planes-downscale-factor-0-5-unity-scaling
[346.290503] Starting dynamic subtest: pipe-A
[346.309025] Dynamic subtest pipe-A: SKIP (0.017s)
[346.319947] Starting dynamic subtest: pipe-B
[346.340552] Dynamic subtest pipe-B: SKIP (0.031s)
[346.350872] Starting dynamic subtest: pipe-C
[346.373958] Dynamic subtest pipe-C: SKIP (0.034s)
[346.383871] Starting dynamic subtest: pipe-D
[346.406987] Dynamic subtest pipe-D: SKIP (0.031s)
[346.411195] Subtest planes-downscale-factor-0-5-unity-scaling: SKIP (0.116s)
[346.510352] [068/133] (683s left) vgem_basic (busy-fence)
[346.556038] Starting subtest: busy-fence
[346.557915] Subtest busy-fence: SUCCESS (0.000s)
[346.614187] [069/133] (683s left) kms_plane (pixel-format-4-tiled-mtl-mc-ccs-modifier)
[346.701880] Starting subtest: pixel-format-4-tiled-mtl-mc-ccs-modifier
[346.731265] Starting dynamic subtest: pipe-A-plane-0
[347.152801] Dynamic subtest pipe-A-plane-0: SUCCESS (0.422s)
[347.162886] Starting dynamic subtest: pipe-A-plane-3
[347.430759] Dynamic subtest pipe-A-plane-3: SUCCESS (0.276s)
[347.442936] Starting dynamic subtest: pipe-A-plane-5
[347.446628] Dynamic subtest pipe-A-plane-5: SKIP (0.000s)
[348.557510] Starting dynamic subtest: pipe-B-plane-0
[349.005055] Dynamic subtest pipe-B-plane-0: SUCCESS (0.455s)
[349.016469] Starting dynamic subtest: pipe-B-plane-3
[349.260408] Dynamic subtest pipe-B-plane-3: SUCCESS (0.255s)
[349.270017] Starting dynamic subtest: pipe-B-plane-5
[349.274459] Dynamic subtest pipe-B-plane-5: SKIP (0.000s)
[349.583442] Subtest pixel-format-4-tiled-mtl-mc-ccs-modifier: SUCCESS (2.882s)
[350.453773] [070/133] (680s left) kms_addfb_basic (invalid-set-prop-any)
[350.517468] Starting subtest: invalid-set-prop-any
[350.520010] Subtest invalid-set-prop-any: SUCCESS (0.000s)
[350.659156] [071/133] (679s left) kms_addfb_basic (size-max)
[350.742100] Starting subtest: size-max
[350.743975] Subtest size-max: SUCCESS (0.000s)
[350.854383] [072/133] (679s left) kms_addfb_basic (bad-pitch-128)
[350.918242] Starting subtest: bad-pitch-128
[350.920453] Subtest bad-pitch-128: SUCCESS (0.000s)
[351.080645] [073/133] (679s left) syncobj_timeline (single-wait-available-submitted)
[351.138570] Starting subtest: single-wait-available-submitted
[351.140836] Subtest single-wait-available-submitted: SUCCESS (0.000s)
[351.261687] [074/133] (679s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-0-hflip)
[351.359808] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-0-hflip
[352.339222] Subtest x-tiled-max-hw-stride-64bpp-rotate-0-hflip: SUCCESS (0.980s)
[352.475394] [075/133] (678s left) gem_pread (exhaustion)
[352.537986] Subtest exhaustion: SKIP (0.000s)
[352.607159] [076/133] (678s left) kms_frontbuffer_tracking (psr-1p-rte)
[352.705797] Starting subtest: psr-1p-rte
[358.151592] Subtest psr-1p-rte: SUCCESS (5.450s)
[358.315876] [077/133] (672s left) kms_cursor_legacy (long-nonblocking-modeset-vs-cursor-atomic)
[358.453406] Starting subtest: long-nonblocking-modeset-vs-cursor-atomic
[375.739482] Subtest long-nonblocking-modeset-vs-cursor-atomic: SUCCESS (17.292s)
[376.540962] [078/133] (654s left) api_intel_allocator (fork-simple-once)
[376.609546] Starting subtest: fork-simple-once
[376.624238] Subtest fork-simple-once: SUCCESS (0.017s)
[376.734130] [079/133] (654s left) gem_set_tiling_vs_pwrite
[376.843907] [080/133] (654s left) kms_pm_backlight (brightness-with-dpms)
[376.931843] Starting subtest: brightness-with-dpms
[376.984803] Starting dynamic subtest: eDP-1
[379.439094] Dynamic subtest eDP-1: SUCCESS (2.456s)
[379.441322] Subtest brightness-with-dpms: SUCCESS (2.508s)
[380.305950] [081/133] (650s left) kms_lease (lease-invalid-crtc)
[380.409839] Starting subtest: lease-invalid-crtc
[380.412114] Starting dynamic subtest: pipe-A-eDP-1
[380.414433] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s)
[380.429159] Starting dynamic subtest: pipe-B-eDP-1
[380.431070] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[380.441056] Starting dynamic subtest: pipe-C-eDP-1
[380.443306] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[380.452894] Starting dynamic subtest: pipe-D-eDP-1
[380.455310] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[380.457599] Subtest lease-invalid-crtc: SUCCESS (0.005s)
[380.497236] [082/133] (650s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-mmap-gtt)
[380.590679] Starting subtest: fbcpsr-rgb101010-draw-mmap-gtt
[380.595155] Subtest fbcpsr-rgb101010-draw-mmap-gtt: SKIP (0.000s)
[380.700704] [083/133] (650s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-indfb-draw-blt)
[380.795432] Starting subtest: psr-1p-offscreen-pri-indfb-draw-blt
[387.776886] Subtest psr-1p-offscreen-pri-indfb-draw-blt: SUCCESS (6.986s)
[387.919996] [084/133] (643s left) kms_dp_linktrain_fallback (dp-fallback)
[388.016861] Starting subtest: dp-fallback
[388.023218] Subtest dp-fallback: SKIP (0.000s)
[388.090436] [085/133] (643s left) kms_vblank (ts-continuation-idle)
[388.175871] Starting subtest: ts-continuation-idle
[388.177709] Starting dynamic subtest: pipe-A-eDP-1
[388.573966] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.396s)
[388.591867] Starting dynamic subtest: pipe-D-eDP-1
[389.668908] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.093s)
[389.671077] Subtest ts-continuation-idle: SUCCESS (1.494s)
[390.534861] [086/133] (640s left) kms_psr (fbc-psr-cursor-mmap-gtt)
[390.644854] Starting subtest: fbc-psr-cursor-mmap-gtt
[390.647073] Starting dynamic subtest: eDP-1
[390.651305] Dynamic subtest eDP-1: SKIP (0.000s)
[390.655481] Subtest fbc-psr-cursor-mmap-gtt: SKIP (0.001s)
[390.722615] [087/133] (640s left) kms_cursor_legacy (cursor-vs-flip-varying-size)
[390.841106] Starting subtest: cursor-vs-flip-varying-size
[422.108879] Subtest cursor-vs-flip-varying-size: SUCCESS (31.258s)
[422.977236] [088/133] (608s left) i915_drm_fdinfo (busy-check-all)
[423.023244] Starting subtest: busy-check-all
[423.025501] Starting dynamic subtest: rcs0
[423.030118] Dynamic subtest rcs0: SKIP (0.003s)
[423.043384] Starting dynamic subtest: bcs0
[423.047507] Dynamic subtest bcs0: SKIP (0.000s)
[423.057336] Starting dynamic subtest: vcs0
[423.061224] Dynamic subtest vcs0: SKIP (0.000s)
[423.076356] Starting dynamic subtest: vcs1
[423.080913] Dynamic subtest vcs1: SKIP (0.000s)
[423.100076] Starting dynamic subtest: vecs0
[423.104902] Dynamic subtest vecs0: SKIP (0.000s)
[423.123305] Starting dynamic subtest: ccs0
[423.127268] Dynamic subtest ccs0: SKIP (0.000s)
[423.131242] Subtest busy-check-all: SKIP (0.008s)
[423.170272] [089/133] (608s left) kms_ccs (bad-pixel-format-4-tiled-mtl-rc-ccs-cc)
[423.259624] Starting subtest: bad-pixel-format-4-tiled-mtl-rc-ccs-cc
[423.261909] Starting dynamic subtest: pipe-A-eDP-1
[423.282527] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s)
[423.294226] Starting dynamic subtest: pipe-B-eDP-1
[423.314026] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[423.324062] Starting dynamic subtest: pipe-C-eDP-1
[423.343559] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[423.353522] Starting dynamic subtest: pipe-D-eDP-1
[423.373014] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[423.375199] Subtest bad-pixel-format-4-tiled-mtl-rc-ccs-cc: SUCCESS (0.006s)
[425.457484] [090/133] (605s left) prime_busy (before-wait)
[425.517924] Starting subtest: before-wait
[425.523067] Starting dynamic subtest: rcs0
[425.546895] Dynamic subtest rcs0: SUCCESS (0.025s)
[425.559414] Starting dynamic subtest: bcs0
[425.585793] Dynamic subtest bcs0: SUCCESS (0.038s)
[425.596052] Starting dynamic subtest: vcs0
[425.625861] Dynamic subtest vcs0: SUCCESS (0.039s)
[425.636023] Starting dynamic subtest: vcs1
[425.666442] Dynamic subtest vcs1: SUCCESS (0.040s)
[425.676520] Starting dynamic subtest: vecs0
[425.707670] Dynamic subtest vecs0: SUCCESS (0.040s)
[425.717854] Starting dynamic subtest: ccs0
[425.749145] Dynamic subtest ccs0: SUCCESS (0.041s)
[425.857453] Subtest before-wait: SUCCESS (0.337s)
[425.936653] [091/133] (605s left) gem_ppgtt (blt-vs-render-ctx0)
[426.000576] Starting subtest: blt-vs-render-ctx0
[458.760073] Subtest blt-vs-render-ctx0: SUCCESS (32.760s)
[458.898053] [092/133] (572s left) kms_cursor_legacy (cursorb-vs-flipb-atomic)
[459.058730] Starting subtest: cursorB-vs-flipB-atomic
[459.063073] Subtest cursorB-vs-flipB-atomic: SKIP (0.001s)
[459.203850] [093/133] (572s left) gem_exec_reloc (basic-wc-read-active)
[459.263428] Subtest basic-wc-read-active: SKIP (0.000s)
[459.337679] [094/133] (572s left) gem_exec_fence (syncobj-import)
[459.799878] Starting subtest: syncobj-import
[459.803330] Subtest syncobj-import: SUCCESS (0.007s)
[461.488475] [095/133] (570s left) kms_psr (fbc-psr2-sprite-blt)
[461.584955] Starting subtest: fbc-psr2-sprite-blt
[461.587094] Starting dynamic subtest: eDP-1
[461.590909] Dynamic subtest eDP-1: SKIP (0.000s)
[461.594827] Subtest fbc-psr2-sprite-blt: SKIP (0.001s)
[461.666891] [096/133] (570s left) kms_color_pipeline (plane-lut1d-post-ctm3x4)
[461.767058] Starting subtest: plane-lut1d-post-ctm3x4
[461.923286] Starting dynamic subtest: pipe-A-plane-0
[462.078481] Dynamic subtest pipe-A-plane-0: SUCCESS (0.155s)
[462.089393] Starting dynamic subtest: pipe-A-plane-1
[462.222918] Dynamic subtest pipe-A-plane-1: SUCCESS (0.144s)
[462.233550] Starting dynamic subtest: pipe-A-plane-2
[462.367418] Dynamic subtest pipe-A-plane-2: SUCCESS (0.143s)
[463.592226] Starting dynamic subtest: pipe-B-plane-0
[463.806373] Dynamic subtest pipe-B-plane-0: SUCCESS (0.222s)
[463.820072] Starting dynamic subtest: pipe-B-plane-1
[463.972890] Dynamic subtest pipe-B-plane-1: SUCCESS (0.164s)
[463.985645] Starting dynamic subtest: pipe-B-plane-2
[464.117275] Dynamic subtest pipe-B-plane-2: SUCCESS (0.144s)
[465.266890] Starting dynamic subtest: pipe-C-plane-0
[465.412492] Dynamic subtest pipe-C-plane-0: SUCCESS (0.155s)
[465.422980] Starting dynamic subtest: pipe-C-plane-1
[465.568914] Dynamic subtest pipe-C-plane-1: SUCCESS (0.155s)
[465.579759] Starting dynamic subtest: pipe-C-plane-2
[465.723647] Dynamic subtest pipe-C-plane-2: SUCCESS (0.155s)
[466.915110] Starting dynamic subtest: pipe-D-plane-0
[467.060917] Dynamic subtest pipe-D-plane-0: SUCCESS (0.155s)
[467.071581] Starting dynamic subtest: pipe-D-plane-1
[467.194263] Dynamic subtest pipe-D-plane-1: SUCCESS (0.133s)
[467.204783] Starting dynamic subtest: pipe-D-plane-2
[467.339411] Dynamic subtest pipe-D-plane-2: SUCCESS (0.143s)
[467.639869] Subtest plane-lut1d-post-ctm3x4: SUCCESS (5.876s)
[468.498997] [097/133] (563s left) gem_render_copy (y-tiled-mc-ccs-to-vebox-y-tiled)
[468.561753] Starting subtest: y-tiled-mc-ccs-to-vebox-y-tiled
[468.566763] Subtest y-tiled-mc-ccs-to-vebox-y-tiled: SKIP (0.000s)
[468.768689] [098/133] (562s left) kms_big_fb (linear-8bpp-rotate-180)
[468.871202] Starting subtest: linear-8bpp-rotate-180
[470.173302] Subtest linear-8bpp-rotate-180: SUCCESS (1.304s)
[470.317373] [099/133] (561s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-blt)
[470.422180] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-blt
[470.425704] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[470.511390] [100/133] (561s left) kms_busy (extended-modeset-hang-oldfb-with-reset)
[470.619776] Starting subtest: extended-modeset-hang-oldfb-with-reset
[470.621601] Starting dynamic subtest: pipe-A
[482.557018] Dynamic subtest pipe-A: SUCCESS (11.938s)
[482.568988] Starting dynamic subtest: pipe-D
[494.812092] Dynamic subtest pipe-D: SUCCESS (12.256s)
[494.813890] Subtest extended-modeset-hang-oldfb-with-reset: SUCCESS (24.198s)
[495.608192] [101/133] (536s left) gem_exec_schedule (timeslicing)
[495.687738] Starting subtest: timeslicing
[495.690077] Starting dynamic subtest: rcs0
[495.698678] Dynamic subtest rcs0: SUCCESS (0.021s)
[495.712358] Starting dynamic subtest: bcs0
[495.718644] Dynamic subtest bcs0: SUCCESS (0.020s)
[495.729525] Starting dynamic subtest: vcs0
[495.739018] Dynamic subtest vcs0: SUCCESS (0.020s)
[495.749172] Starting dynamic subtest: vcs1
[495.759744] Dynamic subtest vcs1: SUCCESS (0.020s)
[495.769977] Starting dynamic subtest: vecs0
[495.780064] Dynamic subtest vecs0: SUCCESS (0.020s)
[495.790315] Starting dynamic subtest: ccs0
[495.800181] Dynamic subtest ccs0: SUCCESS (0.019s)
[495.802491] Subtest timeslicing: SUCCESS (0.123s)
[497.475296] [102/133] (534s left) kms_chamelium_color (ctm-0-25)
[497.565085] Subtest ctm-0-25: SKIP (0.000s)
[497.612541] [103/133] (534s left) kms_psr2_sf (fbc-psr2-plane-move-sf-dmg-area)
[497.715343] Starting subtest: fbc-psr2-plane-move-sf-dmg-area
[497.717710] Starting dynamic subtest: pipe-A-eDP-1
[497.799136] Dynamic subtest pipe-A-eDP-1: SKIP (0.089s)
[497.810938] Starting dynamic subtest: pipe-B-eDP-1
[498.990151] Dynamic subtest pipe-B-eDP-1: SKIP (1.190s)
[498.994901] Subtest fbc-psr2-plane-move-sf-dmg-area: SKIP (1.281s)
[500.181741] [104/133] (531s left) gem_mmap (short-mmap)
[500.246575] Subtest short-mmap: SKIP (0.000s)
[500.306930] [105/133] (531s left) syncobj_timeline (multi-wait-available-unsubmitted-submitted)
[500.363159] Starting subtest: multi-wait-available-unsubmitted-submitted
[500.365837] Subtest multi-wait-available-unsubmitted-submitted: SUCCESS (0.000s)
[500.455115] [106/133] (531s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-blt)
[500.549759] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-blt
[500.554191] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-blt: SKIP (0.000s)
[500.657760] [107/133] (531s left) kms_getfb (getfb2-accept-nv12)
[500.751318] Starting subtest: getfb2-accept-nv12
[500.753717] Subtest getfb2-accept-nv12: SUCCESS (0.001s)
[500.858915] [108/133] (531s left) syncobj_timeline (invalid-signal-zero-handles)
[500.925404] Starting subtest: invalid-signal-zero-handles
[500.927807] Subtest invalid-signal-zero-handles: SUCCESS (0.000s)
[501.038309] [109/133] (531s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-32bpp-ytileccs-upscaling)
[501.125971] Starting subtest: flip-32bpp-ytile-to-32bpp-ytileccs-upscaling
[501.130365] Subtest flip-32bpp-ytile-to-32bpp-ytileccs-upscaling: SKIP (0.000s)
[501.200324] [110/133] (531s left) kms_ccs (crc-sprite-planes-basic-4-tiled-dg2-rc-ccs-cc)
[501.289313] Starting subtest: crc-sprite-planes-basic-4-tiled-dg2-rc-ccs-cc
[501.291070] Starting dynamic subtest: pipe-A-eDP-1
[501.338073] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[501.348324] Starting dynamic subtest: pipe-B-eDP-1
[501.393069] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[501.406379] Starting dynamic subtest: pipe-C-eDP-1
[501.453069] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[501.464075] Starting dynamic subtest: pipe-D-eDP-1
[501.510565] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[501.514085] Subtest crc-sprite-planes-basic-4-tiled-dg2-rc-ccs-cc: SKIP (0.009s)
[503.530510] [111/133] (528s left) kms_flip (2x-flip-vs-absolute-wf_vblank)
[503.626056] Starting subtest: 2x-flip-vs-absolute-wf_vblank
[503.635277] Subtest 2x-flip-vs-absolute-wf_vblank: SKIP (0.011s)
[503.717715] [112/133] (528s left) kms_async_flips (async-flip-with-page-flip-events-tiled)
[503.823764] Starting subtest: async-flip-with-page-flip-events-tiled
[504.195578] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs
[506.996944] Dynamic subtest pipe-A-eDP-1-4-rc-ccs: SUCCESS (2.801s)
[507.010391] Starting dynamic subtest: pipe-A-eDP-1-4
[509.181593] Dynamic subtest pipe-A-eDP-1-4: SUCCESS (2.184s)
[509.192068] Starting dynamic subtest: pipe-A-eDP-1-4
[511.191680] Dynamic subtest pipe-A-eDP-1-4: SUCCESS (2.008s)
[511.205011] Starting dynamic subtest: pipe-A-eDP-1-x
[513.380884] Dynamic subtest pipe-A-eDP-1-x: SUCCESS (2.189s)
[513.759981] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs
[516.522170] Dynamic subtest pipe-B-eDP-1-4-rc-ccs: SUCCESS (2.770s)
[516.535652] Starting dynamic subtest: pipe-B-eDP-1-4
[518.706675] Dynamic subtest pipe-B-eDP-1-4: SUCCESS (2.184s)
[518.717413] Starting dynamic subtest: pipe-B-eDP-1-4
[520.716636] Dynamic subtest pipe-B-eDP-1-4: SUCCESS (2.009s)
[520.730414] Starting dynamic subtest: pipe-B-eDP-1-x
[522.917111] Dynamic subtest pipe-B-eDP-1-x: SUCCESS (2.200s)
[523.295240] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs
[526.054405] Dynamic subtest pipe-C-eDP-1-4-rc-ccs: SUCCESS (2.765s)
[526.065953] Starting dynamic subtest: pipe-C-eDP-1-4
[528.230629] Dynamic subtest pipe-C-eDP-1-4: SUCCESS (2.174s)
[528.243335] Starting dynamic subtest: pipe-C-eDP-1-4
[530.241088] Dynamic subtest pipe-C-eDP-1-4: SUCCESS (2.009s)
[530.252329] Starting dynamic subtest: pipe-C-eDP-1-x
[532.421262] Dynamic subtest pipe-C-eDP-1-x: SUCCESS (2.178s)
[532.785565] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs
[535.589217] Dynamic subtest pipe-D-eDP-1-4-rc-ccs: SUCCESS (2.811s)
[535.600624] Starting dynamic subtest: pipe-D-eDP-1-4
[537.764741] Dynamic subtest pipe-D-eDP-1-4: SUCCESS (2.173s)
[537.775393] Starting dynamic subtest: pipe-D-eDP-1-4
[539.775552] Dynamic subtest pipe-D-eDP-1-4: SUCCESS (2.009s)
[539.786640] Starting dynamic subtest: pipe-D-eDP-1-x
[541.966267] Dynamic subtest pipe-D-eDP-1-x: SUCCESS (2.189s)
[541.968644] Subtest async-flip-with-page-flip-events-tiled: SUCCESS (38.141s)
[543.191186] [113/133] (489s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-0)
[543.279415] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-0
[543.283523] Subtest yf-tiled-max-hw-stride-64bpp-rotate-0: SKIP (0.000s)
[543.371831] [114/133] (489s left) syncobj_timeline (etime-multi-wait-for-submit-submitted)
[543.426834] Starting subtest: etime-multi-wait-for-submit-submitted
[543.529804] Subtest etime-multi-wait-for-submit-submitted: SUCCESS (0.103s)
[543.608935] [115/133] (488s left) kms_pm_rpm (modeset-non-lpsp-stress-no-wait)
[545.638613] Starting subtest: modeset-non-lpsp-stress-no-wait
[545.693958] Subtest modeset-non-lpsp-stress-no-wait: SKIP (0.055s)
[546.088585] [116/133] (486s left) gem_exec_params (sol-reset-invalid)
[546.158684] Starting subtest: sol-reset-invalid
[546.161389] Subtest sol-reset-invalid: SUCCESS (0.003s)
[547.471977] [117/133] (485s left) gem_mmap_gtt (cpuset-big-copy)
[547.538961] Subtest cpuset-big-copy: SKIP (0.000s)
[547.610303] [118/133] (485s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-pwrite)
[547.715901] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-pwrite
[555.485161] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-pwrite: SUCCESS (7.770s)
[555.611044] [119/133] (477s left) kms_psr (psr2-sprite-plane-onoff)
[555.700967] Starting subtest: psr2-sprite-plane-onoff
[555.703276] Starting dynamic subtest: eDP-1
[557.402268] Dynamic subtest eDP-1: SUCCESS (1.699s)
[557.404561] Subtest psr2-sprite-plane-onoff: SUCCESS (1.700s)
[558.263088] [120/133] (474s left) kms_dsc (dsc-with-output-formats)
[558.355211] Starting subtest: dsc-with-output-formats
[558.376249] Subtest dsc-with-output-formats: SKIP (0.001s)
[558.433914] [121/133] (474s left) gen3_mixed_blits
[558.547626] [122/133] (474s left) gem_mmap_offset (clear-via-pagefault)
[558.596235] Starting subtest: clear-via-pagefault
[558.598505] Starting dynamic subtest: smem0
[595.437287] Dynamic subtest smem0: SUCCESS (36.830s)
[595.439789] Subtest clear-via-pagefault: SUCCESS (36.832s)
[595.537927] [123/133] (437s left) gem_eio (reset-stress)
[595.787219] Starting subtest: reset-stress
[595.789123] Starting dynamic subtest: render
[600.778598] Dynamic subtest render: SUCCESS (4.991s)
[600.796995] Starting dynamic subtest: bsd1
[618.984780] Dynamic subtest bsd1: SUCCESS (18.204s)
[619.002898] Starting dynamic subtest: bsd2
[636.935376] Dynamic subtest bsd2: SUCCESS (17.952s)
[636.952159] Starting dynamic subtest: blt
[636.956713] Dynamic subtest blt: SKIP (0.000s)
[636.966330] Starting dynamic subtest: vebox
[654.920499] Dynamic subtest vebox: SUCCESS (17.985s)
[654.922941] Subtest reset-stress: SUCCESS (59.138s)
[656.500974] [124/133] (376s left) syncobj_wait (invalid-multi-wait-unsubmitted-submitted)
[656.568564] Starting subtest: invalid-multi-wait-unsubmitted-submitted
[656.570752] Subtest invalid-multi-wait-unsubmitted-submitted: SUCCESS (0.000s)
[656.665931] [125/133] (376s left) kms_vblank (query-busy-hang)
[656.757144] Starting subtest: query-busy-hang
[656.759327] Starting dynamic subtest: pipe-A-eDP-1
[658.631129] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.875s)
[658.650663] Starting dynamic subtest: pipe-D-eDP-1
[661.219985] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.584s)
[661.222263] Subtest query-busy-hang: SUCCESS (4.463s)
[662.015298] [126/133] (371s left) kms_psr (fbc-pr-cursor-plane-onoff)
[662.105980] Starting subtest: fbc-pr-cursor-plane-onoff
[662.110551] Subtest fbc-pr-cursor-plane-onoff: SKIP (0.000s)
[662.182081] [127/133] (370s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-move)
[662.275134] Starting subtest: psr-1p-primscrn-cur-indfb-move
[669.687014] Subtest psr-1p-primscrn-cur-indfb-move: SUCCESS (7.416s)
[669.814470] [128/133] (363s left) tools_test (sysfs_l3_parity)
[669.873168] Starting subtest: sysfs_l3_parity
[669.952493] Subtest sysfs_l3_parity: SKIP (0.089s)
[670.035227] [129/133] (363s left) kms_vblank (crtc-id)
[670.119944] Starting subtest: crtc-id
[670.122083] Starting dynamic subtest: pipe-A-eDP-1
[670.575387] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.455s)
[670.595405] Starting dynamic subtest: pipe-D-eDP-1
[671.676369] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.099s)
[671.678631] Subtest crtc-id: SUCCESS (1.558s)
[672.514645] [130/133] (360s left) gem_ctx_engines (independent)
[672.569322] Starting subtest: independent
[672.571662] Starting dynamic subtest: rcs0
[672.712552] Dynamic subtest rcs0: SUCCESS (0.141s)
[672.724910] Starting dynamic subtest: bcs0
[672.882101] Dynamic subtest bcs0: SUCCESS (0.169s)
[672.892506] Starting dynamic subtest: vcs0
[673.061854] Dynamic subtest vcs0: SUCCESS (0.179s)
[673.073494] Starting dynamic subtest: vcs1
[673.231542] Dynamic subtest vcs1: SUCCESS (0.169s)
[673.243234] Starting dynamic subtest: vecs0
[673.406876] Dynamic subtest vecs0: SUCCESS (0.174s)
[673.417748] Starting dynamic subtest: ccs0
[673.585771] Dynamic subtest ccs0: SUCCESS (0.178s)
[673.596680] Starting dynamic subtest: all-engines
[674.215693] Dynamic subtest all-engines: SUCCESS (0.630s)
[674.218623] Subtest independent: SUCCESS (1.646s)
[674.612345] [131/133] (358s left) kms_flip (flip-vs-dpms-on-nop-interruptible)
[674.713189] Starting subtest: flip-vs-dpms-on-nop-interruptible
[674.715558] Starting dynamic subtest: A-eDP1
[676.600099] Dynamic subtest A-eDP1: SUCCESS (1.886s)
[676.616048] Starting dynamic subtest: B-eDP1
[678.439063] Dynamic subtest B-eDP1: SUCCESS (1.836s)
[678.453064] Starting dynamic subtest: C-eDP1
[680.242724] Dynamic subtest C-eDP1: SUCCESS (1.801s)
[680.256025] Starting dynamic subtest: D-eDP1
[682.077682] Dynamic subtest D-eDP1: SUCCESS (1.833s)
[682.080262] Subtest flip-vs-dpms-on-nop-interruptible: SUCCESS (7.369s)
[683.259993] [132/133] (350s left) kms_plane_lowres (tiling-x)
[683.354025] Starting subtest: tiling-x
[683.356299] Starting dynamic subtest: pipe-A-eDP-1
[683.360892] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[683.657936] Starting dynamic subtest: pipe-B-eDP-1
[683.662294] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[683.672478] Starting dynamic subtest: pipe-C-eDP-1
[683.676893] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[683.687095] Starting dynamic subtest: pipe-D-eDP-1
[683.691381] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[683.695635] Subtest tiling-x: SKIP (0.303s)
[684.486167] [133/133] (348s left) i915_pm_freq_api (freq-reset)
[684.564511] Starting subtest: freq-reset
[684.566583] Starting dynamic subtest: gt0
[684.753742] Dynamic subtest gt0: SUCCESS (0.192s)
[684.765888] Starting dynamic subtest: gt1
[684.931835] Dynamic subtest gt1: SUCCESS (0.173s)
[684.934716] Subtest freq-reset: SUCCESS (0.366s)
[685.002983] Closing watchdogs
results: parsing output: 0/ for test: kms_frontbuffer_tracking
results: parsing output: 1/ for test: kms_frontbuffer_tracking
results: parsing output: 2/ for test: kms_big_fb
results: parsing output: 3/ for test: gen7_exec_parse
results: parsing output: 4/ for test: kms_frontbuffer_tracking
results: parsing output: 5/ for test: tools_test
results: parsing output: 6/ for test: kms_ccs
results: parsing output: 7/ for test: kms_flip
results: parsing output: 8/ for test: i915_pm_rpm
results: parsing output: 9/ for test: gem_exec_balancer
results: parsing output: 10/ for test: kms_flip_scaled_crc
results: parsing output: 11/ for test: perf_pmu
results: parsing output: 12/ for test: kms_frontbuffer_tracking
results: parsing output: 13/ for test: kms_chamelium_hpd
results: parsing output: 14/ for test: gem_exec_schedule
results: parsing output: 15/ for test: kms_frontbuffer_tracking
results: parsing output: 16/ for test: drm_read
results: parsing output: 17/ for test: perf
results: parsing output: 18/ for test: kms_frontbuffer_tracking
results: parsing output: 19/ for test: kms_frontbuffer_tracking
results: parsing output: 20/ for test: kms_psr
results: parsing output: 21/ for test: kms_ccs
results: parsing output: 22/ for test: kms_chamelium_edid
results: parsing output: 23/ for test: kms_content_protection
results: parsing output: 24/ for test: kms_psr2_sf
results: parsing output: 25/ for test: kms_rotation_crc
results: parsing output: 26/ for test: kms_flip
results: parsing output: 27/ for test: kms_flip
results: parsing output: 28/ for test: gem_tiled_partial_pwrite_pread
results: parsing output: 29/ for test: gem_lmem_swapping
results: parsing output: 30/ for test: kms_big_fb
results: parsing output: 31/ for test: vgem_basic
results: parsing output: 32/ for test: kms_atomic_interruptible
results: parsing output: 33/ for test: gem_pxp
results: parsing output: 34/ for test: gem_exec_basic
results: parsing output: 35/ for test: api_intel_bb
results: parsing output: 36/ for test: kms_joiner
results: parsing output: 37/ for test: kms_addfb_basic
results: parsing output: 38/ for test: i915_query
results: parsing output: 39/ for test: perf
results: parsing output: 40/ for test: kms_frontbuffer_tracking
results: parsing output: 41/ for test: gem_exec_params
results: parsing output: 42/ for test: kms_cursor_crc
results: parsing output: 43/ for test: kms_big_fb
results: parsing output: 44/ for test: kms_big_fb
results: parsing output: 45/ for test: dumb_buffer
results: parsing output: 46/ for test: gem_softpin
results: parsing output: 47/ for test: gem_blits
results: parsing output: 48/ for test: gem_busy
results: parsing output: 49/ for test: gem_exec_alignment
results: parsing output: 50/ for test: syncobj_eventfd
results: parsing output: 51/ for test: prime_mmap
results: parsing output: 52/ for test: gem_ctx_persistence
results: parsing output: 53/ for test: gem_ctx_param
results: parsing output: 54/ for test: i915_query
results: parsing output: 55/ for test: kms_cursor_edge_walk
results: parsing output: 56/ for test: kms_plane
results: parsing output: 57/ for test: kms_frontbuffer_tracking
results: parsing output: 58/ for test: kms_frontbuffer_tracking
results: parsing output: 59/ for test: gem_exec_schedule
results: parsing output: 60/ for test: sw_sync
results: parsing output: 61/ for test: gem_exec_whisper
results: parsing output: 62/ for test: kms_frontbuffer_tracking
results: parsing output: 63/ for test: gem_vm_create
results: parsing output: 64/ for test: kms_cursor_crc
results: parsing output: 65/ for test: kms_plane_alpha_blend
results: parsing output: 66/ for test: kms_plane_scaling
results: parsing output: 67/ for test: vgem_basic
results: parsing output: 68/ for test: kms_plane
results: parsing output: 69/ for test: kms_addfb_basic
results: parsing output: 70/ for test: kms_addfb_basic
results: parsing output: 71/ for test: kms_addfb_basic
results: parsing output: 72/ for test: syncobj_timeline
results: parsing output: 73/ for test: kms_big_fb
results: parsing output: 74/ for test: gem_pread
results: parsing output: 75/ for test: kms_frontbuffer_tracking
results: parsing output: 76/ for test: kms_cursor_legacy
results: parsing output: 77/ for test: api_intel_allocator
results: parsing output: 78/ for test: gem_set_tiling_vs_pwrite
results: parsing output: 79/ for test: kms_pm_backlight
results: parsing output: 80/ for test: kms_lease
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_dp_linktrain_fallback
results: parsing output: 84/ for test: kms_vblank
results: parsing output: 85/ for test: kms_psr
results: parsing output: 86/ for test: kms_cursor_legacy
results: parsing output: 87/ for test: i915_drm_fdinfo
results: parsing output: 88/ for test: kms_ccs
results: parsing output: 89/ for test: prime_busy
results: parsing output: 90/ for test: gem_ppgtt
results: parsing output: 91/ for test: kms_cursor_legacy
results: parsing output: 92/ for test: gem_exec_reloc
results: parsing output: 93/ for test: gem_exec_fence
results: parsing output: 94/ for test: kms_psr
results: parsing output: 95/ for test: kms_color_pipeline
results: parsing output: 96/ for test: gem_render_copy
results: parsing output: 97/ for test: kms_big_fb
results: parsing output: 98/ for test: kms_frontbuffer_tracking
results: parsing output: 99/ for test: kms_busy
results: parsing output: 100/ for test: gem_exec_schedule
results: parsing output: 101/ for test: kms_chamelium_color
results: parsing output: 102/ for test: kms_psr2_sf
results: parsing output: 103/ for test: gem_mmap
results: parsing output: 104/ for test: syncobj_timeline
results: parsing output: 105/ for test: kms_frontbuffer_tracking
results: parsing output: 106/ for test: kms_getfb
results: parsing output: 107/ for test: syncobj_timeline
results: parsing output: 108/ for test: kms_flip_scaled_crc
results: parsing output: 109/ for test: kms_ccs
results: parsing output: 110/ for test: kms_flip
results: parsing output: 111/ for test: kms_async_flips
results: parsing output: 112/ for test: kms_big_fb
results: parsing output: 113/ for test: syncobj_timeline
results: parsing output: 114/ for test: kms_pm_rpm
results: parsing output: 115/ for test: gem_exec_params
results: parsing output: 116/ for test: gem_mmap_gtt
results: parsing output: 117/ for test: kms_frontbuffer_tracking
results: parsing output: 118/ for test: kms_psr
results: parsing output: 119/ for test: kms_dsc
results: parsing output: 120/ for test: gen3_mixed_blits
results: parsing output: 121/ for test: gem_mmap_offset
results: parsing output: 122/ for test: gem_eio
results: parsing output: 123/ for test: syncobj_wait
results: parsing output: 124/ for test: kms_vblank
results: parsing output: 125/ for test: kms_psr
results: parsing output: 126/ for test: kms_frontbuffer_tracking
results: parsing output: 127/ for test: tools_test
results: parsing output: 128/ for test: kms_vblank
results: parsing output: 129/ for test: gem_ctx_engines
results: parsing output: 130/ for test: kms_flip
results: parsing output: 131/ for test: kms_plane_lowres
results: parsing output: 132/ for test: i915_pm_freq_api
Done.