[60.971297] Initializing watchdogs
[60.971362]   /dev/watchdog0
[60.991484] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:03:00.0: 8086:56a0 Intel Dg2 (Gen12) DG2 [Arc A770]
[61.002191] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[61.006092] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[61.008533] [001/132] (960s left) kms_properties (invalid-properties-legacy)
[61.188221] Starting subtest: invalid-properties-legacy
[61.349847] Subtest invalid-properties-legacy: SUCCESS (0.161s)
[61.501272] [002/132] (960s left) gem_ringfill (legacy-basic)
[61.930111] Starting subtest: legacy-basic
[61.931760] Starting dynamic subtest: default
[62.042203] Dynamic subtest default: SUCCESS (0.112s)
[62.053074] Starting dynamic subtest: render
[62.083498] Dynamic subtest render: SUCCESS (0.040s)
[62.115219] Starting dynamic subtest: bsd
[62.133884] Dynamic subtest bsd: SUCCESS (0.049s)
[62.156662] Starting dynamic subtest: bsd1
[62.180417] Dynamic subtest bsd1: SUCCESS (0.046s)
[62.195479] Starting dynamic subtest: bsd2
[62.225721] Dynamic subtest bsd2: SUCCESS (0.044s)
[62.250210] Starting dynamic subtest: blt
[62.272155] Dynamic subtest blt: SUCCESS (0.045s)
[62.296422] Starting dynamic subtest: vebox
[62.319514] Dynamic subtest vebox: SUCCESS (0.046s)
[62.320616] Subtest legacy-basic: SUCCESS (0.390s)
[62.504551] [FACT gem_ringfill (legacy-basic)] new: kernel.kmod_is_loaded.vgem: true
[62.506383] [003/132] (959s left) kms_cursor_legacy (2x-flip-vs-cursor-legacy)
[62.689886] Starting subtest: 2x-flip-vs-cursor-legacy
[62.692598] Subtest 2x-flip-vs-cursor-legacy: SKIP (0.002s)
[62.839388] [004/132] (958s left) kms_cursor_crc (cursor-rapid-movement-512x170)
[63.333485] Starting subtest: cursor-rapid-movement-512x170
[63.336218] Subtest cursor-rapid-movement-512x170: SKIP (0.001s)
[63.574173] [005/132] (958s left) kms_ccs (crc-primary-rotation-180-4-tiled-dg2-rc-ccs-cc)
[63.758095] Starting subtest: crc-primary-rotation-180-4-tiled-dg2-rc-ccs-cc
[63.759035] Starting dynamic subtest: pipe-A-DP-3
[63.767686] Dynamic subtest pipe-A-DP-3: SKIP (0.001s)
[63.775666] Starting dynamic subtest: pipe-B-DP-3
[63.784198] Dynamic subtest pipe-B-DP-3: SKIP (0.001s)
[63.792989] Starting dynamic subtest: pipe-C-DP-3
[63.801252] Dynamic subtest pipe-C-DP-3: SKIP (0.001s)
[63.808976] Starting dynamic subtest: pipe-D-DP-3
[63.818546] Dynamic subtest pipe-D-DP-3: SKIP (0.001s)
[63.820543] Subtest crc-primary-rotation-180-4-tiled-dg2-rc-ccs-cc: SKIP (0.006s)
[64.251366] [006/132] (957s left) api_intel_bb (blit-noreloc-purge-cache)
[64.329904] Starting subtest: blit-noreloc-purge-cache
[64.364192] Subtest blit-noreloc-purge-cache: SUCCESS (0.035s)
[64.538085] [007/132] (957s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-blt)
[64.727606] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-blt
[64.729249] Subtest psr-2p-scndscrn-cur-indfb-draw-blt: SKIP (0.000s)
[64.932913] [008/132] (957s left) kms_flip_scaled_crc (flip-32bpp-yftile-to-32bpp-yftileccs-downscaling)
[65.119438] Starting subtest: flip-32bpp-yftile-to-32bpp-yftileccs-downscaling
[65.120334] Starting dynamic subtest: pipe-A-valid-mode
[65.200438] Dynamic subtest pipe-A-valid-mode: SKIP (0.079s)
[65.202287] Subtest flip-32bpp-yftile-to-32bpp-yftileccs-downscaling: SKIP (0.080s)
[65.446455] [009/132] (956s left) gem_partial_pwrite_pread (writes-after-reads-snoop)
[65.530403] Subtest writes-after-reads-snoop: SKIP (0.000s)
[65.644358] [010/132] (956s left) gem_ctx_isolation (preservation)
[65.732543] Starting subtest: preservation
[65.733480] Starting dynamic subtest: rcs0
[66.160620] Dynamic subtest rcs0: SUCCESS (0.427s)
[66.169053] Starting dynamic subtest: bcs0
[66.624362] Dynamic subtest bcs0: SUCCESS (0.464s)
[66.632521] Starting dynamic subtest: vcs0
[67.303684] Dynamic subtest vcs0: SUCCESS (0.679s)
[67.312168] Starting dynamic subtest: vcs1
[67.984568] Dynamic subtest vcs1: SUCCESS (0.681s)
[67.993254] Starting dynamic subtest: vecs0
[68.417590] Dynamic subtest vecs0: SUCCESS (0.433s)
[68.425969] Starting dynamic subtest: vecs1
[68.865979] Dynamic subtest vecs1: SUCCESS (0.448s)
[68.874658] Starting dynamic subtest: ccs0
[69.318730] Dynamic subtest ccs0: SUCCESS (0.453s)
[69.319598] Subtest preservation: SUCCESS (3.586s)
[69.608960] [011/132] (952s left) i915_power (sanity)
[69.691015] Starting subtest: sanity
[73.760986] Subtest sanity: SUCCESS (4.069s)
[73.933167] [012/132] (948s left) gem_exec_fence (syncobj-timeline-invalid-flags)
[74.599627] Starting subtest: syncobj-timeline-invalid-flags
[74.600546] Subtest syncobj-timeline-invalid-flags: SUCCESS (0.000s)
[74.886590] [013/132] (947s left) gem_exec_schedule (submit-golden-slice)
[74.980204] Starting subtest: submit-golden-slice
[74.981166] Starting dynamic subtest: rcs0
[75.061175] Dynamic subtest rcs0: SUCCESS (0.081s)
[75.069531] Starting dynamic subtest: bcs0
[75.110985] Dynamic subtest bcs0: SUCCESS (0.050s)
[75.119918] Starting dynamic subtest: vcs0
[75.168599] Dynamic subtest vcs0: SUCCESS (0.057s)
[75.176987] Starting dynamic subtest: vcs1
[75.218464] Dynamic subtest vcs1: SUCCESS (0.050s)
[75.227110] Starting dynamic subtest: vecs0
[75.272095] Dynamic subtest vecs0: SUCCESS (0.053s)
[75.280972] Starting dynamic subtest: vecs1
[75.322978] Dynamic subtest vecs1: SUCCESS (0.051s)
[75.331385] Starting dynamic subtest: ccs0
[75.376165] Dynamic subtest ccs0: SUCCESS (0.053s)
[75.377172] Subtest submit-golden-slice: SUCCESS (0.396s)
[75.901855] [014/132] (946s left) gem_exec_gttfill (basic)
[75.996975] Starting subtest: basic
[81.497548] Subtest basic: SUCCESS (5.502s)
[81.767096] [015/132] (940s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-render)
[81.998051] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-render
[84.685682] Subtest fbc-1p-primscrn-pri-indfb-draw-render: SUCCESS (2.689s)
[84.929495] [016/132] (937s left) gem_spin_batch (user-each)
[85.022866] Starting subtest: user-each
[88.450328] Subtest user-each: SUCCESS (3.427s)
[88.798398] [017/132] (933s left) syncobj_wait (invalid-single-wait-unsubmitted)
[88.887215] Starting subtest: invalid-single-wait-unsubmitted
[88.888142] Subtest invalid-single-wait-unsubmitted: SUCCESS (0.000s)
[89.067484] [018/132] (933s left) gem_exec_schedule (pi-userfault)
[89.275654] Starting subtest: pi-userfault
[89.276562] Starting dynamic subtest: rcs0
[89.284966] Dynamic subtest rcs0: SUCCESS (0.010s)
[89.297388] Starting dynamic subtest: bcs0
[89.298439] Dynamic subtest bcs0: SUCCESS (0.013s)
[89.310888] Starting dynamic subtest: vcs0
[89.311856] Dynamic subtest vcs0: SUCCESS (0.010s)
[89.324296] Starting dynamic subtest: vcs1
[89.325368] Dynamic subtest vcs1: SUCCESS (0.010s)
[89.336667] Starting dynamic subtest: vecs0
[89.337566] Dynamic subtest vecs0: SUCCESS (0.009s)
[89.348475] Starting dynamic subtest: vecs1
[89.349402] Dynamic subtest vecs1: SUCCESS (0.012s)
[89.359862] Starting dynamic subtest: ccs0
[89.360790] Dynamic subtest ccs0: SUCCESS (0.008s)
[89.361767] Subtest pi-userfault: SUCCESS (0.073s)
[89.647276] [019/132] (933s left) syncobj_timeline (invalid-multi-wait-unsubmitted-submitted-signaled)
[89.722980] Starting subtest: invalid-multi-wait-unsubmitted-submitted-signaled
[89.724076] Subtest invalid-multi-wait-unsubmitted-submitted-signaled: SUCCESS (0.001s)
[89.896622] [020/132] (932s left) fbdev (eof)
[89.952041] Starting subtest: eof
[89.952983] Subtest eof: SUCCESS (0.000s)
[90.123066] [021/132] (932s left) kms_atomic (plane-overlay-legacy)
[90.309056] Starting subtest: plane-overlay-legacy
[90.309960] Starting dynamic subtest: pipe-A-DP-3
[90.977341] Dynamic subtest pipe-A-DP-3: SUCCESS (0.668s)
[90.978290] Subtest plane-overlay-legacy: SUCCESS (0.669s)
[91.305832] [022/132] (931s left) kms_chamelium_frames (hdmi-crc-multiple)
[91.571018] Subtest hdmi-crc-multiple: SKIP (0.000s)
[91.718935] [023/132] (931s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-0-hflip)
[91.923384] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-0-hflip
[91.925199] Subtest y-tiled-max-hw-stride-64bpp-rotate-0-hflip: SKIP (0.000s)
[92.112176] [024/132] (931s left) kms_psr2_sf (psr2-primary-plane-update-sf-dmg-area-big-fb)
[92.306842] Subtest psr2-primary-plane-update-sf-dmg-area-big-fb: SKIP (0.000s)
[92.356670] [025/132] (930s left) core_auth (many-magics)
[92.439890] Starting subtest: many-magics
[94.219144] Subtest many-magics: SUCCESS (1.779s)
[94.579313] [026/132] (928s left) kms_cursor_legacy (cursora-vs-flipb-legacy)
[94.770060] Starting subtest: cursorA-vs-flipB-legacy
[94.771909] Subtest cursorA-vs-flipB-legacy: SKIP (0.001s)
[94.953888] [027/132] (928s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-mmap-gtt)
[95.152567] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-mmap-gtt
[95.154243] Subtest fbc-2p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[95.349412] [028/132] (928s left) sysfs_timeslice_duration (duration)
[95.436486] Starting subtest: duration
[95.437386] Starting dynamic subtest: vecs0
[108.606748] Dynamic subtest vecs0: SUCCESS (13.169s)
[108.618219] Starting dynamic subtest: ccs0
[121.754059] Dynamic subtest ccs0: SUCCESS (13.147s)
[121.763784] Starting dynamic subtest: vcs0
[134.886574] Dynamic subtest vcs0: SUCCESS (13.131s)
[134.898948] Starting dynamic subtest: bcs0
[148.028878] Dynamic subtest bcs0: SUCCESS (13.140s)
[148.040706] Starting dynamic subtest: vecs1
[161.180044] Dynamic subtest vecs1: SUCCESS (13.149s)
[161.191408] Starting dynamic subtest: rcs0
[174.301153] Dynamic subtest rcs0: SUCCESS (13.119s)
[174.313697] Starting dynamic subtest: vcs1
[187.487717] Dynamic subtest vcs1: SUCCESS (13.184s)
[187.489520] Subtest duration: SUCCESS (92.049s)
[187.632127] [029/132] (835s left) i915_drm_fdinfo (context-close-stress)
[187.704282] Starting subtest: context-close-stress
[198.450069] Subtest context-close-stress: SUCCESS (10.745s)
[198.571882] [030/132] (824s left) gem_pipe_control_store_loop (reused-buffer)
[199.412395] Starting subtest: reused-buffer
[201.586076] Subtest reused-buffer: SUCCESS (2.173s)
[201.764747] [031/132] (821s left) kms_hdr (bpc-switch-suspend)
[201.949925] Starting subtest: bpc-switch-suspend
[205.206457] Starting dynamic subtest: pipe-A-DP-3
[225.466792] Dynamic subtest pipe-A-DP-3: SUCCESS (4.902s)
[225.467779] Subtest bpc-switch-suspend: SUCCESS (8.159s)
[225.847687] [032/132] (797s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-wc)
[226.063264] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-wc
[226.065001] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[226.274931] [033/132] (797s left) gem_madvise (dontneed-before-pwrite)
[226.321493] Starting subtest: dontneed-before-pwrite
[226.349050] Subtest dontneed-before-pwrite: SKIP (0.027s)
[226.426348] [034/132] (797s left) gem_exec_flush (basic-uc-prw-default)
[226.509019] Subtest basic-uc-prw-default: SKIP (0.000s)
[226.593133] [035/132] (797s left) kms_big_fb (yf-tiled-32bpp-rotate-90)
[226.787338] Starting subtest: yf-tiled-32bpp-rotate-90
[226.789145] Subtest yf-tiled-32bpp-rotate-90: SKIP (0.000s)
[226.983625] [036/132] (797s left) kms_plane_scaling (plane-scaler-with-clipping-clamping-pixel-formats)
[227.170849] Starting subtest: plane-scaler-with-clipping-clamping-pixel-formats
[227.171569] Starting dynamic subtest: pipe-A
[229.164599] Dynamic subtest pipe-A: SUCCESS (1.994s)
[229.194237] Starting dynamic subtest: pipe-B
[231.376434] Dynamic subtest pipe-B: SUCCESS (2.211s)
[231.399526] Starting dynamic subtest: pipe-C
[231.695422] Dynamic subtest pipe-C: SUCCESS (0.318s)
[231.726305] Starting dynamic subtest: pipe-D
[232.008307] Dynamic subtest pipe-D: SUCCESS (0.312s)
[232.009405] Subtest plane-scaler-with-clipping-clamping-pixel-formats: SUCCESS (4.838s)
[232.388709] [037/132] (791s left) kms_vrr (seamless-rr-switch-drrs)
[232.578727] Starting subtest: seamless-rr-switch-drrs
[232.581242] Subtest seamless-rr-switch-drrs: SKIP (0.000s)
[232.746329] [038/132] (791s left) syncobj_wait (invalid-signal-one-illegal-handle)
[232.823951] Starting subtest: invalid-signal-one-illegal-handle
[232.824888] Subtest invalid-signal-one-illegal-handle: SUCCESS (0.000s)
[232.971904] [039/132] (791s left) kms_ccs (bad-rotation-90-y-tiled-ccs)
[233.164325] Starting subtest: bad-rotation-90-y-tiled-ccs
[233.165249] Starting dynamic subtest: pipe-A-DP-3
[233.173404] Dynamic subtest pipe-A-DP-3: SKIP (0.000s)
[233.184459] Starting dynamic subtest: pipe-B-DP-3
[233.192931] Dynamic subtest pipe-B-DP-3: SKIP (0.000s)
[233.203891] Starting dynamic subtest: pipe-C-DP-3
[233.211984] Dynamic subtest pipe-C-DP-3: SKIP (0.000s)
[233.223112] Starting dynamic subtest: pipe-D-DP-3
[233.233063] Dynamic subtest pipe-D-DP-3: SKIP (0.000s)
[233.235006] Subtest bad-rotation-90-y-tiled-ccs: SKIP (0.005s)
[233.635663] [040/132] (790s left) syncobj_wait (wait-for-submit-snapshot)
[233.715312] Starting subtest: wait-for-submit-snapshot
[233.798466] Subtest wait-for-submit-snapshot: SUCCESS (0.082s)
[233.948822] [041/132] (790s left) gem_exec_params (invalid-flag)
[234.035988] Starting subtest: invalid-flag
[234.037161] Subtest invalid-flag: SUCCESS (0.000s)
[234.199109] [042/132] (790s left) syncobj_wait (invalid-reset-zero-handles)
[234.275945] Starting subtest: invalid-reset-zero-handles
[234.276867] Subtest invalid-reset-zero-handles: SUCCESS (0.000s)
[234.485019] [043/132] (790s left) syncobj_timeline (wait-all-delayed-signal)
[234.561930] Starting subtest: wait-all-delayed-signal
[234.665518] Subtest wait-all-delayed-signal: SUCCESS (0.103s)
[234.814788] [044/132] (789s left) gem_gpgpu_fill (offset-16x16)
[234.897840] Starting subtest: offset-16x16
[234.929110] Subtest offset-16x16: SUCCESS (0.031s)
[235.155623] [045/132] (789s left) gem_exec_params (secure-non-master)
[235.238600] Starting subtest: secure-non-master
[235.240427] Subtest secure-non-master: SKIP (0.000s)
[235.398798] [046/132] (789s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-gtt)
[235.593540] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-gtt
[235.595268] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[235.787133] [047/132] (788s left) kms_big_fb (y-tiled-32bpp-rotate-90)
[235.990998] Starting subtest: y-tiled-32bpp-rotate-90
[235.992911] Subtest y-tiled-32bpp-rotate-90: SKIP (0.000s)
[236.185005] [048/132] (788s left) kms_cursor_legacy (basic-flip-before-cursor-atomic)
[236.369769] Starting subtest: basic-flip-before-cursor-atomic
[237.399900] Subtest basic-flip-before-cursor-atomic: SUCCESS (1.028s)
[237.756631] [049/132] (787s left) kms_color (invalid-gamma-lut-sizes)
[237.940858] Starting subtest: invalid-gamma-lut-sizes
[237.941700] Starting dynamic subtest: pipe-A
[238.015428] Dynamic subtest pipe-A: SUCCESS (0.074s)
[238.027729] Starting dynamic subtest: pipe-B
[238.028600] Dynamic subtest pipe-B: SUCCESS (0.001s)
[238.040358] Starting dynamic subtest: pipe-C
[238.041299] Dynamic subtest pipe-C: SUCCESS (0.001s)
[238.052728] Starting dynamic subtest: pipe-D
[238.053461] Dynamic subtest pipe-D: SUCCESS (0.001s)
[238.054303] Subtest invalid-gamma-lut-sizes: SUCCESS (0.078s)
[238.270165] [050/132] (786s left) kms_chamelium_hpd (hdmi-hpd-storm-disable)
[238.528298] Subtest hdmi-hpd-storm-disable: SKIP (0.000s)
[238.676630] [051/132] (786s left) kms_pm_rpm (system-suspend-modeset)
[240.373662] Starting subtest: system-suspend-modeset
[260.592145] Subtest system-suspend-modeset: SUCCESS (5.373s)
[261.044864] [052/132] (764s left) kms_big_fb (4-tiled-8bpp-rotate-90)
[261.250360] Starting subtest: 4-tiled-8bpp-rotate-90
[261.315156] Subtest 4-tiled-8bpp-rotate-90: SKIP (0.064s)
[261.518346] [053/132] (763s left) gem_pread (display)
[261.597045] Subtest display: SKIP (0.000s)
[261.678412] [054/132] (763s left) syncobj_timeline (32bits-limit)
[261.764163] Starting subtest: 32bits-limit
[261.765173] Subtest 32bits-limit: SUCCESS (0.001s)
[261.928748] [055/132] (763s left) gem_flink_basic (bad-flink)
[262.003125] Starting subtest: bad-flink
[262.004000] Subtest bad-flink: SUCCESS (0.000s)
[262.196255] [056/132] (763s left) syncobj_timeline (invalid-wait-illegal-handle)
[262.274177] Starting subtest: invalid-wait-illegal-handle
[262.275185] Subtest invalid-wait-illegal-handle: SUCCESS (0.000s)
[262.445831] [057/132] (763s left) prime_busy (hang)
[262.532556] Starting subtest: hang
[262.534524] Starting dynamic subtest: rcs0
[288.675485] Dynamic subtest rcs0: SUCCESS (26.140s)
[288.687851] Starting dynamic subtest: bcs0
[295.837172] Dynamic subtest bcs0: SUCCESS (7.160s)
[295.849217] Starting dynamic subtest: vcs0
[302.811780] Dynamic subtest vcs0: SUCCESS (6.974s)
[302.823934] Starting dynamic subtest: vcs1
[309.850826] Dynamic subtest vcs1: SUCCESS (7.038s)
[309.862961] Starting dynamic subtest: vecs0
[316.828433] Dynamic subtest vecs0: SUCCESS (6.977s)
[316.840844] Starting dynamic subtest: vecs1
[323.794588] Dynamic subtest vecs1: SUCCESS (6.965s)
[323.806914] Starting dynamic subtest: ccs0
[337.703654] Dynamic subtest ccs0: SUCCESS (13.910s)
[337.704539] Subtest hang: SUCCESS (75.171s)
[337.884580] [058/132] (687s left) kms_pipe_stress (stress-xrgb8888-untiled)
[338.076841] Starting subtest: stress-xrgb8888-untiled
[345.910275] Subtest stress-xrgb8888-untiled: SUCCESS (7.833s)
[346.196671] [059/132] (679s left) kms_pm_rpm (modeset-lpsp-stress-no-wait)
[348.203686] Starting subtest: modeset-lpsp-stress-no-wait
[348.344252] Subtest modeset-lpsp-stress-no-wait: SKIP (0.139s)
[348.653365] [060/132] (677s left) kms_vblank (accuracy-idle)
[348.841755] Starting subtest: accuracy-idle
[348.844003] Starting dynamic subtest: pipe-A-DP-3
[351.162631] Dynamic subtest pipe-A-DP-3: SUCCESS (2.319s)
[351.181486] Starting dynamic subtest: pipe-D-DP-3
[353.404935] Dynamic subtest pipe-D-DP-3: SUCCESS (2.236s)
[353.406037] Subtest accuracy-idle: SUCCESS (4.563s)
[353.686186] [061/132] (672s left) syncobj_timeline (etime-multi-wait-all-for-submit-unsubmitted-submitted-signa
[353.770424] Starting subtest: etime-multi-wait-all-for-submit-unsubmitted-submitted-signaled
[353.872455] Subtest etime-multi-wait-all-for-submit-unsubmitted-submitted-signaled: SUCCESS (0.101s)
[354.015368] [062/132] (671s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-mmap-cpu)
[354.206863] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-mmap-cpu
[354.208461] Subtest psr-1p-primscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[354.408710] [063/132] (671s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-render)
[354.598857] Starting subtest: psr-2p-primscrn-pri-indfb-draw-render
[354.600517] Subtest psr-2p-primscrn-pri-indfb-draw-render: SKIP (0.000s)
[354.789604] [064/132] (671s left) kms_big_fb (linear-addfb)
[354.981691] Starting subtest: linear-addfb
[354.982593] Subtest linear-addfb: SUCCESS (0.000s)
[355.174169] [065/132] (670s left) gem_spin_batch (engines)
[355.260783] Starting subtest: engines
[355.261665] Starting dynamic subtest: rcs0
[358.521693] Dynamic subtest rcs0: SUCCESS (3.258s)
[358.535039] Starting dynamic subtest: bcs0
[361.755346] Dynamic subtest bcs0: SUCCESS (3.231s)
[361.769716] Starting dynamic subtest: vcs0
[364.988710] Dynamic subtest vcs0: SUCCESS (3.230s)
[365.001582] Starting dynamic subtest: vcs1
[368.224220] Dynamic subtest vcs1: SUCCESS (3.232s)
[368.240445] Starting dynamic subtest: vecs0
[371.461249] Dynamic subtest vecs0: SUCCESS (3.234s)
[371.474407] Starting dynamic subtest: vecs1
[374.696093] Dynamic subtest vecs1: SUCCESS (3.232s)
[374.712586] Starting dynamic subtest: ccs0
[377.933097] Dynamic subtest ccs0: SUCCESS (3.234s)
[377.934856] Subtest engines: SUCCESS (22.671s)
[378.226341] [066/132] (647s left) kms_flip (nonexisting-fb-interruptible)
[378.414376] Starting subtest: nonexisting-fb-interruptible
[378.419115] Starting dynamic subtest: A-DP3
[378.727598] Dynamic subtest A-DP3: SUCCESS (0.308s)
[378.767390] Starting dynamic subtest: B-DP3
[378.983759] Dynamic subtest B-DP3: SUCCESS (0.252s)
[379.025117] Starting dynamic subtest: C-DP3
[379.237805] Dynamic subtest C-DP3: SUCCESS (0.251s)
[379.281215] Starting dynamic subtest: D-DP3
[379.490756] Dynamic subtest D-DP3: SUCCESS (0.251s)
[379.494904] Subtest nonexisting-fb-interruptible: SUCCESS (1.080s)
[379.920519] [067/132] (646s left) kms_cursor_legacy (cursorb-vs-flipa-atomic-transitions)
[380.101102] Starting subtest: cursorB-vs-flipA-atomic-transitions
[380.104051] Subtest cursorB-vs-flipA-atomic-transitions: SKIP (0.002s)
[380.274729] [068/132] (646s left) syncobj_timeline (reset-during-wait-for-submit)
[380.354468] Starting subtest: reset-during-wait-for-submit
[380.457960] Subtest reset-during-wait-for-submit: SUCCESS (0.103s)
[380.633690] [069/132] (645s left) kms_draw_crc (fill-fb)
[380.820286] Starting subtest: fill-fb
[381.304828] Subtest fill-fb: SUCCESS (0.485s)
[381.467624] [070/132] (645s left) kms_big_fb (x-tiled-addfb)
[381.668273] Starting subtest: x-tiled-addfb
[381.669189] Subtest x-tiled-addfb: SUCCESS (0.000s)
[381.872548] [071/132] (644s left) perf_pmu (frequency)
[381.943880] Starting subtest: frequency
[381.947415] Starting dynamic subtest: gt0
[384.246692] Dynamic subtest gt0: FAIL (2.221s)
[384.289899] Starting dynamic subtest: idle-gt0
[384.677766] Dynamic subtest idle-gt0: SUCCESS (0.505s)
[384.680818] Subtest frequency: FAIL (2.736s)
[384.904925] [072/132] (641s left) kms_fbcon_fbt (psr)
[384.992463] Starting subtest: psr
[384.994269] Subtest psr: SKIP (0.000s)
[385.172519] [073/132] (641s left) gem_exec_schedule (u-submit-golden-slice)
[385.264381] Starting subtest: u-submit-golden-slice
[385.265230] Starting dynamic subtest: rcs0
[385.343067] Dynamic subtest rcs0: SUCCESS (0.078s)
[385.356738] Starting dynamic subtest: bcs0
[385.391768] Dynamic subtest bcs0: SUCCESS (0.048s)
[385.405169] Starting dynamic subtest: vcs0
[385.446884] Dynamic subtest vcs0: SUCCESS (0.054s)
[385.460217] Starting dynamic subtest: vcs1
[385.498114] Dynamic subtest vcs1: SUCCESS (0.050s)
[385.511496] Starting dynamic subtest: vecs0
[385.551381] Dynamic subtest vecs0: SUCCESS (0.053s)
[385.564448] Starting dynamic subtest: vecs1
[385.600647] Dynamic subtest vecs1: SUCCESS (0.048s)
[385.613686] Starting dynamic subtest: ccs0
[385.654730] Dynamic subtest ccs0: SUCCESS (0.053s)
[385.655668] Subtest u-submit-golden-slice: SUCCESS (0.391s)
[386.140598] [074/132] (640s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-blt)
[386.333195] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-blt
[386.334977] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-blt: SKIP (0.000s)
[386.519278] [075/132] (640s left) gem_mmap (bad-size)
[386.597049] Subtest bad-size: SKIP (0.000s)
[386.664923] [076/132] (640s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-mmap-cpu)
[386.860761] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-mmap-cpu
[386.862372] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[387.071444] [077/132] (639s left) gen9_exec_parse (bb-large)
[387.165264] Subtest bb-large: SKIP (0.000s)
[387.248980] [078/132] (639s left) dmabuf_sync_file (export-multiwait)
[387.303362] Starting subtest: export-multiwait
[387.304270] Subtest export-multiwait: SUCCESS (0.000s)
[387.434759] [079/132] (639s left) i915_pm_freq_api (freq-suspend)
[387.521942] Starting subtest: freq-suspend
[387.522931] Starting dynamic subtest: gt0
[405.660914] Dynamic subtest gt0: SUCCESS (3.946s)
[405.661650] Subtest freq-suspend: SUCCESS (3.947s)
[406.805993] [080/132] (621s left) kms_cursor_legacy (torture-bo)
[406.994346] Starting subtest: torture-bo
[406.995259] Starting dynamic subtest: pipe-A
[412.535211] Dynamic subtest pipe-A: SUCCESS (5.539s)
[412.549514] Starting dynamic subtest: pipe-B
[418.158228] Dynamic subtest pipe-B: SUCCESS (5.621s)
[418.172114] Starting dynamic subtest: pipe-C
[423.644051] Dynamic subtest pipe-C: SUCCESS (5.485s)
[423.657414] Starting dynamic subtest: pipe-D
[429.086221] Dynamic subtest pipe-D: SUCCESS (5.441s)
[429.099528] Starting dynamic subtest: all-pipes
[434.551183] Dynamic subtest all-pipes: SUCCESS (5.464s)
[434.552194] Subtest torture-bo: SUCCESS (27.554s)
[434.752554] [081/132] (593s left) kms_async_flips (async-flip-with-page-flip-events-tiled)
[434.943167] Starting subtest: async-flip-with-page-flip-events-tiled
[435.179243] Starting dynamic subtest: pipe-A-DP-3-4
[437.450920] Dynamic subtest pipe-A-DP-3-4: SUCCESS (2.271s)
[437.465090] Starting dynamic subtest: pipe-A-DP-3-x
[439.632817] Dynamic subtest pipe-A-DP-3-x: SUCCESS (2.180s)
[439.856231] Starting dynamic subtest: pipe-B-DP-3-4
[442.082279] Dynamic subtest pipe-B-DP-3-4: SUCCESS (2.238s)
[442.100193] Starting dynamic subtest: pipe-B-DP-3-x
[444.247568] Dynamic subtest pipe-B-DP-3-x: SUCCESS (2.163s)
[444.446424] Starting dynamic subtest: pipe-C-DP-3-4
[446.673781] Dynamic subtest pipe-C-DP-3-4: SUCCESS (2.239s)
[446.686831] Starting dynamic subtest: pipe-C-DP-3-x
[448.839220] Dynamic subtest pipe-C-DP-3-x: SUCCESS (2.164s)
[449.029042] Starting dynamic subtest: pipe-D-DP-3-4
[451.260699] Dynamic subtest pipe-D-DP-3-4: SUCCESS (2.247s)
[451.274554] Starting dynamic subtest: pipe-D-DP-3-x
[453.422286] Dynamic subtest pipe-D-DP-3-x: SUCCESS (2.160s)
[453.423203] Subtest async-flip-with-page-flip-events-tiled: SUCCESS (18.475s)
[453.988735] [082/132] (574s left) kms_content_protection (lic-type-1)
[454.244066] Starting subtest: lic-type-1
[454.250051] Subtest lic-type-1: SKIP (0.003s)
[454.470725] [083/132] (574s left) syncobj_wait (invalid-signal-zero-handles)
[454.547267] Starting subtest: invalid-signal-zero-handles
[454.548228] Subtest invalid-signal-zero-handles: SUCCESS (0.000s)
[454.754304] [084/132] (573s left) kms_rotation_crc (primary-x-tiled-reflect-x-0)
[454.943217] Starting subtest: primary-x-tiled-reflect-x-0
[465.170865] Subtest primary-x-tiled-reflect-x-0: SUCCESS (10.226s)
[465.565319] [085/132] (563s left) kms_ccs (crc-sprite-planes-basic-y-tiled-gen12-mc-ccs)
[465.750633] Starting subtest: crc-sprite-planes-basic-y-tiled-gen12-mc-ccs
[465.752924] Starting dynamic subtest: pipe-A-DP-3
[465.774249] Dynamic subtest pipe-A-DP-3: SKIP (0.002s)
[465.787444] Starting dynamic subtest: pipe-B-DP-3
[465.808498] Dynamic subtest pipe-B-DP-3: SKIP (0.002s)
[465.821654] Starting dynamic subtest: pipe-C-DP-3
[465.847242] Dynamic subtest pipe-C-DP-3: SKIP (0.002s)
[465.860116] Starting dynamic subtest: pipe-D-DP-3
[465.884787] Dynamic subtest pipe-D-DP-3: SKIP (0.002s)
[465.886916] Subtest crc-sprite-planes-basic-y-tiled-gen12-mc-ccs: SKIP (0.014s)
[466.221329] [086/132] (562s left) gem_exec_balancer (nohangcheck)
[466.575981] Starting subtest: nohangcheck
[468.187604] Subtest nohangcheck: SUCCESS (1.611s)
[468.388748] [087/132] (560s left) gem_ccs (large-ctrl-surf-copy)
[468.474223] Starting subtest: large-ctrl-surf-copy
[469.140590] Subtest large-ctrl-surf-copy: SUCCESS (0.666s)
[469.321622] [088/132] (559s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling)
[469.508230] Starting subtest: flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling
[469.509147] Starting dynamic subtest: pipe-A-valid-mode
[469.597915] Dynamic subtest pipe-A-valid-mode: SKIP (0.088s)
[469.599862] Subtest flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling: SKIP (0.090s)
[469.857646] [089/132] (559s left) gem_ctx_param (basic-default)
[469.937811] Starting subtest: basic-default
[469.938693] Subtest basic-default: SUCCESS (0.000s)
[470.122069] [090/132] (558s left) kms_psr2_sf (fbc-psr2-overlay-plane-update-sf-dmg-area)
[470.315160] Subtest fbc-psr2-overlay-plane-update-sf-dmg-area: SKIP (0.000s)
[470.369687] [091/132] (558s left) kms_flip (2x-flip-vs-blocking-wf-vblank)
[470.557321] Starting subtest: 2x-flip-vs-blocking-wf-vblank
[470.572910] Subtest 2x-flip-vs-blocking-wf-vblank: SKIP (0.015s)
[470.747314] [092/132] (558s left) gem_exec_params (no-vebox)
[470.841445] Starting subtest: no-vebox
[470.844320] Subtest no-vebox: SUCCESS (0.003s)
[471.074109] [093/132] (558s left) kms_invalid_mode (bad-vtotal)
[471.261528] Starting subtest: bad-vtotal
[471.262421] Starting dynamic subtest: pipe-A-DP-3
[471.347472] Dynamic subtest pipe-A-DP-3: SUCCESS (0.084s)
[471.367179] Starting dynamic subtest: pipe-B-DP-3
[471.368438] Dynamic subtest pipe-B-DP-3: SUCCESS (0.001s)
[471.385473] Starting dynamic subtest: pipe-C-DP-3
[471.386414] Dynamic subtest pipe-C-DP-3: SUCCESS (0.001s)
[471.399612] Starting dynamic subtest: pipe-D-DP-3
[471.400522] Dynamic subtest pipe-D-DP-3: SUCCESS (0.001s)
[471.401406] Subtest bad-vtotal: SUCCESS (0.096s)
[471.635898] [094/132] (557s left) gem_mmap_gtt (fault-concurrent-y)
[471.713179] Subtest fault-concurrent-Y: SKIP (0.000s)
[471.780447] [095/132] (557s left) kms_frontbuffer_tracking (psr-rgb565-draw-mmap-gtt)
[471.972014] Starting subtest: psr-rgb565-draw-mmap-gtt
[471.973757] Subtest psr-rgb565-draw-mmap-gtt: SKIP (0.000s)
[472.182972] [096/132] (557s left) gem_exec_params (rel-constants-invalid-ring)
[472.267187] Starting subtest: rel-constants-invalid-ring
[472.268197] Subtest rel-constants-invalid-ring: SUCCESS (0.000s)
[472.487367] [097/132] (557s left) kms_ccs (crc-primary-suspend-4-tiled-dg2-rc-ccs-cc)
[472.679424] Starting subtest: crc-primary-suspend-4-tiled-dg2-rc-ccs-cc
[472.680294] Starting dynamic subtest: pipe-A-DP-3
[472.683641] Dynamic subtest pipe-A-DP-3: SKIP (0.000s)
[472.696992] Starting dynamic subtest: pipe-B-DP-3
[472.700440] Dynamic subtest pipe-B-DP-3: SKIP (0.000s)
[472.713384] Starting dynamic subtest: pipe-C-DP-3
[472.716840] Dynamic subtest pipe-C-DP-3: SKIP (0.000s)
[472.729573] Starting dynamic subtest: pipe-D-DP-3
[472.732999] Dynamic subtest pipe-D-DP-3: SKIP (0.000s)
[472.735048] Subtest crc-primary-suspend-4-tiled-dg2-rc-ccs-cc: SKIP (0.007s)
[473.147066] [098/132] (556s left) kms_cdclk (mode-transition-all-outputs)
[473.335272] Starting subtest: mode-transition-all-outputs
[473.421439] Subtest mode-transition-all-outputs: SKIP (0.085s)
[473.639036] [099/132] (556s left) kms_frontbuffer_tracking (fbcpsr-tiling-linear)
[473.830152] Starting subtest: fbcpsr-tiling-linear
[473.831859] Subtest fbcpsr-tiling-linear: SKIP (0.000s)
[474.025609] [100/132] (555s left) gem_pread (self)
[474.103192] Subtest self: SKIP (0.000s)
[474.188685] [101/132] (555s left) gem_exec_schedule (fairslice-all)
[474.277653] Starting subtest: fairslice-all
[476.395035] Subtest fairslice-all: SUCCESS (2.117s)
[476.875127] [102/132] (553s left) kms_lease (page-flip-implicit-plane)
[477.063308] Starting subtest: page-flip-implicit-plane
[477.064213] Starting dynamic subtest: pipe-A-DP-3
[477.452205] Dynamic subtest pipe-A-DP-3: SUCCESS (0.387s)
[477.476645] Starting dynamic subtest: pipe-B-DP-3
[477.794769] Dynamic subtest pipe-B-DP-3: SUCCESS (0.340s)
[477.813454] Starting dynamic subtest: pipe-C-DP-3
[478.121985] Dynamic subtest pipe-C-DP-3: SUCCESS (0.324s)
[478.142300] Starting dynamic subtest: pipe-D-DP-3
[478.439268] Dynamic subtest pipe-D-DP-3: SUCCESS (0.315s)
[478.440162] Subtest page-flip-implicit-plane: SUCCESS (1.377s)
[478.761875] [103/132] (551s left) syncobj_wait (invalid-multi-wait-all-unsubmitted)
[478.840368] Starting subtest: invalid-multi-wait-all-unsubmitted
[478.841272] Subtest invalid-multi-wait-all-unsubmitted: SUCCESS (0.000s)
[479.046048] [104/132] (551s left) gem_caching (writes)
[479.134507] Starting subtest: writes
[483.368599] Subtest writes: SUCCESS (4.233s)
[483.585518] [105/132] (546s left) gem_exec_balancer (parallel-contexts)
[483.941617] Starting subtest: parallel-contexts
[490.432345] Subtest parallel-contexts: SUCCESS (6.498s)
[490.602260] [106/132] (539s left) syncobj_wait (multi-wait-all-for-submit-signaled)
[490.679422] Starting subtest: multi-wait-all-for-submit-signaled
[490.680554] Subtest multi-wait-all-for-submit-signaled: SUCCESS (0.000s)
[490.841802] [107/132] (539s left) syncobj_wait (invalid-multi-wait-unsubmitted-submitted)
[490.937633] Starting subtest: invalid-multi-wait-unsubmitted-submitted
[490.938588] Subtest invalid-multi-wait-unsubmitted-submitted: SUCCESS (0.000s)
[491.149157] [108/132] (539s left) perf_pmu (idle)
[491.219600] Starting subtest: idle
[491.220510] Starting dynamic subtest: rcs0
[491.770226] Dynamic subtest rcs0: SUCCESS (0.549s)
[491.785377] Starting dynamic subtest: bcs0
[492.300588] Dynamic subtest bcs0: SUCCESS (0.526s)
[492.314700] Starting dynamic subtest: vcs0
[492.825003] Dynamic subtest vcs0: SUCCESS (0.523s)
[492.841576] Starting dynamic subtest: vcs1
[493.344126] Dynamic subtest vcs1: SUCCESS (0.515s)
[493.361440] Starting dynamic subtest: vecs0
[493.863126] Dynamic subtest vecs0: SUCCESS (0.514s)
[493.879715] Starting dynamic subtest: vecs1
[494.384485] Dynamic subtest vecs1: SUCCESS (0.514s)
[494.398263] Starting dynamic subtest: ccs0
[494.898179] Dynamic subtest ccs0: SUCCESS (0.512s)
[494.902151] Subtest idle: SUCCESS (3.680s)
[495.080534] [109/132] (535s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-pwrite)
[495.271174] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-pwrite
[495.272916] Subtest fbc-2p-primscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[495.480348] [110/132] (535s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-180)
[495.675884] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-180
[495.677571] Subtest yf-tiled-max-hw-stride-32bpp-rotate-180: SKIP (0.000s)
[495.881907] [111/132] (534s left) kms_psr (psr-cursor-plane-move)
[496.065873] Subtest psr-cursor-plane-move: SKIP (0.000s)
[496.125255] [112/132] (534s left) gem_ctx_persistence (userptr)
[496.209522] Starting subtest: userptr
[496.450245] Subtest userptr: SUCCESS (0.240s)
[496.644031] [113/132] (534s left) perf (invalid-oa-format-id)
[497.050348] Starting subtest: invalid-oa-format-id
[497.069120] Subtest invalid-oa-format-id: SUCCESS (0.019s)
[497.128003] [114/132] (533s left) kms_psr (fbc-pr-primary-page-flip)
[497.315275] Subtest fbc-pr-primary-page-flip: SKIP (0.000s)
[497.374423] [115/132] (533s left) kms_dsc (dsc-with-output-formats-with-bpc)
[497.561940] Starting subtest: dsc-with-output-formats-with-bpc
[497.585098] Subtest dsc-with-output-formats-with-bpc: SKIP (0.002s)
[497.746601] [116/132] (533s left) kms_flip (nonexisting-fb)
[497.940175] Starting subtest: nonexisting-fb
[497.944926] Starting dynamic subtest: A-DP3
[498.290312] Dynamic subtest A-DP3: SUCCESS (0.345s)
[498.336591] Starting dynamic subtest: B-DP3
[498.562773] Dynamic subtest B-DP3: SUCCESS (0.268s)
[498.603484] Starting dynamic subtest: C-DP3
[498.842747] Dynamic subtest C-DP3: SUCCESS (0.277s)
[498.877756] Starting dynamic subtest: D-DP3
[499.125833] Dynamic subtest D-DP3: SUCCESS (0.280s)
[499.130508] Subtest nonexisting-fb: SUCCESS (1.190s)
[499.527541] [117/132] (531s left) gem_pxp (verify-pxp-execution-after-suspend-resume)
[502.136965] Starting subtest: verify-pxp-execution-after-suspend-resume
[502.139087] Subtest verify-pxp-execution-after-suspend-resume: SKIP (0.000s)
[502.275406] [118/132] (528s left) gem_exec_alignment (pi-isolated)
[502.362307] Starting subtest: pi-isolated
[519.733163] Subtest pi-isolated: SUCCESS (17.372s)
[520.275381] [119/132] (510s left) kms_pm_dc (dc5-retention-flops)
[521.536790] Starting subtest: dc5-retention-flops
[521.538526] Subtest dc5-retention-flops: SKIP (0.000s)
[521.728448] [120/132] (509s left) kms_cursor_crc (cursor-offscreen-64x21)
[522.079401] Starting subtest: cursor-offscreen-64x21
[522.084575] Starting dynamic subtest: pipe-A-DP-3
[524.681871] Dynamic subtest pipe-A-DP-3: SUCCESS (2.595s)
[524.732680] Starting dynamic subtest: pipe-D-DP-3
[527.137272] Dynamic subtest pipe-D-DP-3: SUCCESS (2.417s)
[527.138226] Subtest cursor-offscreen-64x21: SUCCESS (5.058s)
[527.653662] [121/132] (503s left) gem_ppgtt (flink-and-close-vma-leak)
[527.738820] Starting subtest: flink-and-close-vma-leak
[527.812560] Subtest flink-and-close-vma-leak: SUCCESS (0.074s)
[528.029439] [122/132] (503s left) kms_psr (fbc-psr-cursor-plane-move)
[528.217545] Subtest fbc-psr-cursor-plane-move: SKIP (0.000s)
[528.275260] [123/132] (503s left) api_intel_bb (destroy-bb)
[528.351467] Starting subtest: destroy-bb
[528.388410] Subtest destroy-bb: SUCCESS (0.036s)
[528.612032] [124/132] (503s left) kms_plane_multiple (2x-tiling-4)
[528.794476] Starting subtest: 2x-tiling-4
[528.796260] Subtest 2x-tiling-4: SKIP (0.000s)
[528.977604] [125/132] (502s left) kms_rotation_crc (multiplane-rotation-cropping-top)
[529.174371] Starting subtest: multiplane-rotation-cropping-top
[556.546743] Subtest multiplane-rotation-cropping-top: SUCCESS (27.373s)
[556.781423] [126/132] (475s left) kms_psr (fbc-psr-sprite-mmap-gtt)
[556.974662] Subtest fbc-psr-sprite-mmap-gtt: SKIP (0.000s)
[557.042406] [127/132] (474s left) kms_flip (dpms-off-confusion-interruptible)
[557.240632] Starting subtest: dpms-off-confusion-interruptible
[557.245534] Starting dynamic subtest: A-DP3
[565.071144] Dynamic subtest A-DP3: SUCCESS (7.824s)
[565.114346] Starting dynamic subtest: B-DP3
[572.824287] Dynamic subtest B-DP3: SUCCESS (7.746s)
[572.869071] Starting dynamic subtest: C-DP3
[580.577312] Dynamic subtest C-DP3: SUCCESS (7.746s)
[580.595526] Starting dynamic subtest: D-DP3
[588.323365] Dynamic subtest D-DP3: SUCCESS (7.740s)
[588.328774] Subtest dpms-off-confusion-interruptible: SUCCESS (31.087s)
[588.641567] [128/132] (443s left) kms_frontbuffer_tracking (psr-1p-primscrn-shrfb-pgflip-blt)
[588.833290] Starting subtest: psr-1p-primscrn-shrfb-pgflip-blt
[588.834988] Subtest psr-1p-primscrn-shrfb-pgflip-blt: SKIP (0.000s)
[589.038653] [129/132] (443s left) kms_cursor_edge_walk (128x128-left-edge)
[589.225404] Starting subtest: 128x128-left-edge
[589.226292] Starting dynamic subtest: pipe-A-DP-3
[592.669672] Dynamic subtest pipe-A-DP-3: SUCCESS (3.443s)
[592.686565] Starting dynamic subtest: pipe-D-DP-3
[595.974694] Dynamic subtest pipe-D-DP-3: SUCCESS (3.302s)
[595.975614] Subtest 128x128-left-edge: SUCCESS (6.750s)
[596.290313] [130/132] (435s left) i915_pm_rpm (gem-execbuf)
[598.395847] Starting subtest: gem-execbuf
[598.399215] Starting dynamic subtest: lmem0
[601.085381] Dynamic subtest lmem0: SUCCESS (2.686s)
[601.121748] Starting dynamic subtest: smem0
[605.470253] Dynamic subtest smem0: SUCCESS (4.381s)
[605.471237] Subtest gem-execbuf: SUCCESS (7.076s)
[605.888817] [131/132] (426s left) kms_psr (pr-sprite-blt)
[606.075524] Subtest pr-sprite-blt: SKIP (0.000s)
[606.146714] [132/132] (426s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-blt)
[606.358499] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-blt
[606.360269] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-blt: SKIP (0.000s)
[606.549704] Closing watchdogs
results: parsing output: 0/ for test: kms_properties
results: parsing output: 1/ for test: gem_ringfill
results: parsing output: 2/ for test: kms_cursor_legacy
results: parsing output: 3/ for test: kms_cursor_crc
results: parsing output: 4/ for test: kms_ccs
results: parsing output: 5/ for test: api_intel_bb
results: parsing output: 6/ for test: kms_frontbuffer_tracking
results: parsing output: 7/ for test: kms_flip_scaled_crc
results: parsing output: 8/ for test: gem_partial_pwrite_pread
results: parsing output: 9/ for test: gem_ctx_isolation
results: parsing output: 10/ for test: i915_power
results: parsing output: 11/ for test: gem_exec_fence
results: parsing output: 12/ for test: gem_exec_schedule
results: parsing output: 13/ for test: gem_exec_gttfill
results: parsing output: 14/ for test: kms_frontbuffer_tracking
results: parsing output: 15/ for test: gem_spin_batch
results: parsing output: 16/ for test: syncobj_wait
results: parsing output: 17/ for test: gem_exec_schedule
results: parsing output: 18/ for test: syncobj_timeline
results: parsing output: 19/ for test: fbdev
results: parsing output: 20/ for test: kms_atomic
results: parsing output: 21/ for test: kms_chamelium_frames
results: parsing output: 22/ for test: kms_big_fb
results: parsing output: 23/ for test: kms_psr2_sf
results: parsing output: 24/ for test: core_auth
results: parsing output: 25/ for test: kms_cursor_legacy
results: parsing output: 26/ for test: kms_frontbuffer_tracking
results: parsing output: 27/ for test: sysfs_timeslice_duration
results: parsing output: 28/ for test: i915_drm_fdinfo
results: parsing output: 29/ for test: gem_pipe_control_store_loop
results: parsing output: 30/ for test: kms_hdr
results: parsing output: 31/ for test: kms_frontbuffer_tracking
results: parsing output: 32/ for test: gem_madvise
results: parsing output: 33/ for test: gem_exec_flush
results: parsing output: 34/ for test: kms_big_fb
results: parsing output: 35/ for test: kms_plane_scaling
results: parsing output: 36/ for test: kms_vrr
results: parsing output: 37/ for test: syncobj_wait
results: parsing output: 38/ for test: kms_ccs
results: parsing output: 39/ for test: syncobj_wait
results: parsing output: 40/ for test: gem_exec_params
results: parsing output: 41/ for test: syncobj_wait
results: parsing output: 42/ for test: syncobj_timeline
results: parsing output: 43/ for test: gem_gpgpu_fill
results: parsing output: 44/ for test: gem_exec_params
results: parsing output: 45/ for test: kms_frontbuffer_tracking
results: parsing output: 46/ for test: kms_big_fb
results: parsing output: 47/ for test: kms_cursor_legacy
results: parsing output: 48/ for test: kms_color
results: parsing output: 49/ for test: kms_chamelium_hpd
results: parsing output: 50/ for test: kms_pm_rpm
results: parsing output: 51/ for test: kms_big_fb
results: parsing output: 52/ for test: gem_pread
results: parsing output: 53/ for test: syncobj_timeline
results: parsing output: 54/ for test: gem_flink_basic
results: parsing output: 55/ for test: syncobj_timeline
results: parsing output: 56/ for test: prime_busy
results: parsing output: 57/ for test: kms_pipe_stress
results: parsing output: 58/ for test: kms_pm_rpm
results: parsing output: 59/ for test: kms_vblank
results: parsing output: 60/ for test: syncobj_timeline
results: parsing output: 61/ for test: kms_frontbuffer_tracking
results: parsing output: 62/ for test: kms_frontbuffer_tracking
results: parsing output: 63/ for test: kms_big_fb
results: parsing output: 64/ for test: gem_spin_batch
results: parsing output: 65/ for test: kms_flip
results: parsing output: 66/ for test: kms_cursor_legacy
results: parsing output: 67/ for test: syncobj_timeline
results: parsing output: 68/ for test: kms_draw_crc
results: parsing output: 69/ for test: kms_big_fb
results: parsing output: 70/ for test: perf_pmu
results: parsing output: 71/ for test: kms_fbcon_fbt
results: parsing output: 72/ for test: gem_exec_schedule
results: parsing output: 73/ for test: kms_frontbuffer_tracking
results: parsing output: 74/ for test: gem_mmap
results: parsing output: 75/ for test: kms_frontbuffer_tracking
results: parsing output: 76/ for test: gen9_exec_parse
results: parsing output: 77/ for test: dmabuf_sync_file
results: parsing output: 78/ for test: i915_pm_freq_api
results: parsing output: 79/ for test: kms_cursor_legacy
results: parsing output: 80/ for test: kms_async_flips
results: parsing output: 81/ for test: kms_content_protection
results: parsing output: 82/ for test: syncobj_wait
results: parsing output: 83/ for test: kms_rotation_crc
results: parsing output: 84/ for test: kms_ccs
results: parsing output: 85/ for test: gem_exec_balancer
results: parsing output: 86/ for test: gem_ccs
results: parsing output: 87/ for test: kms_flip_scaled_crc
results: parsing output: 88/ for test: gem_ctx_param
results: parsing output: 89/ for test: kms_psr2_sf
results: parsing output: 90/ for test: kms_flip
results: parsing output: 91/ for test: gem_exec_params
results: parsing output: 92/ for test: kms_invalid_mode
results: parsing output: 93/ for test: gem_mmap_gtt
results: parsing output: 94/ for test: kms_frontbuffer_tracking
results: parsing output: 95/ for test: gem_exec_params
results: parsing output: 96/ for test: kms_ccs
results: parsing output: 97/ for test: kms_cdclk
results: parsing output: 98/ for test: kms_frontbuffer_tracking
results: parsing output: 99/ for test: gem_pread
results: parsing output: 100/ for test: gem_exec_schedule
results: parsing output: 101/ for test: kms_lease
results: parsing output: 102/ for test: syncobj_wait
results: parsing output: 103/ for test: gem_caching
results: parsing output: 104/ for test: gem_exec_balancer
results: parsing output: 105/ for test: syncobj_wait
results: parsing output: 106/ for test: syncobj_wait
results: parsing output: 107/ for test: perf_pmu
results: parsing output: 108/ for test: kms_frontbuffer_tracking
results: parsing output: 109/ for test: kms_big_fb
results: parsing output: 110/ for test: kms_psr
results: parsing output: 111/ for test: gem_ctx_persistence
results: parsing output: 112/ for test: perf
results: parsing output: 113/ for test: kms_psr
results: parsing output: 114/ for test: kms_dsc
results: parsing output: 115/ for test: kms_flip
results: parsing output: 116/ for test: gem_pxp
results: parsing output: 117/ for test: gem_exec_alignment
results: parsing output: 118/ for test: kms_pm_dc
results: parsing output: 119/ for test: kms_cursor_crc
results: parsing output: 120/ for test: gem_ppgtt
results: parsing output: 121/ for test: kms_psr
results: parsing output: 122/ for test: api_intel_bb
results: parsing output: 123/ for test: kms_plane_multiple
results: parsing output: 124/ for test: kms_rotation_crc
results: parsing output: 125/ for test: kms_psr
results: parsing output: 126/ for test: kms_flip
results: parsing output: 127/ for test: kms_frontbuffer_tracking
results: parsing output: 128/ for test: kms_cursor_edge_walk
results: parsing output: 129/ for test: i915_pm_rpm
results: parsing output: 130/ for test: kms_psr
results: parsing output: 131/ for test: kms_frontbuffer_tracking
Done.