[57.599907] Initializing watchdogs [57.599955] /dev/watchdog0 [57.619985] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:7d55 Intel Meteorlake (Gen12) Meteor Lake-P [Intel Arc Graphics] [57.624392] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [57.626742] [FACT before any test] new: kernel.kmod_is_loaded.i915: true [57.629713] [001/130] (960s left) i915_drm_fdinfo (basics) [57.698104] Starting subtest: basics [57.700633] Subtest basics: SUCCESS (0.000s) [57.791860] [002/130] (960s left) gem_exec_params (rel-constants-invalid-ring) [57.850974] Starting subtest: rel-constants-invalid-ring [57.853375] Subtest rel-constants-invalid-ring: SUCCESS (0.000s) [57.987880] [003/130] (960s left) kms_plane_lowres (tiling-x) [58.085749] Starting subtest: tiling-x [58.088123] Starting dynamic subtest: pipe-A-eDP-1 [58.092683] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [58.379690] Starting dynamic subtest: pipe-B-eDP-1 [58.384146] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [58.390923] Starting dynamic subtest: pipe-C-eDP-1 [58.395413] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [58.402941] Starting dynamic subtest: pipe-D-eDP-1 [58.407596] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [58.412193] Subtest tiling-x: SKIP (0.295s) [59.226881] [004/130] (959s left) kms_flip (flip-vs-panning-vs-hang) [59.329666] Starting subtest: flip-vs-panning-vs-hang [59.332064] Starting dynamic subtest: A-eDP1 [110.400721] Dynamic subtest A-eDP1: SUCCESS (51.071s) [110.419575] Starting dynamic subtest: D-eDP1 [150.399560] Dynamic subtest D-eDP1: SUCCESS (39.997s) [150.404439] Subtest flip-vs-panning-vs-hang: SUCCESS (91.075s) [151.625600] [005/130] (866s left) kms_vblank (wait-idle-hang) [151.715347] Starting subtest: wait-idle-hang [151.717825] Starting dynamic subtest: pipe-A-eDP-1 [177.680248] Dynamic subtest pipe-A-eDP-1: SUCCESS (25.961s) [177.695033] Starting dynamic subtest: pipe-D-eDP-1 [192.677306] Dynamic subtest pipe-D-eDP-1: SUCCESS (14.995s) [192.679966] Subtest wait-idle-hang: SUCCESS (40.960s) [193.490069] [006/130] (824s left) kms_plane (plane-panning-bottom-right) [193.590769] Starting subtest: plane-panning-bottom-right [193.592777] Starting dynamic subtest: pipe-A [195.322070] Dynamic subtest pipe-A: SUCCESS (1.731s) [195.331171] Starting dynamic subtest: pipe-B [197.697172] Dynamic subtest pipe-B: SUCCESS (2.373s) [197.699480] Subtest plane-panning-bottom-right: SUCCESS (4.106s) [198.517622] [007/130] (819s left) syncobj_wait (invalid-wait-illegal-handle) [198.581947] Starting subtest: invalid-wait-illegal-handle [198.584271] Subtest invalid-wait-illegal-handle: SUCCESS (0.000s) [198.711040] [008/130] (819s left) kms_chamelium_hpd (dp-hpd) [199.113999] Subtest dp-hpd: SKIP (0.000s) [199.902784] [009/130] (818s left) kms_frontbuffer_tracking (psr-2p-primscrn-shrfb-plflip-blt) [200.001074] Starting subtest: psr-2p-primscrn-shrfb-plflip-blt [200.005425] Subtest psr-2p-primscrn-shrfb-plflip-blt: SKIP (0.000s) [200.120209] [010/130] (818s left) kms_fence_pin_leak [200.269446] [011/130] (818s left) syncobj_basic (bad-create-flags) [200.319613] Starting subtest: bad-create-flags [200.321813] Subtest bad-create-flags: SUCCESS (0.000s) [200.433723] [012/130] (818s left) syncobj_timeline (etime-multi-wait-all-for-submit-available-unsubmitted-submi [200.492075] Starting subtest: etime-multi-wait-all-for-submit-available-unsubmitted-submitted [200.593727] Subtest etime-multi-wait-all-for-submit-available-unsubmitted-submitted: SUCCESS (0.101s) [200.691192] [013/130] (817s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-indfb-pgflip-blt) [200.796459] Starting subtest: fbcpsr-2p-scndscrn-indfb-pgflip-blt [200.800808] Subtest fbcpsr-2p-scndscrn-indfb-pgflip-blt: SKIP (0.000s) [200.923346] [014/130] (817s left) kms_cursor_legacy (flip-vs-cursor-crc-legacy) [201.048198] Starting subtest: flip-vs-cursor-crc-legacy [201.744197] Subtest flip-vs-cursor-crc-legacy: SUCCESS (0.695s) [202.571798] [015/130] (816s left) gem_partial_pwrite_pread (write-uncached) [202.637893] Subtest write-uncached: SKIP (0.000s) [202.722471] [016/130] (815s left) syncobj_wait (multi-wait-signaled) [202.783430] Starting subtest: multi-wait-signaled [202.785796] Subtest multi-wait-signaled: SUCCESS (0.000s) [202.921979] [017/130] (815s left) gem_mmap (pf-nonblock) [202.984026] Subtest pf-nonblock: SKIP (0.000s) [203.051361] [018/130] (815s left) gem_lmem_swapping (parallel-random) [203.093287] Subtest parallel-random: SKIP (0.000s) [203.129889] [019/130] (815s left) prime_self_import (basic-with_two_bos) [203.162781] Starting subtest: basic-with_two_bos [203.191251] Subtest basic-with_two_bos: SUCCESS (0.028s) [203.326685] [020/130] (815s left) gem_exec_schedule (noreorder-corked) [203.516058] Starting subtest: noreorder-corked [203.518382] Starting dynamic subtest: rcs0 [204.683465] Dynamic subtest rcs0: SUCCESS (1.168s) [204.693499] Starting dynamic subtest: vcs0 [205.895043] Dynamic subtest vcs0: SUCCESS (1.209s) [205.905797] Starting dynamic subtest: vcs1 [207.906262] Dynamic subtest vcs1: SUCCESS (2.010s) [207.916285] Starting dynamic subtest: vecs0 [209.951418] Dynamic subtest vecs0: SUCCESS (2.044s) [209.965993] Starting dynamic subtest: ccs0 [211.118777] Dynamic subtest ccs0: SUCCESS (1.168s) [211.121470] Subtest noreorder-corked: SUCCESS (7.603s) [211.327317] [021/130] (807s left) kms_flip (2x-flip-vs-fences-interruptible) [211.431371] Starting subtest: 2x-flip-vs-fences-interruptible [211.435724] Subtest 2x-flip-vs-fences-interruptible: SKIP (0.000s) [211.557327] [022/130] (807s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-render) [211.669966] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-render [218.478042] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-render: SUCCESS (6.812s) [218.632951] [023/130] (800s left) kms_flip (2x-nonexisting-fb-interruptible) [218.742304] Starting subtest: 2x-nonexisting-fb-interruptible [218.754730] Subtest 2x-nonexisting-fb-interruptible: SKIP (0.011s) [218.851234] [024/130] (800s left) perf_pmu (busy-double-start) [218.892010] Starting subtest: busy-double-start [218.893961] Starting dynamic subtest: rcs0 [222.520534] Dynamic subtest rcs0: FAIL (3.570s) [222.529729] Starting dynamic subtest: bcs0 [226.034129] Dynamic subtest bcs0: SUCCESS (3.573s) [226.043414] Starting dynamic subtest: vcs0 [230.428035] Dynamic subtest vcs0: SUCCESS (4.393s) [230.441446] Starting dynamic subtest: vcs1 [234.426644] Dynamic subtest vcs1: SUCCESS (3.998s) [234.437314] Starting dynamic subtest: vecs0 [238.459735] Dynamic subtest vecs0: SUCCESS (4.032s) [238.470850] Starting dynamic subtest: ccs0 [242.096400] Dynamic subtest ccs0: FAIL (3.566s) [242.098666] Subtest busy-double-start: FAIL (23.137s) [242.143086] [025/130] (776s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-pwrite) [242.245054] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-pwrite [242.249215] Subtest psr-2p-scndscrn-spr-indfb-draw-pwrite: SKIP (0.000s) [242.359717] [026/130] (776s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-onoff) [242.460599] Starting subtest: fbc-1p-primscrn-spr-indfb-onoff [246.457973] Subtest fbc-1p-primscrn-spr-indfb-onoff: SUCCESS (4.001s) [247.686285] [027/130] (771s left) kms_cursor_legacy (2x-long-flip-vs-cursor-legacy) [247.818161] Starting subtest: 2x-long-flip-vs-cursor-legacy [247.822745] Subtest 2x-long-flip-vs-cursor-legacy: SKIP (0.001s) [247.988234] [028/130] (771s left) kms_pm_rpm (modeset-lpsp-stress) [250.011736] Starting subtest: modeset-lpsp-stress [266.735470] Subtest modeset-lpsp-stress: SUCCESS (16.727s) [266.878076] [029/130] (752s left) syncobj_timeline (invalid-query-one-illegal-handle) [266.934094] Starting subtest: invalid-query-one-illegal-handle [266.936386] Subtest invalid-query-one-illegal-handle: SUCCESS (0.000s) [267.067463] [030/130] (752s left) kms_big_fb (y-tiled-16bpp-rotate-270) [267.182148] Starting subtest: y-tiled-16bpp-rotate-270 [267.186359] Subtest y-tiled-16bpp-rotate-270: SKIP (0.000s) [267.319082] [031/130] (751s left) kms_async_flips (basic-modeset-with-all-modifiers-formats) [267.427273] Starting subtest: basic-modeset-with-all-modifiers-formats [267.798921] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-XRGB8888 [269.161643] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-XRGB8888: FAIL (0.773s) [269.170647] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-XRGB2101010 [269.299967] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-XRGB2101010: FAIL (0.458s) [269.309429] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-XRGB16161616F [269.441621] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-XRGB16161616F: FAIL (0.016s) [269.450806] Starting dynamic subtest: pipe-A-eDP-1-4-RGB565 [269.750086] Dynamic subtest pipe-A-eDP-1-4-RGB565: FAIL (0.565s) [269.759052] Starting dynamic subtest: pipe-A-eDP-1-4-XRGB8888 [269.870325] Dynamic subtest pipe-A-eDP-1-4-XRGB8888: FAIL (0.018s) [269.880638] Starting dynamic subtest: pipe-A-eDP-1-4-XRGB2101010 [269.991935] Dynamic subtest pipe-A-eDP-1-4-XRGB2101010: FAIL (0.008s) [270.001759] Starting dynamic subtest: pipe-A-eDP-1-4-XRGB16161616F [270.111925] Dynamic subtest pipe-A-eDP-1-4-XRGB16161616F: FAIL (0.011s) [270.119668] Starting dynamic subtest: pipe-A-eDP-1-4-YUYV [270.230737] Dynamic subtest pipe-A-eDP-1-4-YUYV: FAIL (0.413s) [270.240833] Starting dynamic subtest: pipe-A-eDP-1-4-Y210 [270.351951] Dynamic subtest pipe-A-eDP-1-4-Y210: FAIL (0.016s) [270.361897] Starting dynamic subtest: pipe-A-eDP-1-4-XYUV8888 [270.473045] Dynamic subtest pipe-A-eDP-1-4-XYUV8888: FAIL (0.009s) [270.483260] Starting dynamic subtest: pipe-A-eDP-1-4-XV30 [270.591679] Dynamic subtest pipe-A-eDP-1-4-XV30: FAIL (0.011s) [270.600532] Starting dynamic subtest: pipe-A-eDP-1-4-XV36 [270.709347] Dynamic subtest pipe-A-eDP-1-4-XV36: FAIL (0.420s) [270.718721] Starting dynamic subtest: pipe-A-eDP-1-x-RGB565 [271.014557] Dynamic subtest pipe-A-eDP-1-x-RGB565: FAIL (0.130s) [271.024155] Starting dynamic subtest: pipe-A-eDP-1-x-XRGB8888 [271.136229] Dynamic subtest pipe-A-eDP-1-x-XRGB8888: FAIL (0.009s) [271.144573] Starting dynamic subtest: pipe-A-eDP-1-x-XRGB2101010 [271.250178] Dynamic subtest pipe-A-eDP-1-x-XRGB2101010: FAIL (0.408s) [271.258155] Starting dynamic subtest: pipe-A-eDP-1-x-XRGB16161616F [271.362395] Dynamic subtest pipe-A-eDP-1-x-XRGB16161616F: FAIL (0.018s) [271.369992] Starting dynamic subtest: pipe-A-eDP-1-x-YUYV [271.474850] Dynamic subtest pipe-A-eDP-1-x-YUYV: FAIL (0.008s) [271.482982] Starting dynamic subtest: pipe-A-eDP-1-x-Y210 [271.588065] Dynamic subtest pipe-A-eDP-1-x-Y210: FAIL (0.011s) [271.596241] Starting dynamic subtest: pipe-A-eDP-1-x-XYUV8888 [271.702640] Dynamic subtest pipe-A-eDP-1-x-XYUV8888: FAIL (0.395s) [271.710823] Starting dynamic subtest: pipe-A-eDP-1-x-XV30 [271.815458] Dynamic subtest pipe-A-eDP-1-x-XV30: FAIL (0.017s) [271.823380] Starting dynamic subtest: pipe-A-eDP-1-x-XV36 [271.935443] Dynamic subtest pipe-A-eDP-1-x-XV36: FAIL (0.009s) [271.944885] Starting dynamic subtest: pipe-A-eDP-1-linear-RGB565 [272.224258] Dynamic subtest pipe-A-eDP-1-linear-RGB565: FAIL (0.543s) [272.234183] Starting dynamic subtest: pipe-A-eDP-1-linear-XRGB8888 [272.345200] Dynamic subtest pipe-A-eDP-1-linear-XRGB8888: FAIL (0.018s) [272.354624] Starting dynamic subtest: pipe-A-eDP-1-linear-XRGB2101010 [272.466502] Dynamic subtest pipe-A-eDP-1-linear-XRGB2101010: FAIL (0.008s) [272.476311] Starting dynamic subtest: pipe-A-eDP-1-linear-XRGB16161616F [272.585378] Dynamic subtest pipe-A-eDP-1-linear-XRGB16161616F: FAIL (0.011s) [272.594059] Starting dynamic subtest: pipe-A-eDP-1-linear-YUYV [272.703897] Dynamic subtest pipe-A-eDP-1-linear-YUYV: FAIL (0.412s) [272.713657] Starting dynamic subtest: pipe-A-eDP-1-linear-Y210 [272.824960] Dynamic subtest pipe-A-eDP-1-linear-Y210: FAIL (0.016s) [272.834568] Starting dynamic subtest: pipe-A-eDP-1-linear-XYUV8888 [272.946757] Dynamic subtest pipe-A-eDP-1-linear-XYUV8888: FAIL (0.010s) [272.955840] Starting dynamic subtest: pipe-A-eDP-1-linear-XV30 [273.066497] Dynamic subtest pipe-A-eDP-1-linear-XV30: FAIL (0.011s) [273.074483] Starting dynamic subtest: pipe-A-eDP-1-linear-XV36 [273.180538] Dynamic subtest pipe-A-eDP-1-linear-XV36: FAIL (0.423s) [273.392845] Subtest basic-modeset-with-all-modifiers-formats: FAIL (5.966s) [274.177523] [032/130] (745s left) kms_flip (flip-vs-panning) [274.289387] Starting subtest: flip-vs-panning [274.291724] Starting dynamic subtest: A-eDP1 [282.977901] Dynamic subtest A-eDP1: SUCCESS (8.688s) [282.990541] Starting dynamic subtest: B-eDP1 [291.702309] Dynamic subtest B-eDP1: SUCCESS (8.723s) [291.712277] Starting dynamic subtest: C-eDP1 [300.436475] Dynamic subtest C-eDP1: SUCCESS (8.732s) [300.445171] Starting dynamic subtest: D-eDP1 [309.167334] Dynamic subtest D-eDP1: SUCCESS (8.729s) [309.171698] Subtest flip-vs-panning: SUCCESS (34.879s) [310.348613] [033/130] (708s left) gem_exec_fence (syncobj-timeline-signal) [310.914031] Starting subtest: syncobj-timeline-signal [310.918524] Subtest syncobj-timeline-signal: SUCCESS (0.009s) [312.010552] [FACT gem_exec_fence (syncobj-timeline-signal)] new: kernel.kmod_is_loaded.vgem: true [312.013784] [034/130] (707s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling) [312.113042] Starting subtest: flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling [312.115154] Starting dynamic subtest: pipe-A-default-mode [312.416951] Dynamic subtest pipe-A-default-mode: SKIP (0.301s) [312.421642] Subtest flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling: SKIP (0.303s) [313.292885] [035/130] (706s left) kms_big_fb (yf-tiled-8bpp-rotate-180) [313.391810] Starting subtest: yf-tiled-8bpp-rotate-180 [313.395671] Subtest yf-tiled-8bpp-rotate-180: SKIP (0.000s) [313.531881] [036/130] (705s left) gem_exec_capture (capture) [313.588902] Starting subtest: capture [313.590910] Starting dynamic subtest: rcs0-smem [314.416296] Dynamic subtest rcs0-smem: SUCCESS (0.827s) [314.426524] Starting dynamic subtest: bcs0-smem [315.730256] Dynamic subtest bcs0-smem: SUCCESS (1.315s) [315.741073] Starting dynamic subtest: vcs0-smem [316.560880] Dynamic subtest vcs0-smem: SUCCESS (0.830s) [316.568828] Starting dynamic subtest: vcs1-smem [317.886095] Dynamic subtest vcs1-smem: SUCCESS (1.325s) [317.894165] Starting dynamic subtest: vecs0-smem [318.775077] Dynamic subtest vecs0-smem: FAIL (0.813s) [318.785074] Starting dynamic subtest: ccs0-smem [320.022471] Dynamic subtest ccs0-smem: SUCCESS (1.321s) [320.024942] Subtest capture: FAIL (6.434s) [320.184443] [037/130] (699s left) kms_pipe_crc_basic (compare-crc-sanitycheck-nv12) [320.287890] Starting subtest: compare-crc-sanitycheck-nv12 [320.290236] Starting dynamic subtest: pipe-A-eDP-1 [321.038702] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.749s) [321.049193] Starting dynamic subtest: pipe-B-eDP-1 [322.365853] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.326s) [322.374805] Starting dynamic subtest: pipe-C-eDP-1 [323.628436] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.263s) [323.638966] Starting dynamic subtest: pipe-D-eDP-1 [324.884711] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.253s) [324.887067] Subtest compare-crc-sanitycheck-nv12: SUCCESS (4.596s) [325.731116] [038/130] (693s left) syncobj_timeline (wait-any-snapshot) [325.779770] Starting subtest: wait-any-snapshot [325.860394] Subtest wait-any-snapshot: SUCCESS (0.081s) [325.962244] [039/130] (693s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-mmap-wc) [326.068267] Starting subtest: psr-1p-primscrn-pri-indfb-draw-mmap-wc [333.086044] Subtest psr-1p-primscrn-pri-indfb-draw-mmap-wc: SUCCESS (7.020s) [333.260193] [040/130] (686s left) kms_scaling_modes (scaling-mode-center) [333.359147] Starting subtest: scaling-mode-center [333.361305] Starting dynamic subtest: pipe-A-eDP-1 [333.457485] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.100s) [333.467041] Starting dynamic subtest: pipe-B-eDP-1 [334.658673] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.200s) [334.671068] Starting dynamic subtest: pipe-C-eDP-1 [335.766054] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.104s) [335.774639] Starting dynamic subtest: pipe-D-eDP-1 [336.899987] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.132s) [336.902278] Subtest scaling-mode-center: SUCCESS (3.544s) [338.112454] [041/130] (681s left) kms_pm_rpm (fences-dpms) [340.052299] Starting subtest: fences-dpms [340.057433] Subtest fences-dpms: SKIP (0.000s) [340.440083] [042/130] (679s left) gem_bad_reloc (negative-reloc-lut) [340.504105] Subtest negative-reloc-lut: SKIP (0.000s) [340.585134] [043/130] (679s left) kms_ccs (crc-sprite-planes-basic-4-tiled-mtl-rc-ccs-cc) [340.677387] Starting subtest: crc-sprite-planes-basic-4-tiled-mtl-rc-ccs-cc [340.679756] Starting dynamic subtest: pipe-A-eDP-1 [341.200928] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.496s) [341.213174] Starting dynamic subtest: pipe-B-eDP-1 [342.747305] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.545s) [342.757437] Starting dynamic subtest: pipe-C-eDP-1 [344.149248] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.398s) [344.166319] Starting dynamic subtest: pipe-D-eDP-1 [345.507226] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.359s) [345.509380] Subtest crc-sprite-planes-basic-4-tiled-mtl-rc-ccs-cc: SUCCESS (4.805s) [346.685593] [044/130] (673s left) kms_ccs (ccs-on-another-bo-y-tiled-ccs) [346.782128] Starting subtest: ccs-on-another-bo-y-tiled-ccs [346.784425] Starting dynamic subtest: pipe-A-eDP-1 [346.807228] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [346.821190] Starting dynamic subtest: pipe-B-eDP-1 [346.842380] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [346.851677] Starting dynamic subtest: pipe-C-eDP-1 [346.872622] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [346.880901] Starting dynamic subtest: pipe-D-eDP-1 [346.904042] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [346.908553] Subtest ccs-on-another-bo-y-tiled-ccs: SKIP (0.007s) [349.038510] [045/130] (670s left) gem_fenced_exec_thrash (no-spare-fences-interruptible) [349.095179] Subtest no-spare-fences-interruptible: SKIP (0.000s) [349.174653] [046/130] (670s left) api_intel_allocator (reopen-fork) [349.247460] Starting subtest: reopen-fork [352.896020] Subtest reopen-fork: SUCCESS (3.647s) [352.994507] [047/130] (666s left) kms_cursor_crc (cursor-tearing-position-change) [353.135850] Starting subtest: cursor-tearing-position-change [353.138262] Starting dynamic subtest: pipe-A-eDP-1 [353.718516] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.578s) [353.728066] Starting dynamic subtest: pipe-D-eDP-1 [354.964540] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.246s) [354.966676] Subtest cursor-tearing-position-change: SUCCESS (1.828s) [355.807937] [048/130] (664s left) kms_cursor_legacy (forked-bo) [355.928710] Starting subtest: forked-bo [355.930777] Starting dynamic subtest: pipe-A [361.383651] Dynamic subtest pipe-A: SUCCESS (5.453s) [361.393947] Starting dynamic subtest: pipe-B [366.856648] Dynamic subtest pipe-B: SUCCESS (5.470s) [366.866842] Starting dynamic subtest: pipe-C [372.320172] Dynamic subtest pipe-C: SUCCESS (5.461s) [372.331023] Starting dynamic subtest: pipe-D [377.783303] Dynamic subtest pipe-D: SUCCESS (5.461s) [377.793120] Starting dynamic subtest: all-pipes [383.294642] Dynamic subtest all-pipes: SUCCESS (5.509s) [383.297096] Subtest forked-bo: SUCCESS (27.365s) [383.463955] [049/130] (636s left) gem_create (hog-create) [383.527779] Starting subtest: hog-create [383.529744] Starting dynamic subtest: smem0 [416.944923] Dynamic subtest smem0: SUCCESS (33.417s) [416.947511] Subtest hog-create: SUCCESS (33.419s) [417.156887] [050/130] (602s left) gem_partial_pwrite_pread (reads-uncached) [417.214605] Subtest reads-uncached: SKIP (0.000s) [417.288814] [051/130] (602s left) gen3_mixed_blits [417.405687] [052/130] (602s left) kms_big_fb (4-tiled-8bpp-rotate-90) [417.501391] Starting subtest: 4-tiled-8bpp-rotate-90 [417.523214] Subtest 4-tiled-8bpp-rotate-90: SKIP (0.021s) [417.680218] [053/130] (602s left) i915_fb_tiling (basic-x-tiling) [417.729654] Subtest basic-x-tiling: SKIP (0.000s) [417.794916] [054/130] (602s left) syncobj_timeline (multi-wait-for-submit-available-unsubmitted-submitted-signa [417.849622] Starting subtest: multi-wait-for-submit-available-unsubmitted-submitted-signaled [417.851781] Subtest multi-wait-for-submit-available-unsubmitted-submitted-signaled: SUCCESS (0.000s) [417.985483] [055/130] (602s left) gem_render_copy (y-tiled-ccs-to-y-tiled-mc-ccs) [418.049266] Starting subtest: y-tiled-ccs-to-y-tiled-mc-ccs [418.053829] Subtest y-tiled-ccs-to-y-tiled-mc-ccs: SKIP (0.000s) [418.255194] [056/130] (602s left) gem_exec_schedule (submit-late-slice) [418.332614] Starting subtest: submit-late-slice [418.334875] Starting dynamic subtest: rcs0 [418.358146] Dynamic subtest rcs0: SUCCESS (0.033s) [418.369383] Starting dynamic subtest: bcs0 [418.389351] Dynamic subtest bcs0: SUCCESS (0.031s) [418.398620] Starting dynamic subtest: vcs0 [418.416852] Dynamic subtest vcs0: SUCCESS (0.027s) [418.425708] Starting dynamic subtest: vcs1 [418.452101] Dynamic subtest vcs1: SUCCESS (0.034s) [418.463432] Starting dynamic subtest: vecs0 [418.478523] Dynamic subtest vecs0: SUCCESS (0.026s) [418.486854] Starting dynamic subtest: ccs0 [418.508415] Dynamic subtest ccs0: SUCCESS (0.029s) [418.510662] Subtest submit-late-slice: SUCCESS (0.184s) [420.047775] [057/130] (600s left) kms_color (deep-color) [420.134919] Starting subtest: deep-color [421.162727] Starting dynamic subtest: pipe-A-eDP-1-gamma [421.899709] Dynamic subtest pipe-A-eDP-1-gamma: SUCCESS (0.737s) [421.908200] Starting dynamic subtest: pipe-A-eDP-1-degamma [423.382537] Dynamic subtest pipe-A-eDP-1-degamma: SUCCESS (1.480s) [423.391525] Starting dynamic subtest: pipe-A-eDP-1-ctm [424.776869] Dynamic subtest pipe-A-eDP-1-ctm: SUCCESS (1.394s) [425.568674] Starting dynamic subtest: pipe-B-eDP-1-gamma [426.276920] Dynamic subtest pipe-B-eDP-1-gamma: SUCCESS (0.714s) [426.286032] Starting dynamic subtest: pipe-B-eDP-1-degamma [427.768329] Dynamic subtest pipe-B-eDP-1-degamma: SUCCESS (1.491s) [427.782789] Starting dynamic subtest: pipe-B-eDP-1-ctm [429.159975] Dynamic subtest pipe-B-eDP-1-ctm: SUCCESS (1.390s) [429.938245] Starting dynamic subtest: pipe-C-eDP-1-gamma [430.650412] Dynamic subtest pipe-C-eDP-1-gamma: SUCCESS (0.716s) [430.667807] Starting dynamic subtest: pipe-C-eDP-1-degamma [432.109989] Dynamic subtest pipe-C-eDP-1-degamma: SUCCESS (1.460s) [432.119044] Starting dynamic subtest: pipe-C-eDP-1-ctm [433.525214] Dynamic subtest pipe-C-eDP-1-ctm: SUCCESS (1.412s) [434.331565] Starting dynamic subtest: pipe-D-eDP-1-gamma [435.029464] Dynamic subtest pipe-D-eDP-1-gamma: SUCCESS (0.702s) [435.038294] Starting dynamic subtest: pipe-D-eDP-1-degamma [436.488010] Dynamic subtest pipe-D-eDP-1-degamma: SUCCESS (1.460s) [436.499346] Starting dynamic subtest: pipe-D-eDP-1-ctm [437.917653] Dynamic subtest pipe-D-eDP-1-ctm: SUCCESS (1.428s) [437.920064] Subtest deep-color: SUCCESS (17.783s) [438.788532] [058/130] (581s left) kms_invalid_mode (zero-vdisplay) [438.879858] Starting subtest: zero-vdisplay [438.882378] Starting dynamic subtest: pipe-A-eDP-1 [439.173152] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.293s) [439.182299] Starting dynamic subtest: pipe-B-eDP-1 [439.184283] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s) [439.192252] Starting dynamic subtest: pipe-C-eDP-1 [439.194625] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s) [439.202972] Starting dynamic subtest: pipe-D-eDP-1 [439.204956] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s) [439.206922] Subtest zero-vdisplay: SUCCESS (0.299s) [440.027384] [059/130] (580s left) perf_pmu (render-node-busy-idle) [440.097557] Starting subtest: render-node-busy-idle [440.100053] Starting dynamic subtest: rcs0 [440.797965] Dynamic subtest rcs0: SUCCESS (0.700s) [440.808981] Starting dynamic subtest: bcs0 [441.466930] Dynamic subtest bcs0: SUCCESS (0.667s) [441.478490] Starting dynamic subtest: vcs0 [442.902381] Dynamic subtest vcs0: SUCCESS (1.431s) [442.913732] Starting dynamic subtest: vcs1 [444.884917] Dynamic subtest vcs1: SUCCESS (1.980s) [444.896287] Starting dynamic subtest: vecs0 [446.934326] Dynamic subtest vecs0: SUCCESS (2.046s) [446.949857] Starting dynamic subtest: ccs0 [447.601279] Dynamic subtest ccs0: SUCCESS (0.665s) [447.603838] Subtest render-node-busy-idle: SUCCESS (7.505s) [447.706735] [060/130] (572s left) kms_prop_blob (invalid-get-prop-any) [447.768101] Starting subtest: invalid-get-prop-any [447.770397] Subtest invalid-get-prop-any: SUCCESS (0.000s) [447.914374] [061/130] (572s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-180) [448.027173] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-180 [448.985150] Subtest x-tiled-max-hw-stride-64bpp-rotate-180: SUCCESS (0.957s) [449.174701] [062/130] (571s left) kms_psr (psr2-cursor-render) [449.277673] Starting subtest: psr2-cursor-render [449.279573] Starting dynamic subtest: eDP-1 [450.982115] Dynamic subtest eDP-1: SUCCESS (1.705s) [450.984294] Subtest psr2-cursor-render: SUCCESS (1.707s) [451.806758] [063/130] (568s left) gem_mmap_gtt (ptrace) [451.877110] Subtest ptrace: SKIP (0.000s) [451.941585] [064/130] (568s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-shrfb-plflip-blt) [452.053781] Starting subtest: fbcpsr-1p-primscrn-shrfb-plflip-blt [459.535750] Subtest fbcpsr-1p-primscrn-shrfb-plflip-blt: SUCCESS (7.485s) [459.706517] [065/130] (560s left) kms_plane_scaling (planes-scaler-unity-scaling) [459.808144] Starting subtest: planes-scaler-unity-scaling [459.810447] Starting dynamic subtest: pipe-A [459.870663] Dynamic subtest pipe-A: SUCCESS (0.064s) [459.881094] Starting dynamic subtest: pipe-B [461.026880] Dynamic subtest pipe-B: SUCCESS (1.155s) [461.036477] Starting dynamic subtest: pipe-C [462.157409] Dynamic subtest pipe-C: SUCCESS (1.130s) [462.167650] Starting dynamic subtest: pipe-D [463.280404] Dynamic subtest pipe-D: SUCCESS (1.122s) [463.282863] Subtest planes-scaler-unity-scaling: SUCCESS (3.474s) [464.470384] [066/130] (556s left) kms_flip (flip-vs-dpms-off-vs-modeset) [464.580390] Starting subtest: flip-vs-dpms-off-vs-modeset [464.582803] Starting dynamic subtest: A-eDP1 [468.163551] Dynamic subtest A-eDP1: SUCCESS (3.584s) [468.173711] Starting dynamic subtest: B-eDP1 [471.381308] Dynamic subtest B-eDP1: SUCCESS (3.215s) [471.389875] Starting dynamic subtest: C-eDP1 [474.479430] Dynamic subtest C-eDP1: SUCCESS (3.098s) [474.489073] Starting dynamic subtest: D-eDP1 [477.573305] Dynamic subtest D-eDP1: SUCCESS (3.093s) [477.575693] Subtest flip-vs-dpms-off-vs-modeset: SUCCESS (12.999s) [478.399796] [067/130] (542s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-indfb-draw-pwrite) [478.507246] Starting subtest: fbc-1p-offscreen-pri-indfb-draw-pwrite [483.299975] Subtest fbc-1p-offscreen-pri-indfb-draw-pwrite: SUCCESS (4.795s) [484.520252] [068/130] (536s left) kms_psr (fbc-psr2-primary-mmap-cpu) [484.622158] Starting subtest: fbc-psr2-primary-mmap-cpu [484.624372] Starting dynamic subtest: eDP-1 [484.628369] Dynamic subtest eDP-1: SKIP (0.000s) [484.632430] Subtest fbc-psr2-primary-mmap-cpu: SKIP (0.001s) [484.721906] [069/130] (536s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-mmap-gtt) [484.815698] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-mmap-gtt [484.820155] Subtest fbc-2p-scndscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s) [484.935199] [070/130] (535s left) kms_flip (nonblocking-read) [485.036262] Starting subtest: nonblocking-read [485.038405] Subtest nonblocking-read: SUCCESS (0.000s) [485.170092] [071/130] (535s left) i915_suspend (sysfs-reader) [485.229469] Starting subtest: sysfs-reader [503.547019] Subtest sysfs-reader: SUCCESS (6.890s) [503.606294] [072/130] (517s left) kms_addfb_basic (tile-pitch-mismatch) [503.680722] Starting subtest: tile-pitch-mismatch [503.684217] Subtest tile-pitch-mismatch: SKIP (0.000s) [503.847838] [073/130] (517s left) api_intel_bb (simple-bb) [503.916110] Starting subtest: simple-bb [503.920509] Subtest simple-bb: SUCCESS (0.006s) [504.064019] [074/130] (516s left) kms_psr (psr-dpms) [504.150690] Starting subtest: psr-dpms [504.152501] Starting dynamic subtest: eDP-1 [507.164967] Dynamic subtest eDP-1: SUCCESS (3.010s) [507.167390] Subtest psr-dpms: SUCCESS (3.011s) [508.062002] [075/130] (513s left) i915_pm_freq_mult (media-freq) [508.125328] Starting subtest: media-freq [508.127696] Starting dynamic subtest: gt0 [508.131983] Dynamic subtest gt0: SKIP (0.000s) [508.146233] Starting dynamic subtest: gt1 [508.150956] Dynamic subtest gt1: SKIP (0.000s) [508.155597] Subtest media-freq: SKIP (0.002s) [508.257859] [076/130] (512s left) kms_rotation_crc (sprite-rotation-270) [508.362568] Starting subtest: sprite-rotation-270 [508.366764] Subtest sprite-rotation-270: SKIP (0.001s) [508.465387] [077/130] (512s left) kms_draw_crc (draw-method-mmap-gtt) [508.552316] Starting subtest: draw-method-mmap-gtt [508.556302] Subtest draw-method-mmap-gtt: SKIP (0.000s) [508.690237] [078/130] (512s left) gem_ctx_isolation (preservation-reset) [508.875463] Starting subtest: preservation-reset [508.877447] Starting dynamic subtest: rcs0 [509.144099] Dynamic subtest rcs0: SUCCESS (0.272s) [509.156602] Starting dynamic subtest: bcs0 [509.486299] Dynamic subtest bcs0: SUCCESS (0.341s) [509.499219] Starting dynamic subtest: vcs0 [509.819013] Dynamic subtest vcs0: SUCCESS (0.331s) [509.831465] Starting dynamic subtest: vcs1 [511.649370] Dynamic subtest vcs1: SUCCESS (1.827s) [511.661604] Starting dynamic subtest: vecs0 [513.662034] Dynamic subtest vecs0: SUCCESS (2.010s) [513.674897] Starting dynamic subtest: ccs0 [515.652097] Dynamic subtest ccs0: SUCCESS (1.988s) [515.654476] Subtest preservation-reset: SUCCESS (6.776s) [515.831615] [079/130] (505s left) kms_universal_plane (cursor-fb-leak) [515.939954] Starting subtest: cursor-fb-leak [515.942267] Starting dynamic subtest: pipe-A-eDP-1 [516.290705] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.351s) [516.305526] Starting dynamic subtest: pipe-B-eDP-1 [517.636072] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.343s) [517.647358] Starting dynamic subtest: pipe-C-eDP-1 [518.955415] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.316s) [518.965995] Starting dynamic subtest: pipe-D-eDP-1 [520.299165] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.342s) [520.301492] Subtest cursor-fb-leak: SUCCESS (4.359s) [521.492866] [080/130] (499s left) kms_cursor_crc (cursor-onscreen-128x42) [521.716830] Starting subtest: cursor-onscreen-128x42 [521.763665] Subtest cursor-onscreen-128x42: SKIP (0.042s) [521.992934] [081/130] (499s left) gem_spin_batch (user-each) [522.060464] Starting subtest: user-each [525.336161] Subtest user-each: SUCCESS (3.266s) [527.413537] [082/130] (493s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-shrfb-plflip-blt) [527.520824] Starting subtest: fbcpsr-2p-primscrn-shrfb-plflip-blt [527.525269] Subtest fbcpsr-2p-primscrn-shrfb-plflip-blt: SKIP (0.000s) [527.644678] [083/130] (493s left) kms_chamelium_hpd (hdmi-hpd-storm) [528.042531] Subtest hdmi-hpd-storm: SKIP (0.000s) [528.884268] [084/130] (492s left) kms_big_fb (x-tiled-64bpp-rotate-180) [528.988458] Starting subtest: x-tiled-64bpp-rotate-180 [530.491018] Subtest x-tiled-64bpp-rotate-180: SUCCESS (1.501s) [530.671421] [085/130] (490s left) syncobj_wait (multi-wait-for-submit-submitted) [530.720717] Starting subtest: multi-wait-for-submit-submitted [530.828990] Subtest multi-wait-for-submit-submitted: SUCCESS (0.108s) [530.929533] [086/130] (490s left) kms_psr (fbc-psr-cursor-mmap-cpu) [531.037319] Starting subtest: fbc-psr-cursor-mmap-cpu [531.039680] Starting dynamic subtest: eDP-1 [531.044207] Dynamic subtest eDP-1: SKIP (0.000s) [531.048637] Subtest fbc-psr-cursor-mmap-cpu: SKIP (0.001s) [531.135794] [087/130] (490s left) gem_render_copy (yf-tiled-ccs-to-yf-tiled) [531.207681] Starting subtest: yf-tiled-ccs-to-yf-tiled [531.211985] Subtest yf-tiled-ccs-to-yf-tiled: SKIP (0.000s) [531.416552] [088/130] (490s left) perf (whitelisted-registers-userspace-config) [531.556962] Starting subtest: whitelisted-registers-userspace-config [531.559140] Subtest whitelisted-registers-userspace-config: SUCCESS (0.001s) [531.600553] [089/130] (490s left) syncobj_timeline (host-signal-ordered) [531.658974] Starting subtest: host-signal-ordered [531.661179] Subtest host-signal-ordered: SUCCESS (0.000s) [531.791965] [090/130] (489s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-mmap-wc) [531.889314] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-mmap-wc [531.893429] Subtest fbc-2p-primscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s) [532.006586] [091/130] (489s left) gem_exec_reloc (basic-cpu-gtt) [532.079403] Subtest basic-cpu-gtt: SKIP (0.000s) [532.163542] [092/130] (489s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-mmap-wc) [532.272238] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-mmap-wc [539.008012] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-mmap-wc: SUCCESS (6.735s) [539.195954] [093/130] (482s left) kms_lease (lease-revoke) [539.298455] Starting subtest: lease-revoke [539.300747] Starting dynamic subtest: pipe-A-eDP-1 [539.328556] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.029s) [539.340820] Starting dynamic subtest: pipe-B-eDP-1 [539.356314] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.026s) [539.372287] Starting dynamic subtest: pipe-C-eDP-1 [539.384616] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.027s) [539.401729] Starting dynamic subtest: pipe-D-eDP-1 [539.410143] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.027s) [539.412454] Subtest lease-revoke: SUCCESS (0.115s) [539.583191] [094/130] (482s left) kms_ccs (crc-primary-suspend-4-tiled-mtl-mc-ccs) [539.696335] Starting subtest: crc-primary-suspend-4-tiled-mtl-mc-ccs [539.698242] Starting dynamic subtest: pipe-A-eDP-1 [571.820348] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.960s) [571.830789] Starting dynamic subtest: pipe-B-eDP-1 [604.752608] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.708s) [604.762922] Starting dynamic subtest: pipe-C-eDP-1 [637.749888] Dynamic subtest pipe-C-eDP-1: SUCCESS (3.739s) [637.760427] Starting dynamic subtest: pipe-D-eDP-1 [670.726556] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.667s) [670.729269] Subtest crc-primary-suspend-4-tiled-mtl-mc-ccs: SUCCESS (14.080s) [671.981895] [095/130] (349s left) kms_cursor_crc (cursor-onscreen-64x64) [672.178693] Starting subtest: cursor-onscreen-64x64 [672.181348] Starting dynamic subtest: pipe-A-eDP-1 [674.301622] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.119s) [674.336283] Starting dynamic subtest: pipe-D-eDP-1 [677.173941] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.844s) [677.176482] Subtest cursor-onscreen-64x64: SUCCESS (4.989s) [678.059846] [096/130] (343s left) kms_psr2_sf (psr2-cursor-plane-move-continuous-sf) [683.106127] Starting subtest: psr2-cursor-plane-move-continuous-sf [683.108810] Starting dynamic subtest: pipe-A-eDP-1 [694.222715] Dynamic subtest pipe-A-eDP-1: SUCCESS (11.109s) [694.234419] Starting dynamic subtest: pipe-B-eDP-1 [705.366113] Dynamic subtest pipe-B-eDP-1: SUCCESS (11.136s) [705.368698] Subtest psr2-cursor-plane-move-continuous-sf: SUCCESS (22.248s) [706.190925] [097/130] (315s left) kms_big_fb (linear-64bpp-rotate-90) [706.300241] Starting subtest: linear-64bpp-rotate-90 [706.320767] Subtest linear-64bpp-rotate-90: SKIP (0.019s) [706.458039] [098/130] (315s left) kms_rotation_crc (primary-yf-tiled-reflect-x-0) [706.566467] Starting subtest: primary-yf-tiled-reflect-x-0 [706.626810] Subtest primary-yf-tiled-reflect-x-0: SKIP (0.059s) [706.753579] [099/130] (315s left) kms_psr2_su (page_flip-nv12) [706.812287] Subtest page_flip-NV12: SKIP (0.000s) [706.881771] [100/130] (315s left) core_getstats (basic) [706.946752] Starting subtest: basic [706.949377] Subtest basic: SUCCESS (0.000s) [707.072377] [101/130] (315s left) gem_lmem_swapping (verify-random) [707.115475] Subtest verify-random: SKIP (0.000s) [707.154118] [102/130] (315s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-pwrite) [707.269476] Starting subtest: psr-2p-primscrn-cur-indfb-draw-pwrite [707.273506] Subtest psr-2p-primscrn-cur-indfb-draw-pwrite: SKIP (0.000s) [707.392192] [103/130] (314s left) kms_async_flips (test-time-stamp-atomic) [707.499556] Starting subtest: test-time-stamp-atomic [707.871874] Starting dynamic subtest: pipe-A-eDP-1 [709.204854] Dynamic subtest pipe-A-eDP-1: FAIL (0.762s) [709.217583] Starting dynamic subtest: pipe-B-eDP-1 [710.091686] Dynamic subtest pipe-B-eDP-1: FAIL (0.773s) [710.151168] Starting dynamic subtest: pipe-C-eDP-1 [710.926564] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.781s) [711.303880] Starting dynamic subtest: pipe-D-eDP-1 [712.065986] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.770s) [712.068971] Subtest test-time-stamp-atomic: FAIL (4.563s) [713.254380] [104/130] (309s left) kms_cursor_legacy (cursora-vs-flipb-legacy) [713.376569] Starting subtest: cursorA-vs-flipB-legacy [713.381868] Subtest cursorA-vs-flipB-legacy: SKIP (0.001s) [713.544851] [105/130] (308s left) gem_exec_balancer (individual) [713.625006] Starting subtest: individual [715.287666] Subtest individual: SUCCESS (1.660s) [715.646311] [106/130] (306s left) perf (invalid-oa-format-id) [715.771589] Starting subtest: invalid-oa-format-id [715.783232] Subtest invalid-oa-format-id: SUCCESS (0.010s) [715.825586] [107/130] (306s left) gem_reg_read (timestamp-moving) [715.886640] Starting subtest: timestamp-moving [716.886597] Subtest timestamp-moving: SUCCESS (1.001s) [716.995701] [108/130] (305s left) gem_exec_fence (basic-wait-all) [717.073708] Starting subtest: basic-wait-all [717.182825] Subtest basic-wait-all: SUCCESS (0.112s) [719.391903] [109/130] (303s left) gem_workarounds (basic-read) [719.459852] Starting subtest: basic-read [719.477650] Subtest basic-read: SUCCESS (0.021s) [719.648485] [110/130] (302s left) gem_ctx_persistence (heartbeat-hostile) [719.713493] Starting subtest: heartbeat-hostile [719.718865] Subtest heartbeat-hostile: SKIP (0.000s) [719.841487] [111/130] (302s left) kms_frontbuffer_tracking (fbc-2p-primscrn-indfb-pgflip-blt) [719.945099] Starting subtest: fbc-2p-primscrn-indfb-pgflip-blt [719.950238] Subtest fbc-2p-primscrn-indfb-pgflip-blt: SKIP (0.000s) [720.081034] [112/130] (302s left) gem_exec_fence (syncobj-invalid-wait) [720.494390] Starting subtest: syncobj-invalid-wait [720.496993] Subtest syncobj-invalid-wait: SUCCESS (0.000s) [722.435161] [113/130] (300s left) kms_flip_scaled_crc (flip-32bpp-linear-to-64bpp-linear-downscaling) [722.537487] Starting subtest: flip-32bpp-linear-to-64bpp-linear-downscaling [722.539855] Starting dynamic subtest: pipe-A-default-mode [723.690860] Dynamic subtest pipe-A-default-mode: SKIP (1.148s) [723.696506] Subtest flip-32bpp-linear-to-64bpp-linear-downscaling: SKIP (1.150s) [723.880946] [114/130] (298s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-mmap-cpu) [723.978757] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-mmap-cpu [723.984094] Subtest fbc-2p-scndscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s) [724.110070] [115/130] (298s left) gem_softpin (allocator-basic-reserve) [724.169887] Starting subtest: allocator-basic-reserve [724.240983] Subtest allocator-basic-reserve: SUCCESS (0.071s) [724.422718] [116/130] (298s left) kms_busy (extended-pageflip-hang-oldfb) [724.534505] Starting subtest: extended-pageflip-hang-oldfb [724.536847] Starting dynamic subtest: pipe-A [724.941605] Dynamic subtest pipe-A: SUCCESS (0.405s) [724.952493] Starting dynamic subtest: pipe-D [726.071623] Dynamic subtest pipe-D: SUCCESS (1.130s) [726.074542] Subtest extended-pageflip-hang-oldfb: SUCCESS (1.539s) [726.951371] [117/130] (295s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-mmap-cpu) [727.070066] Starting subtest: fbcpsr-rgb101010-draw-mmap-cpu [733.741315] Subtest fbcpsr-rgb101010-draw-mmap-cpu: SUCCESS (6.671s) [733.880825] [118/130] (289s left) syncobj_eventfd (binary-wait) [733.944854] Starting subtest: binary-wait [733.954228] Subtest binary-wait: SUCCESS (0.011s) [734.073299] [119/130] (288s left) kms_chamelium_audio (dp-audio) [734.474487] Subtest dp-audio: SKIP (0.000s) [735.272046] [120/130] (287s left) kms_flip (basic-flip-vs-dpms) [735.373971] Starting subtest: basic-flip-vs-dpms [735.376647] Starting dynamic subtest: A-eDP1 [738.002835] Dynamic subtest A-eDP1: SUCCESS (2.625s) [738.014241] Starting dynamic subtest: B-eDP1 [740.178824] Dynamic subtest B-eDP1: SUCCESS (2.172s) [740.190206] Starting dynamic subtest: C-eDP1 [742.235852] Dynamic subtest C-eDP1: SUCCESS (2.058s) [742.247512] Starting dynamic subtest: D-eDP1 [744.320361] Dynamic subtest D-eDP1: SUCCESS (2.082s) [744.322991] Subtest basic-flip-vs-dpms: SUCCESS (8.945s) [745.151161] [121/130] (277s left) gem_pread (snoop) [745.213836] Subtest snoop: SKIP (0.000s) [745.281346] [122/130] (277s left) gen7_exec_parse (cmd-crossing-page) [745.340629] Subtest cmd-crossing-page: SKIP (0.000s) [745.425609] [123/130] (277s left) kms_cursor_legacy (cursorb-vs-flipa-atomic) [745.554871] Starting subtest: cursorB-vs-flipA-atomic [745.560063] Subtest cursorB-vs-flipA-atomic: SKIP (0.001s) [745.721883] [124/130] (277s left) kms_ccs (bad-pixel-format-y-tiled-gen12-rc-ccs-cc) [745.809979] Starting subtest: bad-pixel-format-y-tiled-gen12-rc-ccs-cc [745.812770] Starting dynamic subtest: pipe-A-eDP-1 [745.840631] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [745.851856] Starting dynamic subtest: pipe-B-eDP-1 [745.878394] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [745.891110] Starting dynamic subtest: pipe-C-eDP-1 [745.918600] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [745.929512] Starting dynamic subtest: pipe-D-eDP-1 [745.955699] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [745.960636] Subtest bad-pixel-format-y-tiled-gen12-rc-ccs-cc: SKIP (0.005s) [748.033041] [125/130] (275s left) perf (invalid-oa-exponent) [748.133014] Starting subtest: invalid-oa-exponent [748.144511] Subtest invalid-oa-exponent: SUCCESS (0.011s) [748.191037] [126/130] (275s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-blt) [748.291810] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-blt [748.297087] Subtest psr-2p-scndscrn-cur-indfb-draw-blt: SKIP (0.000s) [748.434659] [127/130] (274s left) vgem_basic (bad-flag) [748.481652] Starting subtest: bad-flag [748.484014] Subtest bad-flag: SUCCESS (0.000s) [748.567940] [128/130] (274s left) kms_hdr (bpc-switch-dpms) [748.659378] Starting subtest: bpc-switch-dpms [748.679429] Starting dynamic subtest: pipe-A-eDP-1 [753.181362] Dynamic subtest pipe-A-eDP-1: SUCCESS (4.503s) [753.183768] Subtest bpc-switch-dpms: SUCCESS (4.521s) [753.330425] [129/130] (270s left) gem_exec_whisper (basic-normal-all) [753.390971] Starting subtest: basic-normal-all [755.682002] Subtest basic-normal-all: SUCCESS (2.287s) [755.892099] [130/130] (267s left) tools_test (sysfs_l3_parity) [755.947442] Starting subtest: sysfs_l3_parity [756.001691] Subtest sysfs_l3_parity: SKIP (0.069s) [756.080884] Closing watchdogs results: parsing output: 0/ for test: i915_drm_fdinfo results: parsing output: 1/ for test: gem_exec_params results: parsing output: 2/ for test: kms_plane_lowres results: parsing output: 3/ for test: kms_flip results: parsing output: 4/ for test: kms_vblank results: parsing output: 5/ for test: kms_plane results: parsing output: 6/ for test: syncobj_wait results: parsing output: 7/ for test: kms_chamelium_hpd results: parsing output: 8/ for test: kms_frontbuffer_tracking results: parsing output: 9/ for test: kms_fence_pin_leak results: parsing output: 10/ for test: syncobj_basic results: parsing output: 11/ for test: syncobj_timeline results: parsing output: 12/ for test: kms_frontbuffer_tracking results: parsing output: 13/ for test: kms_cursor_legacy results: parsing output: 14/ for test: gem_partial_pwrite_pread results: parsing output: 15/ for test: syncobj_wait results: parsing output: 16/ for test: gem_mmap results: parsing output: 17/ for test: gem_lmem_swapping results: parsing output: 18/ for test: prime_self_import results: parsing output: 19/ for test: gem_exec_schedule results: parsing output: 20/ for test: kms_flip results: parsing output: 21/ for test: kms_frontbuffer_tracking results: parsing output: 22/ for test: kms_flip results: parsing output: 23/ for test: perf_pmu results: parsing output: 24/ for test: kms_frontbuffer_tracking results: parsing output: 25/ for test: kms_frontbuffer_tracking results: parsing output: 26/ for test: kms_cursor_legacy results: parsing output: 27/ for test: kms_pm_rpm results: parsing output: 28/ for test: syncobj_timeline results: parsing output: 29/ for test: kms_big_fb results: parsing output: 30/ for test: kms_async_flips results: parsing output: 31/ for test: kms_flip results: parsing output: 32/ for test: gem_exec_fence results: parsing output: 33/ for test: kms_flip_scaled_crc results: parsing output: 34/ for test: kms_big_fb results: parsing output: 35/ for test: gem_exec_capture results: parsing output: 36/ for test: kms_pipe_crc_basic results: parsing output: 37/ for test: syncobj_timeline results: parsing output: 38/ for test: kms_frontbuffer_tracking results: parsing output: 39/ for test: kms_scaling_modes results: parsing output: 40/ for test: kms_pm_rpm results: parsing output: 41/ for test: gem_bad_reloc results: parsing output: 42/ for test: kms_ccs results: parsing output: 43/ for test: kms_ccs results: parsing output: 44/ for test: gem_fenced_exec_thrash results: parsing output: 45/ for test: api_intel_allocator results: parsing output: 46/ for test: kms_cursor_crc results: parsing output: 47/ for test: kms_cursor_legacy results: parsing output: 48/ for test: gem_create results: parsing output: 49/ for test: gem_partial_pwrite_pread results: parsing output: 50/ for test: gen3_mixed_blits results: parsing output: 51/ for test: kms_big_fb results: parsing output: 52/ for test: i915_fb_tiling results: parsing output: 53/ for test: syncobj_timeline results: parsing output: 54/ for test: gem_render_copy results: parsing output: 55/ for test: gem_exec_schedule results: parsing output: 56/ for test: kms_color results: parsing output: 57/ for test: kms_invalid_mode results: parsing output: 58/ for test: perf_pmu results: parsing output: 59/ for test: kms_prop_blob results: parsing output: 60/ for test: kms_big_fb results: parsing output: 61/ for test: kms_psr results: parsing output: 62/ for test: gem_mmap_gtt results: parsing output: 63/ for test: kms_frontbuffer_tracking results: parsing output: 64/ for test: kms_plane_scaling results: parsing output: 65/ for test: kms_flip results: parsing output: 66/ for test: kms_frontbuffer_tracking results: parsing output: 67/ for test: kms_psr results: parsing output: 68/ for test: kms_frontbuffer_tracking results: parsing output: 69/ for test: kms_flip results: parsing output: 70/ for test: i915_suspend results: parsing output: 71/ for test: kms_addfb_basic results: parsing output: 72/ for test: api_intel_bb results: parsing output: 73/ for test: kms_psr results: parsing output: 74/ for test: i915_pm_freq_mult results: parsing output: 75/ for test: kms_rotation_crc results: parsing output: 76/ for test: kms_draw_crc results: parsing output: 77/ for test: gem_ctx_isolation results: parsing output: 78/ for test: kms_universal_plane results: parsing output: 79/ for test: kms_cursor_crc results: parsing output: 80/ for test: gem_spin_batch results: parsing output: 81/ for test: kms_frontbuffer_tracking results: parsing output: 82/ for test: kms_chamelium_hpd results: parsing output: 83/ for test: kms_big_fb results: parsing output: 84/ for test: syncobj_wait results: parsing output: 85/ for test: kms_psr results: parsing output: 86/ for test: gem_render_copy results: parsing output: 87/ for test: perf results: parsing output: 88/ for test: syncobj_timeline results: parsing output: 89/ for test: kms_frontbuffer_tracking results: parsing output: 90/ for test: gem_exec_reloc results: parsing output: 91/ for test: kms_frontbuffer_tracking results: parsing output: 92/ for test: kms_lease results: parsing output: 93/ for test: kms_ccs results: parsing output: 94/ for test: kms_cursor_crc results: parsing output: 95/ for test: kms_psr2_sf results: parsing output: 96/ for test: kms_big_fb results: parsing output: 97/ for test: kms_rotation_crc results: parsing output: 98/ for test: kms_psr2_su results: parsing output: 99/ for test: core_getstats results: parsing output: 100/ for test: gem_lmem_swapping results: parsing output: 101/ for test: kms_frontbuffer_tracking results: parsing output: 102/ for test: kms_async_flips results: parsing output: 103/ for test: kms_cursor_legacy results: parsing output: 104/ for test: gem_exec_balancer results: parsing output: 105/ for test: perf results: parsing output: 106/ for test: gem_reg_read results: parsing output: 107/ for test: gem_exec_fence results: parsing output: 108/ for test: gem_workarounds results: parsing output: 109/ for test: gem_ctx_persistence results: parsing output: 110/ for test: kms_frontbuffer_tracking results: parsing output: 111/ for test: gem_exec_fence results: parsing output: 112/ for test: kms_flip_scaled_crc results: parsing output: 113/ for test: kms_frontbuffer_tracking results: parsing output: 114/ for test: gem_softpin results: parsing output: 115/ for test: kms_busy results: parsing output: 116/ for test: kms_frontbuffer_tracking results: parsing output: 117/ for test: syncobj_eventfd results: parsing output: 118/ for test: kms_chamelium_audio results: parsing output: 119/ for test: kms_flip results: parsing output: 120/ for test: gem_pread results: parsing output: 121/ for test: gen7_exec_parse results: parsing output: 122/ for test: kms_cursor_legacy results: parsing output: 123/ for test: kms_ccs results: parsing output: 124/ for test: perf results: parsing output: 125/ for test: kms_frontbuffer_tracking results: parsing output: 126/ for test: vgem_basic results: parsing output: 127/ for test: kms_hdr results: parsing output: 128/ for test: gem_exec_whisper results: parsing output: 129/ for test: tools_test Done.