[61.962580] Initializing watchdogs [61.962640] /dev/watchdog0 [61.975087] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:4c8a Intel Rocketlake (Gen12) RocketLake-S GT1 [UHD Graphics 750] [61.979778] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [61.981930] [FACT before any test] new: kernel.kmod_is_loaded.i915: true [61.983691] [001/130] (960s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-move) [62.165425] Starting subtest: fbc-1p-primscrn-cur-indfb-move [65.290283] Subtest fbc-1p-primscrn-cur-indfb-move: SUCCESS (3.125s) [65.522317] [002/130] (956s left) kms_getfb (getfb-handle-closed) [65.555275] Starting subtest: getfb-handle-closed [65.555972] Subtest getfb-handle-closed: SUCCESS (0.000s) [65.700215] [003/130] (956s left) kms_ccs (missing-ccs-buffer-4-tiled-mtl-mc-ccs) [65.804967] Starting subtest: missing-ccs-buffer-4-tiled-mtl-mc-ccs [65.805761] Starting dynamic subtest: pipe-A-HDMI-A-2 [65.812378] Dynamic subtest pipe-A-HDMI-A-2: SKIP (0.000s) [65.816856] Starting dynamic subtest: pipe-B-HDMI-A-2 [65.823757] Dynamic subtest pipe-B-HDMI-A-2: SKIP (0.000s) [65.825070] Subtest missing-ccs-buffer-4-tiled-mtl-mc-ccs: SKIP (0.002s) [66.029628] [004/130] (956s left) kms_ccs (bad-rotation-90-4-tiled-mtl-rc-ccs-cc) [66.134970] Starting subtest: bad-rotation-90-4-tiled-mtl-rc-ccs-cc [66.135767] Starting dynamic subtest: pipe-A-HDMI-A-2 [66.142439] Dynamic subtest pipe-A-HDMI-A-2: SKIP (0.000s) [66.146946] Starting dynamic subtest: pipe-B-HDMI-A-2 [66.153497] Dynamic subtest pipe-B-HDMI-A-2: SKIP (0.000s) [66.154836] Subtest bad-rotation-90-4-tiled-mtl-rc-ccs-cc: SKIP (0.002s) [66.357167] [005/130] (956s left) gem_pxp (fail-invalid-protected-context) [247.099161] Per-test timeout exceeded. Killing the current test with SIGQUIT. [256.623196] Closing watchdogs [256.627937] Initializing watchdogs [256.627987] /dev/watchdog0 [256.640620] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:4c8a Intel Rocketlake (Gen12) RocketLake-S GT1 [UHD Graphics 750] [256.645302] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [256.646745] [FACT before any test] new: kernel.kmod_is_loaded.i915: true [256.648550] [006/130] (766s left) kms_getfb (getfb-addfb-different-handles) [256.683582] Starting subtest: getfb-addfb-different-handles [256.684283] Subtest getfb-addfb-different-handles: SUCCESS (0.000s) [256.810671] [007/130] (765s left) kms_dp_aux_dev [257.206039] [008/130] (765s left) kms_atomic_transition (plane-all-modeset-transition-fencing) [257.310042] Starting subtest: plane-all-modeset-transition-fencing [257.310752] Starting dynamic subtest: pipe-A-HDMI-A-2 [269.699483] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (12.388s) [269.751330] Starting dynamic subtest: pipe-B-HDMI-A-2 [278.224668] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (8.481s) [278.244273] Subtest plane-all-modeset-transition-fencing: SUCCESS (20.933s) [278.449682] [009/130] (744s left) gem_render_copy_redux (flink-interruptible) [278.485085] Starting subtest: flink-interruptible [279.252539] Subtest flink-interruptible: SUCCESS (0.767s) [279.394471] [010/130] (743s left) kms_psr (fbc-psr-no-drrs) [279.498557] Subtest fbc-psr-no-drrs: SKIP (0.000s) [279.554116] [011/130] (743s left) syncobj_timeline (etime-single-wait-for-submit-submitted) [279.587667] Starting subtest: etime-single-wait-for-submit-submitted [279.693719] Subtest etime-single-wait-for-submit-submitted: SUCCESS (0.105s) [279.799895] [012/130] (743s left) gem_userptr_blits (sync-unmap-after-close) [279.844174] Starting subtest: sync-unmap-after-close [279.854784] Subtest sync-unmap-after-close: SUCCESS (0.011s) [280.018941] [013/130] (742s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-16bpp-ytile-upscaling) [280.125065] Starting subtest: flip-64bpp-ytile-to-16bpp-ytile-upscaling [280.125785] Starting dynamic subtest: pipe-A-valid-mode [280.748398] Dynamic subtest pipe-A-valid-mode: SUCCESS (0.622s) [280.749193] Subtest flip-64bpp-ytile-to-16bpp-ytile-upscaling: SUCCESS (0.623s) [280.943377] [014/130] (742s left) gem_mmap_wc (bad-offset) [280.977101] Starting subtest: bad-offset [280.977828] Subtest bad-offset: SUCCESS (0.000s) [281.105210] [015/130] (741s left) kms_plane_scaling (plane-downscale-factor-0-25-with-rotation) [281.209010] Starting subtest: plane-downscale-factor-0-25-with-rotation [281.209776] Starting dynamic subtest: pipe-A [281.628488] Dynamic subtest pipe-A: SKIP (0.418s) [281.633452] Starting dynamic subtest: pipe-B [282.251356] Dynamic subtest pipe-B: SKIP (0.622s) [282.252682] Subtest plane-downscale-factor-0-25-with-rotation: SKIP (1.041s) [282.380987] [016/130] (740s left) kms_frontbuffer_tracking (fbc-rgb565-draw-pwrite) [282.489691] Starting subtest: fbc-rgb565-draw-pwrite [285.296696] Subtest fbc-rgb565-draw-pwrite: SUCCESS (2.808s) [285.478681] [017/130] (737s left) kms_cursor_legacy (short-flip-after-cursor-atomic-transitions-varying-size) [285.583549] Starting subtest: short-flip-after-cursor-atomic-transitions-varying-size [286.647998] Subtest short-flip-after-cursor-atomic-transitions-varying-size: SUCCESS (1.063s) [286.839814] [018/130] (736s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-render) [286.948913] Starting subtest: fbcpsr-rgb565-draw-render [286.950250] Subtest fbcpsr-rgb565-draw-render: SKIP (0.000s) [287.107499] [019/130] (736s left) kms_psr (fbc-pr-primary-mmap-cpu) [287.210503] Subtest fbc-pr-primary-mmap-cpu: SKIP (0.000s) [287.257887] [020/130] (735s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-move) [287.369749] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-move [287.371065] Subtest fbcpsr-2p-scndscrn-cur-indfb-move: SKIP (0.000s) [287.506069] [021/130] (735s left) gem_exec_reloc (basic-cpu) [287.541667] Subtest basic-cpu: SKIP (0.000s) [287.623802] [022/130] (735s left) gem_exec_params (invalid-bsd1-flag-on-blt) [287.659211] Starting subtest: invalid-bsd1-flag-on-blt [287.659958] Subtest invalid-bsd1-flag-on-blt: SUCCESS (0.000s) [287.809449] [023/130] (735s left) kms_pm_rpm (modeset-non-lpsp-stress) [289.248186] Starting subtest: modeset-non-lpsp-stress [292.063902] Subtest modeset-non-lpsp-stress: SUCCESS (2.816s) [292.242551] [024/130] (731s left) kms_frontbuffer_tracking (fbc-rgb565-draw-mmap-cpu) [292.352836] Starting subtest: fbc-rgb565-draw-mmap-cpu [294.850876] Subtest fbc-rgb565-draw-mmap-cpu: SUCCESS (2.498s) [295.034505] [025/130] (728s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-render) [295.141813] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-render [297.791746] Subtest fbc-1p-primscrn-pri-indfb-draw-render: SUCCESS (2.651s) [297.974773] [026/130] (725s left) gem_ctx_param (invalid-get-ringsize) [298.008806] Starting subtest: invalid-get-ringsize [298.009536] Subtest invalid-get-ringsize: SUCCESS (0.000s) [298.095245] [027/130] (725s left) kms_ccs (crc-primary-suspend-4-tiled-mtl-mc-ccs) [298.199108] Starting subtest: crc-primary-suspend-4-tiled-mtl-mc-ccs [298.200732] Starting dynamic subtest: pipe-A-HDMI-A-2 [298.203336] Dynamic subtest pipe-A-HDMI-A-2: SKIP (0.000s) [298.208227] Starting dynamic subtest: pipe-B-HDMI-A-2 [298.210832] Dynamic subtest pipe-B-HDMI-A-2: SKIP (0.000s) [298.212137] Subtest crc-primary-suspend-4-tiled-mtl-mc-ccs: SKIP (0.002s) [298.418624] [028/130] (725s left) kms_frontbuffer_tracking (fbcpsr-1p-offscren-pri-shrfb-draw-mmap-wc) [298.526700] Starting subtest: fbcpsr-1p-offscren-pri-shrfb-draw-mmap-wc [298.528006] Subtest fbcpsr-1p-offscren-pri-shrfb-draw-mmap-wc: SKIP (0.000s) [298.666933] [029/130] (724s left) kms_cursor_legacy (cursora-vs-flipb-atomic-transitions-varying-size) [298.769471] Starting subtest: cursorA-vs-flipB-atomic-transitions-varying-size [298.771824] Subtest cursorA-vs-flipB-atomic-transitions-varying-size: SKIP (0.001s) [298.874367] [030/130] (724s left) perf_pmu (semaphore-busy) [298.909025] Starting subtest: semaphore-busy [298.909808] Starting dynamic subtest: rcs0 [300.524946] Dynamic subtest rcs0: SUCCESS (1.614s) [300.532369] Starting dynamic subtest: bcs0 [302.094588] Dynamic subtest bcs0: SUCCESS (1.567s) [302.102038] Starting dynamic subtest: vcs0 [303.660435] Dynamic subtest vcs0: SUCCESS (1.564s) [303.669380] Starting dynamic subtest: vecs0 [305.228482] Dynamic subtest vecs0: SUCCESS (1.566s) [305.229703] Subtest semaphore-busy: SUCCESS (6.319s) [305.358574] [031/130] (718s left) kms_rotation_crc (primary-x-tiled-reflect-x-0) [305.462315] Starting subtest: primary-x-tiled-reflect-x-0 [313.344746] Subtest primary-x-tiled-reflect-x-0: SUCCESS (7.882s) [313.561707] [032/130] (710s left) api_intel_allocator (two-level-inception-interruptible) [313.594714] Starting subtest: two-level-inception-interruptible [319.022060] Subtest two-level-inception-interruptible: SUCCESS (5.427s) [319.185687] [033/130] (704s left) kms_flip_scaled_crc (flip-32bpp-yftileccs-to-64bpp-yftile-upscaling) [319.291373] Starting subtest: flip-32bpp-yftileccs-to-64bpp-yftile-upscaling [319.293313] Starting dynamic subtest: pipe-A-valid-mode [319.331253] Dynamic subtest pipe-A-valid-mode: SKIP (0.038s) [319.332659] Subtest flip-32bpp-yftileccs-to-64bpp-yftile-upscaling: SKIP (0.039s) [319.455615] [034/130] (704s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-blt) [319.562746] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-blt [321.975076] Subtest fbc-1p-primscrn-cur-indfb-draw-blt: SUCCESS (2.406s) [322.155820] [035/130] (701s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-180-async-flip) [322.272598] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-180-async-flip [322.783860] Subtest x-tiled-max-hw-stride-64bpp-rotate-180-async-flip: SUCCESS (0.511s) [322.985190] [036/130] (700s left) gem_exec_reloc (basic-write-read) [323.021643] Subtest basic-write-read: SKIP (0.000s) [323.125913] [037/130] (700s left) kms_big_fb (x-tiled-16bpp-rotate-180) [323.238505] Starting subtest: x-tiled-16bpp-rotate-180 [325.042084] Subtest x-tiled-16bpp-rotate-180: SUCCESS (1.803s) [325.258669] [038/130] (698s left) perf (gen8-unprivileged-single-ctx-counters) [325.354767] Starting subtest: gen8-unprivileged-single-ctx-counters [325.356082] Subtest gen8-unprivileged-single-ctx-counters: SKIP (0.000s) [325.392753] [039/130] (698s left) gen7_exec_parse (bitmasks) [325.428283] Subtest bitmasks: SKIP (0.000s) [325.461832] [040/130] (698s left) perf (gen12-group-exclusive-stream-sample-oa) [325.561461] Starting subtest: gen12-group-exclusive-stream-sample-oa [325.577741] Subtest gen12-group-exclusive-stream-sample-oa: SUCCESS (0.016s) [325.620503] [041/130] (698s left) kms_flip (bo-too-big) [325.725760] Starting subtest: bo-too-big [325.727672] Starting dynamic subtest: A-HDMI-A2 [326.576073] Dynamic subtest A-HDMI-A2: SUCCESS (0.849s) [326.585564] Starting dynamic subtest: B-HDMI-A2 [327.354968] Dynamic subtest B-HDMI-A2: SUCCESS (0.776s) [327.358015] Subtest bo-too-big: SUCCESS (1.632s) [327.670251] [042/130] (696s left) syncobj_wait (multi-wait-all-for-submit-unsubmitted) [327.705081] Starting subtest: multi-wait-all-for-submit-unsubmitted [327.813733] Subtest multi-wait-all-for-submit-unsubmitted: SUCCESS (0.108s) [327.923578] [043/130] (696s left) gem_exec_fence (submit) [328.097216] Starting subtest: submit [328.098064] Starting dynamic subtest: rcs0 [328.105606] Dynamic subtest rcs0: SUCCESS (0.008s) [328.111324] Starting dynamic subtest: bcs0 [328.112043] Dynamic subtest bcs0: SUCCESS (0.006s) [328.117730] Starting dynamic subtest: vcs0 [328.119446] Dynamic subtest vcs0: SUCCESS (0.006s) [328.124849] Starting dynamic subtest: vecs0 [328.125534] Dynamic subtest vecs0: SUCCESS (0.005s) [328.126228] Subtest submit: SUCCESS (0.028s) [328.619185] [FACT gem_exec_fence (submit)] new: kernel.kmod_is_loaded.vgem: true [328.620836] [044/130] (695s left) kms_invalid_mode (int-max-clock) [328.727827] Starting subtest: int-max-clock [328.728638] Starting dynamic subtest: pipe-A-HDMI-A-2 [328.767668] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (0.038s) [328.774401] Starting dynamic subtest: pipe-B-HDMI-A-2 [328.775086] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (0.000s) [328.775759] Subtest int-max-clock: SUCCESS (0.042s) [328.955611] [045/130] (695s left) i915_pciid [329.080854] [046/130] (695s left) drm_buddy (drm_buddy) [329.114512] Starting subtest: drm_buddy [329.118816] Starting dynamic subtest: drm_test_buddy_alloc_limit [329.241357] Dynamic subtest drm_test_buddy_alloc_limit: SUCCESS (0.122s) [329.254427] Starting dynamic subtest: drm_test_buddy_alloc_optimistic [329.343204] Dynamic subtest drm_test_buddy_alloc_optimistic: SUCCESS (0.100s) [329.362744] Starting dynamic subtest: drm_test_buddy_alloc_pessimistic [329.441289] Dynamic subtest drm_test_buddy_alloc_pessimistic: SUCCESS (0.095s) [329.451100] Starting dynamic subtest: drm_test_buddy_alloc_pathological [329.521043] Dynamic subtest drm_test_buddy_alloc_pathological: SUCCESS (0.075s) [329.535327] Starting dynamic subtest: drm_test_buddy_alloc_contiguous [329.630705] Dynamic subtest drm_test_buddy_alloc_contiguous: SUCCESS (0.106s) [329.648956] Starting dynamic subtest: drm_test_buddy_alloc_clear [329.785589] Dynamic subtest drm_test_buddy_alloc_clear: SUCCESS (0.155s) [329.791396] Starting dynamic subtest: drm_test_buddy_alloc_range_bias [329.913731] Dynamic subtest drm_test_buddy_alloc_range_bias: SUCCESS (0.125s) [329.914397] Subtest drm_buddy: SUCCESS (0.798s) [330.099368] [047/130] (694s left) syncobj_timeline (multi-wait-available-unsubmitted-submitted) [330.133706] Starting subtest: multi-wait-available-unsubmitted-submitted [330.134371] Subtest multi-wait-available-unsubmitted-submitted: SUCCESS (0.000s) [330.223656] [048/130] (694s left) kms_frontbuffer_tracking (psr-rgb565-draw-mmap-cpu) [330.333690] Starting subtest: psr-rgb565-draw-mmap-cpu [330.335062] Subtest psr-rgb565-draw-mmap-cpu: SKIP (0.000s) [330.476297] [049/130] (693s left) gen9_exec_parse (bb-chained) [330.512829] Subtest bb-chained: SKIP (0.000s) [330.575114] [050/130] (693s left) gem_mmap_gtt (cpuset-medium-copy-xy) [330.608311] Starting subtest: cpuset-medium-copy-XY [343.876160] Subtest cpuset-medium-copy-XY: SUCCESS (13.268s) [344.036419] [051/130] (680s left) syncobj_eventfd (binary-wait-signaled) [344.102047] Starting subtest: binary-wait-signaled [344.102748] Subtest binary-wait-signaled: SUCCESS (0.000s) [344.204149] [052/130] (680s left) gem_lmem_swapping (verify-ccs) [344.241496] Subtest verify-ccs: SKIP (0.000s) [344.279552] [053/130] (680s left) gem_exec_whisper (basic-fds) [344.324425] Starting subtest: basic-fds [346.549705] Subtest basic-fds: SUCCESS (2.225s) [346.760290] [054/130] (677s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-render) [346.871847] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-render [346.873230] Subtest psr-2p-scndscrn-cur-indfb-draw-render: SKIP (0.000s) [347.001705] [055/130] (677s left) core_auth (getclient-master-drop) [347.034263] Starting subtest: getclient-master-drop [347.035679] Subtest getclient-master-drop: SUCCESS (0.001s) [347.125776] [056/130] (677s left) gem_exec_fence (syncobj-timeline-wait) [347.578501] Starting subtest: syncobj-timeline-wait [347.630239] Subtest syncobj-timeline-wait: SUCCESS (0.052s) [347.828032] [057/130] (676s left) i915_pm_sseu (full-enable) [347.866016] Subtest full-enable: SKIP (0.000s) [347.966987] [058/130] (676s left) syncobj_wait (invalid-multi-wait-all-unsubmitted-signaled) [348.000725] Starting subtest: invalid-multi-wait-all-unsubmitted-signaled [348.002413] Subtest invalid-multi-wait-all-unsubmitted-signaled: SUCCESS (0.001s) [348.102361] [059/130] (676s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-180-hflip) [348.215717] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-180-hflip [349.586257] Subtest y-tiled-max-hw-stride-32bpp-rotate-180-hflip: SUCCESS (1.370s) [349.801430] [060/130] (674s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-render) [349.908647] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-render [349.909996] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-render: SKIP (0.000s) [350.048385] [061/130] (674s left) kms_psr (pr-sprite-blt) [350.152640] Subtest pr-sprite-blt: SKIP (0.000s) [350.207741] [062/130] (674s left) kms_getfb (getfb2-handle-not-fb) [350.241844] Starting subtest: getfb2-handle-not-fb [350.312876] Subtest getfb2-handle-not-fb: SUCCESS (0.072s) [350.456172] [063/130] (674s left) syncobj_wait (multi-wait-all-for-submit-unsubmitted-submitted) [350.489692] Starting subtest: multi-wait-all-for-submit-unsubmitted-submitted [350.597631] Subtest multi-wait-all-for-submit-unsubmitted-submitted: SUCCESS (0.107s) [350.701543] [064/130] (674s left) gem_render_copy (linear-to-vebox-yf-tiled) [350.742140] Starting subtest: linear-to-vebox-yf-tiled [350.742894] Starting dynamic subtest: smem [350.812690] Dynamic subtest smem: SUCCESS (0.070s) [350.813387] Subtest linear-to-vebox-yf-tiled: SUCCESS (0.071s) [351.025464] [065/130] (673s left) kms_psr (psr2-sprite-render) [351.132539] Subtest psr2-sprite-render: SKIP (0.000s) [351.189672] [066/130] (673s left) kms_big_fb (linear-32bpp-rotate-270) [351.299737] Starting subtest: linear-32bpp-rotate-270 [351.370723] Subtest linear-32bpp-rotate-270: SKIP (0.070s) [351.517880] [067/130] (673s left) kms_big_fb (yf-tiled-8bpp-rotate-90) [351.629353] Starting subtest: yf-tiled-8bpp-rotate-90 [351.630670] Subtest yf-tiled-8bpp-rotate-90: SKIP (0.000s) [351.774933] [068/130] (673s left) gem_exec_params (invalid-bsd1-flag-on-vebox) [351.810459] Starting subtest: invalid-bsd1-flag-on-vebox [351.811167] Subtest invalid-bsd1-flag-on-vebox: SUCCESS (0.000s) [351.936321] [069/130] (673s left) kms_pm_backlight (bad-brightness) [352.040508] Subtest bad-brightness: SKIP (0.000s) [352.077792] [070/130] (673s left) kms_ccs (bad-rotation-90-4-tiled-bmg-ccs) [352.181295] Starting subtest: bad-rotation-90-4-tiled-bmg-ccs [352.182705] Subtest bad-rotation-90-4-tiled-bmg-ccs: SKIP (0.000s) [352.363671] [071/130] (672s left) gem_render_tiled_blits (basic) [352.399574] Starting subtest: basic [352.422798] Subtest basic: SUCCESS (0.024s) [352.543390] [072/130] (672s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-mmap-wc) [352.651835] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-mmap-wc [352.653239] Subtest fbc-2p-scndscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s) [352.774267] [073/130] (672s left) gem_exec_reloc (basic-gtt-read-active) [352.811647] Subtest basic-gtt-read-active: SKIP (0.000s) [352.917376] [074/130] (672s left) kms_cursor_legacy (cursora-vs-flipb-varying-size) [353.024942] Starting subtest: cursorA-vs-flipB-varying-size [353.026347] Subtest cursorA-vs-flipB-varying-size: SKIP (0.001s) [353.122411] [075/130] (672s left) fbdev (unaligned-write) [353.165909] Starting subtest: unaligned-write [353.273021] Subtest unaligned-write: SUCCESS (0.107s) [353.331245] [076/130] (672s left) perf (short-reads) [353.437030] Starting subtest: short-reads [353.455487] Subtest short-reads: SUCCESS (0.018s) [353.502282] [077/130] (671s left) gem_exec_balancer (full-late) [353.542947] Starting subtest: full-late [354.976730] Subtest full-late: SUCCESS (1.434s) [355.178714] [078/130] (670s left) kms_chamelium_hpd (hdmi-hpd-enable-disable-mode) [355.337184] Subtest hdmi-hpd-enable-disable-mode: SKIP (0.000s) [355.410723] [079/130] (670s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-mmap-wc) [355.518703] Starting subtest: psr-2p-primscrn-spr-indfb-draw-mmap-wc [355.520016] Subtest psr-2p-primscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s) [355.665461] [080/130] (669s left) kms_cursor_crc (cursor-sliding-256x85) [355.777282] Starting subtest: cursor-sliding-256x85 [355.780007] Starting dynamic subtest: pipe-A-HDMI-A-2 [359.828976] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (4.049s) [359.860851] Starting dynamic subtest: pipe-B-HDMI-A-2 [363.774848] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (3.920s) [363.775526] Subtest cursor-sliding-256x85: SUCCESS (7.998s) [363.962439] [081/130] (661s left) kms_cursor_crc (cursor-dpms) [364.066704] Starting subtest: cursor-dpms [364.067394] Starting dynamic subtest: pipe-A-HDMI-A-2 [365.077680] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (1.010s) [365.088008] Starting dynamic subtest: pipe-B-HDMI-A-2 [365.904061] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (0.823s) [365.904757] Subtest cursor-dpms: SUCCESS (1.838s) [366.108039] [082/130] (659s left) gem_ctx_engines (none) [366.149977] Starting subtest: none [366.151734] Subtest none: SUCCESS (0.001s) [366.374889] [083/130] (659s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-blt) [366.483652] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-blt [366.484930] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-blt: SKIP (0.000s) [366.620735] [084/130] (659s left) syncobj_timeline (etime-multi-wait-all-available-unsubmitted-signaled) [366.654386] Starting subtest: etime-multi-wait-all-available-unsubmitted-signaled [366.764566] Subtest etime-multi-wait-all-available-unsubmitted-signaled: SUCCESS (0.103s) [366.868361] [085/130] (658s left) intel_hwmon (hwmon-write) [366.902661] Subtest hwmon-write: SKIP (0.000s) [366.938148] [086/130] (658s left) kms_pipe_crc_basic (compare-crc-sanitycheck-xr24) [367.043327] Starting subtest: compare-crc-sanitycheck-xr24 [367.045162] Starting dynamic subtest: pipe-A-HDMI-A-2 [367.487509] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (0.442s) [367.497432] Starting dynamic subtest: pipe-B-HDMI-A-2 [367.849991] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (0.361s) [367.850691] Subtest compare-crc-sanitycheck-xr24: SUCCESS (0.807s) [368.030754] [087/130] (657s left) drm_read (short-buffer-block) [368.170710] Starting subtest: short-buffer-block [368.171608] Subtest short-buffer-block: SUCCESS (0.000s) [368.348852] [088/130] (657s left) kms_scaling_modes (scaling-mode-none) [368.454606] Starting subtest: scaling-mode-none [368.457892] Subtest scaling-mode-none: SKIP (0.001s) [368.564931] [089/130] (657s left) gem_exec_schedule (implicit-read-write) [368.609867] Starting subtest: implicit-read-write [368.610549] Starting dynamic subtest: rcs0 [368.656963] Dynamic subtest rcs0: SUCCESS (0.048s) [368.668972] Starting dynamic subtest: bcs0 [368.707325] Dynamic subtest bcs0: SUCCESS (0.048s) [368.720045] Starting dynamic subtest: vcs0 [368.759426] Dynamic subtest vcs0: SUCCESS (0.050s) [368.772734] Starting dynamic subtest: vecs0 [368.812874] Dynamic subtest vecs0: SUCCESS (0.051s) [368.814213] Subtest implicit-read-write: SUCCESS (0.205s) [369.142389] [090/130] (656s left) kms_atomic_interruptible (legacy-setmode) [369.251199] Starting subtest: legacy-setmode [369.251984] Starting dynamic subtest: pipe-A-HDMI-A-2 [375.448349] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (6.195s) [375.449366] Subtest legacy-setmode: SUCCESS (6.198s) [375.651501] [091/130] (650s left) kms_cursor_edge_walk (256x256-top-bottom) [375.757389] Starting subtest: 256x256-top-bottom [375.759526] Starting dynamic subtest: pipe-A-HDMI-A-2 [379.420026] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (3.661s) [379.427472] Starting dynamic subtest: pipe-B-HDMI-A-2 [383.032857] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (3.612s) [383.033549] Subtest 256x256-top-bottom: SUCCESS (7.276s) [383.153211] [092/130] (642s left) gem_ctx_persistence (many-contexts) [383.189543] Starting subtest: many-contexts [422.757813] Subtest many-contexts: SUCCESS (39.568s) [422.847312] [093/130] (603s left) kms_psr (pr-primary-page-flip) [422.950569] Subtest pr-primary-page-flip: SKIP (0.000s) [423.011191] [094/130] (603s left) gem_softpin (reverse) [423.049698] Starting subtest: reverse [423.056188] Subtest reverse: SUCCESS (0.006s) [423.219214] [095/130] (602s left) kms_big_fb (y-tiled-32bpp-rotate-90) [423.329188] Starting subtest: y-tiled-32bpp-rotate-90 [425.459498] Subtest y-tiled-32bpp-rotate-90: SUCCESS (2.130s) [425.679124] [096/130] (600s left) i915_query (query-topology-unsupported) [425.712219] Starting subtest: query-topology-unsupported [425.713680] Subtest query-topology-unsupported: SKIP (0.000s) [425.793731] [097/130] (600s left) kms_flip (absolute-wf_vblank) [425.899487] Starting subtest: absolute-wf_vblank [425.901682] Starting dynamic subtest: A-HDMI-A2 [441.274994] Dynamic subtest A-HDMI-A2: SUCCESS (15.372s) [441.285463] Starting dynamic subtest: B-HDMI-A2 [456.613661] Dynamic subtest B-HDMI-A2: SUCCESS (15.335s) [456.617307] Subtest absolute-wf_vblank: SUCCESS (30.717s) [456.841722] [098/130] (569s left) kms_writeback (writeback-fb-id-xrgb2101010) [456.946465] Subtest writeback-fb-id-XRGB2101010: SKIP (0.000s) [456.985666] [099/130] (569s left) gem_softpin (allocator-basic-reserve) [457.021633] Starting subtest: allocator-basic-reserve [457.080468] Subtest allocator-basic-reserve: SUCCESS (0.059s) [457.232721] [100/130] (569s left) gem_exec_schedule (semaphore-codependency) [457.276306] Starting subtest: semaphore-codependency [457.281063] Subtest semaphore-codependency: SUCCESS (0.005s) [457.620053] [101/130] (568s left) gem_exec_schedule (u-submit-late-slice) [457.664117] Starting subtest: u-submit-late-slice [457.664840] Starting dynamic subtest: rcs0 [457.681929] Dynamic subtest rcs0: SUCCESS (0.017s) [457.689465] Starting dynamic subtest: bcs0 [457.711608] Dynamic subtest bcs0: SUCCESS (0.029s) [457.722442] Starting dynamic subtest: vcs0 [457.730788] Dynamic subtest vcs0: SUCCESS (0.017s) [457.737420] Starting dynamic subtest: vecs0 [457.747813] Dynamic subtest vecs0: SUCCESS (0.016s) [457.748487] Subtest u-submit-late-slice: SUCCESS (0.084s) [458.086438] [102/130] (568s left) kms_psr2_sf (pr-overlay-plane-update-sf-dmg-area) [458.192386] Subtest pr-overlay-plane-update-sf-dmg-area: SKIP (0.000s) [458.247809] [103/130] (568s left) gem_workarounds (suspend-resume) [458.290275] Starting subtest: suspend-resume [475.744892] Subtest suspend-resume: SUCCESS (17.454s) [481.928687] [104/130] (550s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-pwrite) [482.042133] Starting subtest: psr-1p-primscrn-spr-indfb-draw-pwrite [482.043468] Subtest psr-1p-primscrn-spr-indfb-draw-pwrite: SKIP (0.000s) [482.199807] [105/130] (550s left) kms_feature_discovery (psr1) [482.304747] Starting subtest: psr1 [482.306109] Subtest psr1: SKIP (0.000s) [482.404199] [106/130] (550s left) kms_cursor_legacy (basic-flip-after-cursor-varying-size) [482.510509] Starting subtest: basic-flip-after-cursor-varying-size [483.550694] Subtest basic-flip-after-cursor-varying-size: SUCCESS (1.039s) [483.713479] [107/130] (548s left) gem_exec_flush (basic-batch-kernel-default-uc) [483.755844] Starting subtest: basic-batch-kernel-default-uc [489.544309] Subtest basic-batch-kernel-default-uc: SUCCESS (5.788s) [489.806416] [108/130] (542s left) kms_cursor_crc (cursor-onscreen-256x256) [489.914864] Starting subtest: cursor-onscreen-256x256 [489.917596] Starting dynamic subtest: pipe-A-HDMI-A-2 [492.442871] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (2.524s) [492.470038] Starting dynamic subtest: pipe-B-HDMI-A-2 [494.885988] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (2.422s) [494.886688] Subtest cursor-onscreen-256x256: SUCCESS (4.971s) [495.068748] [109/130] (537s left) sysfs_timeslice_duration (duration) [495.105030] Starting subtest: duration [495.106737] Starting dynamic subtest: vecs0 [495.158654] Dynamic subtest vecs0: SUCCESS (0.052s) [495.177816] Starting dynamic subtest: vcs0 [495.247943] Dynamic subtest vcs0: SUCCESS (0.086s) [495.270974] Starting dynamic subtest: bcs0 [495.344028] Dynamic subtest bcs0: SUCCESS (0.085s) [495.360681] Starting dynamic subtest: rcs0 [495.448708] Dynamic subtest rcs0: SUCCESS (0.108s) [495.452459] Subtest duration: SUCCESS (0.345s) [495.566519] [110/130] (537s left) syncobj_timeline (multi-wait-for-submit-available-unsubmitted-submitted-signa [495.599490] Starting subtest: multi-wait-for-submit-available-unsubmitted-submitted-signaled [495.600182] Subtest multi-wait-for-submit-available-unsubmitted-submitted-signaled: SUCCESS (0.000s) [495.690504] [111/130] (537s left) gem_exec_balancer (bonded-dual) [495.732737] Starting subtest: bonded-dual [496.753058] Subtest bonded-dual: SUCCESS (1.021s) [496.960475] [112/130] (535s left) kms_plane_lowres (tiling-none) [497.065345] Starting subtest: tiling-none [497.067112] Starting dynamic subtest: pipe-A-HDMI-A-2 [500.801949] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (3.735s) [500.849405] Starting dynamic subtest: pipe-B-HDMI-A-2 [504.393913] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (3.540s) [504.425365] Subtest tiling-none: SUCCESS (7.359s) [504.624034] [113/130] (528s left) gem_exec_reloc (basic-wc-active) [504.662401] Subtest basic-wc-active: SKIP (0.000s) [504.762883] [114/130] (528s left) kms_vblank (query-idle) [504.867269] Starting subtest: query-idle [504.869099] Starting dynamic subtest: pipe-A-HDMI-A-2 [507.405814] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (2.536s) [507.415382] Starting dynamic subtest: pipe-B-HDMI-A-2 [509.847980] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (2.440s) [509.848724] Subtest query-idle: SUCCESS (4.980s) [510.023770] [115/130] (522s left) kms_addfb_basic (size-max) [510.127202] Starting subtest: size-max [510.127904] Subtest size-max: SUCCESS (0.000s) [510.251559] [116/130] (522s left) kms_frontbuffer_tracking (psr-1p-primscrn-indfb-msflip-blt) [510.362902] Starting subtest: psr-1p-primscrn-indfb-msflip-blt [510.364303] Subtest psr-1p-primscrn-indfb-msflip-blt: SKIP (0.000s) [510.498609] [117/130] (522s left) kms_psr2_sf (fbc-psr2-cursor-plane-move-continuous-exceed-sf) [510.607515] Subtest fbc-psr2-cursor-plane-move-continuous-exceed-sf: SKIP (0.000s) [510.662047] [118/130] (522s left) kms_chamelium_hpd (vga-hpd-with-enabled-mode) [510.803764] Subtest vga-hpd-with-enabled-mode: SKIP (0.000s) [510.877098] [119/130] (522s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-cpu) [510.987795] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-cpu [510.989104] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s) [511.129758] [120/130] (522s left) kms_flip (blocking-absolute-wf_vblank) [511.234779] Starting subtest: blocking-absolute-wf_vblank [511.235765] Starting dynamic subtest: A-HDMI-A2 [526.609639] Dynamic subtest A-HDMI-A2: SUCCESS (15.373s) [526.620434] Starting dynamic subtest: B-HDMI-A2 [541.923036] Dynamic subtest B-HDMI-A2: SUCCESS (15.310s) [541.925535] Subtest blocking-absolute-wf_vblank: SUCCESS (30.690s) [542.132374] [121/130] (491s left) kms_ccs (random-ccs-data-4-tiled-mtl-rc-ccs) [542.235261] Starting subtest: random-ccs-data-4-tiled-mtl-rc-ccs [542.237013] Starting dynamic subtest: pipe-A-HDMI-A-2 [542.244120] Dynamic subtest pipe-A-HDMI-A-2: SKIP (0.000s) [542.251474] Starting dynamic subtest: pipe-B-HDMI-A-2 [542.258668] Dynamic subtest pipe-B-HDMI-A-2: SKIP (0.000s) [542.260006] Subtest random-ccs-data-4-tiled-mtl-rc-ccs: SKIP (0.003s) [542.463472] [122/130] (490s left) drm_fdinfo (virtual-idle) [542.498738] Starting subtest: virtual-idle [544.512425] Subtest virtual-idle: SUCCESS (2.010s) [544.599720] [123/130] (488s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-mmap-wc) [544.708661] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-mmap-wc [544.710005] Subtest fbc-2p-primscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s) [544.846787] [124/130] (488s left) kms_async_flips (invalid-async-flip) [544.951849] Starting subtest: invalid-async-flip [545.145914] Starting dynamic subtest: pipe-A-HDMI-A-2 [545.332477] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (0.186s) [545.483577] Starting dynamic subtest: pipe-B-HDMI-A-2 [545.570837] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (0.094s) [545.571600] Subtest invalid-async-flip: SUCCESS (0.620s) [545.837160] [125/130] (487s left) kms_rotation_crc (sprite-rotation-270) [545.942359] Starting subtest: sprite-rotation-270 [552.459693] Subtest sprite-rotation-270: SUCCESS (6.517s) [552.706956] [126/130] (480s left) kms_chamelium_frames (dp-frame-dump) [552.851056] Subtest dp-frame-dump: SKIP (0.000s) [552.922670] [127/130] (480s left) kms_atomic_transition (modeset-transition) [553.028534] Starting subtest: modeset-transition [553.029239] Starting dynamic subtest: 1x-outputs [553.638058] Dynamic subtest 1x-outputs: SUCCESS (0.608s) [553.659981] Subtest modeset-transition: SUCCESS (0.631s) [553.840555] [128/130] (479s left) kms_cursor_legacy (flip-vs-cursor-toggle) [553.945613] Starting subtest: flip-vs-cursor-toggle [563.883538] Subtest flip-vs-cursor-toggle: SUCCESS (9.937s) [564.066254] [129/130] (469s left) kms_plane_scaling (plane-downscale-factor-0-75-with-pixel-format) [564.171292] Starting subtest: plane-downscale-factor-0-75-with-pixel-format [564.171997] Starting dynamic subtest: pipe-A [566.244141] Dynamic subtest pipe-A: SUCCESS (2.072s) [566.263382] Starting dynamic subtest: pipe-B [568.392396] Dynamic subtest pipe-B: SUCCESS (2.145s) [568.393724] Subtest plane-downscale-factor-0-75-with-pixel-format: SUCCESS (4.222s) [568.583926] [130/130] (465s left) syncobj_timeline (wait-zero-handles) [568.618431] Starting subtest: wait-zero-handles [568.619124] Subtest wait-zero-handles: SUCCESS (0.000s) [568.711106] Closing watchdogs Done.