[46.604615] Initializing watchdogs
[46.604683]   /dev/watchdog0
[46.619916] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:9a49 Intel Tigerlake (Gen12) TigerLake-LP GT2 [Iris Xe Graphics]
[46.625905] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[46.628482] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[46.630415] [001/131] (960s left) gem_exec_await (wide-contexts)
[46.726475] Starting subtest: wide-contexts
[68.537331] Subtest wide-contexts: SUCCESS (21.901s)
[68.738565] [FACT gem_exec_await (wide-contexts)] new: kernel.kmod_is_loaded.vgem: true
[68.742579] [002/131] (938s left) kms_flip (2x-flip-vs-modeset)
[68.887294] Starting subtest: 2x-flip-vs-modeset
[68.896020] Subtest 2x-flip-vs-modeset: SKIP (0.009s)
[68.966744] [003/131] (938s left) syncobj_wait (single-wait-all-submitted)
[69.011274] Starting subtest: single-wait-all-submitted
[69.120547] Subtest single-wait-all-submitted: SUCCESS (0.109s)
[69.192498] [004/131] (938s left) gem_exec_balancer (full-late)
[69.250664] Starting subtest: full-late
[70.844110] Subtest full-late: SUCCESS (1.595s)
[71.032355] [005/131] (936s left) kms_plane (plane-position-covered)
[71.118757] Starting subtest: plane-position-covered
[71.344776] Starting dynamic subtest: pipe-A-plane-1
[71.585038] Dynamic subtest pipe-A-plane-1: SUCCESS (0.242s)
[71.593746] Starting dynamic subtest: pipe-A-plane-2
[71.812758] Dynamic subtest pipe-A-plane-2: SUCCESS (0.227s)
[71.822223] Starting dynamic subtest: pipe-A-plane-3
[72.056381] Dynamic subtest pipe-A-plane-3: SUCCESS (0.243s)
[72.062936] Starting dynamic subtest: pipe-A-plane-4
[72.291218] Dynamic subtest pipe-A-plane-4: SUCCESS (0.234s)
[72.299498] Starting dynamic subtest: pipe-A-plane-5
[72.513071] Dynamic subtest pipe-A-plane-5: SUCCESS (0.222s)
[72.520119] Starting dynamic subtest: pipe-A-plane-6
[72.746852] Dynamic subtest pipe-A-plane-6: SUCCESS (0.234s)
[72.755823] Starting dynamic subtest: pipe-A-plane-7
[72.757269] Dynamic subtest pipe-A-plane-7: SUCCESS (0.003s)
[72.940663] Starting dynamic subtest: pipe-B-plane-1
[73.158837] Dynamic subtest pipe-B-plane-1: SUCCESS (0.226s)
[73.165635] Starting dynamic subtest: pipe-B-plane-2
[73.376929] Dynamic subtest pipe-B-plane-2: SUCCESS (0.218s)
[73.386150] Starting dynamic subtest: pipe-B-plane-3
[73.604554] Dynamic subtest pipe-B-plane-3: SUCCESS (0.228s)
[73.613267] Starting dynamic subtest: pipe-B-plane-4
[73.833102] Dynamic subtest pipe-B-plane-4: SUCCESS (0.228s)
[73.841423] Starting dynamic subtest: pipe-B-plane-5
[74.059525] Dynamic subtest pipe-B-plane-5: SUCCESS (0.227s)
[74.068162] Starting dynamic subtest: pipe-B-plane-6
[74.286442] Dynamic subtest pipe-B-plane-6: SUCCESS (0.227s)
[74.295871] Starting dynamic subtest: pipe-B-plane-7
[74.297298] Dynamic subtest pipe-B-plane-7: SUCCESS (0.002s)
[74.298031] Subtest plane-position-covered: SUCCESS (3.172s)
[74.442788] [006/131] (932s left) gem_readwrite (new-obj)
[74.479829] Starting subtest: new-obj
[74.481147] Subtest new-obj: SUCCESS (0.000s)
[74.556589] [007/131] (932s left) gem_exercise_blt (fast-copy-emit)
[74.590876] Starting subtest: fast-copy-emit
[74.591585] Starting dynamic subtest: linear-smem-smem-emit
[74.610366] Dynamic subtest linear-smem-smem-emit: SUCCESS (0.019s)
[74.616791] Starting dynamic subtest: ymajor-smem-smem-emit
[74.626855] Dynamic subtest ymajor-smem-smem-emit: SUCCESS (0.016s)
[74.633123] Starting dynamic subtest: tile4-smem-smem-emit
[74.642634] Dynamic subtest tile4-smem-smem-emit: SUCCESS (0.015s)
[74.649085] Starting dynamic subtest: tile64-smem-smem-emit
[74.658479] Dynamic subtest tile64-smem-smem-emit: SUCCESS (0.016s)
[74.659176] Subtest fast-copy-emit: SUCCESS (0.068s)
[74.753457] [008/131] (932s left) i915_drm_fdinfo (busy)
[74.796642] Starting subtest: busy
[74.797444] Starting dynamic subtest: rcs0
[75.308440] Dynamic subtest rcs0: SUCCESS (0.519s)
[75.319579] Starting dynamic subtest: bcs0
[75.832317] Dynamic subtest bcs0: SUCCESS (0.523s)
[75.841951] Starting dynamic subtest: vcs0
[76.355327] Dynamic subtest vcs0: SUCCESS (0.522s)
[76.369866] Starting dynamic subtest: vcs1
[76.883411] Dynamic subtest vcs1: SUCCESS (0.527s)
[76.892672] Starting dynamic subtest: vecs0
[77.406328] Dynamic subtest vecs0: SUCCESS (0.522s)
[77.407374] Subtest busy: SUCCESS (2.618s)
[77.471158] [009/131] (929s left) perf (polling-parameterized)
[77.562133] Starting subtest: polling-parameterized
[97.613697] Subtest polling-parameterized: SUCCESS (20.020s)
[97.676833] [010/131] (909s left) kms_pm_rpm (modeset-non-lpsp-stress-no-wait)
[99.101959] Starting subtest: modeset-non-lpsp-stress-no-wait
[99.203844] Subtest modeset-non-lpsp-stress-no-wait: SKIP (0.101s)
[99.306253] [011/131] (908s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-mmap-wc)
[99.398723] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-mmap-wc
[99.400093] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[99.488846] [012/131] (908s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-mmap-wc)
[99.578413] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-mmap-wc
[99.579744] Subtest fbc-2p-scndscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[99.684313] [013/131] (907s left) dmabuf_sync_file (import-basic)
[99.719768] Starting subtest: import-basic
[99.721420] Subtest import-basic: SUCCESS (0.002s)
[99.778320] [014/131] (907s left) kms_invalid_mode (zero-hdisplay)
[99.862525] Starting subtest: zero-hdisplay
[99.863261] Starting dynamic subtest: pipe-A-HDMI-A-1
[99.920029] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.056s)
[99.928783] Starting dynamic subtest: pipe-B-HDMI-A-1
[99.929527] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.001s)
[99.936985] Starting dynamic subtest: pipe-C-HDMI-A-1
[99.937719] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.001s)
[99.944400] Starting dynamic subtest: pipe-D-HDMI-A-1
[99.945101] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.001s)
[99.945798] Subtest zero-hdisplay: SUCCESS (0.063s)
[100.049345] [015/131] (907s left) kms_big_fb (linear-32bpp-rotate-90)
[100.147974] Starting subtest: linear-32bpp-rotate-90
[100.229115] Subtest linear-32bpp-rotate-90: SKIP (0.081s)
[100.328762] [016/131] (907s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-pwrite)
[100.416333] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-pwrite
[101.786451] Subtest fbc-1p-primscrn-pri-indfb-draw-pwrite: SUCCESS (1.370s)
[101.890325] [017/131] (905s left) gem_mmap_wc (write-gtt-read-wc)
[101.924019] Starting subtest: write-gtt-read-wc
[102.238387] Subtest write-gtt-read-wc: SUCCESS (0.306s)
[102.310141] [018/131] (905s left) kms_properties (crtc-properties-atomic)
[102.395269] Starting subtest: crtc-properties-atomic
[102.395963] Starting dynamic subtest: pipe-A-HDMI-A-1
[102.542555] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.147s)
[102.552335] Starting dynamic subtest: pipe-B-HDMI-A-1
[102.729718] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.185s)
[102.737036] Starting dynamic subtest: pipe-C-HDMI-A-1
[102.897077] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.166s)
[102.904165] Starting dynamic subtest: pipe-D-HDMI-A-1
[103.090366] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.192s)
[103.091086] Subtest crtc-properties-atomic: SUCCESS (0.695s)
[103.246505] [019/131] (904s left) prime_mmap (test_dup)
[103.284245] Starting subtest: test_dup
[103.284927] Starting dynamic subtest: test_dup-smem
[103.287663] Dynamic subtest test_dup-smem: SUCCESS (0.003s)
[103.288330] Subtest test_dup: SUCCESS (0.004s)
[103.369880] [020/131] (904s left) kms_cursor_crc (cursor-random-128x42)
[103.455868] Starting subtest: cursor-random-128x42
[103.460574] Starting dynamic subtest: pipe-A-HDMI-A-1
[105.371905] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (1.912s)
[105.407443] Starting dynamic subtest: pipe-D-HDMI-A-1
[107.272151] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (1.874s)
[107.273140] Subtest cursor-random-128x42: SUCCESS (3.817s)
[107.443249] [021/131] (900s left) gem_eio (reset-stress)
[107.489526] Starting subtest: reset-stress
[107.490368] Starting dynamic subtest: render
[110.352701] Dynamic subtest render: SUCCESS (2.862s)
[110.361968] Starting dynamic subtest: bsd1
[113.214810] Dynamic subtest bsd1: SUCCESS (2.861s)
[113.226789] Starting dynamic subtest: bsd2
[116.085175] Dynamic subtest bsd2: SUCCESS (2.868s)
[116.096763] Starting dynamic subtest: blt
[118.960050] Dynamic subtest blt: SUCCESS (2.874s)
[118.970741] Starting dynamic subtest: vebox
[121.854043] Dynamic subtest vebox: SUCCESS (2.892s)
[121.854926] Subtest reset-stress: SUCCESS (14.364s)
[121.969358] [022/131] (886s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-0-hflip)
[122.063135] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-0-hflip
[122.064463] Subtest yf-tiled-max-hw-stride-32bpp-rotate-0-hflip: SKIP (0.000s)
[122.152406] [023/131] (885s left) gem_pxp (verify-pxp-stale-buf-execution)
[122.253713] Starting subtest: verify-pxp-stale-buf-execution
[123.319183] Subtest verify-pxp-stale-buf-execution: SUCCESS (1.067s)
[123.423658] [024/131] (884s left) syncobj_timeline (wait-all-for-submit-snapshot)
[123.457104] Starting subtest: wait-all-for-submit-snapshot
[123.540375] Subtest wait-all-for-submit-snapshot: SUCCESS (0.083s)
[123.635139] [025/131] (884s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-blt)
[123.723346] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-blt
[123.724807] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-blt: SKIP (0.000s)
[123.830669] [026/131] (884s left) perf_pmu (render-node-busy)
[123.869889] Starting subtest: render-node-busy
[123.870583] Starting dynamic subtest: rcs0
[124.421376] Dynamic subtest rcs0: SUCCESS (0.552s)
[124.431972] Starting dynamic subtest: bcs0
[124.957178] Dynamic subtest bcs0: SUCCESS (0.535s)
[124.969084] Starting dynamic subtest: vcs0
[125.488432] Dynamic subtest vcs0: SUCCESS (0.530s)
[125.498881] Starting dynamic subtest: vcs1
[126.026402] Dynamic subtest vcs1: SUCCESS (0.537s)
[126.038285] Starting dynamic subtest: vecs0
[126.554319] Dynamic subtest vecs0: SUCCESS (0.527s)
[126.555333] Subtest render-node-busy: SUCCESS (2.686s)
[126.619936] [027/131] (881s left) kms_cursor_legacy (short-flip-after-cursor-atomic-transitions-varying-size)
[126.707915] Starting subtest: short-flip-after-cursor-atomic-transitions-varying-size
[127.241258] Subtest short-flip-after-cursor-atomic-transitions-varying-size: SUCCESS (0.533s)
[127.361890] [028/131] (880s left) perf (blocking)
[127.449529] Starting subtest: blocking
[127.450225] Starting dynamic subtest: 0-rcs0
[137.502321] Dynamic subtest 0-rcs0: SUCCESS (10.018s)
[137.503386] Subtest blocking: SUCCESS (10.019s)
[137.568155] [029/131] (870s left) kms_properties (colorop-properties-atomic)
[137.666613] Starting subtest: colorop-properties-atomic
[137.668242] Starting dynamic subtest: pipe-A-HDMI-A-1
[137.739822] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.072s)
[137.748056] Starting dynamic subtest: pipe-B-HDMI-A-1
[137.838688] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.098s)
[137.847960] Starting dynamic subtest: pipe-C-HDMI-A-1
[137.973139] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.131s)
[137.982764] Starting dynamic subtest: pipe-D-HDMI-A-1
[138.084189] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.110s)
[138.084901] Subtest colorop-properties-atomic: SUCCESS (0.417s)
[138.204442] [030/131] (870s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-mmap-wc)
[138.295531] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-mmap-wc
[139.593677] Subtest fbc-1p-primscrn-pri-indfb-draw-mmap-wc: SUCCESS (1.298s)
[139.698126] [031/131] (868s left) kms_ccs (crc-primary-rotation-180-y-tiled-gen12-mc-ccs)
[139.784954] Starting subtest: crc-primary-rotation-180-y-tiled-gen12-mc-ccs
[139.785796] Starting dynamic subtest: pipe-A-HDMI-A-1
[139.792660] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.001s)
[139.801724] Starting dynamic subtest: pipe-B-HDMI-A-1
[139.808880] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.001s)
[139.817820] Starting dynamic subtest: pipe-C-HDMI-A-1
[139.824895] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.001s)
[139.832579] Starting dynamic subtest: pipe-D-HDMI-A-1
[139.839490] Dynamic subtest pipe-D-HDMI-A-1: SKIP (0.001s)
[139.840831] Subtest crc-primary-rotation-180-y-tiled-gen12-mc-ccs: SKIP (0.008s)
[140.017197] [032/131] (868s left) kms_cursor_crc (cursor-suspend)
[140.104496] Starting subtest: cursor-suspend
[140.105177] Starting dynamic subtest: pipe-A-HDMI-A-1
[172.601918] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (2.885s)
[172.613483] Starting dynamic subtest: pipe-D-HDMI-A-1
[205.594466] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (2.725s)
[205.595230] Subtest cursor-suspend: SUCCESS (5.613s)
[213.780050] [033/131] (802s left) kms_chamelium_hpd (dp-hpd-for-each-pipe)
[213.921039] Subtest dp-hpd-for-each-pipe: SKIP (0.000s)
[214.029174] [034/131] (802s left) syncobj_wait (invalid-reset-bad-pad)
[214.066779] Starting subtest: invalid-reset-bad-pad
[214.067514] Subtest invalid-reset-bad-pad: SUCCESS (0.000s)
[214.132418] [035/131] (802s left) kms_psr (psr2-sprite-plane-onoff)
[214.217548] Subtest psr2-sprite-plane-onoff: SKIP (0.000s)
[214.259155] [036/131] (802s left) kms_psr2_sf (psr2-overlay-plane-update-continuous-sf)
[214.346246] Subtest psr2-overlay-plane-update-continuous-sf: SKIP (0.000s)
[214.391336] [037/131] (802s left) gem_exec_fence (syncobj-signal)
[214.718465] Starting subtest: syncobj-signal
[214.721655] Subtest syncobj-signal: SUCCESS (0.003s)
[215.021920] [038/131] (801s left) kms_scaling_modes (scaling-mode-none)
[215.104896] Starting subtest: scaling-mode-none
[215.108781] Subtest scaling-mode-none: SKIP (0.001s)
[215.164261] [039/131] (801s left) drm_read (fault-buffer)
[215.271140] Starting subtest: fault-buffer
[215.271841] Subtest fault-buffer: SUCCESS (0.000s)
[215.382977] [040/131] (801s left) gem_create (create-valid-nonaligned)
[215.415984] Starting subtest: create-valid-nonaligned
[215.416662] Subtest create-valid-nonaligned: SUCCESS (0.000s)
[215.598167] [041/131] (801s left) gem_mmap_gtt (cpuset-medium-copy-xy)
[215.630676] Starting subtest: cpuset-medium-copy-XY
[225.844071] Subtest cpuset-medium-copy-XY: SUCCESS (10.279s)
[225.931849] [042/131] (790s left) syncobj_timeline (multi-wait-available-unsubmitted-submitted-signaled)
[226.022547] Starting subtest: multi-wait-available-unsubmitted-submitted-signaled
[226.023328] Subtest multi-wait-available-unsubmitted-submitted-signaled: SUCCESS (0.001s)
[226.097183] [043/131] (790s left) kms_psr (fbc-pr-sprite-mmap-cpu)
[226.188468] Subtest fbc-pr-sprite-mmap-cpu: SKIP (0.000s)
[226.231139] [044/131] (790s left) api_intel_bb (delta-check)
[226.264446] Starting subtest: delta-check
[226.267576] Subtest delta-check: SUCCESS (0.003s)
[226.383098] [045/131] (790s left) kms_pipe_b_c_ivb (pipe-b-dpms-off-modeset-pipe-c)
[226.416465] Subtest pipe-B-dpms-off-modeset-pipe-C: SKIP (0.000s)
[226.455961] [046/131] (790s left) gem_request_retire (retire-vma-not-inactive)
[226.493176] Starting subtest: retire-vma-not-inactive
[226.504479] Subtest retire-vma-not-inactive: SUCCESS (0.011s)
[226.623441] [047/131] (790s left) syncobj_wait (multi-wait-all-for-submit-unsubmitted-signaled)
[226.656607] Starting subtest: multi-wait-all-for-submit-unsubmitted-signaled
[226.757636] Subtest multi-wait-all-for-submit-unsubmitted-signaled: SUCCESS (0.102s)
[226.828767] [048/131] (790s left) kms_psr (pr-sprite-render)
[226.914806] Subtest pr-sprite-render: SKIP (0.000s)
[226.955010] [049/131] (790s left) kms_flip (plain-flip-fb-recreate-interruptible)
[227.044217] Starting subtest: plain-flip-fb-recreate-interruptible
[227.047019] Starting dynamic subtest: A-HDMI-A1
[234.872508] Dynamic subtest A-HDMI-A1: SUCCESS (7.840s)
[234.886317] Starting dynamic subtest: B-HDMI-A1
[242.667408] Dynamic subtest B-HDMI-A1: SUCCESS (7.800s)
[242.682608] Starting dynamic subtest: C-HDMI-A1
[250.451071] Dynamic subtest C-HDMI-A1: SUCCESS (7.780s)
[250.468440] Starting dynamic subtest: D-HDMI-A1
[258.230385] Dynamic subtest D-HDMI-A1: SUCCESS (7.776s)
[258.235449] Subtest plain-flip-fb-recreate-interruptible: SUCCESS (31.212s)
[258.387002] [050/131] (758s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-mmap-gtt)
[258.484949] Starting subtest: psr-1p-primscrn-pri-indfb-draw-mmap-gtt
[258.486329] Subtest psr-1p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[258.576130] [051/131] (758s left) syncobj_timeline (etime-multi-wait-all-available-unsubmitted-submitted-signal
[258.610077] Starting subtest: etime-multi-wait-all-available-unsubmitted-submitted-signaled
[258.717828] Subtest etime-multi-wait-all-available-unsubmitted-submitted-signaled: SUCCESS (0.107s)
[258.789098] [052/131] (758s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-64bpp-ytile-upscaling)
[258.878055] Starting subtest: flip-32bpp-ytile-to-64bpp-ytile-upscaling
[258.878746] Starting dynamic subtest: pipe-A-valid-mode
[259.694739] Dynamic subtest pipe-A-valid-mode: SUCCESS (0.816s)
[259.695429] Subtest flip-32bpp-ytile-to-64bpp-ytile-upscaling: SUCCESS (0.818s)
[259.849897] [053/131] (757s left) kms_cdclk (plane-scaling)
[259.884478] Subtest plane-scaling: SKIP (0.000s)
[259.924034] [054/131] (757s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-move)
[260.015027] Starting subtest: psr-2p-scndscrn-cur-indfb-move
[260.016378] Subtest psr-2p-scndscrn-cur-indfb-move: SKIP (0.000s)
[260.104585] [055/131] (757s left) perf (buffer-fill)
[260.193104] Starting subtest: buffer-fill
[260.193877] Starting dynamic subtest: 0-rcs0
[262.451194] Dynamic subtest 0-rcs0: SUCCESS (2.249s)
[262.451910] Subtest buffer-fill: SUCCESS (2.250s)
[262.487048] [056/131] (754s left) sysfs_defaults (readonly)
[262.538704] Starting subtest: readonly
[262.540800] Starting dynamic subtest: vecs0
[262.541571] Dynamic subtest vecs0: SUCCESS (0.001s)
[262.550697] Starting dynamic subtest: vcs0
[262.551422] Dynamic subtest vcs0: SUCCESS (0.001s)
[262.559201] Starting dynamic subtest: bcs0
[262.559899] Dynamic subtest bcs0: SUCCESS (0.000s)
[262.569210] Starting dynamic subtest: rcs0
[262.569939] Dynamic subtest rcs0: SUCCESS (0.000s)
[262.577884] Starting dynamic subtest: vcs1
[262.578571] Dynamic subtest vcs1: SUCCESS (0.000s)
[262.579248] Subtest readonly: SUCCESS (0.009s)
[262.611101] [057/131] (754s left) kms_rotation_crc (exhaust-fences)
[262.701012] Starting subtest: exhaust-fences
[263.826247] Subtest exhaust-fences: SUCCESS (1.126s)
[263.928374] [058/131] (753s left) gem_mmap_gtt (isolation)
[263.961897] Starting subtest: isolation
[263.965081] Subtest isolation: SUCCESS (0.002s)
[264.077753] [059/131] (753s left) gem_exec_schedule (lateslice)
[264.120902] Starting subtest: lateslice
[264.121639] Starting dynamic subtest: rcs0
[264.138274] Dynamic subtest rcs0: SUCCESS (0.018s)
[264.147686] Starting dynamic subtest: bcs0
[264.154137] Dynamic subtest bcs0: SUCCESS (0.015s)
[264.164168] Starting dynamic subtest: vcs0
[264.170181] Dynamic subtest vcs0: SUCCESS (0.015s)
[264.180251] Starting dynamic subtest: vcs1
[264.187243] Dynamic subtest vcs1: SUCCESS (0.016s)
[264.197290] Starting dynamic subtest: vecs0
[264.204262] Dynamic subtest vecs0: SUCCESS (0.016s)
[264.212450] Subtest lateslice: SUCCESS (0.085s)
[264.518639] [060/131] (753s left) gem_userptr_blits (map-fixed-invalidate-busy)
[264.563874] Starting subtest: map-fixed-invalidate-busy
[264.564626] Starting dynamic subtest: gtt
[266.077215] Dynamic subtest gtt: SUCCESS (1.504s)
[266.085566] Starting dynamic subtest: wb
[267.565248] Dynamic subtest wb: SUCCESS (1.487s)
[267.573309] Starting dynamic subtest: wc
[269.029627] Dynamic subtest wc: SUCCESS (1.464s)
[269.037886] Starting dynamic subtest: uc
[270.519394] Dynamic subtest uc: SUCCESS (1.489s)
[270.520152] Subtest map-fixed-invalidate-busy: SUCCESS (5.949s)
[270.628940] [061/131] (746s left) gem_mmap_wc (write-prefaulted)
[270.662111] Starting subtest: write-prefaulted
[270.696098] Subtest write-prefaulted: SUCCESS (0.034s)
[270.784074] [062/131] (746s left) syncobj_timeline (etime-multi-wait-all-for-submit-unsubmitted-submitted-signa
[270.817786] Starting subtest: etime-multi-wait-all-for-submit-unsubmitted-submitted-signaled
[270.927455] Subtest etime-multi-wait-all-for-submit-unsubmitted-submitted-signaled: SUCCESS (0.108s)
[270.998035] [063/131] (746s left) kms_ccs (bad-pixel-format-4-tiled-dg2-rc-ccs-cc)
[271.086032] Starting subtest: bad-pixel-format-4-tiled-dg2-rc-ccs-cc
[271.086805] Starting dynamic subtest: pipe-A-HDMI-A-1
[271.093608] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.000s)
[271.101851] Starting dynamic subtest: pipe-B-HDMI-A-1
[271.108676] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.000s)
[271.116718] Starting dynamic subtest: pipe-C-HDMI-A-1
[271.123478] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.000s)
[271.131303] Starting dynamic subtest: pipe-D-HDMI-A-1
[271.138261] Dynamic subtest pipe-D-HDMI-A-1: SKIP (0.000s)
[271.139649] Subtest bad-pixel-format-4-tiled-dg2-rc-ccs-cc: SKIP (0.007s)
[271.316894] [064/131] (746s left) kms_dirtyfb (fbc-dirtyfb-ioctl)
[271.405481] Starting subtest: fbc-dirtyfb-ioctl
[271.407683] Starting dynamic subtest: A-HDMI-A-1
[272.636919] Dynamic subtest A-HDMI-A-1: SUCCESS (1.230s)
[272.637596] Subtest fbc-dirtyfb-ioctl: SUCCESS (1.233s)
[272.758673] [065/131] (745s left) gem_ctx_isolation (preservation-s3)
[272.804785] Starting subtest: preservation-S3
[272.805498] Starting dynamic subtest: rcs0
[289.519654] Dynamic subtest rcs0: SUCCESS (1.345s)
[289.529118] Starting dynamic subtest: bcs0
[306.510291] Dynamic subtest bcs0: SUCCESS (1.360s)
[306.519665] Starting dynamic subtest: vcs0
[323.484332] Dynamic subtest vcs0: SUCCESS (1.347s)
[323.493245] Starting dynamic subtest: vcs1
[339.510345] Dynamic subtest vcs1: SUCCESS (1.353s)
[339.519854] Starting dynamic subtest: vecs0
[356.509433] Dynamic subtest vecs0: SUCCESS (1.378s)
[356.510202] Subtest preservation-S3: SUCCESS (6.789s)
[364.742680] [066/131] (661s left) kms_content_protection (suspend-resume)
[364.836022] Starting subtest: suspend-resume
[364.841327] Subtest suspend-resume: SKIP (0.004s)
[364.931061] [067/131] (660s left) kms_psr (fbc-psr-cursor-mmap-cpu)
[365.014828] Subtest fbc-psr-cursor-mmap-cpu: SKIP (0.000s)
[365.057511] [068/131] (660s left) gen7_exec_parse (basic-allowed)
[365.093346] Subtest basic-allowed: SKIP (0.000s)
[365.139361] [069/131] (660s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-mmap-wc)
[365.226991] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-mmap-wc
[366.419665] Subtest fbc-1p-primscrn-cur-indfb-draw-mmap-wc: SUCCESS (1.205s)
[366.543326] [070/131] (659s left) kms_draw_crc (draw-method-mmap-gtt)
[366.630071] Starting subtest: draw-method-mmap-gtt
[366.630804] Starting dynamic subtest: xrgb8888-untiled
[366.782952] Dynamic subtest xrgb8888-untiled: SUCCESS (0.155s)
[366.802139] Starting dynamic subtest: rgb565-untiled
[366.948363] Dynamic subtest rgb565-untiled: SUCCESS (0.164s)
[366.966498] Starting dynamic subtest: xrgb2101010-untiled
[367.088603] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.139s)
[367.107971] Starting dynamic subtest: xbgr16161616f-untiled
[367.237396] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.147s)
[367.256676] Starting dynamic subtest: xrgb8888-xtiled
[367.319960] Dynamic subtest xrgb8888-xtiled: SUCCESS (0.081s)
[367.338893] Starting dynamic subtest: rgb565-xtiled
[367.402624] Dynamic subtest rgb565-xtiled: SUCCESS (0.081s)
[367.421500] Starting dynamic subtest: xrgb2101010-xtiled
[367.476838] Dynamic subtest xrgb2101010-xtiled: SUCCESS (0.072s)
[367.495472] Starting dynamic subtest: xbgr16161616f-xtiled
[367.551452] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (0.072s)
[367.570958] Starting dynamic subtest: xrgb8888-ytiled
[367.633944] Dynamic subtest xrgb8888-ytiled: SUCCESS (0.081s)
[367.653462] Starting dynamic subtest: rgb565-ytiled
[367.716717] Dynamic subtest rgb565-ytiled: SUCCESS (0.081s)
[367.734703] Starting dynamic subtest: xrgb2101010-ytiled
[367.790985] Dynamic subtest xrgb2101010-ytiled: SUCCESS (0.072s)
[367.810103] Starting dynamic subtest: xbgr16161616f-ytiled
[367.898455] Dynamic subtest xbgr16161616f-ytiled: SUCCESS (0.106s)
[367.901789] Subtest draw-method-mmap-gtt: SUCCESS (1.282s)
[368.013932] [071/131] (658s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-180)
[368.113428] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-180
[368.114809] Subtest 4-tiled-max-hw-stride-32bpp-rotate-180: SKIP (0.000s)
[368.200658] [072/131] (657s left) kms_frontbuffer_tracking (psr-rgb565-draw-mmap-cpu)
[368.292600] Starting subtest: psr-rgb565-draw-mmap-cpu
[368.294043] Subtest psr-rgb565-draw-mmap-cpu: SKIP (0.000s)
[368.375926] [073/131] (657s left) gem_softpin (allocator-basic-reserve)
[368.413014] Starting subtest: allocator-basic-reserve
[368.491028] Subtest allocator-basic-reserve: SUCCESS (0.078s)
[368.599815] [074/131] (657s left) gem_render_copy (y-tiled-to-vebox-yf-tiled)
[368.638896] Starting subtest: y-tiled-to-vebox-yf-tiled
[368.639595] Starting dynamic subtest: smem
[368.705844] Dynamic subtest smem: SUCCESS (0.067s)
[368.706560] Subtest y-tiled-to-vebox-yf-tiled: SUCCESS (0.068s)
[368.889642] [075/131] (657s left) kms_pipe_crc_basic (compare-crc-sanitycheck-nv12)
[368.973407] Starting subtest: compare-crc-sanitycheck-nv12
[368.974101] Starting dynamic subtest: pipe-A-HDMI-A-1
[369.319617] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.347s)
[369.330231] Starting dynamic subtest: pipe-B-HDMI-A-1
[369.643415] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.323s)
[369.655450] Starting dynamic subtest: pipe-C-HDMI-A-1
[369.965930] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.322s)
[369.976915] Starting dynamic subtest: pipe-D-HDMI-A-1
[370.280065] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.314s)
[370.280876] Subtest compare-crc-sanitycheck-nv12: SUCCESS (1.315s)
[370.423530] [076/131] (655s left) gen7_exec_parse (batch-without-end)
[370.462946] Subtest batch-without-end: SKIP (0.000s)
[370.505982] [077/131] (655s left) kms_frontbuffer_tracking (fbc-2p-primscrn-indfb-plflip-blt)
[370.597088] Starting subtest: fbc-2p-primscrn-indfb-plflip-blt
[370.598490] Subtest fbc-2p-primscrn-indfb-plflip-blt: SKIP (0.000s)
[370.716807] [078/131] (655s left) kms_addfb_basic (basic)
[370.750993] Starting subtest: basic
[370.751720] Subtest basic: SUCCESS (0.000s)
[370.887785] [079/131] (655s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-mmap-gtt)
[370.978318] Starting subtest: psr-2p-primscrn-cur-indfb-draw-mmap-gtt
[370.979678] Subtest psr-2p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[371.077184] [080/131] (655s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-wc)
[371.165033] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-wc
[371.166463] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[371.255253] [081/131] (655s left) kms_flip (2x-blocking-absolute-wf_vblank-interruptible)
[371.343653] Starting subtest: 2x-blocking-absolute-wf_vblank-interruptible
[371.353138] Subtest 2x-blocking-absolute-wf_vblank-interruptible: SKIP (0.009s)
[371.414039] [082/131] (655s left) kms_psr (psr-sprite-plane-move)
[371.499970] Subtest psr-sprite-plane-move: SKIP (0.000s)
[371.543515] [083/131] (654s left) gem_exec_balancer (parallel-dmabuf-import-out-fence)
[371.706641] Subtest parallel-dmabuf-import-out-fence: SKIP (0.000s)
[371.779661] [084/131] (654s left) i915_pm_rpm (system-suspend)
[373.175545] Starting subtest: system-suspend
[391.400895] Subtest system-suspend: SUCCESS (3.400s)
[399.654278] [085/131] (634s left) gem_exec_reloc (basic-wc-read-active)
[399.697633] Starting subtest: basic-wc-read-active
[399.827759] Subtest basic-wc-read-active: SUCCESS (0.122s)
[399.948848] [086/131] (634s left) i915_suspend (basic-s3-without-i915)
[399.980700] Starting subtest: basic-s3-without-i915