[61.941880] Initializing watchdogs
[61.941926]   /dev/watchdog0
[61.956538] [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]
[61.960826] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[61.963013] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[61.966183] [001/130] (960s left) gem_exec_params (invalid-ring)
[62.040874] Starting subtest: invalid-ring
[62.043737] Subtest invalid-ring: SUCCESS (0.000s)
[62.142882] [002/130] (960s left) kms_frontbuffer_tracking (fbcpsr-1p-offscren-pri-shrfb-draw-mmap-cpu)
[62.254270] Starting subtest: fbcpsr-1p-offscren-pri-shrfb-draw-mmap-cpu
[68.773964] Subtest fbcpsr-1p-offscren-pri-shrfb-draw-mmap-cpu: SUCCESS (6.522s)
[68.931868] [003/130] (953s left) gem_spin_batch (legacy)
[68.992813] Starting subtest: legacy
[68.995241] Starting dynamic subtest: default
[72.225040] Dynamic subtest default: SUCCESS (3.227s)
[72.233259] Starting dynamic subtest: render
[75.458268] Dynamic subtest render: SUCCESS (3.231s)
[75.467356] Starting dynamic subtest: bsd
[78.693989] Dynamic subtest bsd: SUCCESS (3.234s)
[78.703926] Starting dynamic subtest: bsd1
[81.927044] Dynamic subtest bsd1: SUCCESS (3.233s)
[81.936042] Starting dynamic subtest: bsd2
[85.157987] Dynamic subtest bsd2: SUCCESS (3.226s)
[85.166736] Starting dynamic subtest: blt
[88.394207] Dynamic subtest blt: SUCCESS (3.231s)
[88.402675] Starting dynamic subtest: vebox
[91.629060] Dynamic subtest vebox: SUCCESS (3.233s)
[91.631468] Subtest legacy: SUCCESS (22.624s)
[91.965747] [004/130] (930s left) perf (gen12-group-exclusive-stream-ctx-handle)
[92.072912] Starting subtest: gen12-group-exclusive-stream-ctx-handle
[92.101666] Subtest gen12-group-exclusive-stream-ctx-handle: SUCCESS (0.027s)
[92.144624] [005/130] (930s left) i915_pm_rps (thresholds-idle)
[93.883796] Starting subtest: thresholds-idle
[93.888982] Subtest thresholds-idle: SKIP (0.001s)
[93.970379] [006/130] (928s left) tools_test (tools_test)
[94.019692] Starting subtest: tools_test
[94.066325] Subtest tools_test: SUCCESS (0.061s)
[94.123414] [007/130] (928s left) gem_mmap_gtt (medium-copy-xy)
[94.191072] Subtest medium-copy-XY: SKIP (0.000s)
[94.256179] [008/130] (928s left) kms_invalid_mode (int-max-clock)
[94.360389] Starting subtest: int-max-clock
[94.362801] Starting dynamic subtest: pipe-A-eDP-1
[94.642196] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.283s)
[94.650977] Starting dynamic subtest: pipe-B-eDP-1
[94.653277] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[94.660047] Starting dynamic subtest: pipe-C-eDP-1
[94.662316] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[94.669296] Starting dynamic subtest: pipe-D-eDP-1
[94.671273] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[94.673181] Subtest int-max-clock: SUCCESS (0.287s)
[95.483622] [009/130] (927s left) kms_big_fb (yf-tiled-64bpp-rotate-0)
[95.586193] Starting subtest: yf-tiled-64bpp-rotate-0
[95.590623] Subtest yf-tiled-64bpp-rotate-0: SKIP (0.000s)
[95.674330] [010/130] (927s left) syncobj_timeline (etime-multi-wait-all-for-submit-available-unsubmitted-submi
[95.734714] Starting subtest: etime-multi-wait-all-for-submit-available-unsubmitted-submitted
[95.840369] Subtest etime-multi-wait-all-for-submit-available-unsubmitted-submitted: SUCCESS (0.106s)
[95.913140] [011/130] (926s left) gem_exec_reloc (basic-range)
[95.974744] Subtest basic-range: SKIP (0.000s)
[96.054868] [012/130] (926s left) gem_userptr_blits (forbidden-operations)
[96.116767] Starting subtest: forbidden-operations
[96.121287] Subtest forbidden-operations: SKIP (0.000s)
[96.235467] [013/130] (926s left) kms_pm_rpm (pm-caching)
[97.991901] Starting subtest: pm-caching
[97.997762] Subtest pm-caching: SKIP (0.000s)
[98.495581] [014/130] (924s left) gem_exec_schedule (u-submit-golden-slice)
[98.568812] Starting subtest: u-submit-golden-slice
[98.571180] Starting dynamic subtest: rcs0
[98.594016] Dynamic subtest rcs0: SUCCESS (0.034s)
[98.603854] Starting dynamic subtest: bcs0
[98.620518] Dynamic subtest bcs0: SUCCESS (0.026s)
[98.627326] Starting dynamic subtest: vcs0
[98.646588] Dynamic subtest vcs0: SUCCESS (0.026s)
[98.653164] Starting dynamic subtest: vcs1
[98.677264] Dynamic subtest vcs1: SUCCESS (0.031s)
[98.683992] Starting dynamic subtest: vecs0
[98.702819] Dynamic subtest vecs0: SUCCESS (0.025s)
[98.709388] Starting dynamic subtest: ccs0
[98.731979] Dynamic subtest ccs0: SUCCESS (0.029s)
[98.734320] Subtest u-submit-golden-slice: SUCCESS (0.172s)
[100.029532] [015/130] (922s left) kms_psr2_sf (fbc-pr-cursor-plane-move-continuous-sf)
[105.064711] Starting subtest: fbc-pr-cursor-plane-move-continuous-sf
[105.069356] Subtest fbc-pr-cursor-plane-move-continuous-sf: SKIP (0.002s)
[105.897122] [016/130] (917s left) gem_exec_params (dr4-dirt)
[105.948125] Starting subtest: DR4-dirt
[105.950395] Subtest DR4-dirt: SUCCESS (0.000s)
[106.058792] [017/130] (917s left) kms_flip (flip-vs-rmfb)
[106.157254] Starting subtest: flip-vs-rmfb
[106.159514] Starting dynamic subtest: A-eDP1
[114.797772] Dynamic subtest A-eDP1: SUCCESS (8.639s)
[114.807047] Starting dynamic subtest: B-eDP1
[123.433251] Dynamic subtest B-eDP1: SUCCESS (8.634s)
[123.443109] Starting dynamic subtest: C-eDP1
[132.050197] Dynamic subtest C-eDP1: SUCCESS (8.615s)
[132.060103] Starting dynamic subtest: D-eDP1
[140.680996] Dynamic subtest D-eDP1: SUCCESS (8.630s)
[140.685891] Subtest flip-vs-rmfb: SUCCESS (34.525s)
[141.860841] [018/130] (881s left) prime_self_import (basic-with_one_bo_two_files)
[141.895138] Starting subtest: basic-with_one_bo_two_files
[141.918788] Subtest basic-with_one_bo_two_files: SUCCESS (0.024s)
[142.047075] [019/130] (881s left) kms_frontbuffer_tracking (fbc-1p-primscrn-indfb-pgflip-blt)
[142.144456] Starting subtest: fbc-1p-primscrn-indfb-pgflip-blt
[146.627064] Subtest fbc-1p-primscrn-indfb-pgflip-blt: SUCCESS (4.487s)
[147.775517] [020/130] (875s left) gem_wait (busy)
[147.843517] Starting subtest: busy
[147.845980] Starting dynamic subtest: all-engines
[149.844648] Dynamic subtest all-engines: SUCCESS (1.999s)
[149.853852] Starting dynamic subtest: rcs0
[150.386869] Dynamic subtest rcs0: SUCCESS (0.541s)
[150.395609] Starting dynamic subtest: bcs0
[150.926320] Dynamic subtest bcs0: SUCCESS (0.539s)
[150.935916] Starting dynamic subtest: vcs0
[152.917220] Dynamic subtest vcs0: SUCCESS (1.989s)
[152.928109] Starting dynamic subtest: vcs1
[154.899895] Dynamic subtest vcs1: SUCCESS (1.980s)
[154.909293] Starting dynamic subtest: vecs0
[156.883466] Dynamic subtest vecs0: SUCCESS (1.981s)
[156.892945] Starting dynamic subtest: ccs0
[157.424326] Dynamic subtest ccs0: SUCCESS (0.541s)
[157.426896] Subtest busy: SUCCESS (9.580s)
[157.613824] [021/130] (865s left) kms_addfb_basic (bad-pitch-128)
[157.666171] Starting subtest: bad-pitch-128
[157.668389] Subtest bad-pitch-128: SUCCESS (0.000s)
[157.820346] [022/130] (865s left) kms_psr (fbc-psr-sprite-plane-onoff)
[157.917290] Starting subtest: fbc-psr-sprite-plane-onoff
[157.919411] Starting dynamic subtest: eDP-1
[157.923360] Dynamic subtest eDP-1: SKIP (0.000s)
[157.927315] Subtest fbc-psr-sprite-plane-onoff: SKIP (0.001s)
[157.986327] [023/130] (865s left) device_reset (unbind-reset-rebind)
[158.033596] Starting subtest: unbind-reset-rebind
[161.157996] Subtest unbind-reset-rebind: SUCCESS (3.119s)
[161.194276] [024/130] (862s left) kms_ccs (crc-sprite-planes-basic-y-tiled-gen12-rc-ccs)
[161.289384] Starting subtest: crc-sprite-planes-basic-y-tiled-gen12-rc-ccs
[161.291739] Starting dynamic subtest: pipe-A-eDP-1
[161.352601] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[161.361768] Starting dynamic subtest: pipe-B-eDP-1
[161.420367] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[161.430968] Starting dynamic subtest: pipe-C-eDP-1
[161.491145] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[161.500230] Starting dynamic subtest: pipe-D-eDP-1
[161.557452] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[161.561592] Subtest crc-sprite-planes-basic-y-tiled-gen12-rc-ccs: SKIP (0.009s)
[163.476922] [025/130] (859s left) syncobj_timeline (invalid-multi-wait-all-unsubmitted-signaled)
[163.538109] Starting subtest: invalid-multi-wait-all-unsubmitted-signaled
[163.540756] Subtest invalid-multi-wait-all-unsubmitted-signaled: SUCCESS (0.000s)
[163.636390] [026/130] (859s left) kms_lease (lease-again)
[163.725238] Starting subtest: lease-again
[163.727636] Starting dynamic subtest: pipe-A-eDP-1
[163.729866] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.003s)
[163.737715] Starting dynamic subtest: pipe-B-eDP-1
[163.739884] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.002s)
[163.746849] Starting dynamic subtest: pipe-C-eDP-1
[163.748918] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.002s)
[163.755798] Starting dynamic subtest: pipe-D-eDP-1
[163.757689] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.002s)
[163.759564] Subtest lease-again: SUCCESS (0.012s)
[163.853035] [027/130] (859s left) gem_ctx_isolation (preservation-s3)
[163.910292] Starting subtest: preservation-S3
[163.912828] Starting dynamic subtest: rcs0
[179.835083] Dynamic subtest rcs0: SUCCESS (1.430s)
[179.849539] Starting dynamic subtest: bcs0
[195.753333] Dynamic subtest bcs0: SUCCESS (1.235s)
[195.763502] Starting dynamic subtest: vcs0
[211.768269] Dynamic subtest vcs0: SUCCESS (2.328s)
[211.778038] Starting dynamic subtest: vcs1
[229.833697] Dynamic subtest vcs1: SUCCESS (5.030s)
[229.843397] Starting dynamic subtest: vecs0
[247.825230] Dynamic subtest vecs0: SUCCESS (5.056s)
[247.839524] Starting dynamic subtest: ccs0
[265.753251] Dynamic subtest ccs0: SUCCESS (3.044s)
[265.755717] Subtest preservation-S3: SUCCESS (18.127s)
[265.998657] [028/130] (757s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-mmap-cpu)
[266.107454] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-mmap-cpu
[269.721369] Subtest fbc-1p-primscrn-cur-indfb-draw-mmap-cpu: SUCCESS (3.615s)
[270.843585] [029/130] (752s left) syncobj_timeline (wait-for-submit-delayed-submit)
[270.905615] Starting subtest: wait-for-submit-delayed-submit
[271.008399] Subtest wait-for-submit-delayed-submit: SUCCESS (0.103s)
[271.082421] [030/130] (752s left) syncobj_wait (multi-wait-for-submit-unsubmitted-submitted)
[271.131502] Starting subtest: multi-wait-for-submit-unsubmitted-submitted
[271.239016] Subtest multi-wait-for-submit-unsubmitted-submitted: SUCCESS (0.107s)
[271.312709] [031/130] (752s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip)
[271.415073] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip
[272.028464] Subtest 4-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip: SUCCESS (0.615s)
[272.199469] [032/130] (751s left) gem_ctx_persistence (legacy-engines-persistence)
[272.262658] Starting subtest: legacy-engines-persistence
[272.264985] Starting dynamic subtest: render
[273.112627] Dynamic subtest render: SUCCESS (0.848s)
[273.124572] Starting dynamic subtest: bsd1
[273.882612] Dynamic subtest bsd1: SUCCESS (0.767s)
[273.894080] Starting dynamic subtest: bsd2
[274.690081] Dynamic subtest bsd2: SUCCESS (0.804s)
[274.701480] Starting dynamic subtest: blt
[275.468789] Dynamic subtest blt: SUCCESS (0.775s)
[275.484018] Starting dynamic subtest: vebox
[276.244560] Dynamic subtest vebox: SUCCESS (0.772s)
[276.247331] Subtest legacy-engines-persistence: SUCCESS (3.979s)
[276.323298] [033/130] (747s left) gem_exec_schedule (preempt-other-chain)
[276.407121] Starting subtest: preempt-other-chain
[276.409425] Starting dynamic subtest: rcs0
[276.541259] Dynamic subtest rcs0: SUCCESS (0.139s)
[276.552808] Starting dynamic subtest: bcs0
[276.674439] Dynamic subtest bcs0: SUCCESS (0.132s)
[276.684153] Starting dynamic subtest: vcs0
[276.815522] Dynamic subtest vcs0: SUCCESS (0.140s)
[276.825091] Starting dynamic subtest: vcs1
[276.942584] Dynamic subtest vcs1: SUCCESS (0.127s)
[276.957602] Starting dynamic subtest: vecs0
[277.074604] Dynamic subtest vecs0: SUCCESS (0.131s)
[277.084533] Starting dynamic subtest: ccs0
[277.200108] Dynamic subtest ccs0: SUCCESS (0.125s)
[277.202703] Subtest preempt-other-chain: SUCCESS (0.798s)
[277.752331] [034/130] (745s left) kms_cursor_edge_walk (256x256-top-edge)
[277.842088] Starting subtest: 256x256-top-edge
[277.844285] Starting dynamic subtest: pipe-A-eDP-1
[281.312908] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.464s)
[281.321953] Starting dynamic subtest: pipe-D-eDP-1
[284.428441] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.115s)
[284.430620] Subtest 256x256-top-edge: SUCCESS (6.581s)
[285.248710] [035/130] (738s left) gem_mmap_gtt (medium-copy)
[285.303197] Subtest medium-copy: SKIP (0.000s)
[285.359334] [036/130] (738s left) api_intel_bb (blit-noreloc-purge-cache)
[285.418921] Starting subtest: blit-noreloc-purge-cache
[285.425014] Subtest blit-noreloc-purge-cache: SUCCESS (0.010s)
[285.569685] [037/130] (738s left) kms_chamelium_color (gamma)
[285.661438] Subtest gamma: SKIP (0.000s)
[285.707587] [038/130] (738s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-mmap-gtt)
[285.805544] Starting subtest: psr-2p-primscrn-cur-indfb-draw-mmap-gtt
[285.809991] Subtest psr-2p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[285.912743] [039/130] (737s left) kms_flip (blocking-absolute-wf_vblank-interruptible)
[286.011206] Starting subtest: blocking-absolute-wf_vblank-interruptible
[286.013536] Starting dynamic subtest: A-eDP1
[294.717429] Dynamic subtest A-eDP1: SUCCESS (8.701s)
[294.726867] Starting dynamic subtest: B-eDP1
[303.450597] Dynamic subtest B-eDP1: SUCCESS (8.726s)
[303.464075] Starting dynamic subtest: C-eDP1
[312.167698] Dynamic subtest C-eDP1: SUCCESS (8.710s)
[312.177984] Starting dynamic subtest: D-eDP1
[320.906579] Dynamic subtest D-eDP1: SUCCESS (8.734s)
[320.911641] Subtest blocking-absolute-wf_vblank-interruptible: SUCCESS (34.883s)
[322.129493] [040/130] (701s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-16bpp-4tile-upscaling)
[322.233431] Starting subtest: flip-64bpp-4tile-to-16bpp-4tile-upscaling
[322.235643] Starting dynamic subtest: pipe-A-default-mode
[324.991773] Dynamic subtest pipe-A-default-mode: SUCCESS (2.755s)
[324.993967] Subtest flip-64bpp-4tile-to-16bpp-4tile-upscaling: SUCCESS (2.757s)
[325.825202] [041/130] (698s left) kms_cursor_crc (cursor-onscreen-128x128)
[326.018950] Starting subtest: cursor-onscreen-128x128
[326.023862] Starting dynamic subtest: pipe-A-eDP-1
[328.120966] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.096s)
[328.145708] Starting dynamic subtest: pipe-D-eDP-1
[330.903185] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.762s)
[330.905556] Subtest cursor-onscreen-128x128: SUCCESS (4.880s)
[331.696445] [042/130] (692s left) kms_cursor_legacy (cursorb-vs-flipb-varying-size)
[331.820533] Starting subtest: cursorB-vs-flipB-varying-size
[331.825511] Subtest cursorB-vs-flipB-varying-size: SKIP (0.001s)
[331.964727] [043/130] (692s left) kms_cursor_legacy (cursorb-vs-flipb-toggle)
[332.092075] Starting subtest: cursorB-vs-flipB-toggle
[332.096611] Subtest cursorB-vs-flipB-toggle: SKIP (0.001s)
[332.235879] [044/130] (691s left) kms_dp_link_training (non-uhbr-mst)
[332.322439] Starting subtest: non-uhbr-mst
[332.330887] Subtest non-uhbr-mst: SKIP (0.000s)
[332.392409] [045/130] (691s left) gem_exec_params (secure-non-master)
[332.447793] Starting subtest: secure-non-master
[332.452643] Subtest secure-non-master: SKIP (0.000s)
[332.558080] [046/130] (691s left) gem_exec_params (rel-constants-invalid-ring)
[332.612428] Starting subtest: rel-constants-invalid-ring
[332.614812] Subtest rel-constants-invalid-ring: SUCCESS (0.000s)
[332.737848] [047/130] (691s left) kms_ccs (random-ccs-data-4-tiled-dg2-mc-ccs)
[332.818838] Starting subtest: random-ccs-data-4-tiled-dg2-mc-ccs
[332.820783] Starting dynamic subtest: pipe-A-eDP-1
[332.841277] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[332.851377] Starting dynamic subtest: pipe-B-eDP-1
[332.870472] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[332.879652] Starting dynamic subtest: pipe-C-eDP-1
[332.899094] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[332.907964] Starting dynamic subtest: pipe-D-eDP-1
[332.929141] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[332.932665] Subtest random-ccs-data-4-tiled-dg2-mc-ccs: SKIP (0.004s)
[334.980284] [048/130] (689s left) fbdev (unaligned-read)
[335.021571] Starting subtest: unaligned-read
[335.038211] Subtest unaligned-read: SUCCESS (0.016s)
[335.088199] [049/130] (689s left) core_auth (many-magics)
[335.146999] Starting subtest: many-magics
[335.985785] Subtest many-magics: SUCCESS (0.841s)
[336.162200] [050/130] (688s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-pwrite)
[336.268432] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-pwrite
[336.272806] Subtest fbc-2p-primscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[336.353789] [051/130] (687s left) i915_hangman (gt-engine-hang)
[336.415470] Starting subtest: gt-engine-hang
[336.417589] Starting dynamic subtest: rcs0
[337.570298] Dynamic subtest rcs0: SUCCESS (1.154s)
[337.582515] Starting dynamic subtest: bcs0
[339.553704] Dynamic subtest bcs0: SUCCESS (1.980s)
[339.565054] Starting dynamic subtest: vcs0
[341.538899] Dynamic subtest vcs0: SUCCESS (1.982s)
[341.550717] Starting dynamic subtest: vcs1
[343.584762] Dynamic subtest vcs1: SUCCESS (2.043s)
[343.597387] Starting dynamic subtest: vecs0
[345.569925] Dynamic subtest vecs0: SUCCESS (1.981s)
[345.582318] Starting dynamic subtest: ccs0
[347.553380] Dynamic subtest ccs0: SUCCESS (1.979s)
[347.556192] Subtest gt-engine-hang: SUCCESS (11.133s)
[347.630936] [052/130] (676s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-cpu)
[347.733958] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-cpu
[347.738505] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[347.826596] [053/130] (676s left) kms_plane_scaling (intel-max-src-size)
[347.923805] Starting subtest: intel-max-src-size
[347.930107] Subtest intel-max-src-size: SKIP (0.000s)
[348.032813] [054/130] (676s left) kms_frontbuffer_tracking (fbc-1p-offscren-pri-shrfb-draw-mmap-wc)
[348.137930] Starting subtest: fbc-1p-offscren-pri-shrfb-draw-mmap-wc
[352.111020] Subtest fbc-1p-offscren-pri-shrfb-draw-mmap-wc: SUCCESS (3.973s)
[353.303658] [055/130] (671s left) perf_pmu (multi-client)
[353.346401] Starting subtest: multi-client
[353.348991] Starting dynamic subtest: rcs0
[354.426982] Dynamic subtest rcs0: SUCCESS (1.080s)
[354.438534] Starting dynamic subtest: bcs0
[355.476413] Dynamic subtest bcs0: SUCCESS (1.047s)
[355.488163] Starting dynamic subtest: vcs0
[356.526583] Dynamic subtest vcs0: SUCCESS (1.048s)
[356.539287] Starting dynamic subtest: vcs1
[357.622949] Dynamic subtest vcs1: SUCCESS (1.094s)
[357.635288] Starting dynamic subtest: vecs0
[359.610519] Dynamic subtest vecs0: SUCCESS (1.985s)
[359.622021] Starting dynamic subtest: ccs0
[361.595391] Dynamic subtest ccs0: SUCCESS (1.982s)
[361.598453] Subtest multi-client: SUCCESS (8.247s)
[361.722596] [056/130] (662s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-shrfb-msflip-blt)
[361.820443] Starting subtest: fbcpsr-2p-primscrn-shrfb-msflip-blt
[361.824480] Subtest fbcpsr-2p-primscrn-shrfb-msflip-blt: SKIP (0.000s)
[361.932207] [057/130] (662s left) kms_async_flips (crc-atomic)
[362.035062] Starting subtest: crc-atomic
[362.421502] Starting dynamic subtest: pipe-A-eDP-1
[365.313993] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.893s)
[365.692553] Starting dynamic subtest: pipe-B-eDP-1
[368.620789] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.943s)
[369.007299] Starting dynamic subtest: pipe-C-eDP-1
[371.849570] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.854s)
[372.226101] Starting dynamic subtest: pipe-D-eDP-1
[375.085942] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.871s)
[375.088247] Subtest crc-atomic: SUCCESS (13.061s)
[376.256447] [058/130] (648s left) gem_close_race (multigpu-basic-process)
[376.322268] Starting subtest: multigpu-basic-process
[376.326662] Subtest multigpu-basic-process: SKIP (0.000s)
[376.539642] [059/130] (648s left) kms_frontbuffer_tracking (fbc-1p-indfb-fliptrack-mmap-gtt)
[376.638764] Starting subtest: fbc-1p-indfb-fliptrack-mmap-gtt
[376.642768] Subtest fbc-1p-indfb-fliptrack-mmap-gtt: SKIP (0.000s)
[376.755759] [060/130] (647s left) kms_cursor_crc (cursor-random-max-size)
[377.041063] Starting subtest: cursor-random-max-size
[377.047672] Subtest cursor-random-max-size: SKIP (0.000s)
[377.187408] [061/130] (647s left) kms_lease (simple-lease)
[377.283434] Starting subtest: simple-lease
[377.285762] Starting dynamic subtest: pipe-A-eDP-1
[377.780152] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.495s)
[377.789932] Starting dynamic subtest: pipe-B-eDP-1
[379.197748] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.416s)
[379.206996] Starting dynamic subtest: pipe-C-eDP-1
[380.593009] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.393s)
[380.603401] Starting dynamic subtest: pipe-D-eDP-1
[381.969813] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.377s)
[381.972206] Subtest simple-lease: SUCCESS (4.687s)
[382.791385] [062/130] (641s left) gem_softpin (overlap)
[382.847921] Starting subtest: overlap
[383.688142] Subtest overlap: SUCCESS (0.839s)
[383.842039] [063/130] (640s left) kms_vrr (flip-basic)
[383.936731] Starting subtest: flip-basic
[383.943504] Subtest flip-basic: SKIP (0.000s)
[384.007019] [064/130] (640s left) kms_plane_scaling (plane-upscale-factor-0-25-with-modifiers)
[384.089434] Starting subtest: plane-upscale-factor-0-25-with-modifiers
[384.091623] Starting dynamic subtest: pipe-A
[384.427327] Dynamic subtest pipe-A: SUCCESS (0.337s)
[384.442908] Starting dynamic subtest: pipe-B
[385.788551] Dynamic subtest pipe-B: SUCCESS (1.360s)
[385.797910] Starting dynamic subtest: pipe-C
[387.229228] Dynamic subtest pipe-C: SUCCESS (1.440s)
[387.240123] Starting dynamic subtest: pipe-D
[388.663682] Dynamic subtest pipe-D: SUCCESS (1.433s)
[388.666232] Subtest plane-upscale-factor-0-25-with-modifiers: SUCCESS (4.576s)
[389.834710] [065/130] (635s left) kms_atomic_transition (plane-all-transition-fencing)
[389.940514] Starting subtest: plane-all-transition-fencing
[389.942790] Starting dynamic subtest: pipe-A-eDP-1
[392.440931] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.503s)
[392.753533] Starting dynamic subtest: pipe-B-eDP-1
[395.969590] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.228s)
[396.266832] Subtest plane-all-transition-fencing: SUCCESS (6.329s)
[397.086459] [066/130] (627s left) kms_big_fb (y-tiled-64bpp-rotate-90)
[397.199783] Starting subtest: y-tiled-64bpp-rotate-90
[397.203971] Subtest y-tiled-64bpp-rotate-90: SKIP (0.000s)
[397.304458] [067/130] (627s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-blt)
[397.412789] Starting subtest: fbcpsr-rgb565-draw-blt
[404.300423] Subtest fbcpsr-rgb565-draw-blt: SUCCESS (6.890s)
[404.455277] [068/130] (620s left) gem_ctx_persistence (engines-mixed-process)
[404.514632] Starting subtest: engines-mixed-process
[404.516987] Starting dynamic subtest: rcs0
[406.599974] Dynamic subtest rcs0: SUCCESS (2.085s)
[406.610231] Starting dynamic subtest: bcs0
[408.559057] Dynamic subtest bcs0: SUCCESS (1.958s)
[408.570021] Starting dynamic subtest: vcs0
[410.612097] Dynamic subtest vcs0: SUCCESS (2.050s)
[410.622440] Starting dynamic subtest: vcs1
[412.631247] Dynamic subtest vcs1: SUCCESS (2.020s)
[412.643034] Starting dynamic subtest: vecs0
[414.621062] Dynamic subtest vecs0: SUCCESS (1.988s)
[414.633128] Starting dynamic subtest: ccs0
[416.611237] Dynamic subtest ccs0: SUCCESS (1.987s)
[416.613963] Subtest engines-mixed-process: SUCCESS (12.096s)
[416.690058] [069/130] (608s left) kms_dsc (dsc-with-output-formats-with-bpc)
[416.803667] Starting subtest: dsc-with-output-formats-with-bpc
[416.861476] Subtest dsc-with-output-formats-with-bpc: SKIP (0.001s)
[416.901139] [070/130] (608s left) gem_softpin (invalid)
[416.968723] Starting subtest: invalid
[416.976755] Subtest invalid: SUCCESS (0.006s)
[417.126136] [071/130] (607s left) gem_lmem_swapping (random-engines)
[417.162928] Subtest random-engines: SKIP (0.000s)
[417.206899] [072/130] (607s left) gem_exec_reloc (basic-cpu-wc-active)
[417.267596] Subtest basic-cpu-wc-active: SKIP (0.000s)
[417.357872] [073/130] (607s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-mmap-cpu)
[417.449638] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-mmap-cpu
[421.715851] Subtest fbc-1p-primscrn-pri-shrfb-draw-mmap-cpu: SUCCESS (4.269s)
[422.897753] [074/130] (602s left) kms_ccs (crc-primary-rotation-180-y-tiled-gen12-rc-ccs)
[422.990464] Starting subtest: crc-primary-rotation-180-y-tiled-gen12-rc-ccs
[422.992796] Starting dynamic subtest: pipe-A-eDP-1
[423.016009] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[423.028369] Starting dynamic subtest: pipe-B-eDP-1
[423.051026] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[423.059773] Starting dynamic subtest: pipe-C-eDP-1
[423.080637] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[423.089316] Starting dynamic subtest: pipe-D-eDP-1
[423.111369] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[423.115425] Subtest crc-primary-rotation-180-y-tiled-gen12-rc-ccs: SKIP (0.005s)
[425.140285] [075/130] (600s left) kms_psr2_sf (psr2-overlay-plane-move-continuous-exceed-sf)
[430.136119] Starting subtest: psr2-overlay-plane-move-continuous-exceed-sf
[430.141526] Starting dynamic subtest: pipe-A-eDP-1
[442.177568] Dynamic subtest pipe-A-eDP-1: SUCCESS (12.035s)
[442.188067] Starting dynamic subtest: pipe-B-eDP-1
[454.202922] Dynamic subtest pipe-B-eDP-1: SUCCESS (12.020s)
[454.205325] Subtest psr2-overlay-plane-move-continuous-exceed-sf: SUCCESS (24.060s)
[455.053425] [076/130] (570s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-pwrite)
[455.163459] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-pwrite
[455.167456] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[455.261220] [077/130] (570s left) kms_frontbuffer_tracking (psr-rgb101010-draw-render)
[455.358943] Starting subtest: psr-rgb101010-draw-render
[462.611682] Subtest psr-rgb101010-draw-render: SUCCESS (7.253s)
[462.734606] [078/130] (562s left) kms_pm_rpm (cursor-dpms)
[464.762163] Starting subtest: cursor-dpms
[464.767877] Subtest cursor-dpms: SKIP (0.000s)
[465.130312] [079/130] (560s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-render)
[465.227263] Starting subtest: psr-1p-primscrn-cur-indfb-draw-render
[471.920010] Subtest psr-1p-primscrn-cur-indfb-draw-render: SUCCESS (6.693s)
[472.064328] [080/130] (553s left) perf (sysctl-defaults)
[472.120988] Starting subtest: sysctl-defaults
[472.123471] Subtest sysctl-defaults: SUCCESS (0.000s)
[472.205334] [081/130] (553s left) kms_psr (fbc-psr2-cursor-plane-move)
[472.295955] Starting subtest: fbc-psr2-cursor-plane-move
[472.298242] Starting dynamic subtest: eDP-1
[472.302727] Dynamic subtest eDP-1: SKIP (0.000s)
[472.307238] Subtest fbc-psr2-cursor-plane-move: SKIP (0.001s)
[472.366452] [082/130] (553s left) gen9_exec_parse (secure-batches)
[472.433517] Subtest secure-batches: SKIP (0.000s)
[472.501347] [083/130] (553s left) gem_mmap_offset (clear-via-pagefault)
[472.564711] Starting subtest: clear-via-pagefault
[472.566817] Starting dynamic subtest: smem0
[503.226473] Dynamic subtest smem0: SUCCESS (30.659s)
[503.231055] Subtest clear-via-pagefault: SUCCESS (30.661s)
[503.348545] [084/130] (522s left) kms_atomic_transition (modeset-transition-fencing)
[503.448947] Starting subtest: modeset-transition-fencing
[503.450934] Starting dynamic subtest: 1x-outputs
[514.017869] Dynamic subtest 1x-outputs: SUCCESS (10.572s)
[514.283127] Subtest modeset-transition-fencing: SUCCESS (10.837s)
[515.151426] [085/130] (510s left) gem_exec_schedule (in-order)
[515.225803] Starting subtest: in-order
[515.227671] Starting dynamic subtest: rcs0
[515.321157] Dynamic subtest rcs0: SUCCESS (0.099s)
[515.333569] Starting dynamic subtest: vcs0
[515.398678] Dynamic subtest vcs0: SUCCESS (0.078s)
[515.411105] Starting dynamic subtest: vcs1
[515.474386] Dynamic subtest vcs1: SUCCESS (0.075s)
[515.485688] Starting dynamic subtest: vecs0
[515.551230] Dynamic subtest vecs0: SUCCESS (0.075s)
[515.563712] Starting dynamic subtest: ccs0
[515.640165] Dynamic subtest ccs0: SUCCESS (0.089s)
[515.642601] Subtest in-order: SUCCESS (0.419s)
[516.727412] [086/130] (508s left) kms_psr (fbc-pr-dpms)
[516.821730] Starting subtest: fbc-pr-dpms
[516.826245] Subtest fbc-pr-dpms: SKIP (0.000s)
[516.894132] [087/130] (508s left) i915_selftest (perf)
[518.872556] Starting subtest: perf
[518.875307] Starting dynamic subtest: engine_cs
[523.264660] Dynamic subtest engine_cs: SUCCESS (4.393s)
[523.273576] Starting dynamic subtest: request
[530.626265] Dynamic subtest request: SUCCESS (7.361s)
[530.635660] Starting dynamic subtest: migrate
[535.082415] Dynamic subtest migrate: SUCCESS (4.455s)
[535.092086] Starting dynamic subtest: region
[541.027394] Dynamic subtest region: SUCCESS (5.943s)
[541.030225] Subtest perf: SUCCESS (22.158s)
[541.057930] [FACT i915_selftest (perf)] deleted: kernel.kmod_is_loaded.i915: true
[541.061173] [088/130] (484s left) kms_psr (psr-primary-blt)
[542.497433] Starting subtest: psr-primary-blt
[542.499736] Starting dynamic subtest: eDP-1
[544.251370] Dynamic subtest eDP-1: SUCCESS (1.753s)
[544.253678] Subtest psr-primary-blt: SUCCESS (1.754s)
[545.127426] [FACT kms_psr (psr-primary-blt)] new: kernel.kmod_is_loaded.i915: true
[545.131764] [089/130] (480s left) kms_sequence (get-idle)
[545.226531] Starting subtest: get-idle
[545.228856] Starting dynamic subtest: pipe-A-eDP-1
[547.021689] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.792s)
[547.033849] Starting dynamic subtest: pipe-B-eDP-1
[549.486071] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.465s)
[549.495435] Starting dynamic subtest: pipe-C-eDP-1
[551.897834] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.408s)
[551.907539] Starting dynamic subtest: pipe-D-eDP-1
[554.329171] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.430s)
[554.331109] Subtest get-idle: SUCCESS (9.100s)
[555.136640] [090/130] (470s left) kms_flip (single-buffer-flip-vs-dpms-off-vs-modeset-interruptible)
[555.242077] Starting subtest: single-buffer-flip-vs-dpms-off-vs-modeset-interruptible
[555.244325] Starting dynamic subtest: A-eDP1
[558.781071] Dynamic subtest A-eDP1: SUCCESS (3.536s)
[558.789616] Starting dynamic subtest: B-eDP1
[561.870430] Dynamic subtest B-eDP1: SUCCESS (3.086s)
[561.879207] Starting dynamic subtest: C-eDP1
[564.975235] Dynamic subtest C-eDP1: SUCCESS (3.106s)
[564.987083] Starting dynamic subtest: D-eDP1
[568.065662] Dynamic subtest D-eDP1: SUCCESS (3.089s)
[568.068049] Subtest single-buffer-flip-vs-dpms-off-vs-modeset-interruptible: SUCCESS (12.824s)
[568.857697] [091/130] (456s left) gem_workarounds (basic-read-fd)
[568.930022] Starting subtest: basic-read-fd
[568.941082] Subtest basic-read-fd: SUCCESS (0.011s)
[569.065335] [092/130] (456s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-render)
[569.156774] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-render
[576.458422] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-render: SUCCESS (7.305s)
[576.595500] [093/130] (449s left) prime_busy (after-wait)
[576.658382] Starting subtest: after-wait
[576.663404] Starting dynamic subtest: rcs0
[576.713452] Dynamic subtest rcs0: SUCCESS (0.051s)
[576.724136] Starting dynamic subtest: bcs0
[576.788940] Dynamic subtest bcs0: SUCCESS (0.075s)
[576.800063] Starting dynamic subtest: vcs0
[576.828655] Dynamic subtest vcs0: SUCCESS (0.040s)
[576.837924] Starting dynamic subtest: vcs1
[576.870572] Dynamic subtest vcs1: SUCCESS (0.041s)
[576.879778] Starting dynamic subtest: vecs0
[576.910814] Dynamic subtest vecs0: SUCCESS (0.040s)
[576.920205] Starting dynamic subtest: ccs0
[576.950232] Dynamic subtest ccs0: SUCCESS (0.039s)
[577.059287] Subtest after-wait: SUCCESS (0.398s)
[577.131748] [094/130] (448s left) gem_sync (basic-store-all)
[577.211137] Starting subtest: basic-store-all
[580.089004] Subtest basic-store-all: SUCCESS (2.888s)
[580.271216] [095/130] (445s left) gem_exec_balancer (bonded-true-hang)
[580.520740] Starting subtest: bonded-true-hang
[580.525542] Subtest bonded-true-hang: SKIP (0.000s)
[580.630027] [096/130] (445s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-mmap-cpu)
[580.742504] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-mmap-cpu
[585.007193] Subtest fbc-1p-primscrn-pri-indfb-draw-mmap-cpu: SUCCESS (4.269s)
[586.136440] [097/130] (439s left) gem_mmap_gtt (bad-object)
[586.193690] Subtest bad-object: SKIP (0.000s)
[586.260526] [098/130] (439s left) kms_flip (flip-vs-wf_vblank-interruptible)
[586.348525] Starting subtest: flip-vs-wf_vblank-interruptible
[586.350924] Starting dynamic subtest: A-eDP1
[588.279258] Dynamic subtest A-eDP1: SUCCESS (1.930s)
[588.289604] Starting dynamic subtest: B-eDP1
[590.208637] Dynamic subtest B-eDP1: SUCCESS (1.928s)
[590.219683] Starting dynamic subtest: C-eDP1
[592.127975] Dynamic subtest C-eDP1: SUCCESS (1.918s)
[592.137901] Starting dynamic subtest: D-eDP1
[593.974673] Dynamic subtest D-eDP1: SUCCESS (1.845s)
[593.977077] Subtest flip-vs-wf_vblank-interruptible: SUCCESS (7.629s)
[595.193712] [099/130] (430s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-mmap-cpu)
[595.303243] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-mmap-cpu
[595.307570] Subtest psr-2p-scndscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[595.425044] [100/130] (430s left) kms_big_fb (x-tiled-16bpp-rotate-270)
[595.534537] Starting subtest: x-tiled-16bpp-rotate-270
[595.553237] Subtest x-tiled-16bpp-rotate-270: SKIP (0.018s)
[595.689280] [101/130] (430s left) kms_cursor_legacy (basic-flip-after-cursor-varying-size)
[595.804541] Starting subtest: basic-flip-after-cursor-varying-size
[596.742374] Subtest basic-flip-after-cursor-varying-size: SUCCESS (0.934s)
[597.539645] [102/130] (428s left) gem_render_copy (mixed-tiled-to-y-tiled-ccs)
[597.601732] Starting subtest: mixed-tiled-to-y-tiled-ccs
[597.606402] Subtest mixed-tiled-to-y-tiled-ccs: SKIP (0.000s)
[597.780776] [103/130] (428s left) gem_softpin (allocator-nopin-reserve)
[597.842451] Starting subtest: allocator-nopin-reserve
[597.933516] Subtest allocator-nopin-reserve: SUCCESS (0.091s)
[598.082281] [104/130] (428s left) gem_ctx_param (invalid-size-get)
[598.137256] Starting subtest: invalid-size-get
[598.139663] Subtest invalid-size-get: SUCCESS (0.001s)
[598.251603] [105/130] (428s left) kms_psr (psr-sprite-mmap-gtt)
[598.348640] Starting subtest: psr-sprite-mmap-gtt
[598.351002] Starting dynamic subtest: eDP-1
[599.779611] Dynamic subtest eDP-1: SKIP (1.425s)
[599.784213] Subtest psr-sprite-mmap-gtt: SKIP (1.426s)
[599.942382] [106/130] (426s left) kms_color (legacy-gamma)
[600.043692] Starting subtest: legacy-gamma
[600.046074] Starting dynamic subtest: pipe-A-eDP-1
[600.761865] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.716s)
[600.771625] Starting dynamic subtest: pipe-B-eDP-1
[602.178392] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.417s)
[602.189801] Starting dynamic subtest: pipe-C-eDP-1
[603.527141] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.345s)
[603.536708] Starting dynamic subtest: pipe-D-eDP-1
[604.878913] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.352s)
[604.881302] Subtest legacy-gamma: SUCCESS (4.834s)
[605.700190] [107/130] (420s left) i915_drm_fdinfo (isolation)
[605.738440] Starting subtest: isolation
[605.740304] Starting dynamic subtest: rcs0
[605.770126] Dynamic subtest rcs0: SKIP (0.031s)
[605.780121] Starting dynamic subtest: bcs0
[605.784204] Dynamic subtest bcs0: SKIP (0.000s)
[605.792790] Starting dynamic subtest: vcs0
[605.796950] Dynamic subtest vcs0: SKIP (0.000s)
[605.805216] Starting dynamic subtest: vcs1
[605.809400] Dynamic subtest vcs1: SKIP (0.000s)
[605.819854] Starting dynamic subtest: vecs0
[605.823938] Dynamic subtest vecs0: SKIP (0.000s)
[605.832307] Starting dynamic subtest: ccs0
[605.836427] Dynamic subtest ccs0: SKIP (0.000s)
[605.840534] Subtest isolation: SKIP (0.035s)
[605.875019] [108/130] (420s left) gem_tiled_fence_blits (basic)
[605.928484] Subtest basic: SKIP (0.000s)
[605.994243] [109/130] (420s left) syncobj_timeline (invalid-transfer-illegal-handle)
[606.038898] Starting subtest: invalid-transfer-illegal-handle
[606.040841] Subtest invalid-transfer-illegal-handle: SUCCESS (0.000s)
[606.154336] [110/130] (420s left) kms_ccs (bad-rotation-90-y-tiled-ccs)
[606.241563] Starting subtest: bad-rotation-90-y-tiled-ccs
[606.243871] Starting dynamic subtest: pipe-A-eDP-1
[606.266454] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[606.277503] Starting dynamic subtest: pipe-B-eDP-1
[606.298501] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[606.307092] Starting dynamic subtest: pipe-C-eDP-1
[606.327916] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[606.336937] Starting dynamic subtest: pipe-D-eDP-1
[606.358505] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[606.362791] Subtest bad-rotation-90-y-tiled-ccs: SKIP (0.004s)
[608.493462] [111/130] (418s left) syncobj_timeline (multi-wait-for-submit-available-submitted)
[608.544540] Starting subtest: multi-wait-for-submit-available-submitted
[608.546487] Subtest multi-wait-for-submit-available-submitted: SUCCESS (0.000s)
[608.655119] [112/130] (418s left) api_intel_allocator (default-alignment)
[608.707564] Starting subtest: default-alignment
[608.709702] Subtest default-alignment: SUCCESS (0.003s)
[608.830641] [113/130] (417s left) kms_chamelium_hpd (hdmi-hpd-after-suspend)
[609.221416] Subtest hdmi-hpd-after-suspend: SKIP (0.000s)
[610.009387] [114/130] (416s left) kms_content_protection (type1)
[610.150995] Starting subtest: type1
[613.579844] Subtest type1: SKIP (3.426s)
[614.752513] [115/130] (412s left) kms_plane_lowres (tiling-x)
[614.847926] Starting subtest: tiling-x
[614.850417] Starting dynamic subtest: pipe-A-eDP-1
[614.855051] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[615.147732] Starting dynamic subtest: pipe-B-eDP-1
[615.152115] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[615.160742] Starting dynamic subtest: pipe-C-eDP-1
[615.165189] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[615.174179] Starting dynamic subtest: pipe-D-eDP-1
[615.178529] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[615.182733] Subtest tiling-x: SKIP (0.297s)
[615.994235] [116/130] (410s left) gem_exec_params (invalid-batch-start-offset)
[616.057317] Starting subtest: invalid-batch-start-offset
[616.059602] Subtest invalid-batch-start-offset: SUCCESS (0.002s)
[616.171496] [117/130] (410s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-mmap-gtt)
[616.262170] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-mmap-gtt
[616.266381] Subtest psr-2p-scndscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[616.357485] [118/130] (410s left) kms_frontbuffer_tracking (fbcpsr-tiling-y)
[616.456423] Starting subtest: fbcpsr-tiling-y
[616.460472] Subtest fbcpsr-tiling-y: SKIP (0.000s)
[616.565275] [119/130] (410s left) gem_exec_balancer (hog)
[616.625953] Starting subtest: hog
[616.630650] Subtest hog: SKIP (0.000s)
[616.932742] [120/130] (410s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-180)
[617.036407] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-180
[618.004397] Subtest x-tiled-max-hw-stride-64bpp-rotate-180: SUCCESS (0.966s)
[618.145954] [121/130] (408s left) gem_exec_capture (pi)
[618.205585] Starting subtest: pi
[618.208065] Starting dynamic subtest: rcs0
[622.526400] Dynamic subtest rcs0: SUCCESS (4.319s)
[622.539161] Starting dynamic subtest: bcs0
[626.452050] Dynamic subtest bcs0: SUCCESS (3.923s)
[626.464054] Starting dynamic subtest: vcs0
[630.318945] Dynamic subtest vcs0: SUCCESS (3.864s)
[630.332043] Starting dynamic subtest: vcs1
[634.198282] Dynamic subtest vcs1: SUCCESS (3.877s)
[634.210176] Starting dynamic subtest: vecs0
[638.042425] Dynamic subtest vecs0: SUCCESS (3.842s)
[638.054813] Starting dynamic subtest: ccs0
[642.005134] Dynamic subtest ccs0: SUCCESS (3.960s)
[642.007634] Subtest pi: SUCCESS (23.796s)
[642.087430] [122/130] (384s left) gem_pwrite (basic-self)
[642.202108] Subtest basic-self: SKIP (0.000s)
[642.262708] [123/130] (384s left) kms_rotation_crc (primary-rotation-180)
[642.361094] Starting subtest: primary-rotation-180
[649.260438] Subtest primary-rotation-180: SUCCESS (6.896s)
[650.453955] [124/130] (376s left) gem_exec_whisper (basic-queues)
[650.526121] Starting subtest: basic-queues
[656.547304] Subtest basic-queues: SUCCESS (6.016s)
[656.725453] [125/130] (370s left) kms_flip (flip-vs-expired-vblank)
[656.831526] Starting subtest: flip-vs-expired-vblank
[656.833775] Starting dynamic subtest: A-eDP1
[665.559510] Dynamic subtest A-eDP1: SUCCESS (8.725s)
[665.570110] Starting dynamic subtest: B-eDP1
[674.187074] Dynamic subtest B-eDP1: SUCCESS (8.625s)
[674.198285] Starting dynamic subtest: C-eDP1
[682.810995] Dynamic subtest C-eDP1: SUCCESS (8.622s)
[682.821417] Starting dynamic subtest: D-eDP1
[691.439487] Dynamic subtest D-eDP1: SUCCESS (8.625s)
[691.444974] Subtest flip-vs-expired-vblank: SUCCESS (34.606s)
[692.602885] [126/130] (334s left) gem_eio (wait-wedge-immediate)
[692.831182] Starting subtest: wait-wedge-immediate
[694.668572] Subtest wait-wedge-immediate: SUCCESS (1.836s)
[694.818899] [127/130] (332s left) kms_ccs (bad-pixel-format-y-tiled-gen12-rc-ccs-cc)
[694.900410] Starting subtest: bad-pixel-format-y-tiled-gen12-rc-ccs-cc
[694.902760] Starting dynamic subtest: pipe-A-eDP-1
[694.935726] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[694.944986] Starting dynamic subtest: pipe-B-eDP-1
[694.966631] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[694.975856] Starting dynamic subtest: pipe-C-eDP-1
[694.997471] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[695.006610] Starting dynamic subtest: pipe-D-eDP-1
[695.028435] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[695.032738] Subtest bad-pixel-format-y-tiled-gen12-rc-ccs-cc: SKIP (0.004s)
[697.081177] [128/130] (330s left) kms_psr (pr-no-drrs)
[697.175625] Starting subtest: pr-no-drrs
[697.180096] Subtest pr-no-drrs: SKIP (0.000s)
[697.242515] [129/130] (330s left) kms_big_fb (y-tiled-8bpp-rotate-90)
[697.352643] Starting subtest: y-tiled-8bpp-rotate-90
[697.356909] Subtest y-tiled-8bpp-rotate-90: SKIP (0.000s)
[697.458805] [130/130] (329s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-pwrite)
[697.558118] Starting subtest: fbcpsr-rgb565-draw-pwrite
[704.455980] Subtest fbcpsr-rgb565-draw-pwrite: SUCCESS (6.905s)
[704.578417] 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.