[59.491254] Initializing watchdogs
[59.491305]   /dev/watchdog0
[59.505493] [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]
[59.510224] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[59.512408] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[59.515848] [001/133] (960s left) kms_ccs (bad-pixel-format-4-tiled-mtl-rc-ccs-cc)
[59.635949] Starting subtest: bad-pixel-format-4-tiled-mtl-rc-ccs-cc
[59.638297] Starting dynamic subtest: pipe-A-eDP-1
[59.658751] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s)
[59.666599] Starting dynamic subtest: pipe-B-eDP-1
[59.686366] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[59.693059] Starting dynamic subtest: pipe-C-eDP-1
[59.712589] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[59.719406] Starting dynamic subtest: pipe-D-eDP-1
[59.738868] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[59.741097] Subtest bad-pixel-format-4-tiled-mtl-rc-ccs-cc: SUCCESS (0.004s)
[61.942653] [002/133] (958s left) gem_mmap (basic)
[62.007095] Subtest basic: SKIP (0.000s)
[62.057901] [003/133] (958s left) gem_exec_schedule (reorder-wide)
[62.246389] Subtest reorder-wide: SKIP (0.000s)
[62.425810] [004/133] (957s left) kms_flip (basic-flip-vs-wf_vblank)
[62.511982] Starting subtest: basic-flip-vs-wf_vblank
[62.514458] Starting dynamic subtest: A-eDP1
[64.493262] Dynamic subtest A-eDP1: SUCCESS (1.986s)
[64.500160] Starting dynamic subtest: B-eDP1
[66.435423] Dynamic subtest B-eDP1: SUCCESS (1.943s)
[66.444688] Starting dynamic subtest: C-eDP1
[68.349400] Dynamic subtest C-eDP1: SUCCESS (1.915s)
[68.359643] Starting dynamic subtest: D-eDP1
[70.277921] Dynamic subtest D-eDP1: SUCCESS (1.928s)
[70.280376] Subtest basic-flip-vs-wf_vblank: SUCCESS (7.778s)
[71.502197] [005/133] (948s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-mmap-wc)
[71.602975] Starting subtest: psr-1p-primscrn-spr-indfb-draw-mmap-wc
[78.205239] Subtest psr-1p-primscrn-spr-indfb-draw-mmap-wc: SUCCESS (6.610s)
[78.329964] [006/133] (941s left) kms_ccs (crc-sprite-planes-basic-y-tiled-gen12-rc-ccs-cc)
[78.427487] Starting subtest: crc-sprite-planes-basic-y-tiled-gen12-rc-ccs-cc
[78.429721] Starting dynamic subtest: pipe-A-eDP-1
[78.488494] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[78.495986] Starting dynamic subtest: pipe-B-eDP-1
[78.553237] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[78.561496] Starting dynamic subtest: pipe-C-eDP-1
[78.618166] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[78.626703] Starting dynamic subtest: pipe-D-eDP-1
[78.684327] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[78.688662] Subtest crc-sprite-planes-basic-y-tiled-gen12-rc-ccs-cc: SKIP (0.007s)
[80.691071] [007/133] (939s left) gem_ringfill (basic-all)
[86.937199] Starting subtest: basic-all
[88.100698] Subtest basic-all: SUCCESS (1.164s)
[88.247226] [FACT gem_ringfill (basic-all)] new: kernel.kmod_is_loaded.vgem: true
[88.250154] [008/133] (932s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-shrfb-msflip-blt)
[88.364417] Starting subtest: fbcpsr-2p-scndscrn-shrfb-msflip-blt
[88.368719] Subtest fbcpsr-2p-scndscrn-shrfb-msflip-blt: SKIP (0.000s)
[88.451772] [009/133] (931s left) gem_exec_reloc (basic-gtt-read)
[88.521079] Subtest basic-gtt-read: SKIP (0.000s)
[88.589541] [010/133] (931s left) kms_pm_rpm (modeset-lpsp)
[90.111380] Starting subtest: modeset-lpsp
[91.586597] Subtest modeset-lpsp: SUCCESS (1.474s)
[91.686144] [011/133] (928s left) gem_ctx_shared (q-promotion)
[91.743754] Starting subtest: Q-promotion
[91.746153] Starting dynamic subtest: rcs0
[91.850862] Dynamic subtest rcs0: SUCCESS (0.106s)
[91.866502] Starting dynamic subtest: vcs0
[91.930457] Dynamic subtest vcs0: SUCCESS (0.080s)
[91.938413] Starting dynamic subtest: vcs1
[92.033113] Dynamic subtest vcs1: SUCCESS (0.101s)
[92.045385] Starting dynamic subtest: vecs0
[92.115628] Dynamic subtest vecs0: SUCCESS (0.081s)
[92.129566] Starting dynamic subtest: ccs0
[92.209034] Dynamic subtest ccs0: SUCCESS (0.093s)
[92.211455] Subtest Q-promotion: SUCCESS (0.466s)
[93.997788] [012/133] (926s left) kms_psr2_sf (fbc-pr-primary-plane-update-sf-dmg-area)
[94.098176] Starting subtest: fbc-pr-primary-plane-update-sf-dmg-area
[94.102220] Subtest fbc-pr-primary-plane-update-sf-dmg-area: SKIP (0.000s)
[94.164661] [013/133] (926s left) kms_vblank (ts-continuation-modeset)
[94.260163] Starting subtest: ts-continuation-modeset
[94.262105] Starting dynamic subtest: pipe-A-eDP-1
[95.728413] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.468s)
[95.743869] Starting dynamic subtest: pipe-D-eDP-1
[97.882395] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.148s)
[97.884653] Subtest ts-continuation-modeset: SUCCESS (3.623s)
[98.685535] [014/133] (921s left) kms_atomic_transition (plane-all-transition-fencing)
[98.786079] Starting subtest: plane-all-transition-fencing
[98.788406] Starting dynamic subtest: pipe-A-eDP-1
[101.281671] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.498s)
[101.586693] Starting dynamic subtest: pipe-B-eDP-1
[104.818864] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.239s)
[105.117655] Subtest plane-all-transition-fencing: SUCCESS (6.333s)
[105.947987] [015/133] (914s left) kms_cursor_crc (cursor-sliding-max-size)
[106.244579] Starting subtest: cursor-sliding-max-size
[106.251128] Subtest cursor-sliding-max-size: SKIP (0.000s)
[106.381406] [016/133] (914s left) gem_create (create-valid-nonaligned)
[106.451364] Starting subtest: create-valid-nonaligned
[106.453403] Subtest create-valid-nonaligned: SUCCESS (0.000s)
[106.648042] [017/133] (914s left) fbdev (pan)
[106.695651] Starting subtest: pan
[106.718813] Subtest pan: SUCCESS (0.025s)
[106.788763] [018/133] (913s left) kms_properties (invalid-properties-legacy)
[106.884649] Starting subtest: invalid-properties-legacy
[106.991634] Subtest invalid-properties-legacy: SUCCESS (0.106s)
[107.068960] [019/133] (913s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-move)
[107.167649] Starting subtest: fbc-2p-scndscrn-spr-indfb-move
[107.172239] Subtest fbc-2p-scndscrn-spr-indfb-move: SKIP (0.000s)
[107.276055] [020/133] (913s left) kms_cursor_legacy (2x-flip-vs-cursor-atomic)
[107.403959] Starting subtest: 2x-flip-vs-cursor-atomic
[107.408384] Subtest 2x-flip-vs-cursor-atomic: SKIP (0.001s)
[107.548643] [021/133] (913s left) kms_vrr (lobf)
[107.645160] Starting subtest: lobf
[107.649771] Subtest lobf: SKIP (0.000s)
[107.720250] [022/133] (913s left) gem_vm_create (create-ext)
[107.784402] Starting subtest: create-ext
[107.786711] Subtest create-ext: SUCCESS (0.004s)
[107.916953] [023/133] (912s left) gem_exec_schedule (lateslice)
[107.979503] Starting subtest: lateslice
[107.981691] Starting dynamic subtest: rcs0
[107.989390] Dynamic subtest rcs0: SUCCESS (0.020s)
[107.998111] Starting dynamic subtest: bcs0
[108.008480] Dynamic subtest bcs0: SUCCESS (0.018s)
[108.018100] Starting dynamic subtest: vcs0
[108.026137] Dynamic subtest vcs0: SUCCESS (0.017s)
[108.033454] Starting dynamic subtest: vcs1
[108.043464] Dynamic subtest vcs1: SUCCESS (0.017s)
[108.050618] Starting dynamic subtest: vecs0
[108.060063] Dynamic subtest vecs0: SUCCESS (0.016s)
[108.067288] Starting dynamic subtest: ccs0
[108.078155] Dynamic subtest ccs0: SUCCESS (0.017s)
[108.080075] Subtest lateslice: SUCCESS (0.109s)
[109.990444] [024/133] (910s left) gem_spin_batch (legacy-resubmit)
[110.048863] Starting subtest: legacy-resubmit
[110.051237] Starting dynamic subtest: default
[110.056683] Dynamic subtest default: SUCCESS (0.005s)
[110.067715] Starting dynamic subtest: render
[110.070026] Dynamic subtest render: SUCCESS (0.001s)
[110.077839] Starting dynamic subtest: bsd
[110.079803] Dynamic subtest bsd: SUCCESS (0.003s)
[110.087115] Starting dynamic subtest: bsd1
[110.088985] Dynamic subtest bsd1: SUCCESS (0.002s)
[110.096195] Starting dynamic subtest: bsd2
[110.098072] Dynamic subtest bsd2: SUCCESS (0.001s)
[110.105392] Starting dynamic subtest: blt
[110.107311] Dynamic subtest blt: SUCCESS (0.002s)
[110.114548] Starting dynamic subtest: vebox
[110.116437] Dynamic subtest vebox: SUCCESS (0.002s)
[110.118336] Subtest legacy-resubmit: SUCCESS (0.020s)
[110.312772] [025/133] (910s left) kms_busy (extended-pageflip-hang-oldfb)
[110.423977] Starting subtest: extended-pageflip-hang-oldfb
[110.426350] Starting dynamic subtest: pipe-A
[110.827344] Dynamic subtest pipe-A: SUCCESS (0.402s)
[110.836271] Starting dynamic subtest: pipe-D
[111.952683] Dynamic subtest pipe-D: SUCCESS (1.124s)
[111.955015] Subtest extended-pageflip-hang-oldfb: SUCCESS (1.530s)
[112.814916] [026/133] (908s left) tools_test (sysfs_l3_parity)
[112.866562] Starting subtest: sysfs_l3_parity
[112.934593] Subtest sysfs_l3_parity: SKIP (0.080s)
[112.988760] [027/133] (908s left) vgem_basic (second-client)
[113.033128] Starting subtest: second-client
[113.052569] Subtest second-client: SUCCESS (0.022s)
[113.109793] [028/133] (908s left) gem_exec_whisper (basic-fds-priority-all)
[113.169564] Starting subtest: basic-fds-priority-all
[135.061792] Subtest basic-fds-priority-all: SUCCESS (21.890s)
[135.261407] [029/133] (885s left) kms_universal_plane (disable-primary-vs-flip)
[135.354589] Starting subtest: disable-primary-vs-flip
[135.356798] Starting dynamic subtest: pipe-A-eDP-1
[136.862452] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.505s)
[136.872030] Starting dynamic subtest: pipe-B-eDP-1
[139.046485] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.184s)
[139.055131] Starting dynamic subtest: pipe-C-eDP-1
[141.311222] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.264s)
[141.319740] Starting dynamic subtest: pipe-D-eDP-1
[143.559437] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.246s)
[143.561743] Subtest disable-primary-vs-flip: SUCCESS (8.205s)
[144.368125] [030/133] (876s left) i915_query (query-topology-known-pci-ids)
[144.432905] Starting subtest: query-topology-known-pci-ids
[144.437894] Subtest query-topology-known-pci-ids: SKIP (0.000s)
[144.554440] [031/133] (876s left) gem_create (create-ext-cpu-access-sanity-check)
[144.713946] Starting subtest: create-ext-cpu-access-sanity-check
[144.718786] Subtest create-ext-cpu-access-sanity-check: SKIP (0.001s)
[144.790575] [032/133] (876s left) kms_ccs (crc-primary-basic-y-tiled-ccs)
[144.897951] Starting subtest: crc-primary-basic-y-tiled-ccs
[144.900291] Starting dynamic subtest: pipe-A-eDP-1
[144.923520] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[144.934051] Starting dynamic subtest: pipe-B-eDP-1
[144.955453] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[144.964166] Starting dynamic subtest: pipe-C-eDP-1
[144.986528] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[144.995876] Starting dynamic subtest: pipe-D-eDP-1
[145.017714] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[145.022045] Subtest crc-primary-basic-y-tiled-ccs: SKIP (0.006s)
[147.161376] [033/133] (874s left) api_intel_bb (object-reloc-keep-cache)
[147.227033] Starting subtest: object-reloc-keep-cache
[147.231444] Subtest object-reloc-keep-cache: SKIP (0.003s)
[147.353919] [034/133] (874s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip)
[147.447303] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip
[147.451634] Subtest yf-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip: SKIP (0.000s)
[147.546714] [035/133] (873s left) kms_ccs (crc-primary-suspend-4-tiled-dg2-rc-ccs-cc)
[147.629203] Starting subtest: crc-primary-suspend-4-tiled-dg2-rc-ccs-cc
[147.631507] Starting dynamic subtest: pipe-A-eDP-1
[147.640341] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[147.649176] Starting dynamic subtest: pipe-B-eDP-1
[147.658566] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[147.669165] Starting dynamic subtest: pipe-C-eDP-1
[147.677600] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[147.685973] Starting dynamic subtest: pipe-D-eDP-1
[147.695168] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[147.699465] Subtest crc-primary-suspend-4-tiled-dg2-rc-ccs-cc: SKIP (0.004s)
[149.916791] [036/133] (871s left) gem_softpin (evict-active)
[149.978241] Starting subtest: evict-active
[149.985481] Subtest evict-active: SUCCESS (0.008s)
[150.102436] [037/133] (871s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-mmap-gtt)
[150.201105] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-mmap-gtt
[150.205559] Subtest psr-2p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[150.316277] [038/133] (871s left) kms_lease (lease-get)
[150.411113] Starting subtest: lease-get
[150.413608] Starting dynamic subtest: pipe-A-eDP-1
[150.416039] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[150.424852] Starting dynamic subtest: pipe-B-eDP-1
[150.427346] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[150.435623] Starting dynamic subtest: pipe-C-eDP-1
[150.437692] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[150.446107] Starting dynamic subtest: pipe-D-eDP-1
[150.448347] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[150.450491] Subtest lease-get: SUCCESS (0.008s)
[150.529051] [039/133] (871s left) kms_draw_crc (draw-method-mmap-cpu)
[150.636188] Starting subtest: draw-method-mmap-cpu
[150.638172] Starting dynamic subtest: xrgb8888-untiled
[150.914372] Dynamic subtest xrgb8888-untiled: SUCCESS (0.281s)
[150.922644] Starting dynamic subtest: rgb565-untiled
[151.159464] Dynamic subtest rgb565-untiled: SUCCESS (0.244s)
[151.168098] Starting dynamic subtest: xrgb2101010-untiled
[151.384489] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.222s)
[151.394368] Starting dynamic subtest: xbgr16161616f-untiled
[151.626481] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.243s)
[151.635118] Starting dynamic subtest: xrgb8888-xtiled
[151.759084] Dynamic subtest xrgb8888-xtiled: SUCCESS (0.133s)
[151.769322] Starting dynamic subtest: rgb565-xtiled
[151.903324] Dynamic subtest rgb565-xtiled: SUCCESS (0.142s)
[151.911476] Starting dynamic subtest: xrgb2101010-xtiled
[152.036800] Dynamic subtest xrgb2101010-xtiled: SUCCESS (0.133s)
[152.045509] Starting dynamic subtest: xbgr16161616f-xtiled
[152.169935] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (0.133s)
[152.178308] Starting dynamic subtest: xrgb8888-4tiled
[152.325678] Dynamic subtest xrgb8888-4tiled: SUCCESS (0.155s)
[152.334524] Starting dynamic subtest: rgb565-4tiled
[152.470100] Dynamic subtest rgb565-4tiled: SUCCESS (0.144s)
[152.478409] Starting dynamic subtest: xrgb2101010-4tiled
[152.614720] Dynamic subtest xrgb2101010-4tiled: SUCCESS (0.144s)
[152.625726] Starting dynamic subtest: xbgr16161616f-4tiled
[152.748448] Dynamic subtest xbgr16161616f-4tiled: SUCCESS (0.133s)
[152.750309] Subtest draw-method-mmap-cpu: SUCCESS (2.115s)
[152.837597] [040/133] (868s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-render)
[152.941326] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-render
[152.944912] Subtest psr-2p-scndscrn-cur-indfb-draw-render: SKIP (0.000s)
[153.036354] [041/133] (868s left) kms_addfb_basic (unused-modifier)
[153.094249] Starting subtest: unused-modifier
[153.096065] Subtest unused-modifier: SUCCESS (0.000s)
[153.224994] [042/133] (868s left) kms_big_fb (4-tiled-64bpp-rotate-270)
[153.336684] Starting subtest: 4-tiled-64bpp-rotate-270
[153.356923] Subtest 4-tiled-64bpp-rotate-270: SKIP (0.020s)
[153.471057] [043/133] (868s left) kms_atomic_transition (plane-all-modeset-transition-internal-panels)
[153.557068] Starting subtest: plane-all-modeset-transition-internal-panels
[153.558825] Starting dynamic subtest: pipe-A-eDP-1
[154.863079] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.305s)
[155.150101] Starting dynamic subtest: pipe-B-eDP-1
[156.201055] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.059s)
[156.469706] Subtest plane-all-modeset-transition-internal-panels: SUCCESS (2.913s)
[157.304152] [044/133] (864s left) kms_atomic (plane-primary-overlay-mutable-zpos)
[157.405968] Starting subtest: plane-primary-overlay-mutable-zpos
[160.868625] Subtest plane-primary-overlay-mutable-zpos: SKIP (3.462s)
[162.055137] [045/133] (859s left) gem_exec_params (invalid-fence-in-submit)
[162.114413] Starting subtest: invalid-fence-in-submit
[162.119145] Subtest invalid-fence-in-submit: SUCCESS (0.004s)
[162.246648] [046/133] (859s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-0)
[162.341056] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-0
[163.352931] Subtest x-tiled-max-hw-stride-64bpp-rotate-0: SUCCESS (1.013s)
[163.491337] [047/133] (858s left) kms_pm_dc (dc5-dpms-negative)
[164.601302] Starting subtest: dc5-dpms-negative
[164.605817] Subtest dc5-dpms-negative: SKIP (0.000s)
[164.672835] [048/133] (857s left) gem_exec_fence (concurrent)
[164.857885] Starting subtest: concurrent
[164.863050] Subtest concurrent: SKIP (0.000s)
[167.034114] [049/133] (854s left) syncobj_eventfd (timeline-wait-signaled)
[167.089104] Starting subtest: timeline-wait-signaled
[167.091313] Subtest timeline-wait-signaled: SUCCESS (0.000s)
[167.197882] [050/133] (854s left) kms_chamelium_hpd (dp-hpd-storm)
[167.597241] Subtest dp-hpd-storm: SKIP (0.000s)
[168.372107] [051/133] (853s left) kms_flip_scaled_crc (flip-32bpp-xtile-to-64bpp-xtile-downscaling)
[168.468845] Starting subtest: flip-32bpp-xtile-to-64bpp-xtile-downscaling
[168.471241] Starting dynamic subtest: pipe-A-default-mode
[169.653556] Dynamic subtest pipe-A-default-mode: SKIP (1.182s)
[169.657388] Subtest flip-32bpp-xtile-to-64bpp-xtile-downscaling: SKIP (1.183s)
[169.811571] [052/133] (852s left) kms_plane_scaling (plane-scaler-unity-scaling-with-modifiers)
[169.911067] Starting subtest: plane-scaler-unity-scaling-with-modifiers
[169.913455] Starting dynamic subtest: pipe-A
[170.273137] Dynamic subtest pipe-A: SUCCESS (0.364s)
[170.282157] Starting dynamic subtest: pipe-B
[171.712800] Dynamic subtest pipe-B: SUCCESS (1.438s)
[171.722414] Starting dynamic subtest: pipe-C
[173.204982] Dynamic subtest pipe-C: SUCCESS (1.491s)
[173.214849] Starting dynamic subtest: pipe-D
[174.583288] Dynamic subtest pipe-D: SUCCESS (1.378s)
[174.585583] Subtest plane-scaler-unity-scaling-with-modifiers: SUCCESS (4.674s)
[175.760389] [053/133] (846s left) kms_setmode (invalid-clone-single-crtc-stealing)
[175.823493] Starting subtest: invalid-clone-single-crtc-stealing
[175.829975] Subtest invalid-clone-single-crtc-stealing: SKIP (0.000s)
[175.932234] [054/133] (846s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip)
[176.045087] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip
[176.839637] Subtest 4-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip: SUCCESS (0.795s)
[176.988821] [055/133] (845s left) syncobj_timeline (multi-wait-available-signaled)
[177.037049] Starting subtest: multi-wait-available-signaled
[177.039223] Subtest multi-wait-available-signaled: SUCCESS (0.000s)
[177.121244] [056/133] (845s left) kms_pipe_crc_basic (bad-source)
[177.210478] Starting subtest: bad-source
[177.212341] Subtest bad-source: SUCCESS (0.000s)
[177.298722] [057/133] (845s left) kms_content_protection (srm)
[177.438943] Starting subtest: srm
[177.446165] Subtest srm: SKIP (0.002s)
[177.549555] [058/133] (844s left) kms_psr (fbc-pr-no-drrs)
[177.639895] Starting subtest: fbc-pr-no-drrs
[177.644044] Subtest fbc-pr-no-drrs: SKIP (0.000s)
[177.714488] [059/133] (844s left) gem_exec_suspend (basic)
[177.771239] Starting subtest: basic
[177.772783] Starting dynamic subtest: smem
[178.901994] Dynamic subtest smem: SUCCESS (1.130s)
[178.904812] Subtest basic: SUCCESS (1.133s)
[179.089070] [060/133] (843s left) kms_force_connector_basic (force-connector-state)
[179.164968] Starting subtest: force-connector-state
[179.790428] Subtest force-connector-state: SUCCESS (0.625s)
[180.714984] [061/133] (841s left) perf_pmu (most-busy-check-all)
[180.765335] Starting subtest: most-busy-check-all
[180.767258] Starting dynamic subtest: rcs0
[181.908995] Dynamic subtest rcs0: SUCCESS (1.143s)
[181.919994] Starting dynamic subtest: bcs0
[183.893924] Dynamic subtest bcs0: SUCCESS (1.981s)
[183.905448] Starting dynamic subtest: vcs0
[185.877790] Dynamic subtest vcs0: SUCCESS (1.980s)
[185.889176] Starting dynamic subtest: vcs1
[187.925843] Dynamic subtest vcs1: SUCCESS (2.045s)
[187.936799] Starting dynamic subtest: vecs0
[189.910340] Dynamic subtest vecs0: SUCCESS (1.981s)
[189.923406] Starting dynamic subtest: ccs0
[191.893846] Dynamic subtest ccs0: SUCCESS (1.981s)
[191.896815] Subtest most-busy-check-all: SUCCESS (11.129s)
[191.994448] [062/133] (830s left) gem_exec_flush (basic-uc-ro-default)
[192.063252] Starting subtest: basic-uc-ro-default
[197.529213] Subtest basic-uc-ro-default: SUCCESS (5.468s)
[197.719434] [063/133] (824s left) kms_cursor_legacy (cursorb-vs-flipa-atomic)
[197.839674] Starting subtest: cursorB-vs-flipA-atomic
[197.844182] Subtest cursorB-vs-flipA-atomic: SKIP (0.001s)
[197.991554] [064/133] (824s left) gem_media_vme
[198.101203] [065/133] (824s left) syncobj_timeline (invalid-single-wait-all-unsubmitted)
[198.154704] Starting subtest: invalid-single-wait-all-unsubmitted
[198.156792] Subtest invalid-single-wait-all-unsubmitted: SUCCESS (0.000s)
[198.237332] [066/133] (824s left) kms_big_fb (y-tiled-16bpp-rotate-180)
[198.327699] Starting subtest: y-tiled-16bpp-rotate-180
[198.332114] Subtest y-tiled-16bpp-rotate-180: SKIP (0.000s)
[198.425593] [067/133] (824s left) gem_fence_thrash (bo-write-verify-threaded-none)
[198.463291] Starting subtest: bo-write-verify-threaded-none
[198.480905] Subtest bo-write-verify-threaded-none: SKIP (0.015s)
[198.540376] [068/133] (824s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-pwrite)
[198.630747] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-pwrite
[205.483291] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-pwrite: SUCCESS (6.854s)
[205.610093] [069/133] (817s left) gen9_exec_parse (shadow-peek)
[205.681744] Subtest shadow-peek: SKIP (0.000s)
[205.746746] [070/133] (817s left) kms_flip (bo-too-big-interruptible)
[205.851227] Starting subtest: bo-too-big-interruptible
[205.853470] Starting dynamic subtest: A-eDP1
[207.104334] Dynamic subtest A-eDP1: SUCCESS (1.251s)
[207.116102] Starting dynamic subtest: B-eDP1
[208.407077] Dynamic subtest B-eDP1: SUCCESS (1.301s)
[208.420952] Starting dynamic subtest: C-eDP1
[209.707226] Dynamic subtest C-eDP1: SUCCESS (1.296s)
[209.725974] Starting dynamic subtest: D-eDP1
[211.011532] Dynamic subtest D-eDP1: SUCCESS (1.302s)
[211.017497] Subtest bo-too-big-interruptible: SUCCESS (5.164s)
[212.179072] [071/133] (810s left) kms_cursor_legacy (forked-bo)
[212.296597] Starting subtest: forked-bo
[212.298871] Starting dynamic subtest: pipe-A
[217.768329] Dynamic subtest pipe-A: SUCCESS (5.468s)
[217.780308] Starting dynamic subtest: pipe-B
[223.256617] Dynamic subtest pipe-B: SUCCESS (5.485s)
[223.273886] Starting dynamic subtest: pipe-C
[228.730473] Dynamic subtest pipe-C: SUCCESS (5.471s)
[228.741155] Starting dynamic subtest: pipe-D
[234.208849] Dynamic subtest pipe-D: SUCCESS (5.476s)
[234.219958] Starting dynamic subtest: all-pipes
[239.709539] Dynamic subtest all-pipes: SUCCESS (5.498s)
[239.712058] Subtest forked-bo: SUCCESS (27.410s)
[239.853622] [072/133] (783s left) syncobj_timeline (transfer-timeline-point)
[239.920181] Starting subtest: transfer-timeline-point
[239.922534] Subtest transfer-timeline-point: SUCCESS (0.001s)
[240.016460] [073/133] (782s left) kms_psr (fbc-psr2-sprite-render)
[240.123360] Starting subtest: fbc-psr2-sprite-render
[240.125716] Starting dynamic subtest: eDP-1
[240.130200] Dynamic subtest eDP-1: SKIP (0.000s)
[240.134288] Subtest fbc-psr2-sprite-render: SKIP (0.002s)
[240.220955] [074/133] (782s left) kms_3d (basic)
[240.285056] Starting subtest: basic
[242.309907] Subtest basic: SUCCESS (2.025s)
[242.780398] [075/133] (780s left) kms_chamelium_audio (hdmi-audio)
[243.179767] Subtest hdmi-audio: SKIP (0.000s)
[243.966892] [076/133] (779s left) kms_joiner (invalid-modeset-force-big-joiner)
[244.072288] Starting subtest: invalid-modeset-force-big-joiner
[244.076303] Subtest invalid-modeset-force-big-joiner: SKIP (0.000s)
[244.138300] [077/133] (779s left) gem_eio (execbuf)
[244.357956] Starting subtest: execbuf
[244.668843] Subtest execbuf: SUCCESS (0.311s)
[244.782782] [078/133] (778s left) kms_psr2_sf (pr-overlay-plane-move-continuous-sf)
[244.875721] Starting subtest: pr-overlay-plane-move-continuous-sf
[244.879987] Subtest pr-overlay-plane-move-continuous-sf: SKIP (0.000s)
[244.945580] [079/133] (778s left) gen9_exec_parse (basic-rejected-ctx-param)
[245.005921] Subtest basic-rejected-ctx-param: SKIP (0.000s)
[245.084199] [080/133] (778s left) gem_tiling_max_stride
[245.202453] [081/133] (778s left) gem_render_copy (mixed-tiled-to-y-tiled-ccs)
[245.252460] Starting subtest: mixed-tiled-to-y-tiled-ccs
[245.256024] Subtest mixed-tiled-to-y-tiled-ccs: SKIP (0.000s)
[245.433450] [082/133] (777s left) gem_ctx_exec (basic-norecovery)
[245.490105] Starting subtest: basic-norecovery
[245.811601] Subtest basic-norecovery: SUCCESS (0.322s)
[245.928135] [083/133] (777s left) kms_big_fb (x-tiled-32bpp-rotate-90)
[246.022237] Starting subtest: x-tiled-32bpp-rotate-90
[246.045255] Subtest x-tiled-32bpp-rotate-90: SKIP (0.022s)
[246.163413] [084/133] (777s left) kms_hdr (invalid-metadata-sizes)
[246.260881] Starting subtest: invalid-metadata-sizes
[246.267339] Subtest invalid-metadata-sizes: SKIP (0.000s)
[246.334105] [085/133] (777s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-render)
[246.438352] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-render
[253.281957] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-render: SUCCESS (6.844s)
[253.420838] [086/133] (770s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-indfb-draw-render)
[253.521896] Starting subtest: fbc-1p-offscreen-pri-indfb-draw-render
[257.673030] Subtest fbc-1p-offscreen-pri-indfb-draw-render: SUCCESS (4.155s)
[258.789821] [087/133] (764s left) syncobj_timeline (etime-single-wait-all-for-submit-available-unsubmitted)
[258.850468] Starting subtest: etime-single-wait-all-for-submit-available-unsubmitted
[258.954136] Subtest etime-single-wait-all-for-submit-available-unsubmitted: SUCCESS (0.104s)
[259.044268] [088/133] (764s left) kms_frontbuffer_tracking (fbc-1p-primscrn-indfb-plflip-blt)
[259.143066] Starting subtest: fbc-1p-primscrn-indfb-plflip-blt
[263.750582] Subtest fbc-1p-primscrn-indfb-plflip-blt: SUCCESS (4.609s)
[264.888737] [089/133] (758s left) kms_frontbuffer_tracking (psr-1p-primscrn-indfb-plflip-blt)
[264.981816] Starting subtest: psr-1p-primscrn-indfb-plflip-blt
[272.339659] Subtest psr-1p-primscrn-indfb-plflip-blt: SUCCESS (7.361s)
[272.468025] [090/133] (751s left) kms_rotation_crc (primary-y-tiled-reflect-x-90)
[272.566062] Starting subtest: primary-y-tiled-reflect-x-90
[272.570358] Subtest primary-y-tiled-reflect-x-90: SKIP (0.001s)
[272.643573] [091/133] (751s left) kms_pipe_crc_basic (read-crc-frame-sequence)
[272.731753] Starting subtest: read-crc-frame-sequence
[272.733888] Starting dynamic subtest: pipe-A-eDP-1
[273.451493] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.718s)
[273.461593] Starting dynamic subtest: pipe-B-eDP-1
[274.829622] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.377s)
[274.839474] Starting dynamic subtest: pipe-C-eDP-1
[276.182328] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.349s)
[276.191865] Starting dynamic subtest: pipe-D-eDP-1
[277.485587] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.303s)
[277.488016] Subtest read-crc-frame-sequence: SUCCESS (4.755s)
[278.293392] [092/133] (745s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-mmap-cpu)
[278.387331] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-mmap-cpu
[281.894722] Subtest fbc-1p-primscrn-spr-indfb-draw-mmap-cpu: SUCCESS (3.510s)
[283.086634] [093/133] (740s left) perf (buffer-fill)
[283.200174] Starting subtest: buffer-fill
[283.202091] Starting dynamic subtest: 0-rcs0
[285.471640] Dynamic subtest 0-rcs0: SUCCESS (2.271s)
[285.481962] Starting dynamic subtest: 1-vcs1
[289.910682] Dynamic subtest 1-vcs1: SUCCESS (4.438s)
[289.913087] Subtest buffer-fill: SUCCESS (6.711s)
[289.960235] [094/133] (733s left) kms_chamelium_edid (dp-edid-change-during-suspend)
[290.340858] Subtest dp-edid-change-during-suspend: SKIP (0.000s)
[291.153506] [095/133] (732s left) kms_cursor_crc (cursor-rapid-movement-64x64)
[291.354732] Starting subtest: cursor-rapid-movement-64x64
[291.359685] Starting dynamic subtest: pipe-A-eDP-1
[291.909889] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.551s)
[291.941221] Starting dynamic subtest: pipe-D-eDP-1
[293.164637] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.232s)
[293.167058] Subtest cursor-rapid-movement-64x64: SUCCESS (1.812s)
[294.002974] [096/133] (729s left) i915_hangman (gt-engine-error)
[294.055753] Starting subtest: gt-engine-error
[294.058038] Starting dynamic subtest: rcs0
[295.860377] Dynamic subtest rcs0: SUCCESS (1.803s)
[295.872388] Starting dynamic subtest: bcs0
[297.844253] Dynamic subtest bcs0: SUCCESS (1.981s)
[297.856893] Starting dynamic subtest: vcs0
[299.891977] Dynamic subtest vcs0: SUCCESS (2.045s)
[299.905765] Starting dynamic subtest: vcs1
[301.876348] Dynamic subtest vcs1: SUCCESS (1.981s)
[301.892473] Starting dynamic subtest: vecs0
[303.859979] Dynamic subtest vecs0: SUCCESS (1.981s)
[303.872252] Starting dynamic subtest: ccs0
[305.844870] Dynamic subtest ccs0: SUCCESS (1.982s)
[305.848024] Subtest gt-engine-error: SUCCESS (11.789s)
[305.997799] [097/133] (718s left) gem_mmap_wc (pf-nonblock)
[306.074715] Subtest pf-nonblock: SKIP (0.000s)
[306.134691] [098/133] (717s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-cpu)
[306.231853] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-cpu
[306.238071] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[306.336422] [099/133] (717s left) gem_partial_pwrite_pread (writes-after-reads-snoop)
[306.390714] Subtest writes-after-reads-snoop: SKIP (0.000s)
[306.459797] [100/133] (717s left) gem_mmap_gtt (hang-user)
[306.534887] Subtest hang-user: SKIP (0.000s)
[306.596963] [101/133] (717s left) syncobj_timeline (wait-delayed-signal)
[306.661466] Starting subtest: wait-delayed-signal
[306.763054] Subtest wait-delayed-signal: SUCCESS (0.102s)
[306.855875] [102/133] (717s left) kms_color_pipeline (plane-lut1d-post-ctm3x4)
[306.953799] Starting subtest: plane-lut1d-post-ctm3x4
[307.111217] Starting dynamic subtest: pipe-A-plane-0
[307.288186] Dynamic subtest pipe-A-plane-0: SUCCESS (0.177s)
[307.298135] Starting dynamic subtest: pipe-A-plane-1
[307.443940] Dynamic subtest pipe-A-plane-1: SUCCESS (0.155s)
[307.453937] Starting dynamic subtest: pipe-A-plane-2
[307.588391] Dynamic subtest pipe-A-plane-2: SUCCESS (0.144s)
[308.794678] Starting dynamic subtest: pipe-B-plane-0
[308.986569] Dynamic subtest pipe-B-plane-0: SUCCESS (0.200s)
[308.996681] Starting dynamic subtest: pipe-B-plane-1
[309.187069] Dynamic subtest pipe-B-plane-1: SUCCESS (0.199s)
[309.196697] Starting dynamic subtest: pipe-B-plane-2
[309.376078] Dynamic subtest pipe-B-plane-2: SUCCESS (0.186s)
[310.536241] Starting dynamic subtest: pipe-C-plane-0
[310.683194] Dynamic subtest pipe-C-plane-0: SUCCESS (0.155s)
[310.692992] Starting dynamic subtest: pipe-C-plane-1
[310.839262] Dynamic subtest pipe-C-plane-1: SUCCESS (0.155s)
[310.849420] Starting dynamic subtest: pipe-C-plane-2
[311.005476] Dynamic subtest pipe-C-plane-2: SUCCESS (0.166s)
[312.235378] Starting dynamic subtest: pipe-D-plane-0
[312.366882] Dynamic subtest pipe-D-plane-0: SUCCESS (0.144s)
[312.376654] Starting dynamic subtest: pipe-D-plane-1
[312.511594] Dynamic subtest pipe-D-plane-1: SUCCESS (0.144s)
[312.521292] Starting dynamic subtest: pipe-D-plane-2
[312.667277] Dynamic subtest pipe-D-plane-2: SUCCESS (0.155s)
[312.954098] Subtest plane-lut1d-post-ctm3x4: SUCCESS (6.002s)
[313.775326] [103/133] (710s left) kms_psr (psr2-suspend)
[313.877149] Starting subtest: psr2-suspend
[313.879408] Starting dynamic subtest: eDP-1
[332.000135] Dynamic subtest eDP-1: SUCCESS (3.406s)
[332.002662] Subtest psr2-suspend: SUCCESS (3.407s)
[340.885648] [104/133] (691s left) gem_exec_balancer (noheartbeat)
[341.214567] Starting subtest: noheartbeat
[341.220076] Subtest noheartbeat: SKIP (0.000s)
[341.323910] [105/133] (691s left) kms_cursor_crc (cursor-offscreen-32x10)
[341.501409] Starting subtest: cursor-offscreen-32x10
[341.549562] Subtest cursor-offscreen-32x10: SKIP (0.046s)
[341.837651] [106/133] (690s left) i915_power (sanity)
[341.890167] Starting subtest: sanity
[345.940470] Subtest sanity: SUCCESS (4.078s)
[347.676729] [107/133] (684s left) sw_sync (sync_merge_invalid)
[347.721330] Starting subtest: sync_merge_invalid
[347.735132] Subtest sync_merge_invalid: SUCCESS (0.015s)
[347.807262] [108/133] (684s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-mmap-wc)
[347.905091] Starting subtest: fbcpsr-rgb565-draw-mmap-wc
[354.655740] Subtest fbcpsr-rgb565-draw-mmap-wc: SUCCESS (6.778s)
[354.770266] [109/133] (677s left) kms_plane (pixel-format-4-tiled-dg2-rc-ccs-cc-modifier-source-clamping)
[354.863327] Starting subtest: pixel-format-4-tiled-dg2-rc-ccs-cc-modifier-source-clamping
[354.867572] Subtest pixel-format-4-tiled-dg2-rc-ccs-cc-modifier-source-clamping: SKIP (0.000s)
[354.935956] [110/133] (677s left) gem_flink_basic (flink-lifetime)
[354.988989] Starting subtest: flink-lifetime
[354.991438] Subtest flink-lifetime: SUCCESS (0.002s)
[355.102598] [111/133] (677s left) gem_lmem_evict (dontneed-evict-race)
[355.144003] Subtest dontneed-evict-race: SKIP (0.000s)
[355.193815] [112/133] (677s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-mmap-wc)
[355.293346] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-mmap-wc
[355.297508] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[355.400911] [113/133] (677s left) syncobj_wait (multi-wait-all-for-submit-submitted)
[355.458130] Starting subtest: multi-wait-all-for-submit-submitted
[355.565892] Subtest multi-wait-all-for-submit-submitted: SUCCESS (0.108s)
[355.645052] [114/133] (677s left) kms_plane_scaling (planes-downscale-factor-0-75-upscale-20x20)
[355.729235] Starting subtest: planes-downscale-factor-0-75-upscale-20x20
[355.731559] Starting dynamic subtest: pipe-A
[355.792386] Dynamic subtest pipe-A: SUCCESS (0.065s)
[355.804384] Starting dynamic subtest: pipe-B
[356.959909] Dynamic subtest pipe-B: SUCCESS (1.169s)
[356.973212] Starting dynamic subtest: pipe-C
[358.047572] Dynamic subtest pipe-C: SUCCESS (1.088s)
[358.061098] Starting dynamic subtest: pipe-D
[359.149422] Dynamic subtest pipe-D: SUCCESS (1.103s)
[359.151607] Subtest planes-downscale-factor-0-75-upscale-20x20: SUCCESS (3.430s)
[360.368166] [115/133] (672s left) kms_scaling_modes (scaling-mode-center)
[360.468941] Starting subtest: scaling-mode-center
[360.471069] Starting dynamic subtest: pipe-A-eDP-1
[360.563160] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.096s)
[360.576581] Starting dynamic subtest: pipe-B-eDP-1
[361.749996] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.185s)
[361.762033] Starting dynamic subtest: pipe-C-eDP-1
[362.934076] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.183s)
[362.944466] Starting dynamic subtest: pipe-D-eDP-1
[364.137879] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.201s)
[364.140260] Subtest scaling-mode-center: SUCCESS (3.675s)
[365.373792] [116/133] (667s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-mmap-cpu)
[365.479741] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-mmap-cpu
[365.483640] Subtest psr-2p-scndscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[365.575980] [117/133] (667s left) kms_plane (pixel-format-yf-tiled-ccs-modifier)
[365.677475] Starting subtest: pixel-format-yf-tiled-ccs-modifier
[365.681510] Subtest pixel-format-yf-tiled-ccs-modifier: SKIP (0.000s)
[365.763781] [118/133] (667s left) kms_psr (fbc-psr2-cursor-mmap-gtt)
[365.843960] Starting subtest: fbc-psr2-cursor-mmap-gtt
[365.845899] Starting dynamic subtest: eDP-1
[365.849976] Dynamic subtest eDP-1: SKIP (0.000s)
[365.854051] Subtest fbc-psr2-cursor-mmap-gtt: SKIP (0.001s)
[365.918075] [119/133] (667s left) syncobj_basic (bad-fd-to-handle)
[365.976954] Starting subtest: bad-fd-to-handle
[365.978951] Subtest bad-fd-to-handle: SUCCESS (0.000s)
[366.084785] [120/133] (666s left) kms_setmode (basic-clone-single-crtc)
[366.145090] Starting subtest: basic-clone-single-crtc
[366.152067] Subtest basic-clone-single-crtc: SKIP (0.000s)
[366.264970] [121/133] (666s left) kms_cursor_legacy (cursora-vs-flipb-legacy)
[366.382752] Starting subtest: cursorA-vs-flipB-legacy
[366.386632] Subtest cursorA-vs-flipB-legacy: SKIP (0.001s)
[366.530673] [122/133] (666s left) kms_flip (flip-vs-panning)
[366.623435] Starting subtest: flip-vs-panning
[366.627801] Starting dynamic subtest: A-eDP1
[375.336141] Dynamic subtest A-eDP1: SUCCESS (8.716s)
[375.347663] Starting dynamic subtest: B-eDP1
[384.020396] Dynamic subtest B-eDP1: SUCCESS (8.688s)
[384.030425] Starting dynamic subtest: C-eDP1
[392.713918] Dynamic subtest C-eDP1: SUCCESS (8.696s)
[392.723782] Starting dynamic subtest: D-eDP1
[401.406704] Dynamic subtest D-eDP1: SUCCESS (8.696s)
[401.410894] Subtest flip-vs-panning: SUCCESS (34.809s)
[402.631399] [123/133] (630s left) drm_read (short-buffer-wakeup)
[402.776118] Starting subtest: short-buffer-wakeup
[434.993979] Subtest short-buffer-wakeup: SUCCESS (32.215s)
[435.141260] [124/133] (598s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-shrfb-pgflip-blt)
[435.242922] Starting subtest: fbc-2p-scndscrn-shrfb-pgflip-blt
[435.247346] Subtest fbc-2p-scndscrn-shrfb-pgflip-blt: SKIP (0.000s)
[435.344502] [125/133] (597s left) i915_pm_rpm (gem-mmap-type)
[436.865417] Starting subtest: gem-mmap-type
[436.868023] Starting dynamic subtest: wb-smem0
[440.757008] Dynamic subtest wb-smem0: SUCCESS (3.885s)
[440.767700] Starting dynamic subtest: wc-smem0
[443.640325] Dynamic subtest wc-smem0: SUCCESS (2.880s)
[443.650736] Starting dynamic subtest: uc-smem0
[446.498438] Dynamic subtest uc-smem0: SUCCESS (2.855s)
[446.500768] Subtest gem-mmap-type: SUCCESS (9.624s)
[446.604339] [126/133] (586s left) kms_flip (single-buffer-flip-vs-dpms-off-vs-modeset)
[446.700167] Starting subtest: single-buffer-flip-vs-dpms-off-vs-modeset
[446.702464] Starting dynamic subtest: A-eDP1
[450.371839] Dynamic subtest A-eDP1: SUCCESS (3.670s)
[450.386622] Starting dynamic subtest: B-eDP1
[453.670340] Dynamic subtest B-eDP1: SUCCESS (3.294s)
[453.681198] Starting dynamic subtest: C-eDP1
[456.991174] Dynamic subtest C-eDP1: SUCCESS (3.318s)
[457.001368] Starting dynamic subtest: D-eDP1
[460.287287] Dynamic subtest D-eDP1: SUCCESS (3.294s)
[460.289816] Subtest single-buffer-flip-vs-dpms-off-vs-modeset: SUCCESS (13.584s)
[461.167174] [127/133] (572s left) kms_flip (flip-vs-rmfb)
[461.273047] Starting subtest: flip-vs-rmfb
[461.275306] Starting dynamic subtest: A-eDP1
[469.912528] Dynamic subtest A-eDP1: SUCCESS (8.639s)
[469.927825] Starting dynamic subtest: B-eDP1
[478.622839] Dynamic subtest B-eDP1: SUCCESS (8.707s)
[478.632960] Starting dynamic subtest: C-eDP1
[487.302761] Dynamic subtest C-eDP1: SUCCESS (8.678s)
[487.312985] Starting dynamic subtest: D-eDP1
[495.997808] Dynamic subtest D-eDP1: SUCCESS (8.693s)
[496.002243] Subtest flip-vs-rmfb: SUCCESS (34.730s)
[497.152751] [128/133] (536s left) kms_flip_scaled_crc (flip-64bpp-linear-to-16bpp-linear-downscaling)
[497.247422] Starting subtest: flip-64bpp-linear-to-16bpp-linear-downscaling
[497.249732] Starting dynamic subtest: pipe-A-default-mode
[498.384792] Dynamic subtest pipe-A-default-mode: SKIP (1.135s)
[498.388561] Subtest flip-64bpp-linear-to-16bpp-linear-downscaling: SKIP (1.137s)
[498.523724] [129/133] (534s left) api_intel_allocator (fork-simple-stress)
[498.574260] Starting subtest: fork-simple-stress
[503.971542] Subtest fork-simple-stress: SUCCESS (5.397s)
[504.128653] [130/133] (529s left) kms_psr (pr-dpms)
[504.233293] Starting subtest: pr-dpms
[504.237732] Subtest pr-dpms: SKIP (0.000s)
[504.311948] [131/133] (529s left) gem_ctx_persistence (legacy-engines-hostile)
[504.387198] Starting subtest: legacy-engines-hostile
[504.389593] Starting dynamic subtest: render
[504.512389] Dynamic subtest render: SUCCESS (0.124s)
[504.528141] Starting dynamic subtest: bsd1
[504.648116] Dynamic subtest bsd1: SUCCESS (0.132s)
[504.663413] Starting dynamic subtest: bsd2
[504.758171] Dynamic subtest bsd2: SUCCESS (0.107s)
[504.771090] Starting dynamic subtest: blt
[504.867235] Dynamic subtest blt: SUCCESS (0.106s)
[504.883191] Starting dynamic subtest: vebox
[504.978626] Dynamic subtest vebox: SUCCESS (0.108s)
[504.981007] Subtest legacy-engines-hostile: SUCCESS (0.593s)
[505.064036] [132/133] (528s left) sriov_basic (bind-unbind-vf)
[505.142883] Starting subtest: bind-unbind-vf
[505.144928] Starting dynamic subtest: vf-1
[505.206814] Dynamic subtest vf-1: FAIL (0.018s)
[505.222199] Starting dynamic subtest: vf-2
[505.281009] Dynamic subtest vf-2: FAIL (0.004s)
[505.296868] Starting dynamic subtest: vf-3
[505.357400] Dynamic subtest vf-3: FAIL (0.004s)
[505.367756] Starting dynamic subtest: vf-4
[505.424568] Dynamic subtest vf-4: FAIL (0.004s)
[505.437191] Starting dynamic subtest: vf-5
[505.494123] Dynamic subtest vf-5: FAIL (0.004s)
[505.504007] Starting dynamic subtest: vf-6
[505.560684] Dynamic subtest vf-6: FAIL (0.004s)
[505.570536] Starting dynamic subtest: vf-7
[505.630393] Dynamic subtest vf-7: FAIL (0.004s)
[505.641221] Starting dynamic subtest: vf-random
[505.700825] Dynamic subtest vf-random: FAIL (0.004s)
[505.711571] Starting dynamic subtest: vf-last
[505.771871] Dynamic subtest vf-last: FAIL (0.004s)
[505.773619] Subtest bind-unbind-vf: FAIL (0.058s)
[505.816692] [133/133] (527s left) gem_exec_fence (syncobj-channel)
[506.308333] Starting subtest: syncobj-channel
[507.329177] Subtest syncobj-channel: SUCCESS (1.017s)
[507.687530] Closing watchdogs
results: parsing output: 0/ for test: kms_ccs
results: parsing output: 1/ for test: gem_mmap
results: parsing output: 2/ for test: gem_exec_schedule
results: parsing output: 3/ for test: kms_flip
results: parsing output: 4/ for test: kms_frontbuffer_tracking
results: parsing output: 5/ for test: kms_ccs
results: parsing output: 6/ for test: gem_ringfill
results: parsing output: 7/ for test: kms_frontbuffer_tracking
results: parsing output: 8/ for test: gem_exec_reloc
results: parsing output: 9/ for test: kms_pm_rpm
results: parsing output: 10/ for test: gem_ctx_shared
results: parsing output: 11/ for test: kms_psr2_sf
results: parsing output: 12/ for test: kms_vblank
results: parsing output: 13/ for test: kms_atomic_transition
results: parsing output: 14/ for test: kms_cursor_crc
results: parsing output: 15/ for test: gem_create
results: parsing output: 16/ for test: fbdev
results: parsing output: 17/ for test: kms_properties
results: parsing output: 18/ for test: kms_frontbuffer_tracking
results: parsing output: 19/ for test: kms_cursor_legacy
results: parsing output: 20/ for test: kms_vrr
results: parsing output: 21/ for test: gem_vm_create
results: parsing output: 22/ for test: gem_exec_schedule
results: parsing output: 23/ for test: gem_spin_batch
results: parsing output: 24/ for test: kms_busy
results: parsing output: 25/ for test: tools_test
results: parsing output: 26/ for test: vgem_basic
results: parsing output: 27/ for test: gem_exec_whisper
results: parsing output: 28/ for test: kms_universal_plane
results: parsing output: 29/ for test: i915_query
results: parsing output: 30/ for test: gem_create
results: parsing output: 31/ for test: kms_ccs
results: parsing output: 32/ for test: api_intel_bb
results: parsing output: 33/ for test: kms_big_fb
results: parsing output: 34/ for test: kms_ccs
results: parsing output: 35/ for test: gem_softpin
results: parsing output: 36/ for test: kms_frontbuffer_tracking
results: parsing output: 37/ for test: kms_lease
results: parsing output: 38/ for test: kms_draw_crc
results: parsing output: 39/ for test: kms_frontbuffer_tracking
results: parsing output: 40/ for test: kms_addfb_basic
results: parsing output: 41/ for test: kms_big_fb
results: parsing output: 42/ for test: kms_atomic_transition
results: parsing output: 43/ for test: kms_atomic
results: parsing output: 44/ for test: gem_exec_params
results: parsing output: 45/ for test: kms_big_fb
results: parsing output: 46/ for test: kms_pm_dc
results: parsing output: 47/ for test: gem_exec_fence
results: parsing output: 48/ for test: syncobj_eventfd
results: parsing output: 49/ for test: kms_chamelium_hpd
results: parsing output: 50/ for test: kms_flip_scaled_crc
results: parsing output: 51/ for test: kms_plane_scaling
results: parsing output: 52/ for test: kms_setmode
results: parsing output: 53/ for test: kms_big_fb
results: parsing output: 54/ for test: syncobj_timeline
results: parsing output: 55/ for test: kms_pipe_crc_basic
results: parsing output: 56/ for test: kms_content_protection
results: parsing output: 57/ for test: kms_psr
results: parsing output: 58/ for test: gem_exec_suspend
results: parsing output: 59/ for test: kms_force_connector_basic
results: parsing output: 60/ for test: perf_pmu
results: parsing output: 61/ for test: gem_exec_flush
results: parsing output: 62/ for test: kms_cursor_legacy
results: parsing output: 63/ for test: gem_media_vme
results: parsing output: 64/ for test: syncobj_timeline
results: parsing output: 65/ for test: kms_big_fb
results: parsing output: 66/ for test: gem_fence_thrash
results: parsing output: 67/ for test: kms_frontbuffer_tracking
results: parsing output: 68/ for test: gen9_exec_parse
results: parsing output: 69/ for test: kms_flip
results: parsing output: 70/ for test: kms_cursor_legacy
results: parsing output: 71/ for test: syncobj_timeline
results: parsing output: 72/ for test: kms_psr
results: parsing output: 73/ for test: kms_3d
results: parsing output: 74/ for test: kms_chamelium_audio
results: parsing output: 75/ for test: kms_joiner
results: parsing output: 76/ for test: gem_eio
results: parsing output: 77/ for test: kms_psr2_sf
results: parsing output: 78/ for test: gen9_exec_parse
results: parsing output: 79/ for test: gem_tiling_max_stride
results: parsing output: 80/ for test: gem_render_copy
results: parsing output: 81/ for test: gem_ctx_exec
results: parsing output: 82/ for test: kms_big_fb
results: parsing output: 83/ for test: kms_hdr
results: parsing output: 84/ for test: kms_frontbuffer_tracking
results: parsing output: 85/ for test: kms_frontbuffer_tracking
results: parsing output: 86/ for test: syncobj_timeline
results: parsing output: 87/ for test: kms_frontbuffer_tracking
results: parsing output: 88/ for test: kms_frontbuffer_tracking
results: parsing output: 89/ for test: kms_rotation_crc
results: parsing output: 90/ for test: kms_pipe_crc_basic
results: parsing output: 91/ for test: kms_frontbuffer_tracking
results: parsing output: 92/ for test: perf
results: parsing output: 93/ for test: kms_chamelium_edid
results: parsing output: 94/ for test: kms_cursor_crc
results: parsing output: 95/ for test: i915_hangman
results: parsing output: 96/ for test: gem_mmap_wc
results: parsing output: 97/ for test: kms_frontbuffer_tracking
results: parsing output: 98/ for test: gem_partial_pwrite_pread
results: parsing output: 99/ for test: gem_mmap_gtt
results: parsing output: 100/ for test: syncobj_timeline
results: parsing output: 101/ for test: kms_color_pipeline
results: parsing output: 102/ for test: kms_psr
results: parsing output: 103/ for test: gem_exec_balancer
results: parsing output: 104/ for test: kms_cursor_crc
results: parsing output: 105/ for test: i915_power
results: parsing output: 106/ for test: sw_sync
results: parsing output: 107/ for test: kms_frontbuffer_tracking
results: parsing output: 108/ for test: kms_plane
results: parsing output: 109/ for test: gem_flink_basic
results: parsing output: 110/ for test: gem_lmem_evict
results: parsing output: 111/ for test: kms_frontbuffer_tracking
results: parsing output: 112/ for test: syncobj_wait
results: parsing output: 113/ for test: kms_plane_scaling
results: parsing output: 114/ for test: kms_scaling_modes
results: parsing output: 115/ for test: kms_frontbuffer_tracking
results: parsing output: 116/ for test: kms_plane
results: parsing output: 117/ for test: kms_psr
results: parsing output: 118/ for test: syncobj_basic
results: parsing output: 119/ for test: kms_setmode
results: parsing output: 120/ for test: kms_cursor_legacy
results: parsing output: 121/ for test: kms_flip
results: parsing output: 122/ for test: drm_read
results: parsing output: 123/ for test: kms_frontbuffer_tracking
results: parsing output: 124/ for test: i915_pm_rpm
results: parsing output: 125/ for test: kms_flip
results: parsing output: 126/ for test: kms_flip
results: parsing output: 127/ for test: kms_flip_scaled_crc
results: parsing output: 128/ for test: api_intel_allocator
results: parsing output: 129/ for test: kms_psr
results: parsing output: 130/ for test: gem_ctx_persistence
results: parsing output: 131/ for test: sriov_basic
results: parsing output: 132/ for test: gem_exec_fence
Done.