[57.239128] Initializing watchdogs [57.239174] /dev/watchdog0 [57.255579] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:7d55 Intel Meteorlake (Gen12) Meteor Lake-P [Intel Arc Graphics] [57.259448] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [57.261733] [FACT before any test] new: kernel.kmod_is_loaded.i915: true [57.265204] [001/133] (960s left) kms_flip_scaled_crc (flip-64bpp-yftile-to-32bpp-yftile-downscaling) [57.428195] Starting subtest: flip-64bpp-yftile-to-32bpp-yftile-downscaling [57.430632] Starting dynamic subtest: pipe-A-default-mode [57.721424] Dynamic subtest pipe-A-default-mode: SKIP (0.284s) [57.726271] Subtest flip-64bpp-yftile-to-32bpp-yftile-downscaling: SKIP (0.285s) [58.548792] [002/133] (959s left) gem_exec_schedule (out-order) [58.623652] Starting subtest: out-order [58.625665] Starting dynamic subtest: rcs0 [58.715591] Dynamic subtest rcs0: SUCCESS (0.095s) [58.727060] Starting dynamic subtest: vcs0 [58.793518] Dynamic subtest vcs0: SUCCESS (0.078s) [58.802891] Starting dynamic subtest: vcs1 [58.870314] Dynamic subtest vcs1: SUCCESS (0.075s) [58.879559] Starting dynamic subtest: vecs0 [58.941577] Dynamic subtest vecs0: SUCCESS (0.070s) [58.950989] Starting dynamic subtest: ccs0 [59.021184] Dynamic subtest ccs0: SUCCESS (0.078s) [59.023683] Subtest out-order: SUCCESS (0.397s) [60.058323] [003/133] (957s left) kms_flip (dpms-off-confusion) [60.147368] Starting subtest: dpms-off-confusion [60.149725] Starting dynamic subtest: A-eDP1 [68.904116] Dynamic subtest A-eDP1: SUCCESS (8.688s) [68.912515] Starting dynamic subtest: B-eDP1 [77.581381] Dynamic subtest B-eDP1: SUCCESS (8.655s) [77.590435] Starting dynamic subtest: C-eDP1 [86.317316] Dynamic subtest C-eDP1: SUCCESS (8.726s) [86.323915] Starting dynamic subtest: D-eDP1 [95.049455] Dynamic subtest D-eDP1: SUCCESS (8.726s) [95.051903] Subtest dpms-off-confusion: SUCCESS (34.800s) [96.202564] [004/133] (921s left) gem_ctx_engines (execute-allforone) [96.263865] Starting subtest: execute-allforone [96.273666] Subtest execute-allforone: SUCCESS (0.012s) [98.054756] [005/133] (919s left) kms_dither (fb-8bpc-vs-panel-8bpc) [98.144931] Starting subtest: fb-8bpc-vs-panel-8bpc [98.147335] Starting dynamic subtest: pipe-A-eDP-1 [99.470523] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.324s) [99.473052] Subtest fb-8bpc-vs-panel-8bpc: SUCCESS (1.324s) [100.254211] [006/133] (917s left) i915_pm_rc6_residency (rc6-accuracy) [100.306863] Starting subtest: rc6-accuracy [100.308802] Starting dynamic subtest: gt0 [103.479092] Dynamic subtest gt0: SUCCESS (3.168s) [103.488637] Starting dynamic subtest: gt1 [106.647798] Dynamic subtest gt1: SUCCESS (3.167s) [106.650732] Subtest rc6-accuracy: SUCCESS (6.335s) [106.711203] [007/133] (911s left) kms_psr2_sf (fbc-psr2-cursor-plane-move-continuous-sf) [111.710824] Starting subtest: fbc-psr2-cursor-plane-move-continuous-sf [111.713327] Starting dynamic subtest: pipe-A-eDP-1 [112.516533] Dynamic subtest pipe-A-eDP-1: SKIP (0.802s) [112.524861] Starting dynamic subtest: pipe-B-eDP-1 [113.640833] Dynamic subtest pipe-B-eDP-1: SKIP (1.123s) [113.645337] Subtest fbc-psr2-cursor-plane-move-continuous-sf: SKIP (1.927s) [114.817530] [008/133] (903s left) kms_plane_scaling (planes-upscale-20x20) [114.912995] Starting subtest: planes-upscale-20x20 [114.915485] Starting dynamic subtest: pipe-A [114.979656] Dynamic subtest pipe-A: SUCCESS (0.067s) [114.988194] Starting dynamic subtest: pipe-B [116.156128] Dynamic subtest pipe-B: SUCCESS (1.176s) [116.164800] Starting dynamic subtest: pipe-C [117.265545] Dynamic subtest pipe-C: SUCCESS (1.109s) [117.272754] Starting dynamic subtest: pipe-D [118.394497] Dynamic subtest pipe-D: SUCCESS (1.129s) [118.396768] Subtest planes-upscale-20x20: SUCCESS (3.481s) [119.543848] [009/133] (898s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-180) [119.654802] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-180 [119.659475] Subtest yf-tiled-max-hw-stride-64bpp-rotate-180: SKIP (0.000s) [119.752704] [010/133] (898s left) kms_chamelium_hpd (hdmi-hpd) [120.131558] Subtest hdmi-hpd: SKIP (0.000s) [120.948273] [011/133] (897s left) kms_feature_discovery (display) [121.044956] Starting subtest: display [121.047401] Subtest display: SUCCESS (0.000s) [121.112925] [012/133] (897s left) kms_psr (pr-sprite-blt) [121.206045] Starting subtest: pr-sprite-blt [121.210869] Subtest pr-sprite-blt: SKIP (0.000s) [121.268057] [013/133] (897s left) gem_exec_whisper (basic-contexts) [121.332264] Starting subtest: basic-contexts [126.481655] Subtest basic-contexts: SUCCESS (5.146s) [126.656331] [014/133] (891s left) gem_exec_schedule (thriceslice) [126.726533] Starting subtest: thriceslice [126.728822] Starting dynamic subtest: rcs0 [126.757846] Dynamic subtest rcs0: SUCCESS (0.038s) [126.768253] Starting dynamic subtest: bcs0 [126.810801] Dynamic subtest bcs0: SUCCESS (0.053s) [126.818467] Starting dynamic subtest: vcs0 [126.845472] Dynamic subtest vcs0: SUCCESS (0.035s) [126.853679] Starting dynamic subtest: vcs1 [126.896979] Dynamic subtest vcs1: SUCCESS (0.051s) [126.905133] Starting dynamic subtest: vecs0 [126.951555] Dynamic subtest vecs0: SUCCESS (0.054s) [126.959252] Starting dynamic subtest: ccs0 [127.007880] Dynamic subtest ccs0: SUCCESS (0.056s) [127.010739] Subtest thriceslice: SUCCESS (0.288s) [127.298384] [015/133] (891s left) gem_exec_gttfill (engines) [127.370023] Starting subtest: engines [127.372581] Starting dynamic subtest: rcs0 [152.785035] Dynamic subtest rcs0: SUCCESS (25.409s) [152.795104] Starting dynamic subtest: bcs0 [178.186065] Dynamic subtest bcs0: SUCCESS (25.398s) [178.194489] Starting dynamic subtest: vcs0 [203.508838] Dynamic subtest vcs0: SUCCESS (25.319s) [203.519264] Starting dynamic subtest: vcs1 [228.814289] Dynamic subtest vcs1: SUCCESS (25.302s) [228.824600] Starting dynamic subtest: vecs0 [254.059445] Dynamic subtest vecs0: SUCCESS (25.243s) [254.069852] Starting dynamic subtest: ccs0 [279.226056] Dynamic subtest ccs0: SUCCESS (25.163s) [279.228913] Subtest engines: SUCCESS (151.839s) [279.404194] [016/133] (739s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip) [279.556667] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip [279.561152] Subtest y-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip: SKIP (0.000s) [279.651108] [017/133] (738s left) kms_getfb (getfb-handle-protection) [279.711276] Starting subtest: getfb-handle-protection [279.732375] Subtest getfb-handle-protection: SUCCESS (0.022s) [279.869215] [018/133] (738s left) vkms/vkms_configfs (enable-plane-no-crtcs) [279.970824] Subtest enable-plane-no-crtcs: SKIP (0.000s) [280.021806] [019/133] (738s left) syncobj_wait (single-wait-for-submit-submitted) [280.077646] Starting subtest: single-wait-for-submit-submitted [280.181118] Subtest single-wait-for-submit-submitted: SUCCESS (0.102s) [280.252723] [020/133] (738s left) dumb_buffer (map-uaf) [280.317538] Starting subtest: map-uaf [280.331346] Subtest map-uaf: SUCCESS (0.015s) [280.441367] [021/133] (738s left) kms_psr (fbc-psr-sprite-plane-move) [280.531263] Starting subtest: fbc-psr-sprite-plane-move [280.533579] Starting dynamic subtest: eDP-1 [280.537950] Dynamic subtest eDP-1: SKIP (0.000s) [280.542248] Subtest fbc-psr-sprite-plane-move: SKIP (0.000s) [280.596877] [022/133] (738s left) perf_pmu (multi-client) [280.639305] Starting subtest: multi-client [280.641311] Starting dynamic subtest: rcs0 [281.734938] Dynamic subtest rcs0: SUCCESS (1.095s) [281.746111] Starting dynamic subtest: bcs0 [282.781518] Dynamic subtest bcs0: SUCCESS (1.046s) [282.792607] Starting dynamic subtest: vcs0 [283.829375] Dynamic subtest vcs0: SUCCESS (1.047s) [283.840210] Starting dynamic subtest: vcs1 [284.958260] Dynamic subtest vcs1: SUCCESS (1.128s) [284.968920] Starting dynamic subtest: vecs0 [286.948116] Dynamic subtest vecs0: SUCCESS (1.990s) [286.957825] Starting dynamic subtest: ccs0 [288.929791] Dynamic subtest ccs0: SUCCESS (1.981s) [288.932371] Subtest multi-client: SUCCESS (8.291s) [289.038629] [023/133] (729s left) kms_psr (psr-cursor-mmap-cpu) [289.143059] Starting subtest: psr-cursor-mmap-cpu [289.145396] Starting dynamic subtest: eDP-1 [290.857066] Dynamic subtest eDP-1: SUCCESS (1.712s) [290.859741] Subtest psr-cursor-mmap-cpu: SUCCESS (1.712s) [291.709589] [024/133] (726s left) gem_basic (create-close) [291.760230] Starting subtest: create-close [291.764858] Subtest create-close: SUCCESS (0.000s) [291.865578] [025/133] (726s left) gem_userptr_blits (readonly-pwrite-unsync) [291.928296] Subtest readonly-pwrite-unsync: SKIP (0.000s) [292.049234] [026/133] (726s left) i915_query (hwconfig_table) [292.105133] Starting subtest: hwconfig_table [292.407322] Subtest hwconfig_table: SUCCESS (0.001s) [292.442594] [027/133] (726s left) gem_userptr_blits (map-fixed-invalidate-busy) [292.518286] Starting subtest: map-fixed-invalidate-busy [292.522968] Subtest map-fixed-invalidate-busy: SKIP (0.000s) [292.668628] [028/133] (726s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-mmap-wc) [292.776983] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-mmap-wc [295.327729] Subtest fbc-1p-primscrn-cur-indfb-draw-mmap-wc: SUCCESS (2.552s) [295.460250] [029/133] (723s left) kms_psr2_sf (pr-overlay-plane-move-continuous-sf) [300.497702] Starting subtest: pr-overlay-plane-move-continuous-sf [300.502257] Subtest pr-overlay-plane-move-continuous-sf: SKIP (0.002s) [301.331017] [030/133] (717s left) kms_flip (plain-flip-interruptible) [301.431292] Starting subtest: plain-flip-interruptible [301.433608] Starting dynamic subtest: A-eDP1 [303.136448] Dynamic subtest A-eDP1: SUCCESS (1.704s) [303.146818] Starting dynamic subtest: B-eDP1 [304.763255] Dynamic subtest B-eDP1: SUCCESS (1.625s) [304.775078] Starting dynamic subtest: C-eDP1 [306.489619] Dynamic subtest C-eDP1: SUCCESS (1.726s) [306.498582] Starting dynamic subtest: D-eDP1 [308.096829] Dynamic subtest D-eDP1: SUCCESS (1.607s) [308.099293] Subtest plain-flip-interruptible: SUCCESS (6.668s) [309.250231] [031/133] (709s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-gtt) [309.346613] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-gtt [309.351094] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s) [309.448252] [032/133] (709s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-mmap-wc) [309.542667] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-mmap-wc [312.878085] Subtest fbc-1p-primscrn-pri-indfb-draw-mmap-wc: SUCCESS (3.340s) [312.997849] [033/133] (705s left) gem_userptr_blits (coherency-unsync) [313.071447] Subtest coherency-unsync: SKIP (0.000s) [313.208968] [034/133] (705s left) gem_madvise (dontneed-before-exec) [313.240991] Starting subtest: dontneed-before-exec [313.267148] Subtest dontneed-before-exec: SKIP (0.024s) [313.319182] [035/133] (705s left) syncobj_wait (wait-all-delayed-signal) [313.378726] Starting subtest: wait-all-delayed-signal [313.484485] Subtest wait-all-delayed-signal: SUCCESS (0.103s) [313.555997] [036/133] (705s left) kms_ccs (bad-rotation-90-4-tiled-mtl-rc-ccs-cc) [313.659475] Starting subtest: bad-rotation-90-4-tiled-mtl-rc-ccs-cc [313.661919] Starting dynamic subtest: pipe-A-eDP-1 [313.856457] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.186s) [313.865137] Starting dynamic subtest: pipe-B-eDP-1 [313.885882] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.008s) [313.894063] Starting dynamic subtest: pipe-C-eDP-1 [313.914245] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.009s) [313.921711] Starting dynamic subtest: pipe-D-eDP-1 [313.941098] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.010s) [313.943279] Subtest bad-rotation-90-4-tiled-mtl-rc-ccs-cc: SUCCESS (0.214s) [316.130262] [037/133] (702s left) gem_softpin (evict-snoop-interruptible) [316.191465] Starting subtest: evict-snoop-interruptible [316.196303] Subtest evict-snoop-interruptible: SKIP (0.000s) [316.312443] [038/133] (702s left) kms_chamelium_audio (dp-audio-edid) [316.703071] Subtest dp-audio-edid: SKIP (0.000s) [317.536198] [039/133] (701s left) kms_psr (fbc-pr-sprite-blt) [317.641078] Starting subtest: fbc-pr-sprite-blt [317.645352] Subtest fbc-pr-sprite-blt: SKIP (0.000s) [317.706102] [040/133] (701s left) gem_render_copy (yf-tiled-mc-ccs-to-vebox-yf-tiled) [317.758074] Starting subtest: yf-tiled-mc-ccs-to-vebox-yf-tiled [317.762675] Subtest yf-tiled-mc-ccs-to-vebox-yf-tiled: SKIP (0.000s) [317.935143] [041/133] (701s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-indfb-plflip-blt) [318.034234] Starting subtest: fbcpsr-1p-primscrn-indfb-plflip-blt [323.259037] Subtest fbcpsr-1p-primscrn-indfb-plflip-blt: SUCCESS (5.229s) [323.377788] [042/133] (695s left) gem_pxp (display-protected-crc) [323.509755] Starting subtest: display-protected-crc [325.148886] Subtest display-protected-crc: SUCCESS (1.642s) [325.269329] [043/133] (694s left) kms_cursor_legacy (basic-flip-after-cursor-varying-size) [325.387655] Starting subtest: basic-flip-after-cursor-varying-size [326.301724] Subtest basic-flip-after-cursor-varying-size: SUCCESS (0.916s) [327.122745] [044/133] (692s left) gem_exec_reloc (basic-wc) [327.184565] Subtest basic-wc: SKIP (0.000s) [327.259698] [045/133] (692s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling) [327.357103] Starting subtest: flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling [327.359705] Starting dynamic subtest: pipe-A-default-mode [327.723890] Dynamic subtest pipe-A-default-mode: SKIP (0.363s) [327.728113] Subtest flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling: SKIP (0.365s) [328.452226] [046/133] (690s left) kms_plane (plane-position-hole) [328.552909] Starting subtest: plane-position-hole [329.056157] Starting dynamic subtest: pipe-A-plane-1 [330.303695] Dynamic subtest pipe-A-plane-1: SUCCESS (1.249s) [330.313104] Starting dynamic subtest: pipe-A-plane-2 [331.533087] Dynamic subtest pipe-A-plane-2: SUCCESS (1.228s) [331.542375] Starting dynamic subtest: pipe-A-plane-3 [332.775058] Dynamic subtest pipe-A-plane-3: SUCCESS (1.241s) [332.784053] Starting dynamic subtest: pipe-A-plane-4 [333.994193] Dynamic subtest pipe-A-plane-4: SUCCESS (1.219s) [334.002928] Starting dynamic subtest: pipe-A-plane-5 [334.033965] Dynamic subtest pipe-A-plane-5: SUCCESS (0.038s) [335.156676] Starting dynamic subtest: pipe-B-plane-1 [336.439603] Dynamic subtest pipe-B-plane-1: SUCCESS (1.288s) [336.447067] Starting dynamic subtest: pipe-B-plane-2 [337.668212] Dynamic subtest pipe-B-plane-2: SUCCESS (1.229s) [337.677506] Starting dynamic subtest: pipe-B-plane-3 [338.900335] Dynamic subtest pipe-B-plane-3: SUCCESS (1.232s) [338.909406] Starting dynamic subtest: pipe-B-plane-4 [340.122453] Dynamic subtest pipe-B-plane-4: SUCCESS (1.220s) [340.135107] Starting dynamic subtest: pipe-B-plane-5 [340.159522] Dynamic subtest pipe-B-plane-5: SUCCESS (0.036s) [340.161964] Subtest plane-position-hole: SUCCESS (11.604s) [340.926495] [047/133] (678s left) kms_flip (flip-vs-expired-vblank) [341.026274] Starting subtest: flip-vs-expired-vblank [341.028727] Starting dynamic subtest: A-eDP1 [349.727767] Dynamic subtest A-eDP1: SUCCESS (8.699s) [349.737270] Starting dynamic subtest: B-eDP1 [358.446951] Dynamic subtest B-eDP1: SUCCESS (8.718s) [358.454718] Starting dynamic subtest: C-eDP1 [367.158088] Dynamic subtest C-eDP1: SUCCESS (8.710s) [367.166767] Starting dynamic subtest: D-eDP1 [375.796460] Dynamic subtest D-eDP1: SUCCESS (8.636s) [375.802255] Subtest flip-vs-expired-vblank: SUCCESS (34.774s) [376.948832] [048/133] (642s left) kms_vrr (max-min) [377.050848] Starting subtest: max-min [377.057297] Subtest max-min: SKIP (0.000s) [377.116695] [049/133] (642s left) kms_color (legacy-gamma) [377.223947] Starting subtest: legacy-gamma [377.226323] Starting dynamic subtest: pipe-A-eDP-1 [377.933924] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.708s) [377.943178] Starting dynamic subtest: pipe-B-eDP-1 [379.332849] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.399s) [379.341985] Starting dynamic subtest: pipe-C-eDP-1 [380.634500] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.300s) [380.644288] Starting dynamic subtest: pipe-D-eDP-1 [381.949237] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.314s) [381.951768] Subtest legacy-gamma: SUCCESS (4.723s) [382.767059] [050/133] (636s left) kms_psr (fbc-psr-no-drrs) [382.873503] Starting subtest: fbc-psr-no-drrs [382.875975] Starting dynamic subtest: eDP-1 [382.880282] Dynamic subtest eDP-1: SKIP (0.000s) [382.884549] Subtest fbc-psr-no-drrs: SKIP (0.001s) [382.942429] [051/133] (636s left) kms_flip (wf_vblank-ts-check) [383.040160] Starting subtest: wf_vblank-ts-check [383.042515] Starting dynamic subtest: A-eDP1 [392.012331] Dynamic subtest A-eDP1: SUCCESS (8.970s) [392.021780] Starting dynamic subtest: B-eDP1 [400.933194] Dynamic subtest B-eDP1: SUCCESS (8.919s) [400.942504] Starting dynamic subtest: C-eDP1 [409.842084] Dynamic subtest C-eDP1: SUCCESS (8.908s) [409.851285] Starting dynamic subtest: D-eDP1 [418.769324] Dynamic subtest D-eDP1: SUCCESS (8.925s) [418.771656] Subtest wf_vblank-ts-check: SUCCESS (35.730s) [419.984537] [052/133] (599s left) gem_exec_fence (basic-wait) [420.174936] Starting subtest: basic-wait [420.177419] Starting dynamic subtest: rcs0 [420.278500] Dynamic subtest rcs0: SUCCESS (0.103s) [420.289265] Starting dynamic subtest: bcs0 [420.335349] Dynamic subtest bcs0: SUCCESS (0.055s) [420.344631] Starting dynamic subtest: vcs0 [420.395908] Dynamic subtest vcs0: SUCCESS (0.059s) [420.404769] Starting dynamic subtest: vcs1 [420.455049] Dynamic subtest vcs1: SUCCESS (0.057s) [420.463874] Starting dynamic subtest: vecs0 [420.515972] Dynamic subtest vecs0: SUCCESS (0.059s) [420.525438] Starting dynamic subtest: ccs0 [420.578175] Dynamic subtest ccs0: SUCCESS (0.061s) [420.580646] Subtest basic-wait: SUCCESS (0.404s) [422.017179] [FACT gem_exec_fence (basic-wait)] new: kernel.kmod_is_loaded.vgem: true [422.020541] [053/133] (597s left) gem_userptr_blits (mmap-offset-banned) [422.102333] Starting subtest: mmap-offset-banned [422.104771] Starting dynamic subtest: wb [422.107088] Dynamic subtest wb: SUCCESS (0.000s) [422.117349] Starting dynamic subtest: wc [422.119323] Dynamic subtest wc: SUCCESS (0.000s) [422.126842] Starting dynamic subtest: uc [422.128744] Dynamic subtest uc: SUCCESS (0.000s) [422.130605] Subtest mmap-offset-banned: SUCCESS (0.002s) [422.257780] [054/133] (597s left) kms_legacy_colorkey (invalid-plane) [422.370864] Starting subtest: invalid-plane [422.373600] Starting dynamic subtest: zero-id [422.375750] Dynamic subtest zero-id: SUCCESS (0.000s) [422.383541] Starting dynamic subtest: outrange-id [422.385404] Dynamic subtest outrange-id: SUCCESS (0.000s) [422.387614] Subtest invalid-plane: SUCCESS (0.001s) [422.439984] [055/133] (597s left) api_intel_allocator (reopen) [422.517099] Starting subtest: reopen [422.521717] Subtest reopen: SUCCESS (0.006s) [422.652498] [056/133] (597s left) gem_ctx_persistence (engines-mixed) [422.709390] Starting subtest: engines-mixed [422.711677] Starting dynamic subtest: rcs0 [422.829359] Dynamic subtest rcs0: SUCCESS (0.119s) [422.840749] Starting dynamic subtest: bcs0 [422.905347] Dynamic subtest bcs0: SUCCESS (0.074s) [422.915766] Starting dynamic subtest: vcs0 [422.974221] Dynamic subtest vcs0: SUCCESS (0.067s) [422.984793] Starting dynamic subtest: vcs1 [423.036300] Dynamic subtest vcs1: SUCCESS (0.061s) [423.046549] Starting dynamic subtest: vecs0 [423.110732] Dynamic subtest vecs0: SUCCESS (0.072s) [423.120803] Starting dynamic subtest: ccs0 [423.196237] Dynamic subtest ccs0: SUCCESS (0.084s) [423.198417] Subtest engines-mixed: SUCCESS (0.488s) [423.272015] [057/133] (596s left) kms_frontbuffer_tracking (fbc-1p-offscren-pri-indfb-draw-mmap-wc) [423.373825] Starting subtest: fbc-1p-offscren-pri-indfb-draw-mmap-wc [426.409867] Subtest fbc-1p-offscren-pri-indfb-draw-mmap-wc: SUCCESS (3.038s) [426.532114] [058/133] (593s left) kms_big_fb (linear-8bpp-rotate-90) [426.642056] Starting subtest: linear-8bpp-rotate-90 [426.661538] Subtest linear-8bpp-rotate-90: SKIP (0.020s) [426.783763] [059/133] (593s left) kms_addfb_basic (basic) [426.850946] Starting subtest: basic [426.853115] Subtest basic: SUCCESS (0.000s) [427.016876] [060/133] (592s left) perf_pmu (busy-start) [427.058215] Starting subtest: busy-start [427.060104] Starting dynamic subtest: rcs0 [429.606486] Dynamic subtest rcs0: SUCCESS (2.549s) [429.617082] Starting dynamic subtest: bcs0 [432.155617] Dynamic subtest bcs0: SUCCESS (2.547s) [432.165108] Starting dynamic subtest: vcs0 [435.945215] Dynamic subtest vcs0: SUCCESS (3.786s) [435.954705] Starting dynamic subtest: vcs1 [439.912788] Dynamic subtest vcs1: SUCCESS (3.966s) [439.923536] Starting dynamic subtest: vecs0 [443.945124] Dynamic subtest vecs0: SUCCESS (4.030s) [443.956864] Starting dynamic subtest: ccs0 [446.492650] Dynamic subtest ccs0: SUCCESS (2.547s) [446.495271] Subtest busy-start: SUCCESS (19.435s) [446.589885] [061/133] (573s left) kms_psr2_sf (fbc-pr-cursor-plane-update-sf) [451.557218] Starting subtest: fbc-pr-cursor-plane-update-sf [451.561709] Subtest fbc-pr-cursor-plane-update-sf: SKIP (0.002s) [452.409932] [062/133] (567s left) gem_mmap_gtt (medium-copy-odd) [452.458387] Subtest medium-copy-odd: SKIP (0.000s) [452.515140] [063/133] (567s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-indfb-pgflip-blt) [452.614701] Starting subtest: fbcpsr-2p-primscrn-indfb-pgflip-blt [452.619245] Subtest fbcpsr-2p-primscrn-indfb-pgflip-blt: SKIP (0.000s) [452.718747] [064/133] (567s left) kms_addfb_basic (addfb25-framebuffer-vs-set-tiling) [452.806872] Subtest addfb25-framebuffer-vs-set-tiling: SKIP (0.000s) [452.896443] [065/133] (567s left) gen9_exec_parse (batch-zero-length) [452.967780] Subtest batch-zero-length: SKIP (0.000s) [453.053087] [066/133] (567s left) kms_content_protection (uevent) [453.214870] Starting subtest: uevent [456.534513] Subtest uevent: SKIP (3.317s) [457.705523] [067/133] (562s left) syncobj_timeline (etime-single-wait-all-for-submit-submitted) [457.776107] Starting subtest: etime-single-wait-all-for-submit-submitted [457.885375] Subtest etime-single-wait-all-for-submit-submitted: SUCCESS (0.108s) [457.952701] [068/133] (562s left) syncobj_timeline (etime-multi-wait-all-for-submit-submitted) [458.014823] Starting subtest: etime-multi-wait-all-for-submit-submitted [458.118244] Subtest etime-multi-wait-all-for-submit-submitted: SUCCESS (0.104s) [458.203455] [069/133] (562s left) kms_rotation_crc (primary-x-tiled-reflect-x-180) [458.303229] Starting subtest: primary-x-tiled-reflect-x-180 [465.307249] Subtest primary-x-tiled-reflect-x-180: SUCCESS (7.002s) [466.554405] [070/133] (553s left) vkms/vkms_configfs (encoder-default-files) [466.605250] Subtest encoder-default-files: SKIP (0.000s) [466.657959] [071/133] (553s left) kms_ccs (crc-primary-basic-4-tiled-mtl-rc-ccs-cc) [466.753328] Starting subtest: crc-primary-basic-4-tiled-mtl-rc-ccs-cc [466.755670] Starting dynamic subtest: pipe-A-eDP-1 [467.651653] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.887s) [467.659785] Starting dynamic subtest: pipe-B-eDP-1 [469.198582] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.545s) [469.207170] Starting dynamic subtest: pipe-C-eDP-1 [470.665311] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.466s) [470.674665] Starting dynamic subtest: pipe-D-eDP-1 [472.124441] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.458s) [472.126697] Subtest crc-primary-basic-4-tiled-mtl-rc-ccs-cc: SUCCESS (5.361s) [473.274176] [072/133] (547s left) gem_ctx_persistence (legacy-engines-mixed-process) [473.337411] Starting subtest: legacy-engines-mixed-process [473.339947] Starting dynamic subtest: render [474.906508] Dynamic subtest render: SUCCESS (1.566s) [474.915184] Starting dynamic subtest: bsd1 [476.913211] Dynamic subtest bsd1: SUCCESS (2.008s) [476.923452] Starting dynamic subtest: bsd2 [478.963810] Dynamic subtest bsd2: SUCCESS (2.049s) [478.974301] Starting dynamic subtest: blt [480.966248] Dynamic subtest blt: SUCCESS (2.000s) [480.976946] Starting dynamic subtest: vebox [482.948793] Dynamic subtest vebox: SUCCESS (1.980s) [482.951288] Subtest legacy-engines-mixed-process: SUCCESS (9.611s) [483.026565] [073/133] (537s left) gem_mmap_gtt (hang-busy) [483.087811] Subtest hang-busy: SKIP (0.000s) [483.148328] [074/133] (537s left) kms_flip (2x-nonexisting-fb) [483.263185] Starting subtest: 2x-nonexisting-fb [483.274078] Subtest 2x-nonexisting-fb: SKIP (0.010s) [483.346605] [075/133] (537s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-onoff) [483.448679] Starting subtest: psr-2p-primscrn-spr-indfb-onoff [483.452834] Subtest psr-2p-primscrn-spr-indfb-onoff: SKIP (0.000s) [483.559925] [076/133] (536s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-mmap-gtt) [483.670300] Starting subtest: psr-1p-primscrn-cur-indfb-draw-mmap-gtt [483.674233] Subtest psr-1p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s) [483.775286] [077/133] (536s left) i915_query (query-topology-kernel-writes) [483.842842] Starting subtest: query-topology-kernel-writes [483.845119] Subtest query-topology-kernel-writes: SUCCESS (0.000s) [483.959086] [078/133] (536s left) gem_eio (wait-immediate) [484.170078] Starting subtest: wait-immediate [484.534045] Subtest wait-immediate: SUCCESS (0.365s) [484.678648] [079/133] (535s left) gem_linear_blits (basic) [484.895916] Starting subtest: basic [484.903961] Subtest basic: SUCCESS (0.008s) [485.052397] [080/133] (535s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-render) [485.189582] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-render [485.193800] Subtest fbc-2p-primscrn-pri-indfb-draw-render: SKIP (0.000s) [485.293368] [081/133] (535s left) i915_pm_rps (thresholds-idle) [485.353662] Starting subtest: thresholds-idle [485.358527] Subtest thresholds-idle: SKIP (0.001s) [485.433397] [082/133] (535s left) kms_big_fb (yf-tiled-64bpp-rotate-90) [485.547610] Starting subtest: yf-tiled-64bpp-rotate-90 [485.552075] Subtest yf-tiled-64bpp-rotate-90: SKIP (0.000s) [485.641547] [083/133] (535s left) kms_chamelium_color (degamma) [485.748086] Subtest degamma: SKIP (0.000s) [485.788266] [084/133] (534s left) syncobj_timeline (single-wait-all-for-submit-available-signaled) [485.846515] Starting subtest: single-wait-all-for-submit-available-signaled [485.848846] Subtest single-wait-all-for-submit-available-signaled: SUCCESS (0.000s) [485.961773] [085/133] (534s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-mmap-gtt) [486.069079] Starting subtest: fbcpsr-rgb565-draw-mmap-gtt [486.072374] Subtest fbcpsr-rgb565-draw-mmap-gtt: SKIP (0.000s) [486.174246] [086/133] (534s left) gem_lmem_swapping (verify-ccs) [486.215855] Subtest verify-ccs: SKIP (0.000s) [486.256198] [087/133] (534s left) kms_vblank (invalid) [486.345566] Starting subtest: invalid [486.347799] Starting dynamic subtest: pipe-A-eDP-1 [486.767297] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.420s) [486.769767] Subtest invalid: SUCCESS (0.421s) [487.603349] [088/133] (533s left) kms_selftest (drm_cmdline_parser) [487.642897] Starting subtest: drm_cmdline_parser [487.653451] Starting dynamic subtest: drm_test_cmdline_force_d_only [487.814304] Dynamic subtest drm_test_cmdline_force_d_only: SUCCESS (0.159s) [487.822449] Starting dynamic subtest: drm_test_cmdline_force_D_only_dvi [487.944728] Dynamic subtest drm_test_cmdline_force_D_only_dvi: SUCCESS (0.130s) [487.952531] Starting dynamic subtest: drm_test_cmdline_force_D_only_hdmi [488.051449] Dynamic subtest drm_test_cmdline_force_D_only_hdmi: SUCCESS (0.106s) [488.060622] Starting dynamic subtest: drm_test_cmdline_force_D_only_not_digital [488.140453] Dynamic subtest drm_test_cmdline_force_D_only_not_digital: SUCCESS (0.087s) [488.149376] Starting dynamic subtest: drm_test_cmdline_force_e_only [488.267150] Dynamic subtest drm_test_cmdline_force_e_only: SUCCESS (0.125s) [488.274696] Starting dynamic subtest: drm_test_cmdline_res [488.407409] Dynamic subtest drm_test_cmdline_res: SUCCESS (0.139s) [488.416438] Starting dynamic subtest: drm_test_cmdline_res_vesa [488.513314] Dynamic subtest drm_test_cmdline_res_vesa: SUCCESS (0.107s) [488.522427] Starting dynamic subtest: drm_test_cmdline_res_vesa_rblank [488.638048] Dynamic subtest drm_test_cmdline_res_vesa_rblank: SUCCESS (0.121s) [488.647432] Starting dynamic subtest: drm_test_cmdline_res_rblank [488.724228] Dynamic subtest drm_test_cmdline_res_rblank: SUCCESS (0.086s) [488.732121] Starting dynamic subtest: drm_test_cmdline_res_bpp [488.848855] Dynamic subtest drm_test_cmdline_res_bpp: SUCCESS (0.123s) [488.856470] Starting dynamic subtest: drm_test_cmdline_res_refresh [488.970047] Dynamic subtest drm_test_cmdline_res_refresh: SUCCESS (0.120s) [488.977707] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh [489.090169] Dynamic subtest drm_test_cmdline_res_bpp_refresh: SUCCESS (0.119s) [489.097784] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_interlaced [489.220101] Dynamic subtest drm_test_cmdline_res_bpp_refresh_interlaced: SUCCESS (0.129s) [489.230077] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_margins [489.349216] Dynamic subtest drm_test_cmdline_res_bpp_refresh_margins: SUCCESS (0.129s) [489.359988] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_force_off [489.495452] Dynamic subtest drm_test_cmdline_res_bpp_refresh_force_off: SUCCESS (0.145s) [489.505343] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_force_on [489.624236] Dynamic subtest drm_test_cmdline_res_bpp_refresh_force_on: SUCCESS (0.128s) [489.634669] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_force_on_analog [489.725112] Dynamic subtest drm_test_cmdline_res_bpp_refresh_force_on_analog: SUCCESS (0.101s) [489.734191] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_force_on_digital [489.799184] Dynamic subtest drm_test_cmdline_res_bpp_refresh_force_on_digital: SUCCESS (0.073s) [489.808549] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_interlaced_margins_force_on [489.909125] Dynamic subtest drm_test_cmdline_res_bpp_refresh_interlaced_margins_force_on: SUCCESS (0.109s) [489.918608] Starting dynamic subtest: drm_test_cmdline_res_margins_force_on [490.027066] Dynamic subtest drm_test_cmdline_res_margins_force_on: SUCCESS (0.116s) [490.036844] Starting dynamic subtest: drm_test_cmdline_res_vesa_margins [490.115664] Dynamic subtest drm_test_cmdline_res_vesa_margins: SUCCESS (0.088s) [490.125281] Starting dynamic subtest: drm_test_cmdline_name [490.239367] Dynamic subtest drm_test_cmdline_name: SUCCESS (0.122s) [490.248986] Starting dynamic subtest: drm_test_cmdline_name_bpp [490.364119] Dynamic subtest drm_test_cmdline_name_bpp: SUCCESS (0.124s) [490.374138] Starting dynamic subtest: drm_test_cmdline_name_option [490.506113] Dynamic subtest drm_test_cmdline_name_option: SUCCESS (0.140s) [490.515240] Starting dynamic subtest: drm_test_cmdline_name_bpp_option [490.626278] Dynamic subtest drm_test_cmdline_name_bpp_option: SUCCESS (0.119s) [490.636293] Starting dynamic subtest: drm_test_cmdline_rotate_0 [490.742089] Dynamic subtest drm_test_cmdline_rotate_0: SUCCESS (0.114s) [490.750046] Starting dynamic subtest: drm_test_cmdline_rotate_90 [490.851801] Dynamic subtest drm_test_cmdline_rotate_90: SUCCESS (0.110s) [490.859732] Starting dynamic subtest: drm_test_cmdline_rotate_180 [490.946771] Dynamic subtest drm_test_cmdline_rotate_180: SUCCESS (0.095s) [490.954848] Starting dynamic subtest: drm_test_cmdline_rotate_270 [491.052368] Dynamic subtest drm_test_cmdline_rotate_270: SUCCESS (0.103s) [491.062081] Starting dynamic subtest: drm_test_cmdline_hmirror [491.170144] Dynamic subtest drm_test_cmdline_hmirror: SUCCESS (0.116s) [491.178967] Starting dynamic subtest: drm_test_cmdline_vmirror [491.288583] Dynamic subtest drm_test_cmdline_vmirror: SUCCESS (0.116s) [491.296440] Starting dynamic subtest: drm_test_cmdline_margin_options [491.395321] Dynamic subtest drm_test_cmdline_margin_options: SUCCESS (0.106s) [491.405088] Starting dynamic subtest: drm_test_cmdline_multiple_options [491.514355] Dynamic subtest drm_test_cmdline_multiple_options: SUCCESS (0.116s) [491.523777] Starting dynamic subtest: drm_test_cmdline_bpp_extra_and_option [491.624539] Dynamic subtest drm_test_cmdline_bpp_extra_and_option: SUCCESS (0.111s) [491.633786] Starting dynamic subtest: drm_test_cmdline_extra_and_option [491.746060] Dynamic subtest drm_test_cmdline_extra_and_option: SUCCESS (0.120s) [491.754052] Starting dynamic subtest: drm_test_cmdline_freestanding_options [491.861528] Dynamic subtest drm_test_cmdline_freestanding_options: SUCCESS (0.115s) [491.869527] Starting dynamic subtest: drm_test_cmdline_freestanding_force_e_and_options [492.000252] Dynamic subtest drm_test_cmdline_freestanding_force_e_and_options: SUCCESS (0.138s) [492.008488] Starting dynamic subtest: drm_test_cmdline_panel_orientation [492.141895] Dynamic subtest drm_test_cmdline_panel_orientation: SUCCESS (0.140s) [492.149825] Starting dynamic subtest: drm_test_cmdline_invalid [492.300270] Dynamic subtest drm_test_cmdline_invalid: SUCCESS (0.160s) [492.308435] Starting dynamic subtest: drm_test_cmdline_tv_options [492.455304] Dynamic subtest drm_test_cmdline_tv_options: SUCCESS (0.153s) [492.457742] Subtest drm_cmdline_parser: SUCCESS (4.814s) [492.648123] [089/133] (528s left) gem_exec_reloc (basic-cpu-wc-noreloc) [492.714390] Subtest basic-cpu-wc-noreloc: SKIP (0.000s) [492.765892] [090/133] (528s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-fullscreen) [492.862104] Starting subtest: psr-1p-primscrn-spr-indfb-fullscreen [497.366367] Subtest psr-1p-primscrn-spr-indfb-fullscreen: SUCCESS (4.507s) [497.518637] [091/133] (523s left) gem_eio (create) [497.746623] Starting subtest: create [498.066262] Subtest create: SUCCESS (0.319s) [498.180459] [092/133] (522s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-cpu) [498.286563] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-cpu [498.290647] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s) [498.384545] [093/133] (522s left) kms_cursor_edge_walk (256x256-left-edge) [498.478377] Starting subtest: 256x256-left-edge [498.480464] Starting dynamic subtest: pipe-A-eDP-1 [501.910612] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.427s) [501.919217] Starting dynamic subtest: pipe-D-eDP-1 [505.029094] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.117s) [505.031451] Subtest 256x256-left-edge: SUCCESS (6.549s) [505.829921] [094/133] (515s left) kms_cursor_legacy (flip-vs-cursor-legacy) [505.960592] Starting subtest: flip-vs-cursor-legacy [512.744288] Subtest flip-vs-cursor-legacy: SUCCESS (6.785s) [513.556335] [095/133] (507s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-blt) [513.659290] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-blt [513.663633] Subtest fbc-2p-primscrn-spr-indfb-draw-blt: SKIP (0.000s) [513.760592] [096/133] (507s left) kms_frontbuffer_tracking (psr-rgb565-draw-blt) [513.870797] Starting subtest: psr-rgb565-draw-blt [518.716736] Subtest psr-rgb565-draw-blt: SUCCESS (4.848s) [518.848396] [097/133] (502s left) gem_mmap (pf-nonblock) [518.899794] Subtest pf-nonblock: SKIP (0.000s) [518.954574] [098/133] (502s left) gem_tiled_partial_pwrite_pread (reads) [519.022065] Subtest reads: SKIP (0.000s) [519.090602] [099/133] (502s left) kms_async_flips (test-cursor-atomic) [519.194741] Starting subtest: test-cursor-atomic [519.198735] Subtest test-cursor-atomic: SKIP (0.000s) [520.419632] [100/133] (500s left) gem_exec_reloc (basic-wc-cpu-active) [520.488384] Subtest basic-wc-cpu-active: SKIP (0.000s) [520.567839] [101/133] (500s left) syncobj_timeline (multi-wait-available-submitted) [520.617711] Starting subtest: multi-wait-available-submitted [520.620037] Subtest multi-wait-available-submitted: SUCCESS (0.000s) [520.712763] [102/133] (500s left) kms_cursor_crc (cursor-random-128x128) [520.895905] Starting subtest: cursor-random-128x128 [520.900792] Starting dynamic subtest: pipe-A-eDP-1 [524.517604] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.617s) [524.543406] Starting dynamic subtest: pipe-D-eDP-1 [528.800645] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.264s) [528.803100] Subtest cursor-random-128x128: SUCCESS (7.902s) [529.686764] [103/133] (491s left) gem_exec_schedule (implicit-write-read) [529.767870] Starting subtest: implicit-write-read [529.770184] Starting dynamic subtest: rcs0 [529.868316] Dynamic subtest rcs0: SUCCESS (0.111s) [529.879153] Starting dynamic subtest: vcs0 [529.941981] Dynamic subtest vcs0: SUCCESS (0.074s) [529.953421] Starting dynamic subtest: vcs1 [530.014773] Dynamic subtest vcs1: SUCCESS (0.072s) [530.026520] Starting dynamic subtest: vecs0 [530.106211] Dynamic subtest vecs0: SUCCESS (0.091s) [530.116825] Starting dynamic subtest: ccs0 [530.199968] Dynamic subtest ccs0: SUCCESS (0.092s) [530.202767] Subtest implicit-write-read: SUCCESS (0.444s) [531.009406] [104/133] (490s left) gem_bad_reloc (negative-reloc-lut) [531.075887] Subtest negative-reloc-lut: SKIP (0.000s) [531.145760] [105/133] (490s left) kms_big_fb (x-tiled-addfb-size-offset-overflow) [531.256159] Starting subtest: x-tiled-addfb-size-offset-overflow [531.258435] Subtest x-tiled-addfb-size-offset-overflow: SUCCESS (0.000s) [531.337803] [106/133] (490s left) kms_hdmi_inject (inject-4k) [531.691530] Starting subtest: inject-4k [531.995322] Subtest inject-4k: SUCCESS (0.305s) [532.533849] [107/133] (489s left) kms_pm_backlight (fade) [532.634405] Starting subtest: fade [532.701799] Starting dynamic subtest: eDP-1 [535.371549] Dynamic subtest eDP-1: SUCCESS (2.669s) [535.373461] Subtest fade: SUCCESS (2.735s) [536.205689] [108/133] (485s left) prime_vgem (sync) [536.295967] Starting subtest: sync [536.298284] Starting dynamic subtest: rcs0 [536.350881] Dynamic subtest rcs0: SUCCESS (0.054s) [536.359338] Starting dynamic subtest: bcs0 [536.410767] Dynamic subtest bcs0: SUCCESS (0.059s) [536.419222] Starting dynamic subtest: vcs0 [536.458281] Dynamic subtest vcs0: SUCCESS (0.047s) [536.466646] Starting dynamic subtest: vcs1 [536.503983] Dynamic subtest vcs1: SUCCESS (0.045s) [536.512849] Starting dynamic subtest: vecs0 [536.551593] Dynamic subtest vecs0: SUCCESS (0.047s) [536.559848] Starting dynamic subtest: ccs0 [536.595812] Dynamic subtest ccs0: SUCCESS (0.043s) [536.597953] Subtest sync: SUCCESS (0.300s) [536.716714] [109/133] (484s left) kms_pm_rpm (fences) [538.250122] Starting subtest: fences [538.255123] Subtest fences: SKIP (0.000s) [539.011764] [110/133] (482s left) sw_sync (sync_busy_fork_unixsocket) [539.053107] Starting subtest: sync_busy_fork_unixsocket [539.059777] Subtest sync_busy_fork_unixsocket: SUCCESS (0.009s) [539.119197] [111/133] (482s left) kms_ccs (crc-primary-suspend-4-tiled-mtl-rc-ccs) [539.226142] Starting subtest: crc-primary-suspend-4-tiled-mtl-rc-ccs [539.228450] Starting dynamic subtest: pipe-A-eDP-1 [554.852688] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.453s) [554.864391] Starting dynamic subtest: pipe-B-eDP-1 [571.742026] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.305s) [571.752961] Starting dynamic subtest: pipe-C-eDP-1 [588.712308] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.192s) [588.723181] Starting dynamic subtest: pipe-D-eDP-1 [605.703520] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.227s) [605.705781] Subtest crc-primary-suspend-4-tiled-mtl-rc-ccs: SUCCESS (8.182s) [606.879476] [112/133] (473s left) device_reset (cold-reset-bound) [606.934204] Starting subtest: cold-reset-bound [606.939467] Subtest cold-reset-bound: SKIP (0.000s) [607.006855] [113/133] (473s left) kms_atomic_transition (plane-all-transition-nonblocking-fencing) [607.118860] Starting subtest: plane-all-transition-nonblocking-fencing [607.121490] Starting dynamic subtest: pipe-A-eDP-1 [609.707454] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.503s) [610.004633] Starting dynamic subtest: pipe-B-eDP-1 [613.262327] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.195s) [613.548113] Subtest plane-all-transition-nonblocking-fencing: SUCCESS (6.256s) [614.373242] [114/133] (466s left) gem_partial_pwrite_pread (write-uncached) [614.436464] Subtest write-uncached: SKIP (0.000s) [614.511860] [115/133] (465s left) kms_cursor_crc (cursor-sliding-512x170) [614.784776] Starting subtest: cursor-sliding-512x170 [614.788981] Subtest cursor-sliding-512x170: SKIP (0.001s) [614.934500] [116/133] (465s left) kms_invalid_mode (int-max-clock) [615.032091] Starting subtest: int-max-clock [615.035098] Starting dynamic subtest: pipe-A-eDP-1 [615.317858] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.280s) [615.328577] Starting dynamic subtest: pipe-B-eDP-1 [615.331128] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s) [615.341022] Starting dynamic subtest: pipe-C-eDP-1 [615.344091] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s) [615.354162] Starting dynamic subtest: pipe-D-eDP-1 [615.356898] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s) [615.359795] Subtest int-max-clock: SUCCESS (0.285s) [616.200639] [117/133] (464s left) kms_pipe_crc_basic (disable-crc-after-crtc) [616.303470] Starting subtest: disable-crc-after-crtc [616.305895] Starting dynamic subtest: pipe-A-eDP-1 [618.015916] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.691s) [618.027269] Starting dynamic subtest: pipe-B-eDP-1 [620.348030] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.310s) [620.358355] Starting dynamic subtest: pipe-C-eDP-1 [622.537163] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.173s) [622.548034] Starting dynamic subtest: pipe-D-eDP-1 [624.771268] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.223s) [624.773791] Subtest disable-crc-after-crtc: SUCCESS (8.402s) [625.571472] [118/133] (455s left) gem_mmap_wc (close) [625.642908] Subtest close: SKIP (0.000s) [625.709832] [119/133] (454s left) vgem_basic (bad-fence) [625.771942] Starting subtest: bad-fence [625.774782] Subtest bad-fence: SUCCESS (0.000s) [625.818603] [120/133] (454s left) syncobj_timeline (transfer-timeline-point) [625.893258] Starting subtest: transfer-timeline-point [625.896779] Subtest transfer-timeline-point: SUCCESS (0.001s) [625.995507] [121/133] (454s left) gem_render_copy (y-tiled-ccs-to-yf-tiled-ccs) [626.066705] Starting subtest: y-tiled-ccs-to-yf-tiled-ccs [626.073181] Subtest y-tiled-ccs-to-yf-tiled-ccs: SKIP (0.000s) [626.249522] [122/133] (454s left) kms_cursor_legacy (flip-vs-cursor-busy-crc-legacy) [626.383079] Starting subtest: flip-vs-cursor-busy-crc-legacy [627.147791] Subtest flip-vs-cursor-busy-crc-legacy: SUCCESS (0.765s) [627.977407] [123/133] (452s left) gem_wait (busy) [628.047737] Starting subtest: busy [628.050745] Starting dynamic subtest: all-engines [629.965275] Dynamic subtest all-engines: SUCCESS (1.911s) [629.978884] Starting dynamic subtest: rcs0 [630.508465] Dynamic subtest rcs0: SUCCESS (0.541s) [630.521147] Starting dynamic subtest: bcs0 [631.048886] Dynamic subtest bcs0: SUCCESS (0.538s) [631.060088] Starting dynamic subtest: vcs0 [632.971084] Dynamic subtest vcs0: SUCCESS (1.917s) [632.984867] Starting dynamic subtest: vcs1 [634.955666] Dynamic subtest vcs1: SUCCESS (1.979s) [634.967108] Starting dynamic subtest: vecs0 [636.939731] Dynamic subtest vecs0: SUCCESS (1.981s) [636.952560] Starting dynamic subtest: ccs0 [637.481522] Dynamic subtest ccs0: SUCCESS (0.541s) [637.484702] Subtest busy: SUCCESS (9.418s) [637.691545] [124/133] (443s left) kms_big_fb (linear-16bpp-rotate-270) [637.794622] Starting subtest: linear-16bpp-rotate-270 [637.835931] Subtest linear-16bpp-rotate-270: SKIP (0.036s) [637.952025] [125/133] (442s left) gem_exec_reloc (basic-write-read-noreloc) [638.025847] Subtest basic-write-read-noreloc: SKIP (0.000s) [638.093729] [126/133] (442s left) gem_exec_balancer (hang) [638.341227] Starting subtest: hang [639.970951] Subtest hang: SUCCESS (1.630s) [640.096841] [127/133] (440s left) gem_ctx_bad_destroy (invalid-ctx) [640.160260] Starting subtest: invalid-ctx [640.163034] Subtest invalid-ctx: SUCCESS (0.000s) [640.238776] [128/133] (440s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-mmap-wc) [640.344652] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-mmap-wc [640.349739] Subtest psr-2p-scndscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s) [640.461413] [129/133] (440s left) kms_big_fb (4-tiled-64bpp-rotate-270) [640.559806] Starting subtest: 4-tiled-64bpp-rotate-270 [640.600088] Subtest 4-tiled-64bpp-rotate-270: SKIP (0.039s) [640.713394] [130/133] (440s left) kms_ccs (bad-pixel-format-4-tiled-mtl-rc-ccs-cc) [640.817537] Starting subtest: bad-pixel-format-4-tiled-mtl-rc-ccs-cc [640.819951] Starting dynamic subtest: pipe-A-eDP-1 [640.842218] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s) [640.853036] Starting dynamic subtest: pipe-B-eDP-1 [640.876017] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s) [640.885696] Starting dynamic subtest: pipe-C-eDP-1 [640.908958] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s) [640.918985] Starting dynamic subtest: pipe-D-eDP-1 [640.942370] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s) [640.944953] Subtest bad-pixel-format-4-tiled-mtl-rc-ccs-cc: SUCCESS (0.005s) [643.087410] [131/133] (438s left) gem_render_copy_redux (flink-interruptible) [643.144271] Starting subtest: flink-interruptible [644.032556] Subtest flink-interruptible: SUCCESS (0.888s) [644.171263] [132/133] (437s left) device_reset (unbind-reset-rebind) [644.225825] Starting subtest: unbind-reset-rebind [647.299382] Subtest unbind-reset-rebind: SUCCESS (3.072s) [647.339577] [133/133] (433s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-blt) [647.451959] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-blt [652.711070] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-blt: SUCCESS (5.263s) [652.839164] Closing watchdogs results: parsing output: 0/ for test: kms_flip_scaled_crc results: parsing output: 1/ for test: gem_exec_schedule results: parsing output: 2/ for test: kms_flip results: parsing output: 3/ for test: gem_ctx_engines results: parsing output: 4/ for test: kms_dither results: parsing output: 5/ for test: i915_pm_rc6_residency results: parsing output: 6/ for test: kms_psr2_sf results: parsing output: 7/ for test: kms_plane_scaling results: parsing output: 8/ for test: kms_big_fb results: parsing output: 9/ for test: kms_chamelium_hpd results: parsing output: 10/ for test: kms_feature_discovery results: parsing output: 11/ for test: kms_psr results: parsing output: 12/ for test: gem_exec_whisper results: parsing output: 13/ for test: gem_exec_schedule results: parsing output: 14/ for test: gem_exec_gttfill results: parsing output: 15/ for test: kms_big_fb results: parsing output: 16/ for test: kms_getfb results: parsing output: 17/ for test: vkms/vkms_configfs results: parsing output: 18/ for test: syncobj_wait results: parsing output: 19/ for test: dumb_buffer results: parsing output: 20/ for test: kms_psr results: parsing output: 21/ for test: perf_pmu results: parsing output: 22/ for test: kms_psr results: parsing output: 23/ for test: gem_basic results: parsing output: 24/ for test: gem_userptr_blits results: parsing output: 25/ for test: i915_query results: parsing output: 26/ for test: gem_userptr_blits results: parsing output: 27/ for test: kms_frontbuffer_tracking results: parsing output: 28/ for test: kms_psr2_sf results: parsing output: 29/ for test: kms_flip results: parsing output: 30/ for test: kms_frontbuffer_tracking results: parsing output: 31/ for test: kms_frontbuffer_tracking results: parsing output: 32/ for test: gem_userptr_blits results: parsing output: 33/ for test: gem_madvise results: parsing output: 34/ for test: syncobj_wait results: parsing output: 35/ for test: kms_ccs results: parsing output: 36/ for test: gem_softpin results: parsing output: 37/ for test: kms_chamelium_audio results: parsing output: 38/ for test: kms_psr results: parsing output: 39/ for test: gem_render_copy results: parsing output: 40/ for test: kms_frontbuffer_tracking results: parsing output: 41/ for test: gem_pxp results: parsing output: 42/ for test: kms_cursor_legacy results: parsing output: 43/ for test: gem_exec_reloc results: parsing output: 44/ for test: kms_flip_scaled_crc results: parsing output: 45/ for test: kms_plane results: parsing output: 46/ for test: kms_flip results: parsing output: 47/ for test: kms_vrr results: parsing output: 48/ for test: kms_color results: parsing output: 49/ for test: kms_psr results: parsing output: 50/ for test: kms_flip results: parsing output: 51/ for test: gem_exec_fence results: parsing output: 52/ for test: gem_userptr_blits results: parsing output: 53/ for test: kms_legacy_colorkey results: parsing output: 54/ for test: api_intel_allocator results: parsing output: 55/ for test: gem_ctx_persistence results: parsing output: 56/ for test: kms_frontbuffer_tracking results: parsing output: 57/ for test: kms_big_fb results: parsing output: 58/ for test: kms_addfb_basic results: parsing output: 59/ for test: perf_pmu results: parsing output: 60/ for test: kms_psr2_sf results: parsing output: 61/ for test: gem_mmap_gtt results: parsing output: 62/ for test: kms_frontbuffer_tracking results: parsing output: 63/ for test: kms_addfb_basic results: parsing output: 64/ for test: gen9_exec_parse results: parsing output: 65/ for test: kms_content_protection results: parsing output: 66/ for test: syncobj_timeline results: parsing output: 67/ for test: syncobj_timeline results: parsing output: 68/ for test: kms_rotation_crc results: parsing output: 69/ for test: vkms/vkms_configfs results: parsing output: 70/ for test: kms_ccs results: parsing output: 71/ for test: gem_ctx_persistence results: parsing output: 72/ for test: gem_mmap_gtt results: parsing output: 73/ for test: kms_flip results: parsing output: 74/ for test: kms_frontbuffer_tracking results: parsing output: 75/ for test: kms_frontbuffer_tracking results: parsing output: 76/ for test: i915_query results: parsing output: 77/ for test: gem_eio results: parsing output: 78/ for test: gem_linear_blits results: parsing output: 79/ for test: kms_frontbuffer_tracking results: parsing output: 80/ for test: i915_pm_rps results: parsing output: 81/ for test: kms_big_fb results: parsing output: 82/ for test: kms_chamelium_color results: parsing output: 83/ for test: syncobj_timeline results: parsing output: 84/ for test: kms_frontbuffer_tracking results: parsing output: 85/ for test: gem_lmem_swapping results: parsing output: 86/ for test: kms_vblank results: parsing output: 87/ for test: kms_selftest results: parsing output: 88/ for test: gem_exec_reloc results: parsing output: 89/ for test: kms_frontbuffer_tracking results: parsing output: 90/ for test: gem_eio results: parsing output: 91/ for test: kms_frontbuffer_tracking results: parsing output: 92/ for test: kms_cursor_edge_walk results: parsing output: 93/ for test: kms_cursor_legacy results: parsing output: 94/ for test: kms_frontbuffer_tracking results: parsing output: 95/ for test: kms_frontbuffer_tracking results: parsing output: 96/ for test: gem_mmap results: parsing output: 97/ for test: gem_tiled_partial_pwrite_pread results: parsing output: 98/ for test: kms_async_flips results: parsing output: 99/ for test: gem_exec_reloc results: parsing output: 100/ for test: syncobj_timeline results: parsing output: 101/ for test: kms_cursor_crc results: parsing output: 102/ for test: gem_exec_schedule results: parsing output: 103/ for test: gem_bad_reloc results: parsing output: 104/ for test: kms_big_fb results: parsing output: 105/ for test: kms_hdmi_inject results: parsing output: 106/ for test: kms_pm_backlight results: parsing output: 107/ for test: prime_vgem results: parsing output: 108/ for test: kms_pm_rpm results: parsing output: 109/ for test: sw_sync results: parsing output: 110/ for test: kms_ccs results: parsing output: 111/ for test: device_reset results: parsing output: 112/ for test: kms_atomic_transition results: parsing output: 113/ for test: gem_partial_pwrite_pread results: parsing output: 114/ for test: kms_cursor_crc results: parsing output: 115/ for test: kms_invalid_mode results: parsing output: 116/ for test: kms_pipe_crc_basic results: parsing output: 117/ for test: gem_mmap_wc results: parsing output: 118/ for test: vgem_basic results: parsing output: 119/ for test: syncobj_timeline results: parsing output: 120/ for test: gem_render_copy results: parsing output: 121/ for test: kms_cursor_legacy results: parsing output: 122/ for test: gem_wait results: parsing output: 123/ for test: kms_big_fb results: parsing output: 124/ for test: gem_exec_reloc results: parsing output: 125/ for test: gem_exec_balancer results: parsing output: 126/ for test: gem_ctx_bad_destroy results: parsing output: 127/ for test: kms_frontbuffer_tracking results: parsing output: 128/ for test: kms_big_fb results: parsing output: 129/ for test: kms_ccs results: parsing output: 130/ for test: gem_render_copy_redux results: parsing output: 131/ for test: device_reset results: parsing output: 132/ for test: kms_frontbuffer_tracking Done.