[140.532027] Initializing watchdogs [140.532075] /dev/watchdog0 [140.547500] [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] [140.552248] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [140.554841] [FACT before any test] new: kernel.kmod_is_loaded.i915: true [140.558457] [001/156] (960s left) syncobj_wait (invalid-reset-one-illegal-handle) [140.628839] Starting subtest: invalid-reset-one-illegal-handle [140.631260] Subtest invalid-reset-one-illegal-handle: SUCCESS (0.000s) [140.742843] [002/156] (960s left) gem_tiled_blits (basic) [140.808057] Subtest basic: SKIP (0.000s) [140.871201] [003/156] (960s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-mmap-cpu) [140.972708] Starting subtest: psr-2p-primscrn-spr-indfb-draw-mmap-cpu [140.976852] Subtest psr-2p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s) [141.074299] [004/156] (960s left) dumb_buffer (map-valid) [141.130163] Starting subtest: map-valid [141.132468] Subtest map-valid: SUCCESS (0.000s) [141.213727] [005/156] (959s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-gtt) [141.318774] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-gtt [141.322910] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s) [141.402271] [006/156] (959s left) kms_frontbuffer_tracking (psrhdr-1p-primscrn-spr-indfb-draw-render) [141.489992] Starting subtest: psrhdr-1p-primscrn-spr-indfb-draw-render [141.493420] Subtest psrhdr-1p-primscrn-spr-indfb-draw-render: SKIP (0.000s) [141.580636] [007/156] (959s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-mmap-wc) [141.674491] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-mmap-wc [141.677916] Subtest fbc-2p-scndscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s) [141.769116] [008/156] (959s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-indfb-msflip-blt) [141.870052] Starting subtest: fbcpsr-1p-primscrn-indfb-msflip-blt [149.397140] Subtest fbcpsr-1p-primscrn-indfb-msflip-blt: SUCCESS (7.532s) [149.533384] [009/156] (951s left) gem_fenced_exec_thrash (2-spare-fences) [149.591802] Subtest 2-spare-fences: SKIP (0.000s) [149.650212] [010/156] (951s left) kms_frontbuffer_tracking (psrhdr-2p-scndscrn-cur-indfb-draw-render) [149.748806] Starting subtest: psrhdr-2p-scndscrn-cur-indfb-draw-render [149.753289] Subtest psrhdr-2p-scndscrn-cur-indfb-draw-render: SKIP (0.000s) [149.871901] [011/156] (951s left) gem_exec_fence (syncobj-timeline-invalid-flags) [150.416838] Starting subtest: syncobj-timeline-invalid-flags [150.419184] Subtest syncobj-timeline-invalid-flags: SUCCESS (0.000s) [151.381773] [FACT gem_exec_fence (syncobj-timeline-invalid-flags)] new: kernel.kmod_is_loaded.vgem: true [151.385444] [012/156] (950s left) kms_properties (connector-properties-atomic) [151.476235] Starting subtest: connector-properties-atomic [151.478710] Starting dynamic subtest: pipe-A-eDP-1 [159.443400] Dynamic subtest pipe-A-eDP-1: SUCCESS (7.969s) [159.453996] Starting dynamic subtest: pipe-None-DP-1 [159.458492] Dynamic subtest pipe-None-DP-1: SUCCESS (0.001s) [159.466294] Starting dynamic subtest: pipe-None-HDMI-A-1 [159.470591] Dynamic subtest pipe-None-HDMI-A-1: SUCCESS (0.001s) [159.478725] Starting dynamic subtest: pipe-None-DP-2 [159.482851] Dynamic subtest pipe-None-DP-2: SUCCESS (0.001s) [159.490893] Starting dynamic subtest: pipe-None-HDMI-A-2 [159.495145] Dynamic subtest pipe-None-HDMI-A-2: SUCCESS (0.001s) [159.502977] Starting dynamic subtest: pipe-None-DP-3 [159.507171] Dynamic subtest pipe-None-DP-3: SUCCESS (0.001s) [159.515327] Starting dynamic subtest: pipe-None-DP-4 [159.519732] Dynamic subtest pipe-None-DP-4: SUCCESS (0.001s) [159.521907] Subtest connector-properties-atomic: SUCCESS (7.978s) [160.326393] [013/156] (941s left) kms_content_protection (atomic-dpms-hdcp14) [160.474508] Starting subtest: atomic-dpms-hdcp14 [160.478908] Subtest atomic-dpms-hdcp14: SKIP (0.000s) [160.622313] [014/156] (940s left) kms_frontbuffer_tracking (psrhdr-2p-primscrn-spr-indfb-draw-mmap-gtt) [160.725952] Starting subtest: psrhdr-2p-primscrn-spr-indfb-draw-mmap-gtt [160.730408] Subtest psrhdr-2p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s) [160.819580] [015/156] (940s left) kms_vblank (query-busy) [160.921301] Starting subtest: query-busy [160.923289] Starting dynamic subtest: pipe-A-eDP-1 [162.797584] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.876s) [162.813893] Starting dynamic subtest: pipe-D-eDP-1 [165.381446] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.584s) [165.383732] Subtest query-busy: SUCCESS (4.463s) [166.195134] [016/156] (935s left) kms_cursor_crc (cursor-sliding-max-size) [166.508156] Starting subtest: cursor-sliding-max-size [166.514499] Subtest cursor-sliding-max-size: SKIP (0.000s) [166.634784] [017/156] (935s left) perf_pmu (init-wait) [166.671583] Starting subtest: init-wait [166.673759] Starting dynamic subtest: rcs0 [166.676420] Dynamic subtest rcs0: SUCCESS (0.002s) [166.686475] Starting dynamic subtest: bcs0 [166.688708] Dynamic subtest bcs0: SUCCESS (0.000s) [166.697155] Starting dynamic subtest: vcs0 [166.699340] Dynamic subtest vcs0: SUCCESS (0.000s) [166.707356] Starting dynamic subtest: vcs1 [166.709576] Dynamic subtest vcs1: SUCCESS (0.000s) [166.720325] Starting dynamic subtest: vecs0 [166.722171] Dynamic subtest vecs0: SUCCESS (0.000s) [166.730852] Starting dynamic subtest: ccs0 [166.733103] Dynamic subtest ccs0: SUCCESS (0.000s) [166.735191] Subtest init-wait: SUCCESS (0.005s) [166.774351] [018/156] (934s left) kms_psr (pr-cursor-blt) [166.883405] Starting subtest: pr-cursor-blt [166.888186] Subtest pr-cursor-blt: SKIP (0.000s) [166.958556] [019/156] (934s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-0-async-flip) [167.065048] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-0-async-flip [167.688697] Subtest 4-tiled-max-hw-stride-32bpp-rotate-0-async-flip: SUCCESS (0.626s) [167.876226] [020/156] (933s left) syncobj_timeline (etime-multi-wait-all-for-submit-unsubmitted-submitted-signa [167.932871] Starting subtest: etime-multi-wait-all-for-submit-unsubmitted-submitted-signaled [168.042644] Subtest etime-multi-wait-all-for-submit-unsubmitted-submitted-signaled: SUCCESS (0.109s) [168.119385] [021/156] (933s left) kms_rotation_crc (primary-y-tiled-reflect-x-270) [168.215066] Starting subtest: primary-y-tiled-reflect-x-270 [168.219871] Subtest primary-y-tiled-reflect-x-270: SKIP (0.001s) [168.310409] [022/156] (933s left) kms_flip (2x-flip-vs-wf_vblank-interruptible) [168.412263] Starting subtest: 2x-flip-vs-wf_vblank-interruptible [168.429512] Subtest 2x-flip-vs-wf_vblank-interruptible: SKIP (0.015s) [168.503073] [023/156] (933s left) kms_flip (flip-vs-suspend-interruptible) [168.600716] Starting subtest: flip-vs-suspend-interruptible [168.603079] Starting dynamic subtest: A-eDP1 [314.317628] Dynamic subtest A-eDP1: SUCCESS (11.284s) [314.320285] Subtest flip-vs-suspend-interruptible: SUCCESS (11.286s) [314.465237] [024/156] (787s left) perf_pmu (busy-idle) [314.511240] Starting subtest: busy-idle [314.513852] Starting dynamic subtest: rcs0 [315.197784] Dynamic subtest rcs0: SUCCESS (0.687s) [315.209386] Starting dynamic subtest: bcs0 [315.860022] Dynamic subtest bcs0: SUCCESS (0.660s) [315.873415] Starting dynamic subtest: vcs0 [317.723999] Dynamic subtest vcs0: SUCCESS (1.860s) [317.735723] Starting dynamic subtest: vcs1 [319.708333] Dynamic subtest vcs1: SUCCESS (1.981s) [319.722005] Starting dynamic subtest: vecs0 [321.754414] Dynamic subtest vecs0: SUCCESS (2.045s) [321.768110] Starting dynamic subtest: ccs0 [322.472860] Dynamic subtest ccs0: FAIL (0.650s) [322.475353] Subtest busy-idle: FAIL (7.890s) [322.520415] [025/156] (779s left) gem_exec_balancer (bonded-true-hang) [322.792434] Starting subtest: bonded-true-hang [322.798255] Subtest bonded-true-hang: SKIP (0.000s) [322.897450] [026/156] (779s left) kms_flip (2x-absolute-wf_vblank) [322.988800] Starting subtest: 2x-absolute-wf_vblank [322.999760] Subtest 2x-absolute-wf_vblank: SKIP (0.010s) [323.093382] [027/156] (779s left) kms_flip (flip-vs-panning) [323.183966] Starting subtest: flip-vs-panning [323.186584] Starting dynamic subtest: A-eDP1 [331.895114] Dynamic subtest A-eDP1: SUCCESS (8.711s) [331.906036] Starting dynamic subtest: B-eDP1 [340.628147] Dynamic subtest B-eDP1: SUCCESS (8.729s) [340.639933] Starting dynamic subtest: C-eDP1 [349.345980] Dynamic subtest C-eDP1: SUCCESS (8.717s) [349.358069] Starting dynamic subtest: D-eDP1 [358.081964] Dynamic subtest D-eDP1: SUCCESS (8.735s) [358.086823] Subtest flip-vs-panning: SUCCESS (34.902s) [359.263039] [028/156] (742s left) syncobj_timeline (multi-wait-for-submit-unsubmitted-signaled) [359.318525] Starting subtest: multi-wait-for-submit-unsubmitted-signaled [359.321258] Subtest multi-wait-for-submit-unsubmitted-signaled: SUCCESS (0.000s) [359.422475] [029/156] (742s left) kms_lease (lease-invalid-connector) [359.522420] Starting subtest: lease-invalid-connector [359.524970] Starting dynamic subtest: pipe-A-eDP-1 [359.527660] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s) [359.538668] Starting dynamic subtest: pipe-B-eDP-1 [359.541066] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s) [359.551337] Starting dynamic subtest: pipe-C-eDP-1 [359.553798] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s) [359.563646] Starting dynamic subtest: pipe-D-eDP-1 [359.566361] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s) [359.568781] Subtest lease-invalid-connector: SUCCESS (0.003s) [359.611208] [030/156] (742s left) gem_ctx_isolation (preservation-s3) [359.676515] Starting subtest: preservation-S3 [359.679078] Starting dynamic subtest: rcs0 [376.322564] Dynamic subtest rcs0: SUCCESS (1.300s) [376.333308] Starting dynamic subtest: bcs0 [392.320885] Dynamic subtest bcs0: SUCCESS (1.282s) [392.334246] Starting dynamic subtest: vcs0 [408.328388] Dynamic subtest vcs0: SUCCESS (2.532s) [408.340271] Starting dynamic subtest: vcs1 [426.336879] Dynamic subtest vcs1: SUCCESS (5.012s) [426.349071] Starting dynamic subtest: vecs0 [444.331320] Dynamic subtest vecs0: SUCCESS (4.969s) [444.345216] Starting dynamic subtest: ccs0 [462.317001] Dynamic subtest ccs0: SUCCESS (3.171s) [462.319953] Subtest preservation-S3: SUCCESS (18.271s) [462.543805] [031/156] (639s left) i915_drm_fdinfo (idle) [462.591163] Starting subtest: idle [462.593512] Starting dynamic subtest: rcs0 [463.118905] Dynamic subtest rcs0: SUCCESS (0.528s) [463.132919] Starting dynamic subtest: bcs0 [463.653807] Dynamic subtest bcs0: SUCCESS (0.530s) [463.665903] Starting dynamic subtest: vcs0 [464.161219] Dynamic subtest vcs0: SUCCESS (0.503s) [464.173940] Starting dynamic subtest: vcs1 [464.667230] Dynamic subtest vcs1: SUCCESS (0.503s) [464.680682] Starting dynamic subtest: vecs0 [465.176745] Dynamic subtest vecs0: SUCCESS (0.503s) [465.188431] Starting dynamic subtest: ccs0 [465.679263] Dynamic subtest ccs0: SUCCESS (0.503s) [465.682079] Subtest idle: SUCCESS (3.084s) [465.760093] [032/156] (636s left) gem_ringfill (basic-all) [471.071577] Starting subtest: basic-all [472.254949] Subtest basic-all: SUCCESS (1.182s) [472.377887] [033/156] (630s left) kms_cdclk (plane-scaling) [472.473711] Starting subtest: plane-scaling [472.476245] Starting dynamic subtest: pipe-A-eDP-1 [472.764687] Dynamic subtest pipe-A-eDP-1: SKIP (0.288s) [472.777669] Starting dynamic subtest: pipe-B-eDP-1 [472.782826] Dynamic subtest pipe-B-eDP-1: SKIP (0.002s) [472.793791] Starting dynamic subtest: pipe-C-eDP-1 [472.799417] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s) [472.809933] Starting dynamic subtest: pipe-D-eDP-1 [472.815599] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s) [472.820736] Subtest plane-scaling: SKIP (0.296s) [473.616028] [034/156] (628s left) perf_pmu (interrupts) [473.659907] Starting subtest: interrupts [474.723646] Subtest interrupts: SUCCESS (1.067s) [474.843508] [035/156] (627s left) syncobj_wait (multi-wait-all-for-submit-unsubmitted) [474.892774] Starting subtest: multi-wait-all-for-submit-unsubmitted [474.999960] Subtest multi-wait-all-for-submit-unsubmitted: SUCCESS (0.107s) [475.079901] [036/156] (627s left) kms_ccs (crc-primary-suspend-4-tiled-dg2-rc-ccs) [475.174904] Starting subtest: crc-primary-suspend-4-tiled-dg2-rc-ccs [475.177682] Starting dynamic subtest: pipe-A-eDP-1 [475.188618] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [475.202701] Starting dynamic subtest: pipe-B-eDP-1 [475.213917] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [475.224912] Starting dynamic subtest: pipe-C-eDP-1 [475.235678] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [475.246037] Starting dynamic subtest: pipe-D-eDP-1 [475.257216] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [475.262804] Subtest crc-primary-suspend-4-tiled-dg2-rc-ccs: SKIP (0.004s) [477.476829] [037/156] (625s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-scndscrn-spr-indfb-draw-mmap-cpu) [477.577300] Starting subtest: fbcpsrhdr-2p-scndscrn-spr-indfb-draw-mmap-cpu [477.582521] Subtest fbcpsrhdr-2p-scndscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s) [477.660226] [038/156] (624s left) i915_pm_rps (fence-order) [477.725786] Starting subtest: fence-order [480.693742] Subtest fence-order: SUCCESS (2.963s) [480.806761] [039/156] (621s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-pwrite) [480.900712] Starting subtest: psr-1p-primscrn-spr-indfb-draw-pwrite [487.856636] Subtest psr-1p-primscrn-spr-indfb-draw-pwrite: SUCCESS (6.959s) [487.998054] [040/156] (614s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-fullscreen) [488.106611] Starting subtest: fbc-2p-scndscrn-spr-indfb-fullscreen [488.111827] Subtest fbc-2p-scndscrn-spr-indfb-fullscreen: SKIP (0.000s) [488.223758] [041/156] (614s left) kms_joiner (basic-force-ultra-joiner) [488.323681] Starting subtest: basic-force-ultra-joiner [488.328796] Subtest basic-force-ultra-joiner: SKIP (0.000s) [488.392463] [042/156] (614s left) kms_big_fb (linear-max-hw-stride-32bpp-rotate-0) [488.485819] Starting subtest: linear-max-hw-stride-32bpp-rotate-0 [489.171826] Subtest linear-max-hw-stride-32bpp-rotate-0: FAIL (0.032s) [489.214442] [043/156] (613s left) kms_pm_backlight (fade-with-dpms) [489.308409] Starting subtest: fade-with-dpms [491.595895] Starting dynamic subtest: eDP-1 [494.588909] Dynamic subtest eDP-1: SUCCESS (2.993s) [494.591485] Subtest fade-with-dpms: SUCCESS (5.280s) [495.481509] [044/156] (607s left) prime_self_import (basic-with_fd_dup) [495.527822] Starting subtest: basic-with_fd_dup [495.552923] Subtest basic-with_fd_dup: SUCCESS (0.028s) [495.643804] [045/156] (607s left) gem_ctx_persistence (hostile) [495.698904] Starting subtest: hostile [498.333785] Subtest hostile: SUCCESS (2.629s) [498.466023] [046/156] (604s left) gem_ppgtt (shrink-vs-evict-any) [498.528812] Starting subtest: shrink-vs-evict-any [504.053486] Subtest shrink-vs-evict-any: SUCCESS (5.520s) [504.149021] [047/156] (598s left) gem_userptr_blits (mmap-offset-banned) [504.207933] Starting subtest: mmap-offset-banned [504.210690] Starting dynamic subtest: wb [504.213463] Dynamic subtest wb: SUCCESS (0.000s) [504.225479] Starting dynamic subtest: wc [504.227689] Dynamic subtest wc: SUCCESS (0.000s) [504.239209] Starting dynamic subtest: uc [504.241321] Dynamic subtest uc: SUCCESS (0.000s) [504.243474] Subtest mmap-offset-banned: SUCCESS (0.002s) [504.351404] [048/156] (598s left) gem_exec_balancer (bonded-chain) [504.402680] Starting subtest: bonded-chain [511.442923] Subtest bonded-chain: SUCCESS (7.036s) [511.757948] [049/156] (591s left) kms_setmode (basic-clone-single-crtc) [511.809827] Starting subtest: basic-clone-single-crtc [511.817592] Subtest basic-clone-single-crtc: SKIP (0.000s) [511.901054] [050/156] (591s left) syncobj_timeline (etime-single-wait-for-submit-submitted) [511.961859] Starting subtest: etime-single-wait-for-submit-submitted [512.063671] Subtest etime-single-wait-for-submit-submitted: SUCCESS (0.104s) [512.145274] [051/156] (591s left) kms_cursor_legacy (cursora-vs-flipb-toggle) [512.269458] Starting subtest: cursorA-vs-flipB-toggle [512.274684] Subtest cursorA-vs-flipB-toggle: SKIP (0.001s) [512.417003] [052/156] (590s left) dumb_buffer (create-valid-dumb) [512.466740] Starting subtest: create-valid-dumb [512.469128] Subtest create-valid-dumb: SUCCESS (0.000s) [512.575711] [053/156] (590s left) kms_frontbuffer_tracking (fbcpsrhdr-slowdraw) [512.682644] Starting subtest: fbcpsrhdr-slowdraw [512.686762] Subtest fbcpsrhdr-slowdraw: SKIP (0.000s) [512.780275] [054/156] (590s left) kms_scaling_modes (scaling-mode-none) [512.866964] Starting subtest: scaling-mode-none [512.869696] Starting dynamic subtest: pipe-A-eDP-1 [512.963908] Dynamic subtest pipe-A-eDP-1: SKIP (0.096s) [512.976611] Starting dynamic subtest: pipe-B-eDP-1 [513.007117] Dynamic subtest pipe-B-eDP-1: SKIP (0.039s) [513.017784] Starting dynamic subtest: pipe-C-eDP-1 [513.041433] Dynamic subtest pipe-C-eDP-1: SKIP (0.032s) [513.052464] Starting dynamic subtest: pipe-D-eDP-1 [513.075152] Dynamic subtest pipe-D-eDP-1: SKIP (0.033s) [513.079101] Subtest scaling-mode-none: SKIP (0.209s) [513.193023] [055/156] (590s left) syncobj_timeline (wait-any-interrupted) [513.247825] Starting subtest: wait-any-interrupted [513.350472] Subtest wait-any-interrupted: SUCCESS (0.103s) [513.429841] [056/156] (589s left) gem_render_copy_redux (normal) [513.480597] Starting subtest: normal [513.756937] Subtest normal: SUCCESS (0.272s) [513.881581] [057/156] (589s left) kms_frontbuffer_tracking (hdr-1p-primscrn-cur-indfb-move) [513.979792] Starting subtest: hdr-1p-primscrn-cur-indfb-move [513.984710] Subtest hdr-1p-primscrn-cur-indfb-move: SKIP (0.000s) [514.073345] [058/156] (589s left) kms_frontbuffer_tracking (fbchdr-1p-primscrn-indfb-msflip-blt) [514.173229] Starting subtest: fbchdr-1p-primscrn-indfb-msflip-blt [514.178394] Subtest fbchdr-1p-primscrn-indfb-msflip-blt: SKIP (0.000s) [514.258691] [059/156] (589s left) kms_frontbuffer_tracking (fbchdr-2p-primscrn-shrfb-msflip-blt) [514.357705] Starting subtest: fbchdr-2p-primscrn-shrfb-msflip-blt [514.362781] Subtest fbchdr-2p-primscrn-shrfb-msflip-blt: SKIP (0.000s) [514.443636] [060/156] (589s left) gem_mmap (bad-offset) [514.497799] Subtest bad-offset: SKIP (0.000s) [514.555009] [061/156] (589s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-pwrite) [514.649173] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-pwrite [514.652809] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-pwrite: SKIP (0.000s) [514.744279] [062/156] (588s left) kms_frontbuffer_tracking (fbc-rgb565-draw-render) [514.846196] Starting subtest: fbc-rgb565-draw-render [519.113506] Subtest fbc-rgb565-draw-render: SUCCESS (4.270s) [520.299050] [063/156] (583s left) kms_plane_scaling (planes-downscale-factor-0-5-upscale-20x20) [520.391740] Starting subtest: planes-downscale-factor-0-5-upscale-20x20 [520.394700] Starting dynamic subtest: pipe-A [520.412637] Dynamic subtest pipe-A: SKIP (0.019s) [520.424372] Starting dynamic subtest: pipe-B [520.447297] Dynamic subtest pipe-B: SKIP (0.032s) [520.458389] Starting dynamic subtest: pipe-C [520.480934] Dynamic subtest pipe-C: SKIP (0.033s) [520.491840] Starting dynamic subtest: pipe-D [520.514845] Dynamic subtest pipe-D: SKIP (0.033s) [520.519743] Subtest planes-downscale-factor-0-5-upscale-20x20: SKIP (0.120s) [520.608784] [064/156] (583s left) gem_tiled_partial_pwrite_pread (writes) [520.670693] Subtest writes: SKIP (0.000s) [520.739947] [065/156] (583s left) gem_userptr_blits (map-fixed-invalidate-overlap-busy) [520.806921] Starting subtest: map-fixed-invalidate-overlap-busy [520.812345] Subtest map-fixed-invalidate-overlap-busy: SKIP (0.000s) [520.930586] [066/156] (582s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-blt) [521.030773] Starting subtest: fbc-rgb101010-draw-blt [523.530182] Subtest fbc-rgb101010-draw-blt: SUCCESS (2.506s) [524.714977] [067/156] (579s left) gem_exec_reloc (basic-cpu-gtt) [524.776786] Subtest basic-cpu-gtt: SKIP (0.000s) [524.857900] [068/156] (579s left) perf_pmu (rc6) [524.891719] Starting subtest: rc6 [524.894892] Starting dynamic subtest: gt0 [531.272937] Dynamic subtest gt0: SUCCESS (6.376s) [531.288895] Starting dynamic subtest: runtime-pm-gt0 [538.990747] Dynamic subtest runtime-pm-gt0: SUCCESS (7.713s) [539.005647] Starting dynamic subtest: runtime-pm-long-gt0 [551.442248] Dynamic subtest runtime-pm-long-gt0: SUCCESS (12.443s) [551.453947] Starting dynamic subtest: other-idle-gt0 [557.788463] Dynamic subtest other-idle-gt0: SUCCESS (6.342s) [557.800656] Starting dynamic subtest: gt1 [564.131474] Dynamic subtest gt1: SUCCESS (6.346s) [564.145952] Starting dynamic subtest: runtime-pm-gt1 [571.572822] Dynamic subtest runtime-pm-gt1: SUCCESS (7.444s) [571.586589] Starting dynamic subtest: runtime-pm-long-gt1 [584.068057] Dynamic subtest runtime-pm-long-gt1: SUCCESS (12.498s) [584.082185] Starting dynamic subtest: other-idle-gt1 [590.410782] Dynamic subtest other-idle-gt1: SUCCESS (6.342s) [590.413602] Subtest rc6: SUCCESS (65.523s) [591.712516] [069/156] (512s left) kms_frontbuffer_tracking (psrhdr-1p-offscreen-pri-shrfb-draw-mmap-gtt) [591.815689] Starting subtest: psrhdr-1p-offscreen-pri-shrfb-draw-mmap-gtt [591.820480] Subtest psrhdr-1p-offscreen-pri-shrfb-draw-mmap-gtt: SKIP (0.000s) [591.875055] [070/156] (512s left) kms_cursor_crc (cursor-random-512x512) [592.149321] Starting subtest: cursor-random-512x512 [592.153436] Subtest cursor-random-512x512: SKIP (0.001s) [592.270297] [071/156] (511s left) gem_exec_params (invalid-bsd2-flag-on-render) [592.317516] Starting subtest: invalid-bsd2-flag-on-render [592.320117] Subtest invalid-bsd2-flag-on-render: SUCCESS (0.000s) [592.394148] [072/156] (511s left) gem_userptr_blits (dmabuf-unsync) [592.453665] Subtest dmabuf-unsync: SKIP (0.000s) [592.548338] [073/156] (511s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-primscrn-pri-shrfb-draw-mmap-cpu) [592.648376] Starting subtest: fbcpsrhdr-2p-primscrn-pri-shrfb-draw-mmap-cpu [592.652381] Subtest fbcpsrhdr-2p-primscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s) [592.716493] [074/156] (511s left) kms_frontbuffer_tracking (fbchdr-1p-shrfb-fliptrack-mmap-gtt) [592.815159] Starting subtest: fbchdr-1p-shrfb-fliptrack-mmap-gtt [592.818970] Subtest fbchdr-1p-shrfb-fliptrack-mmap-gtt: SKIP (0.000s) [592.886343] [075/156] (511s left) kms_pipe_stress (stress-xrgb8888-4tiled) [592.980964] Starting subtest: stress-xrgb8888-4tiled [598.951910] Subtest stress-xrgb8888-4tiled: SUCCESS (5.975s) [599.010337] [076/156] (505s left) kms_frontbuffer_tracking (fbcpsr-1p-rte) [599.103855] Starting subtest: fbcpsr-1p-rte [606.094928] Subtest fbcpsr-1p-rte: SUCCESS (6.997s) [606.207674] [077/156] (498s left) core_auth (getclient-master-drop) [606.245828] Starting subtest: getclient-master-drop [606.264745] Subtest getclient-master-drop: SUCCESS (0.020s) [606.338071] [078/156] (498s left) gem_workarounds (suspend-resume) [606.395380] Starting subtest: suspend-resume [622.300780] Subtest suspend-resume: SUCCESS (1.163s) [622.411459] [079/156] (482s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-scndscrn-indfb-pgflip-blt) [622.522614] Starting subtest: fbcpsrhdr-2p-scndscrn-indfb-pgflip-blt [622.528099] Subtest fbcpsrhdr-2p-scndscrn-indfb-pgflip-blt: SKIP (0.000s) [622.621627] [080/156] (481s left) gem_exec_suspend (basic-s3) [622.688929] Starting subtest: basic-S3 [622.691408] Starting dynamic subtest: smem [642.273905] Dynamic subtest smem: SUCCESS (6.142s) [642.276830] Subtest basic-S3: SUCCESS (6.145s) [642.437319] [081/156] (462s left) kms_ccs (missing-ccs-buffer-y-tiled-gen12-mc-ccs) [642.540903] Starting subtest: missing-ccs-buffer-y-tiled-gen12-mc-ccs [642.543554] Starting dynamic subtest: pipe-A-eDP-1 [642.568670] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [642.583654] Starting dynamic subtest: pipe-B-eDP-1 [642.606762] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [642.617425] Starting dynamic subtest: pipe-C-eDP-1 [642.640271] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [642.650676] Starting dynamic subtest: pipe-D-eDP-1 [642.674689] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [642.678909] Subtest missing-ccs-buffer-y-tiled-gen12-mc-ccs: SKIP (0.005s) [644.821529] [082/156] (459s left) kms_ccs (crc-primary-basic-4-tiled-dg2-rc-ccs) [644.917676] Starting subtest: crc-primary-basic-4-tiled-dg2-rc-ccs [644.920698] Starting dynamic subtest: pipe-A-eDP-1 [644.948510] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [644.960782] Starting dynamic subtest: pipe-B-eDP-1 [644.986805] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [644.997767] Starting dynamic subtest: pipe-C-eDP-1 [645.022737] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [645.033544] Starting dynamic subtest: pipe-D-eDP-1 [645.059700] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [645.065653] Subtest crc-primary-basic-4-tiled-dg2-rc-ccs: SKIP (0.006s) [647.183030] [083/156] (457s left) sysfs_timeslice_duration (invalid) [647.242227] Starting subtest: invalid [647.244730] Starting dynamic subtest: vecs0 [647.247471] Dynamic subtest vecs0: SUCCESS (0.000s) [647.258983] Starting dynamic subtest: ccs0 [647.261414] Dynamic subtest ccs0: SUCCESS (0.000s) [647.271853] Starting dynamic subtest: vcs0 [647.274211] Dynamic subtest vcs0: SUCCESS (0.000s) [647.288599] Starting dynamic subtest: bcs0 [647.291183] Dynamic subtest bcs0: SUCCESS (0.000s) [647.303144] Starting dynamic subtest: rcs0 [647.305692] Dynamic subtest rcs0: SUCCESS (0.000s) [647.316813] Starting dynamic subtest: vcs1 [647.319776] Dynamic subtest vcs1: SUCCESS (0.000s) [647.322655] Subtest invalid: SUCCESS (0.006s) [647.365452] [084/156] (457s left) gem_softpin (reverse) [647.426904] Starting subtest: reverse [647.429950] Subtest reverse: SUCCESS (0.005s) [647.520024] [085/156] (457s left) gem_exercise_blt (fast-copy) [647.574202] Starting subtest: fast-copy [647.576890] Starting dynamic subtest: linear-smem-smem [647.597425] Dynamic subtest linear-smem-smem: SUCCESS (0.023s) [647.610483] Starting dynamic subtest: xmajor-smem-smem [647.616498] Dynamic subtest xmajor-smem-smem: SUCCESS (0.017s) [647.630934] Starting dynamic subtest: tile4-smem-smem [647.633734] Dynamic subtest tile4-smem-smem: SUCCESS (0.017s) [647.645890] Starting dynamic subtest: tile64-smem-smem [647.651795] Dynamic subtest tile64-smem-smem: SUCCESS (0.017s) [647.654750] Subtest fast-copy: SUCCESS (0.077s) [647.739123] [086/156] (457s left) kms_dsc (dsc-fractional-bpp-with-bpc) [647.832734] Starting subtest: dsc-fractional-bpp-with-bpc [647.868523] Subtest dsc-fractional-bpp-with-bpc: SKIP (0.001s) [647.911200] [087/156] (456s left) kms_cursor_legacy (forked-move) [648.035592] Starting subtest: forked-move [648.037951] Starting dynamic subtest: pipe-A [653.513104] Dynamic subtest pipe-A: SUCCESS (5.469s) [653.526498] Starting dynamic subtest: pipe-B [658.998704] Dynamic subtest pipe-B: SUCCESS (5.479s) [659.022449] Starting dynamic subtest: pipe-C [664.479512] Dynamic subtest pipe-C: SUCCESS (5.475s) [664.499087] Starting dynamic subtest: pipe-D [669.968161] Dynamic subtest pipe-D: SUCCESS (5.484s) [669.985562] Starting dynamic subtest: all-pipes [675.461823] Dynamic subtest all-pipes: SUCCESS (5.491s) [675.464427] Subtest forked-move: SUCCESS (27.410s) [675.591274] [088/156] (429s left) kms_psr (fbc-pr-primary-mmap-gtt) [675.696652] Starting subtest: fbc-pr-primary-mmap-gtt [675.701482] Subtest fbc-pr-primary-mmap-gtt: SKIP (0.000s) [675.749192] [089/156] (429s left) kms_cursor_crc (cursor-onscreen-512x512) [676.027613] Starting subtest: cursor-onscreen-512x512 [676.032411] Subtest cursor-onscreen-512x512: SKIP (0.001s) [676.153202] [090/156] (428s left) perf (invalid-create-userspace-config) [676.245961] Starting subtest: invalid-create-userspace-config [676.248787] Subtest invalid-create-userspace-config: SUCCESS (0.001s) [676.299111] [091/156] (428s left) kms_pm_rpm (system-suspend-modeset) [678.428272] Starting subtest: system-suspend-modeset [697.838468] Subtest system-suspend-modeset: SUCCESS (4.608s) [698.216474] [092/156] (406s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-primscrn-cur-indfb-draw-mmap-cpu) [698.329907] Starting subtest: fbcpsrhdr-1p-primscrn-cur-indfb-draw-mmap-cpu [698.335145] Subtest fbcpsrhdr-1p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s) [698.416191] [093/156] (406s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-180) [698.514365] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-180 [699.553650] Subtest x-tiled-max-hw-stride-64bpp-rotate-180: SUCCESS (1.037s) [699.657196] [094/156] (405s left) kms_frontbuffer_tracking (hdr-2p-scndscrn-shrfb-pgflip-blt) [699.748870] Starting subtest: hdr-2p-scndscrn-shrfb-pgflip-blt [699.753794] Subtest hdr-2p-scndscrn-shrfb-pgflip-blt: SKIP (0.000s) [699.835283] [095/156] (405s left) i915_pm_freq_mult (media-freq) [699.884021] Starting subtest: media-freq [699.886861] Starting dynamic subtest: gt0 [699.891655] Dynamic subtest gt0: SKIP (0.000s) [699.903480] Starting dynamic subtest: gt1 [699.908118] Dynamic subtest gt1: SKIP (0.000s) [699.911889] Subtest media-freq: SKIP (0.001s) [699.960063] [096/156] (405s left) gem_ctx_engines (invalid-engines) [700.021473] Starting subtest: invalid-engines [700.029915] Subtest invalid-engines: SUCCESS (0.009s) [700.234590] [097/156] (405s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-rte) [700.349546] Starting subtest: fbcpsrhdr-1p-rte [700.354798] Subtest fbcpsrhdr-1p-rte: SKIP (0.000s) [700.417612] [098/156] (404s left) kms_big_fb (x-tiled-16bpp-rotate-180) [700.524615] Starting subtest: x-tiled-16bpp-rotate-180 [701.871608] Subtest x-tiled-16bpp-rotate-180: SUCCESS (1.346s) [701.974253] [099/156] (403s left) kms_vblank (ts-continuation-modeset-hang) [702.071386] Starting subtest: ts-continuation-modeset-hang [702.073409] Starting dynamic subtest: pipe-A-eDP-1 [728.814552] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.726s) [728.833563] Starting dynamic subtest: pipe-D-eDP-1 [753.772893] Dynamic subtest pipe-D-eDP-1: SUCCESS (24.959s) [753.775543] Subtest ts-continuation-modeset-hang: SUCCESS (51.689s) [754.647686] [100/156] (350s left) kms_pm_lpsp (screens-disabled) [755.752901] Starting subtest: screens-disabled [755.757805] Subtest screens-disabled: SKIP (0.000s) [755.801679] [101/156] (349s left) kms_addfb_basic (invalid-set-prop-any) [755.852867] Starting subtest: invalid-set-prop-any [755.855784] Subtest invalid-set-prop-any: SUCCESS (0.000s) [755.962852] [102/156] (349s left) kms_psr (fbc-pr-sprite-render) [756.048899] Starting subtest: fbc-pr-sprite-render [756.053713] Subtest fbc-pr-sprite-render: SKIP (0.000s) [756.099778] [103/156] (349s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-offscreen-pri-shrfb-draw-render) [756.201619] Starting subtest: fbcpsrhdr-1p-offscreen-pri-shrfb-draw-render [756.206487] Subtest fbcpsrhdr-1p-offscreen-pri-shrfb-draw-render: SKIP (0.000s) [756.276262] [104/156] (349s left) kms_busy (basic-hang) [756.378233] Starting subtest: basic-hang [756.380633] Starting dynamic subtest: flip-pipe-A [756.994610] Dynamic subtest flip-pipe-A: SUCCESS (0.615s) [757.007133] Starting dynamic subtest: modeset-pipe-A [760.405565] Dynamic subtest modeset-pipe-A: SUCCESS (3.410s) [760.418847] Starting dynamic subtest: flip-pipe-D [761.637579] Dynamic subtest flip-pipe-D: SUCCESS (1.229s) [761.650961] Starting dynamic subtest: modeset-pipe-D [765.040032] Dynamic subtest modeset-pipe-D: SUCCESS (3.402s) [765.042888] Subtest basic-hang: SUCCESS (8.662s) [765.924464] [105/156] (339s left) kms_chamelium_frames (vga-frame-dump) [766.318339] Subtest vga-frame-dump: SKIP (0.000s) [767.162706] [106/156] (338s left) kms_frontbuffer_tracking (psrhdr-1p-offscreen-pri-indfb-draw-blt) [767.276729] Starting subtest: psrhdr-1p-offscreen-pri-indfb-draw-blt [767.281912] Subtest psrhdr-1p-offscreen-pri-indfb-draw-blt: SKIP (0.000s) [767.373349] [107/156] (338s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-mmap-gtt) [767.481457] Starting subtest: fbcpsr-rgb565-draw-mmap-gtt [767.486739] Subtest fbcpsr-rgb565-draw-mmap-gtt: SKIP (0.000s) [767.572892] [108/156] (338s left) gem_exec_params (secure-non-root) [767.638392] Starting subtest: secure-non-root [767.643862] Subtest secure-non-root: SKIP (0.000s) [767.723600] [109/156] (338s left) kms_cursor_legacy (cursor-vs-flip-toggle) [767.844547] Starting subtest: cursor-vs-flip-toggle [799.159412] Subtest cursor-vs-flip-toggle: SUCCESS (31.311s) [799.995785] [110/156] (305s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-blt) [800.100608] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-blt [800.105703] Subtest psr-2p-scndscrn-pri-indfb-draw-blt: SKIP (0.000s) [800.161172] [111/156] (305s left) gem_render_copy (x-tiled-to-vebox-y-tiled) [800.219921] Starting subtest: x-tiled-to-vebox-y-tiled [800.224836] Subtest x-tiled-to-vebox-y-tiled: SKIP (0.000s) [800.383649] [112/156] (305s left) kms_frontbuffer_tracking (psrhdr-2p-scndscrn-spr-indfb-draw-blt) [800.474535] Starting subtest: psrhdr-2p-scndscrn-spr-indfb-draw-blt [800.479370] Subtest psrhdr-2p-scndscrn-spr-indfb-draw-blt: SKIP (0.000s) [800.544792] [113/156] (305s left) kms_plane_multiple (2x-tiling-yf) [800.638714] Starting subtest: 2x-tiling-yf [800.644486] Subtest 2x-tiling-yf: SKIP (0.000s) [800.695620] [114/156] (305s left) gem_mmap_offset (perf) [800.750571] Starting subtest: perf [800.753371] Starting dynamic subtest: smem0 [801.117477] Dynamic subtest smem0: SUCCESS (0.367s) [801.120150] Subtest perf: SUCCESS (0.368s) [801.208717] [115/156] (304s left) kms_psr (psr2-suspend) [801.296703] Starting subtest: psr2-suspend [801.299499] Starting dynamic subtest: eDP-1 [818.718912] Dynamic subtest eDP-1: SUCCESS (2.868s) [818.721829] Subtest psr2-suspend: SUCCESS (2.869s) [819.598712] [116/156] (286s left) kms_chamelium_hpd (vga-hpd) [819.987836] Subtest vga-hpd: SKIP (0.000s) [820.808673] [117/156] (285s left) perf (oa-exponents) [820.876190] Starting subtest: oa-exponents [820.878994] Starting dynamic subtest: 0-rcs0 [822.660739] Dynamic subtest 0-rcs0: SUCCESS (1.784s) [822.676441] Starting dynamic subtest: 1-vcs0 [824.487515] Dynamic subtest 1-vcs0: SUCCESS (1.827s) [824.490030] Subtest oa-exponents: SUCCESS (3.613s) [824.543895] [118/156] (281s left) syncobj_timeline (multi-wait-all-for-submit-signaled) [824.601321] Starting subtest: multi-wait-all-for-submit-signaled [824.604039] Subtest multi-wait-all-for-submit-signaled: SUCCESS (0.000s) [824.678597] [119/156] (281s left) kms_frontbuffer_tracking (hdr-2p-scndscrn-pri-shrfb-draw-render) [824.774593] Starting subtest: hdr-2p-scndscrn-pri-shrfb-draw-render [824.779464] Subtest hdr-2p-scndscrn-pri-shrfb-draw-render: SKIP (0.000s) [824.837239] [120/156] (281s left) drm_read (empty-nonblock) [824.984221] Starting subtest: empty-nonblock [824.987041] Subtest empty-nonblock: SUCCESS (0.000s) [825.114087] [121/156] (281s left) gem_exec_whisper (basic-contexts-priority-all) [825.176914] Starting subtest: basic-contexts-priority-all [849.484873] Subtest basic-contexts-priority-all: SUCCESS (24.304s) [849.653046] [122/156] (256s left) kms_frontbuffer_tracking (fbchdr-2p-scndscrn-shrfb-pgflip-blt) [849.758960] Starting subtest: fbchdr-2p-scndscrn-shrfb-pgflip-blt [849.764021] Subtest fbchdr-2p-scndscrn-shrfb-pgflip-blt: SKIP (0.000s) [849.832763] [123/156] (256s left) kms_psr2_sf (fbc-pr-cursor-plane-move-continuous-sf) [849.932790] Starting subtest: fbc-pr-cursor-plane-move-continuous-sf [849.937876] Subtest fbc-pr-cursor-plane-move-continuous-sf: SKIP (0.000s) [849.981298] [124/156] (256s left) gem_sync (basic-each) [850.050062] Starting subtest: basic-each [852.376283] Subtest basic-each: SUCCESS (2.339s) [852.543597] [125/156] (254s left) kms_psr2_sf (pr-plane-move-sf-dmg-area) [852.645136] Starting subtest: pr-plane-move-sf-dmg-area [852.650484] Subtest pr-plane-move-sf-dmg-area: SKIP (0.000s) [852.692896] [126/156] (253s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-mmap-cpu) [852.790278] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-mmap-cpu [857.139661] Subtest fbc-1p-primscrn-pri-indfb-draw-mmap-cpu: SUCCESS (4.355s) [858.331380] [127/156] (248s left) gem_exec_params (rs-invalid) [858.382800] Starting subtest: rs-invalid [858.388884] Subtest rs-invalid: SUCCESS (0.003s) [858.479385] [128/156] (248s left) kms_ccs (bad-aux-stride-y-tiled-gen12-rc-ccs) [858.574744] Starting subtest: bad-aux-stride-y-tiled-gen12-rc-ccs [858.577407] Starting dynamic subtest: pipe-A-eDP-1 [858.603997] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [858.617716] Starting dynamic subtest: pipe-B-eDP-1 [858.643114] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [858.654296] Starting dynamic subtest: pipe-C-eDP-1 [858.680430] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [858.691804] Starting dynamic subtest: pipe-D-eDP-1 [858.718161] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [858.723305] Subtest bad-aux-stride-y-tiled-gen12-rc-ccs: SKIP (0.005s) [860.881053] [129/156] (245s left) kms_flip (flip-vs-rmfb-interruptible) [860.978002] Starting subtest: flip-vs-rmfb-interruptible [860.981138] Starting dynamic subtest: A-eDP1 [869.690374] Dynamic subtest A-eDP1: SUCCESS (8.712s) [869.704617] Starting dynamic subtest: B-eDP1 [878.314665] Dynamic subtest B-eDP1: SUCCESS (8.623s) [878.329795] Starting dynamic subtest: C-eDP1 [886.939293] Dynamic subtest C-eDP1: SUCCESS (8.620s) [886.951880] Starting dynamic subtest: D-eDP1 [895.570886] Dynamic subtest D-eDP1: SUCCESS (8.629s) [895.573360] Subtest flip-vs-rmfb-interruptible: SUCCESS (34.595s) [896.741730] [130/156] (210s left) kms_getfb (getfb-handle-protection) [896.838517] Starting subtest: getfb-handle-protection [896.863904] Subtest getfb-handle-protection: SUCCESS (0.027s) [896.968535] [131/156] (209s left) kms_flip_scaled_crc (flip-64bpp-yftile-to-32bpp-yftile-upscaling) [897.070783] Starting subtest: flip-64bpp-yftile-to-32bpp-yftile-upscaling [897.075862] Subtest flip-64bpp-yftile-to-32bpp-yftile-upscaling: SKIP (0.000s) [897.122024] [132/156] (209s left) kms_frontbuffer_tracking (hdr-2p-primscrn-pri-shrfb-draw-render) [897.222630] Starting subtest: hdr-2p-primscrn-pri-shrfb-draw-render [897.227739] Subtest hdr-2p-primscrn-pri-shrfb-draw-render: SKIP (0.000s) [897.298620] [133/156] (209s left) kms_atomic (plane-immutable-zpos) [897.389933] Starting subtest: plane-immutable-zpos [897.392697] Starting dynamic subtest: pipe-A-eDP-1 [898.044044] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.653s) [898.046923] Subtest plane-immutable-zpos: SUCCESS (0.654s) [898.872309] [134/156] (208s left) gem_userptr_blits (input-checking) [898.940862] Starting subtest: input-checking [898.943282] Subtest input-checking: SUCCESS (0.000s) [899.035372] [135/156] (207s left) prime_vgem (sync) [899.100351] Starting subtest: sync [899.102850] Starting dynamic subtest: rcs0 [899.165710] Dynamic subtest rcs0: SUCCESS (0.068s) [899.177056] Starting dynamic subtest: bcs0 [899.233779] Dynamic subtest bcs0: SUCCESS (0.067s) [899.245585] Starting dynamic subtest: vcs0 [899.282990] Dynamic subtest vcs0: SUCCESS (0.048s) [899.294796] Starting dynamic subtest: vcs1 [899.328341] Dynamic subtest vcs1: SUCCESS (0.044s) [899.340384] Starting dynamic subtest: vecs0 [899.377237] Dynamic subtest vecs0: SUCCESS (0.048s) [899.389225] Starting dynamic subtest: ccs0 [899.426323] Dynamic subtest ccs0: SUCCESS (0.048s) [899.428817] Subtest sync: SUCCESS (0.329s) [899.524760] [136/156] (207s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-shrfb-draw-mmap-cpu) [899.632644] Starting subtest: fbc-1p-offscreen-pri-shrfb-draw-mmap-cpu [903.632917] Subtest fbc-1p-offscreen-pri-shrfb-draw-mmap-cpu: SUCCESS (4.007s) [904.797528] [137/156] (202s left) gem_exec_schedule (manyslice) [904.872514] Starting subtest: manyslice [904.875017] Starting dynamic subtest: rcs0 [909.999468] Dynamic subtest rcs0: SUCCESS (5.139s) [910.015343] Starting dynamic subtest: bcs0 [917.667955] Dynamic subtest bcs0: SUCCESS (7.666s) [917.682507] Starting dynamic subtest: vcs0 [922.763145] Dynamic subtest vcs0: SUCCESS (5.094s) [922.781837] Starting dynamic subtest: vcs1 [928.877916] Dynamic subtest vcs1: SUCCESS (6.111s) [928.892860] Starting dynamic subtest: vecs0 [934.978606] Dynamic subtest vecs0: SUCCESS (6.099s) [934.997318] Starting dynamic subtest: ccs0 [941.167183] Dynamic subtest ccs0: SUCCESS (6.183s) [941.169851] Subtest manyslice: SUCCESS (36.303s) [941.449746] [138/156] (165s left) i915_suspend (basic-s3-without-i915) [941.485762] Starting subtest: basic-s3-without-i915 [944.090664] Subtest basic-s3-without-i915: SKIP (2.601s) [946.483955] [139/156] (160s left) gem_exec_schedule (u-fairslice) [946.572481] Starting subtest: u-fairslice [946.574848] Starting dynamic subtest: rcs0 [948.597319] Dynamic subtest rcs0: SUCCESS (2.032s) [948.608892] Starting dynamic subtest: bcs0 [950.619751] Dynamic subtest bcs0: SUCCESS (2.021s) [950.631687] Starting dynamic subtest: vcs0 [952.649364] Dynamic subtest vcs0: SUCCESS (2.027s) [952.671271] Starting dynamic subtest: vcs1 [954.667020] Dynamic subtest vcs1: SUCCESS (2.018s) [954.677541] Starting dynamic subtest: vecs0 [956.688994] Dynamic subtest vecs0: SUCCESS (2.020s) [956.704034] Starting dynamic subtest: ccs0 [958.721802] Dynamic subtest ccs0: SUCCESS (2.031s) [958.724674] Subtest u-fairslice: SUCCESS (12.154s) [958.996787] [140/156] (148s left) kms_frontbuffer_tracking (fbchdr-2p-primscrn-pri-shrfb-draw-render) [959.098865] Starting subtest: fbchdr-2p-primscrn-pri-shrfb-draw-render [959.104350] Subtest fbchdr-2p-primscrn-pri-shrfb-draw-render: SKIP (0.000s) [959.171525] [141/156] (148s left) kms_async_flips (async-flip-dpms) [959.262838] Starting subtest: async-flip-dpms [959.637569] Starting dynamic subtest: pipe-A-eDP-1 [963.573728] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.934s) [963.956899] Starting dynamic subtest: pipe-B-eDP-1 [966.835709] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.888s) [967.230007] Starting dynamic subtest: pipe-C-eDP-1 [970.103683] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.883s) [970.484272] Starting dynamic subtest: pipe-D-eDP-1 [973.282296] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.808s) [973.284926] Subtest async-flip-dpms: SUCCESS (14.021s) [974.451636] [142/156] (132s left) kms_frontbuffer_tracking (fbchdr-rgb101010-draw-mmap-gtt) [974.550771] Starting subtest: fbchdr-rgb101010-draw-mmap-gtt [974.555697] Subtest fbchdr-rgb101010-draw-mmap-gtt: SKIP (0.000s) [974.628212] [143/156] (132s left) gem_exec_balancer (parallel-keep-submit-fence) [974.885668] Starting subtest: parallel-keep-submit-fence [976.185769] Subtest parallel-keep-submit-fence: SUCCESS (1.300s) [976.268511] [144/156] (131s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-mmap-cpu) [976.364819] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-mmap-cpu [976.369881] Subtest psr-2p-scndscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s) [976.434630] [145/156] (131s left) kms_plane (pixel-format-4-tiled-mtl-rc-ccs-modifier-source-clamping) [976.527722] Starting subtest: pixel-format-4-tiled-mtl-rc-ccs-modifier-source-clamping [976.554379] Starting dynamic subtest: pipe-A-plane-0 [976.842932] Dynamic subtest pipe-A-plane-0: SUCCESS (0.289s) [976.855605] Starting dynamic subtest: pipe-A-plane-3 [977.077045] Dynamic subtest pipe-A-plane-3: SUCCESS (0.233s) [978.151045] Starting dynamic subtest: pipe-B-plane-0 [978.465496] Dynamic subtest pipe-B-plane-0: SUCCESS (0.322s) [978.476608] Starting dynamic subtest: pipe-B-plane-3 [978.698716] Dynamic subtest pipe-B-plane-3: SUCCESS (0.232s) [979.018190] Subtest pixel-format-4-tiled-mtl-rc-ccs-modifier-source-clamping: SUCCESS (2.492s) [979.810279] [146/156] (127s left) kms_color (ctm-blue-to-red) [979.899944] Starting subtest: ctm-blue-to-red [979.902637] Starting dynamic subtest: pipe-A-eDP-1 [980.592994] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.693s) [980.604631] Starting dynamic subtest: pipe-B-eDP-1 [982.025377] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.434s) [982.037743] Starting dynamic subtest: pipe-C-eDP-1 [983.408992] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.381s) [983.421610] Starting dynamic subtest: pipe-D-eDP-1 [984.720684] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.312s) [984.723592] Subtest ctm-blue-to-red: SUCCESS (4.824s) [985.542422] [147/156] (121s left) kms_psr (pr-suspend) [985.636644] Starting subtest: pr-suspend [985.641168] Subtest pr-suspend: SKIP (0.000s) [985.691217] [148/156] (121s left) kms_frontbuffer_tracking (hdr-1p-primscrn-shrfb-pgflip-blt) [985.791840] Starting subtest: hdr-1p-primscrn-shrfb-pgflip-blt [985.797875] Subtest hdr-1p-primscrn-shrfb-pgflip-blt: SKIP (0.000s) [985.878261] [149/156] (121s left) kms_big_fb (y-tiled-16bpp-rotate-270) [985.980077] Starting subtest: y-tiled-16bpp-rotate-270 [985.985760] Subtest y-tiled-16bpp-rotate-270: SKIP (0.000s) [986.043539] [150/156] (121s left) gen9_exec_parse (allowed-single) [986.099575] Subtest allowed-single: SKIP (0.000s) [986.182004] [151/156] (121s left) gem_mmap_gtt (basic-write-read) [986.237553] Subtest basic-write-read: SKIP (0.000s) [986.310638] [152/156] (121s left) api_intel_allocator (fork-simple-stress) [986.363903] Starting subtest: fork-simple-stress [991.759980] Subtest fork-simple-stress: SUCCESS (5.396s) [991.856322] [153/156] (115s left) kms_big_fb (yf-tiled-64bpp-rotate-0) [991.962338] Starting subtest: yf-tiled-64bpp-rotate-0 [991.967050] Subtest yf-tiled-64bpp-rotate-0: SKIP (0.000s) [992.064607] [154/156] (115s left) gem_create (create-invalid-size) [992.118958] Starting subtest: create-invalid-size [992.121296] Subtest create-invalid-size: SUCCESS (0.000s) [992.283137] [155/156] (115s left) sw_sync (sync_merge_same) [992.321297] Starting subtest: sync_merge_same [992.324001] Subtest sync_merge_same: SUCCESS (0.000s) [992.369264] [156/156] (115s left) gem_exec_flush (basic-batch-kernel-default-wb) [992.433467] Starting subtest: basic-batch-kernel-default-wb [998.694256] Subtest basic-batch-kernel-default-wb: SUCCESS (6.261s) [998.861517] Closing watchdogs results: parsing output: 0/ for test: syncobj_wait results: parsing output: 1/ for test: gem_tiled_blits results: parsing output: 2/ for test: kms_frontbuffer_tracking results: parsing output: 3/ for test: dumb_buffer 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_frontbuffer_tracking results: parsing output: 7/ for test: kms_frontbuffer_tracking results: parsing output: 8/ for test: gem_fenced_exec_thrash results: parsing output: 9/ for test: kms_frontbuffer_tracking results: parsing output: 10/ for test: gem_exec_fence results: parsing output: 11/ for test: kms_properties results: parsing output: 12/ for test: kms_content_protection results: parsing output: 13/ for test: kms_frontbuffer_tracking results: parsing output: 14/ for test: kms_vblank results: parsing output: 15/ for test: kms_cursor_crc results: parsing output: 16/ for test: perf_pmu results: parsing output: 17/ for test: kms_psr results: parsing output: 18/ for test: kms_big_fb results: parsing output: 19/ for test: syncobj_timeline results: parsing output: 20/ for test: kms_rotation_crc results: parsing output: 21/ for test: kms_flip results: parsing output: 22/ for test: kms_flip results: parsing output: 23/ for test: perf_pmu results: parsing output: 24/ for test: gem_exec_balancer results: parsing output: 25/ for test: kms_flip results: parsing output: 26/ for test: kms_flip results: parsing output: 27/ for test: syncobj_timeline results: parsing output: 28/ for test: kms_lease results: parsing output: 29/ for test: gem_ctx_isolation results: parsing output: 30/ for test: i915_drm_fdinfo results: parsing output: 31/ for test: gem_ringfill results: parsing output: 32/ for test: kms_cdclk results: parsing output: 33/ for test: perf_pmu results: parsing output: 34/ for test: syncobj_wait results: parsing output: 35/ for test: kms_ccs results: parsing output: 36/ for test: kms_frontbuffer_tracking results: parsing output: 37/ for test: i915_pm_rps results: parsing output: 38/ for test: kms_frontbuffer_tracking results: parsing output: 39/ for test: kms_frontbuffer_tracking results: parsing output: 40/ for test: kms_joiner results: parsing output: 41/ for test: kms_big_fb results: parsing output: 42/ for test: kms_pm_backlight results: parsing output: 43/ for test: prime_self_import results: parsing output: 44/ for test: gem_ctx_persistence results: parsing output: 45/ for test: gem_ppgtt results: parsing output: 46/ for test: gem_userptr_blits results: parsing output: 47/ for test: gem_exec_balancer results: parsing output: 48/ for test: kms_setmode results: parsing output: 49/ for test: syncobj_timeline results: parsing output: 50/ for test: kms_cursor_legacy results: parsing output: 51/ for test: dumb_buffer results: parsing output: 52/ for test: kms_frontbuffer_tracking results: parsing output: 53/ for test: kms_scaling_modes results: parsing output: 54/ for test: syncobj_timeline results: parsing output: 55/ for test: gem_render_copy_redux results: parsing output: 56/ for test: kms_frontbuffer_tracking 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_mmap results: parsing output: 60/ for test: kms_frontbuffer_tracking results: parsing output: 61/ for test: kms_frontbuffer_tracking results: parsing output: 62/ for test: kms_plane_scaling results: parsing output: 63/ for test: gem_tiled_partial_pwrite_pread results: parsing output: 64/ for test: gem_userptr_blits results: parsing output: 65/ for test: kms_frontbuffer_tracking results: parsing output: 66/ for test: gem_exec_reloc results: parsing output: 67/ for test: perf_pmu results: parsing output: 68/ for test: kms_frontbuffer_tracking results: parsing output: 69/ for test: kms_cursor_crc results: parsing output: 70/ for test: gem_exec_params results: parsing output: 71/ for test: gem_userptr_blits results: parsing output: 72/ for test: kms_frontbuffer_tracking results: parsing output: 73/ for test: kms_frontbuffer_tracking results: parsing output: 74/ for test: kms_pipe_stress results: parsing output: 75/ for test: kms_frontbuffer_tracking results: parsing output: 76/ for test: core_auth results: parsing output: 77/ for test: gem_workarounds results: parsing output: 78/ for test: kms_frontbuffer_tracking results: parsing output: 79/ for test: gem_exec_suspend results: parsing output: 80/ for test: kms_ccs results: parsing output: 81/ for test: kms_ccs results: parsing output: 82/ for test: sysfs_timeslice_duration results: parsing output: 83/ for test: gem_softpin results: parsing output: 84/ for test: gem_exercise_blt results: parsing output: 85/ for test: kms_dsc results: parsing output: 86/ for test: kms_cursor_legacy results: parsing output: 87/ for test: kms_psr results: parsing output: 88/ for test: kms_cursor_crc results: parsing output: 89/ for test: perf results: parsing output: 90/ for test: kms_pm_rpm results: parsing output: 91/ for test: kms_frontbuffer_tracking results: parsing output: 92/ for test: kms_big_fb results: parsing output: 93/ for test: kms_frontbuffer_tracking results: parsing output: 94/ for test: i915_pm_freq_mult results: parsing output: 95/ for test: gem_ctx_engines results: parsing output: 96/ for test: kms_frontbuffer_tracking results: parsing output: 97/ for test: kms_big_fb results: parsing output: 98/ for test: kms_vblank results: parsing output: 99/ for test: kms_pm_lpsp results: parsing output: 100/ for test: kms_addfb_basic results: parsing output: 101/ for test: kms_psr results: parsing output: 102/ for test: kms_frontbuffer_tracking results: parsing output: 103/ for test: kms_busy results: parsing output: 104/ for test: kms_chamelium_frames results: parsing output: 105/ for test: kms_frontbuffer_tracking results: parsing output: 106/ for test: kms_frontbuffer_tracking results: parsing output: 107/ for test: gem_exec_params results: parsing output: 108/ for test: kms_cursor_legacy results: parsing output: 109/ for test: kms_frontbuffer_tracking results: parsing output: 110/ for test: gem_render_copy results: parsing output: 111/ for test: kms_frontbuffer_tracking results: parsing output: 112/ for test: kms_plane_multiple results: parsing output: 113/ for test: gem_mmap_offset results: parsing output: 114/ for test: kms_psr results: parsing output: 115/ for test: kms_chamelium_hpd results: parsing output: 116/ for test: perf results: parsing output: 117/ for test: syncobj_timeline results: parsing output: 118/ for test: kms_frontbuffer_tracking results: parsing output: 119/ for test: drm_read results: parsing output: 120/ for test: gem_exec_whisper results: parsing output: 121/ for test: kms_frontbuffer_tracking results: parsing output: 122/ for test: kms_psr2_sf results: parsing output: 123/ for test: gem_sync results: parsing output: 124/ for test: kms_psr2_sf results: parsing output: 125/ for test: kms_frontbuffer_tracking results: parsing output: 126/ for test: gem_exec_params results: parsing output: 127/ for test: kms_ccs results: parsing output: 128/ for test: kms_flip results: parsing output: 129/ for test: kms_getfb results: parsing output: 130/ for test: kms_flip_scaled_crc results: parsing output: 131/ for test: kms_frontbuffer_tracking results: parsing output: 132/ for test: kms_atomic results: parsing output: 133/ for test: gem_userptr_blits results: parsing output: 134/ for test: prime_vgem results: parsing output: 135/ for test: kms_frontbuffer_tracking results: parsing output: 136/ for test: gem_exec_schedule results: parsing output: 137/ for test: i915_suspend results: parsing output: 138/ for test: gem_exec_schedule results: parsing output: 139/ for test: kms_frontbuffer_tracking results: parsing output: 140/ for test: kms_async_flips results: parsing output: 141/ for test: kms_frontbuffer_tracking results: parsing output: 142/ for test: gem_exec_balancer results: parsing output: 143/ for test: kms_frontbuffer_tracking results: parsing output: 144/ for test: kms_plane results: parsing output: 145/ for test: kms_color results: parsing output: 146/ for test: kms_psr results: parsing output: 147/ for test: kms_frontbuffer_tracking results: parsing output: 148/ for test: kms_big_fb results: parsing output: 149/ for test: gen9_exec_parse results: parsing output: 150/ for test: gem_mmap_gtt results: parsing output: 151/ for test: api_intel_allocator results: parsing output: 152/ for test: kms_big_fb results: parsing output: 153/ for test: gem_create results: parsing output: 154/ for test: sw_sync results: parsing output: 155/ for test: gem_exec_flush Done.