[106.843065] Initializing watchdogs
[106.843134]   /dev/watchdog0
[106.863842] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:03:00.0: 8086:56a0 Intel Dg2 (Gen12) DG2 [Arc A770]
[106.875083] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[106.879055] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[106.881519] [001/132] (960s left) i915_pm_freq_api (freq-basic-api)
[106.970298] Starting subtest: freq-basic-api
[106.971231] Starting dynamic subtest: gt0
[106.974052] Dynamic subtest gt0: SUCCESS (0.004s)
[106.974999] Subtest freq-basic-api: SUCCESS (0.004s)
[107.125262] [002/132] (960s left) gem_exec_schedule (u-semaphore-noskip)
[107.210873] Starting subtest: u-semaphore-noskip
[108.076706] Subtest u-semaphore-noskip: SUCCESS (0.865s)
[108.473044] [003/132] (959s left) kms_plane (plane-position-covered)
[108.654914] Starting subtest: plane-position-covered
[109.137340] Starting dynamic subtest: pipe-A-plane-1
[109.587442] Dynamic subtest pipe-A-plane-1: SUCCESS (0.452s)
[109.598073] Starting dynamic subtest: pipe-A-plane-2
[110.065426] Dynamic subtest pipe-A-plane-2: SUCCESS (0.477s)
[110.075671] Starting dynamic subtest: pipe-A-plane-3
[110.544491] Dynamic subtest pipe-A-plane-3: SUCCESS (0.479s)
[110.554359] Starting dynamic subtest: pipe-A-plane-4
[111.022517] Dynamic subtest pipe-A-plane-4: SUCCESS (0.478s)
[111.032457] Starting dynamic subtest: pipe-A-plane-5
[111.043916] Dynamic subtest pipe-A-plane-5: SUCCESS (0.021s)
[111.392195] Starting dynamic subtest: pipe-B-plane-1
[111.809359] Dynamic subtest pipe-B-plane-1: SUCCESS (0.429s)
[111.818372] Starting dynamic subtest: pipe-B-plane-2
[112.265196] Dynamic subtest pipe-B-plane-2: SUCCESS (0.455s)
[112.273593] Starting dynamic subtest: pipe-B-plane-3
[112.720039] Dynamic subtest pipe-B-plane-3: SUCCESS (0.455s)
[112.728516] Starting dynamic subtest: pipe-B-plane-4
[113.178253] Dynamic subtest pipe-B-plane-4: SUCCESS (0.458s)
[113.186723] Starting dynamic subtest: pipe-B-plane-5
[113.198593] Dynamic subtest pipe-B-plane-5: SUCCESS (0.020s)
[113.199436] Subtest plane-position-covered: SUCCESS (4.544s)
[113.439867] [004/132] (954s left) syncobj_basic (bad-handle-to-fd)
[113.508965] Starting subtest: bad-handle-to-fd
[113.510153] Subtest bad-handle-to-fd: SUCCESS (0.000s)
[113.625476] [005/132] (954s left) kms_addfb_basic (addfb25-bad-modifier)
[113.804943] Starting subtest: addfb25-bad-modifier
[113.805994] Subtest addfb25-bad-modifier: SUCCESS (0.000s)
[113.900947] [006/132] (953s left) api_intel_bb (simple-bb)
[113.969197] Starting subtest: simple-bb
[114.001631] Subtest simple-bb: SUCCESS (0.032s)
[114.203463] [007/132] (953s left) gem_exec_reloc (basic-cpu-noreloc)
[114.276675] Subtest basic-cpu-noreloc: SKIP (0.000s)
[114.342895] [008/132] (953s left) gem_exec_suspend (basic-s3-devices)
[114.423593] Starting subtest: basic-S3-devices
[114.424493] Starting dynamic subtest: smem
[124.384789] Dynamic subtest smem: SUCCESS (9.961s)
[124.393897] Starting dynamic subtest: lmem0
[134.111137] Dynamic subtest lmem0: SUCCESS (9.726s)
[134.112150] Subtest basic-S3-devices: SUCCESS (19.687s)
[152.452145] [009/132] (933s left) api_intel_bb (add-remove-objects)
[152.521978] Starting subtest: add-remove-objects
[152.553990] Subtest add-remove-objects: SUCCESS (0.033s)
[152.683525] [010/132] (933s left) kms_flip (2x-dpms-vs-vblank-race)
[152.859453] Starting subtest: 2x-dpms-vs-vblank-race
[152.874477] Subtest 2x-dpms-vs-vblank-race: SKIP (0.014s)
[152.986930] [011/132] (933s left) syncobj_timeline (transfer-timeline-point)
[153.065979] Starting subtest: transfer-timeline-point
[153.066946] Subtest transfer-timeline-point: SUCCESS (0.001s)
[153.229949] [012/132] (932s left) i915_drm_fdinfo (most-busy-idle-check-all)
[153.291774] Starting subtest: most-busy-idle-check-all
[153.292714] Starting dynamic subtest: rcs0
[153.321449] Dynamic subtest rcs0: SKIP (0.029s)
[153.331388] Starting dynamic subtest: bcs0
[153.333161] Dynamic subtest bcs0: SKIP (0.000s)
[153.342245] Starting dynamic subtest: vcs0
[153.344361] Dynamic subtest vcs0: SKIP (0.000s)
[153.353634] Starting dynamic subtest: vcs1
[153.355871] Dynamic subtest vcs1: SKIP (0.000s)
[153.365528] Starting dynamic subtest: vecs0
[153.367178] Dynamic subtest vecs0: SKIP (0.000s)
[153.376099] Starting dynamic subtest: vecs1
[153.377838] Dynamic subtest vecs1: SKIP (0.000s)
[153.386756] Starting dynamic subtest: ccs0
[153.388995] Dynamic subtest ccs0: SKIP (0.000s)
[153.391130] Subtest most-busy-idle-check-all: SKIP (0.033s)
[153.432714] [013/132] (932s left) gem_exec_balancer (individual)
[153.547019] Starting subtest: individual
[155.665540] Subtest individual: SUCCESS (2.119s)
[156.077264] [014/132] (930s left) kms_frontbuffer_tracking (fbcpsr-tiling-linear)
[156.263484] Starting subtest: fbcpsr-tiling-linear
[156.265226] Subtest fbcpsr-tiling-linear: SKIP (0.000s)
[156.406058] [015/132] (929s left) kms_psr (fbc-pr-sprite-plane-onoff)
[156.585238] Subtest fbc-pr-sprite-plane-onoff: SKIP (0.000s)
[156.636303] [016/132] (929s left) kms_flip (plain-flip-ts-check)
[156.814034] Starting subtest: plain-flip-ts-check
[156.817953] Starting dynamic subtest: A-DP3
[164.973506] Dynamic subtest A-DP3: SUCCESS (8.158s)
[164.986230] Starting dynamic subtest: B-DP3
[173.048418] Dynamic subtest B-DP3: SUCCESS (8.076s)
[173.059444] Starting dynamic subtest: C-DP3
[181.115931] Dynamic subtest C-DP3: SUCCESS (8.068s)
[181.127269] Starting dynamic subtest: D-DP3
[189.185954] Dynamic subtest D-DP3: SUCCESS (8.071s)
[189.187916] Subtest plain-flip-ts-check: SUCCESS (32.381s)
[189.501397] [017/132] (896s left) kms_joiner (basic-force-big-joiner)
[189.684419] Starting subtest: basic-force-big-joiner
[189.685216] Starting dynamic subtest: single
[190.457518] Dynamic subtest single: SUCCESS (0.775s)
[190.458543] Subtest basic-force-big-joiner: SUCCESS (0.776s)
[190.816681] [018/132] (895s left) kms_lease (lease-invalid-connector)
[190.991750] Starting subtest: lease-invalid-connector
[190.992594] Starting dynamic subtest: pipe-A-DP-3
[190.993457] Dynamic subtest pipe-A-DP-3: SUCCESS (0.000s)
[191.003497] Starting dynamic subtest: pipe-B-DP-3
[191.004484] Dynamic subtest pipe-B-DP-3: SUCCESS (0.000s)
[191.014533] Starting dynamic subtest: pipe-C-DP-3
[191.015771] Dynamic subtest pipe-C-DP-3: SUCCESS (0.000s)
[191.025750] Starting dynamic subtest: pipe-D-DP-3
[191.026751] Dynamic subtest pipe-D-DP-3: SUCCESS (0.000s)
[191.027755] Subtest lease-invalid-connector: SUCCESS (0.004s)
[191.081431] [019/132] (895s left) perf_pmu (busy)
[191.144586] Starting subtest: busy
[191.145473] Starting dynamic subtest: rcs0
[191.771793] Dynamic subtest rcs0: SUCCESS (0.626s)
[191.784386] Starting dynamic subtest: bcs0
[192.336335] Dynamic subtest bcs0: SUCCESS (0.563s)
[192.349269] Starting dynamic subtest: vcs0
[192.905856] Dynamic subtest vcs0: SUCCESS (0.568s)
[192.919669] Starting dynamic subtest: vcs1
[193.465171] Dynamic subtest vcs1: SUCCESS (0.558s)
[193.477263] Starting dynamic subtest: vecs0
[194.022291] Dynamic subtest vecs0: SUCCESS (0.557s)
[194.034469] Starting dynamic subtest: vecs1
[194.578213] Dynamic subtest vecs1: SUCCESS (0.556s)
[194.590610] Starting dynamic subtest: ccs0
[195.140742] Dynamic subtest ccs0: SUCCESS (0.561s)
[195.142664] Subtest busy: SUCCESS (3.997s)
[195.269204] [020/132] (891s left) gem_ctx_exec (basic)
[195.339949] Starting subtest: basic
[195.344838] Subtest basic: SUCCESS (0.006s)
[195.478431] [021/132] (891s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-0-async-flip)
[195.672839] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-0-async-flip
[195.674530] Subtest yf-tiled-max-hw-stride-64bpp-rotate-0-async-flip: SKIP (0.000s)
[195.800374] [022/132] (890s left) kms_psr (fbc-psr-sprite-blt)
[195.976503] Subtest fbc-psr-sprite-blt: SKIP (0.000s)
[196.026846] [023/132] (890s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-mmap-gtt)
[196.217580] Starting subtest: psr-2p-primscrn-spr-indfb-draw-mmap-gtt
[196.219222] Subtest psr-2p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[196.360513] [024/132] (890s left) gem_exec_reloc (basic-gtt-wc-noreloc)
[196.441439] Subtest basic-gtt-wc-noreloc: SKIP (0.000s)
[196.514309] [025/132] (890s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-mmap-cpu)
[196.696554] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-mmap-cpu
[199.187558] Subtest fbc-1p-primscrn-spr-indfb-draw-mmap-cpu: SUCCESS (2.492s)
[199.410680] [026/132] (887s left) kms_frontbuffer_tracking (fbc-1p-shrfb-fliptrack-mmap-gtt)
[199.596347] Starting subtest: fbc-1p-shrfb-fliptrack-mmap-gtt
[199.597976] Subtest fbc-1p-shrfb-fliptrack-mmap-gtt: SKIP (0.000s)
[199.715533] [027/132] (887s left) kms_frontbuffer_tracking (psr-1p-primscrn-indfb-msflip-blt)
[199.899643] Starting subtest: psr-1p-primscrn-indfb-msflip-blt
[199.901286] Subtest psr-1p-primscrn-indfb-msflip-blt: SKIP (0.000s)
[200.017599] [028/132] (887s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-mmap-wc)
[200.202702] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-mmap-wc
[200.204289] Subtest fbc-1p-primscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[200.311881] [029/132] (886s left) syncobj_timeline (invalid-transfer-bad-pad)
[200.381238] Starting subtest: invalid-transfer-bad-pad
[200.382231] Subtest invalid-transfer-bad-pad: SUCCESS (0.000s)
[200.555496] [030/132] (886s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-mmap-cpu)
[200.737444] Starting subtest: psr-2p-primscrn-cur-indfb-draw-mmap-cpu
[200.739145] Subtest psr-2p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[200.874373] [031/132] (886s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-move)
[201.058696] Starting subtest: psr-2p-scndscrn-spr-indfb-move
[201.060303] Subtest psr-2p-scndscrn-spr-indfb-move: SKIP (0.000s)
[201.188804] [032/132] (886s left) kms_feature_discovery (psr1)
[201.364413] Starting subtest: psr1
[201.366128] Subtest psr1: SKIP (0.000s)
[201.449751] [033/132] (885s left) kms_atomic (plane-primary-legacy)
[201.630309] Starting subtest: plane-primary-legacy
[201.632253] Starting dynamic subtest: pipe-A-DP-3
[202.579811] Dynamic subtest pipe-A-DP-3: SUCCESS (0.948s)
[202.580844] Subtest plane-primary-legacy: SUCCESS (0.949s)
[202.856533] [034/132] (884s left) gem_vm_create (create-ext)
[202.937013] Starting subtest: create-ext
[202.941251] Subtest create-ext: SUCCESS (0.004s)
[203.125333] [035/132] (884s left) kms_vblank (invalid)
[203.301865] Starting subtest: invalid
[203.304186] Starting dynamic subtest: pipe-A-DP-3
[203.621924] Dynamic subtest pipe-A-DP-3: SUCCESS (0.318s)
[203.623034] Subtest invalid: SUCCESS (0.320s)
[203.867506] [036/132] (883s left) kms_ccs (crc-primary-basic-y-tiled-ccs)
[204.041250] Starting subtest: crc-primary-basic-y-tiled-ccs
[204.042171] Starting dynamic subtest: pipe-A-DP-3
[204.050373] Dynamic subtest pipe-A-DP-3: SKIP (0.001s)
[204.060387] Starting dynamic subtest: pipe-B-DP-3
[204.068904] Dynamic subtest pipe-B-DP-3: SKIP (0.001s)
[204.078752] Starting dynamic subtest: pipe-C-DP-3
[204.086919] Dynamic subtest pipe-C-DP-3: SKIP (0.001s)
[204.096701] Starting dynamic subtest: pipe-D-DP-3
[204.106076] Dynamic subtest pipe-D-DP-3: SKIP (0.001s)
[204.108128] Subtest crc-primary-basic-y-tiled-ccs: SKIP (0.007s)
[204.475083] [037/132] (883s left) kms_big_fb (4-tiled-addfb-size-overflow)
[204.664906] Starting subtest: 4-tiled-addfb-size-overflow
[204.666952] Subtest 4-tiled-addfb-size-overflow: SUCCESS (0.002s)
[204.808522] [038/132] (883s left) dmabuf_sync_file (import-multiple-read-only)
[204.910433] Starting subtest: import-multiple-read-only
[204.913856] Subtest import-multiple-read-only: SUCCESS (0.004s)
[205.057575] [FACT dmabuf_sync_file (import-multiple-read-only)] new: kernel.kmod_is_loaded.vgem: true
[205.059578] [039/132] (882s left) kms_cursor_edge_walk (64x64-right-edge)
[205.247038] Starting subtest: 64x64-right-edge
[205.247949] Starting dynamic subtest: pipe-A-DP-3
[208.707146] Dynamic subtest pipe-A-DP-3: SUCCESS (3.459s)
[208.720122] Starting dynamic subtest: pipe-D-DP-3
[212.019992] Dynamic subtest pipe-D-DP-3: SUCCESS (3.311s)
[212.020926] Subtest 64x64-right-edge: SUCCESS (6.774s)
[212.301574] [040/132] (875s left) gem_exec_reloc (basic-write-read)
[212.390145] Subtest basic-write-read: SKIP (0.000s)
[212.480068] [041/132] (875s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-move)
[212.671528] Starting subtest: fbc-1p-primscrn-spr-indfb-move
[216.149883] Subtest fbc-1p-primscrn-spr-indfb-move: SUCCESS (3.479s)
[216.334803] [042/132] (871s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-0)
[216.531183] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-0
[217.799956] Subtest x-tiled-max-hw-stride-32bpp-rotate-0: SUCCESS (1.268s)
[217.953407] [043/132] (870s left) kms_flip (2x-flip-vs-dpms-on-nop)
[218.142997] Starting subtest: 2x-flip-vs-dpms-on-nop
[218.157948] Subtest 2x-flip-vs-dpms-on-nop: SKIP (0.014s)
[218.338603] [044/132] (869s left) gem_exec_params (secure-non-master)
[218.428122] Starting subtest: secure-non-master
[218.430072] Subtest secure-non-master: SKIP (0.000s)
[218.554343] [045/132] (869s left) kms_color (ctm-max)
[218.736362] Starting subtest: ctm-max
[218.737282] Starting dynamic subtest: pipe-A-DP-3
[219.431618] Dynamic subtest pipe-A-DP-3: SUCCESS (0.694s)
[219.453704] Starting dynamic subtest: pipe-B-DP-3
[220.050443] Dynamic subtest pipe-B-DP-3: SUCCESS (0.618s)
[220.065456] Starting dynamic subtest: pipe-C-DP-3
[220.663157] Dynamic subtest pipe-C-DP-3: SUCCESS (0.612s)
[220.675251] Starting dynamic subtest: pipe-D-DP-3
[221.242558] Dynamic subtest pipe-D-DP-3: SUCCESS (0.579s)
[221.243590] Subtest ctm-max: SUCCESS (2.506s)
[221.530190] [046/132] (866s left) kms_cursor_crc (cursor-random-64x21)
[221.879405] Starting subtest: cursor-random-64x21
[221.884126] Starting dynamic subtest: pipe-A-DP-3
[226.453726] Dynamic subtest pipe-A-DP-3: SUCCESS (4.568s)
[226.506553] Starting dynamic subtest: pipe-D-DP-3
[231.004070] Dynamic subtest pipe-D-DP-3: SUCCESS (4.507s)
[231.004994] Subtest cursor-random-64x21: SUCCESS (9.126s)
[231.455517] [047/132] (857s left) kms_pm_rpm (pm-caching)
[233.071545] Starting subtest: pm-caching
[233.075236] Subtest pm-caching: SKIP (0.000s)
[233.464784] [048/132] (855s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-indfb-draw-pwrite)
[233.662862] Starting subtest: psr-1p-offscreen-pri-indfb-draw-pwrite
[233.664522] Subtest psr-1p-offscreen-pri-indfb-draw-pwrite: SKIP (0.000s)
[233.869072] [049/132] (854s left) syncobj_timeline (etime-single-wait-for-submit-unsubmitted)
[233.956484] Starting subtest: etime-single-wait-for-submit-unsubmitted
[234.063659] Subtest etime-single-wait-for-submit-unsubmitted: SUCCESS (0.106s)
[234.173236] [050/132] (854s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-mmap-wc)
[234.362922] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-mmap-wc
[234.364541] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[234.571076] [051/132] (854s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-wc)
[234.763863] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-wc
[234.765509] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[234.967335] [052/132] (853s left) gem_softpin (noreloc-interruptible)
[235.053539] Starting subtest: noreloc-interruptible
[240.448509] Subtest noreloc-interruptible: SUCCESS (5.394s)
[240.590935] [053/132] (848s left) syncobj_wait (invalid-reset-zero-handles)
[240.674174] Starting subtest: invalid-reset-zero-handles
[240.675123] Subtest invalid-reset-zero-handles: SUCCESS (0.000s)
[240.841408] [054/132] (848s left) kms_cursor_legacy (flip-vs-cursor-atomic-transitions-varying-size)
[241.030114] Starting subtest: flip-vs-cursor-atomic-transitions-varying-size
[254.471758] Subtest flip-vs-cursor-atomic-transitions-varying-size: SUCCESS (13.443s)
[254.719951] [055/132] (834s left) kms_content_protection (atomic)
[254.972383] Starting subtest: atomic
[254.996164] Starting dynamic subtest: pipe-A-DP-3
[378.024953] Dynamic subtest pipe-A-DP-3: FAIL (122.884s)
[378.025877] Subtest atomic: FAIL (123.001s)
[378.210951] [056/132] (710s left) prime_self_import (basic-with_fd_dup)
[378.258555] Starting subtest: basic-with_fd_dup
[378.307308] Subtest basic-with_fd_dup: SUCCESS (0.049s)
[378.425067] [057/132] (710s left) kms_big_fb (y-tiled-32bpp-rotate-270)
[378.626049] Starting subtest: y-tiled-32bpp-rotate-270
[378.627784] Subtest y-tiled-32bpp-rotate-270: SKIP (0.000s)
[378.796966] [058/132] (710s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-render)
[378.996948] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-render
[378.998617] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-render: SKIP (0.000s)
[379.125322] [059/132] (710s left) i915_query (query-topology-unsupported)
[379.205405] Starting subtest: query-topology-unsupported
[379.207268] Subtest query-topology-unsupported: SKIP (0.000s)
[379.373326] [060/132] (710s left) kms_plane_multiple (2x-tiling-4)
[379.563157] Starting subtest: 2x-tiling-4
[379.564945] Subtest 2x-tiling-4: SKIP (0.000s)
[379.663167] [061/132] (709s left) kms_ccs (bad-aux-stride-y-tiled-gen12-mc-ccs)
[379.851836] Starting subtest: bad-aux-stride-y-tiled-gen12-mc-ccs
[379.853993] Starting dynamic subtest: pipe-A-DP-3
[379.862344] Dynamic subtest pipe-A-DP-3: SKIP (0.000s)
[379.872962] Starting dynamic subtest: pipe-B-DP-3
[379.881262] Dynamic subtest pipe-B-DP-3: SKIP (0.000s)
[379.891659] Starting dynamic subtest: pipe-C-DP-3
[379.900028] Dynamic subtest pipe-C-DP-3: SKIP (0.000s)
[379.910533] Starting dynamic subtest: pipe-D-DP-3
[379.920238] Dynamic subtest pipe-D-DP-3: SKIP (0.000s)
[379.922181] Subtest bad-aux-stride-y-tiled-gen12-mc-ccs: SKIP (0.006s)
[380.323233] [062/132] (709s left) gem_spin_batch (legacy)
[380.410491] Starting subtest: legacy
[380.412712] Starting dynamic subtest: default
[383.672144] Dynamic subtest default: SUCCESS (3.259s)
[383.686796] Starting dynamic subtest: render
[386.907898] Dynamic subtest render: SUCCESS (3.233s)
[386.922765] Starting dynamic subtest: bsd
[390.149370] Dynamic subtest bsd: SUCCESS (3.234s)
[390.160323] Starting dynamic subtest: bsd1
[393.382074] Dynamic subtest bsd1: SUCCESS (3.231s)
[393.401414] Starting dynamic subtest: bsd2
[396.624038] Dynamic subtest bsd2: SUCCESS (3.237s)
[396.643198] Starting dynamic subtest: blt
[399.867048] Dynamic subtest blt: SUCCESS (3.238s)
[399.885880] Starting dynamic subtest: vebox
[403.106410] Dynamic subtest vebox: SUCCESS (3.236s)
[403.107369] Subtest legacy: SUCCESS (22.696s)
[403.391062] [063/132] (686s left) kms_cursor_legacy (basic-flip-before-cursor-legacy)
[403.588154] Starting subtest: basic-flip-before-cursor-legacy
[404.615576] Subtest basic-flip-before-cursor-legacy: SUCCESS (1.028s)
[404.866159] [064/132] (684s left) gem_ctx_persistence (file)
[404.955809] Starting subtest: file
[405.085858] Subtest file: SUCCESS (0.130s)
[405.286351] [065/132] (684s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-pwrite)
[405.477853] Starting subtest: fbcpsr-rgb565-draw-pwrite
[405.479479] Subtest fbcpsr-rgb565-draw-pwrite: SKIP (0.000s)
[405.599819] [066/132] (684s left) prime_mmap (test_map_unmap)
[405.679975] Starting subtest: test_map_unmap
[405.680966] Starting dynamic subtest: test_map_unmap-smem
[405.728923] Dynamic subtest test_map_unmap-smem: SUCCESS (0.049s)
[405.740966] Starting dynamic subtest: test_map_unmap-lmem0
[405.928255] Dynamic subtest test_map_unmap-lmem0: SUCCESS (0.198s)
[405.929254] Subtest test_map_unmap: SUCCESS (0.249s)
[406.032500] [067/132] (683s left) kms_chamelium_audio (hdmi-audio-edid)
[406.293868] Subtest hdmi-audio-edid: SKIP (0.000s)
[406.444827] [068/132] (683s left) kms_frontbuffer_tracking (psr-2p-scndscrn-indfb-plflip-blt)
[406.639269] Starting subtest: psr-2p-scndscrn-indfb-plflip-blt
[406.640955] Subtest psr-2p-scndscrn-indfb-plflip-blt: SKIP (0.000s)
[406.780158] [069/132] (683s left) kms_psr (psr-cursor-plane-move)
[406.976464] Subtest psr-cursor-plane-move: SKIP (0.000s)
[407.032267] [070/132] (683s left) gem_render_copy (y-tiled-to-vebox-yf-tiled)
[407.118465] Starting subtest: y-tiled-to-vebox-yf-tiled
[407.120576] Subtest y-tiled-to-vebox-yf-tiled: SKIP (0.000s)
[407.361419] [071/132] (682s left) kms_psr2_sf (fbc-pr-cursor-plane-update-sf)
[407.546732] Subtest fbc-pr-cursor-plane-update-sf: SKIP (0.000s)
[407.614040] [072/132] (682s left) kms_psr2_sf (psr2-cursor-plane-move-continuous-sf)
[407.805227] Subtest psr2-cursor-plane-move-continuous-sf: SKIP (0.000s)
[407.864489] [073/132] (682s left) kms_chamelium_color (gamma)
[408.053638] Subtest gamma: SKIP (0.000s)
[408.114749] [074/132] (682s left) prime_vgem (wait)
[408.209340] Starting subtest: wait
[408.210246] Starting dynamic subtest: rcs0
[408.294137] Dynamic subtest rcs0: SUCCESS (0.084s)
[408.306786] Starting dynamic subtest: bcs0
[408.355623] Dynamic subtest bcs0: SUCCESS (0.060s)
[408.366656] Starting dynamic subtest: vcs0
[408.394595] Dynamic subtest vcs0: SUCCESS (0.038s)
[408.412111] Starting dynamic subtest: vcs1
[408.436290] Dynamic subtest vcs1: SUCCESS (0.040s)
[408.457906] Starting dynamic subtest: vecs0
[408.478288] Dynamic subtest vecs0: SUCCESS (0.040s)
[408.500550] Starting dynamic subtest: vecs1
[408.519269] Dynamic subtest vecs1: SUCCESS (0.039s)
[408.537956] Starting dynamic subtest: ccs0
[408.560308] Dynamic subtest ccs0: SUCCESS (0.040s)
[408.561312] Subtest wait: SUCCESS (0.352s)
[408.736829] [075/132] (681s left) gem_exec_fence (syncobj-timeline-chain-engines)
[409.352850] Starting subtest: syncobj-timeline-chain-engines
[409.511975] Subtest syncobj-timeline-chain-engines: SUCCESS (0.160s)
[409.809773] [076/132] (680s left) kms_rmfb (rmfb-ioctl)
[409.997310] Starting subtest: rmfb-ioctl
[409.998210] Starting dynamic subtest: pipe-A-DP-3
[410.135535] Dynamic subtest pipe-A-DP-3: SUCCESS (0.138s)
[410.158049] Starting dynamic subtest: pipe-B-DP-3
[410.415469] Dynamic subtest pipe-B-DP-3: SUCCESS (0.277s)
[410.428390] Starting dynamic subtest: pipe-C-DP-3
[410.679622] Dynamic subtest pipe-C-DP-3: SUCCESS (0.262s)
[410.692048] Starting dynamic subtest: pipe-D-DP-3
[410.943479] Dynamic subtest pipe-D-DP-3: SUCCESS (0.262s)
[410.944414] Subtest rmfb-ioctl: SUCCESS (0.948s)
[411.247595] [077/132] (679s left) gem_ctx_exec (basic-nohangcheck)
[411.331373] Starting subtest: basic-nohangcheck
[411.658799] Subtest basic-nohangcheck: SUCCESS (0.327s)
[411.887421] [078/132] (678s left) perf_pmu (pmu-read)
[411.960406] Starting subtest: pmu-read
[411.964955] Subtest pmu-read: SUCCESS (0.004s)
[412.157638] [079/132] (678s left) gem_exec_whisper (basic-queues-priority)
[412.248792] Starting subtest: basic-queues-priority
[434.674998] Subtest basic-queues-priority: SUCCESS (22.426s)
[434.883825] [080/132] (655s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-mmap-cpu)
[435.079055] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-mmap-cpu
[435.080782] Subtest fbc-2p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[435.217115] [081/132] (655s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-180)
[435.415557] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-180
[435.417430] Subtest y-tiled-max-hw-stride-64bpp-rotate-180: SKIP (0.000s)
[435.546729] [082/132] (655s left) sysfs_timeslice_duration (duration)
[435.631584] Starting subtest: duration
[435.632500] Starting dynamic subtest: vecs0
[448.787586] Dynamic subtest vecs0: SUCCESS (13.152s)
[448.801259] Starting dynamic subtest: ccs0
[461.937078] Dynamic subtest ccs0: SUCCESS (13.144s)
[461.952190] Starting dynamic subtest: vcs0
[475.084031] Dynamic subtest vcs0: SUCCESS (13.139s)
[475.099135] Starting dynamic subtest: bcs0
[488.227950] Dynamic subtest bcs0: SUCCESS (13.136s)
[488.243066] Starting dynamic subtest: vecs1
[501.373535] Dynamic subtest vecs1: SUCCESS (13.139s)
[501.387227] Starting dynamic subtest: rcs0
[514.522120] Dynamic subtest rcs0: SUCCESS (13.144s)
[514.537182] Starting dynamic subtest: vcs1
[527.676952] Dynamic subtest vcs1: SUCCESS (13.148s)
[527.681434] Subtest duration: SUCCESS (92.028s)
[527.788861] [083/132] (563s left) gem_mmap_gtt (basic-copy)
[527.868177] Subtest basic-copy: SKIP (0.000s)
[527.953518] [084/132] (563s left) gem_exec_flush (basic-uc-rw-default)
[528.039443] Subtest basic-uc-rw-default: SKIP (0.000s)
[528.159401] [085/132] (562s left) kms_plane_alpha_blend (alpha-basic)
[528.346742] Starting subtest: alpha-basic
[528.592629] Starting dynamic subtest: pipe-A-DP-3
[531.129371] Dynamic subtest pipe-A-DP-3: SUCCESS (2.535s)
[531.178035] Starting dynamic subtest: pipe-D-DP-3
[533.893985] Dynamic subtest pipe-D-DP-3: SUCCESS (2.726s)
[533.894935] Subtest alpha-basic: SUCCESS (5.547s)
[534.142871] [086/132] (557s left) kms_ccs (missing-ccs-buffer-4-tiled-mtl-mc-ccs)
[534.334431] Starting subtest: missing-ccs-buffer-4-tiled-mtl-mc-ccs
[534.335304] Starting dynamic subtest: pipe-A-DP-3
[534.343945] Dynamic subtest pipe-A-DP-3: SKIP (0.000s)
[534.355201] Starting dynamic subtest: pipe-B-DP-3
[534.363524] Dynamic subtest pipe-B-DP-3: SKIP (0.000s)
[534.374558] Starting dynamic subtest: pipe-C-DP-3
[534.382824] Dynamic subtest pipe-C-DP-3: SKIP (0.000s)
[534.394199] Starting dynamic subtest: pipe-D-DP-3
[534.405550] Dynamic subtest pipe-D-DP-3: SKIP (0.000s)
[534.407347] Subtest missing-ccs-buffer-4-tiled-mtl-mc-ccs: SKIP (0.007s)
[534.790708] [087/132] (556s left) syncobj_timeline (reset-signaled)
[534.873646] Starting subtest: reset-signaled
[534.874568] Subtest reset-signaled: SUCCESS (0.000s)
[535.056174] [088/132] (556s left) syncobj_eventfd (invalid-bad-flags)
[535.140513] Starting subtest: invalid-bad-flags
[535.141461] Subtest invalid-bad-flags: SUCCESS (0.000s)
[535.321977] [089/132] (556s left) gem_exec_balancer (parallel-dmabuf-import-out-fence)
[535.701033] Starting subtest: parallel-dmabuf-import-out-fence
[538.048052] Subtest parallel-dmabuf-import-out-fence: SUCCESS (2.347s)
[538.191593] [090/132] (553s left) kms_properties (invalid-properties-legacy)
[538.378419] Starting subtest: invalid-properties-legacy
[538.535744] Subtest invalid-properties-legacy: SUCCESS (0.158s)
[538.672610] [091/132] (552s left) gem_partial_pwrite_pread (reads-snoop)
[538.762479] Subtest reads-snoop: SKIP (0.000s)
[538.862805] [092/132] (552s left) syncobj_wait (single-wait-all-for-submit-signaled)
[538.941501] Starting subtest: single-wait-all-for-submit-signaled
[538.942406] Subtest single-wait-all-for-submit-signaled: SUCCESS (0.000s)
[539.093390] [093/132] (552s left) kms_pipe_b_c_ivb (enable-pipe-c-while-b-has-3-lanes)
[539.175235] Subtest enable-pipe-C-while-B-has-3-lanes: SKIP (0.000s)
[539.247735] [094/132] (552s left) kms_ccs (crc-primary-suspend-y-tiled-gen12-mc-ccs)
[539.432348] Starting subtest: crc-primary-suspend-y-tiled-gen12-mc-ccs
[539.433242] Starting dynamic subtest: pipe-A-DP-3
[539.436592] Dynamic subtest pipe-A-DP-3: SKIP (0.000s)
[539.448034] Starting dynamic subtest: pipe-B-DP-3
[539.451255] Dynamic subtest pipe-B-DP-3: SKIP (0.000s)
[539.462417] Starting dynamic subtest: pipe-C-DP-3
[539.465734] Dynamic subtest pipe-C-DP-3: SKIP (0.000s)
[539.476918] Starting dynamic subtest: pipe-D-DP-3
[539.480286] Dynamic subtest pipe-D-DP-3: SKIP (0.000s)
[539.481962] Subtest crc-primary-suspend-y-tiled-gen12-mc-ccs: SKIP (0.008s)
[539.895396] [095/132] (551s left) gem_exec_reloc (basic-cpu-gtt-active)
[539.983211] Subtest basic-cpu-gtt-active: SKIP (0.000s)
[540.086919] [096/132] (551s left) kms_pm_rpm (dpms-mode-unset-lpsp)
[542.009285] Starting subtest: dpms-mode-unset-lpsp
[542.333576] Subtest dpms-mode-unset-lpsp: SKIP (0.323s)
[542.781368] [097/132] (549s left) kms_async_flips (basic-modeset-with-all-modifiers-formats)
[542.969283] Starting subtest: basic-modeset-with-all-modifiers-formats
[543.196611] Starting dynamic subtest: pipe-A-DP-3-4-RGB565
[543.451989] Dynamic subtest pipe-A-DP-3-4-RGB565: SUCCESS (0.255s)
[543.470533] Starting dynamic subtest: pipe-A-DP-3-4-XRGB8888
[543.485366] Dynamic subtest pipe-A-DP-3-4-XRGB8888: SUCCESS (0.032s)
[543.504800] Starting dynamic subtest: pipe-A-DP-3-4-XRGB2101010
[543.518685] Dynamic subtest pipe-A-DP-3-4-XRGB2101010: SUCCESS (0.032s)
[543.537620] Starting dynamic subtest: pipe-A-DP-3-4-XRGB16161616F
[543.552113] Dynamic subtest pipe-A-DP-3-4-XRGB16161616F: SUCCESS (0.032s)
[543.568985] Starting dynamic subtest: pipe-A-DP-3-4-YUYV
[543.585357] Dynamic subtest pipe-A-DP-3-4-YUYV: SUCCESS (0.032s)
[543.602343] Starting dynamic subtest: pipe-A-DP-3-4-Y210
[543.618652] Dynamic subtest pipe-A-DP-3-4-Y210: SUCCESS (0.032s)
[543.635541] Starting dynamic subtest: pipe-A-DP-3-4-XYUV8888
[543.652039] Dynamic subtest pipe-A-DP-3-4-XYUV8888: SUCCESS (0.032s)
[543.666890] Starting dynamic subtest: pipe-A-DP-3-4-XV30
[543.685391] Dynamic subtest pipe-A-DP-3-4-XV30: SUCCESS (0.032s)
[543.701574] Starting dynamic subtest: pipe-A-DP-3-4-XV36
[543.718809] Dynamic subtest pipe-A-DP-3-4-XV36: SUCCESS (0.032s)
[543.737457] Starting dynamic subtest: pipe-A-DP-3-x-RGB565
[543.902014] Dynamic subtest pipe-A-DP-3-x-RGB565: SUCCESS (0.182s)
[543.915406] Starting dynamic subtest: pipe-A-DP-3-x-XRGB8888
[543.935421] Dynamic subtest pipe-A-DP-3-x-XRGB8888: SUCCESS (0.032s)
[543.950919] Starting dynamic subtest: pipe-A-DP-3-x-XRGB2101010
[543.968812] Dynamic subtest pipe-A-DP-3-x-XRGB2101010: SUCCESS (0.032s)
[543.985660] Starting dynamic subtest: pipe-A-DP-3-x-XRGB16161616F
[544.002188] Dynamic subtest pipe-A-DP-3-x-XRGB16161616F: SUCCESS (0.032s)
[544.019015] Starting dynamic subtest: pipe-A-DP-3-x-YUYV
[544.035383] Dynamic subtest pipe-A-DP-3-x-YUYV: SUCCESS (0.032s)
[544.052384] Starting dynamic subtest: pipe-A-DP-3-x-Y210
[544.068766] Dynamic subtest pipe-A-DP-3-x-Y210: SUCCESS (0.032s)
[544.082221] Starting dynamic subtest: pipe-A-DP-3-x-XYUV8888
[544.102045] Dynamic subtest pipe-A-DP-3-x-XYUV8888: SUCCESS (0.032s)
[544.115528] Starting dynamic subtest: pipe-A-DP-3-x-XV30
[544.135379] Dynamic subtest pipe-A-DP-3-x-XV30: SUCCESS (0.032s)
[544.148629] Starting dynamic subtest: pipe-A-DP-3-x-XV36
[544.168625] Dynamic subtest pipe-A-DP-3-x-XV36: SUCCESS (0.032s)
[544.182217] Starting dynamic subtest: pipe-A-DP-3-linear-RGB565
[544.336631] Dynamic subtest pipe-A-DP-3-linear-RGB565: SUCCESS (0.167s)
[544.350076] Starting dynamic subtest: pipe-A-DP-3-linear-XRGB8888
[544.370696] Dynamic subtest pipe-A-DP-3-linear-XRGB8888: SUCCESS (0.033s)
[544.385330] Starting dynamic subtest: pipe-A-DP-3-linear-XRGB2101010
[544.404066] Dynamic subtest pipe-A-DP-3-linear-XRGB2101010: SUCCESS (0.032s)
[544.419899] Starting dynamic subtest: pipe-A-DP-3-linear-XRGB16161616F
[544.437496] Dynamic subtest pipe-A-DP-3-linear-XRGB16161616F: SUCCESS (0.032s)
[544.453473] Starting dynamic subtest: pipe-A-DP-3-linear-YUYV
[544.470853] Dynamic subtest pipe-A-DP-3-linear-YUYV: SUCCESS (0.032s)
[544.486780] Starting dynamic subtest: pipe-A-DP-3-linear-Y210
[544.504185] Dynamic subtest pipe-A-DP-3-linear-Y210: SUCCESS (0.032s)
[544.520088] Starting dynamic subtest: pipe-A-DP-3-linear-XYUV8888
[544.537468] Dynamic subtest pipe-A-DP-3-linear-XYUV8888: SUCCESS (0.032s)
[544.553326] Starting dynamic subtest: pipe-A-DP-3-linear-XV30
[544.570795] Dynamic subtest pipe-A-DP-3-linear-XV30: SUCCESS (0.032s)
[544.586611] Starting dynamic subtest: pipe-A-DP-3-linear-XV36
[544.604238] Dynamic subtest pipe-A-DP-3-linear-XV36: SUCCESS (0.032s)
[544.883016] Subtest basic-modeset-with-all-modifiers-formats: SUCCESS (1.914s)
[545.151951] [098/132] (546s left) gem_exec_async (forked-writes)
[545.245719] Starting subtest: forked-writes
[545.246585] Starting dynamic subtest: rcs0
[545.310930] Dynamic subtest rcs0: SUCCESS (0.064s)
[545.325427] Starting dynamic subtest: bcs0
[545.347608] Dynamic subtest bcs0: SUCCESS (0.036s)
[545.362344] Starting dynamic subtest: vcs0
[545.384958] Dynamic subtest vcs0: SUCCESS (0.036s)
[545.398289] Starting dynamic subtest: vcs1
[545.420264] Dynamic subtest vcs1: SUCCESS (0.034s)
[545.432115] Starting dynamic subtest: vecs0
[545.454962] Dynamic subtest vecs0: SUCCESS (0.034s)
[545.469087] Starting dynamic subtest: vecs1
[545.489268] Dynamic subtest vecs1: SUCCESS (0.033s)
[545.503421] Starting dynamic subtest: ccs0
[545.523624] Dynamic subtest ccs0: SUCCESS (0.033s)
[545.524581] Subtest forked-writes: SUCCESS (0.279s)
[545.879112] [099/132] (546s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling)
[546.064887] Starting subtest: flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling
[546.066619] Subtest flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling: SKIP (0.000s)
[546.157966] [100/132] (546s left) kms_psr (psr-primary-render)
[546.354231] Subtest psr-primary-render: SKIP (0.000s)
[546.417955] [101/132] (545s left) gem_create (busy-create)
[546.503953] Starting subtest: busy-create
[546.504904] Starting dynamic subtest: lmem0
[578.812315] Dynamic subtest lmem0: SUCCESS (32.304s)
[578.826270] Starting dynamic subtest: smem0
[611.071266] Dynamic subtest smem0: SUCCESS (32.255s)
[611.072232] Subtest busy-create: SUCCESS (64.561s)
[611.331793] [102/132] (481s left) gem_exec_schedule (lateslice)
[611.421941] Starting subtest: lateslice
[611.422870] Starting dynamic subtest: rcs0
[611.470444] Dynamic subtest rcs0: SUCCESS (0.048s)
[611.484450] Starting dynamic subtest: bcs0
[611.492465] Dynamic subtest bcs0: SUCCESS (0.021s)
[611.506117] Starting dynamic subtest: vcs0
[611.516219] Dynamic subtest vcs0: SUCCESS (0.023s)
[611.529553] Starting dynamic subtest: vcs1
[611.538135] Dynamic subtest vcs1: SUCCESS (0.021s)
[611.551447] Starting dynamic subtest: vecs0
[611.558586] Dynamic subtest vecs0: SUCCESS (0.019s)
[611.572530] Starting dynamic subtest: vecs1
[611.582434] Dynamic subtest vecs1: SUCCESS (0.023s)
[611.595971] Starting dynamic subtest: ccs0
[611.603898] Dynamic subtest ccs0: SUCCESS (0.020s)
[611.604877] Subtest lateslice: SUCCESS (0.183s)
[612.013940] [103/132] (480s left) fbdev (unaligned-read)
[612.081619] Starting subtest: unaligned-read
[612.093499] Subtest unaligned-read: SUCCESS (0.012s)
[612.192407] [104/132] (480s left) gem_exec_fence (syncobj-unused-fence)
[612.770400] Starting subtest: syncobj-unused-fence
[612.801302] Subtest syncobj-unused-fence: SUCCESS (0.031s)
[613.167780] [105/132] (479s left) gem_userptr_blits (dmabuf-sync)
[613.259428] Starting subtest: dmabuf-sync
[613.277432] Subtest dmabuf-sync: SKIP (0.018s)
[613.483949] [106/132] (479s left) gem_mmap_offset (perf)
[613.564529] Starting subtest: perf
[613.565471] Starting dynamic subtest: lmem0
[613.833405] Dynamic subtest lmem0: SUCCESS (0.267s)
[613.845773] Starting dynamic subtest: smem0
[613.850308] Dynamic subtest smem0: SUCCESS (0.003s)
[613.851378] Subtest perf: SUCCESS (0.273s)
[613.989420] [107/132] (478s left) gem_exec_reloc (basic-wc-gtt-active)
[614.075294] Subtest basic-wc-gtt-active: SKIP (0.000s)
[614.160976] [108/132] (478s left) kms_plane (pixel-format-4-tiled-dg2-rc-ccs-modifier-source-clamping)
[614.345575] Starting subtest: pixel-format-4-tiled-dg2-rc-ccs-modifier-source-clamping
[614.347246] Subtest pixel-format-4-tiled-dg2-rc-ccs-modifier-source-clamping: SKIP (0.000s)
[614.465091] [109/132] (478s left) kms_psr (fbc-pr-primary-mmap-cpu)
[614.651304] Subtest fbc-pr-primary-mmap-cpu: SKIP (0.000s)
[614.711129] [110/132] (478s left) i915_selftest (mock)
[615.766353] Starting subtest: mock
[615.767344] Starting dynamic subtest: sanitycheck
[616.585248] Dynamic subtest sanitycheck: SUCCESS (0.818s)
[616.616891] Starting dynamic subtest: shmem
[617.432636] Dynamic subtest shmem: SUCCESS (0.845s)
[617.470432] Starting dynamic subtest: fence
[624.975179] Dynamic subtest fence: SUCCESS (7.538s)
[624.988359] Starting dynamic subtest: scatterlist
[626.819337] Dynamic subtest scatterlist: SUCCESS (1.842s)
[626.831746] Starting dynamic subtest: syncmap
[629.666130] Dynamic subtest syncmap: SUCCESS (2.842s)
[629.682528] Starting dynamic subtest: uncore
[630.494349] Dynamic subtest uncore: SUCCESS (0.824s)
[630.530382] Starting dynamic subtest: ring
[631.363515] Dynamic subtest ring: SUCCESS (0.865s)
[631.398172] Starting dynamic subtest: engine
[632.221587] Dynamic subtest engine: SUCCESS (0.854s)
[632.245308] Starting dynamic subtest: timelines
[636.849947] Dynamic subtest timelines: SUCCESS (4.626s)
[636.859404] Starting dynamic subtest: requests
[640.101997] Dynamic subtest requests: SUCCESS (3.251s)
[640.111537] Starting dynamic subtest: objects
[641.066943] Dynamic subtest objects: SUCCESS (0.964s)
[641.077585] Starting dynamic subtest: phys
[642.056936] Dynamic subtest phys: SUCCESS (0.989s)
[642.068874] Starting dynamic subtest: dmabuf
[643.015883] Dynamic subtest dmabuf: SUCCESS (0.957s)
[643.026173] Starting dynamic subtest: vma
[651.258021] Dynamic subtest vma: SUCCESS (8.240s)
[651.267960] Starting dynamic subtest: evict
[653.106017] Dynamic subtest evict: SUCCESS (1.847s)
[653.116069] Starting dynamic subtest: gtt
[657.067901] Dynamic subtest gtt: SUCCESS (3.960s)
[657.079286] Starting dynamic subtest: hugepages
[658.243874] Dynamic subtest hugepages: SUCCESS (1.175s)
[658.253798] Starting dynamic subtest: memory_region
[661.640882] Dynamic subtest memory_region: SUCCESS (3.396s)
[661.641833] Subtest mock: SUCCESS (45.872s)
[661.679510] [FACT i915_selftest (mock)] deleted: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[661.680714] [FACT i915_selftest (mock)] deleted: kernel.kmod_is_loaded.i915: true
[661.683051] [111/132] (431s left) i915_pm_rps (reset)
[663.353870] Starting subtest: reset
[668.220558] Subtest reset: SUCCESS (4.869s)
[668.316211] [FACT i915_pm_rps (reset)] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[668.318779] [FACT i915_pm_rps (reset)] new: kernel.kmod_is_loaded.i915: true
[668.321586] [112/132] (424s left) kms_big_fb (x-tiled-8bpp-rotate-90)
[668.522261] Starting subtest: x-tiled-8bpp-rotate-90
[668.604374] Subtest x-tiled-8bpp-rotate-90: SKIP (0.081s)
[668.823875] [113/132] (424s left) kms_cursor_crc (cursor-alpha-transparent)
[669.012331] Starting subtest: cursor-alpha-transparent
[669.013223] Starting dynamic subtest: pipe-A-DP-3
[669.637876] Dynamic subtest pipe-A-DP-3: SUCCESS (0.623s)
[669.663223] Starting dynamic subtest: pipe-D-DP-3
[670.165111] Dynamic subtest pipe-D-DP-3: SUCCESS (0.523s)
[670.165987] Subtest cursor-alpha-transparent: SUCCESS (1.153s)
[670.757790] [114/132] (422s left) gen7_exec_parse (bitmasks)
[670.845458] Subtest bitmasks: SKIP (0.000s)
[670.940470] [115/132] (422s left) gem_mmap_gtt (cpuset-medium-copy)
[671.024242] Subtest cpuset-medium-copy: SKIP (0.000s)
[671.106174] [116/132] (422s left) kms_chamelium_hpd (hdmi-hpd-fast)
[671.378400] Subtest hdmi-hpd-fast: SKIP (0.000s)
[671.534794] [117/132] (421s left) gem_exec_schedule (wide)
[671.748564] Starting subtest: wide
[671.749643] Starting dynamic subtest: rcs0
[684.504898] Dynamic subtest rcs0: SUCCESS (12.756s)
[684.519060] Starting dynamic subtest: bcs0
[699.031747] Dynamic subtest bcs0: SUCCESS (14.525s)
[699.048772] Starting dynamic subtest: vcs0
[712.767358] Dynamic subtest vcs0: SUCCESS (13.734s)
[712.779514] Starting dynamic subtest: vcs1
[726.552136] Dynamic subtest vcs1: SUCCESS (13.783s)
[726.566062] Starting dynamic subtest: vecs0
[740.296875] Dynamic subtest vecs0: SUCCESS (13.742s)
[740.312526] Starting dynamic subtest: vecs1
[753.808025] Dynamic subtest vecs1: SUCCESS (13.505s)
[753.845077] Starting dynamic subtest: ccs0
[767.193215] Dynamic subtest ccs0: SUCCESS (13.387s)
[767.194153] Subtest wide: SUCCESS (95.443s)
[768.937982] [118/132] (324s left) kms_big_fb (linear-32bpp-rotate-90)
[769.138173] Starting subtest: linear-32bpp-rotate-90
[769.200833] Subtest linear-32bpp-rotate-90: SKIP (0.059s)
[769.386431] [119/132] (324s left) kms_psr (pr-no-drrs)
[769.574394] Subtest pr-no-drrs: SKIP (0.000s)
[769.643424] [120/132] (323s left) kms_plane_scaling (plane-scaler-with-clipping-clamping-rotation)
[769.830660] Starting subtest: plane-scaler-with-clipping-clamping-rotation
[769.831522] Starting dynamic subtest: pipe-A
[770.229870] Dynamic subtest pipe-A: SUCCESS (0.398s)
[770.258583] Starting dynamic subtest: pipe-B
[770.709389] Dynamic subtest pipe-B: SUCCESS (0.478s)
[770.727178] Starting dynamic subtest: pipe-C
[771.172515] Dynamic subtest pipe-C: SUCCESS (0.462s)
[771.193851] Starting dynamic subtest: pipe-D
[771.669308] Dynamic subtest pipe-D: SUCCESS (0.495s)
[771.677425] Subtest plane-scaler-with-clipping-clamping-rotation: SUCCESS (1.840s)
[771.987125] [121/132] (321s left) gem_mmap_wc (write-prefaulted)
[772.069217] Subtest write-prefaulted: SKIP (0.000s)
[772.156940] [122/132] (321s left) gem_render_copy (yf-tiled)
[772.242974] Starting subtest: yf-tiled
[772.245169] Subtest yf-tiled: SKIP (0.000s)
[772.520083] [123/132] (321s left) kms_flip (2x-flip-vs-modeset)
[772.711950] Starting subtest: 2x-flip-vs-modeset
[772.726075] Subtest 2x-flip-vs-modeset: SKIP (0.015s)
[772.852103] [124/132] (321s left) kms_dither (fb-8bpc-vs-panel-8bpc)
[773.042292] Starting subtest: fb-8bpc-vs-panel-8bpc
[773.043190] Starting dynamic subtest: pipe-A-DP-3
[773.428956] Dynamic subtest pipe-A-DP-3: SUCCESS (0.384s)
[773.430381] Subtest fb-8bpc-vs-panel-8bpc: SUCCESS (0.388s)
[773.675414] [125/132] (320s left) kms_atomic_transition (plane-all-transition)
[773.863356] Starting subtest: plane-all-transition
[773.864259] Starting dynamic subtest: pipe-A-DP-3
[777.628388] Dynamic subtest pipe-A-DP-3: SUCCESS (3.763s)
[777.767550] Starting dynamic subtest: pipe-B-DP-3
[781.660921] Dynamic subtest pipe-B-DP-3: SUCCESS (3.906s)
[781.750285] Subtest plane-all-transition: SUCCESS (7.887s)
[781.987944] [126/132] (312s left) kms_vblank (crtc-id)
[782.184441] Starting subtest: crtc-id
[782.185390] Starting dynamic subtest: pipe-A-DP-3
[782.546752] Dynamic subtest pipe-A-DP-3: SUCCESS (0.361s)
[782.577378] Starting dynamic subtest: pipe-D-DP-3
[782.876213] Dynamic subtest pipe-D-DP-3: SUCCESS (0.318s)
[782.877132] Subtest crtc-id: SUCCESS (0.693s)
[783.114641] [127/132] (311s left) gem_exec_reloc (basic-range-active)
[783.201664] Subtest basic-range-active: SKIP (0.000s)
[783.267520] [128/132] (310s left) kms_vblank (wait-forked-hang)
[783.456487] Starting subtest: wait-forked-hang
[783.457353] Starting dynamic subtest: pipe-A-DP-3
[810.580276] Dynamic subtest pipe-A-DP-3: SUCCESS (27.122s)
[810.595513] Starting dynamic subtest: pipe-D-DP-3
[835.575335] Dynamic subtest pipe-D-DP-3: SUCCESS (24.990s)
[835.576249] Subtest wait-forked-hang: SUCCESS (52.119s)
[835.850968] [129/132] (258s left) kms_flip (flip-vs-panning-interruptible)
[836.040800] Starting subtest: flip-vs-panning-interruptible
[836.045714] Starting dynamic subtest: A-DP3
[843.892541] Dynamic subtest A-DP3: SUCCESS (7.846s)
[843.935734] Starting dynamic subtest: B-DP3
[851.694714] Dynamic subtest B-DP3: SUCCESS (7.796s)
[851.737393] Starting dynamic subtest: C-DP3
[859.494861] Dynamic subtest C-DP3: SUCCESS (7.792s)
[859.537910] Starting dynamic subtest: D-DP3
[867.295942] Dynamic subtest D-DP3: SUCCESS (7.796s)
[867.305144] Subtest flip-vs-panning-interruptible: SUCCESS (31.263s)
[867.666817] [130/132] (226s left) kms_frontbuffer_tracking (fbcpsr-2p-rte)
[867.863800] Starting subtest: fbcpsr-2p-rte
[867.865446] Subtest fbcpsr-2p-rte: SKIP (0.000s)
[867.999788] [131/132] (226s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-pwrite)
[868.193960] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-pwrite
[871.359768] Subtest fbc-1p-primscrn-pri-shrfb-draw-pwrite: SUCCESS (3.166s)
[871.567281] [132/132] (222s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-render)
[871.759113] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-render
[871.760904] Subtest fbc-2p-primscrn-pri-indfb-draw-render: SKIP (0.000s)
[871.966138] Closing watchdogs
results: parsing output: 0/ for test: i915_pm_freq_api
results: parsing output: 1/ for test: gem_exec_schedule
results: parsing output: 2/ for test: kms_plane
results: parsing output: 3/ for test: syncobj_basic
results: parsing output: 4/ for test: kms_addfb_basic
results: parsing output: 5/ for test: api_intel_bb
results: parsing output: 6/ for test: gem_exec_reloc
results: parsing output: 7/ for test: gem_exec_suspend
results: parsing output: 8/ for test: api_intel_bb
results: parsing output: 9/ for test: kms_flip
results: parsing output: 10/ for test: syncobj_timeline
results: parsing output: 11/ for test: i915_drm_fdinfo
results: parsing output: 12/ for test: gem_exec_balancer
results: parsing output: 13/ for test: kms_frontbuffer_tracking
results: parsing output: 14/ for test: kms_psr
results: parsing output: 15/ for test: kms_flip
results: parsing output: 16/ for test: kms_joiner
results: parsing output: 17/ for test: kms_lease
results: parsing output: 18/ for test: perf_pmu
results: parsing output: 19/ for test: gem_ctx_exec
results: parsing output: 20/ for test: kms_big_fb
results: parsing output: 21/ for test: kms_psr
results: parsing output: 22/ for test: kms_frontbuffer_tracking
results: parsing output: 23/ for test: gem_exec_reloc
results: parsing output: 24/ for test: kms_frontbuffer_tracking
results: parsing output: 25/ for test: kms_frontbuffer_tracking
results: parsing output: 26/ for test: kms_frontbuffer_tracking
results: parsing output: 27/ for test: kms_frontbuffer_tracking
results: parsing output: 28/ for test: syncobj_timeline
results: parsing output: 29/ for test: kms_frontbuffer_tracking
results: parsing output: 30/ for test: kms_frontbuffer_tracking
results: parsing output: 31/ for test: kms_feature_discovery
results: parsing output: 32/ for test: kms_atomic
results: parsing output: 33/ for test: gem_vm_create
results: parsing output: 34/ for test: kms_vblank
results: parsing output: 35/ for test: kms_ccs
results: parsing output: 36/ for test: kms_big_fb
results: parsing output: 37/ for test: dmabuf_sync_file
results: parsing output: 38/ for test: kms_cursor_edge_walk
results: parsing output: 39/ for test: gem_exec_reloc
results: parsing output: 40/ for test: kms_frontbuffer_tracking
results: parsing output: 41/ for test: kms_big_fb
results: parsing output: 42/ for test: kms_flip
results: parsing output: 43/ for test: gem_exec_params
results: parsing output: 44/ for test: kms_color
results: parsing output: 45/ for test: kms_cursor_crc
results: parsing output: 46/ for test: kms_pm_rpm
results: parsing output: 47/ for test: kms_frontbuffer_tracking
results: parsing output: 48/ for test: syncobj_timeline
results: parsing output: 49/ for test: kms_frontbuffer_tracking
results: parsing output: 50/ for test: kms_frontbuffer_tracking
results: parsing output: 51/ for test: gem_softpin
results: parsing output: 52/ for test: syncobj_wait
results: parsing output: 53/ for test: kms_cursor_legacy
results: parsing output: 54/ for test: kms_content_protection
results: parsing output: 55/ for test: prime_self_import
results: parsing output: 56/ for test: kms_big_fb
results: parsing output: 57/ for test: kms_frontbuffer_tracking
results: parsing output: 58/ for test: i915_query
results: parsing output: 59/ for test: kms_plane_multiple
results: parsing output: 60/ for test: kms_ccs
results: parsing output: 61/ for test: gem_spin_batch
results: parsing output: 62/ for test: kms_cursor_legacy
results: parsing output: 63/ for test: gem_ctx_persistence
results: parsing output: 64/ for test: kms_frontbuffer_tracking
results: parsing output: 65/ for test: prime_mmap
results: parsing output: 66/ for test: kms_chamelium_audio
results: parsing output: 67/ for test: kms_frontbuffer_tracking
results: parsing output: 68/ for test: kms_psr
results: parsing output: 69/ for test: gem_render_copy
results: parsing output: 70/ for test: kms_psr2_sf
results: parsing output: 71/ for test: kms_psr2_sf
results: parsing output: 72/ for test: kms_chamelium_color
results: parsing output: 73/ for test: prime_vgem
results: parsing output: 74/ for test: gem_exec_fence
results: parsing output: 75/ for test: kms_rmfb
results: parsing output: 76/ for test: gem_ctx_exec
results: parsing output: 77/ for test: perf_pmu
results: parsing output: 78/ for test: gem_exec_whisper
results: parsing output: 79/ for test: kms_frontbuffer_tracking
results: parsing output: 80/ for test: kms_big_fb
results: parsing output: 81/ for test: sysfs_timeslice_duration
results: parsing output: 82/ for test: gem_mmap_gtt
results: parsing output: 83/ for test: gem_exec_flush
results: parsing output: 84/ for test: kms_plane_alpha_blend
results: parsing output: 85/ for test: kms_ccs
results: parsing output: 86/ for test: syncobj_timeline
results: parsing output: 87/ for test: syncobj_eventfd
results: parsing output: 88/ for test: gem_exec_balancer
results: parsing output: 89/ for test: kms_properties
results: parsing output: 90/ for test: gem_partial_pwrite_pread
results: parsing output: 91/ for test: syncobj_wait
results: parsing output: 92/ for test: kms_pipe_b_c_ivb
results: parsing output: 93/ for test: kms_ccs
results: parsing output: 94/ for test: gem_exec_reloc
results: parsing output: 95/ for test: kms_pm_rpm
results: parsing output: 96/ for test: kms_async_flips
results: parsing output: 97/ for test: gem_exec_async
results: parsing output: 98/ for test: kms_flip_scaled_crc
results: parsing output: 99/ for test: kms_psr
results: parsing output: 100/ for test: gem_create
results: parsing output: 101/ for test: gem_exec_schedule
results: parsing output: 102/ for test: fbdev
results: parsing output: 103/ for test: gem_exec_fence
results: parsing output: 104/ for test: gem_userptr_blits
results: parsing output: 105/ for test: gem_mmap_offset
results: parsing output: 106/ for test: gem_exec_reloc
results: parsing output: 107/ for test: kms_plane
results: parsing output: 108/ for test: kms_psr
results: parsing output: 109/ for test: i915_selftest
results: parsing output: 110/ for test: i915_pm_rps
results: parsing output: 111/ for test: kms_big_fb
results: parsing output: 112/ for test: kms_cursor_crc
results: parsing output: 113/ for test: gen7_exec_parse
results: parsing output: 114/ for test: gem_mmap_gtt
results: parsing output: 115/ for test: kms_chamelium_hpd
results: parsing output: 116/ for test: gem_exec_schedule
results: parsing output: 117/ for test: kms_big_fb
results: parsing output: 118/ for test: kms_psr
results: parsing output: 119/ for test: kms_plane_scaling
results: parsing output: 120/ for test: gem_mmap_wc
results: parsing output: 121/ for test: gem_render_copy
results: parsing output: 122/ for test: kms_flip
results: parsing output: 123/ for test: kms_dither
results: parsing output: 124/ for test: kms_atomic_transition
results: parsing output: 125/ for test: kms_vblank
results: parsing output: 126/ for test: gem_exec_reloc
results: parsing output: 127/ for test: kms_vblank
results: parsing output: 128/ for test: kms_flip
results: parsing output: 129/ for test: kms_frontbuffer_tracking
results: parsing output: 130/ for test: kms_frontbuffer_tracking
results: parsing output: 131/ for test: kms_frontbuffer_tracking
Done.