[55.287465] Initializing watchdogs
[55.287509]   /dev/watchdog0
[55.301215] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:7d55 Intel Meteorlake (Gen12) Meteor Lake-P [Intel Arc Graphics]
[55.305255] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[55.307323] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[55.310504] [001/134] (960s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-pwrite)
[55.428304] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-pwrite
[62.148804] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-pwrite: SUCCESS (6.841s)
[62.304479] [002/134] (953s left) kms_draw_crc (draw-method-render)
[62.399184] Starting subtest: draw-method-render
[62.401429] Starting dynamic subtest: xrgb8888-untiled
[62.627541] Dynamic subtest xrgb8888-untiled: SUCCESS (0.233s)
[62.636297] Starting dynamic subtest: rgb565-untiled
[62.847158] Dynamic subtest rgb565-untiled: SUCCESS (0.222s)
[62.854724] Starting dynamic subtest: xrgb2101010-untiled
[63.067569] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.222s)
[63.074187] Starting dynamic subtest: xbgr16161616f-untiled
[63.309537] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.244s)
[63.317713] Starting dynamic subtest: xrgb8888-xtiled
[63.442090] Dynamic subtest xrgb8888-xtiled: SUCCESS (0.133s)
[63.453075] Starting dynamic subtest: rgb565-xtiled
[63.562970] Dynamic subtest rgb565-xtiled: SUCCESS (0.122s)
[63.569472] Starting dynamic subtest: xrgb2101010-xtiled
[63.684079] Dynamic subtest xrgb2101010-xtiled: SUCCESS (0.122s)
[63.690883] Starting dynamic subtest: xbgr16161616f-xtiled
[63.816329] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (0.133s)
[63.823173] Starting dynamic subtest: xrgb8888-4tiled
[63.937395] Dynamic subtest xrgb8888-4tiled: SUCCESS (0.122s)
[63.945130] Starting dynamic subtest: rgb565-4tiled
[64.058537] Dynamic subtest rgb565-4tiled: SUCCESS (0.121s)
[64.066613] Starting dynamic subtest: xrgb2101010-4tiled
[64.179744] Dynamic subtest xrgb2101010-4tiled: SUCCESS (0.122s)
[64.190854] Starting dynamic subtest: xbgr16161616f-4tiled
[64.312116] Dynamic subtest xbgr16161616f-4tiled: SUCCESS (0.133s)
[64.314078] Subtest draw-method-render: SUCCESS (1.933s)
[64.459555] [003/134] (951s left) kms_rmfb (close-fd)
[64.557533] Starting subtest: close-fd
[64.559640] Starting dynamic subtest: pipe-A-eDP-1
[64.665167] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.106s)
[64.673598] Starting dynamic subtest: pipe-B-eDP-1
[65.851874] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.194s)
[65.861057] Starting dynamic subtest: pipe-C-eDP-1
[66.973785] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.128s)
[66.982623] Starting dynamic subtest: pipe-D-eDP-1
[68.105616] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.138s)
[68.107840] Subtest close-fd: SUCCESS (3.568s)
[69.320693] [004/134] (946s left) fbdev (info)
[69.355049] Starting subtest: info
[69.357166] Subtest info: SUCCESS (0.000s)
[69.431597] [005/134] (946s left) gem_exec_reloc (basic-cpu-wc-active)
[69.489774] Subtest basic-cpu-wc-active: SKIP (0.000s)
[69.575507] [006/134] (946s left) gem_pxp (display-protected-crc)
[69.704080] Starting subtest: display-protected-crc
[71.450146] Subtest display-protected-crc: SUCCESS (1.756s)
[71.955822] [007/134] (944s left) syncobj_timeline (etime-single-wait-all-for-submit-submitted)
[72.031274] Starting subtest: etime-single-wait-all-for-submit-submitted
[72.136686] Subtest etime-single-wait-all-for-submit-submitted: SUCCESS (0.105s)
[72.232715] [008/134] (943s left) gem_ctx_shared (q-smoketest-all)
[72.305511] Starting subtest: Q-smoketest-all
[104.677355] Subtest Q-smoketest-all: SUCCESS (32.330s)
[106.011598] [009/134] (910s left) gem_tiled_swapping (non-threaded)
[106.080319] Subtest non-threaded: SKIP (0.000s)
[106.147183] [010/134] (910s left) kms_frontbuffer_tracking (fbc-rgb565-draw-pwrite)
[106.246630] Starting subtest: fbc-rgb565-draw-pwrite
[110.708719] Subtest fbc-rgb565-draw-pwrite: SUCCESS (4.463s)
[111.917218] [011/134] (904s left) i915_hangman (engine-engine-hang)
[111.977402] Starting subtest: engine-engine-hang
[111.979595] Starting dynamic subtest: rcs0
[113.845058] Dynamic subtest rcs0: SUCCESS (1.866s)
[113.855168] Starting dynamic subtest: bcs0
[115.891416] Dynamic subtest bcs0: SUCCESS (2.045s)
[115.902275] Starting dynamic subtest: vcs0
[117.875084] Dynamic subtest vcs0: SUCCESS (1.982s)
[117.886281] Starting dynamic subtest: vcs1
[119.859360] Dynamic subtest vcs1: SUCCESS (1.983s)
[119.870058] Starting dynamic subtest: vecs0
[121.843403] Dynamic subtest vecs0: SUCCESS (1.983s)
[121.853633] Starting dynamic subtest: ccs0
[123.892285] Dynamic subtest ccs0: SUCCESS (2.047s)
[123.895014] Subtest engine-engine-hang: SUCCESS (11.915s)
[123.992018] [012/134] (892s left) gem_mmap_offset (partial-unmap)
[124.046654] Starting subtest: partial-unmap
[124.049035] Starting dynamic subtest: smem0
[124.522430] Dynamic subtest smem0: SUCCESS (0.477s)
[124.525241] Subtest partial-unmap: SUCCESS (0.477s)
[124.664926] [013/134] (891s left) kms_frontbuffer_tracking (fbc-indfb-scaledprimary)
[124.753652] Starting subtest: fbc-indfb-scaledprimary
[127.727725] Subtest fbc-indfb-scaledprimary: SUCCESS (2.977s)
[128.940511] [014/134] (887s left) kms_tiled_display (basic-test-pattern-with-chamelium)
[129.052081] Subtest basic-test-pattern-with-chamelium: SKIP (0.000s)
[129.090969] [015/134] (887s left) kms_addfb_basic (invalid-get-prop-any)
[129.143903] Starting subtest: invalid-get-prop-any
[129.146135] Subtest invalid-get-prop-any: SUCCESS (0.000s)
[129.290157] [016/134] (887s left) gem_ctx_isolation (preservation-reset)
[129.462974] Starting subtest: preservation-reset
[129.465757] Starting dynamic subtest: rcs0
[129.701772] Dynamic subtest rcs0: SUCCESS (0.239s)
[129.712479] Starting dynamic subtest: bcs0
[130.005310] Dynamic subtest bcs0: SUCCESS (0.303s)
[130.015882] Starting dynamic subtest: vcs0
[130.312361] Dynamic subtest vcs0: SUCCESS (0.307s)
[130.322705] Starting dynamic subtest: vcs1
[132.229665] Dynamic subtest vcs1: SUCCESS (1.917s)
[132.240079] Starting dynamic subtest: vecs0
[134.191449] Dynamic subtest vecs0: SUCCESS (1.961s)
[134.201424] Starting dynamic subtest: ccs0
[136.204278] Dynamic subtest ccs0: SUCCESS (2.012s)
[136.206690] Subtest preservation-reset: SUCCESS (6.743s)
[136.351892] [017/134] (880s left) kms_properties (plane-properties-legacy)
[136.452716] Starting subtest: plane-properties-legacy
[136.455069] Starting dynamic subtest: pipe-A-eDP-1
[137.034995] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.583s)
[137.043153] Starting dynamic subtest: pipe-B-eDP-1
[138.290682] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.253s)
[138.299917] Starting dynamic subtest: pipe-C-eDP-1
[139.516149] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.224s)
[139.524103] Starting dynamic subtest: pipe-D-eDP-1
[140.747331] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.230s)
[140.749289] Subtest plane-properties-legacy: SUCCESS (4.294s)
[141.544569] [018/134] (874s left) kms_ccs (crc-sprite-planes-basic-y-tiled-gen12-rc-ccs-cc)
[141.632426] Starting subtest: crc-sprite-planes-basic-y-tiled-gen12-rc-ccs-cc
[141.634759] Starting dynamic subtest: pipe-A-eDP-1
[141.691797] Dynamic subtest pipe-A-eDP-1: SKIP (0.002s)
[141.701143] Starting dynamic subtest: pipe-B-eDP-1
[141.759174] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[141.768266] Starting dynamic subtest: pipe-C-eDP-1
[141.827251] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[141.836779] Starting dynamic subtest: pipe-D-eDP-1
[141.894433] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[141.898607] Subtest crc-sprite-planes-basic-y-tiled-gen12-rc-ccs-cc: SKIP (0.008s)
[143.915295] [019/134] (872s left) prime_vgem (basic-read)
[144.056972] Starting subtest: basic-read
[144.061657] Subtest basic-read: SKIP (0.005s)
[144.159915] [FACT prime_vgem (basic-read)] new: kernel.kmod_is_loaded.vgem: true
[144.163081] [020/134] (872s left) gem_ppgtt (blt-vs-render-ctxn)
[144.217418] Starting subtest: blt-vs-render-ctxN
[177.179511] Subtest blt-vs-render-ctxN: SUCCESS (32.958s)
[177.394083] [021/134] (839s left) kms_ccs (ccs-on-another-bo-y-tiled-ccs)
[177.527771] Starting subtest: ccs-on-another-bo-y-tiled-ccs
[177.529934] Starting dynamic subtest: pipe-A-eDP-1
[177.552064] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[177.560890] Starting dynamic subtest: pipe-B-eDP-1
[177.582075] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[177.589424] Starting dynamic subtest: pipe-C-eDP-1
[177.610101] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[177.617462] Starting dynamic subtest: pipe-D-eDP-1
[177.638602] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[177.642425] Subtest ccs-on-another-bo-y-tiled-ccs: SKIP (0.004s)
[179.698294] [022/134] (836s left) syncobj_timeline (multi-wait-signaled)
[179.767585] Starting subtest: multi-wait-signaled
[179.769983] Subtest multi-wait-signaled: SUCCESS (0.000s)
[179.886464] [023/134] (836s left) kms_psr2_sf (fbc-pr-cursor-plane-move-continuous-exceed-sf)
[184.866360] Starting subtest: fbc-pr-cursor-plane-move-continuous-exceed-sf
[184.871253] Subtest fbc-pr-cursor-plane-move-continuous-exceed-sf: SKIP (0.002s)
[185.717729] [024/134] (831s left) gem_exec_schedule (preempt-other-chain)
[185.795315] Starting subtest: preempt-other-chain
[185.797653] Starting dynamic subtest: rcs0
[185.867403] Dynamic subtest rcs0: SUCCESS (0.080s)
[185.881053] Starting dynamic subtest: bcs0
[185.943992] Dynamic subtest bcs0: SUCCESS (0.076s)
[185.953227] Starting dynamic subtest: vcs0
[186.024574] Dynamic subtest vcs0: SUCCESS (0.080s)
[186.036396] Starting dynamic subtest: vcs1
[186.105766] Dynamic subtest vcs1: SUCCESS (0.080s)
[186.115978] Starting dynamic subtest: vecs0
[186.183461] Dynamic subtest vecs0: SUCCESS (0.078s)
[186.193552] Starting dynamic subtest: ccs0
[186.262326] Dynamic subtest ccs0: SUCCESS (0.078s)
[186.265085] Subtest preempt-other-chain: SUCCESS (0.476s)
[187.019685] [025/134] (829s left) kms_frontbuffer_tracking (fbcpsr-2p-indfb-fliptrack-mmap-gtt)
[187.122160] Starting subtest: fbcpsr-2p-indfb-fliptrack-mmap-gtt
[187.126256] Subtest fbcpsr-2p-indfb-fliptrack-mmap-gtt: SKIP (0.000s)
[187.218503] [026/134] (829s left) kms_plane_alpha_blend (constant-alpha-mid)
[187.317024] Starting subtest: constant-alpha-mid
[187.594333] Starting dynamic subtest: pipe-A-eDP-1
[188.370650] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.774s)
[188.380678] Starting dynamic subtest: pipe-D-eDP-1
[189.906162] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.534s)
[189.908517] Subtest constant-alpha-mid: SUCCESS (2.589s)
[190.773095] [027/134] (826s left) kms_frontbuffer_tracking (fbc-shrfb-scaledprimary)
[190.868516] Starting subtest: fbc-shrfb-scaledprimary
[193.904033] Subtest fbc-shrfb-scaledprimary: SUCCESS (3.039s)
[195.076656] [028/134] (821s left) kms_pm_dc (dc3co-vpb-simulation)
[196.191348] Starting subtest: dc3co-vpb-simulation
[205.236756] Subtest dc3co-vpb-simulation: SKIP (9.041s)
[205.377906] [029/134] (811s left) kms_frontbuffer_tracking (fbcpsr-2p-rte)
[205.470868] Starting subtest: fbcpsr-2p-rte
[205.475141] Subtest fbcpsr-2p-rte: SKIP (0.000s)
[205.586555] [030/134] (811s left) kms_chamelium_hpd (vga-hpd)
[205.969308] Subtest vga-hpd: SKIP (0.000s)
[206.752148] [031/134] (810s left) perf (sysctl-defaults)
[206.846396] Starting subtest: sysctl-defaults
[206.848918] Subtest sysctl-defaults: SUCCESS (0.000s)
[206.938584] [032/134] (810s left) gem_sync (basic-all)
[207.017615] Starting subtest: basic-all
[209.174642] Subtest basic-all: SUCCESS (2.167s)
[209.367606] [033/134] (807s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-32bpp-ytile-upscaling)
[209.472055] Starting subtest: flip-64bpp-ytile-to-32bpp-ytile-upscaling
[209.474309] Starting dynamic subtest: pipe-A-default-mode
[209.766637] Dynamic subtest pipe-A-default-mode: SKIP (0.290s)
[209.771297] Subtest flip-64bpp-ytile-to-32bpp-ytile-upscaling: SKIP (0.292s)
[210.626382] [034/134] (806s left) kms_pipe_crc_basic (read-crc)
[210.718982] Starting subtest: read-crc
[210.721365] Starting dynamic subtest: pipe-A-eDP-1
[211.410286] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.690s)
[211.419411] Starting dynamic subtest: pipe-B-eDP-1
[212.767872] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.358s)
[212.777735] Starting dynamic subtest: pipe-C-eDP-1
[214.078157] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.308s)
[214.088208] Starting dynamic subtest: pipe-D-eDP-1
[215.416272] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.338s)
[215.418759] Subtest read-crc: SUCCESS (4.699s)
[216.236871] [035/134] (800s left) gem_create (create-clear)
[216.290632] Starting subtest: create-clear
[216.292777] Starting dynamic subtest: smem0
[249.001848] Dynamic subtest smem0: SUCCESS (32.707s)
[249.004111] Subtest create-clear: SUCCESS (32.708s)
[249.197985] [036/134] (768s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-fullscreen)
[249.291585] Starting subtest: fbc-1p-primscrn-spr-indfb-fullscreen
[253.259076] Subtest fbc-1p-primscrn-spr-indfb-fullscreen: SUCCESS (3.971s)
[254.454727] [037/134] (762s left) kms_psr2_sf (psr2-overlay-plane-move-continuous-sf)
[259.492732] Starting subtest: psr2-overlay-plane-move-continuous-sf
[259.494974] Starting dynamic subtest: pipe-A-eDP-1
[266.201709] Dynamic subtest pipe-A-eDP-1: SUCCESS (6.706s)
[266.211222] Starting dynamic subtest: pipe-B-eDP-1
[272.931748] Dynamic subtest pipe-B-eDP-1: SUCCESS (6.727s)
[272.934251] Subtest psr2-overlay-plane-move-continuous-sf: SUCCESS (13.438s)
[273.755178] [038/134] (743s left) syncobj_eventfd (invalid-illegal-handle)
[273.810406] Starting subtest: invalid-illegal-handle
[273.812571] Subtest invalid-illegal-handle: SUCCESS (0.000s)
[273.912221] [039/134] (743s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-180)
[274.009578] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-180
[274.013644] Subtest yf-tiled-max-hw-stride-64bpp-rotate-180: SKIP (0.000s)
[274.162737] [040/134] (743s left) kms_joiner (switch-modeset-ultra-joiner-big-joiner)
[274.272221] Starting subtest: switch-modeset-ultra-joiner-big-joiner
[274.276636] Subtest switch-modeset-ultra-joiner-big-joiner: SKIP (0.000s)
[274.340914] [041/134] (743s left) kms_psr (pr-primary-render)
[274.425775] Starting subtest: pr-primary-render
[274.430056] Subtest pr-primary-render: SKIP (0.000s)
[274.509409] [042/134] (742s left) gen9_exec_parse (bb-start-far)
[274.562588] Subtest bb-start-far: SKIP (0.000s)
[274.633696] [043/134] (742s left) kms_flip (2x-modeset-vs-vblank-race)
[274.721443] Starting subtest: 2x-modeset-vs-vblank-race
[274.732667] Subtest 2x-modeset-vs-vblank-race: SKIP (0.011s)
[274.828581] [044/134] (742s left) gem_exec_balancer (invalid-bonds)
[274.883239] Starting subtest: invalid-bonds
[274.886839] Subtest invalid-bonds: SKIP (0.000s)
[275.205070] [045/134] (742s left) gem_sync (basic-store-each)
[275.283362] Starting subtest: basic-store-each
[277.763051] Subtest basic-store-each: SUCCESS (2.490s)
[277.956353] [046/134] (739s left) kms_properties (connector-properties-atomic)
[278.057597] Starting subtest: connector-properties-atomic
[278.059890] Starting dynamic subtest: pipe-A-eDP-1
[285.914077] Dynamic subtest pipe-A-eDP-1: SUCCESS (7.858s)
[285.923609] Starting dynamic subtest: pipe-None-DP-1
[285.927905] Dynamic subtest pipe-None-DP-1: SUCCESS (0.001s)
[285.935450] Starting dynamic subtest: pipe-None-HDMI-A-1
[285.939437] Dynamic subtest pipe-None-HDMI-A-1: SUCCESS (0.001s)
[285.947289] Starting dynamic subtest: pipe-None-DP-2
[285.951778] Dynamic subtest pipe-None-DP-2: SUCCESS (0.001s)
[285.959555] Starting dynamic subtest: pipe-None-HDMI-A-2
[285.963946] Dynamic subtest pipe-None-HDMI-A-2: SUCCESS (0.001s)
[285.971733] Starting dynamic subtest: pipe-None-DP-3
[285.976163] Dynamic subtest pipe-None-DP-3: SUCCESS (0.001s)
[285.983864] Starting dynamic subtest: pipe-None-DP-4
[285.988823] Dynamic subtest pipe-None-DP-4: SUCCESS (0.001s)
[285.991354] Subtest connector-properties-atomic: SUCCESS (7.868s)
[286.791492] [047/134] (730s left) kms_content_protection (atomic)
[286.930109] Starting subtest: atomic
[286.934675] Subtest atomic: SKIP (0.000s)
[287.060604] [048/134] (730s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip)
[287.157397] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip
[287.961487] Subtest 4-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip: SUCCESS (0.806s)
[288.158593] [049/134] (729s left) gem_spin_batch (legacy-resubmit)
[288.220616] Starting subtest: legacy-resubmit
[288.223068] Starting dynamic subtest: default
[288.228046] Dynamic subtest default: SUCCESS (0.005s)
[288.238755] Starting dynamic subtest: render
[288.240833] Dynamic subtest render: SUCCESS (0.001s)
[288.248866] Starting dynamic subtest: bsd
[288.250709] Dynamic subtest bsd: SUCCESS (0.004s)
[288.258164] Starting dynamic subtest: bsd1
[288.259993] Dynamic subtest bsd1: SUCCESS (0.001s)
[288.267758] Starting dynamic subtest: bsd2
[288.269604] Dynamic subtest bsd2: SUCCESS (0.003s)
[288.276935] Starting dynamic subtest: blt
[288.278811] Dynamic subtest blt: SUCCESS (0.002s)
[288.286034] Starting dynamic subtest: vebox
[288.287824] Dynamic subtest vebox: SUCCESS (0.002s)
[288.289608] Subtest legacy-resubmit: SUCCESS (0.026s)
[288.508967] [050/134] (729s left) kms_flip (basic-flip-vs-wf_vblank)
[288.602226] Starting subtest: basic-flip-vs-wf_vblank
[288.604434] Starting dynamic subtest: A-eDP1
[290.532077] Dynamic subtest A-eDP1: SUCCESS (1.929s)
[290.542779] Starting dynamic subtest: B-eDP1
[292.461056] Dynamic subtest B-eDP1: SUCCESS (1.926s)
[292.471190] Starting dynamic subtest: C-eDP1
[294.384953] Dynamic subtest C-eDP1: SUCCESS (1.922s)
[294.394302] Starting dynamic subtest: D-eDP1
[296.325906] Dynamic subtest D-eDP1: SUCCESS (1.941s)
[296.328286] Subtest basic-flip-vs-wf_vblank: SUCCESS (7.727s)
[297.569249] [051/134] (720s left) perf_pmu (multi-client)
[297.608724] Starting subtest: multi-client
[297.611110] Starting dynamic subtest: rcs0
[298.685340] Dynamic subtest rcs0: SUCCESS (1.075s)
[298.697077] Starting dynamic subtest: bcs0
[299.735363] Dynamic subtest bcs0: SUCCESS (1.047s)
[299.746939] Starting dynamic subtest: vcs0
[300.816045] Dynamic subtest vcs0: SUCCESS (1.050s)
[300.832073] Starting dynamic subtest: vcs1
[301.898743] Dynamic subtest vcs1: SUCCESS (1.108s)
[301.909873] Starting dynamic subtest: vecs0
[303.947530] Dynamic subtest vecs0: SUCCESS (2.046s)
[303.958798] Starting dynamic subtest: ccs0
[305.932087] Dynamic subtest ccs0: SUCCESS (1.982s)
[305.934864] Subtest multi-client: SUCCESS (8.323s)
[306.062254] [052/134] (711s left) kms_psr (fbc-psr2-sprite-plane-move)
[306.153876] Starting subtest: fbc-psr2-sprite-plane-move
[306.156163] Starting dynamic subtest: eDP-1
[306.160463] Dynamic subtest eDP-1: SKIP (0.000s)
[306.164872] Subtest fbc-psr2-sprite-plane-move: SKIP (0.001s)
[306.247901] [053/134] (711s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-mmap-gtt)
[306.358252] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-mmap-gtt
[306.362436] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[306.491253] [054/134] (711s left) kms_plane_scaling (plane-scaler-with-clipping-clamping-modifiers)
[306.580271] Starting subtest: plane-scaler-with-clipping-clamping-modifiers
[306.582455] Starting dynamic subtest: pipe-A
[306.920913] Dynamic subtest pipe-A: SUCCESS (0.341s)
[306.929622] Starting dynamic subtest: pipe-B
[308.339313] Dynamic subtest pipe-B: SUCCESS (1.417s)
[308.348400] Starting dynamic subtest: pipe-C
[309.791994] Dynamic subtest pipe-C: SUCCESS (1.452s)
[309.801619] Starting dynamic subtest: pipe-D
[311.224423] Dynamic subtest pipe-D: SUCCESS (1.431s)
[311.226720] Subtest plane-scaler-with-clipping-clamping-modifiers: SUCCESS (4.644s)
[312.400643] [055/134] (705s left) kms_atomic (test-only)
[312.492161] Starting subtest: test-only
[312.539530] Starting dynamic subtest: pipe-A-eDP-1
[315.090460] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.552s)
[315.092858] Subtest test-only: SUCCESS (2.599s)
[315.977552] [056/134] (702s left) kms_frontbuffer_tracking (psr-rgb101010-draw-mmap-gtt)
[316.090414] Starting subtest: psr-rgb101010-draw-mmap-gtt
[316.094637] Subtest psr-rgb101010-draw-mmap-gtt: SKIP (0.000s)
[316.241245] [057/134] (701s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-shrfb-msflip-blt)
[316.353868] Starting subtest: fbcpsr-2p-primscrn-shrfb-msflip-blt
[316.358283] Subtest fbcpsr-2p-primscrn-shrfb-msflip-blt: SKIP (0.000s)
[316.485639] [058/134] (701s left) gem_exercise_blt (fast-copy)
[316.544182] Starting subtest: fast-copy
[316.546081] Starting dynamic subtest: linear-smem-smem
[316.563279] Dynamic subtest linear-smem-smem: SUCCESS (0.022s)
[316.571969] Starting dynamic subtest: xmajor-smem-smem
[316.585516] Dynamic subtest xmajor-smem-smem: SUCCESS (0.022s)
[316.593554] Starting dynamic subtest: tile4-smem-smem
[316.602928] Dynamic subtest tile4-smem-smem: SUCCESS (0.017s)
[316.611026] Starting dynamic subtest: tile64-smem-smem
[316.621959] Dynamic subtest tile64-smem-smem: SUCCESS (0.018s)
[316.624259] Subtest fast-copy: SUCCESS (0.081s)
[316.780982] [059/134] (701s left) kms_cursor_crc (cursor-onscreen-128x128)
[316.988047] Starting subtest: cursor-onscreen-128x128
[316.992170] Starting dynamic subtest: pipe-A-eDP-1
[319.099913] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.101s)
[319.123561] Starting dynamic subtest: pipe-D-eDP-1
[321.813796] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.698s)
[321.816123] Subtest cursor-onscreen-128x128: SUCCESS (4.826s)
[322.639810] [060/134] (695s left) kms_addfb_basic (basic-y-tiled-legacy)
[322.695529] Starting subtest: basic-y-tiled-legacy
[322.699712] Subtest basic-y-tiled-legacy: SKIP (0.000s)
[322.840540] [061/134] (695s left) gem_ctx_persistence (legacy-engines-hang)
[322.897290] Starting subtest: legacy-engines-hang
[322.899683] Starting dynamic subtest: render
[322.988087] Dynamic subtest render: SUCCESS (0.090s)
[323.003134] Starting dynamic subtest: bsd1
[323.094826] Dynamic subtest bsd1: SUCCESS (0.102s)
[323.109536] Starting dynamic subtest: bsd2
[323.217988] Dynamic subtest bsd2: SUCCESS (0.120s)
[323.230208] Starting dynamic subtest: blt
[323.336042] Dynamic subtest blt: SUCCESS (0.115s)
[323.346063] Starting dynamic subtest: vebox
[323.455345] Dynamic subtest vebox: SUCCESS (0.116s)
[323.458088] Subtest legacy-engines-hang: SUCCESS (0.559s)
[323.557928] [062/134] (694s left) vgem_basic (bad-fence)
[323.598080] Starting subtest: bad-fence
[323.600193] Subtest bad-fence: SUCCESS (0.000s)
[323.678186] [063/134] (694s left) kms_flip (blocking-wf_vblank)
[323.774486] Starting subtest: blocking-wf_vblank
[323.776142] Starting dynamic subtest: A-eDP1
[332.657471] Dynamic subtest A-eDP1: SUCCESS (8.884s)
[332.667941] Starting dynamic subtest: B-eDP1
[341.579455] Dynamic subtest B-eDP1: SUCCESS (8.920s)
[341.588086] Starting dynamic subtest: C-eDP1
[350.499259] Dynamic subtest C-eDP1: SUCCESS (8.918s)
[350.509514] Starting dynamic subtest: D-eDP1
[359.425761] Dynamic subtest D-eDP1: SUCCESS (8.926s)
[359.428154] Subtest blocking-wf_vblank: SUCCESS (35.655s)
[360.669288] [064/134] (657s left) gem_pxp (verify-pxp-stale-buf-execution)
[360.739885] Starting subtest: verify-pxp-stale-buf-execution
[361.806768] Subtest verify-pxp-stale-buf-execution: SUCCESS (1.065s)
[361.965093] [065/134] (656s left) kms_psr (fbc-psr2-cursor-mmap-cpu)
[362.056090] Starting subtest: fbc-psr2-cursor-mmap-cpu
[362.058366] Starting dynamic subtest: eDP-1
[362.062710] Dynamic subtest eDP-1: SKIP (0.000s)
[362.067075] Subtest fbc-psr2-cursor-mmap-cpu: SKIP (0.001s)
[362.140068] [066/134] (656s left) kms_colorop (plane-xr30-xr30-multiply_inv_125)
[362.271395] Subtest plane-XR30-XR30-multiply_inv_125: SKIP (0.000s)
[362.347773] [067/134] (656s left) kms_psr (psr2-sprite-mmap-gtt)
[362.431231] Starting subtest: psr2-sprite-mmap-gtt
[362.433513] Starting dynamic subtest: eDP-1
[363.854708] Dynamic subtest eDP-1: SKIP (1.421s)
[363.859622] Subtest psr2-sprite-mmap-gtt: SKIP (1.423s)
[364.048420] [068/134] (654s left) gem_lmem_swapping (verify-ccs)
[364.090313] Subtest verify-ccs: SKIP (0.000s)
[364.137215] [069/134] (654s left) api_intel_bb (reset-flags)
[364.199072] Starting subtest: reset-flags
[364.204198] Subtest reset-flags: SUCCESS (0.007s)
[364.350843] [070/134] (654s left) kms_flip_scaled_crc (flip-32bpp-linear-to-64bpp-linear-downscaling)
[364.450989] Starting subtest: flip-32bpp-linear-to-64bpp-linear-downscaling
[364.453249] Starting dynamic subtest: pipe-A-default-mode
[365.635365] Dynamic subtest pipe-A-default-mode: SKIP (1.180s)
[365.639813] Subtest flip-32bpp-linear-to-64bpp-linear-downscaling: SKIP (1.181s)
[365.848866] [071/134] (652s left) kms_psr2_sf (fbc-pr-primary-plane-update-sf-dmg-area)
[370.901202] Starting subtest: fbc-pr-primary-plane-update-sf-dmg-area
[370.905612] Subtest fbc-pr-primary-plane-update-sf-dmg-area: SKIP (0.003s)
[371.742699] [072/134] (646s left) kms_flip (absolute-wf_vblank-interruptible)
[371.840515] Starting subtest: absolute-wf_vblank-interruptible
[371.842818] Starting dynamic subtest: A-eDP1
[380.589098] Dynamic subtest A-eDP1: SUCCESS (8.746s)
[380.599283] Starting dynamic subtest: B-eDP1
[389.323103] Dynamic subtest B-eDP1: SUCCESS (8.733s)
[389.334208] Starting dynamic subtest: C-eDP1
[398.044228] Dynamic subtest C-eDP1: SUCCESS (8.720s)
[398.052995] Starting dynamic subtest: D-eDP1
[406.783058] Dynamic subtest D-eDP1: SUCCESS (8.738s)
[406.788055] Subtest absolute-wf_vblank-interruptible: SUCCESS (34.945s)
[408.048531] [073/134] (610s left) kms_frontbuffer_tracking (psr-shrfb-scaledprimary)
[408.168195] Starting subtest: psr-shrfb-scaledprimary
[414.003393] Subtest psr-shrfb-scaledprimary: SUCCESS (5.837s)
[414.160058] [074/134] (604s left) kms_psr (psr-cursor-plane-move)
[414.250138] Starting subtest: psr-cursor-plane-move
[414.252333] Starting dynamic subtest: eDP-1
[415.995324] Dynamic subtest eDP-1: SUCCESS (1.746s)
[415.997639] Subtest psr-cursor-plane-move: SUCCESS (1.747s)
[416.865748] [075/134] (601s left) gem_exec_reloc (basic-gtt-cpu-noreloc)
[416.927847] Subtest basic-gtt-cpu-noreloc: SKIP (0.000s)
[417.024116] [076/134] (601s left) gem_exec_reloc (basic-wc-gtt-noreloc)
[417.090297] Subtest basic-wc-gtt-noreloc: SKIP (0.000s)
[417.183786] [077/134] (601s left) kms_feature_discovery (psr1)
[417.287897] Starting subtest: psr1
[417.290252] Subtest psr1: SUCCESS (0.000s)
[417.368524] [078/134] (601s left) gem_render_copy (yf-tiled-ccs-to-y-tiled-ccs)
[417.433311] Starting subtest: yf-tiled-ccs-to-y-tiled-ccs
[417.437957] Subtest yf-tiled-ccs-to-y-tiled-ccs: SKIP (0.000s)
[417.624379] [079/134] (601s left) i915_pm_rps (waitboost)
[417.687309] Starting subtest: waitboost
[423.790629] Subtest waitboost: SUCCESS (6.103s)
[423.960008] [080/134] (595s left) gem_madvise (dontneed-after-mmap)
[423.996363] Starting subtest: dontneed-after-mmap
[424.018649] Subtest dontneed-after-mmap: SUCCESS (0.022s)
[424.150375] [081/134] (594s left) i915_pm_rpm (reg-read-ioctl)
[426.068285] Starting subtest: reg-read-ioctl
[428.366383] Subtest reg-read-ioctl: SUCCESS (2.302s)
[428.748107] [082/134] (590s left) kms_big_fb (x-tiled-16bpp-rotate-180)
[428.841581] Starting subtest: x-tiled-16bpp-rotate-180
[430.077807] Subtest x-tiled-16bpp-rotate-180: SUCCESS (1.236s)
[430.243162] [083/134] (588s left) kms_chamelium_edid (dp-edid-stress-resolution-4k)
[430.638077] Subtest dp-edid-stress-resolution-4k: SKIP (0.000s)
[431.436362] [084/134] (587s left) gem_exec_schedule (fairslice)
[431.501417] Starting subtest: fairslice
[431.503338] Starting dynamic subtest: rcs0
[433.519801] Dynamic subtest rcs0: SUCCESS (2.024s)
[433.528192] Starting dynamic subtest: bcs0
[435.538265] Dynamic subtest bcs0: SUCCESS (2.018s)
[435.547038] Starting dynamic subtest: vcs0
[437.558632] Dynamic subtest vcs0: SUCCESS (2.018s)
[437.567064] Starting dynamic subtest: vcs1
[439.577838] Dynamic subtest vcs1: SUCCESS (2.019s)
[439.588928] Starting dynamic subtest: vecs0
[441.598845] Dynamic subtest vecs0: SUCCESS (2.018s)
[441.609121] Starting dynamic subtest: ccs0
[443.620479] Dynamic subtest ccs0: SUCCESS (2.022s)
[443.622688] Subtest fairslice: SUCCESS (12.124s)
[443.945659] [085/134] (575s left) syncobj_timeline (multi-wait-available-unsubmitted-submitted-signaled)
[443.989179] Starting subtest: multi-wait-available-unsubmitted-submitted-signaled
[443.991472] Subtest multi-wait-available-unsubmitted-submitted-signaled: SUCCESS (0.000s)
[444.101837] [086/134] (575s left) gem_exec_whisper (basic-fds-forked-all)
[444.154920] Starting subtest: basic-fds-forked-all
[467.933967] Subtest basic-fds-forked-all: SUCCESS (23.774s)
[468.127248] [087/134] (551s left) kms_ccs (bad-pixel-format-y-tiled-gen12-rc-ccs-cc)
[468.232063] Starting subtest: bad-pixel-format-y-tiled-gen12-rc-ccs-cc
[468.234370] Starting dynamic subtest: pipe-A-eDP-1
[468.257483] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[468.269226] Starting dynamic subtest: pipe-B-eDP-1
[468.290252] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[468.298810] Starting dynamic subtest: pipe-C-eDP-1
[468.320357] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[468.329032] Starting dynamic subtest: pipe-D-eDP-1
[468.350713] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[468.355145] Subtest bad-pixel-format-y-tiled-gen12-rc-ccs-cc: SKIP (0.004s)
[470.527167] [088/134] (548s left) gem_basic (create-close)
[470.590892] Starting subtest: create-close
[470.595407] Subtest create-close: SUCCESS (0.000s)
[470.707513] [089/134] (548s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-wc)
[470.812609] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-wc
[477.350882] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-wc: SUCCESS (6.540s)
[477.520192] [090/134] (541s left) kms_ccs (random-ccs-data-4-tiled-mtl-rc-ccs-cc)
[477.613832] Starting subtest: random-ccs-data-4-tiled-mtl-rc-ccs-cc
[477.616139] Starting dynamic subtest: pipe-A-eDP-1
[478.355509] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.735s)
[478.365492] Starting dynamic subtest: pipe-B-eDP-1
[480.170999] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.814s)
[480.181036] Starting dynamic subtest: pipe-C-eDP-1
[482.011051] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.838s)
[482.021827] Starting dynamic subtest: pipe-D-eDP-1
[483.826974] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.816s)
[483.829181] Subtest random-ccs-data-4-tiled-mtl-rc-ccs-cc: SUCCESS (6.207s)
[484.991596] [091/134] (534s left) gem_mmap_gtt (basic-small-bo-tiledx)
[485.055318] Subtest basic-small-bo-tiledX: SKIP (0.000s)
[485.116936] [092/134] (534s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-0-hflip)
[485.208713] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-0-hflip
[486.174221] Subtest x-tiled-max-hw-stride-64bpp-rotate-0-hflip: SUCCESS (0.967s)
[486.334681] [093/134] (533s left) gem_mmap (short-mmap)
[486.401333] Subtest short-mmap: SKIP (0.000s)
[486.464457] [094/134] (533s left) kms_big_fb (y-tiled-16bpp-rotate-90)
[486.562854] Starting subtest: y-tiled-16bpp-rotate-90
[486.566558] Subtest y-tiled-16bpp-rotate-90: SKIP (0.000s)
[486.681830] [095/134] (532s left) gem_exec_fence (basic-busy-all)
[486.734555] Starting subtest: basic-busy-all
[486.851985] Subtest basic-busy-all: SUCCESS (0.118s)
[489.005296] [096/134] (530s left) kms_ccs (crc-primary-suspend-yf-tiled-ccs)
[489.102686] Starting subtest: crc-primary-suspend-yf-tiled-ccs
[489.104783] Starting dynamic subtest: pipe-A-eDP-1
[489.113327] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[489.122614] Starting dynamic subtest: pipe-B-eDP-1
[489.131504] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[489.141982] Starting dynamic subtest: pipe-C-eDP-1
[489.150161] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[489.158774] Starting dynamic subtest: pipe-D-eDP-1
[489.167241] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[489.171216] Subtest crc-primary-suspend-yf-tiled-ccs: SKIP (0.004s)
[491.355965] [097/134] (528s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-render)
[491.455575] Starting subtest: psr-1p-primscrn-cur-indfb-draw-render
[498.177573] Subtest psr-1p-primscrn-cur-indfb-draw-render: SUCCESS (6.723s)
[498.328106] [098/134] (521s left) gem_exec_fence (submit-chain)
[498.505402] Starting subtest: submit-chain
[498.523654] Subtest submit-chain: SUCCESS (0.018s)
[500.067405] [099/134] (519s left) gem_mmap_gtt (basic-small-bo-tiledy)
[500.129874] Subtest basic-small-bo-tiledY: SKIP (0.000s)
[500.203402] [100/134] (519s left) kms_colorop (plane-xr24-xr24-srgb_eotf-srgb_inv_eotf-srgb_eotf)
[500.327325] Subtest plane-XR24-XR24-srgb_eotf-srgb_inv_eotf-srgb_eotf: SKIP (0.000s)
[500.412478] [101/134] (519s left) kms_frontbuffer_tracking (psr-2p-primscrn-shrfb-msflip-blt)
[500.510251] Starting subtest: psr-2p-primscrn-shrfb-msflip-blt
[500.514415] Subtest psr-2p-primscrn-shrfb-msflip-blt: SKIP (0.000s)
[500.660993] [102/134] (519s left) gen9_exec_parse (unaligned-access)
[500.724356] Subtest unaligned-access: SKIP (0.000s)
[500.795906] [103/134] (519s left) kms_properties (get_properties-sanity-atomic)
[500.885695] Starting subtest: get_properties-sanity-atomic
[500.888091] Subtest get_properties-sanity-atomic: SUCCESS (0.002s)
[500.975056] [104/134] (519s left) i915_query (query-topology-matches-eu-total)
[501.037586] Starting subtest: query-topology-matches-eu-total
[501.039555] Subtest query-topology-matches-eu-total: SUCCESS (0.000s)
[501.162979] [105/134] (518s left) gem_vm_create (isolation)
[501.222857] Starting subtest: isolation
[501.232718] Subtest isolation: SUCCESS (0.010s)
[501.396037] [106/134] (518s left) kms_vblank (wait-forked)
[501.486385] Starting subtest: wait-forked
[501.488316] Starting dynamic subtest: pipe-A-eDP-1
[503.288913] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.802s)
[503.304086] Starting dynamic subtest: pipe-D-eDP-1
[505.736754] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.445s)
[505.739062] Subtest wait-forked: SUCCESS (4.251s)
[506.614167] [107/134] (513s left) gem_mmap_gtt (fault-concurrent)
[506.677629] Subtest fault-concurrent: SKIP (0.000s)
[506.749953] [108/134] (513s left) syncobj_wait (invalid-reset-illegal-handle)
[506.808313] Starting subtest: invalid-reset-illegal-handle
[506.810531] Subtest invalid-reset-illegal-handle: SUCCESS (0.000s)
[506.912602] [109/134] (513s left) gem_exec_fence (basic-await)
[507.085033] Starting subtest: basic-await
[507.087621] Starting dynamic subtest: rcs0
[507.160027] Dynamic subtest rcs0: SUCCESS (0.075s)
[507.173918] Starting dynamic subtest: bcs0
[507.229962] Dynamic subtest bcs0: SUCCESS (0.069s)
[507.242089] Starting dynamic subtest: vcs0
[507.301095] Dynamic subtest vcs0: SUCCESS (0.069s)
[507.312878] Starting dynamic subtest: vcs1
[507.372474] Dynamic subtest vcs1: SUCCESS (0.070s)
[507.384577] Starting dynamic subtest: vecs0
[507.443745] Dynamic subtest vecs0: SUCCESS (0.069s)
[507.456600] Starting dynamic subtest: ccs0
[507.514676] Dynamic subtest ccs0: SUCCESS (0.069s)
[507.517635] Subtest basic-await: SUCCESS (0.431s)
[509.005486] [110/134] (511s left) gem_exec_flush (basic-wb-pro-default)
[509.065216] Starting subtest: basic-wb-pro-default
[514.524377] Subtest basic-wb-pro-default: SUCCESS (5.459s)
[514.729852] [111/134] (505s left) kms_cursor_crc (cursor-random-64x64)
[514.917314] Starting subtest: cursor-random-64x64
[514.924969] Starting dynamic subtest: pipe-A-eDP-1
[518.230662] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.306s)
[518.263209] Starting dynamic subtest: pipe-D-eDP-1
[522.188682] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.936s)
[522.191193] Subtest cursor-random-64x64: SUCCESS (7.271s)
[523.083967] [112/134] (497s left) api_intel_allocator (alloc-simple)
[523.143255] Starting subtest: alloc-simple
[523.145580] Subtest alloc-simple: SUCCESS (0.003s)
[523.299677] [113/134] (497s left) gem_exec_schedule (preempt-user)
[523.368879] Starting subtest: preempt-user
[523.370787] Starting dynamic subtest: rcs0
[523.383205] Dynamic subtest rcs0: SUCCESS (0.022s)
[523.393018] Starting dynamic subtest: bcs0
[523.400916] Dynamic subtest bcs0: SUCCESS (0.017s)
[523.412829] Starting dynamic subtest: vcs0
[523.420666] Dynamic subtest vcs0: SUCCESS (0.019s)
[523.429863] Starting dynamic subtest: vcs1
[523.440757] Dynamic subtest vcs1: SUCCESS (0.019s)
[523.449628] Starting dynamic subtest: vecs0
[523.461762] Dynamic subtest vecs0: SUCCESS (0.020s)
[523.473449] Starting dynamic subtest: ccs0
[523.482894] Dynamic subtest ccs0: SUCCESS (0.021s)
[523.485176] Subtest preempt-user: SUCCESS (0.122s)
[525.006692] [114/134] (495s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-mmap-gtt)
[525.103162] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-mmap-gtt
[525.107138] Subtest psr-2p-scndscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[525.238144] [115/134] (495s left) kms_plane (plane-panning-bottom-right)
[525.334261] Starting subtest: plane-panning-bottom-right
[525.336427] Starting dynamic subtest: pipe-A
[527.025555] Dynamic subtest pipe-A: SUCCESS (1.689s)
[527.036278] Starting dynamic subtest: pipe-B
[529.376126] Dynamic subtest pipe-B: SUCCESS (2.349s)
[529.378045] Subtest plane-panning-bottom-right: SUCCESS (4.042s)
[530.221465] [116/134] (490s left) drm_mm (drm_mm)
[530.258460] Starting subtest: drm_mm
[530.287133] Starting dynamic subtest: drm_test_mm_init
[530.428043] Dynamic subtest drm_test_mm_init: SUCCESS (0.140s)
[530.437164] Starting dynamic subtest: drm_test_mm_debug
[530.519127] Dynamic subtest drm_test_mm_debug: SUCCESS (0.090s)
[530.536971] Starting dynamic subtest: drm_test_mm_align32
[530.671056] Dynamic subtest drm_test_mm_align32: SUCCESS (0.152s)
[530.680592] Starting dynamic subtest: drm_test_mm_align64
[530.806925] Dynamic subtest drm_test_mm_align64: SUCCESS (0.135s)
[530.815667] Starting dynamic subtest: drm_test_mm_lowest
[530.968398] Dynamic subtest drm_test_mm_lowest: SUCCESS (0.161s)
[530.976761] Starting dynamic subtest: drm_test_mm_highest
[531.120659] Dynamic subtest drm_test_mm_highest: SUCCESS (0.150s)
[531.122664] Subtest drm_mm: SUCCESS (0.859s)
[531.337408] [117/134] (489s left) gem_userptr_blits (coherency-sync)
[531.404696] Starting subtest: coherency-sync
[531.607909] Subtest coherency-sync: SKIP (0.164s)
[531.734065] [118/134] (488s left) gem_userptr_blits (access-control)
[531.830607] Starting subtest: access-control
[531.834740] Subtest access-control: SKIP (0.000s)
[531.974112] [119/134] (488s left) kms_colorop (plane-xr24-xr24-ctm_3x4_50_desat)
[532.134107] Subtest plane-XR24-XR24-ctm_3x4_50_desat: SKIP (0.000s)
[532.230856] [120/134] (488s left) kms_pm_rpm (fences)
[534.099209] Starting subtest: fences
[534.104154] Subtest fences: SKIP (0.000s)
[534.564248] [121/134] (486s left) gem_close_race (basic-process)
[534.636587] Starting subtest: basic-process
[534.697717] Subtest basic-process: SUCCESS (0.061s)
[534.891457] [122/134] (485s left) kms_vrr (flipline)
[534.979068] Starting subtest: flipline
[534.985304] Subtest flipline: SKIP (0.000s)
[535.069539] [123/134] (485s left) perf_pmu (busy)
[535.108878] Starting subtest: busy
[535.111090] Starting dynamic subtest: rcs0
[535.731988] Dynamic subtest rcs0: SUCCESS (0.622s)
[535.743036] Starting dynamic subtest: bcs0
[536.290541] Dynamic subtest bcs0: SUCCESS (0.556s)
[536.300697] Starting dynamic subtest: vcs0
[537.877026] Dynamic subtest vcs0: SUCCESS (1.582s)
[537.889703] Starting dynamic subtest: vcs1
[539.925387] Dynamic subtest vcs1: SUCCESS (2.045s)
[539.937202] Starting dynamic subtest: vecs0
[541.908967] Dynamic subtest vecs0: SUCCESS (1.981s)
[541.920983] Starting dynamic subtest: ccs0
[542.482502] Dynamic subtest ccs0: SUCCESS (0.572s)
[542.485136] Subtest busy: SUCCESS (7.374s)
[542.603515] [124/134] (478s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-shrfb-pgflip-blt)
[542.708504] Starting subtest: fbc-2p-scndscrn-shrfb-pgflip-blt
[542.712756] Subtest fbc-2p-scndscrn-shrfb-pgflip-blt: SKIP (0.000s)
[542.852660] [125/134] (477s left) gem_render_linear_blits (basic)
[542.918853] Starting subtest: basic
[542.937038] Subtest basic: SUCCESS (0.021s)
[543.019642] [126/134] (477s left) kms_busy (extended-modeset-hang-newfb)
[543.112880] Starting subtest: extended-modeset-hang-newfb
[543.115213] Starting dynamic subtest: pipe-A
[577.808536] Dynamic subtest pipe-A: SUCCESS (34.691s)
[577.817839] Starting dynamic subtest: pipe-D
[600.770039] Dynamic subtest pipe-D: SUCCESS (22.959s)
[600.772355] Subtest extended-modeset-hang-newfb: SUCCESS (57.657s)
[601.577329] [127/134] (419s left) kms_cursor_legacy (modeset-atomic-cursor-hotspot)
[601.704515] Starting subtest: modeset-atomic-cursor-hotspot
[601.709112] Subtest modeset-atomic-cursor-hotspot: SKIP (0.000s)
[601.874384] [128/134] (419s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-mmap-wc)
[601.989521] Starting subtest: fbcpsr-rgb101010-draw-mmap-wc
[608.686210] Subtest fbcpsr-rgb101010-draw-mmap-wc: SUCCESS (6.699s)
[608.837550] [129/134] (412s left) gem_flink_basic (basic)
[608.894850] Starting subtest: basic
[608.896815] Subtest basic: SUCCESS (0.000s)
[609.009261] [130/134] (412s left) syncobj_timeline (wait-all-snapshot)
[609.067628] Starting subtest: wait-all-snapshot
[609.149438] Subtest wait-all-snapshot: SUCCESS (0.081s)
[609.248578] [131/134] (411s left) kms_getfb (getfb2-handle-not-fb)
[609.342903] Starting subtest: getfb2-handle-not-fb
[609.345273] Subtest getfb2-handle-not-fb: SUCCESS (0.000s)
[609.449756] [132/134] (411s left) kms_big_fb (4-tiled-8bpp-rotate-0)
[609.544730] Starting subtest: 4-tiled-8bpp-rotate-0
[610.735290] Subtest 4-tiled-8bpp-rotate-0: SUCCESS (1.192s)
[610.896239] [133/134] (410s left) syncobj_timeline (etime-single-wait-submitted)
[610.952100] Starting subtest: etime-single-wait-submitted
[611.057399] Subtest etime-single-wait-submitted: SUCCESS (0.104s)
[611.144792] [134/134] (410s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-render)
[611.237773] Starting subtest: psr-1p-primscrn-spr-indfb-draw-render
[618.017305] Subtest psr-1p-primscrn-spr-indfb-draw-render: SUCCESS (6.783s)
[618.184225] Closing watchdogs
results: parsing output: 0/ for test: kms_frontbuffer_tracking
results: parsing output: 1/ for test: kms_draw_crc
results: parsing output: 2/ for test: kms_rmfb
results: parsing output: 3/ for test: fbdev
results: parsing output: 4/ for test: gem_exec_reloc
results: parsing output: 5/ for test: gem_pxp
results: parsing output: 6/ for test: syncobj_timeline
results: parsing output: 7/ for test: gem_ctx_shared
results: parsing output: 8/ for test: gem_tiled_swapping
results: parsing output: 9/ for test: kms_frontbuffer_tracking
results: parsing output: 10/ for test: i915_hangman
results: parsing output: 11/ for test: gem_mmap_offset
results: parsing output: 12/ for test: kms_frontbuffer_tracking
results: parsing output: 13/ for test: kms_tiled_display
results: parsing output: 14/ for test: kms_addfb_basic
results: parsing output: 15/ for test: gem_ctx_isolation
results: parsing output: 16/ for test: kms_properties
results: parsing output: 17/ for test: kms_ccs
results: parsing output: 18/ for test: prime_vgem
results: parsing output: 19/ for test: gem_ppgtt
results: parsing output: 20/ for test: kms_ccs
results: parsing output: 21/ for test: syncobj_timeline
results: parsing output: 22/ for test: kms_psr2_sf
results: parsing output: 23/ for test: gem_exec_schedule
results: parsing output: 24/ for test: kms_frontbuffer_tracking
results: parsing output: 25/ for test: kms_plane_alpha_blend
results: parsing output: 26/ for test: kms_frontbuffer_tracking
results: parsing output: 27/ for test: kms_pm_dc
results: parsing output: 28/ for test: kms_frontbuffer_tracking
results: parsing output: 29/ for test: kms_chamelium_hpd
results: parsing output: 30/ for test: perf
results: parsing output: 31/ for test: gem_sync
results: parsing output: 32/ for test: kms_flip_scaled_crc
results: parsing output: 33/ for test: kms_pipe_crc_basic
results: parsing output: 34/ for test: gem_create
results: parsing output: 35/ for test: kms_frontbuffer_tracking
results: parsing output: 36/ for test: kms_psr2_sf
results: parsing output: 37/ for test: syncobj_eventfd
results: parsing output: 38/ for test: kms_big_fb
results: parsing output: 39/ for test: kms_joiner
results: parsing output: 40/ for test: kms_psr
results: parsing output: 41/ for test: gen9_exec_parse
results: parsing output: 42/ for test: kms_flip
results: parsing output: 43/ for test: gem_exec_balancer
results: parsing output: 44/ for test: gem_sync
results: parsing output: 45/ for test: kms_properties
results: parsing output: 46/ for test: kms_content_protection
results: parsing output: 47/ for test: kms_big_fb
results: parsing output: 48/ for test: gem_spin_batch
results: parsing output: 49/ for test: kms_flip
results: parsing output: 50/ for test: perf_pmu
results: parsing output: 51/ for test: kms_psr
results: parsing output: 52/ for test: kms_frontbuffer_tracking
results: parsing output: 53/ for test: kms_plane_scaling
results: parsing output: 54/ for test: kms_atomic
results: parsing output: 55/ for test: kms_frontbuffer_tracking
results: parsing output: 56/ for test: kms_frontbuffer_tracking
results: parsing output: 57/ for test: gem_exercise_blt
results: parsing output: 58/ for test: kms_cursor_crc
results: parsing output: 59/ for test: kms_addfb_basic
results: parsing output: 60/ for test: gem_ctx_persistence
results: parsing output: 61/ for test: vgem_basic
results: parsing output: 62/ for test: kms_flip
results: parsing output: 63/ for test: gem_pxp
results: parsing output: 64/ for test: kms_psr
results: parsing output: 65/ for test: kms_colorop
results: parsing output: 66/ for test: kms_psr
results: parsing output: 67/ for test: gem_lmem_swapping
results: parsing output: 68/ for test: api_intel_bb
results: parsing output: 69/ for test: kms_flip_scaled_crc
results: parsing output: 70/ for test: kms_psr2_sf
results: parsing output: 71/ for test: kms_flip
results: parsing output: 72/ for test: kms_frontbuffer_tracking
results: parsing output: 73/ for test: kms_psr
results: parsing output: 74/ for test: gem_exec_reloc
results: parsing output: 75/ for test: gem_exec_reloc
results: parsing output: 76/ for test: kms_feature_discovery
results: parsing output: 77/ for test: gem_render_copy
results: parsing output: 78/ for test: i915_pm_rps
results: parsing output: 79/ for test: gem_madvise
results: parsing output: 80/ for test: i915_pm_rpm
results: parsing output: 81/ for test: kms_big_fb
results: parsing output: 82/ for test: kms_chamelium_edid
results: parsing output: 83/ for test: gem_exec_schedule
results: parsing output: 84/ for test: syncobj_timeline
results: parsing output: 85/ for test: gem_exec_whisper
results: parsing output: 86/ for test: kms_ccs
results: parsing output: 87/ for test: gem_basic
results: parsing output: 88/ for test: kms_frontbuffer_tracking
results: parsing output: 89/ for test: kms_ccs
results: parsing output: 90/ for test: gem_mmap_gtt
results: parsing output: 91/ for test: kms_big_fb
results: parsing output: 92/ for test: gem_mmap
results: parsing output: 93/ for test: kms_big_fb
results: parsing output: 94/ for test: gem_exec_fence
results: parsing output: 95/ for test: kms_ccs
results: parsing output: 96/ for test: kms_frontbuffer_tracking
results: parsing output: 97/ for test: gem_exec_fence
results: parsing output: 98/ for test: gem_mmap_gtt
results: parsing output: 99/ for test: kms_colorop
results: parsing output: 100/ for test: kms_frontbuffer_tracking
results: parsing output: 101/ for test: gen9_exec_parse
results: parsing output: 102/ for test: kms_properties
results: parsing output: 103/ for test: i915_query
results: parsing output: 104/ for test: gem_vm_create
results: parsing output: 105/ for test: kms_vblank
results: parsing output: 106/ for test: gem_mmap_gtt
results: parsing output: 107/ for test: syncobj_wait
results: parsing output: 108/ for test: gem_exec_fence
results: parsing output: 109/ for test: gem_exec_flush
results: parsing output: 110/ for test: kms_cursor_crc
results: parsing output: 111/ for test: api_intel_allocator
results: parsing output: 112/ for test: gem_exec_schedule
results: parsing output: 113/ for test: kms_frontbuffer_tracking
results: parsing output: 114/ for test: kms_plane
results: parsing output: 115/ for test: drm_mm
results: parsing output: 116/ for test: gem_userptr_blits
results: parsing output: 117/ for test: gem_userptr_blits
results: parsing output: 118/ for test: kms_colorop
results: parsing output: 119/ for test: kms_pm_rpm
results: parsing output: 120/ for test: gem_close_race
results: parsing output: 121/ for test: kms_vrr
results: parsing output: 122/ for test: perf_pmu
results: parsing output: 123/ for test: kms_frontbuffer_tracking
results: parsing output: 124/ for test: gem_render_linear_blits
results: parsing output: 125/ for test: kms_busy
results: parsing output: 126/ for test: kms_cursor_legacy
results: parsing output: 127/ for test: kms_frontbuffer_tracking
results: parsing output: 128/ for test: gem_flink_basic
results: parsing output: 129/ for test: syncobj_timeline
results: parsing output: 130/ for test: kms_getfb
results: parsing output: 131/ for test: kms_big_fb
results: parsing output: 132/ for test: syncobj_timeline
results: parsing output: 133/ for test: kms_frontbuffer_tracking
Done.