[58.180146] Initializing watchdogs
[58.180193]   /dev/watchdog0
[58.194499] [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.198711] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[58.200885] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[58.203957] [001/133] (960s left) kms_ccs (ccs-on-another-bo-y-tiled-gen12-mc-ccs)
[58.322585] Starting subtest: ccs-on-another-bo-y-tiled-gen12-mc-ccs
[58.324661] Starting dynamic subtest: pipe-A-eDP-1
[58.346157] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[58.354903] Starting dynamic subtest: pipe-B-eDP-1
[58.375669] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[58.382262] Starting dynamic subtest: pipe-C-eDP-1
[58.403155] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[58.410490] Starting dynamic subtest: pipe-D-eDP-1
[58.431532] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[58.435510] Subtest ccs-on-another-bo-y-tiled-gen12-mc-ccs: SKIP (0.003s)
[60.560365] [002/133] (958s left) kms_plane (planar-pixel-format-settings)
[60.661777] Starting subtest: planar-pixel-format-settings
[60.732317] Subtest planar-pixel-format-settings: SUCCESS (0.072s)
[60.828657] [003/133] (957s left) gem_create (create-size-update)
[60.885753] Starting subtest: create-size-update
[60.887644] Subtest create-size-update: SUCCESS (0.000s)
[61.097581] [004/133] (957s left) kms_big_fb (y-tiled-16bpp-rotate-0)
[61.199374] Starting subtest: y-tiled-16bpp-rotate-0
[61.203488] Subtest y-tiled-16bpp-rotate-0: SKIP (0.000s)
[61.288803] [005/133] (957s left) gem_pipe_control_store_loop (reused-buffer)
[61.351693] Starting subtest: reused-buffer
[63.471893] Subtest reused-buffer: SUCCESS (2.151s)
[63.587802] [006/133] (955s left) kms_getfb (getfb-repeated-different-handles)
[63.688889] Starting subtest: getfb-repeated-different-handles
[63.691164] Subtest getfb-repeated-different-handles: SUCCESS (0.000s)
[63.805893] [007/133] (955s left) kms_big_fb (x-tiled-addfb)
[63.902570] Starting subtest: x-tiled-addfb
[63.905345] Subtest x-tiled-addfb: SUCCESS (0.000s)
[63.978769] [008/133] (954s left) syncobj_timeline (etime-single-wait-for-submit-available-unsubmitted)
[64.025447] Starting subtest: etime-single-wait-for-submit-available-unsubmitted
[64.129596] Subtest etime-single-wait-for-submit-available-unsubmitted: SUCCESS (0.104s)
[64.217795] [009/133] (954s left) kms_flip (2x-flip-vs-dpms-on-nop)
[64.298189] Starting subtest: 2x-flip-vs-dpms-on-nop
[64.306450] Subtest 2x-flip-vs-dpms-on-nop: SKIP (0.010s)
[64.380821] [010/133] (954s left) kms_chamelium_hpd (hdmi-hpd)
[64.765023] Subtest hdmi-hpd: SKIP (0.000s)
[65.597823] [011/133] (953s left) prime_busy (before-wait)
[65.663365] Starting subtest: before-wait
[65.665651] Starting dynamic subtest: rcs0
[65.693443] Dynamic subtest rcs0: SUCCESS (0.030s)
[65.702983] Starting dynamic subtest: bcs0
[65.747983] Dynamic subtest bcs0: SUCCESS (0.055s)
[65.755243] Starting dynamic subtest: vcs0
[65.790610] Dynamic subtest vcs0: SUCCESS (0.042s)
[65.798363] Starting dynamic subtest: vcs1
[65.832907] Dynamic subtest vcs1: SUCCESS (0.041s)
[65.841335] Starting dynamic subtest: vecs0
[65.874337] Dynamic subtest vecs0: SUCCESS (0.041s)
[65.882718] Starting dynamic subtest: ccs0
[65.913917] Dynamic subtest ccs0: SUCCESS (0.041s)
[66.021588] Subtest before-wait: SUCCESS (0.362s)
[66.092642] [012/133] (953s left) kms_ccs (random-ccs-data-4-tiled-dg2-mc-ccs)
[66.178314] Starting subtest: random-ccs-data-4-tiled-dg2-mc-ccs
[66.181798] Starting dynamic subtest: pipe-A-eDP-1
[66.206140] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[66.213659] Starting dynamic subtest: pipe-B-eDP-1
[66.236254] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[66.243835] Starting dynamic subtest: pipe-C-eDP-1
[66.266599] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[66.277879] Starting dynamic subtest: pipe-D-eDP-1
[66.301573] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[66.305953] Subtest random-ccs-data-4-tiled-dg2-mc-ccs: SKIP (0.003s)
[68.371170] [013/133] (950s left) gem_exec_fence (long-history)
[68.822781] Starting subtest: long-history
[76.000613] Subtest long-history: SUCCESS (7.207s)
[76.689097] [FACT gem_exec_fence (long-history)] new: kernel.kmod_is_loaded.vgem: true
[76.692239] [014/133] (942s left) gem_ccs (block-multicopy-inplace)
[76.751628] Starting subtest: block-multicopy-inplace
[76.756041] Subtest block-multicopy-inplace: SKIP (0.000s)
[76.857697] [015/133] (942s left) gem_exec_params (readonly)
[76.913219] Starting subtest: readonly
[76.920052] Subtest readonly: SUCCESS (0.007s)
[77.050742] [016/133] (942s left) syncobj_wait (single-wait-for-submit-submitted)
[77.113811] Starting subtest: single-wait-for-submit-submitted
[77.218531] Subtest single-wait-for-submit-submitted: SUCCESS (0.104s)
[77.298322] [017/133] (942s left) gem_exec_schedule (semaphore-resolve)
[77.376948] Starting subtest: semaphore-resolve
[77.432909] Subtest semaphore-resolve: SUCCESS (0.064s)
[77.767445] [018/133] (941s left) kms_cursor_legacy (cursorb-vs-flipb-toggle)
[77.884236] Starting subtest: cursorB-vs-flipB-toggle
[77.888707] Subtest cursorB-vs-flipB-toggle: SKIP (0.001s)
[78.025365] [019/133] (941s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-mmap-gtt)
[78.119482] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-mmap-gtt
[78.123564] Subtest fbc-2p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[78.230868] [020/133] (941s left) syncobj_wait (invalid-signal-one-illegal-handle)
[78.284905] Starting subtest: invalid-signal-one-illegal-handle
[78.286942] Subtest invalid-signal-one-illegal-handle: SUCCESS (0.000s)
[78.376759] [021/133] (941s left) gem_exec_balancer (indices)
[78.439077] Starting subtest: indices
[81.245107] Subtest indices: SUCCESS (2.808s)
[81.559909] [022/133] (937s left) kms_plane_alpha_blend (coverage-vs-premult-vs-constant)
[81.655736] Starting subtest: coverage-vs-premult-vs-constant
[81.937067] Starting dynamic subtest: pipe-A-eDP-1
[82.562892] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.626s)
[82.570818] Starting dynamic subtest: pipe-D-eDP-1
[83.851943] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.286s)
[83.854404] Subtest coverage-vs-premult-vs-constant: SUCCESS (2.197s)
[84.696384] [023/133] (934s left) kms_psr (fbc-psr2-primary-render)
[84.802323] Starting subtest: fbc-psr2-primary-render
[84.804430] Starting dynamic subtest: eDP-1
[84.808799] Dynamic subtest eDP-1: SKIP (0.000s)
[84.813177] Subtest fbc-psr2-primary-render: SKIP (0.001s)
[84.877614] [024/133] (934s left) kms_content_protection (atomic-dpms)
[85.010934] Starting subtest: atomic-dpms
[85.016204] Subtest atomic-dpms: SKIP (0.000s)
[85.130415] [025/133] (934s left) kms_ccs (random-ccs-data-4-tiled-mtl-rc-ccs)
[85.222986] Starting subtest: random-ccs-data-4-tiled-mtl-rc-ccs
[85.224932] Starting dynamic subtest: pipe-A-eDP-1
[85.949027] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.719s)
[85.958851] Starting dynamic subtest: pipe-B-eDP-1
[87.704705] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.753s)
[87.714557] Starting dynamic subtest: pipe-C-eDP-1
[89.450278] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.744s)
[89.459662] Starting dynamic subtest: pipe-D-eDP-1
[91.180046] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.728s)
[91.182309] Subtest random-ccs-data-4-tiled-mtl-rc-ccs: SUCCESS (5.949s)
[92.323980] [026/133] (927s left) gem_ctx_persistence (legacy-engines-cleanup)
[92.384748] Starting subtest: legacy-engines-cleanup
[92.387204] Starting dynamic subtest: render
[92.459680] Dynamic subtest render: SUCCESS (0.075s)
[92.469586] Starting dynamic subtest: bsd1
[92.545305] Dynamic subtest bsd1: SUCCESS (0.085s)
[92.555498] Starting dynamic subtest: bsd2
[92.610653] Dynamic subtest bsd2: SUCCESS (0.063s)
[92.622692] Starting dynamic subtest: blt
[92.643652] Dynamic subtest blt: SUCCESS (0.032s)
[92.652853] Starting dynamic subtest: vebox
[92.689620] Dynamic subtest vebox: SUCCESS (0.044s)
[92.692071] Subtest legacy-engines-cleanup: SUCCESS (0.305s)
[92.778979] [027/133] (926s left) kms_cursor_edge_walk (128x128-left-edge)
[92.871036] Starting subtest: 128x128-left-edge
[92.873246] Starting dynamic subtest: pipe-A-eDP-1
[96.291594] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.420s)
[96.301133] Starting dynamic subtest: pipe-D-eDP-1
[99.416235] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.123s)
[99.418521] Subtest 128x128-left-edge: SUCCESS (6.545s)
[100.235208] [028/133] (919s left) dmabuf (all-tests)
[100.278287] Starting subtest: all-tests
[100.283181] Subtest all-tests: SKIP (0.000s)
[100.331477] [029/133] (919s left) kms_ccs (crc-primary-suspend-y-tiled-gen12-rc-ccs)
[100.431197] Starting subtest: crc-primary-suspend-y-tiled-gen12-rc-ccs
[100.433592] Starting dynamic subtest: pipe-A-eDP-1
[100.442833] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[100.452403] Starting dynamic subtest: pipe-B-eDP-1
[100.461254] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[100.469332] Starting dynamic subtest: pipe-C-eDP-1
[100.478022] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[100.485975] Starting dynamic subtest: pipe-D-eDP-1
[100.495382] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[100.499789] Subtest crc-primary-suspend-y-tiled-gen12-rc-ccs: SKIP (0.006s)
[102.613780] [030/133] (917s left) kms_color_pipeline (plane-lut1d-ctm3x4)
[102.719043] Starting subtest: plane-lut1d-ctm3x4
[102.843772] Starting dynamic subtest: pipe-A-plane-0
[102.987289] Dynamic subtest pipe-A-plane-0: SUCCESS (0.144s)
[102.997791] Starting dynamic subtest: pipe-A-plane-1
[103.120561] Dynamic subtest pipe-A-plane-1: SUCCESS (0.133s)
[103.130951] Starting dynamic subtest: pipe-A-plane-2
[103.253965] Dynamic subtest pipe-A-plane-2: SUCCESS (0.133s)
[104.421650] Starting dynamic subtest: pipe-B-plane-0
[104.567769] Dynamic subtest pipe-B-plane-0: SUCCESS (0.155s)
[104.576402] Starting dynamic subtest: pipe-B-plane-1
[104.712878] Dynamic subtest pipe-B-plane-1: SUCCESS (0.144s)
[104.728336] Starting dynamic subtest: pipe-B-plane-2
[104.867883] Dynamic subtest pipe-B-plane-2: SUCCESS (0.155s)
[106.052901] Starting dynamic subtest: pipe-C-plane-0
[106.179291] Dynamic subtest pipe-C-plane-0: SUCCESS (0.133s)
[106.188969] Starting dynamic subtest: pipe-C-plane-1
[106.323740] Dynamic subtest pipe-C-plane-1: SUCCESS (0.144s)
[106.332583] Starting dynamic subtest: pipe-C-plane-2
[106.457172] Dynamic subtest pipe-C-plane-2: SUCCESS (0.133s)
[107.699743] Starting dynamic subtest: pipe-D-plane-0
[107.860059] Dynamic subtest pipe-D-plane-0: SUCCESS (0.167s)
[107.872592] Starting dynamic subtest: pipe-D-plane-1
[108.026309] Dynamic subtest pipe-D-plane-1: SUCCESS (0.165s)
[108.035561] Starting dynamic subtest: pipe-D-plane-2
[108.181991] Dynamic subtest pipe-D-plane-2: SUCCESS (0.155s)
[108.474292] Subtest plane-lut1d-ctm3x4: SUCCESS (5.753s)
[109.343462] [031/133] (910s left) gem_exec_await (wide-contexts)
[109.561467] Starting subtest: wide-contexts
[133.181870] Subtest wide-contexts: SUCCESS (23.618s)
[133.378437] [032/133] (886s left) gem_basic (create-close)
[133.464304] Starting subtest: create-close
[133.468493] Subtest create-close: SUCCESS (0.000s)
[133.547110] [033/133] (886s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-pwrite)
[133.653758] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-pwrite
[139.816864] Subtest fbc-1p-primscrn-pri-shrfb-draw-pwrite: SUCCESS (6.167s)
[140.965102] [034/133] (879s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-onoff)
[141.061682] Starting subtest: fbc-2p-scndscrn-cur-indfb-onoff
[141.065834] Subtest fbc-2p-scndscrn-cur-indfb-onoff: SKIP (0.000s)
[141.164395] [035/133] (878s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-mmap-wc)
[141.264669] Starting subtest: fbc-rgb101010-draw-mmap-wc
[145.868186] Subtest fbc-rgb101010-draw-mmap-wc: SUCCESS (4.606s)
[146.976409] [036/133] (873s left) kms_flip (nonexisting-fb-interruptible)
[147.066971] Starting subtest: nonexisting-fb-interruptible
[147.069325] Starting dynamic subtest: A-eDP1
[148.251742] Dynamic subtest A-eDP1: SUCCESS (1.184s)
[148.259939] Starting dynamic subtest: B-eDP1
[149.395503] Dynamic subtest B-eDP1: SUCCESS (1.142s)
[149.409129] Starting dynamic subtest: C-eDP1
[150.530433] Dynamic subtest C-eDP1: SUCCESS (1.133s)
[150.538873] Starting dynamic subtest: D-eDP1
[151.669494] Dynamic subtest D-eDP1: SUCCESS (1.138s)
[151.671919] Subtest nonexisting-fb-interruptible: SUCCESS (4.606s)
[152.832113] [037/133] (867s left) gem_userptr_blits (readonly-pwrite-unsync)
[152.909092] Subtest readonly-pwrite-unsync: SKIP (0.000s)
[153.037516] [038/133] (867s left) gem_exec_balancer (waits)
[153.114678] Starting subtest: waits
[159.649938] Subtest waits: SUCCESS (6.533s)
[159.949953] [039/133] (860s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-render)
[160.050265] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-render
[167.339289] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-render: SUCCESS (7.292s)
[167.461140] [040/133] (852s left) kms_properties (colorop-properties-atomic)
[167.549947] Starting subtest: colorop-properties-atomic
[167.551831] Starting dynamic subtest: pipe-A-eDP-1
[167.906578] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.357s)
[167.917524] Starting dynamic subtest: pipe-B-eDP-1
[168.941086] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.031s)
[168.950058] Starting dynamic subtest: pipe-C-eDP-1
[169.994054] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.052s)
[170.003774] Starting dynamic subtest: pipe-D-eDP-1
[171.027936] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.034s)
[171.030306] Subtest colorop-properties-atomic: SUCCESS (3.479s)
[171.843814] [041/133] (848s left) gem_softpin (overlap)
[171.901159] Starting subtest: overlap
[172.795828] Subtest overlap: SUCCESS (0.893s)
[172.899755] [042/133] (847s left) syncobj_timeline (signal)
[172.959172] Starting subtest: signal
[172.961568] Subtest signal: SUCCESS (0.000s)
[173.049816] [043/133] (847s left) kms_psr2_sf (fbc-psr2-overlay-primary-update-sf-dmg-area)
[173.139993] Starting subtest: fbc-psr2-overlay-primary-update-sf-dmg-area
[173.142374] Starting dynamic subtest: pipe-A-eDP-1
[173.257806] Dynamic subtest pipe-A-eDP-1: SKIP (0.121s)
[173.268651] Starting dynamic subtest: pipe-B-eDP-1
[174.404546] Dynamic subtest pipe-B-eDP-1: SKIP (1.145s)
[174.408842] Subtest fbc-psr2-overlay-primary-update-sf-dmg-area: SKIP (1.268s)
[175.600347] [044/133] (844s left) kms_ccs (bad-aux-stride-y-tiled-gen12-rc-ccs-cc)
[175.691187] Starting subtest: bad-aux-stride-y-tiled-gen12-rc-ccs-cc
[175.693507] Starting dynamic subtest: pipe-A-eDP-1
[175.717913] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[175.729619] Starting dynamic subtest: pipe-B-eDP-1
[175.751598] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[175.759895] Starting dynamic subtest: pipe-C-eDP-1
[175.781572] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[175.789809] Starting dynamic subtest: pipe-D-eDP-1
[175.812359] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[175.818550] Subtest bad-aux-stride-y-tiled-gen12-rc-ccs-cc: SKIP (0.004s)
[177.893882] [045/133] (842s left) kms_cursor_legacy (torture-move)
[178.031928] Starting subtest: torture-move
[178.034126] Starting dynamic subtest: pipe-A
[183.902505] Dynamic subtest pipe-A: SUCCESS (5.867s)
[183.914643] Starting dynamic subtest: pipe-B
[190.378732] Dynamic subtest pipe-B: SUCCESS (6.477s)
[190.389612] Starting dynamic subtest: pipe-C
[197.844066] Dynamic subtest pipe-C: SUCCESS (7.462s)
[197.854936] Starting dynamic subtest: pipe-D
[204.610418] Dynamic subtest pipe-D: SUCCESS (6.764s)
[204.622817] Starting dynamic subtest: all-pipes
[212.101503] Dynamic subtest all-pipes: SUCCESS (7.490s)
[212.103937] Subtest torture-move: SUCCESS (34.068s)
[212.256861] [046/133] (808s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-indfb-msflip-blt)
[212.367057] Starting subtest: fbc-2p-scndscrn-indfb-msflip-blt
[212.371236] Subtest fbc-2p-scndscrn-indfb-msflip-blt: SKIP (0.000s)
[212.469446] [047/133] (808s left) gem_flink_race (flink_close)
[212.512051] Starting subtest: flink_close
[217.619794] Subtest flink_close: SUCCESS (5.107s)
[217.702663] [048/133] (802s left) kms_sequence (get-forked-busy)
[217.813979] Starting subtest: get-forked-busy
[217.816296] Starting dynamic subtest: pipe-A-eDP-1
[219.765935] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.949s)
[219.775241] Starting dynamic subtest: pipe-B-eDP-1
[222.370196] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.605s)
[222.381626] Starting dynamic subtest: pipe-C-eDP-1
[224.982451] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.609s)
[224.991871] Starting dynamic subtest: pipe-D-eDP-1
[227.606320] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.621s)
[227.608330] Subtest get-forked-busy: SUCCESS (9.791s)
[228.396444] [049/133] (792s left) kms_addfb_basic (unused-pitches)
[228.459801] Starting subtest: unused-pitches
[228.461690] Subtest unused-pitches: SUCCESS (0.000s)
[228.601042] [050/133] (792s left) api_intel_bb (blit-noreloc-purge-cache)
[228.652265] Starting subtest: blit-noreloc-purge-cache
[228.660812] Subtest blit-noreloc-purge-cache: SUCCESS (0.010s)
[228.744201] [051/133] (791s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-mmap-cpu)
[228.836170] Starting subtest: psr-1p-primscrn-cur-indfb-draw-mmap-cpu
[235.207125] Subtest psr-1p-primscrn-cur-indfb-draw-mmap-cpu: SUCCESS (6.373s)
[235.315445] [052/133] (785s left) kms_vrr (flip-basic)
[235.412504] Starting subtest: flip-basic
[235.419181] Subtest flip-basic: SKIP (0.000s)
[235.494629] [053/133] (785s left) kms_flip (flip-vs-absolute-wf_vblank)
[235.587486] Starting subtest: flip-vs-absolute-wf_vblank
[235.589822] Starting dynamic subtest: A-eDP1
[244.487465] Dynamic subtest A-eDP1: SUCCESS (8.902s)
[244.505045] Starting dynamic subtest: B-eDP1
[253.416611] Dynamic subtest B-eDP1: SUCCESS (8.926s)
[253.427285] Starting dynamic subtest: C-eDP1
[262.335041] Dynamic subtest C-eDP1: SUCCESS (8.915s)
[262.347344] Starting dynamic subtest: D-eDP1
[271.265957] Dynamic subtest D-eDP1: SUCCESS (8.928s)
[271.270580] Subtest flip-vs-absolute-wf_vblank: SUCCESS (35.684s)
[272.506083] [054/133] (748s left) gem_pread (exhaustion)
[272.569153] Subtest exhaustion: SKIP (0.000s)
[272.627439] [055/133] (748s left) kms_plane_multiple (2x-tiling-yf)
[272.724998] Starting subtest: 2x-tiling-yf
[272.729063] Subtest 2x-tiling-yf: SKIP (0.000s)
[272.792866] [056/133] (748s left) syncobj_wait (multi-wait-for-submit-unsubmitted-submitted)
[272.853201] Starting subtest: multi-wait-for-submit-unsubmitted-submitted
[272.952199] Subtest multi-wait-for-submit-unsubmitted-submitted: SUCCESS (0.101s)
[273.026479] [057/133] (747s left) kms_feature_discovery (display-1x)
[273.109675] Starting subtest: display-1x
[273.111934] Subtest display-1x: SUCCESS (0.000s)
[273.182186] [058/133] (747s left) kms_cursor_crc (cursor-rapid-movement-max-size)
[273.466868] Starting subtest: cursor-rapid-movement-max-size
[273.473386] Subtest cursor-rapid-movement-max-size: SKIP (0.000s)
[273.600382] [059/133] (747s left) tools_test (sysfs_l3_parity)
[273.650699] Starting subtest: sysfs_l3_parity
[273.715557] Subtest sysfs_l3_parity: SKIP (0.074s)
[273.767984] [060/133] (747s left) kms_psr (fbc-pr-primary-mmap-cpu)
[273.854064] Starting subtest: fbc-pr-primary-mmap-cpu
[273.858152] Subtest fbc-pr-primary-mmap-cpu: SKIP (0.000s)
[273.941199] [061/133] (747s left) perf (global-sseu-config)
[274.087762] Starting subtest: global-sseu-config
[274.091663] Subtest global-sseu-config: SKIP (0.000s)
[274.128894] [062/133] (746s left) gem_lmem_swapping (verify)
[274.170489] Subtest verify: SKIP (0.000s)
[274.222034] [063/133] (746s left) kms_plane_scaling (plane-upscale-factor-0-25-with-rotation)
[274.298286] Starting subtest: plane-upscale-factor-0-25-with-rotation
[274.300068] Starting dynamic subtest: pipe-A
[274.523083] Dynamic subtest pipe-A: SUCCESS (0.226s)
[274.532056] Starting dynamic subtest: pipe-B
[275.778990] Dynamic subtest pipe-B: SUCCESS (1.254s)
[275.792841] Starting dynamic subtest: pipe-C
[277.105077] Dynamic subtest pipe-C: SUCCESS (1.324s)
[277.114512] Starting dynamic subtest: pipe-D
[278.437678] Dynamic subtest pipe-D: SUCCESS (1.330s)
[278.440038] Subtest plane-upscale-factor-0-25-with-rotation: SUCCESS (4.142s)
[279.631562] [064/133] (741s left) gem_userptr_blits (nohangcheck)
[279.717599] Starting subtest: nohangcheck
[279.959353] Subtest nohangcheck: SUCCESS (0.241s)
[280.096777] [065/133] (741s left) gem_exec_schedule (u-submit-golden-slice)
[280.174350] Starting subtest: u-submit-golden-slice
[280.176696] Starting dynamic subtest: rcs0
[280.205807] Dynamic subtest rcs0: SUCCESS (0.035s)
[280.215505] Starting dynamic subtest: bcs0
[280.232513] Dynamic subtest bcs0: SUCCESS (0.026s)
[280.241500] Starting dynamic subtest: vcs0
[280.265913] Dynamic subtest vcs0: SUCCESS (0.032s)
[280.275187] Starting dynamic subtest: vcs1
[280.291247] Dynamic subtest vcs1: SUCCESS (0.025s)
[280.299986] Starting dynamic subtest: vecs0
[280.319509] Dynamic subtest vecs0: SUCCESS (0.028s)
[280.328191] Starting dynamic subtest: ccs0
[280.355658] Dynamic subtest ccs0: SUCCESS (0.035s)
[280.358178] Subtest u-submit-golden-slice: SUCCESS (0.185s)
[281.363636] [066/133] (739s left) kms_addfb_basic (addfb25-modifier-no-flag)
[281.453824] Starting subtest: addfb25-modifier-no-flag
[281.456097] Subtest addfb25-modifier-no-flag: SUCCESS (0.000s)
[281.544409] [067/133] (739s left) gem_render_copy (yf-tiled-to-vebox-x-tiled)
[281.609720] Starting subtest: yf-tiled-to-vebox-x-tiled
[281.614428] Subtest yf-tiled-to-vebox-x-tiled: SKIP (0.000s)
[281.803871] [068/133] (739s left) sw_sync (sync_multi_producer_single_consumer)
[281.843463] Starting subtest: sync_multi_producer_single_consumer
[282.914091] Subtest sync_multi_producer_single_consumer: SUCCESS (1.075s)
[282.985414] [069/133] (738s left) kms_psr (pr-primary-blt)
[283.086804] Starting subtest: pr-primary-blt
[283.091145] Subtest pr-primary-blt: SKIP (0.000s)
[283.157920] [070/133] (738s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-move)
[283.257741] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-move
[283.262243] Subtest fbcpsr-2p-primscrn-spr-indfb-move: SKIP (0.000s)
[283.356291] [071/133] (738s left) gem_exec_reloc (basic-wc-cpu-active)
[283.431456] Subtest basic-wc-cpu-active: SKIP (0.000s)
[283.513657] [072/133] (738s left) kms_getfb (getfb-handle-closed)
[283.615740] Starting subtest: getfb-handle-closed
[283.618064] Subtest getfb-handle-closed: SUCCESS (0.000s)
[283.717928] [073/133] (737s left) vgem_basic (dmabuf-mmap)
[283.769751] Starting subtest: dmabuf-mmap
[283.798252] Subtest dmabuf-mmap: SUCCESS (0.030s)
[283.854223] [074/133] (737s left) gem_ctx_param (invalid-set-ringsize)
[283.904886] Starting subtest: invalid-set-ringsize
[283.907308] Subtest invalid-set-ringsize: SUCCESS (0.000s)
[284.019102] [075/133] (737s left) gem_exec_reloc (basic-gtt-cpu-noreloc)
[284.097042] Subtest basic-gtt-cpu-noreloc: SKIP (0.000s)
[284.168928] [076/133] (737s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip)
[284.267798] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip
[285.037300] Subtest 4-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip: SUCCESS (0.770s)
[285.205180] [077/133] (736s left) i915_pm_rps (thresholds)
[285.260274] Starting subtest: thresholds
[285.264764] Subtest thresholds: SKIP (0.000s)
[285.333143] [078/133] (736s left) kms_frontbuffer_tracking (psr-rgb101010-draw-mmap-gtt)
[285.427495] Starting subtest: psr-rgb101010-draw-mmap-gtt
[285.431631] Subtest psr-rgb101010-draw-mmap-gtt: SKIP (0.000s)
[285.510065] [079/133] (736s left) kms_lease (lease-again)
[285.599261] Starting subtest: lease-again
[285.601487] Starting dynamic subtest: pipe-A-eDP-1
[285.603771] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.002s)
[285.616208] Starting dynamic subtest: pipe-B-eDP-1
[285.618056] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.002s)
[285.626414] Starting dynamic subtest: pipe-C-eDP-1
[285.628244] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.002s)
[285.636495] Starting dynamic subtest: pipe-D-eDP-1
[285.638400] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.002s)
[285.640268] Subtest lease-again: SUCCESS (0.012s)
[285.727129] [080/133] (736s left) kms_chamelium_edid (dp-edid-change-during-suspend)
[286.112392] Subtest dp-edid-change-during-suspend: SKIP (0.000s)
[286.936090] [081/133] (734s left) i915_pciid
[287.081574] [082/133] (734s left) gem_tiled_wb
[287.195942] [083/133] (734s left) gem_exec_reloc (basic-cpu-gtt)
[287.249579] Subtest basic-cpu-gtt: SKIP (0.000s)
[287.325508] [084/133] (734s left) kms_hdr (static-toggle)
[287.432083] Starting subtest: static-toggle
[287.438917] Subtest static-toggle: SKIP (0.001s)
[287.518692] [085/133] (734s left) api_intel_bb (delta-check)
[287.588466] Starting subtest: delta-check
[287.590501] Subtest delta-check: SUCCESS (0.005s)
[287.716632] [086/133] (734s left) kms_rotation_crc (multiplane-rotation-cropping-top)
[287.810340] Starting subtest: multiplane-rotation-cropping-top
[305.178989] Subtest multiplane-rotation-cropping-top: SUCCESS (17.371s)
[305.294741] [087/133] (716s left) kms_busy (extended-modeset-hang-newfb)
[305.396945] Starting subtest: extended-modeset-hang-newfb
[305.398688] Starting dynamic subtest: pipe-A
[340.232054] Dynamic subtest pipe-A: SUCCESS (34.831s)
[340.242772] Starting dynamic subtest: pipe-D
[363.215455] Dynamic subtest pipe-D: SUCCESS (22.983s)
[363.217833] Subtest extended-modeset-hang-newfb: SUCCESS (57.818s)
[364.017716] [088/133] (658s left) i915_drm_fdinfo (memory-info-purgeable)
[364.067030] Starting subtest: memory-info-purgeable
[364.069508] Starting dynamic subtest: smem0
[366.425786] Dynamic subtest smem0: SUCCESS (2.361s)
[366.428421] Subtest memory-info-purgeable: SUCCESS (2.361s)
[366.497496] [089/133] (655s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-0-async-flip)
[366.598312] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-0-async-flip
[367.234608] Subtest x-tiled-max-hw-stride-32bpp-rotate-0-async-flip: SUCCESS (0.637s)
[367.409163] [090/133] (654s left) perf (mi-rpc)
[367.507094] Starting subtest: mi-rpc
[367.511587] Subtest mi-rpc: SKIP (0.000s)
[367.554386] [091/133] (654s left) kms_cursor_legacy (short-flip-before-cursor-atomic-transitions)
[367.656651] Starting subtest: short-flip-before-cursor-atomic-transitions
[368.604767] Subtest short-flip-before-cursor-atomic-transitions: SUCCESS (0.947s)
[369.437655] [092/133] (652s left) vgem_basic (bad-handle)
[369.491279] Starting subtest: bad-handle
[369.493579] Subtest bad-handle: SUCCESS (0.000s)
[369.548376] [093/133] (652s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-blt)
[369.647109] Starting subtest: psr-2p-primscrn-spr-indfb-draw-blt
[369.651050] Subtest psr-2p-primscrn-spr-indfb-draw-blt: SKIP (0.000s)
[369.729696] [094/133] (652s left) gem_partial_pwrite_pread (reads-uncached)
[369.782081] Subtest reads-uncached: SKIP (0.000s)
[369.841275] [095/133] (652s left) kms_cursor_legacy (2x-long-cursor-vs-flip-atomic)
[369.953237] Starting subtest: 2x-long-cursor-vs-flip-atomic
[369.957583] Subtest 2x-long-cursor-vs-flip-atomic: SKIP (0.001s)
[370.094836] [096/133] (652s left) perf_pmu (busy-idle)
[370.143796] Starting subtest: busy-idle
[370.146236] Starting dynamic subtest: rcs0
[370.834930] Dynamic subtest rcs0: SUCCESS (0.693s)
[370.847095] Starting dynamic subtest: bcs0
[371.507583] Dynamic subtest bcs0: SUCCESS (0.670s)
[371.519900] Starting dynamic subtest: vcs0
[373.310052] Dynamic subtest vcs0: SUCCESS (1.798s)
[373.322571] Starting dynamic subtest: vcs1
[375.230425] Dynamic subtest vcs1: SUCCESS (1.917s)
[375.242875] Starting dynamic subtest: vecs0
[377.277631] Dynamic subtest vecs0: SUCCESS (2.044s)
[377.292792] Starting dynamic subtest: ccs0
[377.951074] Dynamic subtest ccs0: SUCCESS (0.669s)
[377.953518] Subtest busy-idle: SUCCESS (7.808s)
[378.057028] [097/133] (644s left) kms_big_fb (yf-tiled-8bpp-rotate-90)
[378.166030] Starting subtest: yf-tiled-8bpp-rotate-90
[378.170176] Subtest yf-tiled-8bpp-rotate-90: SKIP (0.000s)
[378.257416] [098/133] (644s left) syncobj_timeline (etime-multi-wait-all-for-submit-submitted-signaled)
[378.314042] Starting subtest: etime-multi-wait-all-for-submit-submitted-signaled
[378.417902] Subtest etime-multi-wait-all-for-submit-submitted-signaled: SUCCESS (0.103s)
[378.505582] [099/133] (644s left) gem_exec_schedule (preempt-other)
[378.590818] Starting subtest: preempt-other
[378.592800] Starting dynamic subtest: rcs0
[378.659353] Dynamic subtest rcs0: SUCCESS (0.074s)
[378.671757] Starting dynamic subtest: bcs0
[378.729429] Dynamic subtest bcs0: SUCCESS (0.069s)
[378.743519] Starting dynamic subtest: vcs0
[378.797355] Dynamic subtest vcs0: SUCCESS (0.067s)
[378.809622] Starting dynamic subtest: vcs1
[378.860682] Dynamic subtest vcs1: SUCCESS (0.063s)
[378.871321] Starting dynamic subtest: vecs0
[378.927348] Dynamic subtest vecs0: SUCCESS (0.065s)
[378.941224] Starting dynamic subtest: ccs0
[378.995785] Dynamic subtest ccs0: SUCCESS (0.067s)
[378.999279] Subtest preempt-other: SUCCESS (0.410s)
[380.374424] [100/133] (642s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-pwrite)
[380.474281] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-pwrite
[384.790378] Subtest fbc-1p-primscrn-cur-indfb-draw-pwrite: SUCCESS (4.319s)
[385.953749] [101/133] (636s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-pwrite)
[386.061732] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-pwrite
[393.140951] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-pwrite: SUCCESS (7.081s)
[393.264972] [102/133] (629s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-shrfb-draw-mmap-wc)
[393.374881] Starting subtest: fbc-1p-offscreen-pri-shrfb-draw-mmap-wc
[397.289712] Subtest fbc-1p-offscreen-pri-shrfb-draw-mmap-wc: SUCCESS (3.918s)
[398.436866] [103/133] (624s left) kms_hdr (bpc-switch-dpms)
[398.535618] Starting subtest: bpc-switch-dpms
[399.611715] Starting dynamic subtest: pipe-A-eDP-1-XRGB2101010
[404.143811] Dynamic subtest pipe-A-eDP-1-XRGB2101010: SUCCESS (4.534s)
[405.188981] Starting dynamic subtest: pipe-A-eDP-1-XRGB16161616F
[409.691984] Dynamic subtest pipe-A-eDP-1-XRGB16161616F: SUCCESS (4.511s)
[409.694333] Subtest bpc-switch-dpms: SUCCESS (11.157s)
[409.822928] [104/133] (613s left) kms_big_fb (4-tiled-8bpp-rotate-270)
[409.927463] Starting subtest: 4-tiled-8bpp-rotate-270
[409.947414] Subtest 4-tiled-8bpp-rotate-270: SKIP (0.020s)
[410.053304] [105/133] (612s left) kms_plane (pixel-format-y-tiled-ccs-modifier-source-clamping)
[410.144951] Starting subtest: pixel-format-y-tiled-ccs-modifier-source-clamping
[410.149089] Subtest pixel-format-y-tiled-ccs-modifier-source-clamping: SKIP (0.000s)
[410.214947] [106/133] (612s left) gem_readwrite (read-bad-handle)
[410.263464] Subtest read-bad-handle: SKIP (0.000s)
[410.321279] [107/133] (612s left) kms_pipe_b_c_ivb (enable-pipe-c-while-b-has-3-lanes)
[410.375723] Subtest enable-pipe-C-while-B-has-3-lanes: SKIP (0.000s)
[410.429919] [108/133] (612s left) gem_render_copy (yf-tiled)
[410.481230] Starting subtest: yf-tiled
[410.485680] Subtest yf-tiled: SKIP (0.000s)
[410.689554] [109/133] (612s left) kms_psr (fbc-psr-sprite-plane-move)
[410.786236] Starting subtest: fbc-psr-sprite-plane-move
[410.788537] Starting dynamic subtest: eDP-1
[410.792743] Dynamic subtest eDP-1: SKIP (0.000s)
[410.796981] Subtest fbc-psr-sprite-plane-move: SKIP (0.001s)
[410.864790] [110/133] (612s left) syncobj_timeline (multi-wait-for-submit-unsubmitted-signaled)
[410.926624] Starting subtest: multi-wait-for-submit-unsubmitted-signaled
[410.928657] Subtest multi-wait-for-submit-unsubmitted-signaled: SUCCESS (0.000s)
[411.018745] [111/133] (612s left) gem_mmap_offset (bad-object)
[411.072084] Starting subtest: bad-object
[411.074337] Subtest bad-object: SUCCESS (0.001s)
[411.172913] [112/133] (612s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-move)
[411.263660] Starting subtest: psr-2p-primscrn-cur-indfb-move
[411.268158] Subtest psr-2p-primscrn-cur-indfb-move: SKIP (0.000s)
[411.375976] [113/133] (611s left) kms_flip_scaled_crc (flip-64bpp-xtile-to-16bpp-xtile-upscaling)
[411.473139] Starting subtest: flip-64bpp-xtile-to-16bpp-xtile-upscaling
[411.475491] Starting dynamic subtest: pipe-A-default-mode
[414.209496] Dynamic subtest pipe-A-default-mode: SUCCESS (2.737s)
[414.212037] Subtest flip-64bpp-xtile-to-16bpp-xtile-upscaling: SUCCESS (2.739s)
[415.052161] [114/133] (608s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-cpu)
[415.161037] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-cpu
[415.165767] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[415.276398] [115/133] (608s left) kms_pm_rpm (modeset-non-lpsp-stress)
[417.409262] Starting subtest: modeset-non-lpsp-stress
[418.554897] Subtest modeset-non-lpsp-stress: SKIP (1.146s)
[418.925243] [116/133] (604s left) sw_sync (alloc_merge_fence)
[418.970220] Starting subtest: alloc_merge_fence
[418.972743] Subtest alloc_merge_fence: SUCCESS (0.000s)
[419.019579] [117/133] (604s left) kms_pm_dc (dc6-dpms)
[420.127940] Starting subtest: dc6-dpms
[422.197936] Subtest dc6-dpms: SUCCESS (2.069s)
[422.279365] [118/133] (601s left) kms_psr (psr2-primary-mmap-cpu)
[422.376235] Starting subtest: psr2-primary-mmap-cpu
[422.378571] Starting dynamic subtest: eDP-1
[424.135543] Dynamic subtest eDP-1: SUCCESS (1.758s)
[424.137778] Subtest psr2-primary-mmap-cpu: SUCCESS (1.758s)
[425.020092] [119/133] (598s left) kms_flip (dpms-vs-vblank-race-interruptible)
[425.111469] Starting subtest: dpms-vs-vblank-race-interruptible
[425.113807] Starting dynamic subtest: A-eDP1
[430.008575] Dynamic subtest A-eDP1: SUCCESS (4.894s)
[430.018654] Starting dynamic subtest: B-eDP1
[434.629514] Dynamic subtest B-eDP1: SUCCESS (4.620s)
[434.639159] Starting dynamic subtest: C-eDP1
[439.236363] Dynamic subtest C-eDP1: SUCCESS (4.606s)
[439.249878] Starting dynamic subtest: D-eDP1
[443.861948] Dynamic subtest D-eDP1: SUCCESS (4.623s)
[443.867220] Subtest dpms-vs-vblank-race-interruptible: SUCCESS (18.756s)
[444.753220] [120/133] (578s left) gem_userptr_blits (dmabuf-sync)
[444.821580] Starting subtest: dmabuf-sync
[444.826229] Subtest dmabuf-sync: SKIP (0.002s)
[444.962929] [121/133] (578s left) gem_ctx_shared (q-in-order)
[445.037121] Starting subtest: Q-in-order
[445.039495] Starting dynamic subtest: rcs0
[445.133359] Dynamic subtest rcs0: SUCCESS (0.098s)
[445.150574] Starting dynamic subtest: vcs0
[445.223415] Dynamic subtest vcs0: SUCCESS (0.089s)
[445.238225] Starting dynamic subtest: vcs1
[445.303869] Dynamic subtest vcs1: SUCCESS (0.080s)
[445.322914] Starting dynamic subtest: vecs0
[445.381994] Dynamic subtest vecs0: SUCCESS (0.077s)
[445.397067] Starting dynamic subtest: ccs0
[445.461530] Dynamic subtest ccs0: SUCCESS (0.078s)
[445.464714] Subtest Q-in-order: SUCCESS (0.427s)
[446.367252] [122/133] (577s left) syncobj_timeline (multi-wait-all-available-submitted)
[446.421126] Starting subtest: multi-wait-all-available-submitted
[446.423456] Subtest multi-wait-all-available-submitted: SUCCESS (0.000s)
[446.518378] [123/133] (577s left) gen9_exec_parse (bb-large)
[446.576421] Subtest bb-large: SKIP (0.000s)
[446.646297] [124/133] (577s left) kms_cursor_crc (cursor-onscreen-512x512)
[446.949912] Starting subtest: cursor-onscreen-512x512
[446.954406] Subtest cursor-onscreen-512x512: SKIP (0.002s)
[447.122622] [125/133] (576s left) i915_pm_rpm (system-suspend-devices)
[448.650446] Starting subtest: system-suspend-devices
[456.480848] Subtest system-suspend-devices: SUCCESS (7.830s)
[456.870474] [126/133] (566s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-wc)
[456.991705] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-wc
[456.995693] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[457.106020] [127/133] (566s left) gem_softpin (allocator-nopin-reserve)
[457.160231] Starting subtest: allocator-nopin-reserve
[457.253739] Subtest allocator-nopin-reserve: SUCCESS (0.094s)
[457.392433] [128/133] (566s left) kms_flip (2x-flip-vs-dpms)
[457.486204] Starting subtest: 2x-flip-vs-dpms
[457.493470] Subtest 2x-flip-vs-dpms: SKIP (0.010s)
[457.615472] [129/133] (566s left) kms_addfb_basic (addfb25-yf-tiled-legacy)
[457.723302] Starting subtest: addfb25-yf-tiled-legacy
[457.725063] Subtest addfb25-yf-tiled-legacy: SUCCESS (0.000s)
[457.804814] [130/133] (566s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-mmap-wc)
[457.894943] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-mmap-wc
[457.898397] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[457.993276] [131/133] (566s left) kms_async_flips (test-time-stamp-atomic)
[458.085026] Starting subtest: test-time-stamp-atomic
[458.457453] Starting dynamic subtest: pipe-A-eDP-1
[459.259306] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.800s)
[459.644370] Starting dynamic subtest: pipe-B-eDP-1
[460.403028] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.764s)
[460.778976] Starting dynamic subtest: pipe-C-eDP-1
[461.527843] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.754s)
[461.889937] Starting dynamic subtest: pipe-D-eDP-1
[462.663773] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.779s)
[462.666056] Subtest test-time-stamp-atomic: SUCCESS (4.580s)
[463.822996] [132/133] (560s left) gem_lmem_swapping (heavy-verify-multi)
[463.873406] Subtest heavy-verify-multi: SKIP (0.000s)
[463.917024] [133/133] (560s left) kms_frontbuffer_tracking (psr-2p-rte)
[464.007786] Starting subtest: psr-2p-rte
[464.012046] Subtest psr-2p-rte: SKIP (0.000s)
[464.096922] Closing watchdogs
results: parsing output: 0/ for test: kms_ccs
results: parsing output: 1/ for test: kms_plane
results: parsing output: 2/ for test: gem_create
results: parsing output: 3/ for test: kms_big_fb
results: parsing output: 4/ for test: gem_pipe_control_store_loop
results: parsing output: 5/ for test: kms_getfb
results: parsing output: 6/ for test: kms_big_fb
results: parsing output: 7/ for test: syncobj_timeline
results: parsing output: 8/ for test: kms_flip
results: parsing output: 9/ for test: kms_chamelium_hpd
results: parsing output: 10/ for test: prime_busy
results: parsing output: 11/ for test: kms_ccs
results: parsing output: 12/ for test: gem_exec_fence
results: parsing output: 13/ for test: gem_ccs
results: parsing output: 14/ for test: gem_exec_params
results: parsing output: 15/ for test: syncobj_wait
results: parsing output: 16/ for test: gem_exec_schedule
results: parsing output: 17/ for test: kms_cursor_legacy
results: parsing output: 18/ for test: kms_frontbuffer_tracking
results: parsing output: 19/ for test: syncobj_wait
results: parsing output: 20/ for test: gem_exec_balancer
results: parsing output: 21/ for test: kms_plane_alpha_blend
results: parsing output: 22/ for test: kms_psr
results: parsing output: 23/ for test: kms_content_protection
results: parsing output: 24/ for test: kms_ccs
results: parsing output: 25/ for test: gem_ctx_persistence
results: parsing output: 26/ for test: kms_cursor_edge_walk
results: parsing output: 27/ for test: dmabuf
results: parsing output: 28/ for test: kms_ccs
results: parsing output: 29/ for test: kms_color_pipeline
results: parsing output: 30/ for test: gem_exec_await
results: parsing output: 31/ for test: gem_basic
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: kms_flip
results: parsing output: 36/ for test: gem_userptr_blits
results: parsing output: 37/ for test: gem_exec_balancer
results: parsing output: 38/ for test: kms_frontbuffer_tracking
results: parsing output: 39/ for test: kms_properties
results: parsing output: 40/ for test: gem_softpin
results: parsing output: 41/ for test: syncobj_timeline
results: parsing output: 42/ for test: kms_psr2_sf
results: parsing output: 43/ for test: kms_ccs
results: parsing output: 44/ for test: kms_cursor_legacy
results: parsing output: 45/ for test: kms_frontbuffer_tracking
results: parsing output: 46/ for test: gem_flink_race
results: parsing output: 47/ for test: kms_sequence
results: parsing output: 48/ for test: kms_addfb_basic
results: parsing output: 49/ for test: api_intel_bb
results: parsing output: 50/ for test: kms_frontbuffer_tracking
results: parsing output: 51/ for test: kms_vrr
results: parsing output: 52/ for test: kms_flip
results: parsing output: 53/ for test: gem_pread
results: parsing output: 54/ for test: kms_plane_multiple
results: parsing output: 55/ for test: syncobj_wait
results: parsing output: 56/ for test: kms_feature_discovery
results: parsing output: 57/ for test: kms_cursor_crc
results: parsing output: 58/ for test: tools_test
results: parsing output: 59/ for test: kms_psr
results: parsing output: 60/ for test: perf
results: parsing output: 61/ for test: gem_lmem_swapping
results: parsing output: 62/ for test: kms_plane_scaling
results: parsing output: 63/ for test: gem_userptr_blits
results: parsing output: 64/ for test: gem_exec_schedule
results: parsing output: 65/ for test: kms_addfb_basic
results: parsing output: 66/ for test: gem_render_copy
results: parsing output: 67/ for test: sw_sync
results: parsing output: 68/ for test: kms_psr
results: parsing output: 69/ for test: kms_frontbuffer_tracking
results: parsing output: 70/ for test: gem_exec_reloc
results: parsing output: 71/ for test: kms_getfb
results: parsing output: 72/ for test: vgem_basic
results: parsing output: 73/ for test: gem_ctx_param
results: parsing output: 74/ for test: gem_exec_reloc
results: parsing output: 75/ for test: kms_big_fb
results: parsing output: 76/ for test: i915_pm_rps
results: parsing output: 77/ for test: kms_frontbuffer_tracking
results: parsing output: 78/ for test: kms_lease
results: parsing output: 79/ for test: kms_chamelium_edid
results: parsing output: 80/ for test: i915_pciid
results: parsing output: 81/ for test: gem_tiled_wb
results: parsing output: 82/ for test: gem_exec_reloc
results: parsing output: 83/ for test: kms_hdr
results: parsing output: 84/ for test: api_intel_bb
results: parsing output: 85/ for test: kms_rotation_crc
results: parsing output: 86/ for test: kms_busy
results: parsing output: 87/ for test: i915_drm_fdinfo
results: parsing output: 88/ for test: kms_big_fb
results: parsing output: 89/ for test: perf
results: parsing output: 90/ for test: kms_cursor_legacy
results: parsing output: 91/ for test: vgem_basic
results: parsing output: 92/ for test: kms_frontbuffer_tracking
results: parsing output: 93/ for test: gem_partial_pwrite_pread
results: parsing output: 94/ for test: kms_cursor_legacy
results: parsing output: 95/ for test: perf_pmu
results: parsing output: 96/ for test: kms_big_fb
results: parsing output: 97/ for test: syncobj_timeline
results: parsing output: 98/ for test: gem_exec_schedule
results: parsing output: 99/ for test: kms_frontbuffer_tracking
results: parsing output: 100/ for test: kms_frontbuffer_tracking
results: parsing output: 101/ for test: kms_frontbuffer_tracking
results: parsing output: 102/ for test: kms_hdr
results: parsing output: 103/ for test: kms_big_fb
results: parsing output: 104/ for test: kms_plane
results: parsing output: 105/ for test: gem_readwrite
results: parsing output: 106/ for test: kms_pipe_b_c_ivb
results: parsing output: 107/ for test: gem_render_copy
results: parsing output: 108/ for test: kms_psr
results: parsing output: 109/ for test: syncobj_timeline
results: parsing output: 110/ for test: gem_mmap_offset
results: parsing output: 111/ for test: kms_frontbuffer_tracking
results: parsing output: 112/ for test: kms_flip_scaled_crc
results: parsing output: 113/ for test: kms_frontbuffer_tracking
results: parsing output: 114/ for test: kms_pm_rpm
results: parsing output: 115/ for test: sw_sync
results: parsing output: 116/ for test: kms_pm_dc
results: parsing output: 117/ for test: kms_psr
results: parsing output: 118/ for test: kms_flip
results: parsing output: 119/ for test: gem_userptr_blits
results: parsing output: 120/ for test: gem_ctx_shared
results: parsing output: 121/ for test: syncobj_timeline
results: parsing output: 122/ for test: gen9_exec_parse
results: parsing output: 123/ for test: kms_cursor_crc
results: parsing output: 124/ for test: i915_pm_rpm
results: parsing output: 125/ for test: kms_frontbuffer_tracking
results: parsing output: 126/ for test: gem_softpin
results: parsing output: 127/ for test: kms_flip
results: parsing output: 128/ for test: kms_addfb_basic
results: parsing output: 129/ for test: kms_frontbuffer_tracking
results: parsing output: 130/ for test: kms_async_flips
results: parsing output: 131/ for test: gem_lmem_swapping
results: parsing output: 132/ for test: kms_frontbuffer_tracking
Done.