[58.597403] Initializing watchdogs
[58.597454]   /dev/watchdog0
[58.612792] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:7d55 Intel Meteorlake (Gen12) Meteor Lake-P [Intel Arc Graphics]
[58.617413] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[58.619806] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[58.623342] [001/133] (960s left) kms_frontbuffer_tracking (psr-modesetfrombusy)
[58.769075] Starting subtest: psr-modesetfrombusy
[64.897460] Subtest psr-modesetfrombusy: SUCCESS (6.134s)
[65.032993] [002/133] (954s left) kms_big_fb (yf-tiled-32bpp-rotate-270)
[65.132150] Starting subtest: yf-tiled-32bpp-rotate-270
[65.135897] Subtest yf-tiled-32bpp-rotate-270: SKIP (0.000s)
[65.238127] [003/133] (953s left) kms_vrr (negative-basic)
[65.333751] Starting subtest: negative-basic
[65.339681] Starting dynamic subtest: pipe-A-eDP-1
[70.762887] Dynamic subtest pipe-A-eDP-1: SUCCESS (5.417s)
[71.035387] Subtest negative-basic: SUCCESS (5.701s)
[71.935110] [004/133] (947s left) kms_chamelium_color (ctm-0-75)
[72.025799] Subtest ctm-0-75: SKIP (0.000s)
[72.068760] [005/133] (947s left) kms_flip (flip-vs-panning-interruptible)
[72.162904] Starting subtest: flip-vs-panning-interruptible
[72.165349] Starting dynamic subtest: A-eDP1
[80.937096] Dynamic subtest A-eDP1: SUCCESS (8.774s)
[80.946314] Starting dynamic subtest: B-eDP1
[89.666060] Dynamic subtest B-eDP1: SUCCESS (8.727s)
[89.674974] Starting dynamic subtest: C-eDP1
[98.382157] Dynamic subtest C-eDP1: SUCCESS (8.714s)
[98.389801] Starting dynamic subtest: D-eDP1
[107.032575] Dynamic subtest D-eDP1: SUCCESS (8.649s)
[107.037072] Subtest flip-vs-panning-interruptible: SUCCESS (34.874s)
[108.290629] [006/133] (911s left) kms_cursor_edge_walk (128x128-left-edge)
[108.389223] Starting subtest: 128x128-left-edge
[108.391593] Starting dynamic subtest: pipe-A-eDP-1
[111.856404] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.467s)
[111.865526] Starting dynamic subtest: pipe-D-eDP-1
[114.986042] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.129s)
[114.988328] Subtest 128x128-left-edge: SUCCESS (6.598s)
[115.783245] [007/133] (903s left) kms_flip (2x-flip-vs-wf_vblank)
[115.892256] Starting subtest: 2x-flip-vs-wf_vblank
[115.901590] Subtest 2x-flip-vs-wf_vblank: SKIP (0.011s)
[115.978308] [008/133] (903s left) gem_exec_gttfill (basic)
[116.050723] Starting subtest: basic
[118.954364] Subtest basic: SUCCESS (2.903s)
[119.159305] [009/133] (900s left) i915_pm_freq_mult (media-freq)
[119.263233] Starting subtest: media-freq
[119.265531] Starting dynamic subtest: gt0
[119.269661] Dynamic subtest gt0: SKIP (0.000s)
[119.277494] Starting dynamic subtest: gt1
[119.281646] Dynamic subtest gt1: SKIP (0.000s)
[119.285725] Subtest media-freq: SKIP (0.001s)
[119.362776] [010/133] (900s left) gem_exec_suspend (basic-s3-devices)
[119.443469] Starting subtest: basic-S3-devices
[119.445681] Starting dynamic subtest: smem
[130.903927] Dynamic subtest smem: SUCCESS (11.458s)
[130.906721] Subtest basic-S3-devices: SUCCESS (11.460s)
[131.089296] [011/133] (888s left) kms_psr (fbc-pr-cursor-mmap-gtt)
[131.210686] Starting subtest: fbc-pr-cursor-mmap-gtt
[131.215272] Subtest fbc-pr-cursor-mmap-gtt: SKIP (0.000s)
[131.287151] [012/133] (888s left) gem_exec_schedule (fairslice-all)
[131.357987] Starting subtest: fairslice-all
[133.423650] Subtest fairslice-all: SUCCESS (2.064s)
[134.953498] [013/133] (884s left) kms_psr (pr-sprite-plane-onoff)
[135.056072] Starting subtest: pr-sprite-plane-onoff
[135.060761] Subtest pr-sprite-plane-onoff: SKIP (0.000s)
[135.159412] [014/133] (884s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-render)
[135.262572] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-render
[135.266681] Subtest fbc-2p-primscrn-cur-indfb-draw-render: SKIP (0.000s)
[135.366742] [015/133] (884s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-mmap-gtt)
[135.465425] Starting subtest: psr-2p-primscrn-cur-indfb-draw-mmap-gtt
[135.469768] Subtest psr-2p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[135.568198] [016/133] (884s left) gem_userptr_blits (sync-overlap)
[135.636615] Starting subtest: sync-overlap
[135.638855] Subtest sync-overlap: SUCCESS (0.000s)
[135.770747] [017/133] (884s left) kms_ccs (crc-primary-suspend-4-tiled-mtl-rc-ccs)
[135.868258] Starting subtest: crc-primary-suspend-4-tiled-mtl-rc-ccs
[135.870630] Starting dynamic subtest: pipe-A-eDP-1
[152.094379] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.419s)
[152.103774] Starting dynamic subtest: pipe-B-eDP-1
[169.089026] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.459s)
[169.104412] Starting dynamic subtest: pipe-C-eDP-1
[186.040285] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.406s)
[186.049217] Starting dynamic subtest: pipe-D-eDP-1
[203.056072] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.386s)
[203.058898] Subtest crc-primary-suspend-4-tiled-mtl-rc-ccs: SUCCESS (8.675s)
[204.292985] [018/133] (815s left) kms_plane_scaling (plane-scaler-with-clipping-clamping-rotation)
[204.395987] Starting subtest: plane-scaler-with-clipping-clamping-rotation
[204.398707] Starting dynamic subtest: pipe-A
[204.624888] Dynamic subtest pipe-A: SUCCESS (0.229s)
[204.633823] Starting dynamic subtest: pipe-B
[205.898096] Dynamic subtest pipe-B: SUCCESS (1.271s)
[205.908698] Starting dynamic subtest: pipe-C
[207.246775] Dynamic subtest pipe-C: SUCCESS (1.347s)
[207.256165] Starting dynamic subtest: pipe-D
[208.558548] Dynamic subtest pipe-D: SUCCESS (1.309s)
[208.561084] Subtest plane-scaler-with-clipping-clamping-rotation: SUCCESS (4.160s)
[209.756064] [019/133] (810s left) syncobj_wait (single-wait-all-for-submit-unsubmitted)
[209.816071] Starting subtest: single-wait-all-for-submit-unsubmitted
[209.921495] Subtest single-wait-all-for-submit-unsubmitted: SUCCESS (0.106s)
[210.003422] [020/133] (809s left) kms_chamelium_frames (hdmi-frame-dump)
[210.393897] Subtest hdmi-frame-dump: SKIP (0.000s)
[211.170956] [021/133] (808s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-180-hflip)
[211.279119] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-180-hflip
[211.284719] Subtest y-tiled-max-hw-stride-32bpp-rotate-180-hflip: SKIP (0.000s)
[211.378700] [022/133] (808s left) kms_psr (fbc-psr-primary-page-flip)
[211.476073] Starting subtest: fbc-psr-primary-page-flip
[211.478449] Starting dynamic subtest: eDP-1
[211.483198] Dynamic subtest eDP-1: SKIP (0.000s)
[211.488208] Subtest fbc-psr-primary-page-flip: SKIP (0.001s)
[211.547952] [023/133] (808s left) gem_softpin (allocator-nopin)
[211.605364] Starting subtest: allocator-nopin
[211.684541] Subtest allocator-nopin: SUCCESS (0.079s)
[211.832445] [024/133] (808s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-shrfb-draw-mmap-cpu)
[211.929451] Starting subtest: psr-1p-offscreen-pri-shrfb-draw-mmap-cpu
[218.543327] Subtest psr-1p-offscreen-pri-shrfb-draw-mmap-cpu: SUCCESS (6.614s)
[218.657812] [025/133] (801s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-0)
[218.752195] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-0
[219.820072] Subtest 4-tiled-max-hw-stride-32bpp-rotate-0: SUCCESS (1.070s)
[219.919075] [026/133] (800s left) kms_flip (flip-vs-rmfb-interruptible)
[220.006204] Starting subtest: flip-vs-rmfb-interruptible
[220.007854] Starting dynamic subtest: A-eDP1
[228.625212] Dynamic subtest A-eDP1: SUCCESS (8.614s)
[228.636477] Starting dynamic subtest: B-eDP1
[237.255832] Dynamic subtest B-eDP1: SUCCESS (8.627s)
[237.267358] Starting dynamic subtest: C-eDP1
[245.874370] Dynamic subtest C-eDP1: SUCCESS (8.614s)
[245.883872] Starting dynamic subtest: D-eDP1
[254.507888] Dynamic subtest D-eDP1: SUCCESS (8.631s)
[254.512423] Subtest flip-vs-rmfb-interruptible: SUCCESS (34.499s)
[255.684698] [027/133] (764s left) syncobj_eventfd (binary-wait-before-signal)
[255.746825] Starting subtest: binary-wait-before-signal
[255.778342] Subtest binary-wait-before-signal: SUCCESS (0.032s)
[255.863655] [028/133] (764s left) gem_render_copy (yf-tiled)
[255.920045] Starting subtest: yf-tiled
[255.925176] Subtest yf-tiled: SKIP (0.000s)
[256.103121] [029/133] (764s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-blt)
[256.204233] Starting subtest: psr-2p-primscrn-spr-indfb-draw-blt
[256.209239] Subtest psr-2p-primscrn-spr-indfb-draw-blt: SKIP (0.000s)
[256.291409] [030/133] (764s left) gem_ctx_exec (basic-norecovery)
[256.349366] Starting subtest: basic-norecovery
[256.697801] Subtest basic-norecovery: SUCCESS (0.348s)
[256.831595] [031/133] (763s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-blt)
[256.932336] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-blt
[264.188795] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-blt: SUCCESS (7.259s)
[264.322031] [032/133] (756s left) kms_ccs (crc-sprite-planes-basic-4-tiled-dg2-rc-ccs-cc)
[264.416625] Starting subtest: crc-sprite-planes-basic-4-tiled-dg2-rc-ccs-cc
[264.419075] Starting dynamic subtest: pipe-A-eDP-1
[264.482039] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[264.491949] Starting dynamic subtest: pipe-B-eDP-1
[264.555567] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[264.564597] Starting dynamic subtest: pipe-C-eDP-1
[264.623821] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[264.632039] Starting dynamic subtest: pipe-D-eDP-1
[264.691570] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[264.695868] Subtest crc-sprite-planes-basic-4-tiled-dg2-rc-ccs-cc: SKIP (0.009s)
[266.681058] [033/133] (753s left) kms_addfb_basic (clobberred-modifier)
[266.731725] Starting subtest: clobberred-modifier
[266.736304] Subtest clobberred-modifier: SKIP (0.000s)
[266.865121] [034/133] (753s left) kms_vblank (query-idle)
[266.948934] Starting subtest: query-idle
[266.951193] Starting dynamic subtest: pipe-A-eDP-1
[268.706354] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.757s)
[268.723486] Starting dynamic subtest: pipe-D-eDP-1
[271.132299] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.423s)
[271.135101] Subtest query-idle: SUCCESS (4.184s)
[271.958520] [035/133] (748s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-32bpp-ytile-downscaling)
[272.061895] Starting subtest: flip-64bpp-ytile-to-32bpp-ytile-downscaling
[272.066833] Subtest flip-64bpp-ytile-to-32bpp-ytile-downscaling: SKIP (0.000s)
[272.132103] [036/133] (748s left) gem_tiled_pread_basic (basic)
[272.188812] Subtest basic: SKIP (0.000s)
[272.250182] [037/133] (748s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-pwrite)
[272.348997] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-pwrite
[272.354133] Subtest psr-2p-scndscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[272.454564] [038/133] (748s left) gem_exec_balancer (parallel-out-fence)
[272.717173] Starting subtest: parallel-out-fence
[274.158216] Subtest parallel-out-fence: SUCCESS (1.440s)
[274.254876] [039/133] (746s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-mmap-cpu)
[274.351895] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-mmap-cpu
[274.356813] Subtest fbc-2p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[274.447233] [040/133] (746s left) gem_eio (hibernate)
[274.695463] Starting subtest: hibernate
[289.357181] Subtest hibernate: SUCCESS (14.659s)
[297.496244] [041/133] (731s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-mmap-wc)
[297.609306] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-mmap-wc
[297.614063] Subtest fbc-2p-primscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[297.699558] [042/133] (731s left) gem_softpin (invalid)
[297.762081] Starting subtest: invalid
[297.770777] Subtest invalid: SUCCESS (0.007s)
[297.878302] [043/133] (731s left) kms_content_protection (lic-type-0)
[298.030472] Starting subtest: lic-type-0
[298.036023] Subtest lic-type-0: SKIP (0.000s)
[298.140194] [044/133] (730s left) kms_psr (psr-dpms)
[298.231202] Starting subtest: psr-dpms
[298.234115] Starting dynamic subtest: eDP-1
[301.214782] Dynamic subtest eDP-1: SUCCESS (2.987s)
[301.217547] Subtest psr-dpms: SUCCESS (2.988s)
[302.070949] [045/133] (726s left) prime_vgem (basic-fence-mmap)
[302.203633] Starting subtest: basic-fence-mmap
[302.208986] Subtest basic-fence-mmap: SKIP (0.000s)
[302.332057] [FACT prime_vgem (basic-fence-mmap)] new: kernel.kmod_is_loaded.vgem: true
[302.335995] [046/133] (726s left) kms_frontbuffer_tracking (fbcpsr-shrfb-scaledprimary)
[302.431920] Starting subtest: fbcpsr-shrfb-scaledprimary
[308.202871] Subtest fbcpsr-shrfb-scaledprimary: SUCCESS (5.777s)
[308.326860] [047/133] (720s left) gem_pxp (create-regular-buffer)
[308.453242] Starting subtest: create-regular-buffer
[308.456096] Subtest create-regular-buffer: SUCCESS (0.000s)
[308.571452] [048/133] (720s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling)
[308.666049] Starting subtest: flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling
[308.670993] Subtest flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling: SKIP (0.000s)
[308.737553] [049/133] (720s left) gem_exec_schedule (preempt-self)
[308.826830] Starting subtest: preempt-self
[308.829575] Starting dynamic subtest: rcs0
[308.837764] Dynamic subtest rcs0: SUCCESS (0.022s)
[308.848037] Starting dynamic subtest: bcs0
[308.854202] Dynamic subtest bcs0: SUCCESS (0.016s)
[308.864648] Starting dynamic subtest: vcs0
[308.877109] Dynamic subtest vcs0: SUCCESS (0.021s)
[308.887259] Starting dynamic subtest: vcs1
[308.892902] Dynamic subtest vcs1: SUCCESS (0.015s)
[308.903297] Starting dynamic subtest: vecs0
[308.909616] Dynamic subtest vecs0: SUCCESS (0.016s)
[308.919925] Starting dynamic subtest: ccs0
[308.927890] Dynamic subtest ccs0: SUCCESS (0.017s)
[308.930896] Subtest preempt-self: SUCCESS (0.112s)
[310.518903] [050/133] (718s left) gem_exec_whisper (basic-sync-all)
[310.600676] Starting subtest: basic-sync-all
[319.214122] Subtest basic-sync-all: SUCCESS (8.614s)
[319.402310] [051/133] (709s left) kms_draw_crc (draw-method-render)
[319.508960] Starting subtest: draw-method-render
[319.511069] Starting dynamic subtest: xrgb8888-untiled
[319.740885] Dynamic subtest xrgb8888-untiled: SUCCESS (0.233s)
[319.754839] Starting dynamic subtest: rgb565-untiled
[319.963235] Dynamic subtest rgb565-untiled: SUCCESS (0.222s)
[319.974741] Starting dynamic subtest: xrgb2101010-untiled
[320.185539] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.222s)
[320.196204] Starting dynamic subtest: xbgr16161616f-untiled
[320.429945] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.244s)
[320.440621] Starting dynamic subtest: xrgb8888-xtiled
[320.551821] Dynamic subtest xrgb8888-xtiled: SUCCESS (0.120s)
[320.562586] Starting dynamic subtest: rgb565-xtiled
[320.662820] Dynamic subtest rgb565-xtiled: SUCCESS (0.110s)
[320.673612] Starting dynamic subtest: xrgb2101010-xtiled
[320.784687] Dynamic subtest xrgb2101010-xtiled: SUCCESS (0.121s)
[320.799518] Starting dynamic subtest: xbgr16161616f-xtiled
[320.918190] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (0.133s)
[320.928403] Starting dynamic subtest: xrgb8888-4tiled
[321.040242] Dynamic subtest xrgb8888-4tiled: SUCCESS (0.121s)
[321.050537] Starting dynamic subtest: rgb565-4tiled
[321.162797] Dynamic subtest rgb565-4tiled: SUCCESS (0.122s)
[321.173684] Starting dynamic subtest: xrgb2101010-4tiled
[321.284781] Dynamic subtest xrgb2101010-4tiled: SUCCESS (0.121s)
[321.295354] Starting dynamic subtest: xbgr16161616f-4tiled
[321.418724] Dynamic subtest xbgr16161616f-4tiled: SUCCESS (0.131s)
[321.420747] Subtest draw-method-render: SUCCESS (1.912s)
[321.530955] [052/133] (707s left) tools_test (tools_test)
[321.591423] Starting subtest: tools_test
[321.644963] Subtest tools_test: SUCCESS (0.070s)
[321.706974] [053/133] (707s left) kms_pm_rpm (modeset-lpsp-stress)
[323.543448] Starting subtest: modeset-lpsp-stress
[340.031994] Subtest modeset-lpsp-stress: SUCCESS (16.491s)
[340.121078] [054/133] (689s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-mmap-cpu)
[340.225119] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-mmap-cpu
[340.230048] Subtest fbc-2p-scndscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[340.324767] [055/133] (689s left) i915_drm_fdinfo (busy)
[340.368674] Starting subtest: busy
[340.371026] Starting dynamic subtest: rcs0
[340.388837] Dynamic subtest rcs0: SKIP (0.021s)
[340.399444] Starting dynamic subtest: bcs0
[340.404276] Dynamic subtest bcs0: SKIP (0.001s)
[340.414578] Starting dynamic subtest: vcs0
[340.419375] Dynamic subtest vcs0: SKIP (0.000s)
[340.429608] Starting dynamic subtest: vcs1
[340.434805] Dynamic subtest vcs1: SKIP (0.000s)
[340.445033] Starting dynamic subtest: vecs0
[340.450137] Dynamic subtest vecs0: SKIP (0.000s)
[340.460130] Starting dynamic subtest: ccs0
[340.465627] Dynamic subtest ccs0: SKIP (0.000s)
[340.470916] Subtest busy: SKIP (0.028s)
[340.511842] [056/133] (688s left) kms_prop_blob (invalid-get-prop)
[340.566685] Starting subtest: invalid-get-prop
[340.568927] Subtest invalid-get-prop: SUCCESS (0.000s)
[340.660286] [057/133] (688s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-indfb-draw-blt)
[340.752615] Starting subtest: psr-1p-offscreen-pri-indfb-draw-blt
[347.705775] Subtest psr-1p-offscreen-pri-indfb-draw-blt: SUCCESS (6.957s)
[347.838697] [058/133] (681s left) kms_big_fb (yf-tiled-addfb-size-overflow)
[347.937606] Starting subtest: yf-tiled-addfb-size-overflow
[347.942778] Subtest yf-tiled-addfb-size-overflow: SKIP (0.000s)
[348.055563] [059/133] (681s left) gem_userptr_blits (create-destroy-unsync)
[348.128886] Subtest create-destroy-unsync: SKIP (0.000s)
[348.256620] [060/133] (681s left) vgem_basic (dmabuf-export)
[348.306045] Starting subtest: dmabuf-export
[348.330136] Subtest dmabuf-export: SUCCESS (0.031s)
[348.436039] [061/133] (681s left) kms_universal_plane (universal-plane-sanity)
[348.529871] Starting subtest: universal-plane-sanity
[348.532062] Starting dynamic subtest: pipe-A-eDP-1
[349.126925] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.595s)
[349.139136] Starting dynamic subtest: pipe-B-eDP-1
[350.317265] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.191s)
[350.332924] Starting dynamic subtest: pipe-C-eDP-1
[351.536190] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.217s)
[351.548796] Starting dynamic subtest: pipe-D-eDP-1
[352.757768] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.218s)
[352.760477] Subtest universal-plane-sanity: SUCCESS (4.228s)
[353.634846] [062/133] (676s left) syncobj_wait (signal)
[353.683032] Starting subtest: signal
[353.686042] Subtest signal: SUCCESS (0.000s)
[353.795046] [063/133] (675s left) gem_mmap_offset (blt-coherency)
[353.853360] Starting subtest: blt-coherency
[353.859077] Subtest blt-coherency: SUCCESS (0.007s)
[353.971506] [064/133] (675s left) gen7_exec_parse (chained-batch)
[354.036705] Subtest chained-batch: SKIP (0.000s)
[354.104472] [065/133] (675s left) kms_invalid_mode (bad-hsync-end)
[354.200368] Starting subtest: bad-hsync-end
[354.202619] Starting dynamic subtest: pipe-A-eDP-1
[354.484050] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.285s)
[354.496205] Starting dynamic subtest: pipe-B-eDP-1
[354.498735] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[354.509361] Starting dynamic subtest: pipe-C-eDP-1
[354.512234] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[354.523130] Starting dynamic subtest: pipe-D-eDP-1
[354.525895] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[354.528495] Subtest bad-hsync-end: SUCCESS (0.291s)
[355.349034] [066/133] (674s left) api_intel_allocator (simple-allocator)
[355.414785] Starting subtest: simple-allocator
[355.417821] Starting dynamic subtest: basic
[355.420903] Dynamic subtest basic: SUCCESS (0.004s)
[355.435362] Starting dynamic subtest: parallel-one
[355.623301] Dynamic subtest parallel-one: SUCCESS (0.205s)
[355.634158] Starting dynamic subtest: print
[355.636575] Dynamic subtest print: SUCCESS (0.000s)
[355.647413] Starting dynamic subtest: reuse
[355.650041] Dynamic subtest reuse: SUCCESS (0.000s)
[355.661218] Starting dynamic subtest: reserve
[355.663928] Dynamic subtest reserve: SUCCESS (0.000s)
[355.674450] Starting dynamic subtest: fork-reopen-allocator
[355.677178] Dynamic subtest fork-reopen-allocator: SUCCESS (0.014s)
[355.680089] Subtest simple-allocator: SUCCESS (0.228s)
[355.765039] [067/133] (674s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-move)
[355.870095] Starting subtest: fbc-2p-scndscrn-spr-indfb-move
[355.875437] Subtest fbc-2p-scndscrn-spr-indfb-move: SKIP (0.000s)
[355.962822] [068/133] (674s left) kms_psr2_sf (pr-cursor-plane-move-continuous-sf)
[356.068776] Starting subtest: pr-cursor-plane-move-continuous-sf
[356.073556] Subtest pr-cursor-plane-move-continuous-sf: SKIP (0.000s)
[356.143251] [069/133] (673s left) gem_mmap_gtt (basic-read-write-distinct)
[356.204882] Subtest basic-read-write-distinct: SKIP (0.000s)
[356.270906] [070/133] (673s left) prime_mmap_coherency (ioctl-errors)
[356.334932] Starting subtest: ioctl-errors
[379.756601] Subtest ioctl-errors: SUCCESS (23.419s)
[379.912598] [071/133] (650s left) kms_psr (psr-cursor-mmap-gtt)
[380.052021] Starting subtest: psr-cursor-mmap-gtt
[380.054572] Starting dynamic subtest: eDP-1
[381.736863] Dynamic subtest eDP-1: SUCCESS (1.684s)
[381.739709] Subtest psr-cursor-mmap-gtt: SUCCESS (1.685s)
[382.600693] [072/133] (647s left) gem_ctx_shared (single-timeline)
[382.667881] Starting subtest: single-timeline
[382.691990] Subtest single-timeline: SUCCESS (0.015s)
[382.913607] [073/133] (647s left) syncobj_timeline (multi-wait-for-submit-submitted-signaled)
[382.986796] Starting subtest: multi-wait-for-submit-submitted-signaled
[382.989227] Subtest multi-wait-for-submit-submitted-signaled: SUCCESS (0.001s)
[383.067359] [074/133] (647s left) kms_cursor_crc (cursor-offscreen-128x42)
[383.295581] Starting subtest: cursor-offscreen-128x42
[383.341770] Subtest cursor-offscreen-128x42: SKIP (0.041s)
[383.569541] [075/133] (646s left) i915_hangman (engine-engine-error)
[383.634880] Starting subtest: engine-engine-error
[383.637411] Starting dynamic subtest: rcs0
[385.412409] Dynamic subtest rcs0: SUCCESS (1.778s)
[385.427029] Starting dynamic subtest: bcs0
[387.395777] Dynamic subtest bcs0: SUCCESS (1.980s)
[387.416801] Starting dynamic subtest: vcs0
[389.379983] Dynamic subtest vcs0: SUCCESS (1.982s)
[389.394662] Starting dynamic subtest: vcs1
[391.364342] Dynamic subtest vcs1: SUCCESS (1.982s)
[391.378545] Starting dynamic subtest: vecs0
[393.412652] Dynamic subtest vecs0: SUCCESS (2.046s)
[393.425945] Starting dynamic subtest: ccs0
[395.396672] Dynamic subtest ccs0: SUCCESS (1.981s)
[395.399833] Subtest engine-engine-error: SUCCESS (11.763s)
[395.494491] [076/133] (634s left) dmabuf_sync_file (import-basic)
[395.556076] Starting subtest: import-basic
[395.559508] Subtest import-basic: SUCCESS (0.001s)
[395.620495] [077/133] (634s left) gem_exec_flush (basic-wb-set-default)
[395.690025] Starting subtest: basic-wb-set-default
[401.160099] Subtest basic-wb-set-default: SUCCESS (5.471s)
[401.353148] [078/133] (629s left) kms_cursor_legacy (2x-flip-vs-cursor-legacy)
[401.488525] Starting subtest: 2x-flip-vs-cursor-legacy
[401.493094] Subtest 2x-flip-vs-cursor-legacy: SKIP (0.001s)
[401.637684] [079/133] (628s left) syncobj_timeline (etime-single-wait-for-submit-unsubmitted)
[401.688736] Starting subtest: etime-single-wait-for-submit-unsubmitted
[401.794329] Subtest etime-single-wait-for-submit-unsubmitted: SUCCESS (0.106s)
[401.876377] [080/133] (628s left) kms_cursor_legacy (short-busy-flip-before-cursor-toggle)
[401.987962] Starting subtest: short-busy-flip-before-cursor-toggle
[401.992720] Subtest short-busy-flip-before-cursor-toggle: SKIP (0.000s)
[402.135814] [081/133] (628s left) kms_ccs (bad-aux-stride-y-tiled-gen12-rc-ccs)
[402.232211] Starting subtest: bad-aux-stride-y-tiled-gen12-rc-ccs
[402.234574] Starting dynamic subtest: pipe-A-eDP-1
[402.260245] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[402.276443] Starting dynamic subtest: pipe-B-eDP-1
[402.301389] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[402.312595] Starting dynamic subtest: pipe-C-eDP-1
[402.337825] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[402.348079] Starting dynamic subtest: pipe-D-eDP-1
[402.374869] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[402.380160] Subtest bad-aux-stride-y-tiled-gen12-rc-ccs: SKIP (0.004s)
[404.472423] [082/133] (626s left) gem_wait (invalid-flags)
[404.538020] Starting subtest: invalid-flags
[404.540678] Subtest invalid-flags: SUCCESS (0.000s)
[404.773947] [083/133] (625s left) gem_exec_schedule (lateslice)
[404.848207] Starting subtest: lateslice
[404.850942] Starting dynamic subtest: rcs0
[404.860803] Dynamic subtest rcs0: SUCCESS (0.026s)
[404.872845] Starting dynamic subtest: bcs0
[404.880223] Dynamic subtest bcs0: SUCCESS (0.019s)
[404.891354] Starting dynamic subtest: vcs0
[404.897971] Dynamic subtest vcs0: SUCCESS (0.017s)
[404.908764] Starting dynamic subtest: vcs1
[404.915897] Dynamic subtest vcs1: SUCCESS (0.017s)
[404.926857] Starting dynamic subtest: vecs0
[404.938553] Dynamic subtest vecs0: SUCCESS (0.020s)
[404.949710] Starting dynamic subtest: ccs0
[404.958361] Dynamic subtest ccs0: SUCCESS (0.020s)
[404.961344] Subtest lateslice: SUCCESS (0.124s)
[406.520095] [084/133] (624s left) gem_basic (multigpu-create-close)
[406.572957] Starting subtest: multigpu-create-close
[406.578633] Subtest multigpu-create-close: SKIP (0.000s)
[406.670812] [085/133] (624s left) kms_atomic_transition (plane-use-after-nonblocking-unbind-fencing)
[406.761549] Starting subtest: plane-use-after-nonblocking-unbind-fencing
[406.763932] Starting dynamic subtest: pipe-A-eDP-1
[406.824327] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.064s)
[407.149915] Starting dynamic subtest: pipe-B-eDP-1
[407.976589] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.843s)
[408.264200] Subtest plane-use-after-nonblocking-unbind-fencing: SUCCESS (1.503s)
[409.141411] [086/133] (621s left) kms_chamelium_frames (vga-frame-dump)
[409.524054] Subtest vga-frame-dump: SKIP (0.000s)
[410.354673] [087/133] (620s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-pwrite)
[410.455398] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-pwrite
[410.459995] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[410.550663] [088/133] (620s left) gem_mmap_gtt (cpuset-basic-small-copy-odd)
[410.608958] Subtest cpuset-basic-small-copy-odd: SKIP (0.000s)
[410.670315] [089/133] (620s left) gem_render_copy (yf-tiled-to-vebox-x-tiled)
[410.733220] Starting subtest: yf-tiled-to-vebox-x-tiled
[410.738956] Subtest yf-tiled-to-vebox-x-tiled: SKIP (0.000s)
[410.919626] [090/133] (620s left) kms_cursor_crc (cursor-sliding-128x42)
[411.156690] Starting subtest: cursor-sliding-128x42
[411.203583] Subtest cursor-sliding-128x42: SKIP (0.045s)
[411.435441] [091/133] (619s left) syncobj_wait (multi-wait-all-for-submit-unsubmitted-submitted)
[411.497328] Starting subtest: multi-wait-all-for-submit-unsubmitted-submitted
[411.602641] Subtest multi-wait-all-for-submit-unsubmitted-submitted: SUCCESS (0.105s)
[411.705625] [092/133] (619s left) syncobj_wait (invalid-reset-bad-pad)
[411.761232] Starting subtest: invalid-reset-bad-pad
[411.763709] Subtest invalid-reset-bad-pad: SUCCESS (0.000s)
[411.862013] [093/133] (619s left) syncobj_wait (single-wait-signaled)
[411.926162] Starting subtest: single-wait-signaled
[411.928717] Subtest single-wait-signaled: SUCCESS (0.000s)
[412.013103] [094/133] (619s left) api_intel_bb (render-ccs)
[412.083287] Starting subtest: render-ccs
[412.432632] Subtest render-ccs: SUCCESS (0.351s)
[412.550783] [095/133] (618s left) kms_flip (plain-flip-fb-recreate)
[412.644955] Starting subtest: plain-flip-fb-recreate
[412.647601] Starting dynamic subtest: A-eDP1
[421.554936] Dynamic subtest A-eDP1: SUCCESS (8.909s)
[421.565780] Starting dynamic subtest: B-eDP1
[430.390438] Dynamic subtest B-eDP1: SUCCESS (8.832s)
[430.410858] Starting dynamic subtest: C-eDP1
[439.225463] Dynamic subtest C-eDP1: SUCCESS (8.831s)
[439.236093] Starting dynamic subtest: D-eDP1
[448.066673] Dynamic subtest D-eDP1: SUCCESS (8.839s)
[448.070923] Subtest plain-flip-fb-recreate: SUCCESS (35.423s)
[449.251856] [096/133] (582s left) kms_color (ctm-green-to-red)
[449.364188] Starting subtest: ctm-green-to-red
[449.366588] Starting dynamic subtest: pipe-A-eDP-1
[450.048783] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.686s)
[450.061052] Starting dynamic subtest: pipe-B-eDP-1
[451.448621] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.397s)
[451.460202] Starting dynamic subtest: pipe-C-eDP-1
[452.810058] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.363s)
[452.821969] Starting dynamic subtest: pipe-D-eDP-1
[454.128858] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.318s)
[454.131762] Subtest ctm-green-to-red: SUCCESS (4.767s)
[454.990169] [097/133] (576s left) sysfs_heartbeat_interval (idempotent)
[455.052904] Starting subtest: idempotent
[455.055635] Starting dynamic subtest: vecs0
[455.058117] Dynamic subtest vecs0: SUCCESS (0.001s)
[455.071246] Starting dynamic subtest: ccs0
[455.073859] Dynamic subtest ccs0: SUCCESS (0.001s)
[455.084665] Starting dynamic subtest: vcs0
[455.087381] Dynamic subtest vcs0: SUCCESS (0.000s)
[455.098782] Starting dynamic subtest: bcs0
[455.101359] Dynamic subtest bcs0: SUCCESS (0.001s)
[455.112132] Starting dynamic subtest: rcs0
[455.115183] Dynamic subtest rcs0: SUCCESS (0.000s)
[455.127748] Starting dynamic subtest: vcs1
[455.130344] Dynamic subtest vcs1: SUCCESS (0.000s)
[455.133323] Subtest idempotent: SUCCESS (0.008s)
[455.177580] [098/133] (576s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-mmap-gtt)
[455.275656] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-mmap-gtt
[455.280812] Subtest fbc-2p-scndscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[455.374882] [099/133] (576s left) kms_big_fb (linear-max-hw-stride-32bpp-rotate-0)
[455.485712] Starting subtest: linear-max-hw-stride-32bpp-rotate-0
[456.722370] Subtest linear-max-hw-stride-32bpp-rotate-0: SUCCESS (1.235s)
[456.834999] [100/133] (574s left) gem_mmap_wc (write-read-distinct)
[456.886297] Subtest write-read-distinct: SKIP (0.000s)
[456.943599] [101/133] (574s left) kms_ccs (ccs-on-another-bo-4-tiled-mtl-rc-ccs-cc)
[457.035853] Starting subtest: ccs-on-another-bo-4-tiled-mtl-rc-ccs-cc
[457.037862] Starting dynamic subtest: pipe-A-eDP-1
[457.056694] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[457.068681] Starting dynamic subtest: pipe-B-eDP-1
[457.088078] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[457.098613] Starting dynamic subtest: pipe-C-eDP-1
[457.119229] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[457.132046] Starting dynamic subtest: pipe-D-eDP-1
[457.152430] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[457.154792] Subtest ccs-on-another-bo-4-tiled-mtl-rc-ccs-cc: SUCCESS (0.008s)
[459.347282] [102/133] (572s left) gem_ctx_persistence (heartbeat-many)
[459.415888] Starting subtest: heartbeat-many
[459.421155] Subtest heartbeat-many: SKIP (0.001s)
[459.529535] [103/133] (572s left) kms_lease (multimaster-lease)
[459.623194] Starting subtest: multimaster-lease
[459.625565] Subtest multimaster-lease: SUCCESS (0.004s)
[459.722942] [104/133] (571s left) syncobj_timeline (single-wait-signaled)
[459.788395] Starting subtest: single-wait-signaled
[459.790736] Subtest single-wait-signaled: SUCCESS (0.000s)
[459.882081] [105/133] (571s left) syncobj_timeline (multi-wait-all-available-submitted-signaled)
[459.937266] Starting subtest: multi-wait-all-available-submitted-signaled
[459.940003] Subtest multi-wait-all-available-submitted-signaled: SUCCESS (0.000s)
[460.024580] [106/133] (571s left) kms_addfb_basic (addfb25-y-tiled-legacy)
[460.120013] Starting subtest: addfb25-y-tiled-legacy
[460.122305] Subtest addfb25-y-tiled-legacy: SUCCESS (0.000s)
[460.210567] [107/133] (571s left) perf_pmu (idle)
[460.259742] Starting subtest: idle
[460.262024] Starting dynamic subtest: rcs0
[460.798857] Dynamic subtest rcs0: SUCCESS (0.537s)
[460.811972] Starting dynamic subtest: bcs0
[461.314962] Dynamic subtest bcs0: SUCCESS (0.513s)
[461.327984] Starting dynamic subtest: vcs0
[461.842623] Dynamic subtest vcs0: SUCCESS (0.524s)
[461.857991] Starting dynamic subtest: vcs1
[462.372994] Dynamic subtest vcs1: SUCCESS (0.522s)
[462.384996] Starting dynamic subtest: vecs0
[462.901710] Dynamic subtest vecs0: SUCCESS (0.515s)
[462.912596] Starting dynamic subtest: ccs0
[463.403958] Dynamic subtest ccs0: SUCCESS (0.513s)
[463.406949] Subtest idle: SUCCESS (3.144s)
[463.503580] [108/133] (568s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-shrfb-plflip-blt)
[463.616099] Starting subtest: fbcpsr-1p-primscrn-shrfb-plflip-blt
[471.062611] Subtest fbcpsr-1p-primscrn-shrfb-plflip-blt: SUCCESS (7.450s)
[471.203580] [109/133] (560s left) gem_exec_whisper (basic-contexts-priority-all)
[471.278254] Starting subtest: basic-contexts-priority-all
[495.538816] Subtest basic-contexts-priority-all: SUCCESS (24.257s)
[495.726072] [110/133] (536s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-blt)
[495.826793] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-blt
[503.192487] Subtest psr-1p-primscrn-pri-shrfb-draw-blt: SUCCESS (7.367s)
[503.320380] [111/133] (528s left) gem_render_copy (y-tiled-ccs-to-linear)
[503.381163] Starting subtest: y-tiled-ccs-to-linear
[503.386506] Subtest y-tiled-ccs-to-linear: SKIP (0.000s)
[503.568579] [112/133] (528s left) kms_big_fb (y-tiled-8bpp-rotate-180)
[503.671332] Starting subtest: y-tiled-8bpp-rotate-180
[503.676070] Subtest y-tiled-8bpp-rotate-180: SKIP (0.000s)
[503.776577] [113/133] (528s left) i915_query (hwconfig_table)
[503.830355] Starting subtest: hwconfig_table
[504.190025] Subtest hwconfig_table: SUCCESS (0.001s)
[504.235453] [114/133] (527s left) kms_plane (plane-panning-bottom-right-suspend)
[504.320734] Starting subtest: plane-panning-bottom-right-suspend
[504.323248] Starting dynamic subtest: pipe-A
[522.243188] Dynamic subtest pipe-A: SUCCESS (2.740s)
[522.259629] Starting dynamic subtest: pipe-B
[540.260012] Dynamic subtest pipe-B: SUCCESS (3.495s)
[540.262300] Subtest plane-panning-bottom-right-suspend: SUCCESS (6.241s)
[541.079498] [115/133] (491s left) kms_atomic (plane-invalid-params)
[541.186080] Starting subtest: plane-invalid-params
[541.187998] Starting dynamic subtest: pipe-A-eDP-1
[541.574413] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.393s)
[541.576877] Subtest plane-invalid-params: SUCCESS (0.394s)
[542.402722] [116/133] (489s left) gem_exec_fence (syncobj-repeat)
[542.901355] Starting subtest: syncobj-repeat
[543.092146] Subtest syncobj-repeat: SUCCESS (0.189s)
[544.188075] [117/133] (488s left) kms_plane (pixel-format-yf-tiled-ccs-modifier)
[544.291134] Starting subtest: pixel-format-yf-tiled-ccs-modifier
[544.295654] Subtest pixel-format-yf-tiled-ccs-modifier: SKIP (0.000s)
[544.369560] [118/133] (487s left) perf (rc6-disable)
[544.535273] Starting subtest: rc6-disable
[544.718373] Subtest rc6-disable: SUCCESS (0.183s)
[544.775944] [119/133] (487s left) kms_plane (pixel-format-4-tiled-dg2-rc-ccs-cc-modifier-source-clamping)
[544.874827] Starting subtest: pixel-format-4-tiled-dg2-rc-ccs-cc-modifier-source-clamping
[544.878872] Subtest pixel-format-4-tiled-dg2-rc-ccs-cc-modifier-source-clamping: SKIP (0.000s)
[544.963726] [120/133] (487s left) kms_flip (2x-dpms-vs-vblank-race)
[545.066649] Starting subtest: 2x-dpms-vs-vblank-race
[545.078767] Subtest 2x-dpms-vs-vblank-race: SKIP (0.011s)
[545.160438] [121/133] (487s left) sw_sync (sync_multi_timeline_wait)
[545.197385] Starting subtest: sync_multi_timeline_wait
[545.199233] Subtest sync_multi_timeline_wait: SUCCESS (0.000s)
[545.258792] [122/133] (487s left) syncobj_wait (multi-wait-all-for-submit-unsubmitted-signaled)
[545.322373] Starting subtest: multi-wait-all-for-submit-unsubmitted-signaled
[545.430330] Subtest multi-wait-all-for-submit-unsubmitted-signaled: SUCCESS (0.107s)
[545.509041] [123/133] (487s left) kms_psr (fbc-pr-primary-mmap-gtt)
[545.589752] Starting subtest: fbc-pr-primary-mmap-gtt
[545.593825] Subtest fbc-pr-primary-mmap-gtt: SKIP (0.000s)
[545.665295] [124/133] (486s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-shrfb-pgflip-blt)
[545.762750] Starting subtest: fbcpsr-2p-primscrn-shrfb-pgflip-blt
[545.766868] Subtest fbcpsr-2p-primscrn-shrfb-pgflip-blt: SKIP (0.000s)
[545.869891] [125/133] (486s left) kms_pm_rpm (dpms-lpsp)
[547.402287] Starting subtest: dpms-lpsp
[548.085109] Subtest dpms-lpsp: SUCCESS (0.686s)
[548.189334] [126/133] (484s left) kms_flip (flip-vs-dpms-on-nop)
[548.284729] Starting subtest: flip-vs-dpms-on-nop
[548.286710] Starting dynamic subtest: A-eDP1
[550.131589] Dynamic subtest A-eDP1: SUCCESS (1.847s)
[550.144179] Starting dynamic subtest: B-eDP1
[551.963715] Dynamic subtest B-eDP1: SUCCESS (1.829s)
[551.976819] Starting dynamic subtest: C-eDP1
[553.783687] Dynamic subtest C-eDP1: SUCCESS (1.816s)
[553.800763] Starting dynamic subtest: D-eDP1
[555.613188] Dynamic subtest D-eDP1: SUCCESS (1.824s)
[555.619100] Subtest flip-vs-dpms-on-nop: SUCCESS (7.330s)
[556.803014] [127/133] (475s left) gem_exec_balancer (parallel-balancer)
[557.064143] Starting subtest: parallel-balancer
[557.963351] Subtest parallel-balancer: SUCCESS (0.899s)
[558.074079] [128/133] (474s left) kms_big_fb (linear-32bpp-rotate-270)
[558.188055] Starting subtest: linear-32bpp-rotate-270
[558.208579] Subtest linear-32bpp-rotate-270: SKIP (0.020s)
[558.334748] [129/133] (474s left) kms_atomic_transition (plane-all-transition-nonblocking-fencing)
[558.423514] Starting subtest: plane-all-transition-nonblocking-fencing
[558.425734] Starting dynamic subtest: pipe-A-eDP-1
[560.919525] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.496s)
[561.229699] Starting dynamic subtest: pipe-B-eDP-1
[564.439715] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.219s)
[564.742879] Subtest plane-all-transition-nonblocking-fencing: SUCCESS (6.314s)
[565.579129] [130/133] (467s left) gem_ctx_exec (basic-invalid-context)
[565.646521] Starting subtest: basic-invalid-context
[565.654325] Subtest basic-invalid-context: SUCCESS (0.008s)
[565.787251] [131/133] (467s left) kms_mmap_write_crc (main)
[565.889373] Starting subtest: main
[565.891801] Starting dynamic subtest: pipe-A-eDP-1
[569.469990] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.580s)
[569.472282] Subtest main: SUCCESS (3.582s)
[570.307109] [132/133] (462s left) perf_pmu (semaphore-wait)
[570.351012] Starting subtest: semaphore-wait
[570.353412] Starting dynamic subtest: rcs0
[570.865046] Dynamic subtest rcs0: SUCCESS (0.512s)
[570.877441] Starting dynamic subtest: bcs0
[571.382127] Dynamic subtest bcs0: SUCCESS (0.514s)
[571.394363] Starting dynamic subtest: vcs0
[571.895753] Dynamic subtest vcs0: SUCCESS (0.510s)
[571.907377] Starting dynamic subtest: vcs1
[572.408579] Dynamic subtest vcs1: SUCCESS (0.510s)
[572.422334] Starting dynamic subtest: vecs0
[572.923939] Dynamic subtest vecs0: SUCCESS (0.512s)
[572.939068] Starting dynamic subtest: ccs0
[573.441228] Dynamic subtest ccs0: SUCCESS (0.513s)
[573.444260] Subtest semaphore-wait: SUCCESS (3.090s)
[573.575809] [133/133] (459s left) kms_frontbuffer_tracking (psr-suspend)
[573.697355] Starting subtest: psr-suspend
[612.420785] Subtest psr-suspend: SUCCESS (7.964s)
[612.551125] 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.