[59.628372] Initializing watchdogs
[59.628421]   /dev/watchdog0
[59.644013] [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]
[59.649248] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[59.651553] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[59.653471] [001/133] (960s left) gem_exec_params (invalid-bsd2-flag-on-render)
[59.714537] Starting subtest: invalid-bsd2-flag-on-render
[59.715619] Subtest invalid-bsd2-flag-on-render: SUCCESS (0.000s)
[59.808955] [002/133] (960s left) kms_flip (2x-flip-vs-absolute-wf_vblank-interruptible)
[59.905468] Starting subtest: 2x-flip-vs-absolute-wf_vblank-interruptible
[59.917406] Subtest 2x-flip-vs-absolute-wf_vblank-interruptible: SKIP (0.011s)
[59.989813] [003/133] (960s left) gem_exec_balancer (waits)
[60.051478] Starting subtest: waits
[66.659728] Subtest waits: SUCCESS (6.560s)
[66.950757] [004/133] (953s left) syncobj_wait (invalid-multi-wait-unsubmitted-submitted)
[67.157592] Starting subtest: invalid-multi-wait-unsubmitted-submitted
[67.158931] Subtest invalid-multi-wait-unsubmitted-submitted: SUCCESS (0.001s)
[67.418249] [005/133] (952s left) kms_atomic_transition (plane-primary-toggle-with-vblank-wait)
[67.620060] Starting subtest: plane-primary-toggle-with-vblank-wait
[67.620997] Starting dynamic subtest: pipe-A-eDP-1
[67.800952] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.180s)
[68.105101] Starting dynamic subtest: pipe-B-eDP-1
[69.040377] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.942s)
[69.335926] Subtest plane-primary-toggle-with-vblank-wait: SUCCESS (1.716s)
[70.188365] [006/133] (950s left) kms_cursor_legacy (cursorb-vs-flipa-legacy)
[70.309901] Starting subtest: cursorB-vs-flipA-legacy
[70.312833] Subtest cursorB-vs-flipA-legacy: SKIP (0.001s)
[70.448574] [007/133] (949s left) gem_create (create-valid-nonaligned)
[70.491492] Starting subtest: create-valid-nonaligned
[70.492472] Subtest create-valid-nonaligned: SUCCESS (0.000s)
[70.681339] [008/133] (949s left) sysfs_heartbeat_interval (mixed)
[70.737336] Starting subtest: mixed
[70.738271] Starting dynamic subtest: vecs0
[75.949254] Dynamic subtest vecs0: SUCCESS (5.211s)
[75.958865] Starting dynamic subtest: ccs0
[81.134622] Dynamic subtest ccs0: SUCCESS (5.185s)
[81.141258] Starting dynamic subtest: vcs0
[86.313898] Dynamic subtest vcs0: SUCCESS (5.178s)
[86.322405] Starting dynamic subtest: bcs0
[91.538943] Dynamic subtest bcs0: SUCCESS (5.224s)
[91.547685] Starting dynamic subtest: rcs0
[96.723542] Dynamic subtest rcs0: SUCCESS (5.183s)
[96.732051] Starting dynamic subtest: vcs1
[101.946864] Dynamic subtest vcs1: SUCCESS (5.222s)
[101.947997] Subtest mixed: SUCCESS (31.209s)
[102.017639] [009/133] (918s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-0-hflip)
[102.115336] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-0-hflip
[103.196182] Subtest 4-tiled-max-hw-stride-32bpp-rotate-0-hflip: SUCCESS (1.081s)
[103.330902] [010/133] (917s left) gem_workarounds (suspend-resume)
[103.396288] Starting subtest: suspend-resume
[119.506598] Subtest suspend-resume: SUCCESS (2.472s)
[126.672567] [011/133] (900s left) kms_prop_blob (invalid-set-prop-any)
[126.723605] Starting subtest: invalid-set-prop-any
[126.724581] Subtest invalid-set-prop-any: SUCCESS (0.000s)
[126.810211] [012/133] (900s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-onoff)
[126.895841] Starting subtest: psr-2p-scndscrn-spr-indfb-onoff
[126.897561] Subtest psr-2p-scndscrn-spr-indfb-onoff: SKIP (0.000s)
[126.985081] [013/133] (900s left) gem_exec_flush (basic-uc-pro-default)
[127.044791] Starting subtest: basic-uc-pro-default
[132.514427] Subtest basic-uc-pro-default: SUCCESS (5.467s)
[132.705889] [014/133] (894s left) gem_exec_reloc (basic-write-gtt-active)
[132.758313] Subtest basic-write-gtt-active: SKIP (0.000s)
[132.833530] [015/133] (894s left) core_getclient (basic)
[132.881501] Starting subtest: basic
[132.882467] Subtest basic: SUCCESS (0.000s)
[132.980126] [016/133] (894s left) prime_vgem (fence-flip-hang)
[133.124514] Subtest fence-flip-hang: SKIP (0.000s)
[133.212419] [FACT prime_vgem (fence-flip-hang)] new: kernel.kmod_is_loaded.vgem: true
[133.214555] [017/133] (894s left) kms_big_fb (linear-64bpp-rotate-270)
[133.302520] Starting subtest: linear-64bpp-rotate-270
[133.321235] Subtest linear-64bpp-rotate-270: SKIP (0.018s)
[133.421293] [018/133] (894s left) kms_plane_scaling (planes-downscale-factor-0-5-upscale-20x20)
[133.515464] Starting subtest: planes-downscale-factor-0-5-upscale-20x20
[133.516314] Starting dynamic subtest: pipe-A
[133.533694] Dynamic subtest pipe-A: SKIP (0.018s)
[133.541263] Starting dynamic subtest: pipe-B
[133.566362] Dynamic subtest pipe-B: SKIP (0.031s)
[133.575229] Starting dynamic subtest: pipe-C
[133.600401] Dynamic subtest pipe-C: SKIP (0.035s)
[133.607136] Starting dynamic subtest: pipe-D
[133.635005] Dynamic subtest pipe-D: SKIP (0.035s)
[133.636674] Subtest planes-downscale-factor-0-5-upscale-20x20: SKIP (0.119s)
[133.745972] [019/133] (894s left) kms_pm_rpm (system-suspend-idle)
[135.675732] Starting subtest: system-suspend-idle
[155.727908] Subtest system-suspend-idle: SUCCESS (4.675s)
[161.153173] [020/133] (871s left) kms_draw_crc (draw-method-render)
[161.252306] Starting subtest: draw-method-render
[161.253305] Starting dynamic subtest: xrgb8888-untiled
[161.530220] Dynamic subtest xrgb8888-untiled: SUCCESS (0.278s)
[161.538739] Starting dynamic subtest: rgb565-untiled
[161.774819] Dynamic subtest rgb565-untiled: SUCCESS (0.244s)
[161.783546] Starting dynamic subtest: xrgb2101010-untiled
[162.008288] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.233s)
[162.018889] Starting dynamic subtest: xbgr16161616f-untiled
[162.263632] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.255s)
[162.271130] Starting dynamic subtest: xrgb8888-xtiled
[162.404912] Dynamic subtest xrgb8888-xtiled: SUCCESS (0.133s)
[162.412277] Starting dynamic subtest: rgb565-xtiled
[162.508321] Dynamic subtest rgb565-xtiled: SUCCESS (0.110s)
[162.515671] Starting dynamic subtest: xrgb2101010-xtiled
[162.630742] Dynamic subtest xrgb2101010-xtiled: SUCCESS (0.122s)
[162.638806] Starting dynamic subtest: xbgr16161616f-xtiled
[162.764269] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (0.132s)
[162.772190] Starting dynamic subtest: xrgb8888-4tiled
[162.897176] Dynamic subtest xrgb8888-4tiled: SUCCESS (0.133s)
[162.904357] Starting dynamic subtest: rgb565-4tiled
[163.008641] Dynamic subtest rgb565-4tiled: SUCCESS (0.111s)
[163.016943] Starting dynamic subtest: xrgb2101010-4tiled
[163.130905] Dynamic subtest xrgb2101010-4tiled: SUCCESS (0.121s)
[163.139155] Starting dynamic subtest: xbgr16161616f-4tiled
[163.264331] Dynamic subtest xbgr16161616f-4tiled: SUCCESS (0.133s)
[163.265304] Subtest draw-method-render: SUCCESS (2.012s)
[163.377685] [021/133] (869s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-mmap-cpu)
[163.463278] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-mmap-cpu
[163.465153] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[163.572895] [022/133] (869s left) gem_set_tiling_vs_gtt
[163.673268] [023/133] (869s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-render)
[163.764064] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-render
[168.317258] Subtest fbc-1p-primscrn-pri-indfb-draw-render: SUCCESS (4.553s)
[169.490453] [024/133] (863s left) kms_hdmi_inject (inject-4k)
[169.833285] Starting subtest: inject-4k
[170.147636] Subtest inject-4k: SUCCESS (0.315s)
[170.734438] [025/133] (862s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-mmap-cpu)
[170.815494] Starting subtest: psr-2p-primscrn-cur-indfb-draw-mmap-cpu
[170.817251] Subtest psr-2p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[170.900811] [026/133] (862s left) kms_busy (extended-pageflip-modeset-hang-oldfb)
[170.986083] Starting subtest: extended-pageflip-modeset-hang-oldfb
[170.986953] Starting dynamic subtest: pipe-A
[178.878091] Dynamic subtest pipe-A: SUCCESS (7.889s)
[178.886808] Starting dynamic subtest: pipe-D
[187.502900] Dynamic subtest pipe-D: SUCCESS (8.622s)
[187.503822] Subtest extended-pageflip-modeset-hang-oldfb: SUCCESS (16.516s)
[188.317892] [027/133] (844s left) gem_exec_fence (syncobj-timeline-wait)
[188.863697] Starting subtest: syncobj-timeline-wait
[189.954453] Subtest syncobj-timeline-wait: SUCCESS (1.091s)
[190.186961] [028/133] (842s left) syncobj_timeline (etime-multi-wait-all-for-submit-unsubmitted)
[190.247602] Starting subtest: etime-multi-wait-all-for-submit-unsubmitted
[190.355060] Subtest etime-multi-wait-all-for-submit-unsubmitted: SUCCESS (0.107s)
[190.429010] [029/133] (842s left) kms_flip (modeset-vs-vblank-race-interruptible)
[190.511865] Starting subtest: modeset-vs-vblank-race-interruptible
[190.513971] Starting dynamic subtest: A-eDP1
[195.209601] Dynamic subtest A-eDP1: SUCCESS (4.695s)
[195.224133] Starting dynamic subtest: B-eDP1
[199.908430] Dynamic subtest B-eDP1: SUCCESS (4.696s)
[199.920483] Starting dynamic subtest: C-eDP1
[204.587336] Dynamic subtest C-eDP1: SUCCESS (4.677s)
[204.597360] Starting dynamic subtest: D-eDP1
[209.283114] Dynamic subtest D-eDP1: SUCCESS (4.693s)
[209.287515] Subtest modeset-vs-vblank-race-interruptible: SUCCESS (18.775s)
[210.511433] [030/133] (822s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-pwrite)
[210.606286] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-pwrite
[219.245499] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-pwrite: SUCCESS (8.640s)
[219.366002] [031/133] (813s left) kms_cursor_legacy (cursorb-vs-flipa-atomic-transitions)
[219.493496] Starting subtest: cursorB-vs-flipA-atomic-transitions
[219.496146] Subtest cursorB-vs-flipA-atomic-transitions: SKIP (0.001s)
[219.644842] [032/133] (813s left) perf (oa-formats)
[219.767713] Starting subtest: oa-formats
[219.768634] Starting dynamic subtest: 0-rcs0
[219.782919] Dynamic subtest 0-rcs0: SUCCESS (0.016s)
[219.790303] Starting dynamic subtest: 1-vecs0
[219.804731] Dynamic subtest 1-vecs0: SUCCESS (0.021s)
[219.805580] Subtest oa-formats: SUCCESS (0.038s)
[219.849782] [033/133] (813s left) kms_joiner (basic-ultra-joiner)
[219.935578] Starting subtest: basic-ultra-joiner
[219.937318] Subtest basic-ultra-joiner: SKIP (0.000s)
[219.999921] [034/133] (813s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-onoff)
[220.090066] Starting subtest: fbc-1p-primscrn-cur-indfb-onoff
[223.944296] Subtest fbc-1p-primscrn-cur-indfb-onoff: SUCCESS (3.855s)
[225.117413] [035/133] (808s left) gem_exec_flush (basic-wb-ro-before-default)
[225.181656] Starting subtest: basic-wb-ro-before-default
[230.647345] Subtest basic-wb-ro-before-default: SUCCESS (5.465s)
[230.833526] [036/133] (802s left) syncobj_wait (wait-all-for-submit-snapshot)
[230.884909] Starting subtest: wait-all-for-submit-snapshot
[230.967080] Subtest wait-all-for-submit-snapshot: SUCCESS (0.081s)
[231.039344] [037/133] (802s left) kms_psr2_sf (pr-overlay-plane-update-sf-dmg-area)
[231.138819] Starting subtest: pr-overlay-plane-update-sf-dmg-area
[231.140488] Subtest pr-overlay-plane-update-sf-dmg-area: SKIP (0.000s)
[231.219146] [038/133] (802s left) syncobj_wait (single-wait-for-submit-submitted)
[231.278287] Starting subtest: single-wait-for-submit-submitted
[231.386181] Subtest single-wait-for-submit-submitted: SUCCESS (0.107s)
[231.471093] [039/133] (802s left) vgem_basic (mmap)
[231.513778] Starting subtest: mmap
[231.521742] Subtest mmap: SUCCESS (0.008s)
[231.604988] [040/133] (801s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-mmap-cpu)
[231.693129] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-mmap-cpu
[231.694915] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[231.785860] [041/133] (801s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-mmap-gtt)
[231.873403] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-mmap-gtt
[231.875222] Subtest psr-2p-scndscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[231.955435] [042/133] (801s left) kms_getfb (getfb2-handle-closed)
[232.039589] Starting subtest: getfb2-handle-closed
[232.040424] Subtest getfb2-handle-closed: SUCCESS (0.000s)
[232.142756] [043/133] (801s left) gem_mmap_gtt (basic-small-copy-xy)
[232.191682] Subtest basic-small-copy-XY: SKIP (0.000s)
[232.239995] [044/133] (801s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-mmap-gtt)
[232.320472] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-mmap-gtt
[232.322004] Subtest fbc-1p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[232.411818] [045/133] (801s left) kms_rotation_crc (sprite-rotation-270)
[232.486966] Starting subtest: sprite-rotation-270
[232.488677] Subtest sprite-rotation-270: SKIP (0.001s)
[232.555573] [046/133] (801s left) kms_psr (psr2-primary-render)
[232.633587] Starting subtest: psr2-primary-render
[232.634583] Starting dynamic subtest: eDP-1
[234.375597] Dynamic subtest eDP-1: SUCCESS (1.742s)
[234.376486] Subtest psr2-primary-render: SUCCESS (1.743s)
[235.216658] [047/133] (798s left) gem_ctx_shared (create-shared-gtt)
[235.287782] Starting subtest: create-shared-gtt
[237.484767] Subtest create-shared-gtt: SUCCESS (2.152s)
[237.749385] [048/133] (796s left) kms_async_flips (async-flip-with-page-flip-events-linear)
[237.842363] Starting subtest: async-flip-with-page-flip-events-linear
[238.222573] Starting dynamic subtest: pipe-A-eDP-1
[240.965091] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.733s)
[241.325873] Starting dynamic subtest: pipe-B-eDP-1
[244.059262] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.731s)
[244.412653] Starting dynamic subtest: pipe-C-eDP-1
[247.160532] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.745s)
[247.522945] Starting dynamic subtest: pipe-D-eDP-1
[250.262902] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.737s)
[250.264555] Subtest async-flip-with-page-flip-events-linear: SUCCESS (12.411s)
[251.418082] [049/133] (782s left) kms_plane (pixel-format-linear-modifier)
[251.501473] Starting subtest: pixel-format-linear-modifier
[251.528522] Starting dynamic subtest: pipe-A-plane-0
[255.139858] Dynamic subtest pipe-A-plane-0: SUCCESS (3.611s)
[255.147713] Starting dynamic subtest: pipe-A-plane-3
[256.851180] Dynamic subtest pipe-A-plane-3: SUCCESS (1.710s)
[256.859204] Starting dynamic subtest: pipe-A-plane-5
[257.062268] Dynamic subtest pipe-A-plane-5: SUCCESS (0.210s)
[258.174200] Starting dynamic subtest: pipe-B-plane-0
[261.688382] Dynamic subtest pipe-B-plane-0: SUCCESS (3.522s)
[261.696300] Starting dynamic subtest: pipe-B-plane-3
[263.355288] Dynamic subtest pipe-B-plane-3: SUCCESS (1.666s)
[263.365562] Starting dynamic subtest: pipe-B-plane-5
[263.566256] Dynamic subtest pipe-B-plane-5: SUCCESS (0.210s)
[263.886270] Subtest pixel-format-linear-modifier: SUCCESS (12.385s)
[264.700030] [050/133] (769s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-64bpp-ytile-upscaling)
[264.784793] Starting subtest: flip-32bpp-ytile-to-64bpp-ytile-upscaling
[264.786740] Subtest flip-32bpp-ytile-to-64bpp-ytile-upscaling: SKIP (0.000s)
[264.869822] [051/133] (769s left) kms_flip_scaled_crc (flip-32bpp-4tile-to-64bpp-4tile-downscaling)
[264.969674] Starting subtest: flip-32bpp-4tile-to-64bpp-4tile-downscaling
[264.970604] Starting dynamic subtest: pipe-A-default-mode
[266.140794] Dynamic subtest pipe-A-default-mode: SKIP (1.169s)
[266.142471] Subtest flip-32bpp-4tile-to-64bpp-4tile-downscaling: SKIP (1.171s)
[266.291354] [052/133] (767s left) gem_exec_balancer (full-late-pulse)
[266.355831] Starting subtest: full-late-pulse
[270.859412] Subtest full-late-pulse: SUCCESS (4.503s)
[271.233599] [053/133] (762s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-0-hflip)
[271.353999] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-0-hflip
[272.399654] Subtest x-tiled-max-hw-stride-32bpp-rotate-0-hflip: SUCCESS (1.046s)
[272.518209] [054/133] (761s left) kms_chamelium_color (degamma)
[272.612961] Subtest degamma: SKIP (0.000s)
[272.652929] [055/133] (761s left) perf_pmu (init-sema)
[272.692328] Starting subtest: init-sema
[272.693057] Starting dynamic subtest: rcs0
[272.695083] Dynamic subtest rcs0: SUCCESS (0.003s)
[272.704948] Starting dynamic subtest: bcs0
[272.705805] Dynamic subtest bcs0: SUCCESS (0.001s)
[272.715385] Starting dynamic subtest: vcs0
[272.716127] Dynamic subtest vcs0: SUCCESS (0.001s)
[272.723761] Starting dynamic subtest: vcs1
[272.724562] Dynamic subtest vcs1: SUCCESS (0.001s)
[272.732155] Starting dynamic subtest: vecs0
[272.732929] Dynamic subtest vecs0: SUCCESS (0.003s)
[272.740639] Starting dynamic subtest: ccs0
[272.741409] Dynamic subtest ccs0: SUCCESS (0.001s)
[272.742116] Subtest init-sema: SUCCESS (0.022s)
[272.815411] [056/133] (761s left) kms_psr (fbc-pr-primary-page-flip)
[272.899393] Starting subtest: fbc-pr-primary-page-flip
[272.901070] Subtest fbc-pr-primary-page-flip: SKIP (0.000s)
[272.982089] [057/133] (761s left) kms_psr2_sf (psr2-overlay-plane-move-continuous-exceed-sf)
[273.066555] Starting subtest: psr2-overlay-plane-move-continuous-exceed-sf
[273.067290] Starting dynamic subtest: pipe-A-eDP-1
[284.379960] Dynamic subtest pipe-A-eDP-1: SUCCESS (11.312s)
[284.388601] Starting dynamic subtest: pipe-B-eDP-1
[296.398992] Dynamic subtest pipe-B-eDP-1: SUCCESS (12.017s)
[296.400037] Subtest psr2-overlay-plane-move-continuous-exceed-sf: SUCCESS (23.332s)
[297.204742] [058/133] (737s left) gem_exec_reloc (basic-gtt-cpu)
[297.263502] Subtest basic-gtt-cpu: SKIP (0.000s)
[297.325169] [059/133] (736s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-pwrite)
[297.419577] Starting subtest: psr-2p-primscrn-spr-indfb-draw-pwrite
[297.421310] Subtest psr-2p-primscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[297.528959] [060/133] (736s left) syncobj_timeline (multi-wait-submitted-signaled)
[297.579582] Starting subtest: multi-wait-submitted-signaled
[297.580605] Subtest multi-wait-submitted-signaled: SUCCESS (0.001s)
[297.681058] [061/133] (736s left) kms_selftest (drm_format)
[297.723846] Starting subtest: drm_format
[297.769589] Starting dynamic subtest: drm_test_format_block_width_invalid
[297.861680] Dynamic subtest drm_test_format_block_width_invalid: SUCCESS (0.092s)
[297.871801] Starting dynamic subtest: drm_test_format_block_width_one_plane
[297.959648] Dynamic subtest drm_test_format_block_width_one_plane: SUCCESS (0.095s)
[297.968573] Starting dynamic subtest: drm_test_format_block_width_two_plane
[298.036206] Dynamic subtest drm_test_format_block_width_two_plane: SUCCESS (0.077s)
[298.045482] Starting dynamic subtest: drm_test_format_block_width_three_plane
[298.142838] Dynamic subtest drm_test_format_block_width_three_plane: SUCCESS (0.106s)
[298.152140] Starting dynamic subtest: drm_test_format_block_width_tiled
[298.234909] Dynamic subtest drm_test_format_block_width_tiled: SUCCESS (0.090s)
[298.242632] Starting dynamic subtest: drm_test_format_block_height_invalid
[298.327402] Dynamic subtest drm_test_format_block_height_invalid: SUCCESS (0.092s)
[298.336780] Starting dynamic subtest: drm_test_format_block_height_one_plane
[298.425619] Dynamic subtest drm_test_format_block_height_one_plane: SUCCESS (0.098s)
[298.435217] Starting dynamic subtest: drm_test_format_block_height_two_plane
[298.513722] Dynamic subtest drm_test_format_block_height_two_plane: SUCCESS (0.087s)
[298.523138] Starting dynamic subtest: drm_test_format_block_height_three_plane
[298.595641] Dynamic subtest drm_test_format_block_height_three_plane: SUCCESS (0.081s)
[298.605182] Starting dynamic subtest: drm_test_format_block_height_tiled
[298.682093] Dynamic subtest drm_test_format_block_height_tiled: SUCCESS (0.086s)
[298.693984] Starting dynamic subtest: drm_test_format_min_pitch_invalid
[298.773613] Dynamic subtest drm_test_format_min_pitch_invalid: SUCCESS (0.090s)
[298.783321] Starting dynamic subtest: drm_test_format_min_pitch_one_plane_8bpp
[298.873816] Dynamic subtest drm_test_format_min_pitch_one_plane_8bpp: SUCCESS (0.099s)
[298.883849] Starting dynamic subtest: drm_test_format_min_pitch_one_plane_16bpp
[298.969744] Dynamic subtest drm_test_format_min_pitch_one_plane_16bpp: SUCCESS (0.096s)
[298.979534] Starting dynamic subtest: drm_test_format_min_pitch_one_plane_24bpp
[299.062688] Dynamic subtest drm_test_format_min_pitch_one_plane_24bpp: SUCCESS (0.093s)
[299.072384] Starting dynamic subtest: drm_test_format_min_pitch_one_plane_32bpp
[299.161657] Dynamic subtest drm_test_format_min_pitch_one_plane_32bpp: SUCCESS (0.095s)
[299.170445] Starting dynamic subtest: drm_test_format_min_pitch_two_plane
[299.249856] Dynamic subtest drm_test_format_min_pitch_two_plane: SUCCESS (0.088s)
[299.260038] Starting dynamic subtest: drm_test_format_min_pitch_three_plane_8bpp
[299.333754] Dynamic subtest drm_test_format_min_pitch_three_plane_8bpp: SUCCESS (0.082s)
[299.342757] Starting dynamic subtest: drm_test_format_min_pitch_tiled
[299.431121] Dynamic subtest drm_test_format_min_pitch_tiled: SUCCESS (0.095s)
[299.432223] Subtest drm_format: SUCCESS (1.708s)
[299.591725] [062/133] (734s left) gen9_exec_parse (batch-zero-length)
[299.656210] Subtest batch-zero-length: SKIP (0.000s)
[299.721631] [063/133] (734s left) kms_flip (nonblocking-read)
[299.817800] Starting subtest: nonblocking-read
[299.818728] Subtest nonblocking-read: SUCCESS (0.000s)
[299.910822] [064/133] (734s left) kms_frontbuffer_tracking (psr-1p-primscrn-indfb-pgflip-blt)
[300.003940] Starting subtest: psr-1p-primscrn-indfb-pgflip-blt
[307.309156] Subtest psr-1p-primscrn-indfb-pgflip-blt: SUCCESS (7.305s)
[307.428454] [065/133] (727s left) kms_frontbuffer_tracking (fbcpsr-modesetfrombusy)
[307.522982] Starting subtest: fbcpsr-modesetfrombusy
[313.637725] Subtest fbcpsr-modesetfrombusy: SUCCESS (6.114s)
[313.785850] [066/133] (720s left) kms_flip (basic-flip-vs-modeset)
[313.880785] Starting subtest: basic-flip-vs-modeset
[313.881841] Starting dynamic subtest: A-eDP1
[316.430417] Dynamic subtest A-eDP1: SUCCESS (2.548s)
[316.438683] Starting dynamic subtest: B-eDP1
[318.627528] Dynamic subtest B-eDP1: SUCCESS (2.196s)
[318.635693] Starting dynamic subtest: C-eDP1
[320.837614] Dynamic subtest C-eDP1: SUCCESS (2.209s)
[320.845981] Starting dynamic subtest: D-eDP1
[323.036355] Dynamic subtest D-eDP1: SUCCESS (2.198s)
[323.038289] Subtest basic-flip-vs-modeset: SUCCESS (9.159s)
[323.894665] [067/133] (710s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-mmap-wc)
[323.996700] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-mmap-wc
[330.680524] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-mmap-wc: SUCCESS (6.683s)
[330.812797] [068/133] (703s left) kms_big_fb (y-tiled-8bpp-rotate-180)
[330.916392] Starting subtest: y-tiled-8bpp-rotate-180
[330.918250] Subtest y-tiled-8bpp-rotate-180: SKIP (0.000s)
[331.005696] [069/133] (703s left) kms_chamelium_hpd (vga-hpd-without-ddc)
[331.412362] Subtest vga-hpd-without-ddc: SKIP (0.000s)
[332.186915] [070/133] (702s left) api_intel_allocator (standalone)
[332.243721] Starting subtest: standalone
[332.259289] Subtest standalone: SUCCESS (0.017s)
[332.385813] [071/133] (702s left) kms_plane_scaling (plane-scaler-unity-scaling-with-modifiers)
[332.480494] Starting subtest: plane-scaler-unity-scaling-with-modifiers
[332.481322] Starting dynamic subtest: pipe-A
[332.852800] Dynamic subtest pipe-A: SUCCESS (0.372s)
[332.862812] Starting dynamic subtest: pipe-B
[334.255405] Dynamic subtest pipe-B: SUCCESS (1.400s)
[334.263821] Starting dynamic subtest: pipe-C
[335.729390] Dynamic subtest pipe-C: SUCCESS (1.473s)
[335.739011] Starting dynamic subtest: pipe-D
[337.197902] Dynamic subtest pipe-D: SUCCESS (1.467s)
[337.200532] Subtest plane-scaler-unity-scaling-with-modifiers: SUCCESS (4.719s)
[338.401195] [072/133] (696s left) gem_exec_whisper (basic-fds-forked)
[338.455763] Starting subtest: basic-fds-forked
[362.379985] Subtest basic-fds-forked: SUCCESS (23.922s)
[362.562237] [073/133] (672s left) kms_color (ctm-0-75)
[362.653637] Starting subtest: ctm-0-75
[362.654367] Starting dynamic subtest: pipe-A-eDP-1
[367.541454] Dynamic subtest pipe-A-eDP-1: SUCCESS (4.887s)
[367.550664] Starting dynamic subtest: pipe-B-eDP-1
[373.148737] Dynamic subtest pipe-B-eDP-1: SUCCESS (5.607s)
[373.166394] Starting dynamic subtest: pipe-C-eDP-1
[378.505674] Dynamic subtest pipe-C-eDP-1: SUCCESS (5.354s)
[378.513947] Starting dynamic subtest: pipe-D-eDP-1
[383.899387] Dynamic subtest pipe-D-eDP-1: SUCCESS (5.394s)
[383.900292] Subtest ctm-0-75: SUCCESS (21.245s)
[384.692462] [074/133] (650s left) gem_pxp (create-protected-buffer)
[384.812757] Starting subtest: create-protected-buffer
[384.814165] Subtest create-protected-buffer: SUCCESS (0.000s)
[384.923664] [075/133] (649s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-render)
[385.014651] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-render
[385.016295] Subtest fbc-2p-scndscrn-cur-indfb-draw-render: SKIP (0.000s)
[385.109027] [076/133] (649s left) kms_cursor_legacy (modeset-atomic-cursor-hotspot)
[385.229616] Starting subtest: modeset-atomic-cursor-hotspot
[385.231259] Subtest modeset-atomic-cursor-hotspot: SKIP (0.000s)
[385.381725] [077/133] (649s left) gem_ctx_exec (basic-close-race)
[385.427950] Starting subtest: basic-close-race
[391.381962] Subtest basic-close-race: SUCCESS (5.908s)
[391.464332] [078/133] (643s left) gem_exec_whisper (basic-sync)
[391.518076] Starting subtest: basic-sync
[400.475414] Subtest basic-sync: SUCCESS (8.946s)
[400.660602] [079/133] (634s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-indfb-plflip-blt)
[400.747832] Starting subtest: fbcpsr-2p-scndscrn-indfb-plflip-blt
[400.749637] Subtest fbcpsr-2p-scndscrn-indfb-plflip-blt: SKIP (0.000s)
[400.834760] [080/133] (634s left) gem_ctx_shared (exec-single-timeline)
[400.897966] Starting subtest: exec-single-timeline
[400.898896] Starting dynamic subtest: rcs0
[401.940145] Dynamic subtest rcs0: SUCCESS (1.032s)
[401.952469] Starting dynamic subtest: bcs0
[402.963635] Dynamic subtest bcs0: SUCCESS (1.020s)
[402.974275] Starting dynamic subtest: vcs0
[403.988060] Dynamic subtest vcs0: SUCCESS (1.022s)
[404.002201] Starting dynamic subtest: vcs1
[405.076592] Dynamic subtest vcs1: SUCCESS (1.087s)
[405.086784] Starting dynamic subtest: vecs0
[406.164353] Dynamic subtest vecs0: SUCCESS (1.085s)
[406.175580] Starting dynamic subtest: ccs0
[407.252031] Dynamic subtest ccs0: SUCCESS (1.085s)
[407.253131] Subtest exec-single-timeline: SUCCESS (6.346s)
[407.433061] [081/133] (627s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling)
[407.526485] Starting subtest: flip-64bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling
[407.536185] Subtest flip-64bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling: SKIP (0.000s)
[407.608859] [082/133] (627s left) kms_vblank (query-forked)
[407.702806] Starting subtest: query-forked
[407.703713] Starting dynamic subtest: pipe-A-eDP-1
[409.529122] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.826s)
[409.538997] Starting dynamic subtest: pipe-D-eDP-1
[412.067773] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.535s)
[412.068627] Subtest query-forked: SUCCESS (4.365s)
[412.902087] [083/133] (622s left) gem_linear_blits (interruptible)
[413.469192] Starting subtest: interruptible
[417.907606] Subtest interruptible: SUCCESS (4.429s)
[418.084718] [084/133] (617s left) gem_exec_schedule (pi-ringfull)
[418.318442] Starting subtest: pi-ringfull
[418.319373] Starting dynamic subtest: rcs0
[418.353582] Dynamic subtest rcs0: SUCCESS (0.044s)
[418.366260] Starting dynamic subtest: bcs0
[418.398523] Dynamic subtest bcs0: SUCCESS (0.044s)
[418.414393] Starting dynamic subtest: vcs0
[418.441100] Dynamic subtest vcs0: SUCCESS (0.041s)
[418.457275] Starting dynamic subtest: vcs1
[418.480928] Dynamic subtest vcs1: SUCCESS (0.039s)
[418.498657] Starting dynamic subtest: vecs0
[418.517195] Dynamic subtest vecs0: SUCCESS (0.035s)
[418.534195] Starting dynamic subtest: ccs0
[418.551583] Dynamic subtest ccs0: SUCCESS (0.034s)
[418.552431] Subtest pi-ringfull: SUCCESS (0.243s)
[418.782626] [085/133] (616s left) gem_mmap_offset (bad-extensions)
[418.831977] Starting subtest: bad-extensions
[418.832884] Subtest bad-extensions: SUCCESS (0.000s)
[418.928460] [086/133] (616s left) kms_plane_multiple (tiling-x)
[419.023193] Starting subtest: tiling-x
[419.025102] Starting dynamic subtest: pipe-A-eDP-1
[422.833893] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.808s)
[422.843763] Starting dynamic subtest: pipe-B-eDP-1
[427.422451] Dynamic subtest pipe-B-eDP-1: SUCCESS (4.587s)
[427.434175] Starting dynamic subtest: pipe-C-eDP-1
[432.010291] Dynamic subtest pipe-C-eDP-1: SUCCESS (4.587s)
[432.020101] Starting dynamic subtest: pipe-D-eDP-1
[436.625117] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.611s)
[436.625978] Subtest tiling-x: SUCCESS (17.600s)
[437.487338] [087/133] (597s left) gem_render_copy (yf-tiled-ccs-to-yf-tiled-ccs)
[437.540617] Starting subtest: yf-tiled-ccs-to-yf-tiled-ccs
[437.542480] Subtest yf-tiled-ccs-to-yf-tiled-ccs: SKIP (0.000s)
[437.719869] [088/133] (597s left) kms_content_protection (dp-mst-type-0-hdcp14)
[437.867714] Starting subtest: dp-mst-type-0-hdcp14
[437.869712] Subtest dp-mst-type-0-hdcp14: SKIP (0.000s)
[437.985860] [089/133] (597s left) i915_drm_fdinfo (virtual-busy-all)
[438.033747] Starting subtest: virtual-busy-all
[438.035732] Subtest virtual-busy-all: SKIP (0.000s)
[438.101182] [090/133] (597s left) gem_exec_params (sol-reset-not-gen7)
[438.158745] Starting subtest: sol-reset-not-gen7
[438.161491] Subtest sol-reset-not-gen7: SUCCESS (0.002s)
[438.275297] [091/133] (597s left) kms_ccs (crc-primary-rotation-180-4-tiled-mtl-mc-ccs)
[438.354399] Starting subtest: crc-primary-rotation-180-4-tiled-mtl-mc-ccs
[438.355186] Starting dynamic subtest: pipe-A-eDP-1
[440.639095] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.284s)
[440.649580] Starting dynamic subtest: pipe-B-eDP-1
[443.074480] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.434s)
[443.084139] Starting dynamic subtest: pipe-C-eDP-1
[445.162603] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.087s)
[445.172851] Starting dynamic subtest: pipe-D-eDP-1
[447.269173] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.105s)
[447.270193] Subtest crc-primary-rotation-180-4-tiled-mtl-mc-ccs: SUCCESS (8.915s)
[448.498092] [092/133] (586s left) syncobj_timeline (single-wait-all-for-submit-available-submitted)
[448.560097] Starting subtest: single-wait-all-for-submit-available-submitted
[448.561162] Subtest single-wait-all-for-submit-available-submitted: SUCCESS (0.000s)
[448.667194] [093/133] (586s left) kms_psr (fbc-psr-cursor-render)
[448.760742] Starting subtest: fbc-psr-cursor-render
[448.761642] Starting dynamic subtest: eDP-1
[448.763473] Dynamic subtest eDP-1: SKIP (0.000s)
[448.765038] Subtest fbc-psr-cursor-render: SKIP (0.001s)
[448.842790] [094/133] (586s left) gem_exec_reloc (basic-range-active)
[448.893260] Subtest basic-range-active: SKIP (0.000s)
[448.958661] [095/133] (586s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-180)
[449.052104] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-180
[449.054036] Subtest yf-tiled-max-hw-stride-32bpp-rotate-180: SKIP (0.000s)
[449.136971] [096/133] (586s left) kms_big_fb (linear-max-hw-stride-64bpp-rotate-0)
[449.245144] Starting subtest: linear-max-hw-stride-64bpp-rotate-0
[450.257075] Subtest linear-max-hw-stride-64bpp-rotate-0: SUCCESS (1.012s)
[450.379404] [097/133] (585s left) gem_busy (extended)
[450.578053] Starting subtest: extended
[450.579334] Starting dynamic subtest: rcs0
[450.648844] Dynamic subtest rcs0: SUCCESS (0.077s)
[450.662656] Starting dynamic subtest: bcs0
[450.691250] Dynamic subtest bcs0: SUCCESS (0.041s)
[450.702066] Starting dynamic subtest: vcs0
[451.960732] Dynamic subtest vcs0: SUCCESS (1.256s)
[451.971588] Starting dynamic subtest: vcs1
[453.945094] Dynamic subtest vcs1: SUCCESS (1.981s)
[453.956061] Starting dynamic subtest: vecs0
[455.928967] Dynamic subtest vecs0: SUCCESS (1.981s)
[455.939514] Starting dynamic subtest: ccs0
[455.965858] Dynamic subtest ccs0: SUCCESS (0.045s)
[455.968605] Subtest extended: SUCCESS (5.395s)
[456.206708] [098/133] (579s left) kms_ccs (bad-rotation-90-4-tiled-dg2-mc-ccs)
[456.298366] Starting subtest: bad-rotation-90-4-tiled-dg2-mc-ccs
[456.299284] Starting dynamic subtest: pipe-A-eDP-1
[456.307907] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[456.317095] Starting dynamic subtest: pipe-B-eDP-1
[456.325023] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[456.334161] Starting dynamic subtest: pipe-C-eDP-1
[456.341842] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[456.349987] Starting dynamic subtest: pipe-D-eDP-1
[456.357939] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[456.359582] Subtest bad-rotation-90-4-tiled-dg2-mc-ccs: SKIP (0.005s)
[458.490576] [099/133] (577s left) gem_flink_basic (basic)
[458.546731] Starting subtest: basic
[458.547683] Subtest basic: SUCCESS (0.000s)
[458.645900] [100/133] (577s left) perf_pmu (busy-check-all)
[458.677166] Starting subtest: busy-check-all
[458.678172] Starting dynamic subtest: rcs0
[459.227208] Dynamic subtest rcs0: SUCCESS (0.550s)
[459.239935] Starting dynamic subtest: bcs0
[459.776595] Dynamic subtest bcs0: SUCCESS (0.547s)
[459.789141] Starting dynamic subtest: vcs0
[460.917723] Dynamic subtest vcs0: SUCCESS (1.130s)
[460.927722] Starting dynamic subtest: vcs1
[462.902888] Dynamic subtest vcs1: SUCCESS (1.983s)
[462.912641] Starting dynamic subtest: vecs0
[464.951622] Dynamic subtest vecs0: SUCCESS (2.045s)
[464.961073] Starting dynamic subtest: ccs0
[465.501054] Dynamic subtest ccs0: SUCCESS (0.556s)
[465.504094] Subtest busy-check-all: SUCCESS (6.825s)
[465.599935] [101/133] (570s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-move)
[465.714177] Starting subtest: fbc-1p-primscrn-spr-indfb-move
[469.985738] Subtest fbc-1p-primscrn-spr-indfb-move: SUCCESS (4.272s)
[471.108933] [102/133] (564s left) syncobj_wait (invalid-reset-illegal-handle)
[471.169088] Starting subtest: invalid-reset-illegal-handle
[471.170103] Subtest invalid-reset-illegal-handle: SUCCESS (0.000s)
[471.254995] [103/133] (564s left) gem_render_copy (y-tiled-mc-ccs-to-vebox-y-tiled)
[471.304077] Starting subtest: y-tiled-mc-ccs-to-vebox-y-tiled
[471.305770] Subtest y-tiled-mc-ccs-to-vebox-y-tiled: SKIP (0.000s)
[471.483448] [104/133] (564s left) gem_exec_schedule (u-fairslice-all)
[471.544273] Starting subtest: u-fairslice-all
[473.604072] Subtest u-fairslice-all: SUCCESS (2.060s)
[474.998006] [105/133] (560s left) kms_ccs (crc-primary-basic-y-tiled-ccs)
[475.085406] Starting subtest: crc-primary-basic-y-tiled-ccs
[475.087422] Starting dynamic subtest: pipe-A-eDP-1
[475.096524] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[475.110690] Starting dynamic subtest: pipe-B-eDP-1
[475.119257] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[475.131739] Starting dynamic subtest: pipe-C-eDP-1
[475.139791] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[475.148340] Starting dynamic subtest: pipe-D-eDP-1
[475.156481] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[475.158120] Subtest crc-primary-basic-y-tiled-ccs: SKIP (0.013s)
[477.384703] [106/133] (558s left) i915_query (query-regions-sanity-check)
[477.445471] Starting subtest: query-regions-sanity-check
[477.454662] Subtest query-regions-sanity-check: SUCCESS (0.011s)
[477.556521] [107/133] (558s left) syncobj_timeline (invalid-query-one-illegal-handle)
[477.611226] Starting subtest: invalid-query-one-illegal-handle
[477.612263] Subtest invalid-query-one-illegal-handle: SUCCESS (0.000s)
[477.710885] [108/133] (558s left) kms_pm_dc (dc5-retention-flops)
[478.799695] Starting subtest: dc5-retention-flops
[478.801428] Subtest dc5-retention-flops: SKIP (0.000s)
[478.868461] [109/133] (557s left) gem_exec_fence (keep-in-fence)
[479.046471] Starting subtest: keep-in-fence
[479.047515] Starting dynamic subtest: rcs0
[479.093163] Dynamic subtest rcs0: SUCCESS (0.054s)
[479.105110] Starting dynamic subtest: bcs0
[479.146641] Dynamic subtest bcs0: SUCCESS (0.051s)
[479.158781] Starting dynamic subtest: vcs0
[480.951938] Dynamic subtest vcs0: SUCCESS (1.794s)
[480.963471] Starting dynamic subtest: vcs1
[482.936575] Dynamic subtest vcs1: SUCCESS (1.981s)
[482.947877] Starting dynamic subtest: vecs0
[484.920794] Dynamic subtest vecs0: SUCCESS (1.982s)
[484.931957] Starting dynamic subtest: ccs0
[485.140095] Dynamic subtest ccs0: SUCCESS (0.225s)
[485.141428] Subtest keep-in-fence: SUCCESS (6.102s)
[487.048471] [110/133] (548s left) kms_ccs (crc-sprite-planes-basic-4-tiled-mtl-rc-ccs-cc)
[487.143066] Starting subtest: crc-sprite-planes-basic-4-tiled-mtl-rc-ccs-cc
[487.143923] Starting dynamic subtest: pipe-A-eDP-1
[487.596140] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.443s)
[487.605259] Starting dynamic subtest: pipe-B-eDP-1
[489.015881] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.418s)
[489.026228] Starting dynamic subtest: pipe-C-eDP-1
[490.416316] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.396s)
[490.428712] Starting dynamic subtest: pipe-D-eDP-1
[491.812007] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.396s)
[491.812798] Subtest crc-sprite-planes-basic-4-tiled-mtl-rc-ccs-cc: SUCCESS (4.660s)
[492.984866] [111/133] (543s left) gem_vm_create (invalid-create)
[493.043159] Starting subtest: invalid-create
[493.045531] Subtest invalid-create: SUCCESS (0.002s)
[493.184175] [112/133] (542s left) i915_pm_rpm (debugfs-forcewake-user)
[495.108965] Starting subtest: debugfs-forcewake-user
[506.498860] Subtest debugfs-forcewake-user: SUCCESS (11.391s)
[506.863653] [113/133] (529s left) kms_cursor_crc (cursor-rapid-movement-512x170)
[507.149177] Starting subtest: cursor-rapid-movement-512x170
[507.151128] Subtest cursor-rapid-movement-512x170: SKIP (0.001s)
[507.292140] [114/133] (528s left) gem_mmap_gtt (cpuset-basic-small-copy-xy)
[507.339823] Subtest cpuset-basic-small-copy-XY: SKIP (0.000s)
[507.393883] [115/133] (528s left) syncobj_timeline (invalid-multi-wait-all-unsubmitted-submitted)
[507.437639] Starting subtest: invalid-multi-wait-all-unsubmitted-submitted
[507.438511] Subtest invalid-multi-wait-all-unsubmitted-submitted: SUCCESS (0.000s)
[507.534106] [116/133] (528s left) gem_softpin (full)
[507.581488] Starting subtest: full
[507.589169] Subtest full: SUCCESS (0.008s)
[507.710920] [117/133] (528s left) prime_busy (hang-wait)
[507.767589] Starting subtest: hang-wait
[507.770069] Starting dynamic subtest: rcs0
[533.386482] Dynamic subtest rcs0: SUCCESS (25.614s)
[533.396580] Starting dynamic subtest: bcs0
[540.541291] Dynamic subtest bcs0: SUCCESS (7.153s)
[540.550854] Starting dynamic subtest: vcs0
[547.581889] Dynamic subtest vcs0: SUCCESS (7.037s)
[547.592320] Starting dynamic subtest: vcs1
[554.556067] Dynamic subtest vcs1: SUCCESS (6.973s)
[554.564919] Starting dynamic subtest: vecs0
[561.596302] Dynamic subtest vecs0: SUCCESS (7.035s)
[561.605516] Starting dynamic subtest: ccs0
[575.368764] Dynamic subtest ccs0: SUCCESS (13.771s)
[575.370078] Subtest hang-wait: SUCCESS (67.597s)
[575.480503] [118/133] (460s left) kms_pipe_stress (stress-xrgb8888-xtiled)
[575.577208] Starting subtest: stress-xrgb8888-xtiled
[581.382842] Subtest stress-xrgb8888-xtiled: SUCCESS (5.806s)
[581.435575] [119/133] (454s left) kms_psr (pr-dpms)
[581.529452] Starting subtest: pr-dpms
[581.531112] Subtest pr-dpms: SKIP (0.000s)
[581.612422] [120/133] (454s left) gem_ctx_exec (basic-norecovery)
[581.662568] Starting subtest: basic-norecovery
[581.981924] Subtest basic-norecovery: SUCCESS (0.320s)
[582.122432] [121/133] (454s left) kms_cursor_crc (cursor-sliding-64x64)
[582.297350] Starting subtest: cursor-sliding-64x64
[582.299683] Starting dynamic subtest: pipe-A-eDP-1
[585.598946] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.299s)
[585.658082] Starting dynamic subtest: pipe-D-eDP-1
[589.424842] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.779s)
[589.425748] Subtest cursor-sliding-64x64: SUCCESS (7.127s)
[590.284100] [122/133] (446s left) kms_cursor_crc (cursor-onscreen-128x128)
[590.518657] Starting subtest: cursor-onscreen-128x128
[590.522773] Starting dynamic subtest: pipe-A-eDP-1
[592.620407] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.097s)
[592.649767] Starting dynamic subtest: pipe-D-eDP-1
[595.462909] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.821s)
[595.463911] Subtest cursor-onscreen-128x128: SUCCESS (4.944s)
[596.280395] [123/133] (440s left) kms_atomic (plane-invalid-params-fence)
[596.365322] Starting subtest: plane-invalid-params-fence
[596.366112] Starting dynamic subtest: pipe-A-eDP-1
[596.739122] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.372s)
[596.740013] Subtest plane-invalid-params-fence: SUCCESS (0.373s)
[597.582844] [124/133] (439s left) core_setmaster (master-drop-set-user)
[597.668178] Starting subtest: master-drop-set-user
[597.680068] Subtest master-drop-set-user: SUCCESS (0.013s)
[597.710738] [125/133] (438s left) kms_addfb_basic (unused-handle)
[597.773917] Starting subtest: unused-handle
[597.774843] Subtest unused-handle: SUCCESS (0.000s)
[597.902725] [126/133] (438s left) syncobj_wait (wait-any-complex)
[597.959003] Starting subtest: wait-any-complex
[598.022700] Subtest wait-any-complex: SUCCESS (0.063s)
[598.094132] [127/133] (438s left) gem_mmap_gtt (basic-small-copy-odd)
[598.133736] Subtest basic-small-copy-odd: SKIP (0.000s)
[598.178250] [128/133] (438s left) kms_psr (psr-dpms)
[598.260063] Starting subtest: psr-dpms
[598.261371] Starting dynamic subtest: eDP-1
[601.249110] Dynamic subtest eDP-1: SUCCESS (2.987s)
[601.249968] Subtest psr-dpms: SUCCESS (2.989s)
[602.073381] [129/133] (434s left) kms_lease (simple-lease)
[602.161867] Starting subtest: simple-lease
[602.162794] Starting dynamic subtest: pipe-A-eDP-1
[602.667773] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.506s)
[602.678269] Starting dynamic subtest: pipe-B-eDP-1
[604.095943] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.425s)
[604.104856] Starting dynamic subtest: pipe-C-eDP-1
[605.503750] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.404s)
[605.514698] Starting dynamic subtest: pipe-D-eDP-1
[606.906912] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.402s)
[606.907861] Subtest simple-lease: SUCCESS (4.744s)
[607.774191] [130/133] (429s left) gem_mmap_wc (invalid-flags)
[607.826635] Subtest invalid-flags: SKIP (0.000s)
[607.881429] [131/133] (428s left) i915_hangman (hangcheck-unterminated)
[607.941515] Starting subtest: hangcheck-unterminated
[619.863570] Subtest hangcheck-unterminated: SUCCESS (11.910s)
[619.982021] [132/133] (416s left) kms_chamelium_color (ctm-negative)
[620.077642] Subtest ctm-negative: SKIP (0.000s)
[620.121619] [133/133] (416s left) kms_properties (get_properties-sanity-atomic)
[620.221684] Starting subtest: get_properties-sanity-atomic
[620.223622] Subtest get_properties-sanity-atomic: SUCCESS (0.002s)
[620.295893] Closing watchdogs
results: parsing output: 0/ for test: gem_exec_params
results: parsing output: 1/ for test: kms_flip
results: parsing output: 2/ for test: gem_exec_balancer
results: parsing output: 3/ for test: syncobj_wait
results: parsing output: 4/ for test: kms_atomic_transition
results: parsing output: 5/ for test: kms_cursor_legacy
results: parsing output: 6/ for test: gem_create
results: parsing output: 7/ for test: sysfs_heartbeat_interval
results: parsing output: 8/ for test: kms_big_fb
results: parsing output: 9/ for test: gem_workarounds
results: parsing output: 10/ for test: kms_prop_blob
results: parsing output: 11/ for test: kms_frontbuffer_tracking
results: parsing output: 12/ for test: gem_exec_flush
results: parsing output: 13/ for test: gem_exec_reloc
results: parsing output: 14/ for test: core_getclient
results: parsing output: 15/ for test: prime_vgem
results: parsing output: 16/ for test: kms_big_fb
results: parsing output: 17/ for test: kms_plane_scaling
results: parsing output: 18/ for test: kms_pm_rpm
results: parsing output: 19/ for test: kms_draw_crc
results: parsing output: 20/ for test: kms_frontbuffer_tracking
results: parsing output: 21/ for test: gem_set_tiling_vs_gtt
results: parsing output: 22/ for test: kms_frontbuffer_tracking
results: parsing output: 23/ for test: kms_hdmi_inject
results: parsing output: 24/ for test: kms_frontbuffer_tracking
results: parsing output: 25/ for test: kms_busy
results: parsing output: 26/ for test: gem_exec_fence
results: parsing output: 27/ for test: syncobj_timeline
results: parsing output: 28/ for test: kms_flip
results: parsing output: 29/ for test: kms_frontbuffer_tracking
results: parsing output: 30/ for test: kms_cursor_legacy
results: parsing output: 31/ for test: perf
results: parsing output: 32/ for test: kms_joiner
results: parsing output: 33/ for test: kms_frontbuffer_tracking
results: parsing output: 34/ for test: gem_exec_flush
results: parsing output: 35/ for test: syncobj_wait
results: parsing output: 36/ for test: kms_psr2_sf
results: parsing output: 37/ for test: syncobj_wait
results: parsing output: 38/ for test: vgem_basic
results: parsing output: 39/ for test: kms_frontbuffer_tracking
results: parsing output: 40/ for test: kms_frontbuffer_tracking
results: parsing output: 41/ for test: kms_getfb
results: parsing output: 42/ for test: gem_mmap_gtt
results: parsing output: 43/ for test: kms_frontbuffer_tracking
results: parsing output: 44/ for test: kms_rotation_crc
results: parsing output: 45/ for test: kms_psr
results: parsing output: 46/ for test: gem_ctx_shared
results: parsing output: 47/ for test: kms_async_flips
results: parsing output: 48/ for test: kms_plane
results: parsing output: 49/ for test: kms_flip_scaled_crc
results: parsing output: 50/ for test: kms_flip_scaled_crc
results: parsing output: 51/ for test: gem_exec_balancer
results: parsing output: 52/ for test: kms_big_fb
results: parsing output: 53/ for test: kms_chamelium_color
results: parsing output: 54/ for test: perf_pmu
results: parsing output: 55/ for test: kms_psr
results: parsing output: 56/ for test: kms_psr2_sf
results: parsing output: 57/ for test: gem_exec_reloc
results: parsing output: 58/ for test: kms_frontbuffer_tracking
results: parsing output: 59/ for test: syncobj_timeline
results: parsing output: 60/ for test: kms_selftest
results: parsing output: 61/ for test: gen9_exec_parse
results: parsing output: 62/ for test: kms_flip
results: parsing output: 63/ for test: kms_frontbuffer_tracking
results: parsing output: 64/ for test: kms_frontbuffer_tracking
results: parsing output: 65/ for test: kms_flip
results: parsing output: 66/ for test: kms_frontbuffer_tracking
results: parsing output: 67/ for test: kms_big_fb
results: parsing output: 68/ for test: kms_chamelium_hpd
results: parsing output: 69/ for test: api_intel_allocator
results: parsing output: 70/ for test: kms_plane_scaling
results: parsing output: 71/ for test: gem_exec_whisper
results: parsing output: 72/ for test: kms_color
results: parsing output: 73/ for test: gem_pxp
results: parsing output: 74/ for test: kms_frontbuffer_tracking
results: parsing output: 75/ for test: kms_cursor_legacy
results: parsing output: 76/ for test: gem_ctx_exec
results: parsing output: 77/ for test: gem_exec_whisper
results: parsing output: 78/ for test: kms_frontbuffer_tracking
results: parsing output: 79/ for test: gem_ctx_shared
results: parsing output: 80/ for test: kms_flip_scaled_crc
results: parsing output: 81/ for test: kms_vblank
results: parsing output: 82/ for test: gem_linear_blits
results: parsing output: 83/ for test: gem_exec_schedule
results: parsing output: 84/ for test: gem_mmap_offset
results: parsing output: 85/ for test: kms_plane_multiple
results: parsing output: 86/ for test: gem_render_copy
results: parsing output: 87/ for test: kms_content_protection
results: parsing output: 88/ for test: i915_drm_fdinfo
results: parsing output: 89/ for test: gem_exec_params
results: parsing output: 90/ for test: kms_ccs
results: parsing output: 91/ for test: syncobj_timeline
results: parsing output: 92/ for test: kms_psr
results: parsing output: 93/ for test: gem_exec_reloc
results: parsing output: 94/ for test: kms_big_fb
results: parsing output: 95/ for test: kms_big_fb
results: parsing output: 96/ for test: gem_busy
results: parsing output: 97/ for test: kms_ccs
results: parsing output: 98/ for test: gem_flink_basic
results: parsing output: 99/ for test: perf_pmu
results: parsing output: 100/ for test: kms_frontbuffer_tracking
results: parsing output: 101/ for test: syncobj_wait
results: parsing output: 102/ for test: gem_render_copy
results: parsing output: 103/ for test: gem_exec_schedule
results: parsing output: 104/ for test: kms_ccs
results: parsing output: 105/ for test: i915_query
results: parsing output: 106/ for test: syncobj_timeline
results: parsing output: 107/ for test: kms_pm_dc
results: parsing output: 108/ for test: gem_exec_fence
results: parsing output: 109/ for test: kms_ccs
results: parsing output: 110/ for test: gem_vm_create
results: parsing output: 111/ for test: i915_pm_rpm
results: parsing output: 112/ for test: kms_cursor_crc
results: parsing output: 113/ for test: gem_mmap_gtt
results: parsing output: 114/ for test: syncobj_timeline
results: parsing output: 115/ for test: gem_softpin
results: parsing output: 116/ for test: prime_busy
results: parsing output: 117/ for test: kms_pipe_stress
results: parsing output: 118/ for test: kms_psr
results: parsing output: 119/ for test: gem_ctx_exec
results: parsing output: 120/ for test: kms_cursor_crc
results: parsing output: 121/ for test: kms_cursor_crc
results: parsing output: 122/ for test: kms_atomic
results: parsing output: 123/ for test: core_setmaster
results: parsing output: 124/ for test: kms_addfb_basic
results: parsing output: 125/ for test: syncobj_wait
results: parsing output: 126/ for test: gem_mmap_gtt
results: parsing output: 127/ for test: kms_psr
results: parsing output: 128/ for test: kms_lease
results: parsing output: 129/ for test: gem_mmap_wc
results: parsing output: 130/ for test: i915_hangman
results: parsing output: 131/ for test: kms_chamelium_color
results: parsing output: 132/ for test: kms_properties
Done.