[61.018994] Initializing watchdogs
[61.019057]   /dev/watchdog0
[61.034247] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:7d55 Intel Meteorlake (Gen12) Meteor Lake-P [Intel Arc Graphics]
[61.039042] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[61.042521] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[61.044620] [001/155] (960s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-render)
[61.154067] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-render
[68.358424] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-render: SUCCESS (7.262s)
[68.487710] [002/155] (953s left) gem_mmap_gtt (hang-busy)
[68.540345] Subtest hang-busy: SKIP (0.000s)
[68.603433] [003/155] (953s left) syncobj_timeline (single-wait-all-for-submit-available-submitted)
[68.652799] Starting subtest: single-wait-all-for-submit-available-submitted
[68.654058] Subtest single-wait-all-for-submit-available-submitted: SUCCESS (0.000s)
[68.751587] [004/155] (952s left) kms_rotation_crc (bad-pixel-format)
[68.840067] Starting subtest: bad-pixel-format
[68.841876] Subtest bad-pixel-format: SKIP (0.001s)
[68.916391] [005/155] (952s left) gem_ctx_create (basic)
[68.970206] Starting subtest: basic
[68.971139] Subtest basic: SUCCESS (0.000s)
[69.144443] [006/155] (952s left) syncobj_timeline (invalid-multi-wait-all-unsubmitted)
[69.189787] Starting subtest: invalid-multi-wait-all-unsubmitted
[69.190782] Subtest invalid-multi-wait-all-unsubmitted: SUCCESS (0.000s)
[69.278357] [007/155] (952s left) gem_exec_params (rsvd2-dirt)
[69.335137] Starting subtest: rsvd2-dirt
[69.336908] Subtest rsvd2-dirt: SKIP (0.000s)
[69.423296] [008/155] (952s left) syncobj_wait (multi-wait-all-submitted)
[69.481387] Starting subtest: multi-wait-all-submitted
[69.587142] Subtest multi-wait-all-submitted: SUCCESS (0.105s)
[69.668913] [009/155] (952s left) syncobj_timeline (etime-multi-wait-available-unsubmitted)
[69.718501] Starting subtest: etime-multi-wait-available-unsubmitted
[69.826309] Subtest etime-multi-wait-available-unsubmitted: SUCCESS (0.107s)
[69.894340] [010/155] (951s left) kms_pm_rpm (package-g7)
[71.459237] Starting subtest: package-g7
[71.461267] Subtest package-g7: SKIP (0.000s)
[72.241319] [011/155] (949s left) kms_psr (fbc-pr-primary-mmap-cpu)
[72.374181] Starting subtest: fbc-pr-primary-mmap-cpu
[72.375917] Subtest fbc-pr-primary-mmap-cpu: SKIP (0.000s)
[72.450304] [012/155] (949s left) syncobj_timeline (multi-wait-all-for-submit-available-signaled)
[72.710228] Starting subtest: multi-wait-all-for-submit-available-signaled
[72.711466] Subtest multi-wait-all-for-submit-available-signaled: SUCCESS (0.001s)
[73.051659] [013/155] (948s left) gem_spin_batch (legacy)
[73.153517] Starting subtest: legacy
[73.154704] Starting dynamic subtest: default
[76.402920] Dynamic subtest default: SUCCESS (3.246s)
[76.411987] Starting dynamic subtest: render
[79.674050] Dynamic subtest render: SUCCESS (3.237s)
[79.683305] Starting dynamic subtest: bsd
[82.912178] Dynamic subtest bsd: SUCCESS (3.239s)
[82.921650] Starting dynamic subtest: bsd1
[86.146387] Dynamic subtest bsd1: SUCCESS (3.232s)
[86.155474] Starting dynamic subtest: bsd2
[89.385942] Dynamic subtest bsd2: SUCCESS (3.236s)
[89.395393] Starting dynamic subtest: blt
[92.586678] Dynamic subtest blt: SUCCESS (3.234s)
[92.595947] Starting dynamic subtest: vebox
[95.861372] Dynamic subtest vebox: SUCCESS (3.234s)
[95.862774] Subtest legacy: SUCCESS (22.671s)
[96.349553] [014/155] (925s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-primscrn-spr-indfb-draw-mmap-cpu)
[96.441538] Starting subtest: fbcpsrhdr-2p-primscrn-spr-indfb-draw-mmap-cpu
[96.443166] Subtest fbcpsrhdr-2p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[96.536336] [015/155] (925s left) kms_color (invalid-gamma-lut-sizes)
[96.618508] Starting subtest: invalid-gamma-lut-sizes
[96.619870] Starting dynamic subtest: pipe-A
[96.904767] Dynamic subtest pipe-A: SUCCESS (0.287s)
[96.912192] Starting dynamic subtest: pipe-B
[96.913029] Dynamic subtest pipe-B: SUCCESS (0.000s)
[96.919443] Starting dynamic subtest: pipe-C
[96.920477] Dynamic subtest pipe-C: SUCCESS (0.000s)
[96.927193] Starting dynamic subtest: pipe-D
[96.928312] Dynamic subtest pipe-D: SUCCESS (0.000s)
[96.929295] Subtest invalid-gamma-lut-sizes: SUCCESS (0.289s)
[97.745836] [016/155] (924s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-primscrn-cur-indfb-draw-pwrite)
[97.842887] Starting subtest: fbcpsrhdr-1p-primscrn-cur-indfb-draw-pwrite
[97.845716] Subtest fbcpsrhdr-1p-primscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[97.949182] [017/155] (924s left) kms_frontbuffer_tracking (fbchdr-1p-primscrn-pri-shrfb-draw-mmap-cpu)
[98.034719] Starting subtest: fbchdr-1p-primscrn-pri-shrfb-draw-mmap-cpu
[98.036334] Subtest fbchdr-1p-primscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[98.134681] [018/155] (923s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-scndscrn-cur-indfb-draw-pwrite)
[98.222227] Starting subtest: fbcpsrhdr-2p-scndscrn-cur-indfb-draw-pwrite
[98.223824] Subtest fbcpsrhdr-2p-scndscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[98.311647] [019/155] (923s left) kms_frontbuffer_tracking (psr-2p-scndscrn-indfb-pgflip-blt)
[98.400892] Starting subtest: psr-2p-scndscrn-indfb-pgflip-blt
[98.402661] Subtest psr-2p-scndscrn-indfb-pgflip-blt: SKIP (0.000s)
[98.506944] [020/155] (923s left) i915_query (query-topology-coherent-slice-mask)
[98.551339] Starting subtest: query-topology-coherent-slice-mask
[98.553295] Subtest query-topology-coherent-slice-mask: SKIP (0.000s)
[98.639025] [021/155] (923s left) kms_cursor_legacy (cursora-vs-flipa-varying-size)
[98.755365] Starting subtest: cursorA-vs-flipA-varying-size
[109.905615] Subtest cursorA-vs-flipA-varying-size: SUCCESS (11.147s)
[110.780043] [022/155] (911s left) sysfs_timeslice_duration (idempotent)
[110.846109] Starting subtest: idempotent
[110.847247] Starting dynamic subtest: vecs0
[110.848371] Dynamic subtest vecs0: SUCCESS (0.000s)
[110.857070] Starting dynamic subtest: ccs0
[110.858062] Dynamic subtest ccs0: SUCCESS (0.000s)
[110.864561] Starting dynamic subtest: vcs0
[110.865558] Dynamic subtest vcs0: SUCCESS (0.000s)
[110.872073] Starting dynamic subtest: bcs0
[110.873137] Dynamic subtest bcs0: SUCCESS (0.000s)
[110.879649] Starting dynamic subtest: rcs0
[110.880625] Dynamic subtest rcs0: SUCCESS (0.000s)
[110.887093] Starting dynamic subtest: vcs1
[110.888045] Dynamic subtest vcs1: SUCCESS (0.000s)
[110.888987] Subtest idempotent: SUCCESS (0.004s)
[110.947187] [023/155] (911s left) perf (create-destroy-userspace-config)
[111.064023] Starting subtest: create-destroy-userspace-config
[111.083527] Subtest create-destroy-userspace-config: SUCCESS (0.019s)
[111.120558] [024/155] (911s left) fbdev (read)
[111.161519] Starting subtest: read
[111.705914] Subtest read: SUCCESS (0.534s)
[111.767326] [025/155] (910s left) gem_partial_pwrite_pread (reads-display)
[111.812175] Subtest reads-display: SKIP (0.000s)
[111.877624] [026/155] (910s left) kms_ccs (bad-rotation-90-4-tiled-dg2-rc-ccs-cc)
[111.970344] Starting subtest: bad-rotation-90-4-tiled-dg2-rc-ccs-cc
[111.971314] Starting dynamic subtest: pipe-A-eDP-1
[111.979951] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[111.987075] Starting dynamic subtest: pipe-B-eDP-1
[111.995710] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[112.002368] Starting dynamic subtest: pipe-C-eDP-1
[112.010708] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[112.017331] Starting dynamic subtest: pipe-D-eDP-1
[112.025275] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[112.026775] Subtest bad-rotation-90-4-tiled-dg2-rc-ccs-cc: SKIP (0.003s)
[114.266802] [027/155] (908s left) syncobj_timeline (multi-wait-for-submit-available-unsubmitted-submitted)
[114.317615] Starting subtest: multi-wait-for-submit-available-unsubmitted-submitted
[114.318718] Subtest multi-wait-for-submit-available-unsubmitted-submitted: SUCCESS (0.000s)
[114.406950] [028/155] (908s left) gem_ctx_shared (single-timeline)
[114.458268] Starting subtest: single-timeline
[114.470684] Subtest single-timeline: SUCCESS (0.013s)
[114.695383] [029/155] (907s left) kms_ccs (crc-primary-basic-4-tiled-mtl-rc-ccs)
[114.780198] Starting subtest: crc-primary-basic-4-tiled-mtl-rc-ccs
[114.781139] Starting dynamic subtest: pipe-A-eDP-1
[115.680442] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.897s)
[115.687401] Starting dynamic subtest: pipe-B-eDP-1
[117.286522] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.605s)
[117.293492] Starting dynamic subtest: pipe-C-eDP-1
[118.783874] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.496s)
[118.792437] Starting dynamic subtest: pipe-D-eDP-1
[120.306574] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.522s)
[120.307473] Subtest crc-primary-basic-4-tiled-mtl-rc-ccs: SUCCESS (5.523s)
[121.486746] [030/155] (901s left) gem_ctx_exec (basic-nohangcheck)
[121.542603] Starting subtest: basic-nohangcheck
[121.798781] Subtest basic-nohangcheck: SUCCESS (0.256s)
[121.907423] [031/155] (900s left) perf (rc6-disable)
[122.026363] Starting subtest: rc6-disable
[122.216548] Subtest rc6-disable: SUCCESS (0.191s)
[122.256863] [032/155] (900s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-blt)
[122.341613] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-blt
[122.343345] Subtest fbc-2p-primscrn-cur-indfb-draw-blt: SKIP (0.000s)
[122.453411] [033/155] (900s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-mmap-gtt)
[122.539988] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-mmap-gtt
[122.541880] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[122.628842] [034/155] (900s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-blt)
[122.713141] Starting subtest: fbcpsr-rgb101010-draw-blt
[127.460219] Subtest fbcpsr-rgb101010-draw-blt: SUCCESS (4.747s)
[127.564377] [035/155] (895s left) gem_mmap_wc (write-gtt-read-wc)
[127.612977] Subtest write-gtt-read-wc: SKIP (0.000s)
[127.668871] [036/155] (895s left) gem_ctx_persistence (engines-queued)
[127.733197] Starting subtest: engines-queued
[127.734102] Starting dynamic subtest: rcs0
[127.769222] Dynamic subtest rcs0: SUCCESS (0.037s)
[127.777304] Starting dynamic subtest: bcs0
[127.873427] Dynamic subtest bcs0: SUCCESS (0.104s)
[127.883559] Starting dynamic subtest: vcs0
[129.285805] Dynamic subtest vcs0: SUCCESS (1.402s)
[129.295758] Starting dynamic subtest: vcs1
[131.270075] Dynamic subtest vcs1: SUCCESS (1.982s)
[131.277258] Starting dynamic subtest: vecs0
[133.315897] Dynamic subtest vecs0: SUCCESS (2.044s)
[133.323940] Starting dynamic subtest: ccs0
[133.470795] Dynamic subtest ccs0: SUCCESS (0.161s)
[133.472334] Subtest engines-queued: SUCCESS (5.738s)
[133.589637] [037/155] (889s left) gem_exec_flush (basic-batch-kernel-default-cmd)
[133.652038] Starting subtest: basic-batch-kernel-default-cmd
[133.654142] Subtest basic-batch-kernel-default-cmd: SKIP (0.000s)
[133.831715] [038/155] (888s left) kms_psr_stress_test (invalidate-primary-flip-overlay)
[133.922780] Starting subtest: invalidate-primary-flip-overlay
[144.662750] Subtest invalidate-primary-flip-overlay: SUCCESS (10.740s)
[144.764316] [039/155] (878s left) kms_frontbuffer_tracking (hdr-2p-scndscrn-cur-indfb-draw-blt)
[144.858395] Starting subtest: hdr-2p-scndscrn-cur-indfb-draw-blt
[144.860365] Subtest hdr-2p-scndscrn-cur-indfb-draw-blt: SKIP (0.000s)
[144.968697] [040/155] (877s left) kms_chamelium_color (ctm-max)
[145.059355] Subtest ctm-max: SKIP (0.000s)
[145.097277] [041/155] (877s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-indfb-msflip-blt)
[145.181264] Starting subtest: fbc-2p-scndscrn-indfb-msflip-blt
[145.182848] Subtest fbc-2p-scndscrn-indfb-msflip-blt: SKIP (0.000s)
[145.277035] [042/155] (877s left) kms_vrr (lobf)
[145.361289] Starting subtest: lobf
[145.362782] Subtest lobf: SKIP (0.000s)
[145.423612] [043/155] (877s left) gem_exec_reloc (basic-cpu-wc-active)
[145.483950] Subtest basic-cpu-wc-active: SKIP (0.000s)
[145.566753] [044/155] (877s left) kms_frontbuffer_tracking (fbcpsr-stridechange)
[145.666706] Starting subtest: fbcpsr-stridechange
[151.937952] Subtest fbcpsr-stridechange: SUCCESS (6.273s)
[152.056294] [045/155] (870s left) kms_sequence (get-forked)
[152.147498] Starting subtest: get-forked
[152.148539] Starting dynamic subtest: pipe-A-eDP-1
[154.030954] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.883s)
[154.038645] Starting dynamic subtest: pipe-B-eDP-1
[156.600360] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.568s)
[156.608493] Starting dynamic subtest: pipe-C-eDP-1
[159.114986] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.513s)
[159.123266] Starting dynamic subtest: pipe-D-eDP-1
[161.645072] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.530s)
[161.645896] Subtest get-forked: SUCCESS (9.498s)
[162.469964] [046/155] (860s left) gem_exec_balancer (noheartbeat)
[162.741481] Starting subtest: noheartbeat
[162.743319] Subtest noheartbeat: SKIP (0.000s)
[162.835799] [047/155] (860s left) kms_psr (fbc-psr-cursor-mmap-cpu)
[162.928278] Starting subtest: fbc-psr-cursor-mmap-cpu
[162.929207] Starting dynamic subtest: eDP-1
[162.930856] Dynamic subtest eDP-1: SKIP (0.000s)
[162.932691] Subtest fbc-psr-cursor-mmap-cpu: SKIP (0.001s)
[162.994765] [048/155] (860s left) i915_suspend (basic-s3-without-i915)
[163.022519] Starting subtest: basic-s3-without-i915
[165.610486] Subtest basic-s3-without-i915: SKIP (2.575s)
[167.204787] [049/155] (855s left) syncobj_wait (wait-all-snapshot)
[167.262445] Starting subtest: wait-all-snapshot
[167.342829] Subtest wait-all-snapshot: SUCCESS (0.081s)
[167.409114] [050/155] (855s left) kms_plane (pixel-format-y-tiled-gen12-rc-ccs-cc-modifier)
[167.495996] Starting subtest: pixel-format-y-tiled-gen12-rc-ccs-cc-modifier
[167.498033] Subtest pixel-format-y-tiled-gen12-rc-ccs-cc-modifier: SKIP (0.000s)
[167.559744] [051/155] (855s left) i915_pm_rc6_residency (rc6-idle)
[167.614839] Starting subtest: rc6-idle
[167.635444] Starting dynamic subtest: gt0-rcs0
[191.939313] Dynamic subtest gt0-rcs0: SUCCESS (24.302s)
[191.949545] Starting dynamic subtest: gt0-bcs0
[216.230785] Dynamic subtest gt0-bcs0: SUCCESS (24.289s)
[216.240841] Starting dynamic subtest: gt0-ccs0
[240.520037] Dynamic subtest gt0-ccs0: SUCCESS (24.286s)
[240.531999] Starting dynamic subtest: gt1-vcs0
[246.741854] Dynamic subtest gt1-vcs0: SUCCESS (6.171s)
[246.752292] Starting dynamic subtest: gt1-vecs0
[252.911438] Dynamic subtest gt1-vecs0: SUCCESS (6.169s)
[252.912534] Subtest rc6-idle: SUCCESS (85.249s)
[252.941465] [052/155] (770s left) perf (whitelisted-registers-userspace-config)
[253.064654] Starting subtest: whitelisted-registers-userspace-config
[253.065479] Subtest whitelisted-registers-userspace-config: SUCCESS (0.001s)
[253.103403] [053/155] (770s left) gem_ctx_persistence (userptr)
[253.174811] Starting subtest: userptr
[253.331766] Subtest userptr: SUCCESS (0.156s)
[253.454026] [054/155] (769s left) prime_mmap (test_map_unmap)
[253.509059] Starting subtest: test_map_unmap
[253.510127] Starting dynamic subtest: test_map_unmap-smem
[253.540880] Dynamic subtest test_map_unmap-smem: SUCCESS (0.033s)
[253.541839] Subtest test_map_unmap: SUCCESS (0.033s)
[253.659562] [055/155] (769s left) kms_psr (psr2-primary-render)
[253.754076] Starting subtest: psr2-primary-render
[253.754935] Starting dynamic subtest: eDP-1
[255.527977] Dynamic subtest eDP-1: SUCCESS (1.773s)
[255.528927] Subtest psr2-primary-render: SUCCESS (1.774s)
[256.399382] [056/155] (766s left) gem_softpin (invalid)
[256.453213] Starting subtest: invalid
[256.459819] Subtest invalid: SUCCESS (0.007s)
[256.590286] [057/155] (766s left) kms_plane_multiple (2x-tiling-4)
[256.686743] Starting subtest: 2x-tiling-4
[256.689103] Subtest 2x-tiling-4: SKIP (0.000s)
[256.769555] [058/155] (766s left) kms_pm_rpm (dpms-non-lpsp)
[258.486991] Starting subtest: dpms-non-lpsp
[258.489919] Subtest dpms-non-lpsp: SKIP (0.001s)
[259.027435] [059/155] (764s left) sw_sync (sync_expired_merge)
[259.057353] Starting subtest: sync_expired_merge
[260.131073] Subtest sync_expired_merge: SUCCESS (1.074s)
[260.184400] [060/155] (763s left) gem_mmap_gtt (basic-write-cpu-read-gtt)
[260.231804] Subtest basic-write-cpu-read-gtt: SKIP (0.000s)
[260.291982] [061/155] (763s left) kms_big_fb (4-tiled-32bpp-rotate-90)
[260.398686] Starting subtest: 4-tiled-32bpp-rotate-90
[260.418370] Subtest 4-tiled-32bpp-rotate-90: SKIP (0.019s)
[260.547143] [062/155] (763s left) kms_frontbuffer_tracking (psrhdr-2p-scndscrn-cur-indfb-draw-mmap-gtt)
[260.640157] Starting subtest: psrhdr-2p-scndscrn-cur-indfb-draw-mmap-gtt
[260.641906] Subtest psrhdr-2p-scndscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[260.753180] [063/155] (762s left) core_sysfs (read-all-entries)
[260.807552] Starting subtest: read-all-entries
[260.819194] Subtest read-all-entries: SUCCESS (0.012s)
[260.921996] [064/155] (762s left) kms_ccs (crc-sprite-planes-basic-y-tiled-gen12-rc-ccs)
[261.011055] Starting subtest: crc-sprite-planes-basic-y-tiled-gen12-rc-ccs
[261.011945] Starting dynamic subtest: pipe-A-eDP-1
[261.033816] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[261.041781] Starting dynamic subtest: pipe-B-eDP-1
[261.063765] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[261.071167] Starting dynamic subtest: pipe-C-eDP-1
[261.091970] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[261.100360] Starting dynamic subtest: pipe-D-eDP-1
[261.121577] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[261.123148] Subtest crc-sprite-planes-basic-y-tiled-gen12-rc-ccs: SKIP (0.009s)
[263.283836] [065/155] (760s left) gem_exec_whisper (basic-fds-forked-all)
[263.340700] Starting subtest: basic-fds-forked-all
[283.512068] Subtest basic-fds-forked-all: SUCCESS (20.161s)
[283.686346] [066/155] (740s left) kms_frontbuffer_tracking (fbchdr-1p-offscreen-pri-indfb-draw-mmap-cpu)
[283.787907] Starting subtest: fbchdr-1p-offscreen-pri-indfb-draw-mmap-cpu
[283.789824] Subtest fbchdr-1p-offscreen-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[283.870064] [067/155] (739s left) kms_ccs (crc-primary-suspend-4-tiled-dg2-rc-ccs-cc)
[283.958199] Starting subtest: crc-primary-suspend-4-tiled-dg2-rc-ccs-cc
[283.959073] Starting dynamic subtest: pipe-A-eDP-1
[283.962855] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[283.970562] Starting dynamic subtest: pipe-B-eDP-1
[283.974172] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[283.981742] Starting dynamic subtest: pipe-C-eDP-1
[283.985362] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[283.992864] Starting dynamic subtest: pipe-D-eDP-1
[283.996439] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[283.998049] Subtest crc-primary-suspend-4-tiled-dg2-rc-ccs-cc: SKIP (0.004s)
[286.268105] [068/155] (737s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-pwrite)
[286.361740] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-pwrite
[286.363447] Subtest psr-2p-scndscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[286.458897] [069/155] (737s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-16bpp-ytile-upscaling)
[286.541187] Starting subtest: flip-64bpp-ytile-to-16bpp-ytile-upscaling
[286.542908] Subtest flip-64bpp-ytile-to-16bpp-ytile-upscaling: SKIP (0.000s)
[286.614839] [070/155] (737s left) kms_frontbuffer_tracking (psrhdr-2p-primscrn-shrfb-plflip-blt)
[286.709509] Starting subtest: psrhdr-2p-primscrn-shrfb-plflip-blt
[286.711218] Subtest psrhdr-2p-primscrn-shrfb-plflip-blt: SKIP (0.000s)
[286.834888] [071/155] (737s left) gem_exec_fence (basic-await)
[287.014948] Starting subtest: basic-await
[287.016255] Starting dynamic subtest: rcs0
[287.086487] Dynamic subtest rcs0: SUCCESS (0.076s)
[287.097994] Starting dynamic subtest: bcs0
[287.159876] Dynamic subtest bcs0: SUCCESS (0.072s)
[287.171676] Starting dynamic subtest: vcs0
[287.233254] Dynamic subtest vcs0: SUCCESS (0.072s)
[287.248529] Starting dynamic subtest: vcs1
[287.306338] Dynamic subtest vcs1: SUCCESS (0.071s)
[287.317892] Starting dynamic subtest: vecs0
[287.380320] Dynamic subtest vecs0: SUCCESS (0.072s)
[287.389990] Starting dynamic subtest: ccs0
[287.452875] Dynamic subtest ccs0: SUCCESS (0.072s)
[287.454465] Subtest basic-await: SUCCESS (0.444s)
[289.391229] [FACT gem_exec_fence (basic-await)] new: kernel.kmod_is_loaded.vgem: true
[289.393292] [072/155] (734s left) kms_big_fb (y-tiled-8bpp-rotate-0)
[289.490202] Starting subtest: y-tiled-8bpp-rotate-0
[289.491962] Subtest y-tiled-8bpp-rotate-0: SKIP (0.000s)
[289.574455] [073/155] (734s left) gem_ctx_param (invalid-ctx-set)
[289.628791] Starting subtest: invalid-ctx-set
[289.629991] Subtest invalid-ctx-set: SUCCESS (0.001s)
[289.719307] [074/155] (734s left) kms_frontbuffer_tracking (hdr-2p-primscrn-cur-indfb-draw-pwrite)
[289.808654] Starting subtest: hdr-2p-primscrn-cur-indfb-draw-pwrite
[289.810233] Subtest hdr-2p-primscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[289.904170] [075/155] (734s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-blt)
[290.003316] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-blt
[290.004875] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[290.082236] [076/155] (733s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-cpu)
[290.178047] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-cpu
[297.310796] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-cpu: SUCCESS (7.134s)
[297.418161] [077/155] (726s left) gem_mmap_gtt (fault-concurrent-x)
[297.466299] Subtest fault-concurrent-X: SKIP (0.000s)
[297.524533] [078/155] (726s left) kms_addfb_basic (invalid-smem-bo-on-discrete)
[297.570999] Starting subtest: invalid-smem-bo-on-discrete
[297.572920] Subtest invalid-smem-bo-on-discrete: SKIP (0.000s)
[297.710509] [079/155] (726s left) kms_lease (simple-lease)
[297.804828] Starting subtest: simple-lease
[297.805604] Starting dynamic subtest: pipe-A-eDP-1
[298.320835] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.514s)
[298.329196] Starting dynamic subtest: pipe-B-eDP-1
[299.830579] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.509s)
[299.839883] Starting dynamic subtest: pipe-C-eDP-1
[301.361049] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.528s)
[301.370045] Starting dynamic subtest: pipe-D-eDP-1
[302.854788] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.492s)
[302.856169] Subtest simple-lease: SUCCESS (5.049s)
[303.661455] [080/155] (720s left) gem_exec_schedule (semaphore-resolve)
[303.734045] Starting subtest: semaphore-resolve
[303.774323] Subtest semaphore-resolve: SUCCESS (0.042s)
[304.108453] [081/155] (720s left) kms_joiner (basic-max-non-joiner)
[304.201752] Starting subtest: basic-max-non-joiner
[304.203476] Subtest basic-max-non-joiner: SKIP (0.000s)
[304.268903] [082/155] (719s left) kms_frontbuffer_tracking (psrhdr-1p-primscrn-cur-indfb-draw-mmap-wc)
[304.362879] Starting subtest: psrhdr-1p-primscrn-cur-indfb-draw-mmap-wc
[304.364511] Subtest psrhdr-1p-primscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[304.448734] [083/155] (719s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-mmap-cpu)
[304.542053] Starting subtest: psr-1p-primscrn-spr-indfb-draw-mmap-cpu
[311.172704] Subtest psr-1p-primscrn-spr-indfb-draw-mmap-cpu: SUCCESS (6.632s)
[311.307717] [084/155] (713s left) kms_psr2_sf (psr2-overlay-plane-update-continuous-sf)
[311.399543] Starting subtest: psr2-overlay-plane-update-continuous-sf
[311.400489] Starting dynamic subtest: pipe-A-eDP-1
[312.526949] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.128s)
[312.536778] Starting dynamic subtest: pipe-B-eDP-1
[314.263688] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.733s)
[314.264583] Subtest psr2-overlay-plane-update-continuous-sf: SUCCESS (2.866s)
[315.066775] [085/155] (709s left) gem_eio (in-flight-external)
[315.297138] Starting subtest: in-flight-external
[316.390801] Subtest in-flight-external: SUCCESS (1.096s)
[316.518316] [086/155] (707s left) kms_frontbuffer_tracking (hdr-1p-offscreen-pri-shrfb-draw-pwrite)
[316.611208] Starting subtest: hdr-1p-offscreen-pri-shrfb-draw-pwrite
[316.613293] Subtest hdr-1p-offscreen-pri-shrfb-draw-pwrite: SKIP (0.000s)
[316.722904] [087/155] (707s left) kms_frontbuffer_tracking (fbchdr-indfb-scaledprimary)
[316.821381] Starting subtest: fbchdr-indfb-scaledprimary
[316.823231] Subtest fbchdr-indfb-scaledprimary: SKIP (0.000s)
[316.911057] [088/155] (707s left) kms_frontbuffer_tracking (hdr-2p-scndscrn-spr-indfb-onoff)
[317.007591] Starting subtest: hdr-2p-scndscrn-spr-indfb-onoff
[317.009165] Subtest hdr-2p-scndscrn-spr-indfb-onoff: SKIP (0.000s)
[317.098752] [089/155] (707s left) sriov_basic (enable-vfs-bind-unbind-each-numvfs-all)
[317.148749] Starting subtest: enable-vfs-bind-unbind-each-numvfs-all
[317.176691] Subtest enable-vfs-bind-unbind-each-numvfs-all: FAIL (0.009s)
[317.225752] [090/155] (707s left) gem_exec_fence (syncobj-timeline-unused-fence)
[317.760346] Starting subtest: syncobj-timeline-unused-fence
[317.764022] Subtest syncobj-timeline-unused-fence: SUCCESS (0.006s)
[319.421550] [091/155] (705s left) kms_chamelium_hpd (vga-hpd)
[319.807333] Subtest vga-hpd: SKIP (0.000s)
[320.587318] [092/155] (704s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-scndscrn-spr-indfb-draw-mmap-cpu)
[320.678413] Starting subtest: fbcpsrhdr-2p-scndscrn-spr-indfb-draw-mmap-cpu
[320.679974] Subtest fbcpsrhdr-2p-scndscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[320.789260] [093/155] (703s left) gem_exec_fence (syncobj-invalid-wait)
[321.198818] Starting subtest: syncobj-invalid-wait
[321.200495] Subtest syncobj-invalid-wait: SUCCESS (0.001s)
[322.414924] [094/155] (702s left) gem_exec_fence (basic-busy-all)
[322.482285] Starting subtest: basic-busy-all
[322.563305] Subtest basic-busy-all: SUCCESS (0.080s)
[324.380302] [095/155] (700s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-mmap-wc)
[324.482406] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-mmap-wc
[328.108108] Subtest fbc-1p-primscrn-cur-indfb-draw-mmap-wc: SUCCESS (3.627s)
[329.251991] [096/155] (695s left) kms_cursor_legacy (cursora-vs-flipa-toggle)
[329.376853] Starting subtest: cursorA-vs-flipA-toggle
[340.493297] Subtest cursorA-vs-flipA-toggle: SUCCESS (11.116s)
[341.368599] [097/155] (683s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-shrfb-draw-pwrite)
[341.462500] Starting subtest: psr-1p-offscreen-pri-shrfb-draw-pwrite
[351.408767] Subtest psr-1p-offscreen-pri-shrfb-draw-pwrite: SUCCESS (9.947s)
[351.517956] [098/155] (673s left) kms_dp_linktrain_fallback (dsc-fallback)
[351.617532] Starting subtest: dsc-fallback
[351.620191] Subtest dsc-fallback: SKIP (0.000s)
[351.699281] [099/155] (673s left) gen9_exec_parse (batch-without-end)
[351.748652] Subtest batch-without-end: SKIP (0.000s)
[351.808891] [100/155] (673s left) kms_content_protection (dp-mst-type-1)
[351.953703] Starting subtest: dp-mst-type-1
[351.955771] Subtest dp-mst-type-1: SKIP (0.000s)
[352.065068] [101/155] (672s left) kms_flip (flip-vs-dpms-on-nop)
[352.147752] Starting subtest: flip-vs-dpms-on-nop
[352.149877] Starting dynamic subtest: A-eDP1
[353.995499] Dynamic subtest A-eDP1: SUCCESS (1.846s)
[354.009681] Starting dynamic subtest: B-eDP1
[355.831293] Dynamic subtest B-eDP1: SUCCESS (1.833s)
[355.843050] Starting dynamic subtest: C-eDP1
[357.669457] Dynamic subtest C-eDP1: SUCCESS (1.832s)
[357.678304] Starting dynamic subtest: D-eDP1
[359.501909] Dynamic subtest D-eDP1: SUCCESS (1.832s)
[359.502950] Subtest flip-vs-dpms-on-nop: SUCCESS (7.355s)
[360.684264] [102/155] (664s left) kms_frontbuffer_tracking (hdr-2p-primscrn-spr-indfb-move)
[360.778564] Starting subtest: hdr-2p-primscrn-spr-indfb-move
[360.780966] Subtest hdr-2p-primscrn-spr-indfb-move: SKIP (0.000s)
[360.887884] [103/155] (664s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-pwrite)
[360.979688] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-pwrite
[360.981249] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[361.066392] [104/155] (663s left) gem_workarounds (basic-read-fd)
[361.125662] Starting subtest: basic-read-fd
[361.139628] Subtest basic-read-fd: SUCCESS (0.014s)
[361.262123] [105/155] (663s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-mmap-cpu)
[361.350684] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-mmap-cpu
[361.352563] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[361.459690] [106/155] (663s left) kms_cursor_crc (cursor-offscreen-128x42)
[361.687929] Starting subtest: cursor-offscreen-128x42
[361.732644] Subtest cursor-offscreen-128x42: SKIP (0.043s)
[361.944631] [107/155] (663s left) gem_mmap_wc (write-prefaulted)
[361.991067] Subtest write-prefaulted: SKIP (0.000s)
[362.041608] [108/155] (663s left) kms_rotation_crc (bad-tiling)
[362.128257] Starting subtest: bad-tiling
[362.130030] Subtest bad-tiling: SKIP (0.001s)
[362.195798] [109/155] (662s left) kms_feature_discovery (display-1x)
[362.284424] Starting subtest: display-1x
[362.285246] Subtest display-1x: SUCCESS (0.000s)
[362.370404] [110/155] (662s left) perf_pmu (idle-no-semaphores)
[362.406843] Starting subtest: idle-no-semaphores
[362.407789] Starting dynamic subtest: rcs0
[362.949192] Dynamic subtest rcs0: SUCCESS (0.534s)
[362.959295] Starting dynamic subtest: bcs0
[363.469763] Dynamic subtest bcs0: SUCCESS (0.517s)
[363.481191] Starting dynamic subtest: vcs0
[363.988329] Dynamic subtest vcs0: SUCCESS (0.516s)
[363.999605] Starting dynamic subtest: vcs1
[364.507650] Dynamic subtest vcs1: SUCCESS (0.516s)
[364.519038] Starting dynamic subtest: vecs0
[365.026530] Dynamic subtest vecs0: SUCCESS (0.515s)
[365.038168] Starting dynamic subtest: ccs0
[365.543553] Dynamic subtest ccs0: SUCCESS (0.514s)
[365.544788] Subtest idle-no-semaphores: SUCCESS (3.131s)
[365.624878] [111/155] (659s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-180-hflip)
[365.729864] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-180-hflip
[365.731901] Subtest y-tiled-max-hw-stride-64bpp-rotate-180-hflip: SKIP (0.000s)
[365.826840] [112/155] (659s left) kms_frontbuffer_tracking (hdr-1p-pri-indfb-multidraw)
[365.910412] Starting subtest: hdr-1p-pri-indfb-multidraw
[365.912064] Subtest hdr-1p-pri-indfb-multidraw: SKIP (0.000s)
[365.989137] [113/155] (659s left) kms_rotation_crc (primary-yf-tiled-reflect-x-180)
[366.079396] Starting subtest: primary-yf-tiled-reflect-x-180
[366.139912] Subtest primary-yf-tiled-reflect-x-180: SKIP (0.060s)
[366.237749] [114/155] (659s left) kms_flip (basic-flip-vs-modeset)
[366.324033] Starting subtest: basic-flip-vs-modeset
[366.326401] Starting dynamic subtest: A-eDP1
[368.881579] Dynamic subtest A-eDP1: SUCCESS (2.555s)
[368.890589] Starting dynamic subtest: B-eDP1
[371.043477] Dynamic subtest B-eDP1: SUCCESS (2.161s)
[371.052082] Starting dynamic subtest: C-eDP1
[373.213652] Dynamic subtest C-eDP1: SUCCESS (2.168s)
[373.222671] Starting dynamic subtest: D-eDP1
[375.397460] Dynamic subtest D-eDP1: SUCCESS (2.184s)
[375.400279] Subtest basic-flip-vs-modeset: SUCCESS (9.077s)
[376.206353] [115/155] (649s left) api_intel_bb (intel-bb-blit-y)
[376.251146] Starting subtest: intel-bb-blit-y
[379.811989] Subtest intel-bb-blit-y: SUCCESS (3.551s)
[379.916797] [116/155] (645s left) i915_drm_fdinfo (memory-info-idle)
[379.956407] Starting subtest: memory-info-idle
[379.957259] Starting dynamic subtest: smem0
[380.024341] Dynamic subtest smem0: SUCCESS (0.067s)
[380.025988] Subtest memory-info-idle: SUCCESS (0.068s)
[380.108533] [117/155] (645s left) kms_frontbuffer_tracking (fbchdr-2p-scndscrn-indfb-plflip-blt)
[380.209459] Starting subtest: fbchdr-2p-scndscrn-indfb-plflip-blt
[380.211235] Subtest fbchdr-2p-scndscrn-indfb-plflip-blt: SKIP (0.000s)
[380.303382] [118/155] (645s left) kms_plane_scaling (planes-scaler-unity-scaling)
[380.392662] Starting subtest: planes-scaler-unity-scaling
[380.393572] Starting dynamic subtest: pipe-A
[380.455827] Dynamic subtest pipe-A: SUCCESS (0.064s)
[380.467059] Starting dynamic subtest: pipe-B
[381.631502] Dynamic subtest pipe-B: SUCCESS (1.174s)
[381.643059] Starting dynamic subtest: pipe-C
[382.744191] Dynamic subtest pipe-C: SUCCESS (1.111s)
[382.755313] Starting dynamic subtest: pipe-D
[383.881271] Dynamic subtest pipe-D: SUCCESS (1.136s)
[383.882170] Subtest planes-scaler-unity-scaling: SUCCESS (3.490s)
[385.039848] [119/155] (640s left) syncobj_wait (wait-all-for-submit-delayed-submit)
[385.087331] Starting subtest: wait-all-for-submit-delayed-submit
[385.189398] Subtest wait-all-for-submit-delayed-submit: SUCCESS (0.102s)
[385.277142] [120/155] (640s left) kms_big_fb (linear-32bpp-rotate-270)
[385.372556] Starting subtest: linear-32bpp-rotate-270
[385.391275] Subtest linear-32bpp-rotate-270: SKIP (0.018s)
[385.500115] [121/155] (640s left) api_intel_allocator (fork-simple-stress-signal)
[385.548219] Starting subtest: fork-simple-stress-signal
[390.998211] Subtest fork-simple-stress-signal: SUCCESS (5.404s)
[391.078464] [122/155] (634s left) kms_frontbuffer_tracking (psrhdr-1p-rte)
[391.182084] Starting subtest: psrhdr-1p-rte
[391.183772] Subtest psrhdr-1p-rte: SKIP (0.000s)
[391.276222] [123/155] (634s left) kms_flip_scaled_crc (flip-64bpp-xtile-to-32bpp-xtile-upscaling)
[391.365327] Starting subtest: flip-64bpp-xtile-to-32bpp-xtile-upscaling
[391.366277] Starting dynamic subtest: pipe-A-default-mode
[394.099358] Dynamic subtest pipe-A-default-mode: SUCCESS (2.733s)
[394.100317] Subtest flip-64bpp-xtile-to-32bpp-xtile-upscaling: SUCCESS (2.735s)
[394.937208] [124/155] (630s left) syncobj_basic (bad-flags-fd-to-handle)
[394.999343] Starting subtest: bad-flags-fd-to-handle
[395.000301] Subtest bad-flags-fd-to-handle: SUCCESS (0.000s)
[395.118970] [125/155] (630s left) gem_render_copy_redux (normal)
[395.170397] Starting subtest: normal
[395.461163] Subtest normal: SUCCESS (0.291s)
[395.566882] [126/155] (630s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-pwrite)
[395.651477] Starting subtest: psr-2p-primscrn-pri-indfb-draw-pwrite
[395.653712] Subtest psr-2p-primscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[395.759105] [127/155] (630s left) i915_pm_freq_mult (media-freq)
[395.811788] Starting subtest: media-freq
[395.812766] Starting dynamic subtest: gt0
[395.814659] Dynamic subtest gt0: SKIP (0.000s)
[395.824895] Starting dynamic subtest: gt1
[395.826689] Dynamic subtest gt1: SKIP (0.000s)
[395.828416] Subtest media-freq: SKIP (0.003s)
[395.927088] [128/155] (629s left) kms_plane_scaling (plane-scaler-unity-scaling-with-modifiers)
[396.010582] Starting subtest: plane-scaler-unity-scaling-with-modifiers
[396.011555] Starting dynamic subtest: pipe-A
[396.359971] Dynamic subtest pipe-A: SUCCESS (0.350s)
[396.370751] Starting dynamic subtest: pipe-B
[397.736358] Dynamic subtest pipe-B: SUCCESS (1.375s)
[397.747011] Starting dynamic subtest: pipe-C
[399.166495] Dynamic subtest pipe-C: SUCCESS (1.429s)
[399.176265] Starting dynamic subtest: pipe-D
[400.596465] Dynamic subtest pipe-D: SUCCESS (1.429s)
[400.597504] Subtest plane-scaler-unity-scaling-with-modifiers: SUCCESS (4.587s)
[401.767657] [129/155] (624s left) kms_pipe_stress (stress-xrgb8888-4tiled)
[401.868369] Starting subtest: stress-xrgb8888-4tiled
[407.720212] Subtest stress-xrgb8888-4tiled: SUCCESS (5.854s)
[407.768289] [130/155] (618s left) gem_pread (uncached)
[407.819065] Subtest uncached: SKIP (0.000s)
[407.876879] [131/155] (618s left) gem_render_copy (yf-tiled-ccs-to-yf-tiled-ccs)
[407.925528] Starting subtest: yf-tiled-ccs-to-yf-tiled-ccs
[407.927378] Subtest yf-tiled-ccs-to-yf-tiled-ccs: SKIP (0.000s)
[408.107076] [132/155] (617s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-shrfb-fliptrack-mmap-gtt)
[408.198384] Starting subtest: fbcpsrhdr-1p-shrfb-fliptrack-mmap-gtt
[408.200150] Subtest fbcpsrhdr-1p-shrfb-fliptrack-mmap-gtt: SKIP (0.000s)
[408.284632] [133/155] (617s left) kms_psr2_sf (fbc-pr-cursor-plane-update-sf)
[408.378694] Starting subtest: fbc-pr-cursor-plane-update-sf
[408.380438] Subtest fbc-pr-cursor-plane-update-sf: SKIP (0.000s)
[408.457459] [134/155] (617s left) gem_render_copy (yf-tiled-mc-ccs-to-vebox-yf-tiled)
[408.503129] Starting subtest: yf-tiled-mc-ccs-to-vebox-yf-tiled
[408.505083] Subtest yf-tiled-mc-ccs-to-vebox-yf-tiled: SKIP (0.000s)
[408.687392] [135/155] (617s left) kms_frontbuffer_tracking (psrhdr-rgb565-draw-mmap-cpu)
[408.777887] Starting subtest: psrhdr-rgb565-draw-mmap-cpu
[408.779798] Subtest psrhdr-rgb565-draw-mmap-cpu: SKIP (0.000s)
[408.884897] [136/155] (617s left) kms_flip (wf_vblank-ts-check)
[408.974283] Starting subtest: wf_vblank-ts-check
[408.975300] Starting dynamic subtest: A-eDP1
[417.944443] Dynamic subtest A-eDP1: SUCCESS (8.945s)
[417.955550] Starting dynamic subtest: B-eDP1
[426.877867] Dynamic subtest B-eDP1: SUCCESS (8.929s)
[426.889252] Starting dynamic subtest: C-eDP1
[435.805361] Dynamic subtest C-eDP1: SUCCESS (8.912s)
[435.816780] Starting dynamic subtest: D-eDP1
[444.732084] Dynamic subtest D-eDP1: SUCCESS (8.925s)
[444.732956] Subtest wf_vblank-ts-check: SUCCESS (35.724s)
[445.919133] [137/155] (580s left) kms_frontbuffer_tracking (fbchdr-2p-primscrn-pri-indfb-draw-blt)
[446.003695] Starting subtest: fbchdr-2p-primscrn-pri-indfb-draw-blt
[446.005514] Subtest fbchdr-2p-primscrn-pri-indfb-draw-blt: SKIP (0.000s)
[446.090404] [138/155] (580s left) kms_chamelium_frames (dp-crc-single)
[446.470452] Subtest dp-crc-single: SKIP (0.000s)
[447.328818] [139/155] (578s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip)
[447.421751] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip
[447.423870] Subtest yf-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip: SKIP (0.000s)
[447.517319] [140/155] (578s left) gem_exec_schedule (preempt-contexts)
[447.586504] Starting subtest: preempt-contexts
[447.587421] Starting dynamic subtest: rcs0
[447.642224] Dynamic subtest rcs0: SUCCESS (0.057s)
[447.652396] Starting dynamic subtest: bcs0
[447.692937] Dynamic subtest bcs0: SUCCESS (0.050s)
[447.701996] Starting dynamic subtest: vcs0
[447.739103] Dynamic subtest vcs0: SUCCESS (0.045s)
[447.748149] Starting dynamic subtest: vcs1
[447.782528] Dynamic subtest vcs1: SUCCESS (0.043s)
[447.792324] Starting dynamic subtest: vecs0
[447.830532] Dynamic subtest vecs0: SUCCESS (0.047s)
[447.839968] Starting dynamic subtest: ccs0
[447.887629] Dynamic subtest ccs0: SUCCESS (0.056s)
[447.888560] Subtest preempt-contexts: SUCCESS (0.303s)
[449.397299] [141/155] (576s left) gem_mmap_gtt (big-bo)
[449.449619] Subtest big-bo: SKIP (0.000s)
[449.503843] [142/155] (576s left) kms_cursor_crc (cursor-random-64x64)
[449.684621] Starting subtest: cursor-random-64x64
[449.688441] Starting dynamic subtest: pipe-A-eDP-1
[453.040157] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.351s)
[453.071663] Starting dynamic subtest: pipe-D-eDP-1
[457.062303] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.999s)
[457.063309] Subtest cursor-random-64x64: SUCCESS (7.376s)
[457.923917] [143/155] (568s left) perf_pmu (busy-check-all)
[457.966353] Starting subtest: busy-check-all
[457.967257] Starting dynamic subtest: rcs0
[458.519396] Dynamic subtest rcs0: SUCCESS (0.552s)
[458.532982] Starting dynamic subtest: bcs0
[459.069723] Dynamic subtest bcs0: SUCCESS (0.548s)
[459.083360] Starting dynamic subtest: vcs0
[460.328446] Dynamic subtest vcs0: SUCCESS (1.246s)
[460.340029] Starting dynamic subtest: vcs1
[462.313805] Dynamic subtest vcs1: SUCCESS (1.983s)
[462.324584] Starting dynamic subtest: vecs0
[464.360024] Dynamic subtest vecs0: SUCCESS (2.043s)
[464.370467] Starting dynamic subtest: ccs0
[464.905965] Dynamic subtest ccs0: SUCCESS (0.554s)
[464.907152] Subtest busy-check-all: SUCCESS (6.940s)
[464.996606] [144/155] (561s left) kms_cursor_edge_walk (64x64-left-edge)
[465.083213] Starting subtest: 64x64-left-edge
[465.084093] Starting dynamic subtest: pipe-A-eDP-1
[468.597895] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.513s)
[468.609235] Starting dynamic subtest: pipe-D-eDP-1
[471.718136] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.119s)
[471.719130] Subtest 64x64-left-edge: SUCCESS (6.634s)
[472.543225] [145/155] (553s left) gem_userptr_blits (userfault)
[472.620198] Starting subtest: userfault
[472.621095] Subtest userfault: SUCCESS (0.006s)
[472.754826] [146/155] (553s left) gem_exec_whisper (basic-queues-forked)
[472.804183] Starting subtest: basic-queues-forked
[497.367761] Subtest basic-queues-forked: SUCCESS (24.514s)
[497.502096] [147/155] (529s left) kms_psr (fbc-psr2-no-drrs)
[497.605209] Starting subtest: fbc-psr2-no-drrs
[497.606037] Starting dynamic subtest: eDP-1
[497.607849] Dynamic subtest eDP-1: SKIP (0.000s)
[497.609500] Subtest fbc-psr2-no-drrs: SKIP (0.001s)
[497.674942] [148/155] (528s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-0)
[497.776160] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-0
[498.832796] Subtest x-tiled-max-hw-stride-64bpp-rotate-0: SUCCESS (1.057s)
[498.952236] [149/155] (527s left) kms_psr (psr2-cursor-blt)
[499.051507] Starting subtest: psr2-cursor-blt
[499.052344] Starting dynamic subtest: eDP-1
[500.807358] Dynamic subtest eDP-1: SUCCESS (1.755s)
[500.808287] Subtest psr2-cursor-blt: SUCCESS (1.756s)
[501.687751] [150/155] (524s left) kms_flip (2x-flip-vs-dpms)
[501.787548] Starting subtest: 2x-flip-vs-dpms
[501.797760] Subtest 2x-flip-vs-dpms: SKIP (0.011s)
[501.874928] [151/155] (524s left) kms_cursor_legacy (basic-flip-before-cursor-varying-size)
[501.991523] Starting subtest: basic-flip-before-cursor-varying-size
[502.926607] Subtest basic-flip-before-cursor-varying-size: SUCCESS (0.934s)
[503.742487] [152/155] (522s left) kms_async_flips (test-time-stamp-atomic)
[503.835259] Starting subtest: test-time-stamp-atomic
[504.214402] Starting dynamic subtest: pipe-A-eDP-1
[505.047675] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.832s)
[505.423264] Starting dynamic subtest: pipe-B-eDP-1
[506.194149] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.778s)
[506.574768] Starting dynamic subtest: pipe-C-eDP-1
[507.425421] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.857s)
[507.791279] Starting dynamic subtest: pipe-D-eDP-1
[508.559197] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.775s)
[508.560230] Subtest test-time-stamp-atomic: SUCCESS (4.724s)
[509.717466] [153/155] (517s left) kms_getfb (getfb-reject-nv12)
[509.819506] Starting subtest: getfb-reject-nv12
[509.820524] Subtest getfb-reject-nv12: SUCCESS (0.001s)
[509.925064] [154/155] (516s left) kms_big_fb (x-tiled-8bpp-rotate-180)
[510.019245] Starting subtest: x-tiled-8bpp-rotate-180
[511.268249] Subtest x-tiled-8bpp-rotate-180: SUCCESS (1.248s)
[511.392738] [155/155] (515s left) syncobj_wait (wait-for-submit-complex)
[511.440120] Starting subtest: wait-for-submit-complex
[511.501831] Subtest wait-for-submit-complex: SUCCESS (0.061s)
[511.576092] Closing watchdogs
results: parsing output: 0/ for test: kms_frontbuffer_tracking
results: parsing output: 1/ for test: gem_mmap_gtt
results: parsing output: 2/ for test: syncobj_timeline
results: parsing output: 3/ for test: kms_rotation_crc
results: parsing output: 4/ for test: gem_ctx_create
results: parsing output: 5/ for test: syncobj_timeline
results: parsing output: 6/ for test: gem_exec_params
results: parsing output: 7/ for test: syncobj_wait
results: parsing output: 8/ for test: syncobj_timeline
results: parsing output: 9/ for test: kms_pm_rpm
results: parsing output: 10/ for test: kms_psr
results: parsing output: 11/ for test: syncobj_timeline
results: parsing output: 12/ for test: gem_spin_batch
results: parsing output: 13/ for test: kms_frontbuffer_tracking
results: parsing output: 14/ for test: kms_color
results: parsing output: 15/ for test: kms_frontbuffer_tracking
results: parsing output: 16/ for test: kms_frontbuffer_tracking
results: parsing output: 17/ for test: kms_frontbuffer_tracking
results: parsing output: 18/ for test: kms_frontbuffer_tracking
results: parsing output: 19/ for test: i915_query
results: parsing output: 20/ for test: kms_cursor_legacy
results: parsing output: 21/ for test: sysfs_timeslice_duration
results: parsing output: 22/ for test: perf
results: parsing output: 23/ for test: fbdev
results: parsing output: 24/ for test: gem_partial_pwrite_pread
results: parsing output: 25/ for test: kms_ccs
results: parsing output: 26/ for test: syncobj_timeline
results: parsing output: 27/ for test: gem_ctx_shared
results: parsing output: 28/ for test: kms_ccs
results: parsing output: 29/ for test: gem_ctx_exec
results: parsing output: 30/ for test: perf
results: parsing output: 31/ for test: kms_frontbuffer_tracking
results: parsing output: 32/ for test: kms_frontbuffer_tracking
results: parsing output: 33/ for test: kms_frontbuffer_tracking
results: parsing output: 34/ for test: gem_mmap_wc
results: parsing output: 35/ for test: gem_ctx_persistence
results: parsing output: 36/ for test: gem_exec_flush
results: parsing output: 37/ for test: kms_psr_stress_test
results: parsing output: 38/ for test: kms_frontbuffer_tracking
results: parsing output: 39/ for test: kms_chamelium_color
results: parsing output: 40/ for test: kms_frontbuffer_tracking
results: parsing output: 41/ for test: kms_vrr
results: parsing output: 42/ for test: gem_exec_reloc
results: parsing output: 43/ for test: kms_frontbuffer_tracking
results: parsing output: 44/ for test: kms_sequence
results: parsing output: 45/ for test: gem_exec_balancer
results: parsing output: 46/ for test: kms_psr
results: parsing output: 47/ for test: i915_suspend
results: parsing output: 48/ for test: syncobj_wait
results: parsing output: 49/ for test: kms_plane
results: parsing output: 50/ for test: i915_pm_rc6_residency
results: parsing output: 51/ for test: perf
results: parsing output: 52/ for test: gem_ctx_persistence
results: parsing output: 53/ for test: prime_mmap
results: parsing output: 54/ for test: kms_psr
results: parsing output: 55/ for test: gem_softpin
results: parsing output: 56/ for test: kms_plane_multiple
results: parsing output: 57/ for test: kms_pm_rpm
results: parsing output: 58/ for test: sw_sync
results: parsing output: 59/ for test: gem_mmap_gtt
results: parsing output: 60/ for test: kms_big_fb
results: parsing output: 61/ for test: kms_frontbuffer_tracking
results: parsing output: 62/ for test: core_sysfs
results: parsing output: 63/ for test: kms_ccs
results: parsing output: 64/ for test: gem_exec_whisper
results: parsing output: 65/ for test: kms_frontbuffer_tracking
results: parsing output: 66/ for test: kms_ccs
results: parsing output: 67/ for test: kms_frontbuffer_tracking
results: parsing output: 68/ for test: kms_flip_scaled_crc
results: parsing output: 69/ for test: kms_frontbuffer_tracking
results: parsing output: 70/ for test: gem_exec_fence
results: parsing output: 71/ for test: kms_big_fb
results: parsing output: 72/ for test: gem_ctx_param
results: parsing output: 73/ for test: kms_frontbuffer_tracking
results: parsing output: 74/ for test: kms_frontbuffer_tracking
results: parsing output: 75/ for test: kms_frontbuffer_tracking
results: parsing output: 76/ for test: gem_mmap_gtt
results: parsing output: 77/ for test: kms_addfb_basic
results: parsing output: 78/ for test: kms_lease
results: parsing output: 79/ for test: gem_exec_schedule
results: parsing output: 80/ for test: kms_joiner
results: parsing output: 81/ for test: kms_frontbuffer_tracking
results: parsing output: 82/ for test: kms_frontbuffer_tracking
results: parsing output: 83/ for test: kms_psr2_sf
results: parsing output: 84/ for test: gem_eio
results: parsing output: 85/ for test: kms_frontbuffer_tracking
results: parsing output: 86/ for test: kms_frontbuffer_tracking
results: parsing output: 87/ for test: kms_frontbuffer_tracking
results: parsing output: 88/ for test: sriov_basic
results: parsing output: 89/ for test: gem_exec_fence
results: parsing output: 90/ for test: kms_chamelium_hpd
results: parsing output: 91/ for test: kms_frontbuffer_tracking
results: parsing output: 92/ for test: gem_exec_fence
results: parsing output: 93/ for test: gem_exec_fence
results: parsing output: 94/ for test: kms_frontbuffer_tracking
results: parsing output: 95/ for test: kms_cursor_legacy
results: parsing output: 96/ for test: kms_frontbuffer_tracking
results: parsing output: 97/ for test: kms_dp_linktrain_fallback
results: parsing output: 98/ for test: gen9_exec_parse
results: parsing output: 99/ for test: kms_content_protection
results: parsing output: 100/ for test: kms_flip
results: parsing output: 101/ for test: kms_frontbuffer_tracking
results: parsing output: 102/ for test: kms_frontbuffer_tracking
results: parsing output: 103/ for test: gem_workarounds
results: parsing output: 104/ for test: kms_frontbuffer_tracking
results: parsing output: 105/ for test: kms_cursor_crc
results: parsing output: 106/ for test: gem_mmap_wc
results: parsing output: 107/ for test: kms_rotation_crc
results: parsing output: 108/ for test: kms_feature_discovery
results: parsing output: 109/ for test: perf_pmu
results: parsing output: 110/ for test: kms_big_fb
results: parsing output: 111/ for test: kms_frontbuffer_tracking
results: parsing output: 112/ for test: kms_rotation_crc
results: parsing output: 113/ for test: kms_flip
results: parsing output: 114/ for test: api_intel_bb
results: parsing output: 115/ for test: i915_drm_fdinfo
results: parsing output: 116/ for test: kms_frontbuffer_tracking
results: parsing output: 117/ for test: kms_plane_scaling
results: parsing output: 118/ for test: syncobj_wait
results: parsing output: 119/ for test: kms_big_fb
results: parsing output: 120/ for test: api_intel_allocator
results: parsing output: 121/ for test: kms_frontbuffer_tracking
results: parsing output: 122/ for test: kms_flip_scaled_crc
results: parsing output: 123/ for test: syncobj_basic
results: parsing output: 124/ for test: gem_render_copy_redux
results: parsing output: 125/ for test: kms_frontbuffer_tracking
results: parsing output: 126/ for test: i915_pm_freq_mult
results: parsing output: 127/ for test: kms_plane_scaling
results: parsing output: 128/ for test: kms_pipe_stress
results: parsing output: 129/ for test: gem_pread
results: parsing output: 130/ for test: gem_render_copy
results: parsing output: 131/ for test: kms_frontbuffer_tracking
results: parsing output: 132/ for test: kms_psr2_sf
results: parsing output: 133/ for test: gem_render_copy
results: parsing output: 134/ for test: kms_frontbuffer_tracking
results: parsing output: 135/ for test: kms_flip
results: parsing output: 136/ for test: kms_frontbuffer_tracking
results: parsing output: 137/ for test: kms_chamelium_frames
results: parsing output: 138/ for test: kms_big_fb
results: parsing output: 139/ for test: gem_exec_schedule
results: parsing output: 140/ for test: gem_mmap_gtt
results: parsing output: 141/ for test: kms_cursor_crc
results: parsing output: 142/ for test: perf_pmu
results: parsing output: 143/ for test: kms_cursor_edge_walk
results: parsing output: 144/ for test: gem_userptr_blits
results: parsing output: 145/ for test: gem_exec_whisper
results: parsing output: 146/ for test: kms_psr
results: parsing output: 147/ for test: kms_big_fb
results: parsing output: 148/ for test: kms_psr
results: parsing output: 149/ for test: kms_flip
results: parsing output: 150/ for test: kms_cursor_legacy
results: parsing output: 151/ for test: kms_async_flips
results: parsing output: 152/ for test: kms_getfb
results: parsing output: 153/ for test: kms_big_fb
results: parsing output: 154/ for test: syncobj_wait
Done.