[62.963484] Initializing watchdogs
[62.963558]   /dev/watchdog0
[62.993688] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:03:00.0: 8086:4905 Intel Dg1 (Gen12) DG1 [Iris Xe MAX Graphics]
[63.008420] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[63.013736] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[63.016362] [001/156] (960s left) syncobj_timeline (wait-all-for-submit-delayed-submit)
[63.068836] Starting subtest: wait-all-for-submit-delayed-submit
[63.178451] Subtest wait-all-for-submit-delayed-submit: SUCCESS (0.106s)
[63.335504] [002/156] (960s left) syncobj_basic (bad-destroy)
[63.379458] Starting subtest: bad-destroy
[63.380320] Subtest bad-destroy: SUCCESS (0.000s)
[63.489712] [003/156] (960s left) kms_frontbuffer_tracking (fbchdr-2p-scndscrn-spr-indfb-draw-mmap-gtt)
[64.976974] Starting subtest: fbchdr-2p-scndscrn-spr-indfb-draw-mmap-gtt
[64.979318] Subtest fbchdr-2p-scndscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[65.133812] [004/156] (958s left) gem_exec_whisper (basic-queues)
[65.204388] Starting subtest: basic-queues
[68.631205] Subtest basic-queues: SUCCESS (3.434s)
[68.871325] [005/156] (954s left) kms_ccs (bad-rotation-90-y-tiled-gen12-mc-ccs)
[70.355236] Starting subtest: bad-rotation-90-y-tiled-gen12-mc-ccs
[70.356117] Starting dynamic subtest: pipe-A-HDMI-A-3
[70.364851] Dynamic subtest pipe-A-HDMI-A-3: SKIP (0.000s)
[70.373488] Starting dynamic subtest: pipe-B-HDMI-A-3
[70.381962] Dynamic subtest pipe-B-HDMI-A-3: SKIP (0.000s)
[70.391056] Starting dynamic subtest: pipe-C-HDMI-A-3
[70.399849] Dynamic subtest pipe-C-HDMI-A-3: SKIP (0.000s)
[70.407907] Starting dynamic subtest: pipe-D-HDMI-A-3
[70.416935] Dynamic subtest pipe-D-HDMI-A-3: SKIP (0.000s)
[70.418782] Subtest bad-rotation-90-y-tiled-gen12-mc-ccs: SKIP (0.006s)
[70.622414] [006/156] (953s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-mmap-gtt)
[72.113858] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-mmap-gtt
[72.115766] Subtest psr-2p-scndscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[72.287088] [007/156] (951s left) prime_vgem (wait)
[72.413665] Starting subtest: wait
[72.414525] Starting dynamic subtest: rcs0
[72.461228] Dynamic subtest rcs0: SUCCESS (0.047s)
[72.471005] Starting dynamic subtest: bcs0
[72.511008] Dynamic subtest bcs0: SUCCESS (0.049s)
[72.522845] Starting dynamic subtest: vcs0
[72.558654] Dynamic subtest vcs0: SUCCESS (0.046s)
[72.592573] Starting dynamic subtest: vcs1
[72.600766] Dynamic subtest vcs1: SUCCESS (0.042s)
[72.617665] Starting dynamic subtest: vecs0
[72.640846] Dynamic subtest vecs0: SUCCESS (0.040s)
[72.642096] Subtest wait: SUCCESS (0.228s)
[72.881225] [FACT prime_vgem (wait)] new: kernel.kmod_is_loaded.vgem: true
[72.883829] [008/156] (951s left) syncobj_wait (invalid-multi-wait-unsubmitted-signaled)
[72.929946] Starting subtest: invalid-multi-wait-unsubmitted-signaled
[72.930871] Subtest invalid-multi-wait-unsubmitted-signaled: SUCCESS (0.000s)
[73.038166] [009/156] (951s left) kms_frontbuffer_tracking (psr-rgb101010-draw-pwrite)
[74.529956] Starting subtest: psr-rgb101010-draw-pwrite
[74.532056] Subtest psr-rgb101010-draw-pwrite: SKIP (0.000s)
[74.696312] [010/156] (949s left) kms_frontbuffer_tracking (hdr-2p-scndscrn-spr-indfb-draw-mmap-gtt)
[76.191909] Starting subtest: hdr-2p-scndscrn-spr-indfb-draw-mmap-gtt
[76.194123] Subtest hdr-2p-scndscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[76.354880] [011/156] (948s left) api_intel_bb (render)
[76.407093] Starting subtest: render
[76.408165] Starting dynamic subtest: render-none-512
[76.451859] Dynamic subtest render-none-512: SUCCESS (0.045s)
[76.461169] Starting dynamic subtest: render-none-1024
[76.522767] Dynamic subtest render-none-1024: SUCCESS (0.071s)
[76.531685] Starting dynamic subtest: render-x-512
[76.544448] Dynamic subtest render-x-512: SUCCESS (0.021s)
[76.553470] Starting dynamic subtest: render-x-1024
[76.611816] Dynamic subtest render-x-1024: SUCCESS (0.067s)
[76.621050] Starting dynamic subtest: render-y-512
[76.633173] Dynamic subtest render-y-512: SUCCESS (0.021s)
[76.642153] Starting dynamic subtest: render-y-1024
[76.692390] Dynamic subtest render-y-1024: SUCCESS (0.059s)
[76.693568] Subtest render: SUCCESS (0.286s)
[76.857797] [012/156] (947s left) kms_busy (extended-pageflip-hang-newfb)
[78.361937] Starting subtest: extended-pageflip-hang-newfb
[78.362856] Starting dynamic subtest: pipe-A
[86.274214] Dynamic subtest pipe-A: SUCCESS (7.911s)
[86.285777] Starting dynamic subtest: pipe-D
[94.071302] Dynamic subtest pipe-D: SUCCESS (7.792s)
[94.073163] Subtest extended-pageflip-hang-newfb: SUCCESS (15.709s)
[94.274219] [013/156] (930s left) gem_mmap_offset (open-flood)
[94.320750] Starting subtest: open-flood
[115.809266] Subtest open-flood: SUCCESS (21.486s)
[115.970441] [014/156] (908s left) gem_spin_batch (resubmit-new-all)
[116.029533] Starting subtest: resubmit-new-all
[116.030471] Starting dynamic subtest: rcs0
[116.058631] Dynamic subtest rcs0: SUCCESS (0.029s)
[116.067735] Starting dynamic subtest: bcs0
[116.068618] Dynamic subtest bcs0: SUCCESS (0.007s)
[116.077925] Starting dynamic subtest: vcs0
[116.078854] Dynamic subtest vcs0: SUCCESS (0.008s)
[116.087820] Starting dynamic subtest: vcs1
[116.088731] Dynamic subtest vcs1: SUCCESS (0.007s)
[116.097954] Starting dynamic subtest: vecs0
[116.099141] Dynamic subtest vecs0: SUCCESS (0.008s)
[116.100227] Subtest resubmit-new-all: SUCCESS (0.063s)
[116.439198] [015/156] (908s left) syncobj_timeline (invalid-signal-illegal-point)
[116.565758] Starting subtest: invalid-signal-illegal-point
[116.583963] Subtest invalid-signal-illegal-point: SUCCESS (0.000s)
[116.732222] [016/156] (908s left) kms_plane (pixel-format-y-tiled-gen12-mc-ccs-modifier-source-clamping)
[118.283350] Starting subtest: pixel-format-y-tiled-gen12-mc-ccs-modifier-source-clamping
[118.285549] Subtest pixel-format-y-tiled-gen12-mc-ccs-modifier-source-clamping: SKIP (0.000s)
[118.399206] [017/156] (906s left) kms_cursor_legacy (short-flip-before-cursor-toggle)
[119.897026] Starting subtest: short-flip-before-cursor-toggle
[120.882217] Subtest short-flip-before-cursor-toggle: SUCCESS (0.984s)
[121.114390] [018/156] (903s left) kms_pm_rpm (pm-tiling)
[125.048704] Starting subtest: pm-tiling
[125.050767] Subtest pm-tiling: SKIP (0.000s)
[126.104605] [019/156] (899s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-wc)
[127.605394] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-wc
[127.607126] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[127.819343] [020/156] (897s left) sw_sync (sync_multi_consumer_producer)
[127.863029] Starting subtest: sync_multi_consumer_producer
[128.148237] Subtest sync_multi_consumer_producer: SUCCESS (0.282s)
[128.254654] [021/156] (897s left) gem_pxp (verify-pxp-stale-buf-execution)
[130.824974] Starting subtest: verify-pxp-stale-buf-execution
[130.826996] Subtest verify-pxp-stale-buf-execution: SKIP (0.000s)
[130.936423] [022/156] (894s left) syncobj_timeline (multi-wait-for-submit-available-submitted)
[130.983357] Starting subtest: multi-wait-for-submit-available-submitted
[130.984225] Subtest multi-wait-for-submit-available-submitted: SUCCESS (0.001s)
[131.096718] [023/156] (894s left) gem_exec_reloc (basic-wc-cpu-active)
[131.149038] Subtest basic-wc-cpu-active: SKIP (0.000s)
[131.239793] [024/156] (894s left) kms_ccs (crc-primary-suspend-yf-tiled-ccs)
[132.726867] Starting subtest: crc-primary-suspend-yf-tiled-ccs
[132.729047] Starting dynamic subtest: pipe-A-HDMI-A-3
[132.732909] Dynamic subtest pipe-A-HDMI-A-3: SKIP (0.000s)
[132.742269] Starting dynamic subtest: pipe-B-HDMI-A-3
[132.745982] Dynamic subtest pipe-B-HDMI-A-3: SKIP (0.000s)
[132.755245] Starting dynamic subtest: pipe-C-HDMI-A-3
[132.758950] Dynamic subtest pipe-C-HDMI-A-3: SKIP (0.000s)
[132.767961] Starting dynamic subtest: pipe-D-HDMI-A-3
[132.771970] Dynamic subtest pipe-D-HDMI-A-3: SKIP (0.000s)
[132.773920] Subtest crc-primary-suspend-yf-tiled-ccs: SKIP (0.008s)
[132.992603] [025/156] (892s left) kms_frontbuffer_tracking (fbchdr-2p-primscrn-pri-shrfb-draw-render)
[134.486829] Starting subtest: fbchdr-2p-primscrn-pri-shrfb-draw-render
[134.488603] Subtest fbchdr-2p-primscrn-pri-shrfb-draw-render: SKIP (0.000s)
[134.641878] [026/156] (891s left) gem_exec_schedule (deep)
[134.871858] Starting subtest: deep
[134.873269] Starting dynamic subtest: rcs0
[150.768211] Dynamic subtest rcs0: SUCCESS (15.894s)
[150.778417] Starting dynamic subtest: bcs0
[166.850931] Dynamic subtest bcs0: SUCCESS (16.082s)
[166.860648] Starting dynamic subtest: vcs0
[182.842139] Dynamic subtest vcs0: SUCCESS (15.990s)
[182.858499] Starting dynamic subtest: vcs1
[199.095185] Dynamic subtest vcs1: SUCCESS (16.252s)
[199.105218] Starting dynamic subtest: vecs0
[215.339151] Dynamic subtest vecs0: SUCCESS (16.243s)
[215.340102] Subtest deep: SUCCESS (80.467s)
[216.387718] [027/156] (809s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-gtt)
[217.881028] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-gtt
[217.882944] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[218.091149] [028/156] (807s left) kms_vblank (ts-continuation-idle-hang)
[219.578824] Starting subtest: ts-continuation-idle-hang
[219.580898] Starting dynamic subtest: pipe-A-HDMI-A-3
[246.500269] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (26.918s)
[246.512653] Starting dynamic subtest: pipe-D-HDMI-A-3
[271.440263] Dynamic subtest pipe-D-HDMI-A-3: SUCCESS (24.936s)
[271.441188] Subtest ts-continuation-idle-hang: SUCCESS (51.861s)
[271.655533] [029/156] (754s left) kms_frontbuffer_tracking (psrhdr-2p-primscrn-pri-indfb-draw-blt)
[273.149211] Starting subtest: psrhdr-2p-primscrn-pri-indfb-draw-blt
[273.151171] Subtest psrhdr-2p-primscrn-pri-indfb-draw-blt: SKIP (0.000s)
[273.348285] [030/156] (752s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-shrfb-draw-mmap-gtt)
[274.843814] Starting subtest: psr-1p-offscreen-pri-shrfb-draw-mmap-gtt
[274.845449] Subtest psr-1p-offscreen-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[275.098546] [031/156] (751s left) gem_mmap_offset (ptrace)
[275.143250] Starting subtest: ptrace
[275.148520] Starting dynamic subtest: lmem0-fixed
[275.278664] Dynamic subtest lmem0-fixed: SUCCESS (0.127s)
[275.289808] Starting dynamic subtest: smem0-fixed
[275.300869] Dynamic subtest smem0-fixed: SUCCESS (0.021s)
[275.301832] Subtest ptrace: SUCCESS (0.158s)
[275.451661] [032/156] (751s left) gem_ctx_sseu (invalid-sseu)
[275.502461] Subtest invalid-sseu: SKIP (0.000s)
[275.587051] [033/156] (750s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-mmap-wc)
[277.081067] Starting subtest: fbcpsr-rgb565-draw-mmap-wc
[277.082886] Subtest fbcpsr-rgb565-draw-mmap-wc: SKIP (0.000s)
[277.275754] [034/156] (749s left) kms_color_pipeline (plane-lut1d-pre-ctm3x4)
[278.770069] Starting subtest: plane-lut1d-pre-ctm3x4
[278.963396] Starting dynamic subtest: pipe-A-plane-0
[279.211992] Dynamic subtest pipe-A-plane-0: SUCCESS (0.248s)
[279.252510] Starting dynamic subtest: pipe-A-plane-1
[279.428493] Dynamic subtest pipe-A-plane-1: SUCCESS (0.211s)
[279.455029] Starting dynamic subtest: pipe-A-plane-2
[279.611800] Dynamic subtest pipe-A-plane-2: SUCCESS (0.178s)
[279.910214] Starting dynamic subtest: pipe-B-plane-0
[280.073502] Dynamic subtest pipe-B-plane-0: SUCCESS (0.198s)
[280.103984] Starting dynamic subtest: pipe-B-plane-1
[280.273899] Dynamic subtest pipe-B-plane-1: SUCCESS (0.193s)
[280.283893] Starting dynamic subtest: pipe-B-plane-2
[280.438406] Dynamic subtest pipe-B-plane-2: SUCCESS (0.166s)
[280.730693] Starting dynamic subtest: pipe-C-plane-0
[280.916055] Dynamic subtest pipe-C-plane-0: SUCCESS (0.214s)
[280.929272] Starting dynamic subtest: pipe-C-plane-1
[281.098836] Dynamic subtest pipe-C-plane-1: SUCCESS (0.178s)
[281.121600] Starting dynamic subtest: pipe-C-plane-2
[281.297390] Dynamic subtest pipe-C-plane-2: SUCCESS (0.196s)
[281.603597] Starting dynamic subtest: pipe-D-plane-0
[281.790378] Dynamic subtest pipe-D-plane-0: SUCCESS (0.214s)
[281.819500] Starting dynamic subtest: pipe-D-plane-1
[282.007178] Dynamic subtest pipe-D-plane-1: SUCCESS (0.211s)
[282.038360] Starting dynamic subtest: pipe-D-plane-2
[282.223795] Dynamic subtest pipe-D-plane-2: SUCCESS (0.210s)
[282.278272] Subtest plane-lut1d-pre-ctm3x4: SUCCESS (3.508s)
[282.507113] [035/156] (744s left) gem_barrier_race (remote-request)
[282.560477] Starting subtest: remote-request
[282.561299] Starting dynamic subtest: rcs0
[287.626966] Dynamic subtest rcs0: SUCCESS (5.066s)
[287.630058] Subtest remote-request: SUCCESS (5.067s)
[287.880650] [036/156] (739s left) syncobj_wait (reset-multiple-signaled)
[287.927128] Starting subtest: reset-multiple-signaled
[287.928043] Subtest reset-multiple-signaled: SUCCESS (0.000s)
[288.049375] [037/156] (738s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-fullscreen)
[289.542126] Starting subtest: fbc-2p-scndscrn-spr-indfb-fullscreen
[289.543967] Subtest fbc-2p-scndscrn-spr-indfb-fullscreen: SKIP (0.000s)
[289.755891] [038/156] (737s left) gem_ctx_param (invalid-get-ringsize)
[289.802996] Starting subtest: invalid-get-ringsize
[289.804044] Subtest invalid-get-ringsize: SUCCESS (0.001s)
[289.939435] [039/156] (737s left) gem_exec_await (wide-contexts)
[290.062381] Starting subtest: wide-contexts
[312.503136] Subtest wide-contexts: SUCCESS (22.441s)
[312.742017] [040/156] (714s left) perf (gen12-oa-tlb-invalidate)
[312.951690] Starting subtest: gen12-oa-tlb-invalidate
[312.952661] Starting dynamic subtest: 0-rcs0
[323.027411] Dynamic subtest 0-rcs0: SUCCESS (10.072s)
[323.028294] Subtest gen12-oa-tlb-invalidate: SUCCESS (10.073s)
[323.099160] [041/156] (704s left) syncobj_wait (multi-wait-for-submit-signaled)
[323.145811] Starting subtest: multi-wait-for-submit-signaled
[323.146683] Subtest multi-wait-for-submit-signaled: SUCCESS (0.000s)
[323.270764] [042/156] (704s left) prime_self_import (export-vs-gem_close-race)
[323.316041] Starting subtest: export-vs-gem_close-race
[328.347278] Subtest export-vs-gem_close-race: SUCCESS (5.031s)
[328.488647] [043/156] (699s left) kms_frontbuffer_tracking (hdr-1p-pri-indfb-multidraw)
[329.999141] Starting subtest: hdr-1p-pri-indfb-multidraw
[330.001041] Subtest hdr-1p-pri-indfb-multidraw: SKIP (0.000s)
[330.182030] [044/156] (697s left) gem_ctx_persistence (legacy-engines-hostile)
[330.238488] Starting subtest: legacy-engines-hostile
[330.239416] Starting dynamic subtest: render
[330.300170] Dynamic subtest render: SUCCESS (0.062s)
[330.313300] Starting dynamic subtest: bsd1
[330.393645] Dynamic subtest bsd1: SUCCESS (0.090s)
[330.442082] Starting dynamic subtest: bsd2
[330.457344] Dynamic subtest bsd2: SUCCESS (0.057s)
[330.474988] Starting dynamic subtest: blt
[330.497273] Dynamic subtest blt: SUCCESS (0.038s)
[330.511126] Starting dynamic subtest: vebox
[330.589484] Dynamic subtest vebox: SUCCESS (0.089s)
[330.598095] Subtest legacy-engines-hostile: SUCCESS (0.355s)
[330.773461] [045/156] (697s left) kms_frontbuffer_tracking (fbchdr-2p-rte)
[332.267205] Starting subtest: fbchdr-2p-rte
[332.269139] Subtest fbchdr-2p-rte: SKIP (0.000s)
[332.456463] [046/156] (695s left) sysfs_heartbeat_interval (invalid)
[332.508905] Starting subtest: invalid
[332.511389] Starting dynamic subtest: vecs0
[332.512277] Dynamic subtest vecs0: SUCCESS (0.000s)
[332.522983] Starting dynamic subtest: vcs0
[332.524451] Dynamic subtest vcs0: SUCCESS (0.000s)
[332.534764] Starting dynamic subtest: bcs0
[332.535960] Dynamic subtest bcs0: SUCCESS (0.000s)
[332.545825] Starting dynamic subtest: rcs0
[332.547043] Dynamic subtest rcs0: SUCCESS (0.000s)
[332.557247] Starting dynamic subtest: vcs1
[332.558460] Dynamic subtest vcs1: SUCCESS (0.000s)
[332.559518] Subtest invalid: SUCCESS (0.009s)
[332.656184] [047/156] (695s left) kms_plane_scaling (plane-upscale-20x20-with-pixel-format)
[334.145266] Starting subtest: plane-upscale-20x20-with-pixel-format
[334.146215] Starting dynamic subtest: pipe-A
[336.367943] Dynamic subtest pipe-A: SUCCESS (2.223s)
[336.381378] Starting dynamic subtest: pipe-B
[338.607581] Dynamic subtest pipe-B: SUCCESS (2.238s)
[338.620430] Starting dynamic subtest: pipe-C
[338.915344] Dynamic subtest pipe-C: SUCCESS (0.306s)
[338.931265] Starting dynamic subtest: pipe-D
[339.221425] Dynamic subtest pipe-D: SUCCESS (0.304s)
[339.222596] Subtest plane-upscale-20x20-with-pixel-format: SUCCESS (5.078s)
[339.486024] [048/156] (688s left) kms_setmode (invalid-clone-exclusive-crtc)
[339.534425] Starting subtest: invalid-clone-exclusive-crtc
[339.537308] Subtest invalid-clone-exclusive-crtc: SKIP (0.000s)
[339.698261] [049/156] (688s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-0)
[341.212579] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-0
[341.214483] Subtest yf-tiled-max-hw-stride-64bpp-rotate-0: SKIP (0.000s)
[341.385779] [050/156] (686s left) kms_big_fb (linear-32bpp-rotate-0)
[342.894526] Starting subtest: linear-32bpp-rotate-0
[345.015774] Subtest linear-32bpp-rotate-0: SUCCESS (2.117s)
[345.244719] [051/156] (683s left) syncobj_timeline (etime-single-wait-all-available-unsubmitted)
[345.294780] Starting subtest: etime-single-wait-all-available-unsubmitted
[345.395311] Subtest etime-single-wait-all-available-unsubmitted: SUCCESS (0.101s)
[345.542786] [052/156] (682s left) gem_madvise (dontneed-before-exec)
[345.586419] Starting subtest: dontneed-before-exec
[345.590578] Subtest dontneed-before-exec: SKIP (0.003s)
[345.691727] [053/156] (682s left) kms_plane_alpha_blend (constant-alpha-min)
[347.180375] Starting subtest: constant-alpha-min
[347.445596] Starting dynamic subtest: pipe-A-HDMI-A-3
[348.116896] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (0.671s)
[348.128948] Starting dynamic subtest: pipe-D-HDMI-A-3
[348.819580] Dynamic subtest pipe-D-HDMI-A-3: SUCCESS (0.699s)
[348.820460] Subtest constant-alpha-min: SUCCESS (1.640s)
[349.050571] [054/156] (679s left) kms_frontbuffer_tracking (psrhdr-rgb101010-draw-mmap-gtt)
[350.544788] Starting subtest: psrhdr-rgb101010-draw-mmap-gtt
[350.546556] Subtest psrhdr-rgb101010-draw-mmap-gtt: SKIP (0.000s)
[350.720478] [055/156] (678s left) kms_frontbuffer_tracking (fbcpsrhdr-tiling-y)
[352.216323] Starting subtest: fbcpsrhdr-tiling-y
[352.218155] Subtest fbcpsrhdr-tiling-y: SKIP (0.000s)
[352.412473] [056/156] (676s left) kms_psr (fbc-psr2-primary-render)
[353.901522] Subtest fbc-psr2-primary-render: SKIP (0.000s)
[353.992506] [057/156] (674s left) kms_chamelium_edid (dp-edid-stress-resolution-4k)
[355.532891] Subtest dp-edid-stress-resolution-4k: SKIP (0.000s)
[355.665441] [058/156] (673s left) gem_create (create-size-update)
[355.713184] Starting subtest: create-size-update
[355.714206] Subtest create-size-update: SUCCESS (0.000s)
[356.063606] [059/156] (673s left) gem_exec_whisper (basic-queues-forked)
[356.123607] Starting subtest: basic-queues-forked
[369.864978] Subtest basic-queues-forked: SUCCESS (13.737s)
[370.088686] [060/156] (659s left) kms_frontbuffer_tracking (hdr-2p-primscrn-shrfb-plflip-blt)
[371.587811] Starting subtest: hdr-2p-primscrn-shrfb-plflip-blt
[371.589530] Subtest hdr-2p-primscrn-shrfb-plflip-blt: SKIP (0.000s)
[371.777064] [061/156] (657s left) gem_render_copy (y-tiled-mc-ccs-to-vebox-yf-tiled)
[371.833988] Starting subtest: y-tiled-mc-ccs-to-vebox-yf-tiled
[371.834875] Starting dynamic subtest: smem
[371.928296] Dynamic subtest smem: SUCCESS (0.093s)
[371.940400] Starting dynamic subtest: lmem0
[372.862033] Dynamic subtest lmem0: SUCCESS (0.929s)
[372.863340] Subtest y-tiled-mc-ccs-to-vebox-yf-tiled: SUCCESS (1.026s)
[373.123169] [062/156] (656s left) perf_pmu (busy-start)
[373.174337] Starting subtest: busy-start
[373.175271] Starting dynamic subtest: rcs0
[375.742039] Dynamic subtest rcs0: SUCCESS (2.567s)
[375.765540] Starting dynamic subtest: bcs0
[378.290098] Dynamic subtest bcs0: SUCCESS (2.546s)
[378.306248] Starting dynamic subtest: vcs0
[380.838121] Dynamic subtest vcs0: SUCCESS (2.546s)
[380.855260] Starting dynamic subtest: vcs1
[383.387138] Dynamic subtest vcs1: SUCCESS (2.546s)
[383.403593] Starting dynamic subtest: vecs0
[385.935099] Dynamic subtest vecs0: SUCCESS (2.546s)
[385.936307] Subtest busy-start: SUCCESS (12.762s)
[386.063352] [063/156] (643s left) kms_cursor_legacy (forked-bo)
[387.552470] Starting subtest: forked-bo
[387.553400] Starting dynamic subtest: pipe-A
[392.977927] Dynamic subtest pipe-A: SUCCESS (5.421s)
[392.992938] Starting dynamic subtest: pipe-B
[398.412045] Dynamic subtest pipe-B: SUCCESS (5.431s)
[398.432781] Starting dynamic subtest: pipe-C
[403.852094] Dynamic subtest pipe-C: SUCCESS (5.436s)
[403.872988] Starting dynamic subtest: pipe-D
[409.302425] Dynamic subtest pipe-D: SUCCESS (5.447s)
[409.323098] Starting dynamic subtest: all-pipes
[414.734155] Dynamic subtest all-pipes: SUCCESS (5.429s)
[414.735051] Subtest forked-bo: SUCCESS (27.179s)
[414.877181] [064/156] (614s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-primscrn-cur-indfb-draw-mmap-cpu)
[416.370885] Starting subtest: fbcpsrhdr-1p-primscrn-cur-indfb-draw-mmap-cpu
[416.372796] Subtest fbcpsrhdr-1p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[416.556842] [065/156] (613s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-mmap-gtt)
[418.050690] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-mmap-gtt
[418.052655] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[418.242562] [066/156] (611s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-blt)
[419.736042] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-blt
[422.619863] Subtest fbc-1p-primscrn-pri-shrfb-draw-blt: SUCCESS (2.884s)
[422.837907] [067/156] (607s left) gem_exec_reloc (basic-wc-cpu)
[422.890116] Subtest basic-wc-cpu: SKIP (0.000s)
[422.985759] [068/156] (607s left) gem_exec_flush (basic-wb-pro-default)
[423.037029] Subtest basic-wb-pro-default: SKIP (0.000s)
[423.131451] [069/156] (606s left) kms_cursor_legacy (flip-vs-cursor-crc-atomic)
[424.619457] Starting subtest: flip-vs-cursor-crc-atomic
[425.141543] Subtest flip-vs-cursor-crc-atomic: SUCCESS (0.521s)
[425.348315] [070/156] (604s left) kms_frontbuffer_tracking (fbcpsrhdr-farfromfence-mmap-gtt)
[426.842899] Starting subtest: fbcpsrhdr-farfromfence-mmap-gtt
[426.844556] Subtest fbcpsrhdr-farfromfence-mmap-gtt: SKIP (0.000s)
[427.017765] [071/156] (603s left) kms_big_fb (x-tiled-32bpp-rotate-0)
[428.526411] Starting subtest: x-tiled-32bpp-rotate-0
[430.792170] Subtest x-tiled-32bpp-rotate-0: SUCCESS (2.263s)
[431.006813] [072/156] (599s left) kms_frontbuffer_tracking (hdr-2p-pri-indfb-multidraw)
[432.505863] Starting subtest: hdr-2p-pri-indfb-multidraw
[432.507686] Subtest hdr-2p-pri-indfb-multidraw: SKIP (0.000s)
[432.679241] [073/156] (597s left) kms_psr2_sf (fbc-pr-overlay-plane-update-sf-dmg-area)
[434.171346] Subtest fbc-pr-overlay-plane-update-sf-dmg-area: SKIP (0.000s)
[434.249450] [074/156] (596s left) kms_frontbuffer_tracking (fbchdr-1p-offscreen-pri-indfb-draw-mmap-gtt)
[435.743821] Starting subtest: fbchdr-1p-offscreen-pri-indfb-draw-mmap-gtt
[435.745508] Subtest fbchdr-1p-offscreen-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[435.917472] [075/156] (594s left) kms_frontbuffer_tracking (psrhdr-2p-primscrn-cur-indfb-onoff)
[437.412151] Starting subtest: psrhdr-2p-primscrn-cur-indfb-onoff
[437.414161] Subtest psrhdr-2p-primscrn-cur-indfb-onoff: SKIP (0.000s)
[437.631757] [076/156] (593s left) gem_exec_schedule (pi-common)
[437.834228] Starting subtest: pi-common
[437.835235] Starting dynamic subtest: rcs0
[437.883967] Dynamic subtest rcs0: SUCCESS (0.049s)
[437.897157] Starting dynamic subtest: bcs0
[437.930642] Dynamic subtest bcs0: SUCCESS (0.045s)
[437.943877] Starting dynamic subtest: vcs0
[437.971366] Dynamic subtest vcs0: SUCCESS (0.039s)
[437.984757] Starting dynamic subtest: vcs1
[438.007740] Dynamic subtest vcs1: SUCCESS (0.035s)
[438.021085] Starting dynamic subtest: vecs0
[438.040575] Dynamic subtest vecs0: SUCCESS (0.031s)
[438.041632] Subtest pi-common: SUCCESS (0.207s)
[438.345999] [077/156] (592s left) kms_plane_scaling (plane-downscale-factor-0-75-with-modifiers)
[439.834502] Starting subtest: plane-downscale-factor-0-75-with-modifiers
[439.835442] Starting dynamic subtest: pipe-A
[440.604101] Dynamic subtest pipe-A: SUCCESS (0.770s)
[440.623542] Starting dynamic subtest: pipe-B
[441.377091] Dynamic subtest pipe-B: SUCCESS (0.771s)
[441.392568] Starting dynamic subtest: pipe-C
[442.151246] Dynamic subtest pipe-C: SUCCESS (0.772s)
[442.170212] Starting dynamic subtest: pipe-D
[442.925215] Dynamic subtest pipe-D: SUCCESS (0.772s)
[442.926226] Subtest plane-downscale-factor-0-75-with-modifiers: SUCCESS (3.093s)
[443.117397] [078/156] (587s left) gem_lmem_swapping (verify-random)
[447.404364] Starting subtest: verify-random
[447.405502] Starting dynamic subtest: lmem0
[457.530437] Dynamic subtest lmem0: SUCCESS (10.124s)
[457.531489] Subtest verify-random: SUCCESS (10.126s)
[458.546468] [FACT gem_lmem_swapping (verify-random)] deleted: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[458.547578] [FACT gem_lmem_swapping (verify-random)] deleted: kernel.kmod_is_loaded.i915: true
[458.550165] [079/156] (572s left) kms_frontbuffer_tracking (psrhdr-1p-primscrn-cur-indfb-draw-mmap-wc)
[463.291025] Starting subtest: psrhdr-1p-primscrn-cur-indfb-draw-mmap-wc
[463.292964] Subtest psrhdr-1p-primscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[463.531229] [FACT kms_frontbuffer_tracking (psrhdr-1p-primscrn-cur-indfb-draw-mmap-wc)] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[463.534406] [FACT kms_frontbuffer_tracking (psrhdr-1p-primscrn-cur-indfb-draw-mmap-wc)] new: kernel.kmod_is_loaded.i915: true
[463.543022] [080/156] (567s left) gem_userptr_blits (invalid-null-pointer)
[463.619984] Starting subtest: invalid-null-pointer
[463.621060] Subtest invalid-null-pointer: SUCCESS (0.002s)
[463.815835] [081/156] (567s left) kms_frontbuffer_tracking (hdr-2p-scndscrn-pri-shrfb-draw-blt)
[465.314628] Starting subtest: hdr-2p-scndscrn-pri-shrfb-draw-blt
[465.316317] Subtest hdr-2p-scndscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[465.476917] [082/156] (565s left) gem_exec_fence (expired-history)
[465.896268] Starting subtest: expired-history
[471.963227] Subtest expired-history: SUCCESS (6.064s)
[472.950436] [083/156] (558s left) kms_big_fb (y-tiled-64bpp-rotate-0)
[474.456969] Starting subtest: y-tiled-64bpp-rotate-0
[477.175725] Subtest y-tiled-64bpp-rotate-0: SUCCESS (2.715s)
[477.412851] [084/156] (554s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-blt)
[478.906814] Starting subtest: psr-2p-primscrn-spr-indfb-draw-blt
[478.908570] Subtest psr-2p-primscrn-spr-indfb-draw-blt: SKIP (0.000s)
[479.098881] [085/156] (552s left) kms_pm_rpm (modeset-lpsp-stress)
[483.027584] Starting subtest: modeset-lpsp-stress
[483.918519] Subtest modeset-lpsp-stress: SKIP (0.896s)
[484.945717] [086/156] (546s left) kms_cursor_legacy (short-busy-flip-before-cursor-atomic-transitions)
[486.436403] Starting subtest: short-busy-flip-before-cursor-atomic-transitions
[486.438101] Subtest short-busy-flip-before-cursor-atomic-transitions: SKIP (0.000s)
[486.560106] [087/156] (545s left) kms_addfb_basic (too-high)
[488.060499] Starting subtest: too-high
[488.061433] Subtest too-high: SUCCESS (0.001s)
[488.248764] [088/156] (543s left) kms_big_fb (4-tiled-8bpp-rotate-0)
[489.774130] Starting subtest: 4-tiled-8bpp-rotate-0
[489.776148] Subtest 4-tiled-8bpp-rotate-0: SKIP (0.000s)
[490.025812] [089/156] (542s left) kms_frontbuffer_tracking (fbchdr-1p-primscrn-pri-indfb-draw-mmap-wc)
[491.521799] Starting subtest: fbchdr-1p-primscrn-pri-indfb-draw-mmap-wc
[491.524208] Subtest fbchdr-1p-primscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[491.750786] [090/156] (540s left) kms_flip (2x-flip-vs-fences)
[493.241100] Starting subtest: 2x-flip-vs-fences
[493.243138] Subtest 2x-flip-vs-fences: SKIP (0.000s)
[493.387793] [091/156] (538s left) gem_eio (in-flight-suspend)
[493.583923] Starting subtest: in-flight-suspend
[542.007994] Subtest in-flight-suspend: SUCCESS (17.838s)
[548.585997] [092/156] (488s left) i915_pm_rps (waitboost)
[548.644239] Starting subtest: waitboost
[552.222294] Subtest waitboost: SUCCESS (3.577s)
[552.392098] [093/156] (485s left) kms_joiner (switch-modeset-ultra-joiner-big-joiner)
[553.881764] Starting subtest: switch-modeset-ultra-joiner-big-joiner
[553.883673] Subtest switch-modeset-ultra-joiner-big-joiner: SKIP (0.000s)
[554.040283] [094/156] (483s left) kms_plane_multiple (tiling-none)
[555.531156] Starting subtest: tiling-none
[555.532132] Starting dynamic subtest: pipe-A-HDMI-A-3
[556.430012] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (0.897s)
[556.446087] Starting dynamic subtest: pipe-B-HDMI-A-3
[557.256240] Dynamic subtest pipe-B-HDMI-A-3: SUCCESS (0.825s)
[557.274549] Starting dynamic subtest: pipe-C-HDMI-A-3
[558.084697] Dynamic subtest pipe-C-HDMI-A-3: SUCCESS (0.825s)
[558.102959] Starting dynamic subtest: pipe-D-HDMI-A-3
[558.924588] Dynamic subtest pipe-D-HDMI-A-3: SUCCESS (0.837s)
[558.925520] Subtest tiling-none: SUCCESS (3.394s)
[559.135670] [095/156] (478s left) sw_sync (alloc_merge_fence)
[559.182468] Starting subtest: alloc_merge_fence
[559.183426] Subtest alloc_merge_fence: SUCCESS (0.000s)
[559.274245] [096/156] (478s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-scndscrn-cur-indfb-draw-blt)
[560.767752] Starting subtest: fbcpsrhdr-2p-scndscrn-cur-indfb-draw-blt
[560.769351] Subtest fbcpsrhdr-2p-scndscrn-cur-indfb-draw-blt: SKIP (0.000s)
[560.959120] [097/156] (476s left) kms_flip (flip-vs-wf_vblank-interruptible)
[562.454069] Starting subtest: flip-vs-wf_vblank-interruptible
[562.462041] Starting dynamic subtest: A-HDMI-A3
[563.465333] Dynamic subtest A-HDMI-A3: SUCCESS (1.003s)
[563.483560] Starting dynamic subtest: B-HDMI-A3
[564.427349] Dynamic subtest B-HDMI-A3: SUCCESS (0.959s)
[564.444683] Starting dynamic subtest: C-HDMI-A3
[565.555532] Dynamic subtest C-HDMI-A3: SUCCESS (1.126s)
[565.571385] Starting dynamic subtest: D-HDMI-A3
[566.499209] Dynamic subtest D-HDMI-A3: SUCCESS (0.942s)
[566.501771] Subtest flip-vs-wf_vblank-interruptible: SUCCESS (4.047s)
[566.727830] [098/156] (471s left) kms_cursor_crc (cursor-offscreen-64x21)
[568.371121] Starting subtest: cursor-offscreen-64x21
[568.377279] Starting dynamic subtest: pipe-A-HDMI-A-3
[570.846201] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (2.468s)
[570.883485] Starting dynamic subtest: pipe-D-HDMI-A-3
[573.256416] Dynamic subtest pipe-D-HDMI-A-3: SUCCESS (2.386s)
[573.257503] Subtest cursor-offscreen-64x21: SUCCESS (4.885s)
[573.762559] [099/156] (464s left) kms_feature_discovery (display-1x)
[575.271375] Starting subtest: display-1x
[575.272330] Subtest display-1x: SUCCESS (0.000s)
[575.410926] [100/156] (462s left) gem_exec_balancer (hog)
[575.475403] Starting subtest: hog
[575.477676] Subtest hog: SKIP (0.000s)
[575.962270] [101/156] (462s left) dumb_buffer (create-valid-dumb)
[576.010694] Starting subtest: create-valid-dumb
[576.011659] Subtest create-valid-dumb: SUCCESS (0.000s)
[576.170392] [102/156] (462s left) kms_flip_scaled_crc (flip-32bpp-ytileccs-to-64bpp-ytile-downscaling)
[577.676082] Starting subtest: flip-32bpp-ytileccs-to-64bpp-ytile-downscaling
[577.677890] Subtest flip-32bpp-ytileccs-to-64bpp-ytile-downscaling: SKIP (0.000s)
[577.824032] [103/156] (460s left) kms_selftest (drm_plane_helper)
[577.976311] Starting subtest: drm_plane_helper
[578.054582] Starting dynamic subtest: drm_test_check_plane_state
[578.130175] Dynamic subtest drm_test_check_plane_state: SUCCESS (0.076s)
[578.170917] Starting dynamic subtest: drm_test_check_invalid_plane_state
[578.202591] Dynamic subtest drm_test_check_invalid_plane_state: SUCCESS (0.069s)
[578.205667] Subtest drm_plane_helper: SUCCESS (0.231s)
[578.465442] [104/156] (460s left) gem_exec_schedule (u-semaphore-noskip)
[578.530238] Starting subtest: u-semaphore-noskip
[578.926182] Subtest u-semaphore-noskip: SUCCESS (0.389s)
[579.366765] [105/156] (459s left) kms_addfb_basic (basic-x-tiled-legacy)
[579.413715] Starting subtest: basic-x-tiled-legacy
[579.415431] Subtest basic-x-tiled-legacy: SKIP (0.000s)
[581.077512] [106/156] (457s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-indfb-draw-pwrite)
[582.586956] Starting subtest: fbc-1p-offscreen-pri-indfb-draw-pwrite
[585.054745] Subtest fbc-1p-offscreen-pri-indfb-draw-pwrite: SUCCESS (2.451s)
[585.267977] [107/156] (453s left) i915_pm_rps (min-max-config-loaded)
[585.320467] Starting subtest: min-max-config-loaded
[585.322379] Subtest min-max-config-loaded: SKIP (0.001s)
[585.444697] [108/156] (453s left) kms_rotation_crc (primary-4-tiled-reflect-x-180)
[586.943056] Starting subtest: primary-4-tiled-reflect-x-180
[587.049804] Subtest primary-4-tiled-reflect-x-180: SKIP (0.106s)
[587.261613] [109/156] (451s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-primscrn-spr-indfb-move)
[588.763990] Starting subtest: fbcpsrhdr-1p-primscrn-spr-indfb-move
[588.765942] Subtest fbcpsrhdr-1p-primscrn-spr-indfb-move: SKIP (0.000s)
[588.947238] [110/156] (450s left) gem_mmap_gtt (basic)
[589.028082] Subtest basic: SKIP (0.000s)
[589.107595] [111/156] (450s left) kms_psr (fbc-pr-primary-render)
[590.607943] Subtest fbc-pr-primary-render: SKIP (0.000s)
[590.784870] [112/156] (448s left) kms_lease (invalid-create-leases)
[592.280452] Starting subtest: invalid-create-leases
[592.287207] Subtest invalid-create-leases: SUCCESS (0.007s)
[592.445074] [113/156] (447s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-mmap-cpu)
[593.945624] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-mmap-cpu
[596.374104] Subtest fbc-1p-primscrn-cur-indfb-draw-mmap-cpu: SUCCESS (2.420s)
[596.568426] [114/156] (442s left) kms_ccs (bad-rotation-90-y-tiled-ccs)
[598.062993] Starting subtest: bad-rotation-90-y-tiled-ccs
[598.063975] Starting dynamic subtest: pipe-A-HDMI-A-3
[598.072772] Dynamic subtest pipe-A-HDMI-A-3: SKIP (0.000s)
[598.088030] Starting dynamic subtest: pipe-B-HDMI-A-3
[598.096495] Dynamic subtest pipe-B-HDMI-A-3: SKIP (0.000s)
[598.111496] Starting dynamic subtest: pipe-C-HDMI-A-3
[598.120265] Dynamic subtest pipe-C-HDMI-A-3: SKIP (0.000s)
[598.134947] Starting dynamic subtest: pipe-D-HDMI-A-3
[598.143973] Dynamic subtest pipe-D-HDMI-A-3: SKIP (0.000s)
[598.145704] Subtest bad-rotation-90-y-tiled-ccs: SKIP (0.011s)
[598.349427] [115/156] (441s left) kms_flip (2x-dpms-vs-vblank-race-interruptible)
[599.848984] Starting subtest: 2x-dpms-vs-vblank-race-interruptible
[599.868949] Subtest 2x-dpms-vs-vblank-race-interruptible: SKIP (0.019s)
[600.028642] [116/156] (439s left) gem_mmap (basic)
[600.074986] Subtest basic: SKIP (0.000s)
[600.163630] [117/156] (439s left) gem_ctx_param (basic)
[600.210674] Starting subtest: basic
[600.211618] Subtest basic: SUCCESS (0.001s)
[600.339751] [118/156] (439s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-render)
[601.838700] Starting subtest: psr-1p-primscrn-pri-indfb-draw-render
[601.840707] Subtest psr-1p-primscrn-pri-indfb-draw-render: SKIP (0.000s)
[602.022493] [119/156] (437s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-mmap-wc)
[603.520814] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-mmap-wc
[603.522499] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[603.708271] [120/156] (436s left) i915_hangman (gt-engine-hang)
[603.770814] Starting subtest: gt-engine-hang
[603.771735] Starting dynamic subtest: rcs0
[604.488135] Dynamic subtest rcs0: SUCCESS (0.715s)
[604.520600] Starting dynamic subtest: bcs0
[605.176957] Dynamic subtest bcs0: SUCCESS (0.685s)
[605.195142] Starting dynamic subtest: vcs0
[605.845899] Dynamic subtest vcs0: SUCCESS (0.666s)
[605.863011] Starting dynamic subtest: vcs1
[606.514919] Dynamic subtest vcs1: SUCCESS (0.666s)
[606.536977] Starting dynamic subtest: vecs0
[607.182868] Dynamic subtest vecs0: SUCCESS (0.665s)
[607.183790] Subtest gt-engine-hang: SUCCESS (3.406s)
[607.354044] [121/156] (432s left) kms_rotation_crc (primary-rotation-180)
[608.847406] Starting subtest: primary-rotation-180
[619.460699] Subtest primary-rotation-180: SUCCESS (10.601s)
[619.727862] [122/156] (420s left) i915_drm_fdinfo (memory-info-shared)
[619.782062] Starting subtest: memory-info-shared
[619.782999] Starting dynamic subtest: lmem0
[619.851809] Dynamic subtest lmem0: SUCCESS (0.070s)
[619.869849] Starting dynamic subtest: smem0
[619.893592] Dynamic subtest smem0: SUCCESS (0.040s)
[619.894564] Subtest memory-info-shared: SUCCESS (0.114s)
[620.029260] [123/156] (420s left) gem_exec_suspend (basic-s3-devices)
[620.087050] Starting subtest: basic-S3-devices
[620.087936] Starting dynamic subtest: smem
[630.418514] Dynamic subtest smem: SUCCESS (10.321s)
[630.434929] Starting dynamic subtest: lmem0
[640.632513] Dynamic subtest lmem0: SUCCESS (10.205s)
[640.633660] Subtest basic-S3-devices: SUCCESS (20.529s)
[646.886432] [124/156] (399s left) syncobj_timeline (32bits-limit)
[646.936353] Starting subtest: 32bits-limit
[646.937157] Subtest 32bits-limit: SUCCESS (0.001s)
[647.061241] [125/156] (399s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-onoff)
[648.556585] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-onoff
[648.558507] Subtest fbcpsr-1p-primscrn-cur-indfb-onoff: SKIP (0.000s)
[648.736321] [126/156] (397s left) kms_chamelium_color (ctm-green-to-red)
[650.228286] Subtest ctm-green-to-red: SKIP (0.000s)
[650.418180] [127/156] (396s left) kms_getfb (getfb2-accept-nv12)
[651.908320] Starting subtest: getfb2-accept-nv12
[651.911221] Subtest getfb2-accept-nv12: SUCCESS (0.002s)
[652.089673] [128/156] (394s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-primscrn-pri-indfb-draw-blt)
[653.585535] Starting subtest: fbcpsrhdr-2p-primscrn-pri-indfb-draw-blt
[653.587578] Subtest fbcpsrhdr-2p-primscrn-pri-indfb-draw-blt: SKIP (0.000s)
[653.793499] [129/156] (393s left) kms_chamelium_hpd (hdmi-hpd-fast)
[655.330317] Subtest hdmi-hpd-fast: SKIP (0.000s)
[655.467930] [130/156] (391s left) kms_flip (2x-nonexisting-fb)
[656.959680] Starting subtest: 2x-nonexisting-fb
[656.978693] Subtest 2x-nonexisting-fb: SKIP (0.020s)
[657.136552] [131/156] (390s left) syncobj_wait (multi-wait-all-for-submit-signaled)
[657.185034] Starting subtest: multi-wait-all-for-submit-signaled
[657.186013] Subtest multi-wait-all-for-submit-signaled: SUCCESS (0.000s)
[657.310211] [132/156] (390s left) kms_big_fb (4-tiled-16bpp-rotate-270)
[658.820914] Starting subtest: 4-tiled-16bpp-rotate-270
[658.822659] Subtest 4-tiled-16bpp-rotate-270: SKIP (0.000s)
[658.991029] [133/156] (388s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-0-async-flip)
[660.501459] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-0-async-flip
[661.100369] Subtest x-tiled-max-hw-stride-64bpp-rotate-0-async-flip: SUCCESS (0.598s)
[661.363428] [134/156] (386s left) gem_busy (close-race)
[661.424313] Starting subtest: close-race
[683.456852] Subtest close-race: SUCCESS (22.026s)
[684.107151] [135/156] (363s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-pwrite)
[685.665792] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-pwrite
[685.667688] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[685.827606] [136/156] (361s left) gem_exec_fence (syncobj-import)
[686.262812] Starting subtest: syncobj-import
[686.283121] Subtest syncobj-import: SUCCESS (0.020s)
[686.786402] [137/156] (361s left) gem_vm_create (create-ext)
[686.839188] Starting subtest: create-ext
[686.843778] Subtest create-ext: SUCCESS (0.004s)
[687.010752] [138/156] (360s left) kms_psr2_sf (pr-primary-plane-update-sf-dmg-area-big-fb)
[688.502652] Subtest pr-primary-plane-update-sf-dmg-area-big-fb: SKIP (0.000s)
[688.609435] [139/156] (359s left) gem_render_copy (y-tiled)
[688.670410] Starting subtest: y-tiled
[688.671305] Starting dynamic subtest: smem
[688.767578] Dynamic subtest smem: SUCCESS (0.096s)
[688.784698] Starting dynamic subtest: lmem0
[689.529522] Dynamic subtest lmem0: SUCCESS (0.757s)
[689.530776] Subtest y-tiled: SUCCESS (0.856s)
[689.819754] [140/156] (358s left) gem_userptr_blits (map-fixed-invalidate-busy)
[689.882214] Starting subtest: map-fixed-invalidate-busy
[689.883982] Subtest map-fixed-invalidate-busy: SKIP (0.000s)
[690.036501] [141/156] (358s left) kms_flip_scaled_crc (flip-64bpp-linear-to-16bpp-linear-upscaling)
[691.527958] Starting subtest: flip-64bpp-linear-to-16bpp-linear-upscaling
[691.529013] Starting dynamic subtest: pipe-A-valid-mode
[692.333647] Dynamic subtest pipe-A-valid-mode: SUCCESS (0.804s)
[692.334586] Subtest flip-64bpp-linear-to-16bpp-linear-upscaling: SUCCESS (0.806s)
[692.547654] [142/156] (355s left) kms_psr (pr-cursor-mmap-cpu)
[694.039426] Subtest pr-cursor-mmap-cpu: SKIP (0.000s)
[694.128696] [143/156] (354s left) perf (invalid-oa-format-id)
[694.285211] Starting subtest: invalid-oa-format-id
[694.310918] Subtest invalid-oa-format-id: SUCCESS (0.026s)
[694.401430] [144/156] (353s left) kms_frontbuffer_tracking (psr-shrfb-scaledprimary)
[695.897224] Starting subtest: psr-shrfb-scaledprimary
[695.898869] Subtest psr-shrfb-scaledprimary: SKIP (0.000s)
[696.108932] [145/156] (352s left) gen9_exec_parse (bb-start-out)
[696.161734] Subtest bb-start-out: SKIP (0.000s)
[696.248613] [146/156] (352s left) kms_content_protection (dp-mst-lic-type-0-hdcp14)
[697.795981] Starting subtest: dp-mst-lic-type-0-hdcp14
[697.797920] Subtest dp-mst-lic-type-0-hdcp14: SKIP (0.000s)
[697.999395] [147/156] (350s left) kms_cursor_crc (cursor-rapid-movement-512x170)
[699.778595] Starting subtest: cursor-rapid-movement-512x170
[699.782312] Subtest cursor-rapid-movement-512x170: SKIP (0.001s)
[700.007526] [148/156] (348s left) gem_userptr_blits (readonly-unsync)
[700.062989] Subtest readonly-unsync: SKIP (0.000s)
[700.233378] [149/156] (348s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-render)
[701.727402] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-render
[704.418353] Subtest fbc-1p-primscrn-spr-indfb-draw-render: SUCCESS (2.690s)
[704.636933] [150/156] (344s left) kms_setmode (invalid-clone-single-crtc)
[704.685754] Starting subtest: invalid-clone-single-crtc
[704.688999] Subtest invalid-clone-single-crtc: SKIP (0.000s)
[704.818960] [151/156] (344s left) api_intel_allocator (reserve-simple)
[704.865840] Starting subtest: reserve-simple
[704.882054] Subtest reserve-simple: SUCCESS (0.016s)
[705.099491] [152/156] (344s left) kms_frontbuffer_tracking (psrhdr-2p-scndscrn-pri-indfb-draw-render)
[706.593126] Starting subtest: psrhdr-2p-scndscrn-pri-indfb-draw-render
[706.594769] Subtest psrhdr-2p-scndscrn-pri-indfb-draw-render: SKIP (0.000s)
[706.751475] [153/156] (342s left) kms_ccs (missing-ccs-buffer-yf-tiled-ccs)
[708.244993] Starting subtest: missing-ccs-buffer-yf-tiled-ccs
[708.245974] Starting dynamic subtest: pipe-A-HDMI-A-3
[708.254656] Dynamic subtest pipe-A-HDMI-A-3: SKIP (0.000s)
[708.269943] Starting dynamic subtest: pipe-B-HDMI-A-3
[708.278518] Dynamic subtest pipe-B-HDMI-A-3: SKIP (0.000s)
[708.293849] Starting dynamic subtest: pipe-C-HDMI-A-3
[708.303325] Dynamic subtest pipe-C-HDMI-A-3: SKIP (0.000s)
[708.318674] Starting dynamic subtest: pipe-D-HDMI-A-3
[708.328740] Dynamic subtest pipe-D-HDMI-A-3: SKIP (0.000s)
[708.331049] Subtest missing-ccs-buffer-yf-tiled-ccs: SKIP (0.010s)
[708.523073] [154/156] (340s left) kms_psr (pr-suspend)
[710.012996] Subtest pr-suspend: SKIP (0.000s)
[710.099991] [155/156] (339s left) kms_psr (psr-cursor-mmap-gtt)
[711.588241] Subtest psr-cursor-mmap-gtt: SKIP (0.000s)
[711.665850] [156/156] (337s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-pwrite)
[713.162361] Starting subtest: psr-2p-primscrn-cur-indfb-draw-pwrite
[713.164071] Subtest psr-2p-primscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[713.320222] Closing watchdogs
results: parsing output: 0/ for test: syncobj_timeline
results: parsing output: 1/ for test: syncobj_basic
results: parsing output: 2/ for test: kms_frontbuffer_tracking
results: parsing output: 3/ for test: gem_exec_whisper
results: parsing output: 4/ for test: kms_ccs
results: parsing output: 5/ for test: kms_frontbuffer_tracking
results: parsing output: 6/ for test: prime_vgem
results: parsing output: 7/ for test: syncobj_wait
results: parsing output: 8/ for test: kms_frontbuffer_tracking
results: parsing output: 9/ for test: kms_frontbuffer_tracking
results: parsing output: 10/ for test: api_intel_bb
results: parsing output: 11/ for test: kms_busy
results: parsing output: 12/ for test: gem_mmap_offset
results: parsing output: 13/ for test: gem_spin_batch
results: parsing output: 14/ for test: syncobj_timeline
results: parsing output: 15/ for test: kms_plane
results: parsing output: 16/ for test: kms_cursor_legacy
results: parsing output: 17/ for test: kms_pm_rpm
results: parsing output: 18/ for test: kms_frontbuffer_tracking
results: parsing output: 19/ for test: sw_sync
results: parsing output: 20/ for test: gem_pxp
results: parsing output: 21/ for test: syncobj_timeline
results: parsing output: 22/ for test: gem_exec_reloc
results: parsing output: 23/ for test: kms_ccs
results: parsing output: 24/ for test: kms_frontbuffer_tracking
results: parsing output: 25/ for test: gem_exec_schedule
results: parsing output: 26/ for test: kms_frontbuffer_tracking
results: parsing output: 27/ for test: kms_vblank
results: parsing output: 28/ for test: kms_frontbuffer_tracking
results: parsing output: 29/ for test: kms_frontbuffer_tracking
results: parsing output: 30/ for test: gem_mmap_offset
results: parsing output: 31/ for test: gem_ctx_sseu
results: parsing output: 32/ for test: kms_frontbuffer_tracking
results: parsing output: 33/ for test: kms_color_pipeline
results: parsing output: 34/ for test: gem_barrier_race
results: parsing output: 35/ for test: syncobj_wait
results: parsing output: 36/ for test: kms_frontbuffer_tracking
results: parsing output: 37/ for test: gem_ctx_param
results: parsing output: 38/ for test: gem_exec_await
results: parsing output: 39/ for test: perf
results: parsing output: 40/ for test: syncobj_wait
results: parsing output: 41/ for test: prime_self_import
results: parsing output: 42/ for test: kms_frontbuffer_tracking
results: parsing output: 43/ for test: gem_ctx_persistence
results: parsing output: 44/ for test: kms_frontbuffer_tracking
results: parsing output: 45/ for test: sysfs_heartbeat_interval
results: parsing output: 46/ for test: kms_plane_scaling
results: parsing output: 47/ for test: kms_setmode
results: parsing output: 48/ for test: kms_big_fb
results: parsing output: 49/ for test: kms_big_fb
results: parsing output: 50/ for test: syncobj_timeline
results: parsing output: 51/ for test: gem_madvise
results: parsing output: 52/ for test: kms_plane_alpha_blend
results: parsing output: 53/ for test: kms_frontbuffer_tracking
results: parsing output: 54/ for test: kms_frontbuffer_tracking
results: parsing output: 55/ for test: kms_psr
results: parsing output: 56/ for test: kms_chamelium_edid
results: parsing output: 57/ for test: gem_create
results: parsing output: 58/ for test: gem_exec_whisper
results: parsing output: 59/ for test: kms_frontbuffer_tracking
results: parsing output: 60/ for test: gem_render_copy
results: parsing output: 61/ for test: perf_pmu
results: parsing output: 62/ for test: kms_cursor_legacy
results: parsing output: 63/ for test: kms_frontbuffer_tracking
results: parsing output: 64/ for test: kms_frontbuffer_tracking
results: parsing output: 65/ for test: kms_frontbuffer_tracking
results: parsing output: 66/ for test: gem_exec_reloc
results: parsing output: 67/ for test: gem_exec_flush
results: parsing output: 68/ for test: kms_cursor_legacy
results: parsing output: 69/ for test: kms_frontbuffer_tracking
results: parsing output: 70/ for test: kms_big_fb
results: parsing output: 71/ for test: kms_frontbuffer_tracking
results: parsing output: 72/ for test: kms_psr2_sf
results: parsing output: 73/ for test: kms_frontbuffer_tracking
results: parsing output: 74/ for test: kms_frontbuffer_tracking
results: parsing output: 75/ for test: gem_exec_schedule
results: parsing output: 76/ for test: kms_plane_scaling
results: parsing output: 77/ for test: gem_lmem_swapping
results: parsing output: 78/ for test: kms_frontbuffer_tracking
results: parsing output: 79/ for test: gem_userptr_blits
results: parsing output: 80/ for test: kms_frontbuffer_tracking
results: parsing output: 81/ for test: gem_exec_fence
results: parsing output: 82/ for test: kms_big_fb
results: parsing output: 83/ for test: kms_frontbuffer_tracking
results: parsing output: 84/ for test: kms_pm_rpm
results: parsing output: 85/ for test: kms_cursor_legacy
results: parsing output: 86/ for test: kms_addfb_basic
results: parsing output: 87/ for test: kms_big_fb
results: parsing output: 88/ for test: kms_frontbuffer_tracking
results: parsing output: 89/ for test: kms_flip
results: parsing output: 90/ for test: gem_eio
results: parsing output: 91/ for test: i915_pm_rps
results: parsing output: 92/ for test: kms_joiner
results: parsing output: 93/ for test: kms_plane_multiple
results: parsing output: 94/ for test: sw_sync
results: parsing output: 95/ for test: kms_frontbuffer_tracking
results: parsing output: 96/ for test: kms_flip
results: parsing output: 97/ for test: kms_cursor_crc
results: parsing output: 98/ for test: kms_feature_discovery
results: parsing output: 99/ for test: gem_exec_balancer
results: parsing output: 100/ for test: dumb_buffer
results: parsing output: 101/ for test: kms_flip_scaled_crc
results: parsing output: 102/ for test: kms_selftest
results: parsing output: 103/ for test: gem_exec_schedule
results: parsing output: 104/ for test: kms_addfb_basic
results: parsing output: 105/ for test: kms_frontbuffer_tracking
results: parsing output: 106/ for test: i915_pm_rps
results: parsing output: 107/ for test: kms_rotation_crc
results: parsing output: 108/ for test: kms_frontbuffer_tracking
results: parsing output: 109/ for test: gem_mmap_gtt
results: parsing output: 110/ for test: kms_psr
results: parsing output: 111/ for test: kms_lease
results: parsing output: 112/ for test: kms_frontbuffer_tracking
results: parsing output: 113/ for test: kms_ccs
results: parsing output: 114/ for test: kms_flip
results: parsing output: 115/ for test: gem_mmap
results: parsing output: 116/ for test: gem_ctx_param
results: parsing output: 117/ for test: kms_frontbuffer_tracking
results: parsing output: 118/ for test: kms_frontbuffer_tracking
results: parsing output: 119/ for test: i915_hangman
results: parsing output: 120/ for test: kms_rotation_crc
results: parsing output: 121/ for test: i915_drm_fdinfo
results: parsing output: 122/ for test: gem_exec_suspend
results: parsing output: 123/ for test: syncobj_timeline
results: parsing output: 124/ for test: kms_frontbuffer_tracking
results: parsing output: 125/ for test: kms_chamelium_color
results: parsing output: 126/ for test: kms_getfb
results: parsing output: 127/ for test: kms_frontbuffer_tracking
results: parsing output: 128/ for test: kms_chamelium_hpd
results: parsing output: 129/ for test: kms_flip
results: parsing output: 130/ for test: syncobj_wait
results: parsing output: 131/ for test: kms_big_fb
results: parsing output: 132/ for test: kms_big_fb
results: parsing output: 133/ for test: gem_busy
results: parsing output: 134/ for test: kms_frontbuffer_tracking
results: parsing output: 135/ for test: gem_exec_fence
results: parsing output: 136/ for test: gem_vm_create
results: parsing output: 137/ for test: kms_psr2_sf
results: parsing output: 138/ for test: gem_render_copy
results: parsing output: 139/ for test: gem_userptr_blits
results: parsing output: 140/ for test: kms_flip_scaled_crc
results: parsing output: 141/ for test: kms_psr
results: parsing output: 142/ for test: perf
results: parsing output: 143/ for test: kms_frontbuffer_tracking
results: parsing output: 144/ for test: gen9_exec_parse
results: parsing output: 145/ for test: kms_content_protection
results: parsing output: 146/ for test: kms_cursor_crc
results: parsing output: 147/ for test: gem_userptr_blits
results: parsing output: 148/ for test: kms_frontbuffer_tracking
results: parsing output: 149/ for test: kms_setmode
results: parsing output: 150/ for test: api_intel_allocator
results: parsing output: 151/ for test: kms_frontbuffer_tracking
results: parsing output: 152/ for test: kms_ccs
results: parsing output: 153/ for test: kms_psr
results: parsing output: 154/ for test: kms_psr
results: parsing output: 155/ for test: kms_frontbuffer_tracking
Done.