[55.712716] Initializing watchdogs
[55.712830]   /dev/watchdog0
[55.727764] [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]
[55.731958] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[55.734058] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[55.737172] [001/130] (960s left) gem_exec_params (invalid-ring)
[55.826889] Starting subtest: invalid-ring
[55.828877] Subtest invalid-ring: SUCCESS (0.000s)
[55.944703] [002/130] (960s left) kms_frontbuffer_tracking (fbcpsr-1p-offscren-pri-shrfb-draw-mmap-cpu)
[56.044276] Starting subtest: fbcpsr-1p-offscren-pri-shrfb-draw-mmap-cpu
[62.551184] Subtest fbcpsr-1p-offscren-pri-shrfb-draw-mmap-cpu: SUCCESS (6.595s)
[62.684223] [003/130] (953s left) gem_spin_batch (legacy)
[62.749532] Starting subtest: legacy
[62.751955] Starting dynamic subtest: default
[65.982668] Dynamic subtest default: SUCCESS (3.249s)
[65.991598] Starting dynamic subtest: render
[69.263332] Dynamic subtest render: SUCCESS (3.242s)
[69.272664] Starting dynamic subtest: bsd
[72.487341] Dynamic subtest bsd: SUCCESS (3.232s)
[72.496382] Starting dynamic subtest: bsd1
[75.716956] Dynamic subtest bsd1: SUCCESS (3.234s)
[75.726287] Starting dynamic subtest: bsd2
[78.950082] Dynamic subtest bsd2: SUCCESS (3.235s)
[78.959486] Starting dynamic subtest: blt
[82.182501] Dynamic subtest blt: SUCCESS (3.235s)
[82.191854] Starting dynamic subtest: vebox
[85.415552] Dynamic subtest vebox: SUCCESS (3.231s)
[85.418063] Subtest legacy: SUCCESS (22.666s)
[85.998916] [004/130] (930s left) perf (gen12-group-exclusive-stream-ctx-handle)
[86.108422] Starting subtest: gen12-group-exclusive-stream-ctx-handle
[86.130067] Subtest gen12-group-exclusive-stream-ctx-handle: SUCCESS (0.022s)
[86.166776] [005/130] (930s left) i915_pm_rps (thresholds-idle)
[87.871697] Starting subtest: thresholds-idle
[87.877048] Subtest thresholds-idle: SKIP (0.001s)
[87.953675] [006/130] (928s left) tools_test (tools_test)
[87.998628] Starting subtest: tools_test
[88.048791] Subtest tools_test: SUCCESS (0.067s)
[88.110806] [007/130] (928s left) gem_mmap_gtt (medium-copy-xy)
[88.166111] Subtest medium-copy-XY: SKIP (0.000s)
[88.218623] [008/130] (928s left) kms_invalid_mode (int-max-clock)
[88.317085] Starting subtest: int-max-clock
[88.319442] Starting dynamic subtest: pipe-A-eDP-1
[88.604411] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.287s)
[88.611268] Starting dynamic subtest: pipe-B-eDP-1
[88.613158] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[88.619597] Starting dynamic subtest: pipe-C-eDP-1
[88.621512] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[88.628451] Starting dynamic subtest: pipe-D-eDP-1
[88.630715] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[88.633055] Subtest int-max-clock: SUCCESS (0.291s)
[89.443341] [009/130] (927s left) kms_big_fb (yf-tiled-64bpp-rotate-0)
[89.549259] Starting subtest: yf-tiled-64bpp-rotate-0
[89.553679] Subtest yf-tiled-64bpp-rotate-0: SKIP (0.000s)
[89.639321] [010/130] (926s left) syncobj_timeline (etime-multi-wait-all-for-submit-available-unsubmitted-submi
[89.683549] Starting subtest: etime-multi-wait-all-for-submit-available-unsubmitted-submitted
[89.792810] Subtest etime-multi-wait-all-for-submit-available-unsubmitted-submitted: SUCCESS (0.109s)
[89.865661] [011/130] (926s left) gem_exec_reloc (basic-range)
[89.921381] Subtest basic-range: SKIP (0.000s)
[89.991317] [012/130] (926s left) gem_userptr_blits (forbidden-operations)
[90.065447] Starting subtest: forbidden-operations
[90.069830] Subtest forbidden-operations: SKIP (0.000s)
[90.195990] [013/130] (926s left) kms_pm_rpm (pm-caching)
[92.043916] Starting subtest: pm-caching
[92.049115] Subtest pm-caching: SKIP (0.000s)
[92.474862] [014/130] (924s left) gem_exec_schedule (u-submit-golden-slice)
[92.555519] Starting subtest: u-submit-golden-slice
[92.557588] Starting dynamic subtest: rcs0
[92.583442] Dynamic subtest rcs0: SUCCESS (0.038s)
[92.590437] Starting dynamic subtest: bcs0
[92.617919] Dynamic subtest bcs0: SUCCESS (0.034s)
[92.625119] Starting dynamic subtest: vcs0
[92.648087] Dynamic subtest vcs0: SUCCESS (0.030s)
[92.658115] Starting dynamic subtest: vcs1
[92.682662] Dynamic subtest vcs1: SUCCESS (0.034s)
[92.690960] Starting dynamic subtest: vecs0
[92.708524] Dynamic subtest vecs0: SUCCESS (0.026s)
[92.716820] Starting dynamic subtest: ccs0
[92.735387] Dynamic subtest ccs0: SUCCESS (0.027s)
[92.737608] Subtest u-submit-golden-slice: SUCCESS (0.190s)
[94.016174] [015/130] (922s left) kms_psr2_sf (fbc-pr-cursor-plane-move-continuous-sf)
[98.970706] Starting subtest: fbc-pr-cursor-plane-move-continuous-sf
[98.975402] Subtest fbc-pr-cursor-plane-move-continuous-sf: SKIP (0.003s)
[99.807645] [016/130] (916s left) gem_exec_params (dr4-dirt)
[99.862164] Starting subtest: DR4-dirt
[99.864523] Subtest DR4-dirt: SUCCESS (0.000s)
[99.973946] [017/130] (916s left) kms_flip (flip-vs-rmfb)
[100.072257] Starting subtest: flip-vs-rmfb
[100.074570] Starting dynamic subtest: A-eDP1
[108.714073] Dynamic subtest A-eDP1: SUCCESS (8.641s)
[108.721556] Starting dynamic subtest: B-eDP1
[117.344944] Dynamic subtest B-eDP1: SUCCESS (8.629s)
[117.352562] Starting dynamic subtest: C-eDP1
[125.964943] Dynamic subtest C-eDP1: SUCCESS (8.619s)
[125.974155] Starting dynamic subtest: D-eDP1
[134.590934] Dynamic subtest D-eDP1: SUCCESS (8.625s)
[134.595039] Subtest flip-vs-rmfb: SUCCESS (34.521s)
[135.780304] [018/130] (881s left) prime_self_import (basic-with_one_bo_two_files)
[135.815397] Starting subtest: basic-with_one_bo_two_files
[135.838170] Subtest basic-with_one_bo_two_files: SUCCESS (0.024s)
[135.945448] [019/130] (880s left) kms_frontbuffer_tracking (fbc-1p-primscrn-indfb-pgflip-blt)
[136.040278] Starting subtest: fbc-1p-primscrn-indfb-pgflip-blt
[140.467870] Subtest fbc-1p-primscrn-indfb-pgflip-blt: SUCCESS (4.432s)
[141.595598] [020/130] (875s left) gem_wait (busy)
[141.661982] Starting subtest: busy
[141.664446] Starting dynamic subtest: all-engines
[142.934763] Dynamic subtest all-engines: SUCCESS (1.271s)
[142.944761] Starting dynamic subtest: rcs0
[143.475085] Dynamic subtest rcs0: SUCCESS (0.540s)
[143.482938] Starting dynamic subtest: bcs0
[144.014725] Dynamic subtest bcs0: SUCCESS (0.538s)
[144.021990] Starting dynamic subtest: vcs0
[145.940559] Dynamic subtest vcs0: SUCCESS (1.923s)
[145.950669] Starting dynamic subtest: vcs1
[147.924634] Dynamic subtest vcs1: SUCCESS (1.981s)
[147.934868] Starting dynamic subtest: vecs0
[149.908422] Dynamic subtest vecs0: SUCCESS (1.982s)
[149.919383] Starting dynamic subtest: ccs0
[150.451121] Dynamic subtest ccs0: SUCCESS (0.542s)
[150.453563] Subtest busy: SUCCESS (8.789s)
[150.645168] [021/130] (866s left) kms_addfb_basic (bad-pitch-128)
[150.709662] Starting subtest: bad-pitch-128
[150.712044] Subtest bad-pitch-128: SUCCESS (0.000s)
[150.869742] [022/130] (866s left) kms_psr (fbc-psr-sprite-plane-onoff)
[150.966807] Starting subtest: fbc-psr-sprite-plane-onoff
[150.968989] Starting dynamic subtest: eDP-1
[150.973013] Dynamic subtest eDP-1: SKIP (0.000s)
[150.976966] Subtest fbc-psr-sprite-plane-onoff: SKIP (0.001s)
[151.037744] [023/130] (866s left) device_reset (unbind-reset-rebind)
[151.082748] Starting subtest: unbind-reset-rebind
[155.719868] Subtest unbind-reset-rebind: SUCCESS (4.632s)
[155.759811] [024/130] (861s left) kms_ccs (crc-sprite-planes-basic-y-tiled-gen12-rc-ccs)
[155.858269] Starting subtest: crc-sprite-planes-basic-y-tiled-gen12-rc-ccs
[155.860487] Starting dynamic subtest: pipe-A-eDP-1
[155.919659] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[155.929076] Starting dynamic subtest: pipe-B-eDP-1
[155.989716] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[155.998944] Starting dynamic subtest: pipe-C-eDP-1
[156.055441] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[156.064920] Starting dynamic subtest: pipe-D-eDP-1
[156.124123] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[156.128621] Subtest crc-sprite-planes-basic-y-tiled-gen12-rc-ccs: SKIP (0.009s)
[158.035103] [025/130] (859s left) syncobj_timeline (invalid-multi-wait-all-unsubmitted-signaled)
[158.085071] Starting subtest: invalid-multi-wait-all-unsubmitted-signaled
[158.087326] Subtest invalid-multi-wait-all-unsubmitted-signaled: SUCCESS (0.000s)
[158.184629] [026/130] (858s left) kms_lease (lease-again)
[158.279118] Starting subtest: lease-again
[158.281449] Starting dynamic subtest: pipe-A-eDP-1
[158.283691] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.003s)
[158.291745] Starting dynamic subtest: pipe-B-eDP-1
[158.293973] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.002s)
[158.301632] Starting dynamic subtest: pipe-C-eDP-1
[158.303552] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.002s)
[158.310617] Starting dynamic subtest: pipe-D-eDP-1
[158.312556] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.002s)
[158.314454] Subtest lease-again: SUCCESS (0.012s)
[158.403125] [027/130] (858s left) gem_ctx_isolation (preservation-s3)
[158.470136] Starting subtest: preservation-S3
[158.472098] Starting dynamic subtest: rcs0
[175.070835] Dynamic subtest rcs0: SUCCESS (1.829s)
[175.080224] Starting dynamic subtest: bcs0
[192.010941] Dynamic subtest bcs0: SUCCESS (1.688s)
[192.020448] Starting dynamic subtest: vcs0
[209.013052] Dynamic subtest vcs0: SUCCESS (3.291s)
[209.022403] Starting dynamic subtest: vcs1
[227.059059] Dynamic subtest vcs1: SUCCESS (5.131s)
[227.068137] Starting dynamic subtest: vecs0
[244.997467] Dynamic subtest vecs0: SUCCESS (4.896s)
[245.008649] Starting dynamic subtest: ccs0
[262.997460] Dynamic subtest ccs0: SUCCESS (3.107s)
[262.999836] Subtest preservation-S3: SUCCESS (19.947s)
[271.294691] [028/130] (754s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-mmap-cpu)
[271.409161] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-mmap-cpu
[274.940545] Subtest fbc-1p-primscrn-cur-indfb-draw-mmap-cpu: SUCCESS (3.635s)
[276.051950] [029/130] (749s left) syncobj_timeline (wait-for-submit-delayed-submit)
[276.105013] Starting subtest: wait-for-submit-delayed-submit
[276.206633] Subtest wait-for-submit-delayed-submit: SUCCESS (0.105s)
[276.281128] [030/130] (749s left) syncobj_wait (multi-wait-for-submit-unsubmitted-submitted)
[276.340614] Starting subtest: multi-wait-for-submit-unsubmitted-submitted
[276.444399] Subtest multi-wait-for-submit-unsubmitted-submitted: SUCCESS (0.104s)
[276.521200] [031/130] (748s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip)
[276.623797] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip
[277.212084] Subtest 4-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip: SUCCESS (0.603s)
[277.369264] [032/130] (748s left) gem_ctx_persistence (legacy-engines-persistence)
[277.432550] Starting subtest: legacy-engines-persistence
[277.434878] Starting dynamic subtest: render
[278.285137] Dynamic subtest render: SUCCESS (0.869s)
[278.297037] Starting dynamic subtest: bsd1
[279.094148] Dynamic subtest bsd1: SUCCESS (0.820s)
[279.106333] Starting dynamic subtest: bsd2
[279.862266] Dynamic subtest bsd2: SUCCESS (0.777s)
[279.873802] Starting dynamic subtest: blt
[280.655463] Dynamic subtest blt: SUCCESS (0.801s)
[280.667678] Starting dynamic subtest: vebox
[281.481412] Dynamic subtest vebox: SUCCESS (0.834s)
[281.484088] Subtest legacy-engines-persistence: SUCCESS (4.113s)
[281.564598] [033/130] (743s left) gem_exec_schedule (preempt-other-chain)
[281.629013] Starting subtest: preempt-other-chain
[281.631081] Starting dynamic subtest: rcs0
[281.770548] Dynamic subtest rcs0: SUCCESS (0.149s)
[281.782676] Starting dynamic subtest: bcs0
[281.912151] Dynamic subtest bcs0: SUCCESS (0.143s)
[281.924757] Starting dynamic subtest: vcs0
[282.042520] Dynamic subtest vcs0: SUCCESS (0.131s)
[282.059995] Starting dynamic subtest: vcs1
[282.171872] Dynamic subtest vcs1: SUCCESS (0.130s)
[282.181589] Starting dynamic subtest: vecs0
[282.305761] Dynamic subtest vecs0: SUCCESS (0.134s)
[282.318183] Starting dynamic subtest: ccs0
[282.433940] Dynamic subtest ccs0: SUCCESS (0.129s)
[282.436829] Subtest preempt-other-chain: SUCCESS (0.820s)
[283.557389] [034/130] (741s left) kms_cursor_edge_walk (256x256-top-edge)
[283.658729] Starting subtest: 256x256-top-edge
[283.661229] Starting dynamic subtest: pipe-A-eDP-1
[287.069312] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.435s)
[287.081652] Starting dynamic subtest: pipe-D-eDP-1
[290.182860] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.125s)
[290.185814] Subtest 256x256-top-edge: SUCCESS (6.564s)
[290.983309] [035/130] (734s left) gem_mmap_gtt (medium-copy)
[291.042481] Subtest medium-copy: SKIP (0.000s)
[291.108169] [036/130] (734s left) api_intel_bb (blit-noreloc-purge-cache)
[291.154860] Starting subtest: blit-noreloc-purge-cache
[291.162870] Subtest blit-noreloc-purge-cache: SUCCESS (0.011s)
[291.292304] [037/130] (734s left) kms_chamelium_color (gamma)
[291.380731] Subtest gamma: SKIP (0.000s)
[291.426688] [038/130] (734s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-mmap-gtt)
[291.530872] Starting subtest: psr-2p-primscrn-cur-indfb-draw-mmap-gtt
[291.535668] Subtest psr-2p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[291.640663] [039/130] (734s left) kms_flip (blocking-absolute-wf_vblank-interruptible)
[291.730465] Starting subtest: blocking-absolute-wf_vblank-interruptible
[291.732767] Starting dynamic subtest: A-eDP1
[300.454760] Dynamic subtest A-eDP1: SUCCESS (8.707s)
[300.466786] Starting dynamic subtest: B-eDP1
[309.180092] Dynamic subtest B-eDP1: SUCCESS (8.726s)
[309.191888] Starting dynamic subtest: C-eDP1
[317.907476] Dynamic subtest C-eDP1: SUCCESS (8.712s)
[317.919134] Starting dynamic subtest: D-eDP1
[326.648834] Dynamic subtest D-eDP1: SUCCESS (8.738s)
[326.651278] Subtest blocking-absolute-wf_vblank-interruptible: SUCCESS (34.893s)
[327.813652] [040/130] (697s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-16bpp-4tile-upscaling)
[327.911684] Starting subtest: flip-64bpp-4tile-to-16bpp-4tile-upscaling
[327.913929] Starting dynamic subtest: pipe-A-default-mode
[330.637093] Dynamic subtest pipe-A-default-mode: SUCCESS (2.722s)
[330.639932] Subtest flip-64bpp-4tile-to-16bpp-4tile-upscaling: SUCCESS (2.724s)
[331.502915] [041/130] (694s left) kms_cursor_crc (cursor-onscreen-128x128)
[331.713665] Starting subtest: cursor-onscreen-128x128
[331.719892] Starting dynamic subtest: pipe-A-eDP-1
[333.837288] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.118s)
[333.865001] Starting dynamic subtest: pipe-D-eDP-1
[336.566362] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.709s)
[336.568907] Subtest cursor-onscreen-128x128: SUCCESS (4.851s)
[337.375568] [042/130] (688s left) kms_cursor_legacy (cursorb-vs-flipb-varying-size)
[337.489758] Starting subtest: cursorB-vs-flipB-varying-size
[337.494352] Subtest cursorB-vs-flipB-varying-size: SKIP (0.001s)
[337.631104] [043/130] (688s left) kms_cursor_legacy (cursorb-vs-flipb-toggle)
[337.744950] Starting subtest: cursorB-vs-flipB-toggle
[337.749579] Subtest cursorB-vs-flipB-toggle: SKIP (0.001s)
[337.884555] [044/130] (688s left) kms_dp_link_training (non-uhbr-mst)
[337.967846] Starting subtest: non-uhbr-mst
[337.978567] Subtest non-uhbr-mst: SKIP (0.000s)
[338.044409] [045/130] (687s left) gem_exec_params (secure-non-master)
[338.090673] Starting subtest: secure-non-master
[338.095885] Subtest secure-non-master: SKIP (0.000s)
[338.201838] [046/130] (687s left) gem_exec_params (rel-constants-invalid-ring)
[338.262822] Starting subtest: rel-constants-invalid-ring
[338.265269] Subtest rel-constants-invalid-ring: SUCCESS (0.000s)
[338.370099] [047/130] (687s left) kms_ccs (random-ccs-data-4-tiled-dg2-mc-ccs)
[338.469888] Starting subtest: random-ccs-data-4-tiled-dg2-mc-ccs
[338.471966] Starting dynamic subtest: pipe-A-eDP-1
[338.495623] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[338.506456] Starting dynamic subtest: pipe-B-eDP-1
[338.528238] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[338.538403] Starting dynamic subtest: pipe-C-eDP-1
[338.560398] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[338.568630] Starting dynamic subtest: pipe-D-eDP-1
[338.591140] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[338.595106] Subtest random-ccs-data-4-tiled-dg2-mc-ccs: SKIP (0.004s)
[340.640778] [048/130] (685s left) fbdev (unaligned-read)
[340.683074] Starting subtest: unaligned-read
[340.697857] Subtest unaligned-read: SUCCESS (0.015s)
[340.755197] [049/130] (685s left) core_auth (many-magics)
[340.816331] Starting subtest: many-magics
[341.589718] Subtest many-magics: SUCCESS (0.775s)
[341.763886] [050/130] (684s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-pwrite)
[341.866922] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-pwrite
[341.871939] Subtest fbc-2p-primscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[341.975555] [051/130] (684s left) i915_hangman (gt-engine-hang)
[342.039483] Starting subtest: gt-engine-hang
[342.041985] Starting dynamic subtest: rcs0
[343.447463] Dynamic subtest rcs0: SUCCESS (1.407s)
[343.460107] Starting dynamic subtest: bcs0
[345.430340] Dynamic subtest bcs0: SUCCESS (1.981s)
[345.442941] Starting dynamic subtest: vcs0
[347.478098] Dynamic subtest vcs0: SUCCESS (2.046s)
[347.490713] Starting dynamic subtest: vcs1
[349.463115] Dynamic subtest vcs1: SUCCESS (1.983s)
[349.475106] Starting dynamic subtest: vecs0
[351.446873] Dynamic subtest vecs0: SUCCESS (1.982s)
[351.459893] Starting dynamic subtest: ccs0
[353.430883] Dynamic subtest ccs0: SUCCESS (1.983s)
[353.433905] Subtest gt-engine-hang: SUCCESS (11.394s)
[353.513756] [052/130] (672s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-cpu)
[353.620940] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-cpu
[353.626881] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[353.715191] [053/130] (672s left) kms_plane_scaling (intel-max-src-size)
[353.808840] Starting subtest: intel-max-src-size
[353.815841] Subtest intel-max-src-size: SKIP (0.000s)
[353.898541] [054/130] (672s left) kms_frontbuffer_tracking (fbc-1p-offscren-pri-shrfb-draw-mmap-wc)
[354.000638] Starting subtest: fbc-1p-offscren-pri-shrfb-draw-mmap-wc
[357.943043] Subtest fbc-1p-offscren-pri-shrfb-draw-mmap-wc: SUCCESS (3.948s)
[359.153803] [055/130] (667s left) perf_pmu (multi-client)
[359.193113] Starting subtest: multi-client
[359.195467] Starting dynamic subtest: rcs0
[360.247967] Dynamic subtest rcs0: SUCCESS (1.055s)
[360.258979] Starting dynamic subtest: bcs0
[361.296428] Dynamic subtest bcs0: SUCCESS (1.046s)
[361.307958] Starting dynamic subtest: vcs0
[362.347471] Dynamic subtest vcs0: SUCCESS (1.049s)
[362.360429] Starting dynamic subtest: vcs1
[363.504342] Dynamic subtest vcs1: SUCCESS (1.154s)
[363.517095] Starting dynamic subtest: vecs0
[365.486370] Dynamic subtest vecs0: SUCCESS (1.981s)
[365.499032] Starting dynamic subtest: ccs0
[367.538110] Dynamic subtest ccs0: SUCCESS (2.050s)
[367.540972] Subtest multi-client: SUCCESS (8.349s)
[367.654557] [056/130] (658s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-shrfb-msflip-blt)
[367.750281] Starting subtest: fbcpsr-2p-primscrn-shrfb-msflip-blt
[367.755104] Subtest fbcpsr-2p-primscrn-shrfb-msflip-blt: SKIP (0.000s)
[367.863370] [057/130] (658s left) kms_async_flips (crc-atomic)
[367.954965] Starting subtest: crc-atomic
[368.329509] Starting dynamic subtest: pipe-A-eDP-1
[371.280210] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.931s)
[371.627702] Starting dynamic subtest: pipe-B-eDP-1
[374.518186] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.869s)
[374.853856] Starting dynamic subtest: pipe-C-eDP-1
[377.743259] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.866s)
[378.084975] Starting dynamic subtest: pipe-D-eDP-1
[380.970268] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.864s)
[380.972980] Subtest crc-atomic: SUCCESS (12.980s)
[382.109782] [058/130] (644s left) gem_close_race (multigpu-basic-process)
[382.180741] Starting subtest: multigpu-basic-process
[382.185867] Subtest multigpu-basic-process: SKIP (0.000s)
[382.427718] [059/130] (644s left) kms_frontbuffer_tracking (fbc-1p-indfb-fliptrack-mmap-gtt)
[382.525667] Starting subtest: fbc-1p-indfb-fliptrack-mmap-gtt
[382.531126] Subtest fbc-1p-indfb-fliptrack-mmap-gtt: SKIP (0.000s)
[382.637390] [060/130] (643s left) kms_cursor_crc (cursor-random-max-size)
[382.924316] Starting subtest: cursor-random-max-size
[382.931517] Subtest cursor-random-max-size: SKIP (0.000s)
[383.036733] [061/130] (643s left) kms_lease (simple-lease)
[383.121377] Starting subtest: simple-lease
[383.123964] Starting dynamic subtest: pipe-A-eDP-1
[383.622260] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.496s)
[383.632273] Starting dynamic subtest: pipe-B-eDP-1
[385.052762] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.427s)
[385.064124] Starting dynamic subtest: pipe-C-eDP-1
[386.430722] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.378s)
[386.441564] Starting dynamic subtest: pipe-D-eDP-1
[387.830259] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.398s)
[387.832649] Subtest simple-lease: SUCCESS (4.707s)
[388.638552] [062/130] (638s left) gem_softpin (overlap)
[388.715090] Starting subtest: overlap
[389.584438] Subtest overlap: SUCCESS (0.868s)
[389.706420] [063/130] (636s left) kms_vrr (flip-basic)
[389.801441] Starting subtest: flip-basic
[389.808816] Subtest flip-basic: SKIP (0.000s)
[389.877171] [064/130] (636s left) kms_plane_scaling (plane-upscale-factor-0-25-with-modifiers)
[389.961751] Starting subtest: plane-upscale-factor-0-25-with-modifiers
[389.964121] Starting dynamic subtest: pipe-A
[390.300038] Dynamic subtest pipe-A: SUCCESS (0.338s)
[390.309761] Starting dynamic subtest: pipe-B
[391.734971] Dynamic subtest pipe-B: SUCCESS (1.433s)
[391.745649] Starting dynamic subtest: pipe-C
[393.167042] Dynamic subtest pipe-C: SUCCESS (1.430s)
[393.177111] Starting dynamic subtest: pipe-D
[394.603249] Dynamic subtest pipe-D: SUCCESS (1.435s)
[394.605758] Subtest plane-upscale-factor-0-25-with-modifiers: SUCCESS (4.642s)
[395.775636] [065/130] (630s left) kms_atomic_transition (plane-all-transition-fencing)
[395.861664] Starting subtest: plane-all-transition-fencing
[395.864043] Starting dynamic subtest: pipe-A-eDP-1
[398.362821] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.500s)
[398.661024] Starting dynamic subtest: pipe-B-eDP-1
[401.914068] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.264s)
[402.198940] Subtest plane-all-transition-fencing: SUCCESS (6.336s)
[403.047022] [066/130] (623s left) kms_big_fb (y-tiled-64bpp-rotate-90)
[403.161419] Starting subtest: y-tiled-64bpp-rotate-90
[403.165759] Subtest y-tiled-64bpp-rotate-90: SKIP (0.000s)
[403.272429] [067/130] (623s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-blt)
[403.388011] Starting subtest: fbcpsr-rgb565-draw-blt
[410.310395] Subtest fbcpsr-rgb565-draw-blt: SUCCESS (6.925s)
[410.453961] [068/130] (616s left) gem_ctx_persistence (engines-mixed-process)
[410.526538] Starting subtest: engines-mixed-process
[410.528780] Starting dynamic subtest: rcs0
[412.496357] Dynamic subtest rcs0: SUCCESS (1.969s)
[412.508276] Starting dynamic subtest: bcs0
[414.482081] Dynamic subtest bcs0: SUCCESS (1.984s)
[414.495186] Starting dynamic subtest: vcs0
[416.532559] Dynamic subtest vcs0: SUCCESS (2.048s)
[416.544930] Starting dynamic subtest: vcs1
[418.503264] Dynamic subtest vcs1: SUCCESS (1.970s)
[418.518573] Starting dynamic subtest: vecs0
[420.481422] Dynamic subtest vecs0: SUCCESS (1.977s)
[420.493143] Starting dynamic subtest: ccs0
[422.441999] Dynamic subtest ccs0: SUCCESS (1.957s)
[422.444952] Subtest engines-mixed-process: SUCCESS (11.914s)
[422.556151] [069/130] (604s left) kms_dsc (dsc-with-output-formats-with-bpc)
[422.654797] Starting subtest: dsc-with-output-formats-with-bpc
[422.720227] Subtest dsc-with-output-formats-with-bpc: SKIP (0.001s)
[422.761234] [070/130] (604s left) gem_softpin (invalid)
[422.809244] Starting subtest: invalid
[422.817222] Subtest invalid: SUCCESS (0.006s)
[422.959444] [071/130] (604s left) gem_lmem_swapping (random-engines)
[422.996778] Subtest random-engines: SKIP (0.000s)
[423.044743] [072/130] (604s left) gem_exec_reloc (basic-cpu-wc-active)
[423.101861] Subtest basic-cpu-wc-active: SKIP (0.000s)
[423.169204] [073/130] (603s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-mmap-cpu)
[423.282911] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-mmap-cpu
[427.537898] Subtest fbc-1p-primscrn-pri-shrfb-draw-mmap-cpu: SUCCESS (4.260s)
[428.662456] [074/130] (598s left) kms_ccs (crc-primary-rotation-180-y-tiled-gen12-rc-ccs)
[428.756375] Starting subtest: crc-primary-rotation-180-y-tiled-gen12-rc-ccs
[428.758985] Starting dynamic subtest: pipe-A-eDP-1
[428.783481] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[428.794507] Starting dynamic subtest: pipe-B-eDP-1
[428.818899] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[428.828780] Starting dynamic subtest: pipe-C-eDP-1
[428.852597] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[428.861905] Starting dynamic subtest: pipe-D-eDP-1
[428.886829] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[428.891630] Subtest crc-primary-rotation-180-y-tiled-gen12-rc-ccs: SKIP (0.005s)
[430.909179] [075/130] (596s left) kms_psr2_sf (psr2-overlay-plane-move-continuous-exceed-sf)
[435.910135] Starting subtest: psr2-overlay-plane-move-continuous-exceed-sf
[435.912770] Starting dynamic subtest: pipe-A-eDP-1
[447.947869] Dynamic subtest pipe-A-eDP-1: SUCCESS (12.039s)
[447.959629] Starting dynamic subtest: pipe-B-eDP-1
[459.975972] Dynamic subtest pipe-B-eDP-1: SUCCESS (12.025s)
[459.978924] Subtest psr2-overlay-plane-move-continuous-exceed-sf: SUCCESS (24.068s)
[460.814485] [076/130] (566s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-pwrite)
[460.923983] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-pwrite
[460.928921] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[461.030184] [077/130] (566s left) kms_frontbuffer_tracking (psr-rgb101010-draw-render)
[461.123594] Starting subtest: psr-rgb101010-draw-render
[468.397720] Subtest psr-rgb101010-draw-render: SUCCESS (7.278s)
[468.519354] [078/130] (558s left) kms_pm_rpm (cursor-dpms)
[470.655908] Starting subtest: cursor-dpms
[470.661994] Subtest cursor-dpms: SKIP (0.000s)
[471.023809] [079/130] (556s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-render)
[471.129497] Starting subtest: psr-1p-primscrn-cur-indfb-draw-render
[477.681432] Subtest psr-1p-primscrn-cur-indfb-draw-render: SUCCESS (6.558s)
[477.804606] [080/130] (549s left) perf (sysctl-defaults)
[477.865332] Starting subtest: sysctl-defaults
[477.867745] Subtest sysctl-defaults: SUCCESS (0.000s)
[477.948414] [081/130] (549s left) kms_psr (fbc-psr2-cursor-plane-move)
[478.035968] Starting subtest: fbc-psr2-cursor-plane-move
[478.038905] Starting dynamic subtest: eDP-1
[478.044104] Dynamic subtest eDP-1: SKIP (0.000s)
[478.049497] Subtest fbc-psr2-cursor-plane-move: SKIP (0.001s)
[478.109313] [082/130] (549s left) gen9_exec_parse (secure-batches)
[478.162881] Subtest secure-batches: SKIP (0.000s)
[478.238430] [083/130] (549s left) gem_mmap_offset (clear-via-pagefault)
[478.287260] Starting subtest: clear-via-pagefault
[478.289308] Starting dynamic subtest: smem0
[509.695299] Dynamic subtest smem0: SUCCESS (31.403s)
[509.697808] Subtest clear-via-pagefault: SUCCESS (31.405s)
[509.833117] [084/130] (517s left) kms_atomic_transition (modeset-transition-fencing)
[509.935640] Starting subtest: modeset-transition-fencing
[509.937966] Starting dynamic subtest: 1x-outputs
[520.516628] Dynamic subtest 1x-outputs: SUCCESS (10.579s)
[520.792852] Subtest modeset-transition-fencing: SUCCESS (10.853s)
[521.646512] [085/130] (505s left) gem_exec_schedule (in-order)
[521.722047] Starting subtest: in-order
[521.724739] Starting dynamic subtest: rcs0
[521.815447] Dynamic subtest rcs0: SUCCESS (0.106s)
[521.828007] Starting dynamic subtest: vcs0
[521.900576] Dynamic subtest vcs0: SUCCESS (0.085s)
[521.914145] Starting dynamic subtest: vcs1
[521.975869] Dynamic subtest vcs1: SUCCESS (0.075s)
[521.988633] Starting dynamic subtest: vecs0
[522.056093] Dynamic subtest vecs0: SUCCESS (0.079s)
[522.068666] Starting dynamic subtest: ccs0
[522.154531] Dynamic subtest ccs0: SUCCESS (0.098s)
[522.157161] Subtest in-order: SUCCESS (0.446s)
[523.631064] [086/130] (504s left) kms_psr (fbc-pr-dpms)
[523.734508] Starting subtest: fbc-pr-dpms
[523.739311] Subtest fbc-pr-dpms: SKIP (0.000s)
[523.807748] [087/130] (503s left) i915_selftest (perf)
[525.761255] Starting subtest: perf
[525.763474] Starting dynamic subtest: engine_cs
[528.712718] Dynamic subtest engine_cs: SUCCESS (2.950s)
[528.722782] Starting dynamic subtest: request
[534.271481] Dynamic subtest request: SUCCESS (5.556s)
[534.281166] Starting dynamic subtest: migrate
[538.884007] Dynamic subtest migrate: SUCCESS (4.610s)
[538.893605] Starting dynamic subtest: region
[544.913888] Dynamic subtest region: SUCCESS (6.027s)
[544.916960] Subtest perf: SUCCESS (19.150s)
[544.946551] [FACT i915_selftest (perf)] deleted: kernel.kmod_is_loaded.i915: true
[544.950254] [088/130] (482s left) kms_psr (psr-primary-blt)
[546.570571] Starting subtest: psr-primary-blt
[546.572812] Starting dynamic subtest: eDP-1
[548.333047] Dynamic subtest eDP-1: SUCCESS (1.764s)
[548.335612] Subtest psr-primary-blt: SUCCESS (1.765s)
[549.197892] [FACT kms_psr (psr-primary-blt)] new: kernel.kmod_is_loaded.i915: true
[549.202100] [089/130] (478s left) kms_sequence (get-idle)
[549.310619] Starting subtest: get-idle
[549.313001] Starting dynamic subtest: pipe-A-eDP-1
[551.102277] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.791s)
[551.114891] Starting dynamic subtest: pipe-B-eDP-1
[553.576910] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.473s)
[553.587591] Starting dynamic subtest: pipe-C-eDP-1
[555.987072] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.408s)
[555.997989] Starting dynamic subtest: pipe-D-eDP-1
[558.423665] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.437s)
[558.425983] Subtest get-idle: SUCCESS (9.113s)
[559.238332] [090/130] (468s left) kms_flip (single-buffer-flip-vs-dpms-off-vs-modeset-interruptible)
[559.344843] Starting subtest: single-buffer-flip-vs-dpms-off-vs-modeset-interruptible
[559.347544] Starting dynamic subtest: A-eDP1
[562.974937] Dynamic subtest A-eDP1: SUCCESS (3.627s)
[562.985537] Starting dynamic subtest: B-eDP1
[566.181552] Dynamic subtest B-eDP1: SUCCESS (3.204s)
[566.191087] Starting dynamic subtest: C-eDP1
[569.284128] Dynamic subtest C-eDP1: SUCCESS (3.101s)
[569.294770] Starting dynamic subtest: D-eDP1
[572.374957] Dynamic subtest D-eDP1: SUCCESS (3.090s)
[572.377478] Subtest single-buffer-flip-vs-dpms-off-vs-modeset-interruptible: SUCCESS (13.033s)
[573.177871] [091/130] (454s left) gem_workarounds (basic-read-fd)
[573.259089] Starting subtest: basic-read-fd
[573.271212] Subtest basic-read-fd: SUCCESS (0.012s)
[573.403170] [092/130] (454s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-render)
[573.499681] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-render
[580.658578] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-render: SUCCESS (7.160s)
[580.803113] [093/130] (447s left) prime_busy (after-wait)
[580.873892] Starting subtest: after-wait
[580.879903] Starting dynamic subtest: rcs0
[580.925815] Dynamic subtest rcs0: SUCCESS (0.048s)
[580.937030] Starting dynamic subtest: bcs0
[580.992864] Dynamic subtest bcs0: SUCCESS (0.066s)
[581.004338] Starting dynamic subtest: vcs0
[581.032562] Dynamic subtest vcs0: SUCCESS (0.039s)
[581.042143] Starting dynamic subtest: vcs1
[581.071752] Dynamic subtest vcs1: SUCCESS (0.039s)
[581.081110] Starting dynamic subtest: vecs0
[581.112922] Dynamic subtest vecs0: SUCCESS (0.040s)
[581.122146] Starting dynamic subtest: ccs0
[581.154406] Dynamic subtest ccs0: SUCCESS (0.040s)
[581.262742] Subtest after-wait: SUCCESS (0.387s)
[581.332896] [094/130] (446s left) gem_sync (basic-store-all)
[581.405780] Starting subtest: basic-store-all
[584.619393] Subtest basic-store-all: SUCCESS (3.226s)
[584.803284] [095/130] (443s left) gem_exec_balancer (bonded-true-hang)
[585.063085] Starting subtest: bonded-true-hang
[585.068722] Subtest bonded-true-hang: SKIP (0.000s)
[585.180423] [096/130] (442s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-mmap-cpu)
[585.292364] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-mmap-cpu
[589.585720] Subtest fbc-1p-primscrn-pri-indfb-draw-mmap-cpu: SUCCESS (4.298s)
[590.730082] [097/130] (437s left) gem_mmap_gtt (bad-object)
[590.779811] Subtest bad-object: SKIP (0.000s)
[590.837828] [098/130] (437s left) kms_flip (flip-vs-wf_vblank-interruptible)
[590.940254] Starting subtest: flip-vs-wf_vblank-interruptible
[590.942701] Starting dynamic subtest: A-eDP1
[592.872267] Dynamic subtest A-eDP1: SUCCESS (1.931s)
[592.883858] Starting dynamic subtest: B-eDP1
[594.808101] Dynamic subtest B-eDP1: SUCCESS (1.935s)
[594.823996] Starting dynamic subtest: C-eDP1
[596.734857] Dynamic subtest C-eDP1: SUCCESS (1.925s)
[596.745569] Starting dynamic subtest: D-eDP1
[598.577896] Dynamic subtest D-eDP1: SUCCESS (1.843s)
[598.580591] Subtest flip-vs-wf_vblank-interruptible: SUCCESS (7.642s)
[599.815170] [099/130] (428s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-mmap-cpu)
[599.925208] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-mmap-cpu
[599.929297] Subtest psr-2p-scndscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[600.042108] [100/130] (428s left) kms_big_fb (x-tiled-16bpp-rotate-270)
[600.142992] Starting subtest: x-tiled-16bpp-rotate-270
[600.162804] Subtest x-tiled-16bpp-rotate-270: SKIP (0.018s)
[600.277977] [101/130] (427s left) kms_cursor_legacy (basic-flip-after-cursor-varying-size)
[600.396925] Starting subtest: basic-flip-after-cursor-varying-size
[601.326772] Subtest basic-flip-after-cursor-varying-size: SUCCESS (0.928s)
[602.153355] [102/130] (426s left) gem_render_copy (mixed-tiled-to-y-tiled-ccs)
[602.209724] Starting subtest: mixed-tiled-to-y-tiled-ccs
[602.215120] Subtest mixed-tiled-to-y-tiled-ccs: SKIP (0.000s)
[602.385913] [103/130] (425s left) gem_softpin (allocator-nopin-reserve)
[602.442031] Starting subtest: allocator-nopin-reserve
[602.556342] Subtest allocator-nopin-reserve: SUCCESS (0.113s)
[602.686153] [104/130] (425s left) gem_ctx_param (invalid-size-get)
[602.731853] Starting subtest: invalid-size-get
[602.734326] Subtest invalid-size-get: SUCCESS (0.001s)
[602.834450] [105/130] (425s left) kms_psr (psr-sprite-mmap-gtt)
[602.927775] Starting subtest: psr-sprite-mmap-gtt
[602.929984] Starting dynamic subtest: eDP-1
[604.385833] Dynamic subtest eDP-1: SKIP (1.455s)
[604.390913] Subtest psr-sprite-mmap-gtt: SKIP (1.457s)
[604.541366] [106/130] (423s left) kms_color (legacy-gamma)
[604.641018] Starting subtest: legacy-gamma
[604.643330] Starting dynamic subtest: pipe-A-eDP-1
[605.328545] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.686s)
[605.338309] Starting dynamic subtest: pipe-B-eDP-1
[606.677823] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.348s)
[606.687263] Starting dynamic subtest: pipe-C-eDP-1
[608.094736] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.415s)
[608.104007] Starting dynamic subtest: pipe-D-eDP-1
[609.405801] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.310s)
[609.408531] Subtest legacy-gamma: SUCCESS (4.762s)
[610.222887] [107/130] (418s left) i915_drm_fdinfo (isolation)
[610.262631] Starting subtest: isolation
[610.265277] Starting dynamic subtest: rcs0
[610.297912] Dynamic subtest rcs0: SKIP (0.036s)
[610.309597] Starting dynamic subtest: bcs0
[610.314050] Dynamic subtest bcs0: SKIP (0.000s)
[610.323121] Starting dynamic subtest: vcs0
[610.328763] Dynamic subtest vcs0: SKIP (0.000s)
[610.338087] Starting dynamic subtest: vcs1
[610.342909] Dynamic subtest vcs1: SKIP (0.000s)
[610.353614] Starting dynamic subtest: vecs0
[610.357974] Dynamic subtest vecs0: SKIP (0.000s)
[610.366384] Starting dynamic subtest: ccs0
[610.370829] Dynamic subtest ccs0: SKIP (0.000s)
[610.375645] Subtest isolation: SKIP (0.041s)
[610.412443] [108/130] (418s left) gem_tiled_fence_blits (basic)
[610.473853] Subtest basic: SKIP (0.000s)
[610.536256] [109/130] (418s left) syncobj_timeline (invalid-transfer-illegal-handle)
[610.590257] Starting subtest: invalid-transfer-illegal-handle
[610.592750] Subtest invalid-transfer-illegal-handle: SUCCESS (0.000s)
[610.684359] [110/130] (417s left) kms_ccs (bad-rotation-90-y-tiled-ccs)
[610.767718] Starting subtest: bad-rotation-90-y-tiled-ccs
[610.770100] Starting dynamic subtest: pipe-A-eDP-1
[610.793118] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[610.803619] Starting dynamic subtest: pipe-B-eDP-1
[610.827707] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[610.837101] Starting dynamic subtest: pipe-C-eDP-1
[610.861826] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[610.872926] Starting dynamic subtest: pipe-D-eDP-1
[610.898013] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[610.902744] Subtest bad-rotation-90-y-tiled-ccs: SKIP (0.005s)
[612.985814] [111/130] (415s left) syncobj_timeline (multi-wait-for-submit-available-submitted)
[613.042826] Starting subtest: multi-wait-for-submit-available-submitted
[613.045730] Subtest multi-wait-for-submit-available-submitted: SUCCESS (0.000s)
[613.135281] [112/130] (415s left) api_intel_allocator (default-alignment)
[613.195495] Starting subtest: default-alignment
[613.198137] Subtest default-alignment: SUCCESS (0.003s)
[613.333033] [113/130] (415s left) kms_chamelium_hpd (hdmi-hpd-after-suspend)
[613.721232] Subtest hdmi-hpd-after-suspend: SKIP (0.000s)
[614.494264] [114/130] (414s left) kms_content_protection (type1)
[614.639527] Starting subtest: type1
[617.976727] Subtest type1: SKIP (3.336s)
[619.152865] [115/130] (409s left) kms_plane_lowres (tiling-x)
[619.246582] Starting subtest: tiling-x
[619.248909] Starting dynamic subtest: pipe-A-eDP-1
[619.253592] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[619.554611] Starting dynamic subtest: pipe-B-eDP-1
[619.559302] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[619.569976] Starting dynamic subtest: pipe-C-eDP-1
[619.574464] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[619.583659] Starting dynamic subtest: pipe-D-eDP-1
[619.587725] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[619.592307] Subtest tiling-x: SKIP (0.302s)
[620.390739] [116/130] (408s left) gem_exec_params (invalid-batch-start-offset)
[620.454898] Starting subtest: invalid-batch-start-offset
[620.457303] Subtest invalid-batch-start-offset: SUCCESS (0.002s)
[620.588516] [117/130] (408s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-mmap-gtt)
[620.687955] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-mmap-gtt
[620.693040] Subtest psr-2p-scndscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[620.787567] [118/130] (408s left) kms_frontbuffer_tracking (fbcpsr-tiling-y)
[620.890510] Starting subtest: fbcpsr-tiling-y
[620.895266] Subtest fbcpsr-tiling-y: SKIP (0.000s)
[621.009793] [119/130] (407s left) gem_exec_balancer (hog)
[621.071043] Starting subtest: hog
[621.076677] Subtest hog: SKIP (0.000s)
[621.363018] [120/130] (407s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-180)
[621.471922] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-180
[622.393377] Subtest x-tiled-max-hw-stride-64bpp-rotate-180: SUCCESS (0.922s)
[622.546061] [121/130] (406s left) gem_exec_capture (pi)
[622.596813] Starting subtest: pi
[622.599454] Starting dynamic subtest: rcs0
[627.029528] Dynamic subtest rcs0: SUCCESS (4.433s)
[627.041627] Starting dynamic subtest: bcs0
[631.068326] Dynamic subtest bcs0: SUCCESS (4.037s)
[631.077924] Starting dynamic subtest: vcs0
[635.170941] Dynamic subtest vcs0: SUCCESS (4.103s)
[635.183875] Starting dynamic subtest: vcs1
[639.094005] Dynamic subtest vcs1: SUCCESS (3.922s)
[639.103317] Starting dynamic subtest: vecs0
[643.051932] Dynamic subtest vecs0: SUCCESS (3.957s)
[643.061933] Starting dynamic subtest: ccs0
[647.039419] Dynamic subtest ccs0: SUCCESS (3.987s)
[647.041918] Subtest pi: SUCCESS (24.445s)
[647.114913] [122/130] (381s left) gem_pwrite (basic-self)
[647.239257] Subtest basic-self: SKIP (0.000s)
[647.307494] [123/130] (381s left) kms_rotation_crc (primary-rotation-180)
[647.418470] Starting subtest: primary-rotation-180
[654.477117] Subtest primary-rotation-180: SUCCESS (7.058s)
[655.652332] [124/130] (373s left) gem_exec_whisper (basic-queues)
[655.722043] Starting subtest: basic-queues
[663.498304] Subtest basic-queues: SUCCESS (7.723s)
[663.627346] [125/130] (365s left) kms_flip (flip-vs-expired-vblank)
[663.729806] Starting subtest: flip-vs-expired-vblank
[663.732193] Starting dynamic subtest: A-eDP1
[672.495635] Dynamic subtest A-eDP1: SUCCESS (8.733s)
[672.505269] Starting dynamic subtest: B-eDP1
[681.221322] Dynamic subtest B-eDP1: SUCCESS (8.726s)
[681.231377] Starting dynamic subtest: C-eDP1
[689.945509] Dynamic subtest C-eDP1: SUCCESS (8.711s)
[689.957522] Starting dynamic subtest: D-eDP1
[698.574354] Dynamic subtest D-eDP1: SUCCESS (8.628s)
[698.577245] Subtest flip-vs-expired-vblank: SUCCESS (34.805s)
[699.690667] [126/130] (329s left) gem_eio (wait-wedge-immediate)
[699.913158] Starting subtest: wait-wedge-immediate
[701.570180] Subtest wait-wedge-immediate: SUCCESS (1.656s)
[701.684565] [127/130] (327s left) kms_ccs (bad-pixel-format-y-tiled-gen12-rc-ccs-cc)
[701.779464] Starting subtest: bad-pixel-format-y-tiled-gen12-rc-ccs-cc
[701.781821] Starting dynamic subtest: pipe-A-eDP-1
[701.804925] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[701.816116] Starting dynamic subtest: pipe-B-eDP-1
[701.841415] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[701.852961] Starting dynamic subtest: pipe-C-eDP-1
[701.877937] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[701.888087] Starting dynamic subtest: pipe-D-eDP-1
[701.912821] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[701.918254] Subtest bad-pixel-format-y-tiled-gen12-rc-ccs-cc: SKIP (0.004s)
[703.965171] [128/130] (325s left) kms_psr (pr-no-drrs)
[704.063825] Starting subtest: pr-no-drrs
[704.068873] Subtest pr-no-drrs: SKIP (0.000s)
[704.140502] [129/130] (325s left) kms_big_fb (y-tiled-8bpp-rotate-90)
[704.253603] Starting subtest: y-tiled-8bpp-rotate-90
[704.258402] Subtest y-tiled-8bpp-rotate-90: SKIP (0.000s)
[704.350714] [130/130] (325s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-pwrite)
[704.455133] Starting subtest: fbcpsr-rgb565-draw-pwrite
[711.380748] Subtest fbcpsr-rgb565-draw-pwrite: SUCCESS (6.930s)
[711.499574] Closing watchdogs
results: parsing output: 0/ for test: gem_exec_params
results: parsing output: 1/ for test: kms_frontbuffer_tracking
results: parsing output: 2/ for test: gem_spin_batch
results: parsing output: 3/ for test: perf
results: parsing output: 4/ for test: i915_pm_rps
results: parsing output: 5/ for test: tools_test
results: parsing output: 6/ for test: gem_mmap_gtt
results: parsing output: 7/ for test: kms_invalid_mode
results: parsing output: 8/ for test: kms_big_fb
results: parsing output: 9/ for test: syncobj_timeline
results: parsing output: 10/ for test: gem_exec_reloc
results: parsing output: 11/ for test: gem_userptr_blits
results: parsing output: 12/ for test: kms_pm_rpm
results: parsing output: 13/ for test: gem_exec_schedule
results: parsing output: 14/ for test: kms_psr2_sf
results: parsing output: 15/ for test: gem_exec_params
results: parsing output: 16/ for test: kms_flip
results: parsing output: 17/ for test: prime_self_import
results: parsing output: 18/ for test: kms_frontbuffer_tracking
results: parsing output: 19/ for test: gem_wait
results: parsing output: 20/ for test: kms_addfb_basic
results: parsing output: 21/ for test: kms_psr
results: parsing output: 22/ for test: device_reset
results: parsing output: 23/ for test: kms_ccs
results: parsing output: 24/ for test: syncobj_timeline
results: parsing output: 25/ for test: kms_lease
results: parsing output: 26/ for test: gem_ctx_isolation
results: parsing output: 27/ for test: kms_frontbuffer_tracking
results: parsing output: 28/ for test: syncobj_timeline
results: parsing output: 29/ for test: syncobj_wait
results: parsing output: 30/ for test: kms_big_fb
results: parsing output: 31/ for test: gem_ctx_persistence
results: parsing output: 32/ for test: gem_exec_schedule
results: parsing output: 33/ for test: kms_cursor_edge_walk
results: parsing output: 34/ for test: gem_mmap_gtt
results: parsing output: 35/ for test: api_intel_bb
results: parsing output: 36/ for test: kms_chamelium_color
results: parsing output: 37/ for test: kms_frontbuffer_tracking
results: parsing output: 38/ for test: kms_flip
results: parsing output: 39/ for test: kms_flip_scaled_crc
results: parsing output: 40/ for test: kms_cursor_crc
results: parsing output: 41/ for test: kms_cursor_legacy
results: parsing output: 42/ for test: kms_cursor_legacy
results: parsing output: 43/ for test: kms_dp_link_training
results: parsing output: 44/ for test: gem_exec_params
results: parsing output: 45/ for test: gem_exec_params
results: parsing output: 46/ for test: kms_ccs
results: parsing output: 47/ for test: fbdev
results: parsing output: 48/ for test: core_auth
results: parsing output: 49/ for test: kms_frontbuffer_tracking
results: parsing output: 50/ for test: i915_hangman
results: parsing output: 51/ for test: kms_frontbuffer_tracking
results: parsing output: 52/ for test: kms_plane_scaling
results: parsing output: 53/ for test: kms_frontbuffer_tracking
results: parsing output: 54/ for test: perf_pmu
results: parsing output: 55/ for test: kms_frontbuffer_tracking
results: parsing output: 56/ for test: kms_async_flips
results: parsing output: 57/ for test: gem_close_race
results: parsing output: 58/ for test: kms_frontbuffer_tracking
results: parsing output: 59/ for test: kms_cursor_crc
results: parsing output: 60/ for test: kms_lease
results: parsing output: 61/ for test: gem_softpin
results: parsing output: 62/ for test: kms_vrr
results: parsing output: 63/ for test: kms_plane_scaling
results: parsing output: 64/ for test: kms_atomic_transition
results: parsing output: 65/ for test: kms_big_fb
results: parsing output: 66/ for test: kms_frontbuffer_tracking
results: parsing output: 67/ for test: gem_ctx_persistence
results: parsing output: 68/ for test: kms_dsc
results: parsing output: 69/ for test: gem_softpin
results: parsing output: 70/ for test: gem_lmem_swapping
results: parsing output: 71/ for test: gem_exec_reloc
results: parsing output: 72/ for test: kms_frontbuffer_tracking
results: parsing output: 73/ for test: kms_ccs
results: parsing output: 74/ for test: kms_psr2_sf
results: parsing output: 75/ for test: kms_frontbuffer_tracking
results: parsing output: 76/ for test: kms_frontbuffer_tracking
results: parsing output: 77/ for test: kms_pm_rpm
results: parsing output: 78/ for test: kms_frontbuffer_tracking
results: parsing output: 79/ for test: perf
results: parsing output: 80/ for test: kms_psr
results: parsing output: 81/ for test: gen9_exec_parse
results: parsing output: 82/ for test: gem_mmap_offset
results: parsing output: 83/ for test: kms_atomic_transition
results: parsing output: 84/ for test: gem_exec_schedule
results: parsing output: 85/ for test: kms_psr
results: parsing output: 86/ for test: i915_selftest
results: parsing output: 87/ for test: kms_psr
results: parsing output: 88/ for test: kms_sequence
results: parsing output: 89/ for test: kms_flip
results: parsing output: 90/ for test: gem_workarounds
results: parsing output: 91/ for test: kms_frontbuffer_tracking
results: parsing output: 92/ for test: prime_busy
results: parsing output: 93/ for test: gem_sync
results: parsing output: 94/ for test: gem_exec_balancer
results: parsing output: 95/ for test: kms_frontbuffer_tracking
results: parsing output: 96/ for test: gem_mmap_gtt
results: parsing output: 97/ for test: kms_flip
results: parsing output: 98/ for test: kms_frontbuffer_tracking
results: parsing output: 99/ for test: kms_big_fb
results: parsing output: 100/ for test: kms_cursor_legacy
results: parsing output: 101/ for test: gem_render_copy
results: parsing output: 102/ for test: gem_softpin
results: parsing output: 103/ for test: gem_ctx_param
results: parsing output: 104/ for test: kms_psr
results: parsing output: 105/ for test: kms_color
results: parsing output: 106/ for test: i915_drm_fdinfo
results: parsing output: 107/ for test: gem_tiled_fence_blits
results: parsing output: 108/ for test: syncobj_timeline
results: parsing output: 109/ for test: kms_ccs
results: parsing output: 110/ for test: syncobj_timeline
results: parsing output: 111/ for test: api_intel_allocator
results: parsing output: 112/ for test: kms_chamelium_hpd
results: parsing output: 113/ for test: kms_content_protection
results: parsing output: 114/ for test: kms_plane_lowres
results: parsing output: 115/ for test: gem_exec_params
results: parsing output: 116/ for test: kms_frontbuffer_tracking
results: parsing output: 117/ for test: kms_frontbuffer_tracking
results: parsing output: 118/ for test: gem_exec_balancer
results: parsing output: 119/ for test: kms_big_fb
results: parsing output: 120/ for test: gem_exec_capture
results: parsing output: 121/ for test: gem_pwrite
results: parsing output: 122/ for test: kms_rotation_crc
results: parsing output: 123/ for test: gem_exec_whisper
results: parsing output: 124/ for test: kms_flip
results: parsing output: 125/ for test: gem_eio
results: parsing output: 126/ for test: kms_ccs
results: parsing output: 127/ for test: kms_psr
results: parsing output: 128/ for test: kms_big_fb
results: parsing output: 129/ for test: kms_frontbuffer_tracking
Done.