[56.851661] Initializing watchdogs
[56.851703]   /dev/watchdog0
[56.865230] [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]
[56.869388] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[56.871536] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[56.874960] [001/133] (960s left) gem_ctx_engines (none)
[56.954768] Starting subtest: none
[56.957289] Subtest none: SUCCESS (0.002s)
[57.150794] [002/133] (960s left) kms_tiled_display (basic-test-pattern-with-chamelium)
[57.259195] Subtest basic-test-pattern-with-chamelium: SKIP (0.000s)
[57.298238] [003/133] (960s left) gem_exec_params (secure-non-master)
[57.355833] Starting subtest: secure-non-master
[57.359943] Subtest secure-non-master: SKIP (0.000s)
[57.475869] [004/133] (960s left) gem_exec_schedule (u-independent)
[57.554562] Starting subtest: u-independent
[57.556777] Starting dynamic subtest: rcs0
[58.902380] Dynamic subtest rcs0: SUCCESS (1.356s)
[58.913311] Starting dynamic subtest: vcs0
[60.896453] Dynamic subtest vcs0: SUCCESS (1.993s)
[60.905960] Starting dynamic subtest: vcs1
[62.944394] Dynamic subtest vcs1: SUCCESS (2.047s)
[62.955617] Starting dynamic subtest: vecs0
[64.928058] Dynamic subtest vecs0: SUCCESS (1.984s)
[64.937997] Starting dynamic subtest: ccs0
[66.902553] Dynamic subtest ccs0: SUCCESS (1.972s)
[66.905573] Subtest u-independent: SUCCESS (9.357s)
[67.258237] [005/133] (950s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-cpu)
[67.470060] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-cpu
[74.530101] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-cpu: SUCCESS (7.065s)
[74.670456] [006/133] (942s left) kms_ccs (random-ccs-data-y-tiled-ccs)
[74.765079] Starting subtest: random-ccs-data-y-tiled-ccs
[74.767492] Starting dynamic subtest: pipe-A-eDP-1
[74.792679] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[74.800363] Starting dynamic subtest: pipe-B-eDP-1
[74.824456] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[74.831701] Starting dynamic subtest: pipe-C-eDP-1
[74.856144] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[74.865961] Starting dynamic subtest: pipe-D-eDP-1
[74.891053] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[74.895213] Subtest random-ccs-data-y-tiled-ccs: SKIP (0.003s)
[77.067809] [007/133] (940s left) syncobj_wait (invalid-multi-wait-all-unsubmitted-submitted-signaled)
[77.116153] Starting subtest: invalid-multi-wait-all-unsubmitted-submitted-signaled
[77.118657] Subtest invalid-multi-wait-all-unsubmitted-submitted-signaled: SUCCESS (0.000s)
[77.204369] [008/133] (940s left) sw_sync (sync_busy)
[77.247640] Starting subtest: sync_busy
[77.249874] Subtest sync_busy: SUCCESS (0.002s)
[77.305454] [009/133] (940s left) i915_suspend (sysfs-reader)
[77.358637] Starting subtest: sysfs-reader
[95.934216] Subtest sysfs-reader: SUCCESS (3.232s)
[96.001062] [010/133] (921s left) kms_psr (fbc-psr2-sprite-mmap-cpu)
[96.107604] Starting subtest: fbc-psr2-sprite-mmap-cpu
[96.109613] Starting dynamic subtest: eDP-1
[96.113286] Dynamic subtest eDP-1: SKIP (0.000s)
[96.117040] Subtest fbc-psr2-sprite-mmap-cpu: SKIP (0.000s)
[96.175437] [011/133] (921s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-indfb-plflip-blt)
[96.271142] Starting subtest: fbcpsr-2p-primscrn-indfb-plflip-blt
[96.274616] Subtest fbcpsr-2p-primscrn-indfb-plflip-blt: SKIP (0.000s)
[96.368274] [012/133] (921s left) dmabuf_sync_file (export-basic)
[96.445319] Starting subtest: export-basic
[96.447365] Subtest export-basic: SUCCESS (0.001s)
[96.500661] [FACT dmabuf_sync_file (export-basic)] new: kernel.kmod_is_loaded.vgem: true
[96.503582] [013/133] (921s left) syncobj_eventfd (binary-wait-before-signal)
[96.559315] Starting subtest: binary-wait-before-signal
[96.590553] Subtest binary-wait-before-signal: SUCCESS (0.031s)
[96.676451] [014/133] (921s left) kms_big_fb (linear-64bpp-rotate-90)
[96.784501] Starting subtest: linear-64bpp-rotate-90
[96.804920] Subtest linear-64bpp-rotate-90: SKIP (0.018s)
[96.917591] [015/133] (921s left) gem_ctx_isolation (nonpriv-switch)
[96.982347] Starting subtest: nonpriv-switch
[96.984406] Starting dynamic subtest: rcs0
[97.260366] Dynamic subtest rcs0: SUCCESS (0.278s)
[97.269210] Starting dynamic subtest: bcs0
[97.574329] Dynamic subtest bcs0: SUCCESS (0.313s)
[97.583022] Starting dynamic subtest: vcs0
[97.839840] Dynamic subtest vcs0: SUCCESS (0.265s)
[97.849980] Starting dynamic subtest: vcs1
[99.544556] Dynamic subtest vcs1: SUCCESS (1.704s)
[99.552390] Starting dynamic subtest: vecs0
[101.547557] Dynamic subtest vecs0: SUCCESS (2.002s)
[101.558295] Starting dynamic subtest: ccs0
[103.566602] Dynamic subtest ccs0: SUCCESS (2.018s)
[103.568910] Subtest nonpriv-switch: SUCCESS (6.583s)
[103.808303] [016/133] (914s left) gem_workarounds (basic-read-fd)
[103.872131] Starting subtest: basic-read-fd
[103.890299] Subtest basic-read-fd: SUCCESS (0.018s)
[104.006495] [017/133] (914s left) syncobj_basic (test-valid-cycle)
[104.066428] Starting subtest: test-valid-cycle
[104.068834] Subtest test-valid-cycle: SUCCESS (0.000s)
[104.196321] [018/133] (913s left) prime_vgem (coherency-blt)
[104.261642] Starting subtest: coherency-blt
[105.926034] Subtest coherency-blt: SUCCESS (1.664s)
[106.075496] [019/133] (912s left) perf (invalid-oa-exponent)
[106.219528] Starting subtest: invalid-oa-exponent
[106.232798] Subtest invalid-oa-exponent: SUCCESS (0.014s)
[106.279235] [020/133] (911s left) kms_cursor_legacy (cursor-vs-flip-atomic-transitions-varying-size)
[106.418540] Starting subtest: cursor-vs-flip-atomic-transitions-varying-size
[137.955848] Subtest cursor-vs-flip-atomic-transitions-varying-size: SUCCESS (31.540s)
[138.832020] [021/133] (879s left) kms_rotation_crc (primary-yf-tiled-reflect-x-0)
[138.933403] Starting subtest: primary-yf-tiled-reflect-x-0
[139.005205] Subtest primary-yf-tiled-reflect-x-0: SKIP (0.071s)
[139.107406] [022/133] (879s left) kms_psr2_sf (fbc-pr-cursor-plane-move-continuous-exceed-fully-sf)
[139.223943] Starting subtest: fbc-pr-cursor-plane-move-continuous-exceed-fully-sf
[139.228184] Subtest fbc-pr-cursor-plane-move-continuous-exceed-fully-sf: SKIP (0.000s)
[139.289443] [023/133] (878s left) kms_big_fb (yf-tiled-addfb-size-overflow)
[139.391529] Starting subtest: yf-tiled-addfb-size-overflow
[139.396042] Subtest yf-tiled-addfb-size-overflow: SKIP (0.000s)
[139.487629] [024/133] (878s left) gem_mmap (big-bo)
[139.545111] Subtest big-bo: SKIP (0.000s)
[139.612219] [025/133] (878s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-fullscreen)
[139.705793] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-fullscreen
[139.709899] Subtest fbcpsr-2p-primscrn-spr-indfb-fullscreen: SKIP (0.000s)
[139.807413] [026/133] (878s left) gem_exec_schedule (pi-ringfull)
[139.992446] Starting subtest: pi-ringfull
[139.995042] Starting dynamic subtest: rcs0
[140.024308] Dynamic subtest rcs0: SUCCESS (0.035s)
[140.033450] Starting dynamic subtest: bcs0
[140.058401] Dynamic subtest bcs0: SUCCESS (0.034s)
[140.077858] Starting dynamic subtest: vcs0
[140.086500] Dynamic subtest vcs0: SUCCESS (0.028s)
[140.098178] Starting dynamic subtest: vcs1
[140.115772] Dynamic subtest vcs1: SUCCESS (0.029s)
[140.127209] Starting dynamic subtest: vecs0
[140.143996] Dynamic subtest vecs0: SUCCESS (0.028s)
[140.156193] Starting dynamic subtest: ccs0
[140.170354] Dynamic subtest ccs0: SUCCESS (0.026s)
[140.172538] Subtest pi-ringfull: SUCCESS (0.181s)
[140.382579] [027/133] (878s left) kms_psr2_sf (pr-cursor-plane-move-continuous-exceed-fully-sf)
[140.486329] Starting subtest: pr-cursor-plane-move-continuous-exceed-fully-sf
[140.490429] Subtest pr-cursor-plane-move-continuous-exceed-fully-sf: SKIP (0.000s)
[140.554269] [028/133] (877s left) kms_busy (extended-pageflip-modeset-hang-oldfb)
[140.655782] Starting subtest: extended-pageflip-modeset-hang-oldfb
[140.657636] Starting dynamic subtest: pipe-A
[148.560335] Dynamic subtest pipe-A: SUCCESS (7.903s)
[148.570189] Starting dynamic subtest: pipe-D
[157.154624] Dynamic subtest pipe-D: SUCCESS (8.592s)
[157.156974] Subtest extended-pageflip-modeset-hang-oldfb: SUCCESS (16.499s)
[158.006725] [029/133] (860s left) kms_cursor_crc (cursor-onscreen-512x170)
[158.268579] Starting subtest: cursor-onscreen-512x170
[158.273135] Subtest cursor-onscreen-512x170: SKIP (0.001s)
[158.408620] [030/133] (860s left) sw_sync (sync_expired_merge)
[158.443843] Starting subtest: sync_expired_merge
[159.516309] Subtest sync_expired_merge: SUCCESS (1.074s)
[159.576494] [031/133] (858s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-shrfb-draw-render)
[159.676733] Starting subtest: psr-1p-offscreen-pri-shrfb-draw-render
[166.575277] Subtest psr-1p-offscreen-pri-shrfb-draw-render: SUCCESS (6.900s)
[166.691934] [032/133] (851s left) kms_content_protection (lic-type-1)
[166.822850] Starting subtest: lic-type-1
[166.827562] Subtest lic-type-1: SKIP (0.000s)
[166.930919] [033/133] (851s left) gem_eio (wait-wedge-1us)
[167.148370] Starting subtest: wait-wedge-1us
[168.333290] Subtest wait-wedge-1us: SUCCESS (1.185s)
[168.483880] [034/133] (850s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-blt)
[168.594930] Starting subtest: fbcpsr-rgb565-draw-blt
[175.529363] Subtest fbcpsr-rgb565-draw-blt: SUCCESS (6.937s)
[175.663460] [035/133] (843s left) i915_pm_freq_api (freq-reset-multiple)
[175.727973] Starting subtest: freq-reset-multiple
[175.730468] Starting dynamic subtest: gt0
[184.909456] Dynamic subtest gt0: SUCCESS (9.180s)
[184.918184] Starting dynamic subtest: gt1
[193.279087] Dynamic subtest gt1: SUCCESS (8.368s)
[193.282184] Subtest freq-reset-multiple: SUCCESS (17.550s)
[193.357769] [036/133] (825s left) kms_invalid_mode (int-max-clock)
[193.464370] Starting subtest: int-max-clock
[193.466595] Starting dynamic subtest: pipe-A-eDP-1
[193.756807] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.292s)
[193.766508] Starting dynamic subtest: pipe-B-eDP-1
[193.768756] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[193.777026] Starting dynamic subtest: pipe-C-eDP-1
[193.779352] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[193.787151] Starting dynamic subtest: pipe-D-eDP-1
[193.789558] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[193.791853] Subtest int-max-clock: SUCCESS (0.297s)
[194.596877] [037/133] (824s left) kms_color_pipeline (plane-lut1d-ctm3x4-lut1d)
[194.699356] Starting subtest: plane-lut1d-ctm3x4-lut1d
[194.821405] Starting dynamic subtest: pipe-A-plane-0
[194.977831] Dynamic subtest pipe-A-plane-0: SUCCESS (0.155s)
[194.987307] Starting dynamic subtest: pipe-A-plane-1
[195.110374] Dynamic subtest pipe-A-plane-1: SUCCESS (0.133s)
[195.122994] Starting dynamic subtest: pipe-A-plane-2
[195.266171] Dynamic subtest pipe-A-plane-2: SUCCESS (0.155s)
[196.483552] Starting dynamic subtest: pipe-B-plane-0
[196.665608] Dynamic subtest pipe-B-plane-0: SUCCESS (0.189s)
[196.678278] Starting dynamic subtest: pipe-B-plane-1
[196.810091] Dynamic subtest pipe-B-plane-1: SUCCESS (0.144s)
[196.819394] Starting dynamic subtest: pipe-B-plane-2
[196.954439] Dynamic subtest pipe-B-plane-2: SUCCESS (0.144s)
[198.108225] Starting dynamic subtest: pipe-C-plane-0
[198.233917] Dynamic subtest pipe-C-plane-0: SUCCESS (0.133s)
[198.243861] Starting dynamic subtest: pipe-C-plane-1
[198.378531] Dynamic subtest pipe-C-plane-1: SUCCESS (0.144s)
[198.388304] Starting dynamic subtest: pipe-C-plane-2
[198.522837] Dynamic subtest pipe-C-plane-2: SUCCESS (0.144s)
[199.730942] Starting dynamic subtest: pipe-D-plane-0
[199.889808] Dynamic subtest pipe-D-plane-0: SUCCESS (0.166s)
[199.900104] Starting dynamic subtest: pipe-D-plane-1
[200.056576] Dynamic subtest pipe-D-plane-1: SUCCESS (0.166s)
[200.065787] Starting dynamic subtest: pipe-D-plane-2
[200.201650] Dynamic subtest pipe-D-plane-2: SUCCESS (0.144s)
[200.486602] Subtest plane-lut1d-ctm3x4-lut1d: SUCCESS (5.788s)
[201.312903] [038/133] (817s left) gem_softpin (allocator-nopin)
[201.378807] Starting subtest: allocator-nopin
[201.484266] Subtest allocator-nopin: SUCCESS (0.105s)
[201.611466] [039/133] (817s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-shrfb-plflip-blt)
[201.712565] Starting subtest: fbc-2p-scndscrn-shrfb-plflip-blt
[201.717279] Subtest fbc-2p-scndscrn-shrfb-plflip-blt: SKIP (0.000s)
[201.816746] [040/133] (817s left) kms_flip (2x-flip-vs-dpms)
[201.910061] Starting subtest: 2x-flip-vs-dpms
[201.919318] Subtest 2x-flip-vs-dpms: SKIP (0.011s)
[201.998604] [041/133] (816s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-mmap-gtt)
[202.098724] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-mmap-gtt
[202.103133] Subtest fbc-1p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[202.201233] [042/133] (816s left) gem_ctx_shared (disjoint-timelines)
[202.275657] Starting subtest: disjoint-timelines
[202.296504] Subtest disjoint-timelines: SUCCESS (0.021s)
[202.536611] [043/133] (816s left) kms_plane (pixel-format-y-tiled-gen12-rc-ccs-modifier-source-clamping)
[202.636064] Starting subtest: pixel-format-y-tiled-gen12-rc-ccs-modifier-source-clamping
[202.641280] Subtest pixel-format-y-tiled-gen12-rc-ccs-modifier-source-clamping: SKIP (0.000s)
[202.706867] [044/133] (816s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-mmap-gtt)
[202.806654] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-mmap-gtt
[202.811014] Subtest fbc-2p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[202.892959] [045/133] (816s left) kms_flip (flip-vs-modeset-vs-hang)
[202.982776] Starting subtest: flip-vs-modeset-vs-hang
[202.985021] Starting dynamic subtest: A-eDP1
[242.722385] Dynamic subtest A-eDP1: SUCCESS (39.739s)
[242.732003] Starting dynamic subtest: D-eDP1
[291.743558] Dynamic subtest D-eDP1: SUCCESS (49.019s)
[291.746094] Subtest flip-vs-modeset-vs-hang: SUCCESS (88.764s)
[292.157232] [046/133] (727s left) kms_big_fb (x-tiled-8bpp-rotate-90)
[292.254742] Starting subtest: x-tiled-8bpp-rotate-90
[292.279414] Subtest x-tiled-8bpp-rotate-90: SKIP (0.022s)
[292.400605] [047/133] (726s left) gem_lmem_swapping (parallel-random-verify)
[292.445174] Subtest parallel-random-verify: SKIP (0.000s)
[292.486659] [048/133] (726s left) syncobj_timeline (multi-wait-all-available-submitted-signaled)
[292.543755] Starting subtest: multi-wait-all-available-submitted-signaled
[292.546237] Subtest multi-wait-all-available-submitted-signaled: SUCCESS (0.001s)
[292.665459] [049/133] (726s left) syncobj_timeline (wait-for-submit-delayed-submit)
[292.712436] Starting subtest: wait-for-submit-delayed-submit
[292.815100] Subtest wait-for-submit-delayed-submit: SUCCESS (0.103s)
[292.890217] [050/133] (726s left) kms_lease (implicit-plane-lease)
[292.982926] Starting subtest: implicit-plane-lease
[292.985117] Subtest implicit-plane-lease: SUCCESS (0.003s)
[293.084724] [051/133] (726s left) kms_rotation_crc (bad-tiling)
[293.175781] Starting subtest: bad-tiling
[293.179824] Subtest bad-tiling: SKIP (0.001s)
[293.258597] [052/133] (726s left) gem_mmap_gtt (basic-small-bo-tiledy)
[293.312897] Subtest basic-small-bo-tiledY: SKIP (0.000s)
[293.370114] [053/133] (726s left) syncobj_basic (bad-destroy)
[293.436469] Starting subtest: bad-destroy
[293.438768] Subtest bad-destroy: SUCCESS (0.000s)
[293.526616] [054/133] (726s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-render)
[293.623405] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-render
[293.627447] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-render: SKIP (0.000s)
[293.717466] [055/133] (725s left) kms_chamelium_frames (hdmi-cmp-planar-formats)
[294.096967] Subtest hdmi-cmp-planar-formats: SKIP (0.000s)
[294.944806] [056/133] (724s left) kms_flip (flip-vs-panning-interruptible)
[295.066389] Starting subtest: flip-vs-panning-interruptible
[295.068882] Starting dynamic subtest: A-eDP1
[303.771172] Dynamic subtest A-eDP1: SUCCESS (8.706s)
[303.782696] Starting dynamic subtest: B-eDP1
[312.512440] Dynamic subtest B-eDP1: SUCCESS (8.739s)
[312.522385] Starting dynamic subtest: C-eDP1
[321.228320] Dynamic subtest C-eDP1: SUCCESS (8.714s)
[321.240409] Starting dynamic subtest: D-eDP1
[329.953881] Dynamic subtest D-eDP1: SUCCESS (8.722s)
[329.956138] Subtest flip-vs-panning-interruptible: SUCCESS (34.892s)
[331.127453] [057/133] (688s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-blt)
[331.227360] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-blt
[331.231545] Subtest psr-2p-primscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[331.310646] [058/133] (688s left) kms_big_fb (4-tiled-16bpp-rotate-270)
[331.414679] Starting subtest: 4-tiled-16bpp-rotate-270
[331.434304] Subtest 4-tiled-16bpp-rotate-270: SKIP (0.019s)
[331.557649] [059/133] (688s left) kms_frontbuffer_tracking (fbcpsr-suspend)
[331.663923] Starting subtest: fbcpsr-suspend
[372.615039] Subtest fbcpsr-suspend: SUCCESS (10.060s)
[372.767463] [060/133] (647s left) kms_cursor_crc (cursor-suspend)
[372.912787] Starting subtest: cursor-suspend
[372.915304] Starting dynamic subtest: pipe-A-eDP-1
[405.441415] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.149s)
[405.450704] Starting dynamic subtest: pipe-D-eDP-1
[439.420124] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.751s)
[439.422425] Subtest cursor-suspend: SUCCESS (6.903s)
[440.258899] [061/133] (579s left) syncobj_timeline (single-wait-available-signaled)
[440.331200] Starting subtest: single-wait-available-signaled
[440.333590] Subtest single-wait-available-signaled: SUCCESS (0.000s)
[440.458558] [062/133] (579s left) kms_ccs (crc-primary-suspend-y-tiled-ccs)
[440.548521] Starting subtest: crc-primary-suspend-y-tiled-ccs
[440.550926] Starting dynamic subtest: pipe-A-eDP-1
[440.559785] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[440.570486] Starting dynamic subtest: pipe-B-eDP-1
[440.579294] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[440.588643] Starting dynamic subtest: pipe-C-eDP-1
[440.596802] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[440.605518] Starting dynamic subtest: pipe-D-eDP-1
[440.613770] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[440.618017] Subtest crc-primary-suspend-y-tiled-ccs: SKIP (0.005s)
[442.815591] [063/133] (577s left) sw_sync (sync_busy_fork)
[442.867672] Starting subtest: sync_busy_fork
[443.879295] Subtest sync_busy_fork: SUCCESS (1.007s)
[443.939836] [064/133] (576s left) kms_draw_crc (draw-method-pwrite)
[444.063132] Starting subtest: draw-method-pwrite
[444.065337] Starting dynamic subtest: xrgb8888-untiled
[444.706775] Dynamic subtest xrgb8888-untiled: SUCCESS (0.645s)
[444.718613] Starting dynamic subtest: rgb565-untiled
[445.162866] Dynamic subtest rgb565-untiled: SUCCESS (0.453s)
[445.173080] Starting dynamic subtest: xrgb2101010-untiled
[445.708067] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.544s)
[445.718760] Starting dynamic subtest: xbgr16161616f-untiled
[446.463975] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.755s)
[446.473639] Starting dynamic subtest: xrgb8888-xtiled
[448.266244] Dynamic subtest xrgb8888-xtiled: SUCCESS (1.798s)
[448.276063] Starting dynamic subtest: rgb565-xtiled
[449.322871] Dynamic subtest rgb565-xtiled: SUCCESS (1.055s)
[449.332735] Starting dynamic subtest: xrgb2101010-xtiled
[451.035686] Dynamic subtest xrgb2101010-xtiled: SUCCESS (1.710s)
[451.045188] Starting dynamic subtest: xbgr16161616f-xtiled
[454.237869] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (3.197s)
[454.247519] Starting dynamic subtest: xrgb8888-4tiled
[455.305305] Dynamic subtest xrgb8888-4tiled: SUCCESS (1.064s)
[455.314293] Starting dynamic subtest: rgb565-4tiled
[455.839064] Dynamic subtest rgb565-4tiled: SUCCESS (0.533s)
[455.848625] Starting dynamic subtest: xrgb2101010-4tiled
[456.884227] Dynamic subtest xrgb2101010-4tiled: SUCCESS (1.042s)
[456.893856] Starting dynamic subtest: xbgr16161616f-4tiled
[459.908692] Dynamic subtest xbgr16161616f-4tiled: SUCCESS (3.022s)
[459.911138] Subtest draw-method-pwrite: SUCCESS (15.835s)
[460.019777] [065/133] (559s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-onoff)
[460.166494] Starting subtest: fbc-2p-scndscrn-cur-indfb-onoff
[460.170757] Subtest fbc-2p-scndscrn-cur-indfb-onoff: SKIP (0.000s)
[460.288353] [066/133] (559s left) gem_exec_fence (syncobj-signal)
[460.704654] Starting subtest: syncobj-signal
[460.709210] Subtest syncobj-signal: SUCCESS (0.007s)
[461.844434] [067/133] (558s left) gem_vm_create (isolation)
[461.899163] Starting subtest: isolation
[461.909134] Subtest isolation: SUCCESS (0.010s)
[462.035853] [068/133] (558s left) kms_prime (basic-crc-hybrid)
[462.115363] Subtest basic-crc-hybrid: SKIP (0.000s)
[462.214907] [069/133] (557s left) gem_exec_schedule (wide)
[462.401369] Starting subtest: wide
[462.403994] Starting dynamic subtest: rcs0
[472.511629] Dynamic subtest rcs0: SUCCESS (10.103s)
[472.526848] Starting dynamic subtest: vcs0
[482.524482] Dynamic subtest vcs0: SUCCESS (10.007s)
[482.536727] Starting dynamic subtest: vcs1
[493.144436] Dynamic subtest vcs1: SUCCESS (10.613s)
[493.156773] Starting dynamic subtest: vecs0
[503.480108] Dynamic subtest vecs0: SUCCESS (10.329s)
[503.492008] Starting dynamic subtest: ccs0
[515.888390] Dynamic subtest ccs0: SUCCESS (12.401s)
[515.891112] Subtest wide: SUCCESS (53.460s)
[517.860147] [070/133] (502s left) kms_frontbuffer_tracking (psr-1p-primscrn-shrfb-plflip-blt)
[517.962771] Starting subtest: psr-1p-primscrn-shrfb-plflip-blt
[525.411696] Subtest psr-1p-primscrn-shrfb-plflip-blt: SUCCESS (7.447s)
[525.536847] [071/133] (494s left) kms_psr (psr2-sprite-plane-move)
[525.629105] Starting subtest: psr2-sprite-plane-move
[525.631353] Starting dynamic subtest: eDP-1
[527.383362] Dynamic subtest eDP-1: SUCCESS (1.752s)
[527.385789] Subtest psr2-sprite-plane-move: SUCCESS (1.753s)
[528.215261] [072/133] (492s left) api_intel_bb (reset-bb)
[528.277684] Starting subtest: reset-bb
[528.280082] Subtest reset-bb: SUCCESS (0.003s)
[528.408793] [073/133] (491s left) kms_ccs (bad-rotation-90-4-tiled-dg2-mc-ccs)
[528.514581] Starting subtest: bad-rotation-90-4-tiled-dg2-mc-ccs
[528.516851] Starting dynamic subtest: pipe-A-eDP-1
[528.540458] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[528.551188] Starting dynamic subtest: pipe-B-eDP-1
[528.572517] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[528.581042] Starting dynamic subtest: pipe-C-eDP-1
[528.602431] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[528.611047] Starting dynamic subtest: pipe-D-eDP-1
[528.632848] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[528.637155] Subtest bad-rotation-90-4-tiled-dg2-mc-ccs: SKIP (0.004s)
[530.694318] [074/133] (489s left) perf (invalid-open-flags)
[530.793125] Starting subtest: invalid-open-flags
[530.795471] Subtest invalid-open-flags: SUCCESS (0.000s)
[530.838331] [075/133] (489s left) perf (blocking)
[530.937372] Starting subtest: blocking
[530.939918] Starting dynamic subtest: 0-rcs0
[540.959575] Dynamic subtest 0-rcs0: SUCCESS (10.015s)
[540.970563] Starting dynamic subtest: 1-vecs0
[550.985176] Dynamic subtest 1-vecs0: SUCCESS (10.019s)
[550.987825] Subtest blocking: SUCCESS (20.037s)
[551.075245] [076/133] (469s left) kms_chamelium_hpd (hdmi-hpd-with-enabled-mode)
[551.484869] Subtest hdmi-hpd-with-enabled-mode: SKIP (0.000s)
[552.318428] [077/133] (468s left) gem_exec_whisper (basic-queues-forked-all)
[552.378470] Starting subtest: basic-queues-forked-all
[572.039227] Subtest basic-queues-forked-all: SUCCESS (19.647s)
[572.224189] [078/133] (448s left) kms_pipe_stress (stress-xrgb8888-yftiled)
[572.323096] Starting subtest: stress-xrgb8888-yftiled
[572.327078] Subtest stress-xrgb8888-yftiled: SKIP (0.000s)
[572.395679] [079/133] (448s left) i915_query (query-topology-coherent-slice-mask)
[572.448518] Starting subtest: query-topology-coherent-slice-mask
[572.452597] Subtest query-topology-coherent-slice-mask: SKIP (0.000s)
[572.562189] [080/133] (448s left) kms_psr (pr-sprite-plane-move)
[572.659262] Starting subtest: pr-sprite-plane-move
[572.663543] Subtest pr-sprite-plane-move: SKIP (0.000s)
[572.732260] [081/133] (447s left) syncobj_timeline (reset-multiple-signaled)
[572.799895] Starting subtest: reset-multiple-signaled
[572.801823] Subtest reset-multiple-signaled: SUCCESS (0.001s)
[572.899052] [082/133] (447s left) kms_psr (fbc-psr2-dpms)
[572.993497] Starting subtest: fbc-psr2-dpms
[572.995901] Starting dynamic subtest: eDP-1
[573.000135] Dynamic subtest eDP-1: SKIP (0.000s)
[573.004529] Subtest fbc-psr2-dpms: SKIP (0.001s)
[573.084109] [083/133] (447s left) kms_psr2_su (page_flip-xrgb8888)
[573.141510] Subtest page_flip-XRGB8888: SKIP (0.000s)
[573.200328] [084/133] (447s left) api_intel_allocator (simple-allocator)
[573.246749] Starting subtest: simple-allocator
[573.248783] Starting dynamic subtest: basic
[573.250628] Dynamic subtest basic: SUCCESS (0.003s)
[573.259387] Starting dynamic subtest: parallel-one
[573.436293] Dynamic subtest parallel-one: SUCCESS (0.186s)
[573.446046] Starting dynamic subtest: print
[573.448184] Dynamic subtest print: SUCCESS (0.000s)
[573.457543] Starting dynamic subtest: reuse
[573.459895] Dynamic subtest reuse: SUCCESS (0.000s)
[573.470154] Starting dynamic subtest: reserve
[573.472353] Dynamic subtest reserve: SUCCESS (0.000s)
[573.481348] Starting dynamic subtest: fork-reopen-allocator
[573.483541] Dynamic subtest fork-reopen-allocator: SUCCESS (0.013s)
[573.485664] Subtest simple-allocator: SUCCESS (0.210s)
[573.578368] [085/133] (447s left) kms_atomic (plane-immutable-zpos)
[573.671559] Starting subtest: plane-immutable-zpos
[573.673999] Starting dynamic subtest: pipe-A-eDP-1
[574.303692] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.633s)
[574.306372] Subtest plane-immutable-zpos: SUCCESS (0.635s)
[575.178903] [086/133] (445s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-blt)
[575.286735] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-blt
[579.020973] Subtest fbc-1p-primscrn-spr-indfb-draw-blt: SUCCESS (3.737s)
[580.188354] [087/133] (440s left) kms_addfb_basic (legacy-format)
[580.243347] Starting subtest: legacy-format
[580.262933] Subtest legacy-format: SUCCESS (0.020s)
[580.408042] [088/133] (440s left) kms_dp_linktrain_fallback (dsc-fallback)
[580.506508] Starting subtest: dsc-fallback
[580.513054] Subtest dsc-fallback: SKIP (0.000s)
[580.589735] [089/133] (440s left) kms_plane_lowres (tiling-x)
[580.686675] Starting subtest: tiling-x
[580.688984] Starting dynamic subtest: pipe-A-eDP-1
[580.693460] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[580.982339] Starting dynamic subtest: pipe-B-eDP-1
[580.986675] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[580.996313] Starting dynamic subtest: pipe-C-eDP-1
[581.000590] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[581.010252] Starting dynamic subtest: pipe-D-eDP-1
[581.014309] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[581.018669] Subtest tiling-x: SKIP (0.295s)
[581.816352] [090/133] (439s left) kms_frontbuffer_tracking (fbc-rgb565-draw-mmap-wc)
[581.929785] Starting subtest: fbc-rgb565-draw-mmap-wc
[585.873144] Subtest fbc-rgb565-draw-mmap-wc: SUCCESS (3.945s)
[587.002629] [091/133] (434s left) gem_exec_params (invalid-bsd-ring)
[587.060830] Starting subtest: invalid-bsd-ring
[587.063093] Subtest invalid-bsd-ring: SUCCESS (0.000s)
[587.177486] [092/133] (434s left) i915_pm_rpm (gem-execbuf)
[588.911546] Starting subtest: gem-execbuf
[588.914160] Starting dynamic subtest: smem0
[590.773624] Dynamic subtest smem0: SUCCESS (1.864s)
[590.775880] Subtest gem-execbuf: SUCCESS (1.865s)
[590.868479] [093/133] (430s left) gem_mmap_offset (ptrace)
[590.926203] Starting subtest: ptrace
[590.928638] Starting dynamic subtest: smem0-wb
[590.946252] Dynamic subtest smem0-wb: SUCCESS (0.020s)
[590.957806] Starting dynamic subtest: smem0-wc
[590.964806] Dynamic subtest smem0-wc: SUCCESS (0.018s)
[590.974561] Starting dynamic subtest: smem0-uc
[590.985785] Dynamic subtest smem0-uc: SUCCESS (0.020s)
[590.988024] Subtest ptrace: SUCCESS (0.063s)
[591.084205] [094/133] (430s left) gem_exec_reloc (basic-gtt-noreloc)
[591.150623] Subtest basic-gtt-noreloc: SKIP (0.000s)
[591.219540] [095/133] (430s left) kms_ccs (crc-primary-basic-4-tiled-mtl-rc-ccs)
[591.307279] Starting subtest: crc-primary-basic-4-tiled-mtl-rc-ccs
[591.309556] Starting dynamic subtest: pipe-A-eDP-1
[592.130522] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.816s)
[592.141825] Starting dynamic subtest: pipe-B-eDP-1
[593.733613] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.599s)
[593.743768] Starting dynamic subtest: pipe-C-eDP-1
[595.232663] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.498s)
[595.245274] Starting dynamic subtest: pipe-D-eDP-1
[596.768990] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.532s)
[596.771277] Subtest crc-primary-basic-4-tiled-mtl-rc-ccs: SUCCESS (5.450s)
[597.947835] [096/133] (423s left) perf_pmu (module-unload)