[56.968028] Initializing watchdogs [56.968075] /dev/watchdog0 [56.982936] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:7dd5 Intel Meteorlake (Gen12) Meteor Lake-P [Intel Graphics] [56.986863] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [56.988987] [FACT before any test] new: kernel.kmod_is_loaded.i915: true [56.992217] [001/133] (960s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-shrfb-pgflip-blt) [57.095595] Starting subtest: fbcpsr-2p-primscrn-shrfb-pgflip-blt [57.099732] Subtest fbcpsr-2p-primscrn-shrfb-pgflip-blt: SKIP (0.000s) [57.183076] [002/133] (960s left) gem_exec_balancer (bonded-true-hang) [57.445323] Starting subtest: bonded-true-hang [57.450296] Subtest bonded-true-hang: SKIP (0.000s) [57.545364] [003/133] (960s left) gem_exec_whisper (basic-fds) [57.621805] Starting subtest: basic-fds [64.826405] Subtest basic-fds: SUCCESS (7.201s) [65.004604] [004/133] (952s left) tools_test (sysfs_l3_parity) [65.065633] Starting subtest: sysfs_l3_parity [65.149069] Subtest sysfs_l3_parity: SKIP (0.098s) [65.202773] [005/133] (952s left) kms_color (legacy-gamma) [65.271215] Starting subtest: legacy-gamma [65.273114] Starting dynamic subtest: pipe-A-eDP-1 [66.032546] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.761s) [66.041108] Starting dynamic subtest: pipe-B-eDP-1 [67.400629] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.369s) [67.408899] Starting dynamic subtest: pipe-C-eDP-1 [68.768250] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.367s) [68.777305] Starting dynamic subtest: pipe-D-eDP-1 [70.085843] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.318s) [70.088266] Subtest legacy-gamma: SUCCESS (4.816s) [70.909842] [006/133] (946s left) syncobj_timeline (single-wait-for-submit-available-signaled) [70.970886] Starting subtest: single-wait-for-submit-available-signaled [70.972921] Subtest single-wait-for-submit-available-signaled: SUCCESS (0.000s) [71.063797] [007/133] (946s left) gem_sync (basic-each) [71.149617] Starting subtest: basic-each [73.534526] Subtest basic-each: SUCCESS (2.396s) [73.718347] [008/133] (944s left) gem_userptr_blits (sd-probe) [73.792410] Starting subtest: sd-probe [73.794720] Subtest sd-probe: SUCCESS (0.000s) [73.902465] [009/133] (943s left) kms_flip (2x-flip-vs-panning-interruptible) [73.983600] Starting subtest: 2x-flip-vs-panning-interruptible [73.993405] Subtest 2x-flip-vs-panning-interruptible: SKIP (0.008s) [74.068625] [010/133] (943s left) gem_softpin (evict-prime-sanity-check) [74.121680] Starting subtest: evict-prime-sanity-check [74.123985] Starting dynamic subtest: rcs0 [75.270103] Dynamic subtest rcs0: SUCCESS (1.148s) [75.279355] Starting dynamic subtest: bcs0 [76.388605] Dynamic subtest bcs0: SUCCESS (1.118s) [76.398659] Starting dynamic subtest: vcs0 [77.852356] Dynamic subtest vcs0: SUCCESS (1.462s) [77.862083] Starting dynamic subtest: vcs1 [79.830588] Dynamic subtest vcs1: SUCCESS (1.977s) [79.841286] Starting dynamic subtest: vecs0 [81.792400] Dynamic subtest vecs0: SUCCESS (1.960s) [81.803718] Starting dynamic subtest: ccs0 [82.926985] Dynamic subtest ccs0: SUCCESS (1.136s) [82.934870] Starting dynamic subtest: all [84.056985] Dynamic subtest all: SUCCESS (1.129s) [84.059484] Subtest evict-prime-sanity-check: SUCCESS (9.935s) [84.134151] [011/133] (933s left) syncobj_timeline (multi-wait-available-unsubmitted-submitted-signaled) [84.201332] Starting subtest: multi-wait-available-unsubmitted-submitted-signaled [84.203739] Subtest multi-wait-available-unsubmitted-submitted-signaled: SUCCESS (0.000s) [84.302549] [012/133] (933s left) kms_plane_scaling (plane-upscale-factor-0-25-with-rotation) [84.388504] Starting subtest: plane-upscale-factor-0-25-with-rotation [84.390774] Starting dynamic subtest: pipe-A [84.614419] Dynamic subtest pipe-A: SUCCESS (0.227s) [84.622267] Starting dynamic subtest: pipe-B [85.894309] Dynamic subtest pipe-B: SUCCESS (1.279s) [85.903931] Starting dynamic subtest: pipe-C [87.227161] Dynamic subtest pipe-C: SUCCESS (1.332s) [87.236227] Starting dynamic subtest: pipe-D [88.545392] Dynamic subtest pipe-D: SUCCESS (1.318s) [88.547695] Subtest plane-upscale-factor-0-25-with-rotation: SUCCESS (4.158s) [89.728528] [013/133] (928s left) kms_ccs (ccs-on-another-bo-y-tiled-gen12-rc-ccs-cc) [89.808189] Starting subtest: ccs-on-another-bo-y-tiled-gen12-rc-ccs-cc [89.812611] Starting dynamic subtest: pipe-A-eDP-1 [89.837077] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [89.850857] Starting dynamic subtest: pipe-B-eDP-1 [89.874302] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [89.883518] Starting dynamic subtest: pipe-C-eDP-1 [89.905439] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [89.912987] Starting dynamic subtest: pipe-D-eDP-1 [89.934997] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [89.939668] Subtest ccs-on-another-bo-y-tiled-gen12-rc-ccs-cc: SKIP (0.003s) [92.072173] [014/133] (925s left) i915_pm_sseu (full-enable) [92.141510] Subtest full-enable: SKIP (0.000s) [92.232664] [015/133] (925s left) gem_exec_reloc (basic-wc-noreloc) [92.290057] Subtest basic-wc-noreloc: SKIP (0.000s) [92.364145] [016/133] (925s left) kms_big_fb (y-tiled-16bpp-rotate-0) [92.456512] Starting subtest: y-tiled-16bpp-rotate-0 [92.460756] Subtest y-tiled-16bpp-rotate-0: SKIP (0.000s) [92.546078] [017/133] (925s left) kms_pwrite_crc [94.115118] [018/133] (923s left) kms_flip (flip-vs-expired-vblank-interruptible) [94.205619] Starting subtest: flip-vs-expired-vblank-interruptible [94.208074] Starting dynamic subtest: A-eDP1 [102.868963] Dynamic subtest A-eDP1: SUCCESS (8.628s) [102.877369] Starting dynamic subtest: B-eDP1 [111.490545] Dynamic subtest B-eDP1: SUCCESS (8.621s) [111.500796] Starting dynamic subtest: C-eDP1 [120.132776] Dynamic subtest C-eDP1: SUCCESS (8.628s) [120.143517] Starting dynamic subtest: D-eDP1 [128.760063] Dynamic subtest D-eDP1: SUCCESS (8.625s) [128.762968] Subtest flip-vs-expired-vblank-interruptible: SUCCESS (34.509s) [129.887685] [019/133] (888s left) perf_pmu (busy-accuracy-2) [129.927495] Starting subtest: busy-accuracy-2 [129.929420] Starting dynamic subtest: rcs0 [132.969330] Dynamic subtest rcs0: SUCCESS (3.041s) [132.979815] Starting dynamic subtest: bcs0 [136.026861] Dynamic subtest bcs0: SUCCESS (3.056s) [136.037562] Starting dynamic subtest: vcs0 [139.074493] Dynamic subtest vcs0: SUCCESS (3.046s) [139.085833] Starting dynamic subtest: vcs1 [142.122065] Dynamic subtest vcs1: SUCCESS (3.046s) [142.132198] Starting dynamic subtest: vecs0 [145.168993] Dynamic subtest vecs0: SUCCESS (3.046s) [145.179125] Starting dynamic subtest: ccs0 [148.228457] Dynamic subtest ccs0: SUCCESS (3.058s) [148.230960] Subtest busy-accuracy-2: SUCCESS (18.300s) [148.341624] [020/133] (869s left) syncobj_basic (bad-fd-to-handle) [148.389144] Starting subtest: bad-fd-to-handle [148.391636] Subtest bad-fd-to-handle: SUCCESS (0.000s) [148.470874] [021/133] (869s left) kms_dsc (dsc-with-bpc-formats) [148.549844] Starting subtest: dsc-with-bpc-formats [148.658689] Subtest dsc-with-bpc-formats: SKIP (0.003s) [148.694066] [022/133] (869s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-move) [148.772728] Starting subtest: psr-2p-primscrn-cur-indfb-move [148.776690] Subtest psr-2p-primscrn-cur-indfb-move: SKIP (0.000s) [148.872826] [023/133] (869s left) kms_joiner (basic-max-non-joiner) [148.955415] Starting subtest: basic-max-non-joiner [148.959843] Subtest basic-max-non-joiner: SKIP (0.000s) [149.017964] [024/133] (869s left) kms_plane (pixel-format-4-tiled-mtl-rc-ccs-cc-modifier) [149.092152] Starting subtest: pixel-format-4-tiled-mtl-rc-ccs-cc-modifier [149.117915] Starting dynamic subtest: pipe-A-plane-0 [149.406859] Dynamic subtest pipe-A-plane-0: SUCCESS (0.289s) [149.414446] Starting dynamic subtest: pipe-A-plane-3 [149.640218] Dynamic subtest pipe-A-plane-3: SUCCESS (0.233s) [149.647494] Starting dynamic subtest: pipe-A-plane-5 [149.650903] Dynamic subtest pipe-A-plane-5: SKIP (0.000s) [150.770598] Starting dynamic subtest: pipe-B-plane-0 [151.074696] Dynamic subtest pipe-B-plane-0: SUCCESS (0.311s) [151.083914] Starting dynamic subtest: pipe-B-plane-3 [151.319045] Dynamic subtest pipe-B-plane-3: SUCCESS (0.243s) [151.327579] Starting dynamic subtest: pipe-B-plane-5 [151.331547] Dynamic subtest pipe-B-plane-5: SKIP (0.000s) [151.640062] Subtest pixel-format-4-tiled-mtl-rc-ccs-cc-modifier: SUCCESS (2.549s) [152.464138] [025/133] (865s left) i915_pm_rc6_residency (rc6-fence) [152.516058] Starting subtest: rc6-fence [152.549186] Starting dynamic subtest: gt0 [164.883969] Dynamic subtest gt0: SUCCESS (12.318s) [164.895161] Starting dynamic subtest: gt1 [180.890408] Dynamic subtest gt1: SUCCESS (16.018s) [180.892975] Subtest rc6-fence: SUCCESS (28.374s) [180.964020] [026/133] (837s left) gen9_exec_parse (cmd-crossing-page) [181.019942] Subtest cmd-crossing-page: SKIP (0.000s) [181.087355] [027/133] (837s left) kms_psr2_sf (psr2-plane-move-sf-dmg-area) [181.173137] Starting subtest: psr2-plane-move-sf-dmg-area [181.175632] Starting dynamic subtest: pipe-A-eDP-1 [185.684239] Dynamic subtest pipe-A-eDP-1: SUCCESS (4.517s) [185.694596] Starting dynamic subtest: pipe-B-eDP-1 [191.013205] Dynamic subtest pipe-B-eDP-1: SUCCESS (5.326s) [191.015538] Subtest psr2-plane-move-sf-dmg-area: SUCCESS (9.846s) [191.891819] [028/133] (826s left) gem_wait (invalid-flags) [191.951736] Starting subtest: invalid-flags [191.954172] Subtest invalid-flags: SUCCESS (0.000s) [192.168514] [029/133] (826s left) gem_flink_basic (basic) [192.214836] Starting subtest: basic [192.217102] Subtest basic: SUCCESS (0.000s) [192.301554] [030/133] (826s left) kms_cursor_edge_walk (256x256-left-edge) [192.377690] Starting subtest: 256x256-left-edge [192.379927] Starting dynamic subtest: pipe-A-eDP-1 [195.876571] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.498s) [195.884869] Starting dynamic subtest: pipe-D-eDP-1 [199.020549] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.142s) [199.022879] Subtest 256x256-left-edge: SUCCESS (6.643s) [199.818510] [031/133] (818s left) vgem_basic (setversion) [199.939904] Starting subtest: setversion [199.944264] Subtest setversion: SUCCESS (0.000s) [199.989417] [FACT vgem_basic (setversion)] new: kernel.kmod_is_loaded.vgem: true [199.992825] [032/133] (818s left) gem_ctx_param (set-priority-invalid-size) [200.051236] Starting subtest: set-priority-invalid-size [200.053623] Subtest set-priority-invalid-size: SUCCESS (0.000s) [200.174212] [033/133] (818s left) gem_workarounds (suspend-resume) [200.242264] Starting subtest: suspend-resume [216.664914] Subtest suspend-resume: SUCCESS (1.326s) [216.783567] [034/133] (801s left) gem_exec_balancer (sequential) [216.856689] Starting subtest: sequential [219.902174] Subtest sequential: SUCCESS (3.044s) [220.239466] [035/133] (798s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-fullscreen) [220.331941] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-fullscreen [226.977488] Subtest fbcpsr-1p-primscrn-spr-indfb-fullscreen: SUCCESS (6.647s) [227.099382] [036/133] (791s left) api_intel_allocator (alloc-simple) [227.155474] Starting subtest: alloc-simple [227.157771] Subtest alloc-simple: SUCCESS (0.003s) [227.257595] [037/133] (791s left) kms_ccs (crc-primary-suspend-4-tiled-dg2-rc-ccs-cc) [227.327252] Starting subtest: crc-primary-suspend-4-tiled-dg2-rc-ccs-cc [227.329551] Starting dynamic subtest: pipe-A-eDP-1 [227.338440] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [227.347413] Starting dynamic subtest: pipe-B-eDP-1 [227.356446] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [227.364646] Starting dynamic subtest: pipe-C-eDP-1 [227.373432] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [227.381861] Starting dynamic subtest: pipe-D-eDP-1 [227.390561] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [227.394816] Subtest crc-primary-suspend-4-tiled-dg2-rc-ccs-cc: SKIP (0.004s) [229.593543] [038/133] (789s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-32bpp-ytile-upscaling) [229.658068] Starting subtest: flip-64bpp-ytile-to-32bpp-ytile-upscaling [229.662222] Subtest flip-64bpp-ytile-to-32bpp-ytile-upscaling: SKIP (0.000s) [229.730789] [039/133] (789s left) kms_rotation_crc (primary-rotation-180) [229.802682] Starting subtest: primary-rotation-180 [236.715860] Subtest primary-rotation-180: SUCCESS (6.914s) [237.948886] [040/133] (781s left) kms_rotation_crc (primary-4-tiled-reflect-x-180) [238.029099] Starting subtest: primary-4-tiled-reflect-x-180 [244.946005] Subtest primary-4-tiled-reflect-x-180: SUCCESS (6.917s) [246.111735] [041/133] (772s left) syncobj_timeline (wait-zero-handles) [246.174056] Starting subtest: wait-zero-handles [246.175998] Subtest wait-zero-handles: SUCCESS (0.000s) [246.288299] [042/133] (772s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-mmap-gtt) [246.373187] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-mmap-gtt [246.377747] Subtest fbc-2p-scndscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s) [246.472472] [043/133] (772s left) syncobj_timeline (etime-multi-wait-all-for-submit-available-unsubmitted-signa [246.532455] Starting subtest: etime-multi-wait-all-for-submit-available-unsubmitted-signaled [246.635148] Subtest etime-multi-wait-all-for-submit-available-unsubmitted-signaled: SUCCESS (0.103s) [246.711059] [044/133] (772s left) syncobj_wait (wait-any-complex) [246.766808] Starting subtest: wait-any-complex [246.827443] Subtest wait-any-complex: SUCCESS (0.062s) [246.915767] [045/133] (772s left) syncobj_wait (signal) [246.978773] Starting subtest: signal [246.981182] Subtest signal: SUCCESS (0.000s) [247.098598] [046/133] (772s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-pwrite) [247.180518] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-pwrite [247.184712] Subtest psr-2p-scndscrn-pri-indfb-draw-pwrite: SKIP (0.000s) [247.285506] [047/133] (772s left) kms_big_fb (linear-64bpp-rotate-180) [247.374711] Starting subtest: linear-64bpp-rotate-180 [248.911002] Subtest linear-64bpp-rotate-180: SUCCESS (1.534s) [249.073804] [048/133] (770s left) gem_ctx_create (basic) [249.129122] Starting subtest: basic [249.131439] Subtest basic: SUCCESS (0.000s) [249.308212] [049/133] (770s left) fbdev (write) [249.351167] Starting subtest: write [249.703791] Subtest write: SUCCESS (0.350s) [249.755759] [050/133] (769s left) kms_pm_dc (dc6-psr) [250.838851] Starting subtest: dc6-psr [253.828055] Subtest dc6-psr: SUCCESS (2.987s) [254.649076] [051/133] (764s left) kms_plane (plane-panning-bottom-right-suspend) [254.739151] Starting subtest: plane-panning-bottom-right-suspend [254.741481] Starting dynamic subtest: pipe-A [272.044717] Dynamic subtest pipe-A: SUCCESS (2.824s) [272.054611] Starting dynamic subtest: pipe-B [291.031981] Dynamic subtest pipe-B: SUCCESS (3.507s) [291.034536] Subtest plane-panning-bottom-right-suspend: SUCCESS (6.333s) [291.852652] [052/133] (727s left) gem_exec_schedule (implicit-read-write) [291.929546] Starting subtest: implicit-read-write [291.931692] Starting dynamic subtest: rcs0 [292.031222] Dynamic subtest rcs0: SUCCESS (0.113s) [292.040956] Starting dynamic subtest: vcs0 [292.109457] Dynamic subtest vcs0: SUCCESS (0.077s) [292.122613] Starting dynamic subtest: vcs1 [292.185380] Dynamic subtest vcs1: SUCCESS (0.075s) [292.197468] Starting dynamic subtest: vecs0 [292.259096] Dynamic subtest vecs0: SUCCESS (0.072s) [292.270753] Starting dynamic subtest: ccs0 [292.337761] Dynamic subtest ccs0: SUCCESS (0.077s) [292.341332] Subtest implicit-read-write: SUCCESS (0.419s) [293.990068] [053/133] (725s left) gem_exec_nop (basic-sequential) [294.063563] Starting subtest: basic-sequential [310.042866] Subtest basic-sequential: SUCCESS (15.947s) [310.237978] [054/133] (709s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-mmap-cpu) [310.316568] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-mmap-cpu [314.543160] Subtest fbc-1p-primscrn-pri-shrfb-draw-mmap-cpu: SUCCESS (4.229s) [315.685025] [055/133] (703s left) kms_atomic_transition (plane-use-after-nonblocking-unbind) [315.768695] Starting subtest: plane-use-after-nonblocking-unbind [315.771071] Starting dynamic subtest: pipe-A-eDP-1 [315.828512] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.061s) [316.124833] Starting dynamic subtest: pipe-B-eDP-1 [316.903873] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.786s) [317.208750] Subtest plane-use-after-nonblocking-unbind: SUCCESS (1.439s) [318.058738] [056/133] (701s left) kms_cursor_legacy (flip-vs-cursor-busy-crc-legacy) [318.166627] Starting subtest: flip-vs-cursor-busy-crc-legacy [318.986146] Subtest flip-vs-cursor-busy-crc-legacy: SUCCESS (0.822s) [319.778199] [057/133] (699s left) gem_exec_fence (syncobj-stationary-timeline-chain-engines) [320.346544] Starting subtest: syncobj-stationary-timeline-chain-engines [320.452992] Subtest syncobj-stationary-timeline-chain-engines: SUCCESS (0.107s) [322.039588] [058/133] (697s left) kms_cursor_legacy (short-flip-after-cursor-atomic-transitions) [322.148267] Starting subtest: short-flip-after-cursor-atomic-transitions [323.109652] Subtest short-flip-after-cursor-atomic-transitions: SUCCESS (0.962s) [323.913343] [059/133] (695s left) kms_cursor_legacy (flip-vs-cursor-atomic-transitions) [324.010252] Starting subtest: flip-vs-cursor-atomic-transitions [331.426529] Subtest flip-vs-cursor-atomic-transitions: SUCCESS (7.417s) [332.249135] [060/133] (687s left) kms_lease (simple-lease) [332.322656] Starting subtest: simple-lease [332.324953] Starting dynamic subtest: pipe-A-eDP-1 [332.822352] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.498s) [332.831629] Starting dynamic subtest: pipe-B-eDP-1 [334.287373] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.464s) [334.296411] Starting dynamic subtest: pipe-C-eDP-1 [335.697109] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.408s) [335.706580] Starting dynamic subtest: pipe-D-eDP-1 [337.088555] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.389s) [337.090732] Subtest simple-lease: SUCCESS (4.765s) [337.899172] [061/133] (681s left) kms_cursor_legacy (cursorb-vs-flipb-atomic) [338.004360] Starting subtest: cursorB-vs-flipB-atomic [338.008973] Subtest cursorB-vs-flipB-atomic: SKIP (0.001s) [338.156639] [062/133] (681s left) kms_pipe_b_c_ivb (pipe-b-dpms-off-modeset-pipe-c) [338.216128] Subtest pipe-B-dpms-off-modeset-pipe-C: SKIP (0.000s) [338.278069] [063/133] (681s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-indfb-draw-blt) [338.357540] Starting subtest: psr-1p-offscreen-pri-indfb-draw-blt [345.264320] Subtest psr-1p-offscreen-pri-indfb-draw-blt: SUCCESS (6.909s) [345.426253] [064/133] (674s left) kms_chamelium_hpd (vga-hpd-with-enabled-mode) [345.794458] Subtest vga-hpd-with-enabled-mode: SKIP (0.000s) [346.676992] [065/133] (673s left) prime_vgem (basic-fence-mmap) [346.765755] Starting subtest: basic-fence-mmap [346.770620] Subtest basic-fence-mmap: SKIP (0.000s) [346.868323] [066/133] (673s left) kms_ccs (bad-aux-stride-y-tiled-gen12-rc-ccs-cc) [346.932012] Starting subtest: bad-aux-stride-y-tiled-gen12-rc-ccs-cc [346.934286] Starting dynamic subtest: pipe-A-eDP-1 [346.957236] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [346.968303] Starting dynamic subtest: pipe-B-eDP-1 [346.990183] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [346.998905] Starting dynamic subtest: pipe-C-eDP-1 [347.020668] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [347.028999] Starting dynamic subtest: pipe-D-eDP-1 [347.051274] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [347.055406] Subtest bad-aux-stride-y-tiled-gen12-rc-ccs-cc: SKIP (0.004s) [349.128580] [067/133] (670s left) kms_content_protection (dp-mst-type-0) [349.259182] Starting subtest: dp-mst-type-0 [349.263827] Subtest dp-mst-type-0: SKIP (0.000s) [349.400964] [068/133] (670s left) gem_exec_alignment (pi-isolated) [349.455967] Starting subtest: pi-isolated [398.176515] Subtest pi-isolated: SUCCESS (48.709s) [398.599819] [069/133] (621s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-render) [398.708285] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-render [398.712481] Subtest psr-2p-scndscrn-pri-shrfb-draw-render: SKIP (0.000s) [398.810123] [070/133] (621s left) kms_chamelium_audio (hdmi-audio) [399.190020] Subtest hdmi-audio: SKIP (0.000s) [400.041875] [071/133] (620s left) sw_sync (sync_random_merge) [400.100597] Starting subtest: sync_random_merge [400.142048] Subtest sync_random_merge: SUCCESS (0.042s) [400.203868] [072/133] (620s left) kms_atomic_transition (plane-all-modeset-transition-fencing) [400.293358] Starting subtest: plane-all-modeset-transition-fencing [400.297789] Subtest plane-all-modeset-transition-fencing: SKIP (0.000s) [400.367502] [073/133] (619s left) gem_exec_schedule (preempt-self) [400.442826] Starting subtest: preempt-self [400.445073] Starting dynamic subtest: rcs0 [400.459092] Dynamic subtest rcs0: SUCCESS (0.022s) [400.469910] Starting dynamic subtest: bcs0 [400.477180] Dynamic subtest bcs0: SUCCESS (0.017s) [400.486104] Starting dynamic subtest: vcs0 [400.494673] Dynamic subtest vcs0: SUCCESS (0.017s) [400.511611] Starting dynamic subtest: vcs1 [400.513823] Dynamic subtest vcs1: SUCCESS (0.016s) [400.523004] Starting dynamic subtest: vecs0 [400.529278] Dynamic subtest vecs0: SUCCESS (0.017s) [400.538596] Starting dynamic subtest: ccs0 [400.547133] Dynamic subtest ccs0: SUCCESS (0.017s) [400.549778] Subtest preempt-self: SUCCESS (0.112s) [401.952324] [074/133] (618s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-180) [402.043202] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-180 [403.079944] Subtest x-tiled-max-hw-stride-64bpp-rotate-180: SUCCESS (1.035s) [403.216227] [075/133] (617s left) kms_dp_link_training (uhbr-mst) [403.288746] Starting subtest: uhbr-mst [403.297513] Subtest uhbr-mst: SKIP (0.000s) [403.360448] [076/133] (617s left) kms_sequence (queue-idle) [403.444408] Starting subtest: queue-idle [403.446311] Starting dynamic subtest: pipe-A-eDP-1 [405.278381] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.832s) [405.288415] Starting dynamic subtest: pipe-B-eDP-1 [407.726963] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.448s) [407.736652] Starting dynamic subtest: pipe-C-eDP-1 [410.146691] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.415s) [410.164039] Starting dynamic subtest: pipe-D-eDP-1 [412.582421] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.438s) [412.584840] Subtest queue-idle: SUCCESS (9.140s) [413.398846] [077/133] (607s left) i915_drm_fdinfo (busy-idle) [413.450126] Starting subtest: busy-idle [413.452457] Starting dynamic subtest: rcs0 [413.468684] Dynamic subtest rcs0: SKIP (0.016s) [413.480364] Starting dynamic subtest: bcs0 [413.484870] Dynamic subtest bcs0: SKIP (0.015s) [413.494125] Starting dynamic subtest: vcs0 [413.498503] Dynamic subtest vcs0: SKIP (0.000s) [413.507962] Starting dynamic subtest: vcs1 [413.512143] Dynamic subtest vcs1: SKIP (0.000s) [413.521670] Starting dynamic subtest: vecs0 [413.526016] Dynamic subtest vecs0: SKIP (0.000s) [413.535221] Starting dynamic subtest: ccs0 [413.539639] Dynamic subtest ccs0: SKIP (0.000s) [413.543959] Subtest busy-idle: SKIP (0.037s) [413.582539] [078/133] (606s left) kms_psr (fbc-psr-sprite-plane-move) [413.658635] Starting subtest: fbc-psr-sprite-plane-move [413.660874] Starting dynamic subtest: eDP-1 [413.664915] Dynamic subtest eDP-1: SKIP (0.000s) [413.668954] Subtest fbc-psr-sprite-plane-move: SKIP (0.001s) [413.733816] [079/133] (606s left) kms_flip (2x-modeset-vs-vblank-race) [413.816736] Starting subtest: 2x-modeset-vs-vblank-race [413.824416] Subtest 2x-modeset-vs-vblank-race: SKIP (0.008s) [413.926697] [080/133] (606s left) gem_mmap_gtt (hang-user) [413.981358] Subtest hang-user: SKIP (0.000s) [414.043561] [081/133] (606s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-mmap-gtt) [414.118378] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-mmap-gtt [414.122479] Subtest fbc-2p-scndscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s) [414.212833] [082/133] (606s left) gem_ccs (suspend-resume) [414.284527] Starting subtest: suspend-resume [414.289283] Subtest suspend-resume: SKIP (0.000s) [414.411403] [083/133] (606s left) gem_lmem_swapping (heavy-verify-multi) [414.455812] Subtest heavy-verify-multi: SKIP (0.000s) [414.502100] [084/133] (606s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-gtt) [414.578891] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-gtt [414.582811] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s) [414.672401] [085/133] (606s left) kms_pm_rpm (universal-planes-dpms) [416.189826] Starting subtest: universal-planes-dpms [416.191942] Starting dynamic subtest: plane-34 [424.504335] Dynamic subtest plane-34: SUCCESS (8.316s) [424.517095] Starting dynamic subtest: plane-64 [432.725571] Dynamic subtest plane-64: SUCCESS (8.218s) [432.737969] Starting dynamic subtest: plane-94 [441.024973] Dynamic subtest plane-94: SUCCESS (8.295s) [441.037433] Starting dynamic subtest: plane-124 [449.317285] Dynamic subtest plane-124: SUCCESS (8.288s) [449.329680] Starting dynamic subtest: plane-134 [457.618143] Dynamic subtest plane-134: SUCCESS (8.297s) [457.629296] Starting dynamic subtest: plane-144 [465.912256] Dynamic subtest plane-144: SUCCESS (8.289s) [465.914864] Subtest universal-planes-dpms: SUCCESS (49.720s) [466.296964] [086/133] (554s left) kms_async_flips (async-flip-hang) [466.378830] Starting subtest: async-flip-hang [466.760409] Starting dynamic subtest: pipe-A-eDP-1 [482.360026] Dynamic subtest pipe-A-eDP-1: SUCCESS (15.588s) [482.741625] Starting dynamic subtest: pipe-B-eDP-1 [498.419578] Dynamic subtest pipe-B-eDP-1: SUCCESS (15.678s) [498.807906] Starting dynamic subtest: pipe-C-eDP-1 [514.428340] Dynamic subtest pipe-C-eDP-1: SUCCESS (15.624s) [514.808752] Starting dynamic subtest: pipe-D-eDP-1 [530.407104] Dynamic subtest pipe-D-eDP-1: SUCCESS (15.608s) [530.409897] Subtest async-flip-hang: SUCCESS (64.017s) [531.654657] [087/133] (489s left) kms_psr2_sf (pr-overlay-primary-update-sf-dmg-area) [531.739808] Starting subtest: pr-overlay-primary-update-sf-dmg-area [531.744039] Subtest pr-overlay-primary-update-sf-dmg-area: SKIP (0.000s) [531.822831] [088/133] (489s left) gem_pxp (verify-pxp-key-change-after-suspend-resume) [531.942451] Starting subtest: verify-pxp-key-change-after-suspend-resume [539.136185] Subtest verify-pxp-key-change-after-suspend-resume: SUCCESS (7.198s) [539.269679] [089/133] (481s left) kms_big_fb (yf-tiled-8bpp-rotate-180) [539.381620] Starting subtest: yf-tiled-8bpp-rotate-180 [539.386062] Subtest yf-tiled-8bpp-rotate-180: SKIP (0.000s) [539.484519] [090/133] (481s left) kms_flip (nonexisting-fb) [539.561047] Starting subtest: nonexisting-fb [539.562931] Starting dynamic subtest: A-eDP1 [540.699105] Dynamic subtest A-eDP1: SUCCESS (1.139s) [540.713696] Starting dynamic subtest: B-eDP1 [541.828315] Dynamic subtest B-eDP1: SUCCESS (1.126s) [541.837877] Starting dynamic subtest: C-eDP1 [542.959188] Dynamic subtest C-eDP1: SUCCESS (1.129s) [542.972871] Starting dynamic subtest: D-eDP1 [544.092361] Dynamic subtest D-eDP1: SUCCESS (1.130s) [544.097147] Subtest nonexisting-fb: SUCCESS (4.538s) [545.280450] [091/133] (475s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-pwrite) [545.367125] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-pwrite [551.568265] Subtest fbc-1p-primscrn-pri-shrfb-draw-pwrite: SUCCESS (6.206s) [552.773136] [092/133] (468s left) syncobj_timeline (invalid-multi-wait-unsubmitted-submitted) [552.843081] Starting subtest: invalid-multi-wait-unsubmitted-submitted [552.845535] Subtest invalid-multi-wait-unsubmitted-submitted: SUCCESS (0.000s) [552.941358] [093/133] (468s left) kms_chamelium_color (ctm-red-to-blue) [553.020758] Subtest ctm-red-to-blue: SKIP (0.000s) [553.107338] [094/133] (468s left) gem_mmap_wc (bad-offset) [553.163943] Subtest bad-offset: SKIP (0.000s) [553.214995] [095/133] (468s left) perf_pmu (enable-race) [553.256138] Starting subtest: enable-race [553.258253] Starting dynamic subtest: rcs0 [566.044867] Dynamic subtest rcs0: SUCCESS (12.768s) [566.065354] Starting dynamic subtest: bcs0 [578.782469] Dynamic subtest bcs0: SUCCESS (12.734s) [578.803435] Starting dynamic subtest: vcs0 [593.872924] Dynamic subtest vcs0: SUCCESS (15.105s) [593.885892] Starting dynamic subtest: vcs1 [609.873007] Dynamic subtest vcs1: SUCCESS (15.995s) [609.886376] Starting dynamic subtest: vecs0 [625.872832] Dynamic subtest vecs0: SUCCESS (15.995s) [625.885647] Starting dynamic subtest: ccs0 [638.647636] Dynamic subtest ccs0: SUCCESS (12.756s) [638.650074] Subtest enable-race: SUCCESS (85.368s) [638.784208] [096/133] (382s left) kms_flip_scaled_crc (flip-32bpp-xtile-to-64bpp-xtile-downscaling) [638.870189] Starting subtest: flip-32bpp-xtile-to-64bpp-xtile-downscaling [638.872436] Starting dynamic subtest: pipe-A-default-mode [640.023877] Dynamic subtest pipe-A-default-mode: SKIP (1.152s) [640.027985] Subtest flip-32bpp-xtile-to-64bpp-xtile-downscaling: SKIP (1.153s) [640.166708] [097/133] (381s left) gem_basic (create-close) [640.222463] Starting subtest: create-close [640.226718] Subtest create-close: SUCCESS (0.000s) [640.316188] [098/133] (381s left) gem_ctx_persistence (saturated-hostile-nopreempt) [640.373803] Starting subtest: saturated-hostile-nopreempt [640.375695] Starting dynamic subtest: rcs0 [640.427578] Dynamic subtest rcs0: SKIP (0.054s) [640.438911] Starting dynamic subtest: bcs0 [640.443450] Dynamic subtest bcs0: SKIP (0.012s) [640.451893] Starting dynamic subtest: vcs0 [640.456331] Dynamic subtest vcs0: SKIP (0.012s) [640.464998] Starting dynamic subtest: vcs1 [640.469152] Dynamic subtest vcs1: SKIP (0.012s) [640.478075] Starting dynamic subtest: vecs0 [640.482414] Dynamic subtest vecs0: SKIP (0.011s) [640.491364] Starting dynamic subtest: ccs0 [640.495777] Dynamic subtest ccs0: SKIP (0.012s) [640.499843] Subtest saturated-hostile-nopreempt: SKIP (0.119s) [640.565173] [099/133] (380s left) gem_exec_gttfill (multigpu-basic) [640.730253] Starting subtest: multigpu-basic [652.993321] Subtest multigpu-basic: SUCCESS (12.264s) [653.046213] [100/133] (368s left) kms_psr (pr-cursor-mmap-gtt) [653.181086] Starting subtest: pr-cursor-mmap-gtt [653.185194] Subtest pr-cursor-mmap-gtt: SKIP (0.000s) [653.255492] [101/133] (368s left) kms_psr2_sf (fbc-pr-overlay-plane-move-continuous-exceed-sf) [653.334844] Starting subtest: fbc-pr-overlay-plane-move-continuous-exceed-sf [653.339092] Subtest fbc-pr-overlay-plane-move-continuous-exceed-sf: SKIP (0.000s) [653.402487] [102/133] (368s left) gem_softpin (evict-snoop) [653.467478] Starting subtest: evict-snoop [653.472007] Subtest evict-snoop: SKIP (0.000s) [653.620240] [103/133] (368s left) kms_plane (pixel-format-4-tiled-bmg-ccs-modifier) [653.685947] Starting subtest: pixel-format-4-tiled-bmg-ccs-modifier [653.690067] Subtest pixel-format-4-tiled-bmg-ccs-modifier: SKIP (0.000s) [653.761611] [104/133] (368s left) core_setmaster (master-drop-set-user) [653.856166] Starting subtest: master-drop-set-user [653.867792] Subtest master-drop-set-user: SUCCESS (0.015s) [653.905731] [105/133] (367s left) kms_psr (psr-basic) [653.979877] Starting subtest: psr-basic [653.982091] Starting dynamic subtest: eDP-1 [655.579114] Dynamic subtest eDP-1: SUCCESS (1.600s) [655.581261] Subtest psr-basic: SUCCESS (1.601s) [656.445553] [106/133] (365s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-shrfb-draw-mmap-gtt) [656.523859] Starting subtest: psr-1p-offscreen-pri-shrfb-draw-mmap-gtt [656.527824] Subtest psr-1p-offscreen-pri-shrfb-draw-mmap-gtt: SKIP (0.000s) [656.638351] [107/133] (365s left) kms_cursor_crc (cursor-rapid-movement-512x512) [656.902217] Starting subtest: cursor-rapid-movement-512x512 [656.906399] Subtest cursor-rapid-movement-512x512: SKIP (0.001s) [657.044408] [108/133] (364s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-blt) [657.121522] Starting subtest: psr-2p-primscrn-spr-indfb-draw-blt [657.125601] Subtest psr-2p-primscrn-spr-indfb-draw-blt: SKIP (0.000s) [657.220114] [109/133] (364s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-pwrite) [657.305014] Starting subtest: fbcpsr-rgb101010-draw-pwrite [664.371693] Subtest fbcpsr-rgb101010-draw-pwrite: SUCCESS (7.066s) [664.480385] [110/133] (357s left) kms_plane_alpha_blend (constant-alpha-max) [664.561149] Starting subtest: constant-alpha-max [664.846585] Starting dynamic subtest: pipe-A-eDP-1 [665.876365] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.026s) [665.886313] Starting dynamic subtest: pipe-D-eDP-1 [667.469543] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.594s) [667.472144] Subtest constant-alpha-max: SUCCESS (2.907s) [668.329523] [111/133] (353s left) kms_busy (extended-pageflip-hang-oldfb) [668.412717] Starting subtest: extended-pageflip-hang-oldfb [668.415060] Starting dynamic subtest: pipe-A [668.857343] Dynamic subtest pipe-A: SUCCESS (0.442s) [668.868436] Starting dynamic subtest: pipe-D [669.951090] Dynamic subtest pipe-D: SUCCESS (1.089s) [669.953256] Subtest extended-pageflip-hang-oldfb: SUCCESS (1.536s) [670.784146] [112/133] (351s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-indfb-plflip-blt) [670.866286] Starting subtest: fbcpsr-1p-primscrn-indfb-plflip-blt [678.349538] Subtest fbcpsr-1p-primscrn-indfb-plflip-blt: SUCCESS (7.484s) [678.472258] [113/133] (343s left) gem_softpin (32b-excludes-last-page) [678.539045] Starting subtest: 32b-excludes-last-page [678.544043] Subtest 32b-excludes-last-page: SUCCESS (0.004s) [678.672034] [114/133] (343s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-mmap-gtt) [678.747226] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-mmap-gtt [678.751182] Subtest fbc-2p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s) [678.862534] [115/133] (343s left) gem_exec_reloc (basic-cpu-wc-noreloc) [678.930751] Subtest basic-cpu-wc-noreloc: SKIP (0.000s) [679.007435] [116/133] (343s left) kms_ccs (crc-sprite-planes-basic-4-tiled-lnl-ccs) [679.085913] Starting subtest: crc-sprite-planes-basic-4-tiled-lnl-ccs [679.090409] Subtest crc-sprite-planes-basic-4-tiled-lnl-ccs: SKIP (0.000s) [680.236280] [117/133] (342s left) gem_mmap_gtt (cpuset-basic-small-copy) [680.289997] Subtest cpuset-basic-small-copy: SKIP (0.000s) [680.352911] [118/133] (341s left) kms_psr (fbc-pr-sprite-plane-onoff) [680.422897] Starting subtest: fbc-pr-sprite-plane-onoff [680.427350] Subtest fbc-pr-sprite-plane-onoff: SKIP (0.000s) [680.502121] [119/133] (341s left) kms_flip_scaled_crc (flip-64bpp-xtile-to-32bpp-xtile-downscaling) [680.572636] Starting subtest: flip-64bpp-xtile-to-32bpp-xtile-downscaling [680.574953] Starting dynamic subtest: pipe-A-default-mode [681.699166] Dynamic subtest pipe-A-default-mode: SKIP (1.124s) [681.703706] Subtest flip-64bpp-xtile-to-32bpp-xtile-downscaling: SKIP (1.126s) [681.843647] [120/133] (340s left) kms_frontbuffer_tracking (psr-1p-primscrn-indfb-pgflip-blt) [681.924137] Starting subtest: psr-1p-primscrn-indfb-pgflip-blt [689.226819] Subtest psr-1p-primscrn-indfb-pgflip-blt: SUCCESS (7.304s) [689.339909] [121/133] (333s left) prime_vgem (fence-wait) [689.416133] Starting subtest: fence-wait [689.418461] Starting dynamic subtest: rcs0 [690.463393] Dynamic subtest rcs0: SUCCESS (1.046s) [690.475162] Starting dynamic subtest: bcs0 [691.524169] Dynamic subtest bcs0: SUCCESS (1.059s) [691.540466] Starting dynamic subtest: vcs0 [692.571967] Dynamic subtest vcs0: SUCCESS (1.047s) [692.585517] Starting dynamic subtest: vcs1 [693.891956] Dynamic subtest vcs1: SUCCESS (1.318s) [693.904019] Starting dynamic subtest: vecs0 [694.936351] Dynamic subtest vecs0: SUCCESS (1.043s) [694.948859] Starting dynamic subtest: ccs0 [695.979016] Dynamic subtest ccs0: SUCCESS (1.040s) [695.981864] Subtest fence-wait: SUCCESS (6.561s) [696.104816] [122/133] (326s left) kms_flip (2x-plain-flip-fb-recreate-interruptible) [696.195819] Starting subtest: 2x-plain-flip-fb-recreate-interruptible [696.204622] Subtest 2x-plain-flip-fb-recreate-interruptible: SKIP (0.008s) [696.292752] [123/133] (326s left) kms_cursor_crc (cursor-offscreen-32x10) [696.442412] Starting subtest: cursor-offscreen-32x10 [696.490060] Subtest cursor-offscreen-32x10: SKIP (0.042s) [696.743972] [124/133] (325s left) gem_ctx_param (vm) [696.809872] Starting subtest: vm [696.861813] Subtest vm: SUCCESS (0.052s) [696.999684] [125/133] (325s left) gem_mmap_gtt (basic-short) [697.053363] Subtest basic-short: SKIP (0.000s) [697.111504] [126/133] (325s left) kms_frontbuffer_tracking (fbc-indfb-scaledprimary) [697.187132] Starting subtest: fbc-indfb-scaledprimary [700.172492] Subtest fbc-indfb-scaledprimary: SUCCESS (2.987s) [701.312559] [127/133] (321s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-180) [701.405868] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-180 [702.418839] Subtest 4-tiled-max-hw-stride-32bpp-rotate-180: SUCCESS (1.012s) [702.543582] [128/133] (320s left) api_intel_bb (simple-bb-ctx) [702.613558] Starting subtest: simple-bb-ctx [702.623330] Subtest simple-bb-ctx: SUCCESS (0.011s) [702.763952] [129/133] (320s left) i915_module_load (resize-bar) [702.803057] Starting subtest: resize-bar [702.808379] Subtest resize-bar: SKIP (0.006s) [702.852955] [130/133] (319s left) kms_vblank (ts-continuation-idle-hang) [702.935234] Starting subtest: ts-continuation-idle-hang [702.937220] Starting dynamic subtest: pipe-A-eDP-1 [729.683089] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.743s) [729.696943] Starting dynamic subtest: pipe-D-eDP-1 [744.727832] Dynamic subtest pipe-D-eDP-1: SUCCESS (15.038s) [744.729752] Subtest ts-continuation-idle-hang: SUCCESS (41.785s) [745.558071] [131/133] (277s left) kms_big_fb (x-tiled-32bpp-rotate-270) [745.646067] Starting subtest: x-tiled-32bpp-rotate-270 [745.668226] Subtest x-tiled-32bpp-rotate-270: SKIP (0.021s) [745.780540] [132/133] (277s left) kms_atomic (plane-primary-legacy) [745.856910] Starting subtest: plane-primary-legacy [745.859202] Starting dynamic subtest: pipe-A-eDP-1 [746.304478] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.447s) [746.306654] Subtest plane-primary-legacy: SUCCESS (0.449s) [747.199977] [133/133] (275s left) syncobj_timeline (invalid-multi-wait-all-unsubmitted-submitted) [747.257180] Starting subtest: invalid-multi-wait-all-unsubmitted-submitted [747.259436] Subtest invalid-multi-wait-all-unsubmitted-submitted: SUCCESS (0.000s) [747.355888] Closing watchdogs results: parsing output: 0/ for test: kms_frontbuffer_tracking results: parsing output: 1/ for test: gem_exec_balancer results: parsing output: 2/ for test: gem_exec_whisper results: parsing output: 3/ for test: tools_test results: parsing output: 4/ for test: kms_color results: parsing output: 5/ for test: syncobj_timeline results: parsing output: 6/ for test: gem_sync results: parsing output: 7/ for test: gem_userptr_blits results: parsing output: 8/ for test: kms_flip results: parsing output: 9/ for test: gem_softpin results: parsing output: 10/ for test: syncobj_timeline results: parsing output: 11/ for test: kms_plane_scaling results: parsing output: 12/ for test: kms_ccs results: parsing output: 13/ for test: i915_pm_sseu results: parsing output: 14/ for test: gem_exec_reloc results: parsing output: 15/ for test: kms_big_fb results: parsing output: 16/ for test: kms_pwrite_crc results: parsing output: 17/ for test: kms_flip results: parsing output: 18/ for test: perf_pmu results: parsing output: 19/ for test: syncobj_basic results: parsing output: 20/ for test: kms_dsc results: parsing output: 21/ for test: kms_frontbuffer_tracking results: parsing output: 22/ for test: kms_joiner results: parsing output: 23/ for test: kms_plane results: parsing output: 24/ for test: i915_pm_rc6_residency results: parsing output: 25/ for test: gen9_exec_parse results: parsing output: 26/ for test: kms_psr2_sf results: parsing output: 27/ for test: gem_wait results: parsing output: 28/ for test: gem_flink_basic results: parsing output: 29/ for test: kms_cursor_edge_walk results: parsing output: 30/ for test: vgem_basic results: parsing output: 31/ for test: gem_ctx_param results: parsing output: 32/ for test: gem_workarounds results: parsing output: 33/ for test: gem_exec_balancer results: parsing output: 34/ for test: kms_frontbuffer_tracking results: parsing output: 35/ for test: api_intel_allocator results: parsing output: 36/ for test: kms_ccs results: parsing output: 37/ for test: kms_flip_scaled_crc results: parsing output: 38/ for test: kms_rotation_crc results: parsing output: 39/ for test: kms_rotation_crc results: parsing output: 40/ for test: syncobj_timeline results: parsing output: 41/ for test: kms_frontbuffer_tracking results: parsing output: 42/ for test: syncobj_timeline results: parsing output: 43/ for test: syncobj_wait results: parsing output: 44/ for test: syncobj_wait results: parsing output: 45/ for test: kms_frontbuffer_tracking results: parsing output: 46/ for test: kms_big_fb results: parsing output: 47/ for test: gem_ctx_create results: parsing output: 48/ for test: fbdev results: parsing output: 49/ for test: kms_pm_dc results: parsing output: 50/ for test: kms_plane results: parsing output: 51/ for test: gem_exec_schedule results: parsing output: 52/ for test: gem_exec_nop results: parsing output: 53/ for test: kms_frontbuffer_tracking results: parsing output: 54/ for test: kms_atomic_transition results: parsing output: 55/ for test: kms_cursor_legacy results: parsing output: 56/ for test: gem_exec_fence results: parsing output: 57/ for test: kms_cursor_legacy results: parsing output: 58/ for test: kms_cursor_legacy results: parsing output: 59/ for test: kms_lease results: parsing output: 60/ for test: kms_cursor_legacy results: parsing output: 61/ for test: kms_pipe_b_c_ivb results: parsing output: 62/ for test: kms_frontbuffer_tracking results: parsing output: 63/ for test: kms_chamelium_hpd results: parsing output: 64/ for test: prime_vgem results: parsing output: 65/ for test: kms_ccs results: parsing output: 66/ for test: kms_content_protection results: parsing output: 67/ for test: gem_exec_alignment results: parsing output: 68/ for test: kms_frontbuffer_tracking results: parsing output: 69/ for test: kms_chamelium_audio results: parsing output: 70/ for test: sw_sync results: parsing output: 71/ for test: kms_atomic_transition results: parsing output: 72/ for test: gem_exec_schedule results: parsing output: 73/ for test: kms_big_fb results: parsing output: 74/ for test: kms_dp_link_training results: parsing output: 75/ for test: kms_sequence results: parsing output: 76/ for test: i915_drm_fdinfo results: parsing output: 77/ for test: kms_psr results: parsing output: 78/ for test: kms_flip results: parsing output: 79/ for test: gem_mmap_gtt results: parsing output: 80/ for test: kms_frontbuffer_tracking results: parsing output: 81/ for test: gem_ccs results: parsing output: 82/ for test: gem_lmem_swapping results: parsing output: 83/ for test: kms_frontbuffer_tracking results: parsing output: 84/ for test: kms_pm_rpm results: parsing output: 85/ for test: kms_async_flips results: parsing output: 86/ for test: kms_psr2_sf results: parsing output: 87/ for test: gem_pxp results: parsing output: 88/ for test: kms_big_fb results: parsing output: 89/ for test: kms_flip results: parsing output: 90/ for test: kms_frontbuffer_tracking results: parsing output: 91/ for test: syncobj_timeline results: parsing output: 92/ for test: kms_chamelium_color results: parsing output: 93/ for test: gem_mmap_wc results: parsing output: 94/ for test: perf_pmu results: parsing output: 95/ for test: kms_flip_scaled_crc results: parsing output: 96/ for test: gem_basic results: parsing output: 97/ for test: gem_ctx_persistence results: parsing output: 98/ for test: gem_exec_gttfill results: parsing output: 99/ for test: kms_psr results: parsing output: 100/ for test: kms_psr2_sf results: parsing output: 101/ for test: gem_softpin results: parsing output: 102/ for test: kms_plane results: parsing output: 103/ for test: core_setmaster results: parsing output: 104/ for test: kms_psr results: parsing output: 105/ for test: kms_frontbuffer_tracking results: parsing output: 106/ for test: kms_cursor_crc results: parsing output: 107/ for test: kms_frontbuffer_tracking results: parsing output: 108/ for test: kms_frontbuffer_tracking results: parsing output: 109/ for test: kms_plane_alpha_blend results: parsing output: 110/ for test: kms_busy results: parsing output: 111/ for test: kms_frontbuffer_tracking results: parsing output: 112/ for test: gem_softpin results: parsing output: 113/ for test: kms_frontbuffer_tracking results: parsing output: 114/ for test: gem_exec_reloc results: parsing output: 115/ for test: kms_ccs results: parsing output: 116/ for test: gem_mmap_gtt results: parsing output: 117/ for test: kms_psr results: parsing output: 118/ for test: kms_flip_scaled_crc results: parsing output: 119/ for test: kms_frontbuffer_tracking results: parsing output: 120/ for test: prime_vgem results: parsing output: 121/ for test: kms_flip results: parsing output: 122/ for test: kms_cursor_crc results: parsing output: 123/ for test: gem_ctx_param results: parsing output: 124/ for test: gem_mmap_gtt results: parsing output: 125/ for test: kms_frontbuffer_tracking results: parsing output: 126/ for test: kms_big_fb results: parsing output: 127/ for test: api_intel_bb results: parsing output: 128/ for test: i915_module_load results: parsing output: 129/ for test: kms_vblank results: parsing output: 130/ for test: kms_big_fb results: parsing output: 131/ for test: kms_atomic results: parsing output: 132/ for test: syncobj_timeline Done.