[60.130172] Initializing watchdogs
[60.130220]   /dev/watchdog0
[60.144714] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:7d55 Intel Meteorlake (Gen12) Meteor Lake-P [Intel Arc Graphics]
[60.149495] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[60.151774] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[60.155129] [001/130] (960s left) kms_ccs (bad-aux-stride-4-tiled-mtl-rc-ccs)
[60.280705] Starting subtest: bad-aux-stride-4-tiled-mtl-rc-ccs
[60.282896] Starting dynamic subtest: pipe-A-eDP-1
[60.302915] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[60.309783] Starting dynamic subtest: pipe-B-eDP-1
[60.329119] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[60.335825] Starting dynamic subtest: pipe-C-eDP-1
[60.354089] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[60.360666] Starting dynamic subtest: pipe-D-eDP-1
[60.379263] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[60.381404] Subtest bad-aux-stride-4-tiled-mtl-rc-ccs: SUCCESS (0.006s)
[62.606756] [002/130] (958s left) gem_fence_thrash (bo-write-verify-x)
[62.648929] Starting subtest: bo-write-verify-x
[62.673851] Subtest bo-write-verify-x: SKIP (0.023s)
[62.733131] [003/130] (957s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-blt)
[62.835490] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-blt
[70.177907] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-blt: SUCCESS (7.347s)
[70.336663] [004/130] (950s left) gem_exec_parallel (contexts)
[70.400891] Starting subtest: contexts
[70.403368] Starting dynamic subtest: rcs0
[73.396855] Dynamic subtest rcs0: SUCCESS (2.994s)
[73.409900] Starting dynamic subtest: bcs0
[77.039446] Dynamic subtest bcs0: SUCCESS (3.641s)
[77.050067] Starting dynamic subtest: vcs0
[81.349881] Dynamic subtest vcs0: SUCCESS (4.309s)
[81.360622] Starting dynamic subtest: vcs1
[85.438023] Dynamic subtest vcs1: SUCCESS (4.087s)
[85.448202] Starting dynamic subtest: vecs0
[89.414963] Dynamic subtest vecs0: SUCCESS (3.976s)
[89.425722] Starting dynamic subtest: ccs0
[93.058413] Dynamic subtest ccs0: SUCCESS (3.643s)
[93.061243] Subtest contexts: SUCCESS (22.656s)
[93.272524] [005/130] (927s left) gem_wait (invalid-buf)
[93.332360] Starting subtest: invalid-buf
[93.334727] Subtest invalid-buf: SUCCESS (0.000s)
[93.593379] [006/130] (927s left) gem_tiled_wb
[93.722783] [007/130] (927s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-mmap-wc)
[93.825538] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-mmap-wc
[97.463468] Subtest fbc-1p-primscrn-cur-indfb-draw-mmap-wc: SUCCESS (3.641s)
[98.684857] [008/130] (922s left) kms_big_fb (x-tiled-8bpp-rotate-90)
[98.791645] Starting subtest: x-tiled-8bpp-rotate-90
[98.812297] Subtest x-tiled-8bpp-rotate-90: SKIP (0.020s)
[98.961189] [009/130] (922s left) i915_drm_fdinfo (most-busy-idle-check-all)
[99.006579] Starting subtest: most-busy-idle-check-all
[99.008810] Starting dynamic subtest: rcs0
[99.013358] Dynamic subtest rcs0: SKIP (0.003s)
[99.022355] Starting dynamic subtest: bcs0
[99.026810] Dynamic subtest bcs0: SKIP (0.000s)
[99.034501] Starting dynamic subtest: vcs0
[99.039048] Dynamic subtest vcs0: SKIP (0.000s)
[99.047093] Starting dynamic subtest: vcs1
[99.051291] Dynamic subtest vcs1: SKIP (0.000s)
[99.059048] Starting dynamic subtest: vecs0
[99.063049] Dynamic subtest vecs0: SKIP (0.000s)
[99.070125] Starting dynamic subtest: ccs0
[99.074273] Dynamic subtest ccs0: SKIP (0.000s)
[99.078271] Subtest most-busy-idle-check-all: SKIP (0.006s)
[99.112938] [010/130] (921s left) gem_exec_reloc (basic-wc-noreloc)
[99.227250] Subtest basic-wc-noreloc: SKIP (0.000s)
[99.300544] [011/130] (921s left) gem_mmap_offset (blt-coherency)
[99.366721] Starting subtest: blt-coherency
[99.375554] Subtest blt-coherency: SUCCESS (0.011s)
[99.538155] [012/130] (921s left) kms_dp_aux_dev
[99.917328] [013/130] (921s left) gem_exec_params (cliprects-invalid)
[99.972231] Starting subtest: cliprects-invalid
[99.974129] Subtest cliprects-invalid: SUCCESS (0.000s)
[100.088139] [014/130] (921s left) vgem_basic (mmap)
[100.229903] Starting subtest: mmap
[100.234196] Subtest mmap: SUCCESS (0.006s)
[100.305237] [FACT vgem_basic (mmap)] new: kernel.kmod_is_loaded.vgem: true
[100.308416] [015/130] (920s left) kms_getfb (getfb-handle-closed)
[100.419376] Starting subtest: getfb-handle-closed
[100.421613] Subtest getfb-handle-closed: SUCCESS (0.000s)
[100.600287] [016/130] (920s left) kms_cursor_crc (cursor-offscreen-max-size)
[100.896087] Starting subtest: cursor-offscreen-max-size
[100.901713] Subtest cursor-offscreen-max-size: SKIP (0.000s)
[101.067421] [017/130] (920s left) kms_cursor_legacy (cursorb-vs-flipb-varying-size)
[101.187029] Starting subtest: cursorB-vs-flipB-varying-size
[101.190936] Subtest cursorB-vs-flipB-varying-size: SKIP (0.001s)
[101.366354] [018/130] (920s left) kms_frontbuffer_tracking (psr-2p-scndscrn-shrfb-plflip-blt)
[101.478384] Starting subtest: psr-2p-scndscrn-shrfb-plflip-blt
[101.481875] Subtest psr-2p-scndscrn-shrfb-plflip-blt: SKIP (0.000s)
[101.606225] [019/130] (919s left) kms_big_fb (linear-8bpp-rotate-270)
[101.698863] Starting subtest: linear-8bpp-rotate-270
[101.721260] Subtest linear-8bpp-rotate-270: SKIP (0.021s)
[101.891190] [020/130] (919s left) kms_dp_linktrain_fallback (dp-fallback)
[101.986257] Starting subtest: dp-fallback
[101.991346] Subtest dp-fallback: SKIP (0.000s)
[102.078812] [021/130] (919s left) core_debugfs (read-all-entries)
[102.137064] Starting subtest: read-all-entries
[102.231711] Subtest read-all-entries: SUCCESS (0.095s)
[102.344386] [022/130] (919s left) gem_ctx_param (invalid-get-engines)
[102.394233] Starting subtest: invalid-get-engines
[102.396166] Subtest invalid-get-engines: SUCCESS (0.001s)
[102.528536] [023/130] (919s left) vgem_basic (setversion)
[102.589436] Starting subtest: setversion
[102.593158] Subtest setversion: SUCCESS (0.000s)
[102.672074] [024/130] (918s left) kms_psr (psr-primary-render)
[102.763068] Starting subtest: psr-primary-render
[102.764927] Starting dynamic subtest: eDP-1
[104.531801] Dynamic subtest eDP-1: SUCCESS (1.768s)
[104.534261] Subtest psr-primary-render: SUCCESS (1.769s)
[105.414383] [025/130] (916s left) kms_getfb (getfb-handle-zero)
[105.514121] Starting subtest: getfb-handle-zero
[105.516469] Subtest getfb-handle-zero: SUCCESS (0.000s)
[105.661548] [026/130] (916s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-32bpp-ytile-downscaling)
[105.761299] Starting subtest: flip-64bpp-ytile-to-32bpp-ytile-downscaling
[105.764082] Starting dynamic subtest: pipe-A-default-mode
[106.050986] Dynamic subtest pipe-A-default-mode: SKIP (0.288s)
[106.055841] Subtest flip-64bpp-ytile-to-32bpp-ytile-downscaling: SKIP (0.289s)
[106.941603] [027/130] (914s left) gem_exec_flush (basic-batch-kernel-default-cmd)
[107.009110] Starting subtest: basic-batch-kernel-default-cmd
[107.013385] Subtest basic-batch-kernel-default-cmd: SKIP (0.000s)
[107.213205] [028/130] (914s left) kms_frontbuffer_tracking (fbc-farfromfence-mmap-gtt)
[107.308671] Starting subtest: fbc-farfromfence-mmap-gtt
[107.313172] Subtest fbc-farfromfence-mmap-gtt: SKIP (0.000s)
[107.435887] [029/130] (914s left) kms_plane_multiple (2x-tiling-4)
[107.534653] Starting subtest: 2x-tiling-4
[107.538673] Subtest 2x-tiling-4: SKIP (0.000s)
[107.626557] [030/130] (914s left) kms_ccs (bad-rotation-90-4-tiled-mtl-rc-ccs)
[107.717830] Starting subtest: bad-rotation-90-4-tiled-mtl-rc-ccs
[107.720169] Starting dynamic subtest: pipe-A-eDP-1
[107.887130] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.161s)
[107.897239] Starting dynamic subtest: pipe-B-eDP-1
[107.916653] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[107.924385] Starting dynamic subtest: pipe-C-eDP-1
[107.943189] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.002s)
[107.950581] Starting dynamic subtest: pipe-D-eDP-1
[107.969612] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.002s)
[107.971550] Subtest bad-rotation-90-4-tiled-mtl-rc-ccs: SUCCESS (0.168s)
[110.214064] [031/130] (911s left) gem_eio (in-flight-suspend)
[110.441541] Starting subtest: in-flight-suspend
[157.600304] Subtest in-flight-suspend: SUCCESS (18.141s)
[170.764610] [032/130] (864s left) gen7_exec_parse (bitmasks)
[170.842362] Subtest bitmasks: SKIP (0.000s)
[170.924896] [033/130] (864s left) gem_mmap_gtt (medium-copy-xy)
[170.989513] Subtest medium-copy-XY: SKIP (0.000s)
[171.059579] [034/130] (863s left) kms_chamelium_frames (hdmi-crc-single)
[171.444405] Subtest hdmi-crc-single: SKIP (0.000s)
[172.241491] [035/130] (862s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-pwrite)
[172.350595] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-pwrite
[172.354566] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[172.486873] [036/130] (862s left) gem_exec_schedule (timeslicing)
[172.564275] Starting subtest: timeslicing
[172.566504] Starting dynamic subtest: rcs0
[172.577748] Dynamic subtest rcs0: SUCCESS (0.021s)
[172.588246] Starting dynamic subtest: bcs0
[172.597174] Dynamic subtest bcs0: SUCCESS (0.019s)
[172.606535] Starting dynamic subtest: vcs0
[172.617150] Dynamic subtest vcs0: SUCCESS (0.020s)
[172.626419] Starting dynamic subtest: vcs1
[172.636818] Dynamic subtest vcs1: SUCCESS (0.019s)
[172.646029] Starting dynamic subtest: vecs0
[172.656569] Dynamic subtest vecs0: SUCCESS (0.020s)
[172.665833] Starting dynamic subtest: ccs0
[172.681695] Dynamic subtest ccs0: SUCCESS (0.024s)
[172.683948] Subtest timeslicing: SUCCESS (0.125s)
[173.996118] [037/130] (861s left) kms_psr2_sf (psr2-overlay-plane-move-continuous-exceed-fully-sf)
[179.040819] Starting subtest: psr2-overlay-plane-move-continuous-exceed-fully-sf
[179.043199] Starting dynamic subtest: pipe-A-eDP-1
[196.229467] Dynamic subtest pipe-A-eDP-1: SUCCESS (17.185s)
[196.239968] Starting dynamic subtest: pipe-B-eDP-1
[213.364021] Dynamic subtest pipe-B-eDP-1: SUCCESS (17.131s)
[213.366361] Subtest psr2-overlay-plane-move-continuous-exceed-fully-sf: SUCCESS (34.320s)
[214.184614] [038/130] (821s left) gem_exec_schedule (deep)
[214.373392] Starting subtest: deep
[214.375600] Starting dynamic subtest: rcs0
[219.864271] Dynamic subtest rcs0: SKIP (5.488s)
[219.876646] Starting dynamic subtest: vcs0
[230.751931] Dynamic subtest vcs0: SUCCESS (10.890s)
[230.763384] Starting dynamic subtest: vcs1
[242.877694] Dynamic subtest vcs1: SUCCESS (12.125s)
[242.892044] Starting dynamic subtest: vecs0
[254.810833] Dynamic subtest vecs0: SUCCESS (11.932s)
[254.841372] Starting dynamic subtest: ccs0
[267.631932] Dynamic subtest ccs0: SUCCESS (12.819s)
[267.634871] Subtest deep: SUCCESS (53.258s)
[268.693175] [039/130] (766s left) kms_color (degamma)
[268.790980] Starting subtest: degamma
[268.792864] Starting dynamic subtest: pipe-A-eDP-1
[269.533697] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.742s)
[269.544321] Starting dynamic subtest: pipe-B-eDP-1
[270.972810] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.439s)
[270.983257] Starting dynamic subtest: pipe-C-eDP-1
[272.349058] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.375s)
[272.359718] Starting dynamic subtest: pipe-D-eDP-1
[273.690043] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.342s)
[273.692405] Subtest degamma: SUCCESS (4.900s)
[274.516861] [040/130] (760s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-180)
[274.622419] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-180
[274.626788] Subtest yf-tiled-max-hw-stride-32bpp-rotate-180: SKIP (0.000s)
[274.739694] [041/130] (760s left) gem_eio (banned)
[274.980566] Starting subtest: banned
[275.646589] Subtest banned: SUCCESS (0.667s)
[275.866878] [042/130] (759s left) gem_ppgtt (flink-and-close-vma-leak)
[275.928964] Starting subtest: flink-and-close-vma-leak
[275.969649] Subtest flink-and-close-vma-leak: SUCCESS (0.041s)
[276.131881] [043/130] (759s left) kms_cursor_crc (cursor-sliding-128x42)
[276.350535] Starting subtest: cursor-sliding-128x42
[276.398219] Subtest cursor-sliding-128x42: SKIP (0.044s)
[276.649829] [044/130] (758s left) kms_atomic_transition (modeset-transition-nonblocking)
[276.743674] Starting subtest: modeset-transition-nonblocking
[276.745465] Starting dynamic subtest: 1x-outputs
[287.602991] Dynamic subtest 1x-outputs: SUCCESS (10.860s)
[287.605320] Subtest modeset-transition-nonblocking: SUCCESS (10.861s)
[288.490255] [045/130] (747s left) kms_plane_alpha_blend (alpha-transparent-fb)
[288.592510] Starting subtest: alpha-transparent-fb
[288.879693] Starting dynamic subtest: pipe-A-eDP-1
[289.511154] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.631s)
[289.522114] Starting dynamic subtest: pipe-D-eDP-1
[290.842723] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.331s)
[290.845167] Subtest alpha-transparent-fb: SUCCESS (2.253s)
[291.659409] [046/130] (743s left) kms_frontbuffer_tracking (psr-1p-primscrn-shrfb-pgflip-blt)
[291.766391] Starting subtest: psr-1p-primscrn-shrfb-pgflip-blt
[299.094789] Subtest psr-1p-primscrn-shrfb-pgflip-blt: SUCCESS (7.331s)
[299.246713] [047/130] (736s left) syncobj_wait (wait-all-complex)
[299.305841] Starting subtest: wait-all-complex
[299.521583] Subtest wait-all-complex: SUCCESS (0.214s)
[299.625237] [048/130] (736s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-mmap-cpu)
[299.734615] Starting subtest: fbcpsr-rgb565-draw-mmap-cpu
[306.540421] Subtest fbcpsr-rgb565-draw-mmap-cpu: SUCCESS (6.808s)
[306.698495] [049/130] (728s left) kms_ccs (crc-primary-basic-4-tiled-lnl-ccs)
[306.810635] Starting subtest: crc-primary-basic-4-tiled-lnl-ccs
[306.815240] Subtest crc-primary-basic-4-tiled-lnl-ccs: SKIP (0.000s)
[307.936638] [050/130] (727s left) gem_exec_whisper (basic-fds-priority)
[308.013381] Starting subtest: basic-fds-priority
[332.110072] Subtest basic-fds-priority: SUCCESS (24.089s)
[332.317009] [051/130] (703s left) gem_wait (await)
[332.375872] Starting subtest: await
[332.378363] Starting dynamic subtest: all-engines
[333.543393] Dynamic subtest all-engines: SUCCESS (1.167s)
[333.559927] Starting dynamic subtest: rcs0
[334.618151] Dynamic subtest rcs0: SUCCESS (1.074s)
[334.630206] Starting dynamic subtest: bcs0
[335.680757] Dynamic subtest bcs0: SUCCESS (1.060s)
[335.697699] Starting dynamic subtest: vcs0
[336.739038] Dynamic subtest vcs0: SUCCESS (1.055s)
[336.757303] Starting dynamic subtest: vcs1
[337.793727] Dynamic subtest vcs1: SUCCESS (1.053s)
[337.811647] Starting dynamic subtest: vecs0
[338.849626] Dynamic subtest vecs0: SUCCESS (1.054s)
[338.867658] Starting dynamic subtest: ccs0
[339.907651] Dynamic subtest ccs0: SUCCESS (1.056s)
[339.910328] Subtest await: SUCCESS (7.533s)
[340.128359] [052/130] (695s left) kms_psr (pr-no-drrs)
[340.232660] Starting subtest: pr-no-drrs
[340.237291] Subtest pr-no-drrs: SKIP (0.000s)
[340.351508] [053/130] (695s left) kms_joiner (basic-max-non-joiner)
[340.469844] Starting subtest: basic-max-non-joiner
[340.473925] Subtest basic-max-non-joiner: SKIP (0.000s)
[340.559865] [054/130] (695s left) kms_vblank (query-idle-hang)
[340.667190] Starting subtest: query-idle-hang
[340.669463] Starting dynamic subtest: pipe-A-eDP-1
[366.701600] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.030s)
[366.718781] Starting dynamic subtest: pipe-D-eDP-1
[381.752313] Dynamic subtest pipe-D-eDP-1: SUCCESS (15.049s)
[381.754348] Subtest query-idle-hang: SUCCESS (41.084s)
[382.585014] [055/130] (653s left) syncobj_timeline (multi-wait-for-submit-available-unsubmitted-submitted)
[382.657674] Starting subtest: multi-wait-for-submit-available-unsubmitted-submitted
[382.659947] Subtest multi-wait-for-submit-available-unsubmitted-submitted: SUCCESS (0.000s)
[382.785633] [056/130] (653s left) kms_cursor_crc (cursor-rapid-movement-256x85)
[383.063220] Starting subtest: cursor-rapid-movement-256x85
[383.109832] Subtest cursor-rapid-movement-256x85: SKIP (0.043s)
[383.342899] [057/130] (652s left) gem_lmem_swapping (verify-ccs)
[383.391220] Subtest verify-ccs: SKIP (0.000s)
[383.445820] [058/130] (652s left) kms_universal_plane (cursor-fb-leak)
[383.547816] Starting subtest: cursor-fb-leak
[383.549663] Starting dynamic subtest: pipe-A-eDP-1
[383.848058] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.302s)
[383.860230] Starting dynamic subtest: pipe-B-eDP-1
[385.155058] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.305s)
[385.170004] Starting dynamic subtest: pipe-C-eDP-1
[386.492596] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.332s)
[386.503677] Starting dynamic subtest: pipe-D-eDP-1
[387.806221] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.315s)
[387.808679] Subtest cursor-fb-leak: SUCCESS (4.260s)
[389.021506] [059/130] (647s left) kms_getfb (getfb-reject-nv12)
[389.123850] Starting subtest: getfb-reject-nv12
[389.126184] Subtest getfb-reject-nv12: SUCCESS (0.001s)
[389.263549] [060/130] (646s left) kms_lease (atomic-implicit-crtc)
[389.364376] Starting subtest: atomic-implicit-crtc
[389.366664] Starting dynamic subtest: pipe-A-eDP-1
[389.377722] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.002s)
[389.387926] Starting dynamic subtest: pipe-B-eDP-1
[389.399003] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.010s)
[389.409776] Starting dynamic subtest: pipe-C-eDP-1
[389.420598] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.010s)
[389.430232] Starting dynamic subtest: pipe-D-eDP-1
[389.441114] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.010s)
[389.443352] Subtest atomic-implicit-crtc: SUCCESS (0.036s)
[389.548605] [061/130] (646s left) kms_flip (flip-vs-dpms-on-nop-interruptible)
[389.661260] Starting subtest: flip-vs-dpms-on-nop-interruptible
[389.663680] Starting dynamic subtest: A-eDP1
[391.492434] Dynamic subtest A-eDP1: SUCCESS (1.833s)
[391.505572] Starting dynamic subtest: B-eDP1
[393.307543] Dynamic subtest B-eDP1: SUCCESS (1.812s)
[393.318833] Starting dynamic subtest: C-eDP1
[395.132387] Dynamic subtest C-eDP1: SUCCESS (1.823s)
[395.144389] Starting dynamic subtest: D-eDP1
[396.960975] Dynamic subtest D-eDP1: SUCCESS (1.828s)
[396.965988] Subtest flip-vs-dpms-on-nop-interruptible: SUCCESS (7.309s)
[398.174753] [062/130] (638s left) kms_ccs (random-ccs-data-4-tiled-mtl-rc-ccs)
[398.264872] Starting subtest: random-ccs-data-4-tiled-mtl-rc-ccs
[398.267158] Starting dynamic subtest: pipe-A-eDP-1
[399.012488] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.741s)
[399.023753] Starting dynamic subtest: pipe-B-eDP-1
[400.794445] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.780s)
[400.805522] Starting dynamic subtest: pipe-C-eDP-1
[402.618802] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.823s)
[402.630119] Starting dynamic subtest: pipe-D-eDP-1
[404.445200] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.825s)
[404.447546] Subtest random-ccs-data-4-tiled-mtl-rc-ccs: SUCCESS (6.174s)
[405.616875] [063/130] (630s left) kms_frontbuffer_tracking (fbc-modesetfrombusy)
[405.732477] Starting subtest: fbc-modesetfrombusy
[409.562286] Subtest fbc-modesetfrombusy: SUCCESS (3.834s)
[410.763911] [064/130] (625s left) gem_create (busy-create)
[410.831135] Starting subtest: busy-create
[410.833388] Starting dynamic subtest: smem0
[443.970025] Dynamic subtest smem0: SUCCESS (33.140s)
[443.972988] Subtest busy-create: SUCCESS (33.142s)
[444.179745] [065/130] (592s left) kms_psr (fbc-pr-sprite-render)
[444.285161] Starting subtest: fbc-pr-sprite-render
[444.289598] Subtest fbc-pr-sprite-render: SKIP (0.000s)
[444.384157] [066/130] (592s left) kms_frontbuffer_tracking (psr-2p-primscrn-indfb-pgflip-blt)
[444.491061] Starting subtest: psr-2p-primscrn-indfb-pgflip-blt
[444.495357] Subtest psr-2p-primscrn-indfb-pgflip-blt: SKIP (0.000s)
[444.619310] [067/130] (591s left) gem_ctx_persistence (engines-queued)
[444.704560] Starting subtest: engines-queued
[444.706456] Starting dynamic subtest: rcs0
[444.840209] Dynamic subtest rcs0: SUCCESS (0.138s)
[444.852460] Starting dynamic subtest: bcs0
[444.874797] Dynamic subtest bcs0: SUCCESS (0.033s)
[444.884646] Starting dynamic subtest: vcs0
[446.859376] Dynamic subtest vcs0: SUCCESS (1.981s)
[446.872452] Starting dynamic subtest: vcs1
[448.905598] Dynamic subtest vcs1: SUCCESS (2.044s)
[448.919369] Starting dynamic subtest: vecs0
[450.891772] Dynamic subtest vecs0: SUCCESS (1.983s)
[450.905127] Starting dynamic subtest: ccs0
[451.119958] Dynamic subtest ccs0: SUCCESS (0.227s)
[451.122389] Subtest engines-queued: SUCCESS (6.419s)
[451.223700] [068/130] (585s left) gem_sync (basic-each)
[451.304999] Starting subtest: basic-each
[453.767482] Subtest basic-each: SUCCESS (2.473s)
[453.985984] [069/130] (582s left) gem_render_copy (x-tiled)
[454.051384] Starting subtest: x-tiled
[454.053798] Starting dynamic subtest: smem
[454.101387] Dynamic subtest smem: SUCCESS (0.049s)
[454.104311] Subtest x-tiled: SUCCESS (0.050s)
[454.373017] [070/130] (582s left) gem_render_copy (yf-tiled-ccs-to-x-tiled)
[454.445380] Starting subtest: yf-tiled-ccs-to-x-tiled
[454.450008] Subtest yf-tiled-ccs-to-x-tiled: SKIP (0.000s)
[454.658627] [071/130] (582s left) kms_flip (basic-flip-vs-wf_vblank)
[454.762436] Starting subtest: basic-flip-vs-wf_vblank
[454.764604] Starting dynamic subtest: A-eDP1
[456.663968] Dynamic subtest A-eDP1: SUCCESS (1.903s)
[456.674935] Starting dynamic subtest: B-eDP1
[458.588152] Dynamic subtest B-eDP1: SUCCESS (1.922s)
[458.600852] Starting dynamic subtest: C-eDP1
[460.516507] Dynamic subtest C-eDP1: SUCCESS (1.926s)
[460.528786] Starting dynamic subtest: D-eDP1
[462.459804] Dynamic subtest D-eDP1: SUCCESS (1.941s)
[462.462117] Subtest basic-flip-vs-wf_vblank: SUCCESS (7.702s)
[463.715567] [072/130] (572s left) gem_exec_reloc (basic-gtt-wc-active)
[463.789310] Subtest basic-gtt-wc-active: SKIP (0.000s)
[463.892572] [073/130] (572s left) kms_async_flips (async-flip-with-page-flip-events-tiled)
[463.988402] Starting subtest: async-flip-with-page-flip-events-tiled
[464.371857] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs
[465.769706] Dynamic subtest pipe-A-eDP-1-4-rc-ccs: FAIL (0.828s)
[465.781957] Starting dynamic subtest: pipe-A-eDP-1-4
[466.131183] Dynamic subtest pipe-A-eDP-1-4: FAIL (0.639s)
[466.142758] Starting dynamic subtest: pipe-A-eDP-1-4
[466.257525] Dynamic subtest pipe-A-eDP-1-4: FAIL (0.016s)
[466.268718] Starting dynamic subtest: pipe-A-eDP-1-x
[466.559627] Dynamic subtest pipe-A-eDP-1-x: FAIL (0.168s)
[466.568516] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs
[467.807632] Dynamic subtest pipe-B-eDP-1-4-rc-ccs: FAIL (1.195s)
[467.820618] Starting dynamic subtest: pipe-B-eDP-1-4
[468.177049] Dynamic subtest pipe-B-eDP-1-4: FAIL (0.176s)
[468.189066] Starting dynamic subtest: pipe-B-eDP-1-4
[468.300924] Dynamic subtest pipe-B-eDP-1-4: FAIL (0.008s)
[468.312059] Starting dynamic subtest: pipe-B-eDP-1-x
[468.600565] Dynamic subtest pipe-B-eDP-1-x: FAIL (0.612s)
[468.770813] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs
[471.537918] Dynamic subtest pipe-C-eDP-1-4-rc-ccs: SUCCESS (2.773s)
[471.548484] Starting dynamic subtest: pipe-C-eDP-1-4
[473.701539] Dynamic subtest pipe-C-eDP-1-4: SUCCESS (2.162s)
[473.711542] Starting dynamic subtest: pipe-C-eDP-1-4
[475.711406] Dynamic subtest pipe-C-eDP-1-4: SUCCESS (2.009s)
[475.721968] Starting dynamic subtest: pipe-C-eDP-1-x
[477.880182] Dynamic subtest pipe-C-eDP-1-x: SUCCESS (2.166s)
[478.248334] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs
[480.972230] Dynamic subtest pipe-D-eDP-1-4-rc-ccs: SUCCESS (2.737s)
[480.987483] Starting dynamic subtest: pipe-D-eDP-1-4
[483.147323] Dynamic subtest pipe-D-eDP-1-4: SUCCESS (2.174s)
[483.163493] Starting dynamic subtest: pipe-D-eDP-1-4
[485.158105] Dynamic subtest pipe-D-eDP-1-4: SUCCESS (2.009s)
[485.171308] Starting dynamic subtest: pipe-D-eDP-1-x
[487.335973] Dynamic subtest pipe-D-eDP-1-x: SUCCESS (2.177s)
[487.338247] Subtest async-flip-with-page-flip-events-tiled: FAIL (23.349s)
[488.582537] [074/130] (548s left) gem_softpin (allocator-basic-reserve)
[488.636384] Starting subtest: allocator-basic-reserve
[488.700150] Subtest allocator-basic-reserve: SUCCESS (0.063s)
[488.858568] [075/130] (547s left) perf_pmu (pmu-read)
[488.896049] Starting subtest: pmu-read
[488.898431] Subtest pmu-read: SUCCESS (0.003s)
[489.028621] [076/130] (547s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-mmap-gtt)
[489.126921] Starting subtest: psr-1p-primscrn-pri-indfb-draw-mmap-gtt
[489.131307] Subtest psr-1p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[489.262518] [077/130] (547s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-render)
[489.365115] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-render
[489.369357] Subtest fbc-2p-primscrn-cur-indfb-draw-render: SKIP (0.000s)
[489.496717] [078/130] (547s left) syncobj_timeline (single-wait-for-submit-available-submitted)
[489.554515] Starting subtest: single-wait-for-submit-available-submitted
[489.556425] Subtest single-wait-for-submit-available-submitted: SUCCESS (0.000s)
[489.677933] [079/130] (547s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-render)
[489.770588] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-render
[489.774096] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-render: SKIP (0.000s)
[489.907922] [080/130] (547s left) gem_render_copy (yf-tiled-to-vebox-linear)
[489.961389] Starting subtest: yf-tiled-to-vebox-linear
[489.965116] Subtest yf-tiled-to-vebox-linear: SKIP (0.000s)
[490.168993] [081/130] (546s left) gem_exec_fence (syncobj-stationary-timeline-chain-engines)
[490.727330] Starting subtest: syncobj-stationary-timeline-chain-engines
[490.850970] Subtest syncobj-stationary-timeline-chain-engines: SUCCESS (0.125s)
[492.038627] [082/130] (545s left) kms_psr (fbc-pr-primary-mmap-gtt)
[492.126632] Starting subtest: fbc-pr-primary-mmap-gtt
[492.131057] Subtest fbc-pr-primary-mmap-gtt: SKIP (0.000s)
[492.220130] [083/130] (544s left) gem_mmap_wc (copy)
[492.272826] Subtest copy: SKIP (0.000s)
[492.333438] [084/130] (544s left) kms_plane_scaling (plane-upscale-factor-0-25-with-rotation)
[492.421314] Starting subtest: plane-upscale-factor-0-25-with-rotation
[492.423643] Starting dynamic subtest: pipe-A
[492.646522] Dynamic subtest pipe-A: SUCCESS (0.227s)
[492.656602] Starting dynamic subtest: pipe-B
[493.949702] Dynamic subtest pipe-B: SUCCESS (1.302s)
[493.959742] Starting dynamic subtest: pipe-C
[495.273581] Dynamic subtest pipe-C: SUCCESS (1.323s)
[495.284424] Starting dynamic subtest: pipe-D
[496.598373] Dynamic subtest pipe-D: SUCCESS (1.324s)
[496.600580] Subtest plane-upscale-factor-0-25-with-rotation: SUCCESS (4.180s)
[497.799789] [085/130] (539s left) gem_exec_schedule (preemptive-hang)
[497.968622] Starting subtest: preemptive-hang
[497.971395] Starting dynamic subtest: rcs0
[507.096042] Dynamic subtest rcs0: SUCCESS (9.128s)
[507.106477] Starting dynamic subtest: bcs0
[516.119397] Dynamic subtest bcs0: SUCCESS (9.021s)
[516.129928] Starting dynamic subtest: vcs0
[525.012371] Dynamic subtest vcs0: SUCCESS (8.891s)
[525.024055] Starting dynamic subtest: vcs1
[534.099665] Dynamic subtest vcs1: SUCCESS (9.087s)
[534.111373] Starting dynamic subtest: vecs0
[543.120396] Dynamic subtest vecs0: SUCCESS (9.016s)
[543.131958] Starting dynamic subtest: ccs0
[552.090748] Dynamic subtest ccs0: SUCCESS (8.970s)
[552.093183] Subtest preemptive-hang: SUCCESS (54.122s)
[552.402027] [086/130] (484s left) kms_ccs (crc-primary-rotation-180-yf-tiled-ccs)
[552.508972] Starting subtest: crc-primary-rotation-180-yf-tiled-ccs
[552.511542] Starting dynamic subtest: pipe-A-eDP-1
[552.535128] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[552.551653] Starting dynamic subtest: pipe-B-eDP-1
[552.573261] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[552.582845] Starting dynamic subtest: pipe-C-eDP-1
[552.604475] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[552.613830] Starting dynamic subtest: pipe-D-eDP-1
[552.635711] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[552.640093] Subtest crc-primary-rotation-180-yf-tiled-ccs: SKIP (0.006s)
[554.763013] [087/130] (482s left) gem_exec_suspend (basic-s3)
[554.826821] Starting subtest: basic-S3
[554.829138] Starting dynamic subtest: smem
[575.549191] Dynamic subtest smem: SUCCESS (7.071s)
[575.551819] Subtest basic-S3: SUCCESS (7.073s)
[584.791209] [088/130] (461s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-render)
[584.901612] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-render
[584.905551] Subtest fbc-2p-primscrn-pri-indfb-draw-render: SKIP (0.000s)
[585.043658] [089/130] (461s left) gem_huc_copy (huc-copy)
[585.097880] Starting subtest: huc-copy
[585.103165] Subtest huc-copy: SUCCESS (0.004s)
[585.250075] [090/130] (461s left) kms_flip (flip-vs-expired-vblank)
[585.341125] Starting subtest: flip-vs-expired-vblank
[585.343082] Starting dynamic subtest: A-eDP1
[594.013197] Dynamic subtest A-eDP1: SUCCESS (8.666s)
[594.027261] Starting dynamic subtest: B-eDP1
[602.667557] Dynamic subtest B-eDP1: SUCCESS (8.648s)
[602.682281] Starting dynamic subtest: C-eDP1
[611.293838] Dynamic subtest C-eDP1: SUCCESS (8.619s)
[611.304111] Starting dynamic subtest: D-eDP1
[619.923005] Dynamic subtest D-eDP1: SUCCESS (8.628s)
[619.928194] Subtest flip-vs-expired-vblank: SUCCESS (34.575s)
[621.125750] [091/130] (425s left) i915_pm_rc6_residency (rc6-fence)
[621.189146] Starting subtest: rc6-fence
[621.204251] Starting dynamic subtest: gt0
[633.523431] Dynamic subtest gt0: SUCCESS (12.319s)
[633.536168] Starting dynamic subtest: gt1
[648.572930] Dynamic subtest gt1: SUCCESS (15.045s)
[648.576071] Subtest rc6-fence: SUCCESS (27.384s)
[648.677080] [092/130] (397s left) kms_plane (plane-position-hole)
[648.771409] Starting subtest: plane-position-hole
[649.284405] Starting dynamic subtest: pipe-A-plane-1
[650.584335] Dynamic subtest pipe-A-plane-1: SUCCESS (1.299s)
[650.595251] Starting dynamic subtest: pipe-A-plane-2
[651.901771] Dynamic subtest pipe-A-plane-2: SUCCESS (1.319s)
[651.913266] Starting dynamic subtest: pipe-A-plane-3
[653.149982] Dynamic subtest pipe-A-plane-3: SUCCESS (1.245s)
[653.160732] Starting dynamic subtest: pipe-A-plane-4
[654.484194] Dynamic subtest pipe-A-plane-4: SUCCESS (1.335s)
[654.495724] Starting dynamic subtest: pipe-A-plane-5
[654.511889] Dynamic subtest pipe-A-plane-5: SUCCESS (0.025s)
[655.667843] Starting dynamic subtest: pipe-B-plane-1
[656.980296] Dynamic subtest pipe-B-plane-1: SUCCESS (1.323s)
[656.992049] Starting dynamic subtest: pipe-B-plane-2
[658.293855] Dynamic subtest pipe-B-plane-2: SUCCESS (1.312s)
[658.310660] Starting dynamic subtest: pipe-B-plane-3
[659.561733] Dynamic subtest pipe-B-plane-3: SUCCESS (1.265s)
[659.571930] Starting dynamic subtest: pipe-B-plane-4
[660.911914] Dynamic subtest pipe-B-plane-4: SUCCESS (1.349s)
[660.922745] Starting dynamic subtest: pipe-B-plane-5
[660.937410] Dynamic subtest pipe-B-plane-5: SUCCESS (0.024s)
[660.939712] Subtest plane-position-hole: SUCCESS (12.165s)
[661.796989] [093/130] (384s left) kms_ccs (random-ccs-data-yf-tiled-ccs)
[661.912657] Starting subtest: random-ccs-data-yf-tiled-ccs
[661.915042] Starting dynamic subtest: pipe-A-eDP-1
[661.940643] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[661.951018] Starting dynamic subtest: pipe-B-eDP-1
[661.974291] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[661.983885] Starting dynamic subtest: pipe-C-eDP-1
[662.007679] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[662.017651] Starting dynamic subtest: pipe-D-eDP-1
[662.041822] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[662.045939] Subtest random-ccs-data-yf-tiled-ccs: SKIP (0.005s)
[664.197927] [094/130] (382s left) i915_hangman (engine-engine-error)
[664.271054] Starting subtest: engine-engine-error
[664.273374] Starting dynamic subtest: rcs0
[665.565014] Dynamic subtest rcs0: SUCCESS (1.292s)
[665.577122] Starting dynamic subtest: bcs0
[667.546769] Dynamic subtest bcs0: SUCCESS (1.978s)
[667.558843] Starting dynamic subtest: vcs0
[669.531551] Dynamic subtest vcs0: SUCCESS (1.982s)
[669.544484] Starting dynamic subtest: vcs1
[671.514542] Dynamic subtest vcs1: SUCCESS (1.980s)
[671.527857] Starting dynamic subtest: vecs0
[673.563278] Dynamic subtest vecs0: SUCCESS (2.046s)
[673.576521] Starting dynamic subtest: ccs0
[675.546982] Dynamic subtest ccs0: SUCCESS (1.980s)
[675.549796] Subtest engine-engine-error: SUCCESS (11.274s)
[675.655046] [095/130] (371s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-shrfb-msflip-blt)
[675.754556] Starting subtest: fbcpsr-1p-primscrn-shrfb-msflip-blt
[683.246731] Subtest fbcpsr-1p-primscrn-shrfb-msflip-blt: SUCCESS (7.494s)
[683.444909] [096/130] (363s left) gem_pwrite (basic-exhaustion)
[683.498656] Subtest basic-exhaustion: SKIP (0.000s)
[683.570081] [097/130] (363s left) syncobj_timeline (etime-single-wait-available-unsubmitted)
[683.624899] Starting subtest: etime-single-wait-available-unsubmitted
[683.729429] Subtest etime-single-wait-available-unsubmitted: SUCCESS (0.104s)
[683.830528] [098/130] (363s left) kms_prime (basic-crc-vgem)
[683.914511] Starting subtest: basic-crc-vgem
[683.916950] Starting dynamic subtest: second-to-first
[684.890449] Dynamic subtest second-to-first: SUCCESS (0.980s)
[684.892393] Subtest basic-crc-vgem: SUCCESS (0.981s)
[684.999544] [099/130] (361s left) kms_flip_scaled_crc (flip-32bpp-ytileccs-to-64bpp-ytile-upscaling)
[685.142649] Starting subtest: flip-32bpp-ytileccs-to-64bpp-ytile-upscaling
[685.144378] Starting dynamic subtest: pipe-A-default-mode
[685.438610] Dynamic subtest pipe-A-default-mode: SKIP (0.287s)
[685.450540] Subtest flip-32bpp-ytileccs-to-64bpp-ytile-upscaling: SKIP (0.288s)
[686.260709] [100/130] (360s left) gem_exec_balancer (invalid-bonds)
[686.339021] Starting subtest: invalid-bonds
[686.343322] Subtest invalid-bonds: SKIP (0.000s)
[686.674381] [101/130] (360s left) gem_exec_balancer (sliced)
[686.751439] Starting subtest: sliced
[686.756031] Subtest sliced: SKIP (0.000s)
[687.093597] [102/130] (359s left) gem_exec_parallel (basic)
[687.170843] Starting subtest: basic
[687.173327] Starting dynamic subtest: rcs0
[688.636107] Dynamic subtest rcs0: SUCCESS (1.468s)
[688.649182] Starting dynamic subtest: bcs0
[690.150922] Dynamic subtest bcs0: SUCCESS (1.512s)
[690.162291] Starting dynamic subtest: vcs0
[691.562247] Dynamic subtest vcs0: SUCCESS (1.409s)
[691.574697] Starting dynamic subtest: vcs1
[693.564359] Dynamic subtest vcs1: SUCCESS (1.999s)
[693.577294] Starting dynamic subtest: vecs0
[695.548736] Dynamic subtest vecs0: SUCCESS (1.982s)
[695.561459] Starting dynamic subtest: ccs0
[697.069565] Dynamic subtest ccs0: SUCCESS (1.520s)
[697.071846] Subtest basic: SUCCESS (9.904s)
[697.282993] [103/130] (349s left) prime_busy (after)
[697.350532] Starting subtest: after
[697.355783] Starting dynamic subtest: rcs0
[697.407443] Dynamic subtest rcs0: SUCCESS (0.051s)
[697.418552] Starting dynamic subtest: bcs0
[697.449951] Dynamic subtest bcs0: SUCCESS (0.042s)
[697.459671] Starting dynamic subtest: vcs0
[697.491548] Dynamic subtest vcs0: SUCCESS (0.041s)
[697.501159] Starting dynamic subtest: vcs1
[697.534585] Dynamic subtest vcs1: SUCCESS (0.042s)
[697.544665] Starting dynamic subtest: vecs0
[697.575985] Dynamic subtest vecs0: SUCCESS (0.041s)
[697.585577] Starting dynamic subtest: ccs0
[697.619530] Dynamic subtest ccs0: SUCCESS (0.043s)
[697.727419] Subtest after: SUCCESS (0.376s)
[697.830528] [104/130] (349s left) kms_big_fb (y-tiled-64bpp-rotate-0)
[697.931928] Starting subtest: y-tiled-64bpp-rotate-0
[697.936450] Subtest y-tiled-64bpp-rotate-0: SKIP (0.000s)
[698.053870] [105/130] (349s left) kms_frontbuffer_tracking (psr-2p-scndscrn-indfb-msflip-blt)
[698.154603] Starting subtest: psr-2p-scndscrn-indfb-msflip-blt
[698.158546] Subtest psr-2p-scndscrn-indfb-msflip-blt: SKIP (0.000s)
[698.272722] [106/130] (348s left) gem_mmap_wc (read-write-distinct)
[698.322802] Subtest read-write-distinct: SKIP (0.000s)
[698.393258] [107/130] (348s left) gem_ctx_sseu (engines)
[698.465001] Subtest engines: SKIP (0.000s)
[698.556035] [108/130] (348s left) syncobj_timeline (etime-multi-wait-all-for-submit-unsubmitted-submitted-signa
[698.622894] Starting subtest: etime-multi-wait-all-for-submit-unsubmitted-submitted-signaled
[698.729444] Subtest etime-multi-wait-all-for-submit-unsubmitted-submitted-signaled: SUCCESS (0.105s)
[698.831257] [109/130] (348s left) kms_cursor_legacy (basic-flip-before-cursor-atomic)
[698.941851] Starting subtest: basic-flip-before-cursor-atomic
[699.854584] Subtest basic-flip-before-cursor-atomic: SUCCESS (0.911s)
[700.687101] [110/130] (346s left) syncobj_wait (single-wait-all-signaled)
[700.741030] Starting subtest: single-wait-all-signaled
[700.743245] Subtest single-wait-all-signaled: SUCCESS (0.000s)
[700.854076] [111/130] (346s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip)
[700.965294] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip
[701.589519] Subtest 4-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip: SUCCESS (0.626s)
[701.783140] [112/130] (345s left) perf (gen12-unprivileged-single-ctx-counters)
[701.943039] Starting subtest: gen12-unprivileged-single-ctx-counters
[701.945111] Starting dynamic subtest: rcs0
[702.021755] Dynamic subtest rcs0: SUCCESS (0.079s)
[702.024048] Subtest gen12-unprivileged-single-ctx-counters: SUCCESS (0.081s)
[702.074554] [113/130] (345s left) kms_psr (psr-cursor-blt)
[702.213239] Starting subtest: psr-cursor-blt
[702.215518] Starting dynamic subtest: eDP-1
[703.967768] Dynamic subtest eDP-1: SUCCESS (1.755s)
[703.969894] Subtest psr-cursor-blt: SUCCESS (1.756s)
[704.866604] [114/130] (342s left) gem_ccs (ctrl-surf-copy)
[704.928345] Starting subtest: ctrl-surf-copy
[704.932991] Subtest ctrl-surf-copy: SKIP (0.000s)
[705.075635] [115/130] (342s left) kms_flip (2x-absolute-wf_vblank)
[705.174514] Starting subtest: 2x-absolute-wf_vblank
[705.183453] Subtest 2x-absolute-wf_vblank: SKIP (0.011s)
[705.328522] [116/130] (342s left) kms_pm_dc (dc3co-vpb-simulation)
[706.434526] Starting subtest: dc3co-vpb-simulation
[715.388151] Subtest dc3co-vpb-simulation: SKIP (8.950s)
[715.555876] [117/130] (332s left) i915_query (test-query-geometry-subslices)
[715.611944] Starting subtest: test-query-geometry-subslices
[715.613834] Subtest test-query-geometry-subslices: SUCCESS (0.000s)
[715.755953] [118/130] (331s left) kms_psr (fbc-psr-sprite-render)
[715.858822] Starting subtest: fbc-psr-sprite-render
[715.860721] Starting dynamic subtest: eDP-1
[715.864750] Dynamic subtest eDP-1: SKIP (0.000s)
[715.868742] Subtest fbc-psr-sprite-render: SKIP (0.001s)
[715.957621] [119/130] (331s left) gem_userptr_blits (sync-overlap)
[716.019676] Starting subtest: sync-overlap
[716.021551] Subtest sync-overlap: SUCCESS (0.000s)
[716.182376] [120/130] (331s left) prime_vgem (fence-read-hang)
[716.278637] Subtest fence-read-hang: SKIP (0.000s)
[716.407703] [121/130] (331s left) syncobj_timeline (invalid-single-wait-all-unsubmitted)
[716.477511] Starting subtest: invalid-single-wait-all-unsubmitted
[716.479533] Subtest invalid-single-wait-all-unsubmitted: SUCCESS (0.000s)
[716.613866] [122/130] (331s left) kms_big_fb (yf-tiled-64bpp-rotate-270)
[716.730683] Starting subtest: yf-tiled-64bpp-rotate-270
[716.734280] Subtest yf-tiled-64bpp-rotate-270: SKIP (0.000s)
[716.867850] [123/130] (331s left) core_setmaster (master-drop-set-shared-fd)
[716.956946] Starting subtest: master-drop-set-shared-fd
[716.978460] Subtest master-drop-set-shared-fd: SUCCESS (0.022s)
[717.018007] [124/130] (330s left) gem_ctx_create (basic-files)
[717.084887] Starting subtest: basic-files
[719.091787] Subtest basic-files: SUCCESS (2.009s)
[720.643254] [125/130] (327s left) kms_pipe_b_c_ivb (pipe-b-double-modeset-then-modeset-pipe-c)
[720.709318] Subtest pipe-B-double-modeset-then-modeset-pipe-C: SKIP (0.000s)
[720.789616] [126/130] (327s left) kms_color (ctm-blue-to-red)
[720.887562] Starting subtest: ctm-blue-to-red
[720.889370] Starting dynamic subtest: pipe-A-eDP-1
[721.590172] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.702s)
[721.601219] Starting dynamic subtest: pipe-B-eDP-1
[722.972226] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.381s)
[722.982519] Starting dynamic subtest: pipe-C-eDP-1
[724.364885] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.391s)
[724.375018] Starting dynamic subtest: pipe-D-eDP-1
[725.700282] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.336s)
[725.702601] Subtest ctm-blue-to-red: SUCCESS (4.814s)
[726.525024] [127/130] (321s left) gem_eio (in-flight-external)
[726.763301] Starting subtest: in-flight-external
[728.647844] Subtest in-flight-external: SUCCESS (1.885s)
[728.787517] [128/130] (319s left) kms_frontbuffer_tracking (fbc-2p-rte)
[728.891131] Starting subtest: fbc-2p-rte
[728.895073] Subtest fbc-2p-rte: SKIP (0.000s)
[729.031678] [129/130] (319s left) syncobj_wait (wait-all-for-submit-complex)
[729.085146] Starting subtest: wait-all-for-submit-complex
[729.298910] Subtest wait-all-for-submit-complex: SUCCESS (0.213s)
[729.395627] [130/130] (318s left) kms_properties (colorop-properties-atomic)
[729.491572] Starting subtest: colorop-properties-atomic
[729.493440] Starting dynamic subtest: pipe-A-eDP-1
[729.870496] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.377s)
[729.881526] Starting dynamic subtest: pipe-B-eDP-1
[730.976306] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.107s)
[730.987994] Starting dynamic subtest: pipe-C-eDP-1
[732.008093] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.030s)
[732.019863] Starting dynamic subtest: pipe-D-eDP-1
[733.035734] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.025s)
[733.038113] Subtest colorop-properties-atomic: SUCCESS (3.546s)
[733.861817] Closing watchdogs
results: parsing output: 0/ for test: kms_ccs
results: parsing output: 1/ for test: gem_fence_thrash
results: parsing output: 2/ for test: kms_frontbuffer_tracking
results: parsing output: 3/ for test: gem_exec_parallel
results: parsing output: 4/ for test: gem_wait
results: parsing output: 5/ for test: gem_tiled_wb
results: parsing output: 6/ for test: kms_frontbuffer_tracking
results: parsing output: 7/ for test: kms_big_fb
results: parsing output: 8/ for test: i915_drm_fdinfo
results: parsing output: 9/ for test: gem_exec_reloc
results: parsing output: 10/ for test: gem_mmap_offset
results: parsing output: 11/ for test: kms_dp_aux_dev
results: parsing output: 12/ for test: gem_exec_params
results: parsing output: 13/ for test: vgem_basic
results: parsing output: 14/ for test: kms_getfb
results: parsing output: 15/ for test: kms_cursor_crc
results: parsing output: 16/ for test: kms_cursor_legacy
results: parsing output: 17/ for test: kms_frontbuffer_tracking
results: parsing output: 18/ for test: kms_big_fb
results: parsing output: 19/ for test: kms_dp_linktrain_fallback
results: parsing output: 20/ for test: core_debugfs
results: parsing output: 21/ for test: gem_ctx_param
results: parsing output: 22/ for test: vgem_basic
results: parsing output: 23/ for test: kms_psr
results: parsing output: 24/ for test: kms_getfb
results: parsing output: 25/ for test: kms_flip_scaled_crc
results: parsing output: 26/ for test: gem_exec_flush
results: parsing output: 27/ for test: kms_frontbuffer_tracking
results: parsing output: 28/ for test: kms_plane_multiple
results: parsing output: 29/ for test: kms_ccs
results: parsing output: 30/ for test: gem_eio
results: parsing output: 31/ for test: gen7_exec_parse
results: parsing output: 32/ for test: gem_mmap_gtt
results: parsing output: 33/ for test: kms_chamelium_frames
results: parsing output: 34/ for test: kms_frontbuffer_tracking
results: parsing output: 35/ for test: gem_exec_schedule
results: parsing output: 36/ for test: kms_psr2_sf
results: parsing output: 37/ for test: gem_exec_schedule
results: parsing output: 38/ for test: kms_color
results: parsing output: 39/ for test: kms_big_fb
results: parsing output: 40/ for test: gem_eio
results: parsing output: 41/ for test: gem_ppgtt
results: parsing output: 42/ for test: kms_cursor_crc
results: parsing output: 43/ for test: kms_atomic_transition
results: parsing output: 44/ for test: kms_plane_alpha_blend
results: parsing output: 45/ for test: kms_frontbuffer_tracking
results: parsing output: 46/ for test: syncobj_wait
results: parsing output: 47/ for test: kms_frontbuffer_tracking
results: parsing output: 48/ for test: kms_ccs
results: parsing output: 49/ for test: gem_exec_whisper
results: parsing output: 50/ for test: gem_wait
results: parsing output: 51/ for test: kms_psr
results: parsing output: 52/ for test: kms_joiner
results: parsing output: 53/ for test: kms_vblank
results: parsing output: 54/ for test: syncobj_timeline
results: parsing output: 55/ for test: kms_cursor_crc
results: parsing output: 56/ for test: gem_lmem_swapping
results: parsing output: 57/ for test: kms_universal_plane
results: parsing output: 58/ for test: kms_getfb
results: parsing output: 59/ for test: kms_lease
results: parsing output: 60/ for test: kms_flip
results: parsing output: 61/ for test: kms_ccs
results: parsing output: 62/ for test: kms_frontbuffer_tracking
results: parsing output: 63/ for test: gem_create
results: parsing output: 64/ for test: kms_psr
results: parsing output: 65/ for test: kms_frontbuffer_tracking
results: parsing output: 66/ for test: gem_ctx_persistence
results: parsing output: 67/ for test: gem_sync
results: parsing output: 68/ for test: gem_render_copy
results: parsing output: 69/ for test: gem_render_copy
results: parsing output: 70/ for test: kms_flip
results: parsing output: 71/ for test: gem_exec_reloc
results: parsing output: 72/ for test: kms_async_flips
results: parsing output: 73/ for test: gem_softpin
results: parsing output: 74/ for test: perf_pmu
results: parsing output: 75/ for test: kms_frontbuffer_tracking
results: parsing output: 76/ for test: kms_frontbuffer_tracking
results: parsing output: 77/ for test: syncobj_timeline
results: parsing output: 78/ for test: kms_frontbuffer_tracking
results: parsing output: 79/ for test: gem_render_copy
results: parsing output: 80/ for test: gem_exec_fence
results: parsing output: 81/ for test: kms_psr
results: parsing output: 82/ for test: gem_mmap_wc
results: parsing output: 83/ for test: kms_plane_scaling
results: parsing output: 84/ for test: gem_exec_schedule
results: parsing output: 85/ for test: kms_ccs
results: parsing output: 86/ for test: gem_exec_suspend
results: parsing output: 87/ for test: kms_frontbuffer_tracking
results: parsing output: 88/ for test: gem_huc_copy
results: parsing output: 89/ for test: kms_flip
results: parsing output: 90/ for test: i915_pm_rc6_residency
results: parsing output: 91/ for test: kms_plane
results: parsing output: 92/ for test: kms_ccs
results: parsing output: 93/ for test: i915_hangman
results: parsing output: 94/ for test: kms_frontbuffer_tracking
results: parsing output: 95/ for test: gem_pwrite
results: parsing output: 96/ for test: syncobj_timeline
results: parsing output: 97/ for test: kms_prime
results: parsing output: 98/ for test: kms_flip_scaled_crc
results: parsing output: 99/ for test: gem_exec_balancer
results: parsing output: 100/ for test: gem_exec_balancer
results: parsing output: 101/ for test: gem_exec_parallel
results: parsing output: 102/ for test: prime_busy
results: parsing output: 103/ for test: kms_big_fb
results: parsing output: 104/ for test: kms_frontbuffer_tracking
results: parsing output: 105/ for test: gem_mmap_wc
results: parsing output: 106/ for test: gem_ctx_sseu
results: parsing output: 107/ for test: syncobj_timeline
results: parsing output: 108/ for test: kms_cursor_legacy
results: parsing output: 109/ for test: syncobj_wait
results: parsing output: 110/ for test: kms_big_fb
results: parsing output: 111/ for test: perf
results: parsing output: 112/ for test: kms_psr
results: parsing output: 113/ for test: gem_ccs
results: parsing output: 114/ for test: kms_flip
results: parsing output: 115/ for test: kms_pm_dc
results: parsing output: 116/ for test: i915_query
results: parsing output: 117/ for test: kms_psr
results: parsing output: 118/ for test: gem_userptr_blits
results: parsing output: 119/ for test: prime_vgem
results: parsing output: 120/ for test: syncobj_timeline
results: parsing output: 121/ for test: kms_big_fb
results: parsing output: 122/ for test: core_setmaster
results: parsing output: 123/ for test: gem_ctx_create
results: parsing output: 124/ for test: kms_pipe_b_c_ivb
results: parsing output: 125/ for test: kms_color
results: parsing output: 126/ for test: gem_eio
results: parsing output: 127/ for test: kms_frontbuffer_tracking
results: parsing output: 128/ for test: syncobj_wait
results: parsing output: 129/ for test: kms_properties
Done.