[63.819268] Initializing watchdogs
[63.819328]   /dev/watchdog0
[63.834545] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:9a49 Intel Tigerlake (Gen12) TigerLake-LP GT2 [Iris Xe Graphics]
[63.840000] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[63.842475] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[63.844383] [001/130] (960s left) kms_ccs (bad-pixel-format-yf-tiled-ccs)
[63.933263] Starting subtest: bad-pixel-format-yf-tiled-ccs
[63.933955] Starting dynamic subtest: pipe-A-HDMI-A-1
[63.940828] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.000s)
[63.945769] Starting dynamic subtest: pipe-B-HDMI-A-1
[63.952234] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.000s)
[63.957096] Starting dynamic subtest: pipe-C-HDMI-A-1
[63.963504] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.000s)
[63.968274] Starting dynamic subtest: pipe-D-HDMI-A-1
[63.974811] Dynamic subtest pipe-D-HDMI-A-1: SKIP (0.000s)
[63.976105] Subtest bad-pixel-format-yf-tiled-ccs: SKIP (0.004s)
[64.173904] [002/130] (960s left) kms_content_protection (dp-mst-type-0)
[64.267490] Starting subtest: dp-mst-type-0
[64.268939] Subtest dp-mst-type-0: SKIP (0.000s)
[64.381529] [003/130] (960s left) gem_exec_reloc (basic-cpu-read-active)
[64.420498] Starting subtest: basic-cpu-read-active
[64.554211] Subtest basic-cpu-read-active: SUCCESS (0.124s)
[64.681581] [004/130] (959s left) kms_ccs (crc-primary-rotation-180-yf-tiled-ccs)
[64.766704] Starting subtest: crc-primary-rotation-180-yf-tiled-ccs
[64.767422] Starting dynamic subtest: pipe-A-HDMI-A-1
[64.774177] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.001s)
[64.780749] Starting dynamic subtest: pipe-B-HDMI-A-1
[64.787580] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.001s)
[64.794132] Starting dynamic subtest: pipe-C-HDMI-A-1
[64.801038] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.001s)
[64.806069] Starting dynamic subtest: pipe-D-HDMI-A-1
[64.812939] Dynamic subtest pipe-D-HDMI-A-1: SKIP (0.001s)
[64.814268] Subtest crc-primary-rotation-180-yf-tiled-ccs: SKIP (0.006s)
[65.023989] [005/130] (959s left) gem_mmap_offset (clear)
[65.059617] Starting subtest: clear
[65.060424] Starting dynamic subtest: smem0
[87.222862] Dynamic subtest smem0: SUCCESS (22.146s)
[87.223574] Subtest clear: SUCCESS (22.146s)
[87.361715] [006/130] (937s left) kms_feature_discovery (psr1)
[87.495931] Starting subtest: psr1
[87.497314] Subtest psr1: SKIP (0.000s)
[87.577826] [007/130] (936s left) kms_cursor_legacy (torture-move)
[87.662423] Starting subtest: torture-move
[87.663113] Starting dynamic subtest: pipe-A
[93.167719] Dynamic subtest pipe-A: SUCCESS (5.469s)
[93.173895] Starting dynamic subtest: pipe-B
[98.615417] Dynamic subtest pipe-B: SUCCESS (5.446s)
[98.621803] Starting dynamic subtest: pipe-C
[104.068046] Dynamic subtest pipe-C: SUCCESS (5.451s)
[104.074327] Starting dynamic subtest: pipe-D
[109.514973] Dynamic subtest pipe-D: SUCCESS (5.446s)
[109.522367] Starting dynamic subtest: all-pipes
[114.980930] Dynamic subtest all-pipes: SUCCESS (5.465s)
[114.981856] Subtest torture-move: SUCCESS (27.278s)
[115.057028] [008/130] (909s left) gem_softpin (evict-snoop)
[115.100195] Starting subtest: evict-snoop
[115.101604] Subtest evict-snoop: SKIP (0.000s)
[115.181951] [009/130] (909s left) gem_ppgtt (blt-vs-render-ctxn)
[115.218888] Starting subtest: blt-vs-render-ctxN
[147.743716] Subtest blt-vs-render-ctxN: SUCCESS (32.511s)
[147.875183] [010/130] (876s left) prime_vgem (fence-read-hang)
[147.999440] Subtest fence-read-hang: SKIP (0.000s)
[148.108405] [FACT prime_vgem (fence-read-hang)] new: kernel.kmod_is_loaded.vgem: true
[148.109966] [011/130] (876s left) i915_drm_fdinfo (memory-info-shared)
[148.144015] Starting subtest: memory-info-shared
[148.144737] Starting dynamic subtest: smem0
[148.197371] Dynamic subtest smem0: SUCCESS (0.053s)
[148.198083] Subtest memory-info-shared: SUCCESS (0.053s)
[148.284133] [012/130] (876s left) gem_exec_schedule (timeslicing)
[148.325237] Starting subtest: timeslicing
[148.325970] Starting dynamic subtest: rcs0
[148.329489] Dynamic subtest rcs0: SUCCESS (0.004s)
[148.337066] Starting dynamic subtest: bcs0
[148.337769] Dynamic subtest bcs0: SUCCESS (0.002s)
[148.344591] Starting dynamic subtest: vcs0
[148.345262] Dynamic subtest vcs0: SUCCESS (0.003s)
[148.351630] Starting dynamic subtest: vcs1
[148.352326] Dynamic subtest vcs1: SUCCESS (0.002s)
[148.358225] Starting dynamic subtest: vecs0
[148.358878] Dynamic subtest vecs0: SUCCESS (0.002s)
[148.359507] Subtest timeslicing: SUCCESS (0.015s)
[148.663115] [013/130] (876s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-move)
[148.761095] Starting subtest: psr-2p-scndscrn-spr-indfb-move
[148.762425] Subtest psr-2p-scndscrn-spr-indfb-move: SKIP (0.000s)
[148.876912] [014/130] (876s left) kms_async_flips (alternate-sync-async-flip-atomic)
[148.961410] Starting subtest: alternate-sync-async-flip-atomic
[149.087861] Starting dynamic subtest: pipe-A-HDMI-A-1
[151.191103] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (2.094s)
[151.323692] Starting dynamic subtest: pipe-B-HDMI-A-1
[153.403700] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (2.077s)
[153.521932] Starting dynamic subtest: pipe-C-HDMI-A-1
[155.620669] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (2.095s)
[155.742407] Starting dynamic subtest: pipe-D-HDMI-A-1
[157.833340] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (2.088s)
[157.834340] Subtest alternate-sync-async-flip-atomic: SUCCESS (8.865s)
[158.065020] [015/130] (866s left) api_intel_bb (simple-bb)
[158.104011] Starting subtest: simple-bb
[158.106665] Subtest simple-bb: SUCCESS (0.003s)
[158.252532] [016/130] (866s left) i915_hangman (engine-engine-error)
[158.293671] Starting subtest: engine-engine-error
[158.294377] Starting dynamic subtest: rcs0
[158.362900] Dynamic subtest rcs0: SUCCESS (0.069s)
[158.381269] Starting dynamic subtest: bcs0
[158.446906] Dynamic subtest bcs0: SUCCESS (0.083s)
[158.462598] Starting dynamic subtest: vcs0
[158.530966] Dynamic subtest vcs0: SUCCESS (0.083s)
[158.546239] Starting dynamic subtest: vcs1
[158.603987] Dynamic subtest vcs1: SUCCESS (0.072s)
[158.618666] Starting dynamic subtest: vecs0
[158.703812] Dynamic subtest vecs0: SUCCESS (0.099s)
[158.704832] Subtest engine-engine-error: SUCCESS (0.411s)
[158.801629] [017/130] (866s left) gem_pxp (verify-pxp-execution-after-suspend-resume)
[158.900484] Starting subtest: verify-pxp-execution-after-suspend-resume
[165.969479] Subtest verify-pxp-execution-after-suspend-resume: SUCCESS (7.071s)
[180.148388] [018/130] (858s left) syncobj_eventfd (timeline-wait)
[180.201400] Starting subtest: timeline-wait
[180.212140] Subtest timeline-wait: SUCCESS (0.011s)
[180.297180] [019/130] (858s left) gem_busy (extended)
[180.469715] Starting subtest: extended
[180.470733] Starting dynamic subtest: rcs0
[180.492574] Dynamic subtest rcs0: SUCCESS (0.031s)
[180.508937] Starting dynamic subtest: bcs0
[180.517299] Dynamic subtest bcs0: SUCCESS (0.024s)
[180.529821] Starting dynamic subtest: vcs0
[180.534881] Dynamic subtest vcs0: SUCCESS (0.017s)
[180.542797] Starting dynamic subtest: vcs1
[180.548779] Dynamic subtest vcs1: SUCCESS (0.014s)
[180.556677] Starting dynamic subtest: vecs0
[180.563503] Dynamic subtest vecs0: SUCCESS (0.014s)
[180.564267] Subtest extended: SUCCESS (0.102s)
[180.820807] [020/130] (858s left) syncobj_timeline (invalid-transfer-illegal-handle)
[180.854425] Starting subtest: invalid-transfer-illegal-handle
[180.855128] Subtest invalid-transfer-illegal-handle: SUCCESS (0.000s)
[180.938665] [021/130] (858s left) gem_ctx_freq (sysfs)
[180.975400] Starting subtest: sysfs
[180.976129] Starting dynamic subtest: gt0
[185.955399] Dynamic subtest gt0: SUCCESS (4.979s)
[185.956346] Subtest sysfs: SUCCESS (4.980s)
[186.040925] [022/130] (853s left) kms_chamelium_edid (hdmi-edid-read)
[186.179907] Subtest hdmi-edid-read: SKIP (0.000s)
[186.267541] [023/130] (853s left) kms_cursor_legacy (short-flip-before-cursor-toggle)
[186.356748] Starting subtest: short-flip-before-cursor-toggle
[186.909484] Subtest short-flip-before-cursor-toggle: SUCCESS (0.553s)
[187.082308] [024/130] (852s left) kms_cursor_crc (cursor-rapid-movement-64x64)
[187.169815] Starting subtest: cursor-rapid-movement-64x64
[187.173655] Starting dynamic subtest: pipe-A-HDMI-A-1
[187.429602] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.255s)
[187.463441] Starting dynamic subtest: pipe-D-HDMI-A-1
[187.660314] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.204s)
[187.661031] Subtest cursor-rapid-movement-64x64: SUCCESS (0.491s)
[187.820027] [025/130] (851s left) gem_exec_flush (basic-wb-prw-default)
[187.861595] Starting subtest: basic-wb-prw-default
[193.288215] Subtest basic-wb-prw-default: SUCCESS (5.426s)
[193.513217] [026/130] (845s left) kms_invalid_mode (bad-vtotal)
[193.600324] Starting subtest: bad-vtotal
[193.601054] Starting dynamic subtest: pipe-A-HDMI-A-1
[193.650537] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.050s)
[193.661448] Starting dynamic subtest: pipe-B-HDMI-A-1
[193.662196] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.001s)
[193.671400] Starting dynamic subtest: pipe-C-HDMI-A-1
[193.672140] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.001s)
[193.681590] Starting dynamic subtest: pipe-D-HDMI-A-1
[193.682330] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.001s)
[193.683052] Subtest bad-vtotal: SUCCESS (0.057s)
[193.802253] [027/130] (845s left) syncobj_timeline (invalid-multi-wait-unsubmitted-signaled)
[193.836013] Starting subtest: invalid-multi-wait-unsubmitted-signaled
[193.836714] Subtest invalid-multi-wait-unsubmitted-signaled: SUCCESS (0.000s)
[193.922553] [028/130] (845s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-blt)
[194.008231] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-blt
[194.009587] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-blt: SKIP (0.000s)
[194.123559] [029/130] (845s left) kms_rotation_crc (primary-yf-tiled-reflect-x-270)
[194.207773] Starting subtest: primary-yf-tiled-reflect-x-270
[194.257105] Subtest primary-yf-tiled-reflect-x-270: SKIP (0.049s)
[194.355680] [030/130] (845s left) gem_exec_schedule (preempt-queue-chain)
[194.400626] Starting subtest: preempt-queue-chain
[194.401334] Starting dynamic subtest: rcs0
[194.544006] Dynamic subtest rcs0: SUCCESS (0.133s)
[194.552267] Starting dynamic subtest: bcs0
[194.683548] Dynamic subtest bcs0: SUCCESS (0.133s)
[194.693863] Starting dynamic subtest: vcs0
[194.798349] Dynamic subtest vcs0: SUCCESS (0.131s)
[194.806561] Starting dynamic subtest: vcs1
[194.947068] Dynamic subtest vcs1: SUCCESS (0.129s)
[194.955510] Starting dynamic subtest: vecs0
[195.060656] Dynamic subtest vecs0: SUCCESS (0.132s)
[195.061475] Subtest preempt-queue-chain: SUCCESS (0.661s)
[195.381919] [031/130] (844s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-shrfb-msflip-blt)
[195.470347] Starting subtest: fbcpsr-2p-primscrn-shrfb-msflip-blt
[195.471666] Subtest fbcpsr-2p-primscrn-shrfb-msflip-blt: SKIP (0.000s)
[195.589429] [032/130] (844s left) kms_ccs (crc-primary-basic-4-tiled-lnl-ccs)
[195.671364] Starting subtest: crc-primary-basic-4-tiled-lnl-ccs
[195.672710] Subtest crc-primary-basic-4-tiled-lnl-ccs: SKIP (0.000s)
[195.836783] [033/130] (843s left) gem_exec_reloc (basic-cpu-active)
[195.873571] Starting subtest: basic-cpu-active
[196.015227] Subtest basic-cpu-active: SUCCESS (0.120s)
[196.141803] [034/130] (843s left) kms_lease (multimaster-lease)
[196.225399] Starting subtest: multimaster-lease
[196.227170] Subtest multimaster-lease: SUCCESS (0.002s)
[196.314671] [035/130] (843s left) kms_dp_linktrain_fallback (dsc-fallback)
[196.398945] Starting subtest: dsc-fallback
[196.401029] Subtest dsc-fallback: SKIP (0.000s)
[196.470113] [036/130] (843s left) kms_ccs (missing-ccs-buffer-4-tiled-mtl-rc-ccs)
[196.556682] Starting subtest: missing-ccs-buffer-4-tiled-mtl-rc-ccs
[196.557384] Starting dynamic subtest: pipe-A-HDMI-A-1
[196.564122] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.000s)
[196.571845] Starting dynamic subtest: pipe-B-HDMI-A-1
[196.578513] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.000s)
[196.586083] Starting dynamic subtest: pipe-C-HDMI-A-1
[196.592566] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.000s)
[196.599939] Starting dynamic subtest: pipe-D-HDMI-A-1
[196.607876] Dynamic subtest pipe-D-HDMI-A-1: SKIP (0.000s)
[196.609282] Subtest missing-ccs-buffer-4-tiled-mtl-rc-ccs: SKIP (0.005s)
[196.805267] [037/130] (843s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-mmap-cpu)
[196.892684] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-mmap-cpu
[196.894099] Subtest fbc-2p-scndscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[197.010731] [038/130] (842s left) kms_psr (psr-primary-page-flip)
[197.096609] Subtest psr-primary-page-flip: SKIP (0.000s)
[197.141680] [039/130] (842s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-180)
[197.238435] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-180
[197.239796] Subtest 4-tiled-max-hw-stride-32bpp-rotate-180: SKIP (0.000s)
[197.344943] [040/130] (842s left) kms_getfb (getfb2-handle-closed)
[197.427854] Starting subtest: getfb2-handle-closed
[197.428580] Subtest getfb2-handle-closed: SUCCESS (0.000s)
[197.562129] [041/130] (842s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-mmap-cpu)
[197.649702] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-mmap-cpu
[197.651095] Subtest fbc-2p-primscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[197.770447] [042/130] (842s left) gem_lmem_swapping (heavy-verify-random)
[197.807295] Subtest heavy-verify-random: SKIP (0.000s)
[197.854028] [043/130] (842s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-mmap-gtt)
[197.940472] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-mmap-gtt
[197.941820] Subtest psr-2p-scndscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[198.053021] [044/130] (842s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-mmap-gtt)
[198.140268] Starting subtest: psr-1p-primscrn-spr-indfb-draw-mmap-gtt
[198.141620] Subtest psr-1p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[198.261721] [045/130] (841s left) gem_exec_gttfill (basic)
[198.303710] Starting subtest: basic
[201.587306] Subtest basic: SUCCESS (3.284s)
[201.793434] [046/130] (838s left) prime_busy (hang)
[201.878999] Starting subtest: hang
[201.879741] Starting dynamic subtest: rcs0
[215.674835] Dynamic subtest rcs0: SUCCESS (13.759s)
[215.682047] Starting dynamic subtest: bcs0
[222.585264] Dynamic subtest bcs0: SUCCESS (6.911s)
[222.592348] Starting dynamic subtest: vcs0
[229.561300] Dynamic subtest vcs0: SUCCESS (6.975s)
[229.568238] Starting dynamic subtest: vcs1
[236.601401] Dynamic subtest vcs1: SUCCESS (7.039s)
[236.608313] Starting dynamic subtest: vecs0
[243.577831] Dynamic subtest vecs0: SUCCESS (6.975s)
[243.578748] Subtest hang: SUCCESS (41.662s)
[243.681949] [047/130] (796s left) kms_psr (fbc-psr2-no-drrs)
[243.773199] Subtest fbc-psr2-no-drrs: SKIP (0.000s)
[243.817950] [048/130] (796s left) kms_vrr (flip-suspend)
[243.902748] Starting subtest: flip-suspend
[243.904710] Subtest flip-suspend: SKIP (0.000s)
[243.989905] [049/130] (796s left) gem_render_copy (yf-tiled-mc-ccs-to-vebox-y-tiled)
[244.028583] Starting subtest: yf-tiled-mc-ccs-to-vebox-y-tiled
[244.036300] Starting dynamic subtest: smem
[244.137114] Dynamic subtest smem: SUCCESS (0.108s)
[244.137856] Subtest yf-tiled-mc-ccs-to-vebox-y-tiled: SUCCESS (0.109s)
[244.339604] [050/130] (796s left) kms_prime (basic-crc-hybrid)
[244.441338] Subtest basic-crc-hybrid: SKIP (0.000s)
[244.545390] [051/130] (795s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-mmap-wc)
[244.634622] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-mmap-wc
[244.635997] Subtest fbc-2p-primscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[244.771103] [052/130] (795s left) kms_chamelium_hpd (dp-hpd-enable-disable-mode)
[244.905779] Subtest dp-hpd-enable-disable-mode: SKIP (0.000s)
[244.996323] [053/130] (795s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-blt)
[245.084540] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-blt
[246.393030] Subtest fbc-1p-primscrn-pri-indfb-draw-blt: SUCCESS (1.308s)
[246.534740] [054/130] (794s left) kms_flip (2x-flip-vs-panning)
[246.623326] Starting subtest: 2x-flip-vs-panning
[246.632531] Subtest 2x-flip-vs-panning: SKIP (0.009s)
[246.721943] [055/130] (793s left) gem_mmap_wc (write-gtt-read-wc)
[246.754818] Starting subtest: write-gtt-read-wc
[247.069505] Subtest write-gtt-read-wc: SUCCESS (0.306s)
[247.162227] [056/130] (793s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-0)
[247.262107] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-0
[247.976786] Subtest y-tiled-max-hw-stride-32bpp-rotate-0: SUCCESS (0.714s)
[248.135799] [057/130] (792s left) kms_flip (2x-flip-vs-wf_vblank)
[248.221123] Starting subtest: 2x-flip-vs-wf_vblank
[248.229994] Subtest 2x-flip-vs-wf_vblank: SKIP (0.009s)
[248.324052] [058/130] (792s left) perf_pmu (semaphore-wait-idle)
[248.359532] Starting subtest: semaphore-wait-idle
[248.360235] Starting dynamic subtest: rcs0
[248.876779] Dynamic subtest rcs0: SUCCESS (0.508s)
[248.887765] Starting dynamic subtest: bcs0
[249.388223] Dynamic subtest bcs0: SUCCESS (0.510s)
[249.398762] Starting dynamic subtest: vcs0
[249.899237] Dynamic subtest vcs0: SUCCESS (0.510s)
[249.909639] Starting dynamic subtest: vcs1
[250.410059] Dynamic subtest vcs1: SUCCESS (0.510s)
[250.420553] Starting dynamic subtest: vecs0
[250.921038] Dynamic subtest vecs0: SUCCESS (0.510s)
[250.922047] Subtest semaphore-wait-idle: SUCCESS (2.553s)
[251.022584] [059/130] (789s left) i915_pm_rpm (gem-pread)
[252.411795] Starting subtest: gem-pread
[253.794255] Subtest gem-pread: SUCCESS (1.383s)
[253.926958] [060/130] (786s left) gem_exec_fence (long-history)
[254.260463] Starting subtest: long-history
[260.053208] Subtest long-history: SUCCESS (5.784s)
[260.606152] [061/130] (780s left) gem_lmem_swapping (parallel-random-engines)
[260.642083] Subtest parallel-random-engines: SKIP (0.000s)
[260.685509] [062/130] (780s left) syncobj_basic (bad-destroy)
[260.717433] Starting subtest: bad-destroy
[260.718116] Subtest bad-destroy: SUCCESS (0.000s)
[260.803348] [063/130] (780s left) kms_cursor_crc (cursor-offscreen-512x170)
[260.895986] Starting subtest: cursor-offscreen-512x170
[260.898201] Subtest cursor-offscreen-512x170: SKIP (0.001s)
[261.013458] [064/130] (780s left) gem_ctx_persistence (hostile)
[261.049332] Starting subtest: hostile
[271.712399] Subtest hostile: SUCCESS (10.655s)
[271.826742] [065/130] (769s left) gem_exec_reloc (basic-cpu-read)
[271.863448] Starting subtest: basic-cpu-read
[271.868273] Subtest basic-cpu-read: SUCCESS (0.005s)
[272.011262] [066/130] (769s left) kms_psr2_sf (psr2-overlay-plane-move-continuous-exceed-sf)
[272.101052] Subtest psr2-overlay-plane-move-continuous-exceed-sf: SKIP (0.000s)
[272.138512] [067/130] (768s left) gem_exec_fence (syncobj-timeline-wait)
[272.602838] Starting subtest: syncobj-timeline-wait
[272.624257] Subtest syncobj-timeline-wait: SUCCESS (0.030s)
[272.825680] [068/130] (768s left) prime_mmap (test_userptr)
[272.858368] Starting subtest: test_userptr
[272.859921] Starting dynamic subtest: test_userptr-smem
[272.860596] Dynamic subtest test_userptr-smem: SUCCESS (0.000s)
[272.861274] Subtest test_userptr: SUCCESS (0.002s)
[272.990446] [069/130] (768s left) gem_exec_store (dword)
[273.030063] Starting subtest: dword
[273.030766] Starting dynamic subtest: rcs0
[273.090768] Dynamic subtest rcs0: SUCCESS (0.060s)
[273.109308] Starting dynamic subtest: bcs0
[273.121131] Dynamic subtest bcs0: SUCCESS (0.029s)
[273.131189] Starting dynamic subtest: vcs0
[273.159952] Dynamic subtest vcs0: SUCCESS (0.038s)
[273.177344] Starting dynamic subtest: vcs1
[273.203873] Dynamic subtest vcs1: SUCCESS (0.043s)
[273.220932] Starting dynamic subtest: vecs0
[273.236803] Dynamic subtest vecs0: SUCCESS (0.032s)
[273.237952] Subtest dword: SUCCESS (0.207s)
[273.423616] [070/130] (767s left) kms_pm_rpm (legacy-planes)
[274.818955] Starting subtest: legacy-planes
[274.820055] Starting dynamic subtest: plane-63
[283.254768] Dynamic subtest plane-63: SUCCESS (8.435s)
[283.265963] Starting dynamic subtest: plane-93
[291.664247] Dynamic subtest plane-93: SUCCESS (8.408s)
[291.676919] Starting dynamic subtest: plane-123
[300.281355] Dynamic subtest plane-123: SUCCESS (8.615s)
[300.294216] Starting dynamic subtest: plane-133
[308.815368] Dynamic subtest plane-133: SUCCESS (8.532s)
[308.828593] Starting dynamic subtest: plane-143
[317.365771] Dynamic subtest plane-143: SUCCESS (8.549s)
[317.378532] Starting dynamic subtest: plane-153
[325.901056] Dynamic subtest plane-153: SUCCESS (8.533s)
[325.902609] Subtest legacy-planes: SUCCESS (51.082s)
[326.116526] [071/130] (715s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-cpu)
[326.205625] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-cpu
[326.206973] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[326.328320] [072/130] (715s left) kms_psr (fbc-psr-suspend)
[326.411407] Subtest fbc-psr-suspend: SKIP (0.000s)
[326.450720] [073/130] (714s left) kms_big_fb (linear-32bpp-rotate-270)
[326.543142] Starting subtest: linear-32bpp-rotate-270
[326.614978] Subtest linear-32bpp-rotate-270: SKIP (0.070s)
[326.761953] [074/130] (714s left) gem_exec_reloc (basic-wc-gtt-noreloc)
[326.797456] Starting subtest: basic-wc-gtt-noreloc
[326.800722] Subtest basic-wc-gtt-noreloc: SUCCESS (0.003s)
[326.938939] [075/130] (714s left) prime_mmap (test_correct)
[326.970717] Starting subtest: test_correct
[326.971420] Starting dynamic subtest: test_correct-smem
[326.973041] Dynamic subtest test_correct-smem: SUCCESS (0.002s)
[326.973727] Subtest test_correct: SUCCESS (0.002s)
[327.104724] [076/130] (714s left) kms_vblank (accuracy-idle)
[327.189727] Starting subtest: accuracy-idle
[327.191321] Starting dynamic subtest: pipe-A-HDMI-A-1
[328.369705] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (1.178s)
[328.383326] Starting dynamic subtest: pipe-D-HDMI-A-1
[329.518793] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (1.145s)
[329.519478] Subtest accuracy-idle: SUCCESS (2.329s)
[329.683355] [077/130] (711s left) perf (invalid-remove-userspace-config)
[329.790974] Starting subtest: invalid-remove-userspace-config
[329.800597] Subtest invalid-remove-userspace-config: SUCCESS (0.010s)
[329.844639] [078/130] (711s left) gem_madvise (dontneed-before-exec)
[329.875133] Starting subtest: dontneed-before-exec
[329.878795] Subtest dontneed-before-exec: SUCCESS (0.004s)
[330.011773] [079/130] (711s left) kms_chamelium_color (ctm-negative)
[330.098338] Subtest ctm-negative: SKIP (0.000s)
[330.143337] [080/130] (711s left) gem_mmap_wc (invalid-flags)
[330.175612] Starting subtest: invalid-flags
[330.176298] Subtest invalid-flags: SUCCESS (0.000s)
[330.289962] [081/130] (711s left) gem_exec_reloc (basic-gtt-wc)
[330.325388] Starting subtest: basic-gtt-wc
[330.331822] Subtest basic-gtt-wc: SUCCESS (0.006s)
[330.466622] [082/130] (711s left) syncobj_timeline (single-wait-all-available-signaled)
[330.501079] Starting subtest: single-wait-all-available-signaled
[330.501776] Subtest single-wait-all-available-signaled: SUCCESS (0.000s)
[330.592837] [083/130] (711s left) gem_ctx_exec (basic-close-race)
[330.626390] Starting subtest: basic-close-race
[336.286105] Subtest basic-close-race: SUCCESS (5.625s)
[336.389130] [084/130] (705s left) gem_exec_balancer (parallel-out-fence)
[336.546664] Subtest parallel-out-fence: SKIP (0.000s)
[336.645710] [085/130] (705s left) kms_cursor_legacy (flip-vs-cursor-legacy)
[336.733818] Starting subtest: flip-vs-cursor-legacy
[343.005861] Subtest flip-vs-cursor-legacy: SUCCESS (6.271s)
[343.162393] [086/130] (698s left) drm_read (fault-buffer)
[343.267498] Starting subtest: fault-buffer
[343.268201] Subtest fault-buffer: SUCCESS (0.001s)
[343.401518] [087/130] (698s left) gem_mmap_wc (pf-nonblock)
[343.432642] Starting subtest: pf-nonblock
[343.434271] Subtest pf-nonblock: SUCCESS (0.002s)
[343.576702] [088/130] (698s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-pwrite)
[343.664608] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-pwrite
[343.665964] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[343.792828] [089/130] (698s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-mmap-wc)
[343.882613] Starting subtest: psr-2p-primscrn-pri-indfb-draw-mmap-wc
[343.884053] Subtest psr-2p-primscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[343.992607] [090/130] (698s left) kms_flip_scaled_crc (flip-32bpp-yftile-to-32bpp-yftileccs-upscaling)
[344.078765] Starting subtest: flip-32bpp-yftile-to-32bpp-yftileccs-upscaling
[344.079444] Starting dynamic subtest: pipe-A-valid-mode
[344.134434] Dynamic subtest pipe-A-valid-mode: SKIP (0.055s)
[344.135885] Subtest flip-32bpp-yftile-to-32bpp-yftileccs-upscaling: SKIP (0.056s)
[344.254480] [091/130] (697s left) gem_spin_batch (spin-all-new)
[344.296410] Starting subtest: spin-all-new
[344.306929] Subtest spin-all-new: SUCCESS (0.011s)
[344.507511] [092/130] (697s left) core_sysfs (read-all-entries)
[344.538650] Starting subtest: read-all-entries
[344.542550] Subtest read-all-entries: SUCCESS (0.004s)
[344.630294] [093/130] (697s left) gem_exec_reloc (basic-range-active)
[344.666659] Starting subtest: basic-range-active
[344.704124] Subtest basic-range-active: SUCCESS (0.037s)
[344.844381] [094/130] (697s left) syncobj_timeline (single-wait-all-signaled)
[344.877234] Starting subtest: single-wait-all-signaled
[344.877949] Subtest single-wait-all-signaled: SUCCESS (0.000s)
[344.961284] [095/130] (697s left) gen7_exec_parse (basic-offset)
[344.997229] Subtest basic-offset: SKIP (0.000s)
[345.036415] [096/130] (697s left) gem_ctx_shared (q-out-order)
[345.077297] Starting subtest: Q-out-order
[345.077997] Starting dynamic subtest: rcs0
[345.125637] Dynamic subtest rcs0: SUCCESS (0.048s)
[345.138869] Starting dynamic subtest: bcs0
[345.186248] Dynamic subtest bcs0: SUCCESS (0.058s)
[345.197662] Starting dynamic subtest: vcs0
[345.236619] Dynamic subtest vcs0: SUCCESS (0.049s)
[345.250062] Starting dynamic subtest: vcs1
[345.287255] Dynamic subtest vcs1: SUCCESS (0.049s)
[345.301857] Starting dynamic subtest: vecs0
[345.338222] Dynamic subtest vecs0: SUCCESS (0.049s)
[345.339125] Subtest Q-out-order: SUCCESS (0.262s)
[345.540854] [097/130] (696s left) gem_exec_flush (basic-batch-kernel-default-wb)
[345.580774] Starting subtest: basic-batch-kernel-default-wb
[351.139018] Subtest basic-batch-kernel-default-wb: SUCCESS (5.558s)
[351.356208] [098/130] (691s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-shrfb-plflip-blt)
[351.447690] Starting subtest: fbcpsr-1p-primscrn-shrfb-plflip-blt
[351.449088] Subtest fbcpsr-1p-primscrn-shrfb-plflip-blt: SKIP (0.000s)
[351.574500] [099/130] (690s left) kms_psr2_sf (fbc-pr-overlay-plane-move-continuous-sf)
[351.663728] Subtest fbc-pr-overlay-plane-move-continuous-sf: SKIP (0.000s)
[351.706204] [100/130] (690s left) kms_psr2_su (page_flip-xrgb8888)
[351.738513] Subtest page_flip-XRGB8888: SKIP (0.000s)
[351.780217] [101/130] (690s left) kms_psr (psr-basic)
[351.864477] Subtest psr-basic: SKIP (0.000s)
[351.906305] [102/130] (690s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-pwrite)
[351.995462] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-pwrite
[351.996832] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[352.104540] [103/130] (690s left) kms_big_fb (yf-tiled-8bpp-rotate-90)
[352.198176] Starting subtest: yf-tiled-8bpp-rotate-90
[352.199525] Subtest yf-tiled-8bpp-rotate-90: SKIP (0.000s)
[352.333878] [104/130] (690s left) kms_big_fb (yf-tiled-16bpp-rotate-90)
[352.427789] Starting subtest: yf-tiled-16bpp-rotate-90
[352.429151] Subtest yf-tiled-16bpp-rotate-90: SKIP (0.000s)
[352.540650] [105/130] (690s left) kms_flip (flip-vs-blocking-wf-vblank)
[352.625568] Starting subtest: flip-vs-blocking-wf-vblank
[352.627531] Starting dynamic subtest: A-HDMI-A1
[360.459278] Dynamic subtest A-HDMI-A1: SUCCESS (7.813s)
[360.468231] Starting dynamic subtest: B-HDMI-A1
[368.270382] Dynamic subtest B-HDMI-A1: SUCCESS (7.799s)
[368.278407] Starting dynamic subtest: C-HDMI-A1
[376.061977] Dynamic subtest C-HDMI-A1: SUCCESS (7.791s)
[376.069419] Starting dynamic subtest: D-HDMI-A1
[383.844693] Dynamic subtest D-HDMI-A1: SUCCESS (7.802s)
[383.845377] Subtest flip-vs-blocking-wf-vblank: SUCCESS (31.217s)
[384.006077] [106/130] (658s left) gem_userptr_blits (stress-purge)
[384.051037] Starting subtest: stress-purge
[389.450305] Subtest stress-purge: SUCCESS (5.398s)
[389.608018] [107/130] (653s left) gem_fenced_exec_thrash (no-spare-fences-busy-interruptible)
[389.685059] Starting subtest: no-spare-fences-busy-interruptible
[391.841591] Subtest no-spare-fences-busy-interruptible: SUCCESS (2.156s)
[391.977722] [108/130] (650s left) gem_exec_balancer (nop)
[392.018290] Starting subtest: nop
[430.248079] Subtest nop: SUCCESS (38.228s)
[430.453311] [109/130] (612s left) gem_eio (in-flight-external)
[430.496556] Starting subtest: in-flight-external
[430.756941] Subtest in-flight-external: SUCCESS (0.258s)
[430.906122] [110/130] (612s left) kms_flip (2x-blocking-absolute-wf_vblank)
[430.990976] Starting subtest: 2x-blocking-absolute-wf_vblank
[431.000139] Subtest 2x-blocking-absolute-wf_vblank: SKIP (0.009s)
[431.146093] [111/130] (611s left) kms_flip (2x-modeset-vs-vblank-race-interruptible)
[431.234383] Starting subtest: 2x-modeset-vs-vblank-race-interruptible
[431.244019] Subtest 2x-modeset-vs-vblank-race-interruptible: SKIP (0.009s)
[431.368328] [112/130] (611s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-mmap-wc)
[431.459294] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-mmap-wc
[431.460721] Subtest fbc-2p-scndscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[431.565028] [113/130] (611s left) kms_atomic (plane-cursor-legacy)
[431.652075] Starting subtest: plane-cursor-legacy
[431.652841] Starting dynamic subtest: pipe-A-HDMI-A-1
[431.810724] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.157s)
[431.811403] Subtest plane-cursor-legacy: SUCCESS (0.160s)
[431.955051] [114/130] (611s left) kms_ccs (bad-aux-stride-y-tiled-ccs)
[432.043893] Starting subtest: bad-aux-stride-y-tiled-ccs
[432.045655] Starting dynamic subtest: pipe-A-HDMI-A-1
[432.052406] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.000s)
[432.060995] Starting dynamic subtest: pipe-B-HDMI-A-1
[432.067828] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.000s)
[432.076360] Starting dynamic subtest: pipe-C-HDMI-A-1
[432.082901] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.000s)
[432.091148] Starting dynamic subtest: pipe-D-HDMI-A-1
[432.097887] Dynamic subtest pipe-D-HDMI-A-1: SKIP (0.000s)
[432.099416] Subtest bad-aux-stride-y-tiled-ccs: SKIP (0.007s)
[432.294720] [115/130] (610s left) kms_pipe_stress (stress-xrgb8888-xtiled)
[432.382498] Starting subtest: stress-xrgb8888-xtiled
[438.643130] Subtest stress-xrgb8888-xtiled: SUCCESS (6.260s)
[438.791209] [116/130] (604s left) kms_plane_scaling (planes-upscale-factor-0-25-downscale-factor-0-5)
[438.880258] Starting subtest: planes-upscale-factor-0-25-downscale-factor-0-5
[438.880981] Starting dynamic subtest: pipe-A
[439.005390] Dynamic subtest pipe-A: SUCCESS (0.125s)
[439.014942] Starting dynamic subtest: pipe-B
[439.130694] Dynamic subtest pipe-B: SUCCESS (0.124s)
[439.148480] Starting dynamic subtest: pipe-C
[439.263695] Dynamic subtest pipe-C: SUCCESS (0.132s)
[439.273462] Starting dynamic subtest: pipe-D
[439.406340] Dynamic subtest pipe-D: SUCCESS (0.142s)
[439.407048] Subtest planes-upscale-factor-0-25-downscale-factor-0-5: SUCCESS (0.527s)
[439.585550] [117/130] (603s left) kms_frontbuffer_tracking (fbc-shrfb-scaledprimary)
[439.674548] Starting subtest: fbc-shrfb-scaledprimary
[442.541614] Subtest fbc-shrfb-scaledprimary: SUCCESS (2.867s)
[442.700660] [118/130] (600s left) kms_big_fb (x-tiled-64bpp-rotate-270)
[442.799378] Starting subtest: x-tiled-64bpp-rotate-270
[442.840697] Subtest x-tiled-64bpp-rotate-270: SKIP (0.039s)
[442.975265] [119/130] (600s left) kms_flip (nonexisting-fb-interruptible)
[443.068341] Starting subtest: nonexisting-fb-interruptible
[443.071313] Starting dynamic subtest: A-HDMI-A1
[443.220147] Dynamic subtest A-HDMI-A1: SUCCESS (0.149s)
[443.230211] Starting dynamic subtest: B-HDMI-A1
[443.349317] Dynamic subtest B-HDMI-A1: SUCCESS (0.128s)
[443.358898] Starting dynamic subtest: C-HDMI-A1
[443.493493] Dynamic subtest C-HDMI-A1: SUCCESS (0.142s)
[443.503783] Starting dynamic subtest: D-HDMI-A1
[443.623491] Dynamic subtest D-HDMI-A1: SUCCESS (0.129s)
[443.625789] Subtest nonexisting-fb-interruptible: SUCCESS (0.557s)
[443.814811] [120/130] (599s left) kms_plane_lowres (tiling-4)
[443.900130] Starting subtest: tiling-4
[443.901553] Subtest tiling-4: SKIP (0.000s)
[443.979577] [121/130] (599s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-pwrite)
[444.067031] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-pwrite
[444.068384] Subtest fbc-2p-primscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[444.204974] [122/130] (599s left) kms_psr (pr-cursor-render)
[444.291732] Subtest pr-cursor-render: SKIP (0.000s)
[444.338414] [123/130] (599s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-indfb-draw-pwrite)
[444.430348] Starting subtest: fbc-1p-offscreen-pri-indfb-draw-pwrite
[445.547626] Subtest fbc-1p-offscreen-pri-indfb-draw-pwrite: SUCCESS (1.117s)
[445.696073] [124/130] (597s left) kms_cursor_crc (cursor-onscreen-64x21)
[445.786555] Starting subtest: cursor-onscreen-64x21
[445.791071] Starting dynamic subtest: pipe-A-HDMI-A-1
[446.659921] Dynamic subtest pipe-A-HDMI-A-1: FAIL (0.691s)
[446.669060] Starting dynamic subtest: pipe-D-HDMI-A-1
[447.756468] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (1.239s)
[447.757143] Subtest cursor-onscreen-64x21: FAIL (1.971s)
[447.937386] [125/130] (595s left) perf_pmu (busy-idle-no-semaphores)
[447.974286] Starting subtest: busy-idle-no-semaphores
[447.974995] Starting dynamic subtest: rcs0
[448.622764] Dynamic subtest rcs0: SUCCESS (0.639s)
[448.634477] Starting dynamic subtest: bcs0
[449.251018] Dynamic subtest bcs0: SUCCESS (0.626s)
[449.263289] Starting dynamic subtest: vcs0
[449.878796] Dynamic subtest vcs0: SUCCESS (0.625s)
[449.890472] Starting dynamic subtest: vcs1
[450.508125] Dynamic subtest vcs1: SUCCESS (0.627s)
[450.519776] Starting dynamic subtest: vecs0
[451.129820] Dynamic subtest vecs0: SUCCESS (0.619s)
[451.130847] Subtest busy-idle-no-semaphores: SUCCESS (3.148s)
[451.233879] [126/130] (592s left) kms_plane_scaling (plane-scaler-with-clipping-clamping-rotation)
[451.320987] Starting subtest: plane-scaler-with-clipping-clamping-rotation
[451.322027] Starting dynamic subtest: pipe-A
[452.346695] Dynamic subtest pipe-A: SKIP (1.024s)
[452.355357] Starting dynamic subtest: pipe-B
[453.458527] Dynamic subtest pipe-B: SKIP (1.111s)
[453.467274] Starting dynamic subtest: pipe-C
[454.550249] Dynamic subtest pipe-C: SKIP (1.090s)
[454.561375] Starting dynamic subtest: pipe-D
[455.740770] Dynamic subtest pipe-D: SKIP (1.190s)
[455.742080] Subtest plane-scaler-with-clipping-clamping-rotation: SKIP (4.419s)
[455.935828] [127/130] (587s left) gem_mmap (short-mmap)
[455.985585] Starting subtest: short-mmap
[455.986282] Subtest short-mmap: SUCCESS (0.000s)
[456.089068] [128/130] (587s left) kms_frontbuffer_tracking (psr-1p-primscrn-indfb-plflip-blt)
[456.178756] Starting subtest: psr-1p-primscrn-indfb-plflip-blt
[456.180104] Subtest psr-1p-primscrn-indfb-plflip-blt: SKIP (0.000s)
[456.290442] [129/130] (587s left) gem_ctx_param (invalid-ctx-set)
[456.325110] Starting subtest: invalid-ctx-set
[456.325807] Subtest invalid-ctx-set: SUCCESS (0.000s)
[456.398478] [130/130] (587s left) i915_suspend (basic-s3-without-i915)
[456.429937] Starting subtest: basic-s3-without-i915