[59.332412] Initializing watchdogs [59.332461] /dev/watchdog0 [59.347382] [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] [59.351846] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [59.354244] [FACT before any test] new: kernel.kmod_is_loaded.i915: true [59.357645] [001/134] (960s left) kms_addfb_basic (addfb25-y-tiled-small-legacy) [59.483525] Starting subtest: addfb25-y-tiled-small-legacy [59.487928] Subtest addfb25-y-tiled-small-legacy: SKIP (0.000s) [59.613962] [002/134] (960s left) kms_plane_scaling (plane-downscale-factor-0-75-with-modifiers) [59.706145] Starting subtest: plane-downscale-factor-0-75-with-modifiers [59.708518] Starting dynamic subtest: pipe-A [60.054574] Dynamic subtest pipe-A: SUCCESS (0.353s) [60.062992] Starting dynamic subtest: pipe-B [61.530873] Dynamic subtest pipe-B: SUCCESS (1.483s) [61.538631] Starting dynamic subtest: pipe-C [62.975848] Dynamic subtest pipe-C: SUCCESS (1.450s) [62.987891] Starting dynamic subtest: pipe-D [64.350639] Dynamic subtest pipe-D: SUCCESS (1.378s) [64.353183] Subtest plane-downscale-factor-0-75-with-modifiers: SUCCESS (4.667s) [65.525675] [003/134] (954s left) i915_drm_fdinfo (virtual-idle) [65.571065] Starting subtest: virtual-idle [68.637469] Subtest virtual-idle: SUCCESS (3.073s) [68.731176] [004/134] (951s left) gem_userptr_blits (huge-split) [68.823235] Starting subtest: huge-split [68.834406] Subtest huge-split: SUCCESS (0.011s) [69.001641] [005/134] (951s left) kms_psr (fbc-pr-no-drrs) [69.102896] Starting subtest: fbc-pr-no-drrs [69.107407] Subtest fbc-pr-no-drrs: SKIP (0.000s) [69.202395] [006/134] (950s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-mmap-cpu) [69.309388] Starting subtest: psr-1p-primscrn-pri-indfb-draw-mmap-cpu [76.274476] Subtest psr-1p-primscrn-pri-indfb-draw-mmap-cpu: SUCCESS (6.976s) [76.415462] [007/134] (943s left) kms_cursor_legacy (cursora-vs-flipa-legacy) [76.534824] Starting subtest: cursorA-vs-flipA-legacy [87.696487] Subtest cursorA-vs-flipA-legacy: SUCCESS (11.162s) [88.557361] [008/134] (931s left) kms_psr (psr2-primary-page-flip) [88.664855] Starting subtest: psr2-primary-page-flip [88.667027] Starting dynamic subtest: eDP-1 [90.410337] Dynamic subtest eDP-1: SUCCESS (1.745s) [90.412291] Subtest psr2-primary-page-flip: SUCCESS (1.746s) [91.314212] [009/134] (928s left) i915_pm_rc6_residency (rc6-accuracy) [91.371852] Starting subtest: rc6-accuracy [91.373850] Starting dynamic subtest: gt0 [94.544981] Dynamic subtest gt0: SUCCESS (3.170s) [94.555046] Starting dynamic subtest: gt1 [97.715087] Dynamic subtest gt1: SUCCESS (3.168s) [97.717750] Subtest rc6-accuracy: SUCCESS (6.341s) [97.813677] [010/134] (922s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-blt) [97.925167] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-blt [105.289915] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-blt: SUCCESS (7.367s) [105.435211] [011/134] (914s left) kms_feature_discovery (psr2) [105.542797] Starting subtest: psr2 [105.544650] Subtest psr2: SUCCESS (0.000s) [105.638479] [012/134] (914s left) syncobj_wait (single-wait-all-for-submit-submitted) [105.691055] Starting subtest: single-wait-all-for-submit-submitted [105.797504] Subtest single-wait-all-for-submit-submitted: SUCCESS (0.106s) [105.893382] [013/134] (914s left) kms_flip (2x-wf_vblank-ts-check-interruptible) [105.998513] Starting subtest: 2x-wf_vblank-ts-check-interruptible [106.010332] Subtest 2x-wf_vblank-ts-check-interruptible: SKIP (0.011s) [106.110809] [014/134] (914s left) kms_psr_stress_test (flip-primary-invalidate-overlay) [106.201434] Starting subtest: flip-primary-invalidate-overlay [117.755753] Subtest flip-primary-invalidate-overlay: SUCCESS (11.557s) [117.925845] [015/134] (902s left) i915_drm_fdinfo (busy-idle) [117.974223] Starting subtest: busy-idle [117.976085] Starting dynamic subtest: rcs0 [117.994409] Dynamic subtest rcs0: SKIP (0.019s) [118.003495] Starting dynamic subtest: bcs0 [118.018157] Dynamic subtest bcs0: SKIP (0.023s) [118.028536] Starting dynamic subtest: vcs0 [118.032080] Dynamic subtest vcs0: SKIP (0.001s) [118.039473] Starting dynamic subtest: vcs1 [118.042938] Dynamic subtest vcs1: SKIP (0.000s) [118.050439] Starting dynamic subtest: vecs0 [118.053979] Dynamic subtest vecs0: SKIP (0.000s) [118.062900] Starting dynamic subtest: ccs0 [118.066291] Dynamic subtest ccs0: SKIP (0.000s) [118.069614] Subtest busy-idle: SKIP (0.047s) [118.116901] [016/134] (902s left) gem_exec_params (invalid-bsd2-flag-on-vebox) [118.175084] Starting subtest: invalid-bsd2-flag-on-vebox [118.177077] Subtest invalid-bsd2-flag-on-vebox: SUCCESS (0.000s) [118.303846] [017/134] (902s left) syncobj_wait (single-wait-all-for-submit-signaled) [118.361286] Starting subtest: single-wait-all-for-submit-signaled [118.363207] Subtest single-wait-all-for-submit-signaled: SUCCESS (0.000s) [118.480262] [018/134] (902s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-blt) [118.574443] Starting subtest: fbcpsr-rgb101010-draw-blt [125.326050] Subtest fbcpsr-rgb101010-draw-blt: SUCCESS (6.751s) [125.492661] [019/134] (895s left) kms_pm_rpm (modeset-lpsp) [127.018811] Starting subtest: modeset-lpsp [128.501156] Subtest modeset-lpsp: SUCCESS (1.482s) [128.623976] [020/134] (891s left) i915_suspend (sysfs-reader) [128.684054] Starting subtest: sysfs-reader [147.014386] Subtest sysfs-reader: SUCCESS (3.260s) [147.119285] [021/134] (873s left) prime_vgem (sync) [147.245803] Starting subtest: sync [147.247774] Starting dynamic subtest: rcs0 [147.299700] Dynamic subtest rcs0: SUCCESS (0.055s) [147.308119] Starting dynamic subtest: bcs0 [147.375313] Dynamic subtest bcs0: SUCCESS (0.077s) [147.383730] Starting dynamic subtest: vcs0 [147.422017] Dynamic subtest vcs0: SUCCESS (0.048s) [147.430386] Starting dynamic subtest: vcs1 [147.468170] Dynamic subtest vcs1: SUCCESS (0.047s) [147.476750] Starting dynamic subtest: vecs0 [147.514552] Dynamic subtest vecs0: SUCCESS (0.047s) [147.523076] Starting dynamic subtest: ccs0 [147.560384] Dynamic subtest ccs0: SUCCESS (0.046s) [147.562273] Subtest sync: SUCCESS (0.323s) [147.698786] [FACT prime_vgem (sync)] new: kernel.kmod_is_loaded.vgem: true [147.702122] [022/134] (873s left) api_intel_allocator (two-level-inception) [147.763686] Starting subtest: two-level-inception [153.062911] Subtest two-level-inception: SUCCESS (5.400s) [153.237818] [023/134] (867s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-move) [153.350028] Starting subtest: psr-2p-primscrn-cur-indfb-move [153.354131] Subtest psr-2p-primscrn-cur-indfb-move: SKIP (0.000s) [153.496587] [024/134] (867s left) sriov_basic (bind-unbind-vf) [153.579899] Starting subtest: bind-unbind-vf [153.582253] Starting dynamic subtest: vf-1 [153.658711] Dynamic subtest vf-1: FAIL (0.030s) [153.672090] Starting dynamic subtest: vf-2 [153.744730] Dynamic subtest vf-2: FAIL (0.004s) [153.755576] Starting dynamic subtest: vf-3 [153.829010] Dynamic subtest vf-3: FAIL (0.004s) [153.839264] Starting dynamic subtest: vf-4 [153.910935] Dynamic subtest vf-4: FAIL (0.004s) [153.921859] Starting dynamic subtest: vf-5 [153.993888] Dynamic subtest vf-5: FAIL (0.004s) [154.004584] Starting dynamic subtest: vf-6 [154.076005] Dynamic subtest vf-6: FAIL (0.004s) [154.085774] Starting dynamic subtest: vf-7 [154.145806] Dynamic subtest vf-7: FAIL (0.004s) [154.155655] Starting dynamic subtest: vf-random [154.214371] Dynamic subtest vf-random: FAIL (0.004s) [154.224467] Starting dynamic subtest: vf-last [154.283377] Dynamic subtest vf-last: FAIL (0.004s) [154.285091] Subtest bind-unbind-vf: FAIL (0.569s) [154.322145] [025/134] (866s left) gem_eio (hibernate) [154.561728] Starting subtest: hibernate [169.141651] Subtest hibernate: SUCCESS (14.652s) [177.369565] [026/134] (851s left) kms_vrr (seamless-rr-switch-virtual) [177.495566] Starting subtest: seamless-rr-switch-virtual [177.501882] Subtest seamless-rr-switch-virtual: SKIP (0.000s) [177.594814] [027/134] (851s left) api_intel_bb (render) [177.657717] Starting subtest: render [177.660029] Starting dynamic subtest: render-none-512 [177.757321] Dynamic subtest render-none-512: SUCCESS (0.100s) [177.770119] Starting dynamic subtest: render-none-1024 [178.139348] Dynamic subtest render-none-1024: SUCCESS (0.380s) [178.153947] Starting dynamic subtest: render-x-512 [178.226559] Dynamic subtest render-x-512: SUCCESS (0.087s) [178.238530] Starting dynamic subtest: render-x-1024 [178.568411] Dynamic subtest render-x-1024: SUCCESS (0.342s) [178.580987] Starting dynamic subtest: render-y-512 [178.656537] Dynamic subtest render-y-512: SUCCESS (0.087s) [178.668352] Starting dynamic subtest: render-y-1024 [179.100911] Dynamic subtest render-y-1024: SUCCESS (0.443s) [179.104042] Subtest render: SUCCESS (1.443s) [179.252266] [028/134] (849s left) kms_cursor_legacy (torture-bo) [179.371780] Starting subtest: torture-bo [179.373919] Starting dynamic subtest: pipe-A [185.055252] Dynamic subtest pipe-A: SUCCESS (5.679s) [185.069916] Starting dynamic subtest: pipe-B [191.346904] Dynamic subtest pipe-B: SUCCESS (6.291s) [191.359545] Starting dynamic subtest: pipe-C [197.931757] Dynamic subtest pipe-C: SUCCESS (6.585s) [197.943147] Starting dynamic subtest: pipe-D [204.167219] Dynamic subtest pipe-D: SUCCESS (6.236s) [204.180975] Starting dynamic subtest: all-pipes [211.155083] Dynamic subtest all-pipes: SUCCESS (6.986s) [211.157745] Subtest torture-bo: SUCCESS (31.784s) [211.338649] [029/134] (817s left) kms_rotation_crc (sprite-rotation-270) [211.450551] Starting subtest: sprite-rotation-270 [211.455047] Subtest sprite-rotation-270: SKIP (0.001s) [211.549714] [030/134] (817s left) kms_prime (basic-modeset-hybrid) [211.649346] Subtest basic-modeset-hybrid: SKIP (0.000s) [211.766700] [031/134] (817s left) gem_ctx_persistence (many-contexts) [211.839079] Starting subtest: many-contexts [257.053848] Subtest many-contexts: SUCCESS (45.225s) [257.169049] [032/134] (772s left) gem_create (busy-create) [257.235036] Starting subtest: busy-create [257.237417] Starting dynamic subtest: smem0 [290.977427] Dynamic subtest smem0: SUCCESS (33.753s) [290.979974] Subtest busy-create: SUCCESS (33.754s) [291.192934] [033/134] (738s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-mmap-gtt) [291.316065] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-mmap-gtt [291.320383] Subtest psr-2p-scndscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s) [291.450437] [034/134] (737s left) kms_psr (fbc-psr-cursor-blt) [291.549662] Starting subtest: fbc-psr-cursor-blt [291.551969] Starting dynamic subtest: eDP-1 [291.556446] Dynamic subtest eDP-1: SKIP (0.000s) [291.560910] Subtest fbc-psr-cursor-blt: SKIP (0.001s) [291.648359] [035/134] (737s left) gem_sync (basic-store-each) [291.719286] Starting subtest: basic-store-each [294.070473] Subtest basic-store-each: SUCCESS (2.363s) [294.282296] [036/134] (735s left) prime_mmap (test_userptr) [294.342789] Starting subtest: test_userptr [294.345177] Starting dynamic subtest: test_userptr-smem [294.347208] Dynamic subtest test_userptr-smem: SUCCESS (0.000s) [294.349219] Subtest test_userptr: SUCCESS (0.001s) [294.465560] [037/134] (734s left) kms_pipe_crc_basic (nonblocking-crc) [294.566761] Starting subtest: nonblocking-crc [294.569165] Starting dynamic subtest: pipe-A-eDP-1 [295.308121] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.742s) [295.318713] Starting dynamic subtest: pipe-B-eDP-1 [296.750851] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.442s) [296.761870] Starting dynamic subtest: pipe-C-eDP-1 [298.157265] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.406s) [298.168153] Starting dynamic subtest: pipe-D-eDP-1 [299.494088] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.334s) [299.496561] Subtest nonblocking-crc: SUCCESS (4.930s) [300.302661] [038/134] (729s left) perf (unprivileged-single-ctx-counters) [300.448791] Starting subtest: unprivileged-single-ctx-counters [300.452515] Subtest unprivileged-single-ctx-counters: SKIP (0.000s) [300.497886] [039/134] (729s left) kms_psr2_sf (psr2-overlay-primary-update-sf-dmg-area) [305.449043] Starting subtest: psr2-overlay-primary-update-sf-dmg-area [305.451448] Starting dynamic subtest: pipe-A-eDP-1 [311.980657] Dynamic subtest pipe-A-eDP-1: SUCCESS (6.535s) [311.990530] Starting dynamic subtest: pipe-B-eDP-1 [318.592828] Dynamic subtest pipe-B-eDP-1: SUCCESS (6.610s) [318.595133] Subtest psr2-overlay-primary-update-sf-dmg-area: SUCCESS (13.149s) [319.494101] [040/134] (710s left) kms_psr2_sf (pr-overlay-plane-move-continuous-sf) [324.434239] Starting subtest: pr-overlay-plane-move-continuous-sf [324.439153] Subtest pr-overlay-plane-move-continuous-sf: SKIP (0.003s) [325.320058] [041/134] (704s left) kms_psr (fbc-psr-sprite-blt) [325.417478] Starting subtest: fbc-psr-sprite-blt [325.419725] Starting dynamic subtest: eDP-1 [325.423668] Dynamic subtest eDP-1: SKIP (0.000s) [325.427668] Subtest fbc-psr-sprite-blt: SKIP (0.001s) [325.516308] [042/134] (704s left) sysfs_timeslice_duration (invalid) [325.586700] Starting subtest: invalid [325.589167] Starting dynamic subtest: vecs0 [325.591662] Dynamic subtest vecs0: SUCCESS (0.001s) [325.604566] Starting dynamic subtest: ccs0 [325.607176] Dynamic subtest ccs0: SUCCESS (0.001s) [325.617190] Starting dynamic subtest: vcs0 [325.619433] Dynamic subtest vcs0: SUCCESS (0.001s) [325.629378] Starting dynamic subtest: bcs0 [325.631610] Dynamic subtest bcs0: SUCCESS (0.001s) [325.641586] Starting dynamic subtest: rcs0 [325.643762] Dynamic subtest rcs0: SUCCESS (0.001s) [325.653543] Starting dynamic subtest: vcs1 [325.655484] Dynamic subtest vcs1: SUCCESS (0.001s) [325.657424] Subtest invalid: SUCCESS (0.017s) [325.736362] [043/134] (703s left) gem_barrier_race (remote-request) [325.802575] Starting subtest: remote-request [325.804634] Starting dynamic subtest: rcs0 [330.959437] Dynamic subtest rcs0: SUCCESS (5.162s) [330.961439] Subtest remote-request: SUCCESS (5.163s) [331.129449] [044/134] (698s left) kms_big_fb (yf-tiled-addfb-size-overflow) [331.229107] Starting subtest: yf-tiled-addfb-size-overflow [331.232788] Subtest yf-tiled-addfb-size-overflow: SKIP (0.000s) [331.336332] [045/134] (698s left) vgem_basic (busy-fence) [331.377780] Starting subtest: busy-fence [331.379835] Subtest busy-fence: SUCCESS (0.000s) [331.462400] [046/134] (698s left) gem_mmap (bad-object) [331.518846] Subtest bad-object: SKIP (0.000s) [331.584374] [047/134] (698s left) kms_big_fb (x-tiled-64bpp-rotate-180) [331.687281] Starting subtest: x-tiled-64bpp-rotate-180 [333.322084] Subtest x-tiled-64bpp-rotate-180: SUCCESS (1.635s) [333.543151] [048/134] (696s left) syncobj_timeline (etime-multi-wait-submitted) [333.600024] Starting subtest: etime-multi-wait-submitted [333.710549] Subtest etime-multi-wait-submitted: SUCCESS (0.109s) [333.810931] [049/134] (696s left) gem_readwrite (read-write) [333.875161] Subtest read-write: SKIP (0.000s) [333.935121] [050/134] (696s left) kms_content_protection (mei-interface) [334.079205] Starting subtest: mei-interface [334.083684] Subtest mei-interface: SKIP (0.001s) [334.249399] [051/134] (695s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip) [334.356450] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip [335.036131] Subtest 4-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip: SUCCESS (0.681s) [335.255329] [052/134] (694s left) gem_mmap_gtt (isolation) [335.316963] Subtest isolation: SKIP (0.000s) [335.383468] [053/134] (694s left) kms_cursor_edge_walk (64x64-top-edge) [335.477257] Starting subtest: 64x64-top-edge [335.479565] Starting dynamic subtest: pipe-A-eDP-1 [338.946385] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.472s) [338.960677] Starting dynamic subtest: pipe-D-eDP-1 [342.064844] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.118s) [342.067166] Subtest 64x64-top-edge: SUCCESS (6.592s) [342.904693] [054/134] (687s left) syncobj_wait (wait-all-snapshot) [342.959535] Starting subtest: wait-all-snapshot [343.039213] Subtest wait-all-snapshot: SUCCESS (0.081s) [343.139150] [055/134] (687s left) kms_frontbuffer_tracking (fbcpsr-argb161616f-draw-mmap-cpu) [343.244207] Starting subtest: fbcpsr-argb161616f-draw-mmap-cpu [343.248709] Subtest fbcpsr-argb161616f-draw-mmap-cpu: SKIP (0.000s) [343.376752] [056/134] (686s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-gtt) [343.482110] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-gtt [343.486211] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s) [343.594461] [057/134] (686s left) gem_create (create-invalid-size) [343.652086] Starting subtest: create-invalid-size [343.654306] Subtest create-invalid-size: SUCCESS (0.000s) [343.861439] [058/134] (686s left) gem_render_copy (y-tiled-ccs-to-yf-tiled) [343.922194] Starting subtest: y-tiled-ccs-to-yf-tiled [343.927026] Subtest y-tiled-ccs-to-yf-tiled: SKIP (0.000s) [344.128575] [059/134] (686s left) kms_frontbuffer_tracking (psr-argb161616f-draw-mmap-wc) [344.232156] Starting subtest: psr-argb161616f-draw-mmap-wc [344.236416] Subtest psr-argb161616f-draw-mmap-wc: SKIP (0.000s) [344.361210] [060/134] (686s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-mmap-cpu) [344.457108] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-mmap-cpu [344.461121] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s) [344.598968] [061/134] (685s left) kms_joiner (switch-modeset-ultra-joiner-big-joiner) [344.697445] Starting subtest: switch-modeset-ultra-joiner-big-joiner [344.701730] Subtest switch-modeset-ultra-joiner-big-joiner: SKIP (0.000s) [344.786293] [062/134] (685s left) sw_sync (sync_merge_same) [344.824140] Starting subtest: sync_merge_same [344.826366] Subtest sync_merge_same: SUCCESS (0.000s) [344.907125] [063/134] (685s left) kms_plane_scaling (planes-downscale-factor-0-75-unity-scaling) [344.999907] Starting subtest: planes-downscale-factor-0-75-unity-scaling [345.002104] Starting dynamic subtest: pipe-A [345.062585] Dynamic subtest pipe-A: SUCCESS (0.065s) [345.072611] Starting dynamic subtest: pipe-B [346.212133] Dynamic subtest pipe-B: SUCCESS (1.148s) [346.223000] Starting dynamic subtest: pipe-C [347.317049] Dynamic subtest pipe-C: SUCCESS (1.103s) [347.333651] Starting dynamic subtest: pipe-D [348.443516] Dynamic subtest pipe-D: SUCCESS (1.126s) [348.445828] Subtest planes-downscale-factor-0-75-unity-scaling: SUCCESS (3.448s) [349.635552] [064/134] (680s left) syncobj_timeline (multi-wait-for-submit-available-unsubmitted-submitted-signa [349.694273] Starting subtest: multi-wait-for-submit-available-unsubmitted-submitted-signaled [349.696610] Subtest multi-wait-for-submit-available-unsubmitted-submitted-signaled: SUCCESS (0.000s) [349.813414] [065/134] (680s left) gem_render_copy (linear-to-vebox-yf-tiled) [349.868695] Starting subtest: linear-to-vebox-yf-tiled [349.873065] Subtest linear-to-vebox-yf-tiled: SKIP (0.000s) [350.078360] [066/134] (680s left) kms_flip (flip-vs-dpms-off-vs-modeset-interruptible) [350.176199] Starting subtest: flip-vs-dpms-off-vs-modeset-interruptible [350.178603] Starting dynamic subtest: A-eDP1 [353.738023] Dynamic subtest A-eDP1: SUCCESS (3.561s) [353.749271] Starting dynamic subtest: B-eDP1 [356.925752] Dynamic subtest B-eDP1: SUCCESS (3.186s) [356.935816] Starting dynamic subtest: C-eDP1 [360.024808] Dynamic subtest C-eDP1: SUCCESS (3.102s) [360.036067] Starting dynamic subtest: D-eDP1 [363.216338] Dynamic subtest D-eDP1: SUCCESS (3.189s) [363.218515] Subtest flip-vs-dpms-off-vs-modeset-interruptible: SUCCESS (13.047s) [364.041372] [067/134] (666s left) kms_chamelium_color (ctm-limited-range) [364.136684] Subtest ctm-limited-range: SKIP (0.000s) [364.184840] [068/134] (666s left) gem_mmap_wc (write) [364.230157] Subtest write: SKIP (0.000s) [364.295298] [069/134] (666s left) prime_mmap (test_correct) [364.359969] Starting subtest: test_correct [364.362204] Starting dynamic subtest: test_correct-smem [364.389888] Dynamic subtest test_correct-smem: SUCCESS (0.032s) [364.392307] Subtest test_correct: SUCCESS (0.032s) [364.534230] [070/134] (666s left) device_reset (cold-reset-bound) [364.588783] Starting subtest: cold-reset-bound [364.593220] Subtest cold-reset-bound: SKIP (0.000s) [364.690767] [071/134] (666s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-blt) [364.804407] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-blt [371.780726] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-blt: SUCCESS (6.980s) [371.967935] [072/134] (658s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-mmap-cpu) [372.080858] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-mmap-cpu [376.324970] Subtest fbc-1p-primscrn-pri-indfb-draw-mmap-cpu: SUCCESS (4.249s) [377.480462] [073/134] (653s left) kms_ccs (crc-primary-basic-y-tiled-gen12-rc-ccs) [377.576554] Starting subtest: crc-primary-basic-y-tiled-gen12-rc-ccs [377.578810] Starting dynamic subtest: pipe-A-eDP-1 [377.601543] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [377.613291] Starting dynamic subtest: pipe-B-eDP-1 [377.634744] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [377.644011] Starting dynamic subtest: pipe-C-eDP-1 [377.665539] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [377.675023] Starting dynamic subtest: pipe-D-eDP-1 [377.697741] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [377.702160] Subtest crc-primary-basic-y-tiled-gen12-rc-ccs: SKIP (0.006s) [379.844569] [074/134] (651s left) gem_exec_fence (syncobj-channel) [380.309608] Starting subtest: syncobj-channel [381.328052] Subtest syncobj-channel: SUCCESS (1.016s) [382.067252] [075/134] (648s left) gem_exec_reloc (basic-gtt-noreloc) [382.128437] Subtest basic-gtt-noreloc: SKIP (0.000s) [382.203166] [076/134] (648s left) kms_flip (dpms-off-confusion-interruptible) [382.305788] Starting subtest: dpms-off-confusion-interruptible [382.308060] Starting dynamic subtest: A-eDP1 [390.933541] Dynamic subtest A-eDP1: SUCCESS (8.630s) [390.947807] Starting dynamic subtest: B-eDP1 [399.571142] Dynamic subtest B-eDP1: SUCCESS (8.639s) [399.583269] Starting dynamic subtest: C-eDP1 [408.184646] Dynamic subtest C-eDP1: SUCCESS (8.616s) [408.196220] Starting dynamic subtest: D-eDP1 [416.810403] Dynamic subtest D-eDP1: SUCCESS (8.629s) [416.815706] Subtest dpms-off-confusion-interruptible: SUCCESS (34.525s) [417.990220] [077/134] (613s left) kms_vblank (wait-forked-busy) [418.092640] Starting subtest: wait-forked-busy [418.094797] Starting dynamic subtest: pipe-A-eDP-1 [419.965413] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.874s) [419.981452] Starting dynamic subtest: pipe-D-eDP-1 [422.528974] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.559s) [422.531008] Subtest wait-forked-busy: SUCCESS (4.438s) [423.350915] [078/134] (607s left) kms_chamelium_frames (dp-frame-dump) [423.759070] Subtest dp-frame-dump: SKIP (0.000s) [424.552573] [079/134] (606s left) kms_ccs (crc-sprite-planes-basic-y-tiled-gen12-mc-ccs) [424.654659] Starting subtest: crc-sprite-planes-basic-y-tiled-gen12-mc-ccs [424.656828] Starting dynamic subtest: pipe-A-eDP-1 [424.714053] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s) [424.724950] Starting dynamic subtest: pipe-B-eDP-1 [424.781718] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s) [424.792568] Starting dynamic subtest: pipe-C-eDP-1 [424.846160] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s) [424.856079] Starting dynamic subtest: pipe-D-eDP-1 [424.911719] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s) [424.915711] Subtest crc-sprite-planes-basic-y-tiled-gen12-mc-ccs: SKIP (0.010s) [426.939959] [080/134] (604s left) kms_frontbuffer_tracking (fbc-2p-primscrn-indfb-plflip-blt) [427.040642] Starting subtest: fbc-2p-primscrn-indfb-plflip-blt [427.044538] Subtest fbc-2p-primscrn-indfb-plflip-blt: SKIP (0.000s) [427.184125] [081/134] (604s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-180) [427.297843] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-180 [427.302419] Subtest y-tiled-max-hw-stride-64bpp-rotate-180: SKIP (0.000s) [427.418064] [082/134] (603s left) gen7_exec_parse (cmd-crossing-page) [427.492614] Subtest cmd-crossing-page: SKIP (0.000s) [427.581720] [083/134] (603s left) kms_atomic_transition (modeset-transition-nonblocking) [427.679695] Starting subtest: modeset-transition-nonblocking [427.682033] Starting dynamic subtest: 1x-outputs [438.669146] Dynamic subtest 1x-outputs: SUCCESS (10.996s) [438.671575] Subtest modeset-transition-nonblocking: SUCCESS (10.997s) [439.569806] [084/134] (591s left) kms_draw_crc (draw-method-mmap-cpu) [439.673723] Starting subtest: draw-method-mmap-cpu [439.675685] Starting dynamic subtest: xrgb8888-untiled [439.917017] Dynamic subtest xrgb8888-untiled: SUCCESS (0.244s) [439.927047] Starting dynamic subtest: rgb565-untiled [440.149451] Dynamic subtest rgb565-untiled: SUCCESS (0.231s) [440.169735] Starting dynamic subtest: xrgb2101010-untiled [440.371487] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.220s) [440.383563] Starting dynamic subtest: xbgr16161616f-untiled [440.604360] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.233s) [440.614154] Starting dynamic subtest: xrgb8888-xtiled [440.781643] Dynamic subtest xrgb8888-xtiled: SUCCESS (0.176s) [440.791970] Starting dynamic subtest: rgb565-xtiled [440.915170] Dynamic subtest rgb565-xtiled: SUCCESS (0.133s) [440.924972] Starting dynamic subtest: xrgb2101010-xtiled [441.059566] Dynamic subtest xrgb2101010-xtiled: SUCCESS (0.143s) [441.069695] Starting dynamic subtest: xbgr16161616f-xtiled [441.192630] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (0.133s) [441.202809] Starting dynamic subtest: xrgb8888-4tiled [441.337225] Dynamic subtest xrgb8888-4tiled: SUCCESS (0.144s) [441.349245] Starting dynamic subtest: rgb565-4tiled [441.481631] Dynamic subtest rgb565-4tiled: SUCCESS (0.142s) [441.491540] Starting dynamic subtest: xrgb2101010-4tiled [441.626279] Dynamic subtest xrgb2101010-4tiled: SUCCESS (0.144s) [441.640525] Starting dynamic subtest: xbgr16161616f-4tiled [441.770283] Dynamic subtest xbgr16161616f-4tiled: SUCCESS (0.143s) [441.772205] Subtest draw-method-mmap-cpu: SUCCESS (2.100s) [441.920458] [085/134] (589s left) kms_ccs (bad-rotation-90-4-tiled-mtl-rc-ccs-cc) [442.022089] Starting subtest: bad-rotation-90-4-tiled-mtl-rc-ccs-cc [442.023858] Starting dynamic subtest: pipe-A-eDP-1 [442.171529] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.141s) [442.183401] Starting dynamic subtest: pipe-B-eDP-1 [442.199189] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.010s) [442.213511] Starting dynamic subtest: pipe-C-eDP-1 [442.231162] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.013s) [442.242838] Starting dynamic subtest: pipe-D-eDP-1 [442.258657] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.011s) [442.260387] Subtest bad-rotation-90-4-tiled-mtl-rc-ccs-cc: SUCCESS (0.180s) [444.509094] [086/134] (587s left) gem_exec_schedule (u-semaphore-user) [444.584337] Starting subtest: u-semaphore-user [444.632722] Subtest u-semaphore-user: SUCCESS (0.057s) [446.092044] [087/134] (585s left) gem_exec_fence (basic-await) [446.278713] Starting subtest: basic-await [446.281208] Starting dynamic subtest: rcs0 [446.354549] Dynamic subtest rcs0: SUCCESS (0.076s) [446.368342] Starting dynamic subtest: bcs0 [446.427154] Dynamic subtest bcs0: SUCCESS (0.071s) [446.439529] Starting dynamic subtest: vcs0 [446.501553] Dynamic subtest vcs0: SUCCESS (0.072s) [446.514703] Starting dynamic subtest: vcs1 [446.574581] Dynamic subtest vcs1: SUCCESS (0.071s) [446.587352] Starting dynamic subtest: vecs0 [446.647584] Dynamic subtest vecs0: SUCCESS (0.072s) [446.660942] Starting dynamic subtest: ccs0 [446.720585] Dynamic subtest ccs0: SUCCESS (0.071s) [446.723403] Subtest basic-await: SUCCESS (0.443s) [448.150030] [088/134] (583s left) kms_rotation_crc (cursor-rotation-180) [448.254788] Starting subtest: cursor-rotation-180 [449.765525] Subtest cursor-rotation-180: SUCCESS (1.512s) [450.978644] [089/134] (580s left) kms_cursor_crc (cursor-onscreen-512x170) [451.290319] Starting subtest: cursor-onscreen-512x170 [451.294927] Subtest cursor-onscreen-512x170: SKIP (0.001s) [451.461063] [090/134] (580s left) kms_big_fb (linear-addfb) [451.570779] Starting subtest: linear-addfb [451.572922] Subtest linear-addfb: SUCCESS (0.000s) [451.707905] [091/134] (580s left) gem_exec_whisper (basic-queues) [451.780590] Starting subtest: basic-queues [459.056148] Subtest basic-queues: SUCCESS (7.275s) [459.265859] [092/134] (572s left) gem_exec_reloc (basic-scanout) [459.333224] Subtest basic-scanout: SKIP (0.000s) [459.428695] [093/134] (572s left) kms_plane_lowres (tiling-4) [459.527193] Starting subtest: tiling-4 [459.529408] Starting dynamic subtest: pipe-A-eDP-1 [459.533760] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [459.824981] Starting dynamic subtest: pipe-B-eDP-1 [459.829699] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [459.840699] Starting dynamic subtest: pipe-C-eDP-1 [459.845320] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [459.855849] Starting dynamic subtest: pipe-D-eDP-1 [459.860203] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [459.864644] Subtest tiling-4: SKIP (0.295s) [460.700301] [094/134] (571s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-onoff) [460.793421] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-onoff [467.914792] Subtest fbcpsr-1p-primscrn-spr-indfb-onoff: SUCCESS (7.112s) [468.065177] [095/134] (563s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-mmap-cpu) [468.166981] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-mmap-cpu [471.745120] Subtest fbc-1p-primscrn-spr-indfb-draw-mmap-cpu: SUCCESS (3.575s) [472.955286] [096/134] (559s left) gem_ctx_create (basic) [473.027809] Starting subtest: basic [473.030221] Subtest basic: SUCCESS (0.000s) [473.234749] [097/134] (558s left) kms_flip_scaled_crc (flip-64bpp-xtile-to-32bpp-xtile-downscaling) [473.340402] Starting subtest: flip-64bpp-xtile-to-32bpp-xtile-downscaling [473.342809] Starting dynamic subtest: pipe-A-default-mode [474.493088] Dynamic subtest pipe-A-default-mode: SKIP (1.149s) [474.497327] Subtest flip-64bpp-xtile-to-32bpp-xtile-downscaling: SKIP (1.152s) [474.685739] [098/134] (557s left) gem_pwrite (basic-exhaustion) [474.755175] Subtest basic-exhaustion: SKIP (0.000s) [474.829417] [099/134] (557s left) kms_atomic_transition (plane-all-transition-nonblocking) [474.939942] Starting subtest: plane-all-transition-nonblocking [474.942312] Starting dynamic subtest: pipe-A-eDP-1 [477.439066] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.497s) [477.749203] Starting dynamic subtest: pipe-B-eDP-1 [480.992579] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.249s) [481.290560] Subtest plane-all-transition-nonblocking: SUCCESS (6.344s) [482.193119] [100/134] (550s left) kms_color_pipeline (plane-lut1d-lut1d) [482.293738] Starting subtest: plane-lut1d-lut1d [482.306832] Starting dynamic subtest: pipe-A-eDP-1 [483.031992] Dynamic subtest pipe-A-eDP-1: FAIL (0.317s) [483.707155] Starting dynamic subtest: pipe-B-eDP-1 [484.576032] Dynamic subtest pipe-B-eDP-1: FAIL (0.346s) [485.136256] Starting dynamic subtest: pipe-C-eDP-1 [485.966929] Dynamic subtest pipe-C-eDP-1: FAIL (0.246s) [486.456828] Starting dynamic subtest: pipe-D-eDP-1 [487.310757] Dynamic subtest pipe-D-eDP-1: FAIL (0.269s) [487.312841] Subtest plane-lut1d-lut1d: FAIL (4.707s) [487.865079] [101/134] (544s left) gem_lmem_swapping (verify-random) [487.908826] Subtest verify-random: SKIP (0.000s) [487.956233] [102/134] (544s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-mmap-wc) [488.060976] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-mmap-wc [488.065304] Subtest psr-2p-primscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s) [488.184233] [103/134] (544s left) sw_sync (sync_random_merge) [488.223870] Starting subtest: sync_random_merge [488.264195] Subtest sync_random_merge: SUCCESS (0.041s) [488.351657] [104/134] (544s left) syncobj_timeline (invalid-signal-bad-pad) [488.410442] Starting subtest: invalid-signal-bad-pad [488.412373] Subtest invalid-signal-bad-pad: SUCCESS (0.000s) [488.555221] [105/134] (543s left) gem_mmap_gtt (basic) [488.623525] Subtest basic: SKIP (0.000s) [488.679459] [106/134] (543s left) gem_exec_balancer (invalid-balancer) [488.738981] Starting subtest: invalid-balancer [489.659704] Subtest invalid-balancer: SUCCESS (0.917s) [490.008290] [107/134] (542s left) kms_big_fb (y-tiled-8bpp-rotate-90) [490.129089] Starting subtest: y-tiled-8bpp-rotate-90 [490.133475] Subtest y-tiled-8bpp-rotate-90: SKIP (0.000s) [490.241697] [108/134] (542s left) gem_render_linear_blits (basic) [490.314466] Starting subtest: basic [490.335876] Subtest basic: SUCCESS (0.022s) [490.436180] [109/134] (542s left) gem_ctx_shared (q-promotion) [490.500169] Starting subtest: Q-promotion [490.502686] Starting dynamic subtest: rcs0 [490.603678] Dynamic subtest rcs0: SUCCESS (0.103s) [490.620529] Starting dynamic subtest: vcs0 [490.693709] Dynamic subtest vcs0: SUCCESS (0.089s) [490.707961] Starting dynamic subtest: vcs1 [490.779386] Dynamic subtest vcs1: SUCCESS (0.083s) [490.797401] Starting dynamic subtest: vecs0 [490.858343] Dynamic subtest vecs0: SUCCESS (0.078s) [490.876185] Starting dynamic subtest: ccs0 [490.947986] Dynamic subtest ccs0: SUCCESS (0.089s) [490.950157] Subtest Q-promotion: SUCCESS (0.448s) [492.114790] [110/134] (540s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-pwrite) [492.215153] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-pwrite [492.219296] Subtest fbc-2p-primscrn-pri-shrfb-draw-pwrite: SKIP (0.000s) [492.361985] [111/134] (540s left) syncobj_timeline (single-wait-for-submit-available-submitted) [492.422893] Starting subtest: single-wait-for-submit-available-submitted [492.425095] Subtest single-wait-for-submit-available-submitted: SUCCESS (0.000s) [492.542939] [112/134] (540s left) gem_flink_basic (bad-open) [492.601596] Starting subtest: bad-open [492.603446] Subtest bad-open: SUCCESS (0.000s) [492.729002] [113/134] (540s left) kms_ccs (crc-primary-rotation-180-4-tiled-mtl-rc-ccs-cc) [492.821693] Starting subtest: crc-primary-rotation-180-4-tiled-mtl-rc-ccs-cc [492.824173] Starting dynamic subtest: pipe-A-eDP-1 [493.748718] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.920s) [493.765746] Starting dynamic subtest: pipe-B-eDP-1 [495.353559] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.597s) [495.365724] Starting dynamic subtest: pipe-C-eDP-1 [496.854821] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.499s) [496.865939] Starting dynamic subtest: pipe-D-eDP-1 [498.378826] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.522s) [498.380718] Subtest crc-primary-rotation-180-4-tiled-mtl-rc-ccs-cc: SUCCESS (5.545s) [499.574906] [114/134] (533s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-mmap-wc) [499.673555] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-mmap-wc [499.677929] Subtest psr-2p-scndscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s) [499.798114] [115/134] (533s left) kms_hdr (bpc-switch-dpms) [499.885865] Starting subtest: bpc-switch-dpms [500.919565] Starting dynamic subtest: pipe-A-eDP-1 [505.442876] Dynamic subtest pipe-A-eDP-1: SUCCESS (4.521s) [505.445282] Subtest bpc-switch-dpms: SUCCESS (5.554s) [505.612603] [116/134] (527s left) kms_chamelium_hpd (hdmi-hpd) [506.009121] Subtest hdmi-hpd: SKIP (0.000s) [506.805784] [117/134] (526s left) kms_rotation_crc (primary-yf-tiled-reflect-x-270) [506.906093] Starting subtest: primary-yf-tiled-reflect-x-270 [506.911138] Subtest primary-yf-tiled-reflect-x-270: SKIP (0.001s) [507.000961] [118/134] (525s left) prime_vgem (basic-write) [507.089915] Starting subtest: basic-write [507.095319] Subtest basic-write: SKIP (0.006s) [507.255230] [119/134] (525s left) gem_ctx_freq (sysfs) [507.316027] Starting subtest: sysfs [507.318322] Starting dynamic subtest: gt0 [512.854046] Dynamic subtest gt0: SUCCESS (5.533s) [512.866726] Starting dynamic subtest: gt1 [553.993275] Dynamic subtest gt1: SUCCESS (41.118s) [553.996065] Subtest sysfs: SUCCESS (46.654s) [554.161265] [120/134] (478s left) kms_cursor_crc (cursor-onscreen-max-size) [554.483605] Starting subtest: cursor-onscreen-max-size [554.490258] Subtest cursor-onscreen-max-size: SKIP (0.000s) [554.654229] [121/134] (478s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-shrfb-draw-mmap-gtt) [554.766804] Starting subtest: fbc-1p-offscreen-pri-shrfb-draw-mmap-gtt [554.771223] Subtest fbc-1p-offscreen-pri-shrfb-draw-mmap-gtt: SKIP (0.000s) [554.917784] [122/134] (478s left) perf (per-context-mode-unprivileged) [555.018225] Starting subtest: per-context-mode-unprivileged [555.021929] Subtest per-context-mode-unprivileged: SKIP (0.000s) [555.066592] [123/134] (478s left) kms_setmode (basic) [555.129488] Starting subtest: basic [555.451128] Starting dynamic subtest: pipe-A-eDP-1 [557.564834] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.109s) [557.923774] Starting dynamic subtest: pipe-B-eDP-1 [559.997244] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.079s) [560.306278] Subtest basic: SUCCESS (5.174s) [561.160023] [124/134] (472s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip) [561.269514] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip [561.949792] Subtest x-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip: SUCCESS (0.681s) [562.140285] [125/134] (471s left) kms_atomic_transition (plane-use-after-nonblocking-unbind) [562.236649] Starting subtest: plane-use-after-nonblocking-unbind [562.238936] Starting dynamic subtest: pipe-A-eDP-1 [562.297023] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.062s) [562.608940] Starting dynamic subtest: pipe-B-eDP-1 [563.436786] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.842s) [563.726671] Subtest plane-use-after-nonblocking-unbind: SUCCESS (1.489s) [564.624508] [126/134] (468s left) kms_atomic_interruptible (universal-setplane-primary) [564.723822] Starting subtest: universal-setplane-primary [564.726068] Starting dynamic subtest: pipe-A-eDP-1 [572.114920] Dynamic subtest pipe-A-eDP-1: SUCCESS (7.387s) [572.116916] Subtest universal-setplane-primary: SUCCESS (7.389s) [572.975626] [127/134] (460s left) kms_pm_backlight (fade-with-dpms) [573.078548] Starting subtest: fade-with-dpms [575.413092] Starting dynamic subtest: eDP-1 [578.093803] Dynamic subtest eDP-1: SUCCESS (2.681s) [578.096311] Subtest fade-with-dpms: SUCCESS (5.017s) [578.920802] [128/134] (454s left) perf_pmu (event-wait) [578.967354] Starting subtest: event-wait [578.969676] Starting dynamic subtest: rcs0 [578.973758] Dynamic subtest rcs0: SKIP (0.000s) [578.978215] Subtest event-wait: SKIP (0.001s) [579.094758] [129/134] (454s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-mmap-gtt) [579.204000] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-mmap-gtt [579.208118] Subtest fbc-2p-scndscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s) [579.346043] [130/134] (454s left) gem_exec_whisper (basic-contexts-all) [579.409565] Starting subtest: basic-contexts-all [588.152346] Subtest basic-contexts-all: SUCCESS (8.738s) [588.363742] [131/134] (445s left) gem_spin_batch (spin-each) [588.435227] Starting subtest: spin-each [591.804752] Subtest spin-each: SUCCESS (3.366s) [592.084711] [132/134] (441s left) kms_universal_plane (disable-primary-vs-flip) [592.189427] Starting subtest: disable-primary-vs-flip [592.191701] Starting dynamic subtest: pipe-A-eDP-1 [593.766747] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.579s) [593.777979] Starting dynamic subtest: pipe-B-eDP-1 [595.923758] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.155s) [595.941387] Starting dynamic subtest: pipe-C-eDP-1 [598.100419] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.173s) [598.114817] Starting dynamic subtest: pipe-D-eDP-1 [600.291310] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.191s) [600.293669] Subtest disable-primary-vs-flip: SUCCESS (8.102s) [601.119183] [133/134] (432s left) gem_exec_schedule (preemptive-hang) [601.306273] Starting subtest: preemptive-hang [601.308529] Starting dynamic subtest: rcs0 [610.103464] Dynamic subtest rcs0: SUCCESS (8.799s) [610.116712] Starting dynamic subtest: bcs0 [619.120650] Dynamic subtest bcs0: SUCCESS (9.017s) [619.134048] Starting dynamic subtest: vcs0 [628.148975] Dynamic subtest vcs0: SUCCESS (9.025s) [628.160711] Starting dynamic subtest: vcs1 [637.106592] Dynamic subtest vcs1: SUCCESS (8.957s) [637.120328] Starting dynamic subtest: vecs0 [646.189032] Dynamic subtest vecs0: SUCCESS (9.082s) [646.199733] Starting dynamic subtest: ccs0 [655.092217] Dynamic subtest ccs0: SUCCESS (8.902s) [655.094414] Subtest preemptive-hang: SUCCESS (53.793s) [655.389246] [134/134] (378s left) syncobj_wait (invalid-signal-bad-pad) [655.453004] Starting subtest: invalid-signal-bad-pad [655.455089] Subtest invalid-signal-bad-pad: SUCCESS (0.000s) [655.596587] Closing watchdogs results: parsing output: 0/ for test: kms_addfb_basic results: parsing output: 1/ for test: kms_plane_scaling results: parsing output: 2/ for test: i915_drm_fdinfo results: parsing output: 3/ for test: gem_userptr_blits results: parsing output: 4/ for test: kms_psr results: parsing output: 5/ for test: kms_frontbuffer_tracking results: parsing output: 6/ for test: kms_cursor_legacy results: parsing output: 7/ for test: kms_psr results: parsing output: 8/ for test: i915_pm_rc6_residency results: parsing output: 9/ for test: kms_frontbuffer_tracking results: parsing output: 10/ for test: kms_feature_discovery results: parsing output: 11/ for test: syncobj_wait results: parsing output: 12/ for test: kms_flip results: parsing output: 13/ for test: kms_psr_stress_test results: parsing output: 14/ for test: i915_drm_fdinfo results: parsing output: 15/ for test: gem_exec_params results: parsing output: 16/ for test: syncobj_wait results: parsing output: 17/ for test: kms_frontbuffer_tracking results: parsing output: 18/ for test: kms_pm_rpm results: parsing output: 19/ for test: i915_suspend results: parsing output: 20/ for test: prime_vgem results: parsing output: 21/ for test: api_intel_allocator results: parsing output: 22/ for test: kms_frontbuffer_tracking results: parsing output: 23/ for test: sriov_basic results: parsing output: 24/ for test: gem_eio results: parsing output: 25/ for test: kms_vrr results: parsing output: 26/ for test: api_intel_bb results: parsing output: 27/ for test: kms_cursor_legacy results: parsing output: 28/ for test: kms_rotation_crc results: parsing output: 29/ for test: kms_prime results: parsing output: 30/ for test: gem_ctx_persistence results: parsing output: 31/ for test: gem_create results: parsing output: 32/ for test: kms_frontbuffer_tracking results: parsing output: 33/ for test: kms_psr results: parsing output: 34/ for test: gem_sync results: parsing output: 35/ for test: prime_mmap results: parsing output: 36/ for test: kms_pipe_crc_basic results: parsing output: 37/ for test: perf results: parsing output: 38/ for test: kms_psr2_sf results: parsing output: 39/ for test: kms_psr2_sf results: parsing output: 40/ for test: kms_psr results: parsing output: 41/ for test: sysfs_timeslice_duration results: parsing output: 42/ for test: gem_barrier_race results: parsing output: 43/ for test: kms_big_fb results: parsing output: 44/ for test: vgem_basic results: parsing output: 45/ for test: gem_mmap results: parsing output: 46/ for test: kms_big_fb results: parsing output: 47/ for test: syncobj_timeline results: parsing output: 48/ for test: gem_readwrite results: parsing output: 49/ for test: kms_content_protection results: parsing output: 50/ for test: kms_big_fb results: parsing output: 51/ for test: gem_mmap_gtt results: parsing output: 52/ for test: kms_cursor_edge_walk results: parsing output: 53/ for test: syncobj_wait results: parsing output: 54/ for test: kms_frontbuffer_tracking results: parsing output: 55/ for test: kms_frontbuffer_tracking results: parsing output: 56/ for test: gem_create results: parsing output: 57/ for test: gem_render_copy results: parsing output: 58/ for test: kms_frontbuffer_tracking results: parsing output: 59/ for test: kms_frontbuffer_tracking results: parsing output: 60/ for test: kms_joiner results: parsing output: 61/ for test: sw_sync results: parsing output: 62/ for test: kms_plane_scaling results: parsing output: 63/ for test: syncobj_timeline results: parsing output: 64/ for test: gem_render_copy results: parsing output: 65/ for test: kms_flip results: parsing output: 66/ for test: kms_chamelium_color results: parsing output: 67/ for test: gem_mmap_wc results: parsing output: 68/ for test: prime_mmap results: parsing output: 69/ for test: device_reset results: parsing output: 70/ for test: kms_frontbuffer_tracking results: parsing output: 71/ for test: kms_frontbuffer_tracking results: parsing output: 72/ for test: kms_ccs results: parsing output: 73/ for test: gem_exec_fence results: parsing output: 74/ for test: gem_exec_reloc results: parsing output: 75/ for test: kms_flip results: parsing output: 76/ for test: kms_vblank results: parsing output: 77/ for test: kms_chamelium_frames results: parsing output: 78/ for test: kms_ccs results: parsing output: 79/ for test: kms_frontbuffer_tracking results: parsing output: 80/ for test: kms_big_fb results: parsing output: 81/ for test: gen7_exec_parse results: parsing output: 82/ for test: kms_atomic_transition results: parsing output: 83/ for test: kms_draw_crc results: parsing output: 84/ for test: kms_ccs results: parsing output: 85/ for test: gem_exec_schedule results: parsing output: 86/ for test: gem_exec_fence results: parsing output: 87/ for test: kms_rotation_crc results: parsing output: 88/ for test: kms_cursor_crc results: parsing output: 89/ for test: kms_big_fb results: parsing output: 90/ for test: gem_exec_whisper results: parsing output: 91/ for test: gem_exec_reloc results: parsing output: 92/ for test: kms_plane_lowres results: parsing output: 93/ for test: kms_frontbuffer_tracking results: parsing output: 94/ for test: kms_frontbuffer_tracking results: parsing output: 95/ for test: gem_ctx_create results: parsing output: 96/ for test: kms_flip_scaled_crc results: parsing output: 97/ for test: gem_pwrite results: parsing output: 98/ for test: kms_atomic_transition results: parsing output: 99/ for test: kms_color_pipeline results: parsing output: 100/ for test: gem_lmem_swapping results: parsing output: 101/ for test: kms_frontbuffer_tracking results: parsing output: 102/ for test: sw_sync results: parsing output: 103/ for test: syncobj_timeline results: parsing output: 104/ for test: gem_mmap_gtt results: parsing output: 105/ for test: gem_exec_balancer results: parsing output: 106/ for test: kms_big_fb results: parsing output: 107/ for test: gem_render_linear_blits results: parsing output: 108/ for test: gem_ctx_shared results: parsing output: 109/ for test: kms_frontbuffer_tracking results: parsing output: 110/ for test: syncobj_timeline results: parsing output: 111/ for test: gem_flink_basic results: parsing output: 112/ for test: kms_ccs results: parsing output: 113/ for test: kms_frontbuffer_tracking results: parsing output: 114/ for test: kms_hdr results: parsing output: 115/ for test: kms_chamelium_hpd results: parsing output: 116/ for test: kms_rotation_crc results: parsing output: 117/ for test: prime_vgem results: parsing output: 118/ for test: gem_ctx_freq results: parsing output: 119/ for test: kms_cursor_crc results: parsing output: 120/ for test: kms_frontbuffer_tracking results: parsing output: 121/ for test: perf results: parsing output: 122/ for test: kms_setmode results: parsing output: 123/ for test: kms_big_fb results: parsing output: 124/ for test: kms_atomic_transition results: parsing output: 125/ for test: kms_atomic_interruptible results: parsing output: 126/ for test: kms_pm_backlight results: parsing output: 127/ for test: perf_pmu results: parsing output: 128/ for test: kms_frontbuffer_tracking results: parsing output: 129/ for test: gem_exec_whisper results: parsing output: 130/ for test: gem_spin_batch results: parsing output: 131/ for test: kms_universal_plane results: parsing output: 132/ for test: gem_exec_schedule results: parsing output: 133/ for test: syncobj_wait Done.