[57.154377] Initializing watchdogs
[57.154425]   /dev/watchdog0
[57.168099] [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]
[57.172406] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[57.174548] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[57.177931] [001/133] (960s left) kms_frontbuffer_tracking (psr-modesetfrombusy)
[57.310053] Starting subtest: psr-modesetfrombusy
[63.468124] Subtest psr-modesetfrombusy: SUCCESS (6.176s)
[63.590578] [002/133] (954s left) kms_big_fb (yf-tiled-32bpp-rotate-270)
[63.688967] Starting subtest: yf-tiled-32bpp-rotate-270
[63.692850] Subtest yf-tiled-32bpp-rotate-270: SKIP (0.000s)
[63.807711] [003/133] (953s left) kms_vrr (negative-basic)
[63.893696] Starting subtest: negative-basic
[63.899483] Starting dynamic subtest: pipe-A-eDP-1
[69.316938] Dynamic subtest pipe-A-eDP-1: SUCCESS (5.418s)
[69.604351] Subtest negative-basic: SUCCESS (5.714s)
[70.487983] [004/133] (947s left) kms_chamelium_color (ctm-0-75)
[70.586190] Subtest ctm-0-75: SKIP (0.000s)
[70.628148] [005/133] (947s left) kms_flip (flip-vs-panning-interruptible)
[70.719442] Starting subtest: flip-vs-panning-interruptible
[70.721933] Starting dynamic subtest: A-eDP1
[79.407930] Dynamic subtest A-eDP1: SUCCESS (8.691s)
[79.415283] Starting dynamic subtest: B-eDP1
[88.134548] Dynamic subtest B-eDP1: SUCCESS (8.725s)
[88.144222] Starting dynamic subtest: C-eDP1
[96.849023] Dynamic subtest C-eDP1: SUCCESS (8.713s)
[96.857578] Starting dynamic subtest: D-eDP1
[105.502692] Dynamic subtest D-eDP1: SUCCESS (8.653s)
[105.506748] Subtest flip-vs-panning-interruptible: SUCCESS (34.789s)
[106.646630] [006/133] (911s left) kms_cursor_edge_walk (128x128-left-edge)
[106.737106] Starting subtest: 128x128-left-edge
[106.739439] Starting dynamic subtest: pipe-A-eDP-1
[110.216384] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.479s)
[110.224738] Starting dynamic subtest: pipe-D-eDP-1
[113.334089] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.116s)
[113.336329] Subtest 128x128-left-edge: SUCCESS (6.597s)
[114.146453] [007/133] (903s left) kms_flip (2x-flip-vs-wf_vblank)
[114.239081] Starting subtest: 2x-flip-vs-wf_vblank
[114.249680] Subtest 2x-flip-vs-wf_vblank: SKIP (0.010s)
[114.326469] [008/133] (903s left) gem_exec_gttfill (basic)
[114.393683] Starting subtest: basic
[116.986671] Subtest basic: SUCCESS (2.593s)
[117.171988] [009/133] (900s left) i915_pm_freq_mult (media-freq)
[117.264598] Starting subtest: media-freq
[117.266985] Starting dynamic subtest: gt0
[117.271487] Dynamic subtest gt0: SKIP (0.000s)
[117.281216] Starting dynamic subtest: gt1
[117.285309] Dynamic subtest gt1: SKIP (0.000s)
[117.289794] Subtest media-freq: SKIP (0.001s)
[117.405368] [010/133] (900s left) gem_exec_suspend (basic-s3-devices)
[117.469570] Starting subtest: basic-S3-devices
[117.471932] Starting dynamic subtest: smem
[128.855936] Dynamic subtest smem: SUCCESS (11.384s)
[128.859060] Subtest basic-S3-devices: SUCCESS (11.385s)
[129.038577] [011/133] (889s left) kms_psr (fbc-pr-cursor-mmap-gtt)
[129.145376] Starting subtest: fbc-pr-cursor-mmap-gtt
[129.150368] Subtest fbc-pr-cursor-mmap-gtt: SKIP (0.000s)
[129.216883] [012/133] (888s left) gem_exec_schedule (fairslice-all)
[129.301526] Starting subtest: fairslice-all
[131.350266] Subtest fairslice-all: SUCCESS (2.056s)
[132.957109] [013/133] (885s left) kms_psr (pr-sprite-plane-onoff)
[133.054420] Starting subtest: pr-sprite-plane-onoff
[133.058730] Subtest pr-sprite-plane-onoff: SKIP (0.000s)
[133.124526] [014/133] (885s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-render)
[133.220958] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-render
[133.225200] Subtest fbc-2p-primscrn-cur-indfb-draw-render: SKIP (0.000s)
[133.318872] [015/133] (884s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-mmap-gtt)
[133.424639] Starting subtest: psr-2p-primscrn-cur-indfb-draw-mmap-gtt
[133.428797] Subtest psr-2p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[133.538473] [016/133] (884s left) gem_userptr_blits (sync-overlap)
[133.613713] Starting subtest: sync-overlap
[133.616121] Subtest sync-overlap: SUCCESS (0.000s)
[133.751320] [017/133] (884s left) kms_ccs (crc-primary-suspend-4-tiled-mtl-rc-ccs)
[133.838904] Starting subtest: crc-primary-suspend-4-tiled-mtl-rc-ccs
[133.841255] Starting dynamic subtest: pipe-A-eDP-1
[150.488567] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.459s)
[150.498504] Starting dynamic subtest: pipe-B-eDP-1
[167.477066] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.462s)
[167.486612] Starting dynamic subtest: pipe-C-eDP-1
[184.421179] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.412s)
[184.430573] Starting dynamic subtest: pipe-D-eDP-1
[201.431602] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.346s)
[201.433894] Subtest crc-primary-suspend-4-tiled-mtl-rc-ccs: SUCCESS (8.683s)
[202.643753] [018/133] (815s left) kms_plane_scaling (plane-scaler-with-clipping-clamping-rotation)
[202.746929] Starting subtest: plane-scaler-with-clipping-clamping-rotation
[202.749214] Starting dynamic subtest: pipe-A
[202.971961] Dynamic subtest pipe-A: SUCCESS (0.228s)
[202.981125] Starting dynamic subtest: pipe-B
[204.224162] Dynamic subtest pipe-B: SUCCESS (1.256s)
[204.232675] Starting dynamic subtest: pipe-C
[205.550254] Dynamic subtest pipe-C: SUCCESS (1.331s)
[205.559276] Starting dynamic subtest: pipe-D
[206.874111] Dynamic subtest pipe-D: SUCCESS (1.327s)
[206.876650] Subtest plane-scaler-with-clipping-clamping-rotation: SUCCESS (4.148s)
[208.063847] [019/133] (810s left) syncobj_wait (single-wait-all-for-submit-unsubmitted)
[208.131094] Starting subtest: single-wait-all-for-submit-unsubmitted
[208.239300] Subtest single-wait-all-for-submit-unsubmitted: SUCCESS (0.106s)
[208.324460] [020/133] (810s left) kms_chamelium_frames (hdmi-frame-dump)
[208.699804] Subtest hdmi-frame-dump: SKIP (0.000s)
[209.469514] [021/133] (809s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-180-hflip)
[209.574871] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-180-hflip
[209.579354] Subtest y-tiled-max-hw-stride-32bpp-rotate-180-hflip: SKIP (0.000s)
[209.680302] [022/133] (808s left) kms_psr (fbc-psr-primary-page-flip)
[209.780529] Starting subtest: fbc-psr-primary-page-flip
[209.782860] Starting dynamic subtest: eDP-1
[209.786944] Dynamic subtest eDP-1: SKIP (0.000s)
[209.791208] Subtest fbc-psr-primary-page-flip: SKIP (0.001s)
[209.863107] [023/133] (808s left) gem_softpin (allocator-nopin)
[209.931046] Starting subtest: allocator-nopin
[210.031224] Subtest allocator-nopin: SUCCESS (0.100s)
[210.160819] [024/133] (808s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-shrfb-draw-mmap-cpu)
[210.266195] Starting subtest: psr-1p-offscreen-pri-shrfb-draw-mmap-cpu
[216.939996] Subtest psr-1p-offscreen-pri-shrfb-draw-mmap-cpu: SUCCESS (6.687s)
[217.062259] [025/133] (801s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-0)
[217.159540] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-0
[218.148187] Subtest 4-tiled-max-hw-stride-32bpp-rotate-0: SUCCESS (0.990s)
[218.287963] [026/133] (800s left) kms_flip (flip-vs-rmfb-interruptible)
[218.383152] Starting subtest: flip-vs-rmfb-interruptible
[218.385147] Starting dynamic subtest: A-eDP1
[227.026370] Dynamic subtest A-eDP1: SUCCESS (8.650s)
[227.037187] Starting dynamic subtest: B-eDP1
[235.669659] Dynamic subtest B-eDP1: SUCCESS (8.655s)
[235.678499] Starting dynamic subtest: C-eDP1
[244.290778] Dynamic subtest C-eDP1: SUCCESS (8.636s)
[244.303242] Starting dynamic subtest: D-eDP1
[252.918667] Dynamic subtest D-eDP1: SUCCESS (8.633s)
[252.923715] Subtest flip-vs-rmfb-interruptible: SUCCESS (34.588s)
[254.066696] [027/133] (764s left) syncobj_eventfd (binary-wait-before-signal)
[254.124854] Starting subtest: binary-wait-before-signal
[254.154274] Subtest binary-wait-before-signal: SUCCESS (0.031s)
[254.229974] [028/133] (764s left) gem_render_copy (yf-tiled)
[254.299125] Starting subtest: yf-tiled
[254.303836] Subtest yf-tiled: SKIP (0.000s)
[254.483656] [029/133] (764s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-blt)
[254.581355] Starting subtest: psr-2p-primscrn-spr-indfb-draw-blt
[254.585761] Subtest psr-2p-primscrn-spr-indfb-draw-blt: SKIP (0.000s)
[254.693567] [030/133] (764s left) gem_ctx_exec (basic-norecovery)
[254.749198] Starting subtest: basic-norecovery
[255.102316] Subtest basic-norecovery: SUCCESS (0.354s)
[255.225961] [031/133] (763s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-blt)
[255.313989] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-blt
[262.551230] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-blt: SUCCESS (7.245s)
[262.686807] [032/133] (756s left) kms_ccs (crc-sprite-planes-basic-4-tiled-dg2-rc-ccs-cc)
[262.772751] Starting subtest: crc-sprite-planes-basic-4-tiled-dg2-rc-ccs-cc
[262.775018] Starting dynamic subtest: pipe-A-eDP-1
[262.832272] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[262.840788] Starting dynamic subtest: pipe-B-eDP-1
[262.897293] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[262.907727] Starting dynamic subtest: pipe-C-eDP-1
[262.964189] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[262.974045] Starting dynamic subtest: pipe-D-eDP-1
[263.032448] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[263.036518] Subtest crc-sprite-planes-basic-4-tiled-dg2-rc-ccs-cc: SKIP (0.009s)
[265.044403] [033/133] (753s left) kms_addfb_basic (clobberred-modifier)
[265.105587] Starting subtest: clobberred-modifier
[265.110392] Subtest clobberred-modifier: SKIP (0.000s)
[265.243133] [034/133] (753s left) kms_vblank (query-idle)
[265.334950] Starting subtest: query-idle
[265.336846] Starting dynamic subtest: pipe-A-eDP-1
[267.089191] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.752s)
[267.107956] Starting dynamic subtest: pipe-D-eDP-1
[269.476264] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.384s)
[269.478769] Subtest query-idle: SUCCESS (4.140s)
[270.299816] [035/133] (748s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-32bpp-ytile-downscaling)
[270.394055] Starting subtest: flip-64bpp-ytile-to-32bpp-ytile-downscaling
[270.398256] Subtest flip-64bpp-ytile-to-32bpp-ytile-downscaling: SKIP (0.000s)
[270.478110] [036/133] (748s left) gem_tiled_pread_basic (basic)
[270.533854] Subtest basic: SKIP (0.000s)
[270.591246] [037/133] (748s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-pwrite)
[270.688564] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-pwrite
[270.693014] Subtest psr-2p-scndscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[270.782620] [038/133] (748s left) gem_exec_balancer (parallel-out-fence)
[271.034635] Starting subtest: parallel-out-fence
[272.238482] Subtest parallel-out-fence: SUCCESS (1.203s)
[272.344901] [039/133] (746s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-mmap-cpu)
[272.433544] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-mmap-cpu
[272.438044] Subtest fbc-2p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[272.533351] [040/133] (746s left) gem_eio (hibernate)
[272.772285] Starting subtest: hibernate
[287.268893] Subtest hibernate: SUCCESS (14.494s)
[295.428008] [041/133] (731s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-mmap-wc)
[295.549625] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-mmap-wc
[295.553741] Subtest fbc-2p-primscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[295.650362] [042/133] (731s left) gem_softpin (invalid)
[295.707330] Starting subtest: invalid
[295.715572] Subtest invalid: SUCCESS (0.007s)
[295.819734] [043/133] (731s left) kms_content_protection (lic-type-0)
[295.957114] Starting subtest: lic-type-0
[295.961776] Subtest lic-type-0: SKIP (0.000s)
[296.084998] [044/133] (731s left) kms_psr (psr-dpms)
[296.178538] Starting subtest: psr-dpms
[296.180750] Starting dynamic subtest: eDP-1
[299.154781] Dynamic subtest eDP-1: SUCCESS (2.974s)
[299.157315] Subtest psr-dpms: SUCCESS (2.975s)
[300.017714] [045/133] (727s left) prime_vgem (basic-fence-mmap)
[300.128285] Starting subtest: basic-fence-mmap
[300.132984] Subtest basic-fence-mmap: SKIP (0.000s)
[300.227570] [FACT prime_vgem (basic-fence-mmap)] new: kernel.kmod_is_loaded.vgem: true
[300.230838] [046/133] (727s left) kms_frontbuffer_tracking (fbcpsr-shrfb-scaledprimary)
[300.351219] Starting subtest: fbcpsr-shrfb-scaledprimary
[306.101632] Subtest fbcpsr-shrfb-scaledprimary: SUCCESS (5.752s)
[306.238429] [047/133] (721s left) gem_pxp (create-regular-buffer)
[306.355553] Starting subtest: create-regular-buffer
[306.358001] Subtest create-regular-buffer: SUCCESS (0.000s)
[306.503538] [048/133] (721s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling)
[306.604378] Starting subtest: flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling
[306.609246] Subtest flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling: SKIP (0.000s)
[306.689808] [049/133] (720s left) gem_exec_schedule (preempt-self)
[306.764965] Starting subtest: preempt-self
[306.767195] Starting dynamic subtest: rcs0
[306.776800] Dynamic subtest rcs0: SUCCESS (0.019s)
[306.788464] Starting dynamic subtest: bcs0
[306.797191] Dynamic subtest bcs0: SUCCESS (0.020s)
[306.806768] Starting dynamic subtest: vcs0
[306.814607] Dynamic subtest vcs0: SUCCESS (0.016s)
[306.828266] Starting dynamic subtest: vcs1
[306.833023] Dynamic subtest vcs1: SUCCESS (0.016s)
[306.842309] Starting dynamic subtest: vecs0
[306.862624] Dynamic subtest vecs0: SUCCESS (0.030s)
[306.877350] Starting dynamic subtest: ccs0
[306.884789] Dynamic subtest ccs0: SUCCESS (0.021s)
[306.887000] Subtest preempt-self: SUCCESS (0.128s)
[307.977973] [050/133] (719s left) gem_exec_whisper (basic-sync-all)
[308.042851] Starting subtest: basic-sync-all
[315.771543] Subtest basic-sync-all: SUCCESS (7.731s)
[315.957303] [051/133] (711s left) kms_draw_crc (draw-method-render)
[316.055754] Starting subtest: draw-method-render
[316.058001] Starting dynamic subtest: xrgb8888-untiled
[316.297163] Dynamic subtest xrgb8888-untiled: SUCCESS (0.244s)
[316.310560] Starting dynamic subtest: rgb565-untiled
[316.542226] Dynamic subtest rgb565-untiled: SUCCESS (0.243s)
[316.554467] Starting dynamic subtest: xrgb2101010-untiled
[316.775156] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.231s)
[316.785522] Starting dynamic subtest: xbgr16161616f-untiled
[317.008216] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.233s)
[317.018183] Starting dynamic subtest: xrgb8888-xtiled
[317.130245] Dynamic subtest xrgb8888-xtiled: SUCCESS (0.121s)
[317.140217] Starting dynamic subtest: rgb565-xtiled
[317.252598] Dynamic subtest rgb565-xtiled: SUCCESS (0.122s)
[317.262589] Starting dynamic subtest: xrgb2101010-xtiled
[317.363779] Dynamic subtest xrgb2101010-xtiled: SUCCESS (0.110s)
[317.373658] Starting dynamic subtest: xbgr16161616f-xtiled
[317.485898] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (0.121s)
[317.495928] Starting dynamic subtest: xrgb8888-4tiled
[317.608084] Dynamic subtest xrgb8888-4tiled: SUCCESS (0.121s)
[317.619999] Starting dynamic subtest: rgb565-4tiled
[317.741374] Dynamic subtest rgb565-4tiled: SUCCESS (0.133s)
[317.750944] Starting dynamic subtest: xrgb2101010-4tiled
[317.863970] Dynamic subtest xrgb2101010-4tiled: SUCCESS (0.122s)
[317.873326] Starting dynamic subtest: xbgr16161616f-4tiled
[317.997096] Dynamic subtest xbgr16161616f-4tiled: SUCCESS (0.132s)
[317.999013] Subtest draw-method-render: SUCCESS (1.944s)
[318.113707] [052/133] (709s left) tools_test (tools_test)
[318.159463] Starting subtest: tools_test
[318.226471] Subtest tools_test: SUCCESS (0.075s)
[318.284794] [053/133] (709s left) kms_pm_rpm (modeset-lpsp-stress)
[320.024664] Starting subtest: modeset-lpsp-stress
[336.757972] Subtest modeset-lpsp-stress: SUCCESS (16.734s)
[336.858289] [054/133] (691s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-mmap-cpu)
[336.968843] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-mmap-cpu
[336.972781] Subtest fbc-2p-scndscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[337.071147] [055/133] (690s left) i915_drm_fdinfo (busy)
[337.119441] Starting subtest: busy
[337.121268] Starting dynamic subtest: rcs0
[337.144331] Dynamic subtest rcs0: SKIP (0.024s)
[337.155075] Starting dynamic subtest: bcs0
[337.159064] Dynamic subtest bcs0: SKIP (0.000s)
[337.168721] Starting dynamic subtest: vcs0
[337.173169] Dynamic subtest vcs0: SKIP (0.000s)
[337.182110] Starting dynamic subtest: vcs1
[337.186277] Dynamic subtest vcs1: SKIP (0.000s)
[337.195239] Starting dynamic subtest: vecs0
[337.199442] Dynamic subtest vecs0: SKIP (0.000s)
[337.208341] Starting dynamic subtest: ccs0
[337.212515] Dynamic subtest ccs0: SKIP (0.000s)
[337.216630] Subtest busy: SKIP (0.030s)
[337.254356] [056/133] (690s left) kms_prop_blob (invalid-get-prop)
[337.320333] Starting subtest: invalid-get-prop
[337.322693] Subtest invalid-get-prop: SUCCESS (0.000s)
[337.427872] [057/133] (690s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-indfb-draw-blt)
[337.517993] Starting subtest: psr-1p-offscreen-pri-indfb-draw-blt
[344.420588] Subtest psr-1p-offscreen-pri-indfb-draw-blt: SUCCESS (6.905s)
[344.552713] [058/133] (683s left) kms_big_fb (yf-tiled-addfb-size-overflow)
[344.661295] Starting subtest: yf-tiled-addfb-size-overflow
[344.665625] Subtest yf-tiled-addfb-size-overflow: SKIP (0.000s)
[344.783127] [059/133] (683s left) gem_userptr_blits (create-destroy-unsync)
[344.850308] Subtest create-destroy-unsync: SKIP (0.000s)
[344.993827] [060/133] (683s left) vgem_basic (dmabuf-export)
[345.047311] Starting subtest: dmabuf-export
[345.062395] Subtest dmabuf-export: SUCCESS (0.019s)
[345.172450] [061/133] (682s left) kms_universal_plane (universal-plane-sanity)
[345.256006] Starting subtest: universal-plane-sanity
[345.258296] Starting dynamic subtest: pipe-A-eDP-1
[345.853768] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.599s)
[345.864602] Starting dynamic subtest: pipe-B-eDP-1
[347.049062] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.194s)
[347.060599] Starting dynamic subtest: pipe-C-eDP-1
[348.257010] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.205s)
[348.268062] Starting dynamic subtest: pipe-D-eDP-1
[349.483456] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.227s)
[349.485866] Subtest universal-plane-sanity: SUCCESS (4.230s)
[350.348671] [062/133] (677s left) syncobj_wait (signal)
[350.406318] Starting subtest: signal
[350.408753] Subtest signal: SUCCESS (0.000s)
[350.522164] [063/133] (677s left) gem_mmap_offset (blt-coherency)
[350.578950] Starting subtest: blt-coherency
[350.583630] Subtest blt-coherency: SUCCESS (0.007s)
[350.710533] [064/133] (677s left) gen7_exec_parse (chained-batch)
[350.757665] Subtest chained-batch: SKIP (0.000s)
[350.829254] [065/133] (677s left) kms_invalid_mode (bad-hsync-end)
[350.913997] Starting subtest: bad-hsync-end
[350.916340] Starting dynamic subtest: pipe-A-eDP-1
[351.213776] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.300s)
[351.224730] Starting dynamic subtest: pipe-B-eDP-1
[351.227095] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[351.236277] Starting dynamic subtest: pipe-C-eDP-1
[351.238660] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[351.247970] Starting dynamic subtest: pipe-D-eDP-1
[351.250371] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[351.252716] Subtest bad-hsync-end: SUCCESS (0.306s)
[352.094210] [066/133] (676s left) api_intel_allocator (simple-allocator)
[352.155266] Starting subtest: simple-allocator
[352.157702] Starting dynamic subtest: basic
[352.159967] Dynamic subtest basic: SUCCESS (0.003s)
[352.173959] Starting dynamic subtest: parallel-one
[352.357726] Dynamic subtest parallel-one: SUCCESS (0.200s)
[352.367330] Starting dynamic subtest: print
[352.369755] Dynamic subtest print: SUCCESS (0.000s)
[352.379372] Starting dynamic subtest: reuse
[352.381358] Dynamic subtest reuse: SUCCESS (0.000s)
[352.390512] Starting dynamic subtest: reserve
[352.392531] Dynamic subtest reserve: SUCCESS (0.000s)
[352.401729] Starting dynamic subtest: fork-reopen-allocator
[352.403596] Dynamic subtest fork-reopen-allocator: SUCCESS (0.012s)
[352.405485] Subtest simple-allocator: SUCCESS (0.219s)
[352.496507] [067/133] (675s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-move)
[352.591927] Starting subtest: fbc-2p-scndscrn-spr-indfb-move
[352.596048] Subtest fbc-2p-scndscrn-spr-indfb-move: SKIP (0.000s)
[352.704343] [068/133] (675s left) kms_psr2_sf (pr-cursor-plane-move-continuous-sf)
[352.802949] Starting subtest: pr-cursor-plane-move-continuous-sf
[352.806899] Subtest pr-cursor-plane-move-continuous-sf: SKIP (0.000s)
[352.875882] [069/133] (675s left) gem_mmap_gtt (basic-read-write-distinct)
[352.939517] Subtest basic-read-write-distinct: SKIP (0.000s)
[353.001142] [070/133] (675s left) prime_mmap_coherency (ioctl-errors)
[353.056360] Starting subtest: ioctl-errors
[368.407374] Subtest ioctl-errors: SUCCESS (15.353s)
[368.557549] [071/133] (660s left) kms_psr (psr-cursor-mmap-gtt)
[368.691049] Starting subtest: psr-cursor-mmap-gtt
[368.693461] Starting dynamic subtest: eDP-1
[370.395466] Dynamic subtest eDP-1: SUCCESS (1.704s)
[370.397889] Subtest psr-cursor-mmap-gtt: SUCCESS (1.705s)
[371.254081] [072/133] (657s left) gem_ctx_shared (single-timeline)
[371.326974] Starting subtest: single-timeline
[371.346137] Subtest single-timeline: SUCCESS (0.011s)
[371.569062] [073/133] (657s left) syncobj_timeline (multi-wait-for-submit-submitted-signaled)
[371.650445] Starting subtest: multi-wait-for-submit-submitted-signaled
[371.652942] Subtest multi-wait-for-submit-submitted-signaled: SUCCESS (0.002s)
[371.746336] [074/133] (656s left) kms_cursor_crc (cursor-offscreen-128x42)
[371.992143] Starting subtest: cursor-offscreen-128x42
[372.038948] Subtest cursor-offscreen-128x42: SKIP (0.042s)
[372.262116] [075/133] (656s left) i915_hangman (engine-engine-error)
[372.315536] Starting subtest: engine-engine-error
[372.317814] Starting dynamic subtest: rcs0
[373.842053] Dynamic subtest rcs0: SUCCESS (1.527s)
[373.854724] Starting dynamic subtest: bcs0
[375.825181] Dynamic subtest bcs0: SUCCESS (1.980s)
[375.838958] Starting dynamic subtest: vcs0
[377.873926] Dynamic subtest vcs0: SUCCESS (2.047s)
[377.887940] Starting dynamic subtest: vcs1
[379.792629] Dynamic subtest vcs1: SUCCESS (1.917s)
[379.806054] Starting dynamic subtest: vecs0
[381.840081] Dynamic subtest vecs0: SUCCESS (2.045s)
[381.856692] Starting dynamic subtest: ccs0
[383.825295] Dynamic subtest ccs0: SUCCESS (1.982s)
[383.828776] Subtest engine-engine-error: SUCCESS (11.514s)
[383.908526] [076/133] (644s left) dmabuf_sync_file (import-basic)
[383.962918] Starting subtest: import-basic
[383.964809] Subtest import-basic: SUCCESS (0.001s)
[384.035402] [077/133] (644s left) gem_exec_flush (basic-wb-set-default)
[384.097737] Starting subtest: basic-wb-set-default
[389.562311] Subtest basic-wb-set-default: SUCCESS (5.466s)
[389.755140] [078/133] (639s left) kms_cursor_legacy (2x-flip-vs-cursor-legacy)
[389.879393] Starting subtest: 2x-flip-vs-cursor-legacy
[389.884726] Subtest 2x-flip-vs-cursor-legacy: SKIP (0.001s)
[390.023177] [079/133] (638s left) syncobj_timeline (etime-single-wait-for-submit-unsubmitted)
[390.074764] Starting subtest: etime-single-wait-for-submit-unsubmitted
[390.183394] Subtest etime-single-wait-for-submit-unsubmitted: SUCCESS (0.108s)
[390.273210] [080/133] (638s left) kms_cursor_legacy (short-busy-flip-before-cursor-toggle)
[390.386157] Starting subtest: short-busy-flip-before-cursor-toggle
[390.390603] Subtest short-busy-flip-before-cursor-toggle: SKIP (0.000s)
[390.544053] [081/133] (638s left) kms_ccs (bad-aux-stride-y-tiled-gen12-rc-ccs)
[390.625581] Starting subtest: bad-aux-stride-y-tiled-gen12-rc-ccs
[390.627851] Starting dynamic subtest: pipe-A-eDP-1
[390.650770] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[390.661521] Starting dynamic subtest: pipe-B-eDP-1
[390.682387] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[390.692724] Starting dynamic subtest: pipe-C-eDP-1
[390.713403] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[390.723043] Starting dynamic subtest: pipe-D-eDP-1
[390.746482] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[390.751117] Subtest bad-aux-stride-y-tiled-gen12-rc-ccs: SKIP (0.004s)
[392.833602] [082/133] (636s left) gem_wait (invalid-flags)
[392.890370] Starting subtest: invalid-flags
[392.892720] Subtest invalid-flags: SUCCESS (0.000s)
[393.114654] [083/133] (635s left) gem_exec_schedule (lateslice)
[393.180209] Starting subtest: lateslice
[393.182544] Starting dynamic subtest: rcs0
[393.190071] Dynamic subtest rcs0: SUCCESS (0.021s)
[393.202292] Starting dynamic subtest: bcs0
[393.208336] Dynamic subtest bcs0: SUCCESS (0.018s)
[393.218831] Starting dynamic subtest: vcs0
[393.229533] Dynamic subtest vcs0: SUCCESS (0.019s)
[393.240059] Starting dynamic subtest: vcs1
[393.246553] Dynamic subtest vcs1: SUCCESS (0.017s)
[393.257035] Starting dynamic subtest: vecs0
[393.265360] Dynamic subtest vecs0: SUCCESS (0.018s)
[393.275750] Starting dynamic subtest: ccs0
[393.287024] Dynamic subtest ccs0: SUCCESS (0.021s)
[393.289305] Subtest lateslice: SUCCESS (0.119s)
[394.942334] [084/133] (634s left) gem_basic (multigpu-create-close)
[395.003433] Starting subtest: multigpu-create-close
[395.007644] Subtest multigpu-create-close: SKIP (0.000s)
[395.093563] [085/133] (634s left) kms_atomic_transition (plane-use-after-nonblocking-unbind-fencing)
[395.195530] Starting subtest: plane-use-after-nonblocking-unbind-fencing
[395.197826] Starting dynamic subtest: pipe-A-eDP-1
[395.257731] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.065s)
[395.564118] Starting dynamic subtest: pipe-B-eDP-1
[396.332012] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.776s)
[396.640282] Subtest plane-use-after-nonblocking-unbind-fencing: SUCCESS (1.447s)
[397.498609] [086/133] (631s left) kms_chamelium_frames (vga-frame-dump)
[397.887542] Subtest vga-frame-dump: SKIP (0.000s)
[398.715950] [087/133] (630s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-pwrite)
[398.805636] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-pwrite
[398.810002] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[398.901360] [088/133] (630s left) gem_mmap_gtt (cpuset-basic-small-copy-odd)
[398.954205] Subtest cpuset-basic-small-copy-odd: SKIP (0.000s)
[399.017646] [089/133] (630s left) gem_render_copy (yf-tiled-to-vebox-x-tiled)
[399.073834] Starting subtest: yf-tiled-to-vebox-x-tiled
[399.078285] Subtest yf-tiled-to-vebox-x-tiled: SKIP (0.000s)
[399.256830] [090/133] (630s left) kms_cursor_crc (cursor-sliding-128x42)
[399.487934] Starting subtest: cursor-sliding-128x42
[399.537935] Subtest cursor-sliding-128x42: SKIP (0.045s)
[399.737928] [091/133] (629s left) syncobj_wait (multi-wait-all-for-submit-unsubmitted-submitted)
[399.795882] Starting subtest: multi-wait-all-for-submit-unsubmitted-submitted
[399.900825] Subtest multi-wait-all-for-submit-unsubmitted-submitted: SUCCESS (0.106s)
[399.981725] [092/133] (629s left) syncobj_wait (invalid-reset-bad-pad)
[400.036098] Starting subtest: invalid-reset-bad-pad
[400.038077] Subtest invalid-reset-bad-pad: SUCCESS (0.000s)
[400.153454] [093/133] (629s left) syncobj_wait (single-wait-signaled)
[400.218491] Starting subtest: single-wait-signaled
[400.220580] Subtest single-wait-signaled: SUCCESS (0.000s)
[400.330961] [094/133] (629s left) api_intel_bb (render-ccs)
[400.389800] Starting subtest: render-ccs
[400.976782] Subtest render-ccs: SUCCESS (0.585s)
[401.083396] [095/133] (628s left) kms_flip (plain-flip-fb-recreate)
[401.185081] Starting subtest: plain-flip-fb-recreate
[401.186986] Starting dynamic subtest: A-eDP1
[410.122807] Dynamic subtest A-eDP1: SUCCESS (8.942s)
[410.135540] Starting dynamic subtest: B-eDP1
[418.955206] Dynamic subtest B-eDP1: SUCCESS (8.832s)
[418.965354] Starting dynamic subtest: C-eDP1
[427.782311] Dynamic subtest C-eDP1: SUCCESS (8.828s)
[427.800099] Starting dynamic subtest: D-eDP1
[436.611762] Dynamic subtest D-eDP1: SUCCESS (8.831s)
[436.616407] Subtest plain-flip-fb-recreate: SUCCESS (35.442s)
[437.787637] [096/133] (591s left) kms_color (ctm-green-to-red)
[437.884893] Starting subtest: ctm-green-to-red
[437.887074] Starting dynamic subtest: pipe-A-eDP-1
[438.552156] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.665s)
[438.564756] Starting dynamic subtest: pipe-B-eDP-1
[439.954855] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.403s)
[439.965885] Starting dynamic subtest: pipe-C-eDP-1
[441.234090] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.280s)
[441.244919] Starting dynamic subtest: pipe-D-eDP-1
[442.568344] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.335s)
[442.570750] Subtest ctm-green-to-red: SUCCESS (4.685s)
[443.413144] [097/133] (586s left) sysfs_heartbeat_interval (idempotent)
[443.472396] Starting subtest: idempotent
[443.474643] Starting dynamic subtest: vecs0
[443.476925] Dynamic subtest vecs0: SUCCESS (0.001s)
[443.494703] Starting dynamic subtest: ccs0
[443.496824] Dynamic subtest ccs0: SUCCESS (0.001s)
[443.512430] Starting dynamic subtest: vcs0
[443.514326] Dynamic subtest vcs0: SUCCESS (0.000s)
[443.524720] Starting dynamic subtest: bcs0
[443.526915] Dynamic subtest bcs0: SUCCESS (0.001s)
[443.538194] Starting dynamic subtest: rcs0
[443.540081] Dynamic subtest rcs0: SUCCESS (0.000s)
[443.549482] Starting dynamic subtest: vcs1
[443.551383] Dynamic subtest vcs1: SUCCESS (0.000s)
[443.553288] Subtest idempotent: SUCCESS (0.008s)
[443.591617] [098/133] (586s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-mmap-gtt)
[443.685833] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-mmap-gtt
[443.689758] Subtest fbc-2p-scndscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[443.776659] [099/133] (585s left) kms_big_fb (linear-max-hw-stride-32bpp-rotate-0)
[443.877257] Starting subtest: linear-max-hw-stride-32bpp-rotate-0
[444.921638] Subtest linear-max-hw-stride-32bpp-rotate-0: SUCCESS (1.045s)
[445.083410] [100/133] (584s left) gem_mmap_wc (write-read-distinct)
[445.146540] Subtest write-read-distinct: SKIP (0.000s)
[445.241608] [101/133] (584s left) kms_ccs (ccs-on-another-bo-4-tiled-mtl-rc-ccs-cc)
[445.342193] Starting subtest: ccs-on-another-bo-4-tiled-mtl-rc-ccs-cc
[445.343930] Starting dynamic subtest: pipe-A-eDP-1
[445.359930] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[445.370651] Starting dynamic subtest: pipe-B-eDP-1
[445.386157] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[445.395565] Starting dynamic subtest: pipe-C-eDP-1
[445.410634] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[445.421322] Starting dynamic subtest: pipe-D-eDP-1
[445.436849] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[445.438352] Subtest ccs-on-another-bo-4-tiled-mtl-rc-ccs-cc: SUCCESS (0.008s)
[447.586199] [102/133] (582s left) gem_ctx_persistence (heartbeat-many)
[447.657011] Starting subtest: heartbeat-many
[447.661718] Subtest heartbeat-many: SKIP (0.000s)
[447.776373] [103/133] (582s left) kms_lease (multimaster-lease)
[447.873507] Starting subtest: multimaster-lease
[447.875951] Subtest multimaster-lease: SUCCESS (0.004s)
[447.991139] [104/133] (582s left) syncobj_timeline (single-wait-signaled)
[448.069750] Starting subtest: single-wait-signaled
[448.071739] Subtest single-wait-signaled: SUCCESS (0.000s)
[448.178007] [105/133] (581s left) syncobj_timeline (multi-wait-all-available-submitted-signaled)
[448.236338] Starting subtest: multi-wait-all-available-submitted-signaled
[448.238336] Subtest multi-wait-all-available-submitted-signaled: SUCCESS (0.000s)
[448.328854] [106/133] (581s left) kms_addfb_basic (addfb25-y-tiled-legacy)
[448.422792] Starting subtest: addfb25-y-tiled-legacy
[448.424763] Subtest addfb25-y-tiled-legacy: SUCCESS (0.000s)
[448.506329] [107/133] (581s left) perf_pmu (idle)
[448.544160] Starting subtest: idle
[448.546118] Starting dynamic subtest: rcs0
[449.092254] Dynamic subtest rcs0: SUCCESS (0.545s)
[449.106537] Starting dynamic subtest: bcs0
[449.615013] Dynamic subtest bcs0: SUCCESS (0.521s)
[449.629248] Starting dynamic subtest: vcs0
[450.133116] Dynamic subtest vcs0: SUCCESS (0.515s)
[450.147387] Starting dynamic subtest: vcs1
[450.654938] Dynamic subtest vcs1: SUCCESS (0.519s)
[450.667621] Starting dynamic subtest: vecs0
[451.170461] Dynamic subtest vecs0: SUCCESS (0.512s)
[451.184339] Starting dynamic subtest: ccs0
[451.698374] Dynamic subtest ccs0: SUCCESS (0.525s)
[451.701180] Subtest idle: SUCCESS (3.155s)
[451.813569] [108/133] (578s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-shrfb-plflip-blt)
[451.921186] Starting subtest: fbcpsr-1p-primscrn-shrfb-plflip-blt
[459.256629] Subtest fbcpsr-1p-primscrn-shrfb-plflip-blt: SUCCESS (7.342s)
[459.383508] [109/133] (570s left) gem_exec_whisper (basic-contexts-priority-all)
[459.447037] Starting subtest: basic-contexts-priority-all
[483.967004] Subtest basic-contexts-priority-all: SUCCESS (24.526s)
[484.171860] [110/133] (546s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-blt)
[484.276727] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-blt
[491.570844] Subtest psr-1p-primscrn-pri-shrfb-draw-blt: SUCCESS (7.298s)
[491.694060] [111/133] (538s left) gem_render_copy (y-tiled-ccs-to-linear)
[491.749395] Starting subtest: y-tiled-ccs-to-linear
[491.754475] Subtest y-tiled-ccs-to-linear: SKIP (0.000s)
[491.943612] [112/133] (538s left) kms_big_fb (y-tiled-8bpp-rotate-180)
[492.050239] Starting subtest: y-tiled-8bpp-rotate-180
[492.054591] Subtest y-tiled-8bpp-rotate-180: SKIP (0.000s)
[492.153461] [113/133] (538s left) i915_query (hwconfig_table)
[492.206137] Starting subtest: hwconfig_table
[492.506721] Subtest hwconfig_table: SUCCESS (0.001s)
[492.551027] [114/133] (537s left) kms_plane (plane-panning-bottom-right-suspend)
[492.641062] Starting subtest: plane-panning-bottom-right-suspend
[492.642969] Starting dynamic subtest: pipe-A
[510.649642] Dynamic subtest pipe-A: SUCCESS (2.876s)
[510.661021] Starting dynamic subtest: pipe-B
[529.697139] Dynamic subtest pipe-B: SUCCESS (3.577s)
[529.699392] Subtest plane-panning-bottom-right-suspend: SUCCESS (6.458s)
[530.544412] [115/133] (499s left) kms_atomic (plane-invalid-params)
[530.648663] Starting subtest: plane-invalid-params
[530.650968] Starting dynamic subtest: pipe-A-eDP-1
[531.038030] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.390s)
[531.040172] Subtest plane-invalid-params: SUCCESS (0.393s)
[531.877263] [116/133] (498s left) gem_exec_fence (syncobj-repeat)
[532.361968] Starting subtest: syncobj-repeat
[532.577926] Subtest syncobj-repeat: SUCCESS (0.216s)
[533.612403] [117/133] (496s left) kms_plane (pixel-format-yf-tiled-ccs-modifier)
[533.705218] Starting subtest: pixel-format-yf-tiled-ccs-modifier
[533.709107] Subtest pixel-format-yf-tiled-ccs-modifier: SKIP (0.000s)
[533.779244] [118/133] (496s left) perf (rc6-disable)
[533.908852] Starting subtest: rc6-disable
[534.091850] Subtest rc6-disable: SUCCESS (0.185s)
[534.137597] [119/133] (496s left) kms_plane (pixel-format-4-tiled-dg2-rc-ccs-cc-modifier-source-clamping)
[534.235139] Starting subtest: pixel-format-4-tiled-dg2-rc-ccs-cc-modifier-source-clamping
[534.239153] Subtest pixel-format-4-tiled-dg2-rc-ccs-cc-modifier-source-clamping: SKIP (0.000s)
[534.308355] [120/133] (496s left) kms_flip (2x-dpms-vs-vblank-race)
[534.403337] Starting subtest: 2x-dpms-vs-vblank-race
[534.414166] Subtest 2x-dpms-vs-vblank-race: SKIP (0.010s)
[534.493315] [121/133] (496s left) sw_sync (sync_multi_timeline_wait)
[534.531081] Starting subtest: sync_multi_timeline_wait
[534.533331] Subtest sync_multi_timeline_wait: SUCCESS (0.000s)
[534.582169] [122/133] (496s left) syncobj_wait (multi-wait-all-for-submit-unsubmitted-signaled)
[534.630899] Starting subtest: multi-wait-all-for-submit-unsubmitted-signaled
[534.734245] Subtest multi-wait-all-for-submit-unsubmitted-signaled: SUCCESS (0.103s)
[534.822848] [123/133] (495s left) kms_psr (fbc-pr-primary-mmap-gtt)
[534.915842] Starting subtest: fbc-pr-primary-mmap-gtt
[534.920306] Subtest fbc-pr-primary-mmap-gtt: SKIP (0.000s)
[535.020004] [124/133] (495s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-shrfb-pgflip-blt)
[535.122401] Starting subtest: fbcpsr-2p-primscrn-shrfb-pgflip-blt
[535.126572] Subtest fbcpsr-2p-primscrn-shrfb-pgflip-blt: SKIP (0.000s)
[535.225784] [125/133] (495s left) kms_pm_rpm (dpms-lpsp)
[536.749589] Starting subtest: dpms-lpsp
[537.404089] Subtest dpms-lpsp: SUCCESS (0.661s)
[537.492950] [126/133] (493s left) kms_flip (flip-vs-dpms-on-nop)
[537.581926] Starting subtest: flip-vs-dpms-on-nop
[537.584330] Starting dynamic subtest: A-eDP1
[539.461539] Dynamic subtest A-eDP1: SUCCESS (1.889s)
[539.475763] Starting dynamic subtest: B-eDP1
[541.289441] Dynamic subtest B-eDP1: SUCCESS (1.831s)
[541.301054] Starting dynamic subtest: C-eDP1
[543.210515] Dynamic subtest C-eDP1: SUCCESS (1.924s)
[543.234818] Starting dynamic subtest: D-eDP1
[545.049190] Dynamic subtest D-eDP1: SUCCESS (1.839s)
[545.054443] Subtest flip-vs-dpms-on-nop: SUCCESS (7.498s)
[546.214575] [127/133] (484s left) gem_exec_balancer (parallel-balancer)
[546.483907] Starting subtest: parallel-balancer
[547.372711] Subtest parallel-balancer: SUCCESS (0.890s)
[547.486014] [128/133] (483s left) kms_big_fb (linear-32bpp-rotate-270)
[547.595067] Starting subtest: linear-32bpp-rotate-270
[547.614357] Subtest linear-32bpp-rotate-270: SKIP (0.019s)
[547.728275] [129/133] (483s left) kms_atomic_transition (plane-all-transition-nonblocking-fencing)
[547.834329] Starting subtest: plane-all-transition-nonblocking-fencing
[547.836762] Starting dynamic subtest: pipe-A-eDP-1
[550.324592] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.495s)
[550.644553] Starting dynamic subtest: pipe-B-eDP-1
[553.846674] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.217s)
[554.144889] Subtest plane-all-transition-nonblocking-fencing: SUCCESS (6.317s)
[554.977392] [130/133] (476s left) gem_ctx_exec (basic-invalid-context)
[555.034729] Starting subtest: basic-invalid-context
[555.044388] Subtest basic-invalid-context: SUCCESS (0.009s)
[555.164652] [131/133] (475s left) kms_mmap_write_crc (main)
[555.264207] Starting subtest: main
[555.266557] Starting dynamic subtest: pipe-A-eDP-1
[558.725195] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.462s)
[558.727590] Subtest main: SUCCESS (3.463s)
[559.609336] [132/133] (471s left) perf_pmu (semaphore-wait)
[559.653859] Starting subtest: semaphore-wait
[559.656115] Starting dynamic subtest: rcs0
[560.166777] Dynamic subtest rcs0: SUCCESS (0.513s)
[560.181270] Starting dynamic subtest: bcs0
[560.679594] Dynamic subtest bcs0: SUCCESS (0.511s)
[560.694805] Starting dynamic subtest: vcs0
[561.193320] Dynamic subtest vcs0: SUCCESS (0.510s)
[561.207017] Starting dynamic subtest: vcs1
[561.706348] Dynamic subtest vcs1: SUCCESS (0.510s)
[561.721804] Starting dynamic subtest: vecs0
[562.219471] Dynamic subtest vecs0: SUCCESS (0.510s)
[562.233449] Starting dynamic subtest: ccs0
[562.736794] Dynamic subtest ccs0: SUCCESS (0.513s)
[562.740180] Subtest semaphore-wait: SUCCESS (3.084s)
[562.866459] [133/133] (468s left) kms_frontbuffer_tracking (psr-suspend)
[562.966482] Starting subtest: psr-suspend
[601.790597] Subtest psr-suspend: SUCCESS (8.669s)
[601.923039] Closing watchdogs
results: parsing output: 0/ for test: kms_frontbuffer_tracking
results: parsing output: 1/ for test: kms_big_fb
results: parsing output: 2/ for test: kms_vrr
results: parsing output: 3/ for test: kms_chamelium_color
results: parsing output: 4/ for test: kms_flip
results: parsing output: 5/ for test: kms_cursor_edge_walk
results: parsing output: 6/ for test: kms_flip
results: parsing output: 7/ for test: gem_exec_gttfill
results: parsing output: 8/ for test: i915_pm_freq_mult
results: parsing output: 9/ for test: gem_exec_suspend
results: parsing output: 10/ for test: kms_psr
results: parsing output: 11/ for test: gem_exec_schedule
results: parsing output: 12/ for test: kms_psr
results: parsing output: 13/ for test: kms_frontbuffer_tracking
results: parsing output: 14/ for test: kms_frontbuffer_tracking
results: parsing output: 15/ for test: gem_userptr_blits
results: parsing output: 16/ for test: kms_ccs
results: parsing output: 17/ for test: kms_plane_scaling
results: parsing output: 18/ for test: syncobj_wait
results: parsing output: 19/ for test: kms_chamelium_frames
results: parsing output: 20/ for test: kms_big_fb
results: parsing output: 21/ for test: kms_psr
results: parsing output: 22/ for test: gem_softpin
results: parsing output: 23/ for test: kms_frontbuffer_tracking
results: parsing output: 24/ for test: kms_big_fb
results: parsing output: 25/ for test: kms_flip
results: parsing output: 26/ for test: syncobj_eventfd
results: parsing output: 27/ for test: gem_render_copy
results: parsing output: 28/ for test: kms_frontbuffer_tracking
results: parsing output: 29/ for test: gem_ctx_exec
results: parsing output: 30/ for test: kms_frontbuffer_tracking
results: parsing output: 31/ for test: kms_ccs
results: parsing output: 32/ for test: kms_addfb_basic
results: parsing output: 33/ for test: kms_vblank
results: parsing output: 34/ for test: kms_flip_scaled_crc
results: parsing output: 35/ for test: gem_tiled_pread_basic
results: parsing output: 36/ for test: kms_frontbuffer_tracking
results: parsing output: 37/ for test: gem_exec_balancer
results: parsing output: 38/ for test: kms_frontbuffer_tracking
results: parsing output: 39/ for test: gem_eio
results: parsing output: 40/ for test: kms_frontbuffer_tracking
results: parsing output: 41/ for test: gem_softpin
results: parsing output: 42/ for test: kms_content_protection
results: parsing output: 43/ for test: kms_psr
results: parsing output: 44/ for test: prime_vgem
results: parsing output: 45/ for test: kms_frontbuffer_tracking
results: parsing output: 46/ for test: gem_pxp
results: parsing output: 47/ for test: kms_flip_scaled_crc
results: parsing output: 48/ for test: gem_exec_schedule
results: parsing output: 49/ for test: gem_exec_whisper
results: parsing output: 50/ for test: kms_draw_crc
results: parsing output: 51/ for test: tools_test
results: parsing output: 52/ for test: kms_pm_rpm
results: parsing output: 53/ for test: kms_frontbuffer_tracking
results: parsing output: 54/ for test: i915_drm_fdinfo
results: parsing output: 55/ for test: kms_prop_blob
results: parsing output: 56/ for test: kms_frontbuffer_tracking
results: parsing output: 57/ for test: kms_big_fb
results: parsing output: 58/ for test: gem_userptr_blits
results: parsing output: 59/ for test: vgem_basic
results: parsing output: 60/ for test: kms_universal_plane
results: parsing output: 61/ for test: syncobj_wait
results: parsing output: 62/ for test: gem_mmap_offset
results: parsing output: 63/ for test: gen7_exec_parse
results: parsing output: 64/ for test: kms_invalid_mode
results: parsing output: 65/ for test: api_intel_allocator
results: parsing output: 66/ for test: kms_frontbuffer_tracking
results: parsing output: 67/ for test: kms_psr2_sf
results: parsing output: 68/ for test: gem_mmap_gtt
results: parsing output: 69/ for test: prime_mmap_coherency
results: parsing output: 70/ for test: kms_psr
results: parsing output: 71/ for test: gem_ctx_shared
results: parsing output: 72/ for test: syncobj_timeline
results: parsing output: 73/ for test: kms_cursor_crc
results: parsing output: 74/ for test: i915_hangman
results: parsing output: 75/ for test: dmabuf_sync_file
results: parsing output: 76/ for test: gem_exec_flush
results: parsing output: 77/ for test: kms_cursor_legacy
results: parsing output: 78/ for test: syncobj_timeline
results: parsing output: 79/ for test: kms_cursor_legacy
results: parsing output: 80/ for test: kms_ccs
results: parsing output: 81/ for test: gem_wait
results: parsing output: 82/ for test: gem_exec_schedule
results: parsing output: 83/ for test: gem_basic
results: parsing output: 84/ for test: kms_atomic_transition
results: parsing output: 85/ for test: kms_chamelium_frames
results: parsing output: 86/ for test: kms_frontbuffer_tracking
results: parsing output: 87/ for test: gem_mmap_gtt
results: parsing output: 88/ for test: gem_render_copy
results: parsing output: 89/ for test: kms_cursor_crc
results: parsing output: 90/ for test: syncobj_wait
results: parsing output: 91/ for test: syncobj_wait
results: parsing output: 92/ for test: syncobj_wait
results: parsing output: 93/ for test: api_intel_bb
results: parsing output: 94/ for test: kms_flip
results: parsing output: 95/ for test: kms_color
results: parsing output: 96/ for test: sysfs_heartbeat_interval
results: parsing output: 97/ for test: kms_frontbuffer_tracking
results: parsing output: 98/ for test: kms_big_fb
results: parsing output: 99/ for test: gem_mmap_wc
results: parsing output: 100/ for test: kms_ccs
results: parsing output: 101/ for test: gem_ctx_persistence
results: parsing output: 102/ for test: kms_lease
results: parsing output: 103/ for test: syncobj_timeline
results: parsing output: 104/ for test: syncobj_timeline
results: parsing output: 105/ for test: kms_addfb_basic
results: parsing output: 106/ for test: perf_pmu
results: parsing output: 107/ for test: kms_frontbuffer_tracking
results: parsing output: 108/ for test: gem_exec_whisper
results: parsing output: 109/ for test: kms_frontbuffer_tracking
results: parsing output: 110/ for test: gem_render_copy
results: parsing output: 111/ for test: kms_big_fb
results: parsing output: 112/ for test: i915_query
results: parsing output: 113/ for test: kms_plane
results: parsing output: 114/ for test: kms_atomic
results: parsing output: 115/ for test: gem_exec_fence
results: parsing output: 116/ for test: kms_plane
results: parsing output: 117/ for test: perf
results: parsing output: 118/ for test: kms_plane
results: parsing output: 119/ for test: kms_flip
results: parsing output: 120/ for test: sw_sync
results: parsing output: 121/ for test: syncobj_wait
results: parsing output: 122/ for test: kms_psr
results: parsing output: 123/ for test: kms_frontbuffer_tracking
results: parsing output: 124/ for test: kms_pm_rpm
results: parsing output: 125/ for test: kms_flip
results: parsing output: 126/ for test: gem_exec_balancer
results: parsing output: 127/ for test: kms_big_fb
results: parsing output: 128/ for test: kms_atomic_transition
results: parsing output: 129/ for test: gem_ctx_exec
results: parsing output: 130/ for test: kms_mmap_write_crc
results: parsing output: 131/ for test: perf_pmu
results: parsing output: 132/ for test: kms_frontbuffer_tracking
Done.