[59.490040] Initializing watchdogs
[59.490090]   /dev/watchdog0
[59.503889] [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.508277] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[59.510836] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[59.514931] [001/133] (960s left) gem_mmap_gtt (zero-extend)
[59.601144] Subtest zero-extend: SKIP (0.000s)
[59.652312] [002/133] (960s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-mmap-cpu)
[59.760794] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-mmap-cpu
[59.765456] Subtest fbc-2p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[59.857392] [003/133] (960s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-mmap-gtt)
[59.953279] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-mmap-gtt
[59.957422] Subtest fbc-2p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[60.038699] [004/133] (960s left) gem_partial_pwrite_pread (reads-uncached)
[60.102724] Subtest reads-uncached: SKIP (0.000s)
[60.167367] [005/133] (959s left) kms_chamelium_edid (dp-edid-read)
[60.551886] Subtest dp-edid-read: SKIP (0.000s)
[61.354650] [006/133] (958s left) gen9_exec_parse (bb-start-far)
[61.413583] Subtest bb-start-far: SKIP (0.000s)
[61.495827] [007/133] (958s left) perf (invalid-oa-format-id)
[61.633662] Starting subtest: invalid-oa-format-id
[61.642674] Subtest invalid-oa-format-id: SUCCESS (0.010s)
[61.684335] [008/133] (958s left) kms_dp_link_training (uhbr-sst)
[61.785808] Starting subtest: uhbr-sst
[61.794420] Subtest uhbr-sst: SKIP (0.000s)
[61.868080] [009/133] (958s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-shrfb-draw-mmap-wc)
[61.966354] Starting subtest: fbc-1p-offscreen-pri-shrfb-draw-mmap-wc
[65.989603] Subtest fbc-1p-offscreen-pri-shrfb-draw-mmap-wc: SUCCESS (4.023s)
[67.206879] [010/133] (953s left) gem_userptr_blits (sync-overlap)
[67.409964] Starting subtest: sync-overlap
[67.412515] Subtest sync-overlap: SUCCESS (0.000s)
[67.781159] [011/133] (952s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-cpu)
[67.955526] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-cpu
[67.959945] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[68.092243] [012/133] (952s left) kms_psr (fbc-psr-sprite-mmap-gtt)
[68.224820] Starting subtest: fbc-psr-sprite-mmap-gtt
[68.226768] Starting dynamic subtest: eDP-1
[68.230892] Dynamic subtest eDP-1: SKIP (0.000s)
[68.235141] Subtest fbc-psr-sprite-mmap-gtt: SKIP (0.001s)
[68.294889] [013/133] (952s left) kms_rotation_crc (primary-4-tiled-reflect-x-180)
[68.385776] Starting subtest: primary-4-tiled-reflect-x-180
[75.386443] Subtest primary-4-tiled-reflect-x-180: SUCCESS (7.001s)
[76.544337] [014/133] (944s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-render)
[76.649241] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-render
[76.653712] Subtest fbc-2p-primscrn-pri-shrfb-draw-render: SKIP (0.000s)
[76.746306] [015/133] (943s left) kms_frontbuffer_tracking (fbc-rgb565-draw-mmap-wc)
[76.844706] Starting subtest: fbc-rgb565-draw-mmap-wc
[80.898613] Subtest fbc-rgb565-draw-mmap-wc: SUCCESS (4.058s)
[82.067899] [016/133] (938s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-render)
[82.157330] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-render
[82.161376] Subtest fbc-2p-scndscrn-cur-indfb-draw-render: SKIP (0.000s)
[82.245423] [017/133] (938s left) syncobj_wait (single-wait-for-submit-signaled)
[82.298732] Starting subtest: single-wait-for-submit-signaled
[82.301054] Subtest single-wait-for-submit-signaled: SUCCESS (0.000s)
[82.391830] [018/133] (938s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-32bpp-ytileccs-downscaling)
[82.482275] Starting subtest: flip-32bpp-ytile-to-32bpp-ytileccs-downscaling
[82.486467] Subtest flip-32bpp-ytile-to-32bpp-ytileccs-downscaling: SKIP (0.000s)
[82.549108] [019/133] (938s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-mmap-cpu)
[82.650433] Starting subtest: psr-2p-primscrn-pri-indfb-draw-mmap-cpu
[82.654515] Subtest psr-2p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[82.741801] [020/133] (938s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-indfb-msflip-blt)
[82.853967] Starting subtest: fbc-2p-scndscrn-indfb-msflip-blt
[82.858335] Subtest fbc-2p-scndscrn-indfb-msflip-blt: SKIP (0.000s)
[82.967203] [021/133] (937s left) kms_ccs (bad-rotation-90-4-tiled-mtl-rc-ccs)
[83.060530] Starting subtest: bad-rotation-90-4-tiled-mtl-rc-ccs
[83.062192] Starting dynamic subtest: pipe-A-eDP-1
[83.215296] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.149s)
[83.223306] Starting dynamic subtest: pipe-B-eDP-1
[83.239543] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[83.247697] Starting dynamic subtest: pipe-C-eDP-1
[83.263075] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.002s)
[83.269761] Starting dynamic subtest: pipe-D-eDP-1
[83.285093] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.002s)
[83.286577] Subtest bad-rotation-90-4-tiled-mtl-rc-ccs: SUCCESS (0.157s)
[85.510858] [022/133] (935s left) kms_psr2_su (page_flip-nv12)
[85.571093] Subtest page_flip-NV12: SKIP (0.000s)
[85.622830] [023/133] (935s left) kms_big_fb (yf-tiled-16bpp-rotate-180)
[85.719455] Starting subtest: yf-tiled-16bpp-rotate-180
[85.723744] Subtest yf-tiled-16bpp-rotate-180: SKIP (0.000s)
[85.815707] [024/133] (935s left) kms_big_fb (x-tiled-16bpp-rotate-270)
[85.924453] Starting subtest: x-tiled-16bpp-rotate-270
[85.944603] Subtest x-tiled-16bpp-rotate-270: SKIP (0.019s)
[86.058660] [025/133] (934s left) gem_exec_whisper (basic-forked-all)
[86.122827] Starting subtest: basic-forked-all
[99.039838] Subtest basic-forked-all: SUCCESS (12.913s)
[99.225112] [026/133] (921s left) kms_cursor_crc (cursor-offscreen-32x32)
[99.378286] Starting subtest: cursor-offscreen-32x32
[99.424060] Subtest cursor-offscreen-32x32: SKIP (0.044s)
[99.702900] [027/133] (921s left) kms_pm_backlight (fade-with-suspend)
[99.791267] Starting subtest: fade-with-suspend
[116.303632] Starting dynamic subtest: eDP-1
[118.990549] Dynamic subtest eDP-1: SUCCESS (2.682s)
[118.993016] Subtest fade-with-suspend: SUCCESS (3.969s)
[119.799619] [028/133] (901s left) syncobj_wait (single-wait-for-submit-unsubmitted)
[119.867245] Starting subtest: single-wait-for-submit-unsubmitted
[119.972950] Subtest single-wait-for-submit-unsubmitted: SUCCESS (0.104s)
[120.045982] [029/133] (901s left) kms_color_pipeline (plane-ctm3x4-lut1d)
[120.142842] Starting subtest: plane-ctm3x4-lut1d
[120.301940] Starting dynamic subtest: pipe-A-plane-0
[120.467365] Dynamic subtest pipe-A-plane-0: SUCCESS (0.166s)
[120.477937] Starting dynamic subtest: pipe-A-plane-1
[120.645766] Dynamic subtest pipe-A-plane-1: SUCCESS (0.178s)
[120.655797] Starting dynamic subtest: pipe-A-plane-2
[120.813265] Dynamic subtest pipe-A-plane-2: SUCCESS (0.166s)
[122.018428] Starting dynamic subtest: pipe-B-plane-0
[122.189048] Dynamic subtest pipe-B-plane-0: SUCCESS (0.178s)
[122.199527] Starting dynamic subtest: pipe-B-plane-1
[122.345374] Dynamic subtest pipe-B-plane-1: SUCCESS (0.155s)
[122.355498] Starting dynamic subtest: pipe-B-plane-2
[122.512743] Dynamic subtest pipe-B-plane-2: SUCCESS (0.166s)
[123.763776] Starting dynamic subtest: pipe-C-plane-0
[123.900708] Dynamic subtest pipe-C-plane-0: SUCCESS (0.144s)
[123.911452] Starting dynamic subtest: pipe-C-plane-1
[124.069085] Dynamic subtest pipe-C-plane-1: SUCCESS (0.166s)
[124.079167] Starting dynamic subtest: pipe-C-plane-2
[124.223624] Dynamic subtest pipe-C-plane-2: SUCCESS (0.155s)
[125.389292] Starting dynamic subtest: pipe-D-plane-0
[125.548583] Dynamic subtest pipe-D-plane-0: SUCCESS (0.166s)
[125.557636] Starting dynamic subtest: pipe-D-plane-1
[125.714631] Dynamic subtest pipe-D-plane-1: SUCCESS (0.166s)
[125.724294] Starting dynamic subtest: pipe-D-plane-2
[125.881887] Dynamic subtest pipe-D-plane-2: SUCCESS (0.166s)
[126.171599] Subtest plane-ctm3x4-lut1d: SUCCESS (6.012s)
[127.051047] [030/133] (894s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-mmap-wc)
[127.157076] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-mmap-wc
[127.161111] Subtest psr-2p-scndscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[127.254452] [031/133] (893s left) gem_exec_reloc (basic-write-cpu-noreloc)
[127.324055] Subtest basic-write-cpu-noreloc: SKIP (0.000s)
[127.410709] [032/133] (893s left) kms_universal_plane (universal-plane-pageflip-windowed)
[127.505780] Starting subtest: universal-plane-pageflip-windowed
[127.508034] Starting dynamic subtest: pipe-A-eDP-1
[128.104944] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.597s)
[128.114847] Starting dynamic subtest: pipe-B-eDP-1
[129.311143] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.201s)
[129.323561] Starting dynamic subtest: pipe-C-eDP-1
[130.529049] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.215s)
[130.538330] Starting dynamic subtest: pipe-D-eDP-1
[131.760306] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.229s)
[131.762560] Subtest universal-plane-pageflip-windowed: SUCCESS (4.247s)
[132.626534] [033/133] (888s left) syncobj_timeline (multi-wait-all-available-signaled)
[132.688287] Starting subtest: multi-wait-all-available-signaled
[132.690801] Subtest multi-wait-all-available-signaled: SUCCESS (0.001s)
[132.775898] [034/133] (888s left) gem_exec_schedule (preempt-user)
[132.851492] Starting subtest: preempt-user
[132.853875] Starting dynamic subtest: rcs0
[132.872237] Dynamic subtest rcs0: SUCCESS (0.027s)
[132.882264] Starting dynamic subtest: bcs0
[132.894531] Dynamic subtest bcs0: SUCCESS (0.022s)
[132.903477] Starting dynamic subtest: vcs0
[132.920505] Dynamic subtest vcs0: SUCCESS (0.025s)
[132.929186] Starting dynamic subtest: vcs1
[132.939706] Dynamic subtest vcs1: SUCCESS (0.019s)
[132.948369] Starting dynamic subtest: vecs0
[132.956781] Dynamic subtest vecs0: SUCCESS (0.017s)
[132.965513] Starting dynamic subtest: ccs0
[132.976247] Dynamic subtest ccs0: SUCCESS (0.019s)
[132.978494] Subtest preempt-user: SUCCESS (0.131s)
[134.221368] [035/133] (887s left) gem_exec_schedule (deep)
[134.420209] Starting subtest: deep
[134.422607] Starting dynamic subtest: rcs0
[140.348974] Dynamic subtest rcs0: SKIP (5.918s)
[140.359959] Starting dynamic subtest: vcs0
[150.439794] Dynamic subtest vcs0: SUCCESS (10.095s)
[150.454659] Starting dynamic subtest: vcs1
[161.668609] Dynamic subtest vcs1: SUCCESS (11.228s)
[161.679028] Starting dynamic subtest: vecs0
[172.489604] Dynamic subtest vecs0: SUCCESS (10.817s)
[172.499779] Starting dynamic subtest: ccs0
[185.002154] Dynamic subtest ccs0: SUCCESS (12.508s)
[185.004661] Subtest deep: SUCCESS (50.570s)
[186.937523] [FACT gem_exec_schedule (deep)] new: kernel.kmod_is_loaded.vgem: true
[186.940844] [036/133] (834s left) gem_mmap_gtt (basic-read-write-distinct)
[187.010309] Subtest basic-read-write-distinct: SKIP (0.000s)
[187.076264] [037/133] (834s left) kms_ccs (random-ccs-data-4-tiled-dg2-rc-ccs)
[187.178473] Starting subtest: random-ccs-data-4-tiled-dg2-rc-ccs
[187.180802] Starting dynamic subtest: pipe-A-eDP-1
[187.205203] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[187.216274] Starting dynamic subtest: pipe-B-eDP-1
[187.238912] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[187.247579] Starting dynamic subtest: pipe-C-eDP-1
[187.270569] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[187.279237] Starting dynamic subtest: pipe-D-eDP-1
[187.303075] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[187.307126] Subtest random-ccs-data-4-tiled-dg2-rc-ccs: SKIP (0.003s)
[189.499209] [038/133] (831s left) gem_softpin (allocator-nopin-reserve)
[189.552439] Starting subtest: allocator-nopin-reserve
[189.640041] Subtest allocator-nopin-reserve: SUCCESS (0.087s)
[189.757384] [039/133] (831s left) kms_pm_rpm (modeset-non-lpsp-stress)
[191.286557] Starting subtest: modeset-non-lpsp-stress
[192.439413] Subtest modeset-non-lpsp-stress: SKIP (1.153s)
[192.832738] [040/133] (828s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-pwrite)
[192.950494] Starting subtest: psr-1p-primscrn-spr-indfb-draw-pwrite
[199.816635] Subtest psr-1p-primscrn-spr-indfb-draw-pwrite: SUCCESS (6.868s)
[199.931893] [041/133] (821s left) gem_ctx_persistence (engines-queued)
[199.997302] Starting subtest: engines-queued
[199.999449] Starting dynamic subtest: rcs0
[200.084959] Dynamic subtest rcs0: SUCCESS (0.087s)
[200.097946] Starting dynamic subtest: bcs0
[200.130998] Dynamic subtest bcs0: SUCCESS (0.044s)
[200.142613] Starting dynamic subtest: vcs0
[202.089488] Dynamic subtest vcs0: SUCCESS (1.955s)
[202.102490] Starting dynamic subtest: vcs1
[204.071380] Dynamic subtest vcs1: SUCCESS (1.979s)
[204.086567] Starting dynamic subtest: vecs0
[206.172117] Dynamic subtest vecs0: SUCCESS (2.044s)
[206.183632] Starting dynamic subtest: ccs0
[206.310314] Dynamic subtest ccs0: SUCCESS (0.191s)
[206.312806] Subtest engines-queued: SUCCESS (6.311s)
[206.442497] [042/133] (815s left) kms_hdr (static-toggle-suspend)
[206.538717] Starting subtest: static-toggle-suspend
[206.545027] Subtest static-toggle-suspend: SKIP (0.000s)
[206.610946] [043/133] (815s left) kms_chamelium_hpd (vga-hpd)
[206.989164] Subtest vga-hpd: SKIP (0.000s)
[207.843145] [044/133] (813s left) kms_ccs (crc-primary-suspend-4-tiled-mtl-rc-ccs-cc)
[207.927947] Starting subtest: crc-primary-suspend-4-tiled-mtl-rc-ccs-cc
[207.929980] Starting dynamic subtest: pipe-A-eDP-1
[224.576285] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.449s)
[224.596872] Starting dynamic subtest: pipe-B-eDP-1
[241.507934] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.420s)
[241.517581] Starting dynamic subtest: pipe-C-eDP-1
[258.479949] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.431s)
[258.494403] Starting dynamic subtest: pipe-D-eDP-1
[275.446217] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.326s)
[275.448392] Subtest crc-primary-suspend-4-tiled-mtl-rc-ccs-cc: SUCCESS (8.631s)
[276.600540] [045/133] (745s left) syncobj_basic (bad-flags-handle-to-fd)
[276.663241] Starting subtest: bad-flags-handle-to-fd
[276.666448] Subtest bad-flags-handle-to-fd: SUCCESS (0.000s)
[276.761820] [046/133] (745s left) gem_wait (busy)
[276.821296] Starting subtest: busy
[276.823611] Starting dynamic subtest: all-engines
[277.996859] Dynamic subtest all-engines: SUCCESS (1.169s)
[278.008675] Starting dynamic subtest: rcs0
[278.538674] Dynamic subtest rcs0: SUCCESS (0.539s)
[278.550858] Starting dynamic subtest: bcs0
[279.078470] Dynamic subtest bcs0: SUCCESS (0.537s)
[279.087917] Starting dynamic subtest: vcs0
[281.004883] Dynamic subtest vcs0: SUCCESS (1.918s)
[281.017215] Starting dynamic subtest: vcs1
[282.989235] Dynamic subtest vcs1: SUCCESS (1.976s)
[283.001798] Starting dynamic subtest: vecs0
[284.975309] Dynamic subtest vecs0: SUCCESS (1.977s)
[284.988652] Starting dynamic subtest: ccs0
[285.515220] Dynamic subtest ccs0: SUCCESS (0.540s)
[285.517748] Subtest busy: SUCCESS (8.668s)
[285.714527] [047/133] (736s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-cpu)
[285.826232] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-cpu
[292.924975] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-cpu: SUCCESS (7.092s)
[293.061342] [048/133] (728s left) i915_drm_fdinfo (virtual-busy-hang-all)
[293.108270] Starting subtest: virtual-busy-hang-all
[293.114118] Subtest virtual-busy-hang-all: SKIP (0.000s)
[293.180246] [049/133] (728s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-pwrite)
[293.286498] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-pwrite
[293.291370] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[293.402405] [050/133] (728s left) kms_lease (page-flip-implicit-plane)
[293.490123] Starting subtest: page-flip-implicit-plane
[293.492745] Starting dynamic subtest: pipe-A-eDP-1
[293.967739] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.478s)
[293.977911] Starting dynamic subtest: pipe-B-eDP-1
[295.089344] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.121s)
[295.099772] Starting dynamic subtest: pipe-C-eDP-1
[296.204352] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.111s)
[296.215078] Starting dynamic subtest: pipe-D-eDP-1
[297.342378] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.136s)
[297.345188] Subtest page-flip-implicit-plane: SUCCESS (3.851s)
[298.200451] [051/133] (723s left) gem_pxp (reject-modify-context-protection-off-3)
[298.312767] Starting subtest: reject-modify-context-protection-off-3
[298.315200] Subtest reject-modify-context-protection-off-3: SUCCESS (0.002s)
[298.421353] [052/133] (723s left) kms_plane_multiple (2x-tiling-none)
[298.508815] Starting subtest: 2x-tiling-none
[298.513469] Subtest 2x-tiling-none: SKIP (0.000s)
[298.586966] [053/133] (723s left) kms_plane (pixel-format-yf-tiled-ccs-modifier-source-clamping)
[298.678162] Starting subtest: pixel-format-yf-tiled-ccs-modifier-source-clamping
[298.683147] Subtest pixel-format-yf-tiled-ccs-modifier-source-clamping: SKIP (0.000s)
[298.752858] [054/133] (723s left) gem_workarounds (suspend-resume-context)
[298.840142] Starting subtest: suspend-resume-context
[315.442517] Subtest suspend-resume-context: SUCCESS (1.322s)
[315.571168] [055/133] (706s left) gem_ccs (large-ctrl-surf-copy)
[315.641293] Starting subtest: large-ctrl-surf-copy
[315.647280] Subtest large-ctrl-surf-copy: SKIP (0.000s)
[315.746938] [056/133] (706s left) gem_exec_whisper (basic-queues-priority-all)
[315.809477] Starting subtest: basic-queues-priority-all
[337.560761] Subtest basic-queues-priority-all: SUCCESS (21.698s)
[337.745365] [057/133] (684s left) gem_exec_reloc (basic-write-read-active)
[337.810280] Subtest basic-write-read-active: SKIP (0.000s)
[337.878977] [058/133] (684s left) kms_frontbuffer_tracking (fbc-2p-primscrn-indfb-msflip-blt)
[337.997051] Starting subtest: fbc-2p-primscrn-indfb-msflip-blt
[338.002181] Subtest fbc-2p-primscrn-indfb-msflip-blt: SKIP (0.000s)
[338.109979] [059/133] (684s left) kms_psr (pr-cursor-plane-onoff)
[338.197432] Starting subtest: pr-cursor-plane-onoff
[338.202633] Subtest pr-cursor-plane-onoff: SKIP (0.000s)
[338.269568] [060/133] (684s left) kms_getfb (getfb2-handle-not-fb)
[338.364387] Starting subtest: getfb2-handle-not-fb
[338.367293] Subtest getfb2-handle-not-fb: SUCCESS (0.000s)
[338.461873] [061/133] (683s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-mmap-wc)
[338.563901] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-mmap-wc
[338.568541] Subtest fbc-2p-scndscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[338.646137] [062/133] (683s left) api_intel_bb (simple-bb)
[338.697177] Starting subtest: simple-bb
[338.702798] Subtest simple-bb: SUCCESS (0.008s)
[338.818796] [063/133] (683s left) kms_pipe_b_c_ivb (enable-pipe-c-while-b-has-3-lanes)
[338.885749] Subtest enable-pipe-C-while-B-has-3-lanes: SKIP (0.000s)
[338.947257] [064/133] (683s left) kms_psr2_sf (fbc-pr-cursor-plane-move-continuous-sf)
[339.042698] Starting subtest: fbc-pr-cursor-plane-move-continuous-sf
[339.046920] Subtest fbc-pr-cursor-plane-move-continuous-sf: SKIP (0.000s)
[339.111953] [065/133] (683s left) prime_vgem (basic-write)
[339.178180] Starting subtest: basic-write
[339.230153] Subtest basic-write: SKIP (0.048s)
[339.336659] [066/133] (683s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-0-hflip)
[339.445035] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-0-hflip
[340.480213] Subtest 4-tiled-max-hw-stride-32bpp-rotate-0-hflip: SUCCESS (1.035s)
[340.603904] [067/133] (682s left) gem_flink_basic (bad-flink)
[340.652088] Starting subtest: bad-flink
[340.654085] Subtest bad-flink: SUCCESS (0.000s)
[340.756276] [068/133] (681s left) perf_pmu (rc6-all-gts)
[340.798293] Starting subtest: rc6-all-gts
[347.222083] Subtest rc6-all-gts: SUCCESS (6.366s)
[348.213271] [069/133] (674s left) gem_render_copy (y-tiled-to-vebox-x-tiled)
[348.282082] Starting subtest: y-tiled-to-vebox-x-tiled
[348.286493] Subtest y-tiled-to-vebox-x-tiled: SKIP (0.000s)
[348.469125] [070/133] (674s left) core_getversion (basic)
[348.514884] Starting subtest: basic
[348.520414] Subtest basic: SUCCESS (0.000s)
[348.581833] [071/133] (674s left) kms_cursor_crc (cursor-sliding-64x64)
[348.772294] Starting subtest: cursor-sliding-64x64
[348.775047] Starting dynamic subtest: pipe-A-eDP-1
[352.038409] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.265s)
[352.073899] Starting dynamic subtest: pipe-D-eDP-1
[355.950327] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.892s)
[355.953147] Subtest cursor-sliding-64x64: SUCCESS (7.183s)
[356.800415] [072/133] (666s left) kms_big_fb (y-tiled-64bpp-rotate-0)
[356.898719] Starting subtest: y-tiled-64bpp-rotate-0
[356.904013] Subtest y-tiled-64bpp-rotate-0: SKIP (0.000s)
[356.996748] [073/133] (665s left) gem_exec_create (madvise)
[357.052480] Starting subtest: madvise
[357.055176] Starting dynamic subtest: smem
[378.342269] Dynamic subtest smem: SUCCESS (21.283s)
[378.344966] Subtest madvise: SUCCESS (21.284s)
[379.273789] [074/133] (643s left) kms_ccs (crc-primary-basic-y-tiled-gen12-mc-ccs)
[379.376196] Starting subtest: crc-primary-basic-y-tiled-gen12-mc-ccs
[379.378674] Starting dynamic subtest: pipe-A-eDP-1
[379.403102] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[379.412703] Starting dynamic subtest: pipe-B-eDP-1
[379.437479] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[379.446720] Starting dynamic subtest: pipe-C-eDP-1
[379.473293] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[379.484337] Starting dynamic subtest: pipe-D-eDP-1
[379.510965] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[379.515743] Subtest crc-primary-basic-y-tiled-gen12-mc-ccs: SKIP (0.006s)
[381.642984] [075/133] (641s left) api_intel_allocator (gem-pool)
[381.701279] Starting subtest: gem-pool
[381.707057] Subtest gem-pool: SUCCESS (0.009s)
[381.816267] [076/133] (641s left) kms_big_fb (linear-8bpp-rotate-180)
[381.913719] Starting subtest: linear-8bpp-rotate-180
[383.228633] Subtest linear-8bpp-rotate-180: SUCCESS (1.316s)
[383.338412] [077/133] (639s left) kms_psr2_sf (fbc-psr2-overlay-plane-update-sf-dmg-area)
[383.432299] Starting subtest: fbc-psr2-overlay-plane-update-sf-dmg-area
[383.434834] Starting dynamic subtest: pipe-A-eDP-1
[383.545032] Dynamic subtest pipe-A-eDP-1: SKIP (0.114s)
[383.554906] Starting dynamic subtest: pipe-B-eDP-1
[384.727054] Dynamic subtest pipe-B-eDP-1: SKIP (1.179s)
[384.732309] Subtest fbc-psr2-overlay-plane-update-sf-dmg-area: SKIP (1.296s)
[385.917222] [078/133] (637s left) kms_cursor_legacy (cursorb-vs-flipa-atomic)
[386.028507] Starting subtest: cursorB-vs-flipA-atomic
[386.033120] Subtest cursorB-vs-flipA-atomic: SKIP (0.001s)
[386.175326] [079/133] (637s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-pwrite)
[386.269346] Starting subtest: psr-1p-primscrn-cur-indfb-draw-pwrite
[393.159154] Subtest psr-1p-primscrn-cur-indfb-draw-pwrite: SUCCESS (6.892s)
[393.272340] [080/133] (629s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-wc)
[393.386339] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-wc
[400.040842] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-wc: SUCCESS (6.656s)
[400.192011] [081/133] (623s left) kms_plane (plane-panning-bottom-right-suspend)
[400.286250] Starting subtest: plane-panning-bottom-right-suspend
[400.288712] Starting dynamic subtest: pipe-A
[417.692178] Dynamic subtest pipe-A: SUCCESS (2.857s)
[417.702173] Starting dynamic subtest: pipe-B
[436.729729] Dynamic subtest pipe-B: SUCCESS (3.516s)
[436.732363] Subtest plane-panning-bottom-right-suspend: SUCCESS (6.377s)
[437.603026] [082/133] (585s left) gem_exec_fence (syncobj-repeat)
[438.054923] Starting subtest: syncobj-repeat
[438.239871] Subtest syncobj-repeat: SUCCESS (0.183s)
[439.368563] [083/133] (584s left) kms_flip_scaled_crc (flip-32bpp-linear-to-64bpp-linear-downscaling)
[439.468085] Starting subtest: flip-32bpp-linear-to-64bpp-linear-downscaling
[439.470748] Starting dynamic subtest: pipe-A-default-mode
[440.595350] Dynamic subtest pipe-A-default-mode: SKIP (1.120s)
[440.601119] Subtest flip-32bpp-linear-to-64bpp-linear-downscaling: SKIP (1.121s)
[440.737723] [084/133] (582s left) gem_exec_params (no-bsd)
[440.797517] Starting subtest: no-bsd
[440.799900] Subtest no-bsd: SUCCESS (0.003s)
[442.390346] [085/133] (581s left) gem_ctx_bad_destroy (invalid-pad)
[442.437473] Starting subtest: invalid-pad
[442.440337] Subtest invalid-pad: SUCCESS (0.000s)
[442.515044] [086/133] (580s left) kms_flip (flip-vs-expired-vblank-interruptible)
[442.606365] Starting subtest: flip-vs-expired-vblank-interruptible
[442.608856] Starting dynamic subtest: A-eDP1
[451.305374] Dynamic subtest A-eDP1: SUCCESS (8.644s)
[451.316878] Starting dynamic subtest: B-eDP1
[459.950949] Dynamic subtest B-eDP1: SUCCESS (8.634s)
[459.967703] Starting dynamic subtest: C-eDP1
[468.592560] Dynamic subtest C-eDP1: SUCCESS (8.626s)
[468.601866] Starting dynamic subtest: D-eDP1
[477.230818] Dynamic subtest D-eDP1: SUCCESS (8.639s)
[477.233871] Subtest flip-vs-expired-vblank-interruptible: SUCCESS (34.560s)
[478.436553] [087/133] (545s left) gen9_exec_parse (unaligned-jump)
[478.488147] Subtest unaligned-jump: SKIP (0.000s)
[478.547898] [088/133] (545s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-shrfb-plflip-blt)
[478.656054] Starting subtest: fbcpsr-2p-scndscrn-shrfb-plflip-blt
[478.660595] Subtest fbcpsr-2p-scndscrn-shrfb-plflip-blt: SKIP (0.000s)
[478.756472] [089/133] (544s left) perf (gen12-group-exclusive-stream-ctx-handle)
[478.856577] Starting subtest: gen12-group-exclusive-stream-ctx-handle
[478.886038] Subtest gen12-group-exclusive-stream-ctx-handle: SUCCESS (0.027s)
[478.931869] [090/133] (544s left) kms_atomic (atomic-invalid-params)
[480.327860] Starting subtest: atomic-invalid-params
[480.330257] Starting dynamic subtest: pipe-A-eDP-1
[480.726340] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.397s)
[480.729135] Subtest atomic-invalid-params: SUCCESS (0.399s)
[481.574360] [091/133] (542s left) perf (low-oa-exponent-permissions)
[481.669534] Starting subtest: low-oa-exponent-permissions
[481.706860] Subtest low-oa-exponent-permissions: SUCCESS (0.037s)
[481.751827] [092/133] (541s left) syncobj_timeline (etime-single-wait-all-for-submit-available-unsubmitted)
[481.812556] Starting subtest: etime-single-wait-all-for-submit-available-unsubmitted
[481.914233] Subtest etime-single-wait-all-for-submit-available-unsubmitted: SUCCESS (0.102s)
[481.999595] [093/133] (541s left) gem_busy (semaphore)
[482.197188] Subtest semaphore: SKIP (0.000s)
[482.423622] [094/133] (541s left) gem_exec_schedule (pi-userfault)
[482.602690] Starting subtest: pi-userfault
[482.604782] Starting dynamic subtest: rcs0
[482.612623] Dynamic subtest rcs0: SUCCESS (0.012s)
[482.622241] Starting dynamic subtest: bcs0
[482.627183] Dynamic subtest bcs0: SUCCESS (0.012s)
[482.635801] Starting dynamic subtest: vcs0
[482.637833] Dynamic subtest vcs0: SUCCESS (0.012s)
[482.646950] Starting dynamic subtest: vcs1
[482.649226] Dynamic subtest vcs1: SUCCESS (0.009s)
[482.658156] Starting dynamic subtest: vecs0
[482.660328] Dynamic subtest vecs0: SUCCESS (0.008s)
[482.669513] Starting dynamic subtest: ccs0
[482.671720] Dynamic subtest ccs0: SUCCESS (0.008s)
[482.674020] Subtest pi-userfault: SUCCESS (0.066s)
[482.852796] [095/133] (541s left) kms_flip (flip-vs-absolute-wf_vblank)
[482.959050] Starting subtest: flip-vs-absolute-wf_vblank
[482.961316] Starting dynamic subtest: A-eDP1
[491.912313] Dynamic subtest A-eDP1: SUCCESS (8.955s)
[491.922705] Starting dynamic subtest: B-eDP1
[500.836692] Dynamic subtest B-eDP1: SUCCESS (8.921s)
[500.848030] Starting dynamic subtest: C-eDP1
[509.810567] Dynamic subtest C-eDP1: SUCCESS (8.926s)
[509.819945] Starting dynamic subtest: D-eDP1
[518.750052] Dynamic subtest D-eDP1: SUCCESS (8.930s)
[518.752739] Subtest flip-vs-absolute-wf_vblank: SUCCESS (35.745s)
[519.933797] [096/133] (503s left) sw_sync (sync_multi_consumer_producer)
[519.973809] Starting subtest: sync_multi_consumer_producer
[520.288729] Subtest sync_multi_consumer_producer: SUCCESS (0.317s)
[520.355095] [097/133] (503s left) kms_chamelium_audio (dp-audio)
[520.734451] Subtest dp-audio: SKIP (0.000s)
[521.537077] [098/133] (502s left) syncobj_wait (multi-wait-all-submitted)
[521.594569] Starting subtest: multi-wait-all-submitted
[521.699598] Subtest multi-wait-all-submitted: SUCCESS (0.106s)
[521.777724] [099/133] (502s left) gem_ctx_sseu (mmap-args)
[521.831008] Subtest mmap-args: SKIP (0.000s)
[521.896651] [100/133] (502s left) gem_ppgtt (shrink-vs-evict-pinned)
[521.963171] Starting subtest: shrink-vs-evict-pinned
[527.371889] Subtest shrink-vs-evict-pinned: SUCCESS (5.352s)
[527.413935] [101/133] (496s left) prime_mmap (test_correct)
[527.475321] Starting subtest: test_correct
[527.478107] Starting dynamic subtest: test_correct-smem
[527.505881] Dynamic subtest test_correct-smem: SUCCESS (0.033s)
[527.508948] Subtest test_correct: SUCCESS (0.033s)
[527.616098] [102/133] (496s left) kms_flip (2x-flip-vs-panning-vs-hang)
[527.715898] Starting subtest: 2x-flip-vs-panning-vs-hang
[527.721119] Subtest 2x-flip-vs-panning-vs-hang: SKIP (0.002s)
[527.798105] [103/133] (496s left) gem_exec_reloc (basic-wc-cpu)
[527.861229] Subtest basic-wc-cpu: SKIP (0.000s)
[527.922142] [104/133] (496s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-180-hflip)
[528.022968] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-180-hflip
[528.031089] Subtest yf-tiled-max-hw-stride-32bpp-rotate-180-hflip: SKIP (0.000s)
[528.125587] [105/133] (496s left) kms_cursor_legacy (torture-move)
[528.245054] Starting subtest: torture-move
[528.247819] Starting dynamic subtest: pipe-A
[534.198391] Dynamic subtest pipe-A: SUCCESS (5.951s)
[534.209355] Starting dynamic subtest: pipe-B
[541.637534] Dynamic subtest pipe-B: SUCCESS (7.439s)
[541.650458] Starting dynamic subtest: pipe-C
[548.711403] Dynamic subtest pipe-C: SUCCESS (7.073s)
[548.721990] Starting dynamic subtest: pipe-D
[555.275183] Dynamic subtest pipe-D: SUCCESS (6.563s)
[555.290055] Starting dynamic subtest: all-pipes
[561.837619] Dynamic subtest all-pipes: SUCCESS (6.560s)
[561.840243] Subtest torture-move: SUCCESS (33.596s)
[561.995375] [106/133] (462s left) gem_exec_balancer (indices)
[562.075086] Starting subtest: indices
[564.252344] Subtest indices: SUCCESS (2.175s)
[564.565732] [107/133] (459s left) syncobj_basic (bad-handle-to-fd)
[564.624149] Starting subtest: bad-handle-to-fd
[564.627051] Subtest bad-handle-to-fd: SUCCESS (0.000s)
[564.727364] [108/133] (459s left) kms_psr (psr2-primary-render)
[564.821905] Starting subtest: psr2-primary-render
[564.824300] Starting dynamic subtest: eDP-1
[566.542803] Dynamic subtest eDP-1: SUCCESS (1.718s)
[566.545312] Subtest psr2-primary-render: SUCCESS (1.721s)
[567.408559] [109/133] (457s left) kms_addfb_basic (addfb25-4-tiled)
[567.505144] Starting subtest: addfb25-4-tiled
[567.507646] Subtest addfb25-4-tiled: SUCCESS (0.000s)
[567.599499] [110/133] (456s left) kms_concurrent (multi-plane-atomic-lowres)
[567.705289] Starting subtest: multi-plane-atomic-lowres
[567.708009] Starting dynamic subtest: pipe-A-eDP-1
[568.210290] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.503s)
[568.220590] Starting dynamic subtest: pipe-B-eDP-1
[569.453592] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.245s)
[569.464313] Starting dynamic subtest: pipe-C-eDP-1
[570.691490] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.234s)
[570.700926] Starting dynamic subtest: pipe-D-eDP-1
[571.902120] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.210s)
[571.904818] Subtest multi-plane-atomic-lowres: SUCCESS (4.197s)
[572.731642] [111/133] (451s left) i915_pm_rps (thresholds-idle)
[572.809200] Starting subtest: thresholds-idle
[572.814589] Subtest thresholds-idle: SKIP (0.001s)
[572.908789] [112/133] (451s left) gem_ctx_persistence (legacy-engines-hostile-preempt)
[572.966151] Starting subtest: legacy-engines-hostile-preempt
[572.969092] Starting dynamic subtest: render
[573.039213] Dynamic subtest render: SUCCESS (0.073s)
[573.051617] Starting dynamic subtest: bsd1
[574.332461] Dynamic subtest bsd1: SUCCESS (1.288s)
[574.346163] Starting dynamic subtest: bsd2
[576.299744] Dynamic subtest bsd2: SUCCESS (1.964s)
[576.313190] Starting dynamic subtest: blt
[576.383630] Dynamic subtest blt: SUCCESS (0.082s)
[576.395224] Starting dynamic subtest: vebox
[578.302816] Dynamic subtest vebox: SUCCESS (1.915s)
[578.305583] Subtest legacy-engines-hostile-preempt: SUCCESS (5.337s)
[578.383744] [113/133] (446s left) gem_userptr_blits (invalid-null-pointer)
[578.461309] Starting subtest: invalid-null-pointer
[578.463655] Subtest invalid-null-pointer: SUCCESS (0.001s)
[578.590130] [114/133] (446s left) kms_busy (extended-modeset-hang-oldfb)
[578.693219] Starting subtest: extended-modeset-hang-oldfb
[578.696041] Starting dynamic subtest: pipe-A
[590.665819] Dynamic subtest pipe-A: SUCCESS (11.970s)
[590.680635] Starting dynamic subtest: pipe-D
[603.144100] Dynamic subtest pipe-D: SUCCESS (12.473s)
[603.147092] Subtest extended-modeset-hang-oldfb: SUCCESS (24.449s)
[604.038085] [115/133] (420s left) i915_pm_rc6_residency (media-rc6-accuracy)
[604.097624] Starting subtest: media-rc6-accuracy
[604.102863] Subtest media-rc6-accuracy: SKIP (0.000s)
[604.178824] [116/133] (420s left) kms_psr (fbc-pr-primary-page-flip)
[604.279231] Starting subtest: fbc-pr-primary-page-flip
[604.284364] Subtest fbc-pr-primary-page-flip: SKIP (0.000s)
[604.352509] [117/133] (420s left) kms_frontbuffer_tracking (psr-rgb101010-draw-mmap-gtt)
[604.453340] Starting subtest: psr-rgb101010-draw-mmap-gtt
[604.458325] Subtest psr-rgb101010-draw-mmap-gtt: SKIP (0.000s)
[604.555636] [118/133] (420s left) gem_exec_fence (concurrent)
[604.736335] Starting subtest: concurrent
[604.742201] Subtest concurrent: SKIP (0.000s)
[606.423236] [119/133] (418s left) prime_vgem (wait)
[606.496165] Starting subtest: wait
[606.498661] Starting dynamic subtest: rcs0
[606.533983] Dynamic subtest rcs0: SUCCESS (0.040s)
[606.544082] Starting dynamic subtest: bcs0
[606.579754] Dynamic subtest bcs0: SUCCESS (0.045s)
[606.589773] Starting dynamic subtest: vcs0
[606.627295] Dynamic subtest vcs0: SUCCESS (0.047s)
[606.637835] Starting dynamic subtest: vcs1
[606.674351] Dynamic subtest vcs1: SUCCESS (0.046s)
[606.684572] Starting dynamic subtest: vecs0
[606.722241] Dynamic subtest vecs0: SUCCESS (0.047s)
[606.732231] Starting dynamic subtest: ccs0
[606.773034] Dynamic subtest ccs0: SUCCESS (0.050s)
[606.775714] Subtest wait: SUCCESS (0.280s)
[606.902053] [120/133] (418s left) syncobj_timeline (single-wait-all-available-signaled)
[606.963261] Starting subtest: single-wait-all-available-signaled
[606.966162] Subtest single-wait-all-available-signaled: SUCCESS (0.001s)
[607.067338] [121/133] (417s left) syncobj_eventfd (invalid-illegal-handle)
[607.119020] Starting subtest: invalid-illegal-handle
[607.121937] Subtest invalid-illegal-handle: SUCCESS (0.000s)
[607.212986] [122/133] (417s left) kms_cursor_legacy (2x-long-flip-vs-cursor-legacy)
[607.330715] Starting subtest: 2x-long-flip-vs-cursor-legacy
[607.335258] Subtest 2x-long-flip-vs-cursor-legacy: SKIP (0.001s)
[607.478704] [123/133] (417s left) kms_cursor_crc (cursor-rapid-movement-64x64)
[607.653791] Starting subtest: cursor-rapid-movement-64x64
[607.658697] Starting dynamic subtest: pipe-A-eDP-1
[608.197454] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.540s)
[608.229055] Starting dynamic subtest: pipe-D-eDP-1
[609.440210] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.217s)
[609.442540] Subtest cursor-rapid-movement-64x64: SUCCESS (1.785s)
[610.299157] [124/133] (414s left) gem_mmap_gtt (cpuset-medium-copy)
[610.368160] Subtest cpuset-medium-copy: SKIP (0.000s)
[610.426379] [125/133] (414s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-onoff)
[610.525094] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-onoff
[617.662731] Subtest fbcpsr-1p-primscrn-spr-indfb-onoff: SUCCESS (7.141s)
[617.798580] [126/133] (407s left) kms_plane_scaling (planes-downscale-factor-0-5-upscale-factor-0-25)
[617.895192] Starting subtest: planes-downscale-factor-0-5-upscale-factor-0-25
[617.897980] Starting dynamic subtest: pipe-A
[617.916579] Dynamic subtest pipe-A: SKIP (0.018s)
[617.927117] Starting dynamic subtest: pipe-B
[617.947702] Dynamic subtest pipe-B: SKIP (0.031s)
[617.957806] Starting dynamic subtest: pipe-C
[617.981810] Dynamic subtest pipe-C: SKIP (0.031s)
[617.991915] Starting dynamic subtest: pipe-D
[618.013050] Dynamic subtest pipe-D: SKIP (0.033s)
[618.018065] Subtest planes-downscale-factor-0-5-upscale-factor-0-25: SKIP (0.116s)
[618.124807] [127/133] (407s left) vgem_slow (nohang)
[618.171358] Starting subtest: nohang
[628.495035] Subtest nohang: SUCCESS (10.271s)
[628.536626] [128/133] (396s left) syncobj_timeline (multi-wait-for-submit-available-submitted-signaled)
[628.586470] Starting subtest: multi-wait-for-submit-available-submitted-signaled
[628.589292] Subtest multi-wait-for-submit-available-submitted-signaled: SUCCESS (0.000s)
[628.682569] [129/133] (396s left) sysfs_timeslice_duration (duration)
[628.738974] Starting subtest: duration
[628.741552] Starting dynamic subtest: vecs0
[642.205474] Dynamic subtest vecs0: SUCCESS (13.461s)
[642.218586] Starting dynamic subtest: ccs0
[655.372289] Dynamic subtest ccs0: SUCCESS (13.154s)
[655.384576] Starting dynamic subtest: vcs0
[670.237125] Dynamic subtest vcs0: SUCCESS (14.868s)
[670.253353] Starting dynamic subtest: bcs0
[683.396314] Dynamic subtest bcs0: SUCCESS (13.141s)
[683.409131] Starting dynamic subtest: rcs0
[696.516673] Dynamic subtest rcs0: SUCCESS (13.137s)
[696.529359] Starting dynamic subtest: vcs1
[710.237601] Dynamic subtest vcs1: SUCCESS (13.717s)
[710.240283] Subtest duration: SUCCESS (81.496s)
[710.327086] [130/133] (315s left) kms_atomic_transition (plane-use-after-nonblocking-unbind)
[710.420021] Starting subtest: plane-use-after-nonblocking-unbind
[710.422342] Starting dynamic subtest: pipe-A-eDP-1
[710.480190] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.061s)
[710.781915] Starting dynamic subtest: pipe-B-eDP-1
[711.620286] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.853s)
[711.928740] Subtest plane-use-after-nonblocking-unbind: SUCCESS (1.509s)
[712.793993] [131/133] (312s left) kms_vblank (ts-continuation-dpms-rpm)
[712.886137] Starting subtest: ts-continuation-dpms-rpm
[712.889001] Starting dynamic subtest: pipe-A-eDP-1
[715.394621] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.509s)
[715.411812] Starting dynamic subtest: pipe-D-eDP-1
[717.634641] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.238s)
[717.637322] Subtest ts-continuation-dpms-rpm: SUCCESS (4.751s)
[718.433840] [132/133] (307s left) gem_ctx_param (basic-default)
[718.482504] Starting subtest: basic-default
[718.485326] Subtest basic-default: SUCCESS (0.000s)
[718.555523] [133/133] (306s left) kms_pipe_stress (stress-xrgb8888-yftiled)
[718.647166] Starting subtest: stress-xrgb8888-yftiled
[718.651956] Subtest stress-xrgb8888-yftiled: SKIP (0.000s)
[718.711787] Closing watchdogs
results: parsing output: 0/ for test: gem_mmap_gtt
results: parsing output: 1/ for test: kms_frontbuffer_tracking
results: parsing output: 2/ for test: kms_frontbuffer_tracking
results: parsing output: 3/ for test: gem_partial_pwrite_pread
results: parsing output: 4/ for test: kms_chamelium_edid
results: parsing output: 5/ for test: gen9_exec_parse
results: parsing output: 6/ for test: perf
results: parsing output: 7/ for test: kms_dp_link_training
results: parsing output: 8/ for test: kms_frontbuffer_tracking
results: parsing output: 9/ for test: gem_userptr_blits
results: parsing output: 10/ for test: kms_frontbuffer_tracking
results: parsing output: 11/ for test: kms_psr
results: parsing output: 12/ for test: kms_rotation_crc
results: parsing output: 13/ for test: kms_frontbuffer_tracking
results: parsing output: 14/ for test: kms_frontbuffer_tracking
results: parsing output: 15/ for test: kms_frontbuffer_tracking
results: parsing output: 16/ for test: syncobj_wait
results: parsing output: 17/ for test: kms_flip_scaled_crc
results: parsing output: 18/ for test: kms_frontbuffer_tracking
results: parsing output: 19/ for test: kms_frontbuffer_tracking
results: parsing output: 20/ for test: kms_ccs
results: parsing output: 21/ for test: kms_psr2_su
results: parsing output: 22/ for test: kms_big_fb
results: parsing output: 23/ for test: kms_big_fb
results: parsing output: 24/ for test: gem_exec_whisper
results: parsing output: 25/ for test: kms_cursor_crc
results: parsing output: 26/ for test: kms_pm_backlight
results: parsing output: 27/ for test: syncobj_wait
results: parsing output: 28/ for test: kms_color_pipeline
results: parsing output: 29/ for test: kms_frontbuffer_tracking
results: parsing output: 30/ for test: gem_exec_reloc
results: parsing output: 31/ for test: kms_universal_plane
results: parsing output: 32/ for test: syncobj_timeline
results: parsing output: 33/ for test: gem_exec_schedule
results: parsing output: 34/ for test: gem_exec_schedule
results: parsing output: 35/ for test: gem_mmap_gtt
results: parsing output: 36/ for test: kms_ccs
results: parsing output: 37/ for test: gem_softpin
results: parsing output: 38/ for test: kms_pm_rpm
results: parsing output: 39/ for test: kms_frontbuffer_tracking
results: parsing output: 40/ for test: gem_ctx_persistence
results: parsing output: 41/ for test: kms_hdr
results: parsing output: 42/ for test: kms_chamelium_hpd
results: parsing output: 43/ for test: kms_ccs
results: parsing output: 44/ for test: syncobj_basic
results: parsing output: 45/ for test: gem_wait
results: parsing output: 46/ for test: kms_frontbuffer_tracking
results: parsing output: 47/ for test: i915_drm_fdinfo
results: parsing output: 48/ for test: kms_frontbuffer_tracking
results: parsing output: 49/ for test: kms_lease
results: parsing output: 50/ for test: gem_pxp
results: parsing output: 51/ for test: kms_plane_multiple
results: parsing output: 52/ for test: kms_plane
results: parsing output: 53/ for test: gem_workarounds
results: parsing output: 54/ for test: gem_ccs
results: parsing output: 55/ for test: gem_exec_whisper
results: parsing output: 56/ for test: gem_exec_reloc
results: parsing output: 57/ for test: kms_frontbuffer_tracking
results: parsing output: 58/ for test: kms_psr
results: parsing output: 59/ for test: kms_getfb
results: parsing output: 60/ for test: kms_frontbuffer_tracking
results: parsing output: 61/ for test: api_intel_bb
results: parsing output: 62/ for test: kms_pipe_b_c_ivb
results: parsing output: 63/ for test: kms_psr2_sf
results: parsing output: 64/ for test: prime_vgem
results: parsing output: 65/ for test: kms_big_fb
results: parsing output: 66/ for test: gem_flink_basic
results: parsing output: 67/ for test: perf_pmu
results: parsing output: 68/ for test: gem_render_copy
results: parsing output: 69/ for test: core_getversion
results: parsing output: 70/ for test: kms_cursor_crc
results: parsing output: 71/ for test: kms_big_fb
results: parsing output: 72/ for test: gem_exec_create
results: parsing output: 73/ for test: kms_ccs
results: parsing output: 74/ for test: api_intel_allocator
results: parsing output: 75/ for test: kms_big_fb
results: parsing output: 76/ for test: kms_psr2_sf
results: parsing output: 77/ for test: kms_cursor_legacy
results: parsing output: 78/ for test: kms_frontbuffer_tracking
results: parsing output: 79/ for test: kms_frontbuffer_tracking
results: parsing output: 80/ for test: kms_plane
results: parsing output: 81/ for test: gem_exec_fence
results: parsing output: 82/ for test: kms_flip_scaled_crc
results: parsing output: 83/ for test: gem_exec_params
results: parsing output: 84/ for test: gem_ctx_bad_destroy
results: parsing output: 85/ for test: kms_flip
results: parsing output: 86/ for test: gen9_exec_parse
results: parsing output: 87/ for test: kms_frontbuffer_tracking
results: parsing output: 88/ for test: perf
results: parsing output: 89/ for test: kms_atomic
results: parsing output: 90/ for test: perf
results: parsing output: 91/ for test: syncobj_timeline
results: parsing output: 92/ for test: gem_busy
results: parsing output: 93/ for test: gem_exec_schedule
results: parsing output: 94/ for test: kms_flip
results: parsing output: 95/ for test: sw_sync
results: parsing output: 96/ for test: kms_chamelium_audio
results: parsing output: 97/ for test: syncobj_wait
results: parsing output: 98/ for test: gem_ctx_sseu
results: parsing output: 99/ for test: gem_ppgtt
results: parsing output: 100/ for test: prime_mmap
results: parsing output: 101/ for test: kms_flip
results: parsing output: 102/ for test: gem_exec_reloc
results: parsing output: 103/ for test: kms_big_fb
results: parsing output: 104/ for test: kms_cursor_legacy
results: parsing output: 105/ for test: gem_exec_balancer
results: parsing output: 106/ for test: syncobj_basic
results: parsing output: 107/ for test: kms_psr
results: parsing output: 108/ for test: kms_addfb_basic
results: parsing output: 109/ for test: kms_concurrent
results: parsing output: 110/ for test: i915_pm_rps
results: parsing output: 111/ for test: gem_ctx_persistence
results: parsing output: 112/ for test: gem_userptr_blits
results: parsing output: 113/ for test: kms_busy
results: parsing output: 114/ for test: i915_pm_rc6_residency
results: parsing output: 115/ for test: kms_psr
results: parsing output: 116/ for test: kms_frontbuffer_tracking
results: parsing output: 117/ for test: gem_exec_fence
results: parsing output: 118/ for test: prime_vgem
results: parsing output: 119/ for test: syncobj_timeline
results: parsing output: 120/ for test: syncobj_eventfd
results: parsing output: 121/ for test: kms_cursor_legacy
results: parsing output: 122/ for test: kms_cursor_crc
results: parsing output: 123/ for test: gem_mmap_gtt
results: parsing output: 124/ for test: kms_frontbuffer_tracking
results: parsing output: 125/ for test: kms_plane_scaling
results: parsing output: 126/ for test: vgem_slow
results: parsing output: 127/ for test: syncobj_timeline
results: parsing output: 128/ for test: sysfs_timeslice_duration
results: parsing output: 129/ for test: kms_atomic_transition
results: parsing output: 130/ for test: kms_vblank
results: parsing output: 131/ for test: gem_ctx_param
results: parsing output: 132/ for test: kms_pipe_stress
Done.