[54.526547] Initializing watchdogs [54.526594] /dev/watchdog0 [54.541355] [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] [54.545795] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [54.548169] [FACT before any test] new: kernel.kmod_is_loaded.i915: true [54.551550] [001/132] (960s left) gem_wait (wait) [54.627104] Starting subtest: wait [54.629512] Starting dynamic subtest: all-engines [55.890078] Dynamic subtest all-engines: SUCCESS (1.262s) [55.900502] Starting dynamic subtest: rcs0 [56.936688] Dynamic subtest rcs0: SUCCESS (1.047s) [56.946847] Starting dynamic subtest: bcs0 [57.983500] Dynamic subtest bcs0: SUCCESS (1.045s) [57.993313] Starting dynamic subtest: vcs0 [59.027993] Dynamic subtest vcs0: SUCCESS (1.044s) [59.038038] Starting dynamic subtest: vcs1 [60.071913] Dynamic subtest vcs1: SUCCESS (1.043s) [60.081378] Starting dynamic subtest: vecs0 [61.116498] Dynamic subtest vecs0: SUCCESS (1.043s) [61.126481] Starting dynamic subtest: ccs0 [62.164335] Dynamic subtest ccs0: SUCCESS (1.047s) [62.167026] Subtest wait: SUCCESS (7.538s) [62.369886] [002/132] (952s left) kms_flip (wf_vblank-ts-check) [62.476088] Starting subtest: wf_vblank-ts-check [62.478351] Starting dynamic subtest: A-eDP1 [71.432837] Dynamic subtest A-eDP1: SUCCESS (8.959s) [71.443230] Starting dynamic subtest: B-eDP1 [80.369771] Dynamic subtest B-eDP1: SUCCESS (8.935s) [80.380656] Starting dynamic subtest: C-eDP1 [89.296192] Dynamic subtest C-eDP1: SUCCESS (8.925s) [89.303306] Starting dynamic subtest: D-eDP1 [98.227055] Dynamic subtest D-eDP1: SUCCESS (8.927s) [98.229746] Subtest wf_vblank-ts-check: SUCCESS (35.754s) [99.472164] [003/132] (915s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-mmap-gtt) [99.571093] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-mmap-gtt [99.575656] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s) [99.695208] [004/132] (915s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-move) [99.794674] Starting subtest: fbc-2p-scndscrn-cur-indfb-move [99.798996] Subtest fbc-2p-scndscrn-cur-indfb-move: SKIP (0.000s) [99.927208] [005/132] (915s left) gem_exec_schedule (fairslice-all) [99.997224] Starting subtest: fairslice-all [102.058842] Subtest fairslice-all: SUCCESS (2.061s) [104.018852] [006/132] (911s left) kms_cursor_legacy (nonblocking-modeset-vs-cursor-atomic) [104.141394] Starting subtest: nonblocking-modeset-vs-cursor-atomic [105.542860] Subtest nonblocking-modeset-vs-cursor-atomic: SUCCESS (1.401s) [106.351208] [007/132] (908s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-180-async-flip) [106.462947] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-180-async-flip [107.098321] Subtest 4-tiled-max-hw-stride-32bpp-rotate-180-async-flip: SUCCESS (0.637s) [107.304784] [008/132] (908s left) gem_userptr_blits (stress-mm-invalidate-close-overlap) [107.375493] Starting subtest: stress-mm-invalidate-close-overlap [109.522615] Subtest stress-mm-invalidate-close-overlap: SUCCESS (2.148s) [109.675962] [009/132] (905s left) kms_psr (fbc-psr2-sprite-plane-move) [109.769643] Starting subtest: fbc-psr2-sprite-plane-move [109.771942] Starting dynamic subtest: eDP-1 [109.776206] Dynamic subtest eDP-1: SKIP (0.000s) [109.780528] Subtest fbc-psr2-sprite-plane-move: SKIP (0.001s) [109.849949] [010/132] (905s left) gem_exec_schedule (u-fairslice) [109.920525] Starting subtest: u-fairslice [109.922527] Starting dynamic subtest: rcs0 [111.929603] Dynamic subtest rcs0: SUCCESS (2.017s) [111.939072] Starting dynamic subtest: bcs0 [113.949055] Dynamic subtest bcs0: SUCCESS (2.017s) [113.957289] Starting dynamic subtest: vcs0 [115.969824] Dynamic subtest vcs0: SUCCESS (2.020s) [115.979344] Starting dynamic subtest: vcs1 [117.985491] Dynamic subtest vcs1: SUCCESS (2.017s) [117.995309] Starting dynamic subtest: vecs0 [120.003083] Dynamic subtest vecs0: SUCCESS (2.017s) [120.012385] Starting dynamic subtest: ccs0 [122.020960] Dynamic subtest ccs0: SUCCESS (2.019s) [122.022933] Subtest u-fairslice: SUCCESS (12.108s) [122.341236] [011/132] (893s left) vgem_basic (dmabuf-mmap) [122.416841] Starting subtest: dmabuf-mmap [122.423287] Subtest dmabuf-mmap: SUCCESS (0.009s) [122.484936] [FACT vgem_basic (dmabuf-mmap)] new: kernel.kmod_is_loaded.vgem: true [122.488861] [012/132] (892s left) gem_workarounds (suspend-resume-context) [122.560795] Starting subtest: suspend-resume-context [138.304292] Subtest suspend-resume-context: SUCCESS (1.302s) [138.453253] [013/132] (877s left) kms_flip (flip-vs-expired-vblank) [138.559239] Starting subtest: flip-vs-expired-vblank [138.561676] Starting dynamic subtest: A-eDP1 [147.283102] Dynamic subtest A-eDP1: SUCCESS (8.723s) [147.293925] Starting dynamic subtest: B-eDP1 [155.920466] Dynamic subtest B-eDP1: SUCCESS (8.635s) [155.930913] Starting dynamic subtest: C-eDP1 [164.548916] Dynamic subtest C-eDP1: SUCCESS (8.627s) [164.562395] Starting dynamic subtest: D-eDP1 [173.188677] Dynamic subtest D-eDP1: SUCCESS (8.638s) [173.193249] Subtest flip-vs-expired-vblank: SUCCESS (34.632s) [174.515928] [014/132] (841s left) kms_psr (fbc-pr-primary-render) [174.609708] Starting subtest: fbc-pr-primary-render [174.613730] Subtest fbc-pr-primary-render: SKIP (0.000s) [174.703822] [015/132] (840s left) perf_pmu (frequency) [174.742465] Starting subtest: frequency [174.747352] Starting dynamic subtest: gt0 [176.929485] Dynamic subtest gt0: SUCCESS (2.179s) [176.940286] Starting dynamic subtest: idle-gt0 [177.434755] Dynamic subtest idle-gt0: SUCCESS (0.505s) [177.446507] Starting dynamic subtest: gt1 [182.356647] Dynamic subtest gt1: SUCCESS (4.918s) [182.367643] Starting dynamic subtest: idle-gt1 [182.860446] Dynamic subtest idle-gt1: SUCCESS (0.505s) [182.863180] Subtest frequency: SUCCESS (8.119s) [182.985011] [016/132] (832s left) gem_exec_schedule (pi-ringfull) [183.163484] Starting subtest: pi-ringfull [183.165565] Starting dynamic subtest: rcs0 [183.194543] Dynamic subtest rcs0: SUCCESS (0.034s) [183.211838] Starting dynamic subtest: bcs0 [183.227111] Dynamic subtest bcs0: SUCCESS (0.032s) [183.239735] Starting dynamic subtest: vcs0 [183.256972] Dynamic subtest vcs0: SUCCESS (0.030s) [183.268548] Starting dynamic subtest: vcs1 [183.285662] Dynamic subtest vcs1: SUCCESS (0.029s) [183.294466] Starting dynamic subtest: vecs0 [183.317200] Dynamic subtest vecs0: SUCCESS (0.031s) [183.329670] Starting dynamic subtest: ccs0 [183.347302] Dynamic subtest ccs0: SUCCESS (0.030s) [183.349549] Subtest pi-ringfull: SUCCESS (0.188s) [183.599809] [017/132] (832s left) i915_query (query-topology-matches-eu-total) [183.652666] Starting subtest: query-topology-matches-eu-total [183.655053] Subtest query-topology-matches-eu-total: SUCCESS (0.000s) [183.780719] [018/132] (831s left) gem_render_copy (x-tiled-to-vebox-yf-tiled) [183.836764] Starting subtest: x-tiled-to-vebox-yf-tiled [183.841440] Subtest x-tiled-to-vebox-yf-tiled: SKIP (0.000s) [184.037105] [019/132] (831s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-mmap-wc) [184.141533] Starting subtest: fbcpsr-rgb565-draw-mmap-wc [190.856709] Subtest fbcpsr-rgb565-draw-mmap-wc: SUCCESS (6.716s) [191.004094] [020/132] (824s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-blt) [191.102618] Starting subtest: psr-1p-primscrn-cur-indfb-draw-blt [197.866962] Subtest psr-1p-primscrn-cur-indfb-draw-blt: SUCCESS (6.766s) [198.026155] [021/132] (817s left) kms_ccs (bad-rotation-90-4-tiled-lnl-ccs) [198.135180] Starting subtest: bad-rotation-90-4-tiled-lnl-ccs [198.139657] Subtest bad-rotation-90-4-tiled-lnl-ccs: SKIP (0.000s) [199.247749] [022/132] (816s left) core_sysfs (read-all-entries) [199.305302] Starting subtest: read-all-entries [199.307739] Subtest read-all-entries: SUCCESS (0.003s) [199.416763] [023/132] (816s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-mmap-gtt) [199.521358] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-mmap-gtt [199.525574] Subtest fbc-2p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s) [199.638527] [024/132] (816s left) gen9_exec_parse (valid-registers) [199.697455] Subtest valid-registers: SKIP (0.000s) [199.784129] [025/132] (816s left) gem_exec_balancer (parallel-ordering) [200.044171] Starting subtest: parallel-ordering [200.988677] Subtest parallel-ordering: SUCCESS (0.945s) [201.156290] [026/132] (814s left) gem_softpin (evict-snoop-interruptible) [201.218840] Starting subtest: evict-snoop-interruptible [201.223414] Subtest evict-snoop-interruptible: SKIP (0.000s) [201.352079] [027/132] (814s left) syncobj_wait (invalid-reset-one-illegal-handle) [201.416554] Starting subtest: invalid-reset-one-illegal-handle [201.418683] Subtest invalid-reset-one-illegal-handle: SUCCESS (0.000s) [201.551102] [028/132] (814s left) gem_render_copy (y-tiled-mc-ccs-to-vebox-yf-tiled) [201.609449] Starting subtest: y-tiled-mc-ccs-to-vebox-yf-tiled [201.613607] Subtest y-tiled-mc-ccs-to-vebox-yf-tiled: SKIP (0.000s) [201.811043] [029/132] (814s left) kms_cursor_legacy (long-nonblocking-modeset-vs-cursor-atomic) [201.925472] Starting subtest: long-nonblocking-modeset-vs-cursor-atomic [219.071464] Subtest long-nonblocking-modeset-vs-cursor-atomic: SUCCESS (17.144s) [219.963076] [030/132] (796s left) kms_cursor_crc (cursor-offscreen-64x21) [220.159942] Starting subtest: cursor-offscreen-64x21 [220.205229] Subtest cursor-offscreen-64x21: SKIP (0.039s) [220.466036] [031/132] (795s left) gem_ctx_engines (invalid-engines) [220.531766] Starting subtest: invalid-engines [220.539487] Subtest invalid-engines: SUCCESS (0.008s) [220.782415] [032/132] (795s left) perf_pmu (busy-no-semaphores) [220.820763] Starting subtest: busy-no-semaphores [220.823156] Starting dynamic subtest: rcs0 [221.405709] Dynamic subtest rcs0: SUCCESS (0.584s) [221.417586] Starting dynamic subtest: bcs0 [221.954719] Dynamic subtest bcs0: SUCCESS (0.547s) [221.966995] Starting dynamic subtest: vcs0 [222.504215] Dynamic subtest vcs0: SUCCESS (0.547s) [222.515957] Starting dynamic subtest: vcs1 [223.875331] Dynamic subtest vcs1: SUCCESS (1.368s) [223.886112] Starting dynamic subtest: vecs0 [225.854854] Dynamic subtest vecs0: SUCCESS (1.978s) [225.866729] Starting dynamic subtest: ccs0 [227.842297] Dynamic subtest ccs0: SUCCESS (1.985s) [227.844820] Subtest busy-no-semaphores: SUCCESS (7.023s) [227.994534] [033/132] (788s left) gem_mmap_gtt (cpuset-basic-small-copy-odd) [228.052390] Subtest cpuset-basic-small-copy-odd: SKIP (0.000s) [228.110565] [034/132] (788s left) kms_big_fb (linear-32bpp-rotate-90) [228.207696] Starting subtest: linear-32bpp-rotate-90 [228.226978] Subtest linear-32bpp-rotate-90: SKIP (0.019s) [228.349661] [035/132] (788s left) kms_pm_rpm (i2c) [230.490725] Starting subtest: i2c [235.536689] Subtest i2c: SUCCESS (5.046s) [235.652491] [036/132] (780s left) kms_frontbuffer_tracking (fbc-2p-primscrn-shrfb-pgflip-blt) [235.759677] Starting subtest: fbc-2p-primscrn-shrfb-pgflip-blt [235.764125] Subtest fbc-2p-primscrn-shrfb-pgflip-blt: SKIP (0.000s) [235.874705] [037/132] (780s left) gem_exec_whisper (basic-normal) [235.948598] Starting subtest: basic-normal [239.548932] Subtest basic-normal: SUCCESS (3.601s) [239.743834] [038/132] (776s left) gem_ctx_persistence (engines-cleanup) [239.805407] Starting subtest: engines-cleanup [239.807726] Starting dynamic subtest: rcs0 [239.902519] Dynamic subtest rcs0: SUCCESS (0.096s) [239.914296] Starting dynamic subtest: bcs0 [239.969500] Dynamic subtest bcs0: SUCCESS (0.064s) [239.979909] Starting dynamic subtest: vcs0 [239.989115] Dynamic subtest vcs0: SUCCESS (0.018s) [239.997711] Starting dynamic subtest: vcs1 [240.105960] Dynamic subtest vcs1: SUCCESS (0.116s) [240.117798] Starting dynamic subtest: vecs0 [240.177515] Dynamic subtest vecs0: SUCCESS (0.070s) [240.189609] Starting dynamic subtest: ccs0 [240.245842] Dynamic subtest ccs0: SUCCESS (0.066s) [240.248441] Subtest engines-cleanup: SUCCESS (0.441s) [240.340504] [039/132] (776s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-mmap-wc) [240.448237] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-mmap-wc [240.452284] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s) [240.569085] [040/132] (776s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-indfb-msflip-blt) [240.662722] Starting subtest: fbcpsr-1p-primscrn-indfb-msflip-blt [247.877584] Subtest fbcpsr-1p-primscrn-indfb-msflip-blt: SUCCESS (7.218s) [248.037935] [041/132] (768s left) kms_chamelium_color (ctm-0-50) [248.137779] Subtest ctm-0-50: SKIP (0.000s) [248.185271] [042/132] (768s left) kms_pipe_b_c_ivb (pipe-b-double-modeset-then-modeset-pipe-c) [248.237719] Subtest pipe-B-double-modeset-then-modeset-pipe-C: SKIP (0.000s) [248.299556] [043/132] (768s left) api_intel_allocator (simple-allocator) [248.353789] Starting subtest: simple-allocator [248.355579] Starting dynamic subtest: basic [248.357838] Dynamic subtest basic: SUCCESS (0.004s) [248.366930] Starting dynamic subtest: parallel-one [248.551970] Dynamic subtest parallel-one: SUCCESS (0.194s) [248.561185] Starting dynamic subtest: print [248.563454] Dynamic subtest print: SUCCESS (0.000s) [248.573140] Starting dynamic subtest: reuse [248.575074] Dynamic subtest reuse: SUCCESS (0.000s) [248.583704] Starting dynamic subtest: reserve [248.585639] Dynamic subtest reserve: SUCCESS (0.000s) [248.594237] Starting dynamic subtest: fork-reopen-allocator [248.596160] Dynamic subtest fork-reopen-allocator: SUCCESS (0.010s) [248.598076] Subtest simple-allocator: SUCCESS (0.214s) [248.726039] [044/132] (768s left) prime_vgem (basic-write) [248.806782] Starting subtest: basic-write [248.814817] Subtest basic-write: SKIP (0.007s) [248.954188] [045/132] (767s left) kms_lease (cursor-implicit-plane) [249.048586] Starting subtest: cursor-implicit-plane [249.050982] Starting dynamic subtest: pipe-A-eDP-1 [249.518520] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.470s) [249.528074] Starting dynamic subtest: pipe-B-eDP-1 [250.652695] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.130s) [250.662843] Starting dynamic subtest: pipe-C-eDP-1 [251.778862] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.128s) [251.790644] Starting dynamic subtest: pipe-D-eDP-1 [252.922417] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.140s) [252.924909] Subtest cursor-implicit-plane: SUCCESS (3.875s) [253.781171] [046/132] (763s left) kms_big_fb (x-tiled-16bpp-rotate-180) [253.892970] Starting subtest: x-tiled-16bpp-rotate-180 [255.093366] Subtest x-tiled-16bpp-rotate-180: SUCCESS (1.200s) [255.229345] [047/132] (761s left) kms_plane_multiple (2x-tiling-4) [255.325716] Starting subtest: 2x-tiling-4 [255.329199] Subtest 2x-tiling-4: SKIP (0.000s) [255.419487] [048/132] (761s left) gem_lmem_swapping (heavy-multi) [255.458504] Subtest heavy-multi: SKIP (0.000s) [255.506725] [049/132] (761s left) kms_fb_coherency (memset-crc) [255.590703] Starting subtest: memset-crc [255.592606] Starting dynamic subtest: mmap-offset-wc [255.968077] Dynamic subtest mmap-offset-wc: SUCCESS (0.379s) [256.267582] Starting dynamic subtest: mmap-offset-uc [262.305636] Dynamic subtest mmap-offset-uc: SUCCESS (6.048s) [262.600531] Subtest memset-crc: SUCCESS (7.007s) [263.449996] [050/132] (753s left) kms_vblank (query-forked) [263.544957] Starting subtest: query-forked [263.547078] Starting dynamic subtest: pipe-A-eDP-1 [265.365142] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.822s) [265.380133] Starting dynamic subtest: pipe-D-eDP-1 [267.838426] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.469s) [267.840779] Subtest query-forked: SUCCESS (4.295s) [268.712147] [051/132] (748s left) gem_eio (in-flight-1us) [268.955383] Starting subtest: in-flight-1us [277.490349] Subtest in-flight-1us: SUCCESS (8.532s) [277.635148] [052/132] (739s left) syncobj_timeline (invalid-multi-wait-unsubmitted-submitted) [277.690101] Starting subtest: invalid-multi-wait-unsubmitted-submitted [277.692454] Subtest invalid-multi-wait-unsubmitted-submitted: SUCCESS (0.000s) [277.814407] [053/132] (739s left) gem_mmap_gtt (big-copy) [277.876466] Subtest big-copy: SKIP (0.000s) [277.942874] [054/132] (739s left) kms_psr (psr2-sprite-plane-onoff) [278.028272] Starting subtest: psr2-sprite-plane-onoff [278.030562] Starting dynamic subtest: eDP-1 [279.750613] Dynamic subtest eDP-1: SUCCESS (1.722s) [279.752838] Subtest psr2-sprite-plane-onoff: SUCCESS (1.723s) [280.605394] [055/132] (736s left) kms_chamelium_frames (dp-crc-fast) [281.000304] Subtest dp-crc-fast: SKIP (0.000s) [281.789727] [056/132] (735s left) gem_ctx_create (basic) [281.857840] Starting subtest: basic [281.860233] Subtest basic: SUCCESS (0.000s) [282.064663] [057/132] (735s left) kms_psr2_sf (pr-cursor-plane-update-sf) [287.088708] Starting subtest: pr-cursor-plane-update-sf [287.093610] Subtest pr-cursor-plane-update-sf: SKIP (0.003s) [287.934976] [058/132] (729s left) dumb_buffer (map-invalid-size) [287.993970] Starting subtest: map-invalid-size [287.996167] Subtest map-invalid-size: SUCCESS (0.000s) [288.123864] [059/132] (729s left) core_debugfs (read-all-entries) [288.175353] Starting subtest: read-all-entries [288.259577] Subtest read-all-entries: SUCCESS (0.082s) [288.346886] [060/132] (729s left) gem_mmap_gtt (coherency) [288.406852] Subtest coherency: SKIP (0.000s) [288.490675] [061/132] (729s left) gem_softpin (softpin) [288.551068] Starting subtest: softpin [320.802502] Subtest softpin: SUCCESS (32.245s) [320.959939] [062/132] (696s left) kms_dither (fb-8bpc-vs-panel-8bpc) [321.052823] Starting subtest: fb-8bpc-vs-panel-8bpc [321.055462] Starting dynamic subtest: pipe-A-eDP-1 [322.486765] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.433s) [322.489194] Subtest fb-8bpc-vs-panel-8bpc: SUCCESS (1.435s) [323.295864] [063/132] (694s left) kms_big_fb (y-tiled-32bpp-rotate-180) [323.390720] Starting subtest: y-tiled-32bpp-rotate-180 [323.395361] Subtest y-tiled-32bpp-rotate-180: SKIP (0.000s) [323.534577] [064/132] (694s left) kms_plane_scaling (2x-scaler-multi-pipe) [323.618868] Starting subtest: 2x-scaler-multi-pipe [323.623351] Subtest 2x-scaler-multi-pipe: SKIP (0.001s) [323.727457] [065/132] (693s left) syncobj_timeline (etime-multi-wait-all-for-submit-unsubmitted-submitted) [323.780522] Starting subtest: etime-multi-wait-all-for-submit-unsubmitted-submitted [323.888223] Subtest etime-multi-wait-all-for-submit-unsubmitted-submitted: SUCCESS (0.108s) [323.987689] [066/132] (693s left) gem_mmap_offset (bad-object) [324.042272] Starting subtest: bad-object [324.044616] Subtest bad-object: SUCCESS (0.001s) [324.186268] [067/132] (693s left) gem_ctx_persistence (saturated-hostile) [324.256389] Starting subtest: saturated-hostile [324.258626] Starting dynamic subtest: rcs0 [325.124395] Dynamic subtest rcs0: SUCCESS (0.867s) [325.137005] Starting dynamic subtest: bcs0 [325.942290] Dynamic subtest bcs0: SUCCESS (0.816s) [325.953575] Starting dynamic subtest: vcs0 [326.765396] Dynamic subtest vcs0: SUCCESS (0.817s) [326.776956] Starting dynamic subtest: vcs1 [327.577717] Dynamic subtest vcs1: SUCCESS (0.811s) [327.589664] Starting dynamic subtest: vecs0 [328.391157] Dynamic subtest vecs0: SUCCESS (0.813s) [328.403974] Starting dynamic subtest: ccs0 [329.246438] Dynamic subtest ccs0: SUCCESS (0.853s) [329.249166] Subtest saturated-hostile: SUCCESS (4.991s) [329.356125] [068/132] (688s left) kms_big_fb (yf-tiled-8bpp-rotate-270) [329.462545] Starting subtest: yf-tiled-8bpp-rotate-270 [329.467050] Subtest yf-tiled-8bpp-rotate-270: SKIP (0.000s) [329.597090] [069/132] (688s left) kms_plane_scaling (planes-upscale-factor-0-25-downscale-factor-0-5) [329.692717] Starting subtest: planes-upscale-factor-0-25-downscale-factor-0-5 [329.694966] Starting dynamic subtest: pipe-A [329.711270] Dynamic subtest pipe-A: SKIP (0.016s) [329.721280] Starting dynamic subtest: pipe-B [329.744587] Dynamic subtest pipe-B: SKIP (0.030s) [329.754248] Starting dynamic subtest: pipe-C [329.774993] Dynamic subtest pipe-C: SKIP (0.030s) [329.784601] Starting dynamic subtest: pipe-D [329.804676] Dynamic subtest pipe-D: SKIP (0.030s) [329.808492] Subtest planes-upscale-factor-0-25-downscale-factor-0-5: SKIP (0.109s) [329.927418] [070/132] (687s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-mmap-gtt) [330.027707] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-mmap-gtt [330.032040] Subtest fbc-1p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s) [330.155760] [071/132] (687s left) kms_frontbuffer_tracking (psr-indfb-scaledprimary) [330.246111] Starting subtest: psr-indfb-scaledprimary [336.063170] Subtest psr-indfb-scaledprimary: SUCCESS (5.816s) [336.215796] [072/132] (681s left) kms_flip_scaled_crc (flip-32bpp-4tile-to-64bpp-4tile-upscaling) [336.313062] Starting subtest: flip-32bpp-4tile-to-64bpp-4tile-upscaling [336.315325] Starting dynamic subtest: pipe-A-default-mode [339.082434] Dynamic subtest pipe-A-default-mode: SUCCESS (2.768s) [339.084848] Subtest flip-32bpp-4tile-to-64bpp-4tile-upscaling: SUCCESS (2.770s) [339.932761] [073/132] (678s left) kms_ccs (crc-primary-suspend-y-tiled-ccs) [340.031067] Starting subtest: crc-primary-suspend-y-tiled-ccs [340.033323] Starting dynamic subtest: pipe-A-eDP-1 [340.042260] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [340.052483] Starting dynamic subtest: pipe-B-eDP-1 [340.061169] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [340.070926] Starting dynamic subtest: pipe-C-eDP-1 [340.079098] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [340.088320] Starting dynamic subtest: pipe-D-eDP-1 [340.096617] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [340.100725] Subtest crc-primary-suspend-y-tiled-ccs: SKIP (0.005s) [342.228602] [074/132] (675s left) kms_psr (psr-sprite-render) [342.330153] Starting subtest: psr-sprite-render [342.332468] Starting dynamic subtest: eDP-1 [344.126135] Dynamic subtest eDP-1: SUCCESS (1.795s) [344.128490] Subtest psr-sprite-render: SUCCESS (1.796s) [344.976940] [075/132] (673s left) sysfs_timeslice_duration (idempotent) [345.043347] Starting subtest: idempotent [345.045651] Starting dynamic subtest: vecs0 [345.047780] Dynamic subtest vecs0: SUCCESS (0.000s) [345.058115] Starting dynamic subtest: ccs0 [345.060240] Dynamic subtest ccs0: SUCCESS (0.000s) [345.070366] Starting dynamic subtest: vcs0 [345.072508] Dynamic subtest vcs0: SUCCESS (0.000s) [345.082034] Starting dynamic subtest: bcs0 [345.084141] Dynamic subtest bcs0: SUCCESS (0.000s) [345.093448] Starting dynamic subtest: rcs0 [345.095502] Dynamic subtest rcs0: SUCCESS (0.000s) [345.105565] Starting dynamic subtest: vcs1 [345.108085] Dynamic subtest vcs1: SUCCESS (0.000s) [345.110500] Subtest idempotent: SUCCESS (0.007s) [345.199304] [076/132] (672s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-render) [345.295190] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-render [352.165373] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-render: SUCCESS (6.871s) [352.362288] [077/132] (665s left) gem_spin_batch (spin-each) [352.431352] Starting subtest: spin-each [355.699695] Subtest spin-each: SUCCESS (3.262s) [356.464607] [078/132] (661s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-mmap-wc) [356.580994] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-mmap-wc [356.585127] Subtest fbc-2p-scndscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s) [356.705005] [079/132] (661s left) kms_async_flips (basic-modeset-with-all-modifiers-formats) [356.793647] Starting subtest: basic-modeset-with-all-modifiers-formats [357.170568] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-XRGB8888 [357.972963] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-XRGB8888: SUCCESS (0.802s) [357.982514] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-XRGB2101010 [357.995196] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-XRGB2101010: SUCCESS (0.021s) [358.004663] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-XRGB16161616F [358.017150] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-XRGB16161616F: SUCCESS (0.022s) [358.026599] Starting dynamic subtest: pipe-A-eDP-1-4-RGB565 [358.162085] Dynamic subtest pipe-A-eDP-1-4-RGB565: SUCCESS (0.144s) [358.174063] Starting dynamic subtest: pipe-A-eDP-1-4-XRGB8888 [358.184159] Dynamic subtest pipe-A-eDP-1-4-XRGB8888: SUCCESS (0.021s) [358.200551] Starting dynamic subtest: pipe-A-eDP-1-4-XRGB2101010 [358.206397] Dynamic subtest pipe-A-eDP-1-4-XRGB2101010: SUCCESS (0.021s) [358.216688] Starting dynamic subtest: pipe-A-eDP-1-4-XRGB16161616F [358.228657] Dynamic subtest pipe-A-eDP-1-4-XRGB16161616F: SUCCESS (0.021s) [358.240324] Starting dynamic subtest: pipe-A-eDP-1-4-YUYV [358.250928] Dynamic subtest pipe-A-eDP-1-4-YUYV: SUCCESS (0.022s) [358.260509] Starting dynamic subtest: pipe-A-eDP-1-4-Y210 [358.273137] Dynamic subtest pipe-A-eDP-1-4-Y210: SUCCESS (0.021s) [358.282333] Starting dynamic subtest: pipe-A-eDP-1-4-XYUV8888 [358.295336] Dynamic subtest pipe-A-eDP-1-4-XYUV8888: SUCCESS (0.021s) [358.304659] Starting dynamic subtest: pipe-A-eDP-1-4-XV30 [358.317287] Dynamic subtest pipe-A-eDP-1-4-XV30: SUCCESS (0.022s) [358.328958] Starting dynamic subtest: pipe-A-eDP-1-4-XV36 [358.339458] Dynamic subtest pipe-A-eDP-1-4-XV36: SUCCESS (0.021s) [358.349115] Starting dynamic subtest: pipe-A-eDP-1-x-RGB565 [358.495267] Dynamic subtest pipe-A-eDP-1-x-RGB565: SUCCESS (0.155s) [358.505080] Starting dynamic subtest: pipe-A-eDP-1-x-XRGB8888 [358.517255] Dynamic subtest pipe-A-eDP-1-x-XRGB8888: SUCCESS (0.021s) [358.527040] Starting dynamic subtest: pipe-A-eDP-1-x-XRGB2101010 [358.539987] Dynamic subtest pipe-A-eDP-1-x-XRGB2101010: SUCCESS (0.021s) [358.550151] Starting dynamic subtest: pipe-A-eDP-1-x-XRGB16161616F [358.561701] Dynamic subtest pipe-A-eDP-1-x-XRGB16161616F: SUCCESS (0.021s) [358.571373] Starting dynamic subtest: pipe-A-eDP-1-x-YUYV [358.584234] Dynamic subtest pipe-A-eDP-1-x-YUYV: SUCCESS (0.021s) [358.593697] Starting dynamic subtest: pipe-A-eDP-1-x-Y210 [358.606175] Dynamic subtest pipe-A-eDP-1-x-Y210: SUCCESS (0.022s) [358.615793] Starting dynamic subtest: pipe-A-eDP-1-x-XYUV8888 [358.628430] Dynamic subtest pipe-A-eDP-1-x-XYUV8888: SUCCESS (0.021s) [358.637778] Starting dynamic subtest: pipe-A-eDP-1-x-XV30 [358.650999] Dynamic subtest pipe-A-eDP-1-x-XV30: SUCCESS (0.021s) [358.661045] Starting dynamic subtest: pipe-A-eDP-1-x-XV36 [358.673235] Dynamic subtest pipe-A-eDP-1-x-XV36: SUCCESS (0.021s) [358.682687] Starting dynamic subtest: pipe-A-eDP-1-linear-RGB565 [358.828834] Dynamic subtest pipe-A-eDP-1-linear-RGB565: SUCCESS (0.155s) [358.838278] Starting dynamic subtest: pipe-A-eDP-1-linear-XRGB8888 [358.851036] Dynamic subtest pipe-A-eDP-1-linear-XRGB8888: SUCCESS (0.021s) [358.860823] Starting dynamic subtest: pipe-A-eDP-1-linear-XRGB2101010 [358.873200] Dynamic subtest pipe-A-eDP-1-linear-XRGB2101010: SUCCESS (0.022s) [358.882822] Starting dynamic subtest: pipe-A-eDP-1-linear-XRGB16161616F [358.895415] Dynamic subtest pipe-A-eDP-1-linear-XRGB16161616F: SUCCESS (0.021s) [358.904529] Starting dynamic subtest: pipe-A-eDP-1-linear-YUYV [358.917404] Dynamic subtest pipe-A-eDP-1-linear-YUYV: SUCCESS (0.021s) [358.926559] Starting dynamic subtest: pipe-A-eDP-1-linear-Y210 [358.939782] Dynamic subtest pipe-A-eDP-1-linear-Y210: SUCCESS (0.022s) [358.949381] Starting dynamic subtest: pipe-A-eDP-1-linear-XYUV8888 [358.962030] Dynamic subtest pipe-A-eDP-1-linear-XYUV8888: SUCCESS (0.022s) [358.971601] Starting dynamic subtest: pipe-A-eDP-1-linear-XV30 [358.984339] Dynamic subtest pipe-A-eDP-1-linear-XV30: SUCCESS (0.022s) [358.993428] Starting dynamic subtest: pipe-A-eDP-1-linear-XV36 [359.006429] Dynamic subtest pipe-A-eDP-1-linear-XV36: SUCCESS (0.021s) [359.401305] Subtest basic-modeset-with-all-modifiers-formats: SUCCESS (2.609s) [360.181905] [080/132] (658s left) kms_multipipe_modeset (basic-max-pipe-crc-check) [360.288104] Starting subtest: basic-max-pipe-crc-check [360.292531] Subtest basic-max-pipe-crc-check: SKIP (0.000s) [360.336495] [081/132] (658s left) kms_cursor_crc (cursor-random-max-size) [360.639728] Starting subtest: cursor-random-max-size [360.646420] Subtest cursor-random-max-size: SKIP (0.000s) [360.800974] [082/132] (657s left) syncobj_timeline (multi-wait-for-submit-available-unsubmitted-submitted) [360.859869] Starting subtest: multi-wait-for-submit-available-unsubmitted-submitted [360.862289] Subtest multi-wait-for-submit-available-unsubmitted-submitted: SUCCESS (0.000s) [360.998791] [083/132] (657s left) kms_cursor_legacy (2x-cursor-vs-flip-legacy) [361.111206] Starting subtest: 2x-cursor-vs-flip-legacy [361.114930] Subtest 2x-cursor-vs-flip-legacy: SKIP (0.001s) [361.270386] [084/132] (657s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-render) [361.376633] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-render [368.610575] Subtest psr-1p-primscrn-pri-shrfb-draw-render: SUCCESS (7.235s) [368.771895] [085/132] (649s left) syncobj_timeline (signal-array) [368.828014] Starting subtest: signal-array [368.830603] Subtest signal-array: SUCCESS (0.001s) [368.944572] [086/132] (649s left) kms_cursor_edge_walk (128x128-left-edge) [369.041981] Starting subtest: 128x128-left-edge [369.044109] Starting dynamic subtest: pipe-A-eDP-1 [372.540293] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.496s) [372.550296] Starting dynamic subtest: pipe-D-eDP-1 [375.655890] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.115s) [375.658016] Subtest 128x128-left-edge: SUCCESS (6.614s) [376.503207] [087/132] (642s left) kms_plane (plane-position-hole) [376.590193] Starting subtest: plane-position-hole [377.096891] Starting dynamic subtest: pipe-A-plane-1 [378.336965] Dynamic subtest pipe-A-plane-1: SUCCESS (1.239s) [378.347106] Starting dynamic subtest: pipe-A-plane-2 [379.558241] Dynamic subtest pipe-A-plane-2: SUCCESS (1.222s) [379.569120] Starting dynamic subtest: pipe-A-plane-3 [380.803347] Dynamic subtest pipe-A-plane-3: SUCCESS (1.242s) [380.813358] Starting dynamic subtest: pipe-A-plane-4 [382.033335] Dynamic subtest pipe-A-plane-4: SUCCESS (1.229s) [382.043920] Starting dynamic subtest: pipe-A-plane-5 [382.057529] Dynamic subtest pipe-A-plane-5: SUCCESS (0.023s) [383.189531] Starting dynamic subtest: pipe-B-plane-1 [384.406106] Dynamic subtest pipe-B-plane-1: SUCCESS (1.224s) [384.416197] Starting dynamic subtest: pipe-B-plane-2 [385.647956] Dynamic subtest pipe-B-plane-2: SUCCESS (1.241s) [385.658854] Starting dynamic subtest: pipe-B-plane-3 [386.871570] Dynamic subtest pipe-B-plane-3: SUCCESS (1.223s) [386.884403] Starting dynamic subtest: pipe-B-plane-4 [388.153079] Dynamic subtest pipe-B-plane-4: SUCCESS (1.277s) [388.165572] Starting dynamic subtest: pipe-B-plane-5 [388.177164] Dynamic subtest pipe-B-plane-5: SUCCESS (0.023s) [388.179499] Subtest plane-position-hole: SUCCESS (11.585s) [389.042706] [088/132] (629s left) kms_addfb_basic (bad-pitch-32) [389.108503] Starting subtest: bad-pitch-32 [389.110653] Subtest bad-pitch-32: SUCCESS (0.000s) [389.272486] [089/132] (629s left) gem_readwrite (beyond-eob) [389.331962] Subtest beyond-EOB: SKIP (0.000s) [389.395069] [090/132] (629s left) kms_psr2_sf (fbc-pr-overlay-plane-update-sf-dmg-area) [394.381435] Starting subtest: fbc-pr-overlay-plane-update-sf-dmg-area [394.386008] Subtest fbc-pr-overlay-plane-update-sf-dmg-area: SKIP (0.003s) [395.260840] [091/132] (623s left) i915_module_load (resize-bar) [395.300311] Starting subtest: resize-bar [395.307261] Subtest resize-bar: SKIP (0.006s) [395.357285] [092/132] (623s left) gen9_exec_parse (bb-secure) [395.421252] Subtest bb-secure: SKIP (0.000s) [395.484015] [093/132] (623s left) kms_flip_scaled_crc (flip-32bpp-yftile-to-64bpp-yftile-upscaling) [395.573982] Starting subtest: flip-32bpp-yftile-to-64bpp-yftile-upscaling [395.576205] Starting dynamic subtest: pipe-A-default-mode [395.865821] Dynamic subtest pipe-A-default-mode: SKIP (0.288s) [395.870463] Subtest flip-32bpp-yftile-to-64bpp-yftile-upscaling: SKIP (0.290s) [396.710247] [094/132] (622s left) kms_psr (psr2-cursor-mmap-cpu) [396.797391] Starting subtest: psr2-cursor-mmap-cpu [396.799611] Starting dynamic subtest: eDP-1 [398.463661] Dynamic subtest eDP-1: SUCCESS (1.667s) [398.465985] Subtest psr2-cursor-mmap-cpu: SUCCESS (1.668s) [399.269274] [095/132] (619s left) kms_flip (flip-vs-panning-interruptible) [399.367973] Starting subtest: flip-vs-panning-interruptible [399.370135] Starting dynamic subtest: A-eDP1 [408.071876] Dynamic subtest A-eDP1: SUCCESS (8.702s) [408.084165] Starting dynamic subtest: B-eDP1 [416.805553] Dynamic subtest B-eDP1: SUCCESS (8.731s) [416.818077] Starting dynamic subtest: C-eDP1 [425.522102] Dynamic subtest C-eDP1: SUCCESS (8.715s) [425.533364] Starting dynamic subtest: D-eDP1 [434.248551] Dynamic subtest D-eDP1: SUCCESS (8.725s) [434.253219] Subtest flip-vs-panning-interruptible: SUCCESS (34.883s) [435.443413] [096/132] (583s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-mmap-wc) [435.543570] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-mmap-wc [435.548185] Subtest psr-2p-scndscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s) [435.673972] [097/132] (583s left) gem_mmap_gtt (medium-copy-xy) [435.730960] Subtest medium-copy-XY: SKIP (0.000s) [435.796642] [098/132] (583s left) kms_psr (fbc-psr-no-drrs) [435.883090] Starting subtest: fbc-psr-no-drrs [435.885386] Starting dynamic subtest: eDP-1 [435.889541] Dynamic subtest eDP-1: SKIP (0.000s) [435.893633] Subtest fbc-psr-no-drrs: SKIP (0.001s) [435.969667] [099/132] (583s left) gem_userptr_blits (sync-overlap) [436.035908] Starting subtest: sync-overlap [436.037795] Subtest sync-overlap: SUCCESS (0.000s) [436.167785] [100/132] (583s left) kms_flip_scaled_crc (flip-64bpp-yftile-to-16bpp-yftile-upscaling) [436.260351] Starting subtest: flip-64bpp-yftile-to-16bpp-yftile-upscaling [436.262668] Starting dynamic subtest: pipe-A-default-mode [436.550549] Dynamic subtest pipe-A-default-mode: SKIP (0.286s) [436.560499] Subtest flip-64bpp-yftile-to-16bpp-yftile-upscaling: SKIP (0.288s) [437.378626] [101/132] (581s left) kms_content_protection (legacy) [437.523190] Starting subtest: legacy [437.527295] Subtest legacy: SKIP (0.000s) [437.662993] [102/132] (581s left) gem_exec_fence (syncobj-import) [438.114760] Starting subtest: syncobj-import [438.117297] Subtest syncobj-import: SUCCESS (0.006s) [439.455897] [103/132] (579s left) kms_flip (bo-too-big-interruptible) [439.547201] Starting subtest: bo-too-big-interruptible [439.549511] Starting dynamic subtest: A-eDP1 [440.804864] Dynamic subtest A-eDP1: SUCCESS (1.256s) [440.814823] Starting dynamic subtest: B-eDP1 [442.039603] Dynamic subtest B-eDP1: SUCCESS (1.234s) [442.051340] Starting dynamic subtest: C-eDP1 [443.290986] Dynamic subtest C-eDP1: SUCCESS (1.249s) [443.302724] Starting dynamic subtest: D-eDP1 [444.529647] Dynamic subtest D-eDP1: SUCCESS (1.238s) [444.532092] Subtest bo-too-big-interruptible: SUCCESS (4.985s) [445.757518] [104/132] (573s left) kms_ccs (crc-sprite-planes-basic-4-tiled-mtl-rc-ccs) [445.847090] Starting subtest: crc-sprite-planes-basic-4-tiled-mtl-rc-ccs [445.849490] Starting dynamic subtest: pipe-A-eDP-1 [446.271627] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.396s) [446.283479] Starting dynamic subtest: pipe-B-eDP-1 [447.631044] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.359s) [447.643538] Starting dynamic subtest: pipe-C-eDP-1 [449.066958] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.433s) [449.077681] Starting dynamic subtest: pipe-D-eDP-1 [450.381012] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.314s) [450.383263] Subtest crc-sprite-planes-basic-4-tiled-mtl-rc-ccs: SUCCESS (4.506s) [451.593269] [105/132] (567s left) perf (global-sseu-config) [451.737631] Starting subtest: global-sseu-config [451.742197] Subtest global-sseu-config: SKIP (0.000s) [451.783197] [106/132] (567s left) gem_mmap (basic) [451.837171] Subtest basic: SKIP (0.000s) [451.905182] [107/132] (567s left) kms_vrr (flip-dpms) [452.000865] Starting subtest: flip-dpms [452.007199] Subtest flip-dpms: SKIP (0.000s) [452.088741] [108/132] (567s left) kms_addfb_basic (bad-pitch-63) [452.146796] Starting subtest: bad-pitch-63 [452.148874] Subtest bad-pitch-63: SUCCESS (0.000s) [452.320875] [109/132] (567s left) i915_suspend (fence-restore-tiled2untiled) [452.380855] Starting subtest: fence-restore-tiled2untiled [452.385582] Subtest fence-restore-tiled2untiled: SKIP (0.000s) [452.519507] [110/132] (567s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-shrfb-draw-mmap-wc) [452.617052] Starting subtest: psr-1p-offscreen-pri-shrfb-draw-mmap-wc [459.163865] Subtest psr-1p-offscreen-pri-shrfb-draw-mmap-wc: SUCCESS (6.550s) [459.322550] [111/132] (560s left) kms_sequence (queue-idle) [459.418787] Starting subtest: queue-idle [459.421307] Starting dynamic subtest: pipe-A-eDP-1 [461.207463] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.789s) [461.218168] Starting dynamic subtest: pipe-B-eDP-1 [463.666649] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.455s) [463.677528] Starting dynamic subtest: pipe-C-eDP-1 [466.081015] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.413s) [466.091764] Starting dynamic subtest: pipe-D-eDP-1 [468.510708] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.429s) [468.512876] Subtest queue-idle: SUCCESS (9.091s) [469.342349] [112/132] (550s left) gem_exec_balancer (bonded-chain) [469.412644] Starting subtest: bonded-chain [476.409614] Subtest bonded-chain: SUCCESS (6.995s) [476.759002] [113/132] (542s left) perf (oa-exponents) [476.857575] Starting subtest: oa-exponents [476.859966] Starting dynamic subtest: 0-rcs0 [478.645600] Dynamic subtest 0-rcs0: SUCCESS (1.786s) [478.655620] Starting dynamic subtest: 1-vcs0 [480.476106] Dynamic subtest 1-vcs0: SUCCESS (1.829s) [480.478498] Subtest oa-exponents: SUCCESS (3.618s) [480.527599] [114/132] (539s left) kms_cursor_legacy (short-flip-after-cursor-toggle) [480.651331] Starting subtest: short-flip-after-cursor-toggle [481.588660] Subtest short-flip-after-cursor-toggle: SUCCESS (0.936s) [482.476315] [115/132] (537s left) kms_chamelium_hpd (vga-hpd-fast) [482.869409] Subtest vga-hpd-fast: SKIP (0.000s) [483.660333] [116/132] (536s left) kms_atomic (crtc-invalid-params) [483.753947] Starting subtest: crtc-invalid-params [483.756112] Starting dynamic subtest: pipe-A-eDP-1 [484.107565] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.354s) [484.109932] Subtest crtc-invalid-params: SUCCESS (0.356s) [484.925829] [117/132] (534s left) kms_prime (d3hot) [485.005981] Subtest D3hot: SKIP (0.000s) [485.105439] [118/132] (534s left) gem_mmap_offset (pf-nonblock) [485.158291] Starting subtest: pf-nonblock [485.162942] Subtest pf-nonblock: SUCCESS (0.007s) [485.267710] [119/132] (534s left) syncobj_timeline (invalid-multi-wait-all-unsubmitted-signaled) [485.313387] Starting subtest: invalid-multi-wait-all-unsubmitted-signaled [485.315564] Subtest invalid-multi-wait-all-unsubmitted-signaled: SUCCESS (0.000s) [485.434713] [120/132] (534s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-mmap-cpu) [485.539390] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-mmap-cpu [485.543484] Subtest fbc-2p-scndscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s) [485.671010] [121/132] (534s left) gem_madvise (dontneed-after-mmap) [485.705260] Starting subtest: dontneed-after-mmap [485.731662] Subtest dontneed-after-mmap: SUCCESS (0.025s) [485.857503] [122/132] (534s left) perf (polling-small-buf) [485.953740] Starting subtest: polling-small-buf [486.040457] Subtest polling-small-buf: SUCCESS (0.088s) [486.090350] [123/132] (534s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-blt) [486.184267] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-blt [486.187712] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-blt: SKIP (0.000s) [486.338878] [124/132] (533s left) gem_eio (wait-10ms) [486.557389] Starting subtest: wait-10ms [486.888892] Subtest wait-10ms: SUCCESS (0.330s) [487.075293] [125/132] (533s left) kms_ccs (crc-primary-basic-y-tiled-ccs) [487.168702] Starting subtest: crc-primary-basic-y-tiled-ccs [487.170462] Starting dynamic subtest: pipe-A-eDP-1 [487.188926] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [487.202406] Starting dynamic subtest: pipe-B-eDP-1 [487.219386] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [487.228398] Starting dynamic subtest: pipe-C-eDP-1 [487.245546] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [487.254430] Starting dynamic subtest: pipe-D-eDP-1 [487.272497] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [487.276098] Subtest crc-primary-basic-y-tiled-ccs: SKIP (0.006s) [489.489450] [126/132] (530s left) gem_exec_alignment (pi) [489.555560] Starting subtest: pi [540.677785] Subtest pi: SUCCESS (51.116s) [541.635725] [127/132] (478s left) kms_invalid_mode (zero-clock) [541.777239] Starting subtest: zero-clock [541.779529] Starting dynamic subtest: pipe-A-eDP-1 [542.060709] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.284s) [542.071832] Starting dynamic subtest: pipe-B-eDP-1 [542.074137] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s) [542.084262] Starting dynamic subtest: pipe-C-eDP-1 [542.086170] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s) [542.095664] Starting dynamic subtest: pipe-D-eDP-1 [542.097838] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s) [542.099772] Subtest zero-clock: SUCCESS (0.290s) [542.929271] [128/132] (477s left) syncobj_wait (wait-all-delayed-signal) [542.997628] Starting subtest: wait-all-delayed-signal [543.099947] Subtest wait-all-delayed-signal: SUCCESS (0.102s) [543.202122] [129/132] (477s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip) [543.306107] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip [544.207871] Subtest x-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip: SUCCESS (0.904s) [544.415934] [130/132] (476s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-pwrite) [544.527324] Starting subtest: psr-2p-primscrn-spr-indfb-draw-pwrite [544.531463] Subtest psr-2p-primscrn-spr-indfb-draw-pwrite: SKIP (0.000s) [544.676864] [131/132] (475s left) kms_busy (basic) [544.774419] Starting subtest: basic [544.776665] Starting dynamic subtest: flip [545.371490] Dynamic subtest flip: SUCCESS (0.595s) [545.388495] Starting dynamic subtest: modeset [548.842006] Dynamic subtest modeset: SUCCESS (3.472s) [548.844363] Subtest basic: SUCCESS (4.070s) [549.659006] [132/132] (470s left) i915_pm_rpm (gem-idle) [551.490941] Starting subtest: gem-idle [557.688551] Subtest gem-idle: SUCCESS (6.199s) [558.024837] Closing watchdogs results: parsing output: 0/ for test: gem_wait results: parsing output: 1/ for test: kms_flip results: parsing output: 2/ for test: kms_frontbuffer_tracking 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_legacy results: parsing output: 6/ for test: kms_big_fb results: parsing output: 7/ for test: gem_userptr_blits results: parsing output: 8/ for test: kms_psr results: parsing output: 9/ for test: gem_exec_schedule results: parsing output: 10/ for test: vgem_basic results: parsing output: 11/ for test: gem_workarounds results: parsing output: 12/ for test: kms_flip results: parsing output: 13/ for test: kms_psr results: parsing output: 14/ for test: perf_pmu results: parsing output: 15/ for test: gem_exec_schedule results: parsing output: 16/ for test: i915_query results: parsing output: 17/ for test: gem_render_copy results: parsing output: 18/ for test: kms_frontbuffer_tracking results: parsing output: 19/ for test: kms_frontbuffer_tracking results: parsing output: 20/ for test: kms_ccs results: parsing output: 21/ for test: core_sysfs results: parsing output: 22/ for test: kms_frontbuffer_tracking results: parsing output: 23/ for test: gen9_exec_parse results: parsing output: 24/ for test: gem_exec_balancer results: parsing output: 25/ for test: gem_softpin results: parsing output: 26/ for test: syncobj_wait results: parsing output: 27/ for test: gem_render_copy results: parsing output: 28/ for test: kms_cursor_legacy results: parsing output: 29/ for test: kms_cursor_crc results: parsing output: 30/ for test: gem_ctx_engines results: parsing output: 31/ for test: perf_pmu results: parsing output: 32/ for test: gem_mmap_gtt results: parsing output: 33/ for test: kms_big_fb results: parsing output: 34/ for test: kms_pm_rpm results: parsing output: 35/ for test: kms_frontbuffer_tracking results: parsing output: 36/ for test: gem_exec_whisper results: parsing output: 37/ for test: gem_ctx_persistence results: parsing output: 38/ for test: kms_frontbuffer_tracking results: parsing output: 39/ for test: kms_frontbuffer_tracking results: parsing output: 40/ for test: kms_chamelium_color results: parsing output: 41/ for test: kms_pipe_b_c_ivb results: parsing output: 42/ for test: api_intel_allocator results: parsing output: 43/ for test: prime_vgem results: parsing output: 44/ for test: kms_lease results: parsing output: 45/ for test: kms_big_fb results: parsing output: 46/ for test: kms_plane_multiple results: parsing output: 47/ for test: gem_lmem_swapping results: parsing output: 48/ for test: kms_fb_coherency results: parsing output: 49/ for test: kms_vblank results: parsing output: 50/ for test: gem_eio results: parsing output: 51/ for test: syncobj_timeline results: parsing output: 52/ for test: gem_mmap_gtt results: parsing output: 53/ for test: kms_psr results: parsing output: 54/ for test: kms_chamelium_frames results: parsing output: 55/ for test: gem_ctx_create results: parsing output: 56/ for test: kms_psr2_sf results: parsing output: 57/ for test: dumb_buffer results: parsing output: 58/ for test: core_debugfs results: parsing output: 59/ for test: gem_mmap_gtt results: parsing output: 60/ for test: gem_softpin results: parsing output: 61/ for test: kms_dither results: parsing output: 62/ for test: kms_big_fb results: parsing output: 63/ for test: kms_plane_scaling results: parsing output: 64/ for test: syncobj_timeline results: parsing output: 65/ for test: gem_mmap_offset results: parsing output: 66/ for test: gem_ctx_persistence results: parsing output: 67/ for test: kms_big_fb results: parsing output: 68/ for test: kms_plane_scaling results: parsing output: 69/ for test: kms_frontbuffer_tracking results: parsing output: 70/ for test: kms_frontbuffer_tracking results: parsing output: 71/ for test: kms_flip_scaled_crc results: parsing output: 72/ for test: kms_ccs results: parsing output: 73/ for test: kms_psr results: parsing output: 74/ for test: sysfs_timeslice_duration results: parsing output: 75/ for test: kms_frontbuffer_tracking results: parsing output: 76/ for test: gem_spin_batch results: parsing output: 77/ for test: kms_frontbuffer_tracking results: parsing output: 78/ for test: kms_async_flips results: parsing output: 79/ for test: kms_multipipe_modeset results: parsing output: 80/ for test: kms_cursor_crc results: parsing output: 81/ for test: syncobj_timeline results: parsing output: 82/ for test: kms_cursor_legacy results: parsing output: 83/ for test: kms_frontbuffer_tracking results: parsing output: 84/ for test: syncobj_timeline results: parsing output: 85/ for test: kms_cursor_edge_walk results: parsing output: 86/ for test: kms_plane results: parsing output: 87/ for test: kms_addfb_basic results: parsing output: 88/ for test: gem_readwrite results: parsing output: 89/ for test: kms_psr2_sf results: parsing output: 90/ for test: i915_module_load results: parsing output: 91/ for test: gen9_exec_parse results: parsing output: 92/ for test: kms_flip_scaled_crc results: parsing output: 93/ for test: kms_psr results: parsing output: 94/ for test: kms_flip results: parsing output: 95/ for test: kms_frontbuffer_tracking results: parsing output: 96/ for test: gem_mmap_gtt results: parsing output: 97/ for test: kms_psr results: parsing output: 98/ for test: gem_userptr_blits results: parsing output: 99/ for test: kms_flip_scaled_crc results: parsing output: 100/ for test: kms_content_protection results: parsing output: 101/ for test: gem_exec_fence results: parsing output: 102/ for test: kms_flip results: parsing output: 103/ for test: kms_ccs results: parsing output: 104/ for test: perf results: parsing output: 105/ for test: gem_mmap results: parsing output: 106/ for test: kms_vrr results: parsing output: 107/ for test: kms_addfb_basic results: parsing output: 108/ for test: i915_suspend results: parsing output: 109/ for test: kms_frontbuffer_tracking results: parsing output: 110/ for test: kms_sequence results: parsing output: 111/ for test: gem_exec_balancer results: parsing output: 112/ for test: perf results: parsing output: 113/ for test: kms_cursor_legacy results: parsing output: 114/ for test: kms_chamelium_hpd results: parsing output: 115/ for test: kms_atomic results: parsing output: 116/ for test: kms_prime results: parsing output: 117/ for test: gem_mmap_offset results: parsing output: 118/ for test: syncobj_timeline results: parsing output: 119/ for test: kms_frontbuffer_tracking results: parsing output: 120/ for test: gem_madvise results: parsing output: 121/ for test: perf results: parsing output: 122/ for test: kms_frontbuffer_tracking results: parsing output: 123/ for test: gem_eio results: parsing output: 124/ for test: kms_ccs results: parsing output: 125/ for test: gem_exec_alignment results: parsing output: 126/ for test: kms_invalid_mode results: parsing output: 127/ for test: syncobj_wait results: parsing output: 128/ for test: kms_big_fb results: parsing output: 129/ for test: kms_frontbuffer_tracking results: parsing output: 130/ for test: kms_busy results: parsing output: 131/ for test: i915_pm_rpm Done.