[57.244365] Initializing watchdogs
[57.244415]   /dev/watchdog0
[57.261560] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:7d55 Intel Meteorlake (Gen12) Meteor Lake-P [Intel Arc Graphics]
[57.266144] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[57.268636] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[57.272245] [001/156] (960s left) kms_psr (fbc-psr2-cursor-plane-move)
[57.402027] Starting subtest: fbc-psr2-cursor-plane-move
[57.404381] Starting dynamic subtest: eDP-1
[57.408671] Dynamic subtest eDP-1: SKIP (0.000s)
[57.412868] Subtest fbc-psr2-cursor-plane-move: SKIP (0.001s)
[57.483484] [002/156] (960s left) gem_mmap_offset (partial-mmap)
[57.555418] Starting subtest: partial-mmap
[57.557938] Starting dynamic subtest: smem0
[57.560452] Dynamic subtest smem0: SUCCESS (0.004s)
[57.562903] Subtest partial-mmap: SUCCESS (0.005s)
[57.688446] [003/156] (960s left) kms_frontbuffer_tracking (hdr-2p-primscrn-spr-indfb-draw-mmap-cpu)
[57.780289] Starting subtest: hdr-2p-primscrn-spr-indfb-draw-mmap-cpu
[57.784929] Subtest hdr-2p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[57.894916] [004/156] (959s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-0-hflip)
[57.991908] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-0-hflip
[59.180535] Subtest 4-tiled-max-hw-stride-32bpp-rotate-0-hflip: SUCCESS (1.170s)
[59.339743] [005/156] (958s left) kms_invalid_mode (zero-vdisplay)
[59.434353] Starting subtest: zero-vdisplay
[59.436447] Starting dynamic subtest: pipe-A-eDP-1
[60.491428] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.044s)
[60.501695] Starting dynamic subtest: pipe-B-eDP-1
[60.503756] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[60.511166] Starting dynamic subtest: pipe-C-eDP-1
[60.513119] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[60.520905] Starting dynamic subtest: pipe-D-eDP-1
[60.523264] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[60.525653] Subtest zero-vdisplay: SUCCESS (1.050s)
[60.867216] [006/156] (957s left) kms_ccs (random-ccs-data-y-tiled-gen12-rc-ccs-cc)
[60.973747] Starting subtest: random-ccs-data-y-tiled-gen12-rc-ccs-cc
[60.976485] Starting dynamic subtest: pipe-A-eDP-1
[61.003291] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[61.016183] Starting dynamic subtest: pipe-B-eDP-1
[61.040415] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[61.052411] Starting dynamic subtest: pipe-C-eDP-1
[61.076476] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[61.084640] Starting dynamic subtest: pipe-D-eDP-1
[61.109272] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[61.113756] Subtest random-ccs-data-y-tiled-gen12-rc-ccs-cc: SKIP (0.003s)
[63.245787] [007/156] (954s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-primscrn-spr-indfb-fullscreen)
[63.347816] Starting subtest: fbcpsrhdr-2p-primscrn-spr-indfb-fullscreen
[63.352509] Subtest fbcpsrhdr-2p-primscrn-spr-indfb-fullscreen: SKIP (0.000s)
[63.440021] [008/156] (954s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-mmap-cpu)
[63.539357] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-mmap-cpu
[70.171357] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-mmap-cpu: SUCCESS (6.602s)
[70.302560] [009/156] (947s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-blt)
[70.397554] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-blt
[70.401734] Subtest fbc-2p-scndscrn-pri-indfb-draw-blt: SKIP (0.000s)
[70.484830] [010/156] (947s left) kms_plane_scaling (planes-downscale-factor-0-5)
[70.567656] Starting subtest: planes-downscale-factor-0-5
[70.569963] Starting dynamic subtest: pipe-A
[70.591126] Dynamic subtest pipe-A: SKIP (0.019s)
[70.599227] Starting dynamic subtest: pipe-B
[70.630634] Dynamic subtest pipe-B: SKIP (0.040s)
[70.638613] Starting dynamic subtest: pipe-C
[70.669778] Dynamic subtest pipe-C: SKIP (0.039s)
[70.677428] Starting dynamic subtest: pipe-D
[70.703217] Dynamic subtest pipe-D: SKIP (0.034s)
[70.706995] Subtest planes-downscale-factor-0-5: SKIP (0.132s)
[70.789681] [011/156] (947s left) kms_frontbuffer_tracking (hdr-1p-primscrn-pri-shrfb-draw-mmap-gtt)
[70.883145] Starting subtest: hdr-1p-primscrn-pri-shrfb-draw-mmap-gtt
[70.887616] Subtest hdr-1p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[70.959758] [012/156] (947s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-pwrite)
[71.057954] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-pwrite
[71.062181] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[71.165595] [013/156] (947s left) gen7_exec_parse (bitmasks)
[71.227934] Subtest bitmasks: SKIP (0.000s)
[71.296950] [014/156] (946s left) kms_frontbuffer_tracking (fbc-2p-pri-indfb-multidraw)
[71.394982] Starting subtest: fbc-2p-pri-indfb-multidraw
[71.398546] Subtest fbc-2p-pri-indfb-multidraw: SKIP (0.000s)
[71.482955] [015/156] (946s left) kms_flip_scaled_crc (flip-64bpp-yftile-to-32bpp-yftile-upscaling)
[71.577917] Starting subtest: flip-64bpp-yftile-to-32bpp-yftile-upscaling
[71.581895] Subtest flip-64bpp-yftile-to-32bpp-yftile-upscaling: SKIP (0.000s)
[71.646106] [016/156] (946s left) kms_big_fb (y-tiled-32bpp-rotate-90)
[71.750739] Starting subtest: y-tiled-32bpp-rotate-90
[71.754351] Subtest y-tiled-32bpp-rotate-90: SKIP (0.000s)
[71.863073] [017/156] (946s left) sysfs_heartbeat_interval (nopreempt)
[71.913483] Starting subtest: nopreempt
[71.915501] Starting dynamic subtest: vecs0
[81.292600] Dynamic subtest vecs0: SUCCESS (9.360s)
[81.301627] Starting dynamic subtest: ccs0
[85.229921] Dynamic subtest ccs0: SUCCESS (3.936s)
[85.240368] Starting dynamic subtest: vcs0
[94.283161] Dynamic subtest vcs0: SUCCESS (9.042s)
[94.293038] Starting dynamic subtest: bcs0
[98.115089] Dynamic subtest bcs0: SUCCESS (3.830s)
[98.125733] Starting dynamic subtest: rcs0
[102.069099] Dynamic subtest rcs0: SUCCESS (3.952s)
[102.079081] Starting dynamic subtest: vcs1
[111.245834] Dynamic subtest vcs1: SUCCESS (9.171s)
[111.248583] Subtest nopreempt: SUCCESS (39.298s)
[111.317847] [018/156] (907s left) kms_ccs (bad-rotation-90-y-tiled-ccs)
[111.423160] Starting subtest: bad-rotation-90-y-tiled-ccs
[111.425474] Starting dynamic subtest: pipe-A-eDP-1
[111.448787] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[111.460087] Starting dynamic subtest: pipe-B-eDP-1
[111.482387] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[111.490564] Starting dynamic subtest: pipe-C-eDP-1
[111.511610] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[111.519452] Starting dynamic subtest: pipe-D-eDP-1
[111.540167] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[111.544066] Subtest bad-rotation-90-y-tiled-ccs: SKIP (0.003s)
[113.685171] [019/156] (904s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-0-async-flip)
[113.788671] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-0-async-flip
[113.792818] Subtest yf-tiled-max-hw-stride-64bpp-rotate-0-async-flip: SKIP (0.000s)
[113.894360] [020/156] (904s left) prime_vgem (wait)
[113.994536] Starting subtest: wait
[113.996581] Starting dynamic subtest: rcs0
[114.031770] Dynamic subtest rcs0: SUCCESS (0.038s)
[114.040108] Starting dynamic subtest: bcs0
[114.089366] Dynamic subtest bcs0: SUCCESS (0.057s)
[114.098111] Starting dynamic subtest: vcs0
[114.138468] Dynamic subtest vcs0: SUCCESS (0.048s)
[114.146787] Starting dynamic subtest: vcs1
[114.182719] Dynamic subtest vcs1: SUCCESS (0.043s)
[114.191063] Starting dynamic subtest: vecs0
[114.231157] Dynamic subtest vecs0: SUCCESS (0.048s)
[114.239566] Starting dynamic subtest: ccs0
[114.275750] Dynamic subtest ccs0: SUCCESS (0.044s)
[114.278119] Subtest wait: SUCCESS (0.282s)
[114.386212] [FACT prime_vgem (wait)] new: kernel.kmod_is_loaded.vgem: true
[114.388982] [021/156] (904s left) i915_power (sanity)
[114.449176] Starting subtest: sanity
[118.497696] Subtest sanity: SUCCESS (4.040s)
[120.345112] [022/156] (898s left) prime_vgem (fence-write-hang)
[120.412892] Subtest fence-write-hang: SKIP (0.000s)
[120.510786] [023/156] (898s left) perf (invalid-oa-exponent)
[120.620917] Starting subtest: invalid-oa-exponent
[120.638178] Subtest invalid-oa-exponent: SUCCESS (0.015s)
[120.679561] [024/156] (897s left) perf (mi-rpc)
[120.781852] Starting subtest: mi-rpc
[120.786617] Subtest mi-rpc: SKIP (0.000s)
[120.825810] [025/156] (897s left) gem_render_copy_redux (flink)
[120.886336] Starting subtest: flink
[122.127960] Subtest flink: SUCCESS (1.242s)
[122.247435] [026/156] (896s left) kms_cursor_crc (cursor-random-32x10)
[122.405761] Starting subtest: cursor-random-32x10
[122.455556] Subtest cursor-random-32x10: SKIP (0.045s)
[122.755618] [027/156] (896s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-mmap-gtt)
[122.858231] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-mmap-gtt
[122.861845] Subtest psr-2p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[122.935395] [028/156] (895s left) kms_cursor_crc (cursor-offscreen-64x64)
[123.113227] Starting subtest: cursor-offscreen-64x64
[123.117803] Starting dynamic subtest: pipe-A-eDP-1
[125.077816] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.958s)
[125.107761] Starting dynamic subtest: pipe-D-eDP-1
[127.729892] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.629s)
[127.732462] Subtest cursor-offscreen-64x64: SUCCESS (4.615s)
[128.573293] [029/156] (890s left) kms_chamelium_hpd (hdmi-hpd-enable-disable-mode)
[128.951595] Subtest hdmi-hpd-enable-disable-mode: SKIP (0.000s)
[129.778151] [030/156] (889s left) syncobj_wait (invalid-signal-bad-pad)
[129.831808] Starting subtest: invalid-signal-bad-pad
[129.834275] Subtest invalid-signal-bad-pad: SUCCESS (0.000s)
[129.930824] [031/156] (889s left) gem_busy (extended)
[130.114764] Starting subtest: extended
[130.117281] Starting dynamic subtest: rcs0
[130.192646] Dynamic subtest rcs0: SUCCESS (0.078s)
[130.204635] Starting dynamic subtest: bcs0
[130.235599] Dynamic subtest bcs0: SUCCESS (0.042s)
[130.246835] Starting dynamic subtest: vcs0
[132.296966] Dynamic subtest vcs0: SUCCESS (2.059s)
[132.309644] Starting dynamic subtest: vcs1
[134.284580] Dynamic subtest vcs1: SUCCESS (1.983s)
[134.296748] Starting dynamic subtest: vecs0
[136.331071] Dynamic subtest vecs0: SUCCESS (2.044s)
[136.343083] Starting dynamic subtest: ccs0
[136.375499] Dynamic subtest ccs0: SUCCESS (0.044s)
[136.378304] Subtest extended: SUCCESS (6.260s)
[136.644994] [032/156] (882s left) gem_exec_fence (syncobj-timeline-repeat)
[137.212498] Starting subtest: syncobj-timeline-repeat
[137.457313] Subtest syncobj-timeline-repeat: SUCCESS (0.245s)
[138.408636] [033/156] (880s left) syncobj_timeline (etime-multi-wait-all-available-unsubmitted-signaled)
[138.466099] Starting subtest: etime-multi-wait-all-available-unsubmitted-signaled
[138.576045] Subtest etime-multi-wait-all-available-unsubmitted-signaled: SUCCESS (0.108s)
[138.669983] [034/156] (880s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-mmap-gtt)
[138.764824] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-mmap-gtt
[138.769307] Subtest psr-2p-scndscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[138.862714] [035/156] (880s left) kms_big_fb (yf-tiled-32bpp-rotate-270)
[138.962373] Starting subtest: yf-tiled-32bpp-rotate-270
[138.966755] Subtest yf-tiled-32bpp-rotate-270: SKIP (0.000s)
[139.051396] [036/156] (880s left) syncobj_basic (create-signaled)
[139.111603] Starting subtest: create-signaled
[139.113496] Subtest create-signaled: SUCCESS (0.000s)
[139.236270] [037/156] (879s left) vgem_basic (dmabuf-fence)
[139.274079] Starting subtest: dmabuf-fence
[139.276282] Subtest dmabuf-fence: SUCCESS (0.001s)
[139.331316] [038/156] (879s left) dmabuf_sync_file (import-multiple-read-write)
[139.374217] Starting subtest: import-multiple-read-write
[139.376467] Subtest import-multiple-read-write: SUCCESS (0.003s)
[139.448935] [039/156] (879s left) api_intel_bb (offset-control)
[139.505706] Starting subtest: offset-control
[139.512097] Subtest offset-control: SUCCESS (0.008s)
[139.627081] [040/156] (879s left) kms_chamelium_edid (dp-mode-timings)
[140.002518] Subtest dp-mode-timings: SKIP (0.000s)
[140.812566] [041/156] (878s left) kms_plane (pixel-format-4-tiled-dg2-mc-ccs-modifier)
[140.908106] Starting subtest: pixel-format-4-tiled-dg2-mc-ccs-modifier
[140.912591] Subtest pixel-format-4-tiled-dg2-mc-ccs-modifier: SKIP (0.000s)
[140.973452] [042/156] (878s left) kms_frontbuffer_tracking (hdr-1p-primscrn-spr-indfb-fullscreen)
[141.065869] Starting subtest: hdr-1p-primscrn-spr-indfb-fullscreen
[141.070150] Subtest hdr-1p-primscrn-spr-indfb-fullscreen: SKIP (0.000s)
[141.160315] [043/156] (878s left) kms_ccs (crc-primary-rotation-180-y-tiled-ccs)
[141.249915] Starting subtest: crc-primary-rotation-180-y-tiled-ccs
[141.252162] Starting dynamic subtest: pipe-A-eDP-1
[141.274870] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[141.286938] Starting dynamic subtest: pipe-B-eDP-1
[141.308539] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[141.317444] Starting dynamic subtest: pipe-C-eDP-1
[141.339300] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[141.350249] Starting dynamic subtest: pipe-D-eDP-1
[141.372875] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[141.377077] Subtest crc-primary-rotation-180-y-tiled-ccs: SKIP (0.005s)
[143.600661] [044/156] (875s left) kms_flip (blocking-absolute-wf_vblank)
[143.708674] Starting subtest: blocking-absolute-wf_vblank
[143.711090] Starting dynamic subtest: A-eDP1
[152.473440] Dynamic subtest A-eDP1: SUCCESS (8.766s)
[152.485055] Starting dynamic subtest: B-eDP1
[161.204610] Dynamic subtest B-eDP1: SUCCESS (8.729s)
[161.220568] Starting dynamic subtest: C-eDP1
[169.914062] Dynamic subtest C-eDP1: SUCCESS (8.707s)
[169.926547] Starting dynamic subtest: D-eDP1
[178.648030] Dynamic subtest D-eDP1: SUCCESS (8.731s)
[178.652954] Subtest blocking-absolute-wf_vblank: SUCCESS (34.947s)
[179.853107] [045/156] (839s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-move)
[179.954765] Starting subtest: fbc-1p-primscrn-cur-indfb-move
[184.057943] Subtest fbc-1p-primscrn-cur-indfb-move: SUCCESS (4.108s)
[185.259851] [046/156] (834s left) kms_plane_scaling (planes-upscale-factor-0-25-downscale-factor-0-5)
[185.346234] Starting subtest: planes-upscale-factor-0-25-downscale-factor-0-5
[185.348397] Starting dynamic subtest: pipe-A
[185.375940] Dynamic subtest pipe-A: SKIP (0.025s)
[185.386978] Starting dynamic subtest: pipe-B
[185.409696] Dynamic subtest pipe-B: SKIP (0.034s)
[185.419086] Starting dynamic subtest: pipe-C
[185.444756] Dynamic subtest pipe-C: SKIP (0.035s)
[185.454146] Starting dynamic subtest: pipe-D
[185.479372] Dynamic subtest pipe-D: SKIP (0.034s)
[185.483812] Subtest planes-upscale-factor-0-25-downscale-factor-0-5: SKIP (0.130s)
[185.588902] [047/156] (834s left) kms_plane_alpha_blend (constant-alpha-max)
[185.678869] Starting subtest: constant-alpha-max
[185.964726] Starting dynamic subtest: pipe-A-eDP-1
[187.195395] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.227s)
[187.205401] Starting dynamic subtest: pipe-D-eDP-1
[188.992520] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.796s)
[188.994807] Subtest constant-alpha-max: SUCCESS (3.313s)
[189.806373] [048/156] (829s left) gem_ctx_persistence (file)
[189.871806] Starting subtest: file
[189.986062] Subtest file: SUCCESS (0.116s)
[190.113525] [049/156] (829s left) perf_pmu (init-busy)
[190.159206] Starting subtest: init-busy
[190.161412] Starting dynamic subtest: rcs0
[190.163704] Dynamic subtest rcs0: SUCCESS (0.001s)
[190.172897] Starting dynamic subtest: bcs0
[190.174846] Dynamic subtest bcs0: SUCCESS (0.000s)
[190.184111] Starting dynamic subtest: vcs0
[190.186217] Dynamic subtest vcs0: SUCCESS (0.001s)
[190.195077] Starting dynamic subtest: vcs1
[190.196973] Dynamic subtest vcs1: SUCCESS (0.001s)
[190.206028] Starting dynamic subtest: vecs0
[190.208267] Dynamic subtest vecs0: SUCCESS (0.000s)
[190.217419] Starting dynamic subtest: ccs0
[190.219691] Dynamic subtest ccs0: SUCCESS (0.000s)
[190.221943] Subtest init-busy: SUCCESS (0.007s)
[190.262561] [050/156] (829s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-0-hflip)
[190.359618] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-0-hflip
[191.460126] Subtest 4-tiled-max-hw-stride-64bpp-rotate-0-hflip: SUCCESS (1.101s)
[191.583773] [051/156] (828s left) kms_atomic_transition (plane-all-modeset-transition-fencing)
[191.682292] Starting subtest: plane-all-modeset-transition-fencing
[191.686016] Subtest plane-all-modeset-transition-fencing: SKIP (0.000s)
[191.752289] [052/156] (828s left) gem_partial_pwrite_pread (write-snoop)
[191.816481] Subtest write-snoop: SKIP (0.000s)
[191.876167] [053/156] (828s left) kms_psr (pr-cursor-plane-move)
[191.965066] Starting subtest: pr-cursor-plane-move
[191.968555] Subtest pr-cursor-plane-move: SKIP (0.000s)
[192.048553] [054/156] (827s left) kms_big_fb (x-tiled-32bpp-rotate-270)
[192.159176] Starting subtest: x-tiled-32bpp-rotate-270
[192.180925] Subtest x-tiled-32bpp-rotate-270: SKIP (0.019s)
[192.296251] [055/156] (827s left) syncobj_timeline (invalid-multi-wait-unsubmitted)
[192.352896] Starting subtest: invalid-multi-wait-unsubmitted
[192.355097] Subtest invalid-multi-wait-unsubmitted: SUCCESS (0.000s)
[192.472732] [056/156] (827s left) kms_frontbuffer_tracking (fbchdr-1p-primscrn-spr-indfb-draw-blt)
[192.571883] Starting subtest: fbchdr-1p-primscrn-spr-indfb-draw-blt
[192.575542] Subtest fbchdr-1p-primscrn-spr-indfb-draw-blt: SKIP (0.000s)
[192.678210] [057/156] (827s left) kms_rotation_crc (exhaust-fences)
[192.775429] Starting subtest: exhaust-fences
[192.778871] Subtest exhaust-fences: SKIP (0.000s)
[192.860127] [058/156] (827s left) kms_frontbuffer_tracking (psr-rgb101010-draw-mmap-gtt)
[192.957935] Starting subtest: psr-rgb101010-draw-mmap-gtt
[192.961556] Subtest psr-rgb101010-draw-mmap-gtt: SKIP (0.000s)
[193.067575] [059/156] (827s left) gem_softpin (evict-prime)
[193.121184] Starting subtest: evict-prime
[193.123239] Starting dynamic subtest: rcs0
[194.288362] Dynamic subtest rcs0: SUCCESS (1.166s)
[194.301663] Starting dynamic subtest: bcs0
[195.411712] Dynamic subtest bcs0: SUCCESS (1.122s)
[195.422657] Starting dynamic subtest: vcs0
[197.333625] Dynamic subtest vcs0: SUCCESS (1.919s)
[197.345825] Starting dynamic subtest: vcs1
[199.255368] Dynamic subtest vcs1: SUCCESS (1.915s)
[199.267622] Starting dynamic subtest: vecs0
[201.295329] Dynamic subtest vecs0: SUCCESS (2.043s)
[201.307912] Starting dynamic subtest: ccs0
[202.427922] Dynamic subtest ccs0: SUCCESS (1.132s)
[202.438833] Starting dynamic subtest: all
[204.248698] Dynamic subtest all: SUCCESS (1.818s)
[204.251217] Subtest evict-prime: SUCCESS (11.127s)
[204.343699] [060/156] (815s left) gem_mmap_gtt (close-race)
[204.403415] Subtest close-race: SKIP (0.000s)
[204.468074] [061/156] (815s left) kms_dsc (dsc-basic-ultrajoiner)
[204.561188] Starting subtest: dsc-basic-ultrajoiner
[204.565269] Subtest dsc-basic-ultrajoiner: SKIP (0.000s)
[204.634840] [062/156] (815s left) gem_exec_whisper (basic-fds-forked)
[204.696434] Starting subtest: basic-fds-forked
[228.978684] Subtest basic-fds-forked: SUCCESS (24.278s)
[229.162396] [063/156] (791s left) kms_setmode (basic-clone-single-crtc)
[229.216169] Starting subtest: basic-clone-single-crtc
[229.223074] Subtest basic-clone-single-crtc: SKIP (0.000s)
[229.321648] [064/156] (791s left) kms_frontbuffer_tracking (hdr-1p-offscreen-pri-shrfb-draw-render)
[229.422037] Starting subtest: hdr-1p-offscreen-pri-shrfb-draw-render
[229.426212] Subtest hdr-1p-offscreen-pri-shrfb-draw-render: SKIP (0.000s)
[229.517160] [065/156] (790s left) kms_atomic (atomic-plane-damage)
[229.607248] Starting subtest: atomic-plane-damage
[229.659031] Starting dynamic subtest: pipe-A-eDP-1
[230.213983] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.557s)
[230.216415] Subtest atomic-plane-damage: SUCCESS (0.610s)
[231.030383] [066/156] (789s left) gem_mmap_wc (write-wc-read-gtt)
[231.085312] Subtest write-wc-read-gtt: SKIP (0.000s)
[231.149921] [067/156] (789s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-mmap-gtt)
[231.247588] Starting subtest: psr-1p-primscrn-spr-indfb-draw-mmap-gtt
[231.251591] Subtest psr-1p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[231.355365] [068/156] (789s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-180-async-flip)
[231.455408] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-180-async-flip
[231.459486] Subtest y-tiled-max-hw-stride-32bpp-rotate-180-async-flip: SKIP (0.000s)
[231.551420] [069/156] (789s left) kms_cursor_crc (cursor-sliding-32x32)
[231.692893] Starting subtest: cursor-sliding-32x32
[231.744364] Subtest cursor-sliding-32x32: SKIP (0.046s)
[232.050329] [070/156] (788s left) gem_ctx_param (invalid-ctx-get)
[232.116287] Starting subtest: invalid-ctx-get
[232.118231] Subtest invalid-ctx-get: SUCCESS (0.000s)
[232.191977] [071/156] (788s left) kms_psr2_sf (fbc-psr2-primary-plane-update-sf-dmg-area)
[232.281402] Starting subtest: fbc-psr2-primary-plane-update-sf-dmg-area
[232.283392] Starting dynamic subtest: pipe-A-eDP-1
[232.383199] Dynamic subtest pipe-A-eDP-1: SKIP (0.103s)
[232.395747] Starting dynamic subtest: pipe-B-eDP-1
[233.510170] Dynamic subtest pipe-B-eDP-1: SKIP (1.125s)
[233.515215] Subtest fbc-psr2-primary-plane-update-sf-dmg-area: SKIP (1.232s)
[234.705286] [072/156] (785s left) kms_psr (psr-sprite-plane-move)
[234.790072] Starting subtest: psr-sprite-plane-move
[234.792321] Starting dynamic subtest: eDP-1
[236.528742] Dynamic subtest eDP-1: SUCCESS (1.739s)
[236.531080] Subtest psr-sprite-plane-move: SUCCESS (1.740s)
[237.396336] [073/156] (783s left) gem_ctx_exec (basic-invalid-context)
[237.444061] Starting subtest: basic-invalid-context
[237.448574] Subtest basic-invalid-context: SUCCESS (0.005s)
[237.586596] [074/156] (783s left) kms_frontbuffer_tracking (fbchdr-2p-rte)
[237.681129] Starting subtest: fbchdr-2p-rte
[237.685186] Subtest fbchdr-2p-rte: SKIP (0.000s)
[237.767071] [075/156] (783s left) gem_ctx_shared (q-smoketest)
[237.821135] Starting subtest: Q-smoketest
[237.823348] Starting dynamic subtest: rcs0
[243.366630] Dynamic subtest rcs0: SUCCESS (5.495s)
[243.378360] Starting dynamic subtest: bcs0
[248.873635] Dynamic subtest bcs0: SUCCESS (5.507s)
[248.883835] Starting dynamic subtest: vcs0
[254.357680] Dynamic subtest vcs0: SUCCESS (5.482s)
[254.369348] Starting dynamic subtest: vcs1
[259.841194] Dynamic subtest vcs1: SUCCESS (5.483s)
[259.852184] Starting dynamic subtest: vecs0
[265.347805] Dynamic subtest vecs0: SUCCESS (5.505s)
[265.357658] Starting dynamic subtest: ccs0
[270.865227] Dynamic subtest ccs0: SUCCESS (5.514s)
[270.867529] Subtest Q-smoketest: SUCCESS (32.994s)
[271.018534] [076/156] (749s left) syncobj_wait (invalid-multi-wait-unsubmitted-signaled)
[271.069232] Starting subtest: invalid-multi-wait-unsubmitted-signaled
[271.071482] Subtest invalid-multi-wait-unsubmitted-signaled: SUCCESS (0.000s)
[271.180026] [077/156] (749s left) perf (low-oa-exponent-permissions)
[271.253609] Starting subtest: low-oa-exponent-permissions
[271.286774] Subtest low-oa-exponent-permissions: SUCCESS (0.033s)
[271.335410] [078/156] (749s left) perf_pmu (enable-race)
[271.373964] Starting subtest: enable-race
[271.376352] Starting dynamic subtest: rcs0
[284.144333] Dynamic subtest rcs0: SUCCESS (12.773s)
[284.155854] Starting dynamic subtest: bcs0
[296.888884] Dynamic subtest bcs0: SUCCESS (12.741s)
[296.900890] Starting dynamic subtest: vcs0
[312.267816] Dynamic subtest vcs0: SUCCESS (15.376s)
[312.282237] Starting dynamic subtest: vcs1
[328.267368] Dynamic subtest vcs1: SUCCESS (15.996s)
[328.278258] Starting dynamic subtest: vecs0
[344.267227] Dynamic subtest vecs0: SUCCESS (15.997s)
[344.278200] Starting dynamic subtest: ccs0
[357.010661] Dynamic subtest ccs0: SUCCESS (12.741s)
[357.013937] Subtest enable-race: SUCCESS (85.639s)
[357.126078] [079/156] (663s left) kms_frontbuffer_tracking (fbchdr-2p-primscrn-spr-indfb-draw-mmap-wc)
[357.237554] Starting subtest: fbchdr-2p-primscrn-spr-indfb-draw-mmap-wc
[357.241628] Subtest fbchdr-2p-primscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[357.329662] [080/156] (663s left) kms_ccs (missing-ccs-buffer-y-tiled-ccs)
[357.419096] Starting subtest: missing-ccs-buffer-y-tiled-ccs
[357.421538] Starting dynamic subtest: pipe-A-eDP-1
[357.444704] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[357.455657] Starting dynamic subtest: pipe-B-eDP-1
[357.476148] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[357.485786] Starting dynamic subtest: pipe-C-eDP-1
[357.506629] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[357.515845] Starting dynamic subtest: pipe-D-eDP-1
[357.537911] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[357.542080] Subtest missing-ccs-buffer-y-tiled-ccs: SKIP (0.004s)
[359.740796] [081/156] (661s left) kms_frontbuffer_tracking (hdr-2p-scndscrn-shrfb-pgflip-blt)
[359.840693] Starting subtest: hdr-2p-scndscrn-shrfb-pgflip-blt
[359.845181] Subtest hdr-2p-scndscrn-shrfb-pgflip-blt: SKIP (0.000s)
[359.939522] [082/156] (661s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-scndscrn-shrfb-pgflip-blt)
[360.033594] Starting subtest: fbcpsrhdr-2p-scndscrn-shrfb-pgflip-blt
[360.037647] Subtest fbcpsrhdr-2p-scndscrn-shrfb-pgflip-blt: SKIP (0.000s)
[360.128190] [083/156] (661s left) i915_drm_fdinfo (basics)
[360.167712] Starting subtest: basics
[360.170159] Subtest basics: SUCCESS (0.000s)
[360.236552] [084/156] (660s left) kms_frontbuffer_tracking (fbchdr-1p-primscrn-pri-indfb-draw-mmap-cpu)
[360.328732] Starting subtest: fbchdr-1p-primscrn-pri-indfb-draw-mmap-cpu
[360.333246] Subtest fbchdr-1p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[360.430450] [085/156] (660s left) kms_tiled_display (basic-test-pattern-with-chamelium)
[360.532642] Subtest basic-test-pattern-with-chamelium: SKIP (0.000s)
[360.580650] [086/156] (660s left) kms_frontbuffer_tracking (fbchdr-tiling-4)
[360.680482] Starting subtest: fbchdr-tiling-4
[360.684122] Subtest fbchdr-tiling-4: SKIP (0.000s)
[360.805908] [087/156] (660s left) kms_prop_blob (blob-prop-lifetime)
[360.862468] Starting subtest: blob-prop-lifetime
[360.864539] Subtest blob-prop-lifetime: SUCCESS (0.001s)
[360.977550] [088/156] (660s left) prime_self_import (basic-llseek-bad)
[361.012651] Starting subtest: basic-llseek-bad
[361.035081] Subtest basic-llseek-bad: SUCCESS (0.026s)
[361.154275] [089/156] (660s left) gem_exec_fence (basic-busy)
[361.326856] Starting subtest: basic-busy
[361.329855] Starting dynamic subtest: rcs0
[361.418032] Dynamic subtest rcs0: SUCCESS (0.092s)
[361.430370] Starting dynamic subtest: bcs0
[361.477457] Dynamic subtest bcs0: SUCCESS (0.058s)
[361.489642] Starting dynamic subtest: vcs0
[361.536191] Dynamic subtest vcs0: SUCCESS (0.057s)
[361.548283] Starting dynamic subtest: vcs1
[361.595567] Dynamic subtest vcs1: SUCCESS (0.057s)
[361.607723] Starting dynamic subtest: vecs0
[361.645148] Dynamic subtest vecs0: SUCCESS (0.048s)
[361.656932] Starting dynamic subtest: ccs0
[361.707264] Dynamic subtest ccs0: SUCCESS (0.060s)
[361.709751] Subtest basic-busy: SUCCESS (0.383s)
[363.364647] [090/156] (658s left) kms_frontbuffer_tracking (fbc-rgb565-draw-pwrite)
[363.477995] Starting subtest: fbc-rgb565-draw-pwrite
[368.051867] Subtest fbc-rgb565-draw-pwrite: SUCCESS (4.579s)
[369.244420] [091/156] (652s left) syncobj_wait (invalid-multi-wait-unsubmitted)
[369.292803] Starting subtest: invalid-multi-wait-unsubmitted
[369.295167] Subtest invalid-multi-wait-unsubmitted: SUCCESS (0.000s)
[369.392880] [092/156] (652s left) kms_frontbuffer_tracking (fbcpsrhdr-rgb565-draw-mmap-gtt)
[369.498092] Starting subtest: fbcpsrhdr-rgb565-draw-mmap-gtt
[369.502386] Subtest fbcpsrhdr-rgb565-draw-mmap-gtt: SKIP (0.000s)
[369.577237] [093/156] (651s left) gem_pxp (reject-modify-context-protection-off-1)
[369.696811] Starting subtest: reject-modify-context-protection-off-1
[369.699303] Subtest reject-modify-context-protection-off-1: SUCCESS (0.002s)
[369.800609] [094/156] (651s left) gem_ctx_persistence (legacy-engines-persistence)
[369.859072] Starting subtest: legacy-engines-persistence
[369.861660] Starting dynamic subtest: render
[370.645254] Dynamic subtest render: SUCCESS (0.786s)
[370.657322] Starting dynamic subtest: bsd1
[371.398987] Dynamic subtest bsd1: SUCCESS (0.751s)
[371.414623] Starting dynamic subtest: bsd2
[372.145273] Dynamic subtest bsd2: SUCCESS (0.742s)
[372.157548] Starting dynamic subtest: blt
[372.941066] Dynamic subtest blt: SUCCESS (0.793s)
[372.953807] Starting dynamic subtest: vebox
[373.705193] Dynamic subtest vebox: SUCCESS (0.761s)
[373.707839] Subtest legacy-engines-persistence: SUCCESS (3.847s)
[373.789885] [095/156] (647s left) kms_addfb_basic (bad-pitch-256)
[373.841180] Starting subtest: bad-pitch-256
[373.843134] Subtest bad-pitch-256: SUCCESS (0.000s)
[373.977557] [096/156] (647s left) kms_psr (pr-sprite-blt)
[374.073499] Starting subtest: pr-sprite-blt
[374.077519] Subtest pr-sprite-blt: SKIP (0.000s)
[374.147338] [097/156] (647s left) gem_exec_schedule (preempt-contexts)
[374.213130] Starting subtest: preempt-contexts
[374.215494] Starting dynamic subtest: rcs0
[374.261087] Dynamic subtest rcs0: SUCCESS (0.056s)
[374.271516] Starting dynamic subtest: bcs0
[374.317708] Dynamic subtest bcs0: SUCCESS (0.055s)
[374.328177] Starting dynamic subtest: vcs0
[374.362668] Dynamic subtest vcs0: SUCCESS (0.045s)
[374.373072] Starting dynamic subtest: vcs1
[374.411465] Dynamic subtest vcs1: SUCCESS (0.046s)
[374.421363] Starting dynamic subtest: vecs0
[374.457908] Dynamic subtest vecs0: SUCCESS (0.046s)
[374.467968] Starting dynamic subtest: ccs0
[374.513915] Dynamic subtest ccs0: SUCCESS (0.056s)
[374.516256] Subtest preempt-contexts: SUCCESS (0.310s)
[376.439563] [098/156] (645s left) kms_pipe_b_c_ivb (pipe-b-dpms-off-modeset-pipe-c)
[376.489060] Subtest pipe-B-dpms-off-modeset-pipe-C: SKIP (0.000s)
[376.545670] [099/156] (645s left) kms_frontbuffer_tracking (psrhdr-rgb565-draw-mmap-cpu)
[376.638841] Starting subtest: psrhdr-rgb565-draw-mmap-cpu
[376.643038] Subtest psrhdr-rgb565-draw-mmap-cpu: SKIP (0.000s)
[376.729096] [100/156] (645s left) gem_exec_schedule (smoketest-all)
[376.786753] Starting subtest: smoketest-all
[409.177474] Subtest smoketest-all: SUCCESS (32.327s)
[410.387810] [101/156] (611s left) kms_frontbuffer_tracking (hdr-rgb565-draw-pwrite)
[410.486238] Starting subtest: hdr-rgb565-draw-pwrite
[410.490635] Subtest hdr-rgb565-draw-pwrite: SKIP (0.000s)
[410.572240] [102/156] (611s left) syncobj_timeline (invalid-signal-zero-handles)
[410.622883] Starting subtest: invalid-signal-zero-handles
[410.625214] Subtest invalid-signal-zero-handles: SUCCESS (0.000s)
[410.707224] [103/156] (611s left) kms_properties (crtc-properties-legacy)
[410.810453] Starting subtest: crtc-properties-legacy
[410.812884] Starting dynamic subtest: pipe-A-eDP-1
[411.260618] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.450s)
[411.270463] Starting dynamic subtest: pipe-B-eDP-1
[412.411370] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.149s)
[412.421621] Starting dynamic subtest: pipe-C-eDP-1
[413.645386] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.233s)
[413.656248] Starting dynamic subtest: pipe-D-eDP-1
[414.792747] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.146s)
[414.795047] Subtest crtc-properties-legacy: SUCCESS (3.983s)
[415.592195] [104/156] (606s left) gem_softpin (32b-excludes-last-page)
[415.643071] Starting subtest: 32b-excludes-last-page
[415.647821] Subtest 32b-excludes-last-page: SUCCESS (0.004s)
[415.776513] [105/156] (606s left) gem_exec_schedule (u-independent)
[415.843265] Starting subtest: u-independent
[415.845437] Starting dynamic subtest: rcs0
[417.290114] Dynamic subtest rcs0: SUCCESS (1.456s)
[417.301799] Starting dynamic subtest: vcs0
[419.306268] Dynamic subtest vcs0: SUCCESS (2.013s)
[419.319864] Starting dynamic subtest: vcs1
[421.331264] Dynamic subtest vcs1: SUCCESS (2.023s)
[421.345897] Starting dynamic subtest: vecs0
[423.320132] Dynamic subtest vecs0: SUCCESS (1.985s)
[423.332338] Starting dynamic subtest: ccs0
[425.290624] Dynamic subtest ccs0: SUCCESS (1.968s)
[425.293511] Subtest u-independent: SUCCESS (9.457s)
[425.619408] [106/156] (596s left) gem_ctx_param (invalid-param-get)
[425.675342] Starting subtest: invalid-param-get
[425.677714] Subtest invalid-param-get: SUCCESS (0.001s)
[425.783353] [107/156] (596s left) kms_frontbuffer_tracking (fbchdr-2p-scndscrn-spr-indfb-draw-pwrite)
[425.878666] Starting subtest: fbchdr-2p-scndscrn-spr-indfb-draw-pwrite
[425.883024] Subtest fbchdr-2p-scndscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[425.977231] [108/156] (596s left) gem_mmap_wc (write-gtt-read-wc)
[426.025348] Subtest write-gtt-read-wc: SKIP (0.000s)
[426.080303] [109/156] (596s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-primscrn-spr-indfb-draw-mmap-wc)
[426.182568] Starting subtest: fbcpsrhdr-1p-primscrn-spr-indfb-draw-mmap-wc
[426.186772] Subtest fbcpsrhdr-1p-primscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[426.280141] [110/156] (595s left) kms_frontbuffer_tracking (psrhdr-2p-primscrn-shrfb-msflip-blt)
[426.380097] Starting subtest: psrhdr-2p-primscrn-shrfb-msflip-blt
[426.384649] Subtest psrhdr-2p-primscrn-shrfb-msflip-blt: SKIP (0.000s)
[426.504087] [111/156] (595s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-render)
[426.612063] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-render
[434.002480] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-render: SUCCESS (7.397s)
[434.127712] [112/156] (588s left) kms_content_protection (uevent)
[434.273046] Starting subtest: uevent
[434.277901] Subtest uevent: SKIP (0.000s)
[434.407770] [113/156] (587s left) kms_psr (psr-cursor-plane-move)
[434.506174] Starting subtest: psr-cursor-plane-move
[434.508466] Starting dynamic subtest: eDP-1
[436.232202] Dynamic subtest eDP-1: SUCCESS (1.726s)
[436.234629] Subtest psr-cursor-plane-move: SUCCESS (1.727s)
[437.113281] [114/156] (585s left) kms_psr (fbc-pr-suspend)
[437.199066] Starting subtest: fbc-pr-suspend
[437.203440] Subtest fbc-pr-suspend: SKIP (0.000s)
[437.275278] [115/156] (585s left) kms_pm_rpm (cursor)
[439.508525] Starting subtest: cursor
[439.513786] Subtest cursor: SKIP (0.000s)
[439.899099] [116/156] (582s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-wc)
[440.003493] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-wc
[440.007728] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[440.090666] [117/156] (582s left) kms_plane (plane-panning-bottom-right)
[440.187171] Starting subtest: plane-panning-bottom-right
[440.189078] Starting dynamic subtest: pipe-A
[441.890806] Dynamic subtest pipe-A: SUCCESS (1.703s)
[441.901092] Starting dynamic subtest: pipe-B
[444.330801] Dynamic subtest pipe-B: SUCCESS (2.438s)
[444.333141] Subtest plane-panning-bottom-right: SUCCESS (4.144s)
[445.137395] [118/156] (577s left) kms_flip_scaled_crc (flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling)
[445.228996] Starting subtest: flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling
[445.233203] Subtest flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling: SKIP (0.000s)
[445.302053] [119/156] (577s left) gem_userptr_blits (huge-split)
[445.377062] Starting subtest: huge-split
[445.381798] Subtest huge-split: SUCCESS (0.007s)
[445.509938] [120/156] (577s left) kms_hdr (static-toggle-suspend)
[445.612131] Starting subtest: static-toggle-suspend
[445.614410] Starting dynamic subtest: pipe-A-eDP-1-XRGB2101010
[445.618801] Dynamic subtest pipe-A-eDP-1-XRGB2101010: SKIP (0.000s)
[445.629359] Starting dynamic subtest: pipe-A-eDP-1-XRGB16161616F
[445.633469] Dynamic subtest pipe-A-eDP-1-XRGB16161616F: SKIP (0.000s)
[445.637662] Subtest static-toggle-suspend: SKIP (0.003s)
[445.697021] [121/156] (577s left) gem_exec_balancer (bonded-true-hang)
[445.975032] Starting subtest: bonded-true-hang
[445.980167] Subtest bonded-true-hang: SKIP (0.000s)
[446.081738] [122/156] (576s left) syncobj_timeline (signal-array)
[446.149862] Starting subtest: signal-array
[446.152075] Subtest signal-array: SUCCESS (0.000s)
[446.266744] [123/156] (576s left) gen3_render_linear_blits
[446.386428] [124/156] (576s left) kms_ccs (ccs-on-another-bo-4-tiled-mtl-rc-ccs-cc)
[446.492700] Starting subtest: ccs-on-another-bo-4-tiled-mtl-rc-ccs-cc
[446.494977] Starting dynamic subtest: pipe-A-eDP-1
[446.515327] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[446.525649] Starting dynamic subtest: pipe-B-eDP-1
[446.546557] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[446.557982] Starting dynamic subtest: pipe-C-eDP-1
[446.577458] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[446.587060] Starting dynamic subtest: pipe-D-eDP-1
[446.607140] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[446.609153] Subtest ccs-on-another-bo-4-tiled-mtl-rc-ccs-cc: SUCCESS (0.008s)
[448.814564] [125/156] (574s left) kms_frontbuffer_tracking (psrhdr-2p-primscrn-pri-indfb-draw-pwrite)
[448.909991] Starting subtest: psrhdr-2p-primscrn-pri-indfb-draw-pwrite
[448.914425] Subtest psrhdr-2p-primscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[449.007435] [126/156] (573s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-shrfb-draw-pwrite)
[449.115275] Starting subtest: fbc-1p-offscreen-pri-shrfb-draw-pwrite
[456.517693] Subtest fbc-1p-offscreen-pri-shrfb-draw-pwrite: SUCCESS (7.411s)
[457.733587] [127/156] (565s left) kms_flip (2x-flip-vs-dpms-on-nop)
[457.828279] Starting subtest: 2x-flip-vs-dpms-on-nop
[457.840047] Subtest 2x-flip-vs-dpms-on-nop: SKIP (0.011s)
[457.931960] [128/156] (565s left) perf (oa-exponents)
[458.026682] Starting subtest: oa-exponents
[458.029105] Starting dynamic subtest: 0-rcs0
[459.801815] Dynamic subtest 0-rcs0: SUCCESS (1.773s)
[459.813304] Starting dynamic subtest: 1-vcs1
[461.603327] Dynamic subtest 1-vcs1: SUCCESS (1.800s)
[461.605997] Subtest oa-exponents: SUCCESS (3.575s)
[461.653326] [129/156] (561s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-pwrite)
[461.764962] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-pwrite
[461.769237] Subtest fbc-2p-primscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[461.870518] [130/156] (561s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-offscreen-pri-indfb-draw-mmap-wc)
[461.972721] Starting subtest: fbcpsrhdr-1p-offscreen-pri-indfb-draw-mmap-wc
[461.976796] Subtest fbcpsrhdr-1p-offscreen-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[462.058443] [131/156] (561s left) kms_psr2_sf (psr2-primary-plane-update-sf-dmg-area-big-fb)
[462.161299] Starting subtest: psr2-primary-plane-update-sf-dmg-area-big-fb
[462.163596] Starting dynamic subtest: pipe-A-eDP-1
[468.936874] Dynamic subtest pipe-A-eDP-1: SUCCESS (6.780s)
[468.948845] Starting dynamic subtest: pipe-B-eDP-1
[476.057727] Dynamic subtest pipe-B-eDP-1: SUCCESS (7.118s)
[476.059989] Subtest psr2-primary-plane-update-sf-dmg-area-big-fb: SUCCESS (13.901s)
[476.916966] [132/156] (546s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-onoff)
[477.012810] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-onoff
[477.017373] Subtest fbcpsr-2p-primscrn-spr-indfb-onoff: SKIP (0.000s)
[477.112752] [133/156] (546s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-shrfb-draw-pwrite)
[477.206096] Starting subtest: psr-1p-offscreen-pri-shrfb-draw-pwrite
[486.779213] Subtest psr-1p-offscreen-pri-shrfb-draw-pwrite: SUCCESS (9.575s)
[486.895832] [134/156] (536s left) kms_addfb_basic (addfb25-yf-tiled-legacy)
[486.990253] Starting subtest: addfb25-yf-tiled-legacy
[486.992363] Subtest addfb25-yf-tiled-legacy: SUCCESS (0.000s)
[487.098526] [135/156] (536s left) kms_lease (setcrtc-implicit-plane)
[487.194935] Starting subtest: setcrtc-implicit-plane
[487.197201] Starting dynamic subtest: pipe-A-eDP-1
[487.655674] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.459s)
[487.666070] Starting dynamic subtest: pipe-B-eDP-1
[488.802031] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.146s)
[488.812743] Starting dynamic subtest: pipe-C-eDP-1
[489.924644] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.120s)
[489.934840] Starting dynamic subtest: pipe-D-eDP-1
[491.047229] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.122s)
[491.049490] Subtest setcrtc-implicit-plane: SUCCESS (3.852s)
[491.889881] [136/156] (531s left) kms_vblank (wait-idle)
[491.985121] Starting subtest: wait-idle
[491.986986] Starting dynamic subtest: pipe-A-eDP-1
[493.743127] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.756s)
[493.757402] Starting dynamic subtest: pipe-D-eDP-1
[496.234486] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.489s)
[496.236888] Subtest wait-idle: SUCCESS (4.250s)
[497.057959] [137/156] (526s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-render)
[497.163058] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-render
[501.612704] Subtest fbc-1p-primscrn-pri-shrfb-draw-render: SUCCESS (4.454s)
[502.778835] [138/156] (520s left) kms_cursor_legacy (torture-move)
[502.903582] Starting subtest: torture-move
[502.906104] Starting dynamic subtest: pipe-A
[508.533722] Dynamic subtest pipe-A: SUCCESS (5.625s)
[508.544053] Starting dynamic subtest: pipe-B
[514.802863] Dynamic subtest pipe-B: SUCCESS (6.268s)
[514.814548] Starting dynamic subtest: pipe-C
[522.282580] Dynamic subtest pipe-C: SUCCESS (7.475s)
[522.300960] Starting dynamic subtest: pipe-D
[529.598615] Dynamic subtest pipe-D: SUCCESS (7.312s)
[529.613515] Starting dynamic subtest: all-pipes
[537.593319] Dynamic subtest all-pipes: SUCCESS (7.993s)
[537.595862] Subtest torture-move: SUCCESS (34.686s)
[537.755152] [139/156] (485s left) gem_exec_suspend (basic-s3-devices)
[537.808441] Starting subtest: basic-S3-devices
[537.810887] Starting dynamic subtest: smem
[549.323482] Dynamic subtest smem: SUCCESS (11.512s)
[549.326352] Subtest basic-S3-devices: SUCCESS (11.514s)
[549.508137] [140/156] (474s left) i915_getparams_basic (basic-subslice-total)
[549.578287] Starting subtest: basic-subslice-total
[549.582648] Subtest basic-subslice-total: SUCCESS (0.000s)
[549.692359] [141/156] (473s left) i915_pm_rpm (system-suspend-execbuf)
[551.425729] Starting subtest: system-suspend-execbuf
[609.768899] Subtest system-suspend-execbuf: SUCCESS (43.624s)
[610.164769] [142/156] (413s left) kms_frontbuffer_tracking (psrhdr-1p-primscrn-indfb-pgflip-blt)
[610.257870] Starting subtest: psrhdr-1p-primscrn-indfb-pgflip-blt
[610.262243] Subtest psrhdr-1p-primscrn-indfb-pgflip-blt: SKIP (0.000s)
[610.365964] [143/156] (413s left) kms_frontbuffer_tracking (fbcpsr-stridechange)
[610.465339] Starting subtest: fbcpsr-stridechange
[616.719370] Subtest fbcpsr-stridechange: SUCCESS (6.257s)
[616.858326] [144/156] (406s left) gem_exec_flush (basic-wb-ro-before-default)
[616.929402] Starting subtest: basic-wb-ro-before-default
[622.387794] Subtest basic-wb-ro-before-default: SUCCESS (5.456s)
[622.578566] [145/156] (401s left) kms_color_pipeline (plane-ctm3x4-lut1d)
[622.677047] Starting subtest: plane-ctm3x4-lut1d
[622.823265] Starting dynamic subtest: pipe-A-plane-0
[623.023353] Dynamic subtest pipe-A-plane-0: SUCCESS (0.200s)
[623.034845] Starting dynamic subtest: pipe-A-plane-1
[623.212135] Dynamic subtest pipe-A-plane-1: SUCCESS (0.188s)
[623.223599] Starting dynamic subtest: pipe-A-plane-2
[623.403161] Dynamic subtest pipe-A-plane-2: SUCCESS (0.188s)
[624.618048] Starting dynamic subtest: pipe-B-plane-0
[624.808932] Dynamic subtest pipe-B-plane-0: SUCCESS (0.200s)
[624.820275] Starting dynamic subtest: pipe-B-plane-1
[624.998126] Dynamic subtest pipe-B-plane-1: SUCCESS (0.188s)
[625.009299] Starting dynamic subtest: pipe-B-plane-2
[625.188004] Dynamic subtest pipe-B-plane-2: SUCCESS (0.188s)
[626.445636] Starting dynamic subtest: pipe-C-plane-0
[626.602499] Dynamic subtest pipe-C-plane-0: SUCCESS (0.166s)
[626.614744] Starting dynamic subtest: pipe-C-plane-1
[626.769509] Dynamic subtest pipe-C-plane-1: SUCCESS (0.166s)
[626.781240] Starting dynamic subtest: pipe-C-plane-2
[626.935571] Dynamic subtest pipe-C-plane-2: SUCCESS (0.166s)
[628.166488] Starting dynamic subtest: pipe-D-plane-0
[628.325481] Dynamic subtest pipe-D-plane-0: SUCCESS (0.166s)
[628.337249] Starting dynamic subtest: pipe-D-plane-1
[628.480244] Dynamic subtest pipe-D-plane-1: SUCCESS (0.155s)
[628.491615] Starting dynamic subtest: pipe-D-plane-2
[628.646466] Dynamic subtest pipe-D-plane-2: SUCCESS (0.166s)
[628.932169] Subtest plane-ctm3x4-lut1d: SUCCESS (6.254s)
[629.828682] [146/156] (393s left) sw_sync (sync_random_merge)
[629.869638] Starting subtest: sync_random_merge
[629.914503] Subtest sync_random_merge: SUCCESS (0.045s)
[629.980270] [147/156] (393s left) syncobj_timeline (single-wait-for-submit-available-submitted)
[630.038830] Starting subtest: single-wait-for-submit-available-submitted
[630.041152] Subtest single-wait-for-submit-available-submitted: SUCCESS (0.000s)
[630.139342] [148/156] (393s left) kms_frontbuffer_tracking (psrhdr-2p-scndscrn-pri-indfb-draw-mmap-cpu)
[630.237220] Starting subtest: psrhdr-2p-scndscrn-pri-indfb-draw-mmap-cpu
[630.241551] Subtest psrhdr-2p-scndscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[630.337571] [149/156] (393s left) kms_cursor_legacy (cursorb-vs-flipa-varying-size)
[630.451844] Starting subtest: cursorB-vs-flipA-varying-size
[630.456346] Subtest cursorB-vs-flipA-varying-size: SKIP (0.001s)
[630.597544] [150/156] (393s left) gem_exec_params (mmapped)
[630.650272] Starting subtest: mmapped
[630.655166] Subtest mmapped: SUCCESS (0.003s)
[630.786430] [151/156] (393s left) perf (short-reads)
[630.868962] Starting subtest: short-reads
[630.881348] Subtest short-reads: SUCCESS (0.013s)
[630.929806] [152/156] (393s left) kms_cursor_legacy (flip-vs-cursor-varying-size)
[631.046577] Starting subtest: flip-vs-cursor-varying-size
[640.111030] Subtest flip-vs-cursor-varying-size: SUCCESS (9.059s)
[640.957807] [153/156] (383s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-primscrn-spr-indfb-move)
[641.067226] Starting subtest: fbcpsrhdr-1p-primscrn-spr-indfb-move
[641.071472] Subtest fbcpsrhdr-1p-primscrn-spr-indfb-move: SKIP (0.000s)
[641.165528] [154/156] (382s left) gem_exercise_blt (fast-copy)
[641.226739] Starting subtest: fast-copy
[641.228972] Starting dynamic subtest: linear-smem-smem
[641.252674] Dynamic subtest linear-smem-smem: SUCCESS (0.025s)
[641.265482] Starting dynamic subtest: xmajor-smem-smem
[641.271032] Dynamic subtest xmajor-smem-smem: SUCCESS (0.017s)
[641.281749] Starting dynamic subtest: tile4-smem-smem
[641.288926] Dynamic subtest tile4-smem-smem: SUCCESS (0.017s)
[641.299463] Starting dynamic subtest: tile64-smem-smem
[641.306406] Dynamic subtest tile64-smem-smem: SUCCESS (0.017s)
[641.308730] Subtest fast-copy: SUCCESS (0.080s)
[641.417353] [155/156] (382s left) gem_exec_flush (basic-batch-kernel-default-uc)
[641.480890] Starting subtest: basic-batch-kernel-default-uc
[648.598702] Subtest basic-batch-kernel-default-uc: SUCCESS (7.114s)
[648.794637] [156/156] (375s left) gem_eio (in-flight-1us)
[649.035081] Starting subtest: in-flight-1us
[657.630738] Subtest in-flight-1us: SUCCESS (8.592s)
[657.810348] Closing watchdogs
results: parsing output: 0/ for test: kms_psr
results: parsing output: 1/ for test: gem_mmap_offset
results: parsing output: 2/ for test: kms_frontbuffer_tracking
results: parsing output: 3/ for test: kms_big_fb
results: parsing output: 4/ for test: kms_invalid_mode
results: parsing output: 5/ for test: kms_ccs
results: parsing output: 6/ for test: kms_frontbuffer_tracking
results: parsing output: 7/ for test: kms_frontbuffer_tracking
results: parsing output: 8/ for test: kms_frontbuffer_tracking
results: parsing output: 9/ for test: kms_plane_scaling
results: parsing output: 10/ for test: kms_frontbuffer_tracking
results: parsing output: 11/ for test: kms_frontbuffer_tracking
results: parsing output: 12/ for test: gen7_exec_parse
results: parsing output: 13/ for test: kms_frontbuffer_tracking
results: parsing output: 14/ for test: kms_flip_scaled_crc
results: parsing output: 15/ for test: kms_big_fb
results: parsing output: 16/ for test: sysfs_heartbeat_interval
results: parsing output: 17/ for test: kms_ccs
results: parsing output: 18/ for test: kms_big_fb
results: parsing output: 19/ for test: prime_vgem
results: parsing output: 20/ for test: i915_power
results: parsing output: 21/ for test: prime_vgem
results: parsing output: 22/ for test: perf
results: parsing output: 23/ for test: perf
results: parsing output: 24/ for test: gem_render_copy_redux
results: parsing output: 25/ for test: kms_cursor_crc
results: parsing output: 26/ for test: kms_frontbuffer_tracking
results: parsing output: 27/ for test: kms_cursor_crc
results: parsing output: 28/ for test: kms_chamelium_hpd
results: parsing output: 29/ for test: syncobj_wait
results: parsing output: 30/ for test: gem_busy
results: parsing output: 31/ for test: gem_exec_fence
results: parsing output: 32/ for test: syncobj_timeline
results: parsing output: 33/ for test: kms_frontbuffer_tracking
results: parsing output: 34/ for test: kms_big_fb
results: parsing output: 35/ for test: syncobj_basic
results: parsing output: 36/ for test: vgem_basic
results: parsing output: 37/ for test: dmabuf_sync_file
results: parsing output: 38/ for test: api_intel_bb
results: parsing output: 39/ for test: kms_chamelium_edid
results: parsing output: 40/ for test: kms_plane
results: parsing output: 41/ for test: kms_frontbuffer_tracking
results: parsing output: 42/ for test: kms_ccs
results: parsing output: 43/ for test: kms_flip
results: parsing output: 44/ for test: kms_frontbuffer_tracking
results: parsing output: 45/ for test: kms_plane_scaling
results: parsing output: 46/ for test: kms_plane_alpha_blend
results: parsing output: 47/ for test: gem_ctx_persistence
results: parsing output: 48/ for test: perf_pmu
results: parsing output: 49/ for test: kms_big_fb
results: parsing output: 50/ for test: kms_atomic_transition
results: parsing output: 51/ for test: gem_partial_pwrite_pread
results: parsing output: 52/ for test: kms_psr
results: parsing output: 53/ for test: kms_big_fb
results: parsing output: 54/ for test: syncobj_timeline
results: parsing output: 55/ for test: kms_frontbuffer_tracking
results: parsing output: 56/ for test: kms_rotation_crc
results: parsing output: 57/ for test: kms_frontbuffer_tracking
results: parsing output: 58/ for test: gem_softpin
results: parsing output: 59/ for test: gem_mmap_gtt
results: parsing output: 60/ for test: kms_dsc
results: parsing output: 61/ for test: gem_exec_whisper
results: parsing output: 62/ for test: kms_setmode
results: parsing output: 63/ for test: kms_frontbuffer_tracking
results: parsing output: 64/ for test: kms_atomic
results: parsing output: 65/ for test: gem_mmap_wc
results: parsing output: 66/ for test: kms_frontbuffer_tracking
results: parsing output: 67/ for test: kms_big_fb
results: parsing output: 68/ for test: kms_cursor_crc
results: parsing output: 69/ for test: gem_ctx_param
results: parsing output: 70/ for test: kms_psr2_sf
results: parsing output: 71/ for test: kms_psr
results: parsing output: 72/ for test: gem_ctx_exec
results: parsing output: 73/ for test: kms_frontbuffer_tracking
results: parsing output: 74/ for test: gem_ctx_shared
results: parsing output: 75/ for test: syncobj_wait
results: parsing output: 76/ for test: perf
results: parsing output: 77/ for test: perf_pmu
results: parsing output: 78/ for test: kms_frontbuffer_tracking
results: parsing output: 79/ for test: kms_ccs
results: parsing output: 80/ for test: kms_frontbuffer_tracking
results: parsing output: 81/ for test: kms_frontbuffer_tracking
results: parsing output: 82/ for test: i915_drm_fdinfo
results: parsing output: 83/ for test: kms_frontbuffer_tracking
results: parsing output: 84/ for test: kms_tiled_display
results: parsing output: 85/ for test: kms_frontbuffer_tracking
results: parsing output: 86/ for test: kms_prop_blob
results: parsing output: 87/ for test: prime_self_import
results: parsing output: 88/ for test: gem_exec_fence
results: parsing output: 89/ for test: kms_frontbuffer_tracking
results: parsing output: 90/ for test: syncobj_wait
results: parsing output: 91/ for test: kms_frontbuffer_tracking
results: parsing output: 92/ for test: gem_pxp
results: parsing output: 93/ for test: gem_ctx_persistence
results: parsing output: 94/ for test: kms_addfb_basic
results: parsing output: 95/ for test: kms_psr
results: parsing output: 96/ for test: gem_exec_schedule
results: parsing output: 97/ for test: kms_pipe_b_c_ivb
results: parsing output: 98/ for test: kms_frontbuffer_tracking
results: parsing output: 99/ for test: gem_exec_schedule
results: parsing output: 100/ for test: kms_frontbuffer_tracking
results: parsing output: 101/ for test: syncobj_timeline
results: parsing output: 102/ for test: kms_properties
results: parsing output: 103/ for test: gem_softpin
results: parsing output: 104/ for test: gem_exec_schedule
results: parsing output: 105/ for test: gem_ctx_param
results: parsing output: 106/ for test: kms_frontbuffer_tracking
results: parsing output: 107/ for test: gem_mmap_wc
results: parsing output: 108/ for test: kms_frontbuffer_tracking
results: parsing output: 109/ for test: kms_frontbuffer_tracking
results: parsing output: 110/ for test: kms_frontbuffer_tracking
results: parsing output: 111/ for test: kms_content_protection
results: parsing output: 112/ for test: kms_psr
results: parsing output: 113/ for test: kms_psr
results: parsing output: 114/ for test: kms_pm_rpm
results: parsing output: 115/ for test: kms_frontbuffer_tracking
results: parsing output: 116/ for test: kms_plane
results: parsing output: 117/ for test: kms_flip_scaled_crc
results: parsing output: 118/ for test: gem_userptr_blits
results: parsing output: 119/ for test: kms_hdr
results: parsing output: 120/ for test: gem_exec_balancer
results: parsing output: 121/ for test: syncobj_timeline
results: parsing output: 122/ for test: gen3_render_linear_blits
results: parsing output: 123/ for test: kms_ccs
results: parsing output: 124/ for test: kms_frontbuffer_tracking
results: parsing output: 125/ for test: kms_frontbuffer_tracking
results: parsing output: 126/ for test: kms_flip
results: parsing output: 127/ for test: perf
results: parsing output: 128/ for test: kms_frontbuffer_tracking
results: parsing output: 129/ for test: kms_frontbuffer_tracking
results: parsing output: 130/ for test: kms_psr2_sf
results: parsing output: 131/ for test: kms_frontbuffer_tracking
results: parsing output: 132/ for test: kms_frontbuffer_tracking
results: parsing output: 133/ for test: kms_addfb_basic
results: parsing output: 134/ for test: kms_lease
results: parsing output: 135/ for test: kms_vblank
results: parsing output: 136/ for test: kms_frontbuffer_tracking
results: parsing output: 137/ for test: kms_cursor_legacy
results: parsing output: 138/ for test: gem_exec_suspend
results: parsing output: 139/ for test: i915_getparams_basic
results: parsing output: 140/ for test: i915_pm_rpm
results: parsing output: 141/ for test: kms_frontbuffer_tracking
results: parsing output: 142/ for test: kms_frontbuffer_tracking
results: parsing output: 143/ for test: gem_exec_flush
results: parsing output: 144/ for test: kms_color_pipeline
results: parsing output: 145/ for test: sw_sync
results: parsing output: 146/ for test: syncobj_timeline
results: parsing output: 147/ for test: kms_frontbuffer_tracking
results: parsing output: 148/ for test: kms_cursor_legacy
results: parsing output: 149/ for test: gem_exec_params
results: parsing output: 150/ for test: perf
results: parsing output: 151/ for test: kms_cursor_legacy
results: parsing output: 152/ for test: kms_frontbuffer_tracking
results: parsing output: 153/ for test: gem_exercise_blt
results: parsing output: 154/ for test: gem_exec_flush
results: parsing output: 155/ for test: gem_eio
Done.