[60.565991] Initializing watchdogs
[60.566228]   /dev/watchdog0
[60.580612] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:7dd5 Intel Meteorlake (Gen12) Meteor Lake-P [Intel Graphics]
[60.584551] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[60.586621] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[60.589881] [001/133] (960s left) kms_frontbuffer_tracking (psr-modesetfrombusy)
[60.690857] Starting subtest: psr-modesetfrombusy
[67.089457] Subtest psr-modesetfrombusy: SUCCESS (6.422s)
[67.789857] [002/133] (953s left) kms_big_fb (yf-tiled-32bpp-rotate-270)
[68.136371] Starting subtest: yf-tiled-32bpp-rotate-270
[68.140620] Subtest yf-tiled-32bpp-rotate-270: SKIP (0.000s)
[68.243103] [003/133] (952s left) kms_vrr (negative-basic)
[68.330348] Starting subtest: negative-basic
[68.337081] Starting dynamic subtest: pipe-A-eDP-1
[73.750324] Dynamic subtest pipe-A-eDP-1: SUCCESS (5.418s)
[74.038930] Subtest negative-basic: SUCCESS (5.715s)
[74.886910] [004/133] (946s left) kms_chamelium_color (ctm-0-75)
[74.962137] Subtest ctm-0-75: SKIP (0.000s)
[75.006310] [005/133] (946s left) kms_flip (flip-vs-panning-interruptible)
[75.083912] Starting subtest: flip-vs-panning-interruptible
[75.086242] Starting dynamic subtest: A-eDP1
[83.798323] Dynamic subtest A-eDP1: SUCCESS (8.715s)
[83.808468] Starting dynamic subtest: B-eDP1
[92.535757] Dynamic subtest B-eDP1: SUCCESS (8.736s)
[92.543125] Starting dynamic subtest: C-eDP1
[101.261638] Dynamic subtest C-eDP1: SUCCESS (8.723s)
[101.270492] Starting dynamic subtest: D-eDP1
[109.984043] Dynamic subtest D-eDP1: SUCCESS (8.720s)
[109.986300] Subtest flip-vs-panning-interruptible: SUCCESS (34.903s)
[111.148391] [006/133] (910s left) kms_cursor_edge_walk (128x128-left-edge)
[111.231857] Starting subtest: 128x128-left-edge
[111.234142] Starting dynamic subtest: pipe-A-eDP-1
[114.711823] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.479s)
[114.720283] Starting dynamic subtest: pipe-D-eDP-1
[117.848047] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.135s)
[117.850453] Subtest 128x128-left-edge: SUCCESS (6.617s)
[118.656495] [007/133] (902s left) kms_flip (2x-flip-vs-wf_vblank)
[118.730928] Starting subtest: 2x-flip-vs-wf_vblank
[118.738095] Subtest 2x-flip-vs-wf_vblank: SKIP (0.008s)
[118.822435] [008/133] (902s left) gem_exec_gttfill (basic)
[118.883978] Starting subtest: basic
[121.504474] Subtest basic: SUCCESS (2.620s)
[121.716541] [009/133] (899s left) i915_pm_freq_mult (media-freq)
[121.814203] Starting subtest: media-freq
[121.816764] Starting dynamic subtest: gt0
[121.821412] Dynamic subtest gt0: SKIP (0.000s)
[121.833963] Starting dynamic subtest: gt1
[121.838367] Dynamic subtest gt1: SKIP (0.000s)
[121.842454] Subtest media-freq: SKIP (0.001s)
[121.904948] [010/133] (899s left) gem_exec_suspend (basic-s3-devices)
[121.971287] Starting subtest: basic-S3-devices
[121.973887] Starting dynamic subtest: smem
[133.786752] Dynamic subtest smem: SUCCESS (11.813s)
[133.789891] Subtest basic-S3-devices: SUCCESS (11.815s)
[133.980682] [011/133] (887s left) kms_psr (fbc-pr-cursor-mmap-gtt)
[134.084895] Starting subtest: fbc-pr-cursor-mmap-gtt
[134.089323] Subtest fbc-pr-cursor-mmap-gtt: SKIP (0.000s)
[134.156414] [012/133] (887s left) gem_exec_schedule (fairslice-all)
[134.251128] Starting subtest: fairslice-all
[136.313230] Subtest fairslice-all: SUCCESS (2.060s)
[136.612990] [013/133] (884s left) kms_psr (pr-sprite-plane-onoff)
[136.680999] Starting subtest: pr-sprite-plane-onoff
[136.685905] Subtest pr-sprite-plane-onoff: SKIP (0.000s)
[136.752762] [014/133] (884s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-render)
[136.825905] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-render
[136.830458] Subtest fbc-2p-primscrn-cur-indfb-draw-render: SKIP (0.000s)
[136.919167] [015/133] (884s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-mmap-gtt)
[137.006678] Starting subtest: psr-2p-primscrn-cur-indfb-draw-mmap-gtt
[137.010800] Subtest psr-2p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[137.097123] [016/133] (884s left) gem_userptr_blits (sync-overlap)
[137.163699] Starting subtest: sync-overlap
[137.165711] Subtest sync-overlap: SUCCESS (0.000s)
[137.283102] [017/133] (884s left) kms_ccs (crc-primary-suspend-4-tiled-mtl-rc-ccs)
[137.362396] Starting subtest: crc-primary-suspend-4-tiled-mtl-rc-ccs
[137.364308] Starting dynamic subtest: pipe-A-eDP-1
[154.222584] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.467s)
[154.234672] Starting dynamic subtest: pipe-B-eDP-1
[171.179970] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.461s)
[171.189106] Starting dynamic subtest: pipe-C-eDP-1
[188.177097] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.411s)
[188.187808] Starting dynamic subtest: pipe-D-eDP-1
[205.194354] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.458s)
[205.196593] Subtest crc-primary-suspend-4-tiled-mtl-rc-ccs: SUCCESS (8.801s)
[206.381046] [018/133] (815s left) kms_plane_scaling (plane-scaler-with-clipping-clamping-rotation)
[206.458711] Starting subtest: plane-scaler-with-clipping-clamping-rotation
[206.461181] Starting dynamic subtest: pipe-A
[206.682114] Dynamic subtest pipe-A: SUCCESS (0.229s)
[206.690454] Starting dynamic subtest: pipe-B
[207.939571] Dynamic subtest pipe-B: SUCCESS (1.282s)
[207.947817] Starting dynamic subtest: pipe-C
[209.249709] Dynamic subtest pipe-C: SUCCESS (1.331s)
[209.259071] Starting dynamic subtest: pipe-D
[210.617383] Dynamic subtest pipe-D: SUCCESS (1.386s)
[210.619743] Subtest plane-scaler-with-clipping-clamping-rotation: SUCCESS (4.233s)
[211.847654] [019/133] (809s left) syncobj_wait (single-wait-all-for-submit-unsubmitted)
[211.907971] Starting subtest: single-wait-all-for-submit-unsubmitted
[212.012777] Subtest single-wait-all-for-submit-unsubmitted: SUCCESS (0.106s)
[212.087468] [020/133] (809s left) kms_chamelium_frames (hdmi-frame-dump)
[212.442814] Subtest hdmi-frame-dump: SKIP (0.000s)
[213.229945] [021/133] (808s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-180-hflip)
[213.317483] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-180-hflip
[213.321883] Subtest y-tiled-max-hw-stride-32bpp-rotate-180-hflip: SKIP (0.000s)
[213.415553] [022/133] (808s left) kms_psr (fbc-psr-primary-page-flip)
[213.505096] Starting subtest: fbc-psr-primary-page-flip
[213.507007] Starting dynamic subtest: eDP-1
[213.511035] Dynamic subtest eDP-1: SKIP (0.000s)
[213.515076] Subtest fbc-psr-primary-page-flip: SKIP (0.001s)
[213.578489] [023/133] (808s left) gem_softpin (allocator-nopin)
[213.636127] Starting subtest: allocator-nopin
[213.717891] Subtest allocator-nopin: SUCCESS (0.082s)
[213.838307] [024/133] (808s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-shrfb-draw-mmap-cpu)
[213.917065] Starting subtest: psr-1p-offscreen-pri-shrfb-draw-mmap-cpu
[220.419284] Subtest psr-1p-offscreen-pri-shrfb-draw-mmap-cpu: SUCCESS (6.542s)
[220.567152] [025/133] (801s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-0)
[220.653142] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-0
[221.617848] Subtest 4-tiled-max-hw-stride-32bpp-rotate-0: SUCCESS (0.968s)
[221.729072] [026/133] (800s left) kms_flip (flip-vs-rmfb-interruptible)
[221.805292] Starting subtest: flip-vs-rmfb-interruptible
[221.807543] Starting dynamic subtest: A-eDP1
[230.439462] Dynamic subtest A-eDP1: SUCCESS (8.652s)
[230.453405] Starting dynamic subtest: B-eDP1
[239.042244] Dynamic subtest B-eDP1: SUCCESS (8.606s)
[239.051136] Starting dynamic subtest: C-eDP1
[247.665084] Dynamic subtest C-eDP1: SUCCESS (8.617s)
[247.679306] Starting dynamic subtest: D-eDP1
[256.298550] Dynamic subtest D-eDP1: SUCCESS (8.629s)
[256.303169] Subtest flip-vs-rmfb-interruptible: SUCCESS (34.516s)
[257.488296] [027/133] (764s left) syncobj_eventfd (binary-wait-before-signal)
[257.550551] Starting subtest: binary-wait-before-signal
[257.579742] Subtest binary-wait-before-signal: SUCCESS (0.031s)
[257.653699] [028/133] (764s left) gem_render_copy (yf-tiled)
[257.713677] Starting subtest: yf-tiled
[257.718358] Subtest yf-tiled: SKIP (0.000s)
[257.894852] [029/133] (764s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-blt)
[257.974747] Starting subtest: psr-2p-primscrn-spr-indfb-draw-blt
[257.979493] Subtest psr-2p-primscrn-spr-indfb-draw-blt: SKIP (0.000s)
[258.069648] [030/133] (764s left) gem_ctx_exec (basic-norecovery)
[258.128864] Starting subtest: basic-norecovery
[258.471121] Subtest basic-norecovery: SUCCESS (0.343s)
[258.576118] [031/133] (763s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-blt)
[258.661421] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-blt
[265.916051] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-blt: SUCCESS (7.258s)
[266.075268] [032/133] (756s left) kms_ccs (crc-sprite-planes-basic-4-tiled-dg2-rc-ccs-cc)
[266.162712] Starting subtest: crc-sprite-planes-basic-4-tiled-dg2-rc-ccs-cc
[266.164984] Starting dynamic subtest: pipe-A-eDP-1
[266.221909] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[266.230605] Starting dynamic subtest: pipe-B-eDP-1
[266.287144] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[266.297043] Starting dynamic subtest: pipe-C-eDP-1
[266.353708] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[266.362377] Starting dynamic subtest: pipe-D-eDP-1
[266.419504] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[266.423860] Subtest crc-sprite-planes-basic-4-tiled-dg2-rc-ccs-cc: SKIP (0.009s)
[268.388359] [033/133] (754s left) kms_addfb_basic (clobberred-modifier)
[268.444548] Starting subtest: clobberred-modifier
[268.448887] Subtest clobberred-modifier: SKIP (0.000s)
[268.563768] [034/133] (753s left) kms_vblank (query-idle)
[268.645071] Starting subtest: query-idle
[268.647271] Starting dynamic subtest: pipe-A-eDP-1
[270.391461] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.747s)
[270.408271] Starting dynamic subtest: pipe-D-eDP-1
[272.823429] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.431s)
[272.825713] Subtest query-idle: SUCCESS (4.181s)
[273.644020] [035/133] (748s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-32bpp-ytile-downscaling)
[273.728735] Starting subtest: flip-64bpp-ytile-to-32bpp-ytile-downscaling
[273.732968] Subtest flip-64bpp-ytile-to-32bpp-ytile-downscaling: SKIP (0.000s)
[273.802891] [036/133] (748s left) gem_tiled_pread_basic (basic)
[273.864003] Subtest basic: SKIP (0.000s)
[273.915264] [037/133] (748s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-pwrite)
[273.984982] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-pwrite
[273.989115] Subtest psr-2p-scndscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[274.093656] [038/133] (748s left) gem_exec_balancer (parallel-out-fence)
[274.347346] Starting subtest: parallel-out-fence
[275.483506] Subtest parallel-out-fence: SUCCESS (1.141s)
[275.590057] [039/133] (747s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-mmap-cpu)
[275.675513] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-mmap-cpu
[275.679231] Subtest fbc-2p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[275.782683] [040/133] (746s left) gem_eio (hibernate)
[276.021690] Starting subtest: hibernate
[289.473991] Subtest hibernate: SUCCESS (13.454s)
[297.639639] [041/133] (733s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-mmap-wc)
[297.729065] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-mmap-wc
[297.733535] Subtest fbc-2p-primscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[297.817724] [042/133] (732s left) gem_softpin (invalid)
[297.892918] Starting subtest: invalid
[297.898306] Subtest invalid: SUCCESS (0.006s)
[298.032440] [043/133] (732s left) kms_content_protection (lic-type-0)
[298.162293] Starting subtest: lic-type-0
[298.166653] Subtest lic-type-0: SKIP (0.000s)
[298.303165] [044/133] (732s left) kms_psr (psr-dpms)
[298.377874] Starting subtest: psr-dpms
[298.380116] Starting dynamic subtest: eDP-1
[301.303201] Dynamic subtest eDP-1: SUCCESS (2.925s)
[301.305438] Subtest psr-dpms: SUCCESS (2.926s)
[302.187192] [045/133] (728s left) prime_vgem (basic-fence-mmap)
[302.289907] Starting subtest: basic-fence-mmap
[302.294597] Subtest basic-fence-mmap: SKIP (0.000s)
[302.390710] [FACT prime_vgem (basic-fence-mmap)] new: kernel.kmod_is_loaded.vgem: true
[302.395140] [046/133] (728s left) kms_frontbuffer_tracking (fbcpsr-shrfb-scaledprimary)
[302.481675] Starting subtest: fbcpsr-shrfb-scaledprimary
[308.274119] Subtest fbcpsr-shrfb-scaledprimary: SUCCESS (5.793s)
[308.386627] [047/133] (722s left) gem_pxp (create-regular-buffer)
[308.513896] Starting subtest: create-regular-buffer
[308.516437] Subtest create-regular-buffer: SUCCESS (0.000s)
[308.635223] [048/133] (722s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling)
[308.721079] Starting subtest: flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling
[308.725521] Subtest flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling: SKIP (0.000s)
[308.794606] [049/133] (722s left) gem_exec_schedule (preempt-self)
[308.860309] Starting subtest: preempt-self
[308.862231] Starting dynamic subtest: rcs0
[308.876965] Dynamic subtest rcs0: SUCCESS (0.024s)
[308.888281] Starting dynamic subtest: bcs0
[308.896785] Dynamic subtest bcs0: SUCCESS (0.019s)
[308.906336] Starting dynamic subtest: vcs0
[308.920025] Dynamic subtest vcs0: SUCCESS (0.022s)
[308.930240] Starting dynamic subtest: vcs1
[308.940456] Dynamic subtest vcs1: SUCCESS (0.020s)
[308.949953] Starting dynamic subtest: vecs0
[308.960160] Dynamic subtest vecs0: SUCCESS (0.019s)
[308.969950] Starting dynamic subtest: ccs0
[308.981348] Dynamic subtest ccs0: SUCCESS (0.020s)
[308.983590] Subtest preempt-self: SUCCESS (0.129s)
[310.116418] [050/133] (721s left) gem_exec_whisper (basic-sync-all)
[310.181896] Starting subtest: basic-sync-all
[317.920282] Subtest basic-sync-all: SUCCESS (7.734s)
[318.104297] [051/133] (713s left) kms_draw_crc (draw-method-render)
[318.184100] Starting subtest: draw-method-render
[318.186294] Starting dynamic subtest: xrgb8888-untiled
[318.428260] Dynamic subtest xrgb8888-untiled: SUCCESS (0.244s)
[318.441367] Starting dynamic subtest: rgb565-untiled
[318.639098] Dynamic subtest rgb565-untiled: SUCCESS (0.210s)
[318.650084] Starting dynamic subtest: xrgb2101010-untiled
[318.851805] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.210s)
[318.862055] Starting dynamic subtest: xbgr16161616f-untiled
[319.061186] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.210s)
[319.071520] Starting dynamic subtest: xrgb8888-xtiled
[319.183362] Dynamic subtest xrgb8888-xtiled: SUCCESS (0.121s)
[319.197000] Starting dynamic subtest: rgb565-xtiled
[319.316544] Dynamic subtest rgb565-xtiled: SUCCESS (0.133s)
[319.326399] Starting dynamic subtest: xrgb2101010-xtiled
[319.427550] Dynamic subtest xrgb2101010-xtiled: SUCCESS (0.110s)
[319.446354] Starting dynamic subtest: xbgr16161616f-xtiled
[319.550124] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (0.122s)
[319.560238] Starting dynamic subtest: xrgb8888-4tiled
[319.672243] Dynamic subtest xrgb8888-4tiled: SUCCESS (0.121s)
[319.682546] Starting dynamic subtest: rgb565-4tiled
[319.783467] Dynamic subtest rgb565-4tiled: SUCCESS (0.110s)
[319.795378] Starting dynamic subtest: xrgb2101010-4tiled
[319.894638] Dynamic subtest xrgb2101010-4tiled: SUCCESS (0.110s)
[319.905003] Starting dynamic subtest: xbgr16161616f-4tiled
[320.017041] Dynamic subtest xbgr16161616f-4tiled: SUCCESS (0.121s)
[320.019028] Subtest draw-method-render: SUCCESS (1.834s)
[320.140822] [052/133] (711s left) tools_test (tools_test)
[320.193172] Starting subtest: tools_test
[320.248963] Subtest tools_test: SUCCESS (0.068s)
[320.307557] [053/133] (710s left) kms_pm_rpm (modeset-lpsp-stress)
[322.122021] Starting subtest: modeset-lpsp-stress
[336.345198] Subtest modeset-lpsp-stress: SUCCESS (14.222s)
[336.438384] [054/133] (694s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-mmap-cpu)
[336.534013] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-mmap-cpu
[336.538042] Subtest fbc-2p-scndscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[336.632714] [055/133] (694s left) i915_drm_fdinfo (busy)
[336.679685] Starting subtest: busy
[336.681913] Starting dynamic subtest: rcs0
[336.707009] Dynamic subtest rcs0: SKIP (0.025s)
[336.719906] Starting dynamic subtest: bcs0
[336.724089] Dynamic subtest bcs0: SKIP (0.000s)
[336.734677] Starting dynamic subtest: vcs0
[336.738866] Dynamic subtest vcs0: SKIP (0.000s)
[336.748800] Starting dynamic subtest: vcs1
[336.752914] Dynamic subtest vcs1: SKIP (0.000s)
[336.762604] Starting dynamic subtest: vecs0
[336.766697] Dynamic subtest vecs0: SKIP (0.000s)
[336.776467] Starting dynamic subtest: ccs0
[336.780626] Dynamic subtest ccs0: SKIP (0.000s)
[336.784897] Subtest busy: SKIP (0.030s)
[336.821979] [056/133] (694s left) kms_prop_blob (invalid-get-prop)
[336.872382] Starting subtest: invalid-get-prop
[336.874502] Subtest invalid-get-prop: SUCCESS (0.000s)
[336.966140] [057/133] (694s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-indfb-draw-blt)
[337.046489] Starting subtest: psr-1p-offscreen-pri-indfb-draw-blt
[343.943127] Subtest psr-1p-offscreen-pri-indfb-draw-blt: SUCCESS (6.897s)
[344.095205] [058/133] (687s left) kms_big_fb (yf-tiled-addfb-size-overflow)
[344.176664] Starting subtest: yf-tiled-addfb-size-overflow
[344.180953] Subtest yf-tiled-addfb-size-overflow: SKIP (0.000s)
[344.271425] [059/133] (687s left) gem_userptr_blits (create-destroy-unsync)
[344.335942] Subtest create-destroy-unsync: SKIP (0.000s)
[344.444805] [060/133] (687s left) vgem_basic (dmabuf-export)
[344.488833] Starting subtest: dmabuf-export
[344.517351] Subtest dmabuf-export: SUCCESS (0.031s)
[344.614665] [061/133] (686s left) kms_universal_plane (universal-plane-sanity)
[344.685193] Starting subtest: universal-plane-sanity
[344.687586] Starting dynamic subtest: pipe-A-eDP-1
[345.291711] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.605s)
[345.302912] Starting dynamic subtest: pipe-B-eDP-1
[346.579179] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.286s)
[346.590579] Starting dynamic subtest: pipe-C-eDP-1
[347.775150] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.195s)
[347.786375] Starting dynamic subtest: pipe-D-eDP-1
[348.992474] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.216s)
[348.994820] Subtest universal-plane-sanity: SUCCESS (4.308s)
[349.853379] [062/133] (681s left) syncobj_wait (signal)
[349.911354] Starting subtest: signal
[349.913533] Subtest signal: SUCCESS (0.000s)
[350.004292] [063/133] (681s left) gem_mmap_offset (blt-coherency)
[350.060133] Starting subtest: blt-coherency
[350.067382] Subtest blt-coherency: SUCCESS (0.009s)
[350.200499] [064/133] (681s left) gen7_exec_parse (chained-batch)
[350.263241] Subtest chained-batch: SKIP (0.000s)
[350.336734] [065/133] (681s left) kms_invalid_mode (bad-hsync-end)
[350.415378] Starting subtest: bad-hsync-end
[350.417662] Starting dynamic subtest: pipe-A-eDP-1
[350.705561] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.293s)
[350.716963] Starting dynamic subtest: pipe-B-eDP-1
[350.719157] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[350.728699] Starting dynamic subtest: pipe-C-eDP-1
[350.730977] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[350.740422] Starting dynamic subtest: pipe-D-eDP-1
[350.742602] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[350.744697] Subtest bad-hsync-end: SUCCESS (0.299s)
[351.505318] [066/133] (680s left) api_intel_allocator (simple-allocator)
[351.567668] Starting subtest: simple-allocator
[351.570004] Starting dynamic subtest: basic
[351.572370] Dynamic subtest basic: SUCCESS (0.004s)
[351.586653] Starting dynamic subtest: parallel-one
[351.759063] Dynamic subtest parallel-one: SUCCESS (0.188s)
[351.769594] Starting dynamic subtest: print
[351.771923] Dynamic subtest print: SUCCESS (0.000s)
[351.781813] Starting dynamic subtest: reuse
[351.783993] Dynamic subtest reuse: SUCCESS (0.000s)
[351.793657] Starting dynamic subtest: reserve
[351.795895] Dynamic subtest reserve: SUCCESS (0.000s)
[351.805585] Starting dynamic subtest: fork-reopen-allocator
[351.807787] Dynamic subtest fork-reopen-allocator: SUCCESS (0.012s)
[351.809975] Subtest simple-allocator: SUCCESS (0.211s)
[351.896518] [067/133] (679s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-move)
[351.989419] Starting subtest: fbc-2p-scndscrn-spr-indfb-move
[351.993296] Subtest fbc-2p-scndscrn-spr-indfb-move: SKIP (0.000s)
[352.095431] [068/133] (679s left) kms_psr2_sf (pr-cursor-plane-move-continuous-sf)
[352.173324] Starting subtest: pr-cursor-plane-move-continuous-sf
[352.177213] Subtest pr-cursor-plane-move-continuous-sf: SKIP (0.000s)
[352.284999] [069/133] (679s left) gem_mmap_gtt (basic-read-write-distinct)
[352.361814] Subtest basic-read-write-distinct: SKIP (0.000s)
[352.425237] [070/133] (679s left) prime_mmap_coherency (ioctl-errors)
[352.474907] Starting subtest: ioctl-errors
[367.997812] Subtest ioctl-errors: SUCCESS (15.523s)
[368.183499] [071/133] (663s left) kms_psr (psr-cursor-mmap-gtt)
[368.290509] Starting subtest: psr-cursor-mmap-gtt
[368.292374] Starting dynamic subtest: eDP-1
[370.000401] Dynamic subtest eDP-1: SUCCESS (1.709s)
[370.002714] Subtest psr-cursor-mmap-gtt: SUCCESS (1.710s)
[370.864573] [072/133] (661s left) gem_ctx_shared (single-timeline)
[370.933653] Starting subtest: single-timeline
[370.951993] Subtest single-timeline: SUCCESS (0.013s)
[371.193812] [073/133] (660s left) syncobj_timeline (multi-wait-for-submit-submitted-signaled)
[371.252900] Starting subtest: multi-wait-for-submit-submitted-signaled
[371.255382] Subtest multi-wait-for-submit-submitted-signaled: SUCCESS (0.001s)
[371.344823] [074/133] (660s left) kms_cursor_crc (cursor-offscreen-128x42)
[371.561346] Starting subtest: cursor-offscreen-128x42
[371.611188] Subtest cursor-offscreen-128x42: SKIP (0.044s)
[371.814273] [075/133] (660s left) i915_hangman (engine-engine-error)
[371.878824] Starting subtest: engine-engine-error
[371.881047] Starting dynamic subtest: rcs0
[373.040007] Dynamic subtest rcs0: SUCCESS (1.161s)
[373.052575] Starting dynamic subtest: bcs0
[375.024759] Dynamic subtest bcs0: SUCCESS (1.983s)
[375.038724] Starting dynamic subtest: vcs0
[377.006664] Dynamic subtest vcs0: SUCCESS (1.979s)
[377.021148] Starting dynamic subtest: vcs1
[378.990787] Dynamic subtest vcs1: SUCCESS (1.982s)
[379.005291] Starting dynamic subtest: vecs0
[381.038953] Dynamic subtest vecs0: SUCCESS (2.046s)
[381.055420] Starting dynamic subtest: ccs0
[383.023578] Dynamic subtest ccs0: SUCCESS (1.982s)
[383.026413] Subtest engine-engine-error: SUCCESS (11.148s)
[383.156334] [076/133] (649s left) dmabuf_sync_file (import-basic)
[383.204149] Starting subtest: import-basic
[383.206639] Subtest import-basic: SUCCESS (0.001s)
[383.280025] [077/133] (649s left) gem_exec_flush (basic-wb-set-default)
[383.351630] Starting subtest: basic-wb-set-default
[388.811818] Subtest basic-wb-set-default: SUCCESS (5.461s)
[389.015446] [078/133] (643s left) kms_cursor_legacy (2x-flip-vs-cursor-legacy)
[389.135571] Starting subtest: 2x-flip-vs-cursor-legacy
[389.140367] Subtest 2x-flip-vs-cursor-legacy: SKIP (0.001s)
[389.279520] [079/133] (643s left) syncobj_timeline (etime-single-wait-for-submit-unsubmitted)
[389.339298] Starting subtest: etime-single-wait-for-submit-unsubmitted
[389.444780] Subtest etime-single-wait-for-submit-unsubmitted: SUCCESS (0.105s)
[389.519229] [080/133] (642s left) kms_cursor_legacy (short-busy-flip-before-cursor-toggle)
[389.624560] Starting subtest: short-busy-flip-before-cursor-toggle
[389.628997] Subtest short-busy-flip-before-cursor-toggle: SKIP (0.000s)
[389.770907] [081/133] (642s left) kms_ccs (bad-aux-stride-y-tiled-gen12-rc-ccs)
[389.848889] Starting subtest: bad-aux-stride-y-tiled-gen12-rc-ccs
[389.851068] Starting dynamic subtest: pipe-A-eDP-1
[389.874084] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[389.886770] Starting dynamic subtest: pipe-B-eDP-1
[389.908666] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[389.919631] Starting dynamic subtest: pipe-C-eDP-1
[389.941494] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[389.954187] Starting dynamic subtest: pipe-D-eDP-1
[389.974807] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[389.978671] Subtest bad-aux-stride-y-tiled-gen12-rc-ccs: SKIP (0.004s)
[392.140370] [082/133] (640s left) gem_wait (invalid-flags)
[392.214467] Starting subtest: invalid-flags
[392.216696] Subtest invalid-flags: SUCCESS (0.000s)
[392.443019] [083/133] (640s left) gem_exec_schedule (lateslice)
[392.512114] Starting subtest: lateslice
[392.514074] Starting dynamic subtest: rcs0
[392.522298] Dynamic subtest rcs0: SUCCESS (0.021s)
[392.535180] Starting dynamic subtest: bcs0
[392.539701] Dynamic subtest bcs0: SUCCESS (0.017s)
[392.550742] Starting dynamic subtest: vcs0
[392.559415] Dynamic subtest vcs0: SUCCESS (0.019s)
[392.569993] Starting dynamic subtest: vcs1
[392.576464] Dynamic subtest vcs1: SUCCESS (0.016s)
[392.587201] Starting dynamic subtest: vecs0
[392.594102] Dynamic subtest vecs0: SUCCESS (0.017s)
[392.604434] Starting dynamic subtest: ccs0
[392.613503] Dynamic subtest ccs0: SUCCESS (0.019s)
[392.615780] Subtest lateslice: SUCCESS (0.113s)
[394.147112] [084/133] (638s left) gem_basic (multigpu-create-close)
[394.201226] Starting subtest: multigpu-create-close
[394.205607] Subtest multigpu-create-close: SKIP (0.000s)
[394.294073] [085/133] (638s left) kms_atomic_transition (plane-use-after-nonblocking-unbind-fencing)
[394.363935] Starting subtest: plane-use-after-nonblocking-unbind-fencing
[394.366233] Starting dynamic subtest: pipe-A-eDP-1
[394.428831] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.064s)
[394.736949] Starting dynamic subtest: pipe-B-eDP-1
[395.553186] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.826s)
[395.842571] Subtest plane-use-after-nonblocking-unbind-fencing: SUCCESS (1.478s)
[396.705769] [086/133] (635s left) kms_chamelium_frames (vga-frame-dump)
[397.069336] Subtest vga-frame-dump: SKIP (0.000s)
[397.922215] [087/133] (634s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-pwrite)
[398.002004] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-pwrite
[398.006492] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[398.092549] [088/133] (634s left) gem_mmap_gtt (cpuset-basic-small-copy-odd)
[398.138738] Subtest cpuset-basic-small-copy-odd: SKIP (0.000s)
[398.196144] [089/133] (634s left) gem_render_copy (yf-tiled-to-vebox-x-tiled)
[398.259761] Starting subtest: yf-tiled-to-vebox-x-tiled
[398.264107] Subtest yf-tiled-to-vebox-x-tiled: SKIP (0.000s)
[398.452289] [090/133] (634s left) kms_cursor_crc (cursor-sliding-128x42)
[398.662057] Starting subtest: cursor-sliding-128x42
[398.707461] Subtest cursor-sliding-128x42: SKIP (0.039s)
[398.903884] [091/133] (634s left) syncobj_wait (multi-wait-all-for-submit-unsubmitted-submitted)
[398.951726] Starting subtest: multi-wait-all-for-submit-unsubmitted-submitted
[399.052228] Subtest multi-wait-all-for-submit-unsubmitted-submitted: SUCCESS (0.101s)
[399.139572] [092/133] (633s left) syncobj_wait (invalid-reset-bad-pad)
[399.194334] Starting subtest: invalid-reset-bad-pad
[399.196575] Subtest invalid-reset-bad-pad: SUCCESS (0.000s)
[399.286554] [093/133] (633s left) syncobj_wait (single-wait-signaled)
[399.341375] Starting subtest: single-wait-signaled
[399.343600] Subtest single-wait-signaled: SUCCESS (0.000s)
[399.452612] [094/133] (633s left) api_intel_bb (render-ccs)
[399.506624] Starting subtest: render-ccs
[399.872189] Subtest render-ccs: SUCCESS (0.364s)
[399.956841] [095/133] (633s left) kms_flip (plain-flip-fb-recreate)
[400.027256] Starting subtest: plain-flip-fb-recreate
[400.029690] Starting dynamic subtest: A-eDP1
[408.935875] Dynamic subtest A-eDP1: SUCCESS (8.912s)
[408.949959] Starting dynamic subtest: B-eDP1
[417.772089] Dynamic subtest B-eDP1: SUCCESS (8.834s)
[417.793922] Starting dynamic subtest: C-eDP1
[426.589779] Dynamic subtest C-eDP1: SUCCESS (8.817s)
[426.600665] Starting dynamic subtest: D-eDP1
[435.415865] Dynamic subtest D-eDP1: SUCCESS (8.826s)
[435.419777] Subtest plain-flip-fb-recreate: SUCCESS (35.401s)
[436.583377] [096/133] (596s left) kms_color (ctm-green-to-red)
[436.659240] Starting subtest: ctm-green-to-red
[436.661468] Starting dynamic subtest: pipe-A-eDP-1
[437.368102] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.709s)
[437.379944] Starting dynamic subtest: pipe-B-eDP-1
[438.760466] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.390s)
[438.771970] Starting dynamic subtest: pipe-C-eDP-1
[440.050365] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.290s)
[440.061349] Starting dynamic subtest: pipe-D-eDP-1
[441.404393] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.354s)
[441.406682] Subtest ctm-green-to-red: SUCCESS (4.746s)
[442.208768] [097/133] (590s left) sysfs_heartbeat_interval (idempotent)
[442.267693] Starting subtest: idempotent
[442.270158] Starting dynamic subtest: vecs0
[442.272533] Dynamic subtest vecs0: SUCCESS (0.001s)
[442.285645] Starting dynamic subtest: ccs0
[442.287897] Dynamic subtest ccs0: SUCCESS (0.001s)
[442.298338] Starting dynamic subtest: vcs0
[442.300583] Dynamic subtest vcs0: SUCCESS (0.000s)
[442.310477] Starting dynamic subtest: bcs0
[442.312896] Dynamic subtest bcs0: SUCCESS (0.001s)
[442.326239] Starting dynamic subtest: rcs0
[442.328531] Dynamic subtest rcs0: SUCCESS (0.000s)
[442.339765] Starting dynamic subtest: vcs1
[442.342065] Dynamic subtest vcs1: SUCCESS (0.001s)
[442.344301] Subtest idempotent: SUCCESS (0.008s)
[442.382372] [098/133] (590s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-mmap-gtt)
[442.455828] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-mmap-gtt
[442.459872] Subtest fbc-2p-scndscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[442.546309] [099/133] (590s left) kms_big_fb (linear-max-hw-stride-32bpp-rotate-0)
[442.629589] Starting subtest: linear-max-hw-stride-32bpp-rotate-0
[443.832179] Subtest linear-max-hw-stride-32bpp-rotate-0: SUCCESS (1.203s)
[443.955107] [100/133] (589s left) gem_mmap_wc (write-read-distinct)
[444.019490] Subtest write-read-distinct: SKIP (0.000s)
[444.079425] [101/133] (589s left) kms_ccs (ccs-on-another-bo-4-tiled-mtl-rc-ccs-cc)
[444.159185] Starting subtest: ccs-on-another-bo-4-tiled-mtl-rc-ccs-cc
[444.161171] Starting dynamic subtest: pipe-A-eDP-1
[444.178177] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[444.192421] Starting dynamic subtest: pipe-B-eDP-1
[444.208530] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[444.219074] Starting dynamic subtest: pipe-C-eDP-1
[444.235244] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[444.246355] Starting dynamic subtest: pipe-D-eDP-1
[444.262695] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[444.264329] Subtest ccs-on-another-bo-4-tiled-mtl-rc-ccs-cc: SUCCESS (0.008s)
[446.476226] [102/133] (586s left) gem_ctx_persistence (heartbeat-many)
[446.534722] Starting subtest: heartbeat-many
[446.539303] Subtest heartbeat-many: SKIP (0.000s)
[446.647021] [103/133] (586s left) kms_lease (multimaster-lease)
[446.725006] Starting subtest: multimaster-lease
[446.729894] Subtest multimaster-lease: SUCCESS (0.003s)
[446.844471] [104/133] (586s left) syncobj_timeline (single-wait-signaled)
[446.896128] Starting subtest: single-wait-signaled
[446.898373] Subtest single-wait-signaled: SUCCESS (0.000s)
[446.988772] [105/133] (586s left) syncobj_timeline (multi-wait-all-available-submitted-signaled)
[447.045785] Starting subtest: multi-wait-all-available-submitted-signaled
[447.047727] Subtest multi-wait-all-available-submitted-signaled: SUCCESS (0.000s)
[447.139032] [106/133] (586s left) kms_addfb_basic (addfb25-y-tiled-legacy)
[447.220683] Starting subtest: addfb25-y-tiled-legacy
[447.222489] Subtest addfb25-y-tiled-legacy: SUCCESS (0.000s)
[447.321134] [107/133] (586s left) perf_pmu (idle)
[447.361598] Starting subtest: idle
[447.363848] Starting dynamic subtest: rcs0
[447.907910] Dynamic subtest rcs0: SUCCESS (0.545s)
[447.923987] Starting dynamic subtest: bcs0
[448.423776] Dynamic subtest bcs0: SUCCESS (0.513s)
[448.437499] Starting dynamic subtest: vcs0
[448.938715] Dynamic subtest vcs0: SUCCESS (0.512s)
[448.952567] Starting dynamic subtest: vcs1
[449.453304] Dynamic subtest vcs1: SUCCESS (0.512s)
[449.467515] Starting dynamic subtest: vecs0
[449.973693] Dynamic subtest vecs0: SUCCESS (0.518s)
[449.987962] Starting dynamic subtest: ccs0
[450.502014] Dynamic subtest ccs0: SUCCESS (0.527s)
[450.504796] Subtest idle: SUCCESS (3.143s)
[450.615159] [108/133] (583s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-shrfb-plflip-blt)
[450.705788] Starting subtest: fbcpsr-1p-primscrn-shrfb-plflip-blt
[458.004764] Subtest fbcpsr-1p-primscrn-shrfb-plflip-blt: SUCCESS (7.305s)
[458.144594] [109/133] (575s left) gem_exec_whisper (basic-contexts-priority-all)
[458.218594] Starting subtest: basic-contexts-priority-all
[481.221437] Subtest basic-contexts-priority-all: SUCCESS (23.003s)
[481.405848] [110/133] (552s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-blt)
[481.496624] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-blt
[488.773350] Subtest psr-1p-primscrn-pri-shrfb-draw-blt: SUCCESS (7.283s)
[488.876461] [111/133] (544s left) gem_render_copy (y-tiled-ccs-to-linear)
[488.940984] Starting subtest: y-tiled-ccs-to-linear
[488.945597] Subtest y-tiled-ccs-to-linear: SKIP (0.000s)
[489.126290] [112/133] (544s left) kms_big_fb (y-tiled-8bpp-rotate-180)
[489.206952] Starting subtest: y-tiled-8bpp-rotate-180
[489.211465] Subtest y-tiled-8bpp-rotate-180: SKIP (0.000s)
[489.308825] [113/133] (544s left) i915_query (hwconfig_table)
[489.369743] Starting subtest: hwconfig_table
[489.672293] Subtest hwconfig_table: SUCCESS (0.001s)
[489.716371] [114/133] (544s left) kms_plane (plane-panning-bottom-right-suspend)
[489.787997] Starting subtest: plane-panning-bottom-right-suspend
[489.789924] Starting dynamic subtest: pipe-A
[507.393961] Dynamic subtest pipe-A: SUCCESS (2.844s)
[507.406843] Starting dynamic subtest: pipe-B
[526.394765] Dynamic subtest pipe-B: SUCCESS (3.537s)
[526.396691] Subtest plane-panning-bottom-right-suspend: SUCCESS (6.383s)
[527.203580] [115/133] (506s left) kms_atomic (plane-invalid-params)
[527.277723] Starting subtest: plane-invalid-params
[527.279812] Starting dynamic subtest: pipe-A-eDP-1
[527.686370] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.415s)
[527.688174] Subtest plane-invalid-params: SUCCESS (0.416s)
[528.493509] [116/133] (505s left) gem_exec_fence (syncobj-repeat)
[528.976047] Starting subtest: syncobj-repeat
[529.155805] Subtest syncobj-repeat: SUCCESS (0.182s)
[530.430615] [117/133] (503s left) kms_plane (pixel-format-yf-tiled-ccs-modifier)
[530.503129] Starting subtest: pixel-format-yf-tiled-ccs-modifier
[530.506855] Subtest pixel-format-yf-tiled-ccs-modifier: SKIP (0.000s)
[530.573508] [118/133] (503s left) perf (rc6-disable)
[530.710667] Starting subtest: rc6-disable
[530.880973] Subtest rc6-disable: SUCCESS (0.175s)
[530.928073] [119/133] (503s left) kms_plane (pixel-format-4-tiled-dg2-rc-ccs-cc-modifier-source-clamping)
[531.008181] Starting subtest: pixel-format-4-tiled-dg2-rc-ccs-cc-modifier-source-clamping
[531.012400] Subtest pixel-format-4-tiled-dg2-rc-ccs-cc-modifier-source-clamping: SKIP (0.000s)
[531.080397] [120/133] (503s left) kms_flip (2x-dpms-vs-vblank-race)
[531.150243] Starting subtest: 2x-dpms-vs-vblank-race
[531.157167] Subtest 2x-dpms-vs-vblank-race: SKIP (0.008s)
[531.276534] [121/133] (502s left) sw_sync (sync_multi_timeline_wait)
[531.318700] Starting subtest: sync_multi_timeline_wait
[531.320743] Subtest sync_multi_timeline_wait: SUCCESS (0.000s)
[531.373667] [122/133] (502s left) syncobj_wait (multi-wait-all-for-submit-unsubmitted-signaled)
[531.423148] Starting subtest: multi-wait-all-for-submit-unsubmitted-signaled
[531.526883] Subtest multi-wait-all-for-submit-unsubmitted-signaled: SUCCESS (0.104s)
[531.611797] [123/133] (502s left) kms_psr (fbc-pr-primary-mmap-gtt)
[531.673155] Starting subtest: fbc-pr-primary-mmap-gtt
[531.677303] Subtest fbc-pr-primary-mmap-gtt: SKIP (0.000s)
[531.768062] [124/133] (502s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-shrfb-pgflip-blt)
[531.845138] Starting subtest: fbcpsr-2p-primscrn-shrfb-pgflip-blt
[531.849225] Subtest fbcpsr-2p-primscrn-shrfb-pgflip-blt: SKIP (0.000s)
[531.970148] [125/133] (502s left) kms_pm_rpm (dpms-lpsp)
[533.562232] Starting subtest: dpms-lpsp
[534.100740] Subtest dpms-lpsp: SUCCESS (0.549s)
[534.196685] [126/133] (500s left) kms_flip (flip-vs-dpms-on-nop)
[534.272403] Starting subtest: flip-vs-dpms-on-nop
[534.274571] Starting dynamic subtest: A-eDP1
[536.144894] Dynamic subtest A-eDP1: SUCCESS (1.889s)
[536.156048] Starting dynamic subtest: B-eDP1
[537.956007] Dynamic subtest B-eDP1: SUCCESS (1.821s)
[537.968791] Starting dynamic subtest: C-eDP1
[539.773505] Dynamic subtest C-eDP1: SUCCESS (1.826s)
[539.784334] Starting dynamic subtest: D-eDP1
[541.609888] Dynamic subtest D-eDP1: SUCCESS (1.842s)
[541.612166] Subtest flip-vs-dpms-on-nop: SUCCESS (7.386s)
[542.771695] [127/133] (491s left) gem_exec_balancer (parallel-balancer)
[543.022090] Starting subtest: parallel-balancer
[543.881133] Subtest parallel-balancer: SUCCESS (0.864s)
[543.994786] [128/133] (490s left) kms_big_fb (linear-32bpp-rotate-270)
[544.078847] Starting subtest: linear-32bpp-rotate-270
[544.098901] Subtest linear-32bpp-rotate-270: SKIP (0.020s)
[544.211307] [129/133] (490s left) kms_atomic_transition (plane-all-transition-nonblocking-fencing)
[544.283006] Starting subtest: plane-all-transition-nonblocking-fencing
[544.285276] Starting dynamic subtest: pipe-A-eDP-1
[546.777010] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.501s)
[547.084133] Starting dynamic subtest: pipe-B-eDP-1
[550.287602] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.220s)
[550.599154] Subtest plane-all-transition-nonblocking-fencing: SUCCESS (6.328s)
[551.415662] [130/133] (483s left) gem_ctx_exec (basic-invalid-context)
[551.487157] Starting subtest: basic-invalid-context
[551.491922] Subtest basic-invalid-context: SUCCESS (0.005s)
[551.623011] [131/133] (482s left) kms_mmap_write_crc (main)
[551.703912] Starting subtest: main
[551.706301] Starting dynamic subtest: pipe-A-eDP-1
[555.050526] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.347s)
[555.052505] Subtest main: SUCCESS (3.348s)
[555.946839] [132/133] (478s left) perf_pmu (semaphore-wait)
[555.981177] Starting subtest: semaphore-wait
[555.983520] Starting dynamic subtest: rcs0
[556.496043] Dynamic subtest rcs0: SUCCESS (0.515s)
[556.508016] Starting dynamic subtest: bcs0
[557.008875] Dynamic subtest bcs0: SUCCESS (0.510s)
[557.028815] Starting dynamic subtest: vcs0
[557.521982] Dynamic subtest vcs0: SUCCESS (0.511s)
[557.535986] Starting dynamic subtest: vcs1
[558.035494] Dynamic subtest vcs1: SUCCESS (0.510s)
[558.049272] Starting dynamic subtest: vecs0
[558.548593] Dynamic subtest vecs0: SUCCESS (0.510s)
[558.562472] Starting dynamic subtest: ccs0
[559.064481] Dynamic subtest ccs0: SUCCESS (0.512s)
[559.067296] Subtest semaphore-wait: SUCCESS (3.085s)
[560.438573] [133/133] (474s left) kms_frontbuffer_tracking (psr-suspend)
[560.523572] Starting subtest: psr-suspend
[599.522374] Subtest psr-suspend: SUCCESS (8.026s)
[599.630493] 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.