[57.699368] Initializing watchdogs
[57.699427]   /dev/watchdog0
[57.714534] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:7d55 Intel Meteorlake (Gen12) Meteor Lake-P [Intel Arc Graphics]
[57.719462] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[57.721999] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[57.725207] [001/133] (960s left) syncobj_wait (wait-any-snapshot)
[57.797103] Starting subtest: wait-any-snapshot
[57.878356] Subtest wait-any-snapshot: SUCCESS (0.082s)
[57.953216] [002/133] (960s left) gem_softpin (evict-snoop)
[58.019440] Starting subtest: evict-snoop
[58.024230] Subtest evict-snoop: SKIP (0.000s)
[58.089874] [003/133] (960s left) kms_lease (lease-invalid-connector)
[58.182386] Starting subtest: lease-invalid-connector
[58.184795] Starting dynamic subtest: pipe-A-eDP-1
[58.187177] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s)
[58.195695] Starting dynamic subtest: pipe-B-eDP-1
[58.197628] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[58.204829] Starting dynamic subtest: pipe-C-eDP-1
[58.207252] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[58.214281] Starting dynamic subtest: pipe-D-eDP-1
[58.216139] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[58.217990] Subtest lease-invalid-connector: SUCCESS (0.003s)
[58.252725] [004/133] (960s left) kms_psr2_su (frontbuffer-xrgb8888)
[58.302973] Subtest frontbuffer-XRGB8888: SKIP (0.000s)
[58.357983] [005/133] (960s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-cpu)
[58.458162] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-cpu
[65.540820] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-cpu: SUCCESS (7.091s)
[65.649440] [006/133] (952s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-render)
[65.756585] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-render
[72.691894] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-render: SUCCESS (6.943s)
[72.837346] [007/133] (945s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-gtt)
[72.948091] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-gtt
[72.952160] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[73.027474] [008/133] (945s left) kms_pipe_b_c_ivb (pipe-b-double-modeset-then-modeset-pipe-c)
[73.085914] Subtest pipe-B-double-modeset-then-modeset-pipe-C: SKIP (0.000s)
[73.151703] [009/133] (945s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-onoff)
[73.247956] Starting subtest: psr-1p-primscrn-cur-indfb-onoff
[80.272924] Subtest psr-1p-primscrn-cur-indfb-onoff: SUCCESS (7.029s)
[80.405718] [010/133] (938s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-render)
[80.501593] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-render
[80.505718] Subtest psr-2p-scndscrn-pri-indfb-draw-render: SKIP (0.000s)
[80.604852] [011/133] (937s left) syncobj_timeline (signal-point-0)
[80.657536] Starting subtest: signal-point-0
[80.659528] Subtest signal-point-0: SUCCESS (0.000s)
[80.774558] [012/133] (937s left) kms_vblank (wait-idle)
[80.873709] Starting subtest: wait-idle
[80.875548] Starting dynamic subtest: pipe-A-eDP-1
[82.644796] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.772s)
[82.658978] Starting dynamic subtest: pipe-D-eDP-1
[85.102089] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.453s)
[85.104092] Subtest wait-idle: SUCCESS (4.228s)
[85.916537] [013/133] (932s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-mmap-cpu)
[86.026182] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-mmap-cpu
[86.030581] Subtest psr-2p-scndscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[86.126838] [014/133] (932s left) kms_addfb_basic (invalid-get-prop)
[86.194041] Starting subtest: invalid-get-prop
[86.196422] Subtest invalid-get-prop: SUCCESS (0.000s)
[86.328449] [015/133] (932s left) kms_psr (psr-primary-page-flip)
[86.438948] Starting subtest: psr-primary-page-flip
[86.441248] Starting dynamic subtest: eDP-1
[88.227478] Dynamic subtest eDP-1: SUCCESS (1.788s)
[88.229821] Subtest psr-primary-page-flip: SUCCESS (1.789s)
[89.084149] [016/133] (929s left) gem_readwrite (read-write)
[89.148318] Subtest read-write: SKIP (0.000s)
[89.213970] [017/133] (929s left) perf_pmu (most-busy-check-all)
[89.254477] Starting subtest: most-busy-check-all
[89.256428] Starting dynamic subtest: rcs0
[90.904522] Dynamic subtest rcs0: SUCCESS (1.650s)
[90.914032] Starting dynamic subtest: bcs0
[92.887784] Dynamic subtest bcs0: SUCCESS (1.982s)
[92.898665] Starting dynamic subtest: vcs0
[94.936212] Dynamic subtest vcs0: SUCCESS (2.048s)
[94.947080] Starting dynamic subtest: vcs1
[96.920348] Dynamic subtest vcs1: SUCCESS (1.982s)
[96.931632] Starting dynamic subtest: vecs0
[98.904171] Dynamic subtest vecs0: SUCCESS (1.983s)
[98.914777] Starting dynamic subtest: ccs0
[100.888424] Dynamic subtest ccs0: SUCCESS (1.983s)
[100.891181] Subtest most-busy-check-all: SUCCESS (11.636s)
[101.003286] [018/133] (917s left) kms_pm_lpsp (kms-lpsp)
[102.105639] Starting subtest: kms-lpsp
[102.108206] Starting dynamic subtest: pipe-A-eDP-1
[102.275056] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.173s)
[102.583847] Subtest kms-lpsp: SUCCESS (0.480s)
[103.419904] [019/133] (915s left) kms_plane (pixel-format-4-tiled-mtl-mc-ccs-modifier-source-clamping)
[103.515209] Starting subtest: pixel-format-4-tiled-mtl-mc-ccs-modifier-source-clamping
[103.540618] Starting dynamic subtest: pipe-A-plane-0
[103.973610] Dynamic subtest pipe-A-plane-0: SUCCESS (0.433s)
[103.982561] Starting dynamic subtest: pipe-A-plane-3
[104.228980] Dynamic subtest pipe-A-plane-3: SUCCESS (0.255s)
[105.323931] Starting dynamic subtest: pipe-B-plane-0
[105.760294] Dynamic subtest pipe-B-plane-0: SUCCESS (0.444s)
[105.770518] Starting dynamic subtest: pipe-B-plane-3
[106.027842] Dynamic subtest pipe-B-plane-3: SUCCESS (0.266s)
[106.336752] Subtest pixel-format-4-tiled-mtl-mc-ccs-modifier-source-clamping: SUCCESS (2.823s)
[107.203188] [020/133] (911s left) kms_plane_multiple (2x-tiling-y)
[107.293074] Starting subtest: 2x-tiling-y
[107.297266] Subtest 2x-tiling-y: SKIP (0.000s)
[107.363178] [021/133] (911s left) syncobj_eventfd (invalid-illegal-eventfd)
[107.418847] Starting subtest: invalid-illegal-eventfd
[107.420835] Subtest invalid-illegal-eventfd: SUCCESS (0.000s)
[107.522660] [022/133] (911s left) gem_exec_fence (submit-chain)
[107.699962] Starting subtest: submit-chain
[107.724789] Subtest submit-chain: SUCCESS (0.025s)
[110.003042] [FACT gem_exec_fence (submit-chain)] new: kernel.kmod_is_loaded.vgem: true
[110.006266] [023/133] (909s left) kms_psr (fbc-psr2-sprite-plane-onoff)
[110.101841] Starting subtest: fbc-psr2-sprite-plane-onoff
[110.104101] Starting dynamic subtest: eDP-1
[110.108214] Dynamic subtest eDP-1: SKIP (0.000s)
[110.112334] Subtest fbc-psr2-sprite-plane-onoff: SKIP (0.001s)
[110.175684] [024/133] (908s left) perf (non-zero-reason)
[110.298028] Starting subtest: non-zero-reason
[110.300393] Starting dynamic subtest: 0-rcs0
[115.739593] Dynamic subtest 0-rcs0: SUCCESS (5.441s)
[115.752945] Starting dynamic subtest: 1-vcs1
[119.668553] Dynamic subtest 1-vcs1: SUCCESS (3.927s)
[119.671603] Subtest non-zero-reason: SUCCESS (9.369s)
[119.711245] [025/133] (899s left) kms_ccs (crc-primary-suspend-yf-tiled-ccs)
[119.819698] Starting subtest: crc-primary-suspend-yf-tiled-ccs
[119.821985] Starting dynamic subtest: pipe-A-eDP-1
[119.830818] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[119.839867] Starting dynamic subtest: pipe-B-eDP-1
[119.848495] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[119.857553] Starting dynamic subtest: pipe-C-eDP-1
[119.866045] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[119.874245] Starting dynamic subtest: pipe-D-eDP-1
[119.883589] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[119.888443] Subtest crc-primary-suspend-yf-tiled-ccs: SKIP (0.004s)
[122.042898] [026/133] (897s left) gem_ctx_exec (basic-nohangcheck)
[122.102144] Starting subtest: basic-nohangcheck
[122.347347] Subtest basic-nohangcheck: SUCCESS (0.246s)
[122.469222] [027/133] (896s left) perf_pmu (semaphore-wait-idle)
[122.510620] Starting subtest: semaphore-wait-idle
[122.512470] Starting dynamic subtest: rcs0
[123.023577] Dynamic subtest rcs0: SUCCESS (0.512s)
[123.036386] Starting dynamic subtest: bcs0
[123.536363] Dynamic subtest bcs0: SUCCESS (0.511s)
[123.546480] Starting dynamic subtest: vcs0
[124.052553] Dynamic subtest vcs0: SUCCESS (0.514s)
[124.062193] Starting dynamic subtest: vcs1
[124.563073] Dynamic subtest vcs1: SUCCESS (0.510s)
[124.574251] Starting dynamic subtest: vecs0
[125.079158] Dynamic subtest vecs0: SUCCESS (0.513s)
[125.090663] Starting dynamic subtest: ccs0
[125.594144] Dynamic subtest ccs0: SUCCESS (0.513s)
[125.596750] Subtest semaphore-wait-idle: SUCCESS (3.084s)
[126.958522] [028/133] (892s left) kms_content_protection (dp-mst-lic-type-0-hdcp14)
[127.104049] Starting subtest: dp-mst-lic-type-0-hdcp14
[127.108496] Subtest dp-mst-lic-type-0-hdcp14: SKIP (0.000s)
[127.219334] [029/133] (892s left) kms_big_fb (yf-tiled-64bpp-rotate-90)
[127.309199] Starting subtest: yf-tiled-64bpp-rotate-90
[127.313578] Subtest yf-tiled-64bpp-rotate-90: SKIP (0.000s)
[127.407632] [030/133] (891s left) dumb_buffer (map-valid)
[127.464876] Starting subtest: map-valid
[127.466776] Subtest map-valid: SUCCESS (0.000s)
[127.575294] [031/133] (891s left) sw_sync (alloc_merge_fence)
[127.614103] Starting subtest: alloc_merge_fence
[127.616493] Subtest alloc_merge_fence: SUCCESS (0.000s)
[127.674959] [032/133] (891s left) gem_ccs (large-ctrl-surf-copy)
[127.732282] Starting subtest: large-ctrl-surf-copy
[127.736660] Subtest large-ctrl-surf-copy: SKIP (0.000s)
[127.823312] [033/133] (891s left) kms_cursor_edge_walk (256x256-top-edge)
[127.909249] Starting subtest: 256x256-top-edge
[127.911115] Starting dynamic subtest: pipe-A-eDP-1
[131.418542] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.508s)
[131.429033] Starting dynamic subtest: pipe-D-eDP-1
[134.545295] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.126s)
[134.547669] Subtest 256x256-top-edge: SUCCESS (6.637s)
[135.347582] [034/133] (884s left) gem_exec_reloc (basic-wc-gtt-noreloc)
[135.419427] Subtest basic-wc-gtt-noreloc: SKIP (0.000s)
[135.500434] [035/133] (884s left) kms_cursor_legacy (cursorb-vs-flipa-varying-size)
[135.622411] Starting subtest: cursorB-vs-flipA-varying-size
[135.626946] Subtest cursorB-vs-flipA-varying-size: SKIP (0.001s)
[135.778540] [036/133] (883s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip)
[135.875595] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip
[136.544713] Subtest 4-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip: SUCCESS (0.670s)
[136.738851] [037/133] (882s left) gem_exec_schedule (u-submit-late-slice)
[136.804349] Starting subtest: u-submit-late-slice
[136.806623] Starting dynamic subtest: rcs0
[136.834683] Dynamic subtest rcs0: SUCCESS (0.031s)
[136.845481] Starting dynamic subtest: bcs0
[136.862455] Dynamic subtest bcs0: SUCCESS (0.027s)
[136.871311] Starting dynamic subtest: vcs0
[136.894649] Dynamic subtest vcs0: SUCCESS (0.032s)
[136.905101] Starting dynamic subtest: vcs1
[136.924942] Dynamic subtest vcs1: SUCCESS (0.030s)
[136.934258] Starting dynamic subtest: vecs0
[136.971620] Dynamic subtest vecs0: SUCCESS (0.045s)
[136.981217] Starting dynamic subtest: ccs0
[137.001804] Dynamic subtest ccs0: SUCCESS (0.030s)
[137.004042] Subtest u-submit-late-slice: SUCCESS (0.198s)
[137.960241] [038/133] (881s left) gem_mmap_wc (bad-size)
[138.025093] Subtest bad-size: SKIP (0.000s)
[138.102032] [039/133] (881s left) kms_explicit_fence (multiplane-atomic-fence-wait)
[138.245662] Starting subtest: multiplane-atomic-fence-wait
[138.569444] Subtest multiplane-atomic-fence-wait: SUCCESS (0.322s)
[139.680632] [040/133] (880s left) i915_hangman (gt-engine-error)
[139.753077] Starting subtest: gt-engine-error
[139.755075] Starting dynamic subtest: rcs0
[140.855496] Dynamic subtest rcs0: SUCCESS (1.101s)
[140.867678] Starting dynamic subtest: bcs0
[142.902480] Dynamic subtest bcs0: SUCCESS (2.046s)
[142.914465] Starting dynamic subtest: vcs0
[144.885619] Dynamic subtest vcs0: SUCCESS (1.981s)
[144.899281] Starting dynamic subtest: vcs1
[146.870632] Dynamic subtest vcs1: SUCCESS (1.983s)
[146.884624] Starting dynamic subtest: vecs0
[148.855167] Dynamic subtest vecs0: SUCCESS (1.982s)
[148.868984] Starting dynamic subtest: ccs0
[150.838621] Dynamic subtest ccs0: SUCCESS (1.982s)
[150.841536] Subtest gt-engine-error: SUCCESS (11.086s)
[150.935562] [041/133] (868s left) kms_plane_alpha_blend (alpha-opaque-fb)
[151.033168] Starting subtest: alpha-opaque-fb
[151.316905] Starting dynamic subtest: pipe-A-eDP-1
[152.005118] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.686s)
[152.014980] Starting dynamic subtest: pipe-D-eDP-1
[153.302521] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.297s)
[153.304919] Subtest alpha-opaque-fb: SUCCESS (2.271s)
[154.147357] [042/133] (865s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-mmap-wc)
[154.241561] Starting subtest: psr-2p-primscrn-cur-indfb-draw-mmap-wc
[154.245978] Subtest psr-2p-primscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[154.386993] [043/133] (865s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-pwrite)
[154.500873] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-pwrite
[154.505180] Subtest psr-2p-primscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[154.619411] [044/133] (865s left) kms_chamelium_frames (dp-crc-fast)
[155.002751] Subtest dp-crc-fast: SKIP (0.000s)
[155.852944] [045/133] (864s left) kms_cursor_crc (cursor-random-128x42)
[156.078927] Starting subtest: cursor-random-128x42
[156.125909] Subtest cursor-random-128x42: SKIP (0.044s)
[156.324062] [046/133] (863s left) syncobj_wait (multi-wait-all-submitted)
[156.377656] Starting subtest: multi-wait-all-submitted
[156.484229] Subtest multi-wait-all-submitted: SUCCESS (0.106s)
[156.559931] [047/133] (863s left) core_auth (many-magics)
[156.610877] Starting subtest: many-magics
[157.453787] Subtest many-magics: SUCCESS (0.843s)
[157.606195] [048/133] (862s left) vgem_basic (mmap)
[157.654871] Starting subtest: mmap
[157.675935] Subtest mmap: SUCCESS (0.023s)
[157.737547] [049/133] (862s left) kms_psr2_sf (fbc-pr-plane-move-sf-dmg-area)
[157.829504] Starting subtest: fbc-pr-plane-move-sf-dmg-area
[157.833171] Subtest fbc-pr-plane-move-sf-dmg-area: SKIP (0.000s)
[157.897938] [050/133] (862s left) gem_exec_schedule (implicit-boths)
[157.970645] Starting subtest: implicit-boths
[157.972516] Starting dynamic subtest: rcs0
[158.080613] Dynamic subtest rcs0: SUCCESS (0.116s)
[158.092681] Starting dynamic subtest: vcs0
[158.164251] Dynamic subtest vcs0: SUCCESS (0.083s)
[158.173147] Starting dynamic subtest: vcs1
[158.270581] Dynamic subtest vcs1: SUCCESS (0.105s)
[158.281636] Starting dynamic subtest: vecs0
[158.347231] Dynamic subtest vecs0: SUCCESS (0.076s)
[158.357871] Starting dynamic subtest: ccs0
[158.433925] Dynamic subtest ccs0: SUCCESS (0.085s)
[158.436289] Subtest implicit-boths: SUCCESS (0.469s)
[159.991724] [051/133] (860s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-shrfb-plflip-blt)
[160.097422] Starting subtest: fbcpsr-2p-scndscrn-shrfb-plflip-blt
[160.101702] Subtest fbcpsr-2p-scndscrn-shrfb-plflip-blt: SKIP (0.000s)
[160.203868] [052/133] (860s left) kms_chamelium_hpd (vga-hpd-for-each-pipe)
[160.605331] Subtest vga-hpd-for-each-pipe: SKIP (0.000s)
[161.381951] [053/133] (858s left) kms_addfb_basic (unused-handle)
[161.442418] Starting subtest: unused-handle
[161.444863] Subtest unused-handle: SUCCESS (0.000s)
[161.575984] [054/133] (858s left) i915_pm_sseu (full-enable)
[161.647942] Subtest full-enable: SKIP (0.000s)
[161.757747] [055/133] (858s left) kms_plane (plane-panning-bottom-right)
[161.849954] Starting subtest: plane-panning-bottom-right
[161.852358] Starting dynamic subtest: pipe-A
[163.542950] Dynamic subtest pipe-A: SUCCESS (1.693s)
[163.552202] Starting dynamic subtest: pipe-B
[165.922660] Dynamic subtest pipe-B: SUCCESS (2.379s)
[165.925050] Subtest plane-panning-bottom-right: SUCCESS (4.074s)
[166.756353] [056/133] (853s left) gem_mmap (short-mmap)
[166.815154] Subtest short-mmap: SKIP (0.000s)
[166.895348] [057/133] (853s left) gem_media_vme
[167.014794] [058/133] (853s left) syncobj_timeline (etime-multi-wait-submitted)
[167.067043] Starting subtest: etime-multi-wait-submitted
[167.172486] Subtest etime-multi-wait-submitted: SUCCESS (0.104s)
[167.248411] [059/133] (853s left) kms_color_pipeline (plane-ctm3x4-lut1d)
[167.346961] Starting subtest: plane-ctm3x4-lut1d
[167.493381] Starting dynamic subtest: pipe-A-plane-0
[167.648667] Dynamic subtest pipe-A-plane-0: SUCCESS (0.155s)
[167.658144] Starting dynamic subtest: pipe-A-plane-1
[167.815403] Dynamic subtest pipe-A-plane-1: SUCCESS (0.166s)
[167.825094] Starting dynamic subtest: pipe-A-plane-2
[167.982142] Dynamic subtest pipe-A-plane-2: SUCCESS (0.166s)
[169.150713] Starting dynamic subtest: pipe-B-plane-0
[169.320427] Dynamic subtest pipe-B-plane-0: SUCCESS (0.178s)
[169.330150] Starting dynamic subtest: pipe-B-plane-1
[169.465497] Dynamic subtest pipe-B-plane-1: SUCCESS (0.144s)
[169.479796] Starting dynamic subtest: pipe-B-plane-2
[169.654208] Dynamic subtest pipe-B-plane-2: SUCCESS (0.188s)
[170.896451] Starting dynamic subtest: pipe-C-plane-0
[171.033268] Dynamic subtest pipe-C-plane-0: SUCCESS (0.144s)
[171.042711] Starting dynamic subtest: pipe-C-plane-1
[171.177652] Dynamic subtest pipe-C-plane-1: SUCCESS (0.144s)
[171.186857] Starting dynamic subtest: pipe-C-plane-2
[171.333144] Dynamic subtest pipe-C-plane-2: SUCCESS (0.155s)
[172.493343] Starting dynamic subtest: pipe-D-plane-0
[172.652315] Dynamic subtest pipe-D-plane-0: SUCCESS (0.166s)
[172.662066] Starting dynamic subtest: pipe-D-plane-1
[172.819297] Dynamic subtest pipe-D-plane-1: SUCCESS (0.166s)
[172.830579] Starting dynamic subtest: pipe-D-plane-2
[172.963837] Dynamic subtest pipe-D-plane-2: SUCCESS (0.144s)
[173.254735] Subtest plane-ctm3x4-lut1d: SUCCESS (5.908s)
[174.082421] [060/133] (846s left) kms_addfb_basic (framebuffer-vs-set-tiling)
[174.138472] Starting subtest: framebuffer-vs-set-tiling
[174.142815] Subtest framebuffer-vs-set-tiling: SKIP (0.000s)
[174.314061] [061/133] (846s left) i915_drm_fdinfo (all-busy-check-all)
[174.354528] Starting subtest: all-busy-check-all
[174.362796] Subtest all-busy-check-all: SKIP (0.004s)
[174.441178] [062/133] (846s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-64bpp-ytile-downscaling)
[174.553643] Starting subtest: flip-32bpp-ytile-to-64bpp-ytile-downscaling
[174.557820] Subtest flip-32bpp-ytile-to-64bpp-ytile-downscaling: SKIP (0.000s)
[174.626056] [063/133] (846s left) kms_atomic_transition (plane-all-transition-fencing)
[174.723962] Starting subtest: plane-all-transition-fencing
[174.726291] Starting dynamic subtest: pipe-A-eDP-1
[177.222491] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.498s)
[177.526538] Starting dynamic subtest: pipe-B-eDP-1
[180.800790] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.282s)
[181.109594] Subtest plane-all-transition-fencing: SUCCESS (6.387s)
[181.953440] [064/133] (838s left) gem_render_copy (yf-tiled-ccs-to-yf-tiled-ccs)
[182.027705] Starting subtest: yf-tiled-ccs-to-yf-tiled-ccs
[182.032225] Subtest yf-tiled-ccs-to-yf-tiled-ccs: SKIP (0.000s)
[182.220455] [065/133] (838s left) kms_frontbuffer_tracking (fbc-1p-primscrn-shrfb-plflip-blt)
[182.322106] Starting subtest: fbc-1p-primscrn-shrfb-plflip-blt
[186.989642] Subtest fbc-1p-primscrn-shrfb-plflip-blt: SUCCESS (4.671s)
[188.136708] [066/133] (832s left) kms_psr2_sf (fbc-psr2-overlay-plane-move-continuous-exceed-sf)
[188.248473] Starting subtest: fbc-psr2-overlay-plane-move-continuous-exceed-sf
[188.250799] Starting dynamic subtest: pipe-A-eDP-1
[188.333925] Dynamic subtest pipe-A-eDP-1: SKIP (0.089s)
[188.343981] Starting dynamic subtest: pipe-B-eDP-1
[189.505699] Dynamic subtest pipe-B-eDP-1: SKIP (1.170s)
[189.510393] Subtest fbc-psr2-overlay-plane-move-continuous-exceed-sf: SKIP (1.262s)
[190.697338] [067/133] (830s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-move)
[190.785177] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-move
[190.789444] Subtest fbcpsr-2p-primscrn-spr-indfb-move: SKIP (0.000s)
[190.896475] [068/133] (830s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-32bpp-ytile-upscaling)
[191.007860] Starting subtest: flip-64bpp-ytile-to-32bpp-ytile-upscaling
[191.012169] Subtest flip-64bpp-ytile-to-32bpp-ytile-upscaling: SKIP (0.000s)
[191.083747] [069/133] (829s left) kms_big_fb (yf-tiled-16bpp-rotate-90)
[191.173304] Starting subtest: yf-tiled-16bpp-rotate-90
[191.177215] Subtest yf-tiled-16bpp-rotate-90: SKIP (0.000s)
[191.268576] [070/133] (829s left) syncobj_timeline (multi-wait-for-submit-available-submitted-signaled)
[191.315776] Starting subtest: multi-wait-for-submit-available-submitted-signaled
[191.318068] Subtest multi-wait-for-submit-available-submitted-signaled: SUCCESS (0.000s)
[191.410033] [071/133] (829s left) kms_psr (fbc-psr2-primary-page-flip)
[191.512041] Starting subtest: fbc-psr2-primary-page-flip
[191.514315] Starting dynamic subtest: eDP-1
[191.518593] Dynamic subtest eDP-1: SKIP (0.000s)
[191.522799] Subtest fbc-psr2-primary-page-flip: SKIP (0.001s)
[191.592663] [072/133] (829s left) gem_lmem_evict (dontneed-evict-race)
[191.643090] Subtest dontneed-evict-race: SKIP (0.000s)
[191.690272] [073/133] (829s left) kms_flip_scaled_crc (flip-32bpp-linear-to-64bpp-linear-upscaling)
[191.778064] Starting subtest: flip-32bpp-linear-to-64bpp-linear-upscaling
[191.779881] Starting dynamic subtest: pipe-A-default-mode
[194.566744] Dynamic subtest pipe-A-default-mode: SUCCESS (2.786s)
[194.568890] Subtest flip-32bpp-linear-to-64bpp-linear-upscaling: SUCCESS (2.787s)
[195.395168] [074/133] (825s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-blt)
[195.508420] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-blt
[199.954938] Subtest fbc-1p-primscrn-pri-indfb-draw-blt: SUCCESS (4.449s)
[201.104409] [075/133] (820s left) kms_cursor_crc (cursor-offscreen-64x21)
[201.312628] Starting subtest: cursor-offscreen-64x21
[201.358587] Subtest cursor-offscreen-64x21: SKIP (0.045s)
[201.573352] [076/133] (819s left) gem_exec_schedule (preempt)
[201.643698] Starting subtest: preempt
[201.645907] Starting dynamic subtest: rcs0
[201.666133] Dynamic subtest rcs0: SUCCESS (0.024s)
[201.675847] Starting dynamic subtest: bcs0
[201.687221] Dynamic subtest bcs0: SUCCESS (0.020s)
[201.695827] Starting dynamic subtest: vcs0
[201.708110] Dynamic subtest vcs0: SUCCESS (0.020s)
[201.716713] Starting dynamic subtest: vcs1
[201.738032] Dynamic subtest vcs1: SUCCESS (0.029s)
[201.746612] Starting dynamic subtest: vecs0
[201.758026] Dynamic subtest vecs0: SUCCESS (0.019s)
[201.766547] Starting dynamic subtest: ccs0
[201.779817] Dynamic subtest ccs0: SUCCESS (0.021s)
[201.782096] Subtest preempt: SUCCESS (0.139s)
[202.999390] [077/133] (818s left) device_reset (unbind-reset-rebind)
[203.047719] Starting subtest: unbind-reset-rebind
[207.986042] Subtest unbind-reset-rebind: SUCCESS (4.935s)
[208.023946] [078/133] (813s left) kms_getfb (getfb2-handle-not-fb)
[208.140931] Starting subtest: getfb2-handle-not-fb
[208.143140] Subtest getfb2-handle-not-fb: SUCCESS (0.000s)
[208.235084] [079/133] (813s left) kms_big_fb (x-tiled-8bpp-rotate-270)
[208.338290] Starting subtest: x-tiled-8bpp-rotate-270
[208.378179] Subtest x-tiled-8bpp-rotate-270: SKIP (0.038s)
[208.488673] [080/133] (813s left) gen7_exec_parse (oacontrol-tracking)
[208.549491] Subtest oacontrol-tracking: SKIP (0.000s)
[208.627593] [081/133] (812s left) gem_render_copy (y-tiled-ccs-to-yf-tiled)
[208.677354] Starting subtest: y-tiled-ccs-to-yf-tiled
[208.681753] Subtest y-tiled-ccs-to-yf-tiled: SKIP (0.000s)
[208.861126] [082/133] (812s left) gem_exec_reloc (basic-range)
[208.918758] Subtest basic-range: SKIP (0.000s)
[208.978794] [083/133] (812s left) kms_chamelium_audio (hdmi-audio)
[209.366334] Subtest hdmi-audio: SKIP (0.000s)
[210.141669] [084/133] (811s left) gem_exec_schedule (u-fairslice-all)
[210.218351] Starting subtest: u-fairslice-all
[212.271104] Subtest u-fairslice-all: SUCCESS (2.057s)
[213.924819] [085/133] (807s left) kms_flip (2x-plain-flip-ts-check)
[214.013850] Starting subtest: 2x-plain-flip-ts-check
[214.023153] Subtest 2x-plain-flip-ts-check: SKIP (0.011s)
[214.102534] [086/133] (807s left) kms_ccs (bad-rotation-90-4-tiled-mtl-rc-ccs-cc)
[214.191828] Starting subtest: bad-rotation-90-4-tiled-mtl-rc-ccs-cc
[214.194116] Starting dynamic subtest: pipe-A-eDP-1
[214.345803] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.144s)
[214.357413] Starting dynamic subtest: pipe-B-eDP-1
[214.376327] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.011s)
[214.386933] Starting dynamic subtest: pipe-C-eDP-1
[214.406650] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.010s)
[214.415536] Starting dynamic subtest: pipe-D-eDP-1
[214.434180] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.011s)
[214.436070] Subtest bad-rotation-90-4-tiled-mtl-rc-ccs-cc: SUCCESS (0.180s)
[216.621509] [087/133] (805s left) gem_ctx_persistence (heartbeat-hostile)
[216.678373] Starting subtest: heartbeat-hostile
[216.683047] Subtest heartbeat-hostile: SKIP (0.000s)
[216.791061] [088/133] (805s left) gem_exec_flush (basic-uc-pro-default)
[216.845575] Starting subtest: basic-uc-pro-default
[222.324954] Subtest basic-uc-pro-default: SUCCESS (5.480s)
[222.529368] [089/133] (799s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-shrfb-pgflip-blt)
[222.632444] Starting subtest: fbcpsr-1p-primscrn-shrfb-pgflip-blt
[230.007187] Subtest fbcpsr-1p-primscrn-shrfb-pgflip-blt: SUCCESS (7.377s)
[230.155726] [090/133] (791s left) gem_close (many-handles-one-vma)
[230.215725] Starting subtest: many-handles-one-vma
[230.240024] Subtest many-handles-one-vma: SUCCESS (0.024s)
[230.335437] [091/133] (791s left) gem_tiled_swapping (non-threaded)
[230.385489] Subtest non-threaded: SKIP (0.000s)
[230.442556] [092/133] (791s left) syncobj_wait (invalid-signal-bad-pad)
[230.494423] Starting subtest: invalid-signal-bad-pad
[230.496663] Subtest invalid-signal-bad-pad: SUCCESS (0.000s)
[230.597081] [093/133] (791s left) kms_invalid_mode (overflow-vrefresh)
[230.698684] Starting subtest: overflow-vrefresh
[230.701040] Starting dynamic subtest: pipe-A-eDP-1
[230.985641] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.285s)
[230.995307] Starting dynamic subtest: pipe-B-eDP-1
[230.997350] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[231.006829] Starting dynamic subtest: pipe-C-eDP-1
[231.009074] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[231.017710] Starting dynamic subtest: pipe-D-eDP-1
[231.019894] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[231.022063] Subtest overflow-vrefresh: SUCCESS (0.291s)
[231.780557] [094/133] (790s left) kms_flip (2x-modeset-vs-vblank-race-interruptible)
[231.886182] Starting subtest: 2x-modeset-vs-vblank-race-interruptible
[231.897563] Subtest 2x-modeset-vs-vblank-race-interruptible: SKIP (0.011s)
[231.972960] [095/133] (790s left) kms_cursor_legacy (flip-vs-cursor-crc-legacy)
[232.096577] Starting subtest: flip-vs-cursor-crc-legacy
[232.780742] Subtest flip-vs-cursor-crc-legacy: SUCCESS (0.682s)
[233.625224] [096/133] (788s left) perf_pmu (interrupts-sync)
[233.675966] Starting subtest: interrupts-sync
[234.754560] Subtest interrupts-sync: SUCCESS (1.078s)
[234.862392] [097/133] (787s left) api_intel_allocator (open-vm)
[234.922839] Starting subtest: open-vm
[234.928098] Subtest open-vm: SUCCESS (0.006s)
[235.052869] [098/133] (787s left) sysfs_heartbeat_interval (nopreempt)
[235.118140] Starting subtest: nopreempt
[235.120487] Starting dynamic subtest: vecs0
[244.884367] Dynamic subtest vecs0: SUCCESS (9.765s)
[244.896556] Starting dynamic subtest: ccs0
[248.907687] Dynamic subtest ccs0: SUCCESS (4.021s)
[248.919621] Starting dynamic subtest: vcs0
[258.906215] Dynamic subtest vcs0: SUCCESS (9.993s)
[258.919201] Starting dynamic subtest: bcs0
[262.871264] Dynamic subtest bcs0: SUCCESS (3.962s)
[262.880944] Starting dynamic subtest: rcs0
[266.900801] Dynamic subtest rcs0: SUCCESS (4.027s)
[266.912074] Starting dynamic subtest: vcs1
[276.885385] Dynamic subtest vcs1: SUCCESS (9.983s)
[276.887839] Subtest nopreempt: SUCCESS (41.763s)
[276.960412] [099/133] (745s left) gem_softpin (evict-prime)
[277.026113] Starting subtest: evict-prime
[277.028054] Starting dynamic subtest: rcs0
[278.189956] Dynamic subtest rcs0: SUCCESS (1.166s)
[278.200390] Starting dynamic subtest: bcs0
[279.307744] Dynamic subtest bcs0: SUCCESS (1.116s)
[279.318656] Starting dynamic subtest: vcs0
[280.920453] Dynamic subtest vcs0: SUCCESS (1.609s)
[280.936972] Starting dynamic subtest: vcs1
[282.909639] Dynamic subtest vcs1: SUCCESS (1.987s)
[282.921671] Starting dynamic subtest: vecs0
[284.886780] Dynamic subtest vecs0: SUCCESS (1.975s)
[284.899350] Starting dynamic subtest: ccs0
[286.020961] Dynamic subtest ccs0: SUCCESS (1.133s)
[286.033110] Starting dynamic subtest: all
[287.891509] Dynamic subtest all: SUCCESS (1.867s)
[287.894171] Subtest evict-prime: SUCCESS (10.867s)
[287.983331] [100/133] (734s left) kms_cursor_legacy (basic-busy-flip-before-cursor-atomic)
[288.103760] Starting subtest: basic-busy-flip-before-cursor-atomic
[288.108595] Subtest basic-busy-flip-before-cursor-atomic: SKIP (0.000s)
[288.252597] [101/133] (734s left) syncobj_timeline (invalid-multi-wait-unsubmitted-submitted-signaled)
[288.304472] Starting subtest: invalid-multi-wait-unsubmitted-submitted-signaled
[288.306605] Subtest invalid-multi-wait-unsubmitted-submitted-signaled: SUCCESS (0.000s)
[288.408365] [102/133] (734s left) kms_ccs (crc-primary-basic-y-tiled-gen12-rc-ccs-cc)
[288.495911] Starting subtest: crc-primary-basic-y-tiled-gen12-rc-ccs-cc
[288.498077] Starting dynamic subtest: pipe-A-eDP-1
[288.519932] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[288.531397] Starting dynamic subtest: pipe-B-eDP-1
[288.552301] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[288.561977] Starting dynamic subtest: pipe-C-eDP-1
[288.582277] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[288.593915] Starting dynamic subtest: pipe-D-eDP-1
[288.616983] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[288.621272] Subtest crc-primary-basic-y-tiled-gen12-rc-ccs-cc: SKIP (0.007s)
[290.777309] [103/133] (731s left) gem_workarounds (basic-read-fd)
[290.841603] Starting subtest: basic-read-fd
[290.854385] Subtest basic-read-fd: SUCCESS (0.012s)
[290.979782] [104/133] (731s left) gem_ctx_exec (basic)
[291.037593] Starting subtest: basic
[291.040028] Subtest basic: SUCCESS (0.005s)
[291.172529] [105/133] (731s left) kms_psr (pr-cursor-render)
[291.263283] Starting subtest: pr-cursor-render
[291.267492] Subtest pr-cursor-render: SKIP (0.000s)
[291.348675] [106/133] (731s left) kms_async_flips (crc-atomic)
[291.435050] Starting subtest: crc-atomic
[291.806614] Starting dynamic subtest: pipe-A-eDP-1
[294.694952] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.886s)
[295.072426] Starting dynamic subtest: pipe-B-eDP-1
[298.020215] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.957s)
[298.405197] Starting dynamic subtest: pipe-C-eDP-1
[301.240171] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.846s)
[301.609285] Starting dynamic subtest: pipe-D-eDP-1
[304.476099] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.883s)
[304.478434] Subtest crc-atomic: SUCCESS (13.043s)
[305.643431] [107/133] (717s left) i915_pm_rpm (system-suspend)
[307.192778] Starting subtest: system-suspend
[325.226445] Subtest system-suspend: SUCCESS (3.028s)
[325.619259] [108/133] (697s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip)
[325.722801] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip
[325.727235] Subtest y-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip: SKIP (0.000s)
[325.826739] [109/133] (696s left) gem_userptr_blits (vma-merge)
[325.905829] Starting subtest: vma-merge
[325.948626] Subtest vma-merge: SUCCESS (0.043s)
[326.058189] [110/133] (696s left) gem_eio (banned)
[326.315126] Starting subtest: banned
[326.957303] Subtest banned: SUCCESS (0.644s)
[327.122731] [111/133] (695s left) gem_exec_nop (basic-sequential)
[327.197448] Starting subtest: basic-sequential
[341.419631] Subtest basic-sequential: SUCCESS (14.242s)
[341.656034] [112/133] (681s left) gem_exec_balancer (bonded-chain)
[341.725461] Starting subtest: bonded-chain
[348.788684] Subtest bonded-chain: SUCCESS (7.068s)
[349.098583] [113/133] (673s left) syncobj_wait (single-wait-all-for-submit-submitted)
[349.143713] Starting subtest: single-wait-all-for-submit-submitted
[349.243811] Subtest single-wait-all-for-submit-submitted: SUCCESS (0.101s)
[349.324076] [114/133] (673s left) gem_mmap_gtt (isolation)
[349.379694] Subtest isolation: SKIP (0.000s)
[349.438155] [115/133] (673s left) gem_ctx_sseu (invalid-sseu)
[349.503512] Subtest invalid-sseu: SKIP (0.000s)
[349.581319] [116/133] (673s left) kms_flip (basic-flip-vs-wf_vblank)
[349.681737] Starting subtest: basic-flip-vs-wf_vblank
[349.683913] Starting dynamic subtest: A-eDP1
[351.622810] Dynamic subtest A-eDP1: SUCCESS (1.943s)
[351.635592] Starting dynamic subtest: B-eDP1
[353.562216] Dynamic subtest B-eDP1: SUCCESS (1.938s)
[353.576249] Starting dynamic subtest: C-eDP1
[355.485665] Dynamic subtest C-eDP1: SUCCESS (1.920s)
[355.496209] Starting dynamic subtest: D-eDP1
[357.419329] Dynamic subtest D-eDP1: SUCCESS (1.933s)
[357.424817] Subtest basic-flip-vs-wf_vblank: SUCCESS (7.746s)
[358.660731] [117/133] (664s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-0-async-flip)
[358.773370] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-0-async-flip
[358.777799] Subtest y-tiled-max-hw-stride-32bpp-rotate-0-async-flip: SKIP (0.000s)
[358.863938] [118/133] (664s left) gem_exec_fence (basic-await)
[359.041924] Starting subtest: basic-await
[359.044176] Starting dynamic subtest: rcs0
[359.117916] Dynamic subtest rcs0: SUCCESS (0.076s)
[359.130114] Starting dynamic subtest: bcs0
[359.195989] Dynamic subtest bcs0: SUCCESS (0.076s)
[359.209621] Starting dynamic subtest: vcs0
[359.277655] Dynamic subtest vcs0: SUCCESS (0.079s)
[359.290894] Starting dynamic subtest: vcs1
[359.353493] Dynamic subtest vcs1: SUCCESS (0.073s)
[359.366685] Starting dynamic subtest: vecs0
[359.428203] Dynamic subtest vecs0: SUCCESS (0.073s)
[359.441063] Starting dynamic subtest: ccs0
[359.502490] Dynamic subtest ccs0: SUCCESS (0.072s)
[359.505029] Subtest basic-await: SUCCESS (0.462s)
[360.981649] [119/133] (662s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-180-async-flip)
[361.092021] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-180-async-flip
[361.927206] Subtest 4-tiled-max-hw-stride-64bpp-rotate-180-async-flip: SUCCESS (0.837s)
[362.098534] [120/133] (661s left) kms_ccs (crc-sprite-planes-basic-4-tiled-mtl-rc-ccs)
[362.187369] Starting subtest: crc-sprite-planes-basic-4-tiled-mtl-rc-ccs
[362.189299] Starting dynamic subtest: pipe-A-eDP-1
[362.665200] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.451s)
[362.678197] Starting dynamic subtest: pipe-B-eDP-1
[364.126530] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.457s)
[364.137441] Starting dynamic subtest: pipe-C-eDP-1
[365.492130] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.366s)
[365.504200] Starting dynamic subtest: pipe-D-eDP-1
[366.890459] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.397s)
[366.892442] Subtest crc-sprite-planes-basic-4-tiled-mtl-rc-ccs: SUCCESS (4.677s)
[368.074610] [121/133] (655s left) kms_flip (single-buffer-flip-vs-dpms-off-vs-modeset-interruptible)
[368.179472] Starting subtest: single-buffer-flip-vs-dpms-off-vs-modeset-interruptible
[368.182011] Starting dynamic subtest: A-eDP1
[371.888539] Dynamic subtest A-eDP1: SUCCESS (3.706s)
[371.899659] Starting dynamic subtest: B-eDP1
[375.203762] Dynamic subtest B-eDP1: SUCCESS (3.317s)
[375.215488] Starting dynamic subtest: C-eDP1
[378.326016] Dynamic subtest C-eDP1: SUCCESS (3.122s)
[378.337663] Starting dynamic subtest: D-eDP1
[381.445117] Dynamic subtest D-eDP1: SUCCESS (3.115s)
[381.447505] Subtest single-buffer-flip-vs-dpms-off-vs-modeset-interruptible: SUCCESS (13.270s)
[382.242310] [122/133] (641s left) gem_fenced_exec_thrash (no-spare-fences-interruptible)
[382.305915] Subtest no-spare-fences-interruptible: SKIP (0.000s)
[382.403881] [123/133] (640s left) api_intel_bb (intel-bb-blit-y)
[382.467488] Starting subtest: intel-bb-blit-y
[386.060616] Subtest intel-bb-blit-y: SUCCESS (3.595s)
[386.187529] [124/133] (637s left) kms_flip (2x-flip-vs-blocking-wf-vblank)
[386.285742] Starting subtest: 2x-flip-vs-blocking-wf-vblank
[386.296768] Subtest 2x-flip-vs-blocking-wf-vblank: SKIP (0.011s)
[386.380420] [125/133] (637s left) kms_cursor_legacy (forked-move)
[386.507851] Starting subtest: forked-move
[386.510129] Starting dynamic subtest: pipe-A
[391.964983] Dynamic subtest pipe-A: SUCCESS (5.456s)
[391.980571] Starting dynamic subtest: pipe-B
[397.444400] Dynamic subtest pipe-B: SUCCESS (5.478s)
[397.457684] Starting dynamic subtest: pipe-C
[402.917095] Dynamic subtest pipe-C: SUCCESS (5.470s)
[402.930664] Starting dynamic subtest: pipe-D
[408.379696] Dynamic subtest pipe-D: SUCCESS (5.461s)
[408.391912] Starting dynamic subtest: all-pipes
[413.866552] Dynamic subtest all-pipes: SUCCESS (5.487s)
[413.869042] Subtest forked-move: SUCCESS (27.364s)
[414.012377] [126/133] (609s left) kms_pm_rpm (modeset-non-lpsp-stress)
[416.061043] Starting subtest: modeset-non-lpsp-stress
[417.213093] Subtest modeset-non-lpsp-stress: SKIP (1.152s)
[417.587592] [127/133] (605s left) kms_async_flips (alternate-sync-async-flip-atomic)
[417.693424] Starting subtest: alternate-sync-async-flip-atomic
[418.072552] Starting dynamic subtest: pipe-A-eDP-1
[420.862743] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.790s)
[421.255068] Starting dynamic subtest: pipe-B-eDP-1
[423.997402] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.750s)
[424.382339] Starting dynamic subtest: pipe-C-eDP-1
[427.130852] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.756s)
[427.500532] Starting dynamic subtest: pipe-D-eDP-1
[430.268157] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.776s)
[430.270277] Subtest alternate-sync-async-flip-atomic: SUCCESS (12.573s)
[431.441269] [128/133] (592s left) kms_vblank (query-busy-hang)
[431.537864] Starting subtest: query-busy-hang
[431.539789] Starting dynamic subtest: pipe-A-eDP-1
[457.666053] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.122s)
[457.681426] Starting dynamic subtest: pipe-D-eDP-1
[472.710503] Dynamic subtest pipe-D-eDP-1: SUCCESS (15.043s)
[472.712735] Subtest query-busy-hang: SUCCESS (41.170s)
[473.509556] [129/133] (550s left) kms_psr (psr2-primary-mmap-cpu)
[473.604231] Starting subtest: psr2-primary-mmap-cpu
[473.606426] Starting dynamic subtest: eDP-1
[475.304485] Dynamic subtest eDP-1: SUCCESS (1.697s)
[475.306397] Subtest psr2-primary-mmap-cpu: SUCCESS (1.699s)
[476.174568] [130/133] (547s left) gem_exec_parallel (basic)
[476.240853] Starting subtest: basic
[476.242744] Starting dynamic subtest: rcs0
[477.683507] Dynamic subtest rcs0: SUCCESS (1.445s)
[477.696119] Starting dynamic subtest: bcs0
[479.166059] Dynamic subtest bcs0: SUCCESS (1.481s)
[479.185561] Starting dynamic subtest: vcs0
[480.923829] Dynamic subtest vcs0: SUCCESS (1.753s)
[480.936465] Starting dynamic subtest: vcs1
[482.936988] Dynamic subtest vcs1: SUCCESS (2.011s)
[482.949675] Starting dynamic subtest: vecs0
[484.855553] Dynamic subtest vecs0: SUCCESS (1.916s)
[484.866482] Starting dynamic subtest: ccs0
[486.351077] Dynamic subtest ccs0: SUCCESS (1.494s)
[486.356236] Subtest basic: SUCCESS (10.116s)
[486.545538] [131/133] (537s left) kms_plane_scaling (planes-unity-scaling-downscale-factor-0-5)
[486.652626] Starting subtest: planes-unity-scaling-downscale-factor-0-5
[486.654847] Starting dynamic subtest: pipe-A
[486.672462] Dynamic subtest pipe-A: SKIP (0.017s)
[486.683451] Starting dynamic subtest: pipe-B
[486.704910] Dynamic subtest pipe-B: SKIP (0.032s)
[486.715559] Starting dynamic subtest: pipe-C
[486.736827] Dynamic subtest pipe-C: SKIP (0.031s)
[486.747135] Starting dynamic subtest: pipe-D
[486.769695] Dynamic subtest pipe-D: SKIP (0.032s)
[486.773276] Subtest planes-unity-scaling-downscale-factor-0-5: SKIP (0.115s)
[486.878359] [132/133] (536s left) perf_pmu (all-busy-check-all)
[486.921942] Starting subtest: all-busy-check-all
[488.954286] Subtest all-busy-check-all: SUCCESS (2.033s)
[489.054592] [133/133] (534s left) kms_cursor_legacy (flip-vs-cursor-atomic-transitions-varying-size)
[489.168794] Starting subtest: flip-vs-cursor-atomic-transitions-varying-size
[498.735222] Subtest flip-vs-cursor-atomic-transitions-varying-size: SUCCESS (9.567s)
[499.597432] Closing watchdogs
results: parsing output: 0/ for test: syncobj_wait
results: parsing output: 1/ for test: gem_softpin
results: parsing output: 2/ for test: kms_lease
results: parsing output: 3/ for test: kms_psr2_su
results: parsing output: 4/ for test: kms_frontbuffer_tracking
results: parsing output: 5/ for test: kms_frontbuffer_tracking
results: parsing output: 6/ for test: kms_frontbuffer_tracking
results: parsing output: 7/ for test: kms_pipe_b_c_ivb
results: parsing output: 8/ for test: kms_frontbuffer_tracking
results: parsing output: 9/ for test: kms_frontbuffer_tracking
results: parsing output: 10/ for test: syncobj_timeline
results: parsing output: 11/ for test: kms_vblank
results: parsing output: 12/ for test: kms_frontbuffer_tracking
results: parsing output: 13/ for test: kms_addfb_basic
results: parsing output: 14/ for test: kms_psr
results: parsing output: 15/ for test: gem_readwrite
results: parsing output: 16/ for test: perf_pmu
results: parsing output: 17/ for test: kms_pm_lpsp
results: parsing output: 18/ for test: kms_plane
results: parsing output: 19/ for test: kms_plane_multiple
results: parsing output: 20/ for test: syncobj_eventfd
results: parsing output: 21/ for test: gem_exec_fence
results: parsing output: 22/ for test: kms_psr
results: parsing output: 23/ for test: perf
results: parsing output: 24/ for test: kms_ccs
results: parsing output: 25/ for test: gem_ctx_exec
results: parsing output: 26/ for test: perf_pmu
results: parsing output: 27/ for test: kms_content_protection
results: parsing output: 28/ for test: kms_big_fb
results: parsing output: 29/ for test: dumb_buffer
results: parsing output: 30/ for test: sw_sync
results: parsing output: 31/ for test: gem_ccs
results: parsing output: 32/ for test: kms_cursor_edge_walk
results: parsing output: 33/ for test: gem_exec_reloc
results: parsing output: 34/ for test: kms_cursor_legacy
results: parsing output: 35/ for test: kms_big_fb
results: parsing output: 36/ for test: gem_exec_schedule
results: parsing output: 37/ for test: gem_mmap_wc
results: parsing output: 38/ for test: kms_explicit_fence
results: parsing output: 39/ for test: i915_hangman
results: parsing output: 40/ for test: kms_plane_alpha_blend
results: parsing output: 41/ for test: kms_frontbuffer_tracking
results: parsing output: 42/ for test: kms_frontbuffer_tracking
results: parsing output: 43/ for test: kms_chamelium_frames
results: parsing output: 44/ for test: kms_cursor_crc
results: parsing output: 45/ for test: syncobj_wait
results: parsing output: 46/ for test: core_auth
results: parsing output: 47/ for test: vgem_basic
results: parsing output: 48/ for test: kms_psr2_sf
results: parsing output: 49/ for test: gem_exec_schedule
results: parsing output: 50/ for test: kms_frontbuffer_tracking
results: parsing output: 51/ for test: kms_chamelium_hpd
results: parsing output: 52/ for test: kms_addfb_basic
results: parsing output: 53/ for test: i915_pm_sseu
results: parsing output: 54/ for test: kms_plane
results: parsing output: 55/ for test: gem_mmap
results: parsing output: 56/ for test: gem_media_vme
results: parsing output: 57/ for test: syncobj_timeline
results: parsing output: 58/ for test: kms_color_pipeline
results: parsing output: 59/ for test: kms_addfb_basic
results: parsing output: 60/ for test: i915_drm_fdinfo
results: parsing output: 61/ for test: kms_flip_scaled_crc
results: parsing output: 62/ for test: kms_atomic_transition
results: parsing output: 63/ for test: gem_render_copy
results: parsing output: 64/ for test: kms_frontbuffer_tracking
results: parsing output: 65/ for test: kms_psr2_sf
results: parsing output: 66/ for test: kms_frontbuffer_tracking
results: parsing output: 67/ for test: kms_flip_scaled_crc
results: parsing output: 68/ for test: kms_big_fb
results: parsing output: 69/ for test: syncobj_timeline
results: parsing output: 70/ for test: kms_psr
results: parsing output: 71/ for test: gem_lmem_evict
results: parsing output: 72/ for test: kms_flip_scaled_crc
results: parsing output: 73/ for test: kms_frontbuffer_tracking
results: parsing output: 74/ for test: kms_cursor_crc
results: parsing output: 75/ for test: gem_exec_schedule
results: parsing output: 76/ for test: device_reset
results: parsing output: 77/ for test: kms_getfb
results: parsing output: 78/ for test: kms_big_fb
results: parsing output: 79/ for test: gen7_exec_parse
results: parsing output: 80/ for test: gem_render_copy
results: parsing output: 81/ for test: gem_exec_reloc
results: parsing output: 82/ for test: kms_chamelium_audio
results: parsing output: 83/ for test: gem_exec_schedule
results: parsing output: 84/ for test: kms_flip
results: parsing output: 85/ for test: kms_ccs
results: parsing output: 86/ for test: gem_ctx_persistence
results: parsing output: 87/ for test: gem_exec_flush
results: parsing output: 88/ for test: kms_frontbuffer_tracking
results: parsing output: 89/ for test: gem_close
results: parsing output: 90/ for test: gem_tiled_swapping
results: parsing output: 91/ for test: syncobj_wait
results: parsing output: 92/ for test: kms_invalid_mode
results: parsing output: 93/ for test: kms_flip
results: parsing output: 94/ for test: kms_cursor_legacy
results: parsing output: 95/ for test: perf_pmu
results: parsing output: 96/ for test: api_intel_allocator
results: parsing output: 97/ for test: sysfs_heartbeat_interval
results: parsing output: 98/ for test: gem_softpin
results: parsing output: 99/ for test: kms_cursor_legacy
results: parsing output: 100/ for test: syncobj_timeline
results: parsing output: 101/ for test: kms_ccs
results: parsing output: 102/ for test: gem_workarounds
results: parsing output: 103/ for test: gem_ctx_exec
results: parsing output: 104/ for test: kms_psr
results: parsing output: 105/ for test: kms_async_flips
results: parsing output: 106/ for test: i915_pm_rpm
results: parsing output: 107/ for test: kms_big_fb
results: parsing output: 108/ for test: gem_userptr_blits
results: parsing output: 109/ for test: gem_eio
results: parsing output: 110/ for test: gem_exec_nop
results: parsing output: 111/ for test: gem_exec_balancer
results: parsing output: 112/ for test: syncobj_wait
results: parsing output: 113/ for test: gem_mmap_gtt
results: parsing output: 114/ for test: gem_ctx_sseu
results: parsing output: 115/ for test: kms_flip
results: parsing output: 116/ for test: kms_big_fb
results: parsing output: 117/ for test: gem_exec_fence
results: parsing output: 118/ for test: kms_big_fb
results: parsing output: 119/ for test: kms_ccs
results: parsing output: 120/ for test: kms_flip
results: parsing output: 121/ for test: gem_fenced_exec_thrash
results: parsing output: 122/ for test: api_intel_bb
results: parsing output: 123/ for test: kms_flip
results: parsing output: 124/ for test: kms_cursor_legacy
results: parsing output: 125/ for test: kms_pm_rpm
results: parsing output: 126/ for test: kms_async_flips
results: parsing output: 127/ for test: kms_vblank
results: parsing output: 128/ for test: kms_psr
results: parsing output: 129/ for test: gem_exec_parallel
results: parsing output: 130/ for test: kms_plane_scaling
results: parsing output: 131/ for test: perf_pmu
results: parsing output: 132/ for test: kms_cursor_legacy
Done.