[106.261361] Initializing watchdogs
[106.261407]   /dev/watchdog0
[106.275507] [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]
[106.279900] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[106.282149] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[106.285326] [001/133] (960s left) gem_lmem_swapping (random-engines)
[106.344907] Subtest random-engines: SKIP (0.000s)
[106.385676] [002/133] (960s left) kms_psr (psr2-sprite-mmap-cpu)
[106.494962] Starting subtest: psr2-sprite-mmap-cpu
[106.497638] Starting dynamic subtest: eDP-1
[108.244500] Dynamic subtest eDP-1: SUCCESS (1.750s)
[108.246890] Subtest psr2-sprite-mmap-cpu: SUCCESS (1.751s)
[109.115466] [003/133] (957s left) sw_sync (sync_random_merge)
[109.162484] Starting subtest: sync_random_merge
[109.208024] Subtest sync_random_merge: SUCCESS (0.046s)
[109.263741] [004/133] (957s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-mmap-wc)
[109.358411] Starting subtest: fbcpsr-rgb565-draw-mmap-wc
[116.079998] Subtest fbcpsr-rgb565-draw-mmap-wc: SUCCESS (6.727s)
[116.188611] [005/133] (950s left) gem_userptr_blits (unsync-unmap-cycles)
[116.265418] Subtest unsync-unmap-cycles: SKIP (0.000s)
[116.395501] [006/133] (950s left) kms_cursor_crc (cursor-rapid-movement-128x128)
[116.597075] Starting subtest: cursor-rapid-movement-128x128
[116.603917] Starting dynamic subtest: pipe-A-eDP-1
[117.174076] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.569s)
[117.203694] Starting dynamic subtest: pipe-D-eDP-1
[118.366377] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.170s)
[118.368797] Subtest cursor-rapid-movement-128x128: SUCCESS (1.770s)
[119.229083] [007/133] (947s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-render)
[119.325562] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-render
[119.329818] Subtest fbc-2p-primscrn-cur-indfb-draw-render: SKIP (0.000s)
[119.419790] [008/133] (947s left) kms_color_pipeline (plane-lut1d-pre-ctm3x4)
[119.519907] Starting subtest: plane-lut1d-pre-ctm3x4
[119.654834] Starting dynamic subtest: pipe-A-plane-0
[119.810313] Dynamic subtest pipe-A-plane-0: SUCCESS (0.156s)
[119.818112] Starting dynamic subtest: pipe-A-plane-1
[119.943606] Dynamic subtest pipe-A-plane-1: SUCCESS (0.133s)
[119.952166] Starting dynamic subtest: pipe-A-plane-2
[120.077056] Dynamic subtest pipe-A-plane-2: SUCCESS (0.133s)
[121.232704] Starting dynamic subtest: pipe-B-plane-0
[121.381684] Dynamic subtest pipe-B-plane-0: SUCCESS (0.155s)
[121.390849] Starting dynamic subtest: pipe-B-plane-1
[121.515392] Dynamic subtest pipe-B-plane-1: SUCCESS (0.133s)
[121.525915] Starting dynamic subtest: pipe-B-plane-2
[121.648457] Dynamic subtest pipe-B-plane-2: SUCCESS (0.133s)
[122.868822] Starting dynamic subtest: pipe-C-plane-0
[122.995471] Dynamic subtest pipe-C-plane-0: SUCCESS (0.133s)
[123.002886] Starting dynamic subtest: pipe-C-plane-1
[123.128651] Dynamic subtest pipe-C-plane-1: SUCCESS (0.133s)
[123.136106] Starting dynamic subtest: pipe-C-plane-2
[123.295346] Dynamic subtest pipe-C-plane-2: SUCCESS (0.166s)
[124.519577] Starting dynamic subtest: pipe-D-plane-0
[124.691176] Dynamic subtest pipe-D-plane-0: SUCCESS (0.178s)
[124.699163] Starting dynamic subtest: pipe-D-plane-1
[124.847321] Dynamic subtest pipe-D-plane-1: SUCCESS (0.155s)
[124.855670] Starting dynamic subtest: pipe-D-plane-2
[124.991629] Dynamic subtest pipe-D-plane-2: SUCCESS (0.144s)
[125.279448] Subtest plane-lut1d-pre-ctm3x4: SUCCESS (5.759s)
[126.087590] [009/133] (940s left) gem_ccs (large-ctrl-surf-copy)
[126.157099] Starting subtest: large-ctrl-surf-copy
[126.161228] Subtest large-ctrl-surf-copy: SKIP (0.000s)
[126.250098] [010/133] (940s left) kms_psr2_sf (fbc-pr-primary-plane-update-sf-dmg-area)
[126.346817] Starting subtest: fbc-pr-primary-plane-update-sf-dmg-area
[126.351171] Subtest fbc-pr-primary-plane-update-sf-dmg-area: SKIP (0.000s)
[126.416116] [011/133] (940s left) gem_exec_reloc (basic-write-read-noreloc)
[126.477798] Subtest basic-write-read-noreloc: SKIP (0.000s)
[126.533806] [012/133] (940s left) gem_render_copy_redux (interruptible)
[126.598690] Starting subtest: interruptible
[126.891547] Subtest interruptible: SUCCESS (0.292s)
[127.005229] [013/133] (940s left) tools_test (tools_test)
[127.053741] Starting subtest: tools_test
[127.106854] Subtest tools_test: SUCCESS (0.066s)
[127.167101] [014/133] (940s left) api_intel_bb (render-ccs)
[127.221354] Starting subtest: render-ccs
[127.573257] Subtest render-ccs: SUCCESS (0.351s)
[127.704698] [015/133] (939s left) kms_joiner (basic-force-ultra-joiner)
[127.812380] Starting subtest: basic-force-ultra-joiner
[127.816544] Subtest basic-force-ultra-joiner: SKIP (0.000s)
[127.877230] [016/133] (939s left) kms_dp_link_training (uhbr-mst)
[127.967029] Starting subtest: uhbr-mst
[127.975478] Subtest uhbr-mst: SKIP (0.000s)
[128.031794] [017/133] (939s left) kms_frontbuffer_tracking (fbc-rgb565-draw-mmap-gtt)
[128.130426] Starting subtest: fbc-rgb565-draw-mmap-gtt
[128.134969] Subtest fbc-rgb565-draw-mmap-gtt: SKIP (0.000s)
[128.227677] [018/133] (939s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-mmap-wc)
[128.317776] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-mmap-wc
[128.322085] Subtest fbc-2p-scndscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[128.420346] [019/133] (939s left) kms_content_protection (atomic-hdcp14)
[128.565304] Starting subtest: atomic-hdcp14
[128.569832] Subtest atomic-hdcp14: SKIP (0.000s)
[128.680064] [020/133] (938s left) kms_addfb_basic (no-handle)
[128.738535] Starting subtest: no-handle
[128.740258] Subtest no-handle: SUCCESS (0.000s)
[128.869512] [021/133] (938s left) core_setmaster (master-drop-set-root)
[128.930990] Starting subtest: master-drop-set-root
[128.957752] Subtest master-drop-set-root: SUCCESS (0.027s)
[129.005250] [022/133] (938s left) kms_flip (bo-too-big-interruptible)
[129.091870] Starting subtest: bo-too-big-interruptible
[129.093487] Starting dynamic subtest: A-eDP1
[130.418686] Dynamic subtest A-eDP1: SUCCESS (1.325s)
[130.428744] Starting dynamic subtest: B-eDP1
[131.663658] Dynamic subtest B-eDP1: SUCCESS (1.245s)
[131.673073] Starting dynamic subtest: C-eDP1
[132.911265] Dynamic subtest C-eDP1: SUCCESS (1.246s)
[132.921919] Starting dynamic subtest: D-eDP1
[134.150628] Dynamic subtest D-eDP1: SUCCESS (1.238s)
[134.156058] Subtest bo-too-big-interruptible: SUCCESS (5.063s)
[135.355912] [023/133] (932s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-pwrite)
[135.468801] Starting subtest: psr-1p-primscrn-pri-indfb-draw-pwrite
[143.111079] Subtest psr-1p-primscrn-pri-indfb-draw-pwrite: SUCCESS (7.646s)
[143.231649] [024/133] (924s left) sysfs_heartbeat_interval (nopreempt)
[143.304962] Starting subtest: nopreempt
[143.309714] Starting dynamic subtest: vecs0
[152.911237] Dynamic subtest vecs0: SUCCESS (9.602s)
[152.921433] Starting dynamic subtest: ccs0
[156.914734] Dynamic subtest ccs0: SUCCESS (4.003s)
[156.924827] Starting dynamic subtest: vcs0
[166.928821] Dynamic subtest vcs0: SUCCESS (10.011s)
[166.938093] Starting dynamic subtest: bcs0
[170.814967] Dynamic subtest bcs0: SUCCESS (3.887s)
[170.825707] Starting dynamic subtest: rcs0
[174.863586] Dynamic subtest rcs0: SUCCESS (4.047s)
[174.873575] Starting dynamic subtest: vcs1
[184.916991] Dynamic subtest vcs1: SUCCESS (10.049s)
[184.919547] Subtest nopreempt: SUCCESS (41.608s)
[184.994816] [025/133] (882s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-shrfb-draw-mmap-gtt)
[185.096456] Starting subtest: psr-1p-offscreen-pri-shrfb-draw-mmap-gtt
[185.100649] Subtest psr-1p-offscreen-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[185.181072] [026/133] (882s left) kms_big_fb (4-tiled-8bpp-rotate-90)
[185.312853] Starting subtest: 4-tiled-8bpp-rotate-90
[185.346441] Subtest 4-tiled-8bpp-rotate-90: SKIP (0.032s)
[185.463538] [027/133] (882s left) syncobj_wait (multi-wait-all-for-submit-unsubmitted-signaled)
[185.519795] Starting subtest: multi-wait-all-for-submit-unsubmitted-signaled
[185.624920] Subtest multi-wait-all-for-submit-unsubmitted-signaled: SUCCESS (0.104s)
[185.703789] [028/133] (882s left) kms_flip (flip-vs-dpms-on-nop-interruptible)
[185.807360] Starting subtest: flip-vs-dpms-on-nop-interruptible
[185.809682] Starting dynamic subtest: A-eDP1
[187.654195] Dynamic subtest A-eDP1: SUCCESS (1.846s)
[187.664832] Starting dynamic subtest: B-eDP1
[189.476784] Dynamic subtest B-eDP1: SUCCESS (1.822s)
[189.486998] Starting dynamic subtest: C-eDP1
[191.301563] Dynamic subtest C-eDP1: SUCCESS (1.822s)
[191.309299] Starting dynamic subtest: D-eDP1
[193.119938] Dynamic subtest D-eDP1: SUCCESS (1.816s)
[193.124940] Subtest flip-vs-dpms-on-nop-interruptible: SUCCESS (7.317s)
[194.294480] [029/133] (873s left) gem_wait (await)
[194.365489] Starting subtest: await
[194.367965] Starting dynamic subtest: all-engines
[195.494436] Dynamic subtest all-engines: SUCCESS (1.128s)
[195.508691] Starting dynamic subtest: rcs0
[196.548857] Dynamic subtest rcs0: SUCCESS (1.053s)
[196.563580] Starting dynamic subtest: bcs0
[197.604044] Dynamic subtest bcs0: SUCCESS (1.053s)
[197.618806] Starting dynamic subtest: vcs0
[198.657215] Dynamic subtest vcs0: SUCCESS (1.051s)
[198.674197] Starting dynamic subtest: vcs1
[199.711339] Dynamic subtest vcs1: SUCCESS (1.052s)
[199.726950] Starting dynamic subtest: vecs0
[200.766261] Dynamic subtest vecs0: SUCCESS (1.053s)
[200.781222] Starting dynamic subtest: ccs0
[201.822109] Dynamic subtest ccs0: SUCCESS (1.054s)
[201.824962] Subtest await: SUCCESS (7.456s)
[202.019170] [FACT gem_wait (await)] new: kernel.kmod_is_loaded.vgem: true
[202.022660] [030/133] (865s left) syncobj_wait (multi-wait-for-submit-signaled)
[202.071095] Starting subtest: multi-wait-for-submit-signaled
[202.073384] Subtest multi-wait-for-submit-signaled: SUCCESS (0.000s)
[202.175399] [031/133] (865s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-mmap-cpu)
[202.265586] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-mmap-cpu
[202.269700] Subtest fbc-2p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[202.384065] [032/133] (865s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-180)
[202.489676] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-180
[203.456724] Subtest 4-tiled-max-hw-stride-64bpp-rotate-180: SUCCESS (0.967s)
[203.597208] [033/133] (864s left) perf_pmu (rc6-all-gts)
[203.637795] Starting subtest: rc6-all-gts
[210.006763] Subtest rc6-all-gts: SUCCESS (6.367s)
[210.897698] [034/133] (857s left) gem_mmap_offset (ptrace)
[210.962858] Starting subtest: ptrace
[210.967424] Starting dynamic subtest: smem0-wb
[210.982934] Dynamic subtest smem0-wb: SUCCESS (0.018s)
[210.991113] Starting dynamic subtest: smem0-wc
[211.003551] Dynamic subtest smem0-wc: SUCCESS (0.020s)
[211.016177] Starting dynamic subtest: smem0-uc
[211.028508] Dynamic subtest smem0-uc: SUCCESS (0.024s)
[211.030959] Subtest ptrace: SUCCESS (0.068s)
[211.158549] [035/133] (856s left) gem_ctx_bad_destroy (invalid-pad)
[211.226231] Starting subtest: invalid-pad
[211.227801] Subtest invalid-pad: SUCCESS (0.000s)
[211.305874] [036/133] (856s left) gem_exec_params (dr1-dirt)
[211.357256] Starting subtest: DR1-dirt
[211.359215] Subtest DR1-dirt: SUCCESS (0.000s)
[211.470204] [037/133] (856s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-cpu)
[211.572978] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-cpu
[218.594164] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-cpu: SUCCESS (7.025s)
[218.704423] [038/133] (849s left) kms_chamelium_color (ctm-blue-to-red)
[218.805444] Subtest ctm-blue-to-red: SKIP (0.000s)
[218.874359] [039/133] (849s left) kms_psr (pr-cursor-mmap-cpu)
[218.976035] Starting subtest: pr-cursor-mmap-cpu
[218.980310] Subtest pr-cursor-mmap-cpu: SKIP (0.000s)
[219.045155] [040/133] (849s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-fullscreen)
[219.149819] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-fullscreen
[225.795807] Subtest fbcpsr-1p-primscrn-spr-indfb-fullscreen: SUCCESS (6.650s)
[225.946475] [041/133] (842s left) kms_cursor_crc (cursor-alpha-transparent)
[226.052153] Starting subtest: cursor-alpha-transparent
[226.054420] Starting dynamic subtest: pipe-A-eDP-1
[226.678246] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.625s)
[226.686990] Starting dynamic subtest: pipe-D-eDP-1
[227.925872] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.247s)
[227.928237] Subtest cursor-alpha-transparent: SUCCESS (1.875s)
[228.735971] [042/133] (839s left) kms_flip (2x-modeset-vs-vblank-race)
[228.839273] Starting subtest: 2x-modeset-vs-vblank-race
[228.848039] Subtest 2x-modeset-vs-vblank-race: SKIP (0.010s)
[228.949588] [043/133] (839s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-wc)
[229.042082] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-wc
[229.046298] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[229.139450] [044/133] (839s left) gem_exec_basic (basic)
[229.189535] Starting subtest: basic
[229.191807] Starting dynamic subtest: rcs0-smem
[229.194193] Dynamic subtest rcs0-smem: SUCCESS (0.002s)
[229.203688] Starting dynamic subtest: bcs0-smem
[229.206039] Dynamic subtest bcs0-smem: SUCCESS (0.001s)
[229.213695] Starting dynamic subtest: vcs0-smem
[229.215934] Dynamic subtest vcs0-smem: SUCCESS (0.001s)
[229.223476] Starting dynamic subtest: vcs1-smem
[229.225670] Dynamic subtest vcs1-smem: SUCCESS (0.001s)
[229.233291] Starting dynamic subtest: vecs0-smem
[229.235459] Dynamic subtest vecs0-smem: SUCCESS (0.002s)
[229.243046] Starting dynamic subtest: ccs0-smem
[229.245277] Dynamic subtest ccs0-smem: SUCCESS (0.002s)
[229.247488] Subtest basic: SUCCESS (0.014s)
[230.971781] [045/133] (837s left) kms_ccs (ccs-on-another-bo-4-tiled-mtl-rc-ccs)
[231.055205] Starting subtest: ccs-on-another-bo-4-tiled-mtl-rc-ccs
[231.057537] Starting dynamic subtest: pipe-A-eDP-1
[231.077718] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[231.087145] Starting dynamic subtest: pipe-B-eDP-1
[231.106616] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[231.114470] Starting dynamic subtest: pipe-C-eDP-1
[231.133462] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[231.141214] Starting dynamic subtest: pipe-D-eDP-1
[231.160735] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[231.162895] Subtest ccs-on-another-bo-4-tiled-mtl-rc-ccs: SUCCESS (0.007s)
[233.317879] [046/133] (835s left) kms_atomic (plane-primary-overlay-mutable-zpos)
[233.409168] Starting subtest: plane-primary-overlay-mutable-zpos
[236.865893] Subtest plane-primary-overlay-mutable-zpos: SKIP (3.456s)
[238.062691] [047/133] (830s left) gem_flink_basic (double-flink)
[238.114277] Starting subtest: double-flink
[238.116169] Subtest double-flink: SUCCESS (0.000s)
[238.197671] [048/133] (830s left) kms_addfb_basic (framebuffer-vs-set-tiling)
[238.251148] Starting subtest: framebuffer-vs-set-tiling
[238.255630] Subtest framebuffer-vs-set-tiling: SKIP (0.000s)
[238.377174] [049/133] (830s left) gem_create (create-ext-cpu-access-big)
[238.549242] Starting subtest: create-ext-cpu-access-big
[238.553942] Subtest create-ext-cpu-access-big: SKIP (0.001s)
[238.634926] [050/133] (830s left) gem_exec_balancer (fairslice)
[238.696154] Starting subtest: fairslice
[241.594896] Subtest fairslice: SUCCESS (2.897s)
[241.903587] [051/133] (826s left) gem_exec_fence (submit-chain)
[242.086990] Starting subtest: submit-chain
[242.116202] Subtest submit-chain: SUCCESS (0.029s)
[244.014417] [052/133] (824s left) kms_lease (lease-get)
[244.114870] Starting subtest: lease-get
[244.117185] Starting dynamic subtest: pipe-A-eDP-1
[244.119473] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[244.128886] Starting dynamic subtest: pipe-B-eDP-1
[244.130855] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[244.138768] Starting dynamic subtest: pipe-C-eDP-1
[244.140676] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[244.148466] Starting dynamic subtest: pipe-D-eDP-1
[244.150450] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[244.152315] Subtest lease-get: SUCCESS (0.009s)
[244.232883] [053/133] (824s left) gen9_exec_parse (shadow-peek)
[244.312544] Subtest shadow-peek: SKIP (0.000s)
[244.363876] [054/133] (824s left) gem_exec_params (no-bsd)
[244.419024] Starting subtest: no-bsd
[244.421411] Subtest no-bsd: SUCCESS (0.002s)
[245.959210] [055/133] (822s left) kms_frontbuffer_tracking (psr-2p-scndscrn-indfb-msflip-blt)
[246.053743] Starting subtest: psr-2p-scndscrn-indfb-msflip-blt
[246.057886] Subtest psr-2p-scndscrn-indfb-msflip-blt: SKIP (0.000s)
[246.134872] [056/133] (822s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-shrfb-pgflip-blt)
[246.234800] Starting subtest: fbc-2p-scndscrn-shrfb-pgflip-blt
[246.238988] Subtest fbc-2p-scndscrn-shrfb-pgflip-blt: SKIP (0.000s)
[246.331308] [057/133] (822s left) syncobj_timeline (device-submit-unordered)
[246.391922] Starting subtest: device-submit-unordered
[246.394260] Subtest device-submit-unordered: SUCCESS (0.001s)
[246.485822] [058/133] (822s left) kms_chamelium_hpd (dp-hpd-for-each-pipe)
[246.881425] Subtest dp-hpd-for-each-pipe: SKIP (0.000s)
[247.669881] [059/133] (821s left) kms_vblank (query-busy-hang)
[247.762290] Starting subtest: query-busy-hang
[247.764159] Starting dynamic subtest: pipe-A-eDP-1
[275.679964] Dynamic subtest pipe-A-eDP-1: SUCCESS (27.914s)
[275.694650] Starting dynamic subtest: pipe-D-eDP-1
[290.636024] Dynamic subtest pipe-D-eDP-1: SUCCESS (14.952s)
[290.638224] Subtest query-busy-hang: SUCCESS (42.871s)
[291.463885] [060/133] (777s left) prime_vgem (shrink)
[291.542711] Starting subtest: shrink
[291.558057] Subtest shrink: SUCCESS (0.013s)
[291.651103] [061/133] (777s left) syncobj_timeline (host-signal-ordered)
[291.714194] Starting subtest: host-signal-ordered
[291.716264] Subtest host-signal-ordered: SUCCESS (0.000s)
[291.821553] [062/133] (777s left) gem_workarounds (basic-read)
[291.881528] Starting subtest: basic-read
[291.891298] Subtest basic-read: SUCCESS (0.012s)
[292.015894] [063/133] (777s left) kms_properties (invalid-properties-atomic)
[292.100322] Starting subtest: invalid-properties-atomic
[292.397505] Subtest invalid-properties-atomic: SUCCESS (0.297s)
[292.468200] [064/133] (776s left) kms_psr2_sf (psr2-overlay-primary-update-sf-dmg-area)
[292.567472] Starting subtest: psr2-overlay-primary-update-sf-dmg-area
[292.569869] Starting dynamic subtest: pipe-A-eDP-1
[298.511860] Dynamic subtest pipe-A-eDP-1: SUCCESS (5.949s)
[298.520895] Starting dynamic subtest: pipe-B-eDP-1
[305.165611] Dynamic subtest pipe-B-eDP-1: SUCCESS (6.650s)
[305.168094] Subtest psr2-overlay-primary-update-sf-dmg-area: SUCCESS (12.603s)
[306.037181] [065/133] (763s left) gem_render_copy (y-tiled-mc-ccs-to-y-tiled-ccs)
[306.093055] Starting subtest: y-tiled-mc-ccs-to-y-tiled-ccs
[306.097112] Subtest y-tiled-mc-ccs-to-y-tiled-ccs: SKIP (0.000s)
[306.279207] [066/133] (763s left) vgem_basic (unload)
[306.318797] Starting subtest: unload
[335.383897] Subtest unload: SUCCESS (29.066s)
[335.479977] [067/133] (733s left) kms_flip (2x-flip-vs-absolute-wf_vblank-interruptible)
[335.586367] Starting subtest: 2x-flip-vs-absolute-wf_vblank-interruptible
[335.597847] Subtest 2x-flip-vs-absolute-wf_vblank-interruptible: SKIP (0.010s)
[335.677733] [068/133] (733s left) kms_pipe_stress (stress-xrgb8888-yftiled)
[335.762746] Starting subtest: stress-xrgb8888-yftiled
[335.766679] Subtest stress-xrgb8888-yftiled: SKIP (0.000s)
[335.834872] [069/133] (733s left) gem_ctx_param (set-priority-range)
[335.881822] Starting subtest: set-priority-range
[335.897954] Subtest set-priority-range: SUCCESS (0.016s)
[336.003530] [070/133] (733s left) gem_lmem_swapping (basic)
[336.049754] Subtest basic: SKIP (0.000s)
[336.090615] [071/133] (733s left) kms_cursor_legacy (cursora-vs-flipa-atomic-transitions-varying-size)
[336.200288] Starting subtest: cursorA-vs-flipA-atomic-transitions-varying-size
[347.382841] Subtest cursorA-vs-flipA-atomic-transitions-varying-size: SUCCESS (11.179s)
[348.186465] [072/133] (721s left) kms_plane_scaling (planes-downscale-factor-0-75-upscale-20x20)
[348.297330] Starting subtest: planes-downscale-factor-0-75-upscale-20x20
[348.299648] Starting dynamic subtest: pipe-A
[348.361800] Dynamic subtest pipe-A: SUCCESS (0.067s)
[348.373076] Starting dynamic subtest: pipe-B
[349.512594] Dynamic subtest pipe-B: SUCCESS (1.148s)
[349.521637] Starting dynamic subtest: pipe-C
[350.619612] Dynamic subtest pipe-C: SUCCESS (1.105s)
[350.629013] Starting dynamic subtest: pipe-D
[351.757110] Dynamic subtest pipe-D: SUCCESS (1.137s)
[351.759382] Subtest planes-downscale-factor-0-75-upscale-20x20: SUCCESS (3.463s)
[352.922366] [073/133] (716s left) kms_big_fb (y-tiled-32bpp-rotate-180)
[353.010780] Starting subtest: y-tiled-32bpp-rotate-180
[353.015218] Subtest y-tiled-32bpp-rotate-180: SKIP (0.000s)
[353.116436] [074/133] (716s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-180-hflip)
[353.237172] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-180-hflip
[353.241712] Subtest y-tiled-max-hw-stride-32bpp-rotate-180-hflip: SKIP (0.000s)
[353.335188] [075/133] (716s left) kms_psr (psr-primary-mmap-gtt)
[353.439866] Starting subtest: psr-primary-mmap-gtt
[353.442151] Starting dynamic subtest: eDP-1
[354.925393] Dynamic subtest eDP-1: SKIP (1.480s)
[354.930359] Subtest psr-primary-mmap-gtt: SKIP (1.483s)
[355.072448] [076/133] (714s left) syncobj_timeline (multi-wait-for-submit-available-signaled)
[355.129744] Starting subtest: multi-wait-for-submit-available-signaled
[355.132092] Subtest multi-wait-for-submit-available-signaled: SUCCESS (0.000s)
[355.212448] [077/133] (714s left) kms_vblank (ts-continuation-modeset)
[355.309320] Starting subtest: ts-continuation-modeset
[355.311190] Starting dynamic subtest: pipe-A-eDP-1
[356.828420] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.518s)
[356.842416] Starting dynamic subtest: pipe-D-eDP-1
[358.981501] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.150s)
[358.983761] Subtest ts-continuation-modeset: SUCCESS (3.672s)
[359.779835] [078/133] (710s left) gem_ctx_persistence (engines-cleanup)
[359.846072] Starting subtest: engines-cleanup
[359.848283] Starting dynamic subtest: rcs0
[359.887916] Dynamic subtest rcs0: SUCCESS (0.041s)
[359.897746] Starting dynamic subtest: bcs0
[359.962810] Dynamic subtest bcs0: SUCCESS (0.074s)
[359.974032] Starting dynamic subtest: vcs0
[359.988552] Dynamic subtest vcs0: SUCCESS (0.024s)
[359.996729] Starting dynamic subtest: vcs1
[360.058708] Dynamic subtest vcs1: SUCCESS (0.069s)
[360.069828] Starting dynamic subtest: vecs0
[360.101762] Dynamic subtest vecs0: SUCCESS (0.041s)
[360.111214] Starting dynamic subtest: ccs0
[360.139868] Dynamic subtest ccs0: SUCCESS (0.036s)
[360.142646] Subtest engines-cleanup: SUCCESS (0.295s)
[360.230190] [079/133] (709s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-fullscreen)
[360.323485] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-fullscreen
[360.327638] Subtest fbcpsr-2p-primscrn-spr-indfb-fullscreen: SKIP (0.000s)
[360.427878] [080/133] (709s left) gem_mmap_offset (open-flood)
[360.473840] Starting subtest: open-flood
[381.964986] Subtest open-flood: SUCCESS (21.493s)
[382.069738] [081/133] (687s left) gem_exec_schedule (preempt-hang)
[382.252045] Starting subtest: preempt-hang
[382.254553] Starting dynamic subtest: rcs0
[382.502377] Dynamic subtest rcs0: SUCCESS (0.255s)
[382.511571] Starting dynamic subtest: bcs0
[382.741116] Dynamic subtest bcs0: SUCCESS (0.238s)
[382.750544] Starting dynamic subtest: vcs0
[382.970951] Dynamic subtest vcs0: SUCCESS (0.227s)
[382.979497] Starting dynamic subtest: vcs1
[383.197292] Dynamic subtest vcs1: SUCCESS (0.226s)
[383.206853] Starting dynamic subtest: vecs0
[383.426471] Dynamic subtest vecs0: SUCCESS (0.228s)
[383.435397] Starting dynamic subtest: ccs0
[383.666993] Dynamic subtest ccs0: SUCCESS (0.240s)
[383.668873] Subtest preempt-hang: SUCCESS (1.418s)
[383.984848] [082/133] (686s left) kms_big_fb (linear-max-hw-stride-32bpp-rotate-0-hflip)
[384.090773] Starting subtest: linear-max-hw-stride-32bpp-rotate-0-hflip
[384.094781] Subtest linear-max-hw-stride-32bpp-rotate-0-hflip: SKIP (0.000s)
[384.187932] [083/133] (685s left) gem_flink_race (flink_close)
[384.230643] Starting subtest: flink_close
[389.318375] Subtest flink_close: SUCCESS (5.088s)
[389.410793] [084/133] (680s left) i915_pm_freq_api (freq-basic-api)
[389.488654] Starting subtest: freq-basic-api
[389.491063] Starting dynamic subtest: gt0
[389.495729] Dynamic subtest gt0: SUCCESS (0.006s)
[389.504985] Starting dynamic subtest: gt1
[389.507233] Dynamic subtest gt1: SUCCESS (0.002s)
[389.509416] Subtest freq-basic-api: SUCCESS (0.009s)
[389.601828] [085/133] (680s left) gem_exec_reloc (basic-cpu-gtt)
[389.660514] Subtest basic-cpu-gtt: SKIP (0.000s)
[389.739962] [086/133] (680s left) kms_plane (pixel-format-yf-tiled-modifier)
[389.839339] Starting subtest: pixel-format-yf-tiled-modifier
[389.844126] Subtest pixel-format-yf-tiled-modifier: SKIP (0.000s)
[389.906910] [087/133] (680s left) i915_suspend (debugfs-reader)
[389.959380] Starting subtest: debugfs-reader
[407.707650] Subtest debugfs-reader: SUCCESS (3.241s)
[407.898317] [088/133] (662s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-mmap-cpu)
[408.012313] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-mmap-cpu
[408.016515] Subtest fbc-2p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[408.107657] [089/133] (662s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip)
[408.194012] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip
[408.198204] Subtest yf-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip: SKIP (0.000s)
[408.296032] [090/133] (662s left) kms_pm_rpm (cursor-dpms)
[410.627375] Starting subtest: cursor-dpms
[410.632530] Subtest cursor-dpms: SKIP (0.000s)
[411.011981] [091/133] (659s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-indfb-draw-mmap-cpu)
[411.121219] Starting subtest: fbc-1p-offscreen-pri-indfb-draw-mmap-cpu
[415.112952] Subtest fbc-1p-offscreen-pri-indfb-draw-mmap-cpu: SUCCESS (3.994s)
[416.305913] [092/133] (654s left) gem_pxp (verify-pxp-stale-ctx-execution)
[416.427459] Starting subtest: verify-pxp-stale-ctx-execution
[417.485753] Subtest verify-pxp-stale-ctx-execution: SUCCESS (1.060s)
[417.614640] [093/133] (653s left) syncobj_wait (multi-wait-all-submitted-signaled)
[417.673918] Starting subtest: multi-wait-all-submitted-signaled
[417.781647] Subtest multi-wait-all-submitted-signaled: SUCCESS (0.107s)
[417.859556] [094/133] (652s left) gem_ctx_shared (exec-shared-gtt)
[417.919697] Starting subtest: exec-shared-gtt
[417.922050] Starting dynamic subtest: rcs0
[417.927292] Dynamic subtest rcs0: SUCCESS (0.007s)
[417.945282] Starting dynamic subtest: bcs0
[417.947381] Dynamic subtest bcs0: SUCCESS (0.005s)
[417.956867] Starting dynamic subtest: vcs0
[417.958728] Dynamic subtest vcs0: SUCCESS (0.010s)
[417.968058] Starting dynamic subtest: vcs1
[417.970245] Dynamic subtest vcs1: SUCCESS (0.005s)
[417.979599] Starting dynamic subtest: vecs0
[417.981743] Dynamic subtest vecs0: SUCCESS (0.005s)
[417.990990] Starting dynamic subtest: ccs0
[417.993234] Dynamic subtest ccs0: SUCCESS (0.006s)
[417.995516] Subtest exec-shared-gtt: SUCCESS (0.042s)
[418.147264] [095/133] (652s left) kms_pm_rpm (modeset-pc8-residency-stress)
[419.665001] Starting subtest: modeset-pc8-residency-stress
[419.669848] Subtest modeset-pc8-residency-stress: SKIP (0.000s)
[420.438141] [096/133] (650s left) kms_cursor_crc (cursor-suspend)
[420.559385] Starting subtest: cursor-suspend
[420.561721] Starting dynamic subtest: pipe-A-eDP-1
[453.163969] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.122s)
[453.175965] Starting dynamic subtest: pipe-D-eDP-1
[487.165426] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.722s)
[487.167454] Subtest cursor-suspend: SUCCESS (6.846s)
[487.995795] [097/133] (582s left) kms_flip (basic-plain-flip)
[488.084078] Starting subtest: basic-plain-flip
[488.086438] Starting dynamic subtest: A-eDP1
[489.792741] Dynamic subtest A-eDP1: SUCCESS (1.708s)
[489.806709] Starting dynamic subtest: B-eDP1
[491.422412] Dynamic subtest B-eDP1: SUCCESS (1.627s)
[491.432533] Starting dynamic subtest: C-eDP1
[493.044827] Dynamic subtest C-eDP1: SUCCESS (1.621s)
[493.058414] Starting dynamic subtest: D-eDP1
[494.677399] Dynamic subtest D-eDP1: SUCCESS (1.630s)
[494.682861] Subtest basic-plain-flip: SUCCESS (6.598s)
[495.849503] [098/133] (575s left) kms_frontbuffer_tracking (psr-rgb565-draw-mmap-wc)
[495.954064] Starting subtest: psr-rgb565-draw-mmap-wc
[502.658622] Subtest psr-rgb565-draw-mmap-wc: SUCCESS (6.707s)
[502.773164] [099/133] (568s left) kms_psr (fbc-psr-basic)
[502.860710] Starting subtest: fbc-psr-basic
[502.862986] Starting dynamic subtest: eDP-1
[502.867235] Dynamic subtest eDP-1: SKIP (0.000s)
[502.871442] Subtest fbc-psr-basic: SKIP (0.001s)
[502.936637] [100/133] (568s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-mmap-cpu)
[503.020656] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-mmap-cpu
[503.025039] Subtest psr-2p-primscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[503.114956] [101/133] (567s left) gem_spin_batch (resubmit-all)
[503.178326] Starting subtest: resubmit-all
[503.180736] Starting dynamic subtest: rcs0
[503.191199] Dynamic subtest rcs0: SUCCESS (0.013s)
[503.201922] Starting dynamic subtest: bcs0
[503.204203] Dynamic subtest bcs0: SUCCESS (0.002s)
[503.213758] Starting dynamic subtest: vcs0
[503.216012] Dynamic subtest vcs0: SUCCESS (0.004s)
[503.224689] Starting dynamic subtest: vcs1
[503.226652] Dynamic subtest vcs1: SUCCESS (0.002s)
[503.235593] Starting dynamic subtest: vecs0
[503.237528] Dynamic subtest vecs0: SUCCESS (0.002s)
[503.246327] Starting dynamic subtest: ccs0
[503.248244] Dynamic subtest ccs0: SUCCESS (0.004s)
[503.250156] Subtest resubmit-all: SUCCESS (0.035s)
[505.248874] [102/133] (565s left) gem_sync (basic-all)
[505.321497] Starting subtest: basic-all
[509.167745] Subtest basic-all: SUCCESS (3.853s)
[509.368039] [103/133] (561s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-mmap-gtt)
[509.473887] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-mmap-gtt
[509.478395] Subtest fbc-2p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[509.584311] [104/133] (561s left) kms_ccs (bad-rotation-90-y-tiled-ccs)
[509.676957] Starting subtest: bad-rotation-90-y-tiled-ccs
[509.679261] Starting dynamic subtest: pipe-A-eDP-1
[509.702509] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[509.714536] Starting dynamic subtest: pipe-B-eDP-1
[509.736082] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[509.745129] Starting dynamic subtest: pipe-C-eDP-1
[509.766179] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[509.775146] Starting dynamic subtest: pipe-D-eDP-1
[509.797256] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[509.801597] Subtest bad-rotation-90-y-tiled-ccs: SKIP (0.004s)
[511.926843] [105/133] (559s left) i915_drm_fdinfo (busy)
[511.974296] Starting subtest: busy
[511.976579] Starting dynamic subtest: rcs0
[511.996574] Dynamic subtest rcs0: SKIP (0.020s)
[512.006834] Starting dynamic subtest: bcs0
[512.010952] Dynamic subtest bcs0: SKIP (0.001s)
[512.020638] Starting dynamic subtest: vcs0
[512.024512] Dynamic subtest vcs0: SKIP (0.000s)
[512.033471] Starting dynamic subtest: vcs1
[512.037715] Dynamic subtest vcs1: SKIP (0.000s)
[512.047267] Starting dynamic subtest: vecs0
[512.051563] Dynamic subtest vecs0: SKIP (0.000s)
[512.062237] Starting dynamic subtest: ccs0
[512.066406] Dynamic subtest ccs0: SKIP (0.000s)
[512.070594] Subtest busy: SKIP (0.027s)
[512.107870] [106/133] (559s left) kms_cursor_legacy (cursora-vs-flipb-toggle)
[512.231201] Starting subtest: cursorA-vs-flipB-toggle
[512.235798] Subtest cursorA-vs-flipB-toggle: SKIP (0.001s)
[512.374527] [107/133] (558s left) kms_plane_multiple (tiling-4)
[512.467119] Starting subtest: tiling-4
[512.469442] Starting dynamic subtest: pipe-A-eDP-1
[516.155944] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.688s)
[516.166528] Starting dynamic subtest: pipe-B-eDP-1
[520.604010] Dynamic subtest pipe-B-eDP-1: SUCCESS (4.442s)
[520.614887] Starting dynamic subtest: pipe-C-eDP-1
[524.949835] Dynamic subtest pipe-C-eDP-1: SUCCESS (4.342s)
[524.959816] Starting dynamic subtest: pipe-D-eDP-1
[529.265836] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.313s)
[529.267930] Subtest tiling-4: SUCCESS (16.791s)
[530.098874] [108/133] (541s left) kms_ccs (random-ccs-data-4-tiled-dg2-mc-ccs)
[530.201990] Starting subtest: random-ccs-data-4-tiled-dg2-mc-ccs
[530.204210] Starting dynamic subtest: pipe-A-eDP-1
[530.228810] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[530.241426] Starting dynamic subtest: pipe-B-eDP-1
[530.264371] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[530.273466] Starting dynamic subtest: pipe-C-eDP-1
[530.296625] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[530.305595] Starting dynamic subtest: pipe-D-eDP-1
[530.329421] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[530.333874] Subtest random-ccs-data-4-tiled-dg2-mc-ccs: SKIP (0.005s)
[532.370504] [109/133] (538s left) kms_psr (fbc-pr-suspend)
[532.454745] Starting subtest: fbc-pr-suspend
[532.458873] Subtest fbc-pr-suspend: SKIP (0.000s)
[532.542216] [110/133] (538s left) gem_exec_params (larger-than-life-batch)
[532.606049] Starting subtest: larger-than-life-batch
[535.041843] Subtest larger-than-life-batch: SUCCESS (2.434s)
[536.225035] [111/133] (535s left) kms_ccs (crc-primary-suspend-4-tiled-dg2-rc-ccs-cc)
[536.363717] Starting subtest: crc-primary-suspend-4-tiled-dg2-rc-ccs-cc
[536.365919] Starting dynamic subtest: pipe-A-eDP-1
[536.374883] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[536.386386] Starting dynamic subtest: pipe-B-eDP-1
[536.395200] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[536.404806] Starting dynamic subtest: pipe-C-eDP-1
[536.412902] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[536.422804] Starting dynamic subtest: pipe-D-eDP-1
[536.431822] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[536.436356] Subtest crc-primary-suspend-4-tiled-dg2-rc-ccs-cc: SKIP (0.004s)
[538.562592] [112/133] (532s left) api_intel_allocator (fork-simple-once)
[538.634829] Starting subtest: fork-simple-once
[538.648799] Subtest fork-simple-once: SUCCESS (0.016s)
[538.772479] [113/133] (532s left) kms_flip (flip-vs-panning-vs-hang)
[538.873176] Starting subtest: flip-vs-panning-vs-hang
[538.875456] Starting dynamic subtest: A-eDP1
[578.646850] Dynamic subtest A-eDP1: SUCCESS (39.774s)
[578.659920] Starting dynamic subtest: D-eDP1
[628.631258] Dynamic subtest D-eDP1: SUCCESS (49.979s)
[628.633618] Subtest flip-vs-panning-vs-hang: SUCCESS (89.758s)
[629.821142] [114/133] (441s left) kms_async_flips (async-flip-with-page-flip-events-linear-atomic)
[629.908096] Starting subtest: async-flip-with-page-flip-events-linear-atomic
[630.290903] Starting dynamic subtest: pipe-A-eDP-1
[633.101031] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.809s)
[633.462881] Starting dynamic subtest: pipe-B-eDP-1
[636.222678] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.766s)
[636.586423] Starting dynamic subtest: pipe-C-eDP-1
[639.347142] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.769s)
[639.721579] Starting dynamic subtest: pipe-D-eDP-1
[642.472585] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.761s)
[642.474801] Subtest async-flip-with-page-flip-events-linear-atomic: SUCCESS (12.566s)
[643.662197] [115/133] (427s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-onoff)
[643.765733] Starting subtest: psr-2p-primscrn-cur-indfb-onoff
[643.769924] Subtest psr-2p-primscrn-cur-indfb-onoff: SKIP (0.000s)
[643.886813] [116/133] (427s left) kms_chamelium_frames (hdmi-crc-multiple)
[644.270662] Subtest hdmi-crc-multiple: SKIP (0.000s)
[645.069814] [117/133] (426s left) gem_ctx_persistence (processes)
[645.138752] Starting subtest: processes
[647.166420] Subtest processes: SUCCESS (2.027s)
[647.247210] [118/133] (424s left) i915_pm_rpm (debugfs-forcewake-user)
[649.286425] Starting subtest: debugfs-forcewake-user
[660.691128] Subtest debugfs-forcewake-user: SUCCESS (11.404s)
[661.087420] [119/133] (410s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-16bpp-ytile-downscaling)
[661.188215] Starting subtest: flip-64bpp-ytile-to-16bpp-ytile-downscaling
[661.192658] Subtest flip-64bpp-ytile-to-16bpp-ytile-downscaling: SKIP (0.000s)
[661.263155] [120/133] (410s left) kms_psr2_sf (psr2-cursor-plane-move-continuous-exceed-sf)
[661.350860] Starting subtest: psr2-cursor-plane-move-continuous-exceed-sf
[661.353102] Starting dynamic subtest: pipe-A-eDP-1
[672.029438] Dynamic subtest pipe-A-eDP-1: SUCCESS (10.682s)
[672.040976] Starting dynamic subtest: pipe-B-eDP-1
[683.463380] Dynamic subtest pipe-B-eDP-1: SUCCESS (11.430s)
[683.465709] Subtest psr2-cursor-plane-move-continuous-exceed-sf: SUCCESS (22.116s)
[684.322778] [121/133] (387s left) syncobj_timeline (transfer-timeline-point)
[684.394968] Starting subtest: transfer-timeline-point
[684.397370] Subtest transfer-timeline-point: SUCCESS (0.000s)
[684.491138] [122/133] (387s left) gem_exec_schedule (smoketest-all)
[684.561013] Starting subtest: smoketest-all
[716.951713] Subtest smoketest-all: SUCCESS (32.349s)
[718.248273] [123/133] (353s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-render)
[718.359490] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-render
[725.259540] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-render: SUCCESS (6.902s)
[725.408864] [124/133] (346s left) kms_feature_discovery (display-3x)
[725.496948] Starting subtest: display-3x
[725.501321] Subtest display-3x: SKIP (0.000s)
[725.575505] [125/133] (346s left) gem_exec_store (pages)
[725.643384] Starting subtest: pages
[725.645561] Starting dynamic subtest: rcs0
[725.745120] Dynamic subtest rcs0: SUCCESS (0.103s)
[725.756841] Starting dynamic subtest: bcs0
[725.816117] Dynamic subtest bcs0: SUCCESS (0.070s)
[725.827459] Starting dynamic subtest: vcs0
[725.884639] Dynamic subtest vcs0: SUCCESS (0.068s)
[725.895269] Starting dynamic subtest: vcs1
[725.949611] Dynamic subtest vcs1: SUCCESS (0.064s)
[725.960345] Starting dynamic subtest: vecs0
[726.014939] Dynamic subtest vecs0: SUCCESS (0.064s)
[726.024728] Starting dynamic subtest: ccs0
[726.083251] Dynamic subtest ccs0: SUCCESS (0.068s)
[726.085751] Subtest pages: SUCCESS (0.443s)
[726.266544] [126/133] (345s left) kms_plane_scaling (plane-scaler-unity-scaling-with-pixel-format)
[726.350123] Starting subtest: plane-scaler-unity-scaling-with-pixel-format
[726.352489] Starting dynamic subtest: pipe-A
[727.542703] Dynamic subtest pipe-A: SUCCESS (1.195s)
[727.553292] Starting dynamic subtest: pipe-B
[729.736086] Dynamic subtest pipe-B: SUCCESS (2.191s)
[729.748871] Starting dynamic subtest: pipe-C
[730.950628] Dynamic subtest pipe-C: SUCCESS (1.212s)
[730.961507] Starting dynamic subtest: pipe-D
[732.190378] Dynamic subtest pipe-D: SUCCESS (1.239s)
[732.192697] Subtest plane-scaler-unity-scaling-with-pixel-format: SUCCESS (5.843s)
[733.371349] [127/133] (338s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-180-async-flip)
[733.470479] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-180-async-flip
[734.305628] Subtest x-tiled-max-hw-stride-64bpp-rotate-180-async-flip: SUCCESS (0.837s)
[734.473231] [128/133] (337s left) gem_exec_schedule (preempt-user)
[734.536456] Starting subtest: preempt-user
[734.538515] Starting dynamic subtest: rcs0
[734.554230] Dynamic subtest rcs0: SUCCESS (0.025s)
[734.564388] Starting dynamic subtest: bcs0
[734.575439] Dynamic subtest bcs0: SUCCESS (0.020s)
[734.585739] Starting dynamic subtest: vcs0
[734.595373] Dynamic subtest vcs0: SUCCESS (0.019s)
[734.605410] Starting dynamic subtest: vcs1
[734.615470] Dynamic subtest vcs1: SUCCESS (0.019s)
[734.626174] Starting dynamic subtest: vecs0
[734.636808] Dynamic subtest vecs0: SUCCESS (0.021s)
[734.646742] Starting dynamic subtest: ccs0
[734.657970] Dynamic subtest ccs0: SUCCESS (0.020s)
[734.660389] Subtest preempt-user: SUCCESS (0.129s)
[736.231684] [129/133] (335s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-fullscreen)
[736.329755] Starting subtest: fbc-2p-scndscrn-spr-indfb-fullscreen
[736.334208] Subtest fbc-2p-scndscrn-spr-indfb-fullscreen: SKIP (0.000s)
[736.449061] [130/133] (335s left) syncobj_timeline (invalid-transfer-bad-pad)
[736.512936] Starting subtest: invalid-transfer-bad-pad
[736.515177] Subtest invalid-transfer-bad-pad: SUCCESS (0.000s)
[736.609680] [131/133] (335s left) gem_sync (basic-many-each)
[736.684588] Starting subtest: basic-many-each
[738.993481] Subtest basic-many-each: SUCCESS (2.318s)
[739.203634] [132/133] (333s left) kms_pipe_b_c_ivb (disable-pipe-b-enable-pipe-c)
[739.265996] Subtest disable-pipe-B-enable-pipe-C: SKIP (0.000s)
[739.326547] [133/133] (333s left) kms_vrr (seamless-rr-switch-virtual)
[739.414871] Starting subtest: seamless-rr-switch-virtual
[739.421167] Subtest seamless-rr-switch-virtual: SKIP (0.000s)
[739.494799] Closing watchdogs
results: parsing output: 0/ for test: gem_lmem_swapping
results: parsing output: 1/ for test: kms_psr
results: parsing output: 2/ for test: sw_sync
results: parsing output: 3/ for test: kms_frontbuffer_tracking
results: parsing output: 4/ for test: gem_userptr_blits
results: parsing output: 5/ for test: kms_cursor_crc
results: parsing output: 6/ for test: kms_frontbuffer_tracking
results: parsing output: 7/ for test: kms_color_pipeline
results: parsing output: 8/ for test: gem_ccs
results: parsing output: 9/ for test: kms_psr2_sf
results: parsing output: 10/ for test: gem_exec_reloc
results: parsing output: 11/ for test: gem_render_copy_redux
results: parsing output: 12/ for test: tools_test
results: parsing output: 13/ for test: api_intel_bb
results: parsing output: 14/ for test: kms_joiner
results: parsing output: 15/ for test: kms_dp_link_training
results: parsing output: 16/ for test: kms_frontbuffer_tracking
results: parsing output: 17/ for test: kms_frontbuffer_tracking
results: parsing output: 18/ for test: kms_content_protection
results: parsing output: 19/ for test: kms_addfb_basic
results: parsing output: 20/ for test: core_setmaster
results: parsing output: 21/ for test: kms_flip
results: parsing output: 22/ for test: kms_frontbuffer_tracking
results: parsing output: 23/ for test: sysfs_heartbeat_interval
results: parsing output: 24/ for test: kms_frontbuffer_tracking
results: parsing output: 25/ for test: kms_big_fb
results: parsing output: 26/ for test: syncobj_wait
results: parsing output: 27/ for test: kms_flip
results: parsing output: 28/ for test: gem_wait
results: parsing output: 29/ for test: syncobj_wait
results: parsing output: 30/ for test: kms_frontbuffer_tracking
results: parsing output: 31/ for test: kms_big_fb
results: parsing output: 32/ for test: perf_pmu
results: parsing output: 33/ for test: gem_mmap_offset
results: parsing output: 34/ for test: gem_ctx_bad_destroy
results: parsing output: 35/ for test: gem_exec_params
results: parsing output: 36/ for test: kms_frontbuffer_tracking
results: parsing output: 37/ for test: kms_chamelium_color
results: parsing output: 38/ for test: kms_psr
results: parsing output: 39/ for test: kms_frontbuffer_tracking
results: parsing output: 40/ for test: kms_cursor_crc
results: parsing output: 41/ for test: kms_flip
results: parsing output: 42/ for test: kms_frontbuffer_tracking
results: parsing output: 43/ for test: gem_exec_basic
results: parsing output: 44/ for test: kms_ccs
results: parsing output: 45/ for test: kms_atomic
results: parsing output: 46/ for test: gem_flink_basic
results: parsing output: 47/ for test: kms_addfb_basic
results: parsing output: 48/ for test: gem_create
results: parsing output: 49/ for test: gem_exec_balancer
results: parsing output: 50/ for test: gem_exec_fence
results: parsing output: 51/ for test: kms_lease
results: parsing output: 52/ for test: gen9_exec_parse
results: parsing output: 53/ for test: gem_exec_params
results: parsing output: 54/ for test: kms_frontbuffer_tracking
results: parsing output: 55/ for test: kms_frontbuffer_tracking
results: parsing output: 56/ for test: syncobj_timeline
results: parsing output: 57/ for test: kms_chamelium_hpd
results: parsing output: 58/ for test: kms_vblank
results: parsing output: 59/ for test: prime_vgem
results: parsing output: 60/ for test: syncobj_timeline
results: parsing output: 61/ for test: gem_workarounds
results: parsing output: 62/ for test: kms_properties
results: parsing output: 63/ for test: kms_psr2_sf
results: parsing output: 64/ for test: gem_render_copy
results: parsing output: 65/ for test: vgem_basic
results: parsing output: 66/ for test: kms_flip
results: parsing output: 67/ for test: kms_pipe_stress
results: parsing output: 68/ for test: gem_ctx_param
results: parsing output: 69/ for test: gem_lmem_swapping
results: parsing output: 70/ for test: kms_cursor_legacy
results: parsing output: 71/ for test: kms_plane_scaling
results: parsing output: 72/ for test: kms_big_fb
results: parsing output: 73/ for test: kms_big_fb
results: parsing output: 74/ for test: kms_psr
results: parsing output: 75/ for test: syncobj_timeline
results: parsing output: 76/ for test: kms_vblank
results: parsing output: 77/ for test: gem_ctx_persistence
results: parsing output: 78/ for test: kms_frontbuffer_tracking
results: parsing output: 79/ for test: gem_mmap_offset
results: parsing output: 80/ for test: gem_exec_schedule
results: parsing output: 81/ for test: kms_big_fb
results: parsing output: 82/ for test: gem_flink_race
results: parsing output: 83/ for test: i915_pm_freq_api
results: parsing output: 84/ for test: gem_exec_reloc
results: parsing output: 85/ for test: kms_plane
results: parsing output: 86/ for test: i915_suspend
results: parsing output: 87/ for test: kms_frontbuffer_tracking
results: parsing output: 88/ for test: kms_big_fb
results: parsing output: 89/ for test: kms_pm_rpm
results: parsing output: 90/ for test: kms_frontbuffer_tracking
results: parsing output: 91/ for test: gem_pxp
results: parsing output: 92/ for test: syncobj_wait
results: parsing output: 93/ for test: gem_ctx_shared
results: parsing output: 94/ for test: kms_pm_rpm
results: parsing output: 95/ for test: kms_cursor_crc
results: parsing output: 96/ for test: kms_flip
results: parsing output: 97/ for test: kms_frontbuffer_tracking
results: parsing output: 98/ for test: kms_psr
results: parsing output: 99/ for test: kms_frontbuffer_tracking
results: parsing output: 100/ for test: gem_spin_batch
results: parsing output: 101/ for test: gem_sync
results: parsing output: 102/ for test: kms_frontbuffer_tracking
results: parsing output: 103/ for test: kms_ccs
results: parsing output: 104/ for test: i915_drm_fdinfo
results: parsing output: 105/ for test: kms_cursor_legacy
results: parsing output: 106/ for test: kms_plane_multiple
results: parsing output: 107/ for test: kms_ccs
results: parsing output: 108/ for test: kms_psr
results: parsing output: 109/ for test: gem_exec_params
results: parsing output: 110/ for test: kms_ccs
results: parsing output: 111/ for test: api_intel_allocator
results: parsing output: 112/ for test: kms_flip
results: parsing output: 113/ for test: kms_async_flips
results: parsing output: 114/ for test: kms_frontbuffer_tracking
results: parsing output: 115/ for test: kms_chamelium_frames
results: parsing output: 116/ for test: gem_ctx_persistence
results: parsing output: 117/ for test: i915_pm_rpm
results: parsing output: 118/ for test: kms_flip_scaled_crc
results: parsing output: 119/ for test: kms_psr2_sf
results: parsing output: 120/ for test: syncobj_timeline
results: parsing output: 121/ for test: gem_exec_schedule
results: parsing output: 122/ for test: kms_frontbuffer_tracking
results: parsing output: 123/ for test: kms_feature_discovery
results: parsing output: 124/ for test: gem_exec_store
results: parsing output: 125/ for test: kms_plane_scaling
results: parsing output: 126/ for test: kms_big_fb
results: parsing output: 127/ for test: gem_exec_schedule
results: parsing output: 128/ for test: kms_frontbuffer_tracking
results: parsing output: 129/ for test: syncobj_timeline
results: parsing output: 130/ for test: gem_sync
results: parsing output: 131/ for test: kms_pipe_b_c_ivb
results: parsing output: 132/ for test: kms_vrr
Done.