[57.819216] Initializing watchdogs
[57.819264]   /dev/watchdog0
[57.836418] [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.840554] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[57.842682] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[57.845941] [001/133] (960s left) kms_frontbuffer_tracking (fbc-1p-primscrn-indfb-msflip-blt)
[57.968346] Starting subtest: fbc-1p-primscrn-indfb-msflip-blt
[62.421575] Subtest fbc-1p-primscrn-indfb-msflip-blt: SUCCESS (4.459s)
[63.614045] [002/133] (954s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-pwrite)
[63.724722] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-pwrite
[63.729145] Subtest psr-2p-primscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[63.835521] [003/133] (954s left) gem_exec_reloc (basic-concurrent0)
[63.896144] Subtest basic-concurrent0: SKIP (0.000s)
[63.959931] [004/133] (954s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-indfb-draw-mmap-cpu)
[64.053789] Starting subtest: fbc-1p-offscreen-pri-indfb-draw-mmap-cpu
[68.362480] Subtest fbc-1p-offscreen-pri-indfb-draw-mmap-cpu: SUCCESS (4.312s)
[69.490358] [005/133] (949s left) kms_psr (psr-dpms)
[69.581853] Starting subtest: psr-dpms
[69.584248] Starting dynamic subtest: eDP-1
[72.524083] Dynamic subtest eDP-1: SUCCESS (2.942s)
[72.526273] Subtest psr-dpms: SUCCESS (2.943s)
[73.388283] [006/133] (945s left) kms_psr2_su (page_flip-p010)
[73.441671] Subtest page_flip-P010: SKIP (0.000s)
[73.505788] [007/133] (945s left) api_intel_bb (object-noreloc-purge-cache-simple)
[73.568840] Starting subtest: object-noreloc-purge-cache-simple
[73.573441] Subtest object-noreloc-purge-cache-simple: SUCCESS (0.005s)
[73.674983] [008/133] (944s left) gem_exec_reloc (basic-gtt-read)
[73.742459] Subtest basic-gtt-read: SKIP (0.000s)
[73.809845] [009/133] (944s left) gem_exec_fence (syncobj-timeline-export)
[74.375464] Starting subtest: syncobj-timeline-export
[74.381187] Subtest syncobj-timeline-export: SUCCESS (0.007s)
[75.956073] [FACT gem_exec_fence (syncobj-timeline-export)] new: kernel.kmod_is_loaded.vgem: true
[75.958816] [010/133] (942s left) kms_setmode (clone-exclusive-crtc)
[76.017830] Starting subtest: clone-exclusive-crtc
[76.024463] Subtest clone-exclusive-crtc: SKIP (0.000s)
[76.116968] [011/133] (942s left) gem_exec_whisper (basic-forked)
[76.177731] Starting subtest: basic-forked
[84.248074] Subtest basic-forked: SUCCESS (8.068s)
[84.430632] [012/133] (934s left) kms_plane_alpha_blend (alpha-transparent-fb)
[84.516825] Starting subtest: alpha-transparent-fb
[84.810416] Starting dynamic subtest: pipe-A-eDP-1
[85.413267] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.601s)
[85.422632] Starting dynamic subtest: pipe-D-eDP-1
[86.728547] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.315s)
[86.730952] Subtest alpha-transparent-fb: SUCCESS (2.212s)
[87.549192] [013/133] (931s left) i915_drm_fdinfo (virtual-busy-hang-all)
[87.595684] Starting subtest: virtual-busy-hang-all
[87.600087] Subtest virtual-busy-hang-all: SKIP (0.000s)
[87.659764] [014/133] (931s left) gem_mmap_wc (set-cache-level)
[87.714811] Subtest set-cache-level: SKIP (0.000s)
[87.781982] [015/133] (931s left) kms_psr (psr2-sprite-render)
[87.862091] Starting subtest: psr2-sprite-render
[87.864352] Starting dynamic subtest: eDP-1
[89.566075] Dynamic subtest eDP-1: SUCCESS (1.704s)
[89.568385] Subtest psr2-sprite-render: SUCCESS (1.704s)
[90.421950] [016/133] (928s left) kms_content_protection (mei-interface)
[90.566696] Starting subtest: mei-interface
[90.571195] Subtest mei-interface: SKIP (0.001s)
[90.679544] [017/133] (928s left) gem_mmap_offset (close-race)
[90.727812] Starting subtest: close-race
[110.829893] Subtest close-race: SUCCESS (20.101s)
[110.963944] [018/133] (908s left) prime_mmap_kms (buffer-sharing)
[111.069140] Starting subtest: buffer-sharing
[111.517210] Subtest buffer-sharing: SUCCESS (0.449s)
[112.354813] [019/133] (906s left) kms_prop_blob (invalid-set-prop-any)
[112.418099] Starting subtest: invalid-set-prop-any
[112.420575] Subtest invalid-set-prop-any: SUCCESS (0.000s)
[112.524160] [020/133] (906s left) syncobj_timeline (multi-wait-for-submit-available-submitted)
[112.588709] Starting subtest: multi-wait-for-submit-available-submitted
[112.591134] Subtest multi-wait-for-submit-available-submitted: SUCCESS (0.001s)
[112.710986] [021/133] (906s left) kms_psr (fbc-psr2-cursor-plane-move)
[112.816212] Starting subtest: fbc-psr2-cursor-plane-move
[112.818634] Starting dynamic subtest: eDP-1
[112.822829] Dynamic subtest eDP-1: SKIP (0.000s)
[112.827013] Subtest fbc-psr2-cursor-plane-move: SKIP (0.001s)
[112.891797] [022/133] (906s left) gem_exec_balancer (invalid-balancer)
[112.955702] Starting subtest: invalid-balancer
[113.852794] Subtest invalid-balancer: SUCCESS (0.896s)
[114.158864] [023/133] (905s left) kms_prime (basic-modeset-hybrid)
[114.250256] Subtest basic-modeset-hybrid: SKIP (0.000s)
[114.346925] [024/133] (904s left) gem_mmap_gtt (medium-copy-xy)
[114.407363] Subtest medium-copy-XY: SKIP (0.000s)
[114.468519] [025/133] (904s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-pwrite)
[114.562976] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-pwrite
[123.232933] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-pwrite: SUCCESS (8.673s)
[123.343043] [026/133] (895s left) kms_frontbuffer_tracking (psr-rgb565-draw-render)
[123.463287] Starting subtest: psr-rgb565-draw-render
[130.540570] Subtest psr-rgb565-draw-render: SUCCESS (7.079s)
[130.677653] [027/133] (888s left) kms_big_fb (4-tiled-16bpp-rotate-0)
[130.778034] Starting subtest: 4-tiled-16bpp-rotate-0
[132.145068] Subtest 4-tiled-16bpp-rotate-0: SUCCESS (1.368s)
[132.274024] [028/133] (887s left) gem_pxp (create-valid-protected-context)
[132.399445] Starting subtest: create-valid-protected-context
[132.401836] Subtest create-valid-protected-context: SUCCESS (0.002s)
[132.527294] [029/133] (886s left) kms_psr (pr-primary-render)
[132.611434] Starting subtest: pr-primary-render
[132.615118] Subtest pr-primary-render: SKIP (0.000s)
[132.693978] [030/133] (886s left) kms_cursor_legacy (2x-long-cursor-vs-flip-atomic)
[132.818351] Starting subtest: 2x-long-cursor-vs-flip-atomic
[132.822349] Subtest 2x-long-cursor-vs-flip-atomic: SKIP (0.001s)
[132.961050] [031/133] (886s left) i915_pm_sseu (full-enable)
[133.025417] Subtest full-enable: SKIP (0.000s)
[133.115557] [032/133] (886s left) prime_vgem (basic-fence-flip)
[133.190676] Starting subtest: basic-fence-flip
[133.530678] Subtest basic-fence-flip: SUCCESS (0.340s)
[133.623568] [033/133] (885s left) kms_lease (lease-uevent)
[133.718857] Starting subtest: lease-uevent
[134.730884] Subtest lease-uevent: SUCCESS (1.012s)
[134.807690] [034/133] (884s left) gem_userptr_blits (map-fixed-invalidate-overlap)
[134.878564] Starting subtest: map-fixed-invalidate-overlap
[134.882672] Subtest map-fixed-invalidate-overlap: SKIP (0.000s)
[135.009352] [035/133] (884s left) syncobj_wait (wait-all-complex)
[135.062742] Starting subtest: wait-all-complex
[135.279064] Subtest wait-all-complex: SUCCESS (0.216s)
[135.367496] [036/133] (884s left) kms_plane (plane-position-hole-dpms)
[135.452288] Starting subtest: plane-position-hole-dpms
[135.977364] Starting dynamic subtest: pipe-A-plane-1
[138.331265] Dynamic subtest pipe-A-plane-1: SUCCESS (2.356s)
[138.341095] Starting dynamic subtest: pipe-A-plane-2
[140.686835] Dynamic subtest pipe-A-plane-2: SUCCESS (2.353s)
[140.696233] Starting dynamic subtest: pipe-A-plane-3
[143.063167] Dynamic subtest pipe-A-plane-3: SUCCESS (2.375s)
[143.072915] Starting dynamic subtest: pipe-A-plane-4
[145.410951] Dynamic subtest pipe-A-plane-4: SUCCESS (2.350s)
[145.420350] Starting dynamic subtest: pipe-A-plane-5
[145.436309] Dynamic subtest pipe-A-plane-5: SUCCESS (0.023s)
[146.587114] Starting dynamic subtest: pipe-B-plane-1
[149.037182] Dynamic subtest pipe-B-plane-1: SUCCESS (2.458s)
[149.047184] Starting dynamic subtest: pipe-B-plane-2
[151.477379] Dynamic subtest pipe-B-plane-2: SUCCESS (2.439s)
[151.486905] Starting dynamic subtest: pipe-B-plane-3
[153.844857] Dynamic subtest pipe-B-plane-3: SUCCESS (2.368s)
[153.853609] Starting dynamic subtest: pipe-B-plane-4
[156.208931] Dynamic subtest pipe-B-plane-4: SUCCESS (2.363s)
[156.218217] Starting dynamic subtest: pipe-B-plane-5
[156.235068] Dynamic subtest pipe-B-plane-5: SUCCESS (0.023s)
[156.237318] Subtest plane-position-hole-dpms: SUCCESS (20.783s)
[157.021597] [037/133] (862s left) kms_chamelium_edid (hdmi-mode-timings)
[157.412790] Subtest hdmi-mode-timings: SKIP (0.000s)
[158.227812] [038/133] (861s left) kms_plane (pixel-format-4-tiled-mtl-mc-ccs-modifier)
[158.324365] Starting subtest: pixel-format-4-tiled-mtl-mc-ccs-modifier
[158.350377] Starting dynamic subtest: pipe-A-plane-0
[158.772016] Dynamic subtest pipe-A-plane-0: SUCCESS (0.422s)
[158.782217] Starting dynamic subtest: pipe-A-plane-3
[159.028075] Dynamic subtest pipe-A-plane-3: SUCCESS (0.255s)
[159.036583] Starting dynamic subtest: pipe-A-plane-5
[159.041067] Dynamic subtest pipe-A-plane-5: SKIP (0.000s)
[160.150586] Starting dynamic subtest: pipe-B-plane-0
[160.586764] Dynamic subtest pipe-B-plane-0: SUCCESS (0.444s)
[160.597644] Starting dynamic subtest: pipe-B-plane-3
[160.842692] Dynamic subtest pipe-B-plane-3: SUCCESS (0.255s)
[160.857170] Starting dynamic subtest: pipe-B-plane-5
[160.861780] Dynamic subtest pipe-B-plane-5: SKIP (0.000s)
[161.165537] Subtest pixel-format-4-tiled-mtl-mc-ccs-modifier: SUCCESS (2.843s)
[162.016834] [039/133] (857s left) kms_color_pipeline (plane-ctm3x4-lut1d)
[162.109046] Starting subtest: plane-ctm3x4-lut1d
[162.277338] Starting dynamic subtest: pipe-A-plane-0
[162.597802] Dynamic subtest pipe-A-plane-0: FAIL (0.155s)
[162.607657] Starting dynamic subtest: pipe-A-plane-1
[162.820822] Dynamic subtest pipe-A-plane-1: FAIL (0.174s)
[162.830373] Starting dynamic subtest: pipe-A-plane-2
[163.051482] Dynamic subtest pipe-A-plane-2: FAIL (0.166s)
[164.005110] Starting dynamic subtest: pipe-B-plane-0
[164.425130] Dynamic subtest pipe-B-plane-0: FAIL (0.152s)
[164.434862] Starting dynamic subtest: pipe-B-plane-1
[164.748450] Dynamic subtest pipe-B-plane-1: FAIL (0.178s)
[164.760064] Starting dynamic subtest: pipe-B-plane-2
[165.069224] Dynamic subtest pipe-B-plane-2: FAIL (0.167s)
[165.743853] Starting dynamic subtest: pipe-C-plane-0
[166.234876] Dynamic subtest pipe-C-plane-0: FAIL (0.129s)
[166.245057] Starting dynamic subtest: pipe-C-plane-1
[166.648345] Dynamic subtest pipe-C-plane-1: FAIL (0.610s)
[166.658265] Starting dynamic subtest: pipe-C-plane-2
[167.024320] Dynamic subtest pipe-C-plane-2: FAIL (0.158s)
[167.856823] Starting dynamic subtest: pipe-D-plane-0
[168.468319] Dynamic subtest pipe-D-plane-0: FAIL (0.163s)
[168.478176] Starting dynamic subtest: pipe-D-plane-1
[168.939354] Dynamic subtest pipe-D-plane-1: FAIL (0.615s)
[168.949096] Starting dynamic subtest: pipe-D-plane-2
[169.392572] Dynamic subtest pipe-D-plane-2: FAIL (0.569s)
[169.496648] Subtest plane-ctm3x4-lut1d: FAIL (7.390s)
[170.348902] [040/133] (849s left) kms_hdr (brightness-with-hdr)
[170.454236] Starting subtest: brightness-with-hdr
[170.460702] Subtest brightness-with-hdr: SKIP (0.000s)
[170.525165] [041/133] (849s left) kms_flip (flip-vs-fences)
[170.631455] Starting subtest: flip-vs-fences
[170.635620] Subtest flip-vs-fences: SKIP (0.000s)
[170.735445] [042/133] (849s left) gem_flink_basic (flink-lifetime)
[170.805735] Starting subtest: flink-lifetime
[170.811151] Subtest flink-lifetime: SUCCESS (0.004s)
[170.925433] [043/133] (849s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-fullscreen)
[171.027058] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-fullscreen
[171.031360] Subtest fbcpsr-2p-scndscrn-spr-indfb-fullscreen: SKIP (0.000s)
[171.126933] [044/133] (848s left) kms_ccs (crc-sprite-planes-basic-y-tiled-ccs)
[171.219927] Starting subtest: crc-sprite-planes-basic-y-tiled-ccs
[171.222205] Starting dynamic subtest: pipe-A-eDP-1
[171.275665] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[171.282757] Starting dynamic subtest: pipe-B-eDP-1
[171.329327] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[171.337708] Starting dynamic subtest: pipe-C-eDP-1
[171.384544] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[171.392874] Starting dynamic subtest: pipe-D-eDP-1
[171.441813] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[171.445481] Subtest crc-sprite-planes-basic-y-tiled-ccs: SKIP (0.008s)
[173.507528] [045/133] (846s left) gem_eio (kms)
[173.777194] Starting subtest: kms
[193.605494] Subtest kms: SUCCESS (19.827s)
[194.794982] [046/133] (825s left) kms_big_fb (x-tiled-64bpp-rotate-180)
[194.893368] Starting subtest: x-tiled-64bpp-rotate-180
[196.427736] Subtest x-tiled-64bpp-rotate-180: SUCCESS (1.534s)
[196.617924] [047/133] (823s left) kms_psr (fbc-psr-no-drrs)
[196.726934] Starting subtest: fbc-psr-no-drrs
[196.729617] Starting dynamic subtest: eDP-1
[196.734160] Dynamic subtest eDP-1: SKIP (0.000s)
[196.738635] Subtest fbc-psr-no-drrs: SKIP (0.001s)
[196.800642] [048/133] (823s left) kms_cursor_crc (cursor-rapid-movement-128x128)
[197.042921] Starting subtest: cursor-rapid-movement-128x128
[197.048094] Starting dynamic subtest: pipe-A-eDP-1
[197.589044] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.539s)
[197.617304] Starting dynamic subtest: pipe-D-eDP-1
[198.813564] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.202s)
[198.815782] Subtest cursor-rapid-movement-128x128: SUCCESS (1.770s)
[199.660428] [049/133] (820s left) kms_pm_rpm (basic-rte)
[199.704745] Starting subtest: basic-rte
[202.649652] Subtest basic-rte: SUCCESS (2.943s)
[204.161364] [050/133] (816s left) kms_flip_scaled_crc (flip-64bpp-yftile-to-32bpp-yftile-upscaling)
[204.251353] Starting subtest: flip-64bpp-yftile-to-32bpp-yftile-upscaling
[204.255362] Subtest flip-64bpp-yftile-to-32bpp-yftile-upscaling: SKIP (0.000s)
[204.322572] [051/133] (816s left) gem_ctx_persistence (heartbeat-hostile)
[204.389257] Starting subtest: heartbeat-hostile
[204.393731] Subtest heartbeat-hostile: SKIP (0.000s)
[204.522354] [052/133] (815s left) kms_flip (flip-vs-panning-vs-hang)
[204.613293] Starting subtest: flip-vs-panning-vs-hang
[204.615496] Starting dynamic subtest: A-eDP1
[255.355411] Dynamic subtest A-eDP1: SUCCESS (50.744s)
[255.366395] Starting dynamic subtest: D-eDP1
[305.407781] Dynamic subtest D-eDP1: SUCCESS (50.047s)
[305.412714] Subtest flip-vs-panning-vs-hang: SUCCESS (100.798s)
[306.628741] [053/133] (713s left) kms_atomic_transition (plane-use-after-nonblocking-unbind)
[306.715309] Starting subtest: plane-use-after-nonblocking-unbind
[306.717599] Starting dynamic subtest: pipe-A-eDP-1
[306.779548] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.064s)
[307.072952] Starting dynamic subtest: pipe-B-eDP-1
[307.821552] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.758s)
[308.136097] Subtest plane-use-after-nonblocking-unbind: SUCCESS (1.420s)
[308.979164] [054/133] (711s left) kms_chamelium_hpd (hdmi-hpd-storm-disable)
[309.373420] Subtest hdmi-hpd-storm-disable: SKIP (0.000s)
[310.198715] [055/133] (710s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-render)
[310.289924] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-render
[310.294131] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-render: SKIP (0.000s)
[310.395164] [056/133] (710s left) i915_drm_fdinfo (memory-info-purgeable)
[310.443185] Starting subtest: memory-info-purgeable
[310.445107] Starting dynamic subtest: smem0
[312.982112] Dynamic subtest smem0: SUCCESS (2.541s)
[312.984596] Subtest memory-info-purgeable: SUCCESS (2.542s)
[313.055726] [057/133] (707s left) kms_cursor_legacy (cursorb-vs-flipb-atomic)
[313.216934] Starting subtest: cursorB-vs-flipB-atomic
[313.220413] Subtest cursorB-vs-flipB-atomic: SKIP (0.001s)
[313.371730] [058/133] (707s left) kms_cursor_crc (cursor-offscreen-256x256)
[313.626353] Starting subtest: cursor-offscreen-256x256
[313.630529] Starting dynamic subtest: pipe-A-eDP-1
[315.573675] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.941s)
[315.599311] Starting dynamic subtest: pipe-D-eDP-1
[318.213055] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.618s)
[318.215254] Subtest cursor-offscreen-256x256: SUCCESS (4.587s)
[319.071282] [059/133] (701s left) gem_userptr_blits (stress-mm-invalidate-close-overlap)
[319.136224] Starting subtest: stress-mm-invalidate-close-overlap
[321.283880] Subtest stress-mm-invalidate-close-overlap: SUCCESS (2.148s)
[321.403174] [060/133] (699s left) kms_big_fb (y-tiled-64bpp-rotate-180)
[321.499478] Starting subtest: y-tiled-64bpp-rotate-180
[321.503787] Subtest y-tiled-64bpp-rotate-180: SKIP (0.000s)
[321.601888] [061/133] (699s left) gem_mmap_gtt (basic-wc)
[321.661316] Subtest basic-wc: SKIP (0.000s)
[321.725898] [062/133] (699s left) kms_big_fb (linear-64bpp-rotate-270)
[321.838744] Starting subtest: linear-64bpp-rotate-270
[321.858359] Subtest linear-64bpp-rotate-270: SKIP (0.019s)
[321.983984] [063/133] (698s left) kms_tiled_display (basic-test-pattern-with-chamelium)
[322.103223] Subtest basic-test-pattern-with-chamelium: SKIP (0.000s)
[322.148028] [064/133] (698s left) gem_exec_schedule (u-semaphore-codependency)
[322.226840] Starting subtest: u-semaphore-codependency
[322.232169] Subtest u-semaphore-codependency: SUCCESS (0.013s)
[322.583761] [065/133] (698s left) kms_pm_backlight (basic-brightness)
[322.690779] Starting subtest: basic-brightness
[322.742461] Starting dynamic subtest: eDP-1
[323.054037] Dynamic subtest eDP-1: SUCCESS (0.312s)
[323.056191] Subtest basic-brightness: SUCCESS (0.364s)
[323.898091] [066/133] (697s left) kms_draw_crc (fill-fb)
[323.999257] Starting subtest: fill-fb
[324.427998] Subtest fill-fb: SUCCESS (0.430s)
[324.522362] [067/133] (696s left) i915_pm_rc6_residency (rc6-idle)
[324.581427] Starting subtest: rc6-idle
[324.605808] Starting dynamic subtest: gt0-rcs0
[348.978493] Dynamic subtest gt0-rcs0: SUCCESS (24.371s)
[348.989628] Starting dynamic subtest: gt0-bcs0
[373.257818] Dynamic subtest gt0-bcs0: SUCCESS (24.277s)
[373.268655] Starting dynamic subtest: gt0-ccs0
[397.555708] Dynamic subtest gt0-ccs0: SUCCESS (24.296s)
[397.566527] Starting dynamic subtest: gt1-vcs0
[403.730092] Dynamic subtest gt1-vcs0: SUCCESS (6.169s)
[403.741278] Starting dynamic subtest: gt1-vecs0
[409.900609] Dynamic subtest gt1-vecs0: SUCCESS (6.169s)
[409.903669] Subtest rc6-idle: SUCCESS (85.321s)
[409.986419] [068/133] (611s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-render)
[410.101629] Starting subtest: psr-1p-primscrn-pri-indfb-draw-render
[417.365343] Subtest psr-1p-primscrn-pri-indfb-draw-render: SUCCESS (7.267s)
[417.479504] [069/133] (603s left) sysfs_timeslice_duration (idempotent)
[417.538308] Starting subtest: idempotent
[417.540533] Starting dynamic subtest: vecs0
[417.542800] Dynamic subtest vecs0: SUCCESS (0.000s)
[417.556508] Starting dynamic subtest: ccs0
[417.558419] Dynamic subtest ccs0: SUCCESS (0.000s)
[417.567036] Starting dynamic subtest: vcs0
[417.569187] Dynamic subtest vcs0: SUCCESS (0.000s)
[417.577564] Starting dynamic subtest: bcs0
[417.579714] Dynamic subtest bcs0: SUCCESS (0.000s)
[417.588118] Starting dynamic subtest: rcs0
[417.590049] Dynamic subtest rcs0: SUCCESS (0.000s)
[417.598573] Starting dynamic subtest: vcs1
[417.600716] Dynamic subtest vcs1: SUCCESS (0.000s)
[417.602876] Subtest idempotent: SUCCESS (0.006s)
[417.649263] [070/133] (603s left) kms_cursor_legacy (basic-flip-after-cursor-varying-size)
[417.767755] Starting subtest: basic-flip-after-cursor-varying-size
[418.698184] Subtest basic-flip-after-cursor-varying-size: SUCCESS (0.929s)
[419.533978] [071/133] (601s left) kms_cursor_legacy (cursorb-vs-flipa-atomic-transitions)
[419.653525] Starting subtest: cursorB-vs-flipA-atomic-transitions
[419.658114] Subtest cursorB-vs-flipA-atomic-transitions: SKIP (0.001s)
[419.811649] [072/133] (601s left) gem_wait (await)
[419.864850] Starting subtest: await
[419.867251] Starting dynamic subtest: all-engines
[420.968568] Dynamic subtest all-engines: SUCCESS (1.103s)
[420.984518] Starting dynamic subtest: rcs0
[422.027392] Dynamic subtest rcs0: SUCCESS (1.056s)
[422.043747] Starting dynamic subtest: bcs0
[423.085947] Dynamic subtest bcs0: SUCCESS (1.056s)
[423.102221] Starting dynamic subtest: vcs0
[424.139267] Dynamic subtest vcs0: SUCCESS (1.051s)
[424.156966] Starting dynamic subtest: vcs1
[425.192188] Dynamic subtest vcs1: SUCCESS (1.051s)
[425.208249] Starting dynamic subtest: vecs0
[426.245175] Dynamic subtest vecs0: SUCCESS (1.051s)
[426.261270] Starting dynamic subtest: ccs0
[427.303037] Dynamic subtest ccs0: SUCCESS (1.056s)
[427.305671] Subtest await: SUCCESS (7.439s)
[427.506553] [073/133] (593s left) gen9_exec_parse (allowed-single)
[427.573403] Subtest allowed-single: SKIP (0.000s)
[427.644160] [074/133] (593s left) gem_ctx_engines (independent)
[427.705198] Starting subtest: independent
[427.707500] Starting dynamic subtest: rcs0
[427.958908] Dynamic subtest rcs0: SUCCESS (0.252s)
[427.968811] Starting dynamic subtest: bcs0
[428.208069] Dynamic subtest bcs0: SUCCESS (0.248s)
[428.217626] Starting dynamic subtest: vcs0
[428.451069] Dynamic subtest vcs0: SUCCESS (0.242s)
[428.460768] Starting dynamic subtest: vcs1
[428.750648] Dynamic subtest vcs1: SUCCESS (0.299s)
[428.761931] Starting dynamic subtest: vecs0
[429.254055] Dynamic subtest vecs0: SUCCESS (0.502s)
[429.266347] Starting dynamic subtest: ccs0
[429.559122] Dynamic subtest ccs0: SUCCESS (0.304s)
[429.570101] Starting dynamic subtest: all-engines
[430.646168] Dynamic subtest all-engines: SUCCESS (1.086s)
[430.648328] Subtest independent: SUCCESS (2.941s)
[431.968675] [075/133] (589s left) kms_ccs (crc-primary-suspend-4-tiled-mtl-mc-ccs)
[432.072672] Starting subtest: crc-primary-suspend-4-tiled-mtl-mc-ccs
[432.074818] Starting dynamic subtest: pipe-A-eDP-1
[464.144286] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.889s)
[464.155870] Starting dynamic subtest: pipe-B-eDP-1
[497.977996] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.766s)
[497.988265] Starting dynamic subtest: pipe-C-eDP-1
[530.948521] Dynamic subtest pipe-C-eDP-1: SUCCESS (3.751s)
[530.959548] Starting dynamic subtest: pipe-D-eDP-1
[563.931817] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.697s)
[563.934163] Subtest crc-primary-suspend-4-tiled-mtl-mc-ccs: SUCCESS (15.109s)
[565.094392] [076/133] (456s left) kms_ccs (crc-primary-basic-4-tiled-bmg-ccs)
[565.237146] Starting subtest: crc-primary-basic-4-tiled-bmg-ccs
[565.241150] Subtest crc-primary-basic-4-tiled-bmg-ccs: SKIP (0.000s)
[566.305982] [077/133] (455s left) gem_exec_flush (basic-wb-rw-before-default)
[566.372823] Starting subtest: basic-wb-rw-before-default
[571.837549] Subtest basic-wb-rw-before-default: SUCCESS (5.459s)
[572.019884] [078/133] (449s left) kms_cursor_legacy (torture-bo)
[572.191757] Starting subtest: torture-bo
[572.194073] Starting dynamic subtest: pipe-A
[578.400101] Dynamic subtest pipe-A: SUCCESS (6.200s)
[578.413062] Starting dynamic subtest: pipe-B
[585.666692] Dynamic subtest pipe-B: SUCCESS (7.262s)
[585.679333] Starting dynamic subtest: pipe-C
[592.664562] Dynamic subtest pipe-C: SUCCESS (6.990s)
[592.677582] Starting dynamic subtest: pipe-D
[599.688517] Dynamic subtest pipe-D: SUCCESS (7.018s)
[599.701633] Starting dynamic subtest: all-pipes
[606.298729] Dynamic subtest all-pipes: SUCCESS (6.607s)
[606.301294] Subtest torture-bo: SUCCESS (34.087s)
[606.483287] [079/133] (415s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-mmap-gtt)
[606.587612] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-mmap-gtt
[606.591984] Subtest fbc-1p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[606.678981] [080/133] (414s left) kms_flip (2x-flip-vs-suspend)
[606.770303] Starting subtest: 2x-flip-vs-suspend
[606.778323] Subtest 2x-flip-vs-suspend: SKIP (0.010s)
[606.855418] [081/133] (414s left) kms_cursor_legacy (cursora-vs-flipb-atomic-transitions)
[606.974390] Starting subtest: cursorA-vs-flipB-atomic-transitions
[606.978771] Subtest cursorA-vs-flipB-atomic-transitions: SKIP (0.001s)
[607.162938] [082/133] (414s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-onoff)
[607.279682] Starting subtest: fbc-2p-primscrn-spr-indfb-onoff
[607.283506] Subtest fbc-2p-primscrn-spr-indfb-onoff: SKIP (0.000s)
[607.404499] [083/133] (414s left) kms_invalid_mode (bad-vtotal)
[607.509517] Starting subtest: bad-vtotal
[607.511399] Starting dynamic subtest: pipe-A-eDP-1
[607.791655] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.284s)
[607.803888] Starting dynamic subtest: pipe-B-eDP-1
[607.805716] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[607.815097] Starting dynamic subtest: pipe-C-eDP-1
[607.817241] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[607.826363] Starting dynamic subtest: pipe-D-eDP-1
[607.828682] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[607.831000] Subtest bad-vtotal: SUCCESS (0.290s)
[608.655479] [084/133] (413s left) gem_exec_params (secure-non-root)
[608.715970] Starting subtest: secure-non-root
[608.720237] Subtest secure-non-root: SKIP (0.000s)
[608.816948] [085/133] (413s left) gem_mmap_gtt (basic-write-read-distinct)
[608.872126] Subtest basic-write-read-distinct: SKIP (0.000s)
[608.931282] [086/133] (412s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip)
[609.018869] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip
[609.632293] Subtest x-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip: SUCCESS (0.614s)
[609.796605] [087/133] (412s left) kms_ccs (bad-rotation-90-4-tiled-mtl-rc-ccs-cc)
[609.883032] Starting subtest: bad-rotation-90-4-tiled-mtl-rc-ccs-cc
[609.884944] Starting dynamic subtest: pipe-A-eDP-1
[610.037079] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.144s)
[610.049471] Starting dynamic subtest: pipe-B-eDP-1
[610.068676] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.011s)
[610.078478] Starting dynamic subtest: pipe-C-eDP-1
[610.097416] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.011s)
[610.106516] Starting dynamic subtest: pipe-D-eDP-1
[610.125854] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.011s)
[610.127819] Subtest bad-rotation-90-4-tiled-mtl-rc-ccs-cc: SUCCESS (0.181s)
[612.318931] [088/133] (409s left) gem_exec_schedule (noreorder-corked)
[612.498054] Starting subtest: noreorder-corked
[612.500714] Starting dynamic subtest: rcs0
[613.643393] Dynamic subtest rcs0: SUCCESS (1.145s)
[613.663049] Starting dynamic subtest: vcs0
[615.628285] Dynamic subtest vcs0: SUCCESS (1.981s)
[615.641486] Starting dynamic subtest: vcs1
[617.617474] Dynamic subtest vcs1: SUCCESS (1.986s)
[617.629036] Starting dynamic subtest: vecs0
[619.657222] Dynamic subtest vecs0: SUCCESS (2.036s)
[619.669799] Starting dynamic subtest: ccs0
[620.810816] Dynamic subtest ccs0: SUCCESS (1.152s)
[620.813419] Subtest noreorder-corked: SUCCESS (8.310s)
[621.000711] [089/133] (400s left) syncobj_timeline (etime-single-wait-all-for-submit-unsubmitted)
[621.063165] Starting subtest: etime-single-wait-all-for-submit-unsubmitted
[621.169620] Subtest etime-single-wait-all-for-submit-unsubmitted: SUCCESS (0.105s)
[621.261552] [090/133] (400s left) kms_atomic_interruptible (universal-setplane-cursor)
[621.370765] Starting subtest: universal-setplane-cursor
[621.373111] Starting dynamic subtest: pipe-A-eDP-1
[628.834837] Dynamic subtest pipe-A-eDP-1: SUCCESS (7.460s)
[628.837274] Subtest universal-setplane-cursor: SUCCESS (7.463s)
[629.685630] [091/133] (392s left) gem_ringfill (legacy-basic)
[635.665800] Starting subtest: legacy-basic
[635.668575] Starting dynamic subtest: default
[635.728983] Dynamic subtest default: SUCCESS (0.063s)
[635.741460] Starting dynamic subtest: render
[635.771088] Dynamic subtest render: SUCCESS (0.040s)
[635.784319] Starting dynamic subtest: bsd
[635.815149] Dynamic subtest bsd: SUCCESS (0.041s)
[635.827801] Starting dynamic subtest: bsd1
[635.858190] Dynamic subtest bsd1: SUCCESS (0.040s)
[635.871262] Starting dynamic subtest: bsd2
[635.899166] Dynamic subtest bsd2: SUCCESS (0.038s)
[635.911622] Starting dynamic subtest: blt
[635.944069] Dynamic subtest blt: SUCCESS (0.042s)
[635.954468] Starting dynamic subtest: vebox
[635.988240] Dynamic subtest vebox: SUCCESS (0.042s)
[635.991130] Subtest legacy-basic: SUCCESS (0.325s)
[636.069581] [092/133] (386s left) prime_vgem (busy)
[636.164756] Starting subtest: busy
[636.166717] Starting dynamic subtest: rcs0
[636.209174] Dynamic subtest rcs0: SUCCESS (0.045s)
[636.219204] Starting dynamic subtest: bcs0
[636.266095] Dynamic subtest bcs0: SUCCESS (0.056s)
[636.276160] Starting dynamic subtest: vcs0
[636.315565] Dynamic subtest vcs0: SUCCESS (0.049s)
[636.326197] Starting dynamic subtest: vcs1
[636.362511] Dynamic subtest vcs1: SUCCESS (0.046s)
[636.372768] Starting dynamic subtest: vecs0
[636.410091] Dynamic subtest vecs0: SUCCESS (0.047s)
[636.419825] Starting dynamic subtest: ccs0
[636.459678] Dynamic subtest ccs0: SUCCESS (0.049s)
[636.461902] Subtest busy: SUCCESS (0.297s)
[636.579878] [093/133] (385s left) fbdev (unaligned-write)
[636.619917] Starting subtest: unaligned-write
[636.720486] Subtest unaligned-write: SUCCESS (0.101s)
[636.787635] [094/133] (385s left) syncobj_wait (multi-wait-all-for-submit-submitted-signaled)
[636.838302] Starting subtest: multi-wait-all-for-submit-submitted-signaled
[636.946655] Subtest multi-wait-all-for-submit-submitted-signaled: SUCCESS (0.108s)
[637.047688] [095/133] (385s left) kms_frontbuffer_tracking (fbcpsr-farfromfence-mmap-gtt)
[637.148138] Starting subtest: fbcpsr-farfromfence-mmap-gtt
[637.152334] Subtest fbcpsr-farfromfence-mmap-gtt: SKIP (0.000s)
[637.233636] [096/133] (385s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-mmap-wc)
[637.317598] Starting subtest: psr-2p-primscrn-cur-indfb-draw-mmap-wc
[637.321768] Subtest psr-2p-primscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[637.415009] [097/133] (384s left) gem_lmem_swapping (heavy-verify-multi)
[637.456167] Subtest heavy-verify-multi: SKIP (0.000s)
[637.499119] [098/133] (384s left) kms_vblank (wait-forked-busy-hang)
[637.584144] Starting subtest: wait-forked-busy-hang
[637.586236] Starting dynamic subtest: pipe-A-eDP-1
[664.390505] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.798s)
[664.405988] Starting dynamic subtest: pipe-D-eDP-1
[690.388235] Dynamic subtest pipe-D-eDP-1: SUCCESS (26.009s)
[690.390578] Subtest wait-forked-busy-hang: SUCCESS (52.813s)
[691.228532] [099/133] (331s left) gem_ctx_bad_destroy (double-destroy)
[691.286748] Starting subtest: double-destroy
[691.289086] Subtest double-destroy: SUCCESS (0.000s)
[691.367450] [100/133] (331s left) kms_rotation_crc (bad-tiling)
[691.461128] Starting subtest: bad-tiling
[691.465552] Subtest bad-tiling: SKIP (0.001s)
[691.546895] [101/133] (330s left) kms_fbcon_fbt (psr)
[691.606371] Starting subtest: psr
[698.947932] Subtest psr: SUCCESS (7.338s)
[699.027950] [102/133] (323s left) kms_ccs (random-ccs-data-y-tiled-ccs)
[699.144205] Starting subtest: random-ccs-data-y-tiled-ccs
[699.148652] Starting dynamic subtest: pipe-A-eDP-1
[699.176061] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[699.188871] Starting dynamic subtest: pipe-B-eDP-1
[699.212347] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[699.222242] Starting dynamic subtest: pipe-C-eDP-1
[699.246065] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[699.256136] Starting dynamic subtest: pipe-D-eDP-1
[699.280307] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[699.284249] Subtest random-ccs-data-y-tiled-ccs: SKIP (0.006s)
[701.474425] [103/133] (321s left) kms_psr2_sf (pr-cursor-plane-move-continuous-exceed-fully-sf)
[701.577844] Starting subtest: pr-cursor-plane-move-continuous-exceed-fully-sf
[701.582301] Subtest pr-cursor-plane-move-continuous-exceed-fully-sf: SKIP (0.000s)
[701.666133] [104/133] (320s left) gem_softpin (reverse)
[701.739787] Starting subtest: reverse
[701.748708] Subtest reverse: SUCCESS (0.012s)
[701.872032] [105/133] (320s left) kms_big_fb (yf-tiled-addfb-size-overflow)
[701.985029] Starting subtest: yf-tiled-addfb-size-overflow
[701.989496] Subtest yf-tiled-addfb-size-overflow: SKIP (0.000s)
[702.095730] [106/133] (320s left) gem_lmem_swapping (random)
[702.138848] Subtest random: SKIP (0.000s)
[702.179646] [107/133] (320s left) kms_cursor_legacy (basic-busy-flip-before-cursor-atomic)
[702.299455] Starting subtest: basic-busy-flip-before-cursor-atomic
[702.304040] Subtest basic-busy-flip-before-cursor-atomic: SKIP (0.000s)
[702.483836] [108/133] (320s left) kms_cursor_edge_walk (64x64-top-bottom)
[702.589468] Starting subtest: 64x64-top-bottom
[702.591343] Starting dynamic subtest: pipe-A-eDP-1
[706.015677] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.426s)
[706.027068] Starting dynamic subtest: pipe-D-eDP-1
[709.127547] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.110s)
[709.129867] Subtest 64x64-top-bottom: SUCCESS (6.539s)
[709.972779] [109/133] (312s left) syncobj_timeline (wait-any-interrupted)
[710.038765] Starting subtest: wait-any-interrupted
[710.143589] Subtest wait-any-interrupted: SUCCESS (0.102s)
[710.219430] [110/133] (312s left) kms_draw_crc (draw-method-render)
[710.313227] Starting subtest: draw-method-render
[710.315197] Starting dynamic subtest: xrgb8888-untiled
[710.556975] Dynamic subtest xrgb8888-untiled: SUCCESS (0.243s)
[710.567758] Starting dynamic subtest: rgb565-untiled
[710.767942] Dynamic subtest rgb565-untiled: SUCCESS (0.210s)
[710.778989] Starting dynamic subtest: xrgb2101010-untiled
[711.000037] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.232s)
[711.009740] Starting dynamic subtest: xbgr16161616f-untiled
[711.232583] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.232s)
[711.241810] Starting dynamic subtest: xrgb8888-xtiled
[711.355337] Dynamic subtest xrgb8888-xtiled: SUCCESS (0.121s)
[711.365122] Starting dynamic subtest: rgb565-xtiled
[711.466082] Dynamic subtest rgb565-xtiled: SUCCESS (0.110s)
[711.475186] Starting dynamic subtest: xrgb2101010-xtiled
[711.588188] Dynamic subtest xrgb2101010-xtiled: SUCCESS (0.121s)
[711.598184] Starting dynamic subtest: xbgr16161616f-xtiled
[711.721662] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (0.133s)
[711.733114] Starting dynamic subtest: xrgb8888-4tiled
[711.854970] Dynamic subtest xrgb8888-4tiled: SUCCESS (0.132s)
[711.864953] Starting dynamic subtest: rgb565-4tiled
[711.977207] Dynamic subtest rgb565-4tiled: SUCCESS (0.121s)
[711.989155] Starting dynamic subtest: xrgb2101010-4tiled
[712.110816] Dynamic subtest xrgb2101010-4tiled: SUCCESS (0.131s)
[712.120282] Starting dynamic subtest: xbgr16161616f-4tiled
[712.245863] Dynamic subtest xbgr16161616f-4tiled: SUCCESS (0.131s)
[712.247539] Subtest draw-method-render: SUCCESS (1.934s)
[712.357958] [111/133] (310s left) kms_plane_multiple (tiling-4)
[712.460542] Starting subtest: tiling-4
[712.462364] Starting dynamic subtest: pipe-A-eDP-1
[716.191739] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.729s)
[716.202845] Starting dynamic subtest: pipe-B-eDP-1
[720.543595] Dynamic subtest pipe-B-eDP-1: SUCCESS (4.350s)
[720.554275] Starting dynamic subtest: pipe-C-eDP-1
[724.891130] Dynamic subtest pipe-C-eDP-1: SUCCESS (4.344s)
[724.904984] Starting dynamic subtest: pipe-D-eDP-1
[729.230580] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.338s)
[729.232517] Subtest tiling-4: SUCCESS (16.768s)
[730.038376] [112/133] (293s left) gem_mmap_gtt (basic-write-read)
[730.097838] Subtest basic-write-read: SKIP (0.000s)
[730.171211] [113/133] (292s left) gem_exec_capture (capture)
[730.226046] Starting subtest: capture
[730.228417] Starting dynamic subtest: rcs0-smem
[731.062125] Dynamic subtest rcs0-smem: SUCCESS (0.834s)
[731.073868] Starting dynamic subtest: bcs0-smem
[731.940369] Dynamic subtest bcs0-smem: SUCCESS (0.878s)
[731.951571] Starting dynamic subtest: vcs0-smem
[732.772501] Dynamic subtest vcs0-smem: SUCCESS (0.830s)
[732.783537] Starting dynamic subtest: vcs1-smem
[733.600522] Dynamic subtest vcs1-smem: SUCCESS (0.827s)
[733.611984] Starting dynamic subtest: vecs0-smem
[734.982857] Dynamic subtest vecs0-smem: FAIL (1.314s)
[734.994506] Starting dynamic subtest: ccs0-smem
[736.244890] Dynamic subtest ccs0-smem: SUCCESS (1.329s)
[736.247193] Subtest capture: FAIL (6.017s)
[736.373492] [114/133] (286s left) gem_ctx_persistence (engines-persistence)
[736.432067] Starting subtest: engines-persistence
[736.434461] Starting dynamic subtest: rcs0
[737.239898] Dynamic subtest rcs0: SUCCESS (0.807s)
[737.253178] Starting dynamic subtest: bcs0
[737.979917] Dynamic subtest bcs0: SUCCESS (0.737s)
[737.994668] Starting dynamic subtest: vcs0
[738.760246] Dynamic subtest vcs0: SUCCESS (0.777s)
[738.772935] Starting dynamic subtest: vcs1
[739.527082] Dynamic subtest vcs1: SUCCESS (0.765s)
[739.539817] Starting dynamic subtest: vecs0
[740.300917] Dynamic subtest vecs0: SUCCESS (0.771s)
[740.313956] Starting dynamic subtest: ccs0
[741.072905] Dynamic subtest ccs0: SUCCESS (0.770s)
[741.075521] Subtest engines-persistence: SUCCESS (4.641s)
[741.155664] [115/133] (282s left) perf_pmu (busy-double-start)
[741.201982] Starting subtest: busy-double-start
[741.204153] Starting dynamic subtest: rcs0
[744.839613] Dynamic subtest rcs0: FAIL (3.572s)
[744.860828] Starting dynamic subtest: bcs0
[748.338336] Dynamic subtest bcs0: SUCCESS (3.565s)
[748.350461] Starting dynamic subtest: vcs0
[752.161828] Dynamic subtest vcs0: SUCCESS (3.820s)
[752.174292] Starting dynamic subtest: vcs1
[756.189853] Dynamic subtest vcs1: SUCCESS (4.025s)
[756.202556] Starting dynamic subtest: vecs0
[760.163741] Dynamic subtest vecs0: SUCCESS (3.970s)
[760.175904] Starting dynamic subtest: ccs0
[763.802158] Dynamic subtest ccs0: FAIL (3.558s)
[763.804487] Subtest busy-double-start: FAIL (22.522s)
[763.869870] [116/133] (259s left) perf_pmu (busy-idle)
[763.922456] Starting subtest: busy-idle
[763.924742] Starting dynamic subtest: rcs0
[764.622637] Dynamic subtest rcs0: SUCCESS (0.699s)
[764.635074] Starting dynamic subtest: bcs0
[765.289217] Dynamic subtest bcs0: SUCCESS (0.664s)
[765.301791] Starting dynamic subtest: vcs0
[766.606270] Dynamic subtest vcs0: SUCCESS (1.313s)
[766.619584] Starting dynamic subtest: vcs1
[768.653958] Dynamic subtest vcs1: SUCCESS (2.044s)
[768.666517] Starting dynamic subtest: vecs0
[770.638498] Dynamic subtest vecs0: SUCCESS (1.980s)
[770.651517] Starting dynamic subtest: ccs0
[771.310479] Dynamic subtest ccs0: SUCCESS (0.670s)
[771.312956] Subtest busy-idle: SUCCESS (7.387s)
[771.424211] [117/133] (251s left) syncobj_basic (bad-destroy-pad)
[771.475371] Starting subtest: bad-destroy-pad
[771.477323] Subtest bad-destroy-pad: SUCCESS (0.000s)
[771.562850] [118/133] (251s left) dmabuf_sync_file (export-before-signal)
[771.613862] Starting subtest: export-before-signal
[771.615783] Subtest export-before-signal: SUCCESS (0.001s)
[771.672041] [119/133] (251s left) prime_vgem (basic-read)
[771.746328] Starting subtest: basic-read
[771.769422] Subtest basic-read: SKIP (0.023s)
[771.877712] [120/133] (251s left) kms_big_fb (4-tiled-32bpp-rotate-90)
[771.982255] Starting subtest: 4-tiled-32bpp-rotate-90
[772.002555] Subtest 4-tiled-32bpp-rotate-90: SKIP (0.020s)
[772.118422] [121/133] (251s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-render)
[772.225875] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-render
[772.230100] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-render: SKIP (0.000s)
[772.331930] [122/133] (251s left) syncobj_timeline (multi-wait-all-available-signaled)
[772.390205] Starting subtest: multi-wait-all-available-signaled
[772.392149] Subtest multi-wait-all-available-signaled: SUCCESS (0.000s)
[772.503661] [123/133] (251s left) intel_hwmon (hwmon-read)
[772.554769] Subtest hwmon-read: SKIP (0.000s)
[772.622097] [124/133] (250s left) syncobj_timeline (etime-multi-wait-all-for-submit-unsubmitted-submitted-signa
[772.687848] Starting subtest: etime-multi-wait-all-for-submit-unsubmitted-submitted-signaled
[772.794394] Subtest etime-multi-wait-all-for-submit-unsubmitted-submitted-signaled: SUCCESS (0.106s)
[772.876659] [125/133] (250s left) gem_ctx_bad_destroy (invalid-pad)
[772.931134] Starting subtest: invalid-pad
[772.933604] Subtest invalid-pad: SUCCESS (0.000s)
[773.003238] [126/133] (250s left) kms_frontbuffer_tracking (psr-2p-scndscrn-shrfb-pgflip-blt)
[773.095414] Starting subtest: psr-2p-scndscrn-shrfb-pgflip-blt
[773.099701] Subtest psr-2p-scndscrn-shrfb-pgflip-blt: SKIP (0.000s)
[773.192432] [127/133] (250s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-mmap-wc)
[773.284189] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-mmap-wc
[773.288112] Subtest psr-2p-scndscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[773.376673] [128/133] (250s left) kms_busy (extended-modeset-hang-oldfb-with-reset)
[773.470509] Starting subtest: extended-modeset-hang-oldfb-with-reset
[773.473327] Starting dynamic subtest: pipe-A
[785.328753] Dynamic subtest pipe-A: SUCCESS (11.855s)
[785.340048] Starting dynamic subtest: pipe-D
[797.604101] Dynamic subtest pipe-D: SUCCESS (12.274s)
[797.606709] Subtest extended-modeset-hang-oldfb-with-reset: SUCCESS (24.133s)
[798.402153] [129/133] (225s left) gem_exec_gttfill (basic)
[798.473604] Starting subtest: basic
[801.320754] Subtest basic: SUCCESS (2.850s)
[801.512468] [130/133] (222s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-mmap-gtt)
[801.665310] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-mmap-gtt
[801.669626] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[801.779853] [131/133] (222s left) api_intel_allocator (reopen)
[801.833943] Starting subtest: reopen
[801.839054] Subtest reopen: SUCCESS (0.005s)
[801.958924] [132/133] (221s left) gem_render_copy (yf-tiled-ccs-to-yf-tiled)
[802.017662] Starting subtest: yf-tiled-ccs-to-yf-tiled
[802.022236] Subtest yf-tiled-ccs-to-yf-tiled: SKIP (0.000s)
[802.213838] [133/133] (221s left) gem_exec_reloc (basic-wc-gtt-noreloc)
[802.275947] Subtest basic-wc-gtt-noreloc: SKIP (0.000s)
[802.347544] Closing watchdogs
results: parsing output: 0/ for test: kms_frontbuffer_tracking
results: parsing output: 1/ for test: kms_frontbuffer_tracking
results: parsing output: 2/ for test: gem_exec_reloc
results: parsing output: 3/ for test: kms_frontbuffer_tracking
results: parsing output: 4/ for test: kms_psr
results: parsing output: 5/ for test: kms_psr2_su
results: parsing output: 6/ for test: api_intel_bb
results: parsing output: 7/ for test: gem_exec_reloc
results: parsing output: 8/ for test: gem_exec_fence
results: parsing output: 9/ for test: kms_setmode
results: parsing output: 10/ for test: gem_exec_whisper
results: parsing output: 11/ for test: kms_plane_alpha_blend
results: parsing output: 12/ for test: i915_drm_fdinfo
results: parsing output: 13/ for test: gem_mmap_wc
results: parsing output: 14/ for test: kms_psr
results: parsing output: 15/ for test: kms_content_protection
results: parsing output: 16/ for test: gem_mmap_offset
results: parsing output: 17/ for test: prime_mmap_kms
results: parsing output: 18/ for test: kms_prop_blob
results: parsing output: 19/ for test: syncobj_timeline
results: parsing output: 20/ for test: kms_psr
results: parsing output: 21/ for test: gem_exec_balancer
results: parsing output: 22/ for test: kms_prime
results: parsing output: 23/ for test: gem_mmap_gtt
results: parsing output: 24/ for test: kms_frontbuffer_tracking
results: parsing output: 25/ for test: kms_frontbuffer_tracking
results: parsing output: 26/ for test: kms_big_fb
results: parsing output: 27/ for test: gem_pxp
results: parsing output: 28/ for test: kms_psr
results: parsing output: 29/ for test: kms_cursor_legacy
results: parsing output: 30/ for test: i915_pm_sseu
results: parsing output: 31/ for test: prime_vgem
results: parsing output: 32/ for test: kms_lease
results: parsing output: 33/ for test: gem_userptr_blits
results: parsing output: 34/ for test: syncobj_wait
results: parsing output: 35/ for test: kms_plane
results: parsing output: 36/ for test: kms_chamelium_edid
results: parsing output: 37/ for test: kms_plane
results: parsing output: 38/ for test: kms_color_pipeline
results: parsing output: 39/ for test: kms_hdr
results: parsing output: 40/ for test: kms_flip
results: parsing output: 41/ for test: gem_flink_basic
results: parsing output: 42/ for test: kms_frontbuffer_tracking
results: parsing output: 43/ for test: kms_ccs
results: parsing output: 44/ for test: gem_eio
results: parsing output: 45/ for test: kms_big_fb
results: parsing output: 46/ for test: kms_psr
results: parsing output: 47/ for test: kms_cursor_crc
results: parsing output: 48/ for test: kms_pm_rpm
results: parsing output: 49/ for test: kms_flip_scaled_crc
results: parsing output: 50/ for test: gem_ctx_persistence
results: parsing output: 51/ for test: kms_flip
results: parsing output: 52/ for test: kms_atomic_transition
results: parsing output: 53/ for test: kms_chamelium_hpd
results: parsing output: 54/ for test: kms_frontbuffer_tracking
results: parsing output: 55/ for test: i915_drm_fdinfo
results: parsing output: 56/ for test: kms_cursor_legacy
results: parsing output: 57/ for test: kms_cursor_crc
results: parsing output: 58/ for test: gem_userptr_blits
results: parsing output: 59/ for test: kms_big_fb
results: parsing output: 60/ for test: gem_mmap_gtt
results: parsing output: 61/ for test: kms_big_fb
results: parsing output: 62/ for test: kms_tiled_display
results: parsing output: 63/ for test: gem_exec_schedule
results: parsing output: 64/ for test: kms_pm_backlight
results: parsing output: 65/ for test: kms_draw_crc
results: parsing output: 66/ for test: i915_pm_rc6_residency
results: parsing output: 67/ for test: kms_frontbuffer_tracking
results: parsing output: 68/ for test: sysfs_timeslice_duration
results: parsing output: 69/ for test: kms_cursor_legacy
results: parsing output: 70/ for test: kms_cursor_legacy
results: parsing output: 71/ for test: gem_wait
results: parsing output: 72/ for test: gen9_exec_parse
results: parsing output: 73/ for test: gem_ctx_engines
results: parsing output: 74/ for test: kms_ccs
results: parsing output: 75/ for test: kms_ccs
results: parsing output: 76/ for test: gem_exec_flush
results: parsing output: 77/ for test: kms_cursor_legacy
results: parsing output: 78/ for test: kms_frontbuffer_tracking
results: parsing output: 79/ for test: kms_flip
results: parsing output: 80/ for test: kms_cursor_legacy
results: parsing output: 81/ for test: kms_frontbuffer_tracking
results: parsing output: 82/ for test: kms_invalid_mode
results: parsing output: 83/ for test: gem_exec_params
results: parsing output: 84/ for test: gem_mmap_gtt
results: parsing output: 85/ for test: kms_big_fb
results: parsing output: 86/ for test: kms_ccs
results: parsing output: 87/ for test: gem_exec_schedule
results: parsing output: 88/ for test: syncobj_timeline
results: parsing output: 89/ for test: kms_atomic_interruptible
results: parsing output: 90/ for test: gem_ringfill
results: parsing output: 91/ for test: prime_vgem
results: parsing output: 92/ for test: fbdev
results: parsing output: 93/ for test: syncobj_wait
results: parsing output: 94/ for test: kms_frontbuffer_tracking
results: parsing output: 95/ for test: kms_frontbuffer_tracking
results: parsing output: 96/ for test: gem_lmem_swapping
results: parsing output: 97/ for test: kms_vblank
results: parsing output: 98/ for test: gem_ctx_bad_destroy
results: parsing output: 99/ for test: kms_rotation_crc
results: parsing output: 100/ for test: kms_fbcon_fbt
results: parsing output: 101/ for test: kms_ccs
results: parsing output: 102/ for test: kms_psr2_sf
results: parsing output: 103/ for test: gem_softpin
results: parsing output: 104/ for test: kms_big_fb
results: parsing output: 105/ for test: gem_lmem_swapping
results: parsing output: 106/ for test: kms_cursor_legacy
results: parsing output: 107/ for test: kms_cursor_edge_walk
results: parsing output: 108/ for test: syncobj_timeline
results: parsing output: 109/ for test: kms_draw_crc
results: parsing output: 110/ for test: kms_plane_multiple
results: parsing output: 111/ for test: gem_mmap_gtt
results: parsing output: 112/ for test: gem_exec_capture
results: parsing output: 113/ for test: gem_ctx_persistence
results: parsing output: 114/ for test: perf_pmu
results: parsing output: 115/ for test: perf_pmu
results: parsing output: 116/ for test: syncobj_basic
results: parsing output: 117/ for test: dmabuf_sync_file
results: parsing output: 118/ for test: prime_vgem
results: parsing output: 119/ for test: kms_big_fb
results: parsing output: 120/ for test: kms_frontbuffer_tracking
results: parsing output: 121/ for test: syncobj_timeline
results: parsing output: 122/ for test: intel_hwmon
results: parsing output: 123/ for test: syncobj_timeline
results: parsing output: 124/ for test: gem_ctx_bad_destroy
results: parsing output: 125/ for test: kms_frontbuffer_tracking
results: parsing output: 126/ for test: kms_frontbuffer_tracking
results: parsing output: 127/ for test: kms_busy
results: parsing output: 128/ for test: gem_exec_gttfill
results: parsing output: 129/ for test: kms_frontbuffer_tracking
results: parsing output: 130/ for test: api_intel_allocator
results: parsing output: 131/ for test: gem_render_copy
results: parsing output: 132/ for test: gem_exec_reloc
Done.