[58.506287] Initializing watchdogs
[58.506333]   /dev/watchdog0
[58.520811] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:7dd5 Intel Meteorlake (Gen12) Meteor Lake-P [Intel Graphics]
[58.524819] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[58.527226] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[58.530678] [001/131] (960s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip)
[58.648978] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip
[58.653425] Subtest yf-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip: SKIP (0.000s)
[58.735596] [002/131] (960s left) dumb_buffer (map-valid)
[58.790708] Starting subtest: map-valid
[58.793054] Subtest map-valid: SUCCESS (0.000s)
[58.873543] [003/131] (960s left) kms_draw_crc (draw-method-mmap-wc)
[58.956781] Starting subtest: draw-method-mmap-wc
[58.958878] Starting dynamic subtest: xrgb8888-untiled
[59.188135] Dynamic subtest xrgb8888-untiled: SUCCESS (0.232s)
[59.195979] Starting dynamic subtest: rgb565-untiled
[59.389083] Dynamic subtest rgb565-untiled: SUCCESS (0.199s)
[59.396396] Starting dynamic subtest: xrgb2101010-untiled
[59.611284] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.222s)
[59.618418] Starting dynamic subtest: xbgr16161616f-untiled
[59.811979] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.199s)
[59.819782] Starting dynamic subtest: xrgb8888-xtiled
[59.934751] Dynamic subtest xrgb8888-xtiled: SUCCESS (0.122s)
[59.943392] Starting dynamic subtest: rgb565-xtiled
[60.068711] Dynamic subtest rgb565-xtiled: SUCCESS (0.133s)
[60.077061] Starting dynamic subtest: xrgb2101010-xtiled
[60.179939] Dynamic subtest xrgb2101010-xtiled: SUCCESS (0.111s)
[60.187691] Starting dynamic subtest: xbgr16161616f-xtiled
[60.291397] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (0.111s)
[60.298759] Starting dynamic subtest: xrgb8888-4tiled
[60.447173] Dynamic subtest xrgb8888-4tiled: SUCCESS (0.155s)
[60.453888] Starting dynamic subtest: rgb565-4tiled
[60.581116] Dynamic subtest rgb565-4tiled: SUCCESS (0.133s)
[60.587896] Starting dynamic subtest: xrgb2101010-4tiled
[60.714397] Dynamic subtest xrgb2101010-4tiled: SUCCESS (0.133s)
[60.722647] Starting dynamic subtest: xbgr16161616f-4tiled
[60.881639] Dynamic subtest xbgr16161616f-4tiled: SUCCESS (0.166s)
[60.883490] Subtest draw-method-mmap-wc: SUCCESS (1.922s)
[60.960214] [004/131] (958s left) syncobj_wait (single-wait-for-submit-submitted)
[61.013989] Starting subtest: single-wait-for-submit-submitted
[61.123045] Subtest single-wait-for-submit-submitted: SUCCESS (0.108s)
[61.194084] [005/131] (957s left) kms_psr (fbc-psr2-primary-render)
[61.265994] Starting subtest: fbc-psr2-primary-render
[61.268349] Starting dynamic subtest: eDP-1
[61.272449] Dynamic subtest eDP-1: SKIP (0.000s)
[61.276538] Subtest fbc-psr2-primary-render: SKIP (0.000s)
[61.337158] [006/131] (957s left) perf (gen12-mi-rpc)
[61.458049] Starting subtest: gen12-mi-rpc
[61.460257] Starting dynamic subtest: rcs0
[61.473700] Dynamic subtest rcs0: SUCCESS (0.017s)
[61.475598] Subtest gen12-mi-rpc: SUCCESS (0.017s)
[61.512820] [007/131] (957s left) kms_ccs (random-ccs-data-4-tiled-bmg-ccs)
[61.602617] Starting subtest: random-ccs-data-4-tiled-bmg-ccs
[61.607091] Subtest random-ccs-data-4-tiled-bmg-ccs: SKIP (0.000s)
[62.760861] [008/131] (956s left) kms_cursor_legacy (cursora-vs-flipa-atomic-transitions)
[62.869331] Starting subtest: cursorA-vs-flipA-atomic-transitions
[74.074778] Subtest cursorA-vs-flipA-atomic-transitions: SUCCESS (11.192s)
[74.917140] [009/131] (944s left) kms_psr_stress_test (flip-primary-invalidate-overlay)
[74.998067] Starting subtest: flip-primary-invalidate-overlay
[86.593221] Subtest flip-primary-invalidate-overlay: SUCCESS (11.594s)
[86.737953] [010/131] (932s left) kms_cursor_legacy (2x-long-nonblocking-modeset-vs-cursor-atomic)
[86.843069] Starting subtest: 2x-long-nonblocking-modeset-vs-cursor-atomic
[86.846857] Subtest 2x-long-nonblocking-modeset-vs-cursor-atomic: SKIP (0.001s)
[86.983538] [011/131] (932s left) gem_ctx_param (get-priority-new-ctx)
[87.031187] Starting subtest: get-priority-new-ctx
[87.032976] Subtest get-priority-new-ctx: SUCCESS (0.001s)
[87.133732] [012/131] (932s left) gem_ctx_persistence (legacy-engines-hang)
[87.201955] Starting subtest: legacy-engines-hang
[87.204039] Starting dynamic subtest: render
[87.273292] Dynamic subtest render: SUCCESS (0.071s)
[87.282971] Starting dynamic subtest: bsd1
[87.358183] Dynamic subtest bsd1: SUCCESS (0.083s)
[87.369130] Starting dynamic subtest: bsd2
[87.450269] Dynamic subtest bsd2: SUCCESS (0.090s)
[87.462846] Starting dynamic subtest: blt
[87.544132] Dynamic subtest blt: SUCCESS (0.090s)
[87.553851] Starting dynamic subtest: vebox
[87.631099] Dynamic subtest vebox: SUCCESS (0.085s)
[87.633344] Subtest legacy-engines-hang: SUCCESS (0.430s)
[87.706581] [013/131] (931s left) gem_softpin (evict-snoop-interruptible)
[87.760547] Starting subtest: evict-snoop-interruptible
[87.764323] Subtest evict-snoop-interruptible: SKIP (0.000s)
[87.874677] [014/131] (931s left) kms_psr (fbc-psr2-suspend)
[87.944076] Starting subtest: fbc-psr2-suspend
[87.945987] Starting dynamic subtest: eDP-1
[87.949393] Dynamic subtest eDP-1: SKIP (0.000s)
[87.952802] Subtest fbc-psr2-suspend: SKIP (0.001s)
[88.012531] [015/131] (931s left) perf (mi-rpc)
[88.106458] Starting subtest: mi-rpc
[88.110126] Subtest mi-rpc: SKIP (0.000s)
[88.166023] [016/131] (931s left) kms_plane_multiple (tiling-4)
[88.229410] Starting subtest: tiling-4
[88.231416] Starting dynamic subtest: pipe-A-eDP-1
[91.867240] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.635s)
[91.875881] Starting dynamic subtest: pipe-B-eDP-1
[96.288391] Dynamic subtest pipe-B-eDP-1: SUCCESS (4.420s)
[96.297690] Starting dynamic subtest: pipe-C-eDP-1
[100.632844] Dynamic subtest pipe-C-eDP-1: SUCCESS (4.343s)
[100.641213] Starting dynamic subtest: pipe-D-eDP-1
[104.976288] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.342s)
[104.978702] Subtest tiling-4: SUCCESS (16.745s)
[105.794503] [017/131] (913s left) syncobj_timeline (signal-array)
[105.863133] Starting subtest: signal-array
[105.865522] Subtest signal-array: SUCCESS (0.000s)
[105.980172] [018/131] (913s left) kms_universal_plane (cursor-fb-leak)
[106.059159] Starting subtest: cursor-fb-leak
[106.061655] Starting dynamic subtest: pipe-A-eDP-1
[106.395049] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.336s)
[106.405083] Starting dynamic subtest: pipe-B-eDP-1
[107.713058] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.316s)
[107.722807] Starting dynamic subtest: pipe-C-eDP-1
[109.023724] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.308s)
[109.033888] Starting dynamic subtest: pipe-D-eDP-1
[110.360206] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.335s)
[110.362659] Subtest cursor-fb-leak: SUCCESS (4.304s)
[111.524158] [019/131] (908s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-indfb-msflip-blt)
[111.602710] Starting subtest: fbcpsr-1p-primscrn-indfb-msflip-blt
[118.915170] Subtest fbcpsr-1p-primscrn-indfb-msflip-blt: SUCCESS (7.318s)
[119.040144] [020/131] (900s left) kms_ccs (bad-rotation-90-4-tiled-mtl-rc-ccs)
[119.111860] Starting subtest: bad-rotation-90-4-tiled-mtl-rc-ccs
[119.114208] Starting dynamic subtest: pipe-A-eDP-1
[119.250388] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.128s)
[119.260934] Starting dynamic subtest: pipe-B-eDP-1
[119.280861] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[119.288863] Starting dynamic subtest: pipe-C-eDP-1
[119.308219] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[119.315968] Starting dynamic subtest: pipe-D-eDP-1
[119.335375] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.002s)
[119.337610] Subtest bad-rotation-90-4-tiled-mtl-rc-ccs: SUCCESS (0.137s)
[121.522950] [021/131] (898s left) kms_frontbuffer_tracking (fbcpsr-suspend)
[121.591658] Starting subtest: fbcpsr-suspend
[162.035761] Subtest fbcpsr-suspend: SUCCESS (10.276s)
[162.168572] [022/131] (857s left) syncobj_eventfd (binary-wait-before-signal)
[162.231139] Starting subtest: binary-wait-before-signal
[162.259958] Subtest binary-wait-before-signal: SUCCESS (0.030s)
[162.346201] [023/131] (857s left) kms_invalid_mode (bad-hsync-start)
[162.427659] Starting subtest: bad-hsync-start
[162.430154] Starting dynamic subtest: pipe-A-eDP-1
[162.712518] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.287s)
[162.722592] Starting dynamic subtest: pipe-B-eDP-1
[162.724782] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[162.733887] Starting dynamic subtest: pipe-C-eDP-1
[162.736865] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[162.745895] Starting dynamic subtest: pipe-D-eDP-1
[162.748887] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[162.751853] Subtest bad-hsync-start: SUCCESS (0.294s)
[163.573695] [024/131] (856s left) i915_power (sanity)
[163.629712] Starting subtest: sanity
[167.670381] Subtest sanity: SUCCESS (4.015s)
[169.474628] [025/131] (850s left) syncobj_wait (invalid-multi-wait-all-unsubmitted)
[169.531135] Starting subtest: invalid-multi-wait-all-unsubmitted
[169.533672] Subtest invalid-multi-wait-all-unsubmitted: SUCCESS (0.000s)
[169.623217] [026/131] (850s left) kms_flip (2x-flip-vs-suspend-interruptible)
[169.699986] Starting subtest: 2x-flip-vs-suspend-interruptible
[169.704502] Subtest 2x-flip-vs-suspend-interruptible: SKIP (0.001s)
[169.820650] [027/131] (850s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-pwrite)
[169.905968] Starting subtest: psr-1p-primscrn-spr-indfb-draw-pwrite
[176.749400] Subtest psr-1p-primscrn-spr-indfb-draw-pwrite: SUCCESS (6.833s)
[176.857679] [028/131] (843s left) kms_chamelium_color (ctm-0-25)
[176.926297] Subtest ctm-0-25: SKIP (0.000s)
[176.972948] [029/131] (843s left) kms_async_flips (async-flip-with-page-flip-events-linear-atomic)
[177.051496] Starting subtest: async-flip-with-page-flip-events-linear-atomic
[177.430302] Starting dynamic subtest: pipe-A-eDP-1
[180.222001] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.787s)
[180.593980] Starting dynamic subtest: pipe-B-eDP-1
[183.350466] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.760s)
[183.725826] Starting dynamic subtest: pipe-C-eDP-1
[186.492083] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.769s)
[186.855693] Starting dynamic subtest: pipe-D-eDP-1
[189.623843] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.775s)
[189.626157] Subtest async-flip-with-page-flip-events-linear-atomic: SUCCESS (12.563s)
[190.809949] [030/131] (829s left) kms_ccs (crc-primary-suspend-4-tiled-dg2-rc-ccs)
[190.898313] Starting subtest: crc-primary-suspend-4-tiled-dg2-rc-ccs
[190.900589] Starting dynamic subtest: pipe-A-eDP-1
[190.909684] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[190.920324] Starting dynamic subtest: pipe-B-eDP-1
[190.929429] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[190.938695] Starting dynamic subtest: pipe-C-eDP-1
[190.947310] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[190.956277] Starting dynamic subtest: pipe-D-eDP-1
[190.964746] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[190.968837] Subtest crc-primary-suspend-4-tiled-dg2-rc-ccs: SKIP (0.005s)
[193.154096] [031/131] (827s left) kms_lease (lease-get)
[193.238156] Starting subtest: lease-get
[193.240442] Starting dynamic subtest: pipe-A-eDP-1
[193.242668] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[193.252222] Starting dynamic subtest: pipe-B-eDP-1
[193.254307] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[193.263172] Starting dynamic subtest: pipe-C-eDP-1
[193.265303] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[193.274155] Starting dynamic subtest: pipe-D-eDP-1
[193.276308] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[193.278457] Subtest lease-get: SUCCESS (0.008s)
[193.372259] [032/131] (826s left) gem_render_copy (y-tiled-ccs-to-x-tiled)
[193.422137] Starting subtest: y-tiled-ccs-to-x-tiled
[193.426478] Subtest y-tiled-ccs-to-x-tiled: SKIP (0.000s)
[193.599137] [033/131] (826s left) kms_psr (pr-sprite-mmap-cpu)
[193.670149] Starting subtest: pr-sprite-mmap-cpu
[193.674286] Subtest pr-sprite-mmap-cpu: SKIP (0.000s)
[193.741002] [034/131] (826s left) kms_flip (2x-busy-flip)
[193.831249] Starting subtest: 2x-busy-flip
[193.838076] Subtest 2x-busy-flip: SKIP (0.008s)
[193.936663] [035/131] (826s left) perf_pmu (gt-awake)
[193.986829] Starting subtest: gt-awake
[202.360082] Subtest gt-awake: SUCCESS (8.375s)
[202.484435] [036/131] (817s left) kms_chamelium_frames (hdmi-cmp-planar-formats)
[202.861730] Subtest hdmi-cmp-planar-formats: SKIP (0.000s)
[203.664146] [037/131] (816s left) i915_pm_rpm (debugfs-read)
[205.480611] Starting subtest: debugfs-read
[206.625838] Subtest debugfs-read: SUCCESS (1.143s)
[207.000838] [038/131] (813s left) syncobj_timeline (invalid-wait-illegal-handle)
[207.049517] Starting subtest: invalid-wait-illegal-handle
[207.051468] Subtest invalid-wait-illegal-handle: SUCCESS (0.000s)
[207.140019] [039/131] (813s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-shrfb-plflip-blt)
[207.219054] Starting subtest: fbcpsr-2p-primscrn-shrfb-plflip-blt
[207.223118] Subtest fbcpsr-2p-primscrn-shrfb-plflip-blt: SKIP (0.000s)
[207.324403] [040/131] (813s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-move)
[207.419745] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-move
[207.423924] Subtest fbcpsr-2p-scndscrn-spr-indfb-move: SKIP (0.000s)
[207.537254] [041/131] (813s left) kms_big_fb (yf-tiled-16bpp-rotate-90)
[207.621124] Starting subtest: yf-tiled-16bpp-rotate-90
[207.625436] Subtest yf-tiled-16bpp-rotate-90: SKIP (0.000s)
[207.715559] [042/131] (812s left) kms_big_fb (x-tiled-16bpp-rotate-270)
[207.806025] Starting subtest: x-tiled-16bpp-rotate-270
[207.824993] Subtest x-tiled-16bpp-rotate-270: SKIP (0.018s)
[207.938148] [043/131] (812s left) i915_hangman (gt-engine-hang)
[208.004687] Starting subtest: gt-engine-hang
[208.006628] Starting dynamic subtest: rcs0
[209.300845] Dynamic subtest rcs0: SUCCESS (1.294s)
[209.312765] Starting dynamic subtest: bcs0
[211.348393] Dynamic subtest bcs0: SUCCESS (2.044s)
[211.363491] Starting dynamic subtest: vcs0
[213.332076] Dynamic subtest vcs0: SUCCESS (1.981s)
[213.344764] Starting dynamic subtest: vcs1
[215.316424] Dynamic subtest vcs1: SUCCESS (1.981s)
[215.329635] Starting dynamic subtest: vecs0
[217.301459] Dynamic subtest vecs0: SUCCESS (1.982s)
[217.313889] Starting dynamic subtest: ccs0
[219.350009] Dynamic subtest ccs0: SUCCESS (2.044s)
[219.353707] Subtest gt-engine-hang: SUCCESS (11.341s)
[219.473130] [044/131] (801s left) syncobj_timeline (etime-multi-wait-submitted)
[219.526536] Starting subtest: etime-multi-wait-submitted
[219.634400] Subtest etime-multi-wait-submitted: SUCCESS (0.108s)
[219.709786] [045/131] (801s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-gtt)
[219.801669] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-gtt
[219.806201] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[219.910178] [046/131] (800s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-mmap-gtt)
[219.989861] Starting subtest: psr-2p-primscrn-pri-indfb-draw-mmap-gtt
[219.994258] Subtest psr-2p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[220.093666] [047/131] (800s left) kms_psr (psr-cursor-plane-onoff)
[220.160876] Starting subtest: psr-cursor-plane-onoff
[220.163356] Starting dynamic subtest: eDP-1
[221.887631] Dynamic subtest eDP-1: SUCCESS (1.727s)
[221.889880] Subtest psr-cursor-plane-onoff: SUCCESS (1.728s)
[222.748953] [048/131] (798s left) kms_frontbuffer_tracking (fbc-indfb-scaledprimary)
[222.834209] Starting subtest: fbc-indfb-scaledprimary
[225.822046] Subtest fbc-indfb-scaledprimary: SUCCESS (2.992s)
[226.981366] [049/131] (793s left) kms_pm_dc (dc5-retention-flops)
[228.059401] Starting subtest: dc5-retention-flops
[228.063947] Subtest dc5-retention-flops: SKIP (0.000s)
[228.151964] [050/131] (792s left) kms_plane_scaling (plane-downscale-factor-0-75-with-rotation)
[228.219745] Starting subtest: plane-downscale-factor-0-75-with-rotation
[228.221975] Starting dynamic subtest: pipe-A
[228.448159] Dynamic subtest pipe-A: SUCCESS (0.230s)
[228.457717] Starting dynamic subtest: pipe-B
[229.756366] Dynamic subtest pipe-B: SUCCESS (1.307s)
[229.768326] Starting dynamic subtest: pipe-C
[231.100555] Dynamic subtest pipe-C: SUCCESS (1.342s)
[231.117642] Starting dynamic subtest: pipe-D
[232.425007] Dynamic subtest pipe-D: SUCCESS (1.322s)
[232.427303] Subtest plane-downscale-factor-0-75-with-rotation: SUCCESS (4.206s)
[233.587328] [051/131] (787s left) kms_plane (pixel-format-y-tiled-gen12-mc-ccs-modifier)
[233.678310] Starting subtest: pixel-format-y-tiled-gen12-mc-ccs-modifier
[233.682765] Subtest pixel-format-y-tiled-gen12-mc-ccs-modifier: SKIP (0.000s)
[233.750812] [052/131] (787s left) gen7_exec_parse (batch-without-end)
[233.817468] Subtest batch-without-end: SKIP (0.000s)
[233.895195] [053/131] (787s left) gem_spin_batch (resubmit-new)
[233.952703] Starting subtest: resubmit-new
[233.955063] Starting dynamic subtest: rcs0
[233.961336] Dynamic subtest rcs0: SUCCESS (0.007s)
[233.975139] Starting dynamic subtest: bcs0
[233.977517] Dynamic subtest bcs0: SUCCESS (0.004s)
[233.987365] Starting dynamic subtest: vcs0
[233.989234] Dynamic subtest vcs0: SUCCESS (0.005s)
[233.997932] Starting dynamic subtest: vcs1
[233.999872] Dynamic subtest vcs1: SUCCESS (0.004s)
[234.008564] Starting dynamic subtest: vecs0
[234.010470] Dynamic subtest vecs0: SUCCESS (0.005s)
[234.019144] Starting dynamic subtest: ccs0
[234.021038] Dynamic subtest ccs0: SUCCESS (0.005s)
[234.022973] Subtest resubmit-new: SUCCESS (0.034s)
[235.441348] [054/131] (785s left) syncobj_wait (multi-wait-signaled)
[235.503298] Starting subtest: multi-wait-signaled
[235.505605] Subtest multi-wait-signaled: SUCCESS (0.001s)
[235.600559] [055/131] (785s left) kms_flip (2x-blocking-absolute-wf_vblank-interruptible)
[235.686900] Starting subtest: 2x-blocking-absolute-wf_vblank-interruptible
[235.693918] Subtest 2x-blocking-absolute-wf_vblank-interruptible: SKIP (0.007s)
[235.792051] [056/131] (785s left) gem_flink_race (flink_close)
[235.837748] Starting subtest: flink_close
[240.945423] Subtest flink_close: SUCCESS (5.110s)
[241.017243] [057/131] (780s left) kms_color (ctm-max)
[241.100379] Starting subtest: ctm-max
[241.102543] Starting dynamic subtest: pipe-A-eDP-1
[241.821953] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.720s)
[241.832309] Starting dynamic subtest: pipe-B-eDP-1
[243.197152] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.377s)
[243.207121] Starting dynamic subtest: pipe-C-eDP-1
[244.585208] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.384s)
[244.594939] Starting dynamic subtest: pipe-D-eDP-1
[245.914654] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.329s)
[245.916688] Subtest ctm-max: SUCCESS (4.813s)
[246.724520] [058/131] (774s left) gem_mmap_offset (ptrace)
[246.779641] Starting subtest: ptrace
[246.781916] Starting dynamic subtest: smem0-wb
[246.796636] Dynamic subtest smem0-wb: SUCCESS (0.017s)
[246.806160] Starting dynamic subtest: smem0-wc
[246.816454] Dynamic subtest smem0-wc: SUCCESS (0.019s)
[246.825730] Starting dynamic subtest: smem0-uc
[246.842821] Dynamic subtest smem0-uc: SUCCESS (0.025s)
[246.845222] Subtest ptrace: SUCCESS (0.067s)
[246.940083] [059/131] (774s left) kms_async_flips (test-cursor)
[247.015061] Starting subtest: test-cursor
[247.396307] Starting dynamic subtest: pipe-A-eDP-1
[248.198698] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.802s)
[248.585206] Starting dynamic subtest: pipe-B-eDP-1
[249.327910] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.750s)
[249.706560] Starting dynamic subtest: pipe-C-eDP-1
[250.453164] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.755s)
[250.820616] Starting dynamic subtest: pipe-D-eDP-1
[251.583303] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.770s)
[251.585649] Subtest test-cursor: SUCCESS (4.568s)
[252.751462] [060/131] (768s left) kms_cursor_crc (cursor-offscreen-512x512)
[252.988337] Starting subtest: cursor-offscreen-512x512
[252.992674] Subtest cursor-offscreen-512x512: SKIP (0.001s)
[253.146119] [061/131] (768s left) dumb_buffer (create-clear)
[253.198229] Starting subtest: create-clear
[287.408382] Subtest create-clear: SUCCESS (34.211s)
[287.529923] [062/131] (733s left) kms_busy (basic-hang)
[287.600110] Starting subtest: basic-hang
[287.602497] Starting dynamic subtest: flip-pipe-A
[288.193271] Dynamic subtest flip-pipe-A: SUCCESS (0.591s)
[288.203596] Starting dynamic subtest: modeset-pipe-A
[291.647371] Dynamic subtest modeset-pipe-A: SUCCESS (3.454s)
[291.657637] Starting dynamic subtest: flip-pipe-D
[292.839369] Dynamic subtest flip-pipe-D: SUCCESS (1.189s)
[292.849409] Starting dynamic subtest: modeset-pipe-D
[296.283747] Dynamic subtest modeset-pipe-D: SUCCESS (3.442s)
[296.286122] Subtest basic-hang: SUCCESS (8.685s)
[297.096881] [063/131] (724s left) kms_big_fb (4-tiled-32bpp-rotate-180)
[297.182024] Starting subtest: 4-tiled-32bpp-rotate-180
[298.618116] Subtest 4-tiled-32bpp-rotate-180: SUCCESS (1.435s)
[298.752615] [064/131] (722s left) kms_flip (flip-vs-wf_vblank-interruptible)
[298.841083] Starting subtest: flip-vs-wf_vblank-interruptible
[298.845568] Starting dynamic subtest: A-eDP1
[300.726960] Dynamic subtest A-eDP1: SUCCESS (1.883s)
[300.739966] Starting dynamic subtest: B-eDP1
[302.662418] Dynamic subtest B-eDP1: SUCCESS (1.932s)
[302.675446] Starting dynamic subtest: C-eDP1
[304.581194] Dynamic subtest C-eDP1: SUCCESS (1.915s)
[304.593582] Starting dynamic subtest: D-eDP1
[306.506466] Dynamic subtest D-eDP1: SUCCESS (1.923s)
[306.508847] Subtest flip-vs-wf_vblank-interruptible: SUCCESS (7.665s)
[307.736135] [065/131] (713s left) gem_exec_params (invalid-flag)
[307.810905] Starting subtest: invalid-flag
[307.813377] Subtest invalid-flag: SUCCESS (0.000s)
[307.926059] [066/131] (713s left) gem_exec_fence (syncobj-backward-timeline-chain-engines)
[308.512476] Starting subtest: syncobj-backward-timeline-chain-engines
[308.610843] Subtest syncobj-backward-timeline-chain-engines: SUCCESS (0.100s)
[310.482981] [FACT gem_exec_fence (syncobj-backward-timeline-chain-engines)] new: kernel.kmod_is_loaded.vgem: true
[310.486461] [067/131] (711s left) kms_cursor_legacy (torture-bo)
[310.591528] Starting subtest: torture-bo
[310.593739] Starting dynamic subtest: pipe-A
[316.758892] Dynamic subtest pipe-A: SUCCESS (6.164s)
[316.776261] Starting dynamic subtest: pipe-B
[323.927295] Dynamic subtest pipe-B: SUCCESS (7.166s)
[323.937852] Starting dynamic subtest: pipe-C
[330.910994] Dynamic subtest pipe-C: SUCCESS (6.980s)
[330.925258] Starting dynamic subtest: pipe-D
[338.343545] Dynamic subtest pipe-D: SUCCESS (7.429s)
[338.353685] Starting dynamic subtest: all-pipes
[344.675616] Dynamic subtest all-pipes: SUCCESS (6.327s)
[344.678011] Subtest torture-bo: SUCCESS (34.076s)
[344.842193] [068/131] (676s left) kms_frontbuffer_tracking (psr-rgb101010-draw-mmap-wc)
[344.911578] Starting subtest: psr-rgb101010-draw-mmap-wc
[351.893506] Subtest psr-rgb101010-draw-mmap-wc: SUCCESS (6.984s)
[351.997400] [069/131] (669s left) gem_exec_fence (syncobj-timeline-unused-fence)
[352.558148] Starting subtest: syncobj-timeline-unused-fence
[352.563479] Subtest syncobj-timeline-unused-fence: SUCCESS (0.006s)
[354.436165] [070/131] (667s left) api_intel_allocator (reserve-simple)
[354.491322] Starting subtest: reserve-simple
[354.493962] Subtest reserve-simple: SUCCESS (0.004s)
[354.604492] [071/131] (667s left) gem_lmem_swapping (massive)
[354.653194] Subtest massive: SKIP (0.000s)
[354.699724] [072/131] (667s left) prime_busy (before)
[354.752615] Starting subtest: before
[354.757697] Starting dynamic subtest: rcs0
[354.799127] Dynamic subtest rcs0: SUCCESS (0.043s)
[354.808857] Starting dynamic subtest: bcs0
[354.853952] Dynamic subtest bcs0: SUCCESS (0.054s)
[354.864991] Starting dynamic subtest: vcs0
[354.895868] Dynamic subtest vcs0: SUCCESS (0.041s)
[354.907165] Starting dynamic subtest: vcs1
[354.937026] Dynamic subtest vcs1: SUCCESS (0.041s)
[354.946460] Starting dynamic subtest: vecs0
[354.980224] Dynamic subtest vecs0: SUCCESS (0.042s)
[354.990119] Starting dynamic subtest: ccs0
[355.026261] Dynamic subtest ccs0: SUCCESS (0.045s)
[355.134241] Subtest before: SUCCESS (0.379s)
[355.221025] [073/131] (666s left) gem_exec_schedule (preempt-other-chain)
[355.291400] Starting subtest: preempt-other-chain
[355.293325] Starting dynamic subtest: rcs0
[355.426992] Dynamic subtest rcs0: SUCCESS (0.141s)
[355.438309] Starting dynamic subtest: bcs0
[355.560682] Dynamic subtest bcs0: SUCCESS (0.132s)
[355.572221] Starting dynamic subtest: vcs0
[355.697430] Dynamic subtest vcs0: SUCCESS (0.135s)
[355.710939] Starting dynamic subtest: vcs1
[355.826686] Dynamic subtest vcs1: SUCCESS (0.128s)
[355.840777] Starting dynamic subtest: vecs0
[355.952651] Dynamic subtest vecs0: SUCCESS (0.126s)
[355.968567] Starting dynamic subtest: ccs0
[356.082641] Dynamic subtest ccs0: SUCCESS (0.129s)
[356.085117] Subtest preempt-other-chain: SUCCESS (0.796s)
[356.518987] [074/131] (665s left) kms_cursor_crc (cursor-random-64x21)
[356.672925] Starting subtest: cursor-random-64x21
[356.716804] Subtest cursor-random-64x21: SKIP (0.039s)
[356.933783] [075/131] (665s left) gem_ctx_isolation (dirty-switch)
[356.983902] Starting subtest: dirty-switch
[356.986332] Starting dynamic subtest: rcs0
[357.161114] Dynamic subtest rcs0: SUCCESS (0.177s)
[357.171320] Starting dynamic subtest: bcs0
[357.355232] Dynamic subtest bcs0: SUCCESS (0.193s)
[357.365293] Starting dynamic subtest: vcs0
[357.558570] Dynamic subtest vcs0: SUCCESS (0.202s)
[357.570044] Starting dynamic subtest: vcs1
[359.543066] Dynamic subtest vcs1: SUCCESS (1.983s)
[359.553111] Starting dynamic subtest: vecs0
[361.529800] Dynamic subtest vecs0: SUCCESS (1.985s)
[361.540019] Starting dynamic subtest: ccs0
[363.602507] Dynamic subtest ccs0: SUCCESS (2.071s)
[363.604895] Subtest dirty-switch: SUCCESS (6.617s)
[363.845770] [076/131] (658s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-shrfb-draw-mmap-cpu)
[363.943788] Starting subtest: fbc-1p-offscreen-pri-shrfb-draw-mmap-cpu
[367.940868] Subtest fbc-1p-offscreen-pri-shrfb-draw-mmap-cpu: SUCCESS (4.001s)
[369.060363] [077/131] (653s left) gem_exec_reloc (basic-gtt-cpu)
[369.124767] Subtest basic-gtt-cpu: SKIP (0.000s)
[369.196464] [078/131] (652s left) syncobj_wait (invalid-multi-wait-all-unsubmitted-signaled)
[369.253772] Starting subtest: invalid-multi-wait-all-unsubmitted-signaled
[369.256043] Subtest invalid-multi-wait-all-unsubmitted-signaled: SUCCESS (0.000s)
[369.354613] [079/131] (652s left) kms_flip (nonblocking-read)
[369.437219] Starting subtest: nonblocking-read
[369.439139] Subtest nonblocking-read: SUCCESS (0.000s)
[369.543504] [080/131] (652s left) kms_pm_rpm (pm-tiling)
[371.545750] Starting subtest: pm-tiling
[371.550794] Subtest pm-tiling: SKIP (0.000s)
[371.910817] [081/131] (650s left) kms_pm_backlight (bad-brightness)
[371.991747] Starting subtest: bad-brightness
[372.043798] Starting dynamic subtest: eDP-1
[372.360346] Dynamic subtest eDP-1: SUCCESS (0.318s)
[372.362897] Subtest bad-brightness: SUCCESS (0.368s)
[373.164783] [082/131] (649s left) core_auth (getclient-simple)
[373.205185] Starting subtest: getclient-simple
[373.234979] Subtest getclient-simple: SUCCESS (0.028s)
[373.346576] [083/131] (648s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-180-async-flip)
[373.431661] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-180-async-flip
[374.187748] Subtest 4-tiled-max-hw-stride-64bpp-rotate-180-async-flip: SUCCESS (0.759s)
[374.353287] [084/131] (648s left) gem_mmap_gtt (close-race)
[374.410485] Subtest close-race: SKIP (0.000s)
[374.475978] [085/131] (647s left) gem_mmap_gtt (pf-nonblock)
[374.541194] Subtest pf-nonblock: SKIP (0.000s)
[374.614580] [086/131] (647s left) gem_sync (basic-store-all)
[374.681975] Starting subtest: basic-store-all
[377.913952] Subtest basic-store-all: SUCCESS (3.242s)
[378.099599] [087/131] (644s left) kms_cursor_crc (cursor-sliding-256x85)
[378.305569] Starting subtest: cursor-sliding-256x85
[378.349345] Subtest cursor-sliding-256x85: SKIP (0.040s)
[378.528419] [088/131] (644s left) kms_mmap_write_crc (main)
[378.604963] Starting subtest: main
[378.607731] Starting dynamic subtest: pipe-A-eDP-1
[382.028487] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.421s)
[382.030367] Subtest main: SUCCESS (3.422s)
[382.895800] [089/131] (639s left) gem_exec_whisper (basic-normal)
[382.971360] Starting subtest: basic-normal
[386.765218] Subtest basic-normal: SUCCESS (3.796s)
[386.948161] [090/131] (635s left) gem_exec_await (wide-all)
[387.165885] Starting subtest: wide-all
[410.374318] Subtest wide-all: SUCCESS (23.215s)
[410.573976] [091/131] (612s left) gem_mmap_gtt (big-bo-tiledx)
[410.678407] Subtest big-bo-tiledX: SKIP (0.000s)
[410.741549] [092/131] (611s left) kms_flip_scaled_crc (flip-64bpp-xtile-to-32bpp-xtile-downscaling)
[410.832932] Starting subtest: flip-64bpp-xtile-to-32bpp-xtile-downscaling
[410.835149] Starting dynamic subtest: pipe-A-default-mode
[411.952377] Dynamic subtest pipe-A-default-mode: SKIP (1.115s)
[411.956549] Subtest flip-64bpp-xtile-to-32bpp-xtile-downscaling: SKIP (1.117s)
[412.085736] [093/131] (610s left) gem_exec_reloc (basic-write-gtt)
[412.142221] Subtest basic-write-gtt: SKIP (0.000s)
[412.216351] [094/131] (610s left) sw_sync (sync_multi_consumer_producer)
[412.264916] Starting subtest: sync_multi_consumer_producer
[412.564125] Subtest sync_multi_consumer_producer: SUCCESS (0.297s)
[412.628663] [095/131] (610s left) kms_vblank (ts-continuation-modeset-rpm)
[412.698562] Starting subtest: ts-continuation-modeset-rpm
[412.700545] Starting dynamic subtest: pipe-A-eDP-1
[415.187208] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.488s)
[415.203150] Starting dynamic subtest: pipe-D-eDP-1
[417.357376] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.170s)
[417.359634] Subtest ts-continuation-modeset-rpm: SUCCESS (4.662s)
[418.163901] [096/131] (604s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-mmap-gtt)
[418.254867] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-mmap-gtt
[418.259313] Subtest fbc-2p-scndscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[418.360968] [097/131] (604s left) kms_cursor_legacy (flip-vs-cursor-busy-crc-legacy)
[418.454547] Starting subtest: flip-vs-cursor-busy-crc-legacy
[419.274516] Subtest flip-vs-cursor-busy-crc-legacy: SUCCESS (0.818s)
[420.093044] [098/131] (602s left) kms_big_fb (y-tiled-32bpp-rotate-180)
[420.178913] Starting subtest: y-tiled-32bpp-rotate-180
[420.183431] Subtest y-tiled-32bpp-rotate-180: SKIP (0.000s)
[420.271448] [099/131] (602s left) gem_exec_reloc (basic-wc-active)
[420.332860] Subtest basic-wc-active: SKIP (0.000s)
[420.407634] [100/131] (602s left) kms_psr2_sf (psr2-cursor-plane-move-continuous-exceed-fully-sf)
[420.475187] Starting subtest: psr2-cursor-plane-move-continuous-exceed-fully-sf
[420.477416] Starting dynamic subtest: pipe-A-eDP-1
[431.468552] Dynamic subtest pipe-A-eDP-1: SUCCESS (10.999s)
[431.479796] Starting dynamic subtest: pipe-B-eDP-1
[443.174259] Dynamic subtest pipe-B-eDP-1: SUCCESS (11.704s)
[443.176397] Subtest psr2-cursor-plane-move-continuous-exceed-fully-sf: SUCCESS (22.706s)
[444.030929] [101/131] (579s left) gem_workarounds (reset-fd)
[444.105924] Starting subtest: reset-fd
[444.276349] Subtest reset-fd: SUCCESS (0.170s)
[444.401189] [102/131] (578s left) kms_rotation_crc (primary-yf-tiled-reflect-x-270)
[444.472137] Starting subtest: primary-yf-tiled-reflect-x-270
[444.476605] Subtest primary-yf-tiled-reflect-x-270: SKIP (0.001s)
[444.549614] [103/131] (578s left) gem_ctx_param (basic-default)
[444.597879] Starting subtest: basic-default
[444.600275] Subtest basic-default: SUCCESS (0.000s)
[444.689261] [104/131] (578s left) gen7_exec_parse (basic-allowed)
[444.744474] Subtest basic-allowed: SKIP (0.000s)
[444.824246] [105/131] (578s left) gem_userptr_blits (coherency-unsync)
[444.894503] Subtest coherency-unsync: SKIP (0.000s)
[445.021614] [106/131] (578s left) kms_ccs (ccs-on-another-bo-4-tiled-mtl-rc-ccs)
[445.097149] Starting subtest: ccs-on-another-bo-4-tiled-mtl-rc-ccs
[445.098906] Starting dynamic subtest: pipe-A-eDP-1
[445.115125] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[445.126332] Starting dynamic subtest: pipe-B-eDP-1
[445.140550] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[445.150590] Starting dynamic subtest: pipe-C-eDP-1
[445.166626] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[445.176573] Starting dynamic subtest: pipe-D-eDP-1
[445.191986] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[445.193597] Subtest ccs-on-another-bo-4-tiled-mtl-rc-ccs: SUCCESS (0.008s)
[447.291454] [107/131] (576s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-blt)
[447.365918] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-blt
[447.369836] Subtest fbc-2p-scndscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[447.460262] [108/131] (575s left) kms_properties (colorop-properties-atomic)
[447.532974] Starting subtest: colorop-properties-atomic
[447.534869] Starting dynamic subtest: pipe-A-eDP-1
[447.866324] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.332s)
[447.880144] Starting dynamic subtest: pipe-B-eDP-1
[448.942998] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.075s)
[448.953689] Starting dynamic subtest: pipe-C-eDP-1
[449.988964] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.045s)
[450.005069] Starting dynamic subtest: pipe-D-eDP-1
[451.024144] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.034s)
[451.026485] Subtest colorop-properties-atomic: SUCCESS (3.492s)
[451.823490] [109/131] (571s left) kms_psr2_sf (psr2-overlay-plane-move-continuous-sf)
[451.904487] Starting subtest: psr2-overlay-plane-move-continuous-sf
[451.906660] Starting dynamic subtest: pipe-A-eDP-1
[457.883762] Dynamic subtest pipe-A-eDP-1: SUCCESS (5.982s)
[457.896499] Starting dynamic subtest: pipe-B-eDP-1
[464.590352] Dynamic subtest pipe-B-eDP-1: SUCCESS (6.703s)
[464.592583] Subtest psr2-overlay-plane-move-continuous-sf: SUCCESS (12.688s)
[465.483765] [110/131] (557s left) kms_frontbuffer_tracking (fbc-2p-primscrn-shrfb-pgflip-blt)
[465.571141] Starting subtest: fbc-2p-primscrn-shrfb-pgflip-blt
[465.575390] Subtest fbc-2p-primscrn-shrfb-pgflip-blt: SKIP (0.000s)
[465.658804] [111/131] (557s left) kms_frontbuffer_tracking (fbcpsr-tiling-linear)
[465.732584] Starting subtest: fbcpsr-tiling-linear
[472.311075] Subtest fbcpsr-tiling-linear: SUCCESS (6.581s)
[472.440130] [112/131] (551s left) gem_ctx_engines (invalid-engines)
[472.505699] Starting subtest: invalid-engines
[472.512628] Subtest invalid-engines: SUCCESS (0.007s)
[472.733346] [113/131] (550s left) syncobj_timeline (multi-wait-for-submit-unsubmitted-signaled)
[472.784727] Starting subtest: multi-wait-for-submit-unsubmitted-signaled
[472.786995] Subtest multi-wait-for-submit-unsubmitted-signaled: SUCCESS (0.001s)
[472.900114] [114/131] (550s left) prime_mmap (test_correct_cpu_write)
[472.964774] Starting subtest: test_correct_cpu_write
[472.966693] Starting dynamic subtest: test_correct_cpu_write-smem
[472.968615] Dynamic subtest test_correct_cpu_write-smem: SUCCESS (0.000s)
[472.970534] Subtest test_correct_cpu_write: SUCCESS (0.001s)
[473.070888] [115/131] (550s left) gem_exec_balancer (bonded-chain)
[473.128111] Starting subtest: bonded-chain
[480.090434] Subtest bonded-chain: SUCCESS (6.963s)
[480.398908] [116/131] (543s left) perf (short-reads)
[480.503284] Starting subtest: short-reads
[480.513686] Subtest short-reads: SUCCESS (0.013s)
[480.563569] [117/131] (543s left) gem_pxp (hw-rejects-pxp-buffer)
[480.681049] Starting subtest: hw-rejects-pxp-buffer
[480.685977] Subtest hw-rejects-pxp-buffer: SKIP (0.000s)
[480.798860] [118/131] (543s left) kms_frontbuffer_tracking (fbc-2p-primscrn-indfb-plflip-blt)
[480.895354] Starting subtest: fbc-2p-primscrn-indfb-plflip-blt
[480.899635] Subtest fbc-2p-primscrn-indfb-plflip-blt: SKIP (0.000s)
[480.995697] [119/131] (542s left) kms_flip (wf_vblank-ts-check-interruptible)
[481.079206] Starting subtest: wf_vblank-ts-check-interruptible
[481.081923] Starting dynamic subtest: A-eDP1
[490.023741] Dynamic subtest A-eDP1: SUCCESS (8.943s)
[490.038965] Starting dynamic subtest: B-eDP1
[498.956882] Dynamic subtest B-eDP1: SUCCESS (8.929s)
[498.970606] Starting dynamic subtest: C-eDP1
[507.884367] Dynamic subtest C-eDP1: SUCCESS (8.925s)
[507.899393] Starting dynamic subtest: D-eDP1
[516.818529] Dynamic subtest D-eDP1: SUCCESS (8.932s)
[516.824154] Subtest wf_vblank-ts-check-interruptible: SUCCESS (35.741s)
[518.050163] [120/131] (505s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-mmap-wc)
[518.140423] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-mmap-wc
[518.144728] Subtest psr-2p-scndscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[518.234608] [121/131] (505s left) gem_exec_reloc (basic-wc-read)
[518.293140] Subtest basic-wc-read: SKIP (0.000s)
[518.357326] [122/131] (505s left) gem_ringfill (basic-all)
[524.346486] Starting subtest: basic-all
[525.496315] Subtest basic-all: SUCCESS (1.150s)
[525.613844] [123/131] (498s left) gem_exec_create (legacy)
[525.675799] Starting subtest: legacy
[525.677847] Starting dynamic subtest: smem
[527.766131] Dynamic subtest smem: SUCCESS (2.093s)
[527.768906] Subtest legacy: SUCCESS (2.094s)
[527.955608] [124/131] (496s left) kms_getfb (getfb-handle-protection)
[528.040472] Starting subtest: getfb-handle-protection
[528.063819] Subtest getfb-handle-protection: SUCCESS (0.024s)
[528.188635] [125/131] (495s left) kms_content_protection (legacy)
[528.303957] Starting subtest: legacy
[528.308538] Subtest legacy: SKIP (0.000s)
[528.432867] [126/131] (495s left) i915_drm_fdinfo (isolation)
[528.478390] Starting subtest: isolation
[528.480673] Starting dynamic subtest: rcs0
[528.516303] Dynamic subtest rcs0: SKIP (0.035s)
[528.530390] Starting dynamic subtest: bcs0
[528.535135] Dynamic subtest bcs0: SKIP (0.000s)
[528.546073] Starting dynamic subtest: vcs0
[528.550293] Dynamic subtest vcs0: SKIP (0.000s)
[528.560599] Starting dynamic subtest: vcs1
[528.564940] Dynamic subtest vcs1: SKIP (0.000s)
[528.575186] Starting dynamic subtest: vecs0
[528.579424] Dynamic subtest vecs0: SKIP (0.000s)
[528.589515] Starting dynamic subtest: ccs0
[528.593811] Dynamic subtest ccs0: SKIP (0.000s)
[528.598119] Subtest isolation: SKIP (0.041s)
[528.635892] [127/131] (495s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-pwrite)
[528.730006] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-pwrite
[535.559818] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-pwrite: SUCCESS (6.832s)
[535.687615] [128/131] (488s left) gem_exec_schedule (smoketest)
[535.864168] Starting subtest: smoketest
[535.866663] Starting dynamic subtest: rcs0
[541.412421] Dynamic subtest rcs0: SUCCESS (5.498s)
[541.427128] Starting dynamic subtest: bcs0
[546.923763] Dynamic subtest bcs0: SUCCESS (5.509s)
[546.936264] Starting dynamic subtest: vcs0
[552.459327] Dynamic subtest vcs0: SUCCESS (5.531s)
[552.480483] Starting dynamic subtest: vcs1
[557.987953] Dynamic subtest vcs1: SUCCESS (5.525s)
[558.006666] Starting dynamic subtest: vecs0
[563.503136] Dynamic subtest vecs0: SUCCESS (5.513s)
[563.521325] Starting dynamic subtest: ccs0
[569.035704] Dynamic subtest ccs0: SUCCESS (5.531s)
[569.037842] Subtest smoketest: SUCCESS (33.118s)
[569.182428] [129/131] (455s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-mmap-wc)
[569.263082] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-mmap-wc
[569.267742] Subtest fbc-2p-primscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[569.355019] [130/131] (454s left) kms_chamelium_hpd (hdmi-hpd-after-suspend)
[569.728749] Subtest hdmi-hpd-after-suspend: SKIP (0.000s)
[570.538565] [131/131] (453s left) sysfs_heartbeat_interval (idempotent)
[570.592558] Starting subtest: idempotent
[570.594957] Starting dynamic subtest: vecs0
[570.597373] Dynamic subtest vecs0: SUCCESS (0.001s)
[570.609147] Starting dynamic subtest: ccs0
[570.611523] Dynamic subtest ccs0: SUCCESS (0.001s)
[570.622391] Starting dynamic subtest: vcs0
[570.624388] Dynamic subtest vcs0: SUCCESS (0.000s)
[570.634447] Starting dynamic subtest: bcs0
[570.636432] Dynamic subtest bcs0: SUCCESS (0.001s)
[570.646641] Starting dynamic subtest: rcs0
[570.648638] Dynamic subtest rcs0: SUCCESS (0.001s)
[570.658663] Starting dynamic subtest: vcs1
[570.660670] Dynamic subtest vcs1: SUCCESS (0.000s)
[570.662649] Subtest idempotent: SUCCESS (0.008s)
[570.698097] Closing watchdogs
results: parsing output: 0/ for test: kms_big_fb
results: parsing output: 1/ for test: dumb_buffer
results: parsing output: 2/ for test: kms_draw_crc
results: parsing output: 3/ for test: syncobj_wait
results: parsing output: 4/ for test: kms_psr
results: parsing output: 5/ for test: perf
results: parsing output: 6/ for test: kms_ccs
results: parsing output: 7/ for test: kms_cursor_legacy
results: parsing output: 8/ for test: kms_psr_stress_test
results: parsing output: 9/ for test: kms_cursor_legacy
results: parsing output: 10/ for test: gem_ctx_param
results: parsing output: 11/ for test: gem_ctx_persistence
results: parsing output: 12/ for test: gem_softpin
results: parsing output: 13/ for test: kms_psr
results: parsing output: 14/ for test: perf
results: parsing output: 15/ for test: kms_plane_multiple
results: parsing output: 16/ for test: syncobj_timeline
results: parsing output: 17/ for test: kms_universal_plane
results: parsing output: 18/ for test: kms_frontbuffer_tracking
results: parsing output: 19/ for test: kms_ccs
results: parsing output: 20/ for test: kms_frontbuffer_tracking
results: parsing output: 21/ for test: syncobj_eventfd
results: parsing output: 22/ for test: kms_invalid_mode
results: parsing output: 23/ for test: i915_power
results: parsing output: 24/ for test: syncobj_wait
results: parsing output: 25/ for test: kms_flip
results: parsing output: 26/ for test: kms_frontbuffer_tracking
results: parsing output: 27/ for test: kms_chamelium_color
results: parsing output: 28/ for test: kms_async_flips
results: parsing output: 29/ for test: kms_ccs
results: parsing output: 30/ for test: kms_lease
results: parsing output: 31/ for test: gem_render_copy
results: parsing output: 32/ for test: kms_psr
results: parsing output: 33/ for test: kms_flip
results: parsing output: 34/ for test: perf_pmu
results: parsing output: 35/ for test: kms_chamelium_frames
results: parsing output: 36/ for test: i915_pm_rpm
results: parsing output: 37/ for test: syncobj_timeline
results: parsing output: 38/ for test: kms_frontbuffer_tracking
results: parsing output: 39/ for test: kms_frontbuffer_tracking
results: parsing output: 40/ for test: kms_big_fb
results: parsing output: 41/ for test: kms_big_fb
results: parsing output: 42/ for test: i915_hangman
results: parsing output: 43/ for test: syncobj_timeline
results: parsing output: 44/ for test: kms_frontbuffer_tracking
results: parsing output: 45/ for test: kms_frontbuffer_tracking
results: parsing output: 46/ for test: kms_psr
results: parsing output: 47/ for test: kms_frontbuffer_tracking
results: parsing output: 48/ for test: kms_pm_dc
results: parsing output: 49/ for test: kms_plane_scaling
results: parsing output: 50/ for test: kms_plane
results: parsing output: 51/ for test: gen7_exec_parse
results: parsing output: 52/ for test: gem_spin_batch
results: parsing output: 53/ for test: syncobj_wait
results: parsing output: 54/ for test: kms_flip
results: parsing output: 55/ for test: gem_flink_race
results: parsing output: 56/ for test: kms_color
results: parsing output: 57/ for test: gem_mmap_offset
results: parsing output: 58/ for test: kms_async_flips
results: parsing output: 59/ for test: kms_cursor_crc
results: parsing output: 60/ for test: dumb_buffer
results: parsing output: 61/ for test: kms_busy
results: parsing output: 62/ for test: kms_big_fb
results: parsing output: 63/ for test: kms_flip
results: parsing output: 64/ for test: gem_exec_params
results: parsing output: 65/ for test: gem_exec_fence
results: parsing output: 66/ for test: kms_cursor_legacy
results: parsing output: 67/ for test: kms_frontbuffer_tracking
results: parsing output: 68/ for test: gem_exec_fence
results: parsing output: 69/ for test: api_intel_allocator
results: parsing output: 70/ for test: gem_lmem_swapping
results: parsing output: 71/ for test: prime_busy
results: parsing output: 72/ for test: gem_exec_schedule
results: parsing output: 73/ for test: kms_cursor_crc
results: parsing output: 74/ for test: gem_ctx_isolation
results: parsing output: 75/ for test: kms_frontbuffer_tracking
results: parsing output: 76/ for test: gem_exec_reloc
results: parsing output: 77/ for test: syncobj_wait
results: parsing output: 78/ for test: kms_flip
results: parsing output: 79/ for test: kms_pm_rpm
results: parsing output: 80/ for test: kms_pm_backlight
results: parsing output: 81/ for test: core_auth
results: parsing output: 82/ for test: kms_big_fb
results: parsing output: 83/ for test: gem_mmap_gtt
results: parsing output: 84/ for test: gem_mmap_gtt
results: parsing output: 85/ for test: gem_sync
results: parsing output: 86/ for test: kms_cursor_crc
results: parsing output: 87/ for test: kms_mmap_write_crc
results: parsing output: 88/ for test: gem_exec_whisper
results: parsing output: 89/ for test: gem_exec_await
results: parsing output: 90/ for test: gem_mmap_gtt
results: parsing output: 91/ for test: kms_flip_scaled_crc
results: parsing output: 92/ for test: gem_exec_reloc
results: parsing output: 93/ for test: sw_sync
results: parsing output: 94/ for test: kms_vblank
results: parsing output: 95/ for test: kms_frontbuffer_tracking
results: parsing output: 96/ for test: kms_cursor_legacy
results: parsing output: 97/ for test: kms_big_fb
results: parsing output: 98/ for test: gem_exec_reloc
results: parsing output: 99/ for test: kms_psr2_sf
results: parsing output: 100/ for test: gem_workarounds
results: parsing output: 101/ for test: kms_rotation_crc
results: parsing output: 102/ for test: gem_ctx_param
results: parsing output: 103/ for test: gen7_exec_parse
results: parsing output: 104/ for test: gem_userptr_blits
results: parsing output: 105/ for test: kms_ccs
results: parsing output: 106/ for test: kms_frontbuffer_tracking
results: parsing output: 107/ for test: kms_properties
results: parsing output: 108/ for test: kms_psr2_sf
results: parsing output: 109/ for test: kms_frontbuffer_tracking
results: parsing output: 110/ for test: kms_frontbuffer_tracking
results: parsing output: 111/ for test: gem_ctx_engines
results: parsing output: 112/ for test: syncobj_timeline
results: parsing output: 113/ for test: prime_mmap
results: parsing output: 114/ for test: gem_exec_balancer
results: parsing output: 115/ for test: perf
results: parsing output: 116/ for test: gem_pxp
results: parsing output: 117/ for test: kms_frontbuffer_tracking
results: parsing output: 118/ for test: kms_flip
results: parsing output: 119/ for test: kms_frontbuffer_tracking
results: parsing output: 120/ for test: gem_exec_reloc
results: parsing output: 121/ for test: gem_ringfill
results: parsing output: 122/ for test: gem_exec_create
results: parsing output: 123/ for test: kms_getfb
results: parsing output: 124/ for test: kms_content_protection
results: parsing output: 125/ for test: i915_drm_fdinfo
results: parsing output: 126/ for test: kms_frontbuffer_tracking
results: parsing output: 127/ for test: gem_exec_schedule
results: parsing output: 128/ for test: kms_frontbuffer_tracking
results: parsing output: 129/ for test: kms_chamelium_hpd
results: parsing output: 130/ for test: sysfs_heartbeat_interval
Done.