[56.595651] Initializing watchdogs [56.595698] /dev/watchdog0 [56.610449] [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] [56.615183] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [56.617500] [FACT before any test] new: kernel.kmod_is_loaded.i915: true [56.621200] [001/132] (960s left) kms_psr (fbc-psr2-dpms) [56.758107] Starting subtest: fbc-psr2-dpms [56.760413] Starting dynamic subtest: eDP-1 [56.764608] Dynamic subtest eDP-1: SKIP (0.000s) [56.768859] Subtest fbc-psr2-dpms: SKIP (0.001s) [56.853443] [002/132] (960s left) kms_frontbuffer_tracking (fbc-2p-primscrn-shrfb-pgflip-blt) [56.949613] Starting subtest: fbc-2p-primscrn-shrfb-pgflip-blt [56.953751] Subtest fbc-2p-primscrn-shrfb-pgflip-blt: SKIP (0.000s) [57.090028] [003/132] (960s left) perf_pmu (idle-no-semaphores) [57.132783] Starting subtest: idle-no-semaphores [57.134824] Starting dynamic subtest: rcs0 [57.701405] Dynamic subtest rcs0: SUCCESS (0.569s) [57.710317] Starting dynamic subtest: bcs0 [58.218391] Dynamic subtest bcs0: SUCCESS (0.518s) [58.228228] Starting dynamic subtest: vcs0 [58.747482] Dynamic subtest vcs0: SUCCESS (0.529s) [58.756276] Starting dynamic subtest: vcs1 [59.272646] Dynamic subtest vcs1: SUCCESS (0.525s) [59.281517] Starting dynamic subtest: vecs0 [59.802808] Dynamic subtest vecs0: SUCCESS (0.530s) [59.813760] Starting dynamic subtest: ccs0 [60.329704] Dynamic subtest ccs0: SUCCESS (0.526s) [60.332420] Subtest idle-no-semaphores: SUCCESS (3.207s) [60.479754] [004/132] (956s left) gem_spin_batch (legacy) [60.541818] Starting subtest: legacy [60.544256] Starting dynamic subtest: default [63.781996] Dynamic subtest default: SUCCESS (3.239s) [63.792321] Starting dynamic subtest: render [67.016250] Dynamic subtest render: SUCCESS (3.234s) [67.028204] Starting dynamic subtest: bsd [70.250189] Dynamic subtest bsd: SUCCESS (3.234s) [70.262378] Starting dynamic subtest: bsd1 [73.484272] Dynamic subtest bsd1: SUCCESS (3.234s) [73.494542] Starting dynamic subtest: bsd2 [76.719086] Dynamic subtest bsd2: SUCCESS (3.234s) [76.728504] Starting dynamic subtest: blt [79.955377] Dynamic subtest blt: SUCCESS (3.235s) [79.965272] Starting dynamic subtest: vebox [83.190061] Dynamic subtest vebox: SUCCESS (3.233s) [83.192380] Subtest legacy: SUCCESS (22.656s) [84.041988] [005/132] (933s left) kms_addfb_basic (unused-handle) [84.103894] Starting subtest: unused-handle [84.106423] Subtest unused-handle: SUCCESS (0.000s) [84.281325] [006/132] (933s left) kms_properties (plane-properties-legacy) [84.389513] Starting subtest: plane-properties-legacy [84.391755] Starting dynamic subtest: pipe-A-eDP-1 [84.989550] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.600s) [84.999865] Starting dynamic subtest: pipe-B-eDP-1 [86.297298] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.306s) [86.305382] Starting dynamic subtest: pipe-C-eDP-1 [87.615398] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.315s) [87.624125] Starting dynamic subtest: pipe-D-eDP-1 [88.855770] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.239s) [88.858141] Subtest plane-properties-legacy: SUCCESS (4.465s) [89.670039] [007/132] (927s left) i915_pm_freq_api (freq-reset-multiple) [89.741500] Starting subtest: freq-reset-multiple [89.743518] Starting dynamic subtest: gt0 [98.538284] Dynamic subtest gt0: SUCCESS (8.796s) [98.548394] Starting dynamic subtest: gt1 [106.073846] Dynamic subtest gt1: SUCCESS (7.536s) [106.076819] Subtest freq-reset-multiple: SUCCESS (16.334s) [106.179220] [008/132] (911s left) kms_cursor_crc (cursor-rapid-movement-64x64) [106.362422] Starting subtest: cursor-rapid-movement-64x64 [106.364635] Starting dynamic subtest: pipe-A-eDP-1 [106.907478] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.542s) [106.937595] Starting dynamic subtest: pipe-D-eDP-1 [108.151439] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.221s) [108.153729] Subtest cursor-rapid-movement-64x64: SUCCESS (1.789s) [109.041362] [009/132] (908s left) kms_atomic (plane-immutable-zpos) [109.147915] Starting subtest: plane-immutable-zpos [109.150643] Starting dynamic subtest: pipe-A-eDP-1 [109.812666] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.665s) [109.815153] Subtest plane-immutable-zpos: SUCCESS (0.666s) [110.663026] [010/132] (906s left) syncobj_timeline (single-wait-for-submit-signaled) [110.724673] Starting subtest: single-wait-for-submit-signaled [110.726848] Subtest single-wait-for-submit-signaled: SUCCESS (0.000s) [110.844382] [011/132] (906s left) kms_cursor_edge_walk (64x64-top-edge) [110.943144] Starting subtest: 64x64-top-edge [110.945291] Starting dynamic subtest: pipe-A-eDP-1 [114.387065] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.445s) [114.395622] Starting dynamic subtest: pipe-D-eDP-1 [117.513460] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.125s) [117.515840] Subtest 64x64-top-edge: SUCCESS (6.572s) [118.351597] [012/132] (899s left) kms_big_fb (y-tiled-64bpp-rotate-270) [118.463654] Starting subtest: y-tiled-64bpp-rotate-270 [118.467880] Subtest y-tiled-64bpp-rotate-270: SKIP (0.000s) [118.604798] [013/132] (898s left) gem_ctx_isolation (preservation-s3) [118.677136] Starting subtest: preservation-S3 [118.679542] Starting dynamic subtest: rcs0 [135.127462] Dynamic subtest rcs0: SUCCESS (5.074s) [135.137287] Starting dynamic subtest: bcs0 [151.091269] Dynamic subtest bcs0: SUCCESS (1.339s) [151.100839] Starting dynamic subtest: vcs0 [167.078174] Dynamic subtest vcs0: SUCCESS (2.931s) [167.089193] Starting dynamic subtest: vcs1 [185.085643] Dynamic subtest vcs1: SUCCESS (5.053s) [185.095252] Starting dynamic subtest: vecs0 [203.078412] Dynamic subtest vecs0: SUCCESS (5.040s) [203.087613] Starting dynamic subtest: ccs0 [221.075906] Dynamic subtest ccs0: SUCCESS (3.260s) [221.079040] Subtest preservation-S3: SUCCESS (22.701s) [221.348530] [014/132] (796s left) kms_flip (plain-flip-ts-check-interruptible) [221.447916] Starting subtest: plain-flip-ts-check-interruptible [221.451006] Starting dynamic subtest: A-eDP1 [242.041868] Dynamic subtest A-eDP1: SUCCESS (20.688s) [242.053803] Starting dynamic subtest: B-eDP1 [250.849834] Dynamic subtest B-eDP1: SUCCESS (8.815s) [250.874726] Starting dynamic subtest: C-eDP1 [259.659730] Dynamic subtest C-eDP1: SUCCESS (8.806s) [259.673524] Starting dynamic subtest: D-eDP1 [268.496554] Dynamic subtest D-eDP1: SUCCESS (8.834s) [268.499149] Subtest plain-flip-ts-check-interruptible: SUCCESS (47.150s) [269.711666] [015/132] (747s left) gem_partial_pwrite_pread (reads-display) [269.785486] Subtest reads-display: SKIP (0.000s) [269.843147] [016/132] (747s left) gen9_exec_parse (bb-oversize) [269.910926] Subtest bb-oversize: SKIP (0.000s) [270.008043] [017/132] (747s left) kms_flip_scaled_crc (flip-64bpp-yftile-to-16bpp-yftile-downscaling) [270.099157] Starting subtest: flip-64bpp-yftile-to-16bpp-yftile-downscaling [270.101696] Starting dynamic subtest: pipe-A-default-mode [270.400160] Dynamic subtest pipe-A-default-mode: SKIP (0.298s) [270.405277] Subtest flip-64bpp-yftile-to-16bpp-yftile-downscaling: SKIP (0.299s) [271.242178] [018/132] (746s left) gem_fenced_exec_thrash (no-spare-fences) [271.313769] Subtest no-spare-fences: SKIP (0.000s) [271.380236] [019/132] (746s left) vgem_basic (bad-fence) [271.468385] Starting subtest: bad-fence [271.470986] Subtest bad-fence: SUCCESS (0.000s) [271.548931] [FACT vgem_basic (bad-fence)] new: kernel.kmod_is_loaded.vgem: true [271.552494] [020/132] (746s left) kms_big_fb (linear-max-hw-stride-64bpp-rotate-180) [271.655660] Starting subtest: linear-max-hw-stride-64bpp-rotate-180 [272.666822] Subtest linear-max-hw-stride-64bpp-rotate-180: SUCCESS (1.011s) [272.868100] [021/132] (745s left) gem_ctx_persistence (idempotent) [272.931789] Starting subtest: idempotent [272.935018] Subtest idempotent: SUCCESS (0.000s) [273.096074] [022/132] (744s left) syncobj_basic (bad-create-flags) [273.155638] Starting subtest: bad-create-flags [273.157889] Subtest bad-create-flags: SUCCESS (0.000s) [273.302549] [023/132] (744s left) kms_frontbuffer_tracking (fbcpsr-1p-pri-indfb-multidraw) [273.407819] Starting subtest: fbcpsr-1p-pri-indfb-multidraw [296.532691] Subtest fbcpsr-1p-pri-indfb-multidraw: SUCCESS (23.131s) [296.735592] [024/132] (721s left) kms_rotation_crc (primary-yf-tiled-reflect-x-0) [296.835826] Starting subtest: primary-yf-tiled-reflect-x-0 [296.895777] Subtest primary-yf-tiled-reflect-x-0: SKIP (0.060s) [297.022018] [025/132] (721s left) fbdev (pan) [297.058448] Starting subtest: pan [297.082513] Subtest pan: SUCCESS (0.027s) [297.178300] [026/132] (721s left) kms_addfb_basic (addfb25-y-tiled-small-legacy) [297.283662] Starting subtest: addfb25-y-tiled-small-legacy [297.288663] Subtest addfb25-y-tiled-small-legacy: SKIP (0.000s) [297.395386] [027/132] (720s left) kms_ccs (crc-primary-suspend-y-tiled-ccs) [297.486406] Starting subtest: crc-primary-suspend-y-tiled-ccs [297.488739] Starting dynamic subtest: pipe-A-eDP-1 [297.497432] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [297.510951] Starting dynamic subtest: pipe-B-eDP-1 [297.520833] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [297.531885] Starting dynamic subtest: pipe-C-eDP-1 [297.540996] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [297.550469] Starting dynamic subtest: pipe-D-eDP-1 [297.559480] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [297.563716] Subtest crc-primary-suspend-y-tiled-ccs: SKIP (0.005s) [299.734828] [028/132] (718s left) gem_mmap_gtt (basic-short) [299.786502] Subtest basic-short: SKIP (0.000s) [299.856514] [029/132] (718s left) kms_force_connector_basic (force-connector-state) [299.931649] Starting subtest: force-connector-state [300.550665] Subtest force-connector-state: SUCCESS (0.622s) [301.514757] [030/132] (716s left) syncobj_wait (invalid-reset-illegal-handle) [301.576996] Starting subtest: invalid-reset-illegal-handle [301.579879] Subtest invalid-reset-illegal-handle: SUCCESS (0.000s) [301.701803] [031/132] (716s left) kms_addfb_basic (too-wide) [301.808830] Starting subtest: too-wide [301.811084] Subtest too-wide: SUCCESS (0.000s) [301.930619] [032/132] (716s left) kms_chamelium_color (degamma) [302.033045] Subtest degamma: SKIP (0.000s) [302.077550] [033/132] (716s left) kms_flip_scaled_crc (flip-32bpp-linear-to-64bpp-linear-downscaling) [302.187397] Starting subtest: flip-32bpp-linear-to-64bpp-linear-downscaling [302.190079] Starting dynamic subtest: pipe-A-default-mode [303.377902] Dynamic subtest pipe-A-default-mode: SKIP (1.188s) [303.383437] Subtest flip-32bpp-linear-to-64bpp-linear-downscaling: SKIP (1.190s) [303.561997] [034/132] (714s left) gem_ctx_create (basic-files) [303.635840] Starting subtest: basic-files [305.646267] Subtest basic-files: SUCCESS (2.012s) [306.001278] [035/132] (712s left) gem_exec_fence (syncobj-timeline-invalid-wait) [306.575553] Starting subtest: syncobj-timeline-invalid-wait [306.582716] Subtest syncobj-timeline-invalid-wait: SUCCESS (0.006s) [307.908882] [036/132] (710s left) gem_mmap_offset (bad-object) [307.972935] Starting subtest: bad-object [307.975816] Subtest bad-object: SUCCESS (0.001s) [308.099976] [037/132] (710s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-onoff) [308.202143] Starting subtest: psr-2p-primscrn-spr-indfb-onoff [308.207017] Subtest psr-2p-primscrn-spr-indfb-onoff: SKIP (0.000s) [308.332013] [038/132] (710s left) kms_frontbuffer_tracking (fbc-1p-indfb-fliptrack-mmap-gtt) [308.432841] Starting subtest: fbc-1p-indfb-fliptrack-mmap-gtt [308.437749] Subtest fbc-1p-indfb-fliptrack-mmap-gtt: SKIP (0.000s) [308.549480] [039/132] (710s left) kms_selftest (drm_format_helper) [308.588385] Starting subtest: drm_format_helper [308.598702] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_gray8 [308.735853] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_gray8: SUCCESS (0.138s) [308.747267] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_rgb332 [308.870180] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_rgb332: SUCCESS (0.130s) [308.881301] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_rgb565 [309.005509] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_rgb565: SUCCESS (0.135s) [309.015251] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_xrgb1555 [309.149774] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_xrgb1555: SUCCESS (0.142s) [309.159991] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_argb1555 [309.280050] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_argb1555: SUCCESS (0.131s) [309.290292] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_rgba5551 [309.437158] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_rgba5551: SUCCESS (0.154s) [309.446741] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_rgb888 [309.590937] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_rgb888: SUCCESS (0.153s) [309.600730] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_bgr888 [309.756201] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_bgr888: SUCCESS (0.166s) [309.766856] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_argb8888 [309.912848] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_argb8888: SUCCESS (0.154s) [309.923414] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_xrgb2101010 [310.036191] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_xrgb2101010: SUCCESS (0.124s) [310.045779] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_argb2101010 [310.194028] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_argb2101010: SUCCESS (0.157s) [310.205831] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_mono [310.321249] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_mono: SUCCESS (0.124s) [310.331809] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_swab [310.414813] Dynamic subtest drm_format_helper_test-drm_test_fb_swab: SUCCESS (0.094s) [310.423876] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_xbgr8888 [310.532237] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_xbgr8888: SUCCESS (0.119s) [310.542591] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_abgr8888 [310.648083] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_abgr8888: SUCCESS (0.114s) [310.657836] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_clip_offset [310.775372] Dynamic subtest drm_format_helper_test-drm_test_fb_clip_offset: SUCCESS (0.127s) [310.785804] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_memcpy [310.946999] Dynamic subtest drm_format_helper_test-drm_test_fb_memcpy: SUCCESS (0.170s) [310.949838] Subtest drm_format_helper: SUCCESS (2.360s) [311.134436] [040/132] (707s left) gem_exec_capture (capture-invisible) [311.208587] Starting subtest: capture-invisible [311.211134] Starting dynamic subtest: smem0 [311.216547] Dynamic subtest smem0: SKIP (0.000s) [311.221283] Subtest capture-invisible: SKIP (0.001s) [311.360670] [041/132] (707s left) kms_psr (pr-cursor-mmap-cpu) [311.464859] Starting subtest: pr-cursor-mmap-cpu [311.469906] Subtest pr-cursor-mmap-cpu: SKIP (0.000s) [311.563155] [042/132] (707s left) kms_cursor_crc (cursor-onscreen-64x64) [311.758600] Starting subtest: cursor-onscreen-64x64 [311.760978] Starting dynamic subtest: pipe-A-eDP-1 [313.901928] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.141s) [313.942789] Starting dynamic subtest: pipe-D-eDP-1 [316.797875] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.865s) [316.801015] Subtest cursor-onscreen-64x64: SUCCESS (5.043s) [317.667845] [043/132] (701s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-0) [317.773802] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-0 [318.831705] Subtest x-tiled-max-hw-stride-64bpp-rotate-0: SUCCESS (1.056s) [318.982078] [044/132] (699s left) prime_vgem (busy) [319.065710] Starting subtest: busy [319.067830] Starting dynamic subtest: rcs0 [319.127732] Dynamic subtest rcs0: SUCCESS (0.062s) [319.138028] Starting dynamic subtest: bcs0 [319.196548] Dynamic subtest bcs0: SUCCESS (0.068s) [319.206045] Starting dynamic subtest: vcs0 [319.244263] Dynamic subtest vcs0: SUCCESS (0.047s) [319.253933] Starting dynamic subtest: vcs1 [319.289460] Dynamic subtest vcs1: SUCCESS (0.044s) [319.299062] Starting dynamic subtest: vecs0 [319.337728] Dynamic subtest vecs0: SUCCESS (0.047s) [319.347622] Starting dynamic subtest: ccs0 [319.384180] Dynamic subtest ccs0: SUCCESS (0.046s) [319.386558] Subtest busy: SUCCESS (0.320s) [319.537425] [045/132] (699s left) i915_pm_rps (thresholds-idle) [319.606750] Starting subtest: thresholds-idle [319.611719] Subtest thresholds-idle: SKIP (0.001s) [319.743032] [046/132] (699s left) gem_mmap (basic) [319.801727] Subtest basic: SKIP (0.000s) [319.867818] [047/132] (699s left) gem_mmap_gtt (cpuset-big-copy) [319.932592] Subtest cpuset-big-copy: SKIP (0.000s) [320.006511] [048/132] (699s left) kms_big_fb (linear-16bpp-rotate-90) [320.104983] Starting subtest: linear-16bpp-rotate-90 [320.125759] Subtest linear-16bpp-rotate-90: SKIP (0.020s) [320.273360] [049/132] (698s left) i915_pm_rpm (gem-evict-pwrite) [321.797475] Starting subtest: gem-evict-pwrite [321.802955] Subtest gem-evict-pwrite: SKIP (0.000s) [322.562772] [050/132] (696s left) gem_pxp (verify-pxp-key-change-after-suspend-resume) [322.685856] Starting subtest: verify-pxp-key-change-after-suspend-resume [329.913180] Subtest verify-pxp-key-change-after-suspend-resume: SUCCESS (7.227s) [330.078263] [051/132] (689s left) syncobj_timeline (etime-multi-wait-for-submit-unsubmitted) [330.147639] Starting subtest: etime-multi-wait-for-submit-unsubmitted [330.250550] Subtest etime-multi-wait-for-submit-unsubmitted: SUCCESS (0.104s) [330.352516] [052/132] (688s left) syncobj_basic (bad-destroy) [330.417019] Starting subtest: bad-destroy [330.419567] Subtest bad-destroy: SUCCESS (0.000s) [330.565507] [053/132] (688s left) kms_plane (planar-pixel-format-settings) [330.663836] Starting subtest: planar-pixel-format-settings [330.705042] Subtest planar-pixel-format-settings: SUCCESS (0.042s) [330.827952] [054/132] (688s left) kms_psr (psr2-cursor-plane-move) [330.921318] Starting subtest: psr2-cursor-plane-move [330.923172] Starting dynamic subtest: eDP-1 [332.603657] Dynamic subtest eDP-1: SUCCESS (1.681s) [332.606163] Subtest psr2-cursor-plane-move: SUCCESS (1.682s) [333.463195] [055/132] (686s left) kms_ccs (crc-sprite-planes-basic-4-tiled-lnl-ccs) [333.560468] Starting subtest: crc-sprite-planes-basic-4-tiled-lnl-ccs [333.565019] Subtest crc-sprite-planes-basic-4-tiled-lnl-ccs: SKIP (0.000s) [334.684672] [056/132] (684s left) kms_legacy_colorkey (basic) [334.780998] Starting subtest: basic [334.783834] Starting dynamic subtest: pipe-A [334.823682] Dynamic subtest pipe-A: SUCCESS (0.045s) [334.837062] Starting dynamic subtest: pipe-B [334.839304] Dynamic subtest pipe-B: SUCCESS (0.000s) [334.849270] Starting dynamic subtest: pipe-C [334.851856] Dynamic subtest pipe-C: SUCCESS (0.000s) [334.861886] Starting dynamic subtest: pipe-D [334.864733] Dynamic subtest pipe-D: SUCCESS (0.000s) [334.867549] Subtest basic: SUCCESS (0.050s) [334.916344] [057/132] (684s left) kms_atomic_interruptible (legacy-setmode) [335.006612] Starting subtest: legacy-setmode [335.008997] Starting dynamic subtest: pipe-A-eDP-1 [341.880327] Dynamic subtest pipe-A-eDP-1: SUCCESS (6.871s) [341.882950] Subtest legacy-setmode: SUCCESS (6.874s) [342.763503] [058/132] (676s left) kms_flip (bo-too-big-interruptible) [342.867010] Starting subtest: bo-too-big-interruptible [342.869775] Starting dynamic subtest: A-eDP1 [344.161721] Dynamic subtest A-eDP1: SUCCESS (1.295s) [344.172595] Starting dynamic subtest: B-eDP1 [345.471898] Dynamic subtest B-eDP1: SUCCESS (1.309s) [345.483525] Starting dynamic subtest: C-eDP1 [346.782034] Dynamic subtest C-eDP1: SUCCESS (1.308s) [346.795012] Starting dynamic subtest: D-eDP1 [348.074218] Dynamic subtest D-eDP1: SUCCESS (1.291s) [348.080754] Subtest bo-too-big-interruptible: SUCCESS (5.215s) [349.289787] [059/132] (670s left) kms_plane_alpha_blend (constant-alpha-max) [349.401869] Starting subtest: constant-alpha-max [349.706700] Starting dynamic subtest: pipe-A-eDP-1 [350.769667] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.054s) [350.780157] Starting dynamic subtest: pipe-D-eDP-1 [352.477835] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.715s) [352.480233] Subtest constant-alpha-max: SUCCESS (3.079s) [353.369875] [060/132] (666s left) perf (polling-parameterized) [353.513038] Starting subtest: polling-parameterized [373.537782] Subtest polling-parameterized: SUCCESS (20.024s) [373.589061] [061/132] (646s left) kms_pm_rpm (modeset-pc8-residency-stress) [375.117005] Starting subtest: modeset-pc8-residency-stress [375.122832] Subtest modeset-pc8-residency-stress: SKIP (0.000s) [375.857368] [062/132] (643s left) gem_pwrite (basic-exhaustion) [375.921740] Subtest basic-exhaustion: SKIP (0.000s) [375.989879] [063/132] (643s left) kms_psr (fbc-pr-sprite-mmap-cpu) [376.082501] Starting subtest: fbc-pr-sprite-mmap-cpu [376.086818] Subtest fbc-pr-sprite-mmap-cpu: SKIP (0.000s) [376.178396] [064/132] (643s left) kms_chamelium_hpd (dp-hpd-enable-disable-mode) [376.568408] Subtest dp-hpd-enable-disable-mode: SKIP (0.000s) [377.416763] [065/132] (642s left) perf_pmu (all-busy-idle-check-all) [377.463582] Starting subtest: all-busy-idle-check-all [378.759635] Subtest all-busy-idle-check-all: SUCCESS (1.297s) [378.898284] [066/132] (641s left) drm_read (short-buffer-block) [379.058714] Starting subtest: short-buffer-block [379.061323] Subtest short-buffer-block: SUCCESS (0.000s) [379.226181] [067/132] (640s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip) [379.334808] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip [379.339714] Subtest y-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip: SKIP (0.000s) [379.475392] [068/132] (640s left) gem_create (create-ext-cpu-access-big) [379.650023] Starting subtest: create-ext-cpu-access-big [379.655819] Subtest create-ext-cpu-access-big: SKIP (0.001s) [379.751539] [069/132] (640s left) gem_eio (suspend) [379.970750] Starting subtest: suspend [392.208619] Subtest suspend: SUCCESS (12.241s) [392.384306] [070/132] (627s left) gem_exec_reloc (basic-active) [392.457701] Subtest basic-active: SKIP (0.000s) [392.540403] [071/132] (627s left) syncobj_timeline (invalid-single-wait-all-unsubmitted) [392.605931] Starting subtest: invalid-single-wait-all-unsubmitted [392.608873] Subtest invalid-single-wait-all-unsubmitted: SUCCESS (0.000s) [392.738277] [072/132] (627s left) dumb_buffer (invalid-bpp) [392.792828] Starting subtest: invalid-bpp [392.795225] Subtest invalid-bpp: SUCCESS (0.000s) [392.931526] [073/132] (627s left) prime_vgem (fence-write-hang) [393.012238] Subtest fence-write-hang: SKIP (0.000s) [393.140508] [074/132] (627s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-render) [393.241140] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-render [400.488007] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-render: SUCCESS (7.249s) [400.659512] [075/132] (619s left) kms_color (gamma) [400.765204] Starting subtest: gamma [400.767782] Starting dynamic subtest: pipe-A-eDP-1 [401.486040] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.721s) [401.496986] Starting dynamic subtest: pipe-B-eDP-1 [402.924764] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.438s) [402.935216] Starting dynamic subtest: pipe-C-eDP-1 [404.259027] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.336s) [404.269909] Starting dynamic subtest: pipe-D-eDP-1 [405.664907] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.405s) [405.667861] Subtest gamma: SUCCESS (4.903s) [406.563824] [076/132] (613s left) kms_ccs (bad-rotation-90-y-tiled-gen12-mc-ccs) [406.656453] Starting subtest: bad-rotation-90-y-tiled-gen12-mc-ccs [406.658638] Starting dynamic subtest: pipe-A-eDP-1 [406.681381] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [406.693079] Starting dynamic subtest: pipe-B-eDP-1 [406.718702] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [406.728729] Starting dynamic subtest: pipe-C-eDP-1 [406.753623] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [406.763763] Starting dynamic subtest: pipe-D-eDP-1 [406.789906] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [406.794782] Subtest bad-rotation-90-y-tiled-gen12-mc-ccs: SKIP (0.005s) [408.960654] [077/132] (611s left) kms_ccs (crc-primary-basic-yf-tiled-ccs) [409.064590] Starting subtest: crc-primary-basic-yf-tiled-ccs [409.066866] Starting dynamic subtest: pipe-A-eDP-1 [409.089402] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [409.101695] Starting dynamic subtest: pipe-B-eDP-1 [409.126786] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [409.136865] Starting dynamic subtest: pipe-C-eDP-1 [409.162186] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [409.171920] Starting dynamic subtest: pipe-D-eDP-1 [409.197859] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [409.202695] Subtest crc-primary-basic-yf-tiled-ccs: SKIP (0.006s) [411.355241] [078/132] (609s left) gem_exec_whisper (basic-sync-all) [411.425563] Starting subtest: basic-sync-all [419.318155] Subtest basic-sync-all: SUCCESS (7.892s) [419.529563] [079/132] (600s left) kms_invalid_mode (bad-hsync-start) [419.633900] Starting subtest: bad-hsync-start [419.636735] Starting dynamic subtest: pipe-A-eDP-1 [419.925618] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.295s) [419.937029] Starting dynamic subtest: pipe-B-eDP-1 [419.939851] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s) [419.949887] Starting dynamic subtest: pipe-C-eDP-1 [419.952419] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s) [419.961890] Starting dynamic subtest: pipe-D-eDP-1 [419.964356] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s) [419.966692] Subtest bad-hsync-start: SUCCESS (0.301s) [420.754022] [080/132] (599s left) kms_big_fb (yf-tiled-8bpp-rotate-90) [420.872039] Starting subtest: yf-tiled-8bpp-rotate-90 [420.876892] Subtest yf-tiled-8bpp-rotate-90: SKIP (0.000s) [421.002923] [081/132] (599s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-indfb-plflip-blt) [421.100802] Starting subtest: fbc-2p-scndscrn-indfb-plflip-blt [421.105767] Subtest fbc-2p-scndscrn-indfb-plflip-blt: SKIP (0.000s) [421.237435] [082/132] (599s left) syncobj_wait (single-wait-all-for-submit-unsubmitted) [421.291864] Starting subtest: single-wait-all-for-submit-unsubmitted [421.394920] Subtest single-wait-all-for-submit-unsubmitted: SUCCESS (0.103s) [421.497241] [083/132] (599s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-move) [421.593627] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-move [421.597765] Subtest fbcpsr-2p-scndscrn-cur-indfb-move: SKIP (0.000s) [421.720988] [084/132] (599s left) prime_mmap (test_forked) [421.780453] Starting subtest: test_forked [421.782733] Starting dynamic subtest: test_forked-smem [421.816526] Dynamic subtest test_forked-smem: SUCCESS (0.037s) [421.818999] Subtest test_forked: SUCCESS (0.039s) [421.946152] [085/132] (598s left) gem_exec_balancer (parallel) [422.210068] Starting subtest: parallel [423.126185] Subtest parallel: SUCCESS (0.917s) [423.812120] [086/132] (597s left) gem_exec_flush (basic-batch-kernel-default-uc) [423.881870] Starting subtest: basic-batch-kernel-default-uc [430.785013] Subtest basic-batch-kernel-default-uc: SUCCESS (6.906s) [430.998373] [087/132] (589s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-mmap-wc) [431.099871] Starting subtest: fbcpsr-rgb565-draw-mmap-wc [437.884277] Subtest fbcpsr-rgb565-draw-mmap-wc: SUCCESS (6.789s) [438.047451] [088/132] (582s left) kms_chamelium_frames (dp-crc-multiple) [438.434021] Subtest dp-crc-multiple: SKIP (0.000s) [439.191499] [089/132] (581s left) kms_psr2_sf (psr2-primary-plane-update-sf-dmg-area) [444.308413] Starting subtest: psr2-primary-plane-update-sf-dmg-area [444.310804] Starting dynamic subtest: pipe-A-eDP-1 [450.791336] Dynamic subtest pipe-A-eDP-1: SUCCESS (6.484s) [450.808838] Starting dynamic subtest: pipe-B-eDP-1 [457.279744] Dynamic subtest pipe-B-eDP-1: SUCCESS (6.489s) [457.282732] Subtest psr2-primary-plane-update-sf-dmg-area: SUCCESS (12.977s) [458.136669] [090/132] (562s left) kms_atomic_transition (plane-all-transition-nonblocking) [458.238894] Starting subtest: plane-all-transition-nonblocking [458.241522] Starting dynamic subtest: pipe-A-eDP-1 [460.732315] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.495s) [461.036586] Starting dynamic subtest: pipe-B-eDP-1 [464.313680] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.287s) [464.626191] Subtest plane-all-transition-nonblocking: SUCCESS (6.389s) [465.439132] [091/132] (555s left) gem_ctx_shared (q-independent) [465.516034] Starting subtest: Q-independent [465.518627] Starting dynamic subtest: rcs0 [465.627731] Dynamic subtest rcs0: SUCCESS (0.113s) [465.639623] Starting dynamic subtest: vcs0 [465.673577] Dynamic subtest vcs0: SUCCESS (0.045s) [465.684756] Starting dynamic subtest: vcs1 [465.715148] Dynamic subtest vcs1: SUCCESS (0.041s) [465.726455] Starting dynamic subtest: vecs0 [465.756179] Dynamic subtest vecs0: SUCCESS (0.040s) [465.767636] Starting dynamic subtest: ccs0 [465.818737] Dynamic subtest ccs0: SUCCESS (0.062s) [465.821908] Subtest Q-independent: SUCCESS (0.306s) [466.922154] [092/132] (554s left) kms_atomic_transition (plane-primary-toggle-with-vblank-wait) [467.015988] Starting subtest: plane-primary-toggle-with-vblank-wait [467.018723] Starting dynamic subtest: pipe-A-eDP-1 [467.188582] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.174s) [467.497005] Starting dynamic subtest: pipe-B-eDP-1 [468.378615] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.893s) [468.692008] Subtest plane-primary-toggle-with-vblank-wait: SUCCESS (1.678s) [469.533490] [093/132] (551s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-pwrite) [469.636343] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-pwrite [474.029956] Subtest fbc-1p-primscrn-spr-indfb-draw-pwrite: SUCCESS (4.399s) [475.254381] [094/132] (545s left) kms_flip (single-buffer-flip-vs-dpms-off-vs-modeset) [475.360086] Starting subtest: single-buffer-flip-vs-dpms-off-vs-modeset [475.362409] Starting dynamic subtest: A-eDP1 [479.037501] Dynamic subtest A-eDP1: SUCCESS (3.673s) [479.048528] Starting dynamic subtest: B-eDP1 [482.324947] Dynamic subtest B-eDP1: SUCCESS (3.288s) [482.337851] Starting dynamic subtest: C-eDP1 [485.635144] Dynamic subtest C-eDP1: SUCCESS (3.312s) [485.648816] Starting dynamic subtest: D-eDP1 [488.938991] Dynamic subtest D-eDP1: SUCCESS (3.301s) [488.941684] Subtest single-buffer-flip-vs-dpms-off-vs-modeset: SUCCESS (13.582s) [489.826557] [095/132] (531s left) syncobj_basic (bad-pad-fd-to-handle) [489.883563] Starting subtest: bad-pad-fd-to-handle [489.885805] Subtest bad-pad-fd-to-handle: SUCCESS (0.000s) [490.020894] [096/132] (531s left) kms_psr (psr-sprite-plane-onoff) [490.107998] Starting subtest: psr-sprite-plane-onoff [490.110788] Starting dynamic subtest: eDP-1 [491.926690] Dynamic subtest eDP-1: SUCCESS (1.820s) [491.929510] Subtest psr-sprite-plane-onoff: SUCCESS (1.821s) [492.828719] [097/132] (528s left) syncobj_timeline (etime-single-wait-for-submit-available-unsubmitted) [492.885362] Starting subtest: etime-single-wait-for-submit-available-unsubmitted [492.985804] Subtest etime-single-wait-for-submit-available-unsubmitted: SUCCESS (0.101s) [493.085987] [098/132] (528s left) gem_exec_schedule (u-submit-early-slice) [493.155806] Starting subtest: u-submit-early-slice [493.158044] Starting dynamic subtest: rcs0 [493.195417] Dynamic subtest rcs0: SUCCESS (0.049s) [493.206021] Starting dynamic subtest: bcs0 [493.235079] Dynamic subtest bcs0: SUCCESS (0.039s) [493.245459] Starting dynamic subtest: vcs0 [493.279444] Dynamic subtest vcs0: SUCCESS (0.043s) [493.290185] Starting dynamic subtest: vcs1 [493.325618] Dynamic subtest vcs1: SUCCESS (0.046s) [493.337502] Starting dynamic subtest: vecs0 [493.370704] Dynamic subtest vecs0: SUCCESS (0.044s) [493.380792] Starting dynamic subtest: ccs0 [493.410926] Dynamic subtest ccs0: SUCCESS (0.040s) [493.413736] Subtest u-submit-early-slice: SUCCESS (0.265s) [494.869478] [099/132] (526s left) kms_cursor_legacy (cursora-vs-flipb-varying-size) [494.997525] Starting subtest: cursorA-vs-flipB-varying-size [495.001791] Subtest cursorA-vs-flipB-varying-size: SKIP (0.001s) [495.182485] [100/132] (526s left) kms_properties (connector-properties-atomic) [495.289785] Starting subtest: connector-properties-atomic [495.292364] Starting dynamic subtest: pipe-A-eDP-1 [503.364446] Dynamic subtest pipe-A-eDP-1: SUCCESS (8.077s) [503.374874] Starting dynamic subtest: pipe-None-DP-1 [503.380035] Dynamic subtest pipe-None-DP-1: SUCCESS (0.001s) [503.390343] Starting dynamic subtest: pipe-None-HDMI-A-1 [503.394863] Dynamic subtest pipe-None-HDMI-A-1: SUCCESS (0.001s) [503.404674] Starting dynamic subtest: pipe-None-DP-2 [503.409161] Dynamic subtest pipe-None-DP-2: SUCCESS (0.001s) [503.418675] Starting dynamic subtest: pipe-None-HDMI-A-2 [503.422913] Dynamic subtest pipe-None-HDMI-A-2: SUCCESS (0.001s) [503.432260] Starting dynamic subtest: pipe-None-DP-3 [503.441797] Dynamic subtest pipe-None-DP-3: SUCCESS (0.001s) [503.453126] Starting dynamic subtest: pipe-None-DP-4 [503.457515] Dynamic subtest pipe-None-DP-4: SUCCESS (0.001s) [503.459840] Subtest connector-properties-atomic: SUCCESS (8.088s) [504.226792] [101/132] (517s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-pwrite) [504.327756] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-pwrite [504.333164] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-pwrite: SKIP (0.000s) [504.451312] [102/132] (517s left) kms_cursor_crc (cursor-alpha-transparent) [504.547001] Starting subtest: cursor-alpha-transparent [504.549409] Starting dynamic subtest: pipe-A-eDP-1 [505.194243] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.646s) [505.205012] Starting dynamic subtest: pipe-D-eDP-1 [506.438285] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.245s) [506.440728] Subtest cursor-alpha-transparent: SUCCESS (1.894s) [507.334438] [103/132] (514s left) gem_exec_schedule (pi-ringfull) [507.523776] Starting subtest: pi-ringfull [507.526021] Starting dynamic subtest: rcs0 [507.556718] Dynamic subtest rcs0: SUCCESS (0.034s) [507.567164] Starting dynamic subtest: bcs0 [507.590904] Dynamic subtest bcs0: SUCCESS (0.033s) [507.606446] Starting dynamic subtest: vcs0 [507.621710] Dynamic subtest vcs0: SUCCESS (0.030s) [507.635875] Starting dynamic subtest: vcs1 [507.652887] Dynamic subtest vcs1: SUCCESS (0.030s) [507.667582] Starting dynamic subtest: vecs0 [507.681993] Dynamic subtest vecs0: SUCCESS (0.028s) [507.697093] Starting dynamic subtest: ccs0 [507.710074] Dynamic subtest ccs0: SUCCESS (0.028s) [507.713040] Subtest pi-ringfull: SUCCESS (0.189s) [507.972512] [104/132] (513s left) kms_flip (2x-flip-vs-fences-interruptible) [508.070784] Starting subtest: 2x-flip-vs-fences-interruptible [508.075989] Subtest 2x-flip-vs-fences-interruptible: SKIP (0.000s) [508.215258] [105/132] (513s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-blt) [508.319087] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-blt [508.324430] Subtest psr-2p-scndscrn-spr-indfb-draw-blt: SKIP (0.000s) [508.444591] [106/132] (513s left) gem_render_copy (yf-tiled-ccs-to-y-tiled) [508.503821] Starting subtest: yf-tiled-ccs-to-y-tiled [508.509011] Subtest yf-tiled-ccs-to-y-tiled: SKIP (0.000s) [508.710766] [107/132] (513s left) kms_plane_scaling (plane-upscale-20x20-with-modifiers) [508.797996] Starting subtest: plane-upscale-20x20-with-modifiers [508.800933] Starting dynamic subtest: pipe-A [509.133614] Dynamic subtest pipe-A: SUCCESS (0.338s) [509.144438] Starting dynamic subtest: pipe-B [510.552278] Dynamic subtest pipe-B: SUCCESS (1.418s) [510.565137] Starting dynamic subtest: pipe-C [511.950939] Dynamic subtest pipe-C: SUCCESS (1.399s) [511.962703] Starting dynamic subtest: pipe-D [513.355530] Dynamic subtest pipe-D: SUCCESS (1.403s) [513.357867] Subtest plane-upscale-20x20-with-modifiers: SUCCESS (4.562s) [514.525744] [108/132] (507s left) kms_cursor_legacy (basic-flip-after-cursor-atomic) [514.648909] Starting subtest: basic-flip-after-cursor-atomic [515.566846] Subtest basic-flip-after-cursor-atomic: SUCCESS (0.916s) [516.429567] [109/132] (505s left) kms_vrr (flipline) [516.538015] Starting subtest: flipline [516.545750] Subtest flipline: SKIP (0.000s) [516.637543] [110/132] (505s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-mmap-cpu) [516.745863] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-mmap-cpu [516.750845] Subtest psr-2p-primscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s) [516.873503] [111/132] (505s left) kms_big_fb (4-tiled-8bpp-rotate-0) [516.968523] Starting subtest: 4-tiled-8bpp-rotate-0 [518.228282] Subtest 4-tiled-8bpp-rotate-0: SUCCESS (1.261s) [518.373077] [112/132] (503s left) kms_sequence (queue-idle) [518.473543] Starting subtest: queue-idle [518.475218] Starting dynamic subtest: pipe-A-eDP-1 [520.274536] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.802s) [520.286064] Starting dynamic subtest: pipe-B-eDP-1 [522.718215] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.440s) [522.729742] Starting dynamic subtest: pipe-C-eDP-1 [525.205769] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.488s) [525.218355] Starting dynamic subtest: pipe-D-eDP-1 [527.605756] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.399s) [527.608641] Subtest queue-idle: SUCCESS (9.135s) [528.434080] [113/132] (493s left) gem_exec_reloc (basic-wc) [528.503871] Subtest basic-wc: SKIP (0.000s) [528.588357] [114/132] (493s left) gem_mmap_gtt (basic-read-write-distinct) [528.651750] Subtest basic-read-write-distinct: SKIP (0.000s) [528.708702] [115/132] (493s left) gem_eio (in-flight-contexts-10ms) [528.943170] Starting subtest: in-flight-contexts-10ms [542.748217] Subtest in-flight-contexts-10ms: SUCCESS (13.808s) [542.947281] [116/132] (479s left) kms_cursor_legacy (torture-move) [543.066880] Starting subtest: torture-move [543.069252] Starting dynamic subtest: pipe-A [549.349372] Dynamic subtest pipe-A: SUCCESS (6.280s) [549.362954] Starting dynamic subtest: pipe-B [555.769303] Dynamic subtest pipe-B: SUCCESS (6.420s) [555.780037] Starting dynamic subtest: pipe-C [562.573776] Dynamic subtest pipe-C: SUCCESS (6.804s) [562.586678] Starting dynamic subtest: pipe-D [569.432920] Dynamic subtest pipe-D: SUCCESS (6.857s) [569.446725] Starting dynamic subtest: all-pipes [576.971049] Dynamic subtest all-pipes: SUCCESS (7.538s) [576.973437] Subtest torture-move: SUCCESS (33.910s) [577.154724] [117/132] (445s left) kms_feature_discovery (display-2x) [577.277846] Starting subtest: display-2x [577.283159] Subtest display-2x: SKIP (0.000s) [577.401757] [118/132] (444s left) syncobj_timeline (single-wait-for-submit-available-signaled) [577.474526] Starting subtest: single-wait-for-submit-available-signaled [577.477043] Subtest single-wait-for-submit-available-signaled: SUCCESS (0.000s) [577.616463] [119/132] (444s left) i915_drm_fdinfo (isolation) [577.665537] Starting subtest: isolation [577.668042] Starting dynamic subtest: rcs0 [577.701661] Dynamic subtest rcs0: SKIP (0.034s) [577.714032] Starting dynamic subtest: bcs0 [577.718858] Dynamic subtest bcs0: SKIP (0.000s) [577.728771] Starting dynamic subtest: vcs0 [577.733872] Dynamic subtest vcs0: SKIP (0.000s) [577.744686] Starting dynamic subtest: vcs1 [577.749737] Dynamic subtest vcs1: SKIP (0.000s) [577.759845] Starting dynamic subtest: vecs0 [577.765012] Dynamic subtest vecs0: SKIP (0.000s) [577.775067] Starting dynamic subtest: ccs0 [577.780583] Dynamic subtest ccs0: SKIP (0.000s) [577.785752] Subtest isolation: SKIP (0.039s) [577.825487] [120/132] (444s left) kms_plane_scaling (planes-unity-scaling-downscale-factor-0-5) [577.933948] Starting subtest: planes-unity-scaling-downscale-factor-0-5 [577.936744] Starting dynamic subtest: pipe-A [577.954460] Dynamic subtest pipe-A: SKIP (0.017s) [577.970515] Starting dynamic subtest: pipe-B [577.987898] Dynamic subtest pipe-B: SKIP (0.032s) [577.998276] Starting dynamic subtest: pipe-C [578.016442] Dynamic subtest pipe-C: SKIP (0.030s) [578.027174] Starting dynamic subtest: pipe-D [578.049851] Dynamic subtest pipe-D: SKIP (0.031s) [578.054286] Subtest planes-unity-scaling-downscale-factor-0-5: SKIP (0.113s) [578.170585] [121/132] (444s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-pwrite) [578.287438] Starting subtest: psr-2p-primscrn-cur-indfb-draw-pwrite [578.291596] Subtest psr-2p-primscrn-cur-indfb-draw-pwrite: SKIP (0.000s) [578.421346] [122/132] (443s left) api_intel_bb (intel-bb-blit-y) [578.481031] Starting subtest: intel-bb-blit-y [582.020537] Subtest intel-bb-blit-y: SUCCESS (3.540s) [582.156283] [123/132] (440s left) kms_frontbuffer_tracking (psr-1p-pri-indfb-multidraw) [582.252722] Starting subtest: psr-1p-pri-indfb-multidraw [605.173920] Subtest psr-1p-pri-indfb-multidraw: SUCCESS (22.929s) [605.326089] [124/132] (417s left) gem_partial_pwrite_pread (writes-after-reads-display) [605.395443] Subtest writes-after-reads-display: SKIP (0.000s) [605.482333] [125/132] (417s left) kms_getfb (getfb-handle-protection) [605.579446] Starting subtest: getfb-handle-protection [605.613088] Subtest getfb-handle-protection: SUCCESS (0.034s) [605.779041] [126/132] (416s left) gem_exec_schedule (u-fairslice-all) [605.858395] Starting subtest: u-fairslice-all [607.925862] Subtest u-fairslice-all: SUCCESS (2.068s) [609.863539] [127/132] (412s left) syncobj_wait (wait-for-submit-delayed-submit) [609.927866] Starting subtest: wait-for-submit-delayed-submit [610.028005] Subtest wait-for-submit-delayed-submit: SUCCESS (0.102s) [610.143805] [128/132] (412s left) gem_madvise (dontneed-after-mmap) [610.179519] Starting subtest: dontneed-after-mmap [610.201177] Subtest dontneed-after-mmap: SUCCESS (0.027s) [610.349395] [129/132] (412s left) kms_psr2_sf (fbc-psr2-overlay-plane-move-continuous-exceed-fully-sf) [615.444037] Starting subtest: fbc-psr2-overlay-plane-move-continuous-exceed-fully-sf [615.446785] Starting dynamic subtest: pipe-A-eDP-1 [616.216610] Dynamic subtest pipe-A-eDP-1: SKIP (0.767s) [616.230605] Starting dynamic subtest: pipe-B-eDP-1 [617.417625] Dynamic subtest pipe-B-eDP-1: SKIP (1.199s) [617.422884] Subtest fbc-psr2-overlay-plane-move-continuous-exceed-fully-sf: SKIP (1.971s) [618.683805] [130/132] (404s left) kms_frontbuffer_tracking (fbc-tiling-linear) [618.793154] Starting subtest: fbc-tiling-linear [622.550234] Subtest fbc-tiling-linear: SUCCESS (3.761s) [623.700023] [131/132] (399s left) gem_userptr_blits (huge-split) [623.776421] Starting subtest: huge-split [623.783411] Subtest huge-split: SUCCESS (0.007s) [623.938831] [132/132] (398s left) kms_properties (colorop-properties-legacy) [624.028680] Starting subtest: colorop-properties-legacy [624.031170] Starting dynamic subtest: pipe-A-eDP-1 [624.389537] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.362s) [624.402150] Starting dynamic subtest: pipe-B-eDP-1 [625.489313] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.100s) [625.500459] Starting dynamic subtest: pipe-C-eDP-1 [626.589012] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.097s) [626.600990] Starting dynamic subtest: pipe-D-eDP-1 [627.677483] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.085s) [627.680200] Subtest colorop-properties-legacy: SUCCESS (3.650s) [628.578728] 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.