[59.009403] Initializing watchdogs
[59.009450]   /dev/watchdog0
[59.023960] [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.028344] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[59.030744] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[59.034165] [001/133] (960s left) kms_pipe_crc_basic (nonblocking-crc-frame-sequence)
[59.165755] Starting subtest: nonblocking-crc-frame-sequence
[59.167686] Starting dynamic subtest: pipe-A-eDP-1
[59.938883] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.770s)
[59.949553] Starting dynamic subtest: pipe-B-eDP-1
[61.361929] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.415s)
[61.368856] Starting dynamic subtest: pipe-C-eDP-1
[62.700294] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.332s)
[62.710641] Starting dynamic subtest: pipe-D-eDP-1
[64.068060] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.361s)
[64.070404] Subtest nonblocking-crc-frame-sequence: SUCCESS (4.884s)
[64.958974] [002/133] (954s left) i915_module_load (reload)
[64.997446] Starting subtest: reload
[70.019951] Subtest reload: SUCCESS (5.016s)
[70.054700] [003/133] (949s left) gem_eio (in-flight-1us)
[71.951083] Starting subtest: in-flight-1us
[79.787848] Subtest in-flight-1us: SUCCESS (7.832s)
[80.000784] [FACT gem_eio (in-flight-1us)] new: kernel.kmod_is_loaded.vgem: true
[80.003655] [004/133] (939s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-0)
[80.102617] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-0
[81.145899] Subtest 4-tiled-max-hw-stride-32bpp-rotate-0: SUCCESS (1.044s)
[81.292076] [005/133] (938s left) kms_addfb_basic (bad-pitch-1024)
[81.353592] Starting subtest: bad-pitch-1024
[81.355356] Subtest bad-pitch-1024: SUCCESS (0.000s)
[81.510961] [006/133] (938s left) kms_getfb (getfb2-handle-zero)
[81.610364] Starting subtest: getfb2-handle-zero
[81.612374] Subtest getfb2-handle-zero: SUCCESS (0.000s)
[81.724590] [007/133] (938s left) syncobj_timeline (single-wait-all-for-submit-signaled)
[81.786868] Starting subtest: single-wait-all-for-submit-signaled
[81.788475] Subtest single-wait-all-for-submit-signaled: SUCCESS (0.001s)
[81.931205] [008/133] (937s left) syncobj_wait (invalid-multi-wait-all-unsubmitted)
[81.992456] Starting subtest: invalid-multi-wait-all-unsubmitted
[81.994156] Subtest invalid-multi-wait-all-unsubmitted: SUCCESS (0.000s)
[82.102703] [009/133] (937s left) kms_atomic_interruptible (universal-setplane-cursor)
[82.197080] Starting subtest: universal-setplane-cursor
[82.199051] Starting dynamic subtest: pipe-A-eDP-1
[89.557084] Dynamic subtest pipe-A-eDP-1: SUCCESS (7.356s)
[89.559305] Subtest universal-setplane-cursor: SUCCESS (7.357s)
[90.415619] [010/133] (929s left) gem_exec_reloc (basic-wc-cpu)
[90.484521] Subtest basic-wc-cpu: SKIP (0.000s)
[90.564859] [011/133] (929s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-onoff)
[90.680048] Starting subtest: fbc-2p-primscrn-cur-indfb-onoff
[90.684258] Subtest fbc-2p-primscrn-cur-indfb-onoff: SKIP (0.000s)
[90.814878] [012/133] (929s left) gem_pxp (hw-rejects-pxp-buffer)
[90.943099] Starting subtest: hw-rejects-pxp-buffer
[90.947659] Subtest hw-rejects-pxp-buffer: SKIP (0.000s)
[91.059509] [013/133] (928s left) gem_exec_balancer (invalid-bonds)
[91.117495] Starting subtest: invalid-bonds
[91.121716] Subtest invalid-bonds: SKIP (0.000s)
[91.429193] [014/133] (928s left) gem_exec_whisper (basic-forked-all)
[91.500551] Starting subtest: basic-forked-all
[104.960403] Subtest basic-forked-all: SUCCESS (13.456s)
[105.156071] [015/133] (914s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-mmap-cpu)
[105.276156] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-mmap-cpu
[111.875064] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-mmap-cpu: SUCCESS (6.605s)
[112.028802] [016/133] (908s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-render)
[112.135235] Starting subtest: psr-1p-primscrn-spr-indfb-draw-render
[118.923128] Subtest psr-1p-primscrn-spr-indfb-draw-render: SUCCESS (6.792s)
[119.097040] [017/133] (901s left) kms_frontbuffer_tracking (psr-rgb565-draw-render)
[119.206921] Starting subtest: psr-rgb565-draw-render
[126.334877] Subtest psr-rgb565-draw-render: SUCCESS (7.132s)
[126.508112] [018/133] (893s left) kms_psr (pr-cursor-mmap-cpu)
[126.612842] Starting subtest: pr-cursor-mmap-cpu
[126.616787] Subtest pr-cursor-mmap-cpu: SKIP (0.000s)
[126.695528] [019/133] (893s left) gem_close_race (basic-process)
[126.773607] Starting subtest: basic-process
[126.851857] Subtest basic-process: SUCCESS (0.078s)
[127.054825] [020/133] (893s left) syncobj_timeline (etime-single-wait-all-submitted)
[127.111039] Starting subtest: etime-single-wait-all-submitted
[127.217070] Subtest etime-single-wait-all-submitted: SUCCESS (0.105s)
[127.306937] [021/133] (893s left) kms_cursor_crc (cursor-random-128x42)
[127.530592] Starting subtest: cursor-random-128x42
[127.580333] Subtest cursor-random-128x42: SKIP (0.045s)
[127.827683] [022/133] (892s left) syncobj_timeline (invalid-wait-bad-flags)
[127.876196] Starting subtest: invalid-wait-bad-flags
[127.878528] Subtest invalid-wait-bad-flags: SUCCESS (0.000s)
[128.012073] [023/133] (892s left) gem_sync (basic-all)
[128.089615] Starting subtest: basic-all
[131.926954] Subtest basic-all: SUCCESS (3.845s)
[132.124553] [024/133] (888s left) kms_big_fb (linear-16bpp-rotate-90)
[132.230586] Starting subtest: linear-16bpp-rotate-90
[132.250442] Subtest linear-16bpp-rotate-90: SKIP (0.020s)
[132.397534] [025/133] (888s left) gem_flink_basic (bad-flink)
[132.454971] Starting subtest: bad-flink
[132.457259] Subtest bad-flink: SUCCESS (0.000s)
[132.581755] [026/133] (887s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-render)
[132.684877] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-render
[132.689082] Subtest fbc-2p-scndscrn-pri-indfb-draw-render: SKIP (0.000s)
[132.802174] [027/133] (887s left) kms_chamelium_hpd (dp-hpd-with-enabled-mode)
[133.196870] Subtest dp-hpd-with-enabled-mode: SKIP (0.000s)
[133.992878] [028/133] (886s left) gem_exec_fence (syncobj-invalid-wait)
[134.414044] Starting subtest: syncobj-invalid-wait
[134.416573] Subtest syncobj-invalid-wait: SUCCESS (0.000s)
[136.003773] [029/133] (884s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-0-async-flip)
[136.116382] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-0-async-flip
[136.950862] Subtest x-tiled-max-hw-stride-64bpp-rotate-0-async-flip: SUCCESS (0.837s)
[137.148963] [030/133] (883s left) gem_exec_schedule (implicit-boths)
[137.236452] Starting subtest: implicit-boths
[137.238773] Starting dynamic subtest: rcs0
[137.338040] Dynamic subtest rcs0: SUCCESS (0.110s)
[137.350052] Starting dynamic subtest: vcs0
[137.420660] Dynamic subtest vcs0: SUCCESS (0.082s)
[137.432464] Starting dynamic subtest: vcs1
[137.501254] Dynamic subtest vcs1: SUCCESS (0.080s)
[137.513027] Starting dynamic subtest: vecs0
[137.581593] Dynamic subtest vecs0: SUCCESS (0.080s)
[137.592681] Starting dynamic subtest: ccs0
[137.673340] Dynamic subtest ccs0: SUCCESS (0.091s)
[137.676079] Subtest implicit-boths: SUCCESS (0.445s)
[139.012302] [031/133] (881s left) kms_big_fb (linear-max-hw-stride-64bpp-rotate-0)
[139.119538] Starting subtest: linear-max-hw-stride-64bpp-rotate-0
[140.110477] Subtest linear-max-hw-stride-64bpp-rotate-0: SUCCESS (0.990s)
[140.266850] [032/133] (880s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-blt)
[140.374577] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-blt
[140.378783] Subtest psr-2p-scndscrn-pri-indfb-draw-blt: SKIP (0.000s)
[140.500785] [033/133] (880s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-onoff)
[140.598387] Starting subtest: fbc-2p-scndscrn-spr-indfb-onoff
[140.602144] Subtest fbc-2p-scndscrn-spr-indfb-onoff: SKIP (0.000s)
[140.732201] [034/133] (880s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-blt)
[140.840612] Starting subtest: fbc-rgb101010-draw-blt
[145.447575] Subtest fbc-rgb101010-draw-blt: SUCCESS (4.609s)
[146.638202] [035/133] (874s left) kms_plane_scaling (planes-downscale-factor-0-75-upscale-factor-0-25)
[146.728106] Starting subtest: planes-downscale-factor-0-75-upscale-factor-0-25
[146.730474] Starting dynamic subtest: pipe-A
[146.790421] Dynamic subtest pipe-A: SUCCESS (0.065s)
[146.801508] Starting dynamic subtest: pipe-B
[147.946344] Dynamic subtest pipe-B: SUCCESS (1.155s)
[147.966632] Starting dynamic subtest: pipe-C
[149.064677] Dynamic subtest pipe-C: SUCCESS (1.116s)
[149.075360] Starting dynamic subtest: pipe-D
[150.203825] Dynamic subtest pipe-D: SUCCESS (1.138s)
[150.206242] Subtest planes-downscale-factor-0-75-upscale-factor-0-25: SUCCESS (3.478s)
[151.389516] [036/133] (869s left) gem_userptr_blits (probe)
[151.461743] Starting subtest: probe
[151.537770] Subtest probe: SUCCESS (0.075s)
[151.683414] [037/133] (869s left) kms_big_fb (yf-tiled-8bpp-rotate-270)
[151.785193] Starting subtest: yf-tiled-8bpp-rotate-270
[151.789597] Subtest yf-tiled-8bpp-rotate-270: SKIP (0.000s)
[151.895358] [038/133] (869s left) gem_eio (wait-wedge-1us)
[152.122500] Starting subtest: wait-wedge-1us
[154.017675] Subtest wait-wedge-1us: SUCCESS (1.897s)
[154.161276] [039/133] (866s left) syncobj_wait (invalid-signal-one-illegal-handle)
[154.212899] Starting subtest: invalid-signal-one-illegal-handle
[154.215220] Subtest invalid-signal-one-illegal-handle: SUCCESS (0.000s)
[154.313813] [040/133] (866s left) gem_exec_parallel (basic)
[154.373909] Starting subtest: basic
[154.376692] Starting dynamic subtest: rcs0
[155.790438] Dynamic subtest rcs0: SUCCESS (1.416s)
[155.801409] Starting dynamic subtest: bcs0
[157.259908] Dynamic subtest bcs0: SUCCESS (1.468s)
[157.271604] Starting dynamic subtest: vcs0
[158.948889] Dynamic subtest vcs0: SUCCESS (1.686s)
[158.959947] Starting dynamic subtest: vcs1
[160.915912] Dynamic subtest vcs1: SUCCESS (1.966s)
[160.926023] Starting dynamic subtest: vecs0
[162.837379] Dynamic subtest vecs0: SUCCESS (1.919s)
[162.849821] Starting dynamic subtest: ccs0
[164.340876] Dynamic subtest ccs0: SUCCESS (1.503s)
[164.343669] Subtest basic: SUCCESS (9.967s)
[164.566682] [041/133] (856s left) gem_ccs (ctrl-surf-copy)
[164.630731] Starting subtest: ctrl-surf-copy
[164.635371] Subtest ctrl-surf-copy: SKIP (0.000s)
[164.772207] [042/133] (856s left) gem_exec_fence (basic-busy-all)
[164.843053] Starting subtest: basic-busy-all
[164.968821] Subtest basic-busy-all: SUCCESS (0.126s)
[167.019620] [043/133] (854s left) kms_psr (psr2-primary-blt)
[167.123731] Starting subtest: psr2-primary-blt
[167.125940] Starting dynamic subtest: eDP-1
[168.868390] Dynamic subtest eDP-1: SUCCESS (1.745s)
[168.870680] Subtest psr2-primary-blt: SUCCESS (1.745s)
[169.751913] [044/133] (851s left) syncobj_wait (single-wait-for-submit-unsubmitted)
[169.807143] Starting subtest: single-wait-for-submit-unsubmitted
[169.912956] Subtest single-wait-for-submit-unsubmitted: SUCCESS (0.105s)
[170.000321] [045/133] (851s left) kms_flip (flip-vs-rmfb-interruptible)
[170.103893] Starting subtest: flip-vs-rmfb-interruptible
[170.106260] Starting dynamic subtest: A-eDP1
[178.736423] Dynamic subtest A-eDP1: SUCCESS (8.631s)
[178.746068] Starting dynamic subtest: B-eDP1
[187.375570] Dynamic subtest B-eDP1: SUCCESS (8.637s)
[187.386159] Starting dynamic subtest: C-eDP1
[195.991514] Dynamic subtest C-eDP1: SUCCESS (8.614s)
[196.001802] Starting dynamic subtest: D-eDP1
[204.622948] Dynamic subtest D-eDP1: SUCCESS (8.629s)
[204.628281] Subtest flip-vs-rmfb-interruptible: SUCCESS (34.521s)
[205.827881] [046/133] (815s left) kms_cursor_legacy (cursor-vs-flip-varying-size)
[205.973275] Starting subtest: cursor-vs-flip-varying-size
[236.749875] Subtest cursor-vs-flip-varying-size: SUCCESS (30.776s)
[237.562621] [047/133] (783s left) i915_query (hwconfig_table)
[237.629613] Starting subtest: hwconfig_table
[237.931188] Subtest hwconfig_table: SUCCESS (0.001s)
[237.970609] [048/133] (783s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-pwrite)
[238.078144] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-pwrite
[238.082174] Subtest psr-2p-scndscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[238.199910] [049/133] (783s left) kms_cursor_legacy (cursorb-vs-flipb-atomic)
[238.326507] Starting subtest: cursorB-vs-flipB-atomic
[238.330830] Subtest cursorB-vs-flipB-atomic: SKIP (0.001s)
[238.493779] [050/133] (783s left) gen9_exec_parse (valid-registers)
[238.557205] Subtest valid-registers: SKIP (0.000s)
[238.644944] [051/133] (782s left) kms_addfb_basic (bo-too-small)
[238.738351] Starting subtest: bo-too-small
[238.740226] Subtest bo-too-small: SUCCESS (0.000s)
[238.857727] [052/133] (782s left) kms_big_fb (y-tiled-8bpp-rotate-0)
[238.965931] Starting subtest: y-tiled-8bpp-rotate-0
[238.969541] Subtest y-tiled-8bpp-rotate-0: SKIP (0.000s)
[239.091343] [053/133] (782s left) gem_linear_blits (interruptible)
[239.447222] Starting subtest: interruptible
[243.822667] Subtest interruptible: SUCCESS (4.377s)
[243.988905] [054/133] (777s left) gem_create (hog-create)
[244.086886] Starting subtest: hog-create
[244.089209] Starting dynamic subtest: smem0
[276.914688] Dynamic subtest smem0: SUCCESS (32.828s)
[276.917851] Subtest hog-create: SUCCESS (32.830s)
[277.135491] [055/133] (744s left) syncobj_wait (multi-wait-all-for-submit-submitted)
[277.201080] Starting subtest: multi-wait-all-for-submit-submitted
[277.305069] Subtest multi-wait-all-for-submit-submitted: SUCCESS (0.102s)
[277.396189] [056/133] (744s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-pwrite)
[277.510490] Starting subtest: fbcpsr-rgb565-draw-pwrite
[284.592101] Subtest fbcpsr-rgb565-draw-pwrite: SUCCESS (7.086s)
[284.753280] [057/133] (737s left) kms_ccs (bad-aux-stride-4-tiled-mtl-mc-ccs)
[284.845996] Starting subtest: bad-aux-stride-4-tiled-mtl-mc-ccs
[284.848196] Starting dynamic subtest: pipe-A-eDP-1
[284.909985] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.065s)
[284.919539] Starting dynamic subtest: pipe-B-eDP-1
[284.972311] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.061s)
[284.981868] Starting dynamic subtest: pipe-C-eDP-1
[285.036137] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.061s)
[285.046479] Starting dynamic subtest: pipe-D-eDP-1
[285.095911] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.061s)
[285.098188] Subtest bad-aux-stride-4-tiled-mtl-mc-ccs: SUCCESS (0.253s)
[287.275561] [058/133] (734s left) gem_exec_balancer (parallel-ordering)
[287.537431] Starting subtest: parallel-ordering
[288.483599] Subtest parallel-ordering: SUCCESS (0.946s)
[288.641211] [059/133] (733s left) kms_frontbuffer_tracking (fbc-1p-primscrn-shrfb-msflip-blt)
[288.741375] Starting subtest: fbc-1p-primscrn-shrfb-msflip-blt
[293.293474] Subtest fbc-1p-primscrn-shrfb-msflip-blt: SUCCESS (4.555s)
[294.479129] [060/133] (727s left) kms_addfb_basic (basic-x-tiled-legacy)
[294.538172] Starting subtest: basic-x-tiled-legacy
[294.542817] Subtest basic-x-tiled-legacy: SKIP (0.000s)
[294.677073] [061/133] (727s left) perf (polling)
[294.814809] Starting subtest: polling
[294.817061] Starting dynamic subtest: 0-rcs0
[304.827815] Dynamic subtest 0-rcs0: SUCCESS (10.012s)
[304.837364] Starting dynamic subtest: 1-vecs0
[314.850580] Dynamic subtest 1-vecs0: SUCCESS (10.021s)
[314.852968] Subtest polling: SUCCESS (20.035s)
[314.900348] [062/133] (707s left) kms_ccs (crc-primary-basic-4-tiled-mtl-mc-ccs)
[314.999948] Starting subtest: crc-primary-basic-4-tiled-mtl-mc-ccs
[315.002240] Starting dynamic subtest: pipe-A-eDP-1
[317.142610] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.144s)
[317.151916] Starting dynamic subtest: pipe-B-eDP-1
[319.415602] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.271s)
[319.425055] Starting dynamic subtest: pipe-C-eDP-1
[321.562561] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.146s)
[321.572829] Starting dynamic subtest: pipe-D-eDP-1
[323.672898] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.109s)
[323.674902] Subtest crc-primary-basic-4-tiled-mtl-mc-ccs: SUCCESS (8.676s)
[324.879104] [063/133] (697s left) api_intel_bb (simple-bb-ctx)
[324.937214] Starting subtest: simple-bb-ctx
[324.944495] Subtest simple-bb-ctx: SUCCESS (0.009s)
[325.092051] [064/133] (697s left) kms_atomic (plane-primary-overlay-mutable-zpos)
[325.202551] Starting subtest: plane-primary-overlay-mutable-zpos
[328.597643] Subtest plane-primary-overlay-mutable-zpos: SKIP (3.399s)
[329.798611] [065/133] (692s left) kms_pm_rpm (pm-caching)
[332.123714] Starting subtest: pm-caching
[332.128548] Subtest pm-caching: SKIP (0.000s)
[332.514140] [066/133] (689s left) gem_ctx_persistence (engines-hang)
[332.586031] Starting subtest: engines-hang
[332.588475] Starting dynamic subtest: rcs0
[332.684651] Dynamic subtest rcs0: SUCCESS (0.098s)
[332.697013] Starting dynamic subtest: bcs0
[332.798045] Dynamic subtest bcs0: SUCCESS (0.111s)
[332.809320] Starting dynamic subtest: vcs0
[332.923945] Dynamic subtest vcs0: SUCCESS (0.124s)
[332.934988] Starting dynamic subtest: vcs1
[333.028547] Dynamic subtest vcs1: SUCCESS (0.104s)
[333.043031] Starting dynamic subtest: vecs0
[333.141282] Dynamic subtest vecs0: SUCCESS (0.109s)
[333.153696] Starting dynamic subtest: ccs0
[333.211483] Dynamic subtest ccs0: SUCCESS (0.069s)
[333.213824] Subtest engines-hang: SUCCESS (0.627s)
[333.353371] [067/133] (688s left) kms_plane_scaling (plane-downscale-factor-0-5-with-pixel-format)
[333.446230] Starting subtest: plane-downscale-factor-0-5-with-pixel-format
[333.448059] Starting dynamic subtest: pipe-A
[333.464372] Dynamic subtest pipe-A: SKIP (0.016s)
[333.473683] Starting dynamic subtest: pipe-B
[333.496494] Dynamic subtest pipe-B: SKIP (0.030s)
[333.505882] Starting dynamic subtest: pipe-C
[333.525496] Dynamic subtest pipe-C: SKIP (0.029s)
[333.534573] Starting dynamic subtest: pipe-D
[333.556233] Dynamic subtest pipe-D: SKIP (0.029s)
[333.559750] Subtest plane-downscale-factor-0-5-with-pixel-format: SKIP (0.107s)
[333.679381] [068/133] (688s left) api_intel_allocator (fork-simple-once)
[333.735486] Starting subtest: fork-simple-once
[333.751917] Subtest fork-simple-once: SUCCESS (0.018s)
[333.885749] [069/133] (688s left) gem_pread (self)
[333.942909] Subtest self: SKIP (0.000s)
[334.014794] [070/133] (688s left) gem_exec_schedule (preempt-other-chain)
[334.100247] Starting subtest: preempt-other-chain
[334.102239] Starting dynamic subtest: rcs0
[334.179328] Dynamic subtest rcs0: SUCCESS (0.084s)
[334.191895] Starting dynamic subtest: bcs0
[334.267207] Dynamic subtest bcs0: SUCCESS (0.088s)
[334.281267] Starting dynamic subtest: vcs0
[334.344502] Dynamic subtest vcs0: SUCCESS (0.077s)
[334.357464] Starting dynamic subtest: vcs1
[334.422024] Dynamic subtest vcs1: SUCCESS (0.077s)
[334.434067] Starting dynamic subtest: vecs0
[334.506433] Dynamic subtest vecs0: SUCCESS (0.084s)
[334.519966] Starting dynamic subtest: ccs0
[334.592252] Dynamic subtest ccs0: SUCCESS (0.085s)
[334.594298] Subtest preempt-other-chain: SUCCESS (0.498s)
[336.010762] [071/133] (686s left) gem_ctx_persistence (legacy-engines-mixed)
[336.073131] Starting subtest: legacy-engines-mixed
[336.075799] Starting dynamic subtest: render
[336.164632] Dynamic subtest render: SUCCESS (0.091s)
[336.179696] Starting dynamic subtest: bsd1
[336.236583] Dynamic subtest bsd1: SUCCESS (0.069s)
[336.248694] Starting dynamic subtest: bsd2
[336.300354] Dynamic subtest bsd2: SUCCESS (0.061s)
[336.311926] Starting dynamic subtest: blt
[336.371360] Dynamic subtest blt: SUCCESS (0.069s)
[336.383600] Starting dynamic subtest: vebox
[336.428488] Dynamic subtest vebox: SUCCESS (0.055s)
[336.431529] Subtest legacy-engines-mixed: SUCCESS (0.356s)
[336.520875] [072/133] (685s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-pwrite)
[336.629194] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-pwrite
[343.390198] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-pwrite: SUCCESS (6.762s)
[343.540103] [073/133] (678s left) gem_mmap_gtt (bad-object)
[343.602294] Subtest bad-object: SKIP (0.000s)
[343.666421] [074/133] (678s left) kms_psr (fbc-psr-basic)
[343.750433] Starting subtest: fbc-psr-basic
[343.752607] Starting dynamic subtest: eDP-1
[343.756801] Dynamic subtest eDP-1: SKIP (0.000s)
[343.761131] Subtest fbc-psr-basic: SKIP (0.001s)
[343.835975] [075/133] (678s left) gem_userptr_blits (access-control)
[343.910872] Starting subtest: access-control
[343.915238] Subtest access-control: SKIP (0.000s)
[344.053236] [076/133] (678s left) gem_ctx_param (non-root-set)
[344.114404] Starting subtest: non-root-set
[344.138040] Subtest non-root-set: SUCCESS (0.024s)
[344.248689] [077/133] (678s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-blt)
[344.345595] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-blt
[351.545354] Subtest psr-1p-primscrn-pri-shrfb-draw-blt: SUCCESS (7.200s)
[351.729309] [078/133] (670s left) kms_ccs (bad-rotation-90-4-tiled-dg2-rc-ccs-cc)
[351.833647] Starting subtest: bad-rotation-90-4-tiled-dg2-rc-ccs-cc
[351.835936] Starting dynamic subtest: pipe-A-eDP-1
[351.858897] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[351.869844] Starting dynamic subtest: pipe-B-eDP-1
[351.891610] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[351.901139] Starting dynamic subtest: pipe-C-eDP-1
[351.922788] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[351.932164] Starting dynamic subtest: pipe-D-eDP-1
[351.954074] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[351.958137] Subtest bad-rotation-90-4-tiled-dg2-rc-ccs-cc: SKIP (0.005s)
[354.010193] [079/133] (668s left) core_setmaster (master-drop-set-user)
[354.104235] Starting subtest: master-drop-set-user
[354.120200] Subtest master-drop-set-user: SUCCESS (0.016s)
[354.159672] [080/133] (668s left) kms_plane (pixel-format-4-tiled-dg2-rc-ccs-modifier-source-clamping)
[354.255249] Starting subtest: pixel-format-4-tiled-dg2-rc-ccs-modifier-source-clamping
[354.280997] Starting dynamic subtest: pipe-A-plane-0
[354.286021] Dynamic subtest pipe-A-plane-0: SKIP (0.000s)
[354.297531] Starting dynamic subtest: pipe-A-plane-3
[354.302149] Dynamic subtest pipe-A-plane-3: SKIP (0.000s)
[354.311606] Starting dynamic subtest: pipe-A-plane-5
[354.316200] Dynamic subtest pipe-A-plane-5: SKIP (0.000s)
[355.384954] Starting dynamic subtest: pipe-B-plane-0
[355.389478] Dynamic subtest pipe-B-plane-0: SKIP (0.000s)
[355.398830] Starting dynamic subtest: pipe-B-plane-3
[355.403450] Dynamic subtest pipe-B-plane-3: SKIP (0.000s)
[355.414648] Starting dynamic subtest: pipe-B-plane-5
[355.419321] Dynamic subtest pipe-B-plane-5: SKIP (0.000s)
[355.711796] Subtest pixel-format-4-tiled-dg2-rc-ccs-modifier-source-clamping: SKIP (1.454s)
[356.581098] [081/133] (666s left) kms_flip_scaled_crc (flip-64bpp-xtile-to-32bpp-xtile-upscaling)
[356.678720] Starting subtest: flip-64bpp-xtile-to-32bpp-xtile-upscaling
[356.680865] Starting dynamic subtest: pipe-A-default-mode
[359.380076] Dynamic subtest pipe-A-default-mode: SUCCESS (2.700s)
[359.382351] Subtest flip-64bpp-xtile-to-32bpp-xtile-upscaling: SUCCESS (2.701s)
[360.256749] [082/133] (662s left) syncobj_timeline (reset-unsignaled)
[360.327602] Starting subtest: reset-unsignaled
[360.329854] Subtest reset-unsignaled: SUCCESS (0.000s)
[360.432607] [083/133] (662s left) gem_render_copy (yf-tiled-to-vebox-x-tiled)
[360.491946] Starting subtest: yf-tiled-to-vebox-x-tiled
[360.496308] Subtest yf-tiled-to-vebox-x-tiled: SKIP (0.000s)
[360.687703] [084/133] (662s left) perf_pmu (busy-idle-check-all)
[360.723992] Starting subtest: busy-idle-check-all
[360.726284] Starting dynamic subtest: rcs0
[361.392281] Dynamic subtest rcs0: SUCCESS (0.668s)
[361.404318] Starting dynamic subtest: bcs0
[362.042455] Dynamic subtest bcs0: SUCCESS (0.648s)
[362.054882] Starting dynamic subtest: vcs0
[363.924620] Dynamic subtest vcs0: SUCCESS (1.878s)
[363.936316] Starting dynamic subtest: vcs1
[365.910682] Dynamic subtest vcs1: SUCCESS (1.983s)
[365.922220] Starting dynamic subtest: vecs0
[367.892900] Dynamic subtest vecs0: SUCCESS (1.979s)
[367.905448] Starting dynamic subtest: ccs0
[368.548150] Dynamic subtest ccs0: SUCCESS (0.654s)
[368.550590] Subtest busy-idle-check-all: SUCCESS (7.826s)
[368.678415] [085/133] (654s left) kms_draw_crc (draw-method-mmap-cpu)
[368.776988] Starting subtest: draw-method-mmap-cpu
[368.779245] Starting dynamic subtest: xrgb8888-untiled
[369.042892] Dynamic subtest xrgb8888-untiled: SUCCESS (0.267s)
[369.052601] Starting dynamic subtest: rgb565-untiled
[369.265598] Dynamic subtest rgb565-untiled: SUCCESS (0.221s)
[369.275163] Starting dynamic subtest: xrgb2101010-untiled
[369.487415] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.221s)
[369.497158] Starting dynamic subtest: xbgr16161616f-untiled
[369.697873] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.210s)
[369.706857] Starting dynamic subtest: xrgb8888-xtiled
[369.831609] Dynamic subtest xrgb8888-xtiled: SUCCESS (0.133s)
[369.845918] Starting dynamic subtest: rgb565-xtiled
[369.964723] Dynamic subtest rgb565-xtiled: SUCCESS (0.132s)
[369.975798] Starting dynamic subtest: xrgb2101010-xtiled
[370.098032] Dynamic subtest xrgb2101010-xtiled: SUCCESS (0.131s)
[370.110177] Starting dynamic subtest: xbgr16161616f-xtiled
[370.242600] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (0.144s)
[370.251677] Starting dynamic subtest: xrgb8888-4tiled
[370.409175] Dynamic subtest xrgb8888-4tiled: SUCCESS (0.166s)
[370.418498] Starting dynamic subtest: rgb565-4tiled
[370.555923] Dynamic subtest rgb565-4tiled: SUCCESS (0.144s)
[370.565078] Starting dynamic subtest: xrgb2101010-4tiled
[370.697925] Dynamic subtest xrgb2101010-4tiled: SUCCESS (0.141s)
[370.708534] Starting dynamic subtest: xbgr16161616f-4tiled
[370.854987] Dynamic subtest xbgr16161616f-4tiled: SUCCESS (0.155s)
[370.856893] Subtest draw-method-mmap-cpu: SUCCESS (2.079s)
[370.982611] [086/133] (652s left) kms_plane (pixel-format-4-tiled-mtl-rc-ccs-modifier-source-clamping)
[371.083244] Starting subtest: pixel-format-4-tiled-mtl-rc-ccs-modifier-source-clamping
[371.111268] Starting dynamic subtest: pipe-A-plane-0
[371.399753] Dynamic subtest pipe-A-plane-0: SUCCESS (0.289s)
[371.409089] Starting dynamic subtest: pipe-A-plane-3
[371.633056] Dynamic subtest pipe-A-plane-3: SUCCESS (0.232s)
[371.642412] Starting dynamic subtest: pipe-A-plane-5
[371.646195] Dynamic subtest pipe-A-plane-5: SKIP (0.000s)
[372.732508] Starting dynamic subtest: pipe-B-plane-0
[373.023998] Dynamic subtest pipe-B-plane-0: SUCCESS (0.300s)
[373.036253] Starting dynamic subtest: pipe-B-plane-3
[373.279690] Dynamic subtest pipe-B-plane-3: SUCCESS (0.255s)
[373.289333] Starting dynamic subtest: pipe-B-plane-5
[373.293826] Dynamic subtest pipe-B-plane-5: SKIP (0.000s)
[373.595164] Subtest pixel-format-4-tiled-mtl-rc-ccs-modifier-source-clamping: SUCCESS (2.510s)
[374.423838] [087/133] (648s left) kms_joiner (invalid-modeset-force-big-joiner)
[374.515136] Starting subtest: invalid-modeset-force-big-joiner
[374.519087] Subtest invalid-modeset-force-big-joiner: SKIP (0.000s)
[374.597038] [088/133] (648s left) kms_flip_scaled_crc (flip-32bpp-4tile-to-64bpp-4tile-downscaling)
[374.698624] Starting subtest: flip-32bpp-4tile-to-64bpp-4tile-downscaling
[374.700725] Starting dynamic subtest: pipe-A-default-mode
[375.872158] Dynamic subtest pipe-A-default-mode: SKIP (1.172s)
[375.876521] Subtest flip-32bpp-4tile-to-64bpp-4tile-downscaling: SKIP (1.173s)
[376.088716] [089/133] (647s left) gem_ctx_shared (single-timeline)
[376.155798] Starting subtest: single-timeline
[376.174533] Subtest single-timeline: SUCCESS (0.011s)
[376.406038] [090/133] (646s left) vgem_basic (unload)
[376.439744] Starting subtest: unload
[405.608948] Subtest unload: SUCCESS (29.168s)
[405.724573] [091/133] (617s left) gem_spin_batch (legacy-resubmit-new)
[405.801426] Starting subtest: legacy-resubmit-new
[405.803775] Starting dynamic subtest: default
[405.815202] Dynamic subtest default: SUCCESS (0.013s)
[405.826734] Starting dynamic subtest: render
[405.828813] Dynamic subtest render: SUCCESS (0.006s)
[405.839820] Starting dynamic subtest: bsd
[405.841713] Dynamic subtest bsd: SUCCESS (0.007s)
[405.851283] Starting dynamic subtest: bsd1
[405.853533] Dynamic subtest bsd1: SUCCESS (0.006s)
[405.862814] Starting dynamic subtest: bsd2
[405.864651] Dynamic subtest bsd2: SUCCESS (0.004s)
[405.873543] Starting dynamic subtest: blt
[405.875399] Dynamic subtest blt: SUCCESS (0.009s)
[405.884107] Starting dynamic subtest: vebox
[405.885943] Dynamic subtest vebox: SUCCESS (0.007s)
[405.887750] Subtest legacy-resubmit-new: SUCCESS (0.060s)
[406.985698] [092/133] (616s left) kms_psr (fbc-pr-dpms)
[407.080696] Starting subtest: fbc-pr-dpms
[407.084799] Subtest fbc-pr-dpms: SKIP (0.000s)
[407.166215] [093/133] (616s left) kms_cursor_crc (cursor-offscreen-128x128)
[407.394371] Starting subtest: cursor-offscreen-128x128
[407.396590] Starting dynamic subtest: pipe-A-eDP-1
[409.337044] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.940s)
[409.366256] Starting dynamic subtest: pipe-D-eDP-1
[411.956513] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.597s)
[411.958344] Subtest cursor-offscreen-128x128: SUCCESS (4.563s)
[412.808965] [094/133] (610s left) gem_exec_reloc (basic-cpu)
[412.881966] Subtest basic-cpu: SKIP (0.000s)
[412.967214] [095/133] (610s left) syncobj_wait (invalid-wait-illegal-handle)
[413.022022] Starting subtest: invalid-wait-illegal-handle
[413.024188] Subtest invalid-wait-illegal-handle: SUCCESS (0.000s)
[413.146204] [096/133] (610s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-pwrite)
[413.247172] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-pwrite
[417.662074] Subtest fbc-1p-primscrn-spr-indfb-draw-pwrite: SUCCESS (4.417s)
[418.830100] [097/133] (604s left) gem_ctx_param (set-priority-not-supported)
[418.892766] Starting subtest: set-priority-not-supported
[418.897325] Subtest set-priority-not-supported: SKIP (0.000s)
[418.980567] [098/133] (604s left) kms_chamelium_color (ctm-max)
[419.077614] Subtest ctm-max: SKIP (0.000s)
[419.123683] [099/133] (604s left) sriov_basic (enable-vfs-autoprobe-on)
[419.182775] Starting subtest: enable-vfs-autoprobe-on
[419.185235] Starting dynamic subtest: numvfs-1
[419.263633] Dynamic subtest numvfs-1: FAIL (0.030s)
[419.274446] Starting dynamic subtest: numvfs-2
[419.344153] Dynamic subtest numvfs-2: FAIL (0.004s)
[419.355485] Starting dynamic subtest: numvfs-3
[419.427518] Dynamic subtest numvfs-3: FAIL (0.003s)
[419.438080] Starting dynamic subtest: numvfs-4
[419.509725] Dynamic subtest numvfs-4: FAIL (0.003s)
[419.520793] Starting dynamic subtest: numvfs-5
[419.593398] Dynamic subtest numvfs-5: FAIL (0.004s)
[419.604530] Starting dynamic subtest: numvfs-6
[419.677687] Dynamic subtest numvfs-6: FAIL (0.003s)
[419.688542] Starting dynamic subtest: numvfs-7
[419.757352] Dynamic subtest numvfs-7: FAIL (0.004s)
[419.766637] Starting dynamic subtest: numvfs-random
[419.824670] Dynamic subtest numvfs-random: FAIL (0.003s)
[419.833213] Starting dynamic subtest: numvfs-all
[419.891598] Dynamic subtest numvfs-all: FAIL (0.507s)
[419.893476] Subtest enable-vfs-autoprobe-on: FAIL (0.569s)
[419.931252] [100/133] (603s left) kms_frontbuffer_tracking (fbc-tiling-y)
[420.019890] Starting subtest: fbc-tiling-y
[420.023461] Subtest fbc-tiling-y: SKIP (0.000s)
[420.137939] [101/133] (603s left) kms_cursor_edge_walk (128x128-left-edge)
[420.221114] Starting subtest: 128x128-left-edge
[420.223025] Starting dynamic subtest: pipe-A-eDP-1
[423.674661] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.452s)
[423.684222] Starting dynamic subtest: pipe-D-eDP-1
[426.802441] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.127s)
[426.804778] Subtest 128x128-left-edge: SUCCESS (6.582s)
[427.612394] [102/133] (596s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-blt)
[427.726731] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-blt
[432.204826] Subtest fbc-1p-primscrn-pri-shrfb-draw-blt: SUCCESS (4.483s)
[433.422939] [103/133] (590s left) kms_debugfs (display-on-read-all)
[433.521711] Starting subtest: display-on-read-all
[433.692512] Subtest display-on-read-all: SUCCESS (0.173s)
[433.847127] [104/133] (589s left) kms_flip (2x-plain-flip-fb-recreate)
[433.950387] Starting subtest: 2x-plain-flip-fb-recreate
[433.960396] Subtest 2x-plain-flip-fb-recreate: SKIP (0.012s)
[434.099394] [105/133] (589s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-blt)
[434.199367] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-blt
[434.203760] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[434.341218] [106/133] (589s left) syncobj_wait (multi-wait-for-submit-unsubmitted-submitted-signaled)
[434.406879] Starting subtest: multi-wait-for-submit-unsubmitted-submitted-signaled
[434.408958] Subtest multi-wait-for-submit-unsubmitted-submitted-signaled: SUCCESS (0.000s)
[434.534912] [107/133] (589s left) kms_flip (2x-wf_vblank-ts-check-interruptible)
[434.634948] Starting subtest: 2x-wf_vblank-ts-check-interruptible
[434.647373] Subtest 2x-wf_vblank-ts-check-interruptible: SKIP (0.011s)
[434.779483] [108/133] (589s left) kms_ccs (missing-ccs-buffer-4-tiled-mtl-mc-ccs)
[434.874528] Starting subtest: missing-ccs-buffer-4-tiled-mtl-mc-ccs
[434.876136] Starting dynamic subtest: pipe-A-eDP-1
[434.894918] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.021s)
[434.908304] Starting dynamic subtest: pipe-B-eDP-1
[434.924568] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.020s)
[434.938286] Starting dynamic subtest: pipe-C-eDP-1
[434.954520] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.022s)
[434.972081] Starting dynamic subtest: pipe-D-eDP-1
[434.989071] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.021s)
[434.991081] Subtest missing-ccs-buffer-4-tiled-mtl-mc-ccs: SUCCESS (0.089s)
[437.264543] [109/133] (586s left) kms_lease (invalid-create-leases)
[437.363590] Starting subtest: invalid-create-leases
[437.373279] Subtest invalid-create-leases: SUCCESS (0.010s)
[437.503330] [110/133] (586s left) kms_selftest (drm_dp_mst_helper)
[437.542756] Starting subtest: drm_dp_mst_helper
[437.556787] Starting dynamic subtest: drm_test_dp_mst_calc_pbn_mode
[437.686299] Dynamic subtest drm_test_dp_mst_calc_pbn_mode: SUCCESS (0.129s)
[437.697354] Starting dynamic subtest: drm_test_dp_mst_calc_pbn_div
[437.846471] Dynamic subtest drm_test_dp_mst_calc_pbn_div: SUCCESS (0.161s)
[437.856561] Starting dynamic subtest: drm_test_dp_mst_sideband_msg_req_decode
[438.005187] Dynamic subtest drm_test_dp_mst_sideband_msg_req_decode: SUCCESS (0.157s)
[438.007075] Subtest drm_dp_mst_helper: SUCCESS (0.461s)
[438.220512] [111/133] (585s left) gen7_exec_parse (oacontrol-tracking)
[438.290229] Subtest oacontrol-tracking: SKIP (0.000s)
[438.350543] [112/133] (585s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-pwrite)
[438.436424] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-pwrite
[438.440495] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[438.557639] [113/133] (585s left) gem_exec_schedule (thriceslice)
[438.633249] Starting subtest: thriceslice
[438.635138] Starting dynamic subtest: rcs0
[438.677355] Dynamic subtest rcs0: SUCCESS (0.054s)
[438.689663] Starting dynamic subtest: bcs0
[438.731717] Dynamic subtest bcs0: SUCCESS (0.052s)
[438.744353] Starting dynamic subtest: vcs0
[438.761865] Dynamic subtest vcs0: SUCCESS (0.028s)
[438.771199] Starting dynamic subtest: vcs1
[438.792423] Dynamic subtest vcs1: SUCCESS (0.029s)
[438.801809] Starting dynamic subtest: vecs0
[438.824285] Dynamic subtest vecs0: SUCCESS (0.031s)
[438.833666] Starting dynamic subtest: ccs0
[438.881903] Dynamic subtest ccs0: SUCCESS (0.055s)
[438.884658] Subtest thriceslice: SUCCESS (0.260s)
[439.197382] [114/133] (584s left) syncobj_eventfd (invalid-illegal-eventfd)
[439.260674] Starting subtest: invalid-illegal-eventfd
[439.263062] Subtest invalid-illegal-eventfd: SUCCESS (0.000s)
[439.397981] [115/133] (584s left) kms_psr (psr-sprite-plane-move)
[439.495941] Starting subtest: psr-sprite-plane-move
[439.498252] Starting dynamic subtest: eDP-1
[441.285306] Dynamic subtest eDP-1: SUCCESS (1.790s)
[441.287570] Subtest psr-sprite-plane-move: SUCCESS (1.791s)
[442.118063] [116/133] (582s left) kms_ccs (crc-primary-rotation-180-y-tiled-gen12-rc-ccs)
[442.205615] Starting subtest: crc-primary-rotation-180-y-tiled-gen12-rc-ccs
[442.207859] Starting dynamic subtest: pipe-A-eDP-1
[442.230344] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[442.242082] Starting dynamic subtest: pipe-B-eDP-1
[442.263258] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[442.272727] Starting dynamic subtest: pipe-C-eDP-1
[442.293745] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[442.303243] Starting dynamic subtest: pipe-D-eDP-1
[442.325129] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[442.329149] Subtest crc-primary-rotation-180-y-tiled-gen12-rc-ccs: SKIP (0.006s)
[444.492103] [117/133] (579s left) i915_pm_rpm (gem-execbuf-stress-pc8)
[446.112994] Starting subtest: gem-execbuf-stress-pc8
[446.151410] Subtest gem-execbuf-stress-pc8: SKIP (0.040s)
[446.726670] [118/133] (577s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-mmap-gtt)
[446.823211] Starting subtest: psr-2p-primscrn-pri-indfb-draw-mmap-gtt
[446.827492] Subtest psr-2p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[446.960757] [119/133] (577s left) sysfs_timeslice_duration (duration)
[447.022851] Starting subtest: duration
[447.025240] Starting dynamic subtest: vecs0
[460.850990] Dynamic subtest vecs0: SUCCESS (13.825s)
[460.862372] Starting dynamic subtest: ccs0
[474.016084] Dynamic subtest ccs0: SUCCESS (13.163s)
[474.029468] Starting dynamic subtest: vcs0
[487.795064] Dynamic subtest vcs0: SUCCESS (13.774s)
[487.811215] Starting dynamic subtest: bcs0
[500.964744] Dynamic subtest bcs0: SUCCESS (13.168s)
[500.980591] Starting dynamic subtest: rcs0
[514.152369] Dynamic subtest rcs0: SUCCESS (13.185s)
[514.164796] Starting dynamic subtest: vcs1
[527.857432] Dynamic subtest vcs1: SUCCESS (13.701s)
[527.860576] Subtest duration: SUCCESS (80.832s)
[527.948614] [120/133] (496s left) gem_gpgpu_fill (basic)
[528.020657] Starting subtest: basic
[528.023415] Starting dynamic subtest: smem
[528.029182] Dynamic subtest smem: SUCCESS (0.010s)
[528.031355] Subtest basic: SUCCESS (0.010s)
[528.201533] [121/133] (496s left) perf (gen12-group-concurrent-oa-buffer-read)
[528.309656] Starting subtest: gen12-group-concurrent-oa-buffer-read
[538.342367] Subtest gen12-group-concurrent-oa-buffer-read: SUCCESS (10.031s)
[538.391130] [122/133] (486s left) kms_psr (fbc-pr-sprite-mmap-cpu)
[538.493730] Starting subtest: fbc-pr-sprite-mmap-cpu
[538.498064] Subtest fbc-pr-sprite-mmap-cpu: SKIP (0.000s)
[538.581529] [123/133] (485s left) kms_psr2_sf (fbc-psr2-overlay-plane-update-continuous-sf)
[538.689862] Starting subtest: fbc-psr2-overlay-plane-update-continuous-sf
[538.692104] Starting dynamic subtest: pipe-A-eDP-1
[538.777292] Dynamic subtest pipe-A-eDP-1: SKIP (0.088s)
[538.788161] Starting dynamic subtest: pipe-B-eDP-1
[539.966823] Dynamic subtest pipe-B-eDP-1: SKIP (1.187s)
[539.971318] Subtest fbc-psr2-overlay-plane-update-continuous-sf: SKIP (1.277s)
[541.174252] [124/133] (483s left) kms_content_protection (dp-mst-type-1)
[541.321686] Starting subtest: dp-mst-type-1
[541.326237] Subtest dp-mst-type-1: SKIP (0.000s)
[541.482327] [125/133] (483s left) kms_pm_lpsp (screens-disabled)
[542.592624] Starting subtest: screens-disabled
[542.597255] Subtest screens-disabled: SKIP (0.000s)
[542.678111] [126/133] (482s left) kms_color_pipeline (plane-lut1d-pre-ctm3x4)
[542.783634] Starting subtest: plane-lut1d-pre-ctm3x4
[542.797752] Starting dynamic subtest: pipe-A-eDP-1
[543.494817] Dynamic subtest pipe-A-eDP-1: FAIL (0.305s)
[544.146887] Starting dynamic subtest: pipe-B-eDP-1
[544.960840] Dynamic subtest pipe-B-eDP-1: FAIL (0.301s)
[545.484742] Starting dynamic subtest: pipe-C-eDP-1
[546.308625] Dynamic subtest pipe-C-eDP-1: FAIL (0.235s)
[546.810464] Starting dynamic subtest: pipe-D-eDP-1
[547.611731] Dynamic subtest pipe-D-eDP-1: FAIL (0.236s)
[547.613783] Subtest plane-lut1d-pre-ctm3x4: FAIL (4.545s)
[548.211054] [127/133] (476s left) kms_psr2_sf (fbc-pr-overlay-primary-update-sf-dmg-area)
[548.312146] Starting subtest: fbc-pr-overlay-primary-update-sf-dmg-area
[548.316247] Subtest fbc-pr-overlay-primary-update-sf-dmg-area: SKIP (0.000s)
[548.394265] [128/133] (476s left) kms_vblank (wait-idle-hang)
[548.483525] Starting subtest: wait-idle-hang
[548.485618] Starting dynamic subtest: pipe-A-eDP-1
[575.651533] Dynamic subtest pipe-A-eDP-1: SUCCESS (27.163s)
[575.676874] Starting dynamic subtest: pipe-D-eDP-1
[590.736254] Dynamic subtest pipe-D-eDP-1: SUCCESS (15.082s)
[590.738589] Subtest wait-idle-hang: SUCCESS (42.250s)
[591.603434] [129/133] (433s left) gem_mmap_gtt (flink-race)
[591.653713] Subtest flink-race: SKIP (0.000s)
[591.726344] [130/133] (433s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-blt)
[591.837557] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-blt
[591.841967] Subtest fbc-2p-primscrn-spr-indfb-draw-blt: SKIP (0.000s)
[591.973126] [131/133] (432s left) kms_chamelium_edid (dp-edid-change-during-suspend)
[592.359564] Subtest dp-edid-change-during-suspend: SKIP (0.000s)
[593.187637] [132/133] (431s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling)
[593.280097] Starting subtest: flip-64bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling
[593.284517] Subtest flip-64bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling: SKIP (0.000s)
[593.365251] [133/133] (431s left) kms_addfb_basic (basic)
[593.426952] Starting subtest: basic
[593.428971] Subtest basic: SUCCESS (0.000s)
[593.591571] Closing watchdogs
results: parsing output: 0/ for test: kms_pipe_crc_basic
results: parsing output: 1/ for test: i915_module_load
results: parsing output: 2/ for test: gem_eio
results: parsing output: 3/ for test: kms_big_fb
results: parsing output: 4/ for test: kms_addfb_basic
results: parsing output: 5/ for test: kms_getfb
results: parsing output: 6/ for test: syncobj_timeline
results: parsing output: 7/ for test: syncobj_wait
results: parsing output: 8/ for test: kms_atomic_interruptible
results: parsing output: 9/ for test: gem_exec_reloc
results: parsing output: 10/ for test: kms_frontbuffer_tracking
results: parsing output: 11/ for test: gem_pxp
results: parsing output: 12/ for test: gem_exec_balancer
results: parsing output: 13/ for test: gem_exec_whisper
results: parsing output: 14/ for test: kms_frontbuffer_tracking
results: parsing output: 15/ for test: kms_frontbuffer_tracking
results: parsing output: 16/ for test: kms_frontbuffer_tracking
results: parsing output: 17/ for test: kms_psr
results: parsing output: 18/ for test: gem_close_race
results: parsing output: 19/ for test: syncobj_timeline
results: parsing output: 20/ for test: kms_cursor_crc
results: parsing output: 21/ for test: syncobj_timeline
results: parsing output: 22/ for test: gem_sync
results: parsing output: 23/ for test: kms_big_fb
results: parsing output: 24/ for test: gem_flink_basic
results: parsing output: 25/ for test: kms_frontbuffer_tracking
results: parsing output: 26/ for test: kms_chamelium_hpd
results: parsing output: 27/ for test: gem_exec_fence
results: parsing output: 28/ for test: kms_big_fb
results: parsing output: 29/ for test: gem_exec_schedule
results: parsing output: 30/ for test: kms_big_fb
results: parsing output: 31/ for test: kms_frontbuffer_tracking
results: parsing output: 32/ for test: kms_frontbuffer_tracking
results: parsing output: 33/ for test: kms_frontbuffer_tracking
results: parsing output: 34/ for test: kms_plane_scaling
results: parsing output: 35/ for test: gem_userptr_blits
results: parsing output: 36/ for test: kms_big_fb
results: parsing output: 37/ for test: gem_eio
results: parsing output: 38/ for test: syncobj_wait
results: parsing output: 39/ for test: gem_exec_parallel
results: parsing output: 40/ for test: gem_ccs
results: parsing output: 41/ for test: gem_exec_fence
results: parsing output: 42/ for test: kms_psr
results: parsing output: 43/ for test: syncobj_wait
results: parsing output: 44/ for test: kms_flip
results: parsing output: 45/ for test: kms_cursor_legacy
results: parsing output: 46/ for test: i915_query
results: parsing output: 47/ for test: kms_frontbuffer_tracking
results: parsing output: 48/ for test: kms_cursor_legacy
results: parsing output: 49/ for test: gen9_exec_parse
results: parsing output: 50/ for test: kms_addfb_basic
results: parsing output: 51/ for test: kms_big_fb
results: parsing output: 52/ for test: gem_linear_blits
results: parsing output: 53/ for test: gem_create
results: parsing output: 54/ for test: syncobj_wait
results: parsing output: 55/ for test: kms_frontbuffer_tracking
results: parsing output: 56/ for test: kms_ccs
results: parsing output: 57/ for test: gem_exec_balancer
results: parsing output: 58/ for test: kms_frontbuffer_tracking
results: parsing output: 59/ for test: kms_addfb_basic
results: parsing output: 60/ for test: perf
results: parsing output: 61/ for test: kms_ccs
results: parsing output: 62/ for test: api_intel_bb
results: parsing output: 63/ for test: kms_atomic
results: parsing output: 64/ for test: kms_pm_rpm
results: parsing output: 65/ for test: gem_ctx_persistence
results: parsing output: 66/ for test: kms_plane_scaling
results: parsing output: 67/ for test: api_intel_allocator
results: parsing output: 68/ for test: gem_pread
results: parsing output: 69/ for test: gem_exec_schedule
results: parsing output: 70/ for test: gem_ctx_persistence
results: parsing output: 71/ for test: kms_frontbuffer_tracking
results: parsing output: 72/ for test: gem_mmap_gtt
results: parsing output: 73/ for test: kms_psr
results: parsing output: 74/ for test: gem_userptr_blits
results: parsing output: 75/ for test: gem_ctx_param
results: parsing output: 76/ for test: kms_frontbuffer_tracking
results: parsing output: 77/ for test: kms_ccs
results: parsing output: 78/ for test: core_setmaster
results: parsing output: 79/ for test: kms_plane
results: parsing output: 80/ for test: kms_flip_scaled_crc
results: parsing output: 81/ for test: syncobj_timeline
results: parsing output: 82/ for test: gem_render_copy
results: parsing output: 83/ for test: perf_pmu
results: parsing output: 84/ for test: kms_draw_crc
results: parsing output: 85/ for test: kms_plane
results: parsing output: 86/ for test: kms_joiner
results: parsing output: 87/ for test: kms_flip_scaled_crc
results: parsing output: 88/ for test: gem_ctx_shared
results: parsing output: 89/ for test: vgem_basic
results: parsing output: 90/ for test: gem_spin_batch
results: parsing output: 91/ for test: kms_psr
results: parsing output: 92/ for test: kms_cursor_crc
results: parsing output: 93/ for test: gem_exec_reloc
results: parsing output: 94/ for test: syncobj_wait
results: parsing output: 95/ for test: kms_frontbuffer_tracking
results: parsing output: 96/ for test: gem_ctx_param
results: parsing output: 97/ for test: kms_chamelium_color
results: parsing output: 98/ for test: sriov_basic
results: parsing output: 99/ for test: kms_frontbuffer_tracking
results: parsing output: 100/ for test: kms_cursor_edge_walk
results: parsing output: 101/ for test: kms_frontbuffer_tracking
results: parsing output: 102/ for test: kms_debugfs
results: parsing output: 103/ for test: kms_flip
results: parsing output: 104/ for test: kms_frontbuffer_tracking
results: parsing output: 105/ for test: syncobj_wait
results: parsing output: 106/ for test: kms_flip
results: parsing output: 107/ for test: kms_ccs
results: parsing output: 108/ for test: kms_lease
results: parsing output: 109/ for test: kms_selftest
results: parsing output: 110/ for test: gen7_exec_parse
results: parsing output: 111/ for test: kms_frontbuffer_tracking
results: parsing output: 112/ for test: gem_exec_schedule
results: parsing output: 113/ for test: syncobj_eventfd
results: parsing output: 114/ for test: kms_psr
results: parsing output: 115/ for test: kms_ccs
results: parsing output: 116/ for test: i915_pm_rpm
results: parsing output: 117/ for test: kms_frontbuffer_tracking
results: parsing output: 118/ for test: sysfs_timeslice_duration
results: parsing output: 119/ for test: gem_gpgpu_fill
results: parsing output: 120/ for test: perf
results: parsing output: 121/ for test: kms_psr
results: parsing output: 122/ for test: kms_psr2_sf
results: parsing output: 123/ for test: kms_content_protection
results: parsing output: 124/ for test: kms_pm_lpsp
results: parsing output: 125/ for test: kms_color_pipeline
results: parsing output: 126/ for test: kms_psr2_sf
results: parsing output: 127/ for test: kms_vblank
results: parsing output: 128/ for test: gem_mmap_gtt
results: parsing output: 129/ for test: kms_frontbuffer_tracking
results: parsing output: 130/ for test: kms_chamelium_edid
results: parsing output: 131/ for test: kms_flip_scaled_crc
results: parsing output: 132/ for test: kms_addfb_basic
Done.