[57.803896] Initializing watchdogs [57.803939] /dev/watchdog0 [57.817322] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:7d55 Intel Meteorlake (Gen12) Meteor Lake-P [Intel Arc Graphics] [57.821377] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [57.823479] [FACT before any test] new: kernel.kmod_is_loaded.i915: true [57.826980] [001/132] (960s left) kms_psr (fbc-psr2-dpms) [57.948927] Starting subtest: fbc-psr2-dpms [57.950901] Starting dynamic subtest: eDP-1 [57.955136] Dynamic subtest eDP-1: SKIP (0.000s) [57.959313] Subtest fbc-psr2-dpms: SKIP (0.000s) [58.040824] [002/132] (960s left) kms_frontbuffer_tracking (fbc-2p-primscrn-shrfb-pgflip-blt) [58.140466] Starting subtest: fbc-2p-primscrn-shrfb-pgflip-blt [58.144633] Subtest fbc-2p-primscrn-shrfb-pgflip-blt: SKIP (0.000s) [58.271079] [003/132] (960s left) perf_pmu (idle-no-semaphores) [58.312970] Starting subtest: idle-no-semaphores [58.315441] Starting dynamic subtest: rcs0 [58.877826] Dynamic subtest rcs0: SUCCESS (0.561s) [58.888752] Starting dynamic subtest: bcs0 [59.394345] Dynamic subtest bcs0: SUCCESS (0.516s) [59.404230] Starting dynamic subtest: vcs0 [59.926211] Dynamic subtest vcs0: SUCCESS (0.530s) [59.941062] Starting dynamic subtest: vcs1 [60.444681] Dynamic subtest vcs1: SUCCESS (0.517s) [60.455218] Starting dynamic subtest: vecs0 [60.963270] Dynamic subtest vecs0: SUCCESS (0.517s) [60.973823] Starting dynamic subtest: ccs0 [61.480440] Dynamic subtest ccs0: SUCCESS (0.515s) [61.483076] Subtest idle-no-semaphores: SUCCESS (3.167s) [61.622235] [004/132] (956s left) gem_spin_batch (legacy) [61.694426] Starting subtest: legacy [61.696827] Starting dynamic subtest: default [64.932073] Dynamic subtest default: SUCCESS (3.233s) [64.942339] Starting dynamic subtest: render [68.157362] Dynamic subtest render: SUCCESS (3.225s) [68.167229] Starting dynamic subtest: bsd [71.393421] Dynamic subtest bsd: SUCCESS (3.234s) [71.403339] Starting dynamic subtest: bsd1 [74.626114] Dynamic subtest bsd1: SUCCESS (3.232s) [74.636160] Starting dynamic subtest: bsd2 [77.864247] Dynamic subtest bsd2: SUCCESS (3.237s) [77.874639] Starting dynamic subtest: blt [81.097826] Dynamic subtest blt: SUCCESS (3.233s) [81.105575] Starting dynamic subtest: vebox [84.334102] Dynamic subtest vebox: SUCCESS (3.234s) [84.336835] Subtest legacy: SUCCESS (22.636s) [85.015441] [005/132] (933s left) kms_addfb_basic (unused-handle) [85.075988] Starting subtest: unused-handle [85.077988] Subtest unused-handle: SUCCESS (0.000s) [85.227704] [006/132] (933s left) kms_properties (plane-properties-legacy) [85.326244] Starting subtest: plane-properties-legacy [85.328197] Starting dynamic subtest: pipe-A-eDP-1 [85.932101] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.606s) [85.941019] Starting dynamic subtest: pipe-B-eDP-1 [87.222941] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.289s) [87.232399] Starting dynamic subtest: pipe-C-eDP-1 [88.462548] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.238s) [88.470343] Starting dynamic subtest: pipe-D-eDP-1 [89.701690] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.239s) [89.704081] Subtest plane-properties-legacy: SUCCESS (4.375s) [90.525035] [007/132] (928s left) i915_pm_freq_api (freq-reset-multiple) [90.602746] Starting subtest: freq-reset-multiple [90.605057] Starting dynamic subtest: gt0 [99.309857] Dynamic subtest gt0: SUCCESS (8.707s) [99.319399] Starting dynamic subtest: gt1 [106.758698] Dynamic subtest gt1: SUCCESS (7.447s) [106.761240] Subtest freq-reset-multiple: SUCCESS (16.155s) [106.856753] [008/132] (911s left) kms_cursor_crc (cursor-rapid-movement-64x64) [107.054069] Starting subtest: cursor-rapid-movement-64x64 [107.058757] Starting dynamic subtest: pipe-A-eDP-1 [107.610697] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.552s) [107.636251] Starting dynamic subtest: pipe-D-eDP-1 [108.815354] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.183s) [108.817686] Subtest cursor-rapid-movement-64x64: SUCCESS (1.759s) [109.692152] [009/132] (908s left) kms_atomic (plane-immutable-zpos) [109.789988] Starting subtest: plane-immutable-zpos [109.792419] Starting dynamic subtest: pipe-A-eDP-1 [110.422390] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.631s) [110.424683] Subtest plane-immutable-zpos: SUCCESS (0.632s) [111.325808] [010/132] (907s left) syncobj_timeline (single-wait-for-submit-signaled) [111.389055] Starting subtest: single-wait-for-submit-signaled [111.391485] Subtest single-wait-for-submit-signaled: SUCCESS (0.000s) [111.509793] [011/132] (907s left) kms_cursor_edge_walk (64x64-top-edge) [111.616664] Starting subtest: 64x64-top-edge [111.618939] Starting dynamic subtest: pipe-A-eDP-1 [115.063371] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.445s) [115.072929] Starting dynamic subtest: pipe-D-eDP-1 [118.192685] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.128s) [118.195062] Subtest 64x64-top-edge: SUCCESS (6.576s) [119.024190] [012/132] (899s left) kms_big_fb (y-tiled-64bpp-rotate-270) [119.138953] Starting subtest: y-tiled-64bpp-rotate-270 [119.142975] Subtest y-tiled-64bpp-rotate-270: SKIP (0.000s) [119.257143] [013/132] (899s left) gem_ctx_isolation (preservation-s3) [119.312856] Starting subtest: preservation-S3 [119.315413] Starting dynamic subtest: rcs0 [136.054804] Dynamic subtest rcs0: SUCCESS (5.695s) [136.065519] Starting dynamic subtest: bcs0 [152.052582] Dynamic subtest bcs0: SUCCESS (1.339s) [152.061382] Starting dynamic subtest: vcs0 [168.061161] Dynamic subtest vcs0: SUCCESS (2.622s) [168.070289] Starting dynamic subtest: vcs1 [186.068401] Dynamic subtest vcs1: SUCCESS (4.990s) [186.078005] Starting dynamic subtest: vecs0 [204.046833] Dynamic subtest vecs0: SUCCESS (4.976s) [204.057262] Starting dynamic subtest: ccs0 [222.068502] Dynamic subtest ccs0: SUCCESS (3.243s) [222.071420] Subtest preservation-S3: SUCCESS (22.867s) [222.321226] [014/132] (796s left) kms_flip (plain-flip-ts-check-interruptible) [222.439072] Starting subtest: plain-flip-ts-check-interruptible [222.444792] Starting dynamic subtest: A-eDP1 [231.280785] Dynamic subtest A-eDP1: SUCCESS (8.828s) [231.289481] Starting dynamic subtest: B-eDP1 [240.114188] Dynamic subtest B-eDP1: SUCCESS (8.827s) [240.123086] Starting dynamic subtest: C-eDP1 [248.939752] Dynamic subtest C-eDP1: SUCCESS (8.819s) [248.949041] Starting dynamic subtest: D-eDP1 [257.773747] Dynamic subtest D-eDP1: SUCCESS (8.827s) [257.776400] Subtest plain-flip-ts-check-interruptible: SUCCESS (35.312s) [258.977896] [015/132] (759s left) gem_partial_pwrite_pread (reads-display) [259.043912] Subtest reads-display: SKIP (0.000s) [259.131080] [016/132] (759s left) gen9_exec_parse (bb-oversize) [259.194663] Subtest bb-oversize: SKIP (0.000s) [259.262342] [017/132] (759s left) kms_flip_scaled_crc (flip-64bpp-yftile-to-16bpp-yftile-downscaling) [259.351045] Starting subtest: flip-64bpp-yftile-to-16bpp-yftile-downscaling [259.353752] Starting dynamic subtest: pipe-A-default-mode [259.645172] Dynamic subtest pipe-A-default-mode: SKIP (0.288s) [259.650784] Subtest flip-64bpp-yftile-to-16bpp-yftile-downscaling: SKIP (0.289s) [260.501982] [018/132] (758s left) gem_fenced_exec_thrash (no-spare-fences) [260.572707] Subtest no-spare-fences: SKIP (0.000s) [260.653335] [019/132] (758s left) vgem_basic (bad-fence) [260.766851] Starting subtest: bad-fence [260.769071] Subtest bad-fence: SUCCESS (0.000s) [260.846220] [FACT vgem_basic (bad-fence)] new: kernel.kmod_is_loaded.vgem: true [260.849486] [020/132] (758s left) kms_big_fb (linear-max-hw-stride-64bpp-rotate-180) [260.957363] Starting subtest: linear-max-hw-stride-64bpp-rotate-180 [261.957531] Subtest linear-max-hw-stride-64bpp-rotate-180: SUCCESS (1.001s) [262.115759] [021/132] (756s left) gem_ctx_persistence (idempotent) [262.184915] Starting subtest: idempotent [262.188056] Subtest idempotent: SUCCESS (0.000s) [262.321389] [022/132] (756s left) syncobj_basic (bad-create-flags) [262.378414] Starting subtest: bad-create-flags [262.380739] Subtest bad-create-flags: SUCCESS (0.000s) [262.508228] [023/132] (756s left) kms_frontbuffer_tracking (fbcpsr-1p-pri-indfb-multidraw) [262.607790] Starting subtest: fbcpsr-1p-pri-indfb-multidraw [285.133697] Subtest fbcpsr-1p-pri-indfb-multidraw: SUCCESS (22.517s) [285.313492] [024/132] (733s left) kms_rotation_crc (primary-yf-tiled-reflect-x-0) [285.408028] Starting subtest: primary-yf-tiled-reflect-x-0 [285.479547] Subtest primary-yf-tiled-reflect-x-0: SKIP (0.071s) [285.604269] [025/132] (733s left) fbdev (pan) [285.642829] Starting subtest: pan [285.676916] Subtest pan: SUCCESS (0.035s) [285.774795] [026/132] (733s left) kms_addfb_basic (addfb25-y-tiled-small-legacy) [285.873781] Starting subtest: addfb25-y-tiled-small-legacy [285.878417] Subtest addfb25-y-tiled-small-legacy: SKIP (0.000s) [286.005387] [027/132] (733s left) kms_ccs (crc-primary-suspend-y-tiled-ccs) [286.096064] Starting subtest: crc-primary-suspend-y-tiled-ccs [286.098520] Starting dynamic subtest: pipe-A-eDP-1 [286.107764] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [286.117602] Starting dynamic subtest: pipe-B-eDP-1 [286.126865] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [286.136022] Starting dynamic subtest: pipe-C-eDP-1 [286.145691] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [286.155960] Starting dynamic subtest: pipe-D-eDP-1 [286.165047] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [286.169737] Subtest crc-primary-suspend-y-tiled-ccs: SKIP (0.005s) [288.330461] [028/132] (731s left) gem_mmap_gtt (basic-short) [288.388871] Subtest basic-short: SKIP (0.000s) [288.454646] [029/132] (730s left) kms_force_connector_basic (force-connector-state) [288.534029] Starting subtest: force-connector-state [289.168874] Subtest force-connector-state: SUCCESS (0.634s) [290.075732] [030/132] (729s left) syncobj_wait (invalid-reset-illegal-handle) [290.132808] Starting subtest: invalid-reset-illegal-handle [290.135943] Subtest invalid-reset-illegal-handle: SUCCESS (0.000s) [290.252975] [031/132] (729s left) kms_addfb_basic (too-wide) [290.362300] Starting subtest: too-wide [290.364767] Subtest too-wide: SUCCESS (0.000s) [290.496410] [032/132] (729s left) kms_chamelium_color (degamma) [290.591515] Subtest degamma: SKIP (0.000s) [290.634418] [033/132] (728s left) kms_flip_scaled_crc (flip-32bpp-linear-to-64bpp-linear-downscaling) [290.726450] Starting subtest: flip-32bpp-linear-to-64bpp-linear-downscaling [290.728908] Starting dynamic subtest: pipe-A-default-mode [291.874938] Dynamic subtest pipe-A-default-mode: SKIP (1.143s) [291.880896] Subtest flip-32bpp-linear-to-64bpp-linear-downscaling: SKIP (1.145s) [292.104949] [034/132] (727s left) gem_ctx_create (basic-files) [292.163961] Starting subtest: basic-files [294.176476] Subtest basic-files: SUCCESS (2.011s) [295.832817] [035/132] (723s left) gem_exec_fence (syncobj-timeline-invalid-wait) [296.399672] Starting subtest: syncobj-timeline-invalid-wait [296.406641] Subtest syncobj-timeline-invalid-wait: SUCCESS (0.007s) [297.844745] [036/132] (721s left) gem_mmap_offset (bad-object) [297.905072] Starting subtest: bad-object [297.907860] Subtest bad-object: SUCCESS (0.001s) [298.040891] [037/132] (721s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-onoff) [298.148975] Starting subtest: psr-2p-primscrn-spr-indfb-onoff [298.154060] Subtest psr-2p-primscrn-spr-indfb-onoff: SKIP (0.000s) [298.276376] [038/132] (721s left) kms_frontbuffer_tracking (fbc-1p-indfb-fliptrack-mmap-gtt) [298.373770] Starting subtest: fbc-1p-indfb-fliptrack-mmap-gtt [298.378410] Subtest fbc-1p-indfb-fliptrack-mmap-gtt: SKIP (0.000s) [298.500516] [039/132] (721s left) kms_selftest (drm_format_helper) [298.535346] Starting subtest: drm_format_helper [298.544085] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_gray8 [298.685735] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_gray8: SUCCESS (0.138s) [298.700051] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_rgb332 [298.815034] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_rgb332: SUCCESS (0.130s) [298.824822] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_rgb565 [298.968385] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_rgb565: SUCCESS (0.152s) [298.977865] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_xrgb1555 [299.118981] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_xrgb1555: SUCCESS (0.150s) [299.128234] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_argb1555 [299.253780] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_argb1555: SUCCESS (0.135s) [299.265597] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_rgba5551 [299.400798] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_rgba5551: SUCCESS (0.146s) [299.410055] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_rgb888 [299.543563] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_rgb888: SUCCESS (0.140s) [299.553107] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_bgr888 [299.677010] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_bgr888: SUCCESS (0.133s) [299.687352] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_argb8888 [299.821924] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_argb8888: SUCCESS (0.144s) [299.831697] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_xrgb2101010 [299.971509] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_xrgb2101010: SUCCESS (0.148s) [299.981122] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_argb2101010 [300.115840] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_argb2101010: SUCCESS (0.145s) [300.126925] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_mono [300.269831] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_mono: SUCCESS (0.154s) [300.279028] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_swab [300.407567] Dynamic subtest drm_format_helper_test-drm_test_fb_swab: SUCCESS (0.134s) [300.416348] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_xbgr8888 [300.532930] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_xbgr8888: SUCCESS (0.124s) [300.542035] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_abgr8888 [300.664800] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_abgr8888: SUCCESS (0.131s) [300.674089] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_clip_offset [300.757078] Dynamic subtest drm_format_helper_test-drm_test_fb_clip_offset: SUCCESS (0.092s) [300.766034] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_memcpy [300.903536] Dynamic subtest drm_format_helper_test-drm_test_fb_memcpy: SUCCESS (0.143s) [300.906040] Subtest drm_format_helper: SUCCESS (2.365s) [301.131823] [040/132] (718s left) gem_exec_capture (capture-invisible) [301.196081] Starting subtest: capture-invisible [301.199055] Starting dynamic subtest: smem0 [301.204879] Dynamic subtest smem0: SKIP (0.000s) [301.210807] Subtest capture-invisible: SKIP (0.001s) [301.339644] [041/132] (718s left) kms_psr (pr-cursor-mmap-cpu) [301.443819] Starting subtest: pr-cursor-mmap-cpu [301.448949] Subtest pr-cursor-mmap-cpu: SKIP (0.000s) [301.537821] [042/132] (718s left) kms_cursor_crc (cursor-onscreen-64x64) [301.722955] Starting subtest: cursor-onscreen-64x64 [301.729044] Starting dynamic subtest: pipe-A-eDP-1 [303.839758] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.112s) [303.872027] Starting dynamic subtest: pipe-D-eDP-1 [306.586048] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.722s) [306.588748] Subtest cursor-onscreen-64x64: SUCCESS (4.859s) [307.469372] [043/132] (712s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-0) [307.562015] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-0 [308.563543] Subtest x-tiled-max-hw-stride-64bpp-rotate-0: SUCCESS (1.000s) [308.734791] [044/132] (711s left) prime_vgem (busy) [308.807830] Starting subtest: busy [308.810670] Starting dynamic subtest: rcs0 [308.875846] Dynamic subtest rcs0: SUCCESS (0.069s) [308.885503] Starting dynamic subtest: bcs0 [308.933598] Dynamic subtest bcs0: SUCCESS (0.057s) [308.942817] Starting dynamic subtest: vcs0 [308.984344] Dynamic subtest vcs0: SUCCESS (0.050s) [308.998656] Starting dynamic subtest: vcs1 [309.033453] Dynamic subtest vcs1: SUCCESS (0.048s) [309.043616] Starting dynamic subtest: vecs0 [309.080321] Dynamic subtest vecs0: SUCCESS (0.046s) [309.089062] Starting dynamic subtest: ccs0 [309.127812] Dynamic subtest ccs0: SUCCESS (0.046s) [309.129882] Subtest busy: SUCCESS (0.322s) [309.296383] [045/132] (710s left) i915_pm_rps (thresholds-idle) [309.367774] Starting subtest: thresholds-idle [309.372589] Subtest thresholds-idle: SKIP (0.001s) [309.497007] [046/132] (710s left) gem_mmap (basic) [309.563645] Subtest basic: SKIP (0.000s) [309.626659] [047/132] (710s left) gem_mmap_gtt (cpuset-big-copy) [309.684674] Subtest cpuset-big-copy: SKIP (0.000s) [309.749342] [048/132] (710s left) kms_big_fb (linear-16bpp-rotate-90) [309.852632] Starting subtest: linear-16bpp-rotate-90 [309.872683] Subtest linear-16bpp-rotate-90: SKIP (0.019s) [310.024255] [049/132] (710s left) i915_pm_rpm (gem-evict-pwrite) [311.956896] Starting subtest: gem-evict-pwrite [311.961653] Subtest gem-evict-pwrite: SKIP (0.000s) [312.339414] [050/132] (707s left) gem_pxp (verify-pxp-key-change-after-suspend-resume) [312.462400] Starting subtest: verify-pxp-key-change-after-suspend-resume [319.623815] Subtest verify-pxp-key-change-after-suspend-resume: SUCCESS (7.161s) [319.783562] [051/132] (700s left) syncobj_timeline (etime-multi-wait-for-submit-unsubmitted) [319.859388] Starting subtest: etime-multi-wait-for-submit-unsubmitted [319.963982] Subtest etime-multi-wait-for-submit-unsubmitted: SUCCESS (0.103s) [320.061551] [052/132] (700s left) syncobj_basic (bad-destroy) [320.124793] Starting subtest: bad-destroy [320.127478] Subtest bad-destroy: SUCCESS (0.000s) [320.243780] [053/132] (700s left) kms_plane (planar-pixel-format-settings) [320.332072] Starting subtest: planar-pixel-format-settings [320.371638] Subtest planar-pixel-format-settings: SUCCESS (0.041s) [320.485111] [054/132] (699s left) kms_psr (psr2-cursor-plane-move) [320.568226] Starting subtest: psr2-cursor-plane-move [320.570504] Starting dynamic subtest: eDP-1 [322.297561] Dynamic subtest eDP-1: SUCCESS (1.727s) [322.299862] Subtest psr2-cursor-plane-move: SUCCESS (1.728s) [323.177504] [055/132] (697s left) kms_ccs (crc-sprite-planes-basic-4-tiled-lnl-ccs) [323.268552] Starting subtest: crc-sprite-planes-basic-4-tiled-lnl-ccs [323.273166] Subtest crc-sprite-planes-basic-4-tiled-lnl-ccs: SKIP (0.000s) [324.472563] [056/132] (696s left) kms_legacy_colorkey (basic) [324.565495] Starting subtest: basic [324.567881] Starting dynamic subtest: pipe-A [324.611054] Dynamic subtest pipe-A: SUCCESS (0.045s) [324.622767] Starting dynamic subtest: pipe-B [324.625612] Dynamic subtest pipe-B: SUCCESS (0.000s) [324.634867] Starting dynamic subtest: pipe-C [324.637318] Dynamic subtest pipe-C: SUCCESS (0.000s) [324.645864] Starting dynamic subtest: pipe-D [324.648297] Dynamic subtest pipe-D: SUCCESS (0.000s) [324.650468] Subtest basic: SUCCESS (0.049s) [324.705664] [057/132] (695s left) kms_atomic_interruptible (legacy-setmode) [324.803927] Starting subtest: legacy-setmode [324.806839] Starting dynamic subtest: pipe-A-eDP-1 [331.678654] Dynamic subtest pipe-A-eDP-1: SUCCESS (6.871s) [331.681654] Subtest legacy-setmode: SUCCESS (6.872s) [332.578786] [058/132] (688s left) kms_flip (bo-too-big-interruptible) [332.681575] Starting subtest: bo-too-big-interruptible [332.683953] Starting dynamic subtest: A-eDP1 [333.966823] Dynamic subtest A-eDP1: SUCCESS (1.285s) [333.978304] Starting dynamic subtest: B-eDP1 [335.281062] Dynamic subtest B-eDP1: SUCCESS (1.312s) [335.293471] Starting dynamic subtest: C-eDP1 [336.584595] Dynamic subtest C-eDP1: SUCCESS (1.302s) [336.597055] Starting dynamic subtest: D-eDP1 [337.877684] Dynamic subtest D-eDP1: SUCCESS (1.291s) [337.884868] Subtest bo-too-big-interruptible: SUCCESS (5.202s) [339.087289] [059/132] (681s left) kms_plane_alpha_blend (constant-alpha-max) [339.181071] Starting subtest: constant-alpha-max [339.489819] Starting dynamic subtest: pipe-A-eDP-1 [340.547696] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.057s) [340.558941] Starting dynamic subtest: pipe-D-eDP-1 [342.124054] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.573s) [342.126898] Subtest constant-alpha-max: SUCCESS (2.944s) [342.986069] [060/132] (677s left) perf (polling-parameterized) [343.115043] Starting subtest: polling-parameterized [363.138195] Subtest polling-parameterized: SUCCESS (20.036s) [363.188517] [061/132] (657s left) kms_pm_rpm (modeset-pc8-residency-stress) [365.017749] Starting subtest: modeset-pc8-residency-stress [365.023453] Subtest modeset-pc8-residency-stress: SKIP (0.000s) [365.482419] [062/132] (655s left) gem_pwrite (basic-exhaustion) [365.557930] Subtest basic-exhaustion: SKIP (0.000s) [365.622164] [063/132] (655s left) kms_psr (fbc-pr-sprite-mmap-cpu) [365.722829] Starting subtest: fbc-pr-sprite-mmap-cpu [365.728038] Subtest fbc-pr-sprite-mmap-cpu: SKIP (0.000s) [365.833864] [064/132] (655s left) kms_chamelium_hpd (dp-hpd-enable-disable-mode) [366.221039] Subtest dp-hpd-enable-disable-mode: SKIP (0.000s) [367.022015] [065/132] (653s left) perf_pmu (all-busy-idle-check-all) [367.065829] Starting subtest: all-busy-idle-check-all [368.792676] Subtest all-busy-idle-check-all: SUCCESS (1.727s) [368.939319] [066/132] (652s left) drm_read (short-buffer-block) [369.086438] Starting subtest: short-buffer-block [369.089074] Subtest short-buffer-block: SUCCESS (0.000s) [369.234385] [067/132] (651s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip) [369.333771] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip [369.338773] Subtest y-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip: SKIP (0.000s) [369.459644] [068/132] (651s left) gem_create (create-ext-cpu-access-big) [369.632056] Starting subtest: create-ext-cpu-access-big [369.637719] Subtest create-ext-cpu-access-big: SKIP (0.001s) [369.726739] [069/132] (651s left) gem_eio (suspend) [369.954076] Starting subtest: suspend [382.158920] Subtest suspend: SUCCESS (12.215s) [382.334242] [070/132] (638s left) gem_exec_reloc (basic-active) [382.397897] Subtest basic-active: SKIP (0.000s) [382.466342] [071/132] (638s left) syncobj_timeline (invalid-single-wait-all-unsubmitted) [382.528045] Starting subtest: invalid-single-wait-all-unsubmitted [382.530573] Subtest invalid-single-wait-all-unsubmitted: SUCCESS (0.000s) [382.640125] [072/132] (638s left) dumb_buffer (invalid-bpp) [382.686337] Starting subtest: invalid-bpp [382.688867] Subtest invalid-bpp: SUCCESS (0.000s) [382.811472] [073/132] (638s left) prime_vgem (fence-write-hang) [382.884268] Subtest fence-write-hang: SKIP (0.000s) [383.010619] [074/132] (638s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-render) [383.108173] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-render [390.412117] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-render: SUCCESS (7.302s) [390.598486] [075/132] (630s left) kms_color (gamma) [390.714267] Starting subtest: gamma [390.716860] Starting dynamic subtest: pipe-A-eDP-1 [391.478478] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.764s) [391.490012] Starting dynamic subtest: pipe-B-eDP-1 [392.906516] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.426s) [392.918473] Starting dynamic subtest: pipe-C-eDP-1 [394.262945] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.354s) [394.273041] Starting dynamic subtest: pipe-D-eDP-1 [395.660024] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.397s) [395.662917] Subtest gamma: SUCCESS (4.945s) [396.550522] [076/132] (624s left) kms_ccs (bad-rotation-90-y-tiled-gen12-mc-ccs) [396.655563] Starting subtest: bad-rotation-90-y-tiled-gen12-mc-ccs [396.658029] Starting dynamic subtest: pipe-A-eDP-1 [396.685867] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [396.696631] Starting dynamic subtest: pipe-B-eDP-1 [396.722197] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [396.731049] Starting dynamic subtest: pipe-C-eDP-1 [396.758196] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [396.767027] Starting dynamic subtest: pipe-D-eDP-1 [396.793819] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [396.798917] Subtest bad-rotation-90-y-tiled-gen12-mc-ccs: SKIP (0.005s) [398.945527] [077/132] (622s left) kms_ccs (crc-primary-basic-yf-tiled-ccs) [399.037590] Starting subtest: crc-primary-basic-yf-tiled-ccs [399.040064] Starting dynamic subtest: pipe-A-eDP-1 [399.064864] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [399.074616] Starting dynamic subtest: pipe-B-eDP-1 [399.100542] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [399.109495] Starting dynamic subtest: pipe-C-eDP-1 [399.134852] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [399.144267] Starting dynamic subtest: pipe-D-eDP-1 [399.169611] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [399.174048] Subtest crc-primary-basic-yf-tiled-ccs: SKIP (0.006s) [401.369334] [078/132] (620s left) gem_exec_whisper (basic-sync-all) [401.434019] Starting subtest: basic-sync-all [409.553085] Subtest basic-sync-all: SUCCESS (8.116s) [409.761556] [079/132] (611s left) kms_invalid_mode (bad-hsync-start) [409.872525] Starting subtest: bad-hsync-start [409.874961] Starting dynamic subtest: pipe-A-eDP-1 [410.152935] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.283s) [410.163228] Starting dynamic subtest: pipe-B-eDP-1 [410.166046] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s) [410.175764] Starting dynamic subtest: pipe-C-eDP-1 [410.178151] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s) [410.187025] Starting dynamic subtest: pipe-D-eDP-1 [410.189540] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s) [410.191898] Subtest bad-hsync-start: SUCCESS (0.288s) [411.046366] [080/132] (610s left) kms_big_fb (yf-tiled-8bpp-rotate-90) [411.150879] Starting subtest: yf-tiled-8bpp-rotate-90 [411.156083] Subtest yf-tiled-8bpp-rotate-90: SKIP (0.000s) [411.268553] [081/132] (610s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-indfb-plflip-blt) [411.370920] Starting subtest: fbc-2p-scndscrn-indfb-plflip-blt [411.375763] Subtest fbc-2p-scndscrn-indfb-plflip-blt: SKIP (0.000s) [411.503864] [082/132] (610s left) syncobj_wait (single-wait-all-for-submit-unsubmitted) [411.577964] Starting subtest: single-wait-all-for-submit-unsubmitted [411.684058] Subtest single-wait-all-for-submit-unsubmitted: SUCCESS (0.105s) [411.788372] [083/132] (609s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-move) [411.896879] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-move [411.902737] Subtest fbcpsr-2p-scndscrn-cur-indfb-move: SKIP (0.000s) [412.015260] [084/132] (609s left) prime_mmap (test_forked) [412.068737] Starting subtest: test_forked [412.071166] Starting dynamic subtest: test_forked-smem [412.102403] Dynamic subtest test_forked-smem: SUCCESS (0.035s) [412.105124] Subtest test_forked: SUCCESS (0.037s) [412.253425] [085/132] (609s left) gem_exec_balancer (parallel) [412.515026] Starting subtest: parallel [413.420318] Subtest parallel: SUCCESS (0.905s) [413.850419] [086/132] (607s left) gem_exec_flush (basic-batch-kernel-default-uc) [413.916056] Starting subtest: basic-batch-kernel-default-uc [420.699435] Subtest basic-batch-kernel-default-uc: SUCCESS (6.782s) [420.914076] [087/132] (600s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-mmap-wc) [421.022208] Starting subtest: fbcpsr-rgb565-draw-mmap-wc [427.732264] Subtest fbcpsr-rgb565-draw-mmap-wc: SUCCESS (6.713s) [427.905349] [088/132] (593s left) kms_chamelium_frames (dp-crc-multiple) [428.306737] Subtest dp-crc-multiple: SKIP (0.000s) [429.100969] [089/132] (592s left) kms_psr2_sf (psr2-primary-plane-update-sf-dmg-area) [434.206715] Starting subtest: psr2-primary-plane-update-sf-dmg-area [434.209654] Starting dynamic subtest: pipe-A-eDP-1 [440.689870] Dynamic subtest pipe-A-eDP-1: SUCCESS (6.480s) [440.701430] Starting dynamic subtest: pipe-B-eDP-1 [447.199049] Dynamic subtest pipe-B-eDP-1: SUCCESS (6.505s) [447.201872] Subtest psr2-primary-plane-update-sf-dmg-area: SUCCESS (12.989s) [448.062121] [090/132] (573s left) kms_atomic_transition (plane-all-transition-nonblocking) [448.162338] Starting subtest: plane-all-transition-nonblocking [448.164767] Starting dynamic subtest: pipe-A-eDP-1 [450.657838] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.496s) [450.977773] Starting dynamic subtest: pipe-B-eDP-1 [454.237499] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.268s) [454.538959] Subtest plane-all-transition-nonblocking: SUCCESS (6.374s) [455.365423] [091/132] (566s left) gem_ctx_shared (q-independent) [455.437140] Starting subtest: Q-independent [455.439212] Starting dynamic subtest: rcs0 [455.509664] Dynamic subtest rcs0: SUCCESS (0.074s) [455.520966] Starting dynamic subtest: vcs0 [455.556032] Dynamic subtest vcs0: SUCCESS (0.045s) [455.565756] Starting dynamic subtest: vcs1 [455.599424] Dynamic subtest vcs1: SUCCESS (0.042s) [455.610022] Starting dynamic subtest: vecs0 [455.642037] Dynamic subtest vecs0: SUCCESS (0.042s) [455.654837] Starting dynamic subtest: ccs0 [455.700330] Dynamic subtest ccs0: SUCCESS (0.058s) [455.703248] Subtest Q-independent: SUCCESS (0.266s) [456.927735] [092/132] (565s left) kms_atomic_transition (plane-primary-toggle-with-vblank-wait) [457.019519] Starting subtest: plane-primary-toggle-with-vblank-wait [457.021857] Starting dynamic subtest: pipe-A-eDP-1 [457.193506] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.175s) [457.513432] Starting dynamic subtest: pipe-B-eDP-1 [458.407791] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.905s) [458.704030] Subtest plane-primary-toggle-with-vblank-wait: SUCCESS (1.684s) [459.558140] [093/132] (562s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-pwrite) [459.667795] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-pwrite [464.082804] Subtest fbc-1p-primscrn-spr-indfb-draw-pwrite: SUCCESS (4.418s) [465.265772] [094/132] (556s left) kms_flip (single-buffer-flip-vs-dpms-off-vs-modeset) [465.354541] Starting subtest: single-buffer-flip-vs-dpms-off-vs-modeset [465.357208] Starting dynamic subtest: A-eDP1 [468.956046] Dynamic subtest A-eDP1: SUCCESS (3.601s) [468.967807] Starting dynamic subtest: B-eDP1 [472.275039] Dynamic subtest B-eDP1: SUCCESS (3.317s) [472.287711] Starting dynamic subtest: C-eDP1 [475.559793] Dynamic subtest C-eDP1: SUCCESS (3.283s) [475.571039] Starting dynamic subtest: D-eDP1 [478.855189] Dynamic subtest D-eDP1: SUCCESS (3.294s) [478.857649] Subtest single-buffer-flip-vs-dpms-off-vs-modeset: SUCCESS (13.502s) [479.756529] [095/132] (542s left) syncobj_basic (bad-pad-fd-to-handle) [479.820848] Starting subtest: bad-pad-fd-to-handle [479.823805] Subtest bad-pad-fd-to-handle: SUCCESS (0.000s) [479.938489] [096/132] (542s left) kms_psr (psr-sprite-plane-onoff) [480.042799] Starting subtest: psr-sprite-plane-onoff [480.045631] Starting dynamic subtest: eDP-1 [481.850928] Dynamic subtest eDP-1: SUCCESS (1.806s) [481.853677] Subtest psr-sprite-plane-onoff: SUCCESS (1.807s) [482.673865] [097/132] (539s left) syncobj_timeline (etime-single-wait-for-submit-available-unsubmitted) [482.743064] Starting subtest: etime-single-wait-for-submit-available-unsubmitted [482.844241] Subtest etime-single-wait-for-submit-available-unsubmitted: SUCCESS (0.103s) [482.949408] [098/132] (539s left) gem_exec_schedule (u-submit-early-slice) [483.025276] Starting subtest: u-submit-early-slice [483.027652] Starting dynamic subtest: rcs0 [483.059389] Dynamic subtest rcs0: SUCCESS (0.047s) [483.071898] Starting dynamic subtest: bcs0 [483.104764] Dynamic subtest bcs0: SUCCESS (0.045s) [483.114414] Starting dynamic subtest: vcs0 [483.145882] Dynamic subtest vcs0: SUCCESS (0.040s) [483.155545] Starting dynamic subtest: vcs1 [483.192019] Dynamic subtest vcs1: SUCCESS (0.045s) [483.205076] Starting dynamic subtest: vecs0 [483.235806] Dynamic subtest vecs0: SUCCESS (0.043s) [483.245902] Starting dynamic subtest: ccs0 [483.280980] Dynamic subtest ccs0: SUCCESS (0.044s) [483.283717] Subtest u-submit-early-slice: SUCCESS (0.269s) [484.902390] [099/132] (537s left) kms_cursor_legacy (cursora-vs-flipb-varying-size) [485.022753] Starting subtest: cursorA-vs-flipB-varying-size [485.027943] Subtest cursorA-vs-flipB-varying-size: SKIP (0.001s) [485.194700] [100/132] (537s left) kms_properties (connector-properties-atomic) [485.286683] Starting subtest: connector-properties-atomic [485.288791] Starting dynamic subtest: pipe-A-eDP-1 [493.394762] Dynamic subtest pipe-A-eDP-1: SUCCESS (8.104s) [493.406553] Starting dynamic subtest: pipe-None-DP-1 [493.411341] Dynamic subtest pipe-None-DP-1: SUCCESS (0.001s) [493.421753] Starting dynamic subtest: pipe-None-HDMI-A-1 [493.426845] Dynamic subtest pipe-None-HDMI-A-1: SUCCESS (0.001s) [493.435871] Starting dynamic subtest: pipe-None-DP-2 [493.440820] Dynamic subtest pipe-None-DP-2: SUCCESS (0.001s) [493.450468] Starting dynamic subtest: pipe-None-HDMI-A-2 [493.455463] Dynamic subtest pipe-None-HDMI-A-2: SUCCESS (0.001s) [493.464698] Starting dynamic subtest: pipe-None-DP-3 [493.469778] Dynamic subtest pipe-None-DP-3: SUCCESS (0.001s) [493.479187] Starting dynamic subtest: pipe-None-DP-4 [493.484730] Dynamic subtest pipe-None-DP-4: SUCCESS (0.001s) [493.487420] Subtest connector-properties-atomic: SUCCESS (8.116s) [494.262599] [101/132] (528s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-pwrite) [494.376836] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-pwrite [494.382040] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-pwrite: SKIP (0.000s) [494.517811] [102/132] (527s left) kms_cursor_crc (cursor-alpha-transparent) [494.621219] Starting subtest: cursor-alpha-transparent [494.623850] Starting dynamic subtest: pipe-A-eDP-1 [495.250664] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.631s) [495.261616] Starting dynamic subtest: pipe-D-eDP-1 [496.581659] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.329s) [496.584385] Subtest cursor-alpha-transparent: SUCCESS (1.962s) [497.459934] [103/132] (525s left) gem_exec_schedule (pi-ringfull) [497.643806] Starting subtest: pi-ringfull [497.646446] Starting dynamic subtest: rcs0 [497.688943] Dynamic subtest rcs0: SUCCESS (0.045s) [497.699022] Starting dynamic subtest: bcs0 [497.723701] Dynamic subtest bcs0: SUCCESS (0.034s) [497.733536] Starting dynamic subtest: vcs0 [497.756032] Dynamic subtest vcs0: SUCCESS (0.031s) [497.768944] Starting dynamic subtest: vcs1 [497.787652] Dynamic subtest vcs1: SUCCESS (0.030s) [497.798950] Starting dynamic subtest: vecs0 [497.817416] Dynamic subtest vecs0: SUCCESS (0.029s) [497.828726] Starting dynamic subtest: ccs0 [497.845933] Dynamic subtest ccs0: SUCCESS (0.028s) [497.848909] Subtest pi-ringfull: SUCCESS (0.203s) [498.076297] [104/132] (524s left) kms_flip (2x-flip-vs-fences-interruptible) [498.189020] Starting subtest: 2x-flip-vs-fences-interruptible [498.194980] Subtest 2x-flip-vs-fences-interruptible: SKIP (0.000s) [498.326275] [105/132] (524s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-blt) [498.428873] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-blt [498.433877] Subtest psr-2p-scndscrn-spr-indfb-draw-blt: SKIP (0.000s) [498.570337] [106/132] (524s left) gem_render_copy (yf-tiled-ccs-to-y-tiled) [498.634063] Starting subtest: yf-tiled-ccs-to-y-tiled [498.639042] Subtest yf-tiled-ccs-to-y-tiled: SKIP (0.000s) [498.835647] [107/132] (523s left) kms_plane_scaling (plane-upscale-20x20-with-modifiers) [498.941778] Starting subtest: plane-upscale-20x20-with-modifiers [498.944514] Starting dynamic subtest: pipe-A [499.277065] Dynamic subtest pipe-A: SUCCESS (0.338s) [499.286875] Starting dynamic subtest: pipe-B [500.689032] Dynamic subtest pipe-B: SUCCESS (1.410s) [500.698577] Starting dynamic subtest: pipe-C [502.087784] Dynamic subtest pipe-C: SUCCESS (1.398s) [502.098202] Starting dynamic subtest: pipe-D [503.486039] Dynamic subtest pipe-D: SUCCESS (1.397s) [503.488931] Subtest plane-upscale-20x20-with-modifiers: SUCCESS (4.546s) [504.667024] [108/132] (518s left) kms_cursor_legacy (basic-flip-after-cursor-atomic) [504.791883] Starting subtest: basic-flip-after-cursor-atomic [505.705106] Subtest basic-flip-after-cursor-atomic: SUCCESS (0.914s) [506.561301] [109/132] (516s left) kms_vrr (flipline) [506.646946] Starting subtest: flipline [506.654859] Subtest flipline: SKIP (0.000s) [506.744464] [110/132] (516s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-mmap-cpu) [506.835878] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-mmap-cpu [506.840957] Subtest psr-2p-primscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s) [506.959813] [111/132] (515s left) kms_big_fb (4-tiled-8bpp-rotate-0) [507.084863] Starting subtest: 4-tiled-8bpp-rotate-0 [508.350600] Subtest 4-tiled-8bpp-rotate-0: SUCCESS (1.266s) [508.503449] [112/132] (514s left) kms_sequence (queue-idle) [508.601073] Starting subtest: queue-idle [508.603295] Starting dynamic subtest: pipe-A-eDP-1 [510.386225] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.782s) [510.397189] Starting dynamic subtest: pipe-B-eDP-1 [512.876360] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.491s) [512.894722] Starting dynamic subtest: pipe-C-eDP-1 [515.357818] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.478s) [515.378059] Starting dynamic subtest: pipe-D-eDP-1 [517.878525] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.518s) [517.881681] Subtest queue-idle: SUCCESS (9.276s) [518.764895] [113/132] (504s left) gem_exec_reloc (basic-wc) [518.820301] Subtest basic-wc: SKIP (0.000s) [518.910367] [114/132] (504s left) gem_mmap_gtt (basic-read-write-distinct) [518.966746] Subtest basic-read-write-distinct: SKIP (0.000s) [519.034425] [115/132] (503s left) gem_eio (in-flight-contexts-10ms) [519.270961] Starting subtest: in-flight-contexts-10ms [532.788744] Subtest in-flight-contexts-10ms: SUCCESS (13.515s) [532.965972] [116/132] (490s left) kms_cursor_legacy (torture-move) [533.082651] Starting subtest: torture-move [533.084826] Starting dynamic subtest: pipe-A [539.304046] Dynamic subtest pipe-A: SUCCESS (6.217s) [539.317178] Starting dynamic subtest: pipe-B [546.904792] Dynamic subtest pipe-B: SUCCESS (7.597s) [546.917577] Starting dynamic subtest: pipe-C [553.671944] Dynamic subtest pipe-C: SUCCESS (6.763s) [553.685930] Starting dynamic subtest: pipe-D [560.386672] Dynamic subtest pipe-D: SUCCESS (6.710s) [560.399216] Starting dynamic subtest: all-pipes [566.401862] Dynamic subtest all-pipes: SUCCESS (6.011s) [566.405059] Subtest torture-move: SUCCESS (33.311s) [566.587673] [117/132] (456s left) kms_feature_discovery (display-2x) [566.694278] Starting subtest: display-2x [566.699092] Subtest display-2x: SKIP (0.000s) [566.791392] [118/132] (456s left) syncobj_timeline (single-wait-for-submit-available-signaled) [566.861601] Starting subtest: single-wait-for-submit-available-signaled [566.864038] Subtest single-wait-for-submit-available-signaled: SUCCESS (0.000s) [567.001091] [119/132] (456s left) i915_drm_fdinfo (isolation) [567.038953] Starting subtest: isolation [567.041560] Starting dynamic subtest: rcs0 [567.083182] Dynamic subtest rcs0: SKIP (0.042s) [567.099979] Starting dynamic subtest: bcs0 [567.105390] Dynamic subtest bcs0: SKIP (0.000s) [567.117036] Starting dynamic subtest: vcs0 [567.121893] Dynamic subtest vcs0: SKIP (0.001s) [567.131238] Starting dynamic subtest: vcs1 [567.136029] Dynamic subtest vcs1: SKIP (0.000s) [567.145062] Starting dynamic subtest: vecs0 [567.149809] Dynamic subtest vecs0: SKIP (0.000s) [567.159117] Starting dynamic subtest: ccs0 [567.164750] Dynamic subtest ccs0: SKIP (0.000s) [567.169772] Subtest isolation: SKIP (0.052s) [567.210633] [120/132] (456s left) kms_plane_scaling (planes-unity-scaling-downscale-factor-0-5) [567.302887] Starting subtest: planes-unity-scaling-downscale-factor-0-5 [567.305549] Starting dynamic subtest: pipe-A [567.322536] Dynamic subtest pipe-A: SKIP (0.016s) [567.334623] Starting dynamic subtest: pipe-B [567.351831] Dynamic subtest pipe-B: SKIP (0.029s) [567.361706] Starting dynamic subtest: pipe-C [567.381598] Dynamic subtest pipe-C: SKIP (0.029s) [567.391852] Starting dynamic subtest: pipe-D [567.412268] Dynamic subtest pipe-D: SKIP (0.031s) [567.416038] Subtest planes-unity-scaling-downscale-factor-0-5: SKIP (0.107s) [567.548246] [121/132] (455s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-pwrite) [567.655339] Starting subtest: psr-2p-primscrn-cur-indfb-draw-pwrite [567.658957] Subtest psr-2p-primscrn-cur-indfb-draw-pwrite: SKIP (0.000s) [567.779423] [122/132] (455s left) api_intel_bb (intel-bb-blit-y) [567.835434] Starting subtest: intel-bb-blit-y [571.315049] Subtest intel-bb-blit-y: SUCCESS (3.479s) [571.458894] [123/132] (451s left) kms_frontbuffer_tracking (psr-1p-pri-indfb-multidraw) [571.566207] Starting subtest: psr-1p-pri-indfb-multidraw [593.983649] Subtest psr-1p-pri-indfb-multidraw: SUCCESS (22.417s) [594.123722] [124/132] (429s left) gem_partial_pwrite_pread (writes-after-reads-display) [594.198889] Subtest writes-after-reads-display: SKIP (0.000s) [594.293274] [125/132] (429s left) kms_getfb (getfb-handle-protection) [594.393033] Starting subtest: getfb-handle-protection [594.415313] Subtest getfb-handle-protection: SUCCESS (0.023s) [594.550269] [126/132] (428s left) gem_exec_schedule (u-fairslice-all) [594.622375] Starting subtest: u-fairslice-all [596.690189] Subtest u-fairslice-all: SUCCESS (2.061s) [597.006162] [127/132] (426s left) syncobj_wait (wait-for-submit-delayed-submit) [597.063269] Starting subtest: wait-for-submit-delayed-submit [597.164195] Subtest wait-for-submit-delayed-submit: SUCCESS (0.103s) [597.273909] [128/132] (426s left) gem_madvise (dontneed-after-mmap) [597.321071] Starting subtest: dontneed-after-mmap [597.343370] Subtest dontneed-after-mmap: SUCCESS (0.029s) [597.473706] [129/132] (426s left) kms_psr2_sf (fbc-psr2-overlay-plane-move-continuous-exceed-fully-sf) [602.514527] Starting subtest: fbc-psr2-overlay-plane-move-continuous-exceed-fully-sf [602.516974] Starting dynamic subtest: pipe-A-eDP-1 [603.293016] Dynamic subtest pipe-A-eDP-1: SKIP (0.774s) [603.303778] Starting dynamic subtest: pipe-B-eDP-1 [604.500015] Dynamic subtest pipe-B-eDP-1: SKIP (1.203s) [604.505515] Subtest fbc-psr2-overlay-plane-move-continuous-exceed-fully-sf: SKIP (1.982s) [605.672414] [130/132] (418s left) kms_frontbuffer_tracking (fbc-tiling-linear) [605.797052] Starting subtest: fbc-tiling-linear [609.546775] Subtest fbc-tiling-linear: SUCCESS (3.754s) [610.770816] [131/132] (412s left) gem_userptr_blits (huge-split) [610.840918] Starting subtest: huge-split [610.847869] Subtest huge-split: SUCCESS (0.007s) [611.004296] [132/132] (412s left) kms_properties (colorop-properties-legacy) [611.103381] Starting subtest: colorop-properties-legacy [611.105819] Starting dynamic subtest: pipe-A-eDP-1 [611.436195] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.334s) [611.447907] Starting dynamic subtest: pipe-B-eDP-1 [612.472644] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.034s) [612.483788] Starting dynamic subtest: pipe-C-eDP-1 [613.585730] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.112s) [613.597413] Starting dynamic subtest: pipe-D-eDP-1 [614.684971] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.097s) [614.687907] Subtest colorop-properties-legacy: SUCCESS (3.581s) [615.581785] Closing watchdogs results: parsing output: 0/ for test: kms_psr results: parsing output: 1/ for test: kms_frontbuffer_tracking results: parsing output: 2/ for test: perf_pmu results: parsing output: 3/ for test: gem_spin_batch results: parsing output: 4/ for test: kms_addfb_basic results: parsing output: 5/ for test: kms_properties results: parsing output: 6/ for test: i915_pm_freq_api results: parsing output: 7/ for test: kms_cursor_crc results: parsing output: 8/ for test: kms_atomic results: parsing output: 9/ for test: syncobj_timeline results: parsing output: 10/ for test: kms_cursor_edge_walk results: parsing output: 11/ for test: kms_big_fb results: parsing output: 12/ for test: gem_ctx_isolation results: parsing output: 13/ for test: kms_flip results: parsing output: 14/ for test: gem_partial_pwrite_pread results: parsing output: 15/ for test: gen9_exec_parse results: parsing output: 16/ for test: kms_flip_scaled_crc results: parsing output: 17/ for test: gem_fenced_exec_thrash results: parsing output: 18/ for test: vgem_basic results: parsing output: 19/ for test: kms_big_fb results: parsing output: 20/ for test: gem_ctx_persistence results: parsing output: 21/ for test: syncobj_basic results: parsing output: 22/ for test: kms_frontbuffer_tracking results: parsing output: 23/ for test: kms_rotation_crc results: parsing output: 24/ for test: fbdev results: parsing output: 25/ for test: kms_addfb_basic results: parsing output: 26/ for test: kms_ccs results: parsing output: 27/ for test: gem_mmap_gtt results: parsing output: 28/ for test: kms_force_connector_basic results: parsing output: 29/ for test: syncobj_wait results: parsing output: 30/ for test: kms_addfb_basic results: parsing output: 31/ for test: kms_chamelium_color results: parsing output: 32/ for test: kms_flip_scaled_crc results: parsing output: 33/ for test: gem_ctx_create results: parsing output: 34/ for test: gem_exec_fence results: parsing output: 35/ for test: gem_mmap_offset results: parsing output: 36/ for test: kms_frontbuffer_tracking results: parsing output: 37/ for test: kms_frontbuffer_tracking results: parsing output: 38/ for test: kms_selftest results: parsing output: 39/ for test: gem_exec_capture results: parsing output: 40/ for test: kms_psr results: parsing output: 41/ for test: kms_cursor_crc results: parsing output: 42/ for test: kms_big_fb results: parsing output: 43/ for test: prime_vgem results: parsing output: 44/ for test: i915_pm_rps results: parsing output: 45/ for test: gem_mmap results: parsing output: 46/ for test: gem_mmap_gtt results: parsing output: 47/ for test: kms_big_fb results: parsing output: 48/ for test: i915_pm_rpm results: parsing output: 49/ for test: gem_pxp results: parsing output: 50/ for test: syncobj_timeline results: parsing output: 51/ for test: syncobj_basic results: parsing output: 52/ for test: kms_plane results: parsing output: 53/ for test: kms_psr results: parsing output: 54/ for test: kms_ccs results: parsing output: 55/ for test: kms_legacy_colorkey results: parsing output: 56/ for test: kms_atomic_interruptible results: parsing output: 57/ for test: kms_flip results: parsing output: 58/ for test: kms_plane_alpha_blend results: parsing output: 59/ for test: perf results: parsing output: 60/ for test: kms_pm_rpm results: parsing output: 61/ for test: gem_pwrite results: parsing output: 62/ for test: kms_psr results: parsing output: 63/ for test: kms_chamelium_hpd results: parsing output: 64/ for test: perf_pmu results: parsing output: 65/ for test: drm_read results: parsing output: 66/ for test: kms_big_fb results: parsing output: 67/ for test: gem_create results: parsing output: 68/ for test: gem_eio results: parsing output: 69/ for test: gem_exec_reloc results: parsing output: 70/ for test: syncobj_timeline results: parsing output: 71/ for test: dumb_buffer results: parsing output: 72/ for test: prime_vgem results: parsing output: 73/ for test: kms_frontbuffer_tracking results: parsing output: 74/ for test: kms_color results: parsing output: 75/ for test: kms_ccs results: parsing output: 76/ for test: kms_ccs results: parsing output: 77/ for test: gem_exec_whisper results: parsing output: 78/ for test: kms_invalid_mode results: parsing output: 79/ for test: kms_big_fb results: parsing output: 80/ for test: kms_frontbuffer_tracking results: parsing output: 81/ for test: syncobj_wait results: parsing output: 82/ for test: kms_frontbuffer_tracking results: parsing output: 83/ for test: prime_mmap results: parsing output: 84/ for test: gem_exec_balancer results: parsing output: 85/ for test: gem_exec_flush results: parsing output: 86/ for test: kms_frontbuffer_tracking results: parsing output: 87/ for test: kms_chamelium_frames results: parsing output: 88/ for test: kms_psr2_sf results: parsing output: 89/ for test: kms_atomic_transition results: parsing output: 90/ for test: gem_ctx_shared results: parsing output: 91/ for test: kms_atomic_transition results: parsing output: 92/ for test: kms_frontbuffer_tracking results: parsing output: 93/ for test: kms_flip results: parsing output: 94/ for test: syncobj_basic results: parsing output: 95/ for test: kms_psr results: parsing output: 96/ for test: syncobj_timeline results: parsing output: 97/ for test: gem_exec_schedule results: parsing output: 98/ for test: kms_cursor_legacy results: parsing output: 99/ for test: kms_properties results: parsing output: 100/ for test: kms_frontbuffer_tracking results: parsing output: 101/ for test: kms_cursor_crc results: parsing output: 102/ for test: gem_exec_schedule results: parsing output: 103/ for test: kms_flip results: parsing output: 104/ for test: kms_frontbuffer_tracking results: parsing output: 105/ for test: gem_render_copy results: parsing output: 106/ for test: kms_plane_scaling results: parsing output: 107/ for test: kms_cursor_legacy results: parsing output: 108/ for test: kms_vrr results: parsing output: 109/ for test: kms_frontbuffer_tracking results: parsing output: 110/ for test: kms_big_fb results: parsing output: 111/ for test: kms_sequence results: parsing output: 112/ for test: gem_exec_reloc results: parsing output: 113/ for test: gem_mmap_gtt results: parsing output: 114/ for test: gem_eio results: parsing output: 115/ for test: kms_cursor_legacy results: parsing output: 116/ for test: kms_feature_discovery results: parsing output: 117/ for test: syncobj_timeline results: parsing output: 118/ for test: i915_drm_fdinfo results: parsing output: 119/ for test: kms_plane_scaling results: parsing output: 120/ for test: kms_frontbuffer_tracking results: parsing output: 121/ for test: api_intel_bb results: parsing output: 122/ for test: kms_frontbuffer_tracking results: parsing output: 123/ for test: gem_partial_pwrite_pread results: parsing output: 124/ for test: kms_getfb results: parsing output: 125/ for test: gem_exec_schedule results: parsing output: 126/ for test: syncobj_wait results: parsing output: 127/ for test: gem_madvise results: parsing output: 128/ for test: kms_psr2_sf results: parsing output: 129/ for test: kms_frontbuffer_tracking results: parsing output: 130/ for test: gem_userptr_blits results: parsing output: 131/ for test: kms_properties Done.