[44.289520] Initializing watchdogs
[44.289591]   /dev/watchdog0
[44.305715] [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]
[44.311255] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[44.313949] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[44.315904] [001/131] (960s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-blt)
[44.414559] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-blt
[44.415954] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-blt: SKIP (0.000s)
[44.504096] [002/131] (960s left) gem_exec_reloc (basic-wc-read-noreloc)
[44.546269] Starting subtest: basic-wc-read-noreloc
[44.550031] Subtest basic-wc-read-noreloc: SUCCESS (0.004s)
[44.665787] [003/131] (960s left) kms_frontbuffer_tracking (fbcpsr-1p-shrfb-fliptrack-mmap-gtt)
[44.755663] Starting subtest: fbcpsr-1p-shrfb-fliptrack-mmap-gtt
[44.757100] Subtest fbcpsr-1p-shrfb-fliptrack-mmap-gtt: SKIP (0.000s)
[44.837882] [004/131] (960s left) syncobj_wait (wait-any-interrupted)
[44.873271] Starting subtest: wait-any-interrupted
[44.982316] Subtest wait-any-interrupted: SUCCESS (0.108s)
[45.049520] [005/131] (959s left) gen9_exec_parse (batch-zero-length)
[45.087297] Subtest batch-zero-length: SKIP (0.000s)
[45.124721] [006/131] (959s left) kms_big_fb (yf-tiled-16bpp-rotate-180)
[45.222472] Starting subtest: yf-tiled-16bpp-rotate-180
[45.223875] Subtest yf-tiled-16bpp-rotate-180: SKIP (0.000s)
[45.303766] [007/131] (959s left) kms_big_fb (4-tiled-8bpp-rotate-180)
[45.398811] Starting subtest: 4-tiled-8bpp-rotate-180
[45.400160] Subtest 4-tiled-8bpp-rotate-180: SKIP (0.000s)
[45.490590] [008/131] (959s left) kms_ccs (crc-primary-suspend-4-tiled-mtl-mc-ccs)
[45.575833] Starting subtest: crc-primary-suspend-4-tiled-mtl-mc-ccs
[45.576554] Starting dynamic subtest: pipe-A-HDMI-A-1
[45.579385] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.000s)
[45.585844] Starting dynamic subtest: pipe-B-HDMI-A-1
[45.588702] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.000s)
[45.595229] Starting dynamic subtest: pipe-C-HDMI-A-1
[45.598084] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.000s)
[45.603908] Starting dynamic subtest: pipe-D-HDMI-A-1
[45.606744] Dynamic subtest pipe-D-HDMI-A-1: SKIP (0.000s)
[45.608209] Subtest crc-primary-suspend-4-tiled-mtl-mc-ccs: SKIP (0.005s)
[45.830687] [009/131] (959s left) kms_flip (2x-plain-flip-interruptible)
[45.922455] Starting subtest: 2x-plain-flip-interruptible
[45.932046] Subtest 2x-plain-flip-interruptible: SKIP (0.009s)
[46.003298] [010/131] (959s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-16bpp-ytile-downscaling)
[46.088934] Starting subtest: flip-64bpp-ytile-to-16bpp-ytile-downscaling
[46.090645] Starting dynamic subtest: pipe-A-valid-mode
[47.124557] Dynamic subtest pipe-A-valid-mode: SUCCESS (1.041s)
[47.127480] Subtest flip-64bpp-ytile-to-16bpp-ytile-downscaling: SUCCESS (1.043s)
[47.263632] [011/131] (957s left) kms_pipe_stress (stress-xrgb8888-untiled)
[47.357621] Starting subtest: stress-xrgb8888-untiled
[53.884340] Subtest stress-xrgb8888-untiled: SUCCESS (6.595s)
[54.023240] [012/131] (951s left) kms_ccs (bad-rotation-90-4-tiled-dg2-mc-ccs)
[54.119196] Starting subtest: bad-rotation-90-4-tiled-dg2-mc-ccs
[54.119893] Starting dynamic subtest: pipe-A-HDMI-A-1
[54.126560] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.000s)
[54.132728] Starting dynamic subtest: pipe-B-HDMI-A-1
[54.139295] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.000s)
[54.145292] Starting dynamic subtest: pipe-C-HDMI-A-1
[54.151866] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.000s)
[54.157847] Starting dynamic subtest: pipe-D-HDMI-A-1
[54.164556] Dynamic subtest pipe-D-HDMI-A-1: SKIP (0.000s)
[54.166185] Subtest bad-rotation-90-4-tiled-dg2-mc-ccs: SKIP (0.004s)
[54.369280] [013/131] (950s left) kms_getfb (getfb2-handle-not-fb)
[54.455408] Starting subtest: getfb2-handle-not-fb
[54.456108] Subtest getfb2-handle-not-fb: SUCCESS (0.000s)
[54.545325] [014/131] (950s left) gem_ctx_create (basic-files)
[54.587164] Starting subtest: basic-files
[56.598750] Subtest basic-files: SUCCESS (2.022s)
[56.772551] [015/131] (948s left) kms_cursor_legacy (single-move)
[56.860724] Starting subtest: single-move
[56.861465] Starting dynamic subtest: pipe-A
[62.258879] Dynamic subtest pipe-A: SUCCESS (5.380s)
[62.264996] Starting dynamic subtest: pipe-B
[67.634806] Dynamic subtest pipe-B: SUCCESS (5.384s)
[67.641458] Starting dynamic subtest: pipe-C
[73.013987] Dynamic subtest pipe-C: SUCCESS (5.383s)
[73.019978] Starting dynamic subtest: pipe-D
[78.391059] Dynamic subtest pipe-D: SUCCESS (5.379s)
[78.397040] Starting dynamic subtest: all-pipes
[83.737094] Dynamic subtest all-pipes: SUCCESS (5.379s)
[83.737837] Subtest single-move: SUCCESS (26.906s)
[83.810628] [016/131] (921s left) kms_vblank (query-forked-busy)
[83.898514] Starting subtest: query-forked-busy
[83.899222] Starting dynamic subtest: pipe-A-HDMI-A-1
[85.194895] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (1.295s)
[85.211476] Starting dynamic subtest: pipe-D-HDMI-A-1
[86.500300] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (1.300s)
[86.501343] Subtest query-forked-busy: SUCCESS (2.601s)
[86.690961] [017/131] (918s left) kms_plane (pixel-format-4-tiled-mtl-rc-ccs-modifier-source-clamping)
[86.781670] Starting subtest: pixel-format-4-tiled-mtl-rc-ccs-modifier-source-clamping
[86.783097] Subtest pixel-format-4-tiled-mtl-rc-ccs-modifier-source-clamping: SKIP (0.000s)
[86.837573] [018/131] (918s left) kms_chamelium_hpd (vga-hpd-without-ddc)
[86.983197] Subtest vga-hpd-without-ddc: SKIP (0.000s)
[87.069861] [019/131] (918s left) kms_chamelium_color (ctm-max)
[87.161367] Subtest ctm-max: SKIP (0.000s)
[87.196442] [020/131] (918s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-onoff)
[87.285639] Starting subtest: psr-1p-primscrn-spr-indfb-onoff
[87.287089] Subtest psr-1p-primscrn-spr-indfb-onoff: SKIP (0.000s)
[87.398700] [021/131] (918s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-mmap-gtt)
[87.487661] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-mmap-gtt
[87.489120] Subtest fbc-2p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[87.600509] [022/131] (917s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-move)
[87.688612] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-move
[87.690010] Subtest fbcpsr-2p-scndscrn-spr-indfb-move: SKIP (0.000s)
[87.782477] [023/131] (917s left) gem_wait (write-busy)
[87.828765] Starting subtest: write-busy
[87.829463] Starting dynamic subtest: all-engines
[88.385023] Dynamic subtest all-engines: SUCCESS (0.557s)
[88.392067] Starting dynamic subtest: rcs0
[88.906946] Dynamic subtest rcs0: SUCCESS (0.522s)
[88.913795] Starting dynamic subtest: bcs0
[89.422904] Dynamic subtest bcs0: SUCCESS (0.516s)
[89.430168] Starting dynamic subtest: vcs0
[89.943119] Dynamic subtest vcs0: SUCCESS (0.520s)
[89.950066] Starting dynamic subtest: vcs1
[90.457134] Dynamic subtest vcs1: SUCCESS (0.514s)
[90.463688] Starting dynamic subtest: vecs0
[90.972954] Dynamic subtest vecs0: SUCCESS (0.515s)
[90.973730] Subtest write-busy: SUCCESS (3.145s)
[91.186852] [FACT gem_wait (write-busy)] new: kernel.kmod_is_loaded.vgem: true
[91.189474] [024/131] (914s left) gem_mmap_gtt (hang-user)
[91.222448] Starting subtest: hang-user
[127.099916] Subtest hang-user: SUCCESS (35.874s)
[127.186740] [025/131] (878s left) kms_ccs (bad-rotation-90-y-tiled-gen12-mc-ccs)
[127.274576] Starting subtest: bad-rotation-90-y-tiled-gen12-mc-ccs
[127.275278] Starting dynamic subtest: pipe-A-HDMI-A-1
[127.282004] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.000s)
[127.288746] Starting dynamic subtest: pipe-B-HDMI-A-1
[127.295368] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.000s)
[127.301994] Starting dynamic subtest: pipe-C-HDMI-A-1
[127.308740] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.000s)
[127.315209] Starting dynamic subtest: pipe-D-HDMI-A-1
[127.321969] Dynamic subtest pipe-D-HDMI-A-1: SKIP (0.000s)
[127.323330] Subtest bad-rotation-90-y-tiled-gen12-mc-ccs: SKIP (0.004s)
[127.512617] [026/131] (878s left) kms_psr2_sf (fbc-pr-overlay-plane-move-continuous-exceed-sf)
[127.600297] Subtest fbc-pr-overlay-plane-move-continuous-exceed-sf: SKIP (0.000s)
[127.642584] [027/131] (878s left) kms_universal_plane (universal-plane-pageflip-windowed)
[127.729736] Starting subtest: universal-plane-pageflip-windowed
[127.730417] Starting dynamic subtest: pipe-A-HDMI-A-1
[128.010084] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.280s)
[128.020265] Starting dynamic subtest: pipe-B-HDMI-A-1
[128.278993] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.267s)
[128.286695] Starting dynamic subtest: pipe-C-HDMI-A-1
[128.534997] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.254s)
[128.543422] Starting dynamic subtest: pipe-D-HDMI-A-1
[128.781919] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.245s)
[128.782642] Subtest universal-plane-pageflip-windowed: SUCCESS (1.053s)
[128.894278] [028/131] (876s left) gem_ctx_isolation (preservation-s3)
[128.936474] Starting subtest: preservation-S3
[128.937191] Starting dynamic subtest: rcs0
[145.534779] Dynamic subtest rcs0: SUCCESS (1.391s)
[145.542339] Starting dynamic subtest: bcs0
[162.509424] Dynamic subtest bcs0: SUCCESS (1.403s)
[162.517404] Starting dynamic subtest: vcs0
[178.520198] Dynamic subtest vcs0: SUCCESS (1.347s)
[178.530904] Starting dynamic subtest: vcs1
[195.521621] Dynamic subtest vcs1: SUCCESS (1.376s)
[195.529845] Starting dynamic subtest: vecs0
[211.530941] Dynamic subtest vecs0: SUCCESS (1.356s)
[211.531688] Subtest preservation-S3: SUCCESS (6.877s)
[220.800070] [029/131] (794s left) kms_fence_pin_leak
[222.291727] [030/131] (792s left) gem_exec_endless (dispatch)
[222.347638] Starting subtest: dispatch
[222.348387] Starting dynamic subtest: rcs0
[222.350855] Dynamic subtest rcs0: SUCCESS (0.003s)
[222.359413] Starting dynamic subtest: bcs0
[222.360865] Dynamic subtest bcs0: SUCCESS (0.003s)
[222.369309] Starting dynamic subtest: vcs0
[222.370658] Dynamic subtest vcs0: SUCCESS (0.003s)
[222.378069] Starting dynamic subtest: vcs1
[222.379428] Dynamic subtest vcs1: SUCCESS (0.003s)
[222.386579] Starting dynamic subtest: vecs0
[222.387990] Dynamic subtest vecs0: SUCCESS (0.003s)
[222.388660] Subtest dispatch: SUCCESS (0.019s)
[222.492529] [031/131] (792s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-pwrite)
[222.583481] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-pwrite
[222.584917] Subtest psr-2p-primscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[222.670872] [032/131] (792s left) kms_psr (fbc-psr2-cursor-blt)
[222.757524] Subtest fbc-psr2-cursor-blt: SKIP (0.000s)
[222.803914] [033/131] (792s left) gem_exec_whisper (basic-sync-all)
[222.847552] Starting subtest: basic-sync-all
[224.516573] Subtest basic-sync-all: SUCCESS (1.685s)
[224.705374] [034/131] (790s left) kms_feature_discovery (display)
[224.791294] Starting subtest: display
[224.791992] Subtest display: SUCCESS (0.000s)
[224.867791] [035/131] (790s left) kms_rotation_crc (bad-tiling)
[224.954759] Starting subtest: bad-tiling
[226.448646] Subtest bad-tiling: SUCCESS (1.507s)
[226.619292] [036/131] (788s left) kms_big_fb (yf-tiled-addfb-size-offset-overflow)
[226.720220] Starting subtest: yf-tiled-addfb-size-offset-overflow
[226.721606] Subtest yf-tiled-addfb-size-offset-overflow: SKIP (0.000s)
[226.827765] [037/131] (788s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-render)
[226.917420] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-render
[226.918802] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-render: SKIP (0.000s)
[227.017546] [038/131] (788s left) kms_chamelium_edid (vga-edid-read)
[227.161064] Subtest vga-edid-read: SKIP (0.000s)
[227.252378] [039/131] (788s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-mmap-wc)
[227.348535] Starting subtest: psr-1p-primscrn-pri-indfb-draw-mmap-wc
[227.349982] Subtest psr-1p-primscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[227.459577] [040/131] (787s left) syncobj_timeline (wait-all-for-submit-snapshot)
[227.495441] Starting subtest: wait-all-for-submit-snapshot
[227.578889] Subtest wait-all-for-submit-snapshot: SUCCESS (0.083s)
[227.654112] [041/131] (787s left) kms_big_fb (4-tiled-16bpp-rotate-270)
[227.749848] Starting subtest: 4-tiled-16bpp-rotate-270
[227.751248] Subtest 4-tiled-16bpp-rotate-270: SKIP (0.000s)
[227.855620] [042/131] (787s left) kms_plane_scaling (planes-downscale-factor-0-75)
[227.943417] Starting subtest: planes-downscale-factor-0-75
[227.944410] Starting dynamic subtest: pipe-A
[228.073283] Dynamic subtest pipe-A: SUCCESS (0.130s)
[228.082642] Starting dynamic subtest: pipe-B
[228.206978] Dynamic subtest pipe-B: SUCCESS (0.134s)
[228.217747] Starting dynamic subtest: pipe-C
[228.342465] Dynamic subtest pipe-C: SUCCESS (0.135s)
[228.351399] Starting dynamic subtest: pipe-D
[228.485948] Dynamic subtest pipe-D: SUCCESS (0.144s)
[228.486718] Subtest planes-downscale-factor-0-75: SUCCESS (0.547s)
[228.665765] [043/131] (786s left) kms_cursor_crc (cursor-onscreen-128x128)
[228.759154] Starting subtest: cursor-onscreen-128x128
[228.767978] Starting dynamic subtest: pipe-A-HDMI-A-1
[229.939207] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (1.176s)
[229.976928] Starting dynamic subtest: pipe-D-HDMI-A-1
[231.118368] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (1.157s)
[231.119135] Subtest cursor-onscreen-128x128: SUCCESS (2.370s)
[231.272545] [044/131] (784s left) i915_selftest (live)
[232.218006] Starting subtest: live
[232.218791] Starting dynamic subtest: sanitycheck
[233.424518] Dynamic subtest sanitycheck: SUCCESS (1.210s)
[233.440827] Starting dynamic subtest: uncore
[234.668570] Dynamic subtest uncore: SUCCESS (1.245s)
[234.677944] Starting dynamic subtest: workarounds
[236.298366] Dynamic subtest workarounds: SUCCESS (1.632s)
[236.306056] Starting dynamic subtest: gt_engines
[238.097512] Dynamic subtest gt_engines: SUCCESS (1.801s)
[238.109761] Starting dynamic subtest: gt_timelines
[246.593253] Dynamic subtest gt_timelines: SUCCESS (8.505s)
[246.601182] Starting dynamic subtest: gt_contexts
[247.959477] Dynamic subtest gt_contexts: SUCCESS (1.365s)
[247.966853] Starting dynamic subtest: gt_lrc
[252.226297] Dynamic subtest gt_lrc: SUCCESS (4.266s)
[252.232920] Starting dynamic subtest: gt_mocs
[253.583468] Dynamic subtest gt_mocs: SUCCESS (1.354s)
[253.590816] Starting dynamic subtest: gt_pm
[275.054625] Dynamic subtest gt_pm: SUCCESS (21.471s)
[275.070917] Starting dynamic subtest: gt_heartbeat
[276.291340] Dynamic subtest gt_heartbeat: SUCCESS (1.235s)
[276.298666] Starting dynamic subtest: gt_tlb
[279.750528] Dynamic subtest gt_tlb: SUCCESS (3.458s)
[279.757313] Starting dynamic subtest: requests
[288.398303] Dynamic subtest requests: SUCCESS (8.648s)
[288.410588] Starting dynamic subtest: migrate
[292.760496] Dynamic subtest migrate: SUCCESS (4.361s)
[292.772109] Starting dynamic subtest: active
[294.038006] Dynamic subtest active: SUCCESS (1.283s)
[294.047822] Starting dynamic subtest: objects
[295.770378] Dynamic subtest objects: SUCCESS (1.723s)
[295.778568] Starting dynamic subtest: mman
[300.497448] Dynamic subtest mman: SUCCESS (4.727s)
[300.505762] Starting dynamic subtest: dmabuf
[301.798443] Dynamic subtest dmabuf: SUCCESS (1.299s)
[301.808414] Starting dynamic subtest: vma
[303.135384] Dynamic subtest vma: SUCCESS (1.335s)
[303.142615] Starting dynamic subtest: coherency
[305.947611] Dynamic subtest coherency: SUCCESS (2.811s)
[305.959190] Starting dynamic subtest: gtt
[314.798384] Dynamic subtest gtt: SUCCESS (8.852s)
[314.805961] Starting dynamic subtest: gem
[316.999216] Dynamic subtest gem: SUCCESS (2.198s)
[317.007425] Starting dynamic subtest: evict
[319.239357] Dynamic subtest evict: SUCCESS (2.237s)
[319.251125] Starting dynamic subtest: hugepages
[326.991312] Dynamic subtest hugepages: SUCCESS (7.747s)
[326.999220] Starting dynamic subtest: gem_contexts
[342.458346] Dynamic subtest gem_contexts: SUCCESS (15.463s)
[342.465456] Starting dynamic subtest: client
[343.784430] Dynamic subtest client: SUCCESS (1.324s)
[343.792046] Starting dynamic subtest: gem_migrate
[345.005443] Dynamic subtest gem_migrate: SUCCESS (1.219s)
[345.013541] Starting dynamic subtest: reset
[349.961304] Dynamic subtest reset: SUCCESS (4.954s)
[349.968886] Starting dynamic subtest: memory_region
[351.175447] Dynamic subtest memory_region: SUCCESS (1.212s)
[351.183204] Starting dynamic subtest: hangcheck
[381.197141] Dynamic subtest hangcheck: SUCCESS (30.032s)
[381.215191] Starting dynamic subtest: execlists
[395.008331] Dynamic subtest execlists: SUCCESS (13.803s)
[395.015943] Starting dynamic subtest: ring_submission
[396.256410] Dynamic subtest ring_submission: SUCCESS (1.246s)
[396.269203] Starting dynamic subtest: perf
[397.605333] Dynamic subtest perf: SUCCESS (1.347s)
[397.613137] Starting dynamic subtest: slpc
[398.819229] Dynamic subtest slpc: SUCCESS (1.212s)
[398.827171] Starting dynamic subtest: guc
[400.081465] Dynamic subtest guc: SUCCESS (1.260s)
[400.089049] Starting dynamic subtest: guc_multi_lrc
[401.287378] Dynamic subtest guc_multi_lrc: SUCCESS (1.204s)
[401.303790] Starting dynamic subtest: guc_hang
[402.526521] Dynamic subtest guc_hang: SUCCESS (1.237s)
[402.543076] Starting dynamic subtest: late_gt_pm
[403.828384] Dynamic subtest late_gt_pm: SUCCESS (1.300s)
[403.829220] Subtest live: SUCCESS (171.664s)
[403.868635] [FACT i915_selftest (live)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[403.869430] [FACT i915_selftest (live)] deleted: kernel.kmod_is_loaded.i915: true
[403.872580] [045/131] (611s left) gem_exec_schedule (preempt-queue)
[404.933134] Starting subtest: preempt-queue
[404.933967] Starting dynamic subtest: rcs0
[405.063172] Dynamic subtest rcs0: SUCCESS (0.121s)
[405.072338] Starting dynamic subtest: bcs0
[405.160152] Dynamic subtest bcs0: SUCCESS (0.104s)
[405.170660] Starting dynamic subtest: vcs0
[405.269287] Dynamic subtest vcs0: SUCCESS (0.108s)
[405.278861] Starting dynamic subtest: vcs1
[405.379042] Dynamic subtest vcs1: SUCCESS (0.109s)
[405.389650] Starting dynamic subtest: vecs0
[405.491908] Dynamic subtest vecs0: SUCCESS (0.112s)
[405.492690] Subtest preempt-queue: SUCCESS (0.559s)
[405.786512] [FACT gem_exec_schedule (preempt-queue)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[405.788102] [FACT gem_exec_schedule (preempt-queue)] new: kernel.kmod_is_loaded.i915: true
[405.792646] [046/131] (609s left) kms_lease (lease-get)
[405.881654] Starting subtest: lease-get
[405.882427] Starting dynamic subtest: pipe-A-HDMI-A-1
[405.883156] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.001s)
[405.893581] Starting dynamic subtest: pipe-B-HDMI-A-1
[405.894389] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.001s)
[405.907203] Starting dynamic subtest: pipe-C-HDMI-A-1
[405.908852] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.001s)
[405.917790] Starting dynamic subtest: pipe-D-HDMI-A-1
[405.919364] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.001s)
[405.920843] Subtest lease-get: SUCCESS (0.010s)
[405.959928] [047/131] (609s left) i915_pm_rc6_residency (media-rc6-accuracy)
[405.996641] Starting subtest: media-rc6-accuracy
[405.998089] Subtest media-rc6-accuracy: SKIP (0.000s)
[406.057021] [048/131] (609s left) kms_psr (psr-cursor-plane-move)
[406.146407] Subtest psr-cursor-plane-move: SKIP (0.000s)
[406.187477] [049/131] (609s left) intel_hwmon (hwmon-write)
[406.221151] Subtest hwmon-write: SKIP (0.000s)
[406.261523] [050/131] (609s left) kms_force_connector_basic (force-connector-state)
[406.385671] Starting subtest: force-connector-state
[406.690003] Subtest force-connector-state: SUCCESS (0.304s)
[406.968041] [051/131] (608s left) kms_big_fb (x-tiled-32bpp-rotate-0)
[407.071722] Starting subtest: x-tiled-32bpp-rotate-0
[408.514574] Subtest x-tiled-32bpp-rotate-0: SUCCESS (1.449s)
[408.642751] [052/131] (607s left) core_auth (many-magics)
[408.678025] Starting subtest: many-magics
[409.186966] Subtest many-magics: SUCCESS (0.510s)
[409.303655] [053/131] (606s left) gem_exec_balancer (parallel-bb-first)
[409.464585] Subtest parallel-bb-first: SKIP (0.000s)
[409.554239] [054/131] (606s left) kms_psr2_sf (pr-overlay-plane-move-continuous-exceed-fully-sf)
[409.646059] Subtest pr-overlay-plane-move-continuous-exceed-fully-sf: SKIP (0.000s)
[409.688843] [055/131] (606s left) syncobj_wait (multi-wait-all-submitted)
[409.724289] Starting subtest: multi-wait-all-submitted
[409.827439] Subtest multi-wait-all-submitted: SUCCESS (0.103s)
[409.904579] [056/131] (606s left) gem_set_tiling_vs_gtt
[410.365413] [057/131] (605s left) gem_spin_batch (resubmit-new-all)
[410.406849] Starting subtest: resubmit-new-all
[410.407610] Starting dynamic subtest: rcs0
[410.412506] Dynamic subtest rcs0: SUCCESS (0.005s)
[410.423826] Starting dynamic subtest: bcs0
[410.424700] Dynamic subtest bcs0: SUCCESS (0.004s)
[410.434643] Starting dynamic subtest: vcs0
[410.435420] Dynamic subtest vcs0: SUCCESS (0.005s)
[410.444224] Starting dynamic subtest: vcs1
[410.444928] Dynamic subtest vcs1: SUCCESS (0.005s)
[410.453079] Starting dynamic subtest: vecs0
[410.453779] Dynamic subtest vecs0: SUCCESS (0.004s)
[410.454468] Subtest resubmit-new-all: SUCCESS (0.029s)
[410.621589] [058/131] (605s left) kms_pwrite_crc (basic)
[410.713117] Starting subtest: basic
[411.023251] Subtest basic: SUCCESS (0.311s)
[411.166552] [059/131] (604s left) kms_color_pipeline (plane-lut1d-ctm3x4-lut1d)
[411.256383] Starting subtest: plane-lut1d-ctm3x4-lut1d
[411.345954] Starting dynamic subtest: pipe-A-plane-0
[411.443318] Dynamic subtest pipe-A-plane-0: SUCCESS (0.099s)
[411.461132] Starting dynamic subtest: pipe-A-plane-1
[411.534925] Dynamic subtest pipe-A-plane-1: SUCCESS (0.089s)
[411.551181] Starting dynamic subtest: pipe-A-plane-2
[411.626581] Dynamic subtest pipe-A-plane-2: SUCCESS (0.089s)
[411.829530] Starting dynamic subtest: pipe-B-plane-0
[411.907787] Dynamic subtest pipe-B-plane-0: SUCCESS (0.091s)
[411.922569] Starting dynamic subtest: pipe-B-plane-1
[411.999849] Dynamic subtest pipe-B-plane-1: SUCCESS (0.089s)
[412.014226] Starting dynamic subtest: pipe-B-plane-2
[412.091572] Dynamic subtest pipe-B-plane-2: SUCCESS (0.089s)
[412.307559] Starting dynamic subtest: pipe-C-plane-0
[412.386344] Dynamic subtest pipe-C-plane-0: SUCCESS (0.090s)
[412.404366] Starting dynamic subtest: pipe-C-plane-1
[412.485227] Dynamic subtest pipe-C-plane-1: SUCCESS (0.099s)
[412.499656] Starting dynamic subtest: pipe-C-plane-2
[412.584794] Dynamic subtest pipe-C-plane-2: SUCCESS (0.097s)
[412.782294] Starting dynamic subtest: pipe-D-plane-0
[412.868832] Dynamic subtest pipe-D-plane-0: SUCCESS (0.099s)
[412.882114] Starting dynamic subtest: pipe-D-plane-1
[412.968819] Dynamic subtest pipe-D-plane-1: SUCCESS (0.098s)
[412.982147] Starting dynamic subtest: pipe-D-plane-2
[413.068726] Dynamic subtest pipe-D-plane-2: SUCCESS (0.097s)
[413.117452] Subtest plane-lut1d-ctm3x4-lut1d: SUCCESS (1.861s)
[413.242919] [060/131] (602s left) kms_flip_scaled_crc (flip-32bpp-4tile-to-64bpp-4tile-downscaling)
[413.333750] Starting subtest: flip-32bpp-4tile-to-64bpp-4tile-downscaling
[413.335244] Subtest flip-32bpp-4tile-to-64bpp-4tile-downscaling: SKIP (0.000s)
[413.397624] [061/131] (602s left) perf_pmu (all-busy-check-all)
[413.435131] Starting subtest: all-busy-check-all
[413.959068] Subtest all-busy-check-all: SUCCESS (0.524s)
[414.039487] [062/131] (602s left) gem_ctx_bad_destroy (invalid-ctx)
[414.080964] Starting subtest: invalid-ctx
[414.081675] Subtest invalid-ctx: SUCCESS (0.000s)
[414.145729] [063/131] (602s left) kms_force_connector_basic (force-load-detect)
[414.269646] Starting subtest: force-load-detect
[414.272927] Subtest force-load-detect: SKIP (0.000s)
[414.431493] [064/131] (601s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-mmap-wc)
[414.524708] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-mmap-wc
[414.526188] Subtest psr-2p-scndscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[414.614277] [065/131] (601s left) sriov_basic (enable-vfs-bind-unbind-each-numvfs-all)
[414.649422] Starting subtest: enable-vfs-bind-unbind-each-numvfs-all
[414.673978] Subtest enable-vfs-bind-unbind-each-numvfs-all: FAIL (0.012s)
[414.728510] [066/131] (601s left) perf_pmu (busy-idle)
[414.764001] Starting subtest: busy-idle
[414.764742] Starting dynamic subtest: rcs0
[415.416990] Dynamic subtest rcs0: SUCCESS (0.652s)
[415.430267] Starting dynamic subtest: bcs0
[416.058143] Dynamic subtest bcs0: SUCCESS (0.636s)
[416.069121] Starting dynamic subtest: vcs0
[416.691894] Dynamic subtest vcs0: SUCCESS (0.632s)
[416.710909] Starting dynamic subtest: vcs1
[417.326831] Dynamic subtest vcs1: SUCCESS (0.634s)
[417.337764] Starting dynamic subtest: vecs0
[417.960116] Dynamic subtest vecs0: SUCCESS (0.631s)
[417.961203] Subtest busy-idle: SUCCESS (3.196s)
[418.045338] [067/131] (598s left) sw_sync (timeline_closed)
[418.079732] Starting subtest: timeline_closed
[418.080449] Subtest timeline_closed: SUCCESS (0.000s)
[418.141341] [068/131] (598s left) syncobj_wait (wait-any-complex)
[418.177548] Starting subtest: wait-any-complex
[418.239510] Subtest wait-any-complex: SUCCESS (0.062s)
[418.314677] [069/131] (598s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-mmap-gtt)
[418.407409] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-mmap-gtt
[418.408786] Subtest fbc-2p-scndscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[418.508525] [070/131] (598s left) gem_exec_params (dr1-dirt)
[418.547671] Starting subtest: DR1-dirt
[418.548440] Subtest DR1-dirt: SUCCESS (0.000s)
[418.637096] [071/131] (598s left) kms_psr (pr-cursor-blt)
[418.728852] Subtest pr-cursor-blt: SKIP (0.000s)
[418.776930] [072/131] (597s left) kms_ccs (random-ccs-data-4-tiled-dg2-mc-ccs)
[418.864764] Starting subtest: random-ccs-data-4-tiled-dg2-mc-ccs
[418.865465] Starting dynamic subtest: pipe-A-HDMI-A-1
[418.872781] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.000s)
[418.881444] Starting dynamic subtest: pipe-B-HDMI-A-1
[418.888772] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.000s)
[418.897159] Starting dynamic subtest: pipe-C-HDMI-A-1
[418.904466] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.000s)
[418.912932] Starting dynamic subtest: pipe-D-HDMI-A-1
[418.920437] Dynamic subtest pipe-D-HDMI-A-1: SKIP (0.000s)
[418.921789] Subtest random-ccs-data-4-tiled-dg2-mc-ccs: SKIP (0.007s)
[419.103212] [073/131] (597s left) gem_pread (self)
[419.138220] Starting subtest: self
[419.144147] Subtest self: SUCCESS (0.007s)
[419.240924] [074/131] (597s left) kms_plane (plane-panning-bottom-right)
[419.327829] Starting subtest: plane-panning-bottom-right
[419.328522] Starting dynamic subtest: pipe-A
[419.723372] Dynamic subtest pipe-A: SUCCESS (0.394s)
[419.732891] Starting dynamic subtest: pipe-B
[420.075280] Dynamic subtest pipe-B: SUCCESS (0.350s)
[420.075998] Subtest plane-panning-bottom-right: SUCCESS (0.748s)
[420.199967] [075/131] (596s left) gem_exec_whisper (basic-fds-all)
[420.245618] Starting subtest: basic-fds-all
[422.815856] Subtest basic-fds-all: SUCCESS (2.571s)
[423.011853] [076/131] (593s left) kms_big_fb (linear-64bpp-rotate-270)
[423.111454] Starting subtest: linear-64bpp-rotate-270
[423.160229] Subtest linear-64bpp-rotate-270: SKIP (0.048s)
[423.262032] [077/131] (593s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-indfb-draw-blt)
[423.355296] Starting subtest: fbc-1p-offscreen-pri-indfb-draw-blt
[424.495676] Subtest fbc-1p-offscreen-pri-indfb-draw-blt: SUCCESS (1.140s)
[424.637930] [078/131] (592s left) core_getversion (all-cards)
[424.671626] Starting subtest: all-cards
[424.686240] Subtest all-cards: SUCCESS (0.016s)
[424.728420] [079/131] (592s left) api_intel_allocator (gem-pool)
[424.761724] Starting subtest: gem-pool
[424.767184] Subtest gem-pool: SUCCESS (0.005s)
[424.882308] [080/131] (592s left) i915_drm_fdinfo (busy)
[424.919108] Starting subtest: busy
[424.919944] Starting dynamic subtest: rcs0
[425.439879] Dynamic subtest rcs0: SUCCESS (0.520s)
[425.454758] Starting dynamic subtest: bcs0
[425.964441] Dynamic subtest bcs0: SUCCESS (0.522s)
[425.979391] Starting dynamic subtest: vcs0
[426.487303] Dynamic subtest vcs0: SUCCESS (0.520s)
[426.499920] Starting dynamic subtest: vcs1
[427.016339] Dynamic subtest vcs1: SUCCESS (0.528s)
[427.028821] Starting dynamic subtest: vecs0
[427.540095] Dynamic subtest vecs0: SUCCESS (0.522s)
[427.543213] Subtest busy: SUCCESS (2.623s)
[427.615037] [081/131] (589s left) kms_cursor_legacy (cursor-vs-flip-toggle)
[427.705370] Starting subtest: cursor-vs-flip-toggle
[459.580608] Subtest cursor-vs-flip-toggle: SUCCESS (31.875s)
[459.710020] [082/131] (557s left) gem_pxp (protected-encrypted-src-copy-not-readible)
[459.812084] Starting subtest: protected-encrypted-src-copy-not-readible
[459.896968] Subtest protected-encrypted-src-copy-not-readible: SUCCESS (0.086s)
[460.018978] [083/131] (557s left) gem_userptr_blits (map-fixed-invalidate-busy)
[460.064641] Starting subtest: map-fixed-invalidate-busy
[460.065477] Starting dynamic subtest: gtt
[461.670827] Dynamic subtest gtt: SUCCESS (1.597s)
[461.679983] Starting dynamic subtest: wb
[463.213525] Dynamic subtest wb: SUCCESS (1.541s)
[463.222342] Starting dynamic subtest: wc
[464.741305] Dynamic subtest wc: SUCCESS (1.525s)
[464.750266] Starting dynamic subtest: uc
[466.318104] Dynamic subtest uc: SUCCESS (1.575s)
[466.318864] Subtest map-fixed-invalidate-busy: SUCCESS (6.244s)
[466.450423] [084/131] (550s left) gem_create (create-ext-cpu-access-big)
[466.596814] Starting subtest: create-ext-cpu-access-big
[466.599375] Subtest create-ext-cpu-access-big: SKIP (0.000s)
[466.679989] [085/131] (550s left) syncobj_wait (multi-wait-all-signaled)
[466.720944] Starting subtest: multi-wait-all-signaled
[466.721666] Subtest multi-wait-all-signaled: SUCCESS (0.000s)
[466.790680] [086/131] (550s left) gem_ctx_persistence (legacy-engines-cleanup)
[466.828355] Starting subtest: legacy-engines-cleanup
[466.829074] Starting dynamic subtest: render
[466.872303] Dynamic subtest render: SUCCESS (0.043s)
[466.894928] Starting dynamic subtest: bsd1
[466.920484] Dynamic subtest bsd1: SUCCESS (0.045s)
[466.940745] Starting dynamic subtest: bsd2
[466.970361] Dynamic subtest bsd2: SUCCESS (0.046s)
[466.990342] Starting dynamic subtest: blt
[467.030425] Dynamic subtest blt: SUCCESS (0.056s)
[467.051153] Starting dynamic subtest: vebox
[467.072271] Dynamic subtest vebox: SUCCESS (0.039s)
[467.073384] Subtest legacy-engines-cleanup: SUCCESS (0.245s)
[467.172067] [087/131] (550s left) syncobj_timeline (invalid-multi-wait-all-unsubmitted-submitted-signaled)
[467.207274] Starting subtest: invalid-multi-wait-all-unsubmitted-submitted-signaled
[467.208035] Subtest invalid-multi-wait-all-unsubmitted-submitted-signaled: SUCCESS (0.000s)
[467.268474] [088/131] (550s left) gem_mmap_gtt (cpuset-basic-small-copy-xy)
[467.302629] Starting subtest: cpuset-basic-small-copy-XY
[472.930833] Subtest cpuset-basic-small-copy-XY: SUCCESS (5.626s)
[473.001906] [089/131] (544s left) kms_cursor_crc (cursor-random-64x64)
[473.144352] Starting subtest: cursor-random-64x64
[473.148995] Starting dynamic subtest: pipe-A-HDMI-A-1
[475.081833] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (1.932s)
[475.118787] Starting dynamic subtest: pipe-D-HDMI-A-1
[476.990737] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (1.883s)
[476.991497] Subtest cursor-random-64x64: SUCCESS (3.847s)
[477.154482] [090/131] (540s left) gem_exec_await (wide-all)
[477.246227] Starting subtest: wide-all
[498.947614] Subtest wide-all: SUCCESS (21.665s)
[499.121662] [091/131] (518s left) core_setmaster (master-drop-set-user)
[499.244432] Starting subtest: master-drop-set-user
[499.256238] Subtest master-drop-set-user: SUCCESS (0.012s)
[499.293407] [092/131] (518s left) kms_big_fb (y-tiled-64bpp-rotate-180)
[499.398132] Starting subtest: y-tiled-64bpp-rotate-180
[500.969977] Subtest y-tiled-64bpp-rotate-180: SUCCESS (1.572s)
[501.091304] [093/131] (516s left) gem_exec_schedule (smoketest)
[501.263216] Starting subtest: smoketest
[501.265819] Starting dynamic subtest: rcs0
[506.702979] Dynamic subtest rcs0: SUCCESS (5.420s)
[506.716991] Starting dynamic subtest: bcs0
[512.155641] Dynamic subtest bcs0: SUCCESS (5.429s)
[512.167046] Starting dynamic subtest: vcs0
[517.573851] Dynamic subtest vcs0: SUCCESS (5.418s)
[517.585666] Starting dynamic subtest: vcs1
[522.996856] Dynamic subtest vcs1: SUCCESS (5.422s)
[523.008517] Starting dynamic subtest: vecs0
[528.424000] Dynamic subtest vecs0: SUCCESS (5.425s)
[528.424940] Subtest smoketest: SUCCESS (27.121s)
[528.584388] [094/131] (489s left) prime_vgem (wait)
[528.628609] Starting subtest: wait
[528.629301] Starting dynamic subtest: rcs0
[528.664725] Dynamic subtest rcs0: SUCCESS (0.035s)
[528.679826] Starting dynamic subtest: bcs0
[528.681664] Dynamic subtest bcs0: SUCCESS (0.016s)
[528.692007] Starting dynamic subtest: vcs0
[528.698756] Dynamic subtest vcs0: SUCCESS (0.016s)
[528.710109] Starting dynamic subtest: vcs1
[528.716351] Dynamic subtest vcs1: SUCCESS (0.017s)
[528.727402] Starting dynamic subtest: vecs0
[528.733346] Dynamic subtest vecs0: SUCCESS (0.016s)
[528.734027] Subtest wait: SUCCESS (0.105s)
[528.837975] [095/131] (488s left) gem_ctx_shared (exec-single-timeline)
[528.881624] Starting subtest: exec-single-timeline
[528.882384] Starting dynamic subtest: rcs0
[529.955717] Dynamic subtest rcs0: SUCCESS (1.065s)
[529.967506] Starting dynamic subtest: bcs0
[530.980152] Dynamic subtest bcs0: SUCCESS (1.022s)
[530.990364] Starting dynamic subtest: vcs0
[532.003613] Dynamic subtest vcs0: SUCCESS (1.021s)
[532.014829] Starting dynamic subtest: vcs1
[533.027663] Dynamic subtest vcs1: SUCCESS (1.022s)
[533.038294] Starting dynamic subtest: vecs0
[534.051786] Dynamic subtest vecs0: SUCCESS (1.022s)
[534.052788] Subtest exec-single-timeline: SUCCESS (5.163s)
[534.237268] [096/131] (483s left) kms_plane_multiple (tiling-yf)
[534.327583] Starting subtest: tiling-yf
[534.328953] Subtest tiling-yf: SKIP (0.000s)
[534.385674] [097/131] (483s left) kms_psr (fbc-psr-cursor-plane-move)
[534.473278] Subtest fbc-psr-cursor-plane-move: SKIP (0.000s)
[534.514727] [098/131] (483s left) syncobj_timeline (multi-wait-all-signaled)
[534.549719] Starting subtest: multi-wait-all-signaled
[534.550394] Subtest multi-wait-all-signaled: SUCCESS (0.001s)
[534.611605] [099/131] (483s left) syncobj_wait (wait-zero-handles)
[534.647005] Starting subtest: wait-zero-handles
[534.647766] Subtest wait-zero-handles: SUCCESS (0.000s)
[534.713627] [100/131] (483s left) kms_invalid_mode (bad-hsync-start)
[534.800278] Starting subtest: bad-hsync-start
[534.802169] Starting dynamic subtest: pipe-A-HDMI-A-1
[534.856570] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.054s)
[534.866335] Starting dynamic subtest: pipe-B-HDMI-A-1
[534.867045] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.001s)
[534.877590] Starting dynamic subtest: pipe-C-HDMI-A-1
[534.878299] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.001s)
[534.887322] Starting dynamic subtest: pipe-D-HDMI-A-1
[534.888024] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.001s)
[534.888737] Subtest bad-hsync-start: SUCCESS (0.063s)
[534.989050] [101/131] (482s left) kms_cursor_legacy (2x-long-flip-vs-cursor-legacy)
[535.076816] Starting subtest: 2x-long-flip-vs-cursor-legacy
[535.078834] Subtest 2x-long-flip-vs-cursor-legacy: SKIP (0.002s)
[535.141757] [102/131] (482s left) gem_exec_reloc (basic-write-gtt-noreloc)
[535.180701] Starting subtest: basic-write-gtt-noreloc
[535.183293] Subtest basic-write-gtt-noreloc: SUCCESS (0.003s)
[535.292379] [103/131] (482s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-fullscreen)
[535.381504] Starting subtest: fbc-1p-primscrn-spr-indfb-fullscreen
[536.339620] Subtest fbc-1p-primscrn-spr-indfb-fullscreen: SUCCESS (0.958s)
[536.461671] [104/131] (481s left) gem_ringfill (engines-basic)
[536.676330] Starting subtest: engines-basic
[536.677452] Starting dynamic subtest: rcs0
[536.706464] Dynamic subtest rcs0: SUCCESS (0.029s)
[536.726608] Starting dynamic subtest: bcs0
[536.730601] Dynamic subtest bcs0: SUCCESS (0.022s)
[536.742177] Starting dynamic subtest: vcs0
[536.749526] Dynamic subtest vcs0: SUCCESS (0.018s)
[536.760965] Starting dynamic subtest: vcs1
[536.767505] Dynamic subtest vcs1: SUCCESS (0.017s)
[536.778823] Starting dynamic subtest: vecs0
[536.791827] Dynamic subtest vecs0: SUCCESS (0.023s)
[536.792690] Subtest engines-basic: SUCCESS (0.116s)
[536.860448] [105/131] (481s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-render)
[536.971537] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-render
[536.972868] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-render: SKIP (0.000s)
[537.043884] [106/131] (481s left) gem_busy (semaphore)
[537.226421] Starting subtest: semaphore
[537.227356] Starting dynamic subtest: rcs0
[537.257237] Dynamic subtest rcs0: SUCCESS (0.040s)
[537.275294] Starting dynamic subtest: bcs0
[537.279569] Dynamic subtest bcs0: SUCCESS (0.020s)
[537.292666] Starting dynamic subtest: vcs0
[537.303678] Dynamic subtest vcs0: SUCCESS (0.023s)
[537.316191] Starting dynamic subtest: vcs1
[537.328975] Dynamic subtest vcs1: SUCCESS (0.024s)
[537.342740] Starting dynamic subtest: vecs0
[537.349559] Dynamic subtest vecs0: SUCCESS (0.019s)
[537.350259] Subtest semaphore: SUCCESS (0.135s)
[537.574150] [107/131] (480s left) gem_exec_suspend (basic)
[537.616882] Starting subtest: basic
[537.617603] Starting dynamic subtest: smem
[538.088277] Dynamic subtest smem: SUCCESS (0.471s)
[538.088964] Subtest basic: SUCCESS (0.472s)
[538.271432] [108/131] (479s left) kms_content_protection (lic-type-0-hdcp14)
[538.365226] Starting subtest: lic-type-0-hdcp14
[538.371379] Subtest lic-type-0-hdcp14: SKIP (0.004s)
[538.459967] [109/131] (479s left) gem_exec_fence (syncobj-repeat)
[538.788592] Starting subtest: syncobj-repeat
[539.067294] Subtest syncobj-repeat: SUCCESS (0.271s)
[539.351596] [110/131] (478s left) gem_eio (wait-immediate)
[539.399732] Starting subtest: wait-immediate
[539.563374] Subtest wait-immediate: SUCCESS (0.162s)
[539.685617] [111/131] (478s left) i915_pm_freq_mult (media-freq)
[539.721132] Starting subtest: media-freq
[539.721896] Starting dynamic subtest: gt0
[539.723409] Dynamic subtest gt0: SKIP (0.000s)
[539.724835] Subtest media-freq: SKIP (0.001s)
[539.789375] [112/131] (478s left) kms_psr (fbc-pr-cursor-render)
[539.878995] Subtest fbc-pr-cursor-render: SKIP (0.000s)
[539.925035] [113/131] (478s left) syncobj_timeline (invalid-multi-wait-all-unsubmitted)
[539.960141] Starting subtest: invalid-multi-wait-all-unsubmitted
[539.960856] Subtest invalid-multi-wait-all-unsubmitted: SUCCESS (0.000s)
[540.038848] [114/131] (478s left) gem_partial_pwrite_pread (reads)
[540.080920] Starting subtest: reads
[541.920623] Subtest reads: SUCCESS (1.844s)
[542.042073] [115/131] (476s left) kms_rotation_crc (primary-y-tiled-reflect-x-90)
[542.131812] Starting subtest: primary-y-tiled-reflect-x-90
[547.127852] Subtest primary-y-tiled-reflect-x-90: SUCCESS (4.996s)
[547.340395] [116/131] (471s left) gem_exec_create (basic)
[547.386729] Starting subtest: basic
[547.387417] Starting dynamic subtest: smem
[549.428091] Dynamic subtest smem: SUCCESS (2.042s)
[549.428803] Subtest basic: SUCCESS (2.043s)
[549.621020] [117/131] (469s left) gem_exec_params (readonly)
[549.659502] Starting subtest: readonly
[549.660317] Subtest readonly: SUCCESS (0.001s)
[549.778476] [118/131] (468s left) gem_wait (invalid-buf)
[549.817736] Starting subtest: invalid-buf
[549.818461] Subtest invalid-buf: SUCCESS (0.000s)
[550.032990] [119/131] (468s left) prime_self_import (basic-llseek-size)
[550.067775] Starting subtest: basic-llseek-size
[550.070437] Subtest basic-llseek-size: SUCCESS (0.003s)
[550.157822] [120/131] (468s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-180)
[550.257378] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-180
[550.901289] Subtest y-tiled-max-hw-stride-32bpp-rotate-180: SUCCESS (0.644s)
[551.046944] [121/131] (467s left) kms_pm_dc (dc3co-vpb-simulation)
[562.194707] Starting subtest: dc3co-vpb-simulation
[562.196137] Subtest dc3co-vpb-simulation: SKIP (0.000s)
[562.254397] [122/131] (456s left) kms_vrr (seamless-rr-switch-virtual-full)
[562.343005] Starting subtest: seamless-rr-switch-virtual-full
[562.345065] Subtest seamless-rr-switch-virtual-full: SKIP (0.000s)
[562.404943] [123/131] (456s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-blt)
[562.495726] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-blt
[562.497154] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-blt: SKIP (0.000s)
[562.589746] [124/131] (456s left) kms_flip (2x-flip-vs-fences)
[562.676445] Starting subtest: 2x-flip-vs-fences
[562.685663] Subtest 2x-flip-vs-fences: SKIP (0.009s)
[562.755655] [125/131] (456s left) perf (non-sampling-read-error)
[562.857851] Starting subtest: non-sampling-read-error
[562.867865] Subtest non-sampling-read-error: SUCCESS (0.010s)
[562.912542] [126/131] (456s left) kms_cursor_crc (cursor-sliding-32x10)
[563.002023] Starting subtest: cursor-sliding-32x10
[563.058676] Subtest cursor-sliding-32x10: SKIP (0.055s)
[563.130680] [127/131] (455s left) kms_flip (plain-flip-ts-check)
[563.219444] Starting subtest: plain-flip-ts-check
[563.221271] Starting dynamic subtest: A-HDMI-A1
[571.047438] Dynamic subtest A-HDMI-A1: SUCCESS (7.809s)
[571.056815] Starting dynamic subtest: B-HDMI-A1
[578.835895] Dynamic subtest B-HDMI-A1: SUCCESS (7.803s)
[578.846183] Starting dynamic subtest: C-HDMI-A1
[586.659423] Dynamic subtest C-HDMI-A1: SUCCESS (7.798s)
[586.668761] Starting dynamic subtest: D-HDMI-A1
[594.462828] Dynamic subtest D-HDMI-A1: SUCCESS (7.823s)
[594.463575] Subtest plain-flip-ts-check: SUCCESS (31.247s)
[594.610059] [128/131] (424s left) gem_exec_reloc (basic-gtt-wc-active)
[594.649098] Starting subtest: basic-gtt-wc-active
[594.780652] Subtest basic-gtt-wc-active: SUCCESS (0.123s)
[594.896982] [129/131] (424s left) sw_sync (sync_random_merge)
[594.930297] Starting subtest: sync_random_merge
[594.993624] Subtest sync_random_merge: SUCCESS (0.063s)
[595.055795] [130/131] (424s left) gem_exec_params (invalid-bsd1-flag-on-blt)
[595.094646] Starting subtest: invalid-bsd1-flag-on-blt
[595.095370] Subtest invalid-bsd1-flag-on-blt: SUCCESS (0.000s)
[595.190886] [131/131] (424s left) kms_frontbuffer_tracking (psr-2p-scndscrn-indfb-msflip-blt)
[595.282491] Starting subtest: psr-2p-scndscrn-indfb-msflip-blt
[595.283889] Subtest psr-2p-scndscrn-indfb-msflip-blt: SKIP (0.000s)
[595.370863] Closing watchdogs
results: parsing output: 0/ for test: kms_frontbuffer_tracking
results: parsing output: 1/ for test: gem_exec_reloc
results: parsing output: 2/ for test: kms_frontbuffer_tracking
results: parsing output: 3/ for test: syncobj_wait
results: parsing output: 4/ for test: gen9_exec_parse
results: parsing output: 5/ for test: kms_big_fb
results: parsing output: 6/ for test: kms_big_fb
results: parsing output: 7/ for test: kms_ccs
results: parsing output: 8/ for test: kms_flip
results: parsing output: 9/ for test: kms_flip_scaled_crc
results: parsing output: 10/ for test: kms_pipe_stress
results: parsing output: 11/ for test: kms_ccs
results: parsing output: 12/ for test: kms_getfb
results: parsing output: 13/ for test: gem_ctx_create
results: parsing output: 14/ for test: kms_cursor_legacy
results: parsing output: 15/ for test: kms_vblank
results: parsing output: 16/ for test: kms_plane
results: parsing output: 17/ for test: kms_chamelium_hpd
results: parsing output: 18/ for test: kms_chamelium_color
results: parsing output: 19/ for test: kms_frontbuffer_tracking
results: parsing output: 20/ for test: kms_frontbuffer_tracking
results: parsing output: 21/ for test: kms_frontbuffer_tracking
results: parsing output: 22/ for test: gem_wait
results: parsing output: 23/ for test: gem_mmap_gtt
results: parsing output: 24/ for test: kms_ccs
results: parsing output: 25/ for test: kms_psr2_sf
results: parsing output: 26/ for test: kms_universal_plane
results: parsing output: 27/ for test: gem_ctx_isolation
results: parsing output: 28/ for test: kms_fence_pin_leak
results: parsing output: 29/ for test: gem_exec_endless
results: parsing output: 30/ for test: kms_frontbuffer_tracking
results: parsing output: 31/ for test: kms_psr
results: parsing output: 32/ for test: gem_exec_whisper
results: parsing output: 33/ for test: kms_feature_discovery
results: parsing output: 34/ for test: kms_rotation_crc
results: parsing output: 35/ for test: kms_big_fb
results: parsing output: 36/ for test: kms_frontbuffer_tracking
results: parsing output: 37/ for test: kms_chamelium_edid
results: parsing output: 38/ for test: kms_frontbuffer_tracking
results: parsing output: 39/ for test: syncobj_timeline
results: parsing output: 40/ for test: kms_big_fb
results: parsing output: 41/ for test: kms_plane_scaling
results: parsing output: 42/ for test: kms_cursor_crc
results: parsing output: 43/ for test: i915_selftest
results: parsing output: 44/ for test: gem_exec_schedule
results: parsing output: 45/ for test: kms_lease
results: parsing output: 46/ for test: i915_pm_rc6_residency
results: parsing output: 47/ for test: kms_psr
results: parsing output: 48/ for test: intel_hwmon
results: parsing output: 49/ for test: kms_force_connector_basic
results: parsing output: 50/ for test: kms_big_fb
results: parsing output: 51/ for test: core_auth
results: parsing output: 52/ for test: gem_exec_balancer
results: parsing output: 53/ for test: kms_psr2_sf
results: parsing output: 54/ for test: syncobj_wait
results: parsing output: 55/ for test: gem_set_tiling_vs_gtt
results: parsing output: 56/ for test: gem_spin_batch
results: parsing output: 57/ for test: kms_pwrite_crc
results: parsing output: 58/ for test: kms_color_pipeline
results: parsing output: 59/ for test: kms_flip_scaled_crc
results: parsing output: 60/ for test: perf_pmu
results: parsing output: 61/ for test: gem_ctx_bad_destroy
results: parsing output: 62/ for test: kms_force_connector_basic
results: parsing output: 63/ for test: kms_frontbuffer_tracking
results: parsing output: 64/ for test: sriov_basic
results: parsing output: 65/ for test: perf_pmu
results: parsing output: 66/ for test: sw_sync
results: parsing output: 67/ for test: syncobj_wait
results: parsing output: 68/ for test: kms_frontbuffer_tracking
results: parsing output: 69/ for test: gem_exec_params
results: parsing output: 70/ for test: kms_psr
results: parsing output: 71/ for test: kms_ccs
results: parsing output: 72/ for test: gem_pread
results: parsing output: 73/ for test: kms_plane
results: parsing output: 74/ for test: gem_exec_whisper
results: parsing output: 75/ for test: kms_big_fb
results: parsing output: 76/ for test: kms_frontbuffer_tracking
results: parsing output: 77/ for test: core_getversion
results: parsing output: 78/ for test: api_intel_allocator
results: parsing output: 79/ for test: i915_drm_fdinfo
results: parsing output: 80/ for test: kms_cursor_legacy
results: parsing output: 81/ for test: gem_pxp
results: parsing output: 82/ for test: gem_userptr_blits
results: parsing output: 83/ for test: gem_create
results: parsing output: 84/ for test: syncobj_wait
results: parsing output: 85/ for test: gem_ctx_persistence
results: parsing output: 86/ for test: syncobj_timeline
results: parsing output: 87/ for test: gem_mmap_gtt
results: parsing output: 88/ for test: kms_cursor_crc
results: parsing output: 89/ for test: gem_exec_await
results: parsing output: 90/ for test: core_setmaster
results: parsing output: 91/ for test: kms_big_fb
results: parsing output: 92/ for test: gem_exec_schedule
results: parsing output: 93/ for test: prime_vgem
results: parsing output: 94/ for test: gem_ctx_shared
results: parsing output: 95/ for test: kms_plane_multiple
results: parsing output: 96/ for test: kms_psr
results: parsing output: 97/ for test: syncobj_timeline
results: parsing output: 98/ for test: syncobj_wait
results: parsing output: 99/ for test: kms_invalid_mode
results: parsing output: 100/ for test: kms_cursor_legacy
results: parsing output: 101/ for test: gem_exec_reloc
results: parsing output: 102/ for test: kms_frontbuffer_tracking
results: parsing output: 103/ for test: gem_ringfill
results: parsing output: 104/ for test: kms_frontbuffer_tracking
results: parsing output: 105/ for test: gem_busy
results: parsing output: 106/ for test: gem_exec_suspend
results: parsing output: 107/ for test: kms_content_protection
results: parsing output: 108/ for test: gem_exec_fence
results: parsing output: 109/ for test: gem_eio
results: parsing output: 110/ for test: i915_pm_freq_mult
results: parsing output: 111/ for test: kms_psr
results: parsing output: 112/ for test: syncobj_timeline
results: parsing output: 113/ for test: gem_partial_pwrite_pread
results: parsing output: 114/ for test: kms_rotation_crc
results: parsing output: 115/ for test: gem_exec_create
results: parsing output: 116/ for test: gem_exec_params
results: parsing output: 117/ for test: gem_wait
results: parsing output: 118/ for test: prime_self_import
results: parsing output: 119/ for test: kms_big_fb
results: parsing output: 120/ for test: kms_pm_dc
results: parsing output: 121/ for test: kms_vrr
results: parsing output: 122/ for test: kms_frontbuffer_tracking
results: parsing output: 123/ for test: kms_flip
results: parsing output: 124/ for test: perf
results: parsing output: 125/ for test: kms_cursor_crc
results: parsing output: 126/ for test: kms_flip
results: parsing output: 127/ for test: gem_exec_reloc
results: parsing output: 128/ for test: sw_sync
results: parsing output: 129/ for test: gem_exec_params
results: parsing output: 130/ for test: kms_frontbuffer_tracking
Done.