[58.777105] Initializing watchdogs [58.777151] /dev/watchdog0 [58.792742] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:7dd5 Intel Meteorlake (Gen12) Meteor Lake-P [Intel Graphics] [58.796815] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [58.798953] [FACT before any test] new: kernel.kmod_is_loaded.i915: true [58.802640] [001/155] (960s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-render) [58.927091] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-render [58.931375] Subtest fbc-2p-scndscrn-cur-indfb-draw-render: SKIP (0.000s) [59.026977] [002/155] (960s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-pwrite) [59.115178] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-pwrite [59.119492] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-pwrite: SKIP (0.000s) [59.224168] [003/155] (960s left) syncobj_timeline (etime-multi-wait-all-for-submit-available-unsubmitted) [59.274296] Starting subtest: etime-multi-wait-all-for-submit-available-unsubmitted [59.380012] Subtest etime-multi-wait-all-for-submit-available-unsubmitted: SUCCESS (0.103s) [59.450874] [004/155] (959s left) kms_frontbuffer_tracking (psr-2p-scndscrn-indfb-plflip-blt) [59.529730] Starting subtest: psr-2p-scndscrn-indfb-plflip-blt [59.534823] Subtest psr-2p-scndscrn-indfb-plflip-blt: SKIP (0.000s) [59.635502] [005/155] (959s left) gem_exec_schedule (reorder-wide) [59.822430] Subtest reorder-wide: SKIP (0.000s) [60.011846] [006/155] (959s left) kms_cursor_crc (cursor-onscreen-64x21) [60.188330] Starting subtest: cursor-onscreen-64x21 [60.238905] Subtest cursor-onscreen-64x21: SKIP (0.047s) [60.447526] [007/155] (959s left) kms_ccs (bad-rotation-90-4-tiled-mtl-rc-ccs-cc) [60.514346] Starting subtest: bad-rotation-90-4-tiled-mtl-rc-ccs-cc [60.516376] Starting dynamic subtest: pipe-A-eDP-1 [60.663620] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.141s) [60.674149] Starting dynamic subtest: pipe-B-eDP-1 [60.693200] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.011s) [60.700849] Starting dynamic subtest: pipe-C-eDP-1 [60.721367] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.011s) [60.730222] Starting dynamic subtest: pipe-D-eDP-1 [60.749177] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.010s) [60.751067] Subtest bad-rotation-90-4-tiled-mtl-rc-ccs-cc: SUCCESS (0.175s) [63.016572] [008/155] (956s left) gem_ccs (large-ctrl-surf-copy) [63.078801] Starting subtest: large-ctrl-surf-copy [63.082987] Subtest large-ctrl-surf-copy: SKIP (0.000s) [63.181343] [009/155] (956s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-indfb-draw-pwrite) [63.264382] Starting subtest: fbc-1p-offscreen-pri-indfb-draw-pwrite [68.109579] Subtest fbc-1p-offscreen-pri-indfb-draw-pwrite: SUCCESS (4.852s) [69.253976] [010/155] (950s left) gem_exec_params (sol-reset-invalid) [69.312990] Starting subtest: sol-reset-invalid [69.315553] Subtest sol-reset-invalid: SUCCESS (0.002s) [71.275407] [011/155] (948s left) kms_rotation_crc (primary-rotation-90) [71.342754] Starting subtest: primary-rotation-90 [71.347327] Subtest primary-rotation-90: SKIP (0.001s) [71.416389] [012/155] (948s left) kms_psr (pr-primary-page-flip) [71.503564] Starting subtest: pr-primary-page-flip [71.507583] Subtest pr-primary-page-flip: SKIP (0.000s) [71.585679] [013/155] (948s left) kms_plane_scaling (plane-scaler-with-clipping-clamping-rotation) [71.647852] Starting subtest: plane-scaler-with-clipping-clamping-rotation [71.650220] Starting dynamic subtest: pipe-A [71.875391] Dynamic subtest pipe-A: SUCCESS (0.229s) [71.885260] Starting dynamic subtest: pipe-B [73.220771] Dynamic subtest pipe-B: SUCCESS (1.344s) [73.229827] Starting dynamic subtest: pipe-C [74.554959] Dynamic subtest pipe-C: SUCCESS (1.334s) [74.566550] Starting dynamic subtest: pipe-D [75.886641] Dynamic subtest pipe-D: SUCCESS (1.330s) [75.889102] Subtest plane-scaler-with-clipping-clamping-rotation: SUCCESS (4.240s) [77.073036] [014/155] (942s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-indfb-pgflip-blt) [77.153635] Starting subtest: fbc-2p-scndscrn-indfb-pgflip-blt [77.157908] Subtest fbc-2p-scndscrn-indfb-pgflip-blt: SKIP (0.000s) [77.266094] [015/155] (942s left) i915_selftest (live) [81.751602] Starting subtest: live [81.754226] Starting dynamic subtest: sanitycheck [86.055829] Dynamic subtest sanitycheck: SUCCESS (4.305s) [86.065057] Starting dynamic subtest: uncore [90.368210] Dynamic subtest uncore: SUCCESS (4.312s) [90.377027] Starting dynamic subtest: workarounds [93.404116] Dynamic subtest workarounds: SUCCESS (3.036s) [93.413793] Starting dynamic subtest: gt_engines [97.919757] Dynamic subtest gt_engines: SUCCESS (4.514s) [97.929463] Starting dynamic subtest: gt_timelines [115.396612] Dynamic subtest gt_timelines: SUCCESS (17.464s) [115.405169] Starting dynamic subtest: gt_contexts [119.763128] Dynamic subtest gt_contexts: SUCCESS (4.378s) [119.772106] Starting dynamic subtest: gt_lrc [124.082218] Dynamic subtest gt_lrc: SUCCESS (4.318s) [124.091726] Starting dynamic subtest: gt_mocs [127.125771] Dynamic subtest gt_mocs: SUCCESS (3.042s) [127.135389] Starting dynamic subtest: gt_pm [133.844844] Dynamic subtest gt_pm: SUCCESS (6.717s) [133.854609] Starting dynamic subtest: gt_heartbeat [138.205468] Dynamic subtest gt_heartbeat: SUCCESS (4.360s) [138.214723] Starting dynamic subtest: gt_tlb [147.643957] Dynamic subtest gt_tlb: SUCCESS (9.436s) [147.653438] Starting dynamic subtest: requests [161.096738] Dynamic subtest requests: SUCCESS (13.450s) [161.104804] Starting dynamic subtest: migrate [166.781204] Dynamic subtest migrate: SUCCESS (5.683s) [166.790975] Starting dynamic subtest: active [171.220664] Dynamic subtest active: SUCCESS (4.438s) [171.228678] Starting dynamic subtest: objects [175.872432] Dynamic subtest objects: SUCCESS (4.650s) [175.882338] Starting dynamic subtest: mman [179.273999] Dynamic subtest mman: SUCCESS (3.400s) [179.283203] Starting dynamic subtest: dmabuf [183.624241] Dynamic subtest dmabuf: SUCCESS (4.349s) [183.631699] Starting dynamic subtest: vma [186.333998] Dynamic subtest vma: SUCCESS (2.707s) [186.343864] Starting dynamic subtest: coherency [191.486875] Dynamic subtest coherency: SUCCESS (5.152s) [191.496183] Starting dynamic subtest: gtt [200.878205] Dynamic subtest gtt: SUCCESS (9.390s) [200.887490] Starting dynamic subtest: gem [206.955204] Dynamic subtest gem: SUCCESS (6.076s) [206.965832] Starting dynamic subtest: evict [212.384740] Dynamic subtest evict: SUCCESS (5.428s) [212.394372] Starting dynamic subtest: hugepages [221.263809] Dynamic subtest hugepages: SUCCESS (8.878s) [221.273684] Starting dynamic subtest: gem_contexts [247.248430] Dynamic subtest gem_contexts: SUCCESS (25.983s) [247.259712] Starting dynamic subtest: client [251.616381] Dynamic subtest client: SUCCESS (4.367s) [251.630974] Starting dynamic subtest: gem_migrate [254.347405] Dynamic subtest gem_migrate: SUCCESS (2.729s) [254.357440] Starting dynamic subtest: reset [257.162981] Dynamic subtest reset: SUCCESS (2.814s) [257.172196] Starting dynamic subtest: memory_region [259.821963] Dynamic subtest memory_region: SUCCESS (2.657s) [259.831982] Starting dynamic subtest: hangcheck [274.477372] Dynamic subtest hangcheck: SUCCESS (14.653s) [274.487687] Starting dynamic subtest: execlists [278.889774] Dynamic subtest execlists: SUCCESS (4.410s) [278.899616] Starting dynamic subtest: ring_submission [283.192901] Dynamic subtest ring_submission: SUCCESS (4.301s) [283.202953] Starting dynamic subtest: perf [287.540025] Dynamic subtest perf: SUCCESS (4.345s) [287.549721] Starting dynamic subtest: slpc [301.316027] Dynamic subtest slpc: SUCCESS (13.774s) [301.327322] Starting dynamic subtest: guc [305.144722] Dynamic subtest guc: SUCCESS (3.825s) [305.154621] Starting dynamic subtest: guc_multi_lrc [309.494323] Dynamic subtest guc_multi_lrc: SUCCESS (4.348s) [309.502712] Starting dynamic subtest: guc_hang [314.383938] Dynamic subtest guc_hang: SUCCESS (4.888s) [314.392231] Starting dynamic subtest: late_gt_pm [318.725200] Dynamic subtest late_gt_pm: SUCCESS (4.339s) [318.727491] Subtest live: SUCCESS (236.963s) [318.755602] [FACT i915_selftest (live)] deleted: kernel.kmod_is_loaded.i915: true [318.758777] [016/155] (701s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-blt) [320.262679] Starting subtest: psr-2p-primscrn-spr-indfb-draw-blt [320.267274] Subtest psr-2p-primscrn-spr-indfb-draw-blt: SKIP (0.000s) [320.346257] [FACT kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-blt)] new: kernel.kmod_is_loaded.i915: true [320.350219] [017/155] (699s left) gem_mmap_wc (read) [320.408435] Subtest read: SKIP (0.000s) [320.465385] [018/155] (699s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-pwrite) [320.546665] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-pwrite [320.550809] Subtest fbc-2p-scndscrn-cur-indfb-draw-pwrite: SKIP (0.000s) [320.655213] [019/155] (699s left) kms_psr (psr-primary-page-flip) [320.729689] Starting subtest: psr-primary-page-flip [320.732610] Starting dynamic subtest: eDP-1 [322.527517] Dynamic subtest eDP-1: SUCCESS (1.799s) [322.530071] Subtest psr-primary-page-flip: SUCCESS (1.800s) [323.390843] [020/155] (696s left) i915_pm_rps (min-max-config-loaded) [323.449565] Starting subtest: min-max-config-loaded [323.454076] Subtest min-max-config-loaded: SKIP (0.001s) [323.556755] [021/155] (696s left) kms_ccs (crc-sprite-planes-basic-4-tiled-dg2-rc-ccs) [323.635809] Starting subtest: crc-sprite-planes-basic-4-tiled-dg2-rc-ccs [323.638075] Starting dynamic subtest: pipe-A-eDP-1 [323.696261] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s) [323.706889] Starting dynamic subtest: pipe-B-eDP-1 [323.765132] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s) [323.775162] Starting dynamic subtest: pipe-C-eDP-1 [323.832398] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s) [323.841353] Starting dynamic subtest: pipe-D-eDP-1 [323.899679] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s) [323.904226] Subtest crc-sprite-planes-basic-4-tiled-dg2-rc-ccs: SKIP (0.008s) [325.942638] [022/155] (694s left) api_intel_allocator (open-vm) [325.992094] Starting subtest: open-vm [325.994475] Subtest open-vm: SUCCESS (0.003s) [326.122501] [023/155] (694s left) gem_wait (write-wait) [326.183128] Starting subtest: write-wait [326.185068] Starting dynamic subtest: all-engines [327.307715] Dynamic subtest all-engines: SUCCESS (1.126s) [327.326331] Starting dynamic subtest: rcs0 [328.363882] Dynamic subtest rcs0: SUCCESS (1.054s) [328.382067] Starting dynamic subtest: bcs0 [329.424994] Dynamic subtest bcs0: SUCCESS (1.059s) [329.442102] Starting dynamic subtest: vcs0 [330.479572] Dynamic subtest vcs0: SUCCESS (1.052s) [330.496350] Starting dynamic subtest: vcs1 [331.534064] Dynamic subtest vcs1: SUCCESS (1.052s) [331.549941] Starting dynamic subtest: vecs0 [332.587183] Dynamic subtest vecs0: SUCCESS (1.051s) [332.603055] Starting dynamic subtest: ccs0 [333.644616] Dynamic subtest ccs0: SUCCESS (1.055s) [333.647527] Subtest write-wait: SUCCESS (7.465s) [333.842842] [FACT gem_wait (write-wait)] new: kernel.kmod_is_loaded.vgem: true [333.846714] [024/155] (686s left) kms_big_fb (x-tiled-8bpp-rotate-90) [333.936159] Starting subtest: x-tiled-8bpp-rotate-90 [333.956079] Subtest x-tiled-8bpp-rotate-90: SKIP (0.019s) [334.070398] [025/155] (686s left) kms_color (deep-color) [334.152307] Starting subtest: deep-color [335.221927] Starting dynamic subtest: pipe-A-eDP-1-gamma [335.936809] Dynamic subtest pipe-A-eDP-1-gamma: SUCCESS (0.716s) [335.954673] Starting dynamic subtest: pipe-A-eDP-1-degamma [337.419665] Dynamic subtest pipe-A-eDP-1-degamma: SUCCESS (1.482s) [337.428840] Starting dynamic subtest: pipe-A-eDP-1-ctm [338.840414] Dynamic subtest pipe-A-eDP-1-ctm: SUCCESS (1.418s) [339.613928] Starting dynamic subtest: pipe-B-eDP-1-gamma [340.311953] Dynamic subtest pipe-B-eDP-1-gamma: SUCCESS (0.703s) [340.321436] Starting dynamic subtest: pipe-B-eDP-1-degamma [341.805520] Dynamic subtest pipe-B-eDP-1-degamma: SUCCESS (1.494s) [341.814378] Starting dynamic subtest: pipe-B-eDP-1-ctm [343.224462] Dynamic subtest pipe-B-eDP-1-ctm: SUCCESS (1.417s) [343.995472] Starting dynamic subtest: pipe-C-eDP-1-gamma [344.690495] Dynamic subtest pipe-C-eDP-1-gamma: SUCCESS (0.702s) [344.698658] Starting dynamic subtest: pipe-C-eDP-1-degamma [346.149206] Dynamic subtest pipe-C-eDP-1-degamma: SUCCESS (1.458s) [346.159758] Starting dynamic subtest: pipe-C-eDP-1-ctm [347.554735] Dynamic subtest pipe-C-eDP-1-ctm: SUCCESS (1.406s) [348.368308] Starting dynamic subtest: pipe-D-eDP-1-gamma [349.058752] Dynamic subtest pipe-D-eDP-1-gamma: SUCCESS (0.698s) [349.068985] Starting dynamic subtest: pipe-D-eDP-1-degamma [350.526607] Dynamic subtest pipe-D-eDP-1-degamma: SUCCESS (1.467s) [350.535705] Starting dynamic subtest: pipe-D-eDP-1-ctm [351.959297] Dynamic subtest pipe-D-eDP-1-ctm: SUCCESS (1.429s) [351.961674] Subtest deep-color: SUCCESS (17.807s) [352.803475] [026/155] (667s left) prime_vgem (coherency-gtt) [352.878048] Starting subtest: coherency-gtt [352.882798] Subtest coherency-gtt: SKIP (0.000s) [352.972688] [027/155] (667s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-pwrite) [353.056502] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-pwrite [360.249651] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-pwrite: SUCCESS (7.196s) [360.378463] [028/155] (659s left) kms_vblank (ts-continuation-modeset) [360.459923] Starting subtest: ts-continuation-modeset [360.462293] Starting dynamic subtest: pipe-A-eDP-1 [361.985399] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.523s) [361.998145] Starting dynamic subtest: pipe-D-eDP-1 [364.166565] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.181s) [364.168874] Subtest ts-continuation-modeset: SUCCESS (3.708s) [364.982658] [029/155] (655s left) gem_exec_fence (syncobj-backward-timeline-chain-engines) [365.518958] Starting subtest: syncobj-backward-timeline-chain-engines [365.619531] Subtest syncobj-backward-timeline-chain-engines: SUCCESS (0.100s) [367.329294] [030/155] (653s left) gem_workarounds (basic-read-fd) [367.393210] Starting subtest: basic-read-fd [367.404978] Subtest basic-read-fd: SUCCESS (0.012s) [367.535125] [031/155] (652s left) i915_drm_fdinfo (memory-info-active) [367.574440] Starting subtest: memory-info-active [367.576890] Starting dynamic subtest: smem0 [370.185512] Dynamic subtest smem0: SUCCESS (2.612s) [370.187655] Subtest memory-info-active: SUCCESS (2.613s) [370.260376] [032/155] (650s left) kms_frontbuffer_tracking (hdr-rgb565-draw-mmap-cpu) [370.348495] Starting subtest: hdr-rgb565-draw-mmap-cpu [370.351908] Subtest hdr-rgb565-draw-mmap-cpu: SKIP (0.000s) [370.448630] [033/155] (650s left) kms_frontbuffer_tracking (psrhdr-2p-rte) [370.526922] Starting subtest: psrhdr-2p-rte [370.530714] Subtest psrhdr-2p-rte: SKIP (0.000s) [370.637942] [034/155] (649s left) gem_exec_reloc (basic-wc-cpu-active) [370.700969] Subtest basic-wc-cpu-active: SKIP (0.000s) [370.769758] [035/155] (649s left) gem_mmap_wc (invalid-flags) [370.825336] Subtest invalid-flags: SKIP (0.000s) [370.890617] [036/155] (649s left) syncobj_timeline (invalid-multi-wait-all-unsubmitted) [370.942144] Starting subtest: invalid-multi-wait-all-unsubmitted [370.943973] Subtest invalid-multi-wait-all-unsubmitted: SUCCESS (0.000s) [371.030349] [037/155] (649s left) kms_lease (multimaster-lease) [371.101594] Starting subtest: multimaster-lease [371.103615] Subtest multimaster-lease: SUCCESS (0.003s) [371.232445] [038/155] (649s left) kms_cursor_crc (cursor-rapid-movement-256x85) [371.458435] Starting subtest: cursor-rapid-movement-256x85 [371.505842] Subtest cursor-rapid-movement-256x85: SKIP (0.043s) [371.662220] [039/155] (649s left) kms_flip (flip-vs-rmfb) [371.729934] Starting subtest: flip-vs-rmfb [371.731939] Starting dynamic subtest: A-eDP1 [380.384348] Dynamic subtest A-eDP1: SUCCESS (8.654s) [380.396773] Starting dynamic subtest: B-eDP1 [389.017422] Dynamic subtest B-eDP1: SUCCESS (8.628s) [389.027750] Starting dynamic subtest: C-eDP1 [397.648274] Dynamic subtest C-eDP1: SUCCESS (8.629s) [397.657186] Starting dynamic subtest: D-eDP1 [406.290198] Dynamic subtest D-eDP1: SUCCESS (8.640s) [406.294568] Subtest flip-vs-rmfb: SUCCESS (34.564s) [407.487586] [040/155] (613s left) kms_flip (2x-flip-vs-blocking-wf-vblank) [407.573047] Starting subtest: 2x-flip-vs-blocking-wf-vblank [407.580616] Subtest 2x-flip-vs-blocking-wf-vblank: SKIP (0.008s) [407.672445] [041/155] (613s left) gem_basic (create-close) [407.728539] Starting subtest: create-close [407.732976] Subtest create-close: SUCCESS (0.000s) [407.844009] [042/155] (613s left) kms_content_protection (mei-interface) [407.966697] Starting subtest: mei-interface [407.971274] Subtest mei-interface: SKIP (0.001s) [408.113016] [043/155] (612s left) kms_addfb_basic (basic-x-tiled-legacy) [408.164926] Starting subtest: basic-x-tiled-legacy [408.168786] Subtest basic-x-tiled-legacy: SKIP (0.000s) [408.281224] [044/155] (612s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-pwrite) [408.355170] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-pwrite [408.359249] Subtest fbc-2p-primscrn-cur-indfb-draw-pwrite: SKIP (0.000s) [408.439036] [045/155] (612s left) gem_exec_balancer (bonded-chain) [408.492109] Starting subtest: bonded-chain [415.528840] Subtest bonded-chain: SUCCESS (7.034s) [416.232460] [046/155] (604s left) kms_frontbuffer_tracking (hdr-2p-scndscrn-cur-indfb-move) [416.319499] Starting subtest: hdr-2p-scndscrn-cur-indfb-move [416.323555] Subtest hdr-2p-scndscrn-cur-indfb-move: SKIP (0.000s) [416.417395] [047/155] (604s left) kms_big_fb (4-tiled-64bpp-rotate-180) [416.489178] Starting subtest: 4-tiled-64bpp-rotate-180 [417.946176] Subtest 4-tiled-64bpp-rotate-180: SUCCESS (1.457s) [418.109956] [048/155] (603s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-0) [418.187596] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-0 [418.192065] Subtest yf-tiled-max-hw-stride-32bpp-rotate-0: SKIP (0.000s) [418.280446] [049/155] (602s left) kms_frontbuffer_tracking (fbchdr-2p-primscrn-pri-shrfb-draw-render) [418.355905] Starting subtest: fbchdr-2p-primscrn-pri-shrfb-draw-render [418.359374] Subtest fbchdr-2p-primscrn-pri-shrfb-draw-render: SKIP (0.000s) [418.434100] [050/155] (602s left) gem_exec_balancer (full-late) [418.482969] Starting subtest: full-late [423.075497] Subtest full-late: SUCCESS (4.592s) [423.410607] [051/155] (597s left) kms_dsc (dsc-with-formats) [423.488025] Starting subtest: dsc-with-formats [423.526165] Subtest dsc-with-formats: SKIP (0.001s) [423.569589] [052/155] (597s left) kms_frontbuffer_tracking (fbchdr-1p-offscreen-pri-shrfb-draw-render) [423.664834] Starting subtest: fbchdr-1p-offscreen-pri-shrfb-draw-render [423.669098] Subtest fbchdr-1p-offscreen-pri-shrfb-draw-render: SKIP (0.000s) [423.760827] [053/155] (597s left) kms_frontbuffer_tracking (hdr-2p-primscrn-spr-indfb-draw-mmap-wc) [423.838898] Starting subtest: hdr-2p-primscrn-spr-indfb-draw-mmap-wc [423.843199] Subtest hdr-2p-primscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s) [423.930634] [054/155] (597s left) kms_psr (fbc-psr-cursor-mmap-cpu) [423.997629] Starting subtest: fbc-psr-cursor-mmap-cpu [423.999832] Starting dynamic subtest: eDP-1 [424.003650] Dynamic subtest eDP-1: SKIP (0.000s) [424.007685] Subtest fbc-psr-cursor-mmap-cpu: SKIP (0.001s) [424.068013] [055/155] (597s left) kms_frontbuffer_tracking (hdr-1p-primscrn-spr-indfb-draw-pwrite) [424.142516] Starting subtest: hdr-1p-primscrn-spr-indfb-draw-pwrite [424.146623] Subtest hdr-1p-primscrn-spr-indfb-draw-pwrite: SKIP (0.000s) [424.239259] [056/155] (597s left) gem_exec_create (forked) [424.304019] Starting subtest: forked [424.305966] Starting dynamic subtest: smem [446.272879] Dynamic subtest smem: SUCCESS (21.965s) [446.275784] Subtest forked: SUCCESS (21.969s) [446.471490] [057/155] (575s left) syncobj_timeline (invalid-wait-illegal-handle) [446.529710] Starting subtest: invalid-wait-illegal-handle [446.532145] Subtest invalid-wait-illegal-handle: SUCCESS (0.000s) [446.627071] [058/155] (574s left) gem_exec_balancer (parallel-out-fence) [446.886962] Starting subtest: parallel-out-fence [447.981818] Subtest parallel-out-fence: SUCCESS (1.094s) [448.094860] [059/155] (573s left) kms_addfb_basic (invalid-get-prop-any) [448.149263] Starting subtest: invalid-get-prop-any [448.151569] Subtest invalid-get-prop-any: SUCCESS (0.000s) [448.278078] [060/155] (573s left) api_intel_bb (reset-flags) [448.340099] Starting subtest: reset-flags [448.345486] Subtest reset-flags: SUCCESS (0.006s) [448.479207] [061/155] (573s left) perf_pmu (busy-hang) [448.516050] Starting subtest: busy-hang [448.518328] Starting dynamic subtest: rcs0 [449.785588] Dynamic subtest rcs0: SUCCESS (1.273s) [449.797802] Starting dynamic subtest: bcs0 [451.026177] Dynamic subtest bcs0: SUCCESS (1.239s) [451.037720] Starting dynamic subtest: vcs0 [452.738112] Dynamic subtest vcs0: SUCCESS (1.707s) [452.748100] Starting dynamic subtest: vcs1 [454.722472] Dynamic subtest vcs1: SUCCESS (1.982s) [454.734123] Starting dynamic subtest: vecs0 [456.768447] Dynamic subtest vecs0: SUCCESS (2.048s) [456.780756] Starting dynamic subtest: ccs0 [458.014269] Dynamic subtest ccs0: SUCCESS (1.241s) [458.016323] Subtest busy-hang: SUCCESS (9.500s) [458.119350] [062/155] (563s left) gen9_exec_parse (bb-large) [458.179978] Subtest bb-large: SKIP (0.000s) [458.244483] [063/155] (563s left) kms_plane (pixel-format-4-tiled-dg2-mc-ccs-modifier-source-clamping) [458.325260] Starting subtest: pixel-format-4-tiled-dg2-mc-ccs-modifier-source-clamping [458.329378] Subtest pixel-format-4-tiled-dg2-mc-ccs-modifier-source-clamping: SKIP (0.000s) [458.409969] [064/155] (563s left) kms_big_fb (yf-tiled-16bpp-rotate-0) [458.486266] Starting subtest: yf-tiled-16bpp-rotate-0 [458.490579] Subtest yf-tiled-16bpp-rotate-0: SKIP (0.000s) [458.587575] [065/155] (563s left) gem_softpin (32b-excludes-last-page) [458.648534] Starting subtest: 32b-excludes-last-page [458.654091] Subtest 32b-excludes-last-page: SUCCESS (0.003s) [458.776698] [066/155] (563s left) gem_mmap (pf-nonblock) [458.833540] Subtest pf-nonblock: SKIP (0.000s) [458.914580] [067/155] (563s left) kms_pm_rpm (dpms-lpsp) [460.409365] Starting subtest: dpms-lpsp [461.049324] Subtest dpms-lpsp: SUCCESS (0.645s) [461.141749] [068/155] (560s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-mmap-cpu) [461.223212] Starting subtest: fbcpsr-rgb101010-draw-mmap-cpu [465.936776] Subtest fbcpsr-rgb101010-draw-mmap-cpu: SUCCESS (4.719s) [466.039399] [069/155] (555s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-primscrn-shrfb-plflip-blt) [466.119171] Starting subtest: fbcpsrhdr-2p-primscrn-shrfb-plflip-blt [466.123452] Subtest fbcpsrhdr-2p-primscrn-shrfb-plflip-blt: SKIP (0.000s) [466.228489] [070/155] (555s left) prime_vgem (coherency-blt) [466.308892] Starting subtest: coherency-blt [467.410726] Subtest coherency-blt: SUCCESS (1.100s) [467.551313] [071/155] (554s left) gem_eio (suspend) [467.779939] Starting subtest: suspend [480.791041] Subtest suspend: SUCCESS (13.012s) [480.911183] [072/155] (541s left) kms_frontbuffer_tracking (psrhdr-2p-scndscrn-spr-indfb-draw-pwrite) [480.991706] Starting subtest: psrhdr-2p-scndscrn-spr-indfb-draw-pwrite [480.996244] Subtest psrhdr-2p-scndscrn-spr-indfb-draw-pwrite: SKIP (0.000s) [481.126792] [073/155] (541s left) kms_plane_scaling (2x-scaler-multi-pipe) [481.203234] Starting subtest: 2x-scaler-multi-pipe [481.207698] Subtest 2x-scaler-multi-pipe: SKIP (0.001s) [481.300568] [074/155] (540s left) gem_mmap_gtt (medium-copy-xy) [481.355590] Subtest medium-copy-XY: SKIP (0.000s) [481.417820] [075/155] (540s left) kms_frontbuffer_tracking (hdr-1p-pri-indfb-multidraw) [481.496109] Starting subtest: hdr-1p-pri-indfb-multidraw [481.500163] Subtest hdr-1p-pri-indfb-multidraw: SKIP (0.000s) [481.585626] [076/155] (540s left) kms_ccs (crc-primary-basic-4-tiled-dg2-rc-ccs) [481.651167] Starting subtest: crc-primary-basic-4-tiled-dg2-rc-ccs [481.652912] Starting dynamic subtest: pipe-A-eDP-1 [481.678433] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [481.690783] Starting dynamic subtest: pipe-B-eDP-1 [481.712182] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [481.722527] Starting dynamic subtest: pipe-C-eDP-1 [481.741853] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [481.751959] Starting dynamic subtest: pipe-D-eDP-1 [481.769970] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [481.773675] Subtest crc-primary-basic-4-tiled-dg2-rc-ccs: SKIP (0.006s) [483.939949] [077/155] (538s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-primscrn-pri-indfb-draw-blt) [484.020162] Starting subtest: fbcpsrhdr-1p-primscrn-pri-indfb-draw-blt [484.024495] Subtest fbcpsrhdr-1p-primscrn-pri-indfb-draw-blt: SKIP (0.000s) [484.110484] [078/155] (538s left) gem_exec_flush (basic-wb-ro-before-default) [484.168799] Starting subtest: basic-wb-ro-before-default [489.628945] Subtest basic-wb-ro-before-default: SUCCESS (5.459s) [489.821279] [079/155] (532s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-scndscrn-pri-shrfb-draw-blt) [489.919876] Starting subtest: fbcpsrhdr-2p-scndscrn-pri-shrfb-draw-blt [489.924899] Subtest fbcpsrhdr-2p-scndscrn-pri-shrfb-draw-blt: SKIP (0.000s) [490.020810] [080/155] (532s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-pri-indfb-multidraw) [490.103804] Starting subtest: fbcpsrhdr-2p-pri-indfb-multidraw [490.108247] Subtest fbcpsrhdr-2p-pri-indfb-multidraw: SKIP (0.000s) [490.199275] [081/155] (532s left) kms_psr (fbc-psr2-suspend) [490.282279] Starting subtest: fbc-psr2-suspend [490.284713] Starting dynamic subtest: eDP-1 [490.288815] Dynamic subtest eDP-1: SKIP (0.000s) [490.292730] Subtest fbc-psr2-suspend: SKIP (0.001s) [490.358527] [082/155] (532s left) kms_big_fb (linear-8bpp-rotate-180) [490.455974] Starting subtest: linear-8bpp-rotate-180 [491.703708] Subtest linear-8bpp-rotate-180: SUCCESS (1.247s) [491.838120] [083/155] (530s left) syncobj_basic (bad-flags-fd-to-handle) [491.897894] Starting subtest: bad-flags-fd-to-handle [491.899817] Subtest bad-flags-fd-to-handle: SUCCESS (0.000s) [492.011081] [084/155] (530s left) syncobj_timeline (wait-any-interrupted) [492.070553] Starting subtest: wait-any-interrupted [492.171211] Subtest wait-any-interrupted: SUCCESS (0.102s) [492.262633] [085/155] (530s left) syncobj_wait (invalid-multi-wait-all-unsubmitted) [492.316085] Starting subtest: invalid-multi-wait-all-unsubmitted [492.318498] Subtest invalid-multi-wait-all-unsubmitted: SUCCESS (0.000s) [492.407009] [086/155] (530s left) gem_exec_store (dword) [492.464473] Starting subtest: dword [492.466557] Starting dynamic subtest: rcs0 [492.529527] Dynamic subtest rcs0: SUCCESS (0.066s) [492.542085] Starting dynamic subtest: bcs0 [492.570158] Dynamic subtest bcs0: SUCCESS (0.039s) [492.585336] Starting dynamic subtest: vcs0 [492.611123] Dynamic subtest vcs0: SUCCESS (0.039s) [492.621964] Starting dynamic subtest: vcs1 [492.654086] Dynamic subtest vcs1: SUCCESS (0.039s) [492.665591] Starting dynamic subtest: vecs0 [492.695379] Dynamic subtest vecs0: SUCCESS (0.040s) [492.706161] Starting dynamic subtest: ccs0 [492.736324] Dynamic subtest ccs0: SUCCESS (0.039s) [492.738653] Subtest dword: SUCCESS (0.275s) [492.922470] [087/155] (529s left) kms_frontbuffer_tracking (fbcpsrhdr-suspend) [493.005363] Starting subtest: fbcpsrhdr-suspend [493.009581] Subtest fbcpsrhdr-suspend: SKIP (0.000s) [493.121820] [088/155] (529s left) gem_fence_thrash (bo-write-verify-threaded-none) [493.153631] Starting subtest: bo-write-verify-threaded-none [493.174825] Subtest bo-write-verify-threaded-none: SKIP (0.017s) [493.240621] [089/155] (529s left) kms_properties (invalid-properties-atomic) [493.315804] Starting subtest: invalid-properties-atomic [493.585688] Subtest invalid-properties-atomic: SUCCESS (0.269s) [493.671824] [090/155] (529s left) gem_ctx_engines (execute-one) [493.726193] Starting subtest: execute-one [496.203977] Subtest execute-one: SUCCESS (2.478s) [496.390034] [091/155] (526s left) gem_softpin (evict-prime) [496.457511] Starting subtest: evict-prime [496.459859] Starting dynamic subtest: rcs0 [497.621758] Dynamic subtest rcs0: SUCCESS (1.163s) [497.635950] Starting dynamic subtest: bcs0 [498.749647] Dynamic subtest bcs0: SUCCESS (1.126s) [498.763292] Starting dynamic subtest: vcs0 [500.230766] Dynamic subtest vcs0: SUCCESS (1.477s) [500.245959] Starting dynamic subtest: vcs1 [502.185958] Dynamic subtest vcs1: SUCCESS (1.953s) [502.197929] Starting dynamic subtest: vecs0 [504.195427] Dynamic subtest vecs0: SUCCESS (2.008s) [504.208092] Starting dynamic subtest: ccs0 [505.330721] Dynamic subtest ccs0: SUCCESS (1.134s) [505.341922] Starting dynamic subtest: all [507.253443] Dynamic subtest all: SUCCESS (1.920s) [507.256585] Subtest evict-prime: SUCCESS (10.795s) [507.335676] [092/155] (515s left) gem_ctx_persistence (legacy-engines-hang) [507.396472] Starting subtest: legacy-engines-hang [507.398989] Starting dynamic subtest: render [507.516042] Dynamic subtest render: SUCCESS (0.118s) [507.529421] Starting dynamic subtest: bsd1 [507.607756] Dynamic subtest bsd1: SUCCESS (0.089s) [507.622478] Starting dynamic subtest: bsd2 [507.704536] Dynamic subtest bsd2: SUCCESS (0.094s) [507.720689] Starting dynamic subtest: blt [507.804628] Dynamic subtest blt: SUCCESS (0.097s) [507.819777] Starting dynamic subtest: vebox [507.893780] Dynamic subtest vebox: SUCCESS (0.086s) [507.896242] Subtest legacy-engines-hang: SUCCESS (0.498s) [507.982034] [093/155] (515s left) gem_exec_reloc (basic-range-active) [508.032056] Subtest basic-range-active: SKIP (0.000s) [508.110055] [094/155] (514s left) kms_getfb (getfb-repeated-different-handles) [508.186978] Starting subtest: getfb-repeated-different-handles [508.189277] Subtest getfb-repeated-different-handles: SUCCESS (0.000s) [508.301414] [095/155] (514s left) gem_lmem_swapping (massive-random) [508.342745] Subtest massive-random: SKIP (0.000s) [508.385114] [096/155] (514s left) sw_sync (sync_busy) [508.417061] Starting subtest: sync_busy [508.418877] Subtest sync_busy: SUCCESS (0.002s) [508.473739] [097/155] (514s left) kms_cursor_crc (cursor-sliding-256x85) [508.706464] Starting subtest: cursor-sliding-256x85 [508.754020] Subtest cursor-sliding-256x85: SKIP (0.043s) [508.930784] [098/155] (514s left) kms_flip_scaled_crc (flip-32bpp-yftileccs-to-64bpp-yftile-downscaling) [509.004361] Starting subtest: flip-32bpp-yftileccs-to-64bpp-yftile-downscaling [509.007925] Subtest flip-32bpp-yftileccs-to-64bpp-yftile-downscaling: SKIP (0.000s) [509.078791] [099/155] (514s left) kms_chamelium_hpd (common-hpd-after-suspend) [509.436783] Subtest common-hpd-after-suspend: SKIP (0.000s) [510.251213] [100/155] (513s left) gem_ctx_create (basic-files) [510.303676] Starting subtest: basic-files [512.827965] Subtest basic-files: SUCCESS (2.524s) [514.299810] [101/155] (509s left) kms_ccs (random-ccs-data-4-tiled-mtl-rc-ccs) [514.388139] Starting subtest: random-ccs-data-4-tiled-mtl-rc-ccs [514.390035] Starting dynamic subtest: pipe-A-eDP-1 [515.117140] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.722s) [515.127778] Starting dynamic subtest: pipe-B-eDP-1 [516.896533] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.778s) [516.908522] Starting dynamic subtest: pipe-C-eDP-1 [518.733290] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.835s) [518.744598] Starting dynamic subtest: pipe-D-eDP-1 [520.538184] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.804s) [520.540447] Subtest random-ccs-data-4-tiled-mtl-rc-ccs: SUCCESS (6.144s) [521.688905] [102/155] (501s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-32bpp-4tile-upscaling) [521.756865] Starting subtest: flip-64bpp-4tile-to-32bpp-4tile-upscaling [521.759219] Starting dynamic subtest: pipe-A-default-mode [524.546293] Dynamic subtest pipe-A-default-mode: SUCCESS (2.787s) [524.548690] Subtest flip-64bpp-4tile-to-32bpp-4tile-upscaling: SUCCESS (2.788s) [525.392091] [103/155] (498s left) kms_psr (psr2-sprite-render) [525.477868] Starting subtest: psr2-sprite-render [525.480160] Starting dynamic subtest: eDP-1 [527.205439] Dynamic subtest eDP-1: SUCCESS (1.727s) [527.207691] Subtest psr2-sprite-render: SUCCESS (1.728s) [528.062559] [104/155] (495s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-move) [528.149393] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-move [528.153681] Subtest fbcpsr-2p-primscrn-spr-indfb-move: SKIP (0.000s) [528.261204] [105/155] (495s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-scndscrn-shrfb-plflip-blt) [528.354636] Starting subtest: fbcpsrhdr-2p-scndscrn-shrfb-plflip-blt [528.358939] Subtest fbcpsrhdr-2p-scndscrn-shrfb-plflip-blt: SKIP (0.000s) [528.468470] [106/155] (495s left) kms_frontbuffer_tracking (psrhdr-1p-primscrn-pri-indfb-draw-mmap-wc) [528.551197] Starting subtest: psrhdr-1p-primscrn-pri-indfb-draw-mmap-wc [528.555212] Subtest psrhdr-1p-primscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s) [528.643685] [107/155] (494s left) gem_lmem_swapping (verify-random-ccs) [528.684772] Subtest verify-random-ccs: SKIP (0.000s) [528.729416] [108/155] (494s left) kms_big_fb (y-tiled-8bpp-rotate-0) [528.805254] Starting subtest: y-tiled-8bpp-rotate-0 [528.809574] Subtest y-tiled-8bpp-rotate-0: SKIP (0.000s) [528.898944] [109/155] (494s left) gem_mmap_gtt (big-bo-tiledy) [528.955725] Subtest big-bo-tiledY: SKIP (0.000s) [529.019387] [110/155] (494s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-indfb-draw-mmap-wc) [529.103880] Starting subtest: psr-1p-offscreen-pri-indfb-draw-mmap-wc [535.770993] Subtest psr-1p-offscreen-pri-indfb-draw-mmap-wc: SUCCESS (6.670s) [535.898471] [111/155] (487s left) i915_pm_freq_api (freq-basic-api) [535.956749] Starting subtest: freq-basic-api [535.959622] Starting dynamic subtest: gt0 [535.962126] Dynamic subtest gt0: SUCCESS (0.002s) [535.975710] Starting dynamic subtest: gt1 [535.978041] Dynamic subtest gt1: SUCCESS (0.003s) [535.980306] Subtest freq-basic-api: SUCCESS (0.007s) [536.067330] [112/155] (487s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-render) [536.140862] Starting subtest: psr-1p-primscrn-pri-indfb-draw-render [543.408463] Subtest psr-1p-primscrn-pri-indfb-draw-render: SUCCESS (7.273s) [543.534639] [113/155] (480s left) kms_frontbuffer_tracking (fbchdr-2p-primscrn-spr-indfb-draw-mmap-gtt) [543.624331] Starting subtest: fbchdr-2p-primscrn-spr-indfb-draw-mmap-gtt [543.628351] Subtest fbchdr-2p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s) [543.719612] [114/155] (480s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-blt) [543.805611] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-blt [551.100667] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-blt: SUCCESS (7.303s) [551.229369] [115/155] (472s left) kms_big_fb (4-tiled-16bpp-rotate-180) [551.314277] Starting subtest: 4-tiled-16bpp-rotate-180 [552.592758] Subtest 4-tiled-16bpp-rotate-180: SUCCESS (1.278s) [552.712784] [116/155] (471s left) kms_chamelium_frames (hdmi-cmp-planar-formats) [553.086718] Subtest hdmi-cmp-planar-formats: SKIP (0.000s) [553.943562] [117/155] (470s left) kms_busy (extended-pageflip-modeset-hang-oldfb) [554.027397] Starting subtest: extended-pageflip-modeset-hang-oldfb [554.029636] Starting dynamic subtest: pipe-A [561.931790] Dynamic subtest pipe-A: SUCCESS (7.902s) [561.943422] Starting dynamic subtest: pipe-D [570.584754] Dynamic subtest pipe-D: SUCCESS (8.650s) [570.586966] Subtest extended-pageflip-modeset-hang-oldfb: SUCCESS (16.557s) [571.442128] [118/155] (452s left) gem_exec_schedule (pi-ringfull) [571.628709] Starting subtest: pi-ringfull [571.631213] Starting dynamic subtest: rcs0 [571.663964] Dynamic subtest rcs0: SUCCESS (0.039s) [571.676467] Starting dynamic subtest: bcs0 [571.713406] Dynamic subtest bcs0: SUCCESS (0.048s) [571.724198] Starting dynamic subtest: vcs0 [571.754490] Dynamic subtest vcs0: SUCCESS (0.040s) [571.770574] Starting dynamic subtest: vcs1 [571.789041] Dynamic subtest vcs1: SUCCESS (0.033s) [571.803860] Starting dynamic subtest: vecs0 [571.820967] Dynamic subtest vecs0: SUCCESS (0.031s) [571.835551] Starting dynamic subtest: ccs0 [571.851764] Dynamic subtest ccs0: SUCCESS (0.030s) [571.853980] Subtest pi-ringfull: SUCCESS (0.228s) [572.065891] [119/155] (452s left) kms_frontbuffer_tracking (fbchdr-1p-primscrn-pri-shrfb-draw-mmap-gtt) [572.140879] Starting subtest: fbchdr-1p-primscrn-pri-shrfb-draw-mmap-gtt [572.144995] Subtest fbchdr-1p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s) [572.253362] [120/155] (451s left) kms_frontbuffer_tracking (psrhdr-2p-primscrn-cur-indfb-onoff) [572.337212] Starting subtest: psrhdr-2p-primscrn-cur-indfb-onoff [572.341593] Subtest psrhdr-2p-primscrn-cur-indfb-onoff: SKIP (0.000s) [572.449437] [121/155] (451s left) kms_psr (fbc-pr-cursor-plane-onoff) [572.521488] Starting subtest: fbc-pr-cursor-plane-onoff [572.525825] Subtest fbc-pr-cursor-plane-onoff: SKIP (0.000s) [572.609991] [122/155] (451s left) sw_sync (alloc_merge_fence) [572.647937] Starting subtest: alloc_merge_fence [572.650177] Subtest alloc_merge_fence: SUCCESS (0.000s) [572.719911] [123/155] (451s left) kms_cursor_legacy (torture-move) [572.823867] Starting subtest: torture-move [572.825774] Starting dynamic subtest: pipe-A [578.588234] Dynamic subtest pipe-A: SUCCESS (5.761s) [578.602800] Starting dynamic subtest: pipe-B [584.653932] Dynamic subtest pipe-B: SUCCESS (6.065s) [584.665814] Starting dynamic subtest: pipe-C [591.093299] Dynamic subtest pipe-C: SUCCESS (6.436s) [591.111960] Starting dynamic subtest: pipe-D [596.762131] Dynamic subtest pipe-D: SUCCESS (5.668s) [596.776540] Starting dynamic subtest: all-pipes [603.939039] Dynamic subtest all-pipes: SUCCESS (7.171s) [603.941630] Subtest torture-move: SUCCESS (31.110s) [604.094179] [124/155] (420s left) kms_pm_dc (dc3co-vpb-simulation) [605.176413] Starting subtest: dc3co-vpb-simulation [614.131762] Subtest dc3co-vpb-simulation: SKIP (8.951s) [614.256698] [125/155] (410s left) syncobj_wait (invalid-multi-wait-all-unsubmitted-submitted) [614.309877] Starting subtest: invalid-multi-wait-all-unsubmitted-submitted [614.312157] Subtest invalid-multi-wait-all-unsubmitted-submitted: SUCCESS (0.000s) [614.412556] [126/155] (409s left) kms_sequence (queue-busy) [614.485662] Starting subtest: queue-busy [614.488099] Starting dynamic subtest: pipe-A-eDP-1 [616.423523] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.935s) [616.434951] Starting dynamic subtest: pipe-B-eDP-1 [619.026841] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.603s) [619.038296] Starting dynamic subtest: pipe-C-eDP-1 [621.660618] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.632s) [621.672420] Starting dynamic subtest: pipe-D-eDP-1 [624.267180] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.603s) [624.269780] Subtest queue-busy: SUCCESS (9.779s) [625.158563] [127/155] (399s left) kms_cursor_legacy (nonblocking-modeset-vs-cursor-atomic) [625.263307] Starting subtest: nonblocking-modeset-vs-cursor-atomic [626.739111] Subtest nonblocking-modeset-vs-cursor-atomic: SUCCESS (1.476s) [627.617841] [128/155] (396s left) syncobj_wait (multi-wait-submitted) [627.662089] Starting subtest: multi-wait-submitted [627.763533] Subtest multi-wait-submitted: SUCCESS (0.101s) [627.842914] [129/155] (396s left) perf (oa-exponents) [627.959387] Starting subtest: oa-exponents [627.961675] Starting dynamic subtest: 0-rcs0 [629.722628] Dynamic subtest 0-rcs0: SUCCESS (1.761s) [629.735505] Starting dynamic subtest: 1-vcs1 [631.551536] Dynamic subtest 1-vcs1: SUCCESS (1.828s) [631.553962] Subtest oa-exponents: SUCCESS (3.592s) [631.602716] [130/155] (392s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-wc) [631.698156] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-wc [638.403633] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-wc: SUCCESS (6.711s) [638.531143] [131/155] (386s left) kms_psr2_sf (psr2-overlay-plane-move-continuous-exceed-fully-sf) [638.626446] Starting subtest: psr2-overlay-plane-move-continuous-exceed-fully-sf [638.628622] Starting dynamic subtest: pipe-A-eDP-1 [655.089430] Dynamic subtest pipe-A-eDP-1: SUCCESS (16.464s) [655.102071] Starting dynamic subtest: pipe-B-eDP-1 [672.240061] Dynamic subtest pipe-B-eDP-1: SUCCESS (17.149s) [672.242448] Subtest psr2-overlay-plane-move-continuous-exceed-fully-sf: SUCCESS (33.617s) [673.065102] [132/155] (351s left) kms_ccs (crc-primary-rotation-180-y-tiled-gen12-rc-ccs) [673.141470] Starting subtest: crc-primary-rotation-180-y-tiled-gen12-rc-ccs [673.143650] Starting dynamic subtest: pipe-A-eDP-1 [673.166063] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [673.178987] Starting dynamic subtest: pipe-B-eDP-1 [673.200528] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [673.211515] Starting dynamic subtest: pipe-C-eDP-1 [673.233517] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [673.243718] Starting dynamic subtest: pipe-D-eDP-1 [673.265685] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [673.269742] Subtest crc-primary-rotation-180-y-tiled-gen12-rc-ccs: SKIP (0.006s) [675.413984] [133/155] (349s left) kms_invalid_mode (bad-vtotal) [675.490111] Starting subtest: bad-vtotal [675.492667] Starting dynamic subtest: pipe-A-eDP-1 [675.772865] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.284s) [675.784661] Starting dynamic subtest: pipe-B-eDP-1 [675.786984] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s) [675.797590] Starting dynamic subtest: pipe-C-eDP-1 [675.799528] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s) [675.810499] Starting dynamic subtest: pipe-D-eDP-1 [675.812913] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s) [675.815414] Subtest bad-vtotal: SUCCESS (0.290s) [676.652966] [134/155] (348s left) gem_eio (in-flight-10ms) [676.866329] Starting subtest: in-flight-10ms [685.088114] Subtest in-flight-10ms: SUCCESS (8.223s) [685.237045] [135/155] (339s left) kms_plane (pixel-format-y-tiled-gen12-rc-ccs-cc-modifier) [685.321041] Starting subtest: pixel-format-y-tiled-gen12-rc-ccs-cc-modifier [685.325595] Subtest pixel-format-y-tiled-gen12-rc-ccs-cc-modifier: SKIP (0.000s) [685.396401] [136/155] (339s left) perf (polling-parameterized) [685.476482] Starting subtest: polling-parameterized [705.492859] Subtest polling-parameterized: SUCCESS (20.017s) [705.533919] [137/155] (319s left) kms_frontbuffer_tracking (fbchdr-2p-scndscrn-pri-shrfb-draw-blt) [705.617039] Starting subtest: fbchdr-2p-scndscrn-pri-shrfb-draw-blt [705.621140] Subtest fbchdr-2p-scndscrn-pri-shrfb-draw-blt: SKIP (0.000s) [705.716213] [138/155] (319s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-mmap-gtt) [705.797116] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-mmap-gtt [705.801568] Subtest fbc-2p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s) [705.890379] [139/155] (319s left) gem_pxp (verify-pxp-stale-ctx-execution) [706.013900] Starting subtest: verify-pxp-stale-ctx-execution [707.075026] Subtest verify-pxp-stale-ctx-execution: SUCCESS (1.061s) [707.199581] [140/155] (317s left) gem_exec_gttfill (engines) [707.256413] Starting subtest: engines [707.258644] Starting dynamic subtest: rcs0 [730.587212] Dynamic subtest rcs0: SUCCESS (23.329s) [730.600539] Starting dynamic subtest: bcs0 [753.865502] Dynamic subtest bcs0: SUCCESS (23.275s) [753.879886] Starting dynamic subtest: vcs0 [777.198640] Dynamic subtest vcs0: SUCCESS (23.329s) [777.212460] Starting dynamic subtest: vcs1 [800.471644] Dynamic subtest vcs1: SUCCESS (23.271s) [800.483707] Starting dynamic subtest: vecs0 [823.791840] Dynamic subtest vecs0: SUCCESS (23.318s) [823.806450] Starting dynamic subtest: ccs0 [847.098316] Dynamic subtest ccs0: SUCCESS (23.302s) [847.100652] Subtest engines: SUCCESS (139.837s) [847.292203] [141/155] (177s left) kms_frontbuffer_tracking (psrhdr-2p-primscrn-spr-indfb-fullscreen) [847.418918] Starting subtest: psrhdr-2p-primscrn-spr-indfb-fullscreen [847.423137] Subtest psrhdr-2p-primscrn-spr-indfb-fullscreen: SKIP (0.000s) [847.521411] [142/155] (177s left) kms_psr2_sf (fbc-pr-cursor-plane-move-continuous-sf) [847.608041] Starting subtest: fbc-pr-cursor-plane-move-continuous-sf [847.612611] Subtest fbc-pr-cursor-plane-move-continuous-sf: SKIP (0.000s) [847.677864] [143/155] (177s left) kms_pm_rpm (package-g7) [849.405273] Starting subtest: package-g7 [849.411745] Subtest package-g7: SKIP (0.000s) [849.986008] [144/155] (175s left) kms_frontbuffer_tracking (psr-rgb101010-draw-mmap-wc) [850.089445] Starting subtest: psr-rgb101010-draw-mmap-wc [857.144796] Subtest psr-rgb101010-draw-mmap-wc: SUCCESS (7.061s) [857.276157] [145/155] (167s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-onoff) [857.365273] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-onoff [864.481457] Subtest fbcpsr-1p-primscrn-spr-indfb-onoff: SUCCESS (7.124s) [864.620159] [146/155] (160s left) kms_hdr (bpc-switch-suspend) [864.694035] Starting subtest: bpc-switch-suspend [864.696286] Starting dynamic subtest: pipe-A-eDP-1-XRGB2101010 [884.562715] Dynamic subtest pipe-A-eDP-1-XRGB2101010: SUCCESS (4.589s) [884.576505] Starting dynamic subtest: pipe-A-eDP-1-XRGB16161616F [905.581690] Dynamic subtest pipe-A-eDP-1-XRGB16161616F: SUCCESS (5.711s) [905.584082] Subtest bpc-switch-suspend: SUCCESS (10.303s) [905.686667] [147/155] (119s left) kms_pipe_b_c_ivb (pipe-b-dpms-off-modeset-pipe-c) [905.750059] Subtest pipe-B-dpms-off-modeset-pipe-C: SKIP (0.000s) [905.809869] [148/155] (119s left) gem_ctx_freq (sysfs) [905.864629] Starting subtest: sysfs [905.866925] Starting dynamic subtest: gt0 [911.337811] Dynamic subtest gt0: SUCCESS (5.466s) [911.351438] Starting dynamic subtest: gt1 [952.818349] Dynamic subtest gt1: SUCCESS (41.460s) [952.821349] Subtest sysfs: SUCCESS (46.928s) [952.970480] [149/155] ( 72s left) syncobj_timeline (multi-wait-for-submit-available-unsubmitted-submitted) [953.050934] Starting subtest: multi-wait-for-submit-available-unsubmitted-submitted [953.053404] Subtest multi-wait-for-submit-available-unsubmitted-submitted: SUCCESS (0.001s) [953.126860] [150/155] ( 72s left) dmabuf_sync_file (export-wait-after-attach) [953.168976] Starting subtest: export-wait-after-attach [953.171005] Subtest export-wait-after-attach: SUCCESS (0.001s) [953.235625] [151/155] ( 72s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-pwrite) [953.314867] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-pwrite [957.723812] Subtest fbc-1p-primscrn-cur-indfb-draw-pwrite: SUCCESS (4.415s) [958.848756] [152/155] ( 66s left) kms_plane_alpha_blend (alpha-basic) [958.927750] Starting subtest: alpha-basic [959.218009] Starting dynamic subtest: pipe-A-eDP-1 [961.133908] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.913s) [961.168920] Starting dynamic subtest: pipe-D-eDP-1 [963.802737] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.643s) [963.804910] Subtest alpha-basic: SUCCESS (4.874s) [964.690327] [153/155] ( 60s left) gem_mmap_offset (partial-remap) [964.741449] Starting subtest: partial-remap [964.744297] Starting dynamic subtest: smem0 [964.753851] Dynamic subtest smem0: SUCCESS (0.003s) [964.756197] Subtest partial-remap: SUCCESS (0.004s) [964.861902] [154/155] ( 60s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-render) [964.942408] Starting subtest: psr-2p-primscrn-cur-indfb-draw-render [964.946519] Subtest psr-2p-primscrn-cur-indfb-draw-render: SKIP (0.000s) [965.051297] [155/155] ( 60s left) syncobj_wait (reset-signaled) [965.103567] Starting subtest: reset-signaled [965.105941] Subtest reset-signaled: SUCCESS (0.000s) [965.219553] Closing watchdogs results: parsing output: 0/ for test: kms_frontbuffer_tracking results: parsing output: 1/ for test: kms_frontbuffer_tracking results: parsing output: 2/ for test: syncobj_timeline results: parsing output: 3/ for test: kms_frontbuffer_tracking results: parsing output: 4/ for test: gem_exec_schedule results: parsing output: 5/ for test: kms_cursor_crc results: parsing output: 6/ for test: kms_ccs results: parsing output: 7/ for test: gem_ccs results: parsing output: 8/ for test: kms_frontbuffer_tracking results: parsing output: 9/ for test: gem_exec_params results: parsing output: 10/ for test: kms_rotation_crc results: parsing output: 11/ for test: kms_psr results: parsing output: 12/ for test: kms_plane_scaling results: parsing output: 13/ for test: kms_frontbuffer_tracking results: parsing output: 14/ for test: i915_selftest results: parsing output: 15/ for test: kms_frontbuffer_tracking results: parsing output: 16/ for test: gem_mmap_wc results: parsing output: 17/ for test: kms_frontbuffer_tracking results: parsing output: 18/ for test: kms_psr results: parsing output: 19/ for test: i915_pm_rps results: parsing output: 20/ for test: kms_ccs results: parsing output: 21/ for test: api_intel_allocator results: parsing output: 22/ for test: gem_wait results: parsing output: 23/ for test: kms_big_fb results: parsing output: 24/ for test: kms_color results: parsing output: 25/ for test: prime_vgem results: parsing output: 26/ for test: kms_frontbuffer_tracking results: parsing output: 27/ for test: kms_vblank results: parsing output: 28/ for test: gem_exec_fence results: parsing output: 29/ for test: gem_workarounds results: parsing output: 30/ for test: i915_drm_fdinfo results: parsing output: 31/ for test: kms_frontbuffer_tracking results: parsing output: 32/ for test: kms_frontbuffer_tracking results: parsing output: 33/ for test: gem_exec_reloc results: parsing output: 34/ for test: gem_mmap_wc results: parsing output: 35/ for test: syncobj_timeline results: parsing output: 36/ for test: kms_lease results: parsing output: 37/ for test: kms_cursor_crc results: parsing output: 38/ for test: kms_flip results: parsing output: 39/ for test: kms_flip results: parsing output: 40/ for test: gem_basic results: parsing output: 41/ for test: kms_content_protection results: parsing output: 42/ for test: kms_addfb_basic results: parsing output: 43/ for test: kms_frontbuffer_tracking results: parsing output: 44/ for test: gem_exec_balancer results: parsing output: 45/ for test: kms_frontbuffer_tracking results: parsing output: 46/ for test: kms_big_fb results: parsing output: 47/ for test: kms_big_fb results: parsing output: 48/ for test: kms_frontbuffer_tracking results: parsing output: 49/ for test: gem_exec_balancer results: parsing output: 50/ for test: kms_dsc results: parsing output: 51/ for test: kms_frontbuffer_tracking results: parsing output: 52/ for test: kms_frontbuffer_tracking results: parsing output: 53/ for test: kms_psr results: parsing output: 54/ for test: kms_frontbuffer_tracking results: parsing output: 55/ for test: gem_exec_create results: parsing output: 56/ for test: syncobj_timeline results: parsing output: 57/ for test: gem_exec_balancer results: parsing output: 58/ for test: kms_addfb_basic results: parsing output: 59/ for test: api_intel_bb results: parsing output: 60/ for test: perf_pmu results: parsing output: 61/ for test: gen9_exec_parse results: parsing output: 62/ for test: kms_plane results: parsing output: 63/ for test: kms_big_fb results: parsing output: 64/ for test: gem_softpin results: parsing output: 65/ for test: gem_mmap results: parsing output: 66/ for test: kms_pm_rpm results: parsing output: 67/ for test: kms_frontbuffer_tracking results: parsing output: 68/ for test: kms_frontbuffer_tracking results: parsing output: 69/ for test: prime_vgem results: parsing output: 70/ for test: gem_eio results: parsing output: 71/ for test: kms_frontbuffer_tracking results: parsing output: 72/ for test: kms_plane_scaling results: parsing output: 73/ for test: gem_mmap_gtt results: parsing output: 74/ for test: kms_frontbuffer_tracking results: parsing output: 75/ for test: kms_ccs results: parsing output: 76/ for test: kms_frontbuffer_tracking results: parsing output: 77/ for test: gem_exec_flush results: parsing output: 78/ for test: kms_frontbuffer_tracking results: parsing output: 79/ for test: kms_frontbuffer_tracking results: parsing output: 80/ for test: kms_psr results: parsing output: 81/ for test: kms_big_fb results: parsing output: 82/ for test: syncobj_basic results: parsing output: 83/ for test: syncobj_timeline results: parsing output: 84/ for test: syncobj_wait results: parsing output: 85/ for test: gem_exec_store results: parsing output: 86/ for test: kms_frontbuffer_tracking results: parsing output: 87/ for test: gem_fence_thrash results: parsing output: 88/ for test: kms_properties results: parsing output: 89/ for test: gem_ctx_engines results: parsing output: 90/ for test: gem_softpin results: parsing output: 91/ for test: gem_ctx_persistence results: parsing output: 92/ for test: gem_exec_reloc results: parsing output: 93/ for test: kms_getfb results: parsing output: 94/ for test: gem_lmem_swapping results: parsing output: 95/ for test: sw_sync results: parsing output: 96/ for test: kms_cursor_crc results: parsing output: 97/ for test: kms_flip_scaled_crc results: parsing output: 98/ for test: kms_chamelium_hpd results: parsing output: 99/ for test: gem_ctx_create results: parsing output: 100/ for test: kms_ccs results: parsing output: 101/ for test: kms_flip_scaled_crc results: parsing output: 102/ for test: kms_psr results: parsing output: 103/ for test: kms_frontbuffer_tracking results: parsing output: 104/ for test: kms_frontbuffer_tracking results: parsing output: 105/ for test: kms_frontbuffer_tracking results: parsing output: 106/ for test: gem_lmem_swapping results: parsing output: 107/ for test: kms_big_fb results: parsing output: 108/ for test: gem_mmap_gtt results: parsing output: 109/ for test: kms_frontbuffer_tracking results: parsing output: 110/ for test: i915_pm_freq_api results: parsing output: 111/ for test: kms_frontbuffer_tracking results: parsing output: 112/ for test: kms_frontbuffer_tracking results: parsing output: 113/ for test: kms_frontbuffer_tracking results: parsing output: 114/ for test: kms_big_fb results: parsing output: 115/ for test: kms_chamelium_frames results: parsing output: 116/ for test: kms_busy results: parsing output: 117/ for test: gem_exec_schedule results: parsing output: 118/ for test: kms_frontbuffer_tracking results: parsing output: 119/ for test: kms_frontbuffer_tracking results: parsing output: 120/ for test: kms_psr results: parsing output: 121/ for test: sw_sync results: parsing output: 122/ for test: kms_cursor_legacy results: parsing output: 123/ for test: kms_pm_dc results: parsing output: 124/ for test: syncobj_wait results: parsing output: 125/ for test: kms_sequence results: parsing output: 126/ for test: kms_cursor_legacy results: parsing output: 127/ for test: syncobj_wait results: parsing output: 128/ for test: perf results: parsing output: 129/ for test: kms_frontbuffer_tracking results: parsing output: 130/ for test: kms_psr2_sf results: parsing output: 131/ for test: kms_ccs results: parsing output: 132/ for test: kms_invalid_mode results: parsing output: 133/ for test: gem_eio results: parsing output: 134/ for test: kms_plane results: parsing output: 135/ for test: perf results: parsing output: 136/ for test: kms_frontbuffer_tracking results: parsing output: 137/ for test: kms_frontbuffer_tracking results: parsing output: 138/ for test: gem_pxp results: parsing output: 139/ for test: gem_exec_gttfill results: parsing output: 140/ for test: kms_frontbuffer_tracking results: parsing output: 141/ for test: kms_psr2_sf results: parsing output: 142/ for test: kms_pm_rpm results: parsing output: 143/ for test: kms_frontbuffer_tracking results: parsing output: 144/ for test: kms_frontbuffer_tracking results: parsing output: 145/ for test: kms_hdr results: parsing output: 146/ for test: kms_pipe_b_c_ivb results: parsing output: 147/ for test: gem_ctx_freq results: parsing output: 148/ for test: syncobj_timeline results: parsing output: 149/ for test: dmabuf_sync_file results: parsing output: 150/ for test: kms_frontbuffer_tracking results: parsing output: 151/ for test: kms_plane_alpha_blend results: parsing output: 152/ for test: gem_mmap_offset results: parsing output: 153/ for test: kms_frontbuffer_tracking results: parsing output: 154/ for test: syncobj_wait Done.