[56.997107] Initializing watchdogs [56.997150] /dev/watchdog0 [57.011438] [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.015820] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [57.017997] [FACT before any test] new: kernel.kmod_is_loaded.i915: true [57.021389] [001/133] (960s left) syncobj_timeline (host-signal-ordered) [57.115949] Starting subtest: host-signal-ordered [57.118416] Subtest host-signal-ordered: SUCCESS (0.000s) [57.248599] [002/133] (960s left) kms_addfb_basic (bad-pitch-63) [57.308797] Starting subtest: bad-pitch-63 [57.311123] Subtest bad-pitch-63: SUCCESS (0.000s) [57.470674] [003/133] (960s left) gem_fence_thrash (bo-write-verify-x) [57.504507] Starting subtest: bo-write-verify-x [57.537173] Subtest bo-write-verify-x: SKIP (0.028s) [57.604235] [004/133] (960s left) kms_frontbuffer_tracking (psr-slowdraw) [57.707041] Starting subtest: psr-slowdraw [82.967796] Subtest psr-slowdraw: SUCCESS (25.265s) [83.123761] [005/133] (934s left) kms_dp_link_training (uhbr-mst) [83.210696] Starting subtest: uhbr-mst [83.219417] Subtest uhbr-mst: SKIP (0.000s) [83.289445] [006/133] (934s left) kms_ccs (random-ccs-data-y-tiled-gen12-rc-ccs) [83.382050] Starting subtest: random-ccs-data-y-tiled-gen12-rc-ccs [83.384461] Starting dynamic subtest: pipe-A-eDP-1 [83.410405] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [83.424927] Starting dynamic subtest: pipe-B-eDP-1 [83.448794] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [83.456088] Starting dynamic subtest: pipe-C-eDP-1 [83.480175] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [83.487592] Starting dynamic subtest: pipe-D-eDP-1 [83.512066] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [83.516178] Subtest random-ccs-data-y-tiled-gen12-rc-ccs: SKIP (0.003s) [85.550503] [007/133] (932s left) syncobj_eventfd (invalid-bad-flags) [85.607831] Starting subtest: invalid-bad-flags [85.610096] Subtest invalid-bad-flags: SUCCESS (0.000s) [85.712532] [008/133] (932s left) gem_workarounds (reset-fd) [85.780642] Starting subtest: reset-fd [85.882065] Subtest reset-fd: SUCCESS (0.101s) [86.005380] [009/133] (931s left) kms_chamelium_hpd (hdmi-hpd-fast) [86.381808] Subtest hdmi-hpd-fast: SKIP (0.000s) [87.154205] [010/133] (930s left) fbdev (read) [87.206708] Starting subtest: read [87.736361] Subtest read: SUCCESS (0.530s) [87.812455] [011/133] (930s left) gen7_exec_parse (basic-offset) [87.877301] Subtest basic-offset: SKIP (0.000s) [87.931877] [012/133] (930s left) core_auth (many-magics) [87.986584] Starting subtest: many-magics [88.911884] Subtest many-magics: SUCCESS (0.927s) [89.124163] [013/133] (928s left) kms_big_fb (linear-16bpp-rotate-0) [89.232909] Starting subtest: linear-16bpp-rotate-0 [90.566551] Subtest linear-16bpp-rotate-0: SUCCESS (1.333s) [90.724112] [014/133] (927s left) kms_big_fb (x-tiled-16bpp-rotate-0) [90.825919] Starting subtest: x-tiled-16bpp-rotate-0 [92.182493] Subtest x-tiled-16bpp-rotate-0: SUCCESS (1.357s) [92.344949] [015/133] (925s left) gem_pread (bench) [92.406055] Subtest bench: SKIP (0.000s) [92.471167] [016/133] (925s left) kms_flip_scaled_crc (flip-32bpp-yftile-to-64bpp-yftile-downscaling) [92.563382] Starting subtest: flip-32bpp-yftile-to-64bpp-yftile-downscaling [92.566896] Subtest flip-32bpp-yftile-to-64bpp-yftile-downscaling: SKIP (0.000s) [92.644059] [017/133] (925s left) kms_vrr (seamless-rr-switch-virtual) [92.741059] Starting subtest: seamless-rr-switch-virtual [92.746351] Subtest seamless-rr-switch-virtual: SKIP (0.000s) [92.819398] [018/133] (925s left) kms_properties (plane-properties-legacy) [92.916304] Starting subtest: plane-properties-legacy [92.918314] Starting dynamic subtest: pipe-A-eDP-1 [93.470215] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.553s) [93.479721] Starting dynamic subtest: pipe-B-eDP-1 [94.757104] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.287s) [94.768139] Starting dynamic subtest: pipe-C-eDP-1 [95.994875] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.236s) [96.003824] Starting dynamic subtest: pipe-D-eDP-1 [97.225073] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.227s) [97.227061] Subtest plane-properties-legacy: SUCCESS (4.308s) [98.027573] [019/133] (920s left) i915_pm_sseu (full-enable) [98.096903] Subtest full-enable: SKIP (0.000s) [98.224341] [020/133] (920s left) kms_busy (basic-hang) [98.332406] Starting subtest: basic-hang [98.337431] Starting dynamic subtest: flip-pipe-A [98.962757] Dynamic subtest flip-pipe-A: SUCCESS (0.626s) [98.971432] Starting dynamic subtest: modeset-pipe-A [102.334417] Dynamic subtest modeset-pipe-A: SUCCESS (3.373s) [102.345254] Starting dynamic subtest: flip-pipe-D [103.541726] Dynamic subtest flip-pipe-D: SUCCESS (1.202s) [103.550836] Starting dynamic subtest: modeset-pipe-D [107.192863] Dynamic subtest modeset-pipe-D: SUCCESS (3.652s) [107.195228] Subtest basic-hang: SUCCESS (8.860s) [108.004832] [021/133] (910s left) gem_exec_schedule (preempt-hang) [108.175907] Starting subtest: preempt-hang [108.178072] Starting dynamic subtest: rcs0 [108.417697] Dynamic subtest rcs0: SUCCESS (0.242s) [108.428216] Starting dynamic subtest: bcs0 [108.656786] Dynamic subtest bcs0: SUCCESS (0.239s) [108.667123] Starting dynamic subtest: vcs0 [108.854433] Dynamic subtest vcs0: SUCCESS (0.197s) [108.865415] Starting dynamic subtest: vcs1 [109.062180] Dynamic subtest vcs1: SUCCESS (0.207s) [109.073062] Starting dynamic subtest: vecs0 [109.277619] Dynamic subtest vecs0: SUCCESS (0.214s) [109.287921] Starting dynamic subtest: ccs0 [109.511677] Dynamic subtest ccs0: SUCCESS (0.233s) [109.513791] Subtest preempt-hang: SUCCESS (1.336s) [110.040673] [022/133] (908s left) kms_psr (pr-cursor-mmap-cpu) [110.146927] Starting subtest: pr-cursor-mmap-cpu [110.151356] Subtest pr-cursor-mmap-cpu: SKIP (0.000s) [110.239297] [023/133] (908s left) perf_pmu (semaphore-busy) [110.283803] Starting subtest: semaphore-busy [110.285908] Starting dynamic subtest: rcs0 [111.956874] Dynamic subtest rcs0: SUCCESS (1.668s) [111.967220] Starting dynamic subtest: bcs0 [113.586493] Dynamic subtest bcs0: SUCCESS (1.627s) [113.597646] Starting dynamic subtest: vcs0 [117.391169] Dynamic subtest vcs0: SUCCESS (3.803s) [117.402495] Starting dynamic subtest: vcs1 [123.407153] Dynamic subtest vcs1: SUCCESS (6.015s) [123.418332] Starting dynamic subtest: vecs0 [129.425835] Dynamic subtest vecs0: SUCCESS (6.016s) [129.436846] Starting dynamic subtest: ccs0 [132.437537] Dynamic subtest ccs0: SUCCESS (3.011s) [132.440919] Subtest semaphore-busy: SUCCESS (22.151s) [132.578640] [024/133] (885s left) kms_plane_scaling (plane-scaler-unity-scaling-with-rotation) [132.685856] Starting subtest: plane-scaler-unity-scaling-with-rotation [132.687821] Starting dynamic subtest: pipe-A [132.912116] Dynamic subtest pipe-A: SUCCESS (0.228s) [132.920061] Starting dynamic subtest: pipe-B [134.168917] Dynamic subtest pipe-B: SUCCESS (1.256s) [134.178895] Starting dynamic subtest: pipe-C [135.502575] Dynamic subtest pipe-C: SUCCESS (1.333s) [135.512296] Starting dynamic subtest: pipe-D [136.829124] Dynamic subtest pipe-D: SUCCESS (1.326s) [136.831394] Subtest plane-scaler-unity-scaling-with-rotation: SUCCESS (4.146s) [138.024053] [025/133] (880s left) api_intel_bb (destroy-bb) [138.081888] Starting subtest: destroy-bb [138.087053] Subtest destroy-bb: SUCCESS (0.007s) [138.209898] [026/133] (880s left) kms_color (deep-color) [138.302217] Starting subtest: deep-color [139.387845] Starting dynamic subtest: pipe-A-eDP-1-gamma [140.099305] Dynamic subtest pipe-A-eDP-1-gamma: SUCCESS (0.710s) [140.107874] Starting dynamic subtest: pipe-A-eDP-1-degamma [141.601378] Dynamic subtest pipe-A-eDP-1-degamma: SUCCESS (1.501s) [141.609963] Starting dynamic subtest: pipe-A-eDP-1-ctm [143.044598] Dynamic subtest pipe-A-eDP-1-ctm: SUCCESS (1.443s) [143.797685] Starting dynamic subtest: pipe-B-eDP-1-gamma [144.497301] Dynamic subtest pipe-B-eDP-1-gamma: SUCCESS (0.705s) [144.506440] Starting dynamic subtest: pipe-B-eDP-1-degamma [145.901600] Dynamic subtest pipe-B-eDP-1-degamma: SUCCESS (1.403s) [145.910694] Starting dynamic subtest: pipe-B-eDP-1-ctm [147.303656] Dynamic subtest pipe-B-eDP-1-ctm: SUCCESS (1.402s) [148.095489] Starting dynamic subtest: pipe-C-eDP-1-gamma [148.778171] Dynamic subtest pipe-C-eDP-1-gamma: SUCCESS (0.693s) [148.787127] Starting dynamic subtest: pipe-C-eDP-1-degamma [150.150522] Dynamic subtest pipe-C-eDP-1-degamma: SUCCESS (1.370s) [150.159337] Starting dynamic subtest: pipe-C-eDP-1-ctm [151.549306] Dynamic subtest pipe-C-eDP-1-ctm: SUCCESS (1.400s) [152.300764] Starting dynamic subtest: pipe-D-eDP-1-gamma [152.996403] Dynamic subtest pipe-D-eDP-1-gamma: SUCCESS (0.700s) [153.005239] Starting dynamic subtest: pipe-D-eDP-1-degamma [154.358132] Dynamic subtest pipe-D-eDP-1-degamma: SUCCESS (1.362s) [154.367056] Starting dynamic subtest: pipe-D-eDP-1-ctm [155.778228] Dynamic subtest pipe-D-eDP-1-ctm: SUCCESS (1.419s) [155.780065] Subtest deep-color: SUCCESS (17.476s) [156.670629] [027/133] (861s left) dmabuf_sync_file (import-basic) [156.788252] Starting subtest: import-basic [156.790514] Subtest import-basic: SUCCESS (0.001s) [156.865622] [FACT dmabuf_sync_file (import-basic)] new: kernel.kmod_is_loaded.vgem: true [156.868947] [028/133] (861s left) gem_mmap (basic-small-bo) [156.916682] Subtest basic-small-bo: SKIP (0.000s) [156.976494] [029/133] (861s left) gem_mmap_wc (fault-concurrent) [157.027082] Subtest fault-concurrent: SKIP (0.000s) [157.082547] [030/133] (861s left) kms_big_fb (y-tiled-8bpp-rotate-180) [157.187171] Starting subtest: y-tiled-8bpp-rotate-180 [157.191108] Subtest y-tiled-8bpp-rotate-180: SKIP (0.000s) [157.307988] [031/133] (861s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-pwrite) [157.403958] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-pwrite [157.408286] Subtest fbc-2p-primscrn-spr-indfb-draw-pwrite: SKIP (0.000s) [157.514052] [032/133] (861s left) gem_caching (reads) [157.578561] Subtest reads: SKIP (0.000s) [157.655767] [033/133] (861s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-shrfb-pgflip-blt) [157.758248] Starting subtest: fbcpsr-1p-primscrn-shrfb-pgflip-blt [165.186588] Subtest fbcpsr-1p-primscrn-shrfb-pgflip-blt: SUCCESS (7.429s) [165.354318] [034/133] (853s left) gem_exec_flush (basic-wb-pro-default) [165.430375] Starting subtest: basic-wb-pro-default [170.895373] Subtest basic-wb-pro-default: SUCCESS (5.456s) [171.113917] [035/133] (847s left) kms_frontbuffer_tracking (psr-rgb101010-draw-mmap-gtt) [171.216499] Starting subtest: psr-rgb101010-draw-mmap-gtt [171.220604] Subtest psr-rgb101010-draw-mmap-gtt: SKIP (0.000s) [171.342756] [036/133] (847s left) kms_frontbuffer_tracking (fbcpsr-suspend) [171.446750] Starting subtest: fbcpsr-suspend [212.417768] Subtest fbcpsr-suspend: SUCCESS (11.909s) [212.603349] [037/133] (806s left) kms_ccs (crc-sprite-planes-basic-4-tiled-bmg-ccs) [212.707903] Starting subtest: crc-sprite-planes-basic-4-tiled-bmg-ccs [212.712445] Subtest crc-sprite-planes-basic-4-tiled-bmg-ccs: SKIP (0.000s) [213.857332] [038/133] (805s left) i915_getparams_basic (basic-eu-total) [213.928088] Starting subtest: basic-eu-total [213.932494] Subtest basic-eu-total: SUCCESS (0.000s) [214.051702] [039/133] (804s left) kms_pipe_crc_basic (hang-read-crc) [214.143902] Starting subtest: hang-read-crc [214.146067] Starting dynamic subtest: pipe-A-eDP-1 [216.218498] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.072s) [216.229766] Starting dynamic subtest: pipe-B-eDP-1 [219.110155] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.890s) [219.120208] Starting dynamic subtest: pipe-C-eDP-1 [221.734845] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.623s) [221.744483] Starting dynamic subtest: pipe-D-eDP-1 [224.392675] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.654s) [224.394940] Subtest hang-read-crc: SUCCESS (10.245s) [225.235900] [040/133] (793s left) kms_fence_pin_leak [225.426024] [041/133] (793s left) syncobj_timeline (wait-all-interrupted) [225.485995] Starting subtest: wait-all-interrupted [225.591077] Subtest wait-all-interrupted: SUCCESS (0.103s) [225.682149] [042/133] (793s left) kms_cursor_legacy (short-flip-after-cursor-atomic-transitions) [225.805100] Starting subtest: short-flip-after-cursor-atomic-transitions [226.756534] Subtest short-flip-after-cursor-atomic-transitions: SUCCESS (0.952s) [227.567245] [043/133] (791s left) gem_tiled_swapping (non-threaded) [227.626594] Subtest non-threaded: SKIP (0.000s) [227.693916] [044/133] (791s left) kms_flip_scaled_crc (flip-64bpp-linear-to-16bpp-linear-downscaling) [227.794626] Starting subtest: flip-64bpp-linear-to-16bpp-linear-downscaling [227.796802] Starting dynamic subtest: pipe-A-default-mode [228.916003] Dynamic subtest pipe-A-default-mode: SKIP (1.117s) [228.919956] Subtest flip-64bpp-linear-to-16bpp-linear-downscaling: SKIP (1.118s) [229.081332] [045/133] (790s left) gem_ctx_shared (q-independent) [229.138981] Starting subtest: Q-independent [229.140912] Starting dynamic subtest: rcs0 [229.206158] Dynamic subtest rcs0: SUCCESS (0.070s) [229.217961] Starting dynamic subtest: vcs0 [229.247375] Dynamic subtest vcs0: SUCCESS (0.040s) [229.268171] Starting dynamic subtest: vcs1 [229.298488] Dynamic subtest vcs1: SUCCESS (0.050s) [229.310789] Starting dynamic subtest: vecs0 [229.340421] Dynamic subtest vecs0: SUCCESS (0.041s) [229.350245] Starting dynamic subtest: ccs0 [229.395633] Dynamic subtest ccs0: SUCCESS (0.054s) [229.398412] Subtest Q-independent: SUCCESS (0.260s) [231.091880] [046/133] (788s left) kms_ccs (ccs-on-another-bo-4-tiled-mtl-rc-ccs) [231.181560] Starting subtest: ccs-on-another-bo-4-tiled-mtl-rc-ccs [231.183867] Starting dynamic subtest: pipe-A-eDP-1 [231.204023] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s) [231.215830] Starting dynamic subtest: pipe-B-eDP-1 [231.234856] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s) [231.243498] Starting dynamic subtest: pipe-C-eDP-1 [231.262776] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s) [231.272680] Starting dynamic subtest: pipe-D-eDP-1 [231.291742] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s) [231.293634] Subtest ccs-on-another-bo-4-tiled-mtl-rc-ccs: SUCCESS (0.008s) [233.460875] [047/133] (785s left) gem_pread (display) [233.522676] Subtest display: SKIP (0.000s) [233.583883] [048/133] (785s left) gem_render_copy (yf-tiled-ccs-to-yf-tiled) [233.651867] Starting subtest: yf-tiled-ccs-to-yf-tiled [233.656313] Subtest yf-tiled-ccs-to-yf-tiled: SKIP (0.000s) [233.847728] [049/133] (785s left) kms_frontbuffer_tracking (fbcpsr-farfromfence-mmap-gtt) [233.944190] Starting subtest: fbcpsr-farfromfence-mmap-gtt [233.948346] Subtest fbcpsr-farfromfence-mmap-gtt: SKIP (0.000s) [234.084004] [050/133] (785s left) gem_mmap_gtt (basic-read-write) [234.148239] Subtest basic-read-write: SKIP (0.000s) [234.216823] [051/133] (785s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-render) [234.314433] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-render [234.318830] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-render: SKIP (0.000s) [234.430767] [052/133] (785s left) kms_flip (plain-flip-ts-check-interruptible) [234.531032] Starting subtest: plain-flip-ts-check-interruptible [234.533190] Starting dynamic subtest: A-eDP1 [243.372231] Dynamic subtest A-eDP1: SUCCESS (8.806s) [243.383062] Starting dynamic subtest: B-eDP1 [252.210773] Dynamic subtest B-eDP1: SUCCESS (8.832s) [252.220106] Starting dynamic subtest: C-eDP1 [261.051402] Dynamic subtest C-eDP1: SUCCESS (8.824s) [261.063646] Starting dynamic subtest: D-eDP1 [269.885395] Dynamic subtest D-eDP1: SUCCESS (8.828s) [269.887908] Subtest plain-flip-ts-check-interruptible: SUCCESS (35.302s) [271.032042] [053/133] (748s left) kms_big_fb (4-tiled-16bpp-rotate-90) [271.137026] Starting subtest: 4-tiled-16bpp-rotate-90 [271.156976] Subtest 4-tiled-16bpp-rotate-90: SKIP (0.019s) [271.286138] [054/133] (748s left) gem_exec_params (invalid-bsd1-flag-on-blt) [271.339968] Starting subtest: invalid-bsd1-flag-on-blt [271.342408] Subtest invalid-bsd1-flag-on-blt: SUCCESS (0.000s) [271.448956] [055/133] (748s left) prime_vgem (busy) [271.525775] Starting subtest: busy [271.528055] Starting dynamic subtest: rcs0 [271.575513] Dynamic subtest rcs0: SUCCESS (0.050s) [271.584979] Starting dynamic subtest: bcs0 [271.634200] Dynamic subtest bcs0: SUCCESS (0.058s) [271.643882] Starting dynamic subtest: vcs0 [271.683553] Dynamic subtest vcs0: SUCCESS (0.048s) [271.693260] Starting dynamic subtest: vcs1 [271.728152] Dynamic subtest vcs1: SUCCESS (0.044s) [271.737091] Starting dynamic subtest: vecs0 [271.774070] Dynamic subtest vecs0: SUCCESS (0.045s) [271.782988] Starting dynamic subtest: ccs0 [271.822141] Dynamic subtest ccs0: SUCCESS (0.047s) [271.823686] Subtest busy: SUCCESS (0.297s) [271.982096] [056/133] (747s left) gem_lmem_swapping (parallel-random-verify-ccs) [272.028453] Subtest parallel-random-verify-ccs: SKIP (0.000s) [272.074661] [057/133] (747s left) kms_flip (2x-flip-vs-modeset-vs-hang) [272.166795] Starting subtest: 2x-flip-vs-modeset-vs-hang [272.176559] Subtest 2x-flip-vs-modeset-vs-hang: SKIP (0.011s) [272.267801] [058/133] (747s left) gem_ctx_create (basic-files) [272.329463] Starting subtest: basic-files [274.376150] Subtest basic-files: SUCCESS (2.045s) [276.045811] [059/133] (743s left) sysfs_timeslice_duration (timeout) [276.115840] Starting subtest: timeout [276.117989] Starting dynamic subtest: vecs0 [285.992805] Dynamic subtest vecs0: SUCCESS (9.873s) [286.004889] Starting dynamic subtest: ccs0 [287.369081] Dynamic subtest ccs0: SUCCESS (1.375s) [287.380946] Starting dynamic subtest: vcs0 [297.000843] Dynamic subtest vcs0: SUCCESS (9.625s) [297.012630] Starting dynamic subtest: bcs0 [297.699306] Dynamic subtest bcs0: SUCCESS (0.698s) [297.711027] Starting dynamic subtest: rcs0 [299.060505] Dynamic subtest rcs0: SUCCESS (1.357s) [299.072923] Starting dynamic subtest: vcs1 [308.948360] Dynamic subtest vcs1: SUCCESS (9.885s) [308.951028] Subtest timeout: SUCCESS (32.828s) [309.050740] [060/133] (710s left) kms_psr (fbc-pr-no-drrs) [309.152585] Starting subtest: fbc-pr-no-drrs [309.156905] Subtest fbc-pr-no-drrs: SKIP (0.000s) [309.253039] [061/133] (710s left) kms_ccs (crc-primary-rotation-180-y-tiled-gen12-rc-ccs-cc) [309.344038] Starting subtest: crc-primary-rotation-180-y-tiled-gen12-rc-ccs-cc [309.346305] Starting dynamic subtest: pipe-A-eDP-1 [309.369498] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [309.381666] Starting dynamic subtest: pipe-B-eDP-1 [309.403420] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [309.412817] Starting dynamic subtest: pipe-C-eDP-1 [309.435247] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [309.444531] Starting dynamic subtest: pipe-D-eDP-1 [309.466797] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [309.470799] Subtest crc-primary-rotation-180-y-tiled-gen12-rc-ccs-cc: SKIP (0.006s) [311.593504] [062/133] (708s left) syncobj_wait (invalid-reset-bad-pad) [311.646371] Starting subtest: invalid-reset-bad-pad [311.648614] Subtest invalid-reset-bad-pad: SUCCESS (0.000s) [311.752916] [063/133] (708s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-shrfb-draw-mmap-wc) [311.857067] Starting subtest: fbc-1p-offscreen-pri-shrfb-draw-mmap-wc [315.869055] Subtest fbc-1p-offscreen-pri-shrfb-draw-mmap-wc: SUCCESS (4.017s) [317.010162] [064/133] (703s left) kms_sequence (queue-busy) [317.108408] Starting subtest: queue-busy [317.110436] Starting dynamic subtest: pipe-A-eDP-1 [319.030604] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.922s) [319.040705] Starting dynamic subtest: pipe-B-eDP-1 [321.663199] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.633s) [321.673297] Starting dynamic subtest: pipe-C-eDP-1 [324.279508] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.614s) [324.289851] Starting dynamic subtest: pipe-D-eDP-1 [326.824244] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.545s) [326.826548] Subtest queue-busy: SUCCESS (9.721s) [327.634675] [065/133] (692s left) gem_render_copy (y-tiled-mc-ccs-to-vebox-y-tiled) [327.721117] Starting subtest: y-tiled-mc-ccs-to-vebox-y-tiled [327.725242] Subtest y-tiled-mc-ccs-to-vebox-y-tiled: SKIP (0.000s) [327.917060] [066/133] (692s left) syncobj_wait (multi-wait-all-for-submit-submitted-signaled) [327.978131] Starting subtest: multi-wait-all-for-submit-submitted-signaled [328.084010] Subtest multi-wait-all-for-submit-submitted-signaled: SUCCESS (0.105s) [328.183683] [067/133] (692s left) gem_mmap_offset (mmap-boundaries) [328.245155] Starting subtest: mmap-boundaries [328.247503] Starting dynamic subtest: smem0 [328.518297] Dynamic subtest smem0: SUCCESS (0.276s) [328.520785] Subtest mmap-boundaries: SUCCESS (0.276s) [328.667441] [068/133] (691s left) kms_flip (flip-vs-rmfb-interruptible) [328.768033] Starting subtest: flip-vs-rmfb-interruptible [328.770032] Starting dynamic subtest: A-eDP1 [337.513372] Dynamic subtest A-eDP1: SUCCESS (8.748s) [337.526074] Starting dynamic subtest: B-eDP1 [346.238554] Dynamic subtest B-eDP1: SUCCESS (8.723s) [346.248916] Starting dynamic subtest: C-eDP1 [355.051361] Dynamic subtest C-eDP1: SUCCESS (8.812s) [355.061910] Starting dynamic subtest: D-eDP1 [363.687203] Dynamic subtest D-eDP1: SUCCESS (8.634s) [363.691797] Subtest flip-vs-rmfb-interruptible: SUCCESS (34.927s) [364.885067] [069/133] (655s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-blt) [365.000887] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-blt [365.004936] Subtest fbc-2p-scndscrn-cur-indfb-draw-blt: SKIP (0.000s) [365.130061] [070/133] (655s left) kms_chamelium_edid (dp-edid-resolution-list) [365.522196] Subtest dp-edid-resolution-list: SKIP (0.000s) [366.386776] [071/133] (654s left) gem_watchdog (default-physical) [366.471904] Starting subtest: default-physical [368.226773] Subtest default-physical: SUCCESS (1.766s) [368.343115] [072/133] (652s left) gem_exec_fence (syncobj-invalid-flags) [368.793913] Starting subtest: syncobj-invalid-flags [368.796474] Subtest syncobj-invalid-flags: SUCCESS (0.000s) [370.033823] [073/133] (650s left) kms_psr2_sf (fbc-pr-overlay-plane-update-sf-dmg-area) [370.146619] Starting subtest: fbc-pr-overlay-plane-update-sf-dmg-area [370.150785] Subtest fbc-pr-overlay-plane-update-sf-dmg-area: SKIP (0.000s) [370.249708] [074/133] (650s left) gem_exec_fence (basic-await) [370.421122] Starting subtest: basic-await [370.423689] Starting dynamic subtest: rcs0 [370.497191] Dynamic subtest rcs0: SUCCESS (0.076s) [370.510062] Starting dynamic subtest: bcs0 [370.574826] Dynamic subtest bcs0: SUCCESS (0.075s) [370.586896] Starting dynamic subtest: vcs0 [370.649868] Dynamic subtest vcs0: SUCCESS (0.072s) [370.662443] Starting dynamic subtest: vcs1 [370.723768] Dynamic subtest vcs1: SUCCESS (0.072s) [370.735267] Starting dynamic subtest: vecs0 [370.796666] Dynamic subtest vecs0: SUCCESS (0.071s) [370.809371] Starting dynamic subtest: ccs0 [370.870615] Dynamic subtest ccs0: SUCCESS (0.073s) [370.873278] Subtest basic-await: SUCCESS (0.451s) [373.057854] [075/133] (647s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-blt) [373.166861] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-blt [373.170774] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-blt: SKIP (0.000s) [373.305151] [076/133] (647s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-render) [373.405394] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-render [380.765029] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-render: SUCCESS (7.362s) [380.933304] [077/133] (639s left) kms_cursor_legacy (basic-busy-flip-before-cursor-varying-size) [381.052663] Starting subtest: basic-busy-flip-before-cursor-varying-size [381.057144] Subtest basic-busy-flip-before-cursor-varying-size: SKIP (0.000s) [381.234895] [078/133] (639s left) prime_mmap (test_forked) [381.284465] Starting subtest: test_forked [381.286426] Starting dynamic subtest: test_forked-smem [381.321762] Dynamic subtest test_forked-smem: SUCCESS (0.039s) [381.324090] Subtest test_forked: SUCCESS (0.040s) [381.468936] [079/133] (639s left) gem_exec_schedule (u-submit-late-slice) [381.534078] Starting subtest: u-submit-late-slice [381.536064] Starting dynamic subtest: rcs0 [381.559463] Dynamic subtest rcs0: SUCCESS (0.033s) [381.572043] Starting dynamic subtest: bcs0 [381.591745] Dynamic subtest bcs0: SUCCESS (0.032s) [381.601432] Starting dynamic subtest: vcs0 [381.623525] Dynamic subtest vcs0: SUCCESS (0.031s) [381.633274] Starting dynamic subtest: vcs1 [381.658206] Dynamic subtest vcs1: SUCCESS (0.034s) [381.668312] Starting dynamic subtest: vecs0 [381.688864] Dynamic subtest vecs0: SUCCESS (0.030s) [381.698445] Starting dynamic subtest: ccs0 [381.724843] Dynamic subtest ccs0: SUCCESS (0.036s) [381.726724] Subtest u-submit-late-slice: SUCCESS (0.200s) [383.050386] [080/133] (637s left) kms_feature_discovery (psr1) [383.149781] Starting subtest: psr1 [383.152085] Subtest psr1: SUCCESS (0.000s) [383.249857] [081/133] (637s left) prime_vgem (fence-write-hang) [383.350740] Subtest fence-write-hang: SKIP (0.000s) [383.477664] [082/133] (637s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-render) [383.584256] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-render [383.588331] Subtest fbc-2p-scndscrn-pri-shrfb-draw-render: SKIP (0.000s) [383.711123] [083/133] (637s left) gem_create (hog-create) [383.761160] Starting subtest: hog-create [383.763513] Starting dynamic subtest: smem0 [416.934277] Dynamic subtest smem0: SUCCESS (33.166s) [416.937254] Subtest hog-create: SUCCESS (33.169s) [417.138290] [084/133] (603s left) kms_big_fb (yf-tiled-8bpp-rotate-270) [417.250720] Starting subtest: yf-tiled-8bpp-rotate-270 [417.255285] Subtest yf-tiled-8bpp-rotate-270: SKIP (0.000s) [417.356598] [085/133] (603s left) gem_softpin (evict-snoop) [417.423878] Starting subtest: evict-snoop [417.428622] Subtest evict-snoop: SKIP (0.000s) [417.583327] [086/133] (603s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-mmap-wc) [417.685203] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-mmap-wc [424.727687] Subtest psr-1p-primscrn-pri-shrfb-draw-mmap-wc: SUCCESS (7.044s) [424.864644] [087/133] (596s left) kms_flip (2x-flip-vs-absolute-wf_vblank) [424.968065] Starting subtest: 2x-flip-vs-absolute-wf_vblank [424.978019] Subtest 2x-flip-vs-absolute-wf_vblank: SKIP (0.012s) [425.082873] [088/133] (596s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-cpu) [425.192561] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-cpu [425.196903] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s) [425.320588] [089/133] (595s left) kms_psr (psr-sprite-render) [425.432754] Starting subtest: psr-sprite-render [425.435022] Starting dynamic subtest: eDP-1 [427.218728] Dynamic subtest eDP-1: SUCCESS (1.785s) [427.221089] Subtest psr-sprite-render: SUCCESS (1.786s) [428.062792] [090/133] (593s left) kms_plane (pixel-format-4-tiled-dg2-mc-ccs-modifier-source-clamping) [428.166976] Starting subtest: pixel-format-4-tiled-dg2-mc-ccs-modifier-source-clamping [428.193013] Starting dynamic subtest: pipe-A-plane-0 [428.197654] Dynamic subtest pipe-A-plane-0: SKIP (0.000s) [428.208899] Starting dynamic subtest: pipe-A-plane-3 [428.213528] Dynamic subtest pipe-A-plane-3: SKIP (0.000s) [428.222604] Starting dynamic subtest: pipe-A-plane-5 [428.226729] Dynamic subtest pipe-A-plane-5: SKIP (0.000s) [429.333926] Starting dynamic subtest: pipe-B-plane-0 [429.338429] Dynamic subtest pipe-B-plane-0: SKIP (0.000s) [429.348040] Starting dynamic subtest: pipe-B-plane-3 [429.352705] Dynamic subtest pipe-B-plane-3: SKIP (0.000s) [429.362336] Starting dynamic subtest: pipe-B-plane-5 [429.366241] Dynamic subtest pipe-B-plane-5: SKIP (0.000s) [429.641927] Subtest pixel-format-4-tiled-dg2-mc-ccs-modifier-source-clamping: SKIP (1.473s) [430.517193] [091/133] (590s left) kms_pm_backlight (bad-brightness) [430.625651] Starting subtest: bad-brightness [430.674886] Starting dynamic subtest: eDP-1 [430.982895] Dynamic subtest eDP-1: SUCCESS (0.307s) [430.985160] Subtest bad-brightness: SUCCESS (0.359s) [431.840169] [092/133] (589s left) gem_ctx_param (invalid-size-get) [431.902148] Starting subtest: invalid-size-get [431.904981] Subtest invalid-size-get: SUCCESS (0.001s) [432.041737] [093/133] (589s left) kms_cursor_crc (cursor-random-128x128) [432.260048] Starting subtest: cursor-random-128x128 [432.265174] Starting dynamic subtest: pipe-A-eDP-1 [435.594828] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.329s) [435.624563] Starting dynamic subtest: pipe-D-eDP-1 [439.646401] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.030s) [439.648558] Subtest cursor-random-128x128: SUCCESS (7.384s) [440.523867] [094/133] (580s left) gem_exec_balancer (fairslice) [440.593399] Starting subtest: fairslice [443.494501] Subtest fairslice: SUCCESS (2.899s) [443.838425] [095/133] (577s left) syncobj_timeline (multi-wait-available-submitted-signaled) [443.898855] Starting subtest: multi-wait-available-submitted-signaled [443.901161] Subtest multi-wait-available-submitted-signaled: SUCCESS (0.000s) [444.017520] [096/133] (577s left) gen9_exec_parse (unaligned-access) [444.090362] Subtest unaligned-access: SKIP (0.000s) [444.171918] [097/133] (577s left) kms_big_fb (yf-tiled-16bpp-rotate-90) [444.278000] Starting subtest: yf-tiled-16bpp-rotate-90 [444.282311] Subtest yf-tiled-16bpp-rotate-90: SKIP (0.000s) [444.412287] [098/133] (577s left) kms_properties (invalid-properties-atomic) [444.516523] Starting subtest: invalid-properties-atomic [444.822388] Subtest invalid-properties-atomic: SUCCESS (0.306s) [444.908115] [099/133] (576s left) gem_exec_reloc (basic-scanout) [444.973294] Subtest basic-scanout: SKIP (0.000s) [445.067459] [100/133] (576s left) sw_sync (sync_busy_fork_unixsocket) [445.099278] Starting subtest: sync_busy_fork_unixsocket [445.106700] Subtest sync_busy_fork_unixsocket: SUCCESS (0.010s) [445.176616] [101/133] (576s left) kms_plane (pixel-format-4-tiled-modifier) [445.265690] Starting subtest: pixel-format-4-tiled-modifier [445.291385] Starting dynamic subtest: pipe-A-plane-0 [445.957496] Dynamic subtest pipe-A-plane-0: SUCCESS (0.667s) [445.967205] Starting dynamic subtest: pipe-A-plane-3 [446.368849] Dynamic subtest pipe-A-plane-3: SUCCESS (0.410s) [446.378815] Starting dynamic subtest: pipe-A-plane-5 [446.382561] Dynamic subtest pipe-A-plane-5: SKIP (0.000s) [447.474152] Starting dynamic subtest: pipe-B-plane-0 [448.154585] Dynamic subtest pipe-B-plane-0: SUCCESS (0.689s) [448.166992] Starting dynamic subtest: pipe-B-plane-3 [448.598649] Dynamic subtest pipe-B-plane-3: SUCCESS (0.444s) [448.608320] Starting dynamic subtest: pipe-B-plane-5 [448.611698] Dynamic subtest pipe-B-plane-5: SKIP (0.000s) [448.919625] Subtest pixel-format-4-tiled-modifier: SUCCESS (3.654s) [449.756582] [102/133] (571s left) kms_getfb (getfb2-accept-nv12) [449.854630] Starting subtest: getfb2-accept-nv12 [449.856866] Subtest getfb2-accept-nv12: SUCCESS (0.001s) [449.985097] [103/133] (571s left) kms_ccs (bad-pixel-format-y-tiled-gen12-rc-ccs-cc) [450.081483] Starting subtest: bad-pixel-format-y-tiled-gen12-rc-ccs-cc [450.083688] Starting dynamic subtest: pipe-A-eDP-1 [450.106629] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [450.121818] Starting dynamic subtest: pipe-B-eDP-1 [450.144201] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [450.155367] Starting dynamic subtest: pipe-C-eDP-1 [450.176739] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [450.185941] Starting dynamic subtest: pipe-D-eDP-1 [450.207754] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [450.211720] Subtest bad-pixel-format-y-tiled-gen12-rc-ccs-cc: SKIP (0.009s) [452.416905] [104/133] (569s left) kms_vblank (ts-continuation-idle-hang) [452.525378] Starting subtest: ts-continuation-idle-hang [452.527200] Starting dynamic subtest: pipe-A-eDP-1 [478.746442] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.220s) [478.761646] Starting dynamic subtest: pipe-D-eDP-1 [493.728767] Dynamic subtest pipe-D-eDP-1: SUCCESS (14.979s) [493.730627] Subtest ts-continuation-idle-hang: SUCCESS (41.203s) [494.592578] [105/133] (527s left) gem_ctx_isolation (nonpriv-switch) [494.663928] Starting subtest: nonpriv-switch [494.666309] Starting dynamic subtest: rcs0 [494.935422] Dynamic subtest rcs0: SUCCESS (0.271s) [494.947650] Starting dynamic subtest: bcs0 [495.260688] Dynamic subtest bcs0: SUCCESS (0.324s) [495.272647] Starting dynamic subtest: vcs0 [495.581721] Dynamic subtest vcs0: SUCCESS (0.320s) [495.593832] Starting dynamic subtest: vcs1 [497.271513] Dynamic subtest vcs1: SUCCESS (1.689s) [497.283284] Starting dynamic subtest: vecs0 [499.264878] Dynamic subtest vecs0: SUCCESS (1.992s) [499.276023] Starting dynamic subtest: ccs0 [501.285879] Dynamic subtest ccs0: SUCCESS (2.020s) [501.288230] Subtest nonpriv-switch: SUCCESS (6.622s) [501.560477] [106/133] (520s left) gem_exec_schedule (u-submit-early-slice) [501.639129] Starting subtest: u-submit-early-slice [501.641547] Starting dynamic subtest: rcs0 [501.689513] Dynamic subtest rcs0: SUCCESS (0.056s) [501.702667] Starting dynamic subtest: bcs0 [501.745474] Dynamic subtest bcs0: SUCCESS (0.055s) [501.758430] Starting dynamic subtest: vcs0 [501.793208] Dynamic subtest vcs0: SUCCESS (0.047s) [501.806548] Starting dynamic subtest: vcs1 [501.851593] Dynamic subtest vcs1: SUCCESS (0.057s) [501.862470] Starting dynamic subtest: vecs0 [501.906453] Dynamic subtest vecs0: SUCCESS (0.054s) [501.917757] Starting dynamic subtest: ccs0 [501.967091] Dynamic subtest ccs0: SUCCESS (0.059s) [501.969720] Subtest u-submit-early-slice: SUCCESS (0.334s) [503.058079] [107/133] (518s left) kms_psr (fbc-psr-sprite-render) [503.159233] Starting subtest: fbc-psr-sprite-render [503.161439] Starting dynamic subtest: eDP-1 [503.166196] Dynamic subtest eDP-1: SKIP (0.000s) [503.170613] Subtest fbc-psr-sprite-render: SKIP (0.001s) [503.243302] [108/133] (518s left) kms_psr2_sf (psr2-cursor-plane-move-continuous-exceed-sf) [503.354485] Starting subtest: psr2-cursor-plane-move-continuous-exceed-sf [503.356710] Starting dynamic subtest: pipe-A-eDP-1 [514.028099] Dynamic subtest pipe-A-eDP-1: SUCCESS (10.679s) [514.038654] Starting dynamic subtest: pipe-B-eDP-1 [525.468444] Dynamic subtest pipe-B-eDP-1: SUCCESS (11.438s) [525.470856] Subtest psr2-cursor-plane-move-continuous-exceed-sf: SUCCESS (22.120s) [526.341911] [109/133] (495s left) kms_psr (psr2-primary-blt) [526.439684] Starting subtest: psr2-primary-blt [526.441901] Starting dynamic subtest: eDP-1 [528.122723] Dynamic subtest eDP-1: SUCCESS (1.684s) [528.124968] Subtest psr2-primary-blt: SUCCESS (1.685s) [529.049002] [110/133] (493s left) kms_content_protection (dp-mst-type-0-hdcp14) [529.187797] Starting subtest: dp-mst-type-0-hdcp14 [529.191735] Subtest dp-mst-type-0-hdcp14: SKIP (0.000s) [529.340244] [111/133] (492s left) gem_sync (basic-all) [529.421271] Starting subtest: basic-all [531.709665] Subtest basic-all: SUCCESS (2.298s) [531.910084] [112/133] (490s left) kms_atomic (atomic-invalid-params) [532.016590] Starting subtest: atomic-invalid-params [532.018892] Starting dynamic subtest: pipe-A-eDP-1 [532.407811] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.391s) [532.410099] Subtest atomic-invalid-params: SUCCESS (0.392s) [533.246190] [113/133] (488s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-fullscreen) [533.352714] Starting subtest: psr-2p-primscrn-spr-indfb-fullscreen [533.356700] Subtest psr-2p-primscrn-spr-indfb-fullscreen: SKIP (0.000s) [533.471083] [114/133] (488s left) kms_psr (fbc-psr2-cursor-render) [533.570305] Starting subtest: fbc-psr2-cursor-render [533.572538] Starting dynamic subtest: eDP-1 [533.576704] Dynamic subtest eDP-1: SKIP (0.000s) [533.580800] Subtest fbc-psr2-cursor-render: SKIP (0.001s) [533.665635] [115/133] (488s left) gem_mmap (basic) [533.730631] Subtest basic: SKIP (0.000s) [533.801069] [116/133] (488s left) kms_cursor_crc (cursor-onscreen-256x85) [534.067550] Starting subtest: cursor-onscreen-256x85 [534.113662] Subtest cursor-onscreen-256x85: SKIP (0.041s) [534.282993] [117/133] (488s left) gem_softpin (zero) [534.347748] Starting subtest: zero [534.353890] Subtest zero: SUCCESS (0.004s) [534.502235] [118/133] (487s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-mmap-cpu) [534.605035] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-mmap-cpu [534.608656] Subtest psr-2p-scndscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s) [534.732698] [119/133] (487s left) kms_hdr (static-toggle) [534.822666] Starting subtest: static-toggle [534.827888] Subtest static-toggle: SKIP (0.000s) [534.910251] [120/133] (487s left) perf (invalid-oa-metric-set-id) [535.034633] Starting subtest: invalid-oa-metric-set-id [535.048524] Subtest invalid-oa-metric-set-id: SUCCESS (0.016s) [535.092679] [121/133] (487s left) gem_ctx_persistence (legacy-engines-hostile-preempt) [535.159036] Starting subtest: legacy-engines-hostile-preempt [535.160957] Starting dynamic subtest: render [535.269632] Dynamic subtest render: SUCCESS (0.110s) [535.283824] Starting dynamic subtest: bsd1 [536.979764] Dynamic subtest bsd1: SUCCESS (1.705s) [536.992053] Starting dynamic subtest: bsd2 [538.996938] Dynamic subtest bsd2: SUCCESS (2.014s) [539.009743] Starting dynamic subtest: blt [539.078619] Dynamic subtest blt: SUCCESS (0.080s) [539.091237] Starting dynamic subtest: vebox [540.934517] Dynamic subtest vebox: SUCCESS (1.851s) [540.937184] Subtest legacy-engines-hostile-preempt: SUCCESS (5.774s) [541.103094] [122/133] (481s left) kms_pm_rpm (modeset-non-lpsp) [543.148696] Starting subtest: modeset-non-lpsp [544.291471] Subtest modeset-non-lpsp: SKIP (1.146s) [544.688273] [123/133] (477s left) gem_lmem_swapping (heavy-random) [544.730688] Subtest heavy-random: SKIP (0.000s) [544.770001] [124/133] (477s left) kms_pm_rpm (dpms-mode-unset-lpsp) [546.297182] Starting subtest: dpms-mode-unset-lpsp [550.351328] Subtest dpms-mode-unset-lpsp: SUCCESS (4.058s) [550.755271] [125/133] (471s left) kms_async_flips (async-flip-with-page-flip-events-tiled) [550.855812] Starting subtest: async-flip-with-page-flip-events-tiled [551.242199] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs [554.014640] Dynamic subtest pipe-A-eDP-1-4-rc-ccs: SUCCESS (2.772s) [554.025003] Starting dynamic subtest: pipe-A-eDP-1-4 [556.200000] Dynamic subtest pipe-A-eDP-1-4: SUCCESS (2.184s) [556.210491] Starting dynamic subtest: pipe-A-eDP-1-4 [558.208611] Dynamic subtest pipe-A-eDP-1-4: SUCCESS (2.007s) [558.219011] Starting dynamic subtest: pipe-A-eDP-1-x [560.410495] Dynamic subtest pipe-A-eDP-1-x: SUCCESS (2.200s) [560.787159] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs [563.540557] Dynamic subtest pipe-B-eDP-1-4-rc-ccs: SUCCESS (2.760s) [563.557513] Starting dynamic subtest: pipe-B-eDP-1-4 [565.726803] Dynamic subtest pipe-B-eDP-1-4: SUCCESS (2.184s) [565.742849] Starting dynamic subtest: pipe-B-eDP-1-4 [567.736611] Dynamic subtest pipe-B-eDP-1-4: SUCCESS (2.008s) [567.747357] Starting dynamic subtest: pipe-B-eDP-1-x [569.927228] Dynamic subtest pipe-B-eDP-1-x: SUCCESS (2.188s) [570.293495] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs [573.074182] Dynamic subtest pipe-C-eDP-1-4-rc-ccs: SUCCESS (2.788s) [573.084104] Starting dynamic subtest: pipe-C-eDP-1-4 [575.249269] Dynamic subtest pipe-C-eDP-1-4: SUCCESS (2.174s) [575.260256] Starting dynamic subtest: pipe-C-eDP-1-4 [577.259639] Dynamic subtest pipe-C-eDP-1-4: SUCCESS (2.009s) [577.272312] Starting dynamic subtest: pipe-C-eDP-1-x [579.450174] Dynamic subtest pipe-C-eDP-1-x: SUCCESS (2.189s) [579.835637] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs [582.604620] Dynamic subtest pipe-D-eDP-1-4-rc-ccs: SUCCESS (2.775s) [582.615066] Starting dynamic subtest: pipe-D-eDP-1-4 [584.780259] Dynamic subtest pipe-D-eDP-1-4: SUCCESS (2.175s) [584.791416] Starting dynamic subtest: pipe-D-eDP-1-4 [586.790116] Dynamic subtest pipe-D-eDP-1-4: SUCCESS (2.008s) [586.805057] Starting dynamic subtest: pipe-D-eDP-1-x [588.969066] Dynamic subtest pipe-D-eDP-1-x: SUCCESS (2.177s) [588.971488] Subtest async-flip-with-page-flip-events-tiled: SUCCESS (38.108s) [590.210611] [126/133] (432s left) prime_mmap (test_map_unmap) [590.267366] Starting subtest: test_map_unmap [590.269401] Starting dynamic subtest: test_map_unmap-smem [590.296804] Dynamic subtest test_map_unmap-smem: SUCCESS (0.032s) [590.299263] Subtest test_map_unmap: SUCCESS (0.032s) [590.434271] [127/133] (432s left) i915_pm_rc6_residency (rc6-idle) [590.492184] Starting subtest: rc6-idle [590.535140] Starting dynamic subtest: gt0-rcs0 [614.811657] Dynamic subtest gt0-rcs0: SUCCESS (24.274s) [614.823773] Starting dynamic subtest: gt0-bcs0 [639.153532] Dynamic subtest gt0-bcs0: SUCCESS (24.337s) [639.165424] Starting dynamic subtest: gt0-ccs0 [663.502283] Dynamic subtest gt0-ccs0: SUCCESS (24.343s) [663.514185] Starting dynamic subtest: gt1-vcs0 [669.728999] Dynamic subtest gt1-vcs0: SUCCESS (6.170s) [669.741922] Starting dynamic subtest: gt1-vecs0 [675.900400] Dynamic subtest gt1-vecs0: SUCCESS (6.168s) [675.902922] Subtest rc6-idle: SUCCESS (85.350s) [675.946669] [128/133] (346s left) kms_lease (lease-unleased-connector) [676.051784] Starting subtest: lease-unleased-connector [676.054139] Starting dynamic subtest: pipe-A-eDP-1 [676.059602] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.006s) [676.076180] Starting dynamic subtest: pipe-B-eDP-1 [676.078481] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.006s) [676.093463] Starting dynamic subtest: pipe-C-eDP-1 [676.095606] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.006s) [676.105671] Starting dynamic subtest: pipe-D-eDP-1 [676.107788] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.008s) [676.109851] Subtest lease-unleased-connector: SUCCESS (0.033s) [676.236555] [129/133] (346s left) gem_flink_basic (bad-open) [676.295382] Starting subtest: bad-open [676.297348] Subtest bad-open: SUCCESS (0.000s) [676.438118] [130/133] (346s left) gem_ctx_param (non-root-set) [676.490539] Starting subtest: non-root-set [676.518643] Subtest non-root-set: SUCCESS (0.028s) [676.628493] [131/133] (346s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-blt) [676.735066] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-blt [676.739264] Subtest fbc-2p-primscrn-pri-shrfb-draw-blt: SKIP (0.000s) [676.857399] [132/133] (346s left) gem_mmap_wc (copy) [676.919386] Subtest copy: SKIP (0.000s) [676.990439] [133/133] (346s left) syncobj_timeline (multi-wait-all-for-submit-available-submitted-signaled) [677.049231] Starting subtest: multi-wait-all-for-submit-available-submitted-signaled [677.051317] Subtest multi-wait-all-for-submit-available-submitted-signaled: SUCCESS (0.000s) [677.152383] Closing watchdogs results: parsing output: 0/ for test: syncobj_timeline results: parsing output: 1/ for test: kms_addfb_basic results: parsing output: 2/ for test: gem_fence_thrash results: parsing output: 3/ for test: kms_frontbuffer_tracking results: parsing output: 4/ for test: kms_dp_link_training results: parsing output: 5/ for test: kms_ccs results: parsing output: 6/ for test: syncobj_eventfd results: parsing output: 7/ for test: gem_workarounds results: parsing output: 8/ for test: kms_chamelium_hpd results: parsing output: 9/ for test: fbdev results: parsing output: 10/ for test: gen7_exec_parse results: parsing output: 11/ for test: core_auth results: parsing output: 12/ for test: kms_big_fb results: parsing output: 13/ for test: kms_big_fb results: parsing output: 14/ for test: gem_pread results: parsing output: 15/ for test: kms_flip_scaled_crc results: parsing output: 16/ for test: kms_vrr results: parsing output: 17/ for test: kms_properties results: parsing output: 18/ for test: i915_pm_sseu results: parsing output: 19/ for test: kms_busy results: parsing output: 20/ for test: gem_exec_schedule results: parsing output: 21/ for test: kms_psr results: parsing output: 22/ for test: perf_pmu results: parsing output: 23/ for test: kms_plane_scaling results: parsing output: 24/ for test: api_intel_bb results: parsing output: 25/ for test: kms_color results: parsing output: 26/ for test: dmabuf_sync_file results: parsing output: 27/ for test: gem_mmap results: parsing output: 28/ for test: gem_mmap_wc results: parsing output: 29/ for test: kms_big_fb results: parsing output: 30/ for test: kms_frontbuffer_tracking results: parsing output: 31/ for test: gem_caching results: parsing output: 32/ for test: kms_frontbuffer_tracking results: parsing output: 33/ for test: gem_exec_flush results: parsing output: 34/ for test: kms_frontbuffer_tracking results: parsing output: 35/ for test: kms_frontbuffer_tracking results: parsing output: 36/ for test: kms_ccs results: parsing output: 37/ for test: i915_getparams_basic results: parsing output: 38/ for test: kms_pipe_crc_basic results: parsing output: 39/ for test: kms_fence_pin_leak results: parsing output: 40/ for test: syncobj_timeline results: parsing output: 41/ for test: kms_cursor_legacy results: parsing output: 42/ for test: gem_tiled_swapping results: parsing output: 43/ for test: kms_flip_scaled_crc results: parsing output: 44/ for test: gem_ctx_shared results: parsing output: 45/ for test: kms_ccs results: parsing output: 46/ for test: gem_pread results: parsing output: 47/ for test: gem_render_copy results: parsing output: 48/ for test: kms_frontbuffer_tracking results: parsing output: 49/ for test: gem_mmap_gtt results: parsing output: 50/ for test: kms_frontbuffer_tracking results: parsing output: 51/ for test: kms_flip results: parsing output: 52/ for test: kms_big_fb results: parsing output: 53/ for test: gem_exec_params results: parsing output: 54/ for test: prime_vgem results: parsing output: 55/ for test: gem_lmem_swapping results: parsing output: 56/ for test: kms_flip results: parsing output: 57/ for test: gem_ctx_create results: parsing output: 58/ for test: sysfs_timeslice_duration results: parsing output: 59/ for test: kms_psr results: parsing output: 60/ for test: kms_ccs results: parsing output: 61/ for test: syncobj_wait results: parsing output: 62/ for test: kms_frontbuffer_tracking results: parsing output: 63/ for test: kms_sequence results: parsing output: 64/ for test: gem_render_copy results: parsing output: 65/ for test: syncobj_wait results: parsing output: 66/ for test: gem_mmap_offset results: parsing output: 67/ for test: kms_flip results: parsing output: 68/ for test: kms_frontbuffer_tracking results: parsing output: 69/ for test: kms_chamelium_edid results: parsing output: 70/ for test: gem_watchdog results: parsing output: 71/ for test: gem_exec_fence results: parsing output: 72/ for test: kms_psr2_sf results: parsing output: 73/ for test: gem_exec_fence results: parsing output: 74/ for test: kms_frontbuffer_tracking results: parsing output: 75/ for test: kms_frontbuffer_tracking results: parsing output: 76/ for test: kms_cursor_legacy results: parsing output: 77/ for test: prime_mmap results: parsing output: 78/ for test: gem_exec_schedule results: parsing output: 79/ for test: kms_feature_discovery results: parsing output: 80/ for test: prime_vgem results: parsing output: 81/ for test: kms_frontbuffer_tracking results: parsing output: 82/ for test: gem_create results: parsing output: 83/ for test: kms_big_fb results: parsing output: 84/ for test: gem_softpin results: parsing output: 85/ for test: kms_frontbuffer_tracking results: parsing output: 86/ for test: kms_flip results: parsing output: 87/ for test: kms_frontbuffer_tracking results: parsing output: 88/ for test: kms_psr results: parsing output: 89/ for test: kms_plane results: parsing output: 90/ for test: kms_pm_backlight results: parsing output: 91/ for test: gem_ctx_param results: parsing output: 92/ for test: kms_cursor_crc results: parsing output: 93/ for test: gem_exec_balancer results: parsing output: 94/ for test: syncobj_timeline results: parsing output: 95/ for test: gen9_exec_parse results: parsing output: 96/ for test: kms_big_fb results: parsing output: 97/ for test: kms_properties results: parsing output: 98/ for test: gem_exec_reloc results: parsing output: 99/ for test: sw_sync results: parsing output: 100/ for test: kms_plane results: parsing output: 101/ for test: kms_getfb results: parsing output: 102/ for test: kms_ccs results: parsing output: 103/ for test: kms_vblank results: parsing output: 104/ for test: gem_ctx_isolation results: parsing output: 105/ for test: gem_exec_schedule results: parsing output: 106/ for test: kms_psr results: parsing output: 107/ for test: kms_psr2_sf results: parsing output: 108/ for test: kms_psr results: parsing output: 109/ for test: kms_content_protection results: parsing output: 110/ for test: gem_sync results: parsing output: 111/ for test: kms_atomic results: parsing output: 112/ for test: kms_frontbuffer_tracking results: parsing output: 113/ for test: kms_psr results: parsing output: 114/ for test: gem_mmap results: parsing output: 115/ for test: kms_cursor_crc results: parsing output: 116/ for test: gem_softpin results: parsing output: 117/ for test: kms_frontbuffer_tracking results: parsing output: 118/ for test: kms_hdr results: parsing output: 119/ for test: perf results: parsing output: 120/ for test: gem_ctx_persistence results: parsing output: 121/ for test: kms_pm_rpm results: parsing output: 122/ for test: gem_lmem_swapping results: parsing output: 123/ for test: kms_pm_rpm results: parsing output: 124/ for test: kms_async_flips results: parsing output: 125/ for test: prime_mmap results: parsing output: 126/ for test: i915_pm_rc6_residency results: parsing output: 127/ for test: kms_lease results: parsing output: 128/ for test: gem_flink_basic results: parsing output: 129/ for test: gem_ctx_param results: parsing output: 130/ for test: kms_frontbuffer_tracking results: parsing output: 131/ for test: gem_mmap_wc results: parsing output: 132/ for test: syncobj_timeline Done.