[56.764816] Initializing watchdogs
[56.764903]   /dev/watchdog0
[56.779180] [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]
[56.783430] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[56.785815] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[56.789085] [001/133] (960s left) kms_plane (pixel-format-4-tiled-mtl-mc-ccs-modifier-source-clamping)
[56.900323] Starting subtest: pixel-format-4-tiled-mtl-mc-ccs-modifier-source-clamping
[56.939537] Starting dynamic subtest: pipe-A-plane-0
[57.394641] Dynamic subtest pipe-A-plane-0: SUCCESS (0.456s)
[57.403110] Starting dynamic subtest: pipe-A-plane-3
[57.649475] Dynamic subtest pipe-A-plane-3: SUCCESS (0.255s)
[58.790518] Starting dynamic subtest: pipe-B-plane-0
[59.215836] Dynamic subtest pipe-B-plane-0: SUCCESS (0.433s)
[59.224060] Starting dynamic subtest: pipe-B-plane-3
[59.482706] Dynamic subtest pipe-B-plane-3: SUCCESS (0.266s)
[59.805256] Subtest pixel-format-4-tiled-mtl-mc-ccs-modifier-source-clamping: SUCCESS (2.907s)
[60.673387] [002/133] (956s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-0-async-flip)
[60.780560] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-0-async-flip
[60.784964] Subtest y-tiled-max-hw-stride-32bpp-rotate-0-async-flip: SKIP (0.000s)
[60.917298] [003/133] (956s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-180-async-flip)
[61.013468] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-180-async-flip
[61.017628] Subtest y-tiled-max-hw-stride-64bpp-rotate-180-async-flip: SKIP (0.000s)
[61.111529] [004/133] (956s left) prime_mmap_coherency (ioctl-errors)
[61.183858] Starting subtest: ioctl-errors
[76.491480] Subtest ioctl-errors: SUCCESS (15.320s)
[76.700922] [005/133] (940s left) perf (non-sampling-read-error)
[76.899914] Starting subtest: non-sampling-read-error
[76.909826] Subtest non-sampling-read-error: SUCCESS (0.010s)
[76.952284] [006/133] (940s left) core_getversion (basic)
[76.987811] Starting subtest: basic
[76.992158] Subtest basic: SUCCESS (0.000s)
[77.066204] [007/133] (940s left) kms_flip (2x-flip-vs-dpms-off-vs-modeset)
[77.177174] Starting subtest: 2x-flip-vs-dpms-off-vs-modeset
[77.188218] Subtest 2x-flip-vs-dpms-off-vs-modeset: SKIP (0.011s)
[77.313826] [008/133] (940s left) api_intel_allocator (execbuf-with-allocator)
[77.378050] Starting subtest: execbuf-with-allocator
[77.385300] Subtest execbuf-with-allocator: SUCCESS (0.009s)
[77.562021] [009/133] (940s left) tools_test (sysfs_l3_parity)
[77.618774] Starting subtest: sysfs_l3_parity
[77.709050] Subtest sysfs_l3_parity: SKIP (0.104s)
[77.785376] [010/133] (939s left) kms_invalid_mode (bad-htotal)
[77.890790] Starting subtest: bad-htotal
[77.892807] Starting dynamic subtest: pipe-A-eDP-1
[78.171476] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.284s)
[78.181241] Starting dynamic subtest: pipe-B-eDP-1
[78.183486] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[78.190897] Starting dynamic subtest: pipe-C-eDP-1
[78.193662] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[78.201096] Starting dynamic subtest: pipe-D-eDP-1
[78.203438] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[78.205757] Subtest bad-htotal: SUCCESS (0.288s)
[78.983789] [011/133] (938s left) kms_getfb (getfb2-handle-closed)
[79.078200] Starting subtest: getfb2-handle-closed
[79.080664] Subtest getfb2-handle-closed: SUCCESS (0.000s)
[79.210043] [012/133] (938s left) gen3_mixed_blits
[79.341907] [013/133] (938s left) kms_frontbuffer_tracking (psr-1p-primscrn-indfb-pgflip-blt)
[79.432984] Starting subtest: psr-1p-primscrn-indfb-pgflip-blt
[86.778340] Subtest psr-1p-primscrn-indfb-pgflip-blt: SUCCESS (7.350s)
[86.931399] [014/133] (930s left) kms_cursor_crc (cursor-tearing-position-change)
[87.079995] Starting subtest: cursor-tearing-position-change
[87.082457] Starting dynamic subtest: pipe-A-eDP-1
[87.657317] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.575s)
[87.667287] Starting dynamic subtest: pipe-D-eDP-1
[88.933828] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.275s)
[88.935840] Subtest cursor-tearing-position-change: SUCCESS (1.852s)
[89.780443] [015/133] (928s left) kms_flip (absolute-wf_vblank)
[89.884770] Starting subtest: absolute-wf_vblank
[89.887169] Starting dynamic subtest: A-eDP1
[98.616417] Dynamic subtest A-eDP1: SUCCESS (8.732s)
[98.629804] Starting dynamic subtest: B-eDP1
[107.349818] Dynamic subtest B-eDP1: SUCCESS (8.733s)
[107.360323] Starting dynamic subtest: C-eDP1
[116.070107] Dynamic subtest C-eDP1: SUCCESS (8.718s)
[116.089713] Starting dynamic subtest: D-eDP1
[124.795184] Dynamic subtest D-eDP1: SUCCESS (8.723s)
[124.797640] Subtest absolute-wf_vblank: SUCCESS (34.915s)
[126.022044] [016/133] (891s left) kms_pm_backlight (basic-brightness)
[126.134123] Starting subtest: basic-brightness
[126.185505] Starting dynamic subtest: eDP-1
[126.686791] Dynamic subtest eDP-1: SUCCESS (0.503s)
[126.689069] Subtest basic-brightness: SUCCESS (0.555s)
[127.544133] [017/133] (890s left) kms_color (ctm-max)
[127.635264] Starting subtest: ctm-max
[127.637510] Starting dynamic subtest: pipe-A-eDP-1
[128.341664] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.703s)
[128.350490] Starting dynamic subtest: pipe-B-eDP-1
[129.737865] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.398s)
[129.746763] Starting dynamic subtest: pipe-C-eDP-1
[131.137187] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.397s)
[131.145825] Starting dynamic subtest: pipe-D-eDP-1
[132.464275] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.327s)
[132.466183] Subtest ctm-max: SUCCESS (4.827s)
[133.280838] [018/133] (884s left) gem_exec_params (rel-constants-invalid)
[133.346806] Starting subtest: rel-constants-invalid
[133.349137] Subtest rel-constants-invalid: SUCCESS (0.000s)
[133.471429] [019/133] (884s left) gem_exec_schedule (noreorder-corked)
[133.649954] Starting subtest: noreorder-corked
[133.652803] Starting dynamic subtest: rcs0
[134.829810] Dynamic subtest rcs0: SUCCESS (1.180s)
[134.840552] Starting dynamic subtest: vcs0
[137.901596] Dynamic subtest vcs0: SUCCESS (3.068s)
[137.913109] Starting dynamic subtest: vcs1
[139.955558] Dynamic subtest vcs1: SUCCESS (2.052s)
[139.966201] Starting dynamic subtest: vecs0
[141.934535] Dynamic subtest vecs0: SUCCESS (1.977s)
[141.949493] Starting dynamic subtest: ccs0
[143.098959] Dynamic subtest ccs0: SUCCESS (1.163s)
[143.101793] Subtest noreorder-corked: SUCCESS (9.450s)
[143.304207] [020/133] (874s left) gem_mmap_gtt (cpuset-medium-copy-xy)
[143.369233] Subtest cpuset-medium-copy-XY: SKIP (0.000s)
[143.445931] [021/133] (874s left) kms_chamelium_frames (hdmi-cmp-planar-formats)
[143.851541] Subtest hdmi-cmp-planar-formats: SKIP (0.000s)
[144.676075] [022/133] (873s left) gem_exec_whisper (basic-contexts-priority-all)
[144.759227] Starting subtest: basic-contexts-priority-all
[166.014153] Subtest basic-contexts-priority-all: SUCCESS (21.252s)
[166.207120] [023/133] (851s left) gen9_exec_parse (allowed-all)
[166.277143] Subtest allowed-all: SKIP (0.000s)
[166.338266] [024/133] (851s left) perf_pmu (busy-accuracy-98)
[166.372450] Starting subtest: busy-accuracy-98
[166.374361] Starting dynamic subtest: rcs0
[169.410588] Dynamic subtest rcs0: SUCCESS (3.037s)
[169.419174] Starting dynamic subtest: bcs0
[172.461512] Dynamic subtest bcs0: SUCCESS (3.049s)
[172.471306] Starting dynamic subtest: vcs0
[175.505069] Dynamic subtest vcs0: SUCCESS (3.041s)
[175.515843] Starting dynamic subtest: vcs1
[178.546812] Dynamic subtest vcs1: SUCCESS (3.040s)
[178.557555] Starting dynamic subtest: vecs0
[181.587727] Dynamic subtest vecs0: SUCCESS (3.038s)
[181.596383] Starting dynamic subtest: ccs0
[184.638125] Dynamic subtest ccs0: SUCCESS (3.048s)
[184.640220] Subtest busy-accuracy-98: SUCCESS (18.265s)
[184.814805] [025/133] (833s left) gem_workarounds (suspend-resume-fd)
[184.886361] Starting subtest: suspend-resume-fd
[201.132988] Subtest suspend-resume-fd: SUCCESS (1.494s)
[201.288405] [026/133] (816s left) kms_psr (fbc-pr-sprite-plane-move)
[201.408323] Starting subtest: fbc-pr-sprite-plane-move
[201.412710] Subtest fbc-pr-sprite-plane-move: SKIP (0.000s)
[201.505301] [027/133] (816s left) syncobj_wait (invalid-wait-bad-flags)
[201.576693] Starting subtest: invalid-wait-bad-flags
[201.578668] Subtest invalid-wait-bad-flags: SUCCESS (0.000s)
[201.709908] [028/133] (816s left) kms_frontbuffer_tracking (fbc-rgb565-draw-mmap-wc)
[201.821335] Starting subtest: fbc-rgb565-draw-mmap-wc
[205.863975] Subtest fbc-rgb565-draw-mmap-wc: SUCCESS (4.054s)
[206.992075] [029/133] (811s left) kms_addfb_basic (unused-offsets)
[207.062302] Starting subtest: unused-offsets
[207.064955] Subtest unused-offsets: SUCCESS (0.000s)
[207.227602] [030/133] (811s left) syncobj_wait (invalid-multi-wait-all-unsubmitted-submitted-signaled)
[207.288521] Starting subtest: invalid-multi-wait-all-unsubmitted-submitted-signaled
[207.290765] Subtest invalid-multi-wait-all-unsubmitted-submitted-signaled: SUCCESS (0.000s)
[207.418939] [031/133] (811s left) kms_psr (fbc-pr-cursor-plane-move)
[207.509582] Starting subtest: fbc-pr-cursor-plane-move
[207.513835] Subtest fbc-pr-cursor-plane-move: SKIP (0.000s)
[207.590709] [032/133] (810s left) kms_psr (psr-cursor-render)
[207.683680] Starting subtest: psr-cursor-render
[207.685983] Starting dynamic subtest: eDP-1
[209.364955] Dynamic subtest eDP-1: SUCCESS (1.682s)
[209.367275] Subtest psr-cursor-render: SUCCESS (1.683s)
[210.242158] [033/133] (808s left) kms_flip (2x-dpms-vs-vblank-race-interruptible)
[210.349174] Starting subtest: 2x-dpms-vs-vblank-race-interruptible
[210.361618] Subtest 2x-dpms-vs-vblank-race-interruptible: SKIP (0.011s)
[210.497329] [034/133] (808s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-wc)
[210.593232] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-wc
[210.597488] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[210.714844] [035/133] (807s left) kms_flip_scaled_crc (flip-64bpp-yftile-to-32bpp-yftile-downscaling)
[210.826470] Starting subtest: flip-64bpp-yftile-to-32bpp-yftile-downscaling
[210.830477] Subtest flip-64bpp-yftile-to-32bpp-yftile-downscaling: SKIP (0.000s)
[210.914619] [036/133] (807s left) kms_addfb_basic (invalid-get-prop)
[210.980871] Starting subtest: invalid-get-prop
[210.983075] Subtest invalid-get-prop: SUCCESS (0.000s)
[211.161654] [037/133] (807s left) gem_softpin (evict-prime-sanity-check)
[211.228056] Starting subtest: evict-prime-sanity-check
[211.229951] Starting dynamic subtest: rcs0
[212.413481] Dynamic subtest rcs0: SUCCESS (1.185s)
[212.425034] Starting dynamic subtest: bcs0
[213.556403] Dynamic subtest bcs0: SUCCESS (1.142s)
[213.567630] Starting dynamic subtest: vcs0
[215.625203] Dynamic subtest vcs0: SUCCESS (2.067s)
[215.637143] Starting dynamic subtest: vcs1
[217.665605] Dynamic subtest vcs1: SUCCESS (2.040s)
[217.677578] Starting dynamic subtest: vecs0
[219.624761] Dynamic subtest vecs0: SUCCESS (1.958s)
[219.636951] Starting dynamic subtest: ccs0
[220.779296] Dynamic subtest ccs0: SUCCESS (1.154s)
[220.790750] Starting dynamic subtest: all
[221.927901] Dynamic subtest all: SUCCESS (1.147s)
[221.930508] Subtest evict-prime-sanity-check: SUCCESS (10.707s)
[222.021552] [038/133] (796s left) i915_suspend (fence-restore-untiled)
[222.089064] Starting subtest: fence-restore-untiled
[222.093673] Subtest fence-restore-untiled: SKIP (0.000s)
[222.213806] [039/133] (796s left) kms_psr (psr-sprite-mmap-gtt)
[222.305137] Starting subtest: psr-sprite-mmap-gtt
[222.307384] Starting dynamic subtest: eDP-1
[223.751793] Dynamic subtest eDP-1: SKIP (1.442s)
[223.756832] Subtest psr-sprite-mmap-gtt: SKIP (1.444s)
[223.918560] [040/133] (794s left) gem_userptr_blits (unsync-unmap)
[223.978063] Subtest unsync-unmap: SKIP (0.000s)
[224.128131] [041/133] (794s left) gem_exec_balancer (bonded-true-hang)
[224.389104] Starting subtest: bonded-true-hang
[224.394957] Subtest bonded-true-hang: SKIP (0.000s)
[224.519342] [042/133] (794s left) gem_lmem_swapping (parallel-random-engines)
[224.560784] Subtest parallel-random-engines: SKIP (0.000s)
[224.600887] [043/133] (794s left) gem_render_copy (y-tiled-mc-ccs-to-y-tiled-ccs)
[224.671186] Starting subtest: y-tiled-mc-ccs-to-y-tiled-ccs
[224.675366] Subtest y-tiled-mc-ccs-to-y-tiled-ccs: SKIP (0.000s)
[224.865698] [044/133] (794s left) syncobj_timeline (etime-single-wait-all-submitted)
[224.923460] Starting subtest: etime-single-wait-all-submitted
[225.027755] Subtest etime-single-wait-all-submitted: SUCCESS (0.104s)
[225.149666] [045/133] (793s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-blt)
[225.260526] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-blt
[225.264698] Subtest psr-2p-scndscrn-spr-indfb-draw-blt: SKIP (0.000s)
[225.377848] [046/133] (793s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-mmap-cpu)
[225.478744] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-mmap-cpu
[225.482978] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[225.614600] [047/133] (793s left) kms_cursor_legacy (short-busy-flip-before-cursor-toggle)
[225.751323] Starting subtest: short-busy-flip-before-cursor-toggle
[225.755702] Subtest short-busy-flip-before-cursor-toggle: SKIP (0.000s)
[225.929910] [048/133] (793s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-wc)
[226.030871] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-wc
[233.121929] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-wc: SUCCESS (7.096s)
[233.265786] [049/133] (785s left) kms_ccs (bad-pixel-format-y-tiled-gen12-rc-ccs)
[233.365545] Starting subtest: bad-pixel-format-y-tiled-gen12-rc-ccs
[233.367741] Starting dynamic subtest: pipe-A-eDP-1
[233.390315] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[233.402124] Starting dynamic subtest: pipe-B-eDP-1
[233.423640] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[233.432899] Starting dynamic subtest: pipe-C-eDP-1
[233.454476] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[233.463641] Starting dynamic subtest: pipe-D-eDP-1
[233.485473] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[233.489467] Subtest bad-pixel-format-y-tiled-gen12-rc-ccs: SKIP (0.004s)
[235.617816] [050/133] (783s left) kms_ccs (ccs-on-another-bo-4-tiled-mtl-rc-ccs-cc)
[235.725810] Starting subtest: ccs-on-another-bo-4-tiled-mtl-rc-ccs-cc
[235.728007] Starting dynamic subtest: pipe-A-eDP-1
[235.748615] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[235.759675] Starting dynamic subtest: pipe-B-eDP-1
[235.779366] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[235.788865] Starting dynamic subtest: pipe-C-eDP-1
[235.808626] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[235.818253] Starting dynamic subtest: pipe-D-eDP-1
[235.838983] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[235.841381] Subtest ccs-on-another-bo-4-tiled-mtl-rc-ccs-cc: SUCCESS (0.008s)
[237.974201] [051/133] (781s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-mmap-cpu)
[238.071797] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-mmap-cpu
[238.075856] Subtest psr-2p-scndscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[238.207076] [052/133] (781s left) gem_partial_pwrite_pread (reads-snoop)
[238.274594] Subtest reads-snoop: SKIP (0.000s)
[238.355506] [053/133] (781s left) syncobj_timeline (invalid-query-illegal-handle)
[238.420910] Starting subtest: invalid-query-illegal-handle
[238.423284] Subtest invalid-query-illegal-handle: SUCCESS (0.000s)
[238.569220] [054/133] (780s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-onoff)
[238.671158] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-onoff
[245.731780] Subtest fbcpsr-1p-primscrn-spr-indfb-onoff: SUCCESS (7.072s)
[245.911082] [055/133] (773s left) kms_lease (lease-unleased-connector)
[246.014601] Starting subtest: lease-unleased-connector
[246.016870] Starting dynamic subtest: pipe-A-eDP-1
[246.021976] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.006s)
[246.031961] Starting dynamic subtest: pipe-B-eDP-1
[246.034508] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.006s)
[246.044832] Starting dynamic subtest: pipe-C-eDP-1
[246.046987] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.006s)
[246.055807] Starting dynamic subtest: pipe-D-eDP-1
[246.057709] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.006s)
[246.059593] Subtest lease-unleased-connector: SUCCESS (0.030s)
[246.170470] [056/133] (773s left) syncobj_wait (invalid-single-wait-unsubmitted)
[246.232818] Starting subtest: invalid-single-wait-unsubmitted
[246.234717] Subtest invalid-single-wait-unsubmitted: SUCCESS (0.000s)
[246.371152] [057/133] (773s left) gem_mmap_gtt (ptrace)
[246.425752] Subtest ptrace: SKIP (0.000s)
[246.493443] [058/133] (773s left) syncobj_timeline (multi-wait-submitted-signaled)
[246.553845] Starting subtest: multi-wait-submitted-signaled
[246.556130] Subtest multi-wait-submitted-signaled: SUCCESS (0.001s)
[246.662566] [059/133] (772s left) gem_madvise (dontneed-before-exec)
[246.695277] Starting subtest: dontneed-before-exec
[246.719206] Subtest dontneed-before-exec: SKIP (0.022s)
[246.788565] [060/133] (772s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-mmap-cpu)
[246.889053] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-mmap-cpu
[246.892709] Subtest psr-2p-primscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[247.001503] [061/133] (772s left) gem_ccs (ctrl-surf-copy-new-ctx)
[247.060114] Starting subtest: ctrl-surf-copy-new-ctx
[247.063795] Subtest ctrl-surf-copy-new-ctx: SKIP (0.000s)
[247.179023] [062/133] (772s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-pwrite)
[247.279553] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-pwrite
[251.698562] Subtest fbc-1p-primscrn-spr-indfb-draw-pwrite: SUCCESS (4.425s)
[252.896587] [063/133] (766s left) syncobj_wait (single-wait-all-for-submit-signaled)
[252.956563] Starting subtest: single-wait-all-for-submit-signaled
[252.958879] Subtest single-wait-all-for-submit-signaled: SUCCESS (0.000s)
[253.072850] [064/133] (766s left) gem_ctx_isolation (nonpriv-switch)
[253.137860] Starting subtest: nonpriv-switch
[253.140038] Starting dynamic subtest: rcs0
[253.412364] Dynamic subtest rcs0: SUCCESS (0.277s)
[253.422473] Starting dynamic subtest: bcs0
[253.708167] Dynamic subtest bcs0: SUCCESS (0.295s)
[253.718809] Starting dynamic subtest: vcs0
[254.011777] Dynamic subtest vcs0: SUCCESS (0.303s)
[254.025178] Starting dynamic subtest: vcs1
[255.982739] Dynamic subtest vcs1: SUCCESS (1.970s)
[255.992246] Starting dynamic subtest: vecs0
[257.970509] Dynamic subtest vecs0: SUCCESS (1.988s)
[257.982269] Starting dynamic subtest: ccs0
[259.982212] Dynamic subtest ccs0: SUCCESS (2.012s)
[259.984608] Subtest nonpriv-switch: SUCCESS (6.853s)
[260.255111] [065/133] (759s left) kms_flip_scaled_crc (flip-32bpp-yftile-to-64bpp-yftile-upscaling)
[260.353759] Starting subtest: flip-32bpp-yftile-to-64bpp-yftile-upscaling
[260.357811] Subtest flip-32bpp-yftile-to-64bpp-yftile-upscaling: SKIP (0.000s)
[260.435625] [066/133] (759s left) i915_drm_fdinfo (most-busy-check-all)
[260.479875] Starting subtest: most-busy-check-all
[260.482202] Starting dynamic subtest: rcs0
[260.486814] Dynamic subtest rcs0: SKIP (0.004s)
[260.498114] Starting dynamic subtest: bcs0
[260.502395] Dynamic subtest bcs0: SKIP (0.000s)
[260.511713] Starting dynamic subtest: vcs0
[260.516137] Dynamic subtest vcs0: SKIP (0.000s)
[260.525006] Starting dynamic subtest: vcs1
[260.529127] Dynamic subtest vcs1: SKIP (0.000s)
[260.537937] Starting dynamic subtest: vecs0
[260.542043] Dynamic subtest vecs0: SKIP (0.000s)
[260.551004] Starting dynamic subtest: ccs0
[260.555092] Dynamic subtest ccs0: SKIP (0.000s)
[260.559149] Subtest most-busy-check-all: SKIP (0.010s)
[260.595157] [067/133] (759s left) kms_psr2_sf (fbc-psr2-overlay-plane-move-continuous-exceed-sf)
[260.741399] Starting subtest: fbc-psr2-overlay-plane-move-continuous-exceed-sf
[260.743706] Starting dynamic subtest: pipe-A-eDP-1
[260.850089] Dynamic subtest pipe-A-eDP-1: SKIP (0.110s)
[260.862103] Starting dynamic subtest: pipe-B-eDP-1
[261.950907] Dynamic subtest pipe-B-eDP-1: SKIP (1.099s)
[261.955387] Subtest fbc-psr2-overlay-plane-move-continuous-exceed-sf: SKIP (1.212s)
[263.252178] [068/133] (756s left) gem_create (create-ext-placement-each)
[263.418490] Starting subtest: create-ext-placement-each
[263.421443] Subtest create-ext-placement-each: SUCCESS (0.000s)
[263.545921] [069/133] (756s left) gen7_exec_parse (basic-allocation)
[263.616919] Subtest basic-allocation: SKIP (0.000s)
[263.676920] [070/133] (756s left) api_intel_bb (intel-bb-blit-none)
[263.738072] Starting subtest: intel-bb-blit-none
[267.547445] Subtest intel-bb-blit-none: SUCCESS (3.812s)
[267.697044] [071/133] (752s left) kms_chamelium_hpd (vga-hpd)
[268.098182] Subtest vga-hpd: SKIP (0.000s)
[268.944851] [072/133] (751s left) kms_pipe_b_c_ivb (enable-pipe-c-while-b-has-3-lanes)
[269.002756] Subtest enable-pipe-C-while-B-has-3-lanes: SKIP (0.000s)
[269.062667] [073/133] (751s left) gem_exec_reloc (basic-gtt-cpu-noreloc)
[269.133388] Subtest basic-gtt-cpu-noreloc: SKIP (0.000s)
[269.222782] [074/133] (750s left) i915_pm_rps (reset)
[269.279428] Starting subtest: reset
[277.781758] Subtest reset: SUCCESS (8.507s)
[277.953105] [075/133] (742s left) kms_cursor_legacy (cursor-vs-flip-legacy)
[278.079007] Starting subtest: cursor-vs-flip-legacy
[307.481266] Subtest cursor-vs-flip-legacy: SUCCESS (29.414s)
[308.310284] [076/133] (711s left) kms_ccs (crc-primary-suspend-yf-tiled-ccs)
[308.413526] Starting subtest: crc-primary-suspend-yf-tiled-ccs
[308.415804] Starting dynamic subtest: pipe-A-eDP-1
[308.425053] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[308.435912] Starting dynamic subtest: pipe-B-eDP-1
[308.445103] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[308.455010] Starting dynamic subtest: pipe-C-eDP-1
[308.463844] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[308.473488] Starting dynamic subtest: pipe-D-eDP-1
[308.482113] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[308.486560] Subtest crc-primary-suspend-yf-tiled-ccs: SKIP (0.005s)
[310.651143] [077/133] (709s left) gem_exec_balancer (parallel-keep-in-fence)
[310.913430] Starting subtest: parallel-keep-in-fence
[312.132080] Subtest parallel-keep-in-fence: SUCCESS (1.223s)
[312.248473] [078/133] (708s left) prime_busy (after-wait)
[312.310121] Starting subtest: after-wait
[312.315864] Starting dynamic subtest: rcs0
[312.375539] Dynamic subtest rcs0: SUCCESS (0.059s)
[312.387444] Starting dynamic subtest: bcs0
[312.443482] Dynamic subtest bcs0: SUCCESS (0.066s)
[312.455061] Starting dynamic subtest: vcs0
[312.486338] Dynamic subtest vcs0: SUCCESS (0.041s)
[312.496597] Starting dynamic subtest: vcs1
[312.529523] Dynamic subtest vcs1: SUCCESS (0.041s)
[312.539538] Starting dynamic subtest: vecs0
[312.570490] Dynamic subtest vecs0: SUCCESS (0.039s)
[312.580681] Starting dynamic subtest: ccs0
[312.611237] Dynamic subtest ccs0: SUCCESS (0.039s)
[312.720303] Subtest after-wait: SUCCESS (0.408s)
[312.810654] [079/133] (707s left) gem_exec_schedule (u-independent)
[312.886335] Starting subtest: u-independent
[312.888385] Starting dynamic subtest: rcs0
[314.681494] Dynamic subtest rcs0: SUCCESS (1.804s)
[314.694189] Starting dynamic subtest: vcs0
[316.678996] Dynamic subtest vcs0: SUCCESS (1.996s)
[316.692089] Starting dynamic subtest: vcs1
[318.667221] Dynamic subtest vcs1: SUCCESS (1.988s)
[318.679710] Starting dynamic subtest: vecs0
[320.670501] Dynamic subtest vecs0: SUCCESS (2.001s)
[320.683473] Starting dynamic subtest: ccs0
[322.679886] Dynamic subtest ccs0: SUCCESS (2.008s)
[322.682675] Subtest u-independent: SUCCESS (9.808s)
[322.996394] [080/133] (697s left) kms_psr2_sf (fbc-pr-cursor-plane-update-sf)
[323.107530] Starting subtest: fbc-pr-cursor-plane-update-sf
[323.111473] Subtest fbc-pr-cursor-plane-update-sf: SKIP (0.000s)
[323.190232] [081/133] (697s left) kms_sequence (queue-busy)
[323.287702] Starting subtest: queue-busy
[323.289825] Starting dynamic subtest: pipe-A-eDP-1
[325.230115] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.943s)
[325.240702] Starting dynamic subtest: pipe-B-eDP-1
[327.828789] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.597s)
[327.840034] Starting dynamic subtest: pipe-C-eDP-1
[330.439483] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.613s)
[330.449657] Starting dynamic subtest: pipe-D-eDP-1
[333.059406] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.620s)
[333.062008] Subtest queue-busy: SUCCESS (9.779s)
[333.946706] [082/133] (686s left) kms_chamelium_audio (hdmi-audio)
[334.354804] Subtest hdmi-audio: SKIP (0.000s)
[335.157859] [083/133] (685s left) gem_mmap_gtt (big-bo-tiledy)
[335.233447] Subtest big-bo-tiledY: SKIP (0.000s)
[335.297335] [084/133] (685s left) gem_mmap_wc (write-prefaulted)
[335.355846] Subtest write-prefaulted: SKIP (0.000s)
[335.425178] [085/133] (685s left) gem_exec_fence (syncobj-unused-fence)
[335.963841] Starting subtest: syncobj-unused-fence
[335.969708] Subtest syncobj-unused-fence: SUCCESS (0.005s)
[337.784564] [FACT gem_exec_fence (syncobj-unused-fence)] new: kernel.kmod_is_loaded.vgem: true
[337.788630] [086/133] (682s left) syncobj_timeline (etime-multi-wait-all-for-submit-available-unsubmitted-signa
[337.850744] Starting subtest: etime-multi-wait-all-for-submit-available-unsubmitted-signaled
[337.956476] Subtest etime-multi-wait-all-for-submit-available-unsubmitted-signaled: SUCCESS (0.104s)
[338.051383] [087/133] (682s left) i915_hangman (engine-engine-hang)
[338.128925] Starting subtest: engine-engine-hang
[338.131150] Starting dynamic subtest: rcs0
[339.670739] Dynamic subtest rcs0: SUCCESS (1.542s)
[339.683882] Starting dynamic subtest: bcs0
[341.655637] Dynamic subtest bcs0: SUCCESS (1.983s)
[341.668906] Starting dynamic subtest: vcs0
[343.638289] Dynamic subtest vcs0: SUCCESS (1.980s)
[343.656095] Starting dynamic subtest: vcs1
[345.622254] Dynamic subtest vcs1: SUCCESS (1.982s)
[345.637610] Starting dynamic subtest: vecs0
[347.606636] Dynamic subtest vecs0: SUCCESS (1.982s)
[347.619827] Starting dynamic subtest: ccs0
[349.590996] Dynamic subtest ccs0: SUCCESS (1.982s)
[349.594005] Subtest engine-engine-hang: SUCCESS (11.469s)
[349.697256] [088/133] (671s left) kms_ccs (crc-sprite-planes-basic-y-tiled-ccs)
[349.812903] Starting subtest: crc-sprite-planes-basic-y-tiled-ccs
[349.815307] Starting dynamic subtest: pipe-A-eDP-1
[349.872266] Dynamic subtest pipe-A-eDP-1: SKIP (0.003s)
[349.882455] Starting dynamic subtest: pipe-B-eDP-1
[349.933669] Dynamic subtest pipe-B-eDP-1: SKIP (0.003s)
[349.943379] Starting dynamic subtest: pipe-C-eDP-1
[349.997363] Dynamic subtest pipe-C-eDP-1: SKIP (0.003s)
[350.007243] Starting dynamic subtest: pipe-D-eDP-1
[350.061299] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[350.065268] Subtest crc-sprite-planes-basic-y-tiled-ccs: SKIP (0.021s)
[352.043148] [089/133] (668s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-onoff)
[352.143292] Starting subtest: psr-2p-primscrn-cur-indfb-onoff
[352.147862] Subtest psr-2p-primscrn-cur-indfb-onoff: SKIP (0.000s)
[352.252811] [090/133] (668s left) kms_plane (pixel-format-4-tiled-bmg-ccs-modifier)
[352.350184] Starting subtest: pixel-format-4-tiled-bmg-ccs-modifier
[352.354536] Subtest pixel-format-4-tiled-bmg-ccs-modifier: SKIP (0.000s)
[352.439570] [091/133] (668s left) prime_mmap (test_map_unmap)
[352.489838] Starting subtest: test_map_unmap
[352.491784] Starting dynamic subtest: test_map_unmap-smem
[352.522061] Dynamic subtest test_map_unmap-smem: SUCCESS (0.033s)
[352.524470] Subtest test_map_unmap: SUCCESS (0.034s)
[352.651057] [092/133] (668s left) prime_self_import (basic-with_two_bos)
[352.690974] Starting subtest: basic-with_two_bos
[352.718030] Subtest basic-with_two_bos: SUCCESS (0.030s)
[352.838575] [093/133] (668s left) sysfs_preempt_timeout (invalid)
[352.905401] Starting subtest: invalid
[352.907714] Starting dynamic subtest: vecs0
[352.909974] Dynamic subtest vecs0: SUCCESS (0.000s)
[352.921229] Starting dynamic subtest: ccs0
[352.923028] Dynamic subtest ccs0: SUCCESS (0.000s)
[352.932383] Starting dynamic subtest: vcs0
[352.934238] Dynamic subtest vcs0: SUCCESS (0.000s)
[352.943507] Starting dynamic subtest: bcs0
[352.945351] Dynamic subtest bcs0: SUCCESS (0.000s)
[352.954995] Starting dynamic subtest: rcs0
[352.956904] Dynamic subtest rcs0: SUCCESS (0.000s)
[352.966795] Starting dynamic subtest: vcs1
[352.968618] Dynamic subtest vcs1: SUCCESS (0.000s)
[352.970436] Subtest invalid: SUCCESS (0.006s)
[353.030976] [094/133] (668s left) kms_big_fb (linear-64bpp-rotate-180)
[353.136763] Starting subtest: linear-64bpp-rotate-180
[354.811228] Subtest linear-64bpp-rotate-180: SUCCESS (1.673s)
[354.977610] [095/133] (666s left) gem_tiled_pread_pwrite
[355.083365] [096/133] (666s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-pwrite)
[355.181495] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-pwrite
[360.429953] Subtest fbc-1p-primscrn-pri-indfb-draw-pwrite: SUCCESS (5.254s)
[361.650228] [097/133] (659s left) gem_fence_thrash (bo-write-verify-y)
[361.691062] Starting subtest: bo-write-verify-y
[361.715744] Subtest bo-write-verify-y: SKIP (0.020s)
[361.786870] [098/133] (659s left) kms_big_fb (4-tiled-addfb)
[361.895546] Starting subtest: 4-tiled-addfb
[361.897860] Subtest 4-tiled-addfb: SUCCESS (0.000s)
[362.023778] [099/133] (659s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-render)
[362.126361] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-render
[366.632243] Subtest fbc-1p-primscrn-pri-indfb-draw-render: SUCCESS (4.513s)
[367.833671] [100/133] (653s left) gem_exec_fence (syncobj-timeline-chain-engines)
[368.388436] Starting subtest: syncobj-timeline-chain-engines
[368.516511] Subtest syncobj-timeline-chain-engines: SUCCESS (0.129s)
[369.778736] [101/133] (651s left) kms_pm_rpm (modeset-non-lpsp)
[371.819210] Starting subtest: modeset-non-lpsp
[372.975944] Subtest modeset-non-lpsp: SKIP (1.155s)
[373.365320] [102/133] (648s left) kms_addfb_basic (addfb25-x-tiled-legacy)
[373.464794] Subtest addfb25-x-tiled-legacy: SKIP (0.000s)
[373.573863] [103/133] (647s left) kms_cursor_crc (cursor-size-hints)
[373.714300] Starting subtest: cursor-size-hints
[373.716477] Starting dynamic subtest: pipe-A-eDP-1
[374.324087] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.611s)
[374.334468] Starting dynamic subtest: pipe-D-eDP-1
[375.602306] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.278s)
[375.604685] Subtest cursor-size-hints: SUCCESS (1.892s)
[376.432910] [104/133] (645s left) kms_big_fb (yf-tiled-addfb-size-overflow)
[376.537958] Starting subtest: yf-tiled-addfb-size-overflow
[376.542379] Subtest yf-tiled-addfb-size-overflow: SKIP (0.000s)
[376.666917] [105/133] (644s left) gem_pxp (verify-pxp-stale-ctx-execution)
[376.797919] Starting subtest: verify-pxp-stale-ctx-execution
[377.852958] Subtest verify-pxp-stale-ctx-execution: SUCCESS (1.059s)
[378.009853] [106/133] (643s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-0)
[378.105471] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-0
[379.116108] Subtest x-tiled-max-hw-stride-32bpp-rotate-0: SUCCESS (1.011s)
[379.254383] [107/133] (642s left) kms_psr (psr2-cursor-mmap-cpu)
[379.352912] Starting subtest: psr2-cursor-mmap-cpu
[379.354663] Starting dynamic subtest: eDP-1
[381.079403] Dynamic subtest eDP-1: SUCCESS (1.725s)
[381.081353] Subtest psr2-cursor-mmap-cpu: SUCCESS (1.726s)
[381.883697] [108/133] (639s left) kms_psr (fbc-psr-sprite-plane-onoff)
[381.979213] Starting subtest: fbc-psr-sprite-plane-onoff
[381.981503] Starting dynamic subtest: eDP-1
[381.985603] Dynamic subtest eDP-1: SKIP (0.000s)
[381.989805] Subtest fbc-psr-sprite-plane-onoff: SKIP (0.001s)
[382.065431] [109/133] (639s left) kms_pm_rpm (fences-dpms)
[383.815160] Starting subtest: fences-dpms
[383.820096] Subtest fences-dpms: SKIP (0.000s)
[384.345694] [110/133] (637s left) prime_mmap_coherency (read)
[384.415819] Starting subtest: read
[389.789483] Subtest read: SUCCESS (5.375s)
[389.936458] [111/133] (631s left) gem_exec_fence (basic-busy-all)
[390.011306] Starting subtest: basic-busy-all
[390.123663] Subtest basic-busy-all: SUCCESS (0.113s)
[391.790145] [112/133] (630s left) prime_vgem (basic-fence-flip)
[391.870453] Starting subtest: basic-fence-flip
[392.160827] Subtest basic-fence-flip: SUCCESS (0.293s)
[392.282479] [113/133] (629s left) syncobj_wait (invalid-signal-bad-pad)
[392.344429] Starting subtest: invalid-signal-bad-pad
[392.346744] Subtest invalid-signal-bad-pad: SUCCESS (0.000s)
[392.461588] [114/133] (629s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-wc)
[392.562867] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-wc
[392.566772] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[392.688318] [115/133] (629s left) kms_big_fb (x-tiled-addfb)
[392.805884] Starting subtest: x-tiled-addfb
[392.808207] Subtest x-tiled-addfb: SUCCESS (0.000s)
[392.940456] [116/133] (629s left) gem_ctx_persistence (legacy-engines-hostile)
[393.009662] Starting subtest: legacy-engines-hostile
[393.011948] Starting dynamic subtest: render
[393.139319] Dynamic subtest render: SUCCESS (0.129s)
[393.154552] Starting dynamic subtest: bsd1
[393.221974] Dynamic subtest bsd1: SUCCESS (0.079s)
[393.235605] Starting dynamic subtest: bsd2
[393.380915] Dynamic subtest bsd2: SUCCESS (0.155s)
[393.395531] Starting dynamic subtest: blt
[393.497872] Dynamic subtest blt: SUCCESS (0.114s)
[393.512188] Starting dynamic subtest: vebox
[393.620933] Dynamic subtest vebox: SUCCESS (0.120s)
[393.623125] Subtest legacy-engines-hostile: SUCCESS (0.613s)
[393.717442] [117/133] (628s left) kms_big_fb (4-tiled-16bpp-rotate-180)
[393.834494] Starting subtest: 4-tiled-16bpp-rotate-180
[395.136950] Subtest 4-tiled-16bpp-rotate-180: SUCCESS (1.302s)
[395.291857] [118/133] (626s left) kms_pipe_crc_basic (compare-crc-sanitycheck-nv12)
[395.395674] Starting subtest: compare-crc-sanitycheck-nv12
[395.397903] Starting dynamic subtest: pipe-A-eDP-1
[396.074244] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.675s)
[396.085339] Starting dynamic subtest: pipe-B-eDP-1
[397.388836] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.315s)
[397.398723] Starting dynamic subtest: pipe-C-eDP-1
[398.661480] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.271s)
[398.672340] Starting dynamic subtest: pipe-D-eDP-1
[399.921228] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.257s)
[399.923469] Subtest compare-crc-sanitycheck-nv12: SUCCESS (4.527s)
[400.735916] [119/133] (621s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-mmap-cpu)
[400.841689] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-mmap-cpu
[407.499807] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-mmap-cpu: SUCCESS (6.662s)
[407.653961] [120/133] (614s left) kms_flip (wf_vblank-ts-check-interruptible)
[407.753396] Starting subtest: wf_vblank-ts-check-interruptible
[407.755746] Starting dynamic subtest: A-eDP1
[416.668697] Dynamic subtest A-eDP1: SUCCESS (8.918s)
[416.678577] Starting dynamic subtest: B-eDP1
[425.601942] Dynamic subtest B-eDP1: SUCCESS (8.936s)
[425.614102] Starting dynamic subtest: C-eDP1
[434.517331] Dynamic subtest C-eDP1: SUCCESS (8.917s)
[434.529721] Starting dynamic subtest: D-eDP1
[443.368829] Dynamic subtest D-eDP1: SUCCESS (8.854s)
[443.373752] Subtest wf_vblank-ts-check-interruptible: SUCCESS (35.637s)
[444.603584] [121/133] (577s left) gem_eio (create)
[444.856479] Starting subtest: create
[445.234817] Subtest create: SUCCESS (0.377s)
[445.425365] [122/133] (576s left) kms_content_protection (dp-mst-lic-type-0-hdcp14)
[445.581913] Starting subtest: dp-mst-lic-type-0-hdcp14
[445.585473] Subtest dp-mst-lic-type-0-hdcp14: SKIP (0.000s)
[445.738300] [123/133] (576s left) kms_vblank (query-idle)
[445.829001] Starting subtest: query-idle
[445.830838] Starting dynamic subtest: pipe-A-eDP-1
[447.571173] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.741s)
[447.587491] Starting dynamic subtest: pipe-D-eDP-1
[450.022704] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.450s)
[450.024987] Subtest query-idle: SUCCESS (4.195s)
[450.874812] [124/133] (571s left) kms_plane_scaling (invalid-num-scalers)
[450.975873] Starting subtest: invalid-num-scalers
[450.978242] Starting dynamic subtest: pipe-A-eDP-1-invalid-num-scalers
[450.995341] Dynamic subtest pipe-A-eDP-1-invalid-num-scalers: SUCCESS (0.019s)
[451.006589] Starting dynamic subtest: pipe-B-eDP-1-invalid-num-scalers
[451.029824] Dynamic subtest pipe-B-eDP-1-invalid-num-scalers: SUCCESS (0.033s)
[451.040088] Starting dynamic subtest: pipe-C-eDP-1-invalid-num-scalers
[451.064108] Dynamic subtest pipe-C-eDP-1-invalid-num-scalers: SUCCESS (0.033s)
[451.074188] Starting dynamic subtest: pipe-D-eDP-1-invalid-num-scalers
[451.096336] Dynamic subtest pipe-D-eDP-1-invalid-num-scalers: SUCCESS (0.032s)
[451.098643] Subtest invalid-num-scalers: SUCCESS (0.124s)
[451.216335] [125/133] (571s left) kms_cursor_crc (cursor-onscreen-512x170)
[451.521144] Starting subtest: cursor-onscreen-512x170
[451.525535] Subtest cursor-onscreen-512x170: SKIP (0.001s)
[451.694030] [126/133] (570s left) kms_rotation_crc (primary-rotation-270)
[451.792374] Starting subtest: primary-rotation-270
[451.796140] Subtest primary-rotation-270: SKIP (0.001s)
[451.889354] [127/133] (570s left) perf (invalid-oa-metric-set-id)
[452.000468] Starting subtest: invalid-oa-metric-set-id
[452.011056] Subtest invalid-oa-metric-set-id: SUCCESS (0.010s)
[452.053992] [128/133] (570s left) syncobj_timeline (single-wait-all-for-submit-available-submitted)
[452.104905] Starting subtest: single-wait-all-for-submit-available-submitted
[452.106946] Subtest single-wait-all-for-submit-available-submitted: SUCCESS (0.000s)
[452.218066] [129/133] (570s left) kms_draw_crc (draw-method-render)
[452.310896] Starting subtest: draw-method-render
[452.312496] Starting dynamic subtest: xrgb8888-untiled
[452.531866] Dynamic subtest xrgb8888-untiled: SUCCESS (0.222s)
[452.541609] Starting dynamic subtest: rgb565-untiled
[452.787072] Dynamic subtest rgb565-untiled: SUCCESS (0.254s)
[452.797476] Starting dynamic subtest: xrgb2101010-untiled
[453.020385] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.232s)
[453.030380] Starting dynamic subtest: xbgr16161616f-untiled
[453.253415] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.233s)
[453.264009] Starting dynamic subtest: xrgb8888-xtiled
[453.386741] Dynamic subtest xrgb8888-xtiled: SUCCESS (0.133s)
[453.396753] Starting dynamic subtest: rgb565-xtiled
[453.498049] Dynamic subtest rgb565-xtiled: SUCCESS (0.110s)
[453.508385] Starting dynamic subtest: xrgb2101010-xtiled
[453.609353] Dynamic subtest xrgb2101010-xtiled: SUCCESS (0.111s)
[453.620715] Starting dynamic subtest: xbgr16161616f-xtiled
[453.731153] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (0.121s)
[453.741202] Starting dynamic subtest: xrgb8888-4tiled
[453.854756] Dynamic subtest xrgb8888-4tiled: SUCCESS (0.121s)
[453.864762] Starting dynamic subtest: rgb565-4tiled
[453.975269] Dynamic subtest rgb565-4tiled: SUCCESS (0.121s)
[453.987044] Starting dynamic subtest: xrgb2101010-4tiled
[454.108670] Dynamic subtest xrgb2101010-4tiled: SUCCESS (0.133s)
[454.119471] Starting dynamic subtest: xbgr16161616f-4tiled
[454.275295] Dynamic subtest xbgr16161616f-4tiled: SUCCESS (0.166s)
[454.277224] Subtest draw-method-render: SUCCESS (1.967s)
[454.449153] [130/133] (568s left) kms_cursor_legacy (basic-flip-before-cursor-legacy)
[454.571665] Starting subtest: basic-flip-before-cursor-legacy
[455.485734] Subtest basic-flip-before-cursor-legacy: SUCCESS (0.914s)
[456.292963] [131/133] (566s left) kms_frontbuffer_tracking (fbc-1p-indfb-fliptrack-mmap-gtt)
[456.399177] Starting subtest: fbc-1p-indfb-fliptrack-mmap-gtt
[456.403564] Subtest fbc-1p-indfb-fliptrack-mmap-gtt: SKIP (0.000s)
[456.531700] [132/133] (566s left) perf_pmu (idle-no-semaphores)
[456.587478] Starting subtest: idle-no-semaphores
[456.589818] Starting dynamic subtest: rcs0
[457.152999] Dynamic subtest rcs0: SUCCESS (0.566s)
[457.166731] Starting dynamic subtest: bcs0
[457.681664] Dynamic subtest bcs0: SUCCESS (0.526s)
[457.695874] Starting dynamic subtest: vcs0
[458.206477] Dynamic subtest vcs0: SUCCESS (0.521s)
[458.219731] Starting dynamic subtest: vcs1
[458.731944] Dynamic subtest vcs1: SUCCESS (0.523s)
[458.744495] Starting dynamic subtest: vecs0
[459.246983] Dynamic subtest vecs0: SUCCESS (0.512s)
[459.260464] Starting dynamic subtest: ccs0
[459.769823] Dynamic subtest ccs0: SUCCESS (0.520s)
[459.772719] Subtest idle-no-semaphores: SUCCESS (3.186s)
[459.901822] [133/133] (562s left) syncobj_wait (multi-wait-all-for-submit-signaled)
[459.956476] Starting subtest: multi-wait-all-for-submit-signaled
[459.958705] Subtest multi-wait-all-for-submit-signaled: SUCCESS (0.000s)
[460.069114] Closing watchdogs
results: parsing output: 0/ for test: kms_plane
results: parsing output: 1/ for test: kms_big_fb
results: parsing output: 2/ for test: kms_big_fb
results: parsing output: 3/ for test: prime_mmap_coherency
results: parsing output: 4/ for test: perf
results: parsing output: 5/ for test: core_getversion
results: parsing output: 6/ for test: kms_flip
results: parsing output: 7/ for test: api_intel_allocator
results: parsing output: 8/ for test: tools_test
results: parsing output: 9/ for test: kms_invalid_mode
results: parsing output: 10/ for test: kms_getfb
results: parsing output: 11/ for test: gen3_mixed_blits
results: parsing output: 12/ for test: kms_frontbuffer_tracking
results: parsing output: 13/ for test: kms_cursor_crc
results: parsing output: 14/ for test: kms_flip
results: parsing output: 15/ for test: kms_pm_backlight
results: parsing output: 16/ for test: kms_color
results: parsing output: 17/ for test: gem_exec_params
results: parsing output: 18/ for test: gem_exec_schedule
results: parsing output: 19/ for test: gem_mmap_gtt
results: parsing output: 20/ for test: kms_chamelium_frames
results: parsing output: 21/ for test: gem_exec_whisper
results: parsing output: 22/ for test: gen9_exec_parse
results: parsing output: 23/ for test: perf_pmu
results: parsing output: 24/ for test: gem_workarounds
results: parsing output: 25/ for test: kms_psr
results: parsing output: 26/ for test: syncobj_wait
results: parsing output: 27/ for test: kms_frontbuffer_tracking
results: parsing output: 28/ for test: kms_addfb_basic
results: parsing output: 29/ for test: syncobj_wait
results: parsing output: 30/ for test: kms_psr
results: parsing output: 31/ for test: kms_psr
results: parsing output: 32/ for test: kms_flip
results: parsing output: 33/ for test: kms_frontbuffer_tracking
results: parsing output: 34/ for test: kms_flip_scaled_crc
results: parsing output: 35/ for test: kms_addfb_basic
results: parsing output: 36/ for test: gem_softpin
results: parsing output: 37/ for test: i915_suspend
results: parsing output: 38/ for test: kms_psr
results: parsing output: 39/ for test: gem_userptr_blits
results: parsing output: 40/ for test: gem_exec_balancer
results: parsing output: 41/ for test: gem_lmem_swapping
results: parsing output: 42/ for test: gem_render_copy
results: parsing output: 43/ for test: syncobj_timeline
results: parsing output: 44/ for test: kms_frontbuffer_tracking
results: parsing output: 45/ for test: kms_frontbuffer_tracking
results: parsing output: 46/ for test: kms_cursor_legacy
results: parsing output: 47/ for test: kms_frontbuffer_tracking
results: parsing output: 48/ for test: kms_ccs
results: parsing output: 49/ for test: kms_ccs
results: parsing output: 50/ for test: kms_frontbuffer_tracking
results: parsing output: 51/ for test: gem_partial_pwrite_pread
results: parsing output: 52/ for test: syncobj_timeline
results: parsing output: 53/ for test: kms_frontbuffer_tracking
results: parsing output: 54/ for test: kms_lease
results: parsing output: 55/ for test: syncobj_wait
results: parsing output: 56/ for test: gem_mmap_gtt
results: parsing output: 57/ for test: syncobj_timeline
results: parsing output: 58/ for test: gem_madvise
results: parsing output: 59/ for test: kms_frontbuffer_tracking
results: parsing output: 60/ for test: gem_ccs
results: parsing output: 61/ for test: kms_frontbuffer_tracking
results: parsing output: 62/ for test: syncobj_wait
results: parsing output: 63/ for test: gem_ctx_isolation
results: parsing output: 64/ for test: kms_flip_scaled_crc
results: parsing output: 65/ for test: i915_drm_fdinfo
results: parsing output: 66/ for test: kms_psr2_sf
results: parsing output: 67/ for test: gem_create
results: parsing output: 68/ for test: gen7_exec_parse
results: parsing output: 69/ for test: api_intel_bb
results: parsing output: 70/ for test: kms_chamelium_hpd
results: parsing output: 71/ for test: kms_pipe_b_c_ivb
results: parsing output: 72/ for test: gem_exec_reloc
results: parsing output: 73/ for test: i915_pm_rps
results: parsing output: 74/ for test: kms_cursor_legacy
results: parsing output: 75/ for test: kms_ccs
results: parsing output: 76/ for test: gem_exec_balancer
results: parsing output: 77/ for test: prime_busy
results: parsing output: 78/ for test: gem_exec_schedule
results: parsing output: 79/ for test: kms_psr2_sf
results: parsing output: 80/ for test: kms_sequence
results: parsing output: 81/ for test: kms_chamelium_audio
results: parsing output: 82/ for test: gem_mmap_gtt
results: parsing output: 83/ for test: gem_mmap_wc
results: parsing output: 84/ for test: gem_exec_fence
results: parsing output: 85/ for test: syncobj_timeline
results: parsing output: 86/ for test: i915_hangman
results: parsing output: 87/ for test: kms_ccs
results: parsing output: 88/ for test: kms_frontbuffer_tracking
results: parsing output: 89/ for test: kms_plane
results: parsing output: 90/ for test: prime_mmap
results: parsing output: 91/ for test: prime_self_import
results: parsing output: 92/ for test: sysfs_preempt_timeout
results: parsing output: 93/ for test: kms_big_fb
results: parsing output: 94/ for test: gem_tiled_pread_pwrite
results: parsing output: 95/ for test: kms_frontbuffer_tracking
results: parsing output: 96/ for test: gem_fence_thrash
results: parsing output: 97/ for test: kms_big_fb
results: parsing output: 98/ for test: kms_frontbuffer_tracking
results: parsing output: 99/ for test: gem_exec_fence
results: parsing output: 100/ for test: kms_pm_rpm
results: parsing output: 101/ for test: kms_addfb_basic
results: parsing output: 102/ for test: kms_cursor_crc
results: parsing output: 103/ for test: kms_big_fb
results: parsing output: 104/ for test: gem_pxp
results: parsing output: 105/ for test: kms_big_fb
results: parsing output: 106/ for test: kms_psr
results: parsing output: 107/ for test: kms_psr
results: parsing output: 108/ for test: kms_pm_rpm
results: parsing output: 109/ for test: prime_mmap_coherency
results: parsing output: 110/ for test: gem_exec_fence
results: parsing output: 111/ for test: prime_vgem
results: parsing output: 112/ for test: syncobj_wait
results: parsing output: 113/ for test: kms_frontbuffer_tracking
results: parsing output: 114/ for test: kms_big_fb
results: parsing output: 115/ for test: gem_ctx_persistence
results: parsing output: 116/ for test: kms_big_fb
results: parsing output: 117/ for test: kms_pipe_crc_basic
results: parsing output: 118/ for test: kms_frontbuffer_tracking
results: parsing output: 119/ for test: kms_flip
results: parsing output: 120/ for test: gem_eio
results: parsing output: 121/ for test: kms_content_protection
results: parsing output: 122/ for test: kms_vblank
results: parsing output: 123/ for test: kms_plane_scaling
results: parsing output: 124/ for test: kms_cursor_crc
results: parsing output: 125/ for test: kms_rotation_crc
results: parsing output: 126/ for test: perf
results: parsing output: 127/ for test: syncobj_timeline
results: parsing output: 128/ for test: kms_draw_crc
results: parsing output: 129/ for test: kms_cursor_legacy
results: parsing output: 130/ for test: kms_frontbuffer_tracking
results: parsing output: 131/ for test: perf_pmu
results: parsing output: 132/ for test: syncobj_wait
Done.