[51.985340] Initializing watchdogs
[51.985384]   /dev/watchdog0
[51.999141] [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]
[52.003589] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[52.005678] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[52.008991] [001/132] (960s left) kms_atomic_transition (plane-all-modeset-transition-fencing)
[52.125381] Starting subtest: plane-all-modeset-transition-fencing
[52.129811] Subtest plane-all-modeset-transition-fencing: SKIP (0.000s)
[52.192711] [002/132] (960s left) gem_exec_flush (basic-wb-prw-default)
[52.255998] Starting subtest: basic-wb-prw-default
[57.633486] Subtest basic-wb-prw-default: SUCCESS (5.453s)
[57.817926] [003/132] (954s left) kms_frontbuffer_tracking (fbc-2p-indfb-fliptrack-mmap-gtt)
[57.919209] Starting subtest: fbc-2p-indfb-fliptrack-mmap-gtt
[57.923224] Subtest fbc-2p-indfb-fliptrack-mmap-gtt: SKIP (0.000s)
[58.017772] [004/132] (954s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-blt)
[58.124092] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-blt
[64.899233] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-blt: SUCCESS (6.817s)
[65.033306] [005/132] (947s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-32bpp-ytileccs-upscaling)
[65.121144] Starting subtest: flip-32bpp-ytile-to-32bpp-ytileccs-upscaling
[65.125172] Subtest flip-32bpp-ytile-to-32bpp-ytileccs-upscaling: SKIP (0.000s)
[65.187895] [006/132] (947s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip)
[65.282395] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip
[65.948593] Subtest x-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip: SUCCESS (0.670s)
[66.119211] [007/132] (946s left) gem_mmap_gtt (basic-short)
[66.166151] Subtest basic-short: SKIP (0.000s)
[66.230758] [008/132] (946s left) kms_content_protection (lic-type-1)
[66.364443] Starting subtest: lic-type-1
[66.369233] Subtest lic-type-1: SKIP (0.000s)
[66.477544] [009/132] (946s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-mmap-cpu)
[66.573585] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-mmap-cpu
[66.578305] Subtest fbc-2p-scndscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[66.668759] [010/132] (946s left) kms_atomic_transition (modeset-transition-nonblocking-fencing)
[66.806874] Starting subtest: modeset-transition-nonblocking-fencing
[66.808819] Starting dynamic subtest: 1x-outputs
[77.600115] Dynamic subtest 1x-outputs: SUCCESS (10.811s)
[77.602687] Subtest modeset-transition-nonblocking-fencing: SUCCESS (10.813s)
[78.456323] [011/132] (934s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-mmap-wc)
[78.567446] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-mmap-wc
[85.620316] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-mmap-wc: SUCCESS (7.055s)
[85.741584] [012/132] (927s left) kms_flip (2x-plain-flip)
[85.833194] Starting subtest: 2x-plain-flip
[85.841771] Subtest 2x-plain-flip: SKIP (0.010s)
[85.925924] [013/132] (927s left) api_intel_allocator (two-level-inception)
[85.976815] Starting subtest: two-level-inception
[91.383206] Subtest two-level-inception: SUCCESS (5.407s)
[91.526682] [014/132] (921s left) kms_chamelium_edid (hdmi-mode-timings)
[91.929064] Subtest hdmi-mode-timings: SKIP (0.000s)
[92.700228] [015/132] (920s left) gem_exec_schedule (noreorder-priority)
[92.878086] Starting subtest: noreorder-priority
[92.881076] Starting dynamic subtest: rcs0
[94.008961] Dynamic subtest rcs0: SUCCESS (1.132s)
[94.019371] Starting dynamic subtest: vcs0
[95.892294] Dynamic subtest vcs0: SUCCESS (1.881s)
[95.903089] Starting dynamic subtest: vcs1
[97.930062] Dynamic subtest vcs1: SUCCESS (2.036s)
[97.941268] Starting dynamic subtest: vecs0
[99.926069] Dynamic subtest vecs0: SUCCESS (1.996s)
[99.935877] Starting dynamic subtest: ccs0
[101.066702] Dynamic subtest ccs0: SUCCESS (1.141s)
[101.069151] Subtest noreorder-priority: SUCCESS (8.190s)
[101.248824] [016/132] (911s left) kms_psr (fbc-psr-no-drrs)
[101.359946] Starting subtest: fbc-psr-no-drrs
[101.362221] Starting dynamic subtest: eDP-1
[101.366568] Dynamic subtest eDP-1: SKIP (0.000s)
[101.370956] Subtest fbc-psr-no-drrs: SKIP (0.000s)
[101.439458] [017/132] (911s left) kms_feature_discovery (display-1x)
[101.527730] Starting subtest: display-1x
[101.529983] Subtest display-1x: SUCCESS (0.000s)
[101.595788] [018/132] (911s left) kms_dirtyfb (fbc-dirtyfb-ioctl)
[101.686662] Starting subtest: fbc-dirtyfb-ioctl
[101.688845] Starting dynamic subtest: A-eDP-1
[104.281852] Dynamic subtest A-eDP-1: SUCCESS (2.594s)
[104.284188] Subtest fbc-dirtyfb-ioctl: SUCCESS (2.594s)
[105.074097] [019/132] (908s left) gem_exec_fence (submit)
[105.255664] Starting subtest: submit
[105.260405] Subtest submit: SKIP (0.000s)
[106.990845] [FACT gem_exec_fence (submit)] new: kernel.kmod_is_loaded.vgem: true
[106.994533] [020/132] (906s left) gem_ctx_engines (independent)
[107.061080] Starting subtest: independent
[107.063474] Starting dynamic subtest: rcs0
[107.220460] Dynamic subtest rcs0: SUCCESS (0.160s)
[107.230542] Starting dynamic subtest: bcs0
[107.361568] Dynamic subtest bcs0: SUCCESS (0.140s)
[107.372076] Starting dynamic subtest: vcs0
[107.494769] Dynamic subtest vcs0: SUCCESS (0.134s)
[107.501932] Starting dynamic subtest: vcs1
[107.649957] Dynamic subtest vcs1: SUCCESS (0.155s)
[107.661036] Starting dynamic subtest: vecs0
[107.874776] Dynamic subtest vecs0: SUCCESS (0.223s)
[107.882280] Starting dynamic subtest: ccs0
[108.095502] Dynamic subtest ccs0: SUCCESS (0.220s)
[108.106856] Starting dynamic subtest: all-engines
[108.969584] Dynamic subtest all-engines: SUCCESS (0.874s)
[108.971516] Subtest independent: SUCCESS (1.910s)
[110.978937] [021/132] (902s left) kms_psr (fbc-psr2-cursor-blt)
[111.083878] Starting subtest: fbc-psr2-cursor-blt
[111.086303] Starting dynamic subtest: eDP-1
[111.090467] Dynamic subtest eDP-1: SKIP (0.000s)
[111.094737] Subtest fbc-psr2-cursor-blt: SKIP (0.000s)
[111.155700] [022/132] (902s left) kms_color (ctm-red-to-blue)
[111.248827] Starting subtest: ctm-red-to-blue
[111.250773] Starting dynamic subtest: pipe-A-eDP-1
[111.958510] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.709s)
[111.967389] Starting dynamic subtest: pipe-B-eDP-1
[113.394459] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.438s)
[113.402894] Starting dynamic subtest: pipe-C-eDP-1
[114.773457] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.378s)
[114.780939] Starting dynamic subtest: pipe-D-eDP-1
[116.095801] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.321s)
[116.098627] Subtest ctm-red-to-blue: SUCCESS (4.847s)
[116.903789] [023/132] (896s left) kms_plane_scaling (planes-downscale-factor-0-75-upscale-20x20)
[117.008424] Starting subtest: planes-downscale-factor-0-75-upscale-20x20
[117.010925] Starting dynamic subtest: pipe-A
[117.070547] Dynamic subtest pipe-A: SUCCESS (0.065s)
[117.078447] Starting dynamic subtest: pipe-B
[118.229725] Dynamic subtest pipe-B: SUCCESS (1.158s)
[118.240640] Starting dynamic subtest: pipe-C
[119.330691] Dynamic subtest pipe-C: SUCCESS (1.100s)
[119.339762] Starting dynamic subtest: pipe-D
[120.475429] Dynamic subtest pipe-D: SUCCESS (1.144s)
[120.477768] Subtest planes-downscale-factor-0-75-upscale-20x20: SUCCESS (3.470s)
[121.622871] [024/132] (891s left) perf_pmu (most-busy-check-all)
[121.667284] Starting subtest: most-busy-check-all
[121.669155] Starting dynamic subtest: rcs0
[122.900867] Dynamic subtest rcs0: SUCCESS (1.233s)
[122.912717] Starting dynamic subtest: bcs0
[124.885352] Dynamic subtest bcs0: SUCCESS (1.983s)
[124.896820] Starting dynamic subtest: vcs0
[126.932992] Dynamic subtest vcs0: SUCCESS (2.046s)
[126.944293] Starting dynamic subtest: vcs1
[128.916874] Dynamic subtest vcs1: SUCCESS (1.983s)
[128.928335] Starting dynamic subtest: vecs0
[130.900868] Dynamic subtest vecs0: SUCCESS (1.983s)
[130.912783] Starting dynamic subtest: ccs0
[132.885125] Dynamic subtest ccs0: SUCCESS (1.983s)
[132.888078] Subtest most-busy-check-all: SUCCESS (11.218s)
[133.003923] [025/132] (880s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-cpu)
[133.100758] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-cpu
[133.105424] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[133.197903] [026/132] (880s left) gem_mmap (bad-size)
[133.252722] Subtest bad-size: SKIP (0.000s)
[133.321968] [027/132] (880s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-move)
[133.416520] Starting subtest: fbc-2p-primscrn-spr-indfb-move
[133.421093] Subtest fbc-2p-primscrn-spr-indfb-move: SKIP (0.000s)
[133.540766] [028/132] (880s left) gem_exec_reloc (basic-write-cpu)
[133.601978] Subtest basic-write-cpu: SKIP (0.000s)
[133.675665] [029/132] (879s left) kms_invalid_mode (bad-htotal)
[133.774798] Starting subtest: bad-htotal
[133.777185] Starting dynamic subtest: pipe-A-eDP-1
[134.067861] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.295s)
[134.079668] Starting dynamic subtest: pipe-B-eDP-1
[134.081737] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[134.089889] Starting dynamic subtest: pipe-C-eDP-1
[134.092369] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[134.100195] Starting dynamic subtest: pipe-D-eDP-1
[134.102561] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[134.104865] Subtest bad-htotal: SUCCESS (0.300s)
[134.861507] [030/132] (878s left) kms_flip (wf_vblank-ts-check)
[134.960327] Starting subtest: wf_vblank-ts-check
[134.962470] Starting dynamic subtest: A-eDP1
[143.906893] Dynamic subtest A-eDP1: SUCCESS (8.950s)
[143.915468] Starting dynamic subtest: B-eDP1
[152.843519] Dynamic subtest B-eDP1: SUCCESS (8.935s)
[152.851736] Starting dynamic subtest: C-eDP1
[161.762771] Dynamic subtest C-eDP1: SUCCESS (8.916s)
[161.772294] Starting dynamic subtest: D-eDP1
[170.688328] Dynamic subtest D-eDP1: SUCCESS (8.923s)
[170.690818] Subtest wf_vblank-ts-check: SUCCESS (35.733s)
[171.915690] [031/132] (841s left) kms_psr (psr-sprite-mmap-gtt)
[171.997271] Starting subtest: psr-sprite-mmap-gtt
[171.999535] Starting dynamic subtest: eDP-1
[173.449803] Dynamic subtest eDP-1: SKIP (1.449s)
[173.454898] Subtest psr-sprite-mmap-gtt: SKIP (1.450s)
[173.608346] [032/132] (840s left) perf (invalid-oa-metric-set-id)
[173.756780] Starting subtest: invalid-oa-metric-set-id
[173.767913] Subtest invalid-oa-metric-set-id: SUCCESS (0.010s)
[173.814845] [033/132] (839s left) gem_ctx_sseu (invalid-sseu)
[173.889735] Subtest invalid-sseu: SKIP (0.000s)
[173.947602] [034/132] (839s left) gem_exec_params (invalid-batch-start-offset)
[174.018086] Starting subtest: invalid-batch-start-offset
[174.020390] Subtest invalid-batch-start-offset: SUCCESS (0.002s)
[174.142662] [035/132] (839s left) gem_close (many-handles-one-vma)
[174.204500] Starting subtest: many-handles-one-vma
[174.227923] Subtest many-handles-one-vma: SUCCESS (0.024s)
[174.315326] [036/132] (839s left) kms_cursor_crc (cursor-offscreen-256x256)
[174.563845] Starting subtest: cursor-offscreen-256x256
[174.568278] Starting dynamic subtest: pipe-A-eDP-1
[176.505587] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.937s)
[176.538696] Starting dynamic subtest: pipe-D-eDP-1
[179.056430] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.527s)
[179.058418] Subtest cursor-offscreen-256x256: SUCCESS (4.490s)
[179.926848] [037/132] (833s left) gem_exec_reloc (basic-cpu-gtt-active)
[179.984413] Subtest basic-cpu-gtt-active: SKIP (0.000s)
[180.056392] [038/132] (833s left) gem_ctx_param (basic-default)
[180.104740] Starting subtest: basic-default
[180.107155] Subtest basic-default: SUCCESS (0.000s)
[180.171282] [039/132] (833s left) kms_ccs (ccs-on-another-bo-4-tiled-mtl-rc-ccs-cc)
[180.260136] Starting subtest: ccs-on-another-bo-4-tiled-mtl-rc-ccs-cc
[180.262420] Starting dynamic subtest: pipe-A-eDP-1
[180.282352] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[180.291344] Starting dynamic subtest: pipe-B-eDP-1
[180.310410] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[180.317848] Starting dynamic subtest: pipe-C-eDP-1
[180.337210] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[180.346941] Starting dynamic subtest: pipe-D-eDP-1
[180.365896] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[180.367777] Subtest ccs-on-another-bo-4-tiled-mtl-rc-ccs-cc: SUCCESS (0.007s)
[182.586766] [040/132] (831s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-blt)
[182.690319] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-blt
[182.694378] Subtest fbc-2p-scndscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[182.787435] [041/132] (831s left) prime_busy (hang-wait)
[182.847189] Starting subtest: hang-wait
[182.849322] Starting dynamic subtest: rcs0
[209.397619] Dynamic subtest rcs0: SUCCESS (26.548s)
[209.405152] Starting dynamic subtest: bcs0
[216.482443] Dynamic subtest bcs0: SUCCESS (7.082s)
[216.492427] Starting dynamic subtest: vcs0
[223.522096] Dynamic subtest vcs0: SUCCESS (7.039s)
[223.531806] Starting dynamic subtest: vcs1
[230.496598] Dynamic subtest vcs1: SUCCESS (6.973s)
[230.504202] Starting dynamic subtest: vecs0
[237.536354] Dynamic subtest vecs0: SUCCESS (7.039s)
[237.546890] Starting dynamic subtest: ccs0
[251.370885] Dynamic subtest ccs0: SUCCESS (13.835s)
[251.373820] Subtest hang-wait: SUCCESS (68.524s)
[251.511479] [042/132] (762s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-mmap-wc)
[251.615424] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-mmap-wc
[251.619549] Subtest psr-2p-scndscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[251.720844] [043/132] (762s left) kms_psr (pr-sprite-mmap-cpu)
[251.806960] Starting subtest: pr-sprite-mmap-cpu
[251.811107] Subtest pr-sprite-mmap-cpu: SKIP (0.000s)
[251.877745] [044/132] (762s left) gem_busy (close-race)
[251.940085] Starting subtest: close-race
[277.909280] Subtest close-race: SUCCESS (25.966s)
[278.277315] [045/132] (735s left) syncobj_wait (reset-multiple-signaled)
[278.377187] Starting subtest: reset-multiple-signaled
[278.379573] Subtest reset-multiple-signaled: SUCCESS (0.000s)
[278.477820] [046/132] (735s left) gem_ctx_isolation (dirty-create)
[278.537956] Starting subtest: dirty-create
[278.540541] Starting dynamic subtest: rcs0
[278.770565] Dynamic subtest rcs0: SUCCESS (0.232s)
[278.781579] Starting dynamic subtest: bcs0
[279.015023] Dynamic subtest bcs0: SUCCESS (0.244s)
[279.024508] Starting dynamic subtest: vcs0
[279.244090] Dynamic subtest vcs0: SUCCESS (0.229s)
[279.254425] Starting dynamic subtest: vcs1
[281.128695] Dynamic subtest vcs1: SUCCESS (1.883s)
[281.137663] Starting dynamic subtest: vecs0
[283.086263] Dynamic subtest vecs0: SUCCESS (1.956s)
[283.094596] Starting dynamic subtest: ccs0
[285.170513] Dynamic subtest ccs0: SUCCESS (2.084s)
[285.172828] Subtest dirty-create: SUCCESS (6.633s)
[285.392227] [047/132] (728s left) kms_ccs (bad-pixel-format-yf-tiled-ccs)
[285.490093] Starting subtest: bad-pixel-format-yf-tiled-ccs
[285.492491] Starting dynamic subtest: pipe-A-eDP-1
[285.516294] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[285.526278] Starting dynamic subtest: pipe-B-eDP-1
[285.547740] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[285.555550] Starting dynamic subtest: pipe-C-eDP-1
[285.576748] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[285.585881] Starting dynamic subtest: pipe-D-eDP-1
[285.607256] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[285.611635] Subtest bad-pixel-format-yf-tiled-ccs: SKIP (0.003s)
[287.728916] [048/132] (726s left) gem_exec_params (secure-non-root)
[287.793018] Starting subtest: secure-non-root
[287.797899] Subtest secure-non-root: SKIP (0.000s)
[287.915996] [049/132] (726s left) gem_basic (bad-close)
[287.962730] Starting subtest: bad-close
[287.967399] Subtest bad-close: SUCCESS (0.000s)
[288.065739] [050/132] (726s left) perf_pmu (invalid-init)
[288.104297] Starting subtest: invalid-init
[288.106512] Subtest invalid-init: SUCCESS (0.000s)
[288.224318] [051/132] (726s left) api_intel_bb (object-noreloc-keep-cache-simple)
[288.292060] Starting subtest: object-noreloc-keep-cache-simple
[288.298626] Subtest object-noreloc-keep-cache-simple: SUCCESS (0.007s)
[288.415347] [052/132] (726s left) kms_big_fb (x-tiled-64bpp-rotate-0)
[288.516147] Starting subtest: x-tiled-64bpp-rotate-0
[290.063852] Subtest x-tiled-64bpp-rotate-0: SUCCESS (1.547s)
[290.225468] [053/132] (724s left) gem_render_copy (y-tiled)
[290.280387] Starting subtest: y-tiled
[290.284828] Subtest y-tiled: SKIP (0.000s)
[290.462125] [054/132] (724s left) kms_frontbuffer_tracking (psr-rgb101010-draw-blt)
[290.556909] Starting subtest: psr-rgb101010-draw-blt
[297.819840] Subtest psr-rgb101010-draw-blt: SUCCESS (7.267s)
[297.934115] [055/132] (716s left) kms_lease (invalid-create-leases)
[298.032976] Starting subtest: invalid-create-leases
[298.035777] Subtest invalid-create-leases: SUCCESS (0.005s)
[298.157085] [056/132] (716s left) gem_exec_balancer (parallel-bb-first)
[298.409058] Starting subtest: parallel-bb-first
[299.328733] Subtest parallel-bb-first: SUCCESS (0.920s)
[299.964952] [057/132] (714s left) gem_exec_params (dr1-dirt)
[300.026647] Starting subtest: DR1-dirt
[300.029130] Subtest DR1-dirt: SUCCESS (0.000s)
[300.129511] [058/132] (714s left) kms_pipe_crc_basic (disable-crc-after-crtc)
[300.213663] Starting subtest: disable-crc-after-crtc
[300.216061] Starting dynamic subtest: pipe-A-eDP-1
[301.914467] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.702s)
[301.923062] Starting dynamic subtest: pipe-B-eDP-1
[304.281324] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.365s)
[304.290470] Starting dynamic subtest: pipe-C-eDP-1
[306.543760] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.260s)
[306.552948] Starting dynamic subtest: pipe-D-eDP-1
[308.781964] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.237s)
[308.784384] Subtest disable-crc-after-crtc: SUCCESS (8.570s)
[309.614331] [059/132] (705s left) gem_mmap_gtt (pf-nonblock)
[309.667692] Subtest pf-nonblock: SKIP (0.000s)
[309.723898] [060/132] (705s left) gem_userptr_blits (nohangcheck)
[309.793270] Starting subtest: nohangcheck
[310.038083] Subtest nohangcheck: SUCCESS (0.244s)
[310.162041] [061/132] (704s left) kms_psr (psr-cursor-plane-onoff)
[310.257312] Starting subtest: psr-cursor-plane-onoff
[310.259575] Starting dynamic subtest: eDP-1
[312.008351] Dynamic subtest eDP-1: SUCCESS (1.750s)
[312.010336] Subtest psr-cursor-plane-onoff: SUCCESS (1.752s)
[312.879088] [062/132] (702s left) kms_pm_dc (dc9-dpms)
[313.977148] Starting subtest: dc9-dpms
[315.431684] Subtest dc9-dpms: SUCCESS (1.455s)
[315.504082] [063/132] (699s left) gem_pxp (fail-invalid-protected-context)
[315.621854] Starting subtest: fail-invalid-protected-context
[315.624719] Subtest fail-invalid-protected-context: SUCCESS (0.000s)
[315.737705] [064/132] (699s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-0)
[315.842944] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-0
[316.878085] Subtest 4-tiled-max-hw-stride-32bpp-rotate-0: SUCCESS (1.035s)
[317.013213] [065/132] (698s left) sysfs_preempt_timeout (timeout)
[317.080457] Starting subtest: timeout
[317.082196] Starting dynamic subtest: vecs0
[326.939093] Dynamic subtest vecs0: SUCCESS (9.859s)
[326.950728] Starting dynamic subtest: ccs0
[328.242496] Dynamic subtest ccs0: SUCCESS (1.299s)
[328.250971] Starting dynamic subtest: vcs0
[337.943223] Dynamic subtest vcs0: SUCCESS (9.693s)
[337.954526] Starting dynamic subtest: bcs0
[339.171564] Dynamic subtest bcs0: SUCCESS (1.233s)
[339.183635] Starting dynamic subtest: rcs0
[340.382135] Dynamic subtest rcs0: SUCCESS (1.209s)
[340.393234] Starting dynamic subtest: vcs1
[349.899270] Dynamic subtest vcs1: SUCCESS (9.513s)
[349.901806] Subtest timeout: SUCCESS (32.817s)
[349.976298] [066/132] (665s left) kms_frontbuffer_tracking (psr-1p-pri-indfb-multidraw)
[350.088284] Starting subtest: psr-1p-pri-indfb-multidraw
[372.489194] Subtest psr-1p-pri-indfb-multidraw: SUCCESS (22.404s)
[372.620500] [067/132] (642s left) kms_frontbuffer_tracking (psr-shrfb-scaledprimary)
[372.723396] Starting subtest: psr-shrfb-scaledprimary
[378.456576] Subtest psr-shrfb-scaledprimary: SUCCESS (5.734s)
[378.583486] [068/132] (636s left) kms_flip (flip-vs-suspend-interruptible)
[378.671991] Starting subtest: flip-vs-suspend-interruptible
[378.674292] Starting dynamic subtest: A-eDP1
[428.321283] Dynamic subtest A-eDP1: SUCCESS (4.671s)
[428.333759] Starting dynamic subtest: B-eDP1
[477.299230] Dynamic subtest B-eDP1: SUCCESS (4.591s)
[477.310786] Starting dynamic subtest: C-eDP1
[526.302273] Dynamic subtest C-eDP1: SUCCESS (4.520s)
[526.312644] Starting dynamic subtest: D-eDP1
[575.310948] Dynamic subtest D-eDP1: SUCCESS (4.531s)
[575.315793] Subtest flip-vs-suspend-interruptible: SUCCESS (18.322s)
[576.506643] [069/132] (438s left) i915_hangman (engine-engine-error)
[576.586664] Starting subtest: engine-engine-error
[576.588598] Starting dynamic subtest: rcs0
[578.498716] Dynamic subtest rcs0: SUCCESS (1.930s)
[578.511569] Starting dynamic subtest: bcs0
[580.479991] Dynamic subtest bcs0: SUCCESS (1.994s)
[580.492208] Starting dynamic subtest: vcs0
[582.528758] Dynamic subtest vcs0: SUCCESS (2.058s)
[582.540491] Starting dynamic subtest: vcs1
[584.511469] Dynamic subtest vcs1: SUCCESS (1.990s)
[584.524585] Starting dynamic subtest: vecs0
[586.496090] Dynamic subtest vecs0: SUCCESS (1.989s)
[586.508280] Starting dynamic subtest: ccs0
[588.482632] Dynamic subtest ccs0: SUCCESS (1.989s)
[588.485503] Subtest engine-engine-error: SUCCESS (11.966s)
[588.613540] [070/132] (426s left) gem_exec_reloc (basic-write-gtt)
[588.692207] Subtest basic-write-gtt: SKIP (0.000s)
[588.769664] [071/132] (426s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-render)
[588.870845] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-render
[588.875139] Subtest fbc-2p-primscrn-pri-indfb-draw-render: SKIP (0.000s)
[588.960216] [072/132] (426s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-0)
[589.070838] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-0
[589.075167] Subtest yf-tiled-max-hw-stride-32bpp-rotate-0: SKIP (0.000s)
[589.181300] [073/132] (426s left) kms_vblank (invalid)
[589.276504] Starting subtest: invalid
[589.278349] Starting dynamic subtest: pipe-A-eDP-1
[589.676518] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.400s)
[589.678667] Subtest invalid: SUCCESS (0.402s)
[590.578017] [074/132] (424s left) kms_flip (flip-vs-dpms-off-vs-modeset)
[590.681720] Starting subtest: flip-vs-dpms-off-vs-modeset
[590.683889] Starting dynamic subtest: A-eDP1
[594.287371] Dynamic subtest A-eDP1: SUCCESS (3.611s)
[594.297114] Starting dynamic subtest: B-eDP1
[597.494984] Dynamic subtest B-eDP1: SUCCESS (3.214s)
[597.505812] Starting dynamic subtest: C-eDP1
[600.589090] Dynamic subtest C-eDP1: SUCCESS (3.094s)
[600.603317] Starting dynamic subtest: D-eDP1
[603.710539] Dynamic subtest D-eDP1: SUCCESS (3.124s)
[603.712892] Subtest flip-vs-dpms-off-vs-modeset: SUCCESS (13.049s)
[604.514873] [075/132] (410s left) kms_frontbuffer_tracking (fbc-modesetfrombusy)
[604.622147] Starting subtest: fbc-modesetfrombusy
[608.348130] Subtest fbc-modesetfrombusy: SUCCESS (3.733s)
[609.537770] [076/132] (405s left) kms_big_fb (y-tiled-addfb-size-offset-overflow)
[609.648331] Starting subtest: y-tiled-addfb-size-offset-overflow
[609.652878] Subtest y-tiled-addfb-size-offset-overflow: SKIP (0.000s)
[609.782839] [077/132] (405s left) i915_query (engine-info)
[609.839120] Starting subtest: engine-info
[609.841395] Subtest engine-info: SUCCESS (0.005s)
[609.968609] [078/132] (405s left) gem_lmem_swapping (parallel-random-engines)
[610.018404] Subtest parallel-random-engines: SKIP (0.000s)
[610.106210] [079/132] (405s left) gem_render_copy (yf-tiled)
[610.167640] Starting subtest: yf-tiled
[610.172245] Subtest yf-tiled: SKIP (0.000s)
[610.363722] [080/132] (405s left) gem_softpin (safe-alignment)
[610.417530] Starting subtest: safe-alignment
[610.438711] Subtest safe-alignment: SUCCESS (0.021s)
[611.599299] [081/132] (404s left) perf (blocking)
[611.695408] Starting subtest: blocking
[611.697917] Starting dynamic subtest: 0-rcs0
[621.716329] Dynamic subtest 0-rcs0: SUCCESS (10.025s)
[621.733339] Starting dynamic subtest: 1-vecs0
[631.733316] Dynamic subtest 1-vecs0: SUCCESS (10.020s)
[631.735790] Subtest blocking: SUCCESS (20.048s)
[631.787807] [082/132] (384s left) kms_pm_rpm (modeset-lpsp)
[633.728411] Starting subtest: modeset-lpsp
[635.175485] Subtest modeset-lpsp: SUCCESS (1.447s)
[635.281045] [083/132] (380s left) syncobj_wait (single-wait-for-submit-unsubmitted)
[635.334219] Starting subtest: single-wait-for-submit-unsubmitted
[635.439849] Subtest single-wait-for-submit-unsubmitted: SUCCESS (0.106s)
[635.517446] [084/132] (380s left) kms_plane (pixel-format-4-tiled-dg2-rc-ccs-modifier)
[635.612566] Starting subtest: pixel-format-4-tiled-dg2-rc-ccs-modifier
[635.616670] Subtest pixel-format-4-tiled-dg2-rc-ccs-modifier: SKIP (0.000s)
[635.688858] [085/132] (380s left) kms_cursor_edge_walk (256x256-top-bottom)
[635.787783] Starting subtest: 256x256-top-bottom
[635.790020] Starting dynamic subtest: pipe-A-eDP-1
[639.199869] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.414s)
[639.209949] Starting dynamic subtest: pipe-D-eDP-1
[642.325750] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.126s)
[642.328346] Subtest 256x256-top-bottom: SUCCESS (6.544s)
[643.128675] [086/132] (372s left) syncobj_timeline (multi-wait-for-submit-available-submitted-signaled)
[643.200898] Starting subtest: multi-wait-for-submit-available-submitted-signaled
[643.203211] Subtest multi-wait-for-submit-available-submitted-signaled: SUCCESS (0.001s)
[643.285341] [087/132] (372s left) syncobj_timeline (device-signal-unordered)
[643.342393] Starting subtest: device-signal-unordered
[643.344677] Subtest device-signal-unordered: SUCCESS (0.001s)
[643.441195] [088/132] (372s left) syncobj_timeline (etime-multi-wait-all-for-submit-unsubmitted-submitted-signa
[643.494381] Starting subtest: etime-multi-wait-all-for-submit-unsubmitted-submitted-signaled
[643.600005] Subtest etime-multi-wait-all-for-submit-unsubmitted-submitted-signaled: SUCCESS (0.104s)
[643.691356] [089/132] (372s left) syncobj_basic (bad-pad-handle-to-fd)
[643.760054] Starting subtest: bad-pad-handle-to-fd
[643.762458] Subtest bad-pad-handle-to-fd: SUCCESS (0.000s)
[643.860002] [090/132] (372s left) gem_mmap_gtt (hang)
[643.911455] Subtest hang: SKIP (0.000s)
[643.969873] [091/132] (372s left) syncobj_timeline (single-wait-all-available-submitted)
[644.026574] Starting subtest: single-wait-all-available-submitted
[644.028913] Subtest single-wait-all-available-submitted: SUCCESS (0.000s)
[644.122817] [092/132] (372s left) kms_psr (fbc-pr-basic)
[644.216763] Starting subtest: fbc-pr-basic
[644.221193] Subtest fbc-pr-basic: SKIP (0.000s)
[644.341477] [093/132] (371s left) kms_ccs (crc-primary-rotation-180-4-tiled-mtl-rc-ccs)
[644.442944] Starting subtest: crc-primary-rotation-180-4-tiled-mtl-rc-ccs
[644.444883] Starting dynamic subtest: pipe-A-eDP-1
[645.261860] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.813s)
[645.274004] Starting dynamic subtest: pipe-B-eDP-1
[646.882355] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.618s)
[646.893160] Starting dynamic subtest: pipe-C-eDP-1
[648.363667] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.481s)
[648.374536] Starting dynamic subtest: pipe-D-eDP-1
[649.918099] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.555s)
[649.920233] Subtest crc-primary-rotation-180-4-tiled-mtl-rc-ccs: SUCCESS (5.472s)
[651.173279] [094/132] (365s left) gem_exec_big (single)
[651.232313] Starting subtest: single
[654.611134] Subtest single: FAIL (3.317s)
[654.655501] [095/132] (361s left) core_getversion (basic)
[654.731873] Starting subtest: basic
[654.736131] Subtest basic: SUCCESS (0.000s)
[654.801194] [096/132] (361s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-blt)
[654.907846] Starting subtest: fbc-rgb101010-draw-blt
[659.467047] Subtest fbc-rgb101010-draw-blt: SUCCESS (4.563s)
[660.575077] [097/132] (355s left) gem_readwrite (read-bad-handle)
[660.632362] Subtest read-bad-handle: SKIP (0.000s)
[660.709396] [098/132] (355s left) kms_plane (pixel-format-yf-tiled-modifier-source-clamping)
[660.806284] Starting subtest: pixel-format-yf-tiled-modifier-source-clamping
[660.810345] Subtest pixel-format-yf-tiled-modifier-source-clamping: SKIP (0.000s)
[660.879841] [099/132] (355s left) kms_ccs (random-ccs-data-4-tiled-mtl-rc-ccs-cc)
[660.968553] Starting subtest: random-ccs-data-4-tiled-mtl-rc-ccs-cc
[660.970465] Starting dynamic subtest: pipe-A-eDP-1
[661.686839] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.711s)
[661.697339] Starting dynamic subtest: pipe-B-eDP-1
[663.468332] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.781s)
[663.478664] Starting dynamic subtest: pipe-C-eDP-1
[665.204740] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.736s)
[665.214857] Starting dynamic subtest: pipe-D-eDP-1
[666.977427] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.773s)
[666.979747] Subtest random-ccs-data-4-tiled-mtl-rc-ccs-cc: SUCCESS (6.006s)
[668.097570] [100/132] (348s left) kms_vblank (ts-continuation-suspend)
[668.191574] Starting subtest: ts-continuation-suspend
[668.193448] Starting dynamic subtest: pipe-A-eDP-1
[684.605835] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.579s)
[684.620156] Starting dynamic subtest: pipe-D-eDP-1
[701.583885] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.172s)
[701.585745] Subtest ts-continuation-suspend: SUCCESS (3.755s)
[702.386701] [101/132] (314s left) kms_big_fb (linear-16bpp-rotate-90)
[702.492869] Starting subtest: linear-16bpp-rotate-90
[702.512322] Subtest linear-16bpp-rotate-90: SKIP (0.019s)
[702.616484] [102/132] (314s left) kms_async_flips (basic-modeset-with-all-modifiers-formats)
[702.705313] Starting subtest: basic-modeset-with-all-modifiers-formats
[703.096377] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-XRGB8888
[703.872392] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-XRGB8888: SUCCESS (0.776s)
[703.882145] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-XRGB2101010
[703.894684] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-XRGB2101010: SUCCESS (0.021s)
[703.903761] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-XRGB16161616F
[703.916479] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-XRGB16161616F: SUCCESS (0.022s)
[703.925615] Starting dynamic subtest: pipe-A-eDP-1-4-RGB565
[704.094779] Dynamic subtest pipe-A-eDP-1-4-RGB565: SUCCESS (0.177s)
[704.104347] Starting dynamic subtest: pipe-A-eDP-1-4-XRGB8888
[704.116727] Dynamic subtest pipe-A-eDP-1-4-XRGB8888: SUCCESS (0.021s)
[704.125985] Starting dynamic subtest: pipe-A-eDP-1-4-XRGB2101010
[704.138868] Dynamic subtest pipe-A-eDP-1-4-XRGB2101010: SUCCESS (0.022s)
[704.147865] Starting dynamic subtest: pipe-A-eDP-1-4-XRGB16161616F
[704.161106] Dynamic subtest pipe-A-eDP-1-4-XRGB16161616F: SUCCESS (0.021s)
[704.170350] Starting dynamic subtest: pipe-A-eDP-1-4-YUYV
[704.183102] Dynamic subtest pipe-A-eDP-1-4-YUYV: SUCCESS (0.021s)
[704.192336] Starting dynamic subtest: pipe-A-eDP-1-4-Y210
[704.205360] Dynamic subtest pipe-A-eDP-1-4-Y210: SUCCESS (0.021s)
[704.214296] Starting dynamic subtest: pipe-A-eDP-1-4-XYUV8888
[704.227881] Dynamic subtest pipe-A-eDP-1-4-XYUV8888: SUCCESS (0.022s)
[704.236866] Starting dynamic subtest: pipe-A-eDP-1-4-XV30
[704.250139] Dynamic subtest pipe-A-eDP-1-4-XV30: SUCCESS (0.021s)
[704.259261] Starting dynamic subtest: pipe-A-eDP-1-4-XV36
[704.272232] Dynamic subtest pipe-A-eDP-1-4-XV36: SUCCESS (0.021s)
[704.281395] Starting dynamic subtest: pipe-A-eDP-1-x-RGB565
[704.427907] Dynamic subtest pipe-A-eDP-1-x-RGB565: SUCCESS (0.155s)
[704.441030] Starting dynamic subtest: pipe-A-eDP-1-x-XRGB8888
[704.449865] Dynamic subtest pipe-A-eDP-1-x-XRGB8888: SUCCESS (0.021s)
[704.458718] Starting dynamic subtest: pipe-A-eDP-1-x-XRGB2101010
[704.472173] Dynamic subtest pipe-A-eDP-1-x-XRGB2101010: SUCCESS (0.021s)
[704.483006] Starting dynamic subtest: pipe-A-eDP-1-x-XRGB16161616F
[704.494382] Dynamic subtest pipe-A-eDP-1-x-XRGB16161616F: SUCCESS (0.022s)
[704.503282] Starting dynamic subtest: pipe-A-eDP-1-x-YUYV
[704.516937] Dynamic subtest pipe-A-eDP-1-x-YUYV: SUCCESS (0.021s)
[704.528699] Starting dynamic subtest: pipe-A-eDP-1-x-Y210
[704.538846] Dynamic subtest pipe-A-eDP-1-x-Y210: SUCCESS (0.021s)
[704.548241] Starting dynamic subtest: pipe-A-eDP-1-x-XYUV8888
[704.560945] Dynamic subtest pipe-A-eDP-1-x-XYUV8888: SUCCESS (0.022s)
[704.570475] Starting dynamic subtest: pipe-A-eDP-1-x-XV30
[704.583204] Dynamic subtest pipe-A-eDP-1-x-XV30: SUCCESS (0.022s)
[704.592743] Starting dynamic subtest: pipe-A-eDP-1-x-XV36
[704.605059] Dynamic subtest pipe-A-eDP-1-x-XV36: SUCCESS (0.021s)
[704.614824] Starting dynamic subtest: pipe-A-eDP-1-linear-RGB565
[704.770857] Dynamic subtest pipe-A-eDP-1-linear-RGB565: SUCCESS (0.166s)
[704.782112] Starting dynamic subtest: pipe-A-eDP-1-linear-XRGB8888
[704.792042] Dynamic subtest pipe-A-eDP-1-linear-XRGB8888: SUCCESS (0.021s)
[704.802485] Starting dynamic subtest: pipe-A-eDP-1-linear-XRGB2101010
[704.813512] Dynamic subtest pipe-A-eDP-1-linear-XRGB2101010: SUCCESS (0.021s)
[704.827537] Starting dynamic subtest: pipe-A-eDP-1-linear-XRGB16161616F
[704.835081] Dynamic subtest pipe-A-eDP-1-linear-XRGB16161616F: SUCCESS (0.021s)
[704.845085] Starting dynamic subtest: pipe-A-eDP-1-linear-YUYV
[704.856390] Dynamic subtest pipe-A-eDP-1-linear-YUYV: SUCCESS (0.021s)
[704.864685] Starting dynamic subtest: pipe-A-eDP-1-linear-Y210
[704.877921] Dynamic subtest pipe-A-eDP-1-linear-Y210: SUCCESS (0.022s)
[704.886104] Starting dynamic subtest: pipe-A-eDP-1-linear-XYUV8888
[704.899414] Dynamic subtest pipe-A-eDP-1-linear-XYUV8888: SUCCESS (0.021s)
[704.913467] Starting dynamic subtest: pipe-A-eDP-1-linear-XV30
[704.920949] Dynamic subtest pipe-A-eDP-1-linear-XV30: SUCCESS (0.021s)
[704.931430] Starting dynamic subtest: pipe-A-eDP-1-linear-XV36
[704.942347] Dynamic subtest pipe-A-eDP-1-linear-XV36: SUCCESS (0.022s)
[705.325481] Subtest basic-modeset-with-all-modifiers-formats: SUCCESS (2.642s)
[706.110181] [103/132] (310s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-blt)
[706.201077] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-blt
[706.205319] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-blt: SKIP (0.000s)
[706.293526] [104/132] (310s left) kms_psr2_sf (psr2-cursor-plane-move-continuous-exceed-fully-sf)
[706.391312] Starting subtest: psr2-cursor-plane-move-continuous-exceed-fully-sf
[706.393537] Starting dynamic subtest: pipe-A-eDP-1
[717.215171] Dynamic subtest pipe-A-eDP-1: SUCCESS (11.002s)
[717.225716] Starting dynamic subtest: pipe-B-eDP-1
[728.897211] Dynamic subtest pipe-B-eDP-1: SUCCESS (11.726s)
[728.899605] Subtest psr2-cursor-plane-move-continuous-exceed-fully-sf: SUCCESS (22.731s)
[729.745915] [105/132] (287s left) kms_frontbuffer_tracking (fbcpsr-modesetfrombusy)
[729.852097] Starting subtest: fbcpsr-modesetfrombusy
[736.119127] Subtest fbcpsr-modesetfrombusy: SUCCESS (6.281s)
[736.212152] [106/132] (280s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-0-async-flip)
[736.317912] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-0-async-flip
[736.321499] Subtest y-tiled-max-hw-stride-64bpp-rotate-0-async-flip: SKIP (0.000s)
[736.400803] [107/132] (280s left) perf (gen12-invalid-class-instance)
[736.520230] Starting subtest: gen12-invalid-class-instance
[736.529247] Subtest gen12-invalid-class-instance: SUCCESS (0.007s)
[736.569891] [108/132] (280s left) gem_render_copy (y-tiled-mc-ccs-to-vebox-y-tiled)
[736.620573] Starting subtest: y-tiled-mc-ccs-to-vebox-y-tiled
[736.624577] Subtest y-tiled-mc-ccs-to-vebox-y-tiled: SKIP (0.000s)
[736.802541] [109/132] (280s left) gem_exec_reloc (basic-gtt-active)
[736.876192] Subtest basic-gtt-active: SKIP (0.000s)
[736.953830] [110/132] (280s left) kms_prop_blob (invalid-set-prop-any)
[737.009524] Starting subtest: invalid-set-prop-any
[737.011801] Subtest invalid-set-prop-any: SUCCESS (0.000s)
[737.112974] [111/132] (279s left) gem_softpin (noreloc-interruptible)
[737.175510] Starting subtest: noreloc-interruptible
[742.598262] Subtest noreloc-interruptible: SUCCESS (5.418s)
[742.721836] [112/132] (274s left) gem_workarounds (basic-read)
[742.796057] Starting subtest: basic-read
[742.808522] Subtest basic-read: SUCCESS (0.016s)
[742.950951] [113/132] (274s left) gem_exec_schedule (semaphore-codependency)
[743.021482] Starting subtest: semaphore-codependency
[743.040177] Subtest semaphore-codependency: SUCCESS (0.027s)
[743.399156] [114/132] (273s left) i915_pm_rpm (reg-read-ioctl)
[745.362611] Starting subtest: reg-read-ioctl
[747.750157] Subtest reg-read-ioctl: SUCCESS (2.386s)
[748.145992] [115/132] (269s left) kms_chamelium_hpd (dp-hpd-storm)
[748.526597] Subtest dp-hpd-storm: SKIP (0.000s)
[749.327495] [116/132] (267s left) tools_test (tools_test)
[749.383595] Starting subtest: tools_test
[749.438566] Subtest tools_test: SUCCESS (0.070s)
[749.489497] [117/132] (267s left) gem_render_copy_redux (normal)
[749.563943] Starting subtest: normal
[749.838867] Subtest normal: SUCCESS (0.275s)
[749.949064] [118/132] (267s left) kms_flip (2x-flip-vs-panning)
[750.043575] Starting subtest: 2x-flip-vs-panning
[750.052101] Subtest 2x-flip-vs-panning: SKIP (0.010s)
[750.132229] [119/132] (267s left) syncobj_timeline (invalid-transfer-illegal-handle)
[750.188682] Starting subtest: invalid-transfer-illegal-handle
[750.190529] Subtest invalid-transfer-illegal-handle: SUCCESS (0.000s)
[750.280077] [120/132] (267s left) kms_flip (2x-absolute-wf_vblank-interruptible)
[750.366722] Starting subtest: 2x-absolute-wf_vblank-interruptible
[750.377887] Subtest 2x-absolute-wf_vblank-interruptible: SKIP (0.010s)
[750.477096] [121/132] (267s left) gem_exec_store (dword)
[750.537363] Starting subtest: dword
[750.538933] Starting dynamic subtest: rcs0
[750.616864] Dynamic subtest rcs0: SUCCESS (0.081s)
[750.629916] Starting dynamic subtest: bcs0
[750.660583] Dynamic subtest bcs0: SUCCESS (0.041s)
[750.672543] Starting dynamic subtest: vcs0
[750.703494] Dynamic subtest vcs0: SUCCESS (0.041s)
[750.714699] Starting dynamic subtest: vcs1
[750.746692] Dynamic subtest vcs1: SUCCESS (0.041s)
[750.756589] Starting dynamic subtest: vecs0
[750.788504] Dynamic subtest vecs0: SUCCESS (0.040s)
[750.800630] Starting dynamic subtest: ccs0
[750.832095] Dynamic subtest ccs0: SUCCESS (0.041s)
[750.834079] Subtest dword: SUCCESS (0.298s)
[751.021145] [122/132] (266s left) kms_frontbuffer_tracking (fbcpsr-tiling-y)
[751.121127] Starting subtest: fbcpsr-tiling-y
[751.125422] Subtest fbcpsr-tiling-y: SKIP (0.000s)
[751.226362] [123/132] (266s left) kms_plane_scaling (plane-scaler-unity-scaling-with-modifiers)
[751.317042] Starting subtest: plane-scaler-unity-scaling-with-modifiers
[751.319306] Starting dynamic subtest: pipe-A
[751.653660] Dynamic subtest pipe-A: SUCCESS (0.339s)
[751.662775] Starting dynamic subtest: pipe-B
[753.028698] Dynamic subtest pipe-B: SUCCESS (1.374s)
[753.039538] Starting dynamic subtest: pipe-C
[754.472699] Dynamic subtest pipe-C: SUCCESS (1.442s)
[754.483205] Starting dynamic subtest: pipe-D
[755.891780] Dynamic subtest pipe-D: SUCCESS (1.417s)
[755.894056] Subtest plane-scaler-unity-scaling-with-modifiers: SUCCESS (4.579s)
[757.044493] [124/132] (260s left) kms_ccs (crc-primary-suspend-y-tiled-gen12-rc-ccs-cc)
[757.140948] Starting subtest: crc-primary-suspend-y-tiled-gen12-rc-ccs-cc
[757.143160] Starting dynamic subtest: pipe-A-eDP-1
[757.151930] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[757.167957] Starting dynamic subtest: pipe-B-eDP-1
[757.176980] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[757.192842] Starting dynamic subtest: pipe-C-eDP-1
[757.201389] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[757.210213] Starting dynamic subtest: pipe-D-eDP-1
[757.218693] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[757.222800] Subtest crc-primary-suspend-y-tiled-gen12-rc-ccs-cc: SKIP (0.004s)
[759.396280] [125/132] (258s left) gem_ctx_persistence (saturated-hostile)
[759.465358] Starting subtest: saturated-hostile
[759.467798] Starting dynamic subtest: rcs0
[760.296180] Dynamic subtest rcs0: SUCCESS (0.830s)
[760.309522] Starting dynamic subtest: bcs0
[761.074464] Dynamic subtest bcs0: SUCCESS (0.776s)
[761.087802] Starting dynamic subtest: vcs0
[761.869520] Dynamic subtest vcs0: SUCCESS (0.794s)
[761.881687] Starting dynamic subtest: vcs1
[762.675014] Dynamic subtest vcs1: SUCCESS (0.804s)
[762.687534] Starting dynamic subtest: vecs0
[763.465971] Dynamic subtest vecs0: SUCCESS (0.789s)
[763.477337] Starting dynamic subtest: ccs0
[764.302070] Dynamic subtest ccs0: SUCCESS (0.834s)
[764.304692] Subtest saturated-hostile: SUCCESS (4.839s)
[764.384444] [126/132] (253s left) gem_ccs (block-copy-compressed)
[764.442176] Starting subtest: block-copy-compressed
[764.446558] Subtest block-copy-compressed: SKIP (0.000s)
[764.557628] [127/132] (253s left) kms_getfb (getfb2-handle-zero)
[764.654677] Starting subtest: getfb2-handle-zero
[764.656936] Subtest getfb2-handle-zero: SUCCESS (0.000s)
[764.786715] [128/132] (253s left) kms_cursor_crc (cursor-rapid-movement-128x128)
[765.004603] Starting subtest: cursor-rapid-movement-128x128
[765.014993] Starting dynamic subtest: pipe-A-eDP-1
[765.555538] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.545s)
[765.590895] Starting dynamic subtest: pipe-D-eDP-1
[766.825580] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.242s)
[766.827512] Subtest cursor-rapid-movement-128x128: SUCCESS (1.821s)
[767.653726] [129/132] (250s left) gen9_exec_parse (bb-start-param)
[767.722950] Subtest bb-start-param: SKIP (0.000s)
[767.798592] [130/132] (250s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-pwrite)
[767.899201] Starting subtest: psr-2p-primscrn-spr-indfb-draw-pwrite
[767.903269] Subtest psr-2p-primscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[767.995148] [131/132] (249s left) i915_drm_fdinfo (memory-info-shared)
[768.039149] Starting subtest: memory-info-shared
[768.041483] Starting dynamic subtest: smem0
[768.097071] Dynamic subtest smem0: SUCCESS (0.058s)
[768.099977] Subtest memory-info-shared: SUCCESS (0.059s)
[768.182480] [132/132] (249s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-onoff)
[768.270358] Starting subtest: psr-2p-primscrn-cur-indfb-onoff
[768.274860] Subtest psr-2p-primscrn-cur-indfb-onoff: SKIP (0.000s)
[768.370670] Closing watchdogs
results: parsing output: 0/ for test: kms_atomic_transition
results: parsing output: 1/ for test: gem_exec_flush
results: parsing output: 2/ for test: kms_frontbuffer_tracking
results: parsing output: 3/ for test: kms_frontbuffer_tracking
results: parsing output: 4/ for test: kms_flip_scaled_crc
results: parsing output: 5/ for test: kms_big_fb
results: parsing output: 6/ for test: gem_mmap_gtt
results: parsing output: 7/ for test: kms_content_protection
results: parsing output: 8/ for test: kms_frontbuffer_tracking
results: parsing output: 9/ for test: kms_atomic_transition
results: parsing output: 10/ for test: kms_frontbuffer_tracking
results: parsing output: 11/ for test: kms_flip
results: parsing output: 12/ for test: api_intel_allocator
results: parsing output: 13/ for test: kms_chamelium_edid
results: parsing output: 14/ for test: gem_exec_schedule
results: parsing output: 15/ for test: kms_psr
results: parsing output: 16/ for test: kms_feature_discovery
results: parsing output: 17/ for test: kms_dirtyfb
results: parsing output: 18/ for test: gem_exec_fence
results: parsing output: 19/ for test: gem_ctx_engines
results: parsing output: 20/ for test: kms_psr
results: parsing output: 21/ for test: kms_color
results: parsing output: 22/ for test: kms_plane_scaling
results: parsing output: 23/ for test: perf_pmu
results: parsing output: 24/ for test: kms_frontbuffer_tracking
results: parsing output: 25/ for test: gem_mmap
results: parsing output: 26/ for test: kms_frontbuffer_tracking
results: parsing output: 27/ for test: gem_exec_reloc
results: parsing output: 28/ for test: kms_invalid_mode
results: parsing output: 29/ for test: kms_flip
results: parsing output: 30/ for test: kms_psr
results: parsing output: 31/ for test: perf
results: parsing output: 32/ for test: gem_ctx_sseu
results: parsing output: 33/ for test: gem_exec_params
results: parsing output: 34/ for test: gem_close
results: parsing output: 35/ for test: kms_cursor_crc
results: parsing output: 36/ for test: gem_exec_reloc
results: parsing output: 37/ for test: gem_ctx_param
results: parsing output: 38/ for test: kms_ccs
results: parsing output: 39/ for test: kms_frontbuffer_tracking
results: parsing output: 40/ for test: prime_busy
results: parsing output: 41/ for test: kms_frontbuffer_tracking
results: parsing output: 42/ for test: kms_psr
results: parsing output: 43/ for test: gem_busy
results: parsing output: 44/ for test: syncobj_wait
results: parsing output: 45/ for test: gem_ctx_isolation
results: parsing output: 46/ for test: kms_ccs
results: parsing output: 47/ for test: gem_exec_params
results: parsing output: 48/ for test: gem_basic
results: parsing output: 49/ for test: perf_pmu
results: parsing output: 50/ for test: api_intel_bb
results: parsing output: 51/ for test: kms_big_fb
results: parsing output: 52/ for test: gem_render_copy
results: parsing output: 53/ for test: kms_frontbuffer_tracking
results: parsing output: 54/ for test: kms_lease
results: parsing output: 55/ for test: gem_exec_balancer
results: parsing output: 56/ for test: gem_exec_params
results: parsing output: 57/ for test: kms_pipe_crc_basic
results: parsing output: 58/ for test: gem_mmap_gtt
results: parsing output: 59/ for test: gem_userptr_blits
results: parsing output: 60/ for test: kms_psr
results: parsing output: 61/ for test: kms_pm_dc
results: parsing output: 62/ for test: gem_pxp
results: parsing output: 63/ for test: kms_big_fb
results: parsing output: 64/ for test: sysfs_preempt_timeout
results: parsing output: 65/ for test: kms_frontbuffer_tracking
results: parsing output: 66/ for test: kms_frontbuffer_tracking
results: parsing output: 67/ for test: kms_flip
results: parsing output: 68/ for test: i915_hangman
results: parsing output: 69/ for test: gem_exec_reloc
results: parsing output: 70/ for test: kms_frontbuffer_tracking
results: parsing output: 71/ for test: kms_big_fb
results: parsing output: 72/ for test: kms_vblank
results: parsing output: 73/ for test: kms_flip
results: parsing output: 74/ for test: kms_frontbuffer_tracking
results: parsing output: 75/ for test: kms_big_fb
results: parsing output: 76/ for test: i915_query
results: parsing output: 77/ for test: gem_lmem_swapping
results: parsing output: 78/ for test: gem_render_copy
results: parsing output: 79/ for test: gem_softpin
results: parsing output: 80/ for test: perf
results: parsing output: 81/ for test: kms_pm_rpm
results: parsing output: 82/ for test: syncobj_wait
results: parsing output: 83/ for test: kms_plane
results: parsing output: 84/ for test: kms_cursor_edge_walk
results: parsing output: 85/ for test: syncobj_timeline
results: parsing output: 86/ for test: syncobj_timeline
results: parsing output: 87/ for test: syncobj_timeline
results: parsing output: 88/ for test: syncobj_basic
results: parsing output: 89/ for test: gem_mmap_gtt
results: parsing output: 90/ for test: syncobj_timeline
results: parsing output: 91/ for test: kms_psr
results: parsing output: 92/ for test: kms_ccs
results: parsing output: 93/ for test: gem_exec_big
results: parsing output: 94/ for test: core_getversion
results: parsing output: 95/ for test: kms_frontbuffer_tracking
results: parsing output: 96/ for test: gem_readwrite
results: parsing output: 97/ for test: kms_plane
results: parsing output: 98/ for test: kms_ccs
results: parsing output: 99/ for test: kms_vblank
results: parsing output: 100/ for test: kms_big_fb
results: parsing output: 101/ for test: kms_async_flips
results: parsing output: 102/ for test: kms_frontbuffer_tracking
results: parsing output: 103/ for test: kms_psr2_sf
results: parsing output: 104/ for test: kms_frontbuffer_tracking
results: parsing output: 105/ for test: kms_big_fb
results: parsing output: 106/ for test: perf
results: parsing output: 107/ for test: gem_render_copy
results: parsing output: 108/ for test: gem_exec_reloc
results: parsing output: 109/ for test: kms_prop_blob
results: parsing output: 110/ for test: gem_softpin
results: parsing output: 111/ for test: gem_workarounds
results: parsing output: 112/ for test: gem_exec_schedule
results: parsing output: 113/ for test: i915_pm_rpm
results: parsing output: 114/ for test: kms_chamelium_hpd
results: parsing output: 115/ for test: tools_test
results: parsing output: 116/ for test: gem_render_copy_redux
results: parsing output: 117/ for test: kms_flip
results: parsing output: 118/ for test: syncobj_timeline
results: parsing output: 119/ for test: kms_flip
results: parsing output: 120/ for test: gem_exec_store
results: parsing output: 121/ for test: kms_frontbuffer_tracking
results: parsing output: 122/ for test: kms_plane_scaling
results: parsing output: 123/ for test: kms_ccs
results: parsing output: 124/ for test: gem_ctx_persistence
results: parsing output: 125/ for test: gem_ccs
results: parsing output: 126/ for test: kms_getfb
results: parsing output: 127/ for test: kms_cursor_crc
results: parsing output: 128/ for test: gen9_exec_parse
results: parsing output: 129/ for test: kms_frontbuffer_tracking
results: parsing output: 130/ for test: i915_drm_fdinfo
results: parsing output: 131/ for test: kms_frontbuffer_tracking
Done.