[56.303321] Initializing watchdogs
[56.303365]   /dev/watchdog0
[56.318379] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:7dd5 Intel Meteorlake (Gen12) Meteor Lake-P [Intel Graphics]
[56.322619] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[56.324684] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[56.328528] [001/156] (960s left) gem_mmap_gtt (coherency)
[56.399059] Subtest coherency: SKIP (0.000s)
[56.453574] [002/156] (960s left) syncobj_eventfd (timeline-wait-before-signal)
[56.515018] Starting subtest: timeline-wait-before-signal
[56.544746] Subtest timeline-wait-before-signal: SUCCESS (0.031s)
[56.625668] [003/156] (960s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-blt)
[56.718155] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-blt
[63.586952] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-blt: SUCCESS (6.804s)
[63.721265] [004/156] (953s left) kms_feature_discovery (chamelium)
[63.797204] Starting subtest: chamelium
[63.801841] Subtest chamelium: SKIP (0.000s)
[63.869690] [005/156] (953s left) gem_ctx_persistence (heartbeat-hang)
[63.940936] Starting subtest: heartbeat-hang
[63.946055] Subtest heartbeat-hang: SKIP (0.000s)
[64.040625] [006/156] (952s left) kms_psr2_sf (psr2-cursor-plane-update-sf)
[64.118244] Starting subtest: psr2-cursor-plane-update-sf
[64.120623] Starting dynamic subtest: pipe-A-eDP-1
[64.688357] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.572s)
[64.697317] Starting dynamic subtest: pipe-B-eDP-1
[66.023199] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.327s)
[66.025577] Subtest psr2-cursor-plane-update-sf: SUCCESS (1.901s)
[66.909615] [007/156] (950s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-mmap-cpu)
[66.991208] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-mmap-cpu
[73.738615] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-mmap-cpu: SUCCESS (6.734s)
[73.866219] [008/156] (943s left) gem_ccs (block-copy-uncompressed)
[73.927841] Starting subtest: block-copy-uncompressed
[73.929821] Starting dynamic subtest: linear-uncompressed-compfmt0-smem-smem
[73.947402] Dynamic subtest linear-uncompressed-compfmt0-smem-smem: SUCCESS (0.022s)
[73.957700] Starting dynamic subtest: xmajor-uncompressed-compfmt0-smem-smem
[73.965488] Dynamic subtest xmajor-uncompressed-compfmt0-smem-smem: SUCCESS (0.018s)
[73.973523] Starting dynamic subtest: tile4-uncompressed-compfmt0-smem-smem
[73.983772] Dynamic subtest tile4-uncompressed-compfmt0-smem-smem: SUCCESS (0.018s)
[73.991518] Starting dynamic subtest: tile64-uncompressed-compfmt0-smem-smem
[74.002798] Dynamic subtest tile64-uncompressed-compfmt0-smem-smem: SUCCESS (0.018s)
[74.005158] Subtest block-copy-uncompressed: SUCCESS (0.077s)
[74.126066] [009/156] (943s left) syncobj_basic (bad-pad-handle-to-fd)
[74.169998] Starting subtest: bad-pad-handle-to-fd
[74.172388] Subtest bad-pad-handle-to-fd: SUCCESS (0.000s)
[74.268189] [010/156] (942s left) kms_flip (flip-vs-fences-interruptible)
[74.342689] Starting subtest: flip-vs-fences-interruptible
[74.347646] Subtest flip-vs-fences-interruptible: SKIP (0.000s)
[74.455994] [011/156] (942s left) kms_psr2_sf (fbc-psr2-cursor-plane-update-sf)
[74.544785] Starting subtest: fbc-psr2-cursor-plane-update-sf
[74.547229] Starting dynamic subtest: pipe-A-eDP-1
[74.618309] Dynamic subtest pipe-A-eDP-1: SKIP (0.078s)
[74.626679] Starting dynamic subtest: pipe-B-eDP-1
[75.733545] Dynamic subtest pipe-B-eDP-1: SKIP (1.111s)
[75.738461] Subtest fbc-psr2-cursor-plane-update-sf: SKIP (1.191s)
[76.918222] [012/156] (940s left) gem_exercise_blt (fast-copy)
[76.975828] Starting subtest: fast-copy
[76.978142] Starting dynamic subtest: linear-smem-smem
[76.997727] Dynamic subtest linear-smem-smem: SUCCESS (0.023s)
[77.005435] Starting dynamic subtest: xmajor-smem-smem
[77.016808] Dynamic subtest xmajor-smem-smem: SUCCESS (0.019s)
[77.024917] Starting dynamic subtest: tile4-smem-smem
[77.035248] Dynamic subtest tile4-smem-smem: SUCCESS (0.018s)
[77.042804] Starting dynamic subtest: tile64-smem-smem
[77.052668] Dynamic subtest tile64-smem-smem: SUCCESS (0.017s)
[77.055363] Subtest fast-copy: SUCCESS (0.078s)
[77.173738] [013/156] (940s left) prime_busy (hang)
[77.223448] Starting subtest: hang
[77.225797] Starting dynamic subtest: rcs0
[103.772766] Dynamic subtest rcs0: SUCCESS (26.531s)
[103.780656] Starting dynamic subtest: bcs0
[110.857732] Dynamic subtest bcs0: SUCCESS (7.081s)
[110.866113] Starting dynamic subtest: vcs0
[117.894725] Dynamic subtest vcs0: SUCCESS (7.038s)
[117.902555] Starting dynamic subtest: vcs1
[124.873963] Dynamic subtest vcs1: SUCCESS (6.974s)
[124.887358] Starting dynamic subtest: vecs0
[131.915857] Dynamic subtest vecs0: SUCCESS (7.042s)
[131.923840] Starting dynamic subtest: ccs0
[145.750925] Dynamic subtest ccs0: SUCCESS (13.832s)
[145.753549] Subtest hang: SUCCESS (68.502s)
[145.863441] [014/156] (871s left) gem_sync (basic-all)
[145.944571] Starting subtest: basic-all
[149.248134] Subtest basic-all: SUCCESS (3.312s)
[149.427078] [015/156] (867s left) sysfs_preempt_timeout (timeout)
[149.477214] Starting subtest: timeout
[149.479598] Starting dynamic subtest: vecs0
[159.231819] Dynamic subtest vecs0: SUCCESS (9.751s)
[159.242985] Starting dynamic subtest: ccs0
[160.555192] Dynamic subtest ccs0: SUCCESS (1.323s)
[160.564304] Starting dynamic subtest: vcs0
[170.241371] Dynamic subtest vcs0: SUCCESS (9.683s)
[170.250535] Starting dynamic subtest: bcs0
[171.493522] Dynamic subtest bcs0: SUCCESS (1.251s)
[171.503065] Starting dynamic subtest: rcs0
[172.759287] Dynamic subtest rcs0: SUCCESS (1.266s)
[172.770353] Starting dynamic subtest: vcs1
[182.199700] Dynamic subtest vcs1: SUCCESS (9.439s)
[182.202345] Subtest timeout: SUCCESS (32.720s)
[182.276105] [016/156] (835s left) kms_flip_scaled_crc (flip-32bpp-linear-to-64bpp-linear-upscaling)
[182.352898] Starting subtest: flip-32bpp-linear-to-64bpp-linear-upscaling
[182.355349] Starting dynamic subtest: pipe-A-default-mode
[185.055558] Dynamic subtest pipe-A-default-mode: SUCCESS (2.701s)
[185.057571] Subtest flip-32bpp-linear-to-64bpp-linear-upscaling: SUCCESS (2.702s)
[185.907407] [017/156] (831s left) gem_pipe_control_store_loop (reused-buffer)
[185.960220] Starting subtest: reused-buffer
[188.112382] Subtest reused-buffer: SUCCESS (2.151s)
[188.221707] [018/156] (829s left) api_intel_allocator (reopen-fork)
[188.268823] Starting subtest: reopen-fork
[191.604038] Subtest reopen-fork: SUCCESS (3.335s)
[191.678201] [019/156] (825s left) gem_exec_balancer (bonded-true-hang)
[191.922459] Starting subtest: bonded-true-hang
[191.927255] Subtest bonded-true-hang: SKIP (0.000s)
[192.042175] [020/156] (825s left) kms_pipe_stress (stress-xrgb8888-ytiled)
[192.116466] Starting subtest: stress-xrgb8888-ytiled
[192.120824] Subtest stress-xrgb8888-ytiled: SKIP (0.000s)
[192.188144] [021/156] (825s left) kms_ccs (bad-rotation-90-4-tiled-dg2-mc-ccs)
[192.262053] Starting subtest: bad-rotation-90-4-tiled-dg2-mc-ccs
[192.264422] Starting dynamic subtest: pipe-A-eDP-1
[192.287528] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[192.302762] Starting dynamic subtest: pipe-B-eDP-1
[192.324592] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[192.332417] Starting dynamic subtest: pipe-C-eDP-1
[192.354251] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[192.361571] Starting dynamic subtest: pipe-D-eDP-1
[192.383395] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[192.387711] Subtest bad-rotation-90-4-tiled-dg2-mc-ccs: SKIP (0.003s)
[194.578818] [022/156] (823s left) kms_flip (2x-flip-vs-fences)
[194.654577] Starting subtest: 2x-flip-vs-fences
[194.659197] Subtest 2x-flip-vs-fences: SKIP (0.000s)
[194.784633] [023/156] (822s left) gem_eio (in-flight-contexts-immediate)
[195.008277] Starting subtest: in-flight-contexts-immediate
[206.220886] Subtest in-flight-contexts-immediate: SUCCESS (11.210s)
[206.370624] [024/156] (811s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-mmap-wc)
[206.450188] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-mmap-wc
[206.454190] Subtest fbc-2p-primscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[206.543365] [025/156] (811s left) gem_userptr_blits (unsync-unmap-after-close)
[206.605125] Subtest unsync-unmap-after-close: SKIP (0.000s)
[206.720284] [026/156] (811s left) kms_vblank (ts-continuation-modeset-rpm)
[206.794387] Starting subtest: ts-continuation-modeset-rpm
[206.796354] Starting dynamic subtest: pipe-A-eDP-1
[209.271267] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.477s)
[209.287046] Starting dynamic subtest: pipe-D-eDP-1
[211.518209] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.243s)
[211.520634] Subtest ts-continuation-modeset-rpm: SUCCESS (4.724s)
[212.413024] [027/156] (805s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-mmap-wc)
[212.488638] Starting subtest: psr-1p-primscrn-cur-indfb-draw-mmap-wc
[219.067357] Subtest psr-1p-primscrn-cur-indfb-draw-mmap-wc: SUCCESS (6.584s)
[219.169273] [028/156] (798s left) gem_mmap_gtt (basic-write)
[219.230274] Subtest basic-write: SKIP (0.000s)
[219.281243] [029/156] (798s left) kms_cursor_crc (cursor-sliding-256x256)
[219.495634] Starting subtest: cursor-sliding-256x256
[219.497990] Starting dynamic subtest: pipe-A-eDP-1
[222.744522] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.245s)
[222.778548] Starting dynamic subtest: pipe-D-eDP-1
[226.619665] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.847s)
[226.622018] Subtest cursor-sliding-256x256: SUCCESS (7.122s)
[227.490316] [030/156] (790s left) kms_properties (get_properties-sanity-atomic)
[227.574813] Starting subtest: get_properties-sanity-atomic
[227.577040] Subtest get_properties-sanity-atomic: SUCCESS (0.002s)
[227.659293] [031/156] (790s left) kms_frontbuffer_tracking (hdr-rgb565-draw-pwrite)
[227.738599] Starting subtest: hdr-rgb565-draw-pwrite
[227.742986] Subtest hdr-rgb565-draw-pwrite: SKIP (0.000s)
[227.830911] [032/156] (790s left) i915_drm_fdinfo (virtual-idle)
[227.870804] Starting subtest: virtual-idle
[230.931232] Subtest virtual-idle: SUCCESS (3.055s)
[231.013405] [033/156] (787s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-180)
[231.099110] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-180
[231.103297] Subtest y-tiled-max-hw-stride-32bpp-rotate-180: SKIP (0.000s)
[231.195899] [034/156] (786s left) kms_frontbuffer_tracking (fbchdr-2p-scndscrn-pri-shrfb-draw-pwrite)
[231.279620] Starting subtest: fbchdr-2p-scndscrn-pri-shrfb-draw-pwrite
[231.283550] Subtest fbchdr-2p-scndscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[231.380433] [035/156] (786s left) perf_pmu (faulting-read)
[231.418838] Starting subtest: faulting-read
[231.421641] Starting dynamic subtest: wb
[231.423830] Dynamic subtest wb: SUCCESS (0.001s)
[231.433089] Starting dynamic subtest: wc
[231.434887] Dynamic subtest wc: SUCCESS (0.000s)
[231.443204] Starting dynamic subtest: uc
[231.445058] Dynamic subtest uc: SUCCESS (0.000s)
[231.446853] Subtest faulting-read: SUCCESS (0.003s)
[231.524944] [036/156] (786s left) prime_mmap (test_invalid_sync_flags)
[231.572848] Starting subtest: test_invalid_sync_flags
[231.575169] Starting dynamic subtest: test_invalid_sync_flags-smem
[231.577104] Dynamic subtest test_invalid_sync_flags-smem: SUCCESS (0.000s)
[231.579048] Subtest test_invalid_sync_flags: SUCCESS (0.000s)
[231.661725] [037/156] (786s left) kms_psr (pr-sprite-plane-onoff)
[231.744442] Starting subtest: pr-sprite-plane-onoff
[231.748982] Subtest pr-sprite-plane-onoff: SKIP (0.000s)
[231.813574] [038/156] (786s left) kms_getfb (getfb2-handle-not-fb)
[231.887686] Starting subtest: getfb2-handle-not-fb
[231.890024] Subtest getfb2-handle-not-fb: SUCCESS (0.000s)
[231.983442] [039/156] (786s left) kms_ccs (ccs-on-another-bo-y-tiled-gen12-mc-ccs)
[232.053173] Starting subtest: ccs-on-another-bo-y-tiled-gen12-mc-ccs
[232.055083] Starting dynamic subtest: pipe-A-eDP-1
[232.073228] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[232.084537] Starting dynamic subtest: pipe-B-eDP-1
[232.102852] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[232.111685] Starting dynamic subtest: pipe-C-eDP-1
[232.129673] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[232.138064] Starting dynamic subtest: pipe-D-eDP-1
[232.156530] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[232.159918] Subtest ccs-on-another-bo-y-tiled-gen12-mc-ccs: SKIP (0.004s)
[234.356954] [040/156] (783s left) gem_close (many-handles-one-vma)
[234.408877] Starting subtest: many-handles-one-vma
[234.433796] Subtest many-handles-one-vma: SUCCESS (0.025s)
[234.564157] [041/156] (783s left) kms_frontbuffer_tracking (hdr-1p-primscrn-cur-indfb-draw-blt)
[234.648666] Starting subtest: hdr-1p-primscrn-cur-indfb-draw-blt
[234.652617] Subtest hdr-1p-primscrn-cur-indfb-draw-blt: SKIP (0.000s)
[234.738682] [042/156] (783s left) core_getversion (all-cards)
[234.772647] Starting subtest: all-cards
[234.780054] Subtest all-cards: SUCCESS (0.010s)
[234.828217] [043/156] (783s left) syncobj_timeline (multi-wait-all-available-signaled)
[234.877149] Starting subtest: multi-wait-all-available-signaled
[234.879578] Subtest multi-wait-all-available-signaled: SUCCESS (0.000s)
[234.977127] [044/156] (783s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-indfb-draw-render)
[235.047540] Starting subtest: fbc-1p-offscreen-pri-indfb-draw-render
[239.174350] Subtest fbc-1p-offscreen-pri-indfb-draw-render: SUCCESS (4.131s)
[240.340788] [045/156] (778s left) syncobj_timeline (single-wait-for-submit-available-submitted)
[240.406411] Starting subtest: single-wait-for-submit-available-submitted
[240.408664] Subtest single-wait-for-submit-available-submitted: SUCCESS (0.000s)
[240.514452] [046/156] (778s left) kms_big_fb (yf-tiled-32bpp-rotate-0)
[240.600663] Starting subtest: yf-tiled-32bpp-rotate-0
[240.605208] Subtest yf-tiled-32bpp-rotate-0: SKIP (0.000s)
[240.706729] [047/156] (777s left) gem_exec_fence (syncobj-repeat)
[241.184211] Starting subtest: syncobj-repeat
[241.372655] Subtest syncobj-repeat: SUCCESS (0.186s)
[242.324945] [FACT gem_exec_fence (syncobj-repeat)] new: kernel.kmod_is_loaded.vgem: true
[242.328121] [048/156] (776s left) kms_ccs (crc-primary-suspend-4-tiled-dg2-rc-ccs)
[242.393990] Starting subtest: crc-primary-suspend-4-tiled-dg2-rc-ccs
[242.396310] Starting dynamic subtest: pipe-A-eDP-1
[242.406184] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[242.416872] Starting dynamic subtest: pipe-B-eDP-1
[242.426090] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[242.435707] Starting dynamic subtest: pipe-C-eDP-1
[242.443943] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[242.452830] Starting dynamic subtest: pipe-D-eDP-1
[242.460984] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[242.464963] Subtest crc-primary-suspend-4-tiled-dg2-rc-ccs: SKIP (0.004s)
[244.699823] [049/156] (773s left) syncobj_timeline (multi-wait-for-submit-available-signaled)
[244.755410] Starting subtest: multi-wait-for-submit-available-signaled
[244.757806] Subtest multi-wait-for-submit-available-signaled: SUCCESS (0.000s)
[244.853915] [050/156] (773s left) kms_atomic (plane-overlay-legacy)
[244.923153] Starting subtest: plane-overlay-legacy
[244.925275] Starting dynamic subtest: pipe-A-eDP-1
[245.315631] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.391s)
[245.318054] Subtest plane-overlay-legacy: SUCCESS (0.392s)
[246.124379] [051/156] (772s left) kms_frontbuffer_tracking (psrhdr-2p-scndscrn-cur-indfb-draw-mmap-gtt)
[246.208271] Starting subtest: psrhdr-2p-scndscrn-cur-indfb-draw-mmap-gtt
[246.212459] Subtest psrhdr-2p-scndscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[246.302503] [052/156] (772s left) gem_madvise (dontneed-before-pwrite)
[246.336881] Starting subtest: dontneed-before-pwrite
[246.361437] Subtest dontneed-before-pwrite: SKIP (0.023s)
[246.418911] [053/156] (772s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-blt)
[246.505366] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-blt
[246.509941] Subtest fbc-2p-scndscrn-spr-indfb-draw-blt: SKIP (0.000s)
[246.617236] [054/156] (772s left) kms_cursor_crc (cursor-offscreen-64x21)
[246.788956] Starting subtest: cursor-offscreen-64x21
[246.837107] Subtest cursor-offscreen-64x21: SKIP (0.042s)
[247.068869] [055/156] (771s left) kms_frontbuffer_tracking (hdr-2p-primscrn-pri-shrfb-draw-mmap-wc)
[247.155915] Starting subtest: hdr-2p-primscrn-pri-shrfb-draw-mmap-wc
[247.159691] Subtest hdr-2p-primscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[247.274092] [056/156] (771s left) perf_pmu (busy-hang)
[247.313390] Starting subtest: busy-hang
[247.315252] Starting dynamic subtest: rcs0
[248.568960] Dynamic subtest rcs0: SUCCESS (1.255s)
[248.581420] Starting dynamic subtest: bcs0
[249.798797] Dynamic subtest bcs0: SUCCESS (1.225s)
[249.809540] Starting dynamic subtest: vcs0
[251.708615] Dynamic subtest vcs0: SUCCESS (1.910s)
[251.720767] Starting dynamic subtest: vcs1
[253.761217] Dynamic subtest vcs1: SUCCESS (2.048s)
[253.770225] Starting dynamic subtest: vecs0
[255.744886] Dynamic subtest vecs0: SUCCESS (1.983s)
[255.756579] Starting dynamic subtest: ccs0
[256.982762] Dynamic subtest ccs0: SUCCESS (1.236s)
[256.985394] Subtest busy-hang: SUCCESS (9.667s)
[257.081020] [057/156] (761s left) kms_joiner (invalid-modeset-force-big-joiner)
[257.155814] Starting subtest: invalid-modeset-force-big-joiner
[257.160164] Subtest invalid-modeset-force-big-joiner: SKIP (0.000s)
[257.221741] [058/156] (761s left) syncobj_timeline (invalid-multi-wait-all-unsubmitted-submitted-signaled)
[257.269871] Starting subtest: invalid-multi-wait-all-unsubmitted-submitted-signaled
[257.272136] Subtest invalid-multi-wait-all-unsubmitted-submitted-signaled: SUCCESS (0.000s)
[257.378339] [059/156] (761s left) kms_frontbuffer_tracking (fbc-rgb565-draw-mmap-wc)
[257.460385] Starting subtest: fbc-rgb565-draw-mmap-wc
[261.425308] Subtest fbc-rgb565-draw-mmap-wc: SUCCESS (3.972s)
[262.621490] [060/156] (756s left) gem_exec_params (larger-than-life-batch)
[262.671790] Starting subtest: larger-than-life-batch
[264.854745] Subtest larger-than-life-batch: SUCCESS (2.183s)
[265.265053] [061/156] (753s left) gem_exec_params (no-bsd)
[265.347786] Starting subtest: no-bsd
[265.350152] Subtest no-bsd: SUCCESS (0.003s)
[267.329584] [062/156] (751s left) kms_frontbuffer_tracking (fbchdr-2p-primscrn-spr-indfb-draw-mmap-cpu)
[267.422277] Starting subtest: fbchdr-2p-primscrn-spr-indfb-draw-mmap-cpu
[267.426587] Subtest fbchdr-2p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[267.518118] [063/156] (751s left) gem_pread (bench)
[267.575128] Subtest bench: SKIP (0.000s)
[267.635093] [064/156] (751s left) kms_big_fb (4-tiled-64bpp-rotate-270)
[267.726518] Starting subtest: 4-tiled-64bpp-rotate-270
[267.745302] Subtest 4-tiled-64bpp-rotate-270: SKIP (0.018s)
[267.847970] [065/156] (751s left) gem_softpin (32b-excludes-last-page)
[267.914582] Starting subtest: 32b-excludes-last-page
[267.919571] Subtest 32b-excludes-last-page: SUCCESS (0.003s)
[268.041481] [066/156] (751s left) kms_atomic_interruptible (atomic-setmode)
[268.127081] Starting subtest: atomic-setmode
[268.129424] Starting dynamic subtest: pipe-A-eDP-1
[275.033580] Dynamic subtest pipe-A-eDP-1: SUCCESS (6.906s)
[275.035942] Subtest atomic-setmode: SUCCESS (6.907s)
[275.837447] [067/156] (743s left) i915_pm_rpm (system-suspend-devices)
[277.369534] Starting subtest: system-suspend-devices
[285.178434] Subtest system-suspend-devices: SUCCESS (7.811s)
[285.587199] [068/156] (733s left) kms_content_protection (dp-mst-type-0)
[285.722964] Starting subtest: dp-mst-type-0
[285.728604] Subtest dp-mst-type-0: SKIP (0.000s)
[285.837616] [069/156] (733s left) kms_frontbuffer_tracking (fbchdr-2p-primscrn-cur-indfb-draw-mmap-cpu)
[285.913355] Starting subtest: fbchdr-2p-primscrn-cur-indfb-draw-mmap-cpu
[285.917628] Subtest fbchdr-2p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[286.011207] [070/156] (733s left) kms_psr (fbc-pr-primary-render)
[286.088443] Starting subtest: fbc-pr-primary-render
[286.092743] Subtest fbc-pr-primary-render: SKIP (0.000s)
[286.162422] [071/156] (733s left) kms_plane (pixel-format-4-tiled-modifier)
[286.242314] Starting subtest: pixel-format-4-tiled-modifier
[286.268638] Starting dynamic subtest: pipe-A-plane-0
[286.656876] Dynamic subtest pipe-A-plane-0: SUCCESS (0.389s)
[286.667747] Starting dynamic subtest: pipe-A-plane-3
[287.012641] Dynamic subtest pipe-A-plane-3: SUCCESS (0.355s)
[287.025201] Starting dynamic subtest: pipe-A-plane-5
[287.028928] Dynamic subtest pipe-A-plane-5: SKIP (0.000s)
[288.160016] Starting dynamic subtest: pipe-B-plane-0
[288.547608] Dynamic subtest pipe-B-plane-0: SUCCESS (0.400s)
[288.559131] Starting dynamic subtest: pipe-B-plane-3
[288.858766] Dynamic subtest pipe-B-plane-3: SUCCESS (0.310s)
[288.869585] Starting dynamic subtest: pipe-B-plane-5
[288.873949] Dynamic subtest pipe-B-plane-5: SKIP (0.000s)
[289.172641] Subtest pixel-format-4-tiled-modifier: SUCCESS (2.930s)
[290.038660] [072/156] (729s left) kms_flip (nonblocking-read)
[290.109921] Starting subtest: nonblocking-read
[290.111802] Subtest nonblocking-read: SUCCESS (0.000s)
[290.210945] [073/156] (729s left) gem_sync (basic-store-each)
[290.277093] Starting subtest: basic-store-each
[292.609847] Subtest basic-store-each: SUCCESS (2.342s)
[292.810733] [074/156] (726s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-primscrn-indfb-msflip-blt)
[292.893727] Starting subtest: fbcpsrhdr-1p-primscrn-indfb-msflip-blt
[292.897613] Subtest fbcpsrhdr-1p-primscrn-indfb-msflip-blt: SKIP (0.000s)
[292.995718] [075/156] (726s left) kms_pm_rpm (universal-planes-dpms)
[294.496609] Starting subtest: universal-planes-dpms
[294.499612] Starting dynamic subtest: plane-35
[302.812793] Dynamic subtest plane-35: SUCCESS (8.315s)
[302.825585] Starting dynamic subtest: plane-65
[311.119953] Dynamic subtest plane-65: SUCCESS (8.304s)
[311.136035] Starting dynamic subtest: plane-95
[319.449665] Dynamic subtest plane-95: SUCCESS (8.326s)
[319.461428] Starting dynamic subtest: plane-125
[327.758216] Dynamic subtest plane-125: SUCCESS (8.306s)
[327.771941] Starting dynamic subtest: plane-135
[336.038188] Dynamic subtest plane-135: SUCCESS (8.277s)
[336.051640] Starting dynamic subtest: plane-145
[344.346136] Dynamic subtest plane-145: SUCCESS (8.304s)
[344.349308] Subtest universal-planes-dpms: SUCCESS (49.849s)
[344.721415] [076/156] (675s left) gem_mmap_wc (write-gtt-read-wc)
[344.789644] Subtest write-gtt-read-wc: SKIP (0.000s)
[344.854196] [077/156] (674s left) kms_plane (pixel-format-4-tiled-mtl-rc-ccs-cc-modifier)
[344.936466] Starting subtest: pixel-format-4-tiled-mtl-rc-ccs-cc-modifier
[344.961711] Starting dynamic subtest: pipe-A-plane-0
[345.250461] Dynamic subtest pipe-A-plane-0: SUCCESS (0.289s)
[345.264328] Starting dynamic subtest: pipe-A-plane-3
[345.483769] Dynamic subtest pipe-A-plane-3: SUCCESS (0.231s)
[345.494058] Starting dynamic subtest: pipe-A-plane-5
[345.498726] Dynamic subtest pipe-A-plane-5: SKIP (0.000s)
[346.621897] Starting dynamic subtest: pipe-B-plane-0
[346.911386] Dynamic subtest pipe-B-plane-0: SUCCESS (0.300s)
[346.924887] Starting dynamic subtest: pipe-B-plane-3
[347.144570] Dynamic subtest pipe-B-plane-3: SUCCESS (0.233s)
[347.155095] Starting dynamic subtest: pipe-B-plane-5
[347.159699] Dynamic subtest pipe-B-plane-5: SKIP (0.000s)
[347.461370] Subtest pixel-format-4-tiled-mtl-rc-ccs-cc-modifier: SUCCESS (2.526s)
[348.298225] [078/156] (671s left) kms_frontbuffer_tracking (fbchdr-2p-indfb-fliptrack-mmap-gtt)
[348.383089] Starting subtest: fbchdr-2p-indfb-fliptrack-mmap-gtt
[348.387302] Subtest fbchdr-2p-indfb-fliptrack-mmap-gtt: SKIP (0.000s)
[348.484422] [079/156] (671s left) kms_psr (fbc-psr-cursor-plane-onoff)
[348.558177] Starting subtest: fbc-psr-cursor-plane-onoff
[348.560438] Starting dynamic subtest: eDP-1
[348.564665] Dynamic subtest eDP-1: SKIP (0.000s)
[348.568856] Subtest fbc-psr-cursor-plane-onoff: SKIP (0.001s)
[348.647112] [080/156] (671s left) kms_plane_scaling (plane-downscale-factor-0-5-with-modifiers)
[348.713426] Starting subtest: plane-downscale-factor-0-5-with-modifiers
[348.715711] Starting dynamic subtest: pipe-A
[348.735479] Dynamic subtest pipe-A: SKIP (0.018s)
[348.746919] Starting dynamic subtest: pipe-B
[348.770310] Dynamic subtest pipe-B: SKIP (0.033s)
[348.781089] Starting dynamic subtest: pipe-C
[348.812055] Dynamic subtest pipe-C: SKIP (0.041s)
[348.822589] Starting dynamic subtest: pipe-D
[348.843348] Dynamic subtest pipe-D: SKIP (0.031s)
[348.847676] Subtest plane-downscale-factor-0-5-with-modifiers: SKIP (0.126s)
[348.954077] [081/156] (671s left) kms_big_fb (linear-8bpp-rotate-180)
[349.032817] Starting subtest: linear-8bpp-rotate-180
[350.256596] Subtest linear-8bpp-rotate-180: SUCCESS (1.224s)
[350.367082] [082/156] (669s left) gem_mmap (bad-size)
[350.415637] Subtest bad-size: SKIP (0.000s)
[350.487508] [083/156] (669s left) kms_frontbuffer_tracking (psr-rgb565-draw-render)
[350.577784] Starting subtest: psr-rgb565-draw-render
[357.656993] Subtest psr-rgb565-draw-render: SUCCESS (7.082s)
[357.793781] [084/156] (662s left) gem_close_race (multigpu-basic-process)
[357.848353] Starting subtest: multigpu-basic-process
[357.852617] Subtest multigpu-basic-process: SKIP (0.000s)
[358.072497] [085/156] (662s left) gem_ctx_persistence (engines-mixed)
[358.119658] Starting subtest: engines-mixed
[358.122079] Starting dynamic subtest: rcs0
[358.199062] Dynamic subtest rcs0: SUCCESS (0.079s)
[358.212478] Starting dynamic subtest: bcs0
[358.263643] Dynamic subtest bcs0: SUCCESS (0.062s)
[358.277380] Starting dynamic subtest: vcs0
[358.326980] Dynamic subtest vcs0: SUCCESS (0.061s)
[358.340169] Starting dynamic subtest: vcs1
[358.377429] Dynamic subtest vcs1: SUCCESS (0.049s)
[358.389517] Starting dynamic subtest: vecs0
[358.429445] Dynamic subtest vecs0: SUCCESS (0.050s)
[358.440842] Starting dynamic subtest: ccs0
[358.490603] Dynamic subtest ccs0: SUCCESS (0.060s)
[358.492840] Subtest engines-mixed: SUCCESS (0.372s)
[358.584329] [086/156] (661s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-mmap-cpu)
[358.667183] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-mmap-cpu
[358.671443] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[358.761702] [087/156] (661s left) kms_frontbuffer_tracking (hdr-1p-offscreen-pri-shrfb-draw-pwrite)
[358.846197] Starting subtest: hdr-1p-offscreen-pri-shrfb-draw-pwrite
[358.850336] Subtest hdr-1p-offscreen-pri-shrfb-draw-pwrite: SKIP (0.000s)
[358.940601] [088/156] (661s left) kms_cursor_legacy (torture-bo)
[359.041568] Starting subtest: torture-bo
[359.043526] Starting dynamic subtest: pipe-A
[364.822533] Dynamic subtest pipe-A: SUCCESS (5.776s)
[364.841563] Starting dynamic subtest: pipe-B
[371.263797] Dynamic subtest pipe-B: SUCCESS (6.441s)
[371.278903] Starting dynamic subtest: pipe-C
[377.762770] Dynamic subtest pipe-C: SUCCESS (6.497s)
[377.781974] Starting dynamic subtest: pipe-D
[384.625671] Dynamic subtest pipe-D: SUCCESS (6.860s)
[384.640539] Starting dynamic subtest: all-pipes
[391.136939] Dynamic subtest all-pipes: SUCCESS (6.508s)
[391.139694] Subtest torture-bo: SUCCESS (32.091s)
[391.298420] [089/156] (629s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-mmap-gtt)
[391.388836] Starting subtest: fbcpsr-rgb565-draw-mmap-gtt
[391.392888] Subtest fbcpsr-rgb565-draw-mmap-gtt: SKIP (0.000s)
[391.495445] [090/156] (628s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-render)
[391.580022] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-render
[391.584410] Subtest psr-2p-scndscrn-pri-indfb-draw-render: SKIP (0.000s)
[391.668205] [091/156] (628s left) gem_exec_flush (basic-batch-kernel-default-uc)
[391.726332] Starting subtest: basic-batch-kernel-default-uc
[398.772247] Subtest basic-batch-kernel-default-uc: SUCCESS (7.046s)
[398.958887] [092/156] (621s left) kms_frontbuffer_tracking (psrhdr-2p-scndscrn-spr-indfb-draw-blt)
[399.038212] Starting subtest: psrhdr-2p-scndscrn-spr-indfb-draw-blt
[399.042590] Subtest psrhdr-2p-scndscrn-spr-indfb-draw-blt: SKIP (0.000s)
[399.143645] [093/156] (621s left) perf (invalid-oa-metric-set-id)
[399.289695] Starting subtest: invalid-oa-metric-set-id
[399.301282] Subtest invalid-oa-metric-set-id: SUCCESS (0.012s)
[399.343635] [094/156] (621s left) gem_softpin (reverse)
[399.407045] Starting subtest: reverse
[399.413780] Subtest reverse: SUCCESS (0.007s)
[399.540477] [095/156] (621s left) gem_tiled_fence_blits (basic)
[399.601357] Subtest basic: SKIP (0.000s)
[399.664374] [096/156] (620s left) kms_frontbuffer_tracking (fbchdr-1p-primscrn-cur-indfb-draw-render)
[399.749565] Starting subtest: fbchdr-1p-primscrn-cur-indfb-draw-render
[399.753824] Subtest fbchdr-1p-primscrn-cur-indfb-draw-render: SKIP (0.000s)
[399.880438] [097/156] (620s left) kms_cursor_crc (cursor-sliding-512x512)
[400.103456] Starting subtest: cursor-sliding-512x512
[400.107103] Subtest cursor-sliding-512x512: SKIP (0.001s)
[400.252023] [098/156] (620s left) gem_exec_whisper (basic-contexts-forked-all)
[400.303107] Starting subtest: basic-contexts-forked-all
[419.270046] Subtest basic-contexts-forked-all: SUCCESS (18.961s)
[419.468390] [099/156] (601s left) gem_exec_capture (capture)
[419.528368] Starting subtest: capture
[419.531356] Starting dynamic subtest: rcs0-smem
[420.364653] Dynamic subtest rcs0-smem: SUCCESS (0.835s)
[420.375632] Starting dynamic subtest: bcs0-smem
[421.190273] Dynamic subtest bcs0-smem: SUCCESS (0.825s)
[421.202040] Starting dynamic subtest: vcs0-smem
[422.020539] Dynamic subtest vcs0-smem: SUCCESS (0.827s)
[422.034077] Starting dynamic subtest: vcs1-smem
[422.832640] Dynamic subtest vcs1-smem: SUCCESS (0.813s)
[422.846138] Starting dynamic subtest: vecs0-smem
[424.228836] Dynamic subtest vecs0-smem: FAIL (1.335s)
[424.242129] Starting dynamic subtest: ccs0-smem
[425.488390] Dynamic subtest ccs0-smem: SUCCESS (1.318s)
[425.490349] Subtest capture: FAIL (5.957s)
[425.596352] [100/156] (595s left) syncobj_basic (create-signaled)
[425.642878] Starting subtest: create-signaled
[425.645172] Subtest create-signaled: SUCCESS (0.000s)
[425.736301] [101/156] (595s left) kms_big_fb (y-tiled-8bpp-rotate-180)
[425.817979] Starting subtest: y-tiled-8bpp-rotate-180
[425.822280] Subtest y-tiled-8bpp-rotate-180: SKIP (0.000s)
[425.914297] [102/156] (594s left) gem_userptr_blits (sd-probe)
[425.969786] Starting subtest: sd-probe
[425.972071] Subtest sd-probe: SUCCESS (0.000s)
[426.081114] [103/156] (594s left) i915_suspend (forcewake)
[426.127176] Starting subtest: forcewake
[457.754549] Subtest forcewake: SUCCESS (2.315s)
[457.823077] [104/156] (563s left) gem_userptr_blits (sync-unmap-after-close)
[457.892917] Starting subtest: sync-unmap-after-close
[457.902333] Subtest sync-unmap-after-close: SUCCESS (0.012s)
[458.023410] [105/156] (562s left) drm_mm (drm_mm)
[458.062769] Starting subtest: drm_mm
[458.143349] Starting dynamic subtest: drm_test_mm_init
[458.244713] Dynamic subtest drm_test_mm_init: SUCCESS (0.097s)
[458.256368] Starting dynamic subtest: drm_test_mm_debug
[458.337574] Dynamic subtest drm_test_mm_debug: SUCCESS (0.088s)
[458.349271] Starting dynamic subtest: drm_test_mm_align32
[458.436441] Dynamic subtest drm_test_mm_align32: SUCCESS (0.094s)
[458.449548] Starting dynamic subtest: drm_test_mm_align64
[458.545205] Dynamic subtest drm_test_mm_align64: SUCCESS (0.103s)
[458.557545] Starting dynamic subtest: drm_test_mm_lowest
[458.631562] Dynamic subtest drm_test_mm_lowest: SUCCESS (0.085s)
[458.645050] Starting dynamic subtest: drm_test_mm_highest
[458.718179] Dynamic subtest drm_test_mm_highest: SUCCESS (0.079s)
[458.720692] Subtest drm_mm: SUCCESS (0.633s)
[458.885032] [106/156] (562s left) kms_frontbuffer_tracking (psrhdr-1p-primscrn-indfb-pgflip-blt)
[458.968614] Starting subtest: psrhdr-1p-primscrn-indfb-pgflip-blt
[458.972189] Subtest psrhdr-1p-primscrn-indfb-pgflip-blt: SKIP (0.000s)
[459.074159] [107/156] (562s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-cpu)
[459.150865] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-cpu
[459.155349] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[459.239242] [108/156] (561s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-move)
[459.317046] Starting subtest: fbc-2p-primscrn-cur-indfb-move
[459.321253] Subtest fbc-2p-primscrn-cur-indfb-move: SKIP (0.000s)
[459.413861] [109/156] (561s left) gem_exec_params (invalid-bsd2-flag-on-render)
[459.464945] Starting subtest: invalid-bsd2-flag-on-render
[459.467003] Subtest invalid-bsd2-flag-on-render: SUCCESS (0.000s)
[459.577964] [110/156] (561s left) gem_partial_pwrite_pread (reads-snoop)
[459.631561] Subtest reads-snoop: SKIP (0.000s)
[459.707589] [111/156] (561s left) kms_cursor_legacy (basic-busy-flip-before-cursor-legacy)
[459.809381] Starting subtest: basic-busy-flip-before-cursor-legacy
[459.814195] Subtest basic-busy-flip-before-cursor-legacy: SKIP (0.000s)
[459.958604] [112/156] (561s left) kms_frontbuffer_tracking (fbcpsrhdr-farfromfence-mmap-gtt)
[460.032867] Starting subtest: fbcpsrhdr-farfromfence-mmap-gtt
[460.037366] Subtest fbcpsrhdr-farfromfence-mmap-gtt: SKIP (0.000s)
[460.117570] [113/156] (561s left) kms_flip (2x-flip-vs-modeset)
[460.190775] Starting subtest: 2x-flip-vs-modeset
[460.198326] Subtest 2x-flip-vs-modeset: SKIP (0.007s)
[460.299351] [114/156] (561s left) kms_big_fb (x-tiled-16bpp-rotate-180)
[460.399990] Starting subtest: x-tiled-16bpp-rotate-180
[461.747078] Subtest x-tiled-16bpp-rotate-180: SUCCESS (1.312s)
[461.849092] [115/156] (559s left) kms_frontbuffer_tracking (hdr-1p-primscrn-spr-indfb-move)
[461.928595] Starting subtest: hdr-1p-primscrn-spr-indfb-move
[461.933388] Subtest hdr-1p-primscrn-spr-indfb-move: SKIP (0.000s)
[462.047504] [116/156] (559s left) kms_vblank (query-forked-hang)
[462.115429] Starting subtest: query-forked-hang
[462.118025] Starting dynamic subtest: pipe-A-eDP-1
[488.389442] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.098s)
[488.407017] Starting dynamic subtest: pipe-D-eDP-1
[513.330073] Dynamic subtest pipe-D-eDP-1: SUCCESS (24.928s)
[513.332923] Subtest query-forked-hang: SUCCESS (51.030s)
[514.149399] [117/156] (507s left) kms_lease (lease-revoke)
[514.233733] Starting subtest: lease-revoke
[514.236182] Starting dynamic subtest: pipe-A-eDP-1
[514.269953] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.034s)
[514.284219] Starting dynamic subtest: pipe-B-eDP-1
[514.297973] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.028s)
[514.312186] Starting dynamic subtest: pipe-C-eDP-1
[514.324577] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.028s)
[514.340781] Starting dynamic subtest: pipe-D-eDP-1
[514.357177] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.028s)
[514.359824] Subtest lease-revoke: SUCCESS (0.123s)
[514.477870] [118/156] (507s left) i915_drm_fdinfo (busy-idle-check-all)
[514.517896] Starting subtest: busy-idle-check-all
[514.520372] Starting dynamic subtest: rcs0
[514.526351] Dynamic subtest rcs0: SKIP (0.004s)
[514.538841] Starting dynamic subtest: bcs0
[514.544247] Dynamic subtest bcs0: SKIP (0.000s)
[514.557753] Starting dynamic subtest: vcs0
[514.562542] Dynamic subtest vcs0: SKIP (0.000s)
[514.573518] Starting dynamic subtest: vcs1
[514.578535] Dynamic subtest vcs1: SKIP (0.000s)
[514.589517] Starting dynamic subtest: vecs0
[514.594737] Dynamic subtest vecs0: SKIP (0.001s)
[514.605422] Starting dynamic subtest: ccs0
[514.610815] Dynamic subtest ccs0: SKIP (0.000s)
[514.616007] Subtest busy-idle-check-all: SKIP (0.009s)
[514.656433] [119/156] (507s left) gem_exec_schedule (submit-early-slice)
[514.751879] Starting subtest: submit-early-slice
[514.754166] Starting dynamic subtest: rcs0
[514.785628] Dynamic subtest rcs0: SUCCESS (0.044s)
[514.798245] Starting dynamic subtest: bcs0
[514.823094] Dynamic subtest bcs0: SUCCESS (0.037s)
[514.834197] Starting dynamic subtest: vcs0
[514.863437] Dynamic subtest vcs0: SUCCESS (0.040s)
[514.876289] Starting dynamic subtest: vcs1
[514.900179] Dynamic subtest vcs1: SUCCESS (0.036s)
[514.911518] Starting dynamic subtest: vecs0
[514.938300] Dynamic subtest vecs0: SUCCESS (0.037s)
[514.949507] Starting dynamic subtest: ccs0
[514.976360] Dynamic subtest ccs0: SUCCESS (0.037s)
[514.978963] Subtest submit-early-slice: SUCCESS (0.235s)
[516.619124] [120/156] (505s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-16bpp-4tile-downscaling)
[516.688309] Starting subtest: flip-64bpp-4tile-to-16bpp-4tile-downscaling
[516.690929] Starting dynamic subtest: pipe-A-default-mode
[517.813344] Dynamic subtest pipe-A-default-mode: SKIP (1.119s)
[517.818192] Subtest flip-64bpp-4tile-to-16bpp-4tile-downscaling: SKIP (1.121s)
[517.948331] [121/156] (503s left) kms_frontbuffer_tracking (psrhdr-1p-primscrn-spr-indfb-draw-pwrite)
[518.028248] Starting subtest: psrhdr-1p-primscrn-spr-indfb-draw-pwrite
[518.033337] Subtest psrhdr-1p-primscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[518.127763] [122/156] (503s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-offscreen-pri-indfb-draw-pwrite)
[518.214085] Starting subtest: fbcpsrhdr-1p-offscreen-pri-indfb-draw-pwrite
[518.218938] Subtest fbcpsrhdr-1p-offscreen-pri-indfb-draw-pwrite: SKIP (0.000s)
[518.312428] [123/156] (503s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-shrfb-fliptrack-mmap-gtt)
[518.392374] Starting subtest: fbcpsrhdr-1p-shrfb-fliptrack-mmap-gtt
[518.397242] Subtest fbcpsrhdr-1p-shrfb-fliptrack-mmap-gtt: SKIP (0.000s)
[518.490437] [124/156] (503s left) gen9_exec_parse (secure-batches)
[518.546118] Subtest secure-batches: SKIP (0.000s)
[518.618276] [125/156] (503s left) kms_plane_scaling (planes-upscale-factor-0-25)
[518.695137] Starting subtest: planes-upscale-factor-0-25
[518.697592] Starting dynamic subtest: pipe-A
[518.755326] Dynamic subtest pipe-A: SUCCESS (0.062s)
[518.767594] Starting dynamic subtest: pipe-B
[519.901856] Dynamic subtest pipe-B: SUCCESS (1.144s)
[519.913991] Starting dynamic subtest: pipe-C
[521.012807] Dynamic subtest pipe-C: SUCCESS (1.109s)
[521.031826] Starting dynamic subtest: pipe-D
[522.139174] Dynamic subtest pipe-D: SUCCESS (1.124s)
[522.141570] Subtest planes-upscale-factor-0-25: SUCCESS (3.445s)
[523.307367] [126/156] (498s left) gem_eio (in-flight-internal-10ms)
[523.512777] Starting subtest: in-flight-internal-10ms
[524.593046] Subtest in-flight-internal-10ms: SUCCESS (1.077s)
[524.732105] [127/156] (497s left) kms_big_fb (yf-tiled-64bpp-rotate-0)
[524.821548] Starting subtest: yf-tiled-64bpp-rotate-0
[524.826302] Subtest yf-tiled-64bpp-rotate-0: SKIP (0.000s)
[524.931049] [128/156] (497s left) kms_chamelium_hpd (vga-hpd-without-ddc)
[525.310176] Subtest vga-hpd-without-ddc: SKIP (0.000s)
[526.121288] [129/156] (495s left) kms_psr (fbc-pr-sprite-render)
[526.189292] Starting subtest: fbc-pr-sprite-render
[526.194748] Subtest fbc-pr-sprite-render: SKIP (0.000s)
[526.260206] [130/156] (495s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-mmap-cpu)
[526.339744] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-mmap-cpu
[526.344399] Subtest psr-2p-scndscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[526.452001] [131/156] (495s left) kms_chamelium_color (degamma)
[526.530304] Subtest degamma: SKIP (0.000s)
[526.574638] [132/156] (495s left) gem_render_copy (yf-tiled-ccs-to-x-tiled)
[526.626524] Starting subtest: yf-tiled-ccs-to-x-tiled
[526.632297] Subtest yf-tiled-ccs-to-x-tiled: SKIP (0.000s)
[526.811949] [133/156] (495s left) kms_frontbuffer_tracking (fbc-suspend)
[526.895279] Starting subtest: fbc-suspend
[564.320247] Subtest fbc-suspend: SUCCESS (7.445s)
[565.540119] [134/156] (456s left) gem_exec_schedule (pi-userfault)
[565.725230] Starting subtest: pi-userfault
[565.727424] Starting dynamic subtest: rcs0
[565.732214] Dynamic subtest rcs0: SUCCESS (0.010s)
[565.743234] Starting dynamic subtest: bcs0
[565.745668] Dynamic subtest bcs0: SUCCESS (0.011s)
[565.757221] Starting dynamic subtest: vcs0
[565.759890] Dynamic subtest vcs0: SUCCESS (0.008s)
[565.771553] Starting dynamic subtest: vcs1
[565.773743] Dynamic subtest vcs1: SUCCESS (0.008s)
[565.787252] Starting dynamic subtest: vecs0
[565.789890] Dynamic subtest vecs0: SUCCESS (0.007s)
[565.801267] Starting dynamic subtest: ccs0
[565.803797] Dynamic subtest ccs0: SUCCESS (0.010s)
[565.806281] Subtest pi-userfault: SUCCESS (0.060s)
[565.972681] [135/156] (456s left) gem_mmap_gtt (big-bo-tiledy)
[566.029062] Subtest big-bo-tiledY: SKIP (0.000s)
[566.083605] [136/156] (456s left) kms_psr (psr-no-drrs)
[566.157014] Starting subtest: psr-no-drrs
[566.159369] Starting dynamic subtest: eDP-1
[567.866635] Dynamic subtest eDP-1: SUCCESS (1.677s)
[567.869362] Subtest psr-no-drrs: SUCCESS (1.678s)
[568.755902] [137/156] (453s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-pwrite)
[568.845784] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-pwrite
[577.570185] Subtest psr-1p-primscrn-pri-shrfb-draw-pwrite: SUCCESS (8.654s)
[577.679200] [138/156] (444s left) kms_frontbuffer_tracking (hdr-2p-scndscrn-cur-indfb-draw-mmap-gtt)
[577.759198] Starting subtest: hdr-2p-scndscrn-cur-indfb-draw-mmap-gtt
[577.764316] Subtest hdr-2p-scndscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[577.851054] [139/156] (444s left) kms_frontbuffer_tracking (psrhdr-1p-offscreen-pri-indfb-draw-render)
[577.926977] Starting subtest: psrhdr-1p-offscreen-pri-indfb-draw-render
[577.931839] Subtest psrhdr-1p-offscreen-pri-indfb-draw-render: SKIP (0.000s)
[578.022559] [140/156] (444s left) gem_mmap_offset (close-race)
[578.074319] Starting subtest: close-race
[598.178387] Subtest close-race: SUCCESS (20.070s)
[598.279312] [141/156] (424s left) syncobj_basic (bad-create-flags)
[598.337817] Starting subtest: bad-create-flags
[598.340264] Subtest bad-create-flags: SUCCESS (0.000s)
[598.453021] [142/156] (424s left) gem_ctx_shared (q-smoketest)
[598.515707] Starting subtest: Q-smoketest
[598.518279] Starting dynamic subtest: rcs0
[604.095962] Dynamic subtest rcs0: SUCCESS (5.511s)
[604.109151] Starting dynamic subtest: bcs0
[609.576008] Dynamic subtest bcs0: SUCCESS (5.489s)
[609.588877] Starting dynamic subtest: vcs0
[615.062619] Dynamic subtest vcs0: SUCCESS (5.495s)
[615.074715] Starting dynamic subtest: vcs1
[620.570489] Dynamic subtest vcs1: SUCCESS (5.490s)
[620.585959] Starting dynamic subtest: vecs0
[626.065157] Dynamic subtest vecs0: SUCCESS (5.484s)
[626.084170] Starting dynamic subtest: ccs0
[631.562934] Dynamic subtest ccs0: SUCCESS (5.502s)
[631.565609] Subtest Q-smoketest: SUCCESS (32.978s)
[631.694419] [143/156] (391s left) syncobj_wait (multi-wait-for-submit-submitted)
[631.748843] Starting subtest: multi-wait-for-submit-submitted
[631.857989] Subtest multi-wait-for-submit-submitted: SUCCESS (0.109s)
[631.950689] [144/156] (390s left) gem_userptr_blits (map-fixed-invalidate-busy)
[632.026367] Starting subtest: map-fixed-invalidate-busy
[632.031646] Subtest map-fixed-invalidate-busy: SKIP (0.000s)
[632.134012] [145/156] (390s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-mmap-wc)
[632.220128] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-mmap-wc
[632.225131] Subtest psr-2p-primscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[632.306436] [146/156] (390s left) kms_pm_dc (dc6-dpms)
[633.383073] Starting subtest: dc6-dpms
[635.460756] Subtest dc6-dpms: SUCCESS (2.075s)
[635.540525] [147/156] (387s left) kms_frontbuffer_tracking (psrhdr-2p-primscrn-pri-indfb-draw-mmap-gtt)
[635.632235] Starting subtest: psrhdr-2p-primscrn-pri-indfb-draw-mmap-gtt
[635.637374] Subtest psrhdr-2p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[635.732354] [148/156] (387s left) kms_color (ctm-signed)
[635.807243] Starting subtest: ctm-signed
[635.809561] Starting dynamic subtest: pipe-A-eDP-1
[637.914858] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.108s)
[637.927376] Starting dynamic subtest: pipe-B-eDP-1
[640.809930] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.894s)
[640.821996] Starting dynamic subtest: pipe-C-eDP-1
[643.532246] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.720s)
[643.544031] Starting dynamic subtest: pipe-D-eDP-1
[646.204119] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.666s)
[646.206345] Subtest ctm-signed: SUCCESS (10.392s)
[647.024120] [149/156] (375s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-primscrn-pri-shrfb-draw-render)
[647.110721] Starting subtest: fbcpsrhdr-2p-primscrn-pri-shrfb-draw-render
[647.116254] Subtest fbcpsrhdr-2p-primscrn-pri-shrfb-draw-render: SKIP (0.000s)
[647.209872] [150/156] (375s left) gem_exec_await (wide-contexts)
[647.422785] Starting subtest: wide-contexts
[670.168399] Subtest wide-contexts: SUCCESS (22.747s)
[670.366718] [151/156] (352s left) kms_ccs (crc-sprite-planes-basic-4-tiled-mtl-rc-ccs-cc)
[670.495905] Starting subtest: crc-sprite-planes-basic-4-tiled-mtl-rc-ccs-cc
[670.498898] Starting dynamic subtest: pipe-A-eDP-1
[671.033092] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.504s)
[671.046473] Starting dynamic subtest: pipe-B-eDP-1
[672.512967] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.481s)
[672.525363] Starting dynamic subtest: pipe-C-eDP-1
[673.965917] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.448s)
[673.977375] Starting dynamic subtest: pipe-D-eDP-1
[675.411350] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.448s)
[675.413862] Subtest crc-sprite-planes-basic-4-tiled-mtl-rc-ccs-cc: SUCCESS (4.887s)
[676.554712] [152/156] (346s left) kms_chamelium_color (ctm-0-25)
[676.635911] Subtest ctm-0-25: SKIP (0.000s)
[676.682779] [153/156] (346s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-scndscrn-cur-indfb-draw-mmap-wc)
[676.764576] Starting subtest: fbcpsrhdr-2p-scndscrn-cur-indfb-draw-mmap-wc
[676.769066] Subtest fbcpsrhdr-2p-scndscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[676.867801] [154/156] (346s left) kms_3d (basic)
[676.920730] Starting subtest: basic
[676.925372] Subtest basic: SKIP (0.000s)
[677.021815] [155/156] (346s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-blt)
[677.107592] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-blt
[684.476173] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-blt: SUCCESS (7.378s)
[684.601651] [156/156] (338s left) kms_psr_stress_test (invalidate-primary-flip-overlay)
[684.686891] Starting subtest: invalidate-primary-flip-overlay
[695.362677] Subtest invalidate-primary-flip-overlay: SUCCESS (10.676s)
[695.476515] Closing watchdogs
results: parsing output: 0/ for test: gem_mmap_gtt
results: parsing output: 1/ for test: syncobj_eventfd
results: parsing output: 2/ for test: kms_frontbuffer_tracking
results: parsing output: 3/ for test: kms_feature_discovery
results: parsing output: 4/ for test: gem_ctx_persistence
results: parsing output: 5/ for test: kms_psr2_sf
results: parsing output: 6/ for test: kms_frontbuffer_tracking
results: parsing output: 7/ for test: gem_ccs
results: parsing output: 8/ for test: syncobj_basic
results: parsing output: 9/ for test: kms_flip
results: parsing output: 10/ for test: kms_psr2_sf
results: parsing output: 11/ for test: gem_exercise_blt
results: parsing output: 12/ for test: prime_busy
results: parsing output: 13/ for test: gem_sync
results: parsing output: 14/ for test: sysfs_preempt_timeout
results: parsing output: 15/ for test: kms_flip_scaled_crc
results: parsing output: 16/ for test: gem_pipe_control_store_loop
results: parsing output: 17/ for test: api_intel_allocator
results: parsing output: 18/ for test: gem_exec_balancer
results: parsing output: 19/ for test: kms_pipe_stress
results: parsing output: 20/ for test: kms_ccs
results: parsing output: 21/ for test: kms_flip
results: parsing output: 22/ for test: gem_eio
results: parsing output: 23/ for test: kms_frontbuffer_tracking
results: parsing output: 24/ for test: gem_userptr_blits
results: parsing output: 25/ for test: kms_vblank
results: parsing output: 26/ for test: kms_frontbuffer_tracking
results: parsing output: 27/ for test: gem_mmap_gtt
results: parsing output: 28/ for test: kms_cursor_crc
results: parsing output: 29/ for test: kms_properties
results: parsing output: 30/ for test: kms_frontbuffer_tracking
results: parsing output: 31/ for test: i915_drm_fdinfo
results: parsing output: 32/ for test: kms_big_fb
results: parsing output: 33/ for test: kms_frontbuffer_tracking
results: parsing output: 34/ for test: perf_pmu
results: parsing output: 35/ for test: prime_mmap
results: parsing output: 36/ for test: kms_psr
results: parsing output: 37/ for test: kms_getfb
results: parsing output: 38/ for test: kms_ccs
results: parsing output: 39/ for test: gem_close
results: parsing output: 40/ for test: kms_frontbuffer_tracking
results: parsing output: 41/ for test: core_getversion
results: parsing output: 42/ for test: syncobj_timeline
results: parsing output: 43/ for test: kms_frontbuffer_tracking
results: parsing output: 44/ for test: syncobj_timeline
results: parsing output: 45/ for test: kms_big_fb
results: parsing output: 46/ for test: gem_exec_fence
results: parsing output: 47/ for test: kms_ccs
results: parsing output: 48/ for test: syncobj_timeline
results: parsing output: 49/ for test: kms_atomic
results: parsing output: 50/ for test: kms_frontbuffer_tracking
results: parsing output: 51/ for test: gem_madvise
results: parsing output: 52/ for test: kms_frontbuffer_tracking
results: parsing output: 53/ for test: kms_cursor_crc
results: parsing output: 54/ for test: kms_frontbuffer_tracking
results: parsing output: 55/ for test: perf_pmu
results: parsing output: 56/ for test: kms_joiner
results: parsing output: 57/ for test: syncobj_timeline
results: parsing output: 58/ for test: kms_frontbuffer_tracking
results: parsing output: 59/ for test: gem_exec_params
results: parsing output: 60/ for test: gem_exec_params
results: parsing output: 61/ for test: kms_frontbuffer_tracking
results: parsing output: 62/ for test: gem_pread
results: parsing output: 63/ for test: kms_big_fb
results: parsing output: 64/ for test: gem_softpin
results: parsing output: 65/ for test: kms_atomic_interruptible
results: parsing output: 66/ for test: i915_pm_rpm
results: parsing output: 67/ for test: kms_content_protection
results: parsing output: 68/ for test: kms_frontbuffer_tracking
results: parsing output: 69/ for test: kms_psr
results: parsing output: 70/ for test: kms_plane
results: parsing output: 71/ for test: kms_flip
results: parsing output: 72/ for test: gem_sync
results: parsing output: 73/ for test: kms_frontbuffer_tracking
results: parsing output: 74/ for test: kms_pm_rpm
results: parsing output: 75/ for test: gem_mmap_wc
results: parsing output: 76/ for test: kms_plane
results: parsing output: 77/ for test: kms_frontbuffer_tracking
results: parsing output: 78/ for test: kms_psr
results: parsing output: 79/ for test: kms_plane_scaling
results: parsing output: 80/ for test: kms_big_fb
results: parsing output: 81/ for test: gem_mmap
results: parsing output: 82/ for test: kms_frontbuffer_tracking
results: parsing output: 83/ for test: gem_close_race
results: parsing output: 84/ for test: gem_ctx_persistence
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_cursor_legacy
results: parsing output: 88/ for test: kms_frontbuffer_tracking
results: parsing output: 89/ for test: kms_frontbuffer_tracking
results: parsing output: 90/ for test: gem_exec_flush
results: parsing output: 91/ for test: kms_frontbuffer_tracking
results: parsing output: 92/ for test: perf
results: parsing output: 93/ for test: gem_softpin
results: parsing output: 94/ for test: gem_tiled_fence_blits
results: parsing output: 95/ for test: kms_frontbuffer_tracking
results: parsing output: 96/ for test: kms_cursor_crc
results: parsing output: 97/ for test: gem_exec_whisper
results: parsing output: 98/ for test: gem_exec_capture
results: parsing output: 99/ for test: syncobj_basic
results: parsing output: 100/ for test: kms_big_fb
results: parsing output: 101/ for test: gem_userptr_blits
results: parsing output: 102/ for test: i915_suspend
results: parsing output: 103/ for test: gem_userptr_blits
results: parsing output: 104/ for test: drm_mm
results: parsing output: 105/ for test: kms_frontbuffer_tracking
results: parsing output: 106/ for test: kms_frontbuffer_tracking
results: parsing output: 107/ for test: kms_frontbuffer_tracking
results: parsing output: 108/ for test: gem_exec_params
results: parsing output: 109/ for test: gem_partial_pwrite_pread
results: parsing output: 110/ for test: kms_cursor_legacy
results: parsing output: 111/ for test: kms_frontbuffer_tracking
results: parsing output: 112/ for test: kms_flip
results: parsing output: 113/ for test: kms_big_fb
results: parsing output: 114/ for test: kms_frontbuffer_tracking
results: parsing output: 115/ for test: kms_vblank
results: parsing output: 116/ for test: kms_lease
results: parsing output: 117/ for test: i915_drm_fdinfo
results: parsing output: 118/ for test: gem_exec_schedule
results: parsing output: 119/ for test: kms_flip_scaled_crc
results: parsing output: 120/ for test: kms_frontbuffer_tracking
results: parsing output: 121/ for test: kms_frontbuffer_tracking
results: parsing output: 122/ for test: kms_frontbuffer_tracking
results: parsing output: 123/ for test: gen9_exec_parse
results: parsing output: 124/ for test: kms_plane_scaling
results: parsing output: 125/ for test: gem_eio
results: parsing output: 126/ for test: kms_big_fb
results: parsing output: 127/ for test: kms_chamelium_hpd
results: parsing output: 128/ for test: kms_psr
results: parsing output: 129/ for test: kms_frontbuffer_tracking
results: parsing output: 130/ for test: kms_chamelium_color
results: parsing output: 131/ for test: gem_render_copy
results: parsing output: 132/ for test: kms_frontbuffer_tracking
results: parsing output: 133/ for test: gem_exec_schedule
results: parsing output: 134/ for test: gem_mmap_gtt
results: parsing output: 135/ for test: kms_psr
results: parsing output: 136/ for test: kms_frontbuffer_tracking
results: parsing output: 137/ for test: kms_frontbuffer_tracking
results: parsing output: 138/ for test: kms_frontbuffer_tracking
results: parsing output: 139/ for test: gem_mmap_offset
results: parsing output: 140/ for test: syncobj_basic
results: parsing output: 141/ for test: gem_ctx_shared
results: parsing output: 142/ for test: syncobj_wait
results: parsing output: 143/ for test: gem_userptr_blits
results: parsing output: 144/ for test: kms_frontbuffer_tracking
results: parsing output: 145/ for test: kms_pm_dc
results: parsing output: 146/ for test: kms_frontbuffer_tracking
results: parsing output: 147/ for test: kms_color
results: parsing output: 148/ for test: kms_frontbuffer_tracking
results: parsing output: 149/ for test: gem_exec_await
results: parsing output: 150/ for test: kms_ccs
results: parsing output: 151/ for test: kms_chamelium_color
results: parsing output: 152/ for test: kms_frontbuffer_tracking
results: parsing output: 153/ for test: kms_3d
results: parsing output: 154/ for test: kms_frontbuffer_tracking
results: parsing output: 155/ for test: kms_psr_stress_test
Done.