[60.874566] Initializing watchdogs
[60.874626]   /dev/watchdog0
[60.889981] [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]
[60.894648] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[60.897544] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[60.899483] [001/132] (960s left) kms_psr (fbc-psr-primary-mmap-gtt)
[60.991069] Starting subtest: fbc-psr-primary-mmap-gtt
[60.992091] Starting dynamic subtest: eDP-1
[60.993883] Dynamic subtest eDP-1: SKIP (0.000s)
[60.995826] Subtest fbc-psr-primary-mmap-gtt: SKIP (0.000s)
[61.056196] [002/132] (960s left) kms_cursor_crc (cursor-random-128x128)
[61.252404] Starting subtest: cursor-random-128x128
[61.266000] Starting dynamic subtest: pipe-A-eDP-1
[64.646406] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.379s)
[64.676930] Starting dynamic subtest: pipe-D-eDP-1
[68.923778] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.250s)
[68.924794] Subtest cursor-random-128x128: SUCCESS (7.670s)
[69.733695] [003/132] (951s left) kms_content_protection (uevent-hdcp14)
[69.873088] Starting subtest: uevent-hdcp14
[69.874927] Subtest uevent-hdcp14: SKIP (0.000s)
[69.985528] [004/132] (951s left) kms_psr (fbc-psr-sprite-render)
[70.077390] Starting subtest: fbc-psr-sprite-render
[70.078473] Starting dynamic subtest: eDP-1
[70.080409] Dynamic subtest eDP-1: SKIP (0.000s)
[70.082349] Subtest fbc-psr-sprite-render: SKIP (0.000s)
[70.143374] [005/132] (951s left) syncobj_basic (create-signaled)
[70.199266] Starting subtest: create-signaled
[70.200334] Subtest create-signaled: SUCCESS (0.000s)
[70.296313] [006/132] (951s left) kms_big_fb (x-tiled-64bpp-rotate-180)
[70.395362] Starting subtest: x-tiled-64bpp-rotate-180
[72.063029] Subtest x-tiled-64bpp-rotate-180: SUCCESS (1.668s)
[72.234189] [007/132] (949s left) gem_exec_schedule (u-submit-late-slice)
[72.308452] Starting subtest: u-submit-late-slice
[72.309426] Starting dynamic subtest: rcs0
[72.344716] Dynamic subtest rcs0: SUCCESS (0.036s)
[72.353981] Starting dynamic subtest: bcs0
[72.372853] Dynamic subtest bcs0: SUCCESS (0.028s)
[72.379779] Starting dynamic subtest: vcs0
[72.403043] Dynamic subtest vcs0: SUCCESS (0.030s)
[72.408951] Starting dynamic subtest: vcs1
[72.442396] Dynamic subtest vcs1: SUCCESS (0.039s)
[72.451948] Starting dynamic subtest: vecs0
[72.468949] Dynamic subtest vecs0: SUCCESS (0.026s)
[72.475065] Starting dynamic subtest: ccs0
[72.497372] Dynamic subtest ccs0: SUCCESS (0.028s)
[72.498269] Subtest u-submit-late-slice: SUCCESS (0.189s)
[73.946285] [008/132] (947s left) kms_lease (implicit-plane-lease)
[74.034063] Starting subtest: implicit-plane-lease
[74.036098] Subtest implicit-plane-lease: SUCCESS (0.002s)
[74.136205] [009/132] (947s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-gtt)
[74.221644] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-gtt
[74.223616] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[74.294749] [010/132] (947s left) kms_plane (pixel-format-4-tiled-modifier-source-clamping)
[74.375145] Starting subtest: pixel-format-4-tiled-modifier-source-clamping
[74.402990] Starting dynamic subtest: pipe-A-plane-0
[75.025085] Dynamic subtest pipe-A-plane-0: SUCCESS (0.622s)
[75.031922] Starting dynamic subtest: pipe-A-plane-3
[75.469781] Dynamic subtest pipe-A-plane-3: SUCCESS (0.444s)
[76.631330] Starting dynamic subtest: pipe-B-plane-0
[77.268852] Dynamic subtest pipe-B-plane-0: SUCCESS (0.645s)
[77.277152] Starting dynamic subtest: pipe-B-plane-3
[77.691067] Dynamic subtest pipe-B-plane-3: SUCCESS (0.422s)
[78.000709] Subtest pixel-format-4-tiled-modifier-source-clamping: SUCCESS (3.625s)
[78.800005] [011/132] (942s left) gem_mmap_offset (clear-via-pagefault)
[78.853203] Starting subtest: clear-via-pagefault
[78.854164] Starting dynamic subtest: smem0
[114.658816] Dynamic subtest smem0: SUCCESS (35.757s)
[114.659868] Subtest clear-via-pagefault: SUCCESS (35.758s)
[114.714652] [012/132] (907s left) kms_big_fb (linear-16bpp-rotate-270)
[114.825133] Starting subtest: linear-16bpp-rotate-270
[114.843752] Subtest linear-16bpp-rotate-270: SKIP (0.019s)
[114.950177] [013/132] (906s left) kms_dirtyfb (default-dirtyfb-ioctl)
[115.033199] Starting subtest: default-dirtyfb-ioctl
[115.034075] Starting dynamic subtest: A-eDP-1
[116.617178] Dynamic subtest A-eDP-1: SUCCESS (1.584s)
[116.618098] Subtest default-dirtyfb-ioctl: SUCCESS (1.585s)
[117.439536] [014/132] (904s left) prime_vgem (fence-write-hang)
[117.563809] Subtest fence-write-hang: SKIP (0.000s)
[117.661492] [FACT prime_vgem (fence-write-hang)] new: kernel.kmod_is_loaded.vgem: true
[117.663354] [015/132] (904s left) syncobj_timeline (etime-multi-wait-all-available-unsubmitted-signaled)
[117.722977] Starting subtest: etime-multi-wait-all-available-unsubmitted-signaled
[117.827437] Subtest etime-multi-wait-all-available-unsubmitted-signaled: SUCCESS (0.104s)
[117.911147] [016/132] (903s left) i915_pm_rpm (gem-execbuf-stress)
[120.033805] Starting subtest: gem-execbuf-stress
[120.035334] Starting dynamic subtest: smem0
[132.847568] Dynamic subtest smem0: SUCCESS (12.813s)
[132.857361] Starting dynamic subtest: extra-wait-smem0
[194.704752] Dynamic subtest extra-wait-smem0: SUCCESS (61.846s)
[194.705942] Subtest gem-execbuf-stress: SUCCESS (74.661s)
[195.059412] [017/132] (826s left) gem_lmem_swapping (heavy-random)
[195.103989] Subtest heavy-random: SKIP (0.000s)
[195.146809] [018/132] (826s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-mmap-cpu)
[195.244971] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-mmap-cpu
[201.816561] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-mmap-cpu: SUCCESS (6.573s)
[201.923248] [019/132] (820s left) syncobj_timeline (invalid-multi-wait-unsubmitted-submitted-signaled)
[201.972483] Starting subtest: invalid-multi-wait-unsubmitted-submitted-signaled
[201.973498] Subtest invalid-multi-wait-unsubmitted-submitted-signaled: SUCCESS (0.000s)
[202.061011] [020/132] (819s left) kms_pm_rpm (basic-rte)
[202.104491] Starting subtest: basic-rte
[205.553051] Subtest basic-rte: SUCCESS (3.450s)
[207.366912] [021/132] (814s left) kms_pm_rpm (system-suspend-idle)
[209.079745] Starting subtest: system-suspend-idle
[228.996202] Subtest system-suspend-idle: SUCCESS (4.711s)
[233.419866] [022/132] (792s left) i915_query (query-garbage)
[233.477011] Starting subtest: query-garbage
[233.477985] Subtest query-garbage: SUCCESS (0.000s)
[233.592218] [023/132] (792s left) gem_exec_await (wide-all)
[233.789186] Starting subtest: wide-all
[257.116410] Subtest wide-all: SUCCESS (23.306s)
[257.294325] [024/132] (768s left) kms_frontbuffer_tracking (psr-2p-scndscrn-indfb-plflip-blt)
[257.431063] Starting subtest: psr-2p-scndscrn-indfb-plflip-blt
[257.432869] Subtest psr-2p-scndscrn-indfb-plflip-blt: SKIP (0.000s)
[257.518648] [025/132] (768s left) kms_properties (crtc-properties-atomic)
[257.602725] Starting subtest: crtc-properties-atomic
[257.603662] Starting dynamic subtest: pipe-A-eDP-1
[258.076207] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.474s)
[258.084553] Starting dynamic subtest: pipe-B-eDP-1
[259.244424] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.167s)
[259.253120] Starting dynamic subtest: pipe-C-eDP-1
[260.355543] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.110s)
[260.363990] Starting dynamic subtest: pipe-D-eDP-1
[261.499353] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.142s)
[261.500265] Subtest crtc-properties-atomic: SUCCESS (3.898s)
[262.303905] [026/132] (763s left) kms_flip (dpms-vs-vblank-race)
[262.401616] Starting subtest: dpms-vs-vblank-race
[262.402540] Starting dynamic subtest: A-eDP1
[266.393951] Dynamic subtest A-eDP1: SUCCESS (3.988s)
[266.401957] Starting dynamic subtest: B-eDP1
[271.043237] Dynamic subtest B-eDP1: SUCCESS (4.645s)
[271.051476] Starting dynamic subtest: C-eDP1
[275.651456] Dynamic subtest C-eDP1: SUCCESS (4.605s)
[275.660612] Starting dynamic subtest: D-eDP1
[280.290744] Dynamic subtest D-eDP1: SUCCESS (4.636s)
[280.293173] Subtest dpms-vs-vblank-race: SUCCESS (17.885s)
[281.147331] [027/132] (745s left) kms_cursor_legacy (cursora-vs-flipa-atomic-transitions)
[281.264580] Starting subtest: cursorA-vs-flipA-atomic-transitions
[292.443030] Subtest cursorA-vs-flipA-atomic-transitions: SUCCESS (11.175s)
[293.282237] [028/132] (733s left) i915_getparams_basic (basic-subslice-total)
[293.331552] Starting subtest: basic-subslice-total
[293.333361] Subtest basic-subslice-total: SUCCESS (0.000s)
[293.412144] [029/132] (732s left) kms_atomic_transition (plane-all-transition-nonblocking-fencing)
[293.500980] Starting subtest: plane-all-transition-nonblocking-fencing
[293.501794] Starting dynamic subtest: pipe-A-eDP-1
[296.005930] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.504s)
[296.323719] Starting dynamic subtest: pipe-B-eDP-1
[299.532130] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.215s)
[299.829989] Subtest plane-all-transition-nonblocking-fencing: SUCCESS (6.326s)
[300.662669] [030/132] (725s left) kms_plane_scaling (plane-upscale-factor-0-25-with-pixel-format)
[300.759025] Starting subtest: plane-upscale-factor-0-25-with-pixel-format
[300.759996] Starting dynamic subtest: pipe-A
[301.808557] Dynamic subtest pipe-A: SUCCESS (1.050s)
[301.817679] Starting dynamic subtest: pipe-B
[304.006102] Dynamic subtest pipe-B: SUCCESS (2.196s)
[304.015749] Starting dynamic subtest: pipe-C
[305.163288] Dynamic subtest pipe-C: SUCCESS (1.154s)
[305.172545] Starting dynamic subtest: pipe-D
[306.314448] Dynamic subtest pipe-D: SUCCESS (1.149s)
[306.315408] Subtest plane-upscale-factor-0-25-with-pixel-format: SUCCESS (5.556s)
[307.495546] [031/132] (718s left) kms_prop_blob (invalid-get-prop-any)
[307.544929] Starting subtest: invalid-get-prop-any
[307.545759] Subtest invalid-get-prop-any: SUCCESS (0.000s)
[307.633376] [032/132] (718s left) syncobj_timeline (reset-signaled)
[307.686964] Starting subtest: reset-signaled
[307.687815] Subtest reset-signaled: SUCCESS (0.000s)
[307.780242] [033/132] (718s left) kms_ccs (crc-primary-suspend-4-tiled-mtl-rc-ccs)
[307.862409] Starting subtest: crc-primary-suspend-4-tiled-mtl-rc-ccs
[307.863590] Starting dynamic subtest: pipe-A-eDP-1
[325.073749] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.836s)
[325.081794] Starting dynamic subtest: pipe-B-eDP-1
[343.066040] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.826s)
[343.074380] Starting dynamic subtest: pipe-C-eDP-1
[361.030593] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.833s)
[361.038364] Starting dynamic subtest: pipe-D-eDP-1
[379.050496] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.780s)
[379.051423] Subtest crc-primary-suspend-4-tiled-mtl-rc-ccs: SUCCESS (10.281s)
[385.287564] [034/132] (646s left) syncobj_wait (multi-wait-all-for-submit-submitted-signaled)
[385.352310] Starting subtest: multi-wait-all-for-submit-submitted-signaled
[385.459053] Subtest multi-wait-all-for-submit-submitted-signaled: SUCCESS (0.106s)
[385.532739] [035/132] (646s left) gem_render_copy (yf-tiled-ccs-to-yf-tiled)
[385.582206] Starting subtest: yf-tiled-ccs-to-yf-tiled
[385.583861] Subtest yf-tiled-ccs-to-yf-tiled: SKIP (0.000s)
[385.763598] [036/132] (645s left) kms_plane (pixel-format-y-tiled-modifier)
[385.847585] Starting subtest: pixel-format-y-tiled-modifier
[385.849420] Subtest pixel-format-y-tiled-modifier: SKIP (0.000s)
[385.920953] [037/132] (645s left) kms_cursor_edge_walk (256x256-top-edge)
[386.012622] Starting subtest: 256x256-top-edge
[386.013489] Starting dynamic subtest: pipe-A-eDP-1
[389.456833] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.434s)
[389.466611] Starting dynamic subtest: pipe-D-eDP-1
[392.588789] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.125s)
[392.589693] Subtest 256x256-top-edge: SUCCESS (6.562s)
[393.404076] [038/132] (638s left) syncobj_wait (single-wait-for-submit-submitted)
[393.456751] Starting subtest: single-wait-for-submit-submitted
[393.563154] Subtest single-wait-for-submit-submitted: SUCCESS (0.105s)
[393.635779] [039/132] (638s left) kms_big_fb (yf-tiled-8bpp-rotate-90)
[393.737814] Starting subtest: yf-tiled-8bpp-rotate-90
[393.739882] Subtest yf-tiled-8bpp-rotate-90: SKIP (0.000s)
[393.821998] [040/132] (637s left) sysfs_preempt_timeout (timeout)
[393.878625] Starting subtest: timeout
[393.879576] Starting dynamic subtest: vecs0
[403.047221] Dynamic subtest vecs0: SUCCESS (9.149s)
[403.056874] Starting dynamic subtest: ccs0
[404.327336] Dynamic subtest ccs0: SUCCESS (1.285s)
[404.338920] Starting dynamic subtest: vcs0
[413.998673] Dynamic subtest vcs0: SUCCESS (9.654s)
[414.008905] Starting dynamic subtest: bcs0
[415.245068] Dynamic subtest bcs0: SUCCESS (1.253s)
[415.257021] Starting dynamic subtest: rcs0
[416.520930] Dynamic subtest rcs0: SUCCESS (1.272s)
[416.532222] Starting dynamic subtest: vcs1
[426.025081] Dynamic subtest vcs1: SUCCESS (9.488s)
[426.026535] Subtest timeout: SUCCESS (32.115s)
[426.104456] [041/132] (605s left) kms_chamelium_frames (vga-frame-dump)
[426.489246] Subtest vga-frame-dump: SKIP (0.000s)
[427.310441] [042/132] (604s left) syncobj_timeline (etime-single-wait-available-unsubmitted)
[427.352559] Starting subtest: etime-single-wait-available-unsubmitted
[427.459148] Subtest etime-single-wait-available-unsubmitted: SUCCESS (0.105s)
[427.531362] [043/132] (604s left) kms_addfb_basic (bo-too-small-due-to-tiling)
[427.625287] Starting subtest: bo-too-small-due-to-tiling
[427.627060] Subtest bo-too-small-due-to-tiling: SKIP (0.000s)
[427.719769] [044/132] (604s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-indfb-msflip-blt)
[427.812634] Starting subtest: fbcpsr-2p-primscrn-indfb-msflip-blt
[427.814496] Subtest fbcpsr-2p-primscrn-indfb-msflip-blt: SKIP (0.000s)
[427.903953] [045/132] (604s left) kms_rotation_crc (primary-yf-tiled-reflect-x-90)
[427.988663] Starting subtest: primary-yf-tiled-reflect-x-90
[427.990404] Subtest primary-yf-tiled-reflect-x-90: SKIP (0.001s)
[428.063141] [046/132] (603s left) gem_exec_parallel (contexts)
[428.120617] Starting subtest: contexts
[428.121626] Starting dynamic subtest: rcs0
[430.945737] Dynamic subtest rcs0: SUCCESS (2.815s)
[430.954239] Starting dynamic subtest: bcs0
[434.350717] Dynamic subtest bcs0: SUCCESS (3.402s)
[434.361235] Starting dynamic subtest: vcs0
[438.483972] Dynamic subtest vcs0: SUCCESS (4.129s)
[438.495718] Starting dynamic subtest: vcs1
[442.536429] Dynamic subtest vcs1: SUCCESS (4.050s)
[442.544193] Starting dynamic subtest: vecs0
[446.511404] Dynamic subtest vecs0: SUCCESS (3.971s)
[446.519313] Starting dynamic subtest: ccs0
[450.140444] Dynamic subtest ccs0: SUCCESS (3.626s)
[450.141725] Subtest contexts: SUCCESS (22.004s)
[450.318648] [047/132] (581s left) kms_plane (pixel-format-4-tiled-dg2-rc-ccs-modifier)
[450.411281] Starting subtest: pixel-format-4-tiled-dg2-rc-ccs-modifier
[450.412988] Subtest pixel-format-4-tiled-dg2-rc-ccs-modifier: SKIP (0.000s)
[450.481690] [048/132] (581s left) gem_mmap_gtt (basic-short)
[450.530929] Subtest basic-short: SKIP (0.000s)
[450.597972] [049/132] (581s left) kms_frontbuffer_tracking (fbc-tiling-linear)
[450.697641] Starting subtest: fbc-tiling-linear
[454.474719] Subtest fbc-tiling-linear: SUCCESS (3.778s)
[455.630631] [050/132] (576s left) kms_pipe_crc_basic (suspend-read-crc)
[455.723781] Starting subtest: suspend-read-crc
[455.724730] Starting dynamic subtest: pipe-A-eDP-1
[473.773966] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.883s)
[473.781963] Starting dynamic subtest: pipe-B-eDP-1
[492.781278] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.543s)
[492.789592] Starting dynamic subtest: pipe-C-eDP-1
[511.748031] Dynamic subtest pipe-C-eDP-1: SUCCESS (3.383s)
[511.757792] Starting dynamic subtest: pipe-D-eDP-1
[530.737701] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.413s)
[530.738560] Subtest suspend-read-crc: SUCCESS (13.229s)
[536.612116] [051/132] (500s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-blt)
[536.702156] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-blt
[536.703999] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-blt: SKIP (0.000s)
[536.792310] [052/132] (500s left) gem_mmap_gtt (cpuset-big-copy)
[536.844670] Subtest cpuset-big-copy: SKIP (0.000s)
[536.906136] [053/132] (500s left) core_getstats (basic)
[536.952577] Starting subtest: basic
[536.953539] Subtest basic: SUCCESS (0.000s)
[537.042065] [054/132] (500s left) kms_big_fb (yf-tiled-32bpp-rotate-0)
[537.129874] Starting subtest: yf-tiled-32bpp-rotate-0
[537.131710] Subtest yf-tiled-32bpp-rotate-0: SKIP (0.000s)
[537.213071] [055/132] (500s left) gem_userptr_blits (userfault)
[537.262428] Starting subtest: userfault
[537.265817] Subtest userfault: SUCCESS (0.004s)
[537.406465] [056/132] (499s left) gem_render_copy (yf-tiled-ccs-to-y-tiled-ccs)
[537.466588] Starting subtest: yf-tiled-ccs-to-y-tiled-ccs
[537.468274] Subtest yf-tiled-ccs-to-y-tiled-ccs: SKIP (0.000s)
[537.648181] [057/132] (499s left) gem_exec_balancer (bonded-true-hang)
[537.921372] Starting subtest: bonded-true-hang
[537.923453] Subtest bonded-true-hang: SKIP (0.000s)
[538.016254] [058/132] (499s left) core_setmaster (master-drop-set-shared-fd)
[538.084019] Starting subtest: master-drop-set-shared-fd
[538.104242] Subtest master-drop-set-shared-fd: SUCCESS (0.022s)
[538.139277] [059/132] (499s left) i915_drm_fdinfo (virtual-busy-hang)
[538.169866] Starting subtest: virtual-busy-hang
[538.171767] Subtest virtual-busy-hang: SKIP (0.000s)
[538.247341] [060/132] (499s left) kms_psr2_sf (psr2-cursor-plane-update-sf)
[538.338428] Starting subtest: psr2-cursor-plane-update-sf
[538.339289] Starting dynamic subtest: pipe-A-eDP-1
[538.906932] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.567s)
[538.917730] Starting dynamic subtest: pipe-B-eDP-1
[540.161715] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.248s)
[540.162606] Subtest psr2-cursor-plane-update-sf: SUCCESS (1.818s)
[541.051164] [061/132] (496s left) kms_addfb_basic (invalid-smem-bo-on-discrete)
[541.103706] Starting subtest: invalid-smem-bo-on-discrete
[541.105974] Subtest invalid-smem-bo-on-discrete: SKIP (0.000s)
[541.251796] [062/132] (496s left) kms_ccs (bad-rotation-90-4-tiled-dg2-mc-ccs)
[541.332271] Starting subtest: bad-rotation-90-4-tiled-dg2-mc-ccs
[541.333029] Starting dynamic subtest: pipe-A-eDP-1
[541.341215] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[541.349897] Starting dynamic subtest: pipe-B-eDP-1
[541.358044] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[541.366562] Starting dynamic subtest: pipe-C-eDP-1
[541.374551] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[541.382778] Starting dynamic subtest: pipe-D-eDP-1
[541.391274] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[541.392881] Subtest bad-rotation-90-4-tiled-dg2-mc-ccs: SKIP (0.004s)
[543.532838] [063/132] (494s left) gem_busy (extended)
[543.714929] Starting subtest: extended
[543.716025] Starting dynamic subtest: rcs0
[543.786059] Dynamic subtest rcs0: SUCCESS (0.077s)
[543.798486] Starting dynamic subtest: bcs0
[543.828606] Dynamic subtest bcs0: SUCCESS (0.041s)
[543.840664] Starting dynamic subtest: vcs0
[545.804490] Dynamic subtest vcs0: SUCCESS (1.960s)
[545.813827] Starting dynamic subtest: vcs1
[547.788985] Dynamic subtest vcs1: SUCCESS (1.978s)
[547.799627] Starting dynamic subtest: vecs0
[549.836201] Dynamic subtest vecs0: SUCCESS (2.043s)
[549.846884] Starting dynamic subtest: ccs0
[549.873676] Dynamic subtest ccs0: SUCCESS (0.045s)
[549.884720] Subtest extended: SUCCESS (6.157s)
[550.122050] [064/132] (487s left) gem_mmap_wc (write-cpu-read-wc-unflushed)
[550.174261] Subtest write-cpu-read-wc-unflushed: SKIP (0.000s)
[550.250870] [065/132] (487s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-indfb-draw-blt)
[550.352827] Starting subtest: fbc-1p-offscreen-pri-indfb-draw-blt
[554.489628] Subtest fbc-1p-offscreen-pri-indfb-draw-blt: SUCCESS (4.133s)
[555.651916] [066/132] (482s left) vgem_basic (debugfs)
[555.684961] Starting subtest: debugfs
[555.685916] Subtest debugfs: SUCCESS (0.000s)
[555.754758] [067/132] (482s left) kms_selftest (drm_damage_helper)
[555.793452] Starting subtest: drm_damage_helper
[555.854423] Starting dynamic subtest: drm_test_damage_iter_no_damage
[555.938287] Dynamic subtest drm_test_damage_iter_no_damage: SUCCESS (0.084s)
[555.953454] Starting dynamic subtest: drm_test_damage_iter_no_damage_fractional_src
[556.023923] Dynamic subtest drm_test_damage_iter_no_damage_fractional_src: SUCCESS (0.085s)
[556.037846] Starting dynamic subtest: drm_test_damage_iter_no_damage_src_moved
[556.115735] Dynamic subtest drm_test_damage_iter_no_damage_src_moved: SUCCESS (0.091s)
[556.126237] Starting dynamic subtest: drm_test_damage_iter_no_damage_fractional_src_moved
[556.210799] Dynamic subtest drm_test_damage_iter_no_damage_fractional_src_moved: SUCCESS (0.093s)
[556.220271] Starting dynamic subtest: drm_test_damage_iter_no_damage_not_visible
[556.301241] Dynamic subtest drm_test_damage_iter_no_damage_not_visible: SUCCESS (0.088s)
[556.311258] Starting dynamic subtest: drm_test_damage_iter_no_damage_no_crtc
[556.394743] Dynamic subtest drm_test_damage_iter_no_damage_no_crtc: SUCCESS (0.094s)
[556.405146] Starting dynamic subtest: drm_test_damage_iter_no_damage_no_fb
[556.475932] Dynamic subtest drm_test_damage_iter_no_damage_no_fb: SUCCESS (0.080s)
[556.485951] Starting dynamic subtest: drm_test_damage_iter_simple_damage
[556.569764] Dynamic subtest drm_test_damage_iter_simple_damage: SUCCESS (0.092s)
[556.578985] Starting dynamic subtest: drm_test_damage_iter_single_damage
[556.663155] Dynamic subtest drm_test_damage_iter_single_damage: SUCCESS (0.092s)
[556.672985] Starting dynamic subtest: drm_test_damage_iter_single_damage_intersect_src
[556.755967] Dynamic subtest drm_test_damage_iter_single_damage_intersect_src: SUCCESS (0.093s)
[556.764028] Starting dynamic subtest: drm_test_damage_iter_single_damage_outside_src
[556.839798] Dynamic subtest drm_test_damage_iter_single_damage_outside_src: SUCCESS (0.082s)
[556.849192] Starting dynamic subtest: drm_test_damage_iter_single_damage_fractional_src
[556.915683] Dynamic subtest drm_test_damage_iter_single_damage_fractional_src: SUCCESS (0.074s)
[556.925366] Starting dynamic subtest: drm_test_damage_iter_single_damage_intersect_fractional_src
[557.003843] Dynamic subtest drm_test_damage_iter_single_damage_intersect_fractional_src: SUCCESS (0.088s)
[557.011917] Starting dynamic subtest: drm_test_damage_iter_single_damage_outside_fractional_src
[557.103813] Dynamic subtest drm_test_damage_iter_single_damage_outside_fractional_src: SUCCESS (0.099s)
[557.114046] Starting dynamic subtest: drm_test_damage_iter_single_damage_src_moved
[557.179561] Dynamic subtest drm_test_damage_iter_single_damage_src_moved: SUCCESS (0.074s)
[557.191753] Starting dynamic subtest: drm_test_damage_iter_single_damage_fractional_src_moved
[557.277533] Dynamic subtest drm_test_damage_iter_single_damage_fractional_src_moved: SUCCESS (0.094s)
[557.286740] Starting dynamic subtest: drm_test_damage_iter_damage
[557.378954] Dynamic subtest drm_test_damage_iter_damage: SUCCESS (0.101s)
[557.388952] Starting dynamic subtest: drm_test_damage_iter_damage_one_intersect
[557.465107] Dynamic subtest drm_test_damage_iter_damage_one_intersect: SUCCESS (0.085s)
[557.472997] Starting dynamic subtest: drm_test_damage_iter_damage_one_outside
[557.552829] Dynamic subtest drm_test_damage_iter_damage_one_outside: SUCCESS (0.087s)
[557.560834] Starting dynamic subtest: drm_test_damage_iter_damage_src_moved
[557.648624] Dynamic subtest drm_test_damage_iter_damage_src_moved: SUCCESS (0.094s)
[557.658559] Starting dynamic subtest: drm_test_damage_iter_damage_not_visible
[557.727548] Dynamic subtest drm_test_damage_iter_damage_not_visible: SUCCESS (0.077s)
[557.728469] Subtest drm_damage_helper: SUCCESS (1.932s)
[557.881618] [068/132] (479s left) kms_psr (fbc-psr2-primary-render)
[557.976564] Starting subtest: fbc-psr2-primary-render
[557.977477] Starting dynamic subtest: eDP-1
[557.979263] Dynamic subtest eDP-1: SKIP (0.000s)
[557.980972] Subtest fbc-psr2-primary-render: SKIP (0.001s)
[558.046178] [069/132] (479s left) kms_ccs (random-ccs-data-y-tiled-gen12-rc-ccs)
[558.137502] Starting subtest: random-ccs-data-y-tiled-gen12-rc-ccs
[558.138443] Starting dynamic subtest: pipe-A-eDP-1
[558.148075] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[558.161186] Starting dynamic subtest: pipe-B-eDP-1
[558.170523] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[558.179052] Starting dynamic subtest: pipe-C-eDP-1
[558.187983] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[558.196118] Starting dynamic subtest: pipe-D-eDP-1
[558.205510] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[558.207050] Subtest random-ccs-data-y-tiled-gen12-rc-ccs: SKIP (0.004s)
[560.406183] [070/132] (477s left) kms_vblank (wait-busy)
[560.513567] Starting subtest: wait-busy
[560.514469] Starting dynamic subtest: pipe-A-eDP-1
[562.404147] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.888s)
[562.419385] Starting dynamic subtest: pipe-D-eDP-1
[564.962607] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.555s)
[564.963444] Subtest wait-busy: SUCCESS (4.447s)
[565.765939] [071/132] (472s left) kms_flip (2x-nonexisting-fb)
[565.859122] Starting subtest: 2x-nonexisting-fb
[565.870400] Subtest 2x-nonexisting-fb: SKIP (0.011s)
[565.941936] [072/132] (472s left) gem_pread (display)
[566.002371] Subtest display: SKIP (0.000s)
[566.060281] [073/132] (471s left) gen3_render_tiledx_blits
[566.170786] [074/132] (471s left) i915_query (query-topology-garbage-items)
[566.220559] Starting subtest: query-topology-garbage-items
[566.221443] Subtest query-topology-garbage-items: SUCCESS (0.000s)
[566.309688] [075/132] (471s left) kms_frontbuffer_tracking (psr-2p-primscrn-shrfb-plflip-blt)
[566.400243] Starting subtest: psr-2p-primscrn-shrfb-plflip-blt
[566.402086] Subtest psr-2p-primscrn-shrfb-plflip-blt: SKIP (0.000s)
[566.491996] [076/132] (471s left) gem_ctx_persistence (legacy-engines-persistence)
[566.543668] Starting subtest: legacy-engines-persistence
[566.544570] Starting dynamic subtest: render
[567.374950] Dynamic subtest render: SUCCESS (0.831s)
[567.389079] Starting dynamic subtest: bsd1
[568.108038] Dynamic subtest bsd1: SUCCESS (0.728s)
[568.118384] Starting dynamic subtest: bsd2
[568.900599] Dynamic subtest bsd2: SUCCESS (0.792s)
[568.912997] Starting dynamic subtest: blt
[569.644459] Dynamic subtest blt: SUCCESS (0.737s)
[569.654640] Starting dynamic subtest: vebox
[570.440692] Dynamic subtest vebox: SUCCESS (0.798s)
[570.443719] Subtest legacy-engines-persistence: SUCCESS (3.898s)
[570.524211] [077/132] (467s left) kms_chamelium_edid (dp-edid-change-during-suspend)
[570.908675] Subtest dp-edid-change-during-suspend: SKIP (0.000s)
[571.684499] [078/132] (466s left) kms_frontbuffer_tracking (psr-modesetfrombusy)
[571.789749] Starting subtest: psr-modesetfrombusy
[577.987087] Subtest psr-modesetfrombusy: SUCCESS (6.208s)
[578.091302] [079/132] (460s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-shrfb-draw-render)
[578.188033] Starting subtest: psr-1p-offscreen-pri-shrfb-draw-render
[585.140248] Subtest psr-1p-offscreen-pri-shrfb-draw-render: SUCCESS (6.961s)
[585.280275] [080/132] (452s left) core_auth (basic-auth)
[585.332977] Starting subtest: basic-auth
[585.333968] Subtest basic-auth: SUCCESS (0.001s)
[585.438988] [081/132] (452s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-180-hflip)
[585.543967] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-180-hflip
[585.545783] Subtest y-tiled-max-hw-stride-32bpp-rotate-180-hflip: SKIP (0.000s)
[585.640119] [082/132] (452s left) gem_sync (basic-each)
[585.700720] Starting subtest: basic-each
[587.959006] Subtest basic-each: SUCCESS (2.259s)
[588.139743] [083/132] (450s left) kms_cursor_legacy (short-flip-after-cursor-atomic-transitions)
[588.263910] Starting subtest: short-flip-after-cursor-atomic-transitions
[589.252115] Subtest short-flip-after-cursor-atomic-transitions: SUCCESS (0.987s)
[590.041322] [084/132] (448s left) perf_pmu (init-wait)
[590.076270] Starting subtest: init-wait
[590.077262] Starting dynamic subtest: rcs0
[590.079369] Dynamic subtest rcs0: SUCCESS (0.002s)
[590.087889] Starting dynamic subtest: bcs0
[590.088748] Dynamic subtest bcs0: SUCCESS (0.000s)
[590.096882] Starting dynamic subtest: vcs0
[590.097783] Dynamic subtest vcs0: SUCCESS (0.001s)
[590.105790] Starting dynamic subtest: vcs1
[590.106669] Dynamic subtest vcs1: SUCCESS (0.001s)
[590.115067] Starting dynamic subtest: vecs0
[590.116013] Dynamic subtest vecs0: SUCCESS (0.001s)
[590.124148] Starting dynamic subtest: ccs0
[590.125077] Dynamic subtest ccs0: SUCCESS (0.001s)
[590.126050] Subtest init-wait: SUCCESS (0.009s)
[590.192401] [085/132] (448s left) perf (stress-open-close)
[590.326674] Starting subtest: stress-open-close
[590.327557] Starting dynamic subtest: 0-rcs0
[592.491654] Dynamic subtest 0-rcs0: SUCCESS (2.165s)
[592.501554] Starting dynamic subtest: 1-vecs0
[594.653823] Dynamic subtest 1-vecs0: SUCCESS (2.161s)
[594.654840] Subtest stress-open-close: SUCCESS (4.328s)
[594.694933] [086/132] (443s left) gem_mmap_offset (ptrace)
[594.747841] Starting subtest: ptrace
[594.749208] Starting dynamic subtest: smem0-wb
[594.769562] Dynamic subtest smem0-wb: SUCCESS (0.020s)
[594.780867] Starting dynamic subtest: smem0-wc
[594.796467] Dynamic subtest smem0-wc: SUCCESS (0.026s)
[594.805429] Starting dynamic subtest: smem0-uc
[594.819948] Dynamic subtest smem0-uc: SUCCESS (0.021s)
[594.821027] Subtest ptrace: SUCCESS (0.074s)
[594.943527] [087/132] (443s left) gem_exec_balancer (parallel-keep-submit-fence)
[595.207245] Starting subtest: parallel-keep-submit-fence
[596.434247] Subtest parallel-keep-submit-fence: SUCCESS (1.228s)
[596.528599] [088/132] (442s left) kms_getfb (getfb-handle-zero)
[596.624639] Starting subtest: getfb-handle-zero
[596.625527] Subtest getfb-handle-zero: SUCCESS (0.000s)
[596.714545] [089/132] (441s left) kms_draw_crc (draw-method-mmap-cpu)
[596.792816] Starting subtest: draw-method-mmap-cpu
[596.793802] Starting dynamic subtest: xrgb8888-untiled
[597.025449] Dynamic subtest xrgb8888-untiled: SUCCESS (0.233s)
[597.034174] Starting dynamic subtest: rgb565-untiled
[597.236633] Dynamic subtest rgb565-untiled: SUCCESS (0.210s)
[597.245305] Starting dynamic subtest: xrgb2101010-untiled
[597.459027] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.221s)
[597.468356] Starting dynamic subtest: xbgr16161616f-untiled
[597.681177] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.221s)
[597.690060] Starting dynamic subtest: xrgb8888-xtiled
[597.825573] Dynamic subtest xrgb8888-xtiled: SUCCESS (0.144s)
[597.834369] Starting dynamic subtest: rgb565-xtiled
[597.958980] Dynamic subtest rgb565-xtiled: SUCCESS (0.133s)
[597.967710] Starting dynamic subtest: xrgb2101010-xtiled
[598.081329] Dynamic subtest xrgb2101010-xtiled: SUCCESS (0.121s)
[598.090059] Starting dynamic subtest: xbgr16161616f-xtiled
[598.214662] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (0.132s)
[598.223531] Starting dynamic subtest: xrgb8888-4tiled
[598.347912] Dynamic subtest xrgb8888-4tiled: SUCCESS (0.132s)
[598.356781] Starting dynamic subtest: rgb565-4tiled
[598.481250] Dynamic subtest rgb565-4tiled: SUCCESS (0.133s)
[598.489910] Starting dynamic subtest: xrgb2101010-4tiled
[598.614710] Dynamic subtest xrgb2101010-4tiled: SUCCESS (0.133s)
[598.623838] Starting dynamic subtest: xbgr16161616f-4tiled
[598.759439] Dynamic subtest xbgr16161616f-4tiled: SUCCESS (0.144s)
[598.762667] Subtest draw-method-mmap-cpu: SUCCESS (1.968s)
[598.847772] [090/132] (439s left) syncobj_wait (wait-delayed-signal)
[598.899466] Starting subtest: wait-delayed-signal
[599.002453] Subtest wait-delayed-signal: SUCCESS (0.103s)
[599.090898] [091/132] (439s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-render)
[599.188194] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-render
[602.887270] Subtest fbc-1p-primscrn-spr-indfb-draw-render: SUCCESS (3.698s)
[604.043601] [092/132] (434s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-blt)
[604.146310] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-blt
[604.147970] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-blt: SKIP (0.000s)
[604.245240] [093/132] (434s left) syncobj_timeline (single-wait-all-available-submitted)
[604.300071] Starting subtest: single-wait-all-available-submitted
[604.301065] Subtest single-wait-all-available-submitted: SUCCESS (0.000s)
[604.418078] [094/132] (434s left) kms_flip_scaled_crc (flip-32bpp-yftile-to-32bpp-yftileccs-upscaling)
[604.501735] Starting subtest: flip-32bpp-yftile-to-32bpp-yftileccs-upscaling
[604.503776] Subtest flip-32bpp-yftile-to-32bpp-yftileccs-upscaling: SKIP (0.000s)
[604.621244] [095/132] (434s left) gem_ctx_exec (basic-nohangcheck)
[604.676842] Starting subtest: basic-nohangcheck
[604.926053] Subtest basic-nohangcheck: SUCCESS (0.251s)
[605.038181] [096/132] (433s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-indfb-plflip-blt)
[605.123916] Starting subtest: fbc-2p-scndscrn-indfb-plflip-blt
[605.125678] Subtest fbc-2p-scndscrn-indfb-plflip-blt: SKIP (0.000s)
[605.229632] [097/132] (433s left) gen9_exec_parse (batch-without-end)
[605.277033] Subtest batch-without-end: SKIP (0.000s)
[605.346126] [098/132] (433s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-move)
[605.436908] Starting subtest: psr-1p-primscrn-spr-indfb-move
[613.002769] Subtest psr-1p-primscrn-spr-indfb-move: SUCCESS (7.564s)
[613.122201] [099/132] (425s left) perf (non-zero-reason)
[613.207558] Starting subtest: non-zero-reason
[613.208467] Starting dynamic subtest: 0-rcs0
[618.809289] Dynamic subtest 0-rcs0: SUCCESS (5.556s)
[618.820978] Starting dynamic subtest: 1-vecs0
[622.787398] Dynamic subtest 1-vecs0: SUCCESS (3.976s)
[622.788665] Subtest non-zero-reason: SUCCESS (9.533s)
[622.823784] [100/132] (416s left) kms_color (ctm-max)
[622.920817] Starting subtest: ctm-max
[622.921841] Starting dynamic subtest: pipe-A-eDP-1
[623.631040] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.710s)
[623.639538] Starting dynamic subtest: pipe-B-eDP-1
[625.078476] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.446s)
[625.091119] Starting dynamic subtest: pipe-C-eDP-1
[626.453697] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.373s)
[626.462675] Starting dynamic subtest: pipe-D-eDP-1
[627.786985] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.331s)
[627.787894] Subtest ctm-max: SUCCESS (4.865s)
[628.595138] [101/132] (410s left) syncobj_wait (invalid-multi-wait-all-unsubmitted)
[628.646755] Starting subtest: invalid-multi-wait-all-unsubmitted
[628.647742] Subtest invalid-multi-wait-all-unsubmitted: SUCCESS (0.000s)
[628.754060] [102/132] (410s left) gem_exec_schedule (semaphore-noskip)
[628.820929] Starting subtest: semaphore-noskip
[629.260553] Subtest semaphore-noskip: SUCCESS (0.430s)
[629.602953] [103/132] (409s left) tools_test (tools_test)
[629.641758] Starting subtest: tools_test
[629.698675] Subtest tools_test: SUCCESS (0.063s)
[629.762722] [104/132] (409s left) gem_close_race (multigpu-basic-process)
[629.835209] Starting subtest: multigpu-basic-process
[629.837171] Subtest multigpu-basic-process: SKIP (0.000s)
[630.047128] [105/132] (409s left) kms_frontbuffer_tracking (fbc-2p-pri-indfb-multidraw)
[630.155633] Starting subtest: fbc-2p-pri-indfb-multidraw
[630.157387] Subtest fbc-2p-pri-indfb-multidraw: SKIP (0.000s)
[630.250747] [106/132] (408s left) gem_tiling_max_stride
[630.371278] [107/132] (408s left) kms_async_flips (invalid-async-flip-atomic)
[630.462591] Starting subtest: invalid-async-flip-atomic
[630.836456] Starting dynamic subtest: pipe-A-eDP-1
[631.624607] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.788s)
[631.983141] Starting dynamic subtest: pipe-B-eDP-1
[632.756815] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.781s)
[633.112251] Starting dynamic subtest: pipe-C-eDP-1
[633.896162] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.791s)
[634.249826] Starting dynamic subtest: pipe-D-eDP-1
[635.014890] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.773s)
[635.015815] Subtest invalid-async-flip-atomic: SUCCESS (4.553s)
[636.161146] [108/132] (403s left) gem_userptr_blits (unsync-overlap)
[636.215359] Subtest unsync-overlap: SKIP (0.000s)
[636.328742] [109/132] (403s left) kms_psr2_sf (fbc-psr2-plane-move-sf-dmg-area)
[636.410359] Starting subtest: fbc-psr2-plane-move-sf-dmg-area
[636.411435] Starting dynamic subtest: pipe-A-eDP-1
[636.521823] Dynamic subtest pipe-A-eDP-1: SKIP (0.111s)
[636.532611] Starting dynamic subtest: pipe-B-eDP-1
[637.650162] Dynamic subtest pipe-B-eDP-1: SKIP (1.127s)
[637.651877] Subtest fbc-psr2-plane-move-sf-dmg-area: SKIP (1.241s)
[638.841666] [110/132] (400s left) kms_psr (psr-cursor-mmap-gtt)
[638.926587] Starting subtest: psr-cursor-mmap-gtt
[638.927472] Starting dynamic subtest: eDP-1
[640.642761] Dynamic subtest eDP-1: SUCCESS (1.715s)
[640.643739] Subtest psr-cursor-mmap-gtt: SUCCESS (1.716s)
[641.503254] [111/132] (397s left) kms_flip (flip-vs-expired-vblank)
[641.596551] Starting subtest: flip-vs-expired-vblank
[641.597424] Starting dynamic subtest: A-eDP1
[650.345748] Dynamic subtest A-eDP1: SUCCESS (8.723s)
[650.357078] Starting dynamic subtest: B-eDP1
[659.070846] Dynamic subtest B-eDP1: SUCCESS (8.723s)
[659.081745] Starting dynamic subtest: C-eDP1
[667.706462] Dynamic subtest C-eDP1: SUCCESS (8.621s)
[667.717587] Starting dynamic subtest: D-eDP1
[676.301003] Dynamic subtest D-eDP1: SUCCESS (8.628s)
[676.301970] Subtest flip-vs-expired-vblank: SUCCESS (34.707s)
[677.466017] [112/132] (361s left) gem_ctx_param (invalid-size-get)
[677.519004] Starting subtest: invalid-size-get
[677.519928] Subtest invalid-size-get: SUCCESS (0.001s)
[677.633234] [113/132] (361s left) kms_pipe_crc_basic (bad-source)
[677.720652] Starting subtest: bad-source
[677.721546] Subtest bad-source: SUCCESS (0.000s)
[677.790560] [114/132] (361s left) kms_ccs (crc-primary-basic-4-tiled-mtl-rc-ccs-cc)
[677.882824] Starting subtest: crc-primary-basic-4-tiled-mtl-rc-ccs-cc
[677.883737] Starting dynamic subtest: pipe-A-eDP-1
[678.765821] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.880s)
[678.775248] Starting dynamic subtest: pipe-B-eDP-1
[680.331601] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.564s)
[680.340413] Starting dynamic subtest: pipe-C-eDP-1
[681.798028] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.465s)
[681.806377] Starting dynamic subtest: pipe-D-eDP-1
[683.337670] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.538s)
[683.338531] Subtest crc-primary-basic-4-tiled-mtl-rc-ccs-cc: SUCCESS (5.452s)
[684.503162] [115/132] (355s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-mmap-wc)
[684.599691] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-mmap-wc
[688.960819] Subtest fbc-1p-primscrn-pri-shrfb-draw-mmap-wc: SUCCESS (4.361s)
[690.121512] [116/132] (349s left) gem_fence_thrash (bo-copy)
[690.162878] Starting subtest: bo-copy
[690.180641] Subtest bo-copy: SKIP (0.015s)
[690.244061] [117/132] (349s left) kms_flip (2x-wf_vblank-ts-check)
[690.340118] Starting subtest: 2x-wf_vblank-ts-check
[690.351683] Subtest 2x-wf_vblank-ts-check: SKIP (0.011s)
[690.444940] [118/132] (349s left) kms_psr (psr-primary-mmap-cpu)
[690.527444] Starting subtest: psr-primary-mmap-cpu
[690.528275] Starting dynamic subtest: eDP-1
[692.228532] Dynamic subtest eDP-1: SUCCESS (1.699s)
[692.229861] Subtest psr-primary-mmap-cpu: SUCCESS (1.700s)
[693.094546] [119/132] (346s left) gem_exec_reloc (basic-active)
[693.154172] Subtest basic-active: SKIP (0.000s)
[693.234744] [120/132] (346s left) gem_exec_schedule (independent)
[693.301247] Starting subtest: independent
[693.302294] Starting dynamic subtest: rcs0
[694.796002] Dynamic subtest rcs0: SUCCESS (1.485s)
[694.804680] Starting dynamic subtest: vcs0
[696.855022] Dynamic subtest vcs0: SUCCESS (2.056s)
[696.866722] Starting dynamic subtest: vcs1
[698.832915] Dynamic subtest vcs1: SUCCESS (1.975s)
[698.841510] Starting dynamic subtest: vecs0
[700.822582] Dynamic subtest vecs0: SUCCESS (1.987s)
[700.834708] Starting dynamic subtest: ccs0
[702.795893] Dynamic subtest ccs0: SUCCESS (1.970s)
[702.797478] Subtest independent: SUCCESS (9.485s)
[703.096075] [121/132] (336s left) kms_joiner (basic-ultra-joiner)
[703.204231] Starting subtest: basic-ultra-joiner
[703.205962] Subtest basic-ultra-joiner: SKIP (0.000s)
[703.275681] [122/132] (336s left) gem_exec_fence (syncobj-repeat)
[703.719759] Starting subtest: syncobj-repeat
[703.926151] Subtest syncobj-repeat: SUCCESS (0.198s)
[704.889402] [123/132] (334s left) gem_exec_params (secure-non-root)
[704.960611] Starting subtest: secure-non-root
[704.962646] Subtest secure-non-root: SKIP (0.000s)
[705.070292] [124/132] (334s left) gem_softpin (allocator-nopin)
[705.122728] Starting subtest: allocator-nopin
[705.243799] Subtest allocator-nopin: SUCCESS (0.111s)
[705.365037] [125/132] (334s left) kms_cursor_crc (cursor-onscreen-128x42)
[705.579848] Starting subtest: cursor-onscreen-128x42
[705.627467] Subtest cursor-onscreen-128x42: SKIP (0.045s)
[705.819231] [126/132] (334s left) kms_ccs (random-ccs-data-4-tiled-bmg-ccs)
[705.913708] Starting subtest: random-ccs-data-4-tiled-bmg-ccs
[705.915441] Subtest random-ccs-data-4-tiled-bmg-ccs: SKIP (0.000s)
[707.032959] [127/132] (332s left) gem_userptr_blits (sync-unmap-after-close)
[707.084771] Starting subtest: sync-unmap-after-close
[707.100528] Subtest sync-unmap-after-close: SUCCESS (0.015s)
[707.244745] [128/132] (332s left) kms_flip_scaled_crc (flip-64bpp-xtile-to-16bpp-xtile-upscaling)
[707.344436] Starting subtest: flip-64bpp-xtile-to-16bpp-xtile-upscaling
[707.345274] Starting dynamic subtest: pipe-A-default-mode
[710.093471] Dynamic subtest pipe-A-default-mode: SUCCESS (2.747s)
[710.094316] Subtest flip-64bpp-xtile-to-16bpp-xtile-upscaling: SUCCESS (2.749s)
[710.932015] [129/132] (329s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-0)
[711.023160] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-0
[711.024953] Subtest y-tiled-max-hw-stride-32bpp-rotate-0: SKIP (0.000s)
[711.112587] [130/132] (328s left) kms_flip (plain-flip-fb-recreate-interruptible)
[711.202279] Starting subtest: plain-flip-fb-recreate-interruptible
[711.203560] Starting dynamic subtest: A-eDP1
[720.011720] Dynamic subtest A-eDP1: SUCCESS (8.806s)
[720.022792] Starting dynamic subtest: B-eDP1
[728.836974] Dynamic subtest B-eDP1: SUCCESS (8.822s)
[728.848762] Starting dynamic subtest: C-eDP1
[737.661247] Dynamic subtest C-eDP1: SUCCESS (8.819s)
[737.671417] Starting dynamic subtest: D-eDP1
[746.487887] Dynamic subtest D-eDP1: SUCCESS (8.824s)
[746.490715] Subtest plain-flip-fb-recreate-interruptible: SUCCESS (35.283s)
[747.668421] [131/132] (292s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-pwrite)
[747.759615] Starting subtest: psr-1p-primscrn-pri-indfb-draw-pwrite
[755.466850] Subtest psr-1p-primscrn-pri-indfb-draw-pwrite: SUCCESS (7.706s)
[755.566084] [132/132] (284s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-180)
[755.659023] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-180
[756.670974] Subtest 4-tiled-max-hw-stride-32bpp-rotate-180: SUCCESS (1.012s)
[756.797580] Closing watchdogs
results: parsing output: 0/ for test: kms_psr
results: parsing output: 1/ for test: kms_cursor_crc
results: parsing output: 2/ for test: kms_content_protection
results: parsing output: 3/ for test: kms_psr
results: parsing output: 4/ for test: syncobj_basic
results: parsing output: 5/ for test: kms_big_fb
results: parsing output: 6/ for test: gem_exec_schedule
results: parsing output: 7/ for test: kms_lease
results: parsing output: 8/ for test: kms_frontbuffer_tracking
results: parsing output: 9/ for test: kms_plane
results: parsing output: 10/ for test: gem_mmap_offset
results: parsing output: 11/ for test: kms_big_fb
results: parsing output: 12/ for test: kms_dirtyfb
results: parsing output: 13/ for test: prime_vgem
results: parsing output: 14/ for test: syncobj_timeline
results: parsing output: 15/ for test: i915_pm_rpm
results: parsing output: 16/ for test: gem_lmem_swapping
results: parsing output: 17/ for test: kms_frontbuffer_tracking
results: parsing output: 18/ for test: syncobj_timeline
results: parsing output: 19/ for test: kms_pm_rpm
results: parsing output: 20/ for test: kms_pm_rpm
results: parsing output: 21/ for test: i915_query
results: parsing output: 22/ for test: gem_exec_await
results: parsing output: 23/ for test: kms_frontbuffer_tracking
results: parsing output: 24/ for test: kms_properties
results: parsing output: 25/ for test: kms_flip
results: parsing output: 26/ for test: kms_cursor_legacy
results: parsing output: 27/ for test: i915_getparams_basic
results: parsing output: 28/ for test: kms_atomic_transition
results: parsing output: 29/ for test: kms_plane_scaling
results: parsing output: 30/ for test: kms_prop_blob
results: parsing output: 31/ for test: syncobj_timeline
results: parsing output: 32/ for test: kms_ccs
results: parsing output: 33/ for test: syncobj_wait
results: parsing output: 34/ for test: gem_render_copy
results: parsing output: 35/ for test: kms_plane
results: parsing output: 36/ for test: kms_cursor_edge_walk
results: parsing output: 37/ for test: syncobj_wait
results: parsing output: 38/ for test: kms_big_fb
results: parsing output: 39/ for test: sysfs_preempt_timeout
results: parsing output: 40/ for test: kms_chamelium_frames
results: parsing output: 41/ for test: syncobj_timeline
results: parsing output: 42/ for test: kms_addfb_basic
results: parsing output: 43/ for test: kms_frontbuffer_tracking
results: parsing output: 44/ for test: kms_rotation_crc
results: parsing output: 45/ for test: gem_exec_parallel
results: parsing output: 46/ for test: kms_plane
results: parsing output: 47/ for test: gem_mmap_gtt
results: parsing output: 48/ for test: kms_frontbuffer_tracking
results: parsing output: 49/ for test: kms_pipe_crc_basic
results: parsing output: 50/ for test: kms_frontbuffer_tracking
results: parsing output: 51/ for test: gem_mmap_gtt
results: parsing output: 52/ for test: core_getstats
results: parsing output: 53/ for test: kms_big_fb
results: parsing output: 54/ for test: gem_userptr_blits
results: parsing output: 55/ for test: gem_render_copy
results: parsing output: 56/ for test: gem_exec_balancer
results: parsing output: 57/ for test: core_setmaster
results: parsing output: 58/ for test: i915_drm_fdinfo
results: parsing output: 59/ for test: kms_psr2_sf
results: parsing output: 60/ for test: kms_addfb_basic
results: parsing output: 61/ for test: kms_ccs
results: parsing output: 62/ for test: gem_busy
results: parsing output: 63/ for test: gem_mmap_wc
results: parsing output: 64/ for test: kms_frontbuffer_tracking
results: parsing output: 65/ for test: vgem_basic
results: parsing output: 66/ for test: kms_selftest
results: parsing output: 67/ for test: kms_psr
results: parsing output: 68/ for test: kms_ccs
results: parsing output: 69/ for test: kms_vblank
results: parsing output: 70/ for test: kms_flip
results: parsing output: 71/ for test: gem_pread
results: parsing output: 72/ for test: gen3_render_tiledx_blits
results: parsing output: 73/ for test: i915_query
results: parsing output: 74/ for test: kms_frontbuffer_tracking
results: parsing output: 75/ for test: gem_ctx_persistence
results: parsing output: 76/ for test: kms_chamelium_edid
results: parsing output: 77/ for test: kms_frontbuffer_tracking
results: parsing output: 78/ for test: kms_frontbuffer_tracking
results: parsing output: 79/ for test: core_auth
results: parsing output: 80/ for test: kms_big_fb
results: parsing output: 81/ for test: gem_sync
results: parsing output: 82/ for test: kms_cursor_legacy
results: parsing output: 83/ for test: perf_pmu
results: parsing output: 84/ for test: perf
results: parsing output: 85/ for test: gem_mmap_offset
results: parsing output: 86/ for test: gem_exec_balancer
results: parsing output: 87/ for test: kms_getfb
results: parsing output: 88/ for test: kms_draw_crc
results: parsing output: 89/ for test: syncobj_wait
results: parsing output: 90/ for test: kms_frontbuffer_tracking
results: parsing output: 91/ for test: kms_frontbuffer_tracking
results: parsing output: 92/ for test: syncobj_timeline
results: parsing output: 93/ for test: kms_flip_scaled_crc
results: parsing output: 94/ for test: gem_ctx_exec
results: parsing output: 95/ for test: kms_frontbuffer_tracking
results: parsing output: 96/ for test: gen9_exec_parse
results: parsing output: 97/ for test: kms_frontbuffer_tracking
results: parsing output: 98/ for test: perf
results: parsing output: 99/ for test: kms_color
results: parsing output: 100/ for test: syncobj_wait
results: parsing output: 101/ for test: gem_exec_schedule
results: parsing output: 102/ for test: tools_test
results: parsing output: 103/ for test: gem_close_race
results: parsing output: 104/ for test: kms_frontbuffer_tracking
results: parsing output: 105/ for test: gem_tiling_max_stride
results: parsing output: 106/ for test: kms_async_flips
results: parsing output: 107/ for test: gem_userptr_blits
results: parsing output: 108/ for test: kms_psr2_sf
results: parsing output: 109/ for test: kms_psr
results: parsing output: 110/ for test: kms_flip
results: parsing output: 111/ for test: gem_ctx_param
results: parsing output: 112/ for test: kms_pipe_crc_basic
results: parsing output: 113/ for test: kms_ccs
results: parsing output: 114/ for test: kms_frontbuffer_tracking
results: parsing output: 115/ for test: gem_fence_thrash
results: parsing output: 116/ for test: kms_flip
results: parsing output: 117/ for test: kms_psr
results: parsing output: 118/ for test: gem_exec_reloc
results: parsing output: 119/ for test: gem_exec_schedule
results: parsing output: 120/ for test: kms_joiner
results: parsing output: 121/ for test: gem_exec_fence
results: parsing output: 122/ for test: gem_exec_params
results: parsing output: 123/ for test: gem_softpin
results: parsing output: 124/ for test: kms_cursor_crc
results: parsing output: 125/ for test: kms_ccs
results: parsing output: 126/ for test: gem_userptr_blits
results: parsing output: 127/ for test: kms_flip_scaled_crc
results: parsing output: 128/ for test: kms_big_fb
results: parsing output: 129/ for test: kms_flip
results: parsing output: 130/ for test: kms_frontbuffer_tracking
results: parsing output: 131/ for test: kms_big_fb
Done.