[58.784471] Initializing watchdogs
[58.784517]   /dev/watchdog0
[58.798295] [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]
[58.802411] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[58.804536] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[58.807814] [001/133] (960s left) kms_ccs (crc-sprite-planes-basic-y-tiled-gen12-rc-ccs-cc)
[58.920652] Starting subtest: crc-sprite-planes-basic-y-tiled-gen12-rc-ccs-cc
[58.922950] Starting dynamic subtest: pipe-A-eDP-1
[58.980265] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[58.988583] Starting dynamic subtest: pipe-B-eDP-1
[59.045863] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[59.054109] Starting dynamic subtest: pipe-C-eDP-1
[59.110421] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[59.117240] Starting dynamic subtest: pipe-D-eDP-1
[59.171009] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[59.175122] Subtest crc-sprite-planes-basic-y-tiled-gen12-rc-ccs-cc: SKIP (0.007s)
[61.213803] [002/133] (958s left) gem_exec_schedule (noreorder-corked)
[61.390198] Starting subtest: noreorder-corked
[61.392764] Starting dynamic subtest: rcs0
[62.521303] Dynamic subtest rcs0: SUCCESS (1.137s)
[62.532371] Starting dynamic subtest: vcs0
[63.895229] Dynamic subtest vcs0: SUCCESS (1.377s)
[63.904451] Starting dynamic subtest: vcs1
[65.939607] Dynamic subtest vcs1: SUCCESS (2.049s)
[65.948859] Starting dynamic subtest: vecs0
[68.049495] Dynamic subtest vecs0: SUCCESS (2.113s)
[68.059033] Starting dynamic subtest: ccs0
[69.194399] Dynamic subtest ccs0: SUCCESS (1.147s)
[69.197362] Subtest noreorder-corked: SUCCESS (7.827s)
[69.390901] [003/133] (949s left) kms_big_fb (yf-tiled-16bpp-rotate-0)
[69.498739] Starting subtest: yf-tiled-16bpp-rotate-0
[69.503449] Subtest yf-tiled-16bpp-rotate-0: SKIP (0.000s)
[69.594183] [004/133] (949s left) gem_exec_balancer (sequential)
[69.664184] Starting subtest: sequential
[72.750159] Subtest sequential: SUCCESS (3.091s)
[73.058215] [005/133] (946s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-gtt)
[73.153381] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-gtt
[73.157893] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[73.259312] [006/133] (946s left) gem_userptr_blits (unsync-unmap)
[73.342731] Subtest unsync-unmap: SKIP (0.000s)
[73.487223] [007/133] (946s left) syncobj_timeline (invalid-single-wait-all-unsubmitted)
[73.543049] Starting subtest: invalid-single-wait-all-unsubmitted
[73.545494] Subtest invalid-single-wait-all-unsubmitted: SUCCESS (0.000s)
[73.654257] [008/133] (945s left) kms_cursor_legacy (cursora-vs-flipa-legacy)
[73.779192] Starting subtest: cursorA-vs-flipA-legacy
[84.930142] Subtest cursorA-vs-flipA-legacy: SUCCESS (11.153s)
[85.711469] [009/133] (933s left) kms_big_fb (4-tiled-64bpp-rotate-180)
[85.817359] Starting subtest: 4-tiled-64bpp-rotate-180
[87.362563] Subtest 4-tiled-64bpp-rotate-180: SUCCESS (1.545s)
[87.525154] [010/133] (932s left) kms_properties (connector-properties-legacy)
[87.631026] Starting subtest: connector-properties-legacy
[87.633380] Starting dynamic subtest: pipe-A-eDP-1
[95.514787] Dynamic subtest pipe-A-eDP-1: SUCCESS (7.883s)
[95.522728] Starting dynamic subtest: pipe-None-DP-1
[95.526947] Dynamic subtest pipe-None-DP-1: SUCCESS (0.001s)
[95.533720] Starting dynamic subtest: pipe-None-HDMI-A-1
[95.537873] Dynamic subtest pipe-None-HDMI-A-1: SUCCESS (0.001s)
[95.544630] Starting dynamic subtest: pipe-None-DP-2
[95.548645] Dynamic subtest pipe-None-DP-2: SUCCESS (0.001s)
[95.555127] Starting dynamic subtest: pipe-None-HDMI-A-2
[95.559085] Dynamic subtest pipe-None-HDMI-A-2: SUCCESS (0.001s)
[95.566081] Starting dynamic subtest: pipe-None-DP-3
[95.570442] Dynamic subtest pipe-None-DP-3: SUCCESS (0.001s)
[95.577305] Starting dynamic subtest: pipe-None-DP-4
[95.581752] Dynamic subtest pipe-None-DP-4: SUCCESS (0.001s)
[95.584064] Subtest connector-properties-legacy: SUCCESS (7.891s)
[96.383320] [011/133] (923s left) kms_plane_scaling (plane-upscale-20x20-with-pixel-format)
[96.480955] Starting subtest: plane-upscale-20x20-with-pixel-format
[96.483431] Starting dynamic subtest: pipe-A
[97.528112] Dynamic subtest pipe-A: SUCCESS (1.049s)
[97.539885] Starting dynamic subtest: pipe-B
[99.687341] Dynamic subtest pipe-B: SUCCESS (2.159s)
[99.696292] Starting dynamic subtest: pipe-C
[100.878297] Dynamic subtest pipe-C: SUCCESS (1.190s)
[100.887732] Starting dynamic subtest: pipe-D
[102.121594] Dynamic subtest pipe-D: SUCCESS (1.242s)
[102.123882] Subtest plane-upscale-20x20-with-pixel-format: SUCCESS (5.643s)
[103.309356] [012/133] (916s left) gem_wait (await)
[103.372039] Starting subtest: await
[103.374414] Starting dynamic subtest: all-engines
[104.502759] Dynamic subtest all-engines: SUCCESS (1.127s)
[104.517124] Starting dynamic subtest: rcs0
[105.554029] Dynamic subtest rcs0: SUCCESS (1.053s)
[105.569651] Starting dynamic subtest: bcs0
[106.611035] Dynamic subtest bcs0: SUCCESS (1.055s)
[106.626063] Starting dynamic subtest: vcs0
[107.667186] Dynamic subtest vcs0: SUCCESS (1.055s)
[107.681130] Starting dynamic subtest: vcs1
[108.718513] Dynamic subtest vcs1: SUCCESS (1.051s)
[108.732435] Starting dynamic subtest: vecs0
[109.774702] Dynamic subtest vecs0: SUCCESS (1.055s)
[109.788754] Starting dynamic subtest: ccs0
[110.831098] Dynamic subtest ccs0: SUCCESS (1.055s)
[110.834061] Subtest await: SUCCESS (7.459s)
[111.025622] [FACT gem_wait (await)] new: kernel.kmod_is_loaded.vgem: true
[111.028759] [013/133] (908s left) i915_hangman (error-state-basic)
[111.100708] Starting subtest: error-state-basic
[111.238767] Subtest error-state-basic: SUCCESS (0.136s)
[111.317103] [014/133] (908s left) syncobj_wait (single-wait-all-submitted)
[111.370892] Starting subtest: single-wait-all-submitted
[111.473038] Subtest single-wait-all-submitted: SUCCESS (0.102s)
[111.550968] [015/133] (908s left) gem_ctx_create (basic-files)
[111.619584] Starting subtest: basic-files
[113.628728] Subtest basic-files: SUCCESS (2.009s)
[114.945431] [016/133] (904s left) gem_mmap_gtt (cpuset-basic-small-copy-odd)
[115.020265] Subtest cpuset-basic-small-copy-odd: SKIP (0.000s)
[115.082038] [017/133] (904s left) kms_plane_scaling (plane-scaler-with-clipping-clamping-modifiers)
[115.168406] Starting subtest: plane-scaler-with-clipping-clamping-modifiers
[115.170767] Starting dynamic subtest: pipe-A
[115.541929] Dynamic subtest pipe-A: SUCCESS (0.374s)
[115.553044] Starting dynamic subtest: pipe-B
[116.994695] Dynamic subtest pipe-B: SUCCESS (1.452s)
[117.002514] Starting dynamic subtest: pipe-C
[118.419117] Dynamic subtest pipe-C: SUCCESS (1.424s)
[118.428389] Starting dynamic subtest: pipe-D
[119.857600] Dynamic subtest pipe-D: SUCCESS (1.438s)
[119.859980] Subtest plane-scaler-with-clipping-clamping-modifiers: SUCCESS (4.690s)
[121.025511] [018/133] (898s left) gem_eio (throttle)
[121.251716] Starting subtest: throttle
[121.577150] Subtest throttle: SUCCESS (0.324s)
[121.686638] [019/133] (898s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-shrfb-pgflip-blt)
[121.792840] Starting subtest: fbc-2p-scndscrn-shrfb-pgflip-blt
[121.797224] Subtest fbc-2p-scndscrn-shrfb-pgflip-blt: SKIP (0.000s)
[121.889468] [020/133] (898s left) perf_pmu (busy-hang)
[121.938073] Starting subtest: busy-hang
[121.940613] Starting dynamic subtest: rcs0
[123.223255] Dynamic subtest rcs0: SUCCESS (1.284s)
[123.231371] Starting dynamic subtest: bcs0
[124.457272] Dynamic subtest bcs0: SUCCESS (1.235s)
[124.465932] Starting dynamic subtest: vcs0
[126.426562] Dynamic subtest vcs0: SUCCESS (1.966s)
[126.437063] Starting dynamic subtest: vcs1
[128.403057] Dynamic subtest vcs1: SUCCESS (1.978s)
[128.413189] Starting dynamic subtest: vecs0
[130.466778] Dynamic subtest vecs0: SUCCESS (2.060s)
[130.476358] Starting dynamic subtest: ccs0
[131.699813] Dynamic subtest ccs0: SUCCESS (1.234s)
[131.702736] Subtest busy-hang: SUCCESS (9.765s)
[131.796632] [021/133] (888s left) kms_chamelium_color (ctm-green-to-red)
[131.898459] Subtest ctm-green-to-red: SKIP (0.000s)
[131.941584] [022/133] (888s left) syncobj_timeline (single-wait-signaled)
[131.986081] Starting subtest: single-wait-signaled
[131.988433] Subtest single-wait-signaled: SUCCESS (0.000s)
[132.078099] [023/133] (888s left) kms_flip_scaled_crc (flip-64bpp-yftile-to-32bpp-yftile-upscaling)
[132.169051] Starting subtest: flip-64bpp-yftile-to-32bpp-yftile-upscaling
[132.173216] Subtest flip-64bpp-yftile-to-32bpp-yftile-upscaling: SKIP (0.000s)
[132.240334] [024/133] (887s left) kms_addfb_basic (addfb25-4-tiled)
[132.327154] Starting subtest: addfb25-4-tiled
[132.329469] Subtest addfb25-4-tiled: SUCCESS (0.000s)
[132.416230] [025/133] (887s left) kms_cursor_crc (cursor-sliding-32x32)
[132.553613] Starting subtest: cursor-sliding-32x32
[132.599553] Subtest cursor-sliding-32x32: SKIP (0.041s)
[132.889269] [026/133] (887s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-shrfb-draw-mmap-cpu)
[132.992440] Starting subtest: fbc-1p-offscreen-pri-shrfb-draw-mmap-cpu
[136.962500] Subtest fbc-1p-offscreen-pri-shrfb-draw-mmap-cpu: SUCCESS (3.970s)
[138.159134] [027/133] (882s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-wc)
[138.258619] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-wc
[145.307820] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-wc: SUCCESS (7.053s)
[145.446632] [028/133] (874s left) gem_close (many-handles-one-vma)
[145.503703] Starting subtest: many-handles-one-vma
[145.526478] Subtest many-handles-one-vma: SUCCESS (0.024s)
[145.639921] [029/133] (874s left) kms_cursor_legacy (torture-move)
[145.769588] Starting subtest: torture-move
[145.771439] Starting dynamic subtest: pipe-A
[151.636212] Dynamic subtest pipe-A: SUCCESS (5.866s)
[151.646890] Starting dynamic subtest: pipe-B
[158.091818] Dynamic subtest pipe-B: SUCCESS (6.453s)
[158.106277] Starting dynamic subtest: pipe-C
[165.282687] Dynamic subtest pipe-C: SUCCESS (7.189s)
[165.299517] Starting dynamic subtest: pipe-D
[171.216023] Dynamic subtest pipe-D: SUCCESS (5.932s)
[171.230772] Starting dynamic subtest: all-pipes
[178.257651] Dynamic subtest all-pipes: SUCCESS (7.041s)
[178.259945] Subtest torture-move: SUCCESS (32.487s)
[178.412070] [030/133] (842s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-pwrite)
[178.510983] Starting subtest: psr-2p-primscrn-pri-indfb-draw-pwrite
[178.515286] Subtest psr-2p-primscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[178.616214] [031/133] (841s left) kms_psr2_sf (fbc-psr2-overlay-primary-update-sf-dmg-area)
[178.702362] Starting subtest: fbc-psr2-overlay-primary-update-sf-dmg-area
[178.704726] Starting dynamic subtest: pipe-A-eDP-1
[178.820968] Dynamic subtest pipe-A-eDP-1: SKIP (0.122s)
[178.831708] Starting dynamic subtest: pipe-B-eDP-1
[180.022095] Dynamic subtest pipe-B-eDP-1: SKIP (1.195s)
[180.026609] Subtest fbc-psr2-overlay-primary-update-sf-dmg-area: SKIP (1.319s)
[181.196709] [032/133] (839s left) gem_exec_flush (basic-uc-rw-default)
[181.267892] Starting subtest: basic-uc-rw-default
[186.721974] Subtest basic-uc-rw-default: SUCCESS (5.455s)
[186.922735] [033/133] (833s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-mmap-wc)
[187.040443] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-mmap-wc
[187.044784] Subtest psr-2p-scndscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[187.134349] [034/133] (833s left) kms_frontbuffer_tracking (psr-slowdraw)
[187.236822] Starting subtest: psr-slowdraw
[212.422114] Subtest psr-slowdraw: SUCCESS (25.187s)
[212.569421] [035/133] (808s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-onoff)
[212.658823] Starting subtest: psr-1p-primscrn-spr-indfb-onoff
[219.657176] Subtest psr-1p-primscrn-spr-indfb-onoff: SUCCESS (7.002s)
[219.792116] [036/133] (800s left) gem_mmap_gtt (hang-busy)
[219.848619] Subtest hang-busy: SKIP (0.000s)
[219.912926] [037/133] (800s left) kms_joiner (basic-max-non-joiner)
[220.022314] Starting subtest: basic-max-non-joiner
[220.026762] Subtest basic-max-non-joiner: SKIP (0.000s)
[220.086346] [038/133] (800s left) syncobj_wait (wait-delayed-signal)
[220.137373] Starting subtest: wait-delayed-signal
[220.240623] Subtest wait-delayed-signal: SUCCESS (0.102s)
[220.314558] [039/133] (800s left) kms_cursor_crc (cursor-rapid-movement-max-size)
[220.624140] Starting subtest: cursor-rapid-movement-max-size
[220.631096] Subtest cursor-rapid-movement-max-size: SKIP (0.000s)
[220.761370] [040/133] (800s left) kms_psr2_su (frontbuffer-xrgb8888)
[220.818396] Subtest frontbuffer-XRGB8888: SKIP (0.000s)
[220.872794] [041/133] (800s left) gem_exec_balancer (full-late-pulse)
[220.942594] Starting subtest: full-late-pulse
[225.827963] Subtest full-late-pulse: SUCCESS (4.885s)
[226.166358] [042/133] (794s left) prime_mmap (test_invalid_sync_flags)
[226.228050] Starting subtest: test_invalid_sync_flags
[226.230584] Starting dynamic subtest: test_invalid_sync_flags-smem
[226.232962] Dynamic subtest test_invalid_sync_flags-smem: SUCCESS (0.000s)
[226.235409] Subtest test_invalid_sync_flags: SUCCESS (0.001s)
[226.331653] [043/133] (794s left) prime_vgem (fence-write-hang)
[226.414547] Subtest fence-write-hang: SKIP (0.000s)
[226.506318] [044/133] (794s left) kms_color (legacy-gamma-reset)
[226.598743] Starting subtest: legacy-gamma-reset
[226.600593] Starting dynamic subtest: pipe-A-eDP-1
[226.976479] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.376s)
[226.985069] Starting dynamic subtest: pipe-B-eDP-1
[226.989840] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.014s)
[226.998063] Starting dynamic subtest: pipe-C-eDP-1
[227.002821] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.012s)
[227.010879] Starting dynamic subtest: pipe-D-eDP-1
[227.013077] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.011s)
[227.015232] Subtest legacy-gamma-reset: SUCCESS (0.416s)
[227.791335] [045/133] (793s left) i915_pm_rc6_residency (media-rc6-accuracy)
[227.856281] Starting subtest: media-rc6-accuracy
[227.860677] Subtest media-rc6-accuracy: SKIP (0.000s)
[227.951685] [046/133] (793s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-onoff)
[228.045157] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-onoff
[228.049618] Subtest fbcpsr-2p-scndscrn-cur-indfb-onoff: SKIP (0.000s)
[228.151716] [047/133] (793s left) syncobj_timeline (multi-wait-for-submit-available-unsubmitted-submitted)
[228.220597] Starting subtest: multi-wait-for-submit-available-unsubmitted-submitted
[228.222967] Subtest multi-wait-for-submit-available-unsubmitted-submitted: SUCCESS (0.000s)
[228.372462] [048/133] (792s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-shrfb-draw-pwrite)
[228.471137] Starting subtest: psr-1p-offscreen-pri-shrfb-draw-pwrite
[237.895768] Subtest psr-1p-offscreen-pri-shrfb-draw-pwrite: SUCCESS (9.426s)
[238.038825] [049/133] (783s left) kms_ccs (ccs-on-another-bo-4-tiled-mtl-rc-ccs)
[238.124506] Starting subtest: ccs-on-another-bo-4-tiled-mtl-rc-ccs
[238.126847] Starting dynamic subtest: pipe-A-eDP-1
[238.148738] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[238.161129] Starting dynamic subtest: pipe-B-eDP-1
[238.179901] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[238.188945] Starting dynamic subtest: pipe-C-eDP-1
[238.208125] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[238.216356] Starting dynamic subtest: pipe-D-eDP-1
[238.235828] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[238.238134] Subtest ccs-on-another-bo-4-tiled-mtl-rc-ccs: SUCCESS (0.008s)
[240.406683] [050/133] (780s left) gem_ctx_sseu (invalid-sseu)
[240.474322] Subtest invalid-sseu: SKIP (0.000s)
[240.557085] [051/133] (780s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-mmap-wc)
[240.664331] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-mmap-wc
[240.668223] Subtest fbc-2p-primscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[240.749550] [052/133] (780s left) i915_drm_fdinfo (busy-hang)
[240.790068] Starting subtest: busy-hang
[240.792198] Starting dynamic subtest: rcs0
[240.825561] Dynamic subtest rcs0: SKIP (0.035s)
[240.834085] Starting dynamic subtest: bcs0
[240.837908] Dynamic subtest bcs0: SKIP (0.001s)
[240.845613] Starting dynamic subtest: vcs0
[240.849953] Dynamic subtest vcs0: SKIP (0.000s)
[240.858488] Starting dynamic subtest: vcs1
[240.862396] Dynamic subtest vcs1: SKIP (0.000s)
[240.870126] Starting dynamic subtest: vecs0
[240.874204] Dynamic subtest vecs0: SKIP (0.000s)
[240.882437] Starting dynamic subtest: ccs0
[240.886446] Dynamic subtest ccs0: SKIP (0.002s)
[240.890506] Subtest busy-hang: SKIP (0.044s)
[240.927598] [053/133] (780s left) gem_mmap_wc (bad-offset)
[240.980250] Subtest bad-offset: SKIP (0.000s)
[241.037715] [054/133] (780s left) kms_psr (pr-primary-page-flip)
[241.132524] Starting subtest: pr-primary-page-flip
[241.136800] Subtest pr-primary-page-flip: SKIP (0.000s)
[241.207931] [055/133] (780s left) syncobj_timeline (etime-multi-wait-all-for-submit-available-unsubmitted)
[241.262086] Starting subtest: etime-multi-wait-all-for-submit-available-unsubmitted
[241.369664] Subtest etime-multi-wait-all-for-submit-available-unsubmitted: SUCCESS (0.105s)
[241.450397] [056/133] (780s left) gem_exec_params (invalid-bsd1-flag-on-render)
[241.518051] Starting subtest: invalid-bsd1-flag-on-render
[241.520333] Subtest invalid-bsd1-flag-on-render: SUCCESS (0.000s)
[241.607429] [057/133] (779s left) kms_vblank (wait-busy)
[241.712744] Starting subtest: wait-busy
[241.714994] Starting dynamic subtest: pipe-A-eDP-1
[243.587900] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.874s)
[243.601217] Starting dynamic subtest: pipe-D-eDP-1
[246.158094] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.567s)
[246.160253] Subtest wait-busy: SUCCESS (4.445s)
[246.958673] [058/133] (774s left) gem_render_copy (y-tiled-mc-ccs-to-y-tiled-ccs)
[247.030090] Starting subtest: y-tiled-mc-ccs-to-y-tiled-ccs
[247.034209] Subtest y-tiled-mc-ccs-to-y-tiled-ccs: SKIP (0.000s)
[247.210144] [059/133] (774s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-shrfb-plflip-blt)
[247.305639] Starting subtest: fbcpsr-2p-scndscrn-shrfb-plflip-blt
[247.309726] Subtest fbcpsr-2p-scndscrn-shrfb-plflip-blt: SKIP (0.000s)
[247.406556] [060/133] (774s left) gem_ctx_persistence (engines-queued)
[247.471450] Starting subtest: engines-queued
[247.473623] Starting dynamic subtest: rcs0
[247.562598] Dynamic subtest rcs0: SUCCESS (0.093s)
[247.573261] Starting dynamic subtest: bcs0
[247.622575] Dynamic subtest bcs0: SUCCESS (0.058s)
[247.633606] Starting dynamic subtest: vcs0
[248.885987] Dynamic subtest vcs0: SUCCESS (1.260s)
[248.897485] Starting dynamic subtest: vcs1
[250.867459] Dynamic subtest vcs1: SUCCESS (1.978s)
[250.878875] Starting dynamic subtest: vecs0
[252.851663] Dynamic subtest vecs0: SUCCESS (1.981s)
[252.863010] Starting dynamic subtest: ccs0
[253.027440] Dynamic subtest ccs0: SUCCESS (0.175s)
[253.029797] Subtest engines-queued: SUCCESS (5.559s)
[253.144889] [061/133] (768s left) kms_psr (fbc-psr2-primary-mmap-cpu)
[253.233150] Starting subtest: fbc-psr2-primary-mmap-cpu
[253.234972] Starting dynamic subtest: eDP-1
[253.238885] Dynamic subtest eDP-1: SKIP (0.000s)
[253.242709] Subtest fbc-psr2-primary-mmap-cpu: SKIP (0.001s)
[253.337680] [062/133] (768s left) gem_mmap_wc (read-write-distinct)
[253.406124] Subtest read-write-distinct: SKIP (0.000s)
[253.475125] [063/133] (768s left) kms_flip (2x-flip-vs-expired-vblank)
[253.570054] Starting subtest: 2x-flip-vs-expired-vblank
[253.581033] Subtest 2x-flip-vs-expired-vblank: SKIP (0.010s)
[253.662840] [064/133] (768s left) gem_create (create-ext-cpu-access-sanity-check)
[253.831568] Starting subtest: create-ext-cpu-access-sanity-check
[253.836294] Subtest create-ext-cpu-access-sanity-check: SKIP (0.001s)
[253.905895] [065/133] (768s left) vgem_basic (bad-flag)
[253.948178] Starting subtest: bad-flag
[253.950551] Subtest bad-flag: SUCCESS (0.000s)
[254.008073] [066/133] (767s left) api_intel_bb (object-noreloc-keep-cache-simple)
[254.065922] Starting subtest: object-noreloc-keep-cache-simple
[254.070283] Subtest object-noreloc-keep-cache-simple: SUCCESS (0.007s)
[254.178391] [067/133] (767s left) kms_pipe_crc_basic (read-crc)
[254.257284] Starting subtest: read-crc
[254.259220] Starting dynamic subtest: pipe-A-eDP-1
[254.971463] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.710s)
[254.988439] Starting dynamic subtest: pipe-B-eDP-1
[256.336877] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.365s)
[256.346064] Starting dynamic subtest: pipe-C-eDP-1
[257.702876] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.368s)
[257.720834] Starting dynamic subtest: pipe-D-eDP-1
[259.034064] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.328s)
[259.036297] Subtest read-crc: SUCCESS (4.777s)
[259.885172] [068/133] (762s left) gem_exec_reloc (basic-write-read)
[259.945055] Subtest basic-write-read: SKIP (0.000s)
[260.010024] [069/133] (762s left) i915_query (query-garbage)
[260.070353] Starting subtest: query-garbage
[260.072321] Subtest query-garbage: SUCCESS (0.000s)
[260.183085] [070/133] (761s left) kms_big_fb (4-tiled-16bpp-rotate-0)
[260.275949] Starting subtest: 4-tiled-16bpp-rotate-0
[261.656729] Subtest 4-tiled-16bpp-rotate-0: SUCCESS (1.380s)
[261.766892] [071/133] (760s left) kms_plane_cursor (overlay)
[261.864063] Starting subtest: overlay
[261.867789] Starting dynamic subtest: pipe-A-eDP-1-size-64
[264.469788] Dynamic subtest pipe-A-eDP-1-size-64: SUCCESS (2.606s)
[264.530177] Starting dynamic subtest: pipe-A-eDP-1-size-128
[266.984818] Dynamic subtest pipe-A-eDP-1-size-128: SUCCESS (2.463s)
[267.040829] Starting dynamic subtest: pipe-A-eDP-1-size-256
[269.505706] Dynamic subtest pipe-A-eDP-1-size-256: SUCCESS (2.471s)
[269.858973] Starting dynamic subtest: pipe-B-eDP-1-size-64
[273.130116] Dynamic subtest pipe-B-eDP-1-size-64: SUCCESS (3.280s)
[273.195131] Starting dynamic subtest: pipe-B-eDP-1-size-128
[275.608964] Dynamic subtest pipe-B-eDP-1-size-128: SUCCESS (2.427s)
[275.667430] Starting dynamic subtest: pipe-B-eDP-1-size-256
[278.132719] Dynamic subtest pipe-B-eDP-1-size-256: SUCCESS (2.471s)
[278.487575] Starting dynamic subtest: pipe-C-eDP-1-size-64
[281.319898] Dynamic subtest pipe-C-eDP-1-size-64: SUCCESS (2.842s)
[281.357781] Starting dynamic subtest: pipe-C-eDP-1-size-128
[283.441276] Dynamic subtest pipe-C-eDP-1-size-128: SUCCESS (2.092s)
[283.478605] Starting dynamic subtest: pipe-C-eDP-1-size-256
[285.543019] Dynamic subtest pipe-C-eDP-1-size-256: SUCCESS (2.069s)
[286.602733] Starting dynamic subtest: pipe-D-eDP-1-size-64
[289.011956] Dynamic subtest pipe-D-eDP-1-size-64: SUCCESS (2.423s)
[289.049942] Starting dynamic subtest: pipe-D-eDP-1-size-128
[291.200738] Dynamic subtest pipe-D-eDP-1-size-128: SUCCESS (2.158s)
[291.238734] Starting dynamic subtest: pipe-D-eDP-1-size-256
[293.334288] Dynamic subtest pipe-D-eDP-1-size-256: SUCCESS (2.103s)
[293.656460] Subtest overlay: SUCCESS (31.791s)
[294.505221] [072/133] (727s left) kms_chamelium_hpd (vga-hpd-fast)
[294.899793] Subtest vga-hpd-fast: SKIP (0.000s)
[295.705344] [073/133] (726s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-180-async-flip)
[295.806754] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-180-async-flip
[295.810998] Subtest y-tiled-max-hw-stride-32bpp-rotate-180-async-flip: SKIP (0.000s)
[295.908092] [074/133] (726s left) gem_exec_params (dr4-dirt)
[295.973285] Starting subtest: DR4-dirt
[295.975181] Subtest DR4-dirt: SUCCESS (0.000s)
[296.085900] [075/133] (726s left) kms_prop_blob (invalid-get-prop)
[296.144072] Starting subtest: invalid-get-prop
[296.146387] Subtest invalid-get-prop: SUCCESS (0.000s)
[296.249174] [076/133] (726s left) kms_pm_rpm (modeset-stress-extra-wait)
[298.074215] Starting subtest: modeset-stress-extra-wait
[352.386760] Subtest modeset-stress-extra-wait: SUCCESS (54.314s)
[352.489043] [077/133] (669s left) gem_exec_suspend (basic-s0)
[352.548057] Starting subtest: basic-S0
[352.550405] Starting dynamic subtest: smem
[372.941636] Dynamic subtest smem: SUCCESS (6.420s)
[372.944506] Subtest basic-S0: SUCCESS (6.423s)
[373.125028] [078/133] (649s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-mmap-cpu)
[373.250486] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-mmap-cpu
[376.740788] Subtest fbc-1p-primscrn-spr-indfb-draw-mmap-cpu: SUCCESS (3.559s)
[377.965431] [079/133] (644s left) kms_psr (fbc-psr2-sprite-plane-onoff)
[378.062278] Starting subtest: fbc-psr2-sprite-plane-onoff
[378.064670] Starting dynamic subtest: eDP-1
[378.068820] Dynamic subtest eDP-1: SKIP (0.000s)
[378.072969] Subtest fbc-psr2-sprite-plane-onoff: SKIP (0.001s)
[378.144152] [080/133] (644s left) kms_big_fb (yf-tiled-8bpp-rotate-0)
[378.239785] Starting subtest: yf-tiled-8bpp-rotate-0
[378.244241] Subtest yf-tiled-8bpp-rotate-0: SKIP (0.000s)
[378.336059] [081/133] (644s left) kms_vrr (lobf)
[378.424450] Starting subtest: lobf
[378.428705] Subtest lobf: SKIP (0.000s)
[378.512216] [082/133] (644s left) gem_exec_reloc (basic-gtt-wc-noreloc)
[378.571372] Subtest basic-gtt-wc-noreloc: SKIP (0.000s)
[378.642906] [083/133] (644s left) kms_big_fb (linear-max-hw-stride-64bpp-rotate-0-hflip)
[378.731563] Starting subtest: linear-max-hw-stride-64bpp-rotate-0-hflip
[378.735849] Subtest linear-max-hw-stride-64bpp-rotate-0-hflip: SKIP (0.000s)
[378.839640] [084/133] (643s left) syncobj_wait (multi-wait-all-for-submit-unsubmitted-submitted)
[378.890743] Starting subtest: multi-wait-all-for-submit-unsubmitted-submitted
[378.993082] Subtest multi-wait-all-for-submit-unsubmitted-submitted: SUCCESS (0.103s)
[379.070550] [085/133] (643s left) kms_cursor_crc (cursor-onscreen-256x256)
[379.314562] Starting subtest: cursor-onscreen-256x256
[379.319501] Starting dynamic subtest: pipe-A-eDP-1
[381.421616] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.120s)
[381.447523] Starting dynamic subtest: pipe-D-eDP-1
[384.156172] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.732s)
[384.158089] Subtest cursor-onscreen-256x256: SUCCESS (4.877s)
[384.949771] [086/133] (637s left) gem_ccs (block-multicopy-compressed)
[385.018184] Starting subtest: block-multicopy-compressed
[385.022194] Subtest block-multicopy-compressed: SKIP (0.000s)
[385.136331] [087/133] (637s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-blt)
[385.232998] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-blt
[385.237246] Subtest psr-2p-scndscrn-spr-indfb-draw-blt: SKIP (0.000s)
[385.319180] [088/133] (637s left) gem_exec_schedule (semaphore-power)
[385.506007] Subtest semaphore-power: SKIP (0.000s)
[385.684650] [089/133] (637s left) kms_rotation_crc (multiplane-rotation)
[385.767008] Starting subtest: multiplane-rotation
[403.188390] Subtest multiplane-rotation: SUCCESS (17.460s)
[403.304767] [090/133] (619s left) kms_chamelium_frames (dp-frame-dump)
[403.696232] Subtest dp-frame-dump: SKIP (0.000s)
[404.523156] [091/133] (618s left) gem_softpin (evict-prime-sanity-check)
[404.580854] Starting subtest: evict-prime-sanity-check
[404.583129] Starting dynamic subtest: rcs0
[405.714766] Dynamic subtest rcs0: SUCCESS (1.134s)
[405.729886] Starting dynamic subtest: bcs0
[406.833814] Dynamic subtest bcs0: SUCCESS (1.116s)
[406.846351] Starting dynamic subtest: vcs0
[408.886427] Dynamic subtest vcs0: SUCCESS (2.051s)
[408.899634] Starting dynamic subtest: vcs1
[410.867088] Dynamic subtest vcs1: SUCCESS (1.979s)
[410.879593] Starting dynamic subtest: vecs0
[412.913663] Dynamic subtest vecs0: SUCCESS (2.045s)
[412.925653] Starting dynamic subtest: ccs0
[414.072914] Dynamic subtest ccs0: SUCCESS (1.158s)
[414.085250] Starting dynamic subtest: all
[415.189589] Dynamic subtest all: SUCCESS (1.115s)
[415.192164] Subtest evict-prime-sanity-check: SUCCESS (10.615s)
[415.273379] [092/133] (607s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-move)
[415.372184] Starting subtest: fbc-2p-scndscrn-cur-indfb-move
[415.376298] Subtest fbc-2p-scndscrn-cur-indfb-move: SKIP (0.000s)
[415.466432] [093/133] (607s left) prime_mmap (test_refcounting)
[415.525865] Starting subtest: test_refcounting
[415.528046] Starting dynamic subtest: test_refcounting-smem
[415.555342] Dynamic subtest test_refcounting-smem: SUCCESS (0.031s)
[415.557754] Subtest test_refcounting: SUCCESS (0.032s)
[415.643839] [094/133] (607s left) kms_big_fb (linear-32bpp-rotate-270)
[415.742820] Starting subtest: linear-32bpp-rotate-270
[415.762441] Subtest linear-32bpp-rotate-270: SKIP (0.019s)
[415.868801] [095/133] (607s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-mmap-gtt)
[415.960661] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-mmap-gtt
[415.964735] Subtest psr-1p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[416.064527] [096/133] (607s left) kms_pm_rpm (fences)
[418.091022] Starting subtest: fences
[418.096802] Subtest fences: SKIP (0.000s)
[418.488473] [097/133] (604s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-mmap-cpu)
[418.581343] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-mmap-cpu
[425.021559] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-mmap-cpu: SUCCESS (6.448s)
[425.160052] [098/133] (598s left) gem_exec_fence (syncobj-invalid-flags)
[425.639422] Starting subtest: syncobj-invalid-flags
[425.641766] Subtest syncobj-invalid-flags: SUCCESS (0.000s)
[426.998946] [099/133] (596s left) gem_tiled_wb
[427.120370] [100/133] (596s left) kms_ccs (bad-rotation-90-4-tiled-dg2-rc-ccs)
[427.223396] Starting subtest: bad-rotation-90-4-tiled-dg2-rc-ccs
[427.225680] Starting dynamic subtest: pipe-A-eDP-1
[427.247400] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[427.258710] Starting dynamic subtest: pipe-B-eDP-1
[427.279256] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[427.288558] Starting dynamic subtest: pipe-C-eDP-1
[427.309573] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[427.319773] Starting dynamic subtest: pipe-D-eDP-1
[427.340689] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[427.344770] Subtest bad-rotation-90-4-tiled-dg2-rc-ccs: SKIP (0.005s)
[429.476732] [101/133] (593s left) gem_lmem_swapping (parallel-random-engines)
[429.519855] Subtest parallel-random-engines: SKIP (0.000s)
[429.559820] [102/133] (593s left) kms_addfb_basic (invalid-get-prop-any)
[429.613490] Starting subtest: invalid-get-prop-any
[429.615651] Subtest invalid-get-prop-any: SUCCESS (0.000s)
[429.744281] [103/133] (593s left) gem_mmap_gtt (basic-write-read-distinct)
[429.807460] Subtest basic-write-read-distinct: SKIP (0.000s)
[429.866826] [104/133] (593s left) gem_ctx_persistence (heartbeat-hostile)
[429.917529] Starting subtest: heartbeat-hostile
[429.921935] Subtest heartbeat-hostile: SKIP (0.000s)
[430.030021] [105/133] (593s left) kms_lease (invalid-create-leases)
[430.116366] Starting subtest: invalid-create-leases
[430.121126] Subtest invalid-create-leases: SUCCESS (0.005s)
[430.244375] [106/133] (593s left) prime_busy (before)
[430.298096] Starting subtest: before
[430.303029] Starting dynamic subtest: rcs0
[430.329909] Dynamic subtest rcs0: SUCCESS (0.028s)
[430.340505] Starting dynamic subtest: bcs0
[430.369378] Dynamic subtest bcs0: SUCCESS (0.039s)
[430.379425] Starting dynamic subtest: vcs0
[430.410681] Dynamic subtest vcs0: SUCCESS (0.041s)
[430.419479] Starting dynamic subtest: vcs1
[430.451620] Dynamic subtest vcs1: SUCCESS (0.040s)
[430.460323] Starting dynamic subtest: vecs0
[430.492650] Dynamic subtest vecs0: SUCCESS (0.040s)
[430.501464] Starting dynamic subtest: ccs0
[430.533555] Dynamic subtest ccs0: SUCCESS (0.040s)
[430.642783] Subtest before: SUCCESS (0.343s)
[430.739575] [107/133] (592s left) kms_universal_plane (universal-plane-pageflip-windowed)
[430.823125] Starting subtest: universal-plane-pageflip-windowed
[430.825112] Starting dynamic subtest: pipe-A-eDP-1
[431.401512] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.578s)
[431.412270] Starting dynamic subtest: pipe-B-eDP-1
[432.595825] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.193s)
[432.606042] Starting dynamic subtest: pipe-C-eDP-1
[433.795200] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.200s)
[433.805639] Starting dynamic subtest: pipe-D-eDP-1
[435.034444] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.237s)
[435.036747] Subtest universal-plane-pageflip-windowed: SUCCESS (4.214s)
[435.876121] [108/133] (587s left) kms_flip (plain-flip-ts-check-interruptible)
[435.980518] Starting subtest: plain-flip-ts-check-interruptible
[435.982849] Starting dynamic subtest: A-eDP1
[444.876132] Dynamic subtest A-eDP1: SUCCESS (8.898s)
[444.887840] Starting dynamic subtest: B-eDP1
[453.705752] Dynamic subtest B-eDP1: SUCCESS (8.833s)
[453.717927] Starting dynamic subtest: C-eDP1
[462.522407] Dynamic subtest C-eDP1: SUCCESS (8.819s)
[462.534962] Starting dynamic subtest: D-eDP1
[471.353502] Dynamic subtest D-eDP1: SUCCESS (8.827s)
[471.358791] Subtest plain-flip-ts-check-interruptible: SUCCESS (35.388s)
[472.536319] [109/133] (551s left) gen3_render_tiledy_blits
[472.662553] [110/133] (551s left) gen9_exec_parse (batch-zero-length)
[472.715151] Subtest batch-zero-length: SKIP (0.000s)
[472.791472] [111/133] (551s left) perf (non-sampling-read-error)
[472.908539] Starting subtest: non-sampling-read-error
[472.921482] Subtest non-sampling-read-error: SUCCESS (0.011s)
[472.967686] [112/133] (550s left) kms_cursor_legacy (cursorb-vs-flipb-varying-size)
[473.098465] Starting subtest: cursorB-vs-flipB-varying-size
[473.103012] Subtest cursorB-vs-flipB-varying-size: SKIP (0.001s)
[473.236506] [113/133] (550s left) gem_exec_reloc (basic-range)
[473.302344] Subtest basic-range: SKIP (0.000s)
[473.377901] [114/133] (550s left) device_reset (cold-reset-bound)
[473.421447] Starting subtest: cold-reset-bound
[473.426085] Subtest cold-reset-bound: SKIP (0.000s)
[473.484448] [115/133] (550s left) kms_content_protection (lic-type-0)
[473.627520] Starting subtest: lic-type-0
[473.631539] Subtest lic-type-0: SKIP (0.000s)
[473.761059] [116/133] (550s left) kms_cursor_legacy (flip-vs-cursor-legacy)
[473.871673] Starting subtest: flip-vs-cursor-legacy
[481.258666] Subtest flip-vs-cursor-legacy: SUCCESS (7.380s)
[482.081938] [117/133] (542s left) kms_ccs (crc-primary-suspend-4-tiled-dg2-rc-ccs)
[482.168809] Starting subtest: crc-primary-suspend-4-tiled-dg2-rc-ccs
[482.171071] Starting dynamic subtest: pipe-A-eDP-1
[482.179961] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[482.190361] Starting dynamic subtest: pipe-B-eDP-1
[482.199214] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[482.209095] Starting dynamic subtest: pipe-C-eDP-1
[482.217696] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[482.227080] Starting dynamic subtest: pipe-D-eDP-1
[482.236141] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[482.240724] Subtest crc-primary-suspend-4-tiled-dg2-rc-ccs: SKIP (0.005s)
[484.437941] [118/133] (539s left) kms_flip_scaled_crc (flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling)
[484.531366] Starting subtest: flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling
[484.535721] Subtest flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling: SKIP (0.000s)
[484.619817] [119/133] (539s left) gem_mmap_gtt (fault-concurrent)
[484.670845] Subtest fault-concurrent: SKIP (0.000s)
[484.735120] [120/133] (539s left) gem_exec_reloc (basic-concurrent0)
[484.789356] Subtest basic-concurrent0: SKIP (0.000s)
[484.848543] [121/133] (539s left) i915_query (query-regions-sanity-check)
[484.899696] Starting subtest: query-regions-sanity-check
[484.906381] Subtest query-regions-sanity-check: SUCCESS (0.010s)
[485.036041] [122/133] (539s left) kms_explicit_fence (multiplane-atomic-fence-wait)
[485.167566] Starting subtest: multiplane-atomic-fence-wait
[485.487691] Subtest multiplane-atomic-fence-wait: SUCCESS (0.317s)
[486.670428] [123/133] (537s left) kms_plane (pixel-format-yf-tiled-ccs-modifier)
[486.756424] Starting subtest: pixel-format-yf-tiled-ccs-modifier
[486.760933] Subtest pixel-format-yf-tiled-ccs-modifier: SKIP (0.000s)
[486.829068] [124/133] (537s left) gem_pxp (regular-baseline-src-copy-readible)
[486.955240] Starting subtest: regular-baseline-src-copy-readible
[487.012811] Subtest regular-baseline-src-copy-readible: SUCCESS (0.060s)
[487.136634] [125/133] (537s left) gem_tiled_blits (interruptible)
[487.205144] Subtest interruptible: SKIP (0.000s)
[487.278176] [126/133] (537s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-render)
[487.370243] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-render
[487.374278] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-render: SKIP (0.000s)
[487.454978] [127/133] (537s left) kms_big_fb (y-tiled-16bpp-rotate-90)
[487.549855] Starting subtest: y-tiled-16bpp-rotate-90
[487.554014] Subtest y-tiled-16bpp-rotate-90: SKIP (0.000s)
[487.651587] [128/133] (536s left) kms_flip (flip-vs-expired-vblank-interruptible)
[487.750321] Starting subtest: flip-vs-expired-vblank-interruptible
[487.752252] Starting dynamic subtest: A-eDP1
[496.366394] Dynamic subtest A-eDP1: SUCCESS (8.612s)
[496.387537] Starting dynamic subtest: B-eDP1
[505.000395] Dynamic subtest B-eDP1: SUCCESS (8.630s)
[505.012001] Starting dynamic subtest: C-eDP1
[513.635458] Dynamic subtest C-eDP1: SUCCESS (8.634s)
[513.655824] Starting dynamic subtest: D-eDP1
[522.248538] Dynamic subtest D-eDP1: SUCCESS (8.611s)
[522.251173] Subtest flip-vs-expired-vblank-interruptible: SUCCESS (34.499s)
[523.409861] [129/133] (501s left) kms_atomic_interruptible (universal-setplane-primary)
[523.505467] Starting subtest: universal-setplane-primary
[523.507745] Starting dynamic subtest: pipe-A-eDP-1
[530.916502] Dynamic subtest pipe-A-eDP-1: SUCCESS (7.412s)
[530.918795] Subtest universal-setplane-primary: SUCCESS (7.413s)
[531.768230] [130/133] (492s left) kms_psr (psr2-suspend)
[531.872206] Starting subtest: psr2-suspend
[531.874348] Starting dynamic subtest: eDP-1
[549.472003] Dynamic subtest eDP-1: SUCCESS (2.848s)
[549.474508] Subtest psr2-suspend: SUCCESS (2.849s)
[550.261335] [131/133] (474s left) syncobj_timeline (host-signal-points)
[550.331124] Starting subtest: host-signal-points
[550.333785] Subtest host-signal-points: SUCCESS (0.004s)
[550.431939] [132/133] (474s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-move)
[550.527948] Starting subtest: fbc-2p-scndscrn-spr-indfb-move
[550.532453] Subtest fbc-2p-scndscrn-spr-indfb-move: SKIP (0.000s)
[550.630495] [133/133] (474s left) prime_mmap_kms (buffer-sharing)
[550.720458] Starting subtest: buffer-sharing
[551.159725] Subtest buffer-sharing: SUCCESS (0.448s)
[551.945452] Closing watchdogs
results: parsing output: 0/ for test: kms_ccs
results: parsing output: 1/ for test: gem_exec_schedule
results: parsing output: 2/ for test: kms_big_fb
results: parsing output: 3/ for test: gem_exec_balancer
results: parsing output: 4/ for test: kms_frontbuffer_tracking
results: parsing output: 5/ for test: gem_userptr_blits
results: parsing output: 6/ for test: syncobj_timeline
results: parsing output: 7/ for test: kms_cursor_legacy
results: parsing output: 8/ for test: kms_big_fb
results: parsing output: 9/ for test: kms_properties
results: parsing output: 10/ for test: kms_plane_scaling
results: parsing output: 11/ for test: gem_wait
results: parsing output: 12/ for test: i915_hangman
results: parsing output: 13/ for test: syncobj_wait
results: parsing output: 14/ for test: gem_ctx_create
results: parsing output: 15/ for test: gem_mmap_gtt
results: parsing output: 16/ for test: kms_plane_scaling
results: parsing output: 17/ for test: gem_eio
results: parsing output: 18/ for test: kms_frontbuffer_tracking
results: parsing output: 19/ for test: perf_pmu
results: parsing output: 20/ for test: kms_chamelium_color
results: parsing output: 21/ for test: syncobj_timeline
results: parsing output: 22/ for test: kms_flip_scaled_crc
results: parsing output: 23/ for test: kms_addfb_basic
results: parsing output: 24/ for test: kms_cursor_crc
results: parsing output: 25/ for test: kms_frontbuffer_tracking
results: parsing output: 26/ for test: kms_frontbuffer_tracking
results: parsing output: 27/ for test: gem_close
results: parsing output: 28/ for test: kms_cursor_legacy
results: parsing output: 29/ for test: kms_frontbuffer_tracking
results: parsing output: 30/ for test: kms_psr2_sf
results: parsing output: 31/ for test: gem_exec_flush
results: parsing output: 32/ for test: kms_frontbuffer_tracking
results: parsing output: 33/ for test: kms_frontbuffer_tracking
results: parsing output: 34/ for test: kms_frontbuffer_tracking
results: parsing output: 35/ for test: gem_mmap_gtt
results: parsing output: 36/ for test: kms_joiner
results: parsing output: 37/ for test: syncobj_wait
results: parsing output: 38/ for test: kms_cursor_crc
results: parsing output: 39/ for test: kms_psr2_su
results: parsing output: 40/ for test: gem_exec_balancer
results: parsing output: 41/ for test: prime_mmap
results: parsing output: 42/ for test: prime_vgem
results: parsing output: 43/ for test: kms_color
results: parsing output: 44/ for test: i915_pm_rc6_residency
results: parsing output: 45/ for test: kms_frontbuffer_tracking
results: parsing output: 46/ for test: syncobj_timeline
results: parsing output: 47/ for test: kms_frontbuffer_tracking
results: parsing output: 48/ for test: kms_ccs
results: parsing output: 49/ for test: gem_ctx_sseu
results: parsing output: 50/ for test: kms_frontbuffer_tracking
results: parsing output: 51/ for test: i915_drm_fdinfo
results: parsing output: 52/ for test: gem_mmap_wc
results: parsing output: 53/ for test: kms_psr
results: parsing output: 54/ for test: syncobj_timeline
results: parsing output: 55/ for test: gem_exec_params
results: parsing output: 56/ for test: kms_vblank
results: parsing output: 57/ for test: gem_render_copy
results: parsing output: 58/ for test: kms_frontbuffer_tracking
results: parsing output: 59/ for test: gem_ctx_persistence
results: parsing output: 60/ for test: kms_psr
results: parsing output: 61/ for test: gem_mmap_wc
results: parsing output: 62/ for test: kms_flip
results: parsing output: 63/ for test: gem_create
results: parsing output: 64/ for test: vgem_basic
results: parsing output: 65/ for test: api_intel_bb
results: parsing output: 66/ for test: kms_pipe_crc_basic
results: parsing output: 67/ for test: gem_exec_reloc
results: parsing output: 68/ for test: i915_query
results: parsing output: 69/ for test: kms_big_fb
results: parsing output: 70/ for test: kms_plane_cursor
results: parsing output: 71/ for test: kms_chamelium_hpd
results: parsing output: 72/ for test: kms_big_fb
results: parsing output: 73/ for test: gem_exec_params
results: parsing output: 74/ for test: kms_prop_blob
results: parsing output: 75/ for test: kms_pm_rpm
results: parsing output: 76/ for test: gem_exec_suspend
results: parsing output: 77/ for test: kms_frontbuffer_tracking
results: parsing output: 78/ for test: kms_psr
results: parsing output: 79/ for test: kms_big_fb
results: parsing output: 80/ for test: kms_vrr
results: parsing output: 81/ for test: gem_exec_reloc
results: parsing output: 82/ for test: kms_big_fb
results: parsing output: 83/ for test: syncobj_wait
results: parsing output: 84/ for test: kms_cursor_crc
results: parsing output: 85/ for test: gem_ccs
results: parsing output: 86/ for test: kms_frontbuffer_tracking
results: parsing output: 87/ for test: gem_exec_schedule
results: parsing output: 88/ for test: kms_rotation_crc
results: parsing output: 89/ for test: kms_chamelium_frames
results: parsing output: 90/ for test: gem_softpin
results: parsing output: 91/ for test: kms_frontbuffer_tracking
results: parsing output: 92/ for test: prime_mmap
results: parsing output: 93/ for test: kms_big_fb
results: parsing output: 94/ for test: kms_frontbuffer_tracking
results: parsing output: 95/ for test: kms_pm_rpm
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_tiled_wb
results: parsing output: 99/ for test: kms_ccs
results: parsing output: 100/ for test: gem_lmem_swapping
results: parsing output: 101/ for test: kms_addfb_basic
results: parsing output: 102/ for test: gem_mmap_gtt
results: parsing output: 103/ for test: gem_ctx_persistence
results: parsing output: 104/ for test: kms_lease
results: parsing output: 105/ for test: prime_busy
results: parsing output: 106/ for test: kms_universal_plane
results: parsing output: 107/ for test: kms_flip
results: parsing output: 108/ for test: gen3_render_tiledy_blits
results: parsing output: 109/ for test: gen9_exec_parse
results: parsing output: 110/ for test: perf
results: parsing output: 111/ for test: kms_cursor_legacy
results: parsing output: 112/ for test: gem_exec_reloc
results: parsing output: 113/ for test: device_reset
results: parsing output: 114/ for test: kms_content_protection
results: parsing output: 115/ for test: kms_cursor_legacy
results: parsing output: 116/ for test: kms_ccs
results: parsing output: 117/ for test: kms_flip_scaled_crc
results: parsing output: 118/ for test: gem_mmap_gtt
results: parsing output: 119/ for test: gem_exec_reloc
results: parsing output: 120/ for test: i915_query
results: parsing output: 121/ for test: kms_explicit_fence
results: parsing output: 122/ for test: kms_plane
results: parsing output: 123/ for test: gem_pxp
results: parsing output: 124/ for test: gem_tiled_blits
results: parsing output: 125/ for test: kms_frontbuffer_tracking
results: parsing output: 126/ for test: kms_big_fb
results: parsing output: 127/ for test: kms_flip
results: parsing output: 128/ for test: kms_atomic_interruptible
results: parsing output: 129/ for test: kms_psr
results: parsing output: 130/ for test: syncobj_timeline
results: parsing output: 131/ for test: kms_frontbuffer_tracking
results: parsing output: 132/ for test: prime_mmap_kms
Done.