[141.929803] Initializing watchdogs
[141.929849]   /dev/watchdog0
[141.946653] [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]
[141.950825] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[141.952995] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[141.956271] [001/131] (960s left) gem_render_copy (yf-tiled-to-vebox-y-tiled)
[142.044482] Starting subtest: yf-tiled-to-vebox-y-tiled
[142.049270] Subtest yf-tiled-to-vebox-y-tiled: SKIP (0.000s)
[142.224927] [002/131] (960s left) kms_pm_rpm (pc8-residency)
[144.002652] Starting subtest: pc8-residency
[144.008095] Subtest pc8-residency: SKIP (0.000s)
[144.487147] [003/131] (958s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-mmap-cpu)
[144.586518] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-mmap-cpu
[144.590723] Subtest psr-2p-scndscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[144.676719] [004/131] (957s left) gem_softpin (softpin)
[144.747110] Starting subtest: softpin
[176.993321] Subtest softpin: SUCCESS (32.238s)
[177.135911] [005/131] (925s left) gem_exec_whisper (basic-contexts-forked-all)
[177.201071] Starting subtest: basic-contexts-forked-all
[199.711805] Subtest basic-contexts-forked-all: SUCCESS (22.456s)
[199.834261] [006/131] (902s left) kms_big_fb (linear-8bpp-rotate-0)
[199.947655] Starting subtest: linear-8bpp-rotate-0
[201.170663] Subtest linear-8bpp-rotate-0: SUCCESS (1.223s)
[201.332549] [007/131] (901s left) kms_atomic (test-only)
[201.432481] Starting subtest: test-only
[201.497712] Starting dynamic subtest: pipe-A-eDP-1
[203.957449] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.459s)
[203.959651] Subtest test-only: SUCCESS (2.522s)
[204.741298] [008/131] (897s left) gem_userptr_blits (input-checking)
[204.799675] Starting subtest: input-checking
[204.801966] Subtest input-checking: SUCCESS (0.000s)
[204.914878] [009/131] (897s left) kms_busy (extended-modeset-hang-newfb-with-reset)
[205.028425] Starting subtest: extended-modeset-hang-newfb-with-reset
[205.030765] Starting dynamic subtest: pipe-A
[218.767639] Dynamic subtest pipe-A: SUCCESS (13.738s)
[218.777273] Starting dynamic subtest: pipe-D
[234.629266] Dynamic subtest pipe-D: SUCCESS (15.859s)
[234.631710] Subtest extended-modeset-hang-newfb-with-reset: SUCCESS (29.601s)
[235.418186] [010/131] (867s left) gem_reg_read (timestamp-moving)
[235.473109] Starting subtest: timestamp-moving
[236.474058] Subtest timestamp-moving: SUCCESS (1.001s)
[236.546812] [011/131] (866s left) i915_drm_fdinfo (memory-info-purgeable)
[236.580706] Starting subtest: memory-info-purgeable
[236.582603] Starting dynamic subtest: smem0
[239.664891] Dynamic subtest smem0: SUCCESS (3.087s)
[239.666969] Subtest memory-info-purgeable: SUCCESS (3.087s)
[239.732486] [012/131] (863s left) kms_color (deep-color)
[239.817518] Starting subtest: deep-color
[240.884845] Starting dynamic subtest: pipe-A-eDP-1-gamma
[241.578509] Dynamic subtest pipe-A-eDP-1-gamma: SUCCESS (0.693s)
[241.588425] Starting dynamic subtest: pipe-A-eDP-1-degamma
[242.965734] Dynamic subtest pipe-A-eDP-1-degamma: SUCCESS (1.387s)
[242.975950] Starting dynamic subtest: pipe-A-eDP-1-ctm
[244.375751] Dynamic subtest pipe-A-eDP-1-ctm: SUCCESS (1.410s)
[245.156535] Starting dynamic subtest: pipe-B-eDP-1-gamma
[245.851777] Dynamic subtest pipe-B-eDP-1-gamma: SUCCESS (0.702s)
[245.861340] Starting dynamic subtest: pipe-B-eDP-1-degamma
[247.230216] Dynamic subtest pipe-B-eDP-1-degamma: SUCCESS (1.377s)
[247.238163] Starting dynamic subtest: pipe-B-eDP-1-ctm
[248.677649] Dynamic subtest pipe-B-eDP-1-ctm: SUCCESS (1.447s)
[249.435909] Starting dynamic subtest: pipe-C-eDP-1-gamma
[250.107868] Dynamic subtest pipe-C-eDP-1-gamma: SUCCESS (0.680s)
[250.117292] Starting dynamic subtest: pipe-C-eDP-1-degamma
[251.480102] Dynamic subtest pipe-C-eDP-1-degamma: SUCCESS (1.370s)
[251.489203] Starting dynamic subtest: pipe-C-eDP-1-ctm
[252.882388] Dynamic subtest pipe-C-eDP-1-ctm: SUCCESS (1.404s)
[253.712434] Starting dynamic subtest: pipe-D-eDP-1-gamma
[254.375402] Dynamic subtest pipe-D-eDP-1-gamma: SUCCESS (0.670s)
[254.385608] Starting dynamic subtest: pipe-D-eDP-1-degamma
[255.737541] Dynamic subtest pipe-D-eDP-1-degamma: SUCCESS (1.362s)
[255.748297] Starting dynamic subtest: pipe-D-eDP-1-ctm
[257.199158] Dynamic subtest pipe-D-eDP-1-ctm: SUCCESS (1.458s)
[257.201146] Subtest deep-color: SUCCESS (17.378s)
[258.036758] [013/131] (844s left) kms_frontbuffer_tracking (psr-1p-offscren-pri-shrfb-draw-mmap-gtt)
[258.148264] Starting subtest: psr-1p-offscren-pri-shrfb-draw-mmap-gtt
[258.152472] Subtest psr-1p-offscren-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[258.271652] [014/131] (844s left) kms_ccs (bad-pixel-format-y-tiled-gen12-rc-ccs-cc)
[258.364981] Starting subtest: bad-pixel-format-y-tiled-gen12-rc-ccs-cc
[258.367259] Starting dynamic subtest: pipe-A-eDP-1
[258.389454] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[258.397609] Starting dynamic subtest: pipe-B-eDP-1
[258.419071] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[258.426295] Starting dynamic subtest: pipe-C-eDP-1
[258.448031] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[258.455536] Starting dynamic subtest: pipe-D-eDP-1
[258.476617] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[258.480701] Subtest bad-pixel-format-y-tiled-gen12-rc-ccs-cc: SKIP (0.003s)
[260.475240] [015/131] (842s left) prime_vgem (basic-gtt)
[260.605243] Starting subtest: basic-gtt
[260.609983] Subtest basic-gtt: SKIP (0.000s)
[260.711707] [FACT prime_vgem (basic-gtt)] new: kernel.kmod_is_loaded.vgem: true
[260.715094] [016/131] (842s left) kms_mmap_write_crc (main)
[260.805960] Starting subtest: main
[260.808330] Starting dynamic subtest: pipe-A-eDP-1
[264.287741] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.479s)
[264.289865] Subtest main: SUCCESS (3.480s)
[265.099040] [017/131] (837s left) sysfs_heartbeat_interval (nopreempt)
[265.163280] Starting subtest: nopreempt
[265.165800] Starting dynamic subtest: vecs0
[274.907230] Dynamic subtest vecs0: SUCCESS (9.743s)
[274.917909] Starting dynamic subtest: ccs0
[278.904814] Dynamic subtest ccs0: SUCCESS (3.994s)
[278.914779] Starting dynamic subtest: vcs0
[288.937190] Dynamic subtest vcs0: SUCCESS (10.033s)
[288.948059] Starting dynamic subtest: bcs0
[292.915932] Dynamic subtest bcs0: SUCCESS (3.976s)
[292.926584] Starting dynamic subtest: rcs0
[296.947605] Dynamic subtest rcs0: SUCCESS (4.032s)
[296.957394] Starting dynamic subtest: vcs1
[305.958327] Dynamic subtest vcs1: SUCCESS (9.009s)
[305.960836] Subtest nopreempt: SUCCESS (40.794s)
[306.041714] [018/131] (797s left) i915_power (sanity)
[306.091410] Starting subtest: sanity
[310.144474] Subtest sanity: SUCCESS (4.045s)
[311.889486] [019/131] (791s left) gem_exec_reloc (basic-wc-gtt-noreloc)
[311.955952] Subtest basic-wc-gtt-noreloc: SKIP (0.000s)
[312.042777] [020/131] (791s left) kms_ccs (crc-primary-rotation-180-4-tiled-mtl-mc-ccs)
[312.132058] Starting subtest: crc-primary-rotation-180-4-tiled-mtl-mc-ccs
[312.134368] Starting dynamic subtest: pipe-A-eDP-1
[314.253836] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.120s)
[314.261920] Starting dynamic subtest: pipe-B-eDP-1
[316.359428] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.104s)
[316.369072] Starting dynamic subtest: pipe-C-eDP-1
[318.412579] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.050s)
[318.429805] Starting dynamic subtest: pipe-D-eDP-1
[320.443072] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.030s)
[320.445396] Subtest crc-primary-rotation-180-4-tiled-mtl-mc-ccs: SUCCESS (8.309s)
[321.676883] [021/131] (781s left) perf (blocking-parameterized)
[321.807171] Starting subtest: blocking-parameterized
[341.890977] Subtest blocking-parameterized: SUCCESS (20.033s)
[341.930076] [022/131] (761s left) kms_async_flips (basic-modeset-with-all-modifiers-formats)
[342.024278] Starting subtest: basic-modeset-with-all-modifiers-formats
[342.396712] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-XRGB8888
[343.149316] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-XRGB8888: SUCCESS (0.754s)
[343.157410] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-XRGB2101010
[343.171270] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-XRGB2101010: SUCCESS (0.021s)
[343.179663] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-XRGB16161616F
[343.194189] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-XRGB16161616F: SUCCESS (0.022s)
[343.202527] Starting dynamic subtest: pipe-A-eDP-1-4-RGB565
[343.415778] Dynamic subtest pipe-A-eDP-1-4-RGB565: SUCCESS (0.221s)
[343.423697] Starting dynamic subtest: pipe-A-eDP-1-4-XRGB8888
[343.438075] Dynamic subtest pipe-A-eDP-1-4-XRGB8888: SUCCESS (0.022s)
[343.446078] Starting dynamic subtest: pipe-A-eDP-1-4-XRGB2101010
[343.460241] Dynamic subtest pipe-A-eDP-1-4-XRGB2101010: SUCCESS (0.022s)
[343.467747] Starting dynamic subtest: pipe-A-eDP-1-4-XRGB16161616F
[343.482161] Dynamic subtest pipe-A-eDP-1-4-XRGB16161616F: SUCCESS (0.022s)
[343.490200] Starting dynamic subtest: pipe-A-eDP-1-4-YUYV
[343.504780] Dynamic subtest pipe-A-eDP-1-4-YUYV: SUCCESS (0.021s)
[343.515443] Starting dynamic subtest: pipe-A-eDP-1-4-Y210
[343.526719] Dynamic subtest pipe-A-eDP-1-4-Y210: SUCCESS (0.021s)
[343.535450] Starting dynamic subtest: pipe-A-eDP-1-4-XYUV8888
[343.549461] Dynamic subtest pipe-A-eDP-1-4-XYUV8888: SUCCESS (0.022s)
[343.559636] Starting dynamic subtest: pipe-A-eDP-1-4-XV30
[343.571523] Dynamic subtest pipe-A-eDP-1-4-XV30: SUCCESS (0.022s)
[343.579408] Starting dynamic subtest: pipe-A-eDP-1-4-XV36
[343.593770] Dynamic subtest pipe-A-eDP-1-4-XV36: SUCCESS (0.022s)
[343.604171] Starting dynamic subtest: pipe-A-eDP-1-x-RGB565
[343.804924] Dynamic subtest pipe-A-eDP-1-x-RGB565: SUCCESS (0.211s)
[343.813066] Starting dynamic subtest: pipe-A-eDP-1-x-XRGB8888
[343.827317] Dynamic subtest pipe-A-eDP-1-x-XRGB8888: SUCCESS (0.022s)
[343.841552] Starting dynamic subtest: pipe-A-eDP-1-x-XRGB2101010
[343.849301] Dynamic subtest pipe-A-eDP-1-x-XRGB2101010: SUCCESS (0.021s)
[343.857442] Starting dynamic subtest: pipe-A-eDP-1-x-XRGB16161616F
[343.871592] Dynamic subtest pipe-A-eDP-1-x-XRGB16161616F: SUCCESS (0.022s)
[343.879232] Starting dynamic subtest: pipe-A-eDP-1-x-YUYV
[343.894080] Dynamic subtest pipe-A-eDP-1-x-YUYV: SUCCESS (0.022s)
[343.901681] Starting dynamic subtest: pipe-A-eDP-1-x-Y210
[343.915688] Dynamic subtest pipe-A-eDP-1-x-Y210: SUCCESS (0.022s)
[343.923073] Starting dynamic subtest: pipe-A-eDP-1-x-XYUV8888
[343.937807] Dynamic subtest pipe-A-eDP-1-x-XYUV8888: SUCCESS (0.022s)
[343.945080] Starting dynamic subtest: pipe-A-eDP-1-x-XV30
[343.960061] Dynamic subtest pipe-A-eDP-1-x-XV30: SUCCESS (0.022s)
[343.967675] Starting dynamic subtest: pipe-A-eDP-1-x-XV36
[343.982286] Dynamic subtest pipe-A-eDP-1-x-XV36: SUCCESS (0.022s)
[343.990081] Starting dynamic subtest: pipe-A-eDP-1-linear-RGB565
[344.204920] Dynamic subtest pipe-A-eDP-1-linear-RGB565: SUCCESS (0.222s)
[344.212605] Starting dynamic subtest: pipe-A-eDP-1-linear-XRGB8888
[344.226989] Dynamic subtest pipe-A-eDP-1-linear-XRGB8888: SUCCESS (0.022s)
[344.234286] Starting dynamic subtest: pipe-A-eDP-1-linear-XRGB2101010
[344.249320] Dynamic subtest pipe-A-eDP-1-linear-XRGB2101010: SUCCESS (0.022s)
[344.256574] Starting dynamic subtest: pipe-A-eDP-1-linear-XRGB16161616F
[344.271579] Dynamic subtest pipe-A-eDP-1-linear-XRGB16161616F: SUCCESS (0.022s)
[344.279082] Starting dynamic subtest: pipe-A-eDP-1-linear-YUYV
[344.293815] Dynamic subtest pipe-A-eDP-1-linear-YUYV: SUCCESS (0.022s)
[344.301056] Starting dynamic subtest: pipe-A-eDP-1-linear-Y210
[344.315645] Dynamic subtest pipe-A-eDP-1-linear-Y210: SUCCESS (0.022s)
[344.323025] Starting dynamic subtest: pipe-A-eDP-1-linear-XYUV8888
[344.338304] Dynamic subtest pipe-A-eDP-1-linear-XYUV8888: SUCCESS (0.022s)
[344.345654] Starting dynamic subtest: pipe-A-eDP-1-linear-XV30
[344.360459] Dynamic subtest pipe-A-eDP-1-linear-XV30: SUCCESS (0.022s)
[344.367781] Starting dynamic subtest: pipe-A-eDP-1-linear-XV36
[344.382820] Dynamic subtest pipe-A-eDP-1-linear-XV36: SUCCESS (0.022s)
[344.772950] Subtest basic-modeset-with-all-modifiers-formats: SUCCESS (2.748s)
[345.530372] [023/131] (757s left) kms_fbcon_fbt (psr)
[345.587550] Starting subtest: psr
[352.928294] Subtest psr: SUCCESS (7.340s)
[352.998459] [024/131] (750s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-indfb-pgflip-blt)
[353.099236] Starting subtest: fbc-2p-scndscrn-indfb-pgflip-blt
[353.103151] Subtest fbc-2p-scndscrn-indfb-pgflip-blt: SKIP (0.000s)
[353.194972] [025/131] (750s left) i915_module_load (reload-no-display)
[353.232475] Starting subtest: reload-no-display
[359.446167] Subtest reload-no-display: SUCCESS (6.218s)
[359.473183] [FACT i915_module_load (reload-no-display)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[359.473883] [FACT i915_module_load (reload-no-display)] deleted: kernel.kmod_is_loaded.i915: true
[359.477572] [026/131] (743s left) gem_ctx_persistence (legacy-engines-queued)
[360.899533] Starting subtest: legacy-engines-queued
[360.901627] Starting dynamic subtest: render
[361.002989] Dynamic subtest render: SUCCESS (0.104s)
[361.012299] Starting dynamic subtest: bsd1
[362.870485] Dynamic subtest bsd1: SUCCESS (1.864s)
[362.883483] Starting dynamic subtest: bsd2
[364.851209] Dynamic subtest bsd2: SUCCESS (1.977s)
[364.862484] Starting dynamic subtest: blt
[364.925618] Dynamic subtest blt: SUCCESS (0.073s)
[364.938549] Starting dynamic subtest: vebox
[366.847570] Dynamic subtest vebox: SUCCESS (1.902s)
[366.850174] Subtest legacy-engines-queued: SUCCESS (5.934s)
[366.899655] [FACT gem_ctx_persistence (legacy-engines-queued)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[366.900816] [FACT gem_ctx_persistence (legacy-engines-queued)] new: kernel.kmod_is_loaded.i915: true
[366.904869] [027/131] (736s left) gem_exec_schedule (semaphore-resolve)
[366.985345] Starting subtest: semaphore-resolve
[367.053479] Subtest semaphore-resolve: SUCCESS (0.070s)
[367.407732] [028/131] (736s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-pwrite)
[367.520234] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-pwrite
[371.924613] Subtest fbc-1p-primscrn-spr-indfb-draw-pwrite: SUCCESS (4.408s)
[373.059927] [029/131] (730s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-0-hflip)
[373.168978] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-0-hflip
[374.401215] Subtest x-tiled-max-hw-stride-64bpp-rotate-0-hflip: SUCCESS (1.234s)
[374.534935] [030/131] (729s left) syncobj_wait (wait-all-for-submit-complex)
[374.589646] Starting subtest: wait-all-for-submit-complex
[374.803648] Subtest wait-all-for-submit-complex: SUCCESS (0.213s)
[374.905501] [031/131] (728s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-mmap-cpu)
[375.000877] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-mmap-cpu
[375.005446] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[375.110426] [032/131] (728s left) kms_cursor_crc (cursor-sliding-64x21)
[375.292782] Starting subtest: cursor-sliding-64x21
[375.340140] Subtest cursor-sliding-64x21: SKIP (0.040s)
[375.570891] [033/131] (728s left) kms_frontbuffer_tracking (fbc-1p-rte)
[375.677378] Starting subtest: fbc-1p-rte
[381.121751] Subtest fbc-1p-rte: SUCCESS (5.449s)
[382.312870] [034/131] (721s left) dumb_buffer (map-valid)
[382.368784] Starting subtest: map-valid
[382.370705] Subtest map-valid: SUCCESS (0.000s)
[382.483889] [035/131] (721s left) gem_exec_balancer (bonded-false-hang)
[382.742325] Starting subtest: bonded-false-hang
[382.747266] Subtest bonded-false-hang: SKIP (0.000s)
[382.849767] [036/131] (720s left) kms_addfb_basic (invalid-smem-bo-on-discrete)
[382.902435] Starting subtest: invalid-smem-bo-on-discrete
[382.906635] Subtest invalid-smem-bo-on-discrete: SKIP (0.000s)
[383.053731] [037/131] (720s left) kms_flip_scaled_crc (flip-64bpp-linear-to-16bpp-linear-downscaling)
[383.149287] Starting subtest: flip-64bpp-linear-to-16bpp-linear-downscaling
[383.151624] Starting dynamic subtest: pipe-A-default-mode
[384.251224] Dynamic subtest pipe-A-default-mode: SKIP (1.096s)
[384.255783] Subtest flip-64bpp-linear-to-16bpp-linear-downscaling: SKIP (1.098s)
[384.404771] [038/131] (719s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-render)
[384.508041] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-render
[391.833978] Subtest psr-1p-primscrn-pri-shrfb-draw-render: SUCCESS (7.329s)
[391.964459] [039/131] (711s left) kms_ccs (random-ccs-data-4-tiled-mtl-mc-ccs)
[392.051087] Starting subtest: random-ccs-data-4-tiled-mtl-mc-ccs
[392.053269] Starting dynamic subtest: pipe-A-eDP-1
[393.281100] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.229s)
[393.289580] Starting dynamic subtest: pipe-B-eDP-1
[395.546223] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.264s)
[395.554840] Starting dynamic subtest: pipe-C-eDP-1
[397.891435] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.344s)
[397.900393] Starting dynamic subtest: pipe-D-eDP-1
[400.216679] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.324s)
[400.219129] Subtest random-ccs-data-4-tiled-mtl-mc-ccs: SUCCESS (8.165s)
[401.421131] [040/131] (702s left) gem_mmap_wc (bad-offset)
[401.474916] Subtest bad-offset: SKIP (0.000s)
[401.539791] [041/131] (702s left) kms_properties (plane-properties-legacy)
[401.626290] Starting subtest: plane-properties-legacy
[401.628623] Starting dynamic subtest: pipe-A-eDP-1
[402.189515] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.558s)
[402.200095] Starting dynamic subtest: pipe-B-eDP-1
[403.483286] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.294s)
[403.490690] Starting dynamic subtest: pipe-C-eDP-1
[404.689279] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.204s)
[404.698567] Starting dynamic subtest: pipe-D-eDP-1
[405.918498] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.229s)
[405.920840] Subtest plane-properties-legacy: SUCCESS (4.291s)
[406.704821] [042/131] (697s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-180-async-flip)
[406.809064] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-180-async-flip
[408.088884] Subtest 4-tiled-max-hw-stride-64bpp-rotate-180-async-flip: SUCCESS (1.281s)
[408.337337] [043/131] (695s left) kms_psr (fbc-psr-primary-blt)
[408.431300] Starting subtest: fbc-psr-primary-blt
[408.433586] Starting dynamic subtest: eDP-1
[408.437700] Dynamic subtest eDP-1: SKIP (0.000s)
[408.441856] Subtest fbc-psr-primary-blt: SKIP (0.001s)
[408.501365] [044/131] (695s left) kms_frontbuffer_tracking (fbc-2p-pri-indfb-multidraw)
[408.597086] Starting subtest: fbc-2p-pri-indfb-multidraw
[408.601274] Subtest fbc-2p-pri-indfb-multidraw: SKIP (0.000s)
[408.705395] [045/131] (695s left) kms_ccs (bad-rotation-90-y-tiled-ccs)
[408.796327] Starting subtest: bad-rotation-90-y-tiled-ccs
[408.798614] Starting dynamic subtest: pipe-A-eDP-1
[408.822087] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[408.832684] Starting dynamic subtest: pipe-B-eDP-1
[408.853183] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[408.860655] Starting dynamic subtest: pipe-C-eDP-1
[408.881131] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[408.888461] Starting dynamic subtest: pipe-D-eDP-1
[408.910024] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[408.914619] Subtest bad-rotation-90-y-tiled-ccs: SKIP (0.004s)
[410.963060] [046/131] (693s left) kms_flip (absolute-wf_vblank-interruptible)
[411.057653] Starting subtest: absolute-wf_vblank-interruptible
[411.059928] Starting dynamic subtest: A-eDP1
[419.853578] Dynamic subtest A-eDP1: SUCCESS (8.760s)
[419.863751] Starting dynamic subtest: B-eDP1
[428.581398] Dynamic subtest B-eDP1: SUCCESS (8.726s)
[428.591968] Starting dynamic subtest: C-eDP1
[437.308352] Dynamic subtest C-eDP1: SUCCESS (8.716s)
[437.318805] Starting dynamic subtest: D-eDP1
[446.037861] Dynamic subtest D-eDP1: SUCCESS (8.726s)
[446.040191] Subtest absolute-wf_vblank-interruptible: SUCCESS (34.937s)
[447.189783] [047/131] (657s left) kms_cursor_legacy (basic-flip-before-cursor-atomic)
[447.312172] Starting subtest: basic-flip-before-cursor-atomic
[448.222109] Subtest basic-flip-before-cursor-atomic: SUCCESS (0.908s)
[449.012823] [048/131] (655s left) kms_cursor_edge_walk (256x256-right-edge)
[449.108363] Starting subtest: 256x256-right-edge
[449.110799] Starting dynamic subtest: pipe-A-eDP-1
[452.561563] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.452s)
[452.571091] Starting dynamic subtest: pipe-D-eDP-1
[455.690371] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.126s)
[455.692690] Subtest 256x256-right-edge: SUCCESS (6.580s)
[456.481466] [049/131] (647s left) prime_self_import (basic-with_one_bo_two_files)
[456.515866] Starting subtest: basic-with_one_bo_two_files
[456.536610] Subtest basic-with_one_bo_two_files: SUCCESS (0.021s)
[456.630426] [050/131] (647s left) kms_joiner (basic-force-big-joiner)
[456.729485] Starting subtest: basic-force-big-joiner
[456.731747] Starting dynamic subtest: single
[460.015180] Dynamic subtest single: SUCCESS (3.293s)
[460.017303] Subtest basic-force-big-joiner: SUCCESS (3.294s)
[461.196141] [051/131] (643s left) kms_addfb_basic (no-handle)
[461.253855] Starting subtest: no-handle
[461.256046] Subtest no-handle: SUCCESS (0.000s)
[461.407101] [052/131] (643s left) kms_pipe_b_c_ivb (from-pipe-c-to-b-with-3-lanes)
[461.464757] Subtest from-pipe-C-to-B-with-3-lanes: SKIP (0.000s)
[461.520811] [053/131] (642s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-mmap-wc)
[461.613908] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-mmap-wc
[461.618454] Subtest fbc-2p-primscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[461.707038] [054/131] (642s left) syncobj_timeline (single-wait-signaled)
[461.757970] Starting subtest: single-wait-signaled
[461.760229] Subtest single-wait-signaled: SUCCESS (0.000s)
[461.848911] [055/131] (642s left) kms_lease (lease-invalid-connector)
[461.925028] Starting subtest: lease-invalid-connector
[461.927163] Starting dynamic subtest: pipe-A-eDP-1
[461.929419] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s)
[461.938219] Starting dynamic subtest: pipe-B-eDP-1
[461.940073] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[461.948231] Starting dynamic subtest: pipe-C-eDP-1
[461.950388] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[461.958523] Starting dynamic subtest: pipe-D-eDP-1
[461.960451] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[461.962384] Subtest lease-invalid-connector: SUCCESS (0.004s)
[461.998936] [056/131] (642s left) gem_pxp (hw-rejects-pxp-context)
[462.117766] Starting subtest: hw-rejects-pxp-context
[462.121957] Subtest hw-rejects-pxp-context: SKIP (0.000s)
[462.232294] [057/131] (642s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-render)
[462.335601] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-render
[469.488368] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-render: SUCCESS (7.153s)
[469.644862] [058/131] (635s left) kms_psr (psr-sprite-mmap-cpu)
[469.739323] Starting subtest: psr-sprite-mmap-cpu
[469.741593] Starting dynamic subtest: eDP-1
[471.494773] Dynamic subtest eDP-1: SUCCESS (1.751s)
[471.496614] Subtest psr-sprite-mmap-cpu: SUCCESS (1.753s)
[472.331362] [059/131] (632s left) gem_spin_batch (spin-all-new)
[472.395388] Starting subtest: spin-all-new
[472.408901] Subtest spin-all-new: SUCCESS (0.012s)
[473.910639] [060/131] (630s left) gem_exec_fence (syncobj-invalid-wait)
[474.338773] Starting subtest: syncobj-invalid-wait
[474.341192] Subtest syncobj-invalid-wait: SUCCESS (0.001s)
[476.031768] [061/131] (628s left) kms_big_fb (yf-tiled-8bpp-rotate-270)
[476.145728] Starting subtest: yf-tiled-8bpp-rotate-270
[476.149842] Subtest yf-tiled-8bpp-rotate-270: SKIP (0.000s)
[476.255657] [062/131] (628s left) syncobj_timeline (multi-wait-for-submit-unsubmitted-submitted-signaled)
[476.316652] Starting subtest: multi-wait-for-submit-unsubmitted-submitted-signaled
[476.318999] Subtest multi-wait-for-submit-unsubmitted-submitted-signaled: SUCCESS (0.000s)
[476.407776] [063/131] (628s left) syncobj_wait (multi-wait-for-submit-signaled)
[476.461772] Starting subtest: multi-wait-for-submit-signaled
[476.464054] Subtest multi-wait-for-submit-signaled: SUCCESS (0.000s)
[476.551354] [064/131] (628s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-blt)
[476.646714] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-blt
[480.371882] Subtest fbc-1p-primscrn-cur-indfb-draw-blt: SUCCESS (3.729s)
[481.520510] [065/131] (623s left) i915_query (query-garbage)
[481.581622] Starting subtest: query-garbage
[481.583636] Subtest query-garbage: SUCCESS (0.000s)
[481.685410] [066/131] (623s left) gem_exec_params (invalid-ring2)
[481.744739] Starting subtest: invalid-ring2
[481.747048] Subtest invalid-ring2: SUCCESS (0.000s)
[481.869446] [067/131] (623s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-blt)
[481.977616] Starting subtest: psr-2p-primscrn-spr-indfb-draw-blt
[481.981949] Subtest psr-2p-primscrn-spr-indfb-draw-blt: SKIP (0.000s)
[482.095677] [068/131] (622s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-mmap-cpu)
[482.198462] Starting subtest: fbcpsr-rgb565-draw-mmap-cpu
[488.956438] Subtest fbcpsr-rgb565-draw-mmap-cpu: SUCCESS (6.760s)
[489.064808] [069/131] (616s left) gem_mmap_gtt (fault-concurrent)
[489.115060] Subtest fault-concurrent: SKIP (0.000s)
[489.173380] [070/131] (615s left) kms_ccs (missing-ccs-buffer-yf-tiled-ccs)
[489.268274] Starting subtest: missing-ccs-buffer-yf-tiled-ccs
[489.270590] Starting dynamic subtest: pipe-A-eDP-1
[489.293520] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[489.302854] Starting dynamic subtest: pipe-B-eDP-1
[489.324529] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[489.332986] Starting dynamic subtest: pipe-C-eDP-1
[489.355025] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[489.364080] Starting dynamic subtest: pipe-D-eDP-1
[489.386020] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[489.390430] Subtest missing-ccs-buffer-yf-tiled-ccs: SKIP (0.004s)
[491.467729] [071/131] (613s left) gem_exec_balancer (invalid-balancer)
[491.526118] Starting subtest: invalid-balancer
[492.392105] Subtest invalid-balancer: SUCCESS (0.864s)
[492.693115] [072/131] (612s left) kms_vblank (wait-idle-hang)
[492.787138] Starting subtest: wait-idle-hang
[492.789509] Starting dynamic subtest: pipe-A-eDP-1
[519.698762] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.909s)
[519.714311] Starting dynamic subtest: pipe-D-eDP-1
[544.661053] Dynamic subtest pipe-D-eDP-1: SUCCESS (24.959s)
[544.663292] Subtest wait-idle-hang: SUCCESS (51.872s)
[545.511728] [073/131] (559s left) kms_pm_backlight (brightness-with-dpms)
[545.599740] Starting subtest: brightness-with-dpms
[545.663851] Starting dynamic subtest: eDP-1
[548.108360] Dynamic subtest eDP-1: SUCCESS (2.445s)
[548.110887] Subtest brightness-with-dpms: SUCCESS (2.509s)
[548.962601] [074/131] (556s left) kms_frontbuffer_tracking (fbc-suspend)
[549.057983] Starting subtest: fbc-suspend
[586.636391] Subtest fbc-suspend: SUCCESS (7.257s)
[587.804234] [075/131] (517s left) syncobj_wait (wait-all-complex)
[587.873577] Starting subtest: wait-all-complex
[588.087412] Subtest wait-all-complex: SUCCESS (0.219s)
[588.164798] [076/131] (517s left) gem_exec_reloc (basic-write-cpu)
[588.223565] Subtest basic-write-cpu: SKIP (0.000s)
[588.315747] [077/131] (517s left) kms_frontbuffer_tracking (pipe-fbc-rte)
[588.418354] Starting subtest: pipe-fbc-rte
[588.425072] Starting dynamic subtest: pipe-B-eDP-1
[593.738377] Dynamic subtest pipe-B-eDP-1: SUCCESS (5.408s)
[593.748323] Subtest pipe-fbc-rte: SUCCESS (5.410s)
[596.042277] [078/131] (509s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-blt)
[596.136345] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-blt
[596.140845] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-blt: SKIP (0.000s)
[596.228071] [079/131] (509s left) kms_big_fb (y-tiled-16bpp-rotate-270)
[596.334630] Starting subtest: y-tiled-16bpp-rotate-270
[596.340082] Subtest y-tiled-16bpp-rotate-270: SKIP (0.000s)
[596.434520] [080/131] (509s left) api_intel_allocator (reserve-simple)
[596.488898] Starting subtest: reserve-simple
[596.491981] Subtest reserve-simple: SUCCESS (0.004s)
[596.599853] [081/131] (508s left) gem_exec_reloc (basic-gtt)
[596.678770] Subtest basic-gtt: SKIP (0.000s)
[596.770099] [082/131] (508s left) gem_ctx_engines (invalid-engines)
[596.826571] Starting subtest: invalid-engines
[596.834261] Subtest invalid-engines: SUCCESS (0.008s)
[597.082166] [083/131] (508s left) kms_plane_scaling (planes-upscale-factor-0-25)
[597.170383] Starting subtest: planes-upscale-factor-0-25
[597.173062] Starting dynamic subtest: pipe-A
[597.234590] Dynamic subtest pipe-A: SUCCESS (0.064s)
[597.245723] Starting dynamic subtest: pipe-B
[598.343022] Dynamic subtest pipe-B: SUCCESS (1.115s)
[598.354536] Starting dynamic subtest: pipe-C
[599.440088] Dynamic subtest pipe-C: SUCCESS (1.102s)
[599.451552] Starting dynamic subtest: pipe-D
[600.550954] Dynamic subtest pipe-D: SUCCESS (1.115s)
[600.553396] Subtest planes-upscale-factor-0-25: SUCCESS (3.400s)
[601.693086] [084/131] (504s left) gem_exec_schedule (implicit-boths)
[601.769115] Starting subtest: implicit-boths
[601.771827] Starting dynamic subtest: rcs0
[601.869785] Dynamic subtest rcs0: SUCCESS (0.114s)
[601.882092] Starting dynamic subtest: vcs0
[601.945844] Dynamic subtest vcs0: SUCCESS (0.076s)
[601.955878] Starting dynamic subtest: vcs1
[602.020367] Dynamic subtest vcs1: SUCCESS (0.075s)
[602.032389] Starting dynamic subtest: vecs0
[602.097979] Dynamic subtest vecs0: SUCCESS (0.076s)
[602.107527] Starting dynamic subtest: ccs0
[602.186987] Dynamic subtest ccs0: SUCCESS (0.089s)
[602.189755] Subtest implicit-boths: SUCCESS (0.433s)
[603.404493] [085/131] (502s left) kms_frontbuffer_tracking (psr-2p-primscrn-indfb-pgflip-blt)
[603.514350] Starting subtest: psr-2p-primscrn-indfb-pgflip-blt
[603.519063] Subtest psr-2p-primscrn-indfb-pgflip-blt: SKIP (0.000s)
[603.603588] [086/131] (502s left) kms_chamelium_color (ctm-green-to-red)
[603.702240] Subtest ctm-green-to-red: SKIP (0.000s)
[603.750020] [087/131] (502s left) gen9_exec_parse (unaligned-jump)
[603.803304] Subtest unaligned-jump: SKIP (0.000s)
[603.879081] [088/131] (501s left) kms_psr2_sf (fbc-pr-plane-move-sf-dmg-area)
[608.912618] Starting subtest: fbc-pr-plane-move-sf-dmg-area
[608.918403] Subtest fbc-pr-plane-move-sf-dmg-area: SKIP (0.002s)
[609.762295] [089/131] (496s left) syncobj_timeline (invalid-multi-wait-unsubmitted)
[609.846615] Starting subtest: invalid-multi-wait-unsubmitted
[609.848937] Subtest invalid-multi-wait-unsubmitted: SUCCESS (0.000s)
[609.944020] [090/131] (496s left) syncobj_eventfd (timeline-wait-before-signal)
[609.996260] Starting subtest: timeline-wait-before-signal
[610.025715] Subtest timeline-wait-before-signal: SUCCESS (0.031s)
[610.102919] [091/131] (495s left) kms_chamelium_frames (vga-frame-dump)
[610.486469] Subtest vga-frame-dump: SKIP (0.000s)
[611.260981] [092/131] (494s left) perf_pmu (busy-idle-check-all)
[611.297297] Starting subtest: busy-idle-check-all
[611.299572] Starting dynamic subtest: rcs0
[611.959445] Dynamic subtest rcs0: SUCCESS (0.664s)
[611.971595] Starting dynamic subtest: bcs0
[612.609927] Dynamic subtest bcs0: SUCCESS (0.651s)
[612.622797] Starting dynamic subtest: vcs0
[614.310870] Dynamic subtest vcs0: SUCCESS (1.700s)
[614.323753] Starting dynamic subtest: vcs1
[616.296254] Dynamic subtest vcs1: SUCCESS (1.981s)
[616.308186] Starting dynamic subtest: vecs0
[618.344078] Dynamic subtest vecs0: SUCCESS (2.042s)
[618.356808] Starting dynamic subtest: ccs0
[619.001454] Dynamic subtest ccs0: SUCCESS (0.655s)
[619.004380] Subtest busy-idle-check-all: SUCCESS (7.706s)
[619.108877] [093/131] (486s left) gem_lmem_swapping (massive-random)
[619.153825] Subtest massive-random: SKIP (0.000s)
[619.198931] [094/131] (486s left) kms_cursor_legacy (cursora-vs-flipa-varying-size)
[619.315162] Starting subtest: cursorA-vs-flipA-varying-size
[630.525224] Subtest cursorA-vs-flipA-varying-size: SUCCESS (11.149s)
[631.317886] [095/131] (474s left) kms_cursor_crc (cursor-onscreen-128x128)
[631.532168] Starting subtest: cursor-onscreen-128x128
[631.534823] Starting dynamic subtest: pipe-A-eDP-1
[633.878157] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.339s)
[633.904229] Starting dynamic subtest: pipe-D-eDP-1
[636.877721] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.981s)
[636.880245] Subtest cursor-onscreen-128x128: SUCCESS (5.342s)
[637.668559] [096/131] (468s left) perf (invalid-oa-exponent)
[637.783726] Starting subtest: invalid-oa-exponent
[637.802381] Subtest invalid-oa-exponent: SUCCESS (0.021s)
[637.844427] [097/131] (468s left) kms_sequence (queue-busy)
[637.944350] Starting subtest: queue-busy
[637.947139] Starting dynamic subtest: pipe-A-eDP-1
[639.880571] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.932s)
[639.890100] Starting dynamic subtest: pipe-B-eDP-1
[642.447277] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.566s)
[642.458343] Starting dynamic subtest: pipe-C-eDP-1
[645.045207] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.597s)
[645.055810] Starting dynamic subtest: pipe-D-eDP-1
[647.579467] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.532s)
[647.581999] Subtest queue-busy: SUCCESS (9.631s)
[648.363312] [098/131] (457s left) kms_rotation_crc (sprite-rotation-180)
[648.458328] Starting subtest: sprite-rotation-180
[653.466330] Subtest sprite-rotation-180: SUCCESS (5.009s)
[654.623178] [099/131] (451s left) kms_frontbuffer_tracking (fbc-2p-primscrn-shrfb-pgflip-blt)
[654.729576] Starting subtest: fbc-2p-primscrn-shrfb-pgflip-blt
[654.734300] Subtest fbc-2p-primscrn-shrfb-pgflip-blt: SKIP (0.000s)
[654.818962] [100/131] (451s left) kms_psr (fbc-pr-no-drrs)
[654.905458] Starting subtest: fbc-pr-no-drrs
[654.911332] Subtest fbc-pr-no-drrs: SKIP (0.000s)
[654.980248] [101/131] (451s left) kms_content_protection (atomic)
[655.138533] Starting subtest: atomic
[658.537853] Subtest atomic: SKIP (3.398s)
[659.716382] [102/131] (446s left) kms_psr (psr2-primary-blt)
[659.803022] Starting subtest: psr2-primary-blt
[659.805399] Starting dynamic subtest: eDP-1
[661.592390] Dynamic subtest eDP-1: SUCCESS (1.789s)
[661.595141] Subtest psr2-primary-blt: SUCCESS (1.790s)
[662.461939] [103/131] (444s left) gem_create (create-ext-placement-all)
[662.625063] Starting subtest: create-ext-placement-all
[662.627765] Subtest create-ext-placement-all: SUCCESS (0.000s)
[662.711788] [104/131] (443s left) gem_userptr_blits (coherency-sync)
[662.780405] Starting subtest: coherency-sync
[663.218296] Subtest coherency-sync: SKIP (0.398s)
[663.326443] [105/131] (443s left) kms_flip (2x-flip-vs-suspend)
[663.474325] Starting subtest: 2x-flip-vs-suspend
[663.484993] Subtest 2x-flip-vs-suspend: SKIP (0.010s)
[663.600029] [106/131] (443s left) kms_psr (fbc-psr2-primary-page-flip)
[663.692545] Starting subtest: fbc-psr2-primary-page-flip
[663.694826] Starting dynamic subtest: eDP-1
[663.699091] Dynamic subtest eDP-1: SKIP (0.000s)
[663.703308] Subtest fbc-psr2-primary-page-flip: SKIP (0.001s)
[663.764007] [107/131] (442s left) kms_psr (psr2-cursor-blt)
[663.867246] Starting subtest: psr2-cursor-blt
[663.869525] Starting dynamic subtest: eDP-1
[665.534876] Dynamic subtest eDP-1: SUCCESS (1.666s)
[665.537214] Subtest psr2-cursor-blt: SUCCESS (1.666s)
[666.321493] [108/131] (440s left) gem_render_copy (y-tiled-mc-ccs-to-vebox-y-tiled)
[666.382934] Starting subtest: y-tiled-mc-ccs-to-vebox-y-tiled
[666.388124] Subtest y-tiled-mc-ccs-to-vebox-y-tiled: SKIP (0.000s)
[666.569127] [109/131] (440s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-mmap-gtt)
[666.667064] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-mmap-gtt
[666.671593] Subtest fbc-2p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[666.765002] [110/131] (440s left) kms_plane_scaling (invalid-parameters)
[666.863795] Starting subtest: invalid-parameters
[666.866171] Starting dynamic subtest: less-than-1-height-src
[666.875204] Dynamic subtest less-than-1-height-src: SUCCESS (0.011s)
[666.884889] Starting dynamic subtest: less-than-1-width-src
[666.887427] Dynamic subtest less-than-1-width-src: SUCCESS (0.010s)
[666.889798] Subtest invalid-parameters: SUCCESS (0.022s)
[666.998403] [111/131] (439s left) gem_exec_fence (basic-wait)
[667.179771] Starting subtest: basic-wait
[667.182236] Starting dynamic subtest: rcs0
[667.283756] Dynamic subtest rcs0: SUCCESS (0.104s)
[667.295087] Starting dynamic subtest: bcs0
[667.340748] Dynamic subtest bcs0: SUCCESS (0.055s)
[667.352686] Starting dynamic subtest: vcs0
[667.399779] Dynamic subtest vcs0: SUCCESS (0.057s)
[667.409709] Starting dynamic subtest: vcs1
[667.466975] Dynamic subtest vcs1: SUCCESS (0.065s)
[667.480375] Starting dynamic subtest: vecs0
[667.527621] Dynamic subtest vecs0: SUCCESS (0.059s)
[667.539068] Starting dynamic subtest: ccs0
[667.587823] Dynamic subtest ccs0: SUCCESS (0.058s)
[667.590578] Subtest basic-wait: SUCCESS (0.409s)
[669.415249] [112/131] (437s left) api_intel_bb (object-reloc-keep-cache)
[669.472475] Starting subtest: object-reloc-keep-cache
[669.477768] Subtest object-reloc-keep-cache: SKIP (0.006s)
[669.571774] [113/131] (437s left) syncobj_timeline (etime-single-wait-all-for-submit-unsubmitted)
[669.625231] Starting subtest: etime-single-wait-all-for-submit-unsubmitted
[669.731243] Subtest etime-single-wait-all-for-submit-unsubmitted: SUCCESS (0.104s)
[669.807860] [114/131] (437s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-render)
[669.904982] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-render
[676.597357] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-render: SUCCESS (6.697s)
[676.756684] [115/131] (430s left) gem_lmem_evict (dontneed-evict-race)
[676.798800] Subtest dontneed-evict-race: SKIP (0.000s)
[676.844024] [116/131] (430s left) sw_sync (sync_merge_invalid)
[676.878798] Starting subtest: sync_merge_invalid
[676.903364] Subtest sync_merge_invalid: SUCCESS (0.029s)
[676.991661] [117/131] (430s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-render)
[677.084942] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-render
[677.089268] Subtest fbc-2p-scndscrn-pri-indfb-draw-render: SKIP (0.000s)
[677.188693] [118/131] (429s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-64bpp-ytile-upscaling)
[677.289478] Starting subtest: flip-32bpp-ytile-to-64bpp-ytile-upscaling
[677.292458] Starting dynamic subtest: pipe-A-default-mode
[677.579582] Dynamic subtest pipe-A-default-mode: SKIP (0.284s)
[677.584535] Subtest flip-32bpp-ytile-to-64bpp-ytile-upscaling: SKIP (0.286s)
[678.435495] [119/131] (428s left) kms_psr2_sf (pr-primary-plane-update-sf-dmg-area)
[683.498147] Starting subtest: pr-primary-plane-update-sf-dmg-area
[683.503265] Subtest pr-primary-plane-update-sf-dmg-area: SKIP (0.002s)
[684.348913] [120/131] (422s left) kms_rotation_crc (primary-yf-tiled-reflect-x-90)
[684.445285] Starting subtest: primary-yf-tiled-reflect-x-90
[684.450247] Subtest primary-yf-tiled-reflect-x-90: SKIP (0.001s)
[684.520120] [121/131] (422s left) kms_setmode (basic-clone-single-crtc)
[684.577530] Starting subtest: basic-clone-single-crtc
[684.585580] Subtest basic-clone-single-crtc: SKIP (0.000s)
[684.695029] [122/131] (422s left) kms_plane_lowres (tiling-x)
[684.792174] Starting subtest: tiling-x
[684.794585] Starting dynamic subtest: pipe-A-eDP-1
[684.799471] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[685.088221] Starting dynamic subtest: pipe-B-eDP-1
[685.093562] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[685.103705] Starting dynamic subtest: pipe-C-eDP-1
[685.109368] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[685.118403] Starting dynamic subtest: pipe-D-eDP-1
[685.123096] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[685.127318] Subtest tiling-x: SKIP (0.290s)
[685.872367] [123/131] (421s left) perf_pmu (semaphore-busy)
[685.913320] Starting subtest: semaphore-busy
[685.915678] Starting dynamic subtest: rcs0
[687.567428] Dynamic subtest rcs0: SUCCESS (1.651s)
[687.577609] Starting dynamic subtest: bcs0
[689.196786] Dynamic subtest bcs0: SUCCESS (1.626s)
[689.209804] Starting dynamic subtest: vcs0
[692.890350] Dynamic subtest vcs0: SUCCESS (3.634s)
[692.902267] Starting dynamic subtest: vcs1
[698.901889] Dynamic subtest vcs1: SUCCESS (6.013s)
[698.913477] Starting dynamic subtest: vecs0
[704.802057] Dynamic subtest vecs0: SUCCESS (5.948s)
[704.813689] Starting dynamic subtest: ccs0
[707.941247] Dynamic subtest ccs0: SUCCESS (3.136s)
[707.943911] Subtest semaphore-busy: SUCCESS (22.022s)
[708.058855] [124/131] (399s left) gem_exec_suspend (basic-s3-devices)
[708.128267] Starting subtest: basic-S3-devices
[708.131067] Starting dynamic subtest: smem
[718.312605] Dynamic subtest smem: SUCCESS (10.182s)
[718.315718] Subtest basic-S3-devices: SUCCESS (10.183s)
[718.499016] [125/131] (388s left) gen9_exec_parse (batch-invalid-length)
[718.573371] Subtest batch-invalid-length: SKIP (0.000s)
[718.647176] [126/131] (388s left) sw_sync (sync_multi_consumer_producer)
[718.681723] Starting subtest: sync_multi_consumer_producer
[719.063048] Subtest sync_multi_consumer_producer: SUCCESS (0.383s)
[719.127918] [127/131] (388s left) kms_dirtyfb (default-dirtyfb-ioctl)
[719.221242] Starting subtest: default-dirtyfb-ioctl
[719.223922] Starting dynamic subtest: A-eDP-1
[720.863137] Dynamic subtest A-eDP-1: SUCCESS (1.642s)
[720.865770] Subtest default-dirtyfb-ioctl: SUCCESS (1.643s)
[721.703272] [128/131] (385s left) gem_ctx_param (vm)
[721.760288] Starting subtest: vm
[721.816319] Subtest vm: SUCCESS (0.056s)
[721.942809] [129/131] (385s left) gem_mmap_gtt (close-race)
[721.990951] Subtest close-race: SKIP (0.000s)
[722.050304] [130/131] (385s left) syncobj_wait (single-wait-signaled)
[722.106233] Starting subtest: single-wait-signaled
[722.108706] Subtest single-wait-signaled: SUCCESS (0.000s)
[722.209948] [131/131] (385s left) syncobj_basic (bad-flags-fd-to-handle)
[722.266335] Starting subtest: bad-flags-fd-to-handle
[722.268633] Subtest bad-flags-fd-to-handle: SUCCESS (0.000s)
[722.367702] Closing watchdogs
results: parsing output: 0/ for test: gem_render_copy
results: parsing output: 1/ for test: kms_pm_rpm
results: parsing output: 2/ for test: kms_frontbuffer_tracking
results: parsing output: 3/ for test: gem_softpin
results: parsing output: 4/ for test: gem_exec_whisper
results: parsing output: 5/ for test: kms_big_fb
results: parsing output: 6/ for test: kms_atomic
results: parsing output: 7/ for test: gem_userptr_blits
results: parsing output: 8/ for test: kms_busy
results: parsing output: 9/ for test: gem_reg_read
results: parsing output: 10/ for test: i915_drm_fdinfo
results: parsing output: 11/ for test: kms_color
results: parsing output: 12/ for test: kms_frontbuffer_tracking
results: parsing output: 13/ for test: kms_ccs
results: parsing output: 14/ for test: prime_vgem
results: parsing output: 15/ for test: kms_mmap_write_crc
results: parsing output: 16/ for test: sysfs_heartbeat_interval
results: parsing output: 17/ for test: i915_power
results: parsing output: 18/ for test: gem_exec_reloc
results: parsing output: 19/ for test: kms_ccs
results: parsing output: 20/ for test: perf
results: parsing output: 21/ for test: kms_async_flips
results: parsing output: 22/ for test: kms_fbcon_fbt
results: parsing output: 23/ for test: kms_frontbuffer_tracking
results: parsing output: 24/ for test: i915_module_load
results: parsing output: 25/ for test: gem_ctx_persistence
results: parsing output: 26/ for test: gem_exec_schedule
results: parsing output: 27/ for test: kms_frontbuffer_tracking
results: parsing output: 28/ for test: kms_big_fb
results: parsing output: 29/ for test: syncobj_wait
results: parsing output: 30/ for test: kms_frontbuffer_tracking
results: parsing output: 31/ for test: kms_cursor_crc
results: parsing output: 32/ for test: kms_frontbuffer_tracking
results: parsing output: 33/ for test: dumb_buffer
results: parsing output: 34/ for test: gem_exec_balancer
results: parsing output: 35/ for test: kms_addfb_basic
results: parsing output: 36/ for test: kms_flip_scaled_crc
results: parsing output: 37/ for test: kms_frontbuffer_tracking
results: parsing output: 38/ for test: kms_ccs
results: parsing output: 39/ for test: gem_mmap_wc
results: parsing output: 40/ for test: kms_properties
results: parsing output: 41/ for test: kms_big_fb
results: parsing output: 42/ for test: kms_psr
results: parsing output: 43/ for test: kms_frontbuffer_tracking
results: parsing output: 44/ for test: kms_ccs
results: parsing output: 45/ for test: kms_flip
results: parsing output: 46/ for test: kms_cursor_legacy
results: parsing output: 47/ for test: kms_cursor_edge_walk
results: parsing output: 48/ for test: prime_self_import
results: parsing output: 49/ for test: kms_joiner
results: parsing output: 50/ for test: kms_addfb_basic
results: parsing output: 51/ for test: kms_pipe_b_c_ivb
results: parsing output: 52/ for test: kms_frontbuffer_tracking
results: parsing output: 53/ for test: syncobj_timeline
results: parsing output: 54/ for test: kms_lease
results: parsing output: 55/ for test: gem_pxp
results: parsing output: 56/ for test: kms_frontbuffer_tracking
results: parsing output: 57/ for test: kms_psr
results: parsing output: 58/ for test: gem_spin_batch
results: parsing output: 59/ for test: gem_exec_fence
results: parsing output: 60/ for test: kms_big_fb
results: parsing output: 61/ for test: syncobj_timeline
results: parsing output: 62/ for test: syncobj_wait
results: parsing output: 63/ for test: kms_frontbuffer_tracking
results: parsing output: 64/ for test: i915_query
results: parsing output: 65/ for test: gem_exec_params
results: parsing output: 66/ for test: kms_frontbuffer_tracking
results: parsing output: 67/ for test: kms_frontbuffer_tracking
results: parsing output: 68/ for test: gem_mmap_gtt
results: parsing output: 69/ for test: kms_ccs
results: parsing output: 70/ for test: gem_exec_balancer
results: parsing output: 71/ for test: kms_vblank
results: parsing output: 72/ for test: kms_pm_backlight
results: parsing output: 73/ for test: kms_frontbuffer_tracking
results: parsing output: 74/ for test: syncobj_wait
results: parsing output: 75/ for test: gem_exec_reloc
results: parsing output: 76/ for test: kms_frontbuffer_tracking
results: parsing output: 77/ for test: kms_frontbuffer_tracking
results: parsing output: 78/ for test: kms_big_fb
results: parsing output: 79/ for test: api_intel_allocator
results: parsing output: 80/ for test: gem_exec_reloc
results: parsing output: 81/ for test: gem_ctx_engines
results: parsing output: 82/ for test: kms_plane_scaling
results: parsing output: 83/ for test: gem_exec_schedule
results: parsing output: 84/ for test: kms_frontbuffer_tracking
results: parsing output: 85/ for test: kms_chamelium_color
results: parsing output: 86/ for test: gen9_exec_parse
results: parsing output: 87/ for test: kms_psr2_sf
results: parsing output: 88/ for test: syncobj_timeline
results: parsing output: 89/ for test: syncobj_eventfd
results: parsing output: 90/ for test: kms_chamelium_frames
results: parsing output: 91/ for test: perf_pmu
results: parsing output: 92/ for test: gem_lmem_swapping
results: parsing output: 93/ for test: kms_cursor_legacy
results: parsing output: 94/ for test: kms_cursor_crc
results: parsing output: 95/ for test: perf
results: parsing output: 96/ for test: kms_sequence
results: parsing output: 97/ for test: kms_rotation_crc
results: parsing output: 98/ for test: kms_frontbuffer_tracking
results: parsing output: 99/ for test: kms_psr
results: parsing output: 100/ for test: kms_content_protection
results: parsing output: 101/ for test: kms_psr
results: parsing output: 102/ for test: gem_create
results: parsing output: 103/ for test: gem_userptr_blits
results: parsing output: 104/ for test: kms_flip
results: parsing output: 105/ for test: kms_psr
results: parsing output: 106/ for test: kms_psr
results: parsing output: 107/ for test: gem_render_copy
results: parsing output: 108/ for test: kms_frontbuffer_tracking
results: parsing output: 109/ for test: kms_plane_scaling
results: parsing output: 110/ for test: gem_exec_fence
results: parsing output: 111/ for test: api_intel_bb
results: parsing output: 112/ for test: syncobj_timeline
results: parsing output: 113/ for test: kms_frontbuffer_tracking
results: parsing output: 114/ for test: gem_lmem_evict
results: parsing output: 115/ for test: sw_sync
results: parsing output: 116/ for test: kms_frontbuffer_tracking
results: parsing output: 117/ for test: kms_flip_scaled_crc
results: parsing output: 118/ for test: kms_psr2_sf
results: parsing output: 119/ for test: kms_rotation_crc
results: parsing output: 120/ for test: kms_setmode
results: parsing output: 121/ for test: kms_plane_lowres
results: parsing output: 122/ for test: perf_pmu
results: parsing output: 123/ for test: gem_exec_suspend
results: parsing output: 124/ for test: gen9_exec_parse
results: parsing output: 125/ for test: sw_sync
results: parsing output: 126/ for test: kms_dirtyfb
results: parsing output: 127/ for test: gem_ctx_param
results: parsing output: 128/ for test: gem_mmap_gtt
results: parsing output: 129/ for test: syncobj_wait
results: parsing output: 130/ for test: syncobj_basic
Done.