[58.672430] Initializing watchdogs
[58.672563]   /dev/watchdog0
[58.689710] [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]
[58.694436] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[58.698619] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[58.702060] [001/156] (960s left) kms_pm_dc (dc5-dpms-negative)
[59.828840] Starting subtest: dc5-dpms-negative
[59.833338] Subtest dc5-dpms-negative: SKIP (0.000s)
[59.898164] [002/156] (959s left) kms_cursor_legacy (long-nonblocking-modeset-vs-cursor-atomic)
[60.029531] Starting subtest: long-nonblocking-modeset-vs-cursor-atomic
[78.402808] Subtest long-nonblocking-modeset-vs-cursor-atomic: SUCCESS (18.377s)
[79.288322] [003/156] (939s left) kms_frontbuffer_tracking (fbcpsr-indfb-scaledprimary)
[79.398745] Starting subtest: fbcpsr-indfb-scaledprimary
[85.162237] Subtest fbcpsr-indfb-scaledprimary: SUCCESS (5.771s)
[85.339389] [004/156] (933s left) kms_frontbuffer_tracking (fbcpsrhdr-rgb101010-draw-mmap-cpu)
[85.442289] Starting subtest: fbcpsrhdr-rgb101010-draw-mmap-cpu
[85.446299] Subtest fbcpsrhdr-rgb101010-draw-mmap-cpu: SKIP (0.000s)
[85.562637] [005/156] (933s left) syncobj_eventfd (invalid-bad-flags)
[85.617036] Starting subtest: invalid-bad-flags
[85.619461] Subtest invalid-bad-flags: SUCCESS (0.000s)
[85.715075] [006/156] (933s left) kms_plane (pixel-format-4-tiled-dg2-mc-ccs-modifier-source-clamping)
[85.810081] Starting subtest: pixel-format-4-tiled-dg2-mc-ccs-modifier-source-clamping
[85.814342] Subtest pixel-format-4-tiled-dg2-mc-ccs-modifier-source-clamping: SKIP (0.000s)
[85.879795] [007/156] (933s left) gem_exec_whisper (basic-forked)
[85.941477] Starting subtest: basic-forked
[93.128446] Subtest basic-forked: SUCCESS (7.185s)
[93.323183] [008/156] (926s left) gem_spin_batch (engines)
[93.393844] Starting subtest: engines
[93.396418] Starting dynamic subtest: rcs0
[96.694689] Dynamic subtest rcs0: SUCCESS (3.242s)
[96.707089] Starting dynamic subtest: bcs0
[99.929053] Dynamic subtest bcs0: SUCCESS (3.235s)
[99.939812] Starting dynamic subtest: vcs0
[103.166710] Dynamic subtest vcs0: SUCCESS (3.237s)
[103.178161] Starting dynamic subtest: vcs1
[106.400877] Dynamic subtest vcs1: SUCCESS (3.232s)
[106.412569] Starting dynamic subtest: vecs0
[109.637366] Dynamic subtest vecs0: SUCCESS (3.236s)
[109.648547] Starting dynamic subtest: ccs0
[112.875819] Dynamic subtest ccs0: SUCCESS (3.236s)
[112.878243] Subtest engines: SUCCESS (19.428s)
[113.046045] [009/156] (906s left) kms_frontbuffer_tracking (basic)
[113.164454] Starting subtest: basic
[116.571103] Subtest basic: SUCCESS (3.415s)
[116.706809] [010/156] (902s left) kms_frontbuffer_tracking (fbchdr-2p-scndscrn-cur-indfb-draw-pwrite)
[116.807420] Starting subtest: fbchdr-2p-scndscrn-cur-indfb-draw-pwrite
[116.810964] Subtest fbchdr-2p-scndscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[116.897642] [011/156] (902s left) i915_query (engine-info)
[116.947742] Starting subtest: engine-info
[116.951505] Subtest engine-info: SUCCESS (0.005s)
[117.059735] [012/156] (902s left) gem_ctx_persistence (legacy-engines-persistence)
[117.111094] Starting subtest: legacy-engines-persistence
[117.112964] Starting dynamic subtest: render
[117.892829] Dynamic subtest render: SUCCESS (0.780s)
[117.903925] Starting dynamic subtest: bsd1
[118.651561] Dynamic subtest bsd1: SUCCESS (0.755s)
[118.661830] Starting dynamic subtest: bsd2
[119.440678] Dynamic subtest bsd2: SUCCESS (0.788s)
[119.451673] Starting dynamic subtest: blt
[120.173088] Dynamic subtest blt: SUCCESS (0.730s)
[120.184738] Starting dynamic subtest: vebox
[120.971077] Dynamic subtest vebox: SUCCESS (0.796s)
[120.973572] Subtest legacy-engines-persistence: SUCCESS (3.860s)
[121.062419] [013/156] (898s left) kms_rotation_crc (exhaust-fences)
[121.162801] Starting subtest: exhaust-fences
[121.167263] Subtest exhaust-fences: SKIP (0.000s)
[121.229506] [014/156] (898s left) kms_addfb_basic (legacy-format)
[121.292578] Starting subtest: legacy-format
[121.324962] Subtest legacy-format: SUCCESS (0.028s)
[121.465391] [015/156] (898s left) gem_exec_fence (syncobj-timeline-repeat)
[122.016458] Starting subtest: syncobj-timeline-repeat
[122.264848] Subtest syncobj-timeline-repeat: SUCCESS (0.248s)
[123.364686] [FACT gem_exec_fence (syncobj-timeline-repeat)] new: kernel.kmod_is_loaded.vgem: true
[123.368406] [016/156] (896s left) kms_frontbuffer_tracking (fbchdr-2p-primscrn-pri-shrfb-draw-mmap-cpu)
[123.474822] Starting subtest: fbchdr-2p-primscrn-pri-shrfb-draw-mmap-cpu
[123.479070] Subtest fbchdr-2p-primscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[123.575169] [017/156] (896s left) kms_rotation_crc (primary-y-tiled-reflect-x-270)
[123.665251] Starting subtest: primary-y-tiled-reflect-x-270
[123.669698] Subtest primary-y-tiled-reflect-x-270: SKIP (0.001s)
[123.739620] [018/156] (896s left) gem_exec_reloc (basic-write-read-noreloc)
[123.791232] Subtest basic-write-read-noreloc: SKIP (0.000s)
[123.871283] [019/156] (896s left) kms_frontbuffer_tracking (fbc-2p-pri-indfb-multidraw)
[123.968282] Starting subtest: fbc-2p-pri-indfb-multidraw
[123.972417] Subtest fbc-2p-pri-indfb-multidraw: SKIP (0.000s)
[124.067536] [020/156] (895s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-0)
[124.168817] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-0
[124.173332] Subtest yf-tiled-max-hw-stride-32bpp-rotate-0: SKIP (0.000s)
[124.278914] [021/156] (895s left) syncobj_basic (bad-create-flags)
[124.326935] Starting subtest: bad-create-flags
[124.328726] Subtest bad-create-flags: SUCCESS (0.000s)
[124.417262] [022/156] (895s left) prime_self_import (basic-with_two_bos)
[124.448644] Starting subtest: basic-with_two_bos
[124.471499] Subtest basic-with_two_bos: SUCCESS (0.023s)
[124.592094] [023/156] (895s left) syncobj_timeline (reset-unsignaled)
[124.648737] Starting subtest: reset-unsignaled
[124.650887] Subtest reset-unsignaled: SUCCESS (0.000s)
[124.763524] [024/156] (895s left) gen7_exec_parse (batch-without-end)
[124.809135] Subtest batch-without-end: SKIP (0.000s)
[124.889653] [025/156] (895s left) syncobj_timeline (single-wait-for-submit-available-submitted)
[124.936471] Starting subtest: single-wait-for-submit-available-submitted
[124.938388] Subtest single-wait-for-submit-available-submitted: SUCCESS (0.001s)
[125.049763] [026/156] (895s left) kms_flip (flip-vs-expired-vblank-interruptible)
[125.142230] Starting subtest: flip-vs-expired-vblank-interruptible
[125.143972] Starting dynamic subtest: A-eDP1
[133.841045] Dynamic subtest A-eDP1: SUCCESS (8.663s)
[133.852684] Starting dynamic subtest: B-eDP1
[142.479794] Dynamic subtest B-eDP1: SUCCESS (8.635s)
[142.491205] Starting dynamic subtest: C-eDP1
[151.116732] Dynamic subtest C-eDP1: SUCCESS (8.624s)
[151.127070] Starting dynamic subtest: D-eDP1
[159.754595] Dynamic subtest D-eDP1: SUCCESS (8.636s)
[159.756694] Subtest flip-vs-expired-vblank-interruptible: SUCCESS (34.566s)
[160.899248] [027/156] (859s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-indfb-draw-mmap-wc)
[160.994871] Starting subtest: fbc-1p-offscreen-pri-indfb-draw-mmap-wc
[165.105371] Subtest fbc-1p-offscreen-pri-indfb-draw-mmap-wc: SUCCESS (4.115s)
[166.299209] [028/156] (854s left) kms_frontbuffer_tracking (hdr-1p-primscrn-pri-indfb-draw-mmap-wc)
[166.391711] Starting subtest: hdr-1p-primscrn-pri-indfb-draw-mmap-wc
[166.395909] Subtest hdr-1p-primscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[166.485538] [029/156] (853s left) kms_frontbuffer_tracking (hdr-2p-primscrn-pri-shrfb-draw-mmap-cpu)
[166.580728] Starting subtest: hdr-2p-primscrn-pri-shrfb-draw-mmap-cpu
[166.584878] Subtest hdr-2p-primscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[166.678585] [030/156] (853s left) kms_flip_scaled_crc (flip-64bpp-linear-to-16bpp-linear-upscaling)
[166.769113] Starting subtest: flip-64bpp-linear-to-16bpp-linear-upscaling
[166.771336] Starting dynamic subtest: pipe-A-default-mode
[169.564975] Dynamic subtest pipe-A-default-mode: SUCCESS (2.795s)
[169.567157] Subtest flip-64bpp-linear-to-16bpp-linear-upscaling: SUCCESS (2.796s)
[170.399081] [031/156] (850s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-mmap-cpu)
[170.491840] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-mmap-cpu
[170.496379] Subtest psr-2p-scndscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[170.579358] [032/156] (849s left) kms_ccs (bad-pixel-format-y-tiled-gen12-rc-ccs-cc)
[170.676366] Starting subtest: bad-pixel-format-y-tiled-gen12-rc-ccs-cc
[170.678621] Starting dynamic subtest: pipe-A-eDP-1
[170.701746] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[170.713049] Starting dynamic subtest: pipe-B-eDP-1
[170.734778] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[170.743894] Starting dynamic subtest: pipe-C-eDP-1
[170.765528] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[170.774211] Starting dynamic subtest: pipe-D-eDP-1
[170.796325] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[170.800364] Subtest bad-pixel-format-y-tiled-gen12-rc-ccs-cc: SKIP (0.004s)
[172.979146] [033/156] (847s left) gem_exec_balancer (bonded-dual)
[173.041609] Starting subtest: bonded-dual
[173.046300] Subtest bonded-dual: SKIP (0.000s)
[173.335231] [034/156] (847s left) kms_big_fb (linear-64bpp-rotate-270)
[173.441350] Starting subtest: linear-64bpp-rotate-270
[173.460343] Subtest linear-64bpp-rotate-270: SKIP (0.019s)
[173.572266] [035/156] (847s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-0)
[173.669300] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-0
[173.673844] Subtest y-tiled-max-hw-stride-64bpp-rotate-0: SKIP (0.000s)
[173.764572] [036/156] (846s left) gem_exec_params (invalid-ring)
[173.816796] Starting subtest: invalid-ring
[173.819180] Subtest invalid-ring: SUCCESS (0.000s)
[173.920014] [037/156] (846s left) gem_exec_balancer (smoke)
[173.979203] Starting subtest: smoke
[196.674788] Subtest smoke: SUCCESS (22.642s)
[198.389114] [038/156] (822s left) syncobj_timeline (etime-multi-wait-all-for-submit-submitted)
[198.449646] Starting subtest: etime-multi-wait-all-for-submit-submitted
[198.553231] Subtest etime-multi-wait-all-for-submit-submitted: SUCCESS (0.103s)
[198.632210] [039/156] (822s left) fbdev (write)
[198.670950] Starting subtest: write
[199.035647] Subtest write: SUCCESS (0.363s)
[199.098900] [040/156] (821s left) kms_psr (fbc-pr-primary-render)
[199.202363] Starting subtest: fbc-pr-primary-render
[199.206860] Subtest fbc-pr-primary-render: SKIP (0.000s)
[199.273998] [041/156] (821s left) kms_plane (pixel-format-y-tiled-ccs-modifier)
[199.368128] Starting subtest: pixel-format-y-tiled-ccs-modifier
[199.372249] Subtest pixel-format-y-tiled-ccs-modifier: SKIP (0.000s)
[199.441260] [042/156] (821s left) gem_mmap_gtt (basic-write-cpu-read-gtt)
[199.496721] Subtest basic-write-cpu-read-gtt: SKIP (0.000s)
[199.552566] [043/156] (821s left) kms_hdr (bpc-switch-suspend)
[199.664361] Starting subtest: bpc-switch-suspend
[199.666673] Starting dynamic subtest: pipe-A-eDP-1-XRGB2101010
[220.072115] Dynamic subtest pipe-A-eDP-1-XRGB2101010: SUCCESS (6.526s)
[220.083551] Starting dynamic subtest: pipe-A-eDP-1-XRGB16161616F
[241.038330] Dynamic subtest pipe-A-eDP-1-XRGB16161616F: SUCCESS (5.753s)
[241.040702] Subtest bpc-switch-suspend: SUCCESS (12.284s)
[241.166248] [044/156] (779s left) kms_frontbuffer_tracking (fbchdr-2p-scndscrn-shrfb-pgflip-blt)
[241.277117] Starting subtest: fbchdr-2p-scndscrn-shrfb-pgflip-blt
[241.281229] Subtest fbchdr-2p-scndscrn-shrfb-pgflip-blt: SKIP (0.000s)
[241.378990] [045/156] (779s left) kms_color (invalid-gamma-lut-sizes)
[241.491736] Starting subtest: invalid-gamma-lut-sizes
[241.494048] Starting dynamic subtest: pipe-A
[241.782604] Dynamic subtest pipe-A: SUCCESS (0.292s)
[241.795108] Starting dynamic subtest: pipe-B
[241.797592] Dynamic subtest pipe-B: SUCCESS (0.000s)
[241.810559] Starting dynamic subtest: pipe-C
[241.812960] Dynamic subtest pipe-C: SUCCESS (0.000s)
[241.822986] Starting dynamic subtest: pipe-D
[241.824918] Dynamic subtest pipe-D: SUCCESS (0.000s)
[241.826759] Subtest invalid-gamma-lut-sizes: SUCCESS (0.296s)
[242.612909] [046/156] (778s left) kms_ccs (crc-primary-basic-y-tiled-gen12-mc-ccs)
[242.709295] Starting subtest: crc-primary-basic-y-tiled-gen12-mc-ccs
[242.711478] Starting dynamic subtest: pipe-A-eDP-1
[242.734114] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[242.746669] Starting dynamic subtest: pipe-B-eDP-1
[242.768052] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[242.777594] Starting dynamic subtest: pipe-C-eDP-1
[242.797958] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[242.807188] Starting dynamic subtest: pipe-D-eDP-1
[242.828194] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[242.832060] Subtest crc-primary-basic-y-tiled-gen12-mc-ccs: SKIP (0.006s)
[244.981475] [047/156] (776s left) gem_mmap_offset (clear-via-pagefault)
[245.041785] Starting subtest: clear-via-pagefault
[245.044104] Starting dynamic subtest: smem0
[281.329691] Dynamic subtest smem0: SUCCESS (36.294s)
[281.331798] Subtest clear-via-pagefault: SUCCESS (36.295s)
[281.418109] [048/156] (739s left) kms_chamelium_frames (dp-frame-dump)
[281.801321] Subtest dp-frame-dump: SKIP (0.000s)
[282.590541] [049/156] (738s left) kms_psr2_sf (pr-overlay-plane-update-sf-dmg-area)
[282.687653] Starting subtest: pr-overlay-plane-update-sf-dmg-area
[282.691960] Subtest pr-overlay-plane-update-sf-dmg-area: SKIP (0.000s)
[282.777349] [050/156] (738s left) kms_invalid_mode (zero-clock)
[282.868335] Starting subtest: zero-clock
[282.870607] Starting dynamic subtest: pipe-A-eDP-1
[283.153630] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.285s)
[283.164172] Starting dynamic subtest: pipe-B-eDP-1
[283.166621] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[283.177475] Starting dynamic subtest: pipe-C-eDP-1
[283.179747] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[283.189625] Starting dynamic subtest: pipe-D-eDP-1
[283.191884] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[283.194105] Subtest zero-clock: SUCCESS (0.290s)
[284.033587] [051/156] (737s left) kms_frontbuffer_tracking (fbc-tiling-y)
[284.132192] Starting subtest: fbc-tiling-y
[284.136473] Subtest fbc-tiling-y: SKIP (0.000s)
[284.215814] [052/156] (737s left) kms_frontbuffer_tracking (psrhdr-1p-primscrn-pri-indfb-draw-mmap-wc)
[284.310135] Starting subtest: psrhdr-1p-primscrn-pri-indfb-draw-mmap-wc
[284.314306] Subtest psrhdr-1p-primscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[284.410816] [053/156] (736s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-render)
[284.506323] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-render
[284.510861] Subtest fbc-2p-scndscrn-spr-indfb-draw-render: SKIP (0.000s)
[284.606034] [054/156] (736s left) kms_plane_scaling (plane-scaler-unity-scaling-with-modifiers)
[284.698715] Starting subtest: plane-scaler-unity-scaling-with-modifiers
[284.700798] Starting dynamic subtest: pipe-A
[285.046646] Dynamic subtest pipe-A: SUCCESS (0.350s)
[285.057583] Starting dynamic subtest: pipe-B
[286.435923] Dynamic subtest pipe-B: SUCCESS (1.388s)
[286.448145] Starting dynamic subtest: pipe-C
[287.885717] Dynamic subtest pipe-C: SUCCESS (1.448s)
[287.896571] Starting dynamic subtest: pipe-D
[289.317617] Dynamic subtest pipe-D: SUCCESS (1.431s)
[289.319921] Subtest plane-scaler-unity-scaling-with-modifiers: SUCCESS (4.622s)
[290.472292] [055/156] (730s left) gen3_render_tiledy_blits
[290.586148] [056/156] (730s left) perf_pmu (idle)
[290.622785] Starting subtest: idle
[290.624986] Starting dynamic subtest: rcs0
[291.170050] Dynamic subtest rcs0: SUCCESS (0.546s)
[291.183995] Starting dynamic subtest: bcs0
[291.695177] Dynamic subtest bcs0: SUCCESS (0.518s)
[291.706193] Starting dynamic subtest: vcs0
[292.206159] Dynamic subtest vcs0: SUCCESS (0.512s)
[292.218276] Starting dynamic subtest: vcs1
[292.730166] Dynamic subtest vcs1: SUCCESS (0.521s)
[292.740895] Starting dynamic subtest: vecs0
[293.251099] Dynamic subtest vecs0: SUCCESS (0.517s)
[293.262172] Starting dynamic subtest: ccs0
[293.774799] Dynamic subtest ccs0: SUCCESS (0.521s)
[293.777776] Subtest idle: SUCCESS (3.153s)
[293.872469] [057/156] (727s left) kms_chamelium_hpd (dp-hpd-enable-disable-mode)
[294.262851] Subtest dp-hpd-enable-disable-mode: SKIP (0.000s)
[295.067723] [058/156] (726s left) gem_render_copy (y-tiled-ccs-to-yf-tiled)
[295.127057] Starting subtest: y-tiled-ccs-to-yf-tiled
[295.131871] Subtest y-tiled-ccs-to-yf-tiled: SKIP (0.000s)
[295.326059] [059/156] (726s left) kms_atomic_transition (plane-all-modeset-transition)
[295.421337] Starting subtest: plane-all-modeset-transition
[295.425849] Subtest plane-all-modeset-transition: SKIP (0.000s)
[295.498167] [060/156] (726s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-blt)
[295.588043] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-blt
[295.592495] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-blt: SKIP (0.000s)
[295.712393] [061/156] (725s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-mmap-gtt)
[295.811655] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-mmap-gtt
[295.815617] Subtest fbc-1p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[295.892008] [062/156] (725s left) kms_rmfb (rmfb-ioctl)
[295.977647] Starting subtest: rmfb-ioctl
[295.979842] Starting dynamic subtest: pipe-A-eDP-1
[296.081657] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.105s)
[296.093834] Starting dynamic subtest: pipe-B-eDP-1
[297.248835] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.166s)
[297.260307] Starting dynamic subtest: pipe-C-eDP-1
[298.479822] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.230s)
[298.491592] Starting dynamic subtest: pipe-D-eDP-1
[299.615012] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.134s)
[299.617288] Subtest rmfb-ioctl: SUCCESS (3.641s)
[300.828747] [063/156] (720s left) gem_pxp (display-protected-crc)
[300.959620] Starting subtest: display-protected-crc
[302.670067] Subtest display-protected-crc: SUCCESS (1.714s)
[302.782088] [064/156] (719s left) gem_mmap_gtt (cpuset-big-copy-xy)
[302.830452] Subtest cpuset-big-copy-XY: SKIP (0.000s)
[302.885107] [065/156] (718s left) syncobj_timeline (etime-multi-wait-for-submit-unsubmitted-submitted)
[302.942104] Starting subtest: etime-multi-wait-for-submit-unsubmitted-submitted
[303.046318] Subtest etime-multi-wait-for-submit-unsubmitted-submitted: SUCCESS (0.103s)
[303.135901] [066/156] (718s left) gem_exec_parallel (engines)
[303.188657] Starting subtest: engines
[303.191155] Starting dynamic subtest: basic
[305.394097] Dynamic subtest basic: SUCCESS (2.203s)
[305.407458] Starting dynamic subtest: contexts
[309.776912] Dynamic subtest contexts: SUCCESS (4.382s)
[309.793282] Starting dynamic subtest: fds
[313.531733] Dynamic subtest fds: SUCCESS (3.754s)
[313.544217] Starting dynamic subtest: userptr
[315.377474] Dynamic subtest userptr: SUCCESS (1.844s)
[315.380206] Subtest engines: SUCCESS (12.191s)
[315.573861] [067/156] (706s left) kms_content_protection (content-type-change)
[315.720494] Starting subtest: content-type-change
[315.724946] Subtest content-type-change: SKIP (0.000s)
[315.893494] [068/156] (706s left) i915_pm_freq_api (freq-reset)
[315.941775] Starting subtest: freq-reset
[315.944072] Starting dynamic subtest: gt0
[316.139206] Dynamic subtest gt0: SUCCESS (0.196s)
[316.149942] Starting dynamic subtest: gt1
[316.316839] Dynamic subtest gt1: SUCCESS (0.176s)
[316.319235] Subtest freq-reset: SUCCESS (0.374s)
[316.396292] [069/156] (705s left) gem_exec_schedule (preempt-contexts)
[316.460515] Starting subtest: preempt-contexts
[316.462722] Starting dynamic subtest: rcs0
[316.510368] Dynamic subtest rcs0: SUCCESS (0.055s)
[316.521567] Starting dynamic subtest: bcs0
[316.567499] Dynamic subtest bcs0: SUCCESS (0.056s)
[316.578444] Starting dynamic subtest: vcs0
[316.616968] Dynamic subtest vcs0: SUCCESS (0.048s)
[316.628671] Starting dynamic subtest: vcs1
[316.665277] Dynamic subtest vcs1: SUCCESS (0.048s)
[316.676572] Starting dynamic subtest: vecs0
[316.710070] Dynamic subtest vecs0: SUCCESS (0.043s)
[316.720947] Starting dynamic subtest: ccs0
[316.753736] Dynamic subtest ccs0: SUCCESS (0.043s)
[316.756051] Subtest preempt-contexts: SUCCESS (0.300s)
[318.486495] [070/156] (703s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-0-hflip)
[318.593128] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-0-hflip
[319.650865] Subtest 4-tiled-max-hw-stride-32bpp-rotate-0-hflip: SUCCESS (1.056s)
[319.760328] [071/156] (702s left) kms_psr (fbc-psr2-sprite-mmap-gtt)
[319.853764] Starting subtest: fbc-psr2-sprite-mmap-gtt
[319.855702] Starting dynamic subtest: eDP-1
[319.859256] Dynamic subtest eDP-1: SKIP (0.000s)
[319.862951] Subtest fbc-psr2-sprite-mmap-gtt: SKIP (0.001s)
[319.928633] [072/156] (702s left) kms_fence_pin_leak
[320.102309] [073/156] (702s left) sw_sync (sync_random_merge)
[320.137318] Starting subtest: sync_random_merge
[320.182506] Subtest sync_random_merge: SUCCESS (0.046s)
[320.247054] [074/156] (702s left) gem_render_copy (linear-to-vebox-y-tiled)
[320.302727] Starting subtest: linear-to-vebox-y-tiled
[320.305966] Subtest linear-to-vebox-y-tiled: SKIP (0.000s)
[320.486128] [075/156] (701s left) kms_cursor_legacy (flip-vs-cursor-atomic)
[320.603687] Starting subtest: flip-vs-cursor-atomic
[328.132472] Subtest flip-vs-cursor-atomic: SUCCESS (7.529s)
[328.952233] [076/156] (693s left) kms_frontbuffer_tracking (psr-rgb565-draw-mmap-cpu)
[329.054152] Starting subtest: psr-rgb565-draw-mmap-cpu
[335.933578] Subtest psr-rgb565-draw-mmap-cpu: SUCCESS (6.886s)
[336.037837] [077/156] (686s left) kms_cursor_crc (cursor-offscreen-max-size)
[336.362575] Starting subtest: cursor-offscreen-max-size
[336.369205] Subtest cursor-offscreen-max-size: SKIP (0.000s)
[336.493682] [078/156] (685s left) kms_flip (2x-dpms-vs-vblank-race-interruptible)
[336.599632] Starting subtest: 2x-dpms-vs-vblank-race-interruptible
[336.612456] Subtest 2x-dpms-vs-vblank-race-interruptible: SKIP (0.011s)
[336.713839] [079/156] (685s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip)
[336.810416] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip
[336.814310] Subtest yf-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip: SKIP (0.000s)
[336.912013] [080/156] (685s left) i915_query (query-topology-known-pci-ids)
[336.954068] Starting subtest: query-topology-known-pci-ids
[336.957630] Subtest query-topology-known-pci-ids: SKIP (0.000s)
[337.053036] [081/156] (685s left) kms_flip (dpms-vs-vblank-race-interruptible)
[337.138302] Starting subtest: dpms-vs-vblank-race-interruptible
[337.140186] Starting dynamic subtest: A-eDP1
[341.017192] Dynamic subtest A-eDP1: SUCCESS (3.872s)
[341.028114] Starting dynamic subtest: B-eDP1
[344.620682] Dynamic subtest B-eDP1: SUCCESS (3.599s)
[344.632200] Starting dynamic subtest: C-eDP1
[349.253794] Dynamic subtest C-eDP1: SUCCESS (4.630s)
[349.266743] Starting dynamic subtest: D-eDP1
[353.914092] Dynamic subtest D-eDP1: SUCCESS (4.658s)
[353.916400] Subtest dpms-vs-vblank-race-interruptible: SUCCESS (16.771s)
[354.788681] [082/156] (667s left) gem_close_race (basic-process)
[354.867491] Starting subtest: basic-process
[354.930838] Subtest basic-process: SUCCESS (0.064s)
[355.153903] [083/156] (667s left) kms_frontbuffer_tracking (hdr-2p-scndscrn-pri-indfb-draw-pwrite)
[355.263717] Starting subtest: hdr-2p-scndscrn-pri-indfb-draw-pwrite
[355.267738] Subtest hdr-2p-scndscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[355.380779] [084/156] (667s left) kms_atomic_interruptible (legacy-pageflip)
[355.476264] Starting subtest: legacy-pageflip
[355.478533] Starting dynamic subtest: pipe-A-eDP-1
[362.923067] Dynamic subtest pipe-A-eDP-1: SUCCESS (7.444s)
[362.925295] Subtest legacy-pageflip: SUCCESS (7.446s)
[363.765876] [085/156] (659s left) api_intel_bb (reset-flags)
[363.823927] Starting subtest: reset-flags
[363.829012] Subtest reset-flags: SUCCESS (0.007s)
[363.960025] [086/156] (658s left) kms_addfb_basic (unused-modifier)
[364.009478] Starting subtest: unused-modifier
[364.011415] Subtest unused-modifier: SUCCESS (0.000s)
[364.175483] [087/156] (658s left) kms_cursor_crc (cursor-sliding-64x21)
[364.377135] Starting subtest: cursor-sliding-64x21
[364.426046] Subtest cursor-sliding-64x21: SKIP (0.043s)
[364.684561] [088/156] (658s left) gem_wait (busy)
[364.743629] Starting subtest: busy
[364.745742] Starting dynamic subtest: all-engines
[366.385645] Dynamic subtest all-engines: SUCCESS (1.640s)
[366.398113] Starting dynamic subtest: rcs0
[366.930077] Dynamic subtest rcs0: SUCCESS (0.543s)
[366.940594] Starting dynamic subtest: bcs0
[367.470704] Dynamic subtest bcs0: SUCCESS (0.540s)
[367.481046] Starting dynamic subtest: vcs0
[369.393512] Dynamic subtest vcs0: SUCCESS (1.920s)
[369.405047] Starting dynamic subtest: vcs1
[371.377364] Dynamic subtest vcs1: SUCCESS (1.981s)
[371.390908] Starting dynamic subtest: vecs0
[373.425508] Dynamic subtest vecs0: SUCCESS (2.045s)
[373.438608] Starting dynamic subtest: ccs0
[373.967938] Dynamic subtest ccs0: SUCCESS (0.541s)
[373.970791] Subtest busy: SUCCESS (9.224s)
[374.166509] [089/156] (648s left) kms_multipipe_modeset (basic-max-pipe-crc-check)
[374.258517] Starting subtest: basic-max-pipe-crc-check
[374.262975] Subtest basic-max-pipe-crc-check: SKIP (0.000s)
[374.308033] [090/156] (648s left) kms_psr2_sf (fbc-pr-cursor-plane-update-sf)
[374.403075] Starting subtest: fbc-pr-cursor-plane-update-sf
[374.407438] Subtest fbc-pr-cursor-plane-update-sf: SKIP (0.000s)
[374.473363] [091/156] (648s left) kms_tiled_display (basic-test-pattern-with-chamelium)
[374.583571] Subtest basic-test-pattern-with-chamelium: SKIP (0.000s)
[374.634620] [092/156] (648s left) syncobj_wait (single-wait-for-submit-signaled)
[374.690945] Starting subtest: single-wait-for-submit-signaled
[374.692949] Subtest single-wait-for-submit-signaled: SUCCESS (0.000s)
[374.812369] [093/156] (648s left) i915_drm_fdinfo (memory-info-resident)
[374.851572] Starting subtest: memory-info-resident
[374.853713] Starting dynamic subtest: smem0
[377.472618] Dynamic subtest smem0: SUCCESS (2.621s)
[377.474876] Subtest memory-info-resident: SUCCESS (2.622s)
[377.559085] [094/156] (645s left) kms_psr (psr2-sprite-plane-onoff)
[377.666705] Starting subtest: psr2-sprite-plane-onoff
[377.668693] Starting dynamic subtest: eDP-1
[379.457420] Dynamic subtest eDP-1: SUCCESS (1.789s)
[379.459616] Subtest psr2-sprite-plane-onoff: SUCCESS (1.790s)
[380.314727] [095/156] (642s left) kms_flip (flip-vs-suspend)
[380.402765] Starting subtest: flip-vs-suspend
[380.405077] Starting dynamic subtest: A-eDP1
[525.900249] Dynamic subtest A-eDP1: SUCCESS (11.269s)
[525.904360] Subtest flip-vs-suspend: SUCCESS (11.271s)
[526.036942] [096/156] (497s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-offscreen-pri-shrfb-draw-pwrite)
[526.142321] Starting subtest: fbcpsrhdr-1p-offscreen-pri-shrfb-draw-pwrite
[526.146010] Subtest fbcpsrhdr-1p-offscreen-pri-shrfb-draw-pwrite: SKIP (0.000s)
[526.266895] [097/156] (497s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip)
[526.362878] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip
[527.008778] Subtest x-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip: SUCCESS (0.648s)
[527.171467] [098/156] (496s left) api_intel_allocator (reserve-simple)
[527.221704] Starting subtest: reserve-simple
[527.226149] Subtest reserve-simple: SUCCESS (0.003s)
[527.338776] [099/156] (496s left) gem_exec_reloc (basic-cpu-gtt)
[527.394712] Subtest basic-cpu-gtt: SKIP (0.000s)
[527.466837] [100/156] (495s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-primscrn-cur-indfb-draw-pwrite)
[527.569485] Starting subtest: fbcpsrhdr-2p-primscrn-cur-indfb-draw-pwrite
[527.573505] Subtest fbcpsrhdr-2p-primscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[527.668390] [101/156] (495s left) kms_prop_blob (invalid-get-prop-any)
[527.725388] Starting subtest: invalid-get-prop-any
[527.727353] Subtest invalid-get-prop-any: SUCCESS (0.000s)
[527.831166] [102/156] (495s left) drm_read (invalid-buffer)
[527.970026] Starting subtest: invalid-buffer
[527.972030] Subtest invalid-buffer: SUCCESS (0.000s)
[528.095649] [103/156] (495s left) kms_big_fb (x-tiled-8bpp-rotate-90)
[528.189628] Starting subtest: x-tiled-8bpp-rotate-90
[528.213197] Subtest x-tiled-8bpp-rotate-90: SKIP (0.022s)
[528.326729] [104/156] (495s left) kms_plane_cursor (primary)
[528.431260] Starting subtest: primary
[528.434822] Starting dynamic subtest: pipe-A-eDP-1-size-64
[531.026200] Dynamic subtest pipe-A-eDP-1-size-64: SUCCESS (2.598s)
[531.054162] Starting dynamic subtest: pipe-A-eDP-1-size-128
[533.626426] Dynamic subtest pipe-A-eDP-1-size-128: SUCCESS (2.582s)
[533.652957] Starting dynamic subtest: pipe-A-eDP-1-size-256
[536.193163] Dynamic subtest pipe-A-eDP-1-size-256: SUCCESS (2.550s)
[536.511252] Starting dynamic subtest: pipe-B-eDP-1-size-64
[539.783414] Dynamic subtest pipe-B-eDP-1-size-64: SUCCESS (3.288s)
[539.811182] Starting dynamic subtest: pipe-B-eDP-1-size-128
[542.361729] Dynamic subtest pipe-B-eDP-1-size-128: SUCCESS (2.560s)
[542.388785] Starting dynamic subtest: pipe-B-eDP-1-size-256
[544.983900] Dynamic subtest pipe-B-eDP-1-size-256: SUCCESS (2.605s)
[545.303598] Starting dynamic subtest: pipe-C-eDP-1-size-64
[548.205965] Dynamic subtest pipe-C-eDP-1-size-64: SUCCESS (2.916s)
[548.235321] Starting dynamic subtest: pipe-C-eDP-1-size-128
[550.427521] Dynamic subtest pipe-C-eDP-1-size-128: SUCCESS (2.203s)
[550.461666] Starting dynamic subtest: pipe-C-eDP-1-size-256
[552.670983] Dynamic subtest pipe-C-eDP-1-size-256: SUCCESS (2.225s)
[552.993520] Starting dynamic subtest: pipe-D-eDP-1-size-64
[555.998132] Dynamic subtest pipe-D-eDP-1-size-64: SUCCESS (3.017s)
[556.026703] Starting dynamic subtest: pipe-D-eDP-1-size-128
[558.231435] Dynamic subtest pipe-D-eDP-1-size-128: SUCCESS (2.214s)
[558.260625] Starting dynamic subtest: pipe-D-eDP-1-size-256
[560.465986] Dynamic subtest pipe-D-eDP-1-size-256: SUCCESS (2.214s)
[560.777558] Subtest primary: SUCCESS (32.356s)
[561.598507] [105/156] (462s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-primscrn-spr-indfb-fullscreen)
[561.713537] Starting subtest: fbcpsrhdr-2p-primscrn-spr-indfb-fullscreen
[561.717909] Subtest fbcpsrhdr-2p-primscrn-spr-indfb-fullscreen: SKIP (0.000s)
[561.825214] [106/156] (461s left) kms_frontbuffer_tracking (psrhdr-1p-offscreen-pri-shrfb-draw-blt)
[561.932989] Starting subtest: psrhdr-1p-offscreen-pri-shrfb-draw-blt
[561.937223] Subtest psrhdr-1p-offscreen-pri-shrfb-draw-blt: SKIP (0.000s)
[562.051585] [107/156] (461s left) gem_ctx_isolation (nonpriv-switch)
[562.116361] Starting subtest: nonpriv-switch
[562.118331] Starting dynamic subtest: rcs0
[562.388763] Dynamic subtest rcs0: SUCCESS (0.275s)
[562.402208] Starting dynamic subtest: bcs0
[562.688335] Dynamic subtest bcs0: SUCCESS (0.299s)
[562.700010] Starting dynamic subtest: vcs0
[562.984574] Dynamic subtest vcs0: SUCCESS (0.295s)
[562.997106] Starting dynamic subtest: vcs1
[564.911858] Dynamic subtest vcs1: SUCCESS (1.926s)
[564.924237] Starting dynamic subtest: vecs0
[566.940621] Dynamic subtest vecs0: SUCCESS (2.028s)
[566.953423] Starting dynamic subtest: ccs0
[568.974037] Dynamic subtest ccs0: SUCCESS (2.032s)
[568.976397] Subtest nonpriv-switch: SUCCESS (6.861s)
[569.216306] [108/156] (454s left) kms_chamelium_audio (dp-audio-edid)
[569.600347] Subtest dp-audio-edid: SKIP (0.000s)
[570.411148] [109/156] (453s left) kms_getfb (getfb-addfb-different-handles)
[570.502872] Starting subtest: getfb-addfb-different-handles
[570.505241] Subtest getfb-addfb-different-handles: SUCCESS (0.000s)
[570.607637] [110/156] (453s left) kms_frontbuffer_tracking (fbcpsr-suspend)
[570.717345] Starting subtest: fbcpsr-suspend
[611.550276] Subtest fbcpsr-suspend: SUCCESS (10.022s)
[611.699504] [111/156] (412s left) dmabuf_sync_file (export-wait-after-attach)
[611.751782] Starting subtest: export-wait-after-attach
[611.753717] Subtest export-wait-after-attach: SUCCESS (0.001s)
[611.806858] [112/156] (412s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-pwrite)
[611.907939] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-pwrite
[611.912111] Subtest psr-2p-primscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[612.034577] [113/156] (411s left) kms_frontbuffer_tracking (hdr-1p-primscrn-shrfb-pgflip-blt)
[612.132052] Starting subtest: hdr-1p-primscrn-shrfb-pgflip-blt
[612.136012] Subtest hdr-1p-primscrn-shrfb-pgflip-blt: SKIP (0.000s)
[612.235536] [114/156] (411s left) gem_ctx_sseu (invalid-sseu)
[612.287487] Subtest invalid-sseu: SKIP (0.000s)
[612.369261] [115/156] (411s left) kms_ccs (crc-sprite-planes-basic-y-tiled-ccs)
[612.458662] Starting subtest: crc-sprite-planes-basic-y-tiled-ccs
[612.460961] Starting dynamic subtest: pipe-A-eDP-1
[612.513766] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[612.526654] Starting dynamic subtest: pipe-B-eDP-1
[612.575029] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[612.586996] Starting dynamic subtest: pipe-C-eDP-1
[612.633193] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[612.644113] Starting dynamic subtest: pipe-D-eDP-1
[612.691101] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[612.694781] Subtest crc-sprite-planes-basic-y-tiled-ccs: SKIP (0.009s)
[614.725981] [116/156] (409s left) kms_atomic_interruptible (atomic-setmode)
[614.828221] Starting subtest: atomic-setmode
[614.830620] Starting dynamic subtest: pipe-A-eDP-1
[621.780042] Dynamic subtest pipe-A-eDP-1: SUCCESS (6.952s)
[621.781979] Subtest atomic-setmode: SUCCESS (6.954s)
[622.652698] [117/156] (401s left) kms_psr (psr-sprite-plane-move)
[622.743292] Starting subtest: psr-sprite-plane-move
[622.745597] Starting dynamic subtest: eDP-1
[624.466021] Dynamic subtest eDP-1: SUCCESS (1.722s)
[624.468430] Subtest psr-sprite-plane-move: SUCCESS (1.724s)
[625.296225] [118/156] (398s left) kms_dirtyfb (fbc-dirtyfb-ioctl)
[625.386421] Starting subtest: fbc-dirtyfb-ioctl
[625.388734] Starting dynamic subtest: A-eDP-1
[627.964370] Dynamic subtest A-eDP-1: SUCCESS (2.579s)
[627.966665] Subtest fbc-dirtyfb-ioctl: SUCCESS (2.580s)
[628.857153] [119/156] (395s left) syncobj_timeline (invalid-query-one-illegal-handle)
[628.906176] Starting subtest: invalid-query-one-illegal-handle
[628.908385] Subtest invalid-query-one-illegal-handle: SUCCESS (0.000s)
[629.001991] [120/156] (395s left) kms_cursor_crc (cursor-rapid-movement-256x85)
[629.249336] Starting subtest: cursor-rapid-movement-256x85
[629.299006] Subtest cursor-rapid-movement-256x85: SKIP (0.046s)
[629.485372] [121/156] (394s left) kms_atomic_transition (modeset-transition)
[629.569363] Starting subtest: modeset-transition
[629.571375] Starting dynamic subtest: 1x-outputs
[640.660505] Dynamic subtest 1x-outputs: SUCCESS (11.094s)
[640.662902] Subtest modeset-transition: SUCCESS (11.095s)
[641.533051] [122/156] (382s left) kms_draw_crc (draw-method-mmap-cpu)
[641.626653] Starting subtest: draw-method-mmap-cpu
[641.628818] Starting dynamic subtest: xrgb8888-untiled
[641.857975] Dynamic subtest xrgb8888-untiled: SUCCESS (0.232s)
[641.869282] Starting dynamic subtest: rgb565-untiled
[642.058198] Dynamic subtest rgb565-untiled: SUCCESS (0.199s)
[642.069379] Starting dynamic subtest: xrgb2101010-untiled
[642.280846] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.221s)
[642.292520] Starting dynamic subtest: xbgr16161616f-untiled
[642.502416] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.222s)
[642.513648] Starting dynamic subtest: xrgb8888-xtiled
[642.646812] Dynamic subtest xrgb8888-xtiled: SUCCESS (0.143s)
[642.658372] Starting dynamic subtest: rgb565-xtiled
[642.780305] Dynamic subtest rgb565-xtiled: SUCCESS (0.133s)
[642.791466] Starting dynamic subtest: xrgb2101010-xtiled
[642.913571] Dynamic subtest xrgb2101010-xtiled: SUCCESS (0.133s)
[642.925071] Starting dynamic subtest: xbgr16161616f-xtiled
[643.047051] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (0.133s)
[643.058244] Starting dynamic subtest: xrgb8888-4tiled
[643.191289] Dynamic subtest xrgb8888-4tiled: SUCCESS (0.143s)
[643.202291] Starting dynamic subtest: rgb565-4tiled
[643.336135] Dynamic subtest rgb565-4tiled: SUCCESS (0.144s)
[643.354556] Starting dynamic subtest: xrgb2101010-4tiled
[643.469202] Dynamic subtest xrgb2101010-4tiled: SUCCESS (0.132s)
[643.479954] Starting dynamic subtest: xbgr16161616f-4tiled
[643.613991] Dynamic subtest xbgr16161616f-4tiled: SUCCESS (0.144s)
[643.615912] Subtest draw-method-mmap-cpu: SUCCESS (1.989s)
[643.724260] [123/156] (380s left) gem_close_race (multigpu-basic-threads)
[643.788861] Starting subtest: multigpu-basic-threads
[643.792610] Subtest multigpu-basic-threads: SKIP (0.000s)
[644.015638] [124/156] (380s left) gem_gpgpu_fill (basic)
[644.076610] Starting subtest: basic
[644.078787] Starting dynamic subtest: smem
[644.085159] Dynamic subtest smem: SUCCESS (0.008s)
[644.087452] Subtest basic: SUCCESS (0.009s)
[644.219237] [125/156] (380s left) kms_frontbuffer_tracking (psrhdr-2p-primscrn-spr-indfb-fullscreen)
[644.323174] Starting subtest: psrhdr-2p-primscrn-spr-indfb-fullscreen
[644.327352] Subtest psrhdr-2p-primscrn-spr-indfb-fullscreen: SKIP (0.000s)
[644.427546] [126/156] (380s left) kms_plane_scaling (planes-upscale-factor-0-25)
[644.513589] Starting subtest: planes-upscale-factor-0-25
[644.515791] Starting dynamic subtest: pipe-A
[644.574138] Dynamic subtest pipe-A: SUCCESS (0.063s)
[644.587296] Starting dynamic subtest: pipe-B
[645.748080] Dynamic subtest pipe-B: SUCCESS (1.172s)
[645.760900] Starting dynamic subtest: pipe-C
[646.856124] Dynamic subtest pipe-C: SUCCESS (1.106s)
[646.867892] Starting dynamic subtest: pipe-D
[647.995890] Dynamic subtest pipe-D: SUCCESS (1.139s)
[647.998198] Subtest planes-upscale-factor-0-25: SUCCESS (3.484s)
[649.148167] [127/156] (375s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-indfb-msflip-blt)
[649.249707] Starting subtest: fbcpsr-2p-scndscrn-indfb-msflip-blt
[649.254065] Subtest fbcpsr-2p-scndscrn-indfb-msflip-blt: SKIP (0.000s)
[649.360529] [128/156] (375s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-mmap-cpu)
[649.466052] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-mmap-cpu
[649.470052] Subtest fbc-2p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[649.559700] [129/156] (375s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-blt)
[649.667655] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-blt
[649.671528] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-blt: SKIP (0.000s)
[649.779183] [130/156] (374s left) kms_frontbuffer_tracking (fbc-rgb565-draw-mmap-cpu)
[649.880123] Starting subtest: fbc-rgb565-draw-mmap-cpu
[653.932216] Subtest fbc-rgb565-draw-mmap-cpu: SUCCESS (4.058s)
[655.066618] [131/156] (369s left) kms_frontbuffer_tracking (psrhdr-1p-primscrn-spr-indfb-draw-blt)
[655.171494] Starting subtest: psrhdr-1p-primscrn-spr-indfb-draw-blt
[655.175923] Subtest psrhdr-1p-primscrn-spr-indfb-draw-blt: SKIP (0.000s)
[655.285880] [132/156] (369s left) kms_frontbuffer_tracking (psrhdr-2p-scndscrn-pri-indfb-draw-render)
[655.386317] Starting subtest: psrhdr-2p-scndscrn-pri-indfb-draw-render
[655.390506] Subtest psrhdr-2p-scndscrn-pri-indfb-draw-render: SKIP (0.000s)
[655.472523] [133/156] (369s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-scndscrn-indfb-pgflip-blt)
[655.574003] Starting subtest: fbcpsrhdr-2p-scndscrn-indfb-pgflip-blt
[655.578000] Subtest fbcpsrhdr-2p-scndscrn-indfb-pgflip-blt: SKIP (0.000s)
[655.687343] [134/156] (369s left) kms_psr (pr-primary-mmap-cpu)
[655.781395] Starting subtest: pr-primary-mmap-cpu
[655.785578] Subtest pr-primary-mmap-cpu: SKIP (0.000s)
[655.856512] [135/156] (369s left) kms_frontbuffer_tracking (hdr-rgb565-draw-render)
[655.953482] Starting subtest: hdr-rgb565-draw-render
[655.957747] Subtest hdr-rgb565-draw-render: SKIP (0.000s)
[656.069360] [136/156] (368s left) gem_userptr_blits (unsync-unmap)
[656.131386] Subtest unsync-unmap: SKIP (0.000s)
[656.265351] [137/156] (368s left) kms_vblank (wait-forked)
[656.344675] Starting subtest: wait-forked
[656.346286] Starting dynamic subtest: pipe-A-eDP-1
[658.164242] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.820s)
[658.181048] Starting dynamic subtest: pipe-D-eDP-1
[660.651907] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.484s)
[660.654285] Subtest wait-forked: SUCCESS (4.308s)
[661.526191] [138/156] (363s left) kms_ccs (crc-primary-suspend-4-tiled-mtl-rc-ccs)
[661.626558] Starting subtest: crc-primary-suspend-4-tiled-mtl-rc-ccs
[661.628841] Starting dynamic subtest: pipe-A-eDP-1
[678.135423] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.436s)
[678.150868] Starting dynamic subtest: pipe-B-eDP-1
[695.096300] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.407s)
[695.109488] Starting dynamic subtest: pipe-C-eDP-1
[712.043635] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.335s)
[712.054869] Starting dynamic subtest: pipe-D-eDP-1
[729.059859] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.374s)
[729.062496] Subtest crc-primary-suspend-4-tiled-mtl-rc-ccs: SUCCESS (8.557s)
[730.215502] [139/156] (294s left) sysfs_heartbeat_interval (invalid)
[730.290208] Starting subtest: invalid
[730.292813] Starting dynamic subtest: vecs0
[730.295583] Dynamic subtest vecs0: SUCCESS (0.000s)
[730.306334] Starting dynamic subtest: ccs0
[730.308701] Dynamic subtest ccs0: SUCCESS (0.000s)
[730.319283] Starting dynamic subtest: vcs0
[730.321525] Dynamic subtest vcs0: SUCCESS (0.000s)
[730.332051] Starting dynamic subtest: bcs0
[730.334652] Dynamic subtest bcs0: SUCCESS (0.000s)
[730.345750] Starting dynamic subtest: rcs0
[730.348218] Dynamic subtest rcs0: SUCCESS (0.000s)
[730.358651] Starting dynamic subtest: vcs1
[730.361171] Dynamic subtest vcs1: SUCCESS (0.000s)
[730.363551] Subtest invalid: SUCCESS (0.005s)
[730.405038] [140/156] (294s left) perf (buffer-fill)
[730.518380] Starting subtest: buffer-fill
[730.520894] Starting dynamic subtest: 0-rcs0
[732.794559] Dynamic subtest 0-rcs0: SUCCESS (2.277s)
[732.806911] Starting dynamic subtest: 1-vecs0
[737.279312] Dynamic subtest 1-vecs0: SUCCESS (4.484s)
[737.281769] Subtest buffer-fill: SUCCESS (6.764s)
[737.333183] [141/156] (287s left) kms_frontbuffer_tracking (fbchdr-1p-primscrn-cur-indfb-draw-mmap-gtt)
[737.430295] Starting subtest: fbchdr-1p-primscrn-cur-indfb-draw-mmap-gtt
[737.435289] Subtest fbchdr-1p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[737.525384] [142/156] (287s left) i915_pm_rpm (gem-pread)
[739.451798] Starting subtest: gem-pread
[741.235697] Subtest gem-pread: SUCCESS (1.782s)
[741.359345] [143/156] (283s left) kms_flip (2x-flip-vs-dpms-off-vs-modeset-interruptible)
[741.464255] Starting subtest: 2x-flip-vs-dpms-off-vs-modeset-interruptible
[741.482040] Subtest 2x-flip-vs-dpms-off-vs-modeset-interruptible: SKIP (0.014s)
[741.564671] [144/156] (283s left) gem_partial_pwrite_pread (writes-after-reads-display)
[741.619669] Subtest writes-after-reads-display: SKIP (0.000s)
[741.679435] [145/156] (283s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-move)
[741.782534] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-move
[749.201546] Subtest fbcpsr-1p-primscrn-cur-indfb-move: SUCCESS (7.426s)
[749.343594] [146/156] (276s left) kms_psr (fbc-psr-sprite-mmap-gtt)
[749.441492] Starting subtest: fbc-psr-sprite-mmap-gtt
[749.444269] Starting dynamic subtest: eDP-1
[749.449267] Dynamic subtest eDP-1: SKIP (0.000s)
[749.454210] Subtest fbc-psr-sprite-mmap-gtt: SKIP (0.001s)
[749.515795] [147/156] (275s left) perf (invalid-create-userspace-config)
[749.607646] Starting subtest: invalid-create-userspace-config
[749.610584] Subtest invalid-create-userspace-config: SUCCESS (0.001s)
[749.659556] [148/156] (275s left) gem_exec_schedule (thriceslice)
[749.733657] Starting subtest: thriceslice
[749.735905] Starting dynamic subtest: rcs0
[749.752886] Dynamic subtest rcs0: SUCCESS (0.031s)
[749.766652] Starting dynamic subtest: bcs0
[749.808874] Dynamic subtest bcs0: SUCCESS (0.054s)
[749.821481] Starting dynamic subtest: vcs0
[749.841513] Dynamic subtest vcs0: SUCCESS (0.031s)
[749.852646] Starting dynamic subtest: vcs1
[749.871429] Dynamic subtest vcs1: SUCCESS (0.029s)
[749.882498] Starting dynamic subtest: vecs0
[749.901672] Dynamic subtest vecs0: SUCCESS (0.029s)
[749.913346] Starting dynamic subtest: ccs0
[749.956576] Dynamic subtest ccs0: SUCCESS (0.054s)
[749.959413] Subtest thriceslice: SUCCESS (0.236s)
[751.369439] [149/156] (274s left) kms_addfb_basic (clobberred-modifier)
[751.426877] Starting subtest: clobberred-modifier
[751.431698] Subtest clobberred-modifier: SKIP (0.000s)
[751.559251] [150/156] (274s left) kms_frontbuffer_tracking (psr-2p-pri-indfb-multidraw)
[751.657371] Starting subtest: psr-2p-pri-indfb-multidraw
[751.662424] Subtest psr-2p-pri-indfb-multidraw: SKIP (0.000s)
[751.747720] [151/156] (273s left) kms_frontbuffer_tracking (fbchdr-rgb565-draw-mmap-cpu)
[751.845427] Starting subtest: fbchdr-rgb565-draw-mmap-cpu
[751.850599] Subtest fbchdr-rgb565-draw-mmap-cpu: SKIP (0.000s)
[751.928153] [152/156] (273s left) kms_frontbuffer_tracking (fbchdr-1p-primscrn-pri-indfb-draw-render)
[752.028530] Starting subtest: fbchdr-1p-primscrn-pri-indfb-draw-render
[752.033507] Subtest fbchdr-1p-primscrn-pri-indfb-draw-render: SKIP (0.000s)
[752.133487] [153/156] (273s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-render)
[752.240446] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-render
[752.245647] Subtest fbc-2p-primscrn-pri-shrfb-draw-render: SKIP (0.000s)
[752.336024] [154/156] (273s left) kms_frontbuffer_tracking (psrhdr-2p-scndscrn-spr-indfb-draw-pwrite)
[752.437893] Starting subtest: psrhdr-2p-scndscrn-spr-indfb-draw-pwrite
[752.441677] Subtest psrhdr-2p-scndscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[752.531193] [155/156] (273s left) perf (gen12-group-exclusive-stream-sample-oa)
[752.615419] Starting subtest: gen12-group-exclusive-stream-sample-oa
[752.634472] Subtest gen12-group-exclusive-stream-sample-oa: SUCCESS (0.019s)
[752.684552] [156/156] (273s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-primscrn-pri-indfb-draw-mmap-gtt)
[752.788535] Starting subtest: fbcpsrhdr-1p-primscrn-pri-indfb-draw-mmap-gtt
[752.793264] Subtest fbcpsrhdr-1p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[752.886962] Closing watchdogs
results: parsing output: 0/ for test: kms_pm_dc
results: parsing output: 1/ for test: kms_cursor_legacy
results: parsing output: 2/ for test: kms_frontbuffer_tracking
results: parsing output: 3/ for test: kms_frontbuffer_tracking
results: parsing output: 4/ for test: syncobj_eventfd
results: parsing output: 5/ for test: kms_plane
results: parsing output: 6/ for test: gem_exec_whisper
results: parsing output: 7/ for test: gem_spin_batch
results: parsing output: 8/ for test: kms_frontbuffer_tracking
results: parsing output: 9/ for test: kms_frontbuffer_tracking
results: parsing output: 10/ for test: i915_query
results: parsing output: 11/ for test: gem_ctx_persistence
results: parsing output: 12/ for test: kms_rotation_crc
results: parsing output: 13/ for test: kms_addfb_basic
results: parsing output: 14/ for test: gem_exec_fence
results: parsing output: 15/ for test: kms_frontbuffer_tracking
results: parsing output: 16/ for test: kms_rotation_crc
results: parsing output: 17/ for test: gem_exec_reloc
results: parsing output: 18/ for test: kms_frontbuffer_tracking
results: parsing output: 19/ for test: kms_big_fb
results: parsing output: 20/ for test: syncobj_basic
results: parsing output: 21/ for test: prime_self_import
results: parsing output: 22/ for test: syncobj_timeline
results: parsing output: 23/ for test: gen7_exec_parse
results: parsing output: 24/ for test: syncobj_timeline
results: parsing output: 25/ for test: kms_flip
results: parsing output: 26/ for test: kms_frontbuffer_tracking
results: parsing output: 27/ for test: kms_frontbuffer_tracking
results: parsing output: 28/ for test: kms_frontbuffer_tracking
results: parsing output: 29/ for test: kms_flip_scaled_crc
results: parsing output: 30/ for test: kms_frontbuffer_tracking
results: parsing output: 31/ for test: kms_ccs
results: parsing output: 32/ for test: gem_exec_balancer
results: parsing output: 33/ for test: kms_big_fb
results: parsing output: 34/ for test: kms_big_fb
results: parsing output: 35/ for test: gem_exec_params
results: parsing output: 36/ for test: gem_exec_balancer
results: parsing output: 37/ for test: syncobj_timeline
results: parsing output: 38/ for test: fbdev
results: parsing output: 39/ for test: kms_psr
results: parsing output: 40/ for test: kms_plane
results: parsing output: 41/ for test: gem_mmap_gtt
results: parsing output: 42/ for test: kms_hdr
results: parsing output: 43/ for test: kms_frontbuffer_tracking
results: parsing output: 44/ for test: kms_color
results: parsing output: 45/ for test: kms_ccs
results: parsing output: 46/ for test: gem_mmap_offset
results: parsing output: 47/ for test: kms_chamelium_frames
results: parsing output: 48/ for test: kms_psr2_sf
results: parsing output: 49/ for test: kms_invalid_mode
results: parsing output: 50/ for test: kms_frontbuffer_tracking
results: parsing output: 51/ for test: kms_frontbuffer_tracking
results: parsing output: 52/ for test: kms_frontbuffer_tracking
results: parsing output: 53/ for test: kms_plane_scaling
results: parsing output: 54/ for test: gen3_render_tiledy_blits
results: parsing output: 55/ for test: perf_pmu
results: parsing output: 56/ for test: kms_chamelium_hpd
results: parsing output: 57/ for test: gem_render_copy
results: parsing output: 58/ for test: kms_atomic_transition
results: parsing output: 59/ for test: kms_frontbuffer_tracking
results: parsing output: 60/ for test: kms_frontbuffer_tracking
results: parsing output: 61/ for test: kms_rmfb
results: parsing output: 62/ for test: gem_pxp
results: parsing output: 63/ for test: gem_mmap_gtt
results: parsing output: 64/ for test: syncobj_timeline
results: parsing output: 65/ for test: gem_exec_parallel
results: parsing output: 66/ for test: kms_content_protection
results: parsing output: 67/ for test: i915_pm_freq_api
results: parsing output: 68/ for test: gem_exec_schedule
results: parsing output: 69/ for test: kms_big_fb
results: parsing output: 70/ for test: kms_psr
results: parsing output: 71/ for test: kms_fence_pin_leak
results: parsing output: 72/ for test: sw_sync
results: parsing output: 73/ for test: gem_render_copy
results: parsing output: 74/ for test: kms_cursor_legacy
results: parsing output: 75/ for test: kms_frontbuffer_tracking
results: parsing output: 76/ for test: kms_cursor_crc
results: parsing output: 77/ for test: kms_flip
results: parsing output: 78/ for test: kms_big_fb
results: parsing output: 79/ for test: i915_query
results: parsing output: 80/ for test: kms_flip
results: parsing output: 81/ for test: gem_close_race
results: parsing output: 82/ for test: kms_frontbuffer_tracking
results: parsing output: 83/ for test: kms_atomic_interruptible
results: parsing output: 84/ for test: api_intel_bb
results: parsing output: 85/ for test: kms_addfb_basic
results: parsing output: 86/ for test: kms_cursor_crc
results: parsing output: 87/ for test: gem_wait
results: parsing output: 88/ for test: kms_multipipe_modeset
results: parsing output: 89/ for test: kms_psr2_sf
results: parsing output: 90/ for test: kms_tiled_display
results: parsing output: 91/ for test: syncobj_wait
results: parsing output: 92/ for test: i915_drm_fdinfo
results: parsing output: 93/ for test: kms_psr
results: parsing output: 94/ for test: kms_flip
results: parsing output: 95/ for test: kms_frontbuffer_tracking
results: parsing output: 96/ for test: kms_big_fb
results: parsing output: 97/ for test: api_intel_allocator
results: parsing output: 98/ for test: gem_exec_reloc
results: parsing output: 99/ for test: kms_frontbuffer_tracking
results: parsing output: 100/ for test: kms_prop_blob
results: parsing output: 101/ for test: drm_read
results: parsing output: 102/ for test: kms_big_fb
results: parsing output: 103/ for test: kms_plane_cursor
results: parsing output: 104/ for test: kms_frontbuffer_tracking
results: parsing output: 105/ for test: kms_frontbuffer_tracking
results: parsing output: 106/ for test: gem_ctx_isolation
results: parsing output: 107/ for test: kms_chamelium_audio
results: parsing output: 108/ for test: kms_getfb
results: parsing output: 109/ for test: kms_frontbuffer_tracking
results: parsing output: 110/ for test: dmabuf_sync_file
results: parsing output: 111/ for test: kms_frontbuffer_tracking
results: parsing output: 112/ for test: kms_frontbuffer_tracking
results: parsing output: 113/ for test: gem_ctx_sseu
results: parsing output: 114/ for test: kms_ccs
results: parsing output: 115/ for test: kms_atomic_interruptible
results: parsing output: 116/ for test: kms_psr
results: parsing output: 117/ for test: kms_dirtyfb
results: parsing output: 118/ for test: syncobj_timeline
results: parsing output: 119/ for test: kms_cursor_crc
results: parsing output: 120/ for test: kms_atomic_transition
results: parsing output: 121/ for test: kms_draw_crc
results: parsing output: 122/ for test: gem_close_race
results: parsing output: 123/ for test: gem_gpgpu_fill
results: parsing output: 124/ for test: kms_frontbuffer_tracking
results: parsing output: 125/ for test: kms_plane_scaling
results: parsing output: 126/ for test: kms_frontbuffer_tracking
results: parsing output: 127/ for test: kms_frontbuffer_tracking
results: parsing output: 128/ for test: kms_frontbuffer_tracking
results: parsing output: 129/ for test: kms_frontbuffer_tracking
results: parsing output: 130/ for test: kms_frontbuffer_tracking
results: parsing output: 131/ for test: kms_frontbuffer_tracking
results: parsing output: 132/ for test: kms_frontbuffer_tracking
results: parsing output: 133/ for test: kms_psr
results: parsing output: 134/ for test: kms_frontbuffer_tracking
results: parsing output: 135/ for test: gem_userptr_blits
results: parsing output: 136/ for test: kms_vblank
results: parsing output: 137/ for test: kms_ccs
results: parsing output: 138/ for test: sysfs_heartbeat_interval
results: parsing output: 139/ for test: perf
results: parsing output: 140/ for test: kms_frontbuffer_tracking
results: parsing output: 141/ for test: i915_pm_rpm
results: parsing output: 142/ for test: kms_flip
results: parsing output: 143/ for test: gem_partial_pwrite_pread
results: parsing output: 144/ for test: kms_frontbuffer_tracking
results: parsing output: 145/ for test: kms_psr
results: parsing output: 146/ for test: perf
results: parsing output: 147/ for test: gem_exec_schedule
results: parsing output: 148/ for test: kms_addfb_basic
results: parsing output: 149/ for test: kms_frontbuffer_tracking
results: parsing output: 150/ for test: kms_frontbuffer_tracking
results: parsing output: 151/ for test: kms_frontbuffer_tracking
results: parsing output: 152/ for test: kms_frontbuffer_tracking
results: parsing output: 153/ for test: kms_frontbuffer_tracking
results: parsing output: 154/ for test: perf
results: parsing output: 155/ for test: kms_frontbuffer_tracking
Done.