[57.384010] Initializing watchdogs
[57.384072]   /dev/watchdog0
[57.398926] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:7d55 Intel Meteorlake (Gen12) Meteor Lake-P [Intel Arc Graphics]
[57.403535] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[57.406263] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[57.409641] [001/133] (960s left) gem_exec_schedule (u-submit-late-slice)
[57.510569] Starting subtest: u-submit-late-slice
[57.512978] Starting dynamic subtest: rcs0
[57.565902] Dynamic subtest rcs0: SUCCESS (0.059s)
[57.576103] Starting dynamic subtest: bcs0
[57.613852] Dynamic subtest bcs0: SUCCESS (0.047s)
[57.621630] Starting dynamic subtest: vcs0
[57.660425] Dynamic subtest vcs0: SUCCESS (0.047s)
[57.667843] Starting dynamic subtest: vcs1
[57.709228] Dynamic subtest vcs1: SUCCESS (0.047s)
[57.716874] Starting dynamic subtest: vecs0
[57.754563] Dynamic subtest vecs0: SUCCESS (0.046s)
[57.763817] Starting dynamic subtest: ccs0
[57.802079] Dynamic subtest ccs0: SUCCESS (0.047s)
[57.804414] Subtest u-submit-late-slice: SUCCESS (0.296s)
[59.000171] [002/133] (958s left) gem_exec_flush (basic-wb-rw-default)
[59.067535] Starting subtest: basic-wb-rw-default
[64.559029] Subtest basic-wb-rw-default: SUCCESS (5.481s)
[64.744111] [003/133] (953s left) sysfs_timeslice_duration (duration)
[64.800906] Starting subtest: duration
[64.803067] Starting dynamic subtest: vecs0
[78.901089] Dynamic subtest vecs0: SUCCESS (14.100s)
[78.911642] Starting dynamic subtest: ccs0
[92.048903] Dynamic subtest ccs0: SUCCESS (13.148s)
[92.059886] Starting dynamic subtest: vcs0
[106.867417] Dynamic subtest vcs0: SUCCESS (14.815s)
[106.877795] Starting dynamic subtest: bcs0
[120.019599] Dynamic subtest bcs0: SUCCESS (13.137s)
[120.028830] Starting dynamic subtest: rcs0
[133.143293] Dynamic subtest rcs0: SUCCESS (13.138s)
[133.154980] Starting dynamic subtest: vcs1
[146.870069] Dynamic subtest vcs1: SUCCESS (13.723s)
[146.872770] Subtest duration: SUCCESS (82.067s)
[146.942107] [004/133] (871s left) gem_userptr_blits (readonly-unsync)
[147.012783] Subtest readonly-unsync: SKIP (0.000s)
[147.129014] [005/133] (870s left) kms_color_pipeline (plane-lut1d-pre-ctm3x4)
[147.226090] Starting subtest: plane-lut1d-pre-ctm3x4
[147.420159] Starting dynamic subtest: pipe-A-plane-0
[147.598470] Dynamic subtest pipe-A-plane-0: SUCCESS (0.178s)
[147.606093] Starting dynamic subtest: pipe-A-plane-1
[147.763680] Dynamic subtest pipe-A-plane-1: SUCCESS (0.166s)
[147.771215] Starting dynamic subtest: pipe-A-plane-2
[147.929941] Dynamic subtest pipe-A-plane-2: SUCCESS (0.166s)
[149.091955] Starting dynamic subtest: pipe-B-plane-0
[149.261667] Dynamic subtest pipe-B-plane-0: SUCCESS (0.178s)
[149.271655] Starting dynamic subtest: pipe-B-plane-1
[149.420302] Dynamic subtest pipe-B-plane-1: SUCCESS (0.156s)
[149.427893] Starting dynamic subtest: pipe-B-plane-2
[149.572652] Dynamic subtest pipe-B-plane-2: SUCCESS (0.155s)
[150.722291] Starting dynamic subtest: pipe-C-plane-0
[150.860244] Dynamic subtest pipe-C-plane-0: SUCCESS (0.144s)
[150.869226] Starting dynamic subtest: pipe-C-plane-1
[151.026882] Dynamic subtest pipe-C-plane-1: SUCCESS (0.166s)
[151.036179] Starting dynamic subtest: pipe-C-plane-2
[151.193637] Dynamic subtest pipe-C-plane-2: SUCCESS (0.166s)
[152.401082] Starting dynamic subtest: pipe-D-plane-0
[152.527547] Dynamic subtest pipe-D-plane-0: SUCCESS (0.133s)
[152.536383] Starting dynamic subtest: pipe-D-plane-1
[152.671582] Dynamic subtest pipe-D-plane-1: SUCCESS (0.144s)
[152.680052] Starting dynamic subtest: pipe-D-plane-2
[152.838559] Dynamic subtest pipe-D-plane-2: SUCCESS (0.166s)
[153.126839] Subtest plane-lut1d-pre-ctm3x4: SUCCESS (5.897s)
[153.941976] [006/133] (864s left) kms_sequence (queue-busy)
[154.039277] Starting subtest: queue-busy
[154.041593] Starting dynamic subtest: pipe-A-eDP-1
[155.982477] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.941s)
[155.991223] Starting dynamic subtest: pipe-B-eDP-1
[158.557606] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.573s)
[158.570472] Starting dynamic subtest: pipe-C-eDP-1
[161.172459] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.612s)
[161.181556] Starting dynamic subtest: pipe-D-eDP-1
[163.792968] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.619s)
[163.795191] Subtest queue-busy: SUCCESS (9.751s)
[164.596216] [007/133] (853s left) kms_ccs (crc-primary-rotation-180-4-tiled-mtl-rc-ccs)
[164.687388] Starting subtest: crc-primary-rotation-180-4-tiled-mtl-rc-ccs
[164.689775] Starting dynamic subtest: pipe-A-eDP-1
[165.585583] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.890s)
[165.597643] Starting dynamic subtest: pipe-B-eDP-1
[167.254408] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.667s)
[167.263586] Starting dynamic subtest: pipe-C-eDP-1
[168.791339] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.536s)
[168.800564] Starting dynamic subtest: pipe-D-eDP-1
[170.297752] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.502s)
[170.300046] Subtest crc-primary-rotation-180-4-tiled-mtl-rc-ccs: SUCCESS (5.599s)
[171.449915] [008/133] (846s left) gem_pxp (reject-modify-context-protection-on)
[171.587610] Starting subtest: reject-modify-context-protection-on
[171.590220] Subtest reject-modify-context-protection-on: SUCCESS (0.002s)
[171.689742] [009/133] (846s left) gen9_exec_parse (bb-secure)
[171.748301] Subtest bb-secure: SKIP (0.000s)
[171.816804] [010/133] (846s left) kms_cursor_crc (cursor-rapid-movement-128x42)
[172.022668] Starting subtest: cursor-rapid-movement-128x42
[172.071261] Subtest cursor-rapid-movement-128x42: SKIP (0.043s)
[172.279842] [011/133] (846s left) syncobj_timeline (invalid-single-wait-all-unsubmitted)
[172.349076] Starting subtest: invalid-single-wait-all-unsubmitted
[172.351762] Subtest invalid-single-wait-all-unsubmitted: SUCCESS (0.000s)
[172.452707] [012/133] (845s left) gem_mmap_gtt (coherency)
[172.505563] Subtest coherency: SKIP (0.000s)
[172.564261] [013/133] (845s left) kms_frontbuffer_tracking (psr-rgb101010-draw-mmap-wc)
[172.664092] Starting subtest: psr-rgb101010-draw-mmap-wc
[179.756264] Subtest psr-rgb101010-draw-mmap-wc: SUCCESS (7.095s)
[179.853974] [014/133] (838s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-move)
[179.956046] Starting subtest: psr-1p-primscrn-spr-indfb-move
[187.563369] Subtest psr-1p-primscrn-spr-indfb-move: SUCCESS (7.610s)
[187.707568] [015/133] (830s left) kms_plane (planar-pixel-format-settings)
[187.798734] Starting subtest: planar-pixel-format-settings
[187.868693] Subtest planar-pixel-format-settings: SUCCESS (0.070s)
[187.993024] [016/133] (830s left) kms_psr (pr-cursor-plane-onoff)
[188.087144] Starting subtest: pr-cursor-plane-onoff
[188.091656] Subtest pr-cursor-plane-onoff: SKIP (0.000s)
[188.157013] [017/133] (830s left) kms_ccs (ccs-on-another-bo-yf-tiled-ccs)
[188.254782] Starting subtest: ccs-on-another-bo-yf-tiled-ccs
[188.257096] Starting dynamic subtest: pipe-A-eDP-1
[188.279957] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[188.291230] Starting dynamic subtest: pipe-B-eDP-1
[188.309872] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[188.317497] Starting dynamic subtest: pipe-C-eDP-1
[188.339158] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[188.346301] Starting dynamic subtest: pipe-D-eDP-1
[188.367853] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[188.372144] Subtest ccs-on-another-bo-yf-tiled-ccs: SKIP (0.004s)
[190.541969] [018/133] (828s left) kms_frontbuffer_tracking (psr-1p-primscrn-indfb-msflip-blt)
[190.642187] Starting subtest: psr-1p-primscrn-indfb-msflip-blt
[197.978250] Subtest psr-1p-primscrn-indfb-msflip-blt: SUCCESS (7.338s)
[198.109145] [019/133] (820s left) kms_cursor_crc (cursor-offscreen-32x32)
[198.261705] Starting subtest: cursor-offscreen-32x32
[198.317983] Subtest cursor-offscreen-32x32: SKIP (0.048s)
[198.597388] [020/133] (820s left) gem_exec_balancer (parallel-contexts)
[198.862438] Starting subtest: parallel-contexts
[201.471842] Subtest parallel-contexts: SUCCESS (2.610s)
[201.588392] [021/133] (817s left) gem_ctx_persistence (saturated-hostile-nopreempt)
[201.657907] Starting subtest: saturated-hostile-nopreempt
[201.660350] Starting dynamic subtest: rcs0
[201.732696] Dynamic subtest rcs0: SKIP (0.072s)
[201.742874] Starting dynamic subtest: bcs0
[201.752548] Dynamic subtest bcs0: SKIP (0.019s)
[201.760406] Starting dynamic subtest: vcs0
[201.764473] Dynamic subtest vcs0: SKIP (0.011s)
[201.772149] Starting dynamic subtest: vcs1
[201.779507] Dynamic subtest vcs1: SKIP (0.014s)
[201.787340] Starting dynamic subtest: vecs0
[201.791667] Dynamic subtest vecs0: SKIP (0.011s)
[201.799046] Starting dynamic subtest: ccs0
[201.805683] Dynamic subtest ccs0: SKIP (0.014s)
[201.810070] Subtest saturated-hostile-nopreempt: SKIP (0.146s)
[201.880090] [022/133] (816s left) kms_getfb (getfb-handle-zero)
[201.971832] Starting subtest: getfb-handle-zero
[201.974229] Subtest getfb-handle-zero: SUCCESS (0.000s)
[202.074749] [023/133] (816s left) kms_frontbuffer_tracking (fbc-1p-primscrn-indfb-plflip-blt)
[202.172564] Starting subtest: fbc-1p-primscrn-indfb-plflip-blt
[206.803405] Subtest fbc-1p-primscrn-indfb-plflip-blt: SUCCESS (4.634s)
[207.995953] [024/133] (810s left) syncobj_timeline (etime-single-wait-for-submit-submitted)
[208.053478] Starting subtest: etime-single-wait-for-submit-submitted
[208.162210] Subtest etime-single-wait-for-submit-submitted: SUCCESS (0.109s)
[208.233532] [025/133] (810s left) syncobj_timeline (multi-wait-submitted-signaled)
[208.294227] Starting subtest: multi-wait-submitted-signaled
[208.296494] Subtest multi-wait-submitted-signaled: SUCCESS (0.001s)
[208.398556] [026/133] (810s left) gem_exec_schedule (preempt-queue-chain)
[208.471337] Subtest preempt-queue-chain: SKIP (0.000s)
[208.767448] [027/133] (810s left) gem_exec_schedule (fairslice)
[208.836223] Starting subtest: fairslice
[208.838616] Starting dynamic subtest: rcs0
[210.846913] Dynamic subtest rcs0: SUCCESS (2.020s)
[210.855580] Starting dynamic subtest: bcs0
[212.922194] Dynamic subtest bcs0: SUCCESS (2.023s)
[212.931825] Starting dynamic subtest: vcs0
[214.939834] Dynamic subtest vcs0: SUCCESS (2.017s)
[214.949497] Starting dynamic subtest: vcs1
[216.906197] Dynamic subtest vcs1: SUCCESS (2.015s)
[216.915789] Starting dynamic subtest: vecs0
[218.974082] Dynamic subtest vecs0: SUCCESS (2.017s)
[218.982697] Starting dynamic subtest: ccs0
[220.950499] Dynamic subtest ccs0: SUCCESS (2.024s)
[220.952501] Subtest fairslice: SUCCESS (12.122s)
[221.246297] [028/133] (797s left) kms_big_fb (x-tiled-16bpp-rotate-180)
[221.357211] Starting subtest: x-tiled-16bpp-rotate-180
[222.702420] Subtest x-tiled-16bpp-rotate-180: SUCCESS (1.346s)
[222.822747] [029/133] (796s left) kms_psr (psr2-no-drrs)
[222.913963] Starting subtest: psr2-no-drrs
[222.915751] Starting dynamic subtest: eDP-1
[224.560576] Dynamic subtest eDP-1: SUCCESS (1.645s)
[224.562898] Subtest psr2-no-drrs: SUCCESS (1.646s)
[225.354153] [030/133] (793s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-render)
[225.454583] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-render
[225.459071] Subtest fbc-2p-scndscrn-spr-indfb-draw-render: SKIP (0.000s)
[225.557855] [031/133] (793s left) gem_unref_active_buffers
[225.742900] [032/133] (793s left) kms_vblank (query-forked)
[225.835021] Starting subtest: query-forked
[225.836925] Starting dynamic subtest: pipe-A-eDP-1
[227.670514] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.834s)
[227.684272] Starting dynamic subtest: pipe-D-eDP-1
[230.196779] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.524s)
[230.199133] Subtest query-forked: SUCCESS (4.362s)
[231.035039] [033/133] (788s left) syncobj_timeline (wait-all-snapshot)
[231.097323] Starting subtest: wait-all-snapshot
[231.177827] Subtest wait-all-snapshot: SUCCESS (0.082s)
[231.252976] [034/133] (787s left) gem_create (create-ext-set-pat)
[231.432637] Starting subtest: create-ext-set-pat
[231.434893] Subtest create-ext-set-pat: SUCCESS (0.001s)
[231.542513] [035/133] (787s left) kms_psr2_sf (fbc-psr2-overlay-plane-move-continuous-sf)
[231.640064] Starting subtest: fbc-psr2-overlay-plane-move-continuous-sf
[231.642419] Starting dynamic subtest: pipe-A-eDP-1
[231.727106] Dynamic subtest pipe-A-eDP-1: SKIP (0.089s)
[231.735558] Starting dynamic subtest: pipe-B-eDP-1
[232.913675] Dynamic subtest pipe-B-eDP-1: SKIP (1.185s)
[232.918110] Subtest fbc-psr2-overlay-plane-move-continuous-sf: SKIP (1.276s)
[234.100560] [036/133] (785s left) syncobj_basic (bad-destroy-pad)
[234.162563] Starting subtest: bad-destroy-pad
[234.164909] Subtest bad-destroy-pad: SUCCESS (0.000s)
[234.268303] [037/133] (785s left) gem_gpgpu_fill (offset-16x16)
[234.332043] Starting subtest: offset-16x16
[234.338083] Subtest offset-16x16: SUCCESS (0.006s)
[234.485685] [038/133] (784s left) gem_exec_params (batch-first)
[234.540760] Starting subtest: batch-first
[234.546287] Subtest batch-first: SUCCESS (0.005s)
[234.684227] [039/133] (784s left) kms_plane_lowres (tiling-4)
[234.771233] Starting subtest: tiling-4
[234.773519] Starting dynamic subtest: pipe-A-eDP-1
[234.777946] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[235.067618] Starting dynamic subtest: pipe-B-eDP-1
[235.072459] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[235.082478] Starting dynamic subtest: pipe-C-eDP-1
[235.087158] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[235.095149] Starting dynamic subtest: pipe-D-eDP-1
[235.099634] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[235.103815] Subtest tiling-4: SKIP (0.296s)
[235.937364] [040/133] (783s left) kms_dirtyfb (default-dirtyfb-ioctl)
[236.036073] Starting subtest: default-dirtyfb-ioctl
[236.038433] Starting dynamic subtest: A-eDP-1
[237.663929] Dynamic subtest A-eDP-1: SUCCESS (1.628s)
[237.666762] Subtest default-dirtyfb-ioctl: SUCCESS (1.630s)
[238.465366] [041/133] (781s left) syncobj_wait (multi-wait-for-submit-signaled)
[238.523151] Starting subtest: multi-wait-for-submit-signaled
[238.525488] Subtest multi-wait-for-submit-signaled: SUCCESS (0.000s)
[238.624262] [042/133] (780s left) gem_exec_balancer (bonded-dual)
[238.683685] Starting subtest: bonded-dual
[238.688258] Subtest bonded-dual: SKIP (0.000s)
[238.979221] [043/133] (780s left) i915_selftest (live)
[242.288423] Starting subtest: live
[242.291312] Starting dynamic subtest: sanitycheck
[246.569412] Dynamic subtest sanitycheck: SUCCESS (4.281s)
[246.578184] Starting dynamic subtest: uncore
[249.247251] Dynamic subtest uncore: SUCCESS (2.677s)
[249.256557] Starting dynamic subtest: workarounds
[252.285903] Dynamic subtest workarounds: SUCCESS (3.037s)
[252.294969] Starting dynamic subtest: gt_engines
[256.864268] Dynamic subtest gt_engines: SUCCESS (4.577s)
[256.877997] Starting dynamic subtest: gt_timelines
[272.523346] Dynamic subtest gt_timelines: SUCCESS (15.657s)
[272.532948] Starting dynamic subtest: gt_contexts
[276.850326] Dynamic subtest gt_contexts: SUCCESS (4.324s)
[276.865397] Starting dynamic subtest: gt_lrc
[281.147541] Dynamic subtest gt_lrc: SUCCESS (4.294s)
[281.156550] Starting dynamic subtest: gt_mocs
[284.034950] Dynamic subtest gt_mocs: SUCCESS (2.886s)
[284.043661] Starting dynamic subtest: gt_pm
[290.792536] Dynamic subtest gt_pm: SUCCESS (6.756s)
[290.801265] Starting dynamic subtest: gt_heartbeat
[295.095802] Dynamic subtest gt_heartbeat: SUCCESS (4.301s)
[295.105227] Starting dynamic subtest: gt_tlb
[304.472241] Dynamic subtest gt_tlb: SUCCESS (9.374s)
[304.480897] Starting dynamic subtest: requests
[318.182258] Dynamic subtest requests: SUCCESS (13.709s)
[318.192188] Starting dynamic subtest: migrate
[323.915546] Dynamic subtest migrate: SUCCESS (5.730s)
[323.924644] Starting dynamic subtest: active
[328.215745] Dynamic subtest active: SUCCESS (4.298s)
[328.225177] Starting dynamic subtest: objects
[333.259731] Dynamic subtest objects: SUCCESS (5.043s)
[333.270274] Starting dynamic subtest: mman
[337.964983] Dynamic subtest mman: SUCCESS (4.702s)
[337.973842] Starting dynamic subtest: dmabuf
[342.279207] Dynamic subtest dmabuf: SUCCESS (4.313s)
[342.288571] Starting dynamic subtest: vma
[346.577699] Dynamic subtest vma: SUCCESS (4.296s)
[346.587286] Starting dynamic subtest: coherency
[350.547683] Dynamic subtest coherency: SUCCESS (3.968s)
[350.556749] Starting dynamic subtest: gtt
[360.581344] Dynamic subtest gtt: SUCCESS (10.033s)
[360.590712] Starting dynamic subtest: gem
[368.522666] Dynamic subtest gem: SUCCESS (7.939s)
[368.532076] Starting dynamic subtest: evict
[373.955038] Dynamic subtest evict: SUCCESS (5.431s)
[373.964506] Starting dynamic subtest: hugepages
[382.736627] Dynamic subtest hugepages: SUCCESS (8.780s)
[382.745955] Starting dynamic subtest: gem_contexts
[411.498292] Dynamic subtest gem_contexts: SUCCESS (28.759s)
[411.507186] Starting dynamic subtest: client
[415.807944] Dynamic subtest client: SUCCESS (4.309s)
[415.814564] Starting dynamic subtest: gem_migrate
[420.154030] Dynamic subtest gem_migrate: SUCCESS (4.343s)
[420.163130] Starting dynamic subtest: reset
[424.449301] Dynamic subtest reset: SUCCESS (4.294s)
[424.458821] Starting dynamic subtest: memory_region
[427.123072] Dynamic subtest memory_region: SUCCESS (2.672s)
[427.132546] Starting dynamic subtest: hangcheck
[439.990665] Dynamic subtest hangcheck: SUCCESS (12.866s)
[439.998905] Starting dynamic subtest: execlists
[444.299021] Dynamic subtest execlists: SUCCESS (4.306s)
[444.308122] Starting dynamic subtest: ring_submission
[446.999075] Dynamic subtest ring_submission: SUCCESS (2.698s)
[447.008538] Starting dynamic subtest: perf
[451.332364] Dynamic subtest perf: SUCCESS (4.332s)
[451.341227] Starting dynamic subtest: slpc
[463.385953] Dynamic subtest slpc: SUCCESS (12.053s)
[463.395030] Starting dynamic subtest: guc
[467.261061] Dynamic subtest guc: SUCCESS (3.871s)
[467.272588] Starting dynamic subtest: guc_multi_lrc
[471.552237] Dynamic subtest guc_multi_lrc: SUCCESS (4.290s)
[471.561572] Starting dynamic subtest: guc_hang
[476.380580] Dynamic subtest guc_hang: SUCCESS (4.827s)
[476.395554] Starting dynamic subtest: late_gt_pm
[480.691960] Dynamic subtest late_gt_pm: SUCCESS (4.308s)
[480.694613] Subtest live: SUCCESS (238.396s)
[480.721223] [FACT i915_selftest (live)] deleted: kernel.kmod_is_loaded.i915: true
[480.724322] [044/133] (538s left) kms_tv_load_detect (load-detect)
[482.246845] Subtest load-detect: SKIP (0.000s)
[482.320600] [FACT kms_tv_load_detect (load-detect)] new: kernel.kmod_is_loaded.i915: true
[482.324758] [045/133] (537s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-mmap-wc)
[482.423334] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-mmap-wc
[482.427654] Subtest fbc-2p-scndscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[482.529812] [046/133] (537s left) kms_async_flips (async-flip-hang)
[482.628111] Starting subtest: async-flip-hang
[483.015566] Starting dynamic subtest: pipe-A-eDP-1
[509.436343] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.414s)
[509.812771] Starting dynamic subtest: pipe-B-eDP-1
[525.435462] Dynamic subtest pipe-B-eDP-1: SUCCESS (15.622s)
[525.812763] Starting dynamic subtest: pipe-C-eDP-1
[541.431246] Dynamic subtest pipe-C-eDP-1: SUCCESS (15.612s)
[541.793518] Starting dynamic subtest: pipe-D-eDP-1
[557.423348] Dynamic subtest pipe-D-eDP-1: SUCCESS (15.631s)
[557.425940] Subtest async-flip-hang: SUCCESS (74.792s)
[558.584615] [047/133] (461s left) kms_pm_rpm (cursor)
[560.130060] Starting subtest: cursor
[560.135205] Subtest cursor: SKIP (0.000s)
[560.847566] [048/133] (458s left) gem_userptr_blits (relocations)
[560.910664] Starting subtest: relocations
[560.914979] Subtest relocations: SKIP (0.001s)
[561.028476] [049/133] (458s left) kms_pm_rpm (modeset-non-lpsp-stress-no-wait)
[563.067426] Starting subtest: modeset-non-lpsp-stress-no-wait
[563.106640] Subtest modeset-non-lpsp-stress-no-wait: SKIP (0.042s)
[563.443751] [050/133] (456s left) kms_plane_scaling (planes-downscale-factor-0-75-upscale-20x20)
[563.541170] Starting subtest: planes-downscale-factor-0-75-upscale-20x20
[563.543511] Starting dynamic subtest: pipe-A
[563.604653] Dynamic subtest pipe-A: SUCCESS (0.065s)
[563.613864] Starting dynamic subtest: pipe-B
[564.756141] Dynamic subtest pipe-B: SUCCESS (1.150s)
[564.768097] Starting dynamic subtest: pipe-C
[565.858422] Dynamic subtest pipe-C: SUCCESS (1.101s)
[565.866482] Starting dynamic subtest: pipe-D
[566.997549] Dynamic subtest pipe-D: SUCCESS (1.138s)
[566.999817] Subtest planes-downscale-factor-0-75-upscale-20x20: SUCCESS (3.459s)
[568.160558] [051/133] (451s left) kms_async_flips (invalid-async-flip)
[568.253317] Starting subtest: invalid-async-flip
[568.638364] Starting dynamic subtest: pipe-A-eDP-1
[569.501194] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.863s)
[569.860216] Starting dynamic subtest: pipe-B-eDP-1
[570.730063] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.877s)
[571.088811] Starting dynamic subtest: pipe-C-eDP-1
[571.862430] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.780s)
[572.218906] Starting dynamic subtest: pipe-D-eDP-1
[572.993026] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.783s)
[572.995312] Subtest invalid-async-flip: SUCCESS (4.742s)
[574.142327] [052/133] (445s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-fullscreen)
[574.231385] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-fullscreen
[580.953403] Subtest fbcpsr-1p-primscrn-spr-indfb-fullscreen: SUCCESS (6.727s)
[581.087705] [053/133] (438s left) kms_cursor_legacy (2x-cursor-vs-flip-atomic)
[581.209463] Starting subtest: 2x-cursor-vs-flip-atomic
[581.213743] Subtest 2x-cursor-vs-flip-atomic: SKIP (0.001s)
[581.359375] [054/133] (438s left) kms_lease (setcrtc-implicit-plane)
[581.440083] Starting subtest: setcrtc-implicit-plane
[581.442419] Starting dynamic subtest: pipe-A-eDP-1
[581.909732] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.469s)
[581.925532] Starting dynamic subtest: pipe-B-eDP-1
[583.016413] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.103s)
[583.025084] Starting dynamic subtest: pipe-C-eDP-1
[584.126698] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.109s)
[584.135094] Starting dynamic subtest: pipe-D-eDP-1
[585.268768] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.142s)
[585.270972] Subtest setcrtc-implicit-plane: SUCCESS (3.830s)
[586.113212] [055/133] (433s left) kms_flip (flip-vs-panning-interruptible)
[586.199990] Starting subtest: flip-vs-panning-interruptible
[586.201947] Starting dynamic subtest: A-eDP1
[594.927062] Dynamic subtest A-eDP1: SUCCESS (8.725s)
[594.935196] Starting dynamic subtest: B-eDP1
[603.658580] Dynamic subtest B-eDP1: SUCCESS (8.730s)
[603.669487] Starting dynamic subtest: C-eDP1
[612.377663] Dynamic subtest C-eDP1: SUCCESS (8.716s)
[612.385629] Starting dynamic subtest: D-eDP1
[621.031990] Dynamic subtest D-eDP1: SUCCESS (8.651s)
[621.033944] Subtest flip-vs-panning-interruptible: SUCCESS (34.834s)
[622.199592] [056/133] (397s left) kms_big_fb (x-tiled-addfb-size-offset-overflow)
[622.298643] Starting subtest: x-tiled-addfb-size-offset-overflow
[622.300644] Subtest x-tiled-addfb-size-offset-overflow: SUCCESS (0.000s)
[622.391854] [057/133] (397s left) kms_ccs (crc-sprite-planes-basic-4-tiled-dg2-rc-ccs-cc)
[622.479343] Starting subtest: crc-sprite-planes-basic-4-tiled-dg2-rc-ccs-cc
[622.481559] Starting dynamic subtest: pipe-A-eDP-1
[622.536602] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[622.544727] Starting dynamic subtest: pipe-B-eDP-1
[622.602980] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[622.613042] Starting dynamic subtest: pipe-C-eDP-1
[622.670381] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[622.679611] Starting dynamic subtest: pipe-D-eDP-1
[622.738208] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[622.742282] Subtest crc-sprite-planes-basic-4-tiled-dg2-rc-ccs-cc: SKIP (0.009s)
[624.753551] [058/133] (395s left) kms_prop_blob (invalid-get-prop-any)
[624.805740] Starting subtest: invalid-get-prop-any
[624.807860] Subtest invalid-get-prop-any: SUCCESS (0.000s)
[624.899585] [059/133] (395s left) core_getclient (basic)
[624.949289] Starting subtest: basic
[624.951536] Subtest basic: SUCCESS (0.000s)
[625.043572] [060/133] (395s left) gem_mmap_offset (partial-unmap)
[625.096959] Starting subtest: partial-unmap
[625.099445] Starting dynamic subtest: smem0
[625.605859] Dynamic subtest smem0: SUCCESS (0.511s)
[625.608948] Subtest partial-unmap: SUCCESS (0.512s)
[625.716166] [061/133] (394s left) gem_exec_params (invalid-bsd1-flag-on-blt)
[625.787198] Starting subtest: invalid-bsd1-flag-on-blt
[625.789557] Subtest invalid-bsd1-flag-on-blt: SUCCESS (0.000s)
[625.903921] [062/133] (394s left) gem_workarounds (reset)
[625.975034] Starting subtest: reset
[626.120804] Subtest reset: SUCCESS (0.145s)
[626.232272] [063/133] (394s left) syncobj_eventfd (invalid-illegal-handle)
[626.280425] Starting subtest: invalid-illegal-handle
[626.282693] Subtest invalid-illegal-handle: SUCCESS (0.000s)
[626.373325] [064/133] (394s left) gem_exec_schedule (semaphore-codependency)
[626.441364] Starting subtest: semaphore-codependency
[626.447461] Subtest semaphore-codependency: SUCCESS (0.014s)
[626.787262] [065/133] (393s left) gem_tiled_partial_pwrite_pread (reads)
[626.847454] Subtest reads: SKIP (0.000s)
[626.913167] [066/133] (393s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-blt)
[627.024419] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-blt
[634.370926] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-blt: SUCCESS (7.348s)
[634.503681] [067/133] (386s left) gem_spin_batch (resubmit-new)
[634.576720] Starting subtest: resubmit-new
[634.579105] Starting dynamic subtest: rcs0
[634.585217] Dynamic subtest rcs0: SUCCESS (0.008s)
[634.595852] Starting dynamic subtest: bcs0
[634.598259] Dynamic subtest bcs0: SUCCESS (0.005s)
[634.606483] Starting dynamic subtest: vcs0
[634.608750] Dynamic subtest vcs0: SUCCESS (0.005s)
[634.617024] Starting dynamic subtest: vcs1
[634.618964] Dynamic subtest vcs1: SUCCESS (0.004s)
[634.626928] Starting dynamic subtest: vecs0
[634.628834] Dynamic subtest vecs0: SUCCESS (0.004s)
[634.636586] Starting dynamic subtest: ccs0
[634.638477] Dynamic subtest ccs0: SUCCESS (0.004s)
[634.640383] Subtest resubmit-new: SUCCESS (0.035s)
[635.964388] [068/133] (384s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-180-hflip)
[636.068222] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-180-hflip
[636.072750] Subtest yf-tiled-max-hw-stride-32bpp-rotate-180-hflip: SKIP (0.000s)
[636.162192] [069/133] (384s left) gem_mmap_gtt (cpuset-big-copy-xy)
[636.218594] Subtest cpuset-big-copy-XY: SKIP (0.000s)
[636.274708] [070/133] (384s left) kms_flip_scaled_crc (flip-32bpp-yftile-to-64bpp-yftile-downscaling)
[636.362530] Starting subtest: flip-32bpp-yftile-to-64bpp-yftile-downscaling
[636.366864] Subtest flip-32bpp-yftile-to-64bpp-yftile-downscaling: SKIP (0.000s)
[636.434488] [071/133] (384s left) syncobj_wait (single-wait-all-for-submit-signaled)
[636.499529] Starting subtest: single-wait-all-for-submit-signaled
[636.501758] Subtest single-wait-all-for-submit-signaled: SUCCESS (0.000s)
[636.610311] [072/133] (384s left) kms_cursor_edge_walk (64x64-left-edge)
[636.698750] Starting subtest: 64x64-left-edge
[636.700991] Starting dynamic subtest: pipe-A-eDP-1
[640.180234] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.482s)
[640.189087] Starting dynamic subtest: pipe-D-eDP-1
[643.359132] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.175s)
[643.361265] Subtest 64x64-left-edge: SUCCESS (6.660s)
[644.163331] [073/133] (376s left) api_intel_allocator (open-vm)
[644.217559] Starting subtest: open-vm
[644.219812] Subtest open-vm: SUCCESS (0.003s)
[644.341849] [074/133] (376s left) kms_joiner (basic-force-ultra-joiner)
[644.431860] Starting subtest: basic-force-ultra-joiner
[644.435731] Subtest basic-force-ultra-joiner: SKIP (0.000s)
[644.497372] [075/133] (376s left) sw_sync (timeline_closed)
[644.534647] Starting subtest: timeline_closed
[644.537059] Subtest timeline_closed: SUCCESS (0.000s)
[644.586682] [076/133] (376s left) kms_hdmi_inject (inject-4k)
[644.917544] Starting subtest: inject-4k
[645.229707] Subtest inject-4k: SUCCESS (0.314s)
[645.835503] [077/133] (375s left) i915_drm_fdinfo (virtual-busy-idle)
[645.875995] Starting subtest: virtual-busy-idle
[645.880473] Subtest virtual-busy-idle: SKIP (0.000s)
[645.945639] [078/133] (374s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-indfb-draw-mmap-wc)
[646.036720] Starting subtest: fbc-1p-offscreen-pri-indfb-draw-mmap-wc
[650.167792] Subtest fbc-1p-offscreen-pri-indfb-draw-mmap-wc: SUCCESS (4.134s)
[651.328895] [079/133] (369s left) kms_chamelium_color (ctm-0-75)
[651.429550] Subtest ctm-0-75: SKIP (0.000s)
[651.475247] [080/133] (369s left) kms_ccs (bad-pixel-format-y-tiled-gen12-rc-ccs-cc)
[651.578906] Starting subtest: bad-pixel-format-y-tiled-gen12-rc-ccs-cc
[651.581177] Starting dynamic subtest: pipe-A-eDP-1
[651.603827] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[651.614670] Starting dynamic subtest: pipe-B-eDP-1
[651.635806] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[651.644159] Starting dynamic subtest: pipe-C-eDP-1
[651.665273] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[651.673638] Starting dynamic subtest: pipe-D-eDP-1
[651.695132] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[651.699141] Subtest bad-pixel-format-y-tiled-gen12-rc-ccs-cc: SKIP (0.005s)
[653.796089] [081/133] (367s left) gem_userptr_blits (dmabuf-unsync)
[653.873187] Subtest dmabuf-unsync: SKIP (0.000s)
[653.999347] [082/133] (367s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-pwrite)
[654.089438] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-pwrite
[654.093471] Subtest psr-2p-scndscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[654.177799] [083/133] (366s left) kms_busy (extended-modeset-hang-newfb-with-reset)
[654.283079] Starting subtest: extended-modeset-hang-newfb-with-reset
[654.285326] Starting dynamic subtest: pipe-A
[667.814387] Dynamic subtest pipe-A: SUCCESS (13.527s)
[667.823511] Starting dynamic subtest: pipe-D
[682.728187] Dynamic subtest pipe-D: SUCCESS (14.913s)
[682.730377] Subtest extended-modeset-hang-newfb-with-reset: SUCCESS (28.444s)
[683.587174] [084/133] (337s left) prime_busy (after)
[683.651541] Starting subtest: after
[683.656749] Starting dynamic subtest: rcs0
[683.695833] Dynamic subtest rcs0: SUCCESS (0.041s)
[683.706304] Starting dynamic subtest: bcs0
[683.746857] Dynamic subtest bcs0: SUCCESS (0.050s)
[683.756237] Starting dynamic subtest: vcs0
[683.787569] Dynamic subtest vcs0: SUCCESS (0.040s)
[683.796683] Starting dynamic subtest: vcs1
[683.827920] Dynamic subtest vcs1: SUCCESS (0.040s)
[683.837069] Starting dynamic subtest: vecs0
[683.868429] Dynamic subtest vecs0: SUCCESS (0.040s)
[683.877659] Starting dynamic subtest: ccs0
[683.909822] Dynamic subtest ccs0: SUCCESS (0.041s)
[684.018705] Subtest after: SUCCESS (0.365s)
[684.098055] [085/133] (337s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-32bpp-ytileccs-downscaling)
[684.191960] Starting subtest: flip-32bpp-ytile-to-32bpp-ytileccs-downscaling
[684.196238] Subtest flip-32bpp-ytile-to-32bpp-ytileccs-downscaling: SKIP (0.000s)
[684.273083] [086/133] (336s left) gem_render_copy (y-tiled-ccs-to-yf-tiled-ccs)
[684.342556] Starting subtest: y-tiled-ccs-to-yf-tiled-ccs
[684.347026] Subtest y-tiled-ccs-to-yf-tiled-ccs: SKIP (0.000s)
[684.522458] [087/133] (336s left) gem_ctx_shared (exec-shared-gtt)
[684.589562] Starting subtest: exec-shared-gtt
[684.591888] Starting dynamic subtest: rcs0
[684.600121] Dynamic subtest rcs0: SUCCESS (0.010s)
[684.610587] Starting dynamic subtest: bcs0
[684.612780] Dynamic subtest bcs0: SUCCESS (0.006s)
[684.621762] Starting dynamic subtest: vcs0
[684.624089] Dynamic subtest vcs0: SUCCESS (0.007s)
[684.632458] Starting dynamic subtest: vcs1
[684.634342] Dynamic subtest vcs1: SUCCESS (0.007s)
[684.643166] Starting dynamic subtest: vecs0
[684.645297] Dynamic subtest vecs0: SUCCESS (0.006s)
[684.653776] Starting dynamic subtest: ccs0
[684.655992] Dynamic subtest ccs0: SUCCESS (0.008s)
[684.658156] Subtest exec-shared-gtt: SUCCESS (0.049s)
[684.828099] [088/133] (336s left) kms_getfb (getfb-handle-valid)
[684.911764] Starting subtest: getfb-handle-valid
[684.914027] Subtest getfb-handle-valid: SUCCESS (0.000s)
[685.005698] [089/133] (336s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-onoff)
[685.100813] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-onoff
[685.105180] Subtest fbcpsr-2p-primscrn-spr-indfb-onoff: SKIP (0.000s)
[685.198173] [090/133] (336s left) kms_content_protection (atomic-dpms-hdcp14)
[685.329643] Starting subtest: atomic-dpms-hdcp14
[685.334123] Subtest atomic-dpms-hdcp14: SKIP (0.000s)
[685.446953] [091/133] (336s left) kms_atomic_transition (plane-primary-toggle-with-vblank-wait)
[685.533109] Starting subtest: plane-primary-toggle-with-vblank-wait
[685.534891] Starting dynamic subtest: pipe-A-eDP-1
[685.707039] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.174s)
[686.015399] Starting dynamic subtest: pipe-B-eDP-1
[686.962158] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.957s)
[687.259080] Subtest plane-primary-toggle-with-vblank-wait: SUCCESS (1.726s)
[688.086821] [092/133] (333s left) gem_mmap_gtt (basic-read-write-distinct)
[688.161152] Subtest basic-read-write-distinct: SKIP (0.000s)
[688.227510] [093/133] (333s left) gem_exec_params (cliprects_ptr-dirt)
[688.300398] Starting subtest: cliprects_ptr-dirt
[688.302762] Subtest cliprects_ptr-dirt: SUCCESS (0.000s)
[688.428198] [094/133] (333s left) sw_sync (sync_merge_invalid)
[688.494691] Starting subtest: sync_merge_invalid
[688.518706] Subtest sync_merge_invalid: SUCCESS (0.024s)
[688.588964] [095/133] (333s left) kms_cursor_legacy (flip-vs-cursor-atomic)
[688.708393] Starting subtest: flip-vs-cursor-atomic
[696.191549] Subtest flip-vs-cursor-atomic: SUCCESS (7.480s)
[697.001424] [096/133] (324s left) kms_psr (fbc-psr-primary-render)
[697.105894] Starting subtest: fbc-psr-primary-render
[697.108146] Starting dynamic subtest: eDP-1
[697.112282] Dynamic subtest eDP-1: SKIP (0.000s)
[697.116359] Subtest fbc-psr-primary-render: SKIP (0.001s)
[697.177737] [097/133] (324s left) gem_fenced_exec_thrash (no-spare-fences-busy)
[697.248794] Subtest no-spare-fences-busy: SKIP (0.000s)
[697.307314] [098/133] (324s left) kms_chamelium_hpd (hdmi-hpd-storm)
[697.694373] Subtest hdmi-hpd-storm: SKIP (0.000s)
[698.465760] [099/133] (323s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-move)
[698.574643] Starting subtest: fbc-1p-primscrn-cur-indfb-move
[702.599841] Subtest fbc-1p-primscrn-cur-indfb-move: SUCCESS (4.028s)
[703.808527] [100/133] (318s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-render)
[703.909426] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-render
[703.913981] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-render: SKIP (0.000s)
[704.034830] [101/133] (317s left) fbdev (eof)
[704.077999] Starting subtest: eof
[704.080428] Subtest eof: SUCCESS (0.000s)
[704.157237] [102/133] (317s left) perf (gen12-unprivileged-single-ctx-counters)
[704.278663] Starting subtest: gen12-unprivileged-single-ctx-counters
[704.280869] Starting dynamic subtest: rcs0
[704.355102] Dynamic subtest rcs0: SUCCESS (0.078s)
[704.357444] Subtest gen12-unprivileged-single-ctx-counters: SUCCESS (0.079s)
[704.404634] [103/133] (317s left) kms_feature_discovery (display-1x)
[704.532234] Starting subtest: display-1x
[704.534103] Subtest display-1x: SUCCESS (0.000s)
[704.620061] [104/133] (317s left) kms_chamelium_edid (dp-mode-timings)
[705.000239] Subtest dp-mode-timings: SKIP (0.000s)
[705.772885] [105/133] (316s left) gem_mmap_gtt (basic-wc)
[705.823627] Subtest basic-wc: SKIP (0.000s)
[705.883938] [106/133] (316s left) kms_fbcon_fbt (fbc-suspend)
[705.936984] Starting subtest: fbc-suspend
[756.053066] Subtest fbc-suspend: SUCCESS (19.997s)
[758.394577] [107/133] (264s left) perf_pmu (busy-idle)
[758.446241] Starting subtest: busy-idle
[758.450860] Starting dynamic subtest: rcs0
[759.127396] Dynamic subtest rcs0: SUCCESS (0.682s)
[759.140556] Starting dynamic subtest: bcs0
[759.789257] Dynamic subtest bcs0: SUCCESS (0.659s)
[759.802148] Starting dynamic subtest: vcs0
[761.013939] Dynamic subtest vcs0: SUCCESS (1.220s)
[761.027187] Starting dynamic subtest: vcs1
[762.998579] Dynamic subtest vcs1: SUCCESS (1.981s)
[763.012060] Starting dynamic subtest: vecs0
[765.046012] Dynamic subtest vecs0: SUCCESS (2.043s)
[765.057216] Starting dynamic subtest: ccs0
[765.716009] Dynamic subtest ccs0: SUCCESS (0.668s)
[765.719030] Subtest busy-idle: SUCCESS (7.269s)
[765.812423] [108/133] (257s left) kms_multipipe_modeset (basic-max-pipe-crc-check)
[765.922469] Starting subtest: basic-max-pipe-crc-check
[765.926984] Subtest basic-max-pipe-crc-check: SKIP (0.000s)
[765.969817] [109/133] (257s left) dumb_buffer (create-clear)
[766.029677] Starting subtest: create-clear
[800.781174] Subtest create-clear: SUCCESS (34.739s)
[800.889420] [110/133] (222s left) kms_big_fb (4-tiled-32bpp-rotate-0)
[800.989450] Starting subtest: 4-tiled-32bpp-rotate-0
[802.347092] Subtest 4-tiled-32bpp-rotate-0: SUCCESS (1.358s)
[802.483208] [111/133] (220s left) kms_big_fb (linear-16bpp-rotate-180)
[802.587530] Starting subtest: linear-16bpp-rotate-180
[803.935077] Subtest linear-16bpp-rotate-180: SUCCESS (1.348s)
[804.092783] [112/133] (219s left) gem_pread (self)
[804.158813] Subtest self: SKIP (0.000s)
[804.222297] [113/133] (219s left) kms_psr2_su (frontbuffer-xrgb8888)
[804.271242] Subtest frontbuffer-XRGB8888: SKIP (0.000s)
[804.330979] [114/133] (219s left) gem_exec_parallel (basic)
[804.395600] Starting subtest: basic
[804.397665] Starting dynamic subtest: rcs0
[805.797748] Dynamic subtest rcs0: SUCCESS (1.401s)
[805.808511] Starting dynamic subtest: bcs0
[807.272796] Dynamic subtest bcs0: SUCCESS (1.474s)
[807.283951] Starting dynamic subtest: vcs0
[809.014977] Dynamic subtest vcs0: SUCCESS (1.739s)
[809.025779] Starting dynamic subtest: vcs1
[810.998273] Dynamic subtest vcs1: SUCCESS (1.980s)
[811.008884] Starting dynamic subtest: vecs0
[812.983310] Dynamic subtest vecs0: SUCCESS (1.982s)
[812.994365] Starting dynamic subtest: ccs0
[814.468194] Dynamic subtest ccs0: SUCCESS (1.483s)
[814.470711] Subtest basic: SUCCESS (10.071s)
[814.658477] [115/133] (208s left) gem_mmap_wc (read-write-distinct)
[814.717937] Subtest read-write-distinct: SKIP (0.000s)
[814.777918] [116/133] (208s left) gem_ctx_param (invalid-get-engines)
[814.832941] Starting subtest: invalid-get-engines
[814.835176] Subtest invalid-get-engines: SUCCESS (0.001s)
[814.940765] [117/133] (208s left) kms_getfb (getfb-reject-nv12)
[815.026356] Starting subtest: getfb-reject-nv12
[815.028586] Subtest getfb-reject-nv12: SUCCESS (0.001s)
[815.127575] [118/133] (208s left) kms_plane (pixel-format-yf-tiled-modifier)
[815.224473] Starting subtest: pixel-format-yf-tiled-modifier
[815.228553] Subtest pixel-format-yf-tiled-modifier: SKIP (0.000s)
[815.298419] [119/133] (208s left) gem_exec_flush (basic-wb-set-default)
[815.354934] Starting subtest: basic-wb-set-default
[820.842077] Subtest basic-wb-set-default: SUCCESS (5.471s)
[821.030216] [120/133] (202s left) vgem_slow (nohang)
[821.144310] Starting subtest: nohang
[831.559718] Subtest nohang: SUCCESS (10.361s)
[831.600023] [FACT vgem_slow (nohang)] new: kernel.kmod_is_loaded.vgem: true
[831.603898] [121/133] (192s left) gem_softpin (invalid)
[831.676598] Starting subtest: invalid
[831.687225] Subtest invalid: SUCCESS (0.012s)
[831.805038] [122/133] (191s left) i915_pm_rpm (gem-pread)
[833.339450] Starting subtest: gem-pread
[835.785085] Subtest gem-pread: SUCCESS (2.444s)
[835.908282] [123/133] (187s left) gem_vm_create (invalid-destroy)
[835.976016] Starting subtest: invalid-destroy
[835.978347] Subtest invalid-destroy: SUCCESS (0.002s)
[836.091779] [124/133] (187s left) syncobj_wait (wait-any-snapshot)
[836.145369] Starting subtest: wait-any-snapshot
[836.228366] Subtest wait-any-snapshot: SUCCESS (0.083s)
[836.323771] [125/133] (187s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-180-async-flip)
[836.432408] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-180-async-flip
[836.436892] Subtest yf-tiled-max-hw-stride-64bpp-rotate-180-async-flip: SKIP (0.000s)
[836.528597] [126/133] (187s left) kms_psr (fbc-psr2-cursor-plane-move)
[836.630660] Starting subtest: fbc-psr2-cursor-plane-move
[836.632951] Starting dynamic subtest: eDP-1
[836.637453] Dynamic subtest eDP-1: SKIP (0.000s)
[836.641779] Subtest fbc-psr2-cursor-plane-move: SKIP (0.003s)
[836.719260] [127/133] (187s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-blt)
[836.822681] Starting subtest: fbcpsr-rgb101010-draw-blt
[843.430644] Subtest fbcpsr-rgb101010-draw-blt: SUCCESS (6.609s)
[843.546943] [128/133] (180s left) gem_exec_fence (syncobj-timeline-multiple-ext-nodes)
[844.071473] Starting subtest: syncobj-timeline-multiple-ext-nodes
[844.074203] Subtest syncobj-timeline-multiple-ext-nodes: SUCCESS (0.004s)
[845.107203] [129/133] (178s left) gem_render_tiled_blits (basic)
[845.173237] Subtest basic: SKIP (0.000s)
[845.249883] [130/133] (178s left) i915_drm_fdinfo (memory-info-purgeable)
[845.297392] Starting subtest: memory-info-purgeable
[845.299665] Starting dynamic subtest: smem0
[847.950665] Dynamic subtest smem0: SUCCESS (2.654s)
[847.952902] Subtest memory-info-purgeable: SUCCESS (2.656s)
[848.026500] [131/133] (176s left) kms_scaling_modes (scaling-mode-full-aspect)
[848.119352] Starting subtest: scaling-mode-full-aspect
[848.120942] Starting dynamic subtest: pipe-A-eDP-1
[848.214219] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.095s)
[848.225413] Starting dynamic subtest: pipe-B-eDP-1
[849.388176] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.172s)
[849.401301] Starting dynamic subtest: pipe-C-eDP-1
[850.582529] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.192s)
[850.592950] Starting dynamic subtest: pipe-D-eDP-1
[851.768843] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.185s)
[851.771174] Subtest scaling-mode-full-aspect: SUCCESS (3.651s)
[852.999246] [132/133] (171s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-mmap-cpu)
[853.095370] Starting subtest: psr-2p-primscrn-spr-indfb-draw-mmap-cpu
[853.099175] Subtest psr-2p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[853.209416] [133/133] (171s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-mmap-cpu)
[853.308708] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-mmap-cpu
[859.856170] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-mmap-cpu: SUCCESS (6.552s)
[859.998928] Closing watchdogs
results: parsing output: 0/ for test: gem_exec_schedule
results: parsing output: 1/ for test: gem_exec_flush
results: parsing output: 2/ for test: sysfs_timeslice_duration
results: parsing output: 3/ for test: gem_userptr_blits
results: parsing output: 4/ for test: kms_color_pipeline
results: parsing output: 5/ for test: kms_sequence
results: parsing output: 6/ for test: kms_ccs
results: parsing output: 7/ for test: gem_pxp
results: parsing output: 8/ for test: gen9_exec_parse
results: parsing output: 9/ for test: kms_cursor_crc
results: parsing output: 10/ for test: syncobj_timeline
results: parsing output: 11/ for test: gem_mmap_gtt
results: parsing output: 12/ for test: kms_frontbuffer_tracking
results: parsing output: 13/ for test: kms_frontbuffer_tracking
results: parsing output: 14/ for test: kms_plane
results: parsing output: 15/ for test: kms_psr
results: parsing output: 16/ for test: kms_ccs
results: parsing output: 17/ for test: kms_frontbuffer_tracking
results: parsing output: 18/ for test: kms_cursor_crc
results: parsing output: 19/ for test: gem_exec_balancer
results: parsing output: 20/ for test: gem_ctx_persistence
results: parsing output: 21/ for test: kms_getfb
results: parsing output: 22/ for test: kms_frontbuffer_tracking
results: parsing output: 23/ for test: syncobj_timeline
results: parsing output: 24/ for test: syncobj_timeline
results: parsing output: 25/ for test: gem_exec_schedule
results: parsing output: 26/ for test: gem_exec_schedule
results: parsing output: 27/ for test: kms_big_fb
results: parsing output: 28/ for test: kms_psr
results: parsing output: 29/ for test: kms_frontbuffer_tracking
results: parsing output: 30/ for test: gem_unref_active_buffers
results: parsing output: 31/ for test: kms_vblank
results: parsing output: 32/ for test: syncobj_timeline
results: parsing output: 33/ for test: gem_create
results: parsing output: 34/ for test: kms_psr2_sf
results: parsing output: 35/ for test: syncobj_basic
results: parsing output: 36/ for test: gem_gpgpu_fill
results: parsing output: 37/ for test: gem_exec_params
results: parsing output: 38/ for test: kms_plane_lowres
results: parsing output: 39/ for test: kms_dirtyfb
results: parsing output: 40/ for test: syncobj_wait
results: parsing output: 41/ for test: gem_exec_balancer
results: parsing output: 42/ for test: i915_selftest
results: parsing output: 43/ for test: kms_tv_load_detect
results: parsing output: 44/ for test: kms_frontbuffer_tracking
results: parsing output: 45/ for test: kms_async_flips
results: parsing output: 46/ for test: kms_pm_rpm
results: parsing output: 47/ for test: gem_userptr_blits
results: parsing output: 48/ for test: kms_pm_rpm
results: parsing output: 49/ for test: kms_plane_scaling
results: parsing output: 50/ for test: kms_async_flips
results: parsing output: 51/ for test: kms_frontbuffer_tracking
results: parsing output: 52/ for test: kms_cursor_legacy
results: parsing output: 53/ for test: kms_lease
results: parsing output: 54/ for test: kms_flip
results: parsing output: 55/ for test: kms_big_fb
results: parsing output: 56/ for test: kms_ccs
results: parsing output: 57/ for test: kms_prop_blob
results: parsing output: 58/ for test: core_getclient
results: parsing output: 59/ for test: gem_mmap_offset
results: parsing output: 60/ for test: gem_exec_params
results: parsing output: 61/ for test: gem_workarounds
results: parsing output: 62/ for test: syncobj_eventfd
results: parsing output: 63/ for test: gem_exec_schedule
results: parsing output: 64/ for test: gem_tiled_partial_pwrite_pread
results: parsing output: 65/ for test: kms_frontbuffer_tracking
results: parsing output: 66/ for test: gem_spin_batch
results: parsing output: 67/ for test: kms_big_fb
results: parsing output: 68/ for test: gem_mmap_gtt
results: parsing output: 69/ for test: kms_flip_scaled_crc
results: parsing output: 70/ for test: syncobj_wait
results: parsing output: 71/ for test: kms_cursor_edge_walk
results: parsing output: 72/ for test: api_intel_allocator
results: parsing output: 73/ for test: kms_joiner
results: parsing output: 74/ for test: sw_sync
results: parsing output: 75/ for test: kms_hdmi_inject
results: parsing output: 76/ for test: i915_drm_fdinfo
results: parsing output: 77/ for test: kms_frontbuffer_tracking
results: parsing output: 78/ for test: kms_chamelium_color
results: parsing output: 79/ for test: kms_ccs
results: parsing output: 80/ for test: gem_userptr_blits
results: parsing output: 81/ for test: kms_frontbuffer_tracking
results: parsing output: 82/ for test: kms_busy
results: parsing output: 83/ for test: prime_busy
results: parsing output: 84/ for test: kms_flip_scaled_crc
results: parsing output: 85/ for test: gem_render_copy
results: parsing output: 86/ for test: gem_ctx_shared
results: parsing output: 87/ for test: kms_getfb
results: parsing output: 88/ for test: kms_frontbuffer_tracking
results: parsing output: 89/ for test: kms_content_protection
results: parsing output: 90/ for test: kms_atomic_transition
results: parsing output: 91/ for test: gem_mmap_gtt
results: parsing output: 92/ for test: gem_exec_params
results: parsing output: 93/ for test: sw_sync
results: parsing output: 94/ for test: kms_cursor_legacy
results: parsing output: 95/ for test: kms_psr
results: parsing output: 96/ for test: gem_fenced_exec_thrash
results: parsing output: 97/ for test: kms_chamelium_hpd
results: parsing output: 98/ for test: kms_frontbuffer_tracking
results: parsing output: 99/ for test: kms_frontbuffer_tracking
results: parsing output: 100/ for test: fbdev
results: parsing output: 101/ for test: perf
results: parsing output: 102/ for test: kms_feature_discovery
results: parsing output: 103/ for test: kms_chamelium_edid
results: parsing output: 104/ for test: gem_mmap_gtt
results: parsing output: 105/ for test: kms_fbcon_fbt
results: parsing output: 106/ for test: perf_pmu
results: parsing output: 107/ for test: kms_multipipe_modeset
results: parsing output: 108/ for test: dumb_buffer
results: parsing output: 109/ for test: kms_big_fb
results: parsing output: 110/ for test: kms_big_fb
results: parsing output: 111/ for test: gem_pread
results: parsing output: 112/ for test: kms_psr2_su
results: parsing output: 113/ for test: gem_exec_parallel
results: parsing output: 114/ for test: gem_mmap_wc
results: parsing output: 115/ for test: gem_ctx_param
results: parsing output: 116/ for test: kms_getfb
results: parsing output: 117/ for test: kms_plane
results: parsing output: 118/ for test: gem_exec_flush
results: parsing output: 119/ for test: vgem_slow
results: parsing output: 120/ for test: gem_softpin
results: parsing output: 121/ for test: i915_pm_rpm
results: parsing output: 122/ for test: gem_vm_create
results: parsing output: 123/ for test: syncobj_wait
results: parsing output: 124/ for test: kms_big_fb
results: parsing output: 125/ for test: kms_psr
results: parsing output: 126/ for test: kms_frontbuffer_tracking
results: parsing output: 127/ for test: gem_exec_fence
results: parsing output: 128/ for test: gem_render_tiled_blits
results: parsing output: 129/ for test: i915_drm_fdinfo
results: parsing output: 130/ for test: kms_scaling_modes
results: parsing output: 131/ for test: kms_frontbuffer_tracking
results: parsing output: 132/ for test: kms_frontbuffer_tracking
Done.