[58.714933] Initializing watchdogs
[58.714989]   /dev/watchdog0
[58.729715] [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]
[58.734150] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[58.736336] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[58.738221] [001/133] (960s left) kms_psr (psr-cursor-render)
[58.828147] Starting subtest: psr-cursor-render
[58.829251] Starting dynamic subtest: eDP-1
[60.556614] Dynamic subtest eDP-1: SUCCESS (1.728s)
[60.557536] Subtest psr-cursor-render: SUCCESS (1.730s)
[61.415455] [002/133] (957s left) kms_addfb_basic (addfb25-framebuffer-vs-set-tiling)
[61.511698] Subtest addfb25-framebuffer-vs-set-tiling: SKIP (0.000s)
[61.618925] [003/133] (957s left) kms_chamelium_audio (hdmi-audio)
[62.005076] Subtest hdmi-audio: SKIP (0.000s)
[62.843514] [004/133] (956s left) gem_lmem_swapping (basic)
[62.883685] Subtest basic: SKIP (0.000s)
[62.913591] [005/133] (956s left) kms_sequence (get-busy)
[62.997272] Starting subtest: get-busy
[62.998234] Starting dynamic subtest: pipe-A-eDP-1
[64.943382] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.946s)
[64.949851] Starting dynamic subtest: pipe-B-eDP-1
[67.593561] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.649s)
[67.600264] Starting dynamic subtest: pipe-C-eDP-1
[70.197808] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.603s)
[70.205548] Starting dynamic subtest: pipe-D-eDP-1
[72.742390] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.544s)
[72.743379] Subtest get-busy: SUCCESS (9.746s)
[73.528045] [006/133] (945s left) gem_mmap_offset (mmap-unmap)
[73.576805] Starting subtest: mmap-unmap
[73.577792] Starting dynamic subtest: smem0
[97.698996] Dynamic subtest smem0: SUCCESS (24.077s)
[97.700585] Subtest mmap-unmap: SUCCESS (24.078s)
[97.756544] [007/133] (921s left) gem_mmap (basic)
[97.805270] Subtest basic: SKIP (0.000s)
[97.859189] [008/133] (921s left) kms_ccs (bad-pixel-format-4-tiled-dg2-rc-ccs-cc)
[97.944975] Starting subtest: bad-pixel-format-4-tiled-dg2-rc-ccs-cc
[97.945858] Starting dynamic subtest: pipe-A-eDP-1
[97.953980] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[97.962948] Starting dynamic subtest: pipe-B-eDP-1
[97.971757] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[97.977534] Starting dynamic subtest: pipe-C-eDP-1
[97.985673] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[97.990840] Starting dynamic subtest: pipe-D-eDP-1
[97.999425] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[98.001062] Subtest bad-pixel-format-4-tiled-dg2-rc-ccs-cc: SKIP (0.003s)
[100.191485] [009/133] (919s left) gem_ctx_bad_destroy (invalid-ctx)
[100.240481] Starting subtest: invalid-ctx
[100.241477] Subtest invalid-ctx: SUCCESS (0.000s)
[100.311439] [010/133] (919s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-shrfb-draw-render)
[100.397172] Starting subtest: psr-1p-offscreen-pri-shrfb-draw-render
[107.281916] Subtest psr-1p-offscreen-pri-shrfb-draw-render: SUCCESS (6.884s)
[107.412382] [011/133] (912s left) kms_flip (basic-flip-vs-modeset)
[107.519047] Starting subtest: basic-flip-vs-modeset
[107.519929] Starting dynamic subtest: A-eDP1
[110.096408] Dynamic subtest A-eDP1: SUCCESS (2.576s)
[110.102981] Starting dynamic subtest: B-eDP1
[112.301351] Dynamic subtest B-eDP1: SUCCESS (2.205s)
[112.307862] Starting dynamic subtest: C-eDP1
[114.551094] Dynamic subtest C-eDP1: SUCCESS (2.249s)
[114.557969] Starting dynamic subtest: D-eDP1
[116.709860] Dynamic subtest D-eDP1: SUCCESS (2.158s)
[116.711681] Subtest basic-flip-vs-modeset: SUCCESS (9.194s)
[117.508351] [012/133] (902s left) kms_vblank (wait-forked)
[117.610379] Starting subtest: wait-forked
[117.611340] Starting dynamic subtest: pipe-A-eDP-1
[119.418577] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.808s)
[119.426961] Starting dynamic subtest: pipe-D-eDP-1
[121.914550] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.494s)
[121.915423] Subtest wait-forked: SUCCESS (4.305s)
[122.769201] [013/133] (896s left) kms_big_fb (yf-tiled-addfb-size-offset-overflow)
[122.868477] Starting subtest: yf-tiled-addfb-size-offset-overflow
[122.870352] Subtest yf-tiled-addfb-size-offset-overflow: SKIP (0.000s)
[122.948717] [014/133] (896s left) syncobj_wait (wait-all-complex)
[123.002213] Starting subtest: wait-all-complex
[123.226777] Subtest wait-all-complex: SUCCESS (0.215s)
[123.284819] [015/133] (896s left) gem_wait (busy)
[123.346989] Starting subtest: busy
[123.348026] Starting dynamic subtest: all-engines
[124.898329] Dynamic subtest all-engines: SUCCESS (1.542s)
[124.906697] Starting dynamic subtest: rcs0
[125.433711] Dynamic subtest rcs0: SUCCESS (0.543s)
[125.442259] Starting dynamic subtest: bcs0
[125.974260] Dynamic subtest bcs0: SUCCESS (0.540s)
[125.983564] Starting dynamic subtest: vcs0
[127.906760] Dynamic subtest vcs0: SUCCESS (1.923s)
[127.914583] Starting dynamic subtest: vcs1
[129.889790] Dynamic subtest vcs1: SUCCESS (1.982s)
[129.898025] Starting dynamic subtest: vecs0
[131.937086] Dynamic subtest vecs0: SUCCESS (2.046s)
[131.945394] Starting dynamic subtest: ccs0
[132.471996] Dynamic subtest ccs0: SUCCESS (0.542s)
[132.473647] Subtest busy: SUCCESS (9.125s)
[132.662400] [016/133] (887s left) syncobj_timeline (transfer-timeline-point)
[132.733145] Starting subtest: transfer-timeline-point
[132.734109] Subtest transfer-timeline-point: SUCCESS (0.001s)
[132.829601] [017/133] (886s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-pwrite)
[132.918617] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-pwrite
[139.841033] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-pwrite: SUCCESS (6.923s)
[139.971573] [018/133] (879s left) kms_content_protection (uevent)
[140.112466] Starting subtest: uevent
[140.114426] Subtest uevent: SKIP (0.000s)
[140.218802] [019/133] (879s left) kms_big_fb (4-tiled-32bpp-rotate-180)
[140.308375] Starting subtest: 4-tiled-32bpp-rotate-180
[141.731496] Subtest 4-tiled-32bpp-rotate-180: SUCCESS (1.423s)
[141.869295] [020/133] (877s left) kms_cursor_legacy (cursor-vs-flip-atomic)
[141.987741] Starting subtest: cursor-vs-flip-atomic
[171.319219] Subtest cursor-vs-flip-atomic: SUCCESS (29.328s)
[172.175907] [021/133] (847s left) gem_userptr_blits (create-destroy-sync)
[172.248497] Starting subtest: create-destroy-sync
[177.312037] Subtest create-destroy-sync: SUCCESS (5.017s)
[177.373606] [022/133] (842s left) kms_ccs (crc-primary-suspend-4-tiled-dg2-rc-ccs-cc)
[177.455260] Starting subtest: crc-primary-suspend-4-tiled-dg2-rc-ccs-cc
[177.456226] Starting dynamic subtest: pipe-A-eDP-1
[177.460025] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[177.467080] Starting dynamic subtest: pipe-B-eDP-1
[177.470625] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[177.476421] Starting dynamic subtest: pipe-C-eDP-1
[177.480193] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[177.487961] Starting dynamic subtest: pipe-D-eDP-1
[177.491378] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[177.493074] Subtest crc-primary-suspend-4-tiled-dg2-rc-ccs-cc: SKIP (0.004s)
[179.746789] [023/133] (840s left) syncobj_timeline (multi-wait-for-submit-available-unsubmitted-submitted-signa
[179.801180] Starting subtest: multi-wait-for-submit-available-unsubmitted-submitted-signaled
[179.802194] Subtest multi-wait-for-submit-available-unsubmitted-submitted-signaled: SUCCESS (0.001s)
[179.875695] [024/133] (840s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-mmap-cpu)
[179.982888] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-mmap-cpu
[186.544619] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-mmap-cpu: SUCCESS (6.562s)
[186.661301] [025/133] (833s left) kms_cursor_legacy (flip-vs-cursor-atomic-transitions)
[186.785039] Starting subtest: flip-vs-cursor-atomic-transitions
[194.400219] Subtest flip-vs-cursor-atomic-transitions: SUCCESS (7.614s)
[195.215669] [026/133] (824s left) prime_mmap (test_aperture_limit)
[195.265689] Starting subtest: test_aperture_limit
[195.266881] Starting dynamic subtest: test_aperture_limit-smem
[195.275226] Dynamic subtest test_aperture_limit-smem: SKIP (0.008s)
[195.277086] Subtest test_aperture_limit: SKIP (0.009s)
[195.349280] [027/133] (824s left) gem_ctx_param (set-priority-range)
[195.397470] Starting subtest: set-priority-range
[195.413927] Subtest set-priority-range: SUCCESS (0.017s)
[195.504779] [028/133] (824s left) perf_pmu (multi-client)
[195.538407] Starting subtest: multi-client
[195.539473] Starting dynamic subtest: rcs0
[196.588882] Dynamic subtest rcs0: SUCCESS (1.041s)
[196.597978] Starting dynamic subtest: bcs0
[197.639043] Dynamic subtest bcs0: SUCCESS (1.048s)
[197.648435] Starting dynamic subtest: vcs0
[198.690029] Dynamic subtest vcs0: SUCCESS (1.049s)
[198.698865] Starting dynamic subtest: vcs1
[199.961877] Dynamic subtest vcs1: SUCCESS (1.269s)
[199.970656] Starting dynamic subtest: vecs0
[201.946847] Dynamic subtest vecs0: SUCCESS (1.983s)
[201.955609] Starting dynamic subtest: ccs0
[203.929713] Dynamic subtest ccs0: SUCCESS (1.980s)
[203.930983] Subtest multi-client: SUCCESS (8.384s)
[204.044713] [029/133] (816s left) kms_hdr (static-toggle-suspend)
[204.127281] Starting subtest: static-toggle-suspend
[204.129877] Subtest static-toggle-suspend: SKIP (0.000s)
[204.192296] [030/133] (815s left) kms_cursor_edge_walk (256x256-right-edge)
[204.273161] Starting subtest: 256x256-right-edge
[204.275794] Starting dynamic subtest: pipe-A-eDP-1
[207.694262] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.418s)
[207.701655] Starting dynamic subtest: pipe-D-eDP-1
[210.829389] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.133s)
[210.830324] Subtest 256x256-right-edge: SUCCESS (6.556s)
[211.611457] [031/133] (808s left) i915_pm_rpm (sysfs-read)
[213.130451] Starting subtest: sysfs-read
[214.277322] Subtest sysfs-read: SUCCESS (1.147s)
[214.651421] [032/133] (805s left) gem_linear_blits (normal)
[214.948634] Starting subtest: normal
[218.712236] Subtest normal: SUCCESS (3.755s)
[218.828297] [033/133] (801s left) kms_setmode (invalid-clone-single-crtc-stealing)
[218.917636] Starting subtest: invalid-clone-single-crtc-stealing
[218.920342] Subtest invalid-clone-single-crtc-stealing: SKIP (0.000s)
[219.001524] [034/133] (801s left) gem_exec_schedule (independent)
[219.076903] Starting subtest: independent
[219.078113] Starting dynamic subtest: rcs0
[220.900327] Dynamic subtest rcs0: SUCCESS (1.813s)
[220.909976] Starting dynamic subtest: vcs0
[222.946040] Dynamic subtest vcs0: SUCCESS (2.044s)
[222.955437] Starting dynamic subtest: vcs1
[224.941695] Dynamic subtest vcs1: SUCCESS (1.994s)
[224.951449] Starting dynamic subtest: vecs0
[226.914138] Dynamic subtest vecs0: SUCCESS (1.971s)
[226.925691] Starting dynamic subtest: ccs0
[228.900373] Dynamic subtest ccs0: SUCCESS (1.983s)
[228.901868] Subtest independent: SUCCESS (9.814s)
[229.182883] [035/133] (791s left) dumb_buffer (create-valid-dumb)
[229.227376] Starting subtest: create-valid-dumb
[229.228458] Subtest create-valid-dumb: SUCCESS (0.000s)
[229.312128] [036/133] (790s left) kms_chamelium_hpd (hdmi-hpd-with-enabled-mode)
[229.693571] Subtest hdmi-hpd-with-enabled-mode: SKIP (0.000s)
[230.460097] [037/133] (789s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-180-async-flip)
[230.554095] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-180-async-flip
[231.368933] Subtest x-tiled-max-hw-stride-64bpp-rotate-180-async-flip: SUCCESS (0.815s)
[231.539038] [038/133] (788s left) kms_getfb (getfb-addfb-different-handles)
[231.635311] Starting subtest: getfb-addfb-different-handles
[231.636262] Subtest getfb-addfb-different-handles: SUCCESS (0.000s)
[231.725998] [039/133] (788s left) kms_plane_scaling (planes-upscale-factor-0-25)
[231.815272] Starting subtest: planes-upscale-factor-0-25
[231.816102] Starting dynamic subtest: pipe-A
[231.876954] Dynamic subtest pipe-A: SUCCESS (0.062s)
[231.885849] Starting dynamic subtest: pipe-B
[233.012346] Dynamic subtest pipe-B: SUCCESS (1.134s)
[233.021979] Starting dynamic subtest: pipe-C
[234.131496] Dynamic subtest pipe-C: SUCCESS (1.117s)
[234.140758] Starting dynamic subtest: pipe-D
[235.244953] Dynamic subtest pipe-D: SUCCESS (1.113s)
[235.245906] Subtest planes-upscale-factor-0-25: SUCCESS (3.431s)
[236.394893] [040/133] (784s left) kms_lease (lease-get)
[236.486333] Starting subtest: lease-get
[236.487223] Starting dynamic subtest: pipe-A-eDP-1
[236.488195] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[236.498826] Starting dynamic subtest: pipe-B-eDP-1
[236.499848] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[236.510873] Starting dynamic subtest: pipe-C-eDP-1
[236.511897] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[236.522627] Starting dynamic subtest: pipe-D-eDP-1
[236.523498] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[236.524358] Subtest lease-get: SUCCESS (0.009s)
[236.608087] [041/133] (783s left) kms_addfb_basic (size-max)
[236.691419] Starting subtest: size-max
[236.692357] Subtest size-max: SUCCESS (0.000s)
[236.776493] [042/133] (783s left) gem_exec_schedule (u-semaphore-user)
[236.832058] Starting subtest: u-semaphore-user
[236.889361] Subtest u-semaphore-user: SUCCESS (0.058s)
[237.947142] [043/133] (782s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-mmap-wc)
[238.041960] Starting subtest: fbc-rgb101010-draw-mmap-wc
[242.589674] Subtest fbc-rgb101010-draw-mmap-wc: SUCCESS (4.550s)
[243.704177] [044/133] (776s left) kms_flip_scaled_crc (flip-64bpp-yftile-to-16bpp-yftile-downscaling)
[243.791281] Starting subtest: flip-64bpp-yftile-to-16bpp-yftile-downscaling
[243.793172] Subtest flip-64bpp-yftile-to-16bpp-yftile-downscaling: SKIP (0.000s)
[243.859983] [045/133] (776s left) perf (blocking-parameterized)
[244.008813] Starting subtest: blocking-parameterized
[264.077455] Subtest blocking-parameterized: SUCCESS (20.022s)
[264.108432] [046/133] (756s left) gem_lmem_swapping (parallel-random-verify)
[264.145053] Subtest parallel-random-verify: SKIP (0.000s)
[264.181660] [047/133] (756s left) gem_create (hog-create)
[264.250727] Starting subtest: hog-create
[264.251645] Starting dynamic subtest: smem0
[296.932559] Dynamic subtest smem0: SUCCESS (32.668s)
[296.933906] Subtest hog-create: SUCCESS (32.670s)
[297.109577] [048/133] (723s left) api_intel_bb (intel-bb-blit-x)
[297.159493] Starting subtest: intel-bb-blit-x
[300.820673] Subtest intel-bb-blit-x: SUCCESS (3.652s)
[300.915491] [049/133] (719s left) kms_pipe_crc_basic (suspend-read-crc)
[301.008179] Starting subtest: suspend-read-crc
[301.009199] Starting dynamic subtest: pipe-A-eDP-1
[319.109705] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.104s)
[319.117679] Starting dynamic subtest: pipe-B-eDP-1
[338.100137] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.500s)
[338.108311] Starting dynamic subtest: pipe-C-eDP-1
[357.060938] Dynamic subtest pipe-C-eDP-1: SUCCESS (3.343s)
[357.070337] Starting dynamic subtest: pipe-D-eDP-1
[376.039759] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.399s)
[376.040788] Subtest suspend-read-crc: SUCCESS (13.352s)
[381.921629] [050/133] (643s left) gem_exec_whisper (basic-fds-priority-all)
[381.992815] Starting subtest: basic-fds-priority-all
[405.556775] Subtest basic-fds-priority-all: SUCCESS (23.544s)
[405.738616] [051/133] (620s left) gem_exec_balancer (full)
[405.806068] Starting subtest: full
[410.511962] Subtest full: SUCCESS (4.706s)
[410.822842] [052/133] (615s left) kms_dp_link_training (uhbr-sst)
[410.935252] Starting subtest: uhbr-sst
[410.938539] Subtest uhbr-sst: SKIP (0.000s)
[411.004685] [053/133] (614s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-fullscreen)
[411.088333] Starting subtest: psr-2p-primscrn-spr-indfb-fullscreen
[411.089942] Subtest psr-2p-primscrn-spr-indfb-fullscreen: SKIP (0.000s)
[411.191900] [054/133] (614s left) kms_ccs (crc-primary-basic-4-tiled-bmg-ccs)
[411.287217] Starting subtest: crc-primary-basic-4-tiled-bmg-ccs
[411.288856] Subtest crc-primary-basic-4-tiled-bmg-ccs: SKIP (0.000s)
[412.409410] [055/133] (613s left) gem_exec_flush (basic-wb-pro-default)
[412.470847] Starting subtest: basic-wb-pro-default
[417.932778] Subtest basic-wb-pro-default: SUCCESS (5.462s)
[418.118158] [056/133] (607s left) kms_cursor_legacy (flip-vs-cursor-toggle)
[418.231587] Starting subtest: flip-vs-cursor-toggle
[426.991281] Subtest flip-vs-cursor-toggle: SUCCESS (8.758s)
[427.836666] [057/133] (598s left) kms_psr (fbc-pr-cursor-mmap-cpu)
[427.924417] Starting subtest: fbc-pr-cursor-mmap-cpu
[427.926062] Subtest fbc-pr-cursor-mmap-cpu: SKIP (0.000s)
[427.989637] [058/133] (598s left) drm_read (empty-block)
[428.133585] Starting subtest: empty-block
[429.133990] Subtest empty-block: SUCCESS (1.001s)
[429.260345] [059/133] (596s left) kms_psr (fbc-pr-sprite-mmap-gtt)
[429.341432] Starting subtest: fbc-pr-sprite-mmap-gtt
[429.343465] Subtest fbc-pr-sprite-mmap-gtt: SKIP (0.000s)
[429.419186] [060/133] (596s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-shrfb-draw-mmap-wc)
[429.512559] Starting subtest: fbc-1p-offscreen-pri-shrfb-draw-mmap-wc
[433.640326] Subtest fbc-1p-offscreen-pri-shrfb-draw-mmap-wc: SUCCESS (4.127s)
[434.834310] [061/133] (591s left) vgem_basic (bad-handle)
[434.993106] Starting subtest: bad-handle
[434.993990] Subtest bad-handle: SUCCESS (0.000s)
[435.045060] [FACT vgem_basic (bad-handle)] new: kernel.kmod_is_loaded.vgem: true
[435.046854] [062/133] (591s left) gem_exec_params (mmapped)
[435.104967] Starting subtest: mmapped
[435.107100] Subtest mmapped: SUCCESS (0.003s)
[435.218940] [063/133] (590s left) kms_pm_dc (dc6-psr)
[436.317848] Starting subtest: dc6-psr
[439.212878] Subtest dc6-psr: SUCCESS (2.894s)
[440.056810] [064/133] (586s left) kms_addfb_basic (framebuffer-vs-set-tiling)
[440.102006] Starting subtest: framebuffer-vs-set-tiling
[440.103827] Subtest framebuffer-vs-set-tiling: SKIP (0.000s)
[440.230695] [065/133] (586s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-indfb-pgflip-blt)
[440.330024] Starting subtest: fbcpsr-2p-scndscrn-indfb-pgflip-blt
[440.331639] Subtest fbcpsr-2p-scndscrn-indfb-pgflip-blt: SKIP (0.000s)
[440.430415] [066/133] (585s left) gem_softpin (evict-prime-sanity-check)
[440.477312] Starting subtest: evict-prime-sanity-check
[440.478372] Starting dynamic subtest: rcs0
[441.627471] Dynamic subtest rcs0: SUCCESS (1.151s)
[441.639232] Starting dynamic subtest: bcs0
[442.744864] Dynamic subtest bcs0: SUCCESS (1.116s)
[442.756338] Starting dynamic subtest: vcs0
[444.598927] Dynamic subtest vcs0: SUCCESS (1.844s)
[444.607629] Starting dynamic subtest: vcs1
[446.520777] Dynamic subtest vcs1: SUCCESS (1.919s)
[446.530062] Starting dynamic subtest: vecs0
[448.585494] Dynamic subtest vecs0: SUCCESS (2.062s)
[448.595490] Starting dynamic subtest: ccs0
[449.697698] Dynamic subtest ccs0: SUCCESS (1.119s)
[449.710008] Starting dynamic subtest: all
[450.814346] Dynamic subtest all: SUCCESS (1.115s)
[450.816680] Subtest evict-prime-sanity-check: SUCCESS (10.339s)
[450.903618] [067/133] (575s left) kms_cursor_legacy (torture-move)
[451.025586] Starting subtest: torture-move
[451.026729] Starting dynamic subtest: pipe-A
[456.930440] Dynamic subtest pipe-A: SUCCESS (5.894s)
[456.942394] Starting dynamic subtest: pipe-B
[464.392150] Dynamic subtest pipe-B: SUCCESS (7.468s)
[464.401720] Starting dynamic subtest: pipe-C
[471.199347] Dynamic subtest pipe-C: SUCCESS (6.804s)
[471.208690] Starting dynamic subtest: pipe-D
[477.884711] Dynamic subtest pipe-D: SUCCESS (6.683s)
[477.893652] Starting dynamic subtest: all-pipes
[484.963255] Dynamic subtest all-pipes: SUCCESS (7.068s)
[484.964436] Subtest torture-move: SUCCESS (33.927s)
[485.112127] [068/133] (541s left) kms_flip (plain-flip-fb-recreate-interruptible)
[485.207193] Starting subtest: plain-flip-fb-recreate-interruptible
[485.209798] Starting dynamic subtest: A-eDP1
[494.049393] Dynamic subtest A-eDP1: SUCCESS (8.840s)
[494.060214] Starting dynamic subtest: B-eDP1
[502.876196] Dynamic subtest B-eDP1: SUCCESS (8.824s)
[502.886712] Starting dynamic subtest: C-eDP1
[511.696716] Dynamic subtest C-eDP1: SUCCESS (8.818s)
[511.704924] Starting dynamic subtest: D-eDP1
[520.524008] Dynamic subtest D-eDP1: SUCCESS (8.826s)
[520.527005] Subtest plain-flip-fb-recreate-interruptible: SUCCESS (35.319s)
[521.697580] [069/133] (504s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-mmap-cpu)
[521.785417] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-mmap-cpu
[521.787132] Subtest psr-2p-scndscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[521.880757] [070/133] (504s left) perf_pmu (all-busy-check-all)
[521.921674] Starting subtest: all-busy-check-all
[523.537454] Subtest all-busy-check-all: SUCCESS (1.606s)
[523.622904] [071/133] (502s left) kms_plane (pixel-format-4-tiled-mtl-mc-ccs-modifier)
[523.716234] Starting subtest: pixel-format-4-tiled-mtl-mc-ccs-modifier
[523.744359] Starting dynamic subtest: pipe-A-plane-0
[524.166452] Dynamic subtest pipe-A-plane-0: SUCCESS (0.422s)
[524.175858] Starting dynamic subtest: pipe-A-plane-3
[524.422297] Dynamic subtest pipe-A-plane-3: SUCCESS (0.253s)
[524.432358] Starting dynamic subtest: pipe-A-plane-5
[524.434056] Dynamic subtest pipe-A-plane-5: SKIP (0.000s)
[525.494675] Starting dynamic subtest: pipe-B-plane-0
[525.920308] Dynamic subtest pipe-B-plane-0: SUCCESS (0.433s)
[525.929971] Starting dynamic subtest: pipe-B-plane-3
[526.176245] Dynamic subtest pipe-B-plane-3: SUCCESS (0.253s)
[526.189848] Starting dynamic subtest: pipe-B-plane-5
[526.191581] Dynamic subtest pipe-B-plane-5: SKIP (0.000s)
[526.498333] Subtest pixel-format-4-tiled-mtl-mc-ccs-modifier: SUCCESS (2.782s)
[527.375941] [072/133] (499s left) gem_ctx_param (invalid-get-ringsize)
[527.429488] Starting subtest: invalid-get-ringsize
[527.430610] Subtest invalid-get-ringsize: SUCCESS (0.001s)
[527.534354] [073/133] (499s left) gem_eio (in-flight-contexts-1us)
[527.762375] Starting subtest: in-flight-contexts-1us
[541.587626] Subtest in-flight-contexts-1us: SUCCESS (13.825s)
[541.755120] [074/133] (484s left) kms_frontbuffer_tracking (fbc-1p-rte)
[541.846706] Starting subtest: fbc-1p-rte
[547.365514] Subtest fbc-1p-rte: SUCCESS (5.519s)
[548.521483] [075/133] (478s left) gem_pxp (reject-modify-context-protection-off-2)
[548.639274] Starting subtest: reject-modify-context-protection-off-2
[548.640296] Subtest reject-modify-context-protection-off-2: SUCCESS (0.001s)
[548.756240] [076/133] (477s left) drm_read (short-buffer-block)
[548.891596] Starting subtest: short-buffer-block
[548.892824] Subtest short-buffer-block: SUCCESS (0.000s)
[549.001585] [077/133] (477s left) kms_ccs (random-ccs-data-4-tiled-dg2-rc-ccs)
[549.094026] Starting subtest: random-ccs-data-4-tiled-dg2-rc-ccs
[549.094866] Starting dynamic subtest: pipe-A-eDP-1
[549.104250] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[549.112883] Starting dynamic subtest: pipe-B-eDP-1
[549.124843] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[549.133675] Starting dynamic subtest: pipe-C-eDP-1
[549.142819] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[549.151176] Starting dynamic subtest: pipe-D-eDP-1
[549.160683] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[549.162408] Subtest random-ccs-data-4-tiled-dg2-rc-ccs: SKIP (0.005s)
[551.368434] [078/133] (475s left) kms_plane_scaling (plane-downscale-factor-0-75-with-modifiers)
[551.454385] Starting subtest: plane-downscale-factor-0-75-with-modifiers
[551.455288] Starting dynamic subtest: pipe-A
[551.838632] Dynamic subtest pipe-A: SUCCESS (0.382s)
[551.848080] Starting dynamic subtest: pipe-B
[553.266594] Dynamic subtest pipe-B: SUCCESS (1.428s)
[553.275507] Starting dynamic subtest: pipe-C
[554.729813] Dynamic subtest pipe-C: SUCCESS (1.462s)
[554.738663] Starting dynamic subtest: pipe-D
[556.123104] Dynamic subtest pipe-D: SUCCESS (1.392s)
[556.125183] Subtest plane-downscale-factor-0-75-with-modifiers: SUCCESS (4.671s)
[557.278142] [079/133] (469s left) kms_plane (pixel-format-4-tiled-dg2-rc-ccs-cc-modifier)
[557.367931] Starting subtest: pixel-format-4-tiled-dg2-rc-ccs-cc-modifier
[557.369458] Subtest pixel-format-4-tiled-dg2-rc-ccs-cc-modifier: SKIP (0.000s)
[557.444321] [080/133] (469s left) gem_exec_alignment (pi)
[557.496623] Starting subtest: pi
[613.169009] Subtest pi: SUCCESS (55.667s)
[614.233558] [081/133] (412s left) kms_cursor_crc (cursor-onscreen-256x256)
[614.538911] Starting subtest: cursor-onscreen-256x256
[614.542142] Starting dynamic subtest: pipe-A-eDP-1
[616.733705] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.191s)
[616.764826] Starting dynamic subtest: pipe-D-eDP-1
[619.650661] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.893s)
[619.651545] Subtest cursor-onscreen-256x256: SUCCESS (5.112s)
[620.473373] [082/133] (406s left) syncobj_wait (single-wait-for-submit-signaled)
[620.532318] Starting subtest: single-wait-for-submit-signaled
[620.533369] Subtest single-wait-for-submit-signaled: SUCCESS (0.000s)
[620.603194] [083/133] (406s left) kms_psr (psr2-sprite-blt)
[620.692312] Starting subtest: psr2-sprite-blt
[620.693415] Starting dynamic subtest: eDP-1
[622.445094] Dynamic subtest eDP-1: SUCCESS (1.752s)
[622.446048] Subtest psr2-sprite-blt: SUCCESS (1.753s)
[623.331382] [084/133] (403s left) syncobj_timeline (multi-wait-all-available-submitted)
[623.379605] Starting subtest: multi-wait-all-available-submitted
[623.380526] Subtest multi-wait-all-available-submitted: SUCCESS (0.000s)
[623.467407] [085/133] (403s left) gen3_render_tiledx_blits
[623.581775] [086/133] (403s left) kms_cursor_crc (cursor-rapid-movement-256x256)
[623.820890] Starting subtest: cursor-rapid-movement-256x256
[623.823667] Starting dynamic subtest: pipe-A-eDP-1
[624.385192] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.563s)
[624.416708] Starting dynamic subtest: pipe-D-eDP-1
[625.659851] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.251s)
[625.660731] Subtest cursor-rapid-movement-256x256: SUCCESS (1.841s)
[626.490714] [087/133] (400s left) kms_psr (pr-primary-blt)
[626.596217] Starting subtest: pr-primary-blt
[626.597919] Subtest pr-primary-blt: SKIP (0.000s)
[626.668860] [088/133] (400s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-render)
[626.768464] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-render
[626.770053] Subtest fbc-2p-scndscrn-pri-indfb-draw-render: SKIP (0.000s)
[626.862815] [089/133] (400s left) gem_userptr_blits (coherency-sync)
[626.931712] Starting subtest: coherency-sync
[627.078772] Subtest coherency-sync: SKIP (0.129s)
[627.185561] [090/133] (400s left) kms_chamelium_frames (dp-frame-dump)
[627.602100] Subtest dp-frame-dump: SKIP (0.000s)
[628.392720] [091/133] (398s left) i915_selftest (live)
[631.768223] Starting subtest: live
[631.769768] Starting dynamic subtest: sanitycheck
[634.553283] Dynamic subtest sanitycheck: SUCCESS (2.776s)
[634.562998] Starting dynamic subtest: uncore
[638.877995] Dynamic subtest uncore: SUCCESS (4.323s)
[638.887373] Starting dynamic subtest: workarounds
[642.019827] Dynamic subtest workarounds: SUCCESS (3.139s)
[642.029401] Starting dynamic subtest: gt_engines
[645.055440] Dynamic subtest gt_engines: SUCCESS (3.036s)
[645.066892] Starting dynamic subtest: gt_timelines
[660.797009] Dynamic subtest gt_timelines: SUCCESS (15.739s)
[660.806671] Starting dynamic subtest: gt_contexts
[663.538919] Dynamic subtest gt_contexts: SUCCESS (2.740s)
[663.548232] Starting dynamic subtest: gt_lrc
[669.644431] Dynamic subtest gt_lrc: SUCCESS (6.104s)
[669.653971] Starting dynamic subtest: gt_mocs
[674.045628] Dynamic subtest gt_mocs: SUCCESS (4.400s)
[674.054921] Starting dynamic subtest: gt_pm
[680.818822] Dynamic subtest gt_pm: SUCCESS (6.771s)
[680.827871] Starting dynamic subtest: gt_heartbeat
[683.549713] Dynamic subtest gt_heartbeat: SUCCESS (2.729s)
[683.558480] Starting dynamic subtest: gt_tlb
[692.927549] Dynamic subtest gt_tlb: SUCCESS (9.377s)
[692.938089] Starting dynamic subtest: requests
[704.537985] Dynamic subtest requests: SUCCESS (11.608s)
[704.547690] Starting dynamic subtest: migrate
[712.278223] Dynamic subtest migrate: SUCCESS (7.738s)
[712.286214] Starting dynamic subtest: active
[715.021963] Dynamic subtest active: SUCCESS (2.741s)
[715.031465] Starting dynamic subtest: objects
[719.912672] Dynamic subtest objects: SUCCESS (4.888s)
[719.922459] Starting dynamic subtest: mman
[723.424362] Dynamic subtest mman: SUCCESS (3.510s)
[723.433991] Starting dynamic subtest: dmabuf
[727.798784] Dynamic subtest dmabuf: SUCCESS (4.371s)
[727.807856] Starting dynamic subtest: vma
[732.154248] Dynamic subtest vma: SUCCESS (4.355s)
[732.162474] Starting dynamic subtest: coherency
[735.691352] Dynamic subtest coherency: SUCCESS (3.533s)
[735.701199] Starting dynamic subtest: gtt
[747.685421] Dynamic subtest gtt: SUCCESS (11.992s)
[747.695002] Starting dynamic subtest: gem
[755.740618] Dynamic subtest gem: SUCCESS (8.053s)
[755.749736] Starting dynamic subtest: evict
[761.272497] Dynamic subtest evict: SUCCESS (5.529s)
[761.282139] Starting dynamic subtest: hugepages
[770.052258] Dynamic subtest hugepages: SUCCESS (8.778s)
[770.061666] Starting dynamic subtest: gem_contexts
[796.754735] Dynamic subtest gem_contexts: SUCCESS (26.699s)
[796.770577] Starting dynamic subtest: client
[801.177833] Dynamic subtest client: SUCCESS (4.421s)
[801.186918] Starting dynamic subtest: gem_migrate
[805.464771] Dynamic subtest gem_migrate: SUCCESS (4.285s)
[805.474100] Starting dynamic subtest: reset
[808.290028] Dynamic subtest reset: SUCCESS (2.823s)
[808.300091] Starting dynamic subtest: memory_region
[811.021435] Dynamic subtest memory_region: SUCCESS (2.730s)
[811.029476] Starting dynamic subtest: hangcheck
[824.016475] Dynamic subtest hangcheck: SUCCESS (12.991s)
[824.025707] Starting dynamic subtest: execlists
[828.365837] Dynamic subtest execlists: SUCCESS (4.354s)
[828.375249] Starting dynamic subtest: ring_submission
[832.712891] Dynamic subtest ring_submission: SUCCESS (4.340s)
[832.722163] Starting dynamic subtest: perf
[837.023909] Dynamic subtest perf: SUCCESS (4.308s)
[837.033485] Starting dynamic subtest: slpc
[851.161270] Dynamic subtest slpc: SUCCESS (14.134s)
[851.168835] Starting dynamic subtest: guc
[855.158389] Dynamic subtest guc: SUCCESS (3.994s)
[855.167930] Starting dynamic subtest: guc_multi_lrc
[859.490541] Dynamic subtest guc_multi_lrc: SUCCESS (4.330s)
[859.500132] Starting dynamic subtest: guc_hang
[864.409512] Dynamic subtest guc_hang: SUCCESS (4.916s)
[864.419380] Starting dynamic subtest: late_gt_pm
[868.754402] Dynamic subtest late_gt_pm: SUCCESS (4.344s)
[868.755626] Subtest live: SUCCESS (236.964s)
[868.777783] [FACT i915_selftest (live)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[868.778487] [FACT i915_selftest (live)] deleted: kernel.kmod_is_loaded.i915: true
[868.780100] [092/133] (158s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-mmap-wc)
[870.416808] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-mmap-wc
[870.418486] Subtest fbc-2p-primscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[870.507053] [FACT kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-mmap-wc)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[870.508289] [FACT kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-mmap-wc)] new: kernel.kmod_is_loaded.i915: true
[870.512310] [093/133] (156s left) kms_ccs (bad-aux-stride-4-tiled-mtl-mc-ccs)
[870.592302] Starting subtest: bad-aux-stride-4-tiled-mtl-mc-ccs
[870.593220] Starting dynamic subtest: pipe-A-eDP-1
[870.669556] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.077s)
[870.678632] Starting dynamic subtest: pipe-B-eDP-1
[870.739674] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.069s)
[870.748632] Starting dynamic subtest: pipe-C-eDP-1
[870.802759] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.062s)
[870.811461] Starting dynamic subtest: pipe-D-eDP-1
[870.867795] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.064s)
[870.868660] Subtest bad-aux-stride-4-tiled-mtl-mc-ccs: SUCCESS (0.277s)
[873.182606] [094/133] (154s left) perf (polling)
[873.324778] Starting subtest: polling
[873.325619] Starting dynamic subtest: 0-rcs0
[883.380603] Dynamic subtest 0-rcs0: SUCCESS (10.011s)
[883.390782] Starting dynamic subtest: 1-vecs0
[893.401553] Dynamic subtest 1-vecs0: SUCCESS (10.019s)
[893.402998] Subtest polling: SUCCESS (20.033s)
[893.437517] [095/133] (133s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-mmap-wc)
[893.537000] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-mmap-wc
[897.119087] Subtest fbc-1p-primscrn-spr-indfb-draw-mmap-wc: SUCCESS (3.582s)
[898.303237] [096/133] (129s left) syncobj_timeline (invalid-multi-wait-all-unsubmitted-submitted)
[898.360301] Starting subtest: invalid-multi-wait-all-unsubmitted-submitted
[898.361410] Subtest invalid-multi-wait-all-unsubmitted-submitted: SUCCESS (0.000s)
[898.465136] [097/133] (128s left) kms_prime (basic-crc-hybrid)
[898.543879] Subtest basic-crc-hybrid: SKIP (0.000s)
[898.651215] [098/133] (128s left) kms_cursor_legacy (cursorb-vs-flipb-atomic-transitions-varying-size)
[898.765133] Starting subtest: cursorB-vs-flipB-atomic-transitions-varying-size
[898.766801] Subtest cursorB-vs-flipB-atomic-transitions-varying-size: SKIP (0.001s)
[898.905007] [099/133] (128s left) kms_big_fb (x-tiled-8bpp-rotate-90)
[899.000464] Starting subtest: x-tiled-8bpp-rotate-90
[899.025834] Subtest x-tiled-8bpp-rotate-90: SKIP (0.025s)
[899.124123] [100/133] (128s left) gen9_exec_parse (unaligned-jump)
[899.183755] Subtest unaligned-jump: SKIP (0.000s)
[899.255612] [101/133] (128s left) perf_pmu (semaphore-wait)
[899.290444] Starting subtest: semaphore-wait
[899.291437] Starting dynamic subtest: rcs0
[899.814827] Dynamic subtest rcs0: SUCCESS (0.515s)
[899.825232] Starting dynamic subtest: bcs0
[900.328499] Dynamic subtest bcs0: SUCCESS (0.510s)
[900.338445] Starting dynamic subtest: vcs0
[900.841817] Dynamic subtest vcs0: SUCCESS (0.510s)
[900.851519] Starting dynamic subtest: vcs1
[901.354981] Dynamic subtest vcs1: SUCCESS (0.510s)
[901.365304] Starting dynamic subtest: vecs0
[901.868001] Dynamic subtest vecs0: SUCCESS (0.510s)
[901.878196] Starting dynamic subtest: ccs0
[902.383397] Dynamic subtest ccs0: SUCCESS (0.512s)
[902.384620] Subtest semaphore-wait: SUCCESS (3.086s)
[903.646370] [102/133] (123s left) syncobj_wait (invalid-reset-one-illegal-handle)
[903.703863] Starting subtest: invalid-reset-one-illegal-handle
[903.704939] Subtest invalid-reset-one-illegal-handle: SUCCESS (0.000s)
[903.803038] [103/133] (123s left) gem_render_copy (yf-tiled-to-vebox-yf-tiled)
[903.854159] Starting subtest: yf-tiled-to-vebox-yf-tiled
[903.856051] Subtest yf-tiled-to-vebox-yf-tiled: SKIP (0.000s)
[904.052016] [104/133] (123s left) kms_flip (single-buffer-flip-vs-dpms-off-vs-modeset-interruptible)
[904.148305] Starting subtest: single-buffer-flip-vs-dpms-off-vs-modeset-interruptible
[904.150608] Starting dynamic subtest: A-eDP1
[907.730703] Dynamic subtest A-eDP1: SUCCESS (3.578s)
[907.739044] Starting dynamic subtest: B-eDP1
[910.935659] Dynamic subtest B-eDP1: SUCCESS (3.205s)
[910.944050] Starting dynamic subtest: C-eDP1
[914.050875] Dynamic subtest C-eDP1: SUCCESS (3.114s)
[914.059010] Starting dynamic subtest: D-eDP1
[917.165262] Dynamic subtest D-eDP1: SUCCESS (3.113s)
[917.167070] Subtest single-buffer-flip-vs-dpms-off-vs-modeset-interruptible: SUCCESS (13.018s)
[917.959432] [105/133] (109s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-render)
[918.048243] Starting subtest: fbcpsr-rgb101010-draw-render
[924.859896] Subtest fbcpsr-rgb101010-draw-render: SUCCESS (6.812s)
[925.001594] [106/133] (102s left) i915_drm_fdinfo (virtual-busy-idle-all)
[925.036202] Starting subtest: virtual-busy-idle-all
[925.038174] Subtest virtual-busy-idle-all: SKIP (0.000s)
[925.113418] [107/133] (102s left) kms_pipe_b_c_ivb (pipe-b-dpms-off-modeset-pipe-c)
[925.170689] Subtest pipe-B-dpms-off-modeset-pipe-C: SKIP (0.000s)
[925.235722] [108/133] (102s left) kms_psr (fbc-psr-dpms)
[925.328166] Starting subtest: fbc-psr-dpms
[925.328988] Starting dynamic subtest: eDP-1
[925.330691] Dynamic subtest eDP-1: SKIP (0.000s)
[925.332640] Subtest fbc-psr-dpms: SKIP (0.001s)
[925.397512] [109/133] (102s left) gem_render_linear_blits (basic)
[925.456054] Starting subtest: basic
[925.476876] Subtest basic: SUCCESS (0.022s)
[925.554462] [110/133] (102s left) kms_frontbuffer_tracking (psr-rgb101010-draw-pwrite)
[925.648393] Starting subtest: psr-rgb101010-draw-pwrite
[933.434967] Subtest psr-rgb101010-draw-pwrite: SUCCESS (7.787s)
[933.575314] [111/133] ( 94s left) intel_hwmon (hwmon-read)
[933.631363] Subtest hwmon-read: SKIP (0.000s)
[933.686969] [112/133] ( 94s left) kms_psr2_sf (psr2-cursor-plane-move-continuous-exceed-fully-sf)
[933.778106] Starting subtest: psr2-cursor-plane-move-continuous-exceed-fully-sf
[933.778964] Starting dynamic subtest: pipe-A-eDP-1
[944.780019] Dynamic subtest pipe-A-eDP-1: SUCCESS (11.002s)
[944.789086] Starting dynamic subtest: pipe-B-eDP-1
[956.464294] Dynamic subtest pipe-B-eDP-1: SUCCESS (11.682s)
[956.465067] Subtest psr2-cursor-plane-move-continuous-exceed-fully-sf: SUCCESS (22.688s)
[957.306547] [113/133] ( 70s left) kms_frontbuffer_tracking (psr-1p-primscrn-shrfb-plflip-blt)
[957.409494] Starting subtest: psr-1p-primscrn-shrfb-plflip-blt
[965.049336] Subtest psr-1p-primscrn-shrfb-plflip-blt: SUCCESS (7.640s)
[965.170528] [114/133] ( 62s left) gem_ctx_persistence (processes)
[965.228072] Starting subtest: processes
[966.543103] Subtest processes: SUCCESS (1.315s)
[966.629387] [115/133] ( 61s left) gem_exec_reloc (basic-gtt)
[966.688046] Subtest basic-gtt: SKIP (0.000s)
[966.754664] [116/133] ( 61s left) syncobj_eventfd (invalid-bad-flags)
[966.802313] Starting subtest: invalid-bad-flags
[966.803278] Subtest invalid-bad-flags: SUCCESS (0.000s)
[966.897512] [117/133] ( 61s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-render)
[966.983440] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-render
[966.985104] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-render: SKIP (0.000s)
[967.078652] [118/133] ( 61s left) kms_atomic (crtc-invalid-params-fence)
[967.175298] Starting subtest: crtc-invalid-params-fence
[967.176227] Starting dynamic subtest: pipe-A-eDP-1
[967.608969] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.427s)
[967.609848] Subtest crtc-invalid-params-fence: SUCCESS (0.429s)
[968.455857] [119/133] ( 59s left) dumb_buffer (map-valid)
[968.516833] Starting subtest: map-valid
[968.517822] Subtest map-valid: SUCCESS (0.000s)
[968.614183] [120/133] ( 59s left) gem_exec_reloc (basic-wc-read-active)
[968.664013] Subtest basic-wc-read-active: SKIP (0.000s)
[968.734877] [121/133] ( 59s left) kms_frontbuffer_tracking (psr-1p-pri-indfb-multidraw)
[968.818216] Starting subtest: psr-1p-pri-indfb-multidraw
[992.270399] Subtest psr-1p-pri-indfb-multidraw: SUCCESS (23.451s)
[992.392388] [122/133] ( 35s left) kms_color_pipeline (plane-ctm3x4)
[992.487291] Starting subtest: plane-ctm3x4
[992.656813] Starting dynamic subtest: pipe-A-plane-0
[992.869720] Dynamic subtest pipe-A-plane-0: FAIL (0.151s)
[992.879285] Starting dynamic subtest: pipe-A-plane-1
[993.033872] Dynamic subtest pipe-A-plane-1: FAIL (0.152s)
[993.043163] Starting dynamic subtest: pipe-A-plane-2
[993.196651] Dynamic subtest pipe-A-plane-2: FAIL (0.148s)
[994.322811] Starting dynamic subtest: pipe-B-plane-0
[994.571087] Dynamic subtest pipe-B-plane-0: FAIL (0.163s)
[994.581069] Starting dynamic subtest: pipe-B-plane-1
[994.740929] Dynamic subtest pipe-B-plane-1: FAIL (0.157s)
[994.750532] Starting dynamic subtest: pipe-B-plane-2
[994.907983] Dynamic subtest pipe-B-plane-2: FAIL (0.153s)
[996.059861] Starting dynamic subtest: pipe-C-plane-0
[996.307942] Dynamic subtest pipe-C-plane-0: FAIL (0.118s)
[996.317767] Starting dynamic subtest: pipe-C-plane-1
[996.447716] Dynamic subtest pipe-C-plane-1: FAIL (0.110s)
[996.456433] Starting dynamic subtest: pipe-C-plane-2
[996.593794] Dynamic subtest pipe-C-plane-2: FAIL (0.110s)
[997.565860] Starting dynamic subtest: pipe-D-plane-0
[997.823485] Dynamic subtest pipe-D-plane-0: FAIL (0.107s)
[997.833419] Starting dynamic subtest: pipe-D-plane-1
[997.999403] Dynamic subtest pipe-D-plane-1: FAIL (0.155s)
[998.008534] Starting dynamic subtest: pipe-D-plane-2
[998.192305] Dynamic subtest pipe-D-plane-2: FAIL (0.144s)
[998.252272] Subtest plane-ctm3x4: FAIL (5.766s)
[999.132215] [123/133] ( 29s left) kms_psr2_sf (fbc-pr-cursor-plane-move-continuous-exceed-fully-sf)
[999.228810] Starting subtest: fbc-pr-cursor-plane-move-continuous-exceed-fully-sf
[999.230632] Subtest fbc-pr-cursor-plane-move-continuous-exceed-fully-sf: SKIP (0.000s)
[999.295394] [124/133] ( 29s left) gem_exec_big (single)
[999.345606] Starting subtest: single
[1002.932520] Subtest single: FAIL (3.564s)
[1002.991242] [125/133] ( 25s left) kms_flip_scaled_crc (flip-32bpp-xtile-to-64bpp-xtile-upscaling)
[1003.120153] Starting subtest: flip-32bpp-xtile-to-64bpp-xtile-upscaling
[1003.120984] Starting dynamic subtest: pipe-A-default-mode
[1005.891243] Dynamic subtest pipe-A-default-mode: SUCCESS (2.770s)
[1005.892076] Subtest flip-32bpp-xtile-to-64bpp-xtile-upscaling: SUCCESS (2.772s)
[1006.718310] [126/133] ( 21s left) kms_frontbuffer_tracking (fbcpsr-farfromfence-mmap-gtt)
[1006.815700] Starting subtest: fbcpsr-farfromfence-mmap-gtt
[1006.817552] Subtest fbcpsr-farfromfence-mmap-gtt: SKIP (0.000s)
[1006.913467] [127/133] ( 21s left) gem_exec_fence (syncobj-channel)
[1007.363982] Starting subtest: syncobj-channel
[1008.389523] Subtest syncobj-channel: SUCCESS (1.015s)
[1008.684623] [128/133] ( 19s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip)
[1008.785752] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip
[1008.787776] Subtest yf-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip: SKIP (0.000s)
[1008.871690] [129/133] ( 19s left) gem_pwrite (basic-random)
[1008.931986] Subtest basic-random: SKIP (0.000s)
[1008.997753] [130/133] ( 19s left) syncobj_wait (reset-unsignaled)
[1009.051213] Starting subtest: reset-unsignaled
[1009.052216] Subtest reset-unsignaled: SUCCESS (0.000s)
[1009.161978] [131/133] ( 19s left) api_intel_allocator (reloc-allocator)
[1009.219249] Starting subtest: reloc-allocator
[1009.220132] Starting dynamic subtest: basic
[1009.222700] Dynamic subtest basic: SUCCESS (0.003s)
[1009.232766] Starting dynamic subtest: parallel-one
[1009.233733] Dynamic subtest parallel-one: SUCCESS (0.007s)
[1009.242592] Starting dynamic subtest: print
[1009.243591] Dynamic subtest print: SUCCESS (0.000s)
[1009.255074] Starting dynamic subtest: reuse
[1009.255822] Dynamic subtest reuse: SUCCESS (0.000s)
[1009.264140] Starting dynamic subtest: fork-reopen-allocator
[1009.264962] Dynamic subtest fork-reopen-allocator: SUCCESS (0.012s)
[1009.265716] Subtest reloc-allocator: SUCCESS (0.026s)
[1009.382893] [132/133] ( 19s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-180)
[1009.474752] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-180
[1010.519830] Subtest 4-tiled-max-hw-stride-64bpp-rotate-180: SUCCESS (1.045s)
[1010.644864] [133/133] ( 18s left) gen9_exec_parse (allowed-single)
[1010.709989] Subtest allowed-single: SKIP (0.000s)
[1010.790043] Closing watchdogs
results: parsing output: 0/ for test: kms_psr
results: parsing output: 1/ for test: kms_addfb_basic
results: parsing output: 2/ for test: kms_chamelium_audio
results: parsing output: 3/ for test: gem_lmem_swapping
results: parsing output: 4/ for test: kms_sequence
results: parsing output: 5/ for test: gem_mmap_offset
results: parsing output: 6/ for test: gem_mmap
results: parsing output: 7/ for test: kms_ccs
results: parsing output: 8/ for test: gem_ctx_bad_destroy
results: parsing output: 9/ for test: kms_frontbuffer_tracking
results: parsing output: 10/ for test: kms_flip
results: parsing output: 11/ for test: kms_vblank
results: parsing output: 12/ for test: kms_big_fb
results: parsing output: 13/ for test: syncobj_wait
results: parsing output: 14/ for test: gem_wait
results: parsing output: 15/ for test: syncobj_timeline
results: parsing output: 16/ for test: kms_frontbuffer_tracking
results: parsing output: 17/ for test: kms_content_protection
results: parsing output: 18/ for test: kms_big_fb
results: parsing output: 19/ for test: kms_cursor_legacy
results: parsing output: 20/ for test: gem_userptr_blits
results: parsing output: 21/ for test: kms_ccs
results: parsing output: 22/ for test: syncobj_timeline
results: parsing output: 23/ for test: kms_frontbuffer_tracking
results: parsing output: 24/ for test: kms_cursor_legacy
results: parsing output: 25/ for test: prime_mmap
results: parsing output: 26/ for test: gem_ctx_param
results: parsing output: 27/ for test: perf_pmu
results: parsing output: 28/ for test: kms_hdr
results: parsing output: 29/ for test: kms_cursor_edge_walk
results: parsing output: 30/ for test: i915_pm_rpm
results: parsing output: 31/ for test: gem_linear_blits
results: parsing output: 32/ for test: kms_setmode
results: parsing output: 33/ for test: gem_exec_schedule
results: parsing output: 34/ for test: dumb_buffer
results: parsing output: 35/ for test: kms_chamelium_hpd
results: parsing output: 36/ for test: kms_big_fb
results: parsing output: 37/ for test: kms_getfb
results: parsing output: 38/ for test: kms_plane_scaling
results: parsing output: 39/ for test: kms_lease
results: parsing output: 40/ for test: kms_addfb_basic
results: parsing output: 41/ for test: gem_exec_schedule
results: parsing output: 42/ for test: kms_frontbuffer_tracking
results: parsing output: 43/ for test: kms_flip_scaled_crc
results: parsing output: 44/ for test: perf
results: parsing output: 45/ for test: gem_lmem_swapping
results: parsing output: 46/ for test: gem_create
results: parsing output: 47/ for test: api_intel_bb
results: parsing output: 48/ for test: kms_pipe_crc_basic
results: parsing output: 49/ for test: gem_exec_whisper
results: parsing output: 50/ for test: gem_exec_balancer
results: parsing output: 51/ for test: kms_dp_link_training
results: parsing output: 52/ for test: kms_frontbuffer_tracking
results: parsing output: 53/ for test: kms_ccs
results: parsing output: 54/ for test: gem_exec_flush
results: parsing output: 55/ for test: kms_cursor_legacy
results: parsing output: 56/ for test: kms_psr
results: parsing output: 57/ for test: drm_read
results: parsing output: 58/ for test: kms_psr
results: parsing output: 59/ for test: kms_frontbuffer_tracking
results: parsing output: 60/ for test: vgem_basic
results: parsing output: 61/ for test: gem_exec_params
results: parsing output: 62/ for test: kms_pm_dc
results: parsing output: 63/ for test: kms_addfb_basic
results: parsing output: 64/ for test: kms_frontbuffer_tracking
results: parsing output: 65/ for test: gem_softpin
results: parsing output: 66/ for test: kms_cursor_legacy
results: parsing output: 67/ for test: kms_flip
results: parsing output: 68/ for test: kms_frontbuffer_tracking
results: parsing output: 69/ for test: perf_pmu
results: parsing output: 70/ for test: kms_plane
results: parsing output: 71/ for test: gem_ctx_param
results: parsing output: 72/ for test: gem_eio
results: parsing output: 73/ for test: kms_frontbuffer_tracking
results: parsing output: 74/ for test: gem_pxp
results: parsing output: 75/ for test: drm_read
results: parsing output: 76/ for test: kms_ccs
results: parsing output: 77/ for test: kms_plane_scaling
results: parsing output: 78/ for test: kms_plane
results: parsing output: 79/ for test: gem_exec_alignment
results: parsing output: 80/ for test: kms_cursor_crc
results: parsing output: 81/ for test: syncobj_wait
results: parsing output: 82/ for test: kms_psr
results: parsing output: 83/ for test: syncobj_timeline
results: parsing output: 84/ for test: gen3_render_tiledx_blits
results: parsing output: 85/ for test: kms_cursor_crc
results: parsing output: 86/ for test: kms_psr
results: parsing output: 87/ for test: kms_frontbuffer_tracking
results: parsing output: 88/ for test: gem_userptr_blits
results: parsing output: 89/ for test: kms_chamelium_frames
results: parsing output: 90/ for test: i915_selftest
results: parsing output: 91/ for test: kms_frontbuffer_tracking
results: parsing output: 92/ for test: kms_ccs
results: parsing output: 93/ for test: perf
results: parsing output: 94/ for test: kms_frontbuffer_tracking
results: parsing output: 95/ for test: syncobj_timeline
results: parsing output: 96/ for test: kms_prime
results: parsing output: 97/ for test: kms_cursor_legacy
results: parsing output: 98/ for test: kms_big_fb
results: parsing output: 99/ for test: gen9_exec_parse
results: parsing output: 100/ for test: perf_pmu
results: parsing output: 101/ for test: syncobj_wait
results: parsing output: 102/ for test: gem_render_copy
results: parsing output: 103/ for test: kms_flip
results: parsing output: 104/ for test: kms_frontbuffer_tracking
results: parsing output: 105/ for test: i915_drm_fdinfo
results: parsing output: 106/ for test: kms_pipe_b_c_ivb
results: parsing output: 107/ for test: kms_psr
results: parsing output: 108/ for test: gem_render_linear_blits
results: parsing output: 109/ for test: kms_frontbuffer_tracking
results: parsing output: 110/ for test: intel_hwmon
results: parsing output: 111/ for test: kms_psr2_sf
results: parsing output: 112/ for test: kms_frontbuffer_tracking
results: parsing output: 113/ for test: gem_ctx_persistence
results: parsing output: 114/ for test: gem_exec_reloc
results: parsing output: 115/ for test: syncobj_eventfd
results: parsing output: 116/ for test: kms_frontbuffer_tracking
results: parsing output: 117/ for test: kms_atomic
results: parsing output: 118/ for test: dumb_buffer
results: parsing output: 119/ for test: gem_exec_reloc
results: parsing output: 120/ for test: kms_frontbuffer_tracking
results: parsing output: 121/ for test: kms_color_pipeline
results: parsing output: 122/ for test: kms_psr2_sf
results: parsing output: 123/ for test: gem_exec_big
results: parsing output: 124/ for test: kms_flip_scaled_crc
results: parsing output: 125/ for test: kms_frontbuffer_tracking
results: parsing output: 126/ for test: gem_exec_fence
results: parsing output: 127/ for test: kms_big_fb
results: parsing output: 128/ for test: gem_pwrite
results: parsing output: 129/ for test: syncobj_wait
results: parsing output: 130/ for test: api_intel_allocator
results: parsing output: 131/ for test: kms_big_fb
results: parsing output: 132/ for test: gen9_exec_parse
Done.