[56.215442] Initializing watchdogs [56.215483] /dev/watchdog0 [56.228939] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:7d55 Intel Meteorlake (Gen12) Meteor Lake-P [Intel Arc Graphics] [56.233162] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [56.235346] [FACT before any test] new: kernel.kmod_is_loaded.i915: true [56.238799] [001/134] (960s left) kms_addfb_basic (addfb25-y-tiled-small-legacy) [56.370523] Starting subtest: addfb25-y-tiled-small-legacy [56.374638] Subtest addfb25-y-tiled-small-legacy: SKIP (0.000s) [56.505884] [002/134] (960s left) kms_plane_scaling (plane-downscale-factor-0-75-with-modifiers) [56.599852] Starting subtest: plane-downscale-factor-0-75-with-modifiers [56.601960] Starting dynamic subtest: pipe-A [56.971638] Dynamic subtest pipe-A: SUCCESS (0.374s) [56.980449] Starting dynamic subtest: pipe-B [58.397545] Dynamic subtest pipe-B: SUCCESS (1.430s) [58.404734] Starting dynamic subtest: pipe-C [59.846197] Dynamic subtest pipe-C: SUCCESS (1.452s) [59.853612] Starting dynamic subtest: pipe-D [61.252097] Dynamic subtest pipe-D: SUCCESS (1.408s) [61.254384] Subtest plane-downscale-factor-0-75-with-modifiers: SUCCESS (4.667s) [62.425776] [003/134] (954s left) i915_drm_fdinfo (virtual-idle) [62.467139] Starting subtest: virtual-idle [65.518333] Subtest virtual-idle: SUCCESS (3.053s) [65.612985] [004/134] (951s left) gem_userptr_blits (huge-split) [65.697502] Starting subtest: huge-split [65.710077] Subtest huge-split: SUCCESS (0.012s) [65.878398] [005/134] (951s left) kms_psr (fbc-pr-no-drrs) [65.977870] Starting subtest: fbc-pr-no-drrs [65.981906] Subtest fbc-pr-no-drrs: SKIP (0.000s) [66.066642] [006/134] (950s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-mmap-cpu) [66.167644] Starting subtest: psr-1p-primscrn-pri-indfb-draw-mmap-cpu [73.142648] Subtest psr-1p-primscrn-pri-indfb-draw-mmap-cpu: SUCCESS (6.981s) [73.267770] [007/134] (943s left) kms_cursor_legacy (cursora-vs-flipa-legacy) [73.389776] Starting subtest: cursorA-vs-flipA-legacy [84.562967] Subtest cursorA-vs-flipA-legacy: SUCCESS (11.175s) [85.443048] [008/134] (931s left) kms_psr (psr2-primary-page-flip) [85.554150] Starting subtest: psr2-primary-page-flip [85.556365] Starting dynamic subtest: eDP-1 [87.306494] Dynamic subtest eDP-1: SUCCESS (1.752s) [87.308900] Subtest psr2-primary-page-flip: SUCCESS (1.752s) [88.216639] [009/134] (928s left) i915_pm_rc6_residency (rc6-accuracy) [88.273801] Starting subtest: rc6-accuracy [88.276047] Starting dynamic subtest: gt0 [91.445093] Dynamic subtest gt0: SUCCESS (3.169s) [91.452987] Starting dynamic subtest: gt1 [94.616341] Dynamic subtest gt1: SUCCESS (3.169s) [94.618893] Subtest rc6-accuracy: SUCCESS (6.342s) [94.711340] [010/134] (922s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-blt) [94.826212] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-blt [102.022111] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-blt: SUCCESS (7.198s) [102.188850] [011/134] (914s left) kms_feature_discovery (psr2) [102.285724] Starting subtest: psr2 [102.287962] Subtest psr2: SUCCESS (0.000s) [102.378650] [012/134] (914s left) syncobj_wait (single-wait-all-for-submit-submitted) [102.439148] Starting subtest: single-wait-all-for-submit-submitted [102.545251] Subtest single-wait-all-for-submit-submitted: SUCCESS (0.105s) [102.639632] [013/134] (914s left) kms_flip (2x-wf_vblank-ts-check-interruptible) [102.739498] Starting subtest: 2x-wf_vblank-ts-check-interruptible [102.750317] Subtest 2x-wf_vblank-ts-check-interruptible: SKIP (0.010s) [102.883718] [014/134] (914s left) kms_psr_stress_test (flip-primary-invalidate-overlay) [102.987183] Starting subtest: flip-primary-invalidate-overlay [114.555114] Subtest flip-primary-invalidate-overlay: SUCCESS (11.569s) [114.704202] [015/134] (902s left) i915_drm_fdinfo (busy-idle) [114.742287] Starting subtest: busy-idle [114.744154] Starting dynamic subtest: rcs0 [114.768111] Dynamic subtest rcs0: SKIP (0.024s) [114.774808] Starting dynamic subtest: bcs0 [114.794867] Dynamic subtest bcs0: SKIP (0.026s) [114.801505] Starting dynamic subtest: vcs0 [114.805141] Dynamic subtest vcs0: SKIP (0.000s) [114.811819] Starting dynamic subtest: vcs1 [114.815177] Dynamic subtest vcs1: SKIP (0.000s) [114.821882] Starting dynamic subtest: vecs0 [114.825460] Dynamic subtest vecs0: SKIP (0.000s) [114.831993] Starting dynamic subtest: ccs0 [114.835645] Dynamic subtest ccs0: SKIP (0.000s) [114.839161] Subtest busy-idle: SKIP (0.054s) [114.885279] [016/134] (902s left) gem_exec_params (invalid-bsd2-flag-on-vebox) [114.956271] Starting subtest: invalid-bsd2-flag-on-vebox [114.958104] Subtest invalid-bsd2-flag-on-vebox: SUCCESS (0.000s) [115.101137] [017/134] (902s left) syncobj_wait (single-wait-all-for-submit-signaled) [115.165292] Starting subtest: single-wait-all-for-submit-signaled [115.167209] Subtest single-wait-all-for-submit-signaled: SUCCESS (0.000s) [115.309391] [018/134] (902s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-blt) [115.414957] Starting subtest: fbcpsr-rgb101010-draw-blt [122.197085] Subtest fbcpsr-rgb101010-draw-blt: SUCCESS (6.784s) [122.365215] [019/134] (895s left) kms_pm_rpm (modeset-lpsp) [124.094087] Starting subtest: modeset-lpsp [125.545815] Subtest modeset-lpsp: SUCCESS (1.451s) [125.657779] [020/134] (891s left) i915_suspend (sysfs-reader) [125.718864] Starting subtest: sysfs-reader [143.893618] Subtest sysfs-reader: SUCCESS (3.285s) [143.947775] [021/134] (873s left) prime_vgem (sync) [144.106995] Starting subtest: sync [144.108887] Starting dynamic subtest: rcs0 [144.154089] Dynamic subtest rcs0: SUCCESS (0.049s) [144.162482] Starting dynamic subtest: bcs0 [144.216732] Dynamic subtest bcs0: SUCCESS (0.063s) [144.224383] Starting dynamic subtest: vcs0 [144.265428] Dynamic subtest vcs0: SUCCESS (0.049s) [144.273442] Starting dynamic subtest: vcs1 [144.311360] Dynamic subtest vcs1: SUCCESS (0.046s) [144.319614] Starting dynamic subtest: vecs0 [144.357581] Dynamic subtest vecs0: SUCCESS (0.046s) [144.365868] Starting dynamic subtest: ccs0 [144.404312] Dynamic subtest ccs0: SUCCESS (0.046s) [144.406556] Subtest sync: SUCCESS (0.303s) [144.555814] [FACT prime_vgem (sync)] new: kernel.kmod_is_loaded.vgem: true [144.558547] [022/134] (872s left) api_intel_allocator (two-level-inception) [144.622392] Starting subtest: two-level-inception [149.973878] Subtest two-level-inception: SUCCESS (5.399s) [150.126036] [023/134] (867s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-move) [150.235288] Starting subtest: psr-2p-primscrn-cur-indfb-move [150.239395] Subtest psr-2p-primscrn-cur-indfb-move: SKIP (0.000s) [150.385177] [024/134] (867s left) sriov_basic (bind-unbind-vf) [150.446455] Starting subtest: bind-unbind-vf [150.448788] Starting dynamic subtest: vf-1 [150.529069] Dynamic subtest vf-1: FAIL (0.032s) [150.539392] Starting dynamic subtest: vf-2 [150.613521] Dynamic subtest vf-2: FAIL (0.004s) [150.624142] Starting dynamic subtest: vf-3 [150.698194] Dynamic subtest vf-3: FAIL (0.004s) [150.707445] Starting dynamic subtest: vf-4 [150.775679] Dynamic subtest vf-4: FAIL (0.004s) [150.784253] Starting dynamic subtest: vf-5 [150.857014] Dynamic subtest vf-5: FAIL (0.004s) [150.866911] Starting dynamic subtest: vf-6 [150.939429] Dynamic subtest vf-6: FAIL (0.004s) [150.949516] Starting dynamic subtest: vf-7 [151.015917] Dynamic subtest vf-7: FAIL (0.004s) [151.025063] Starting dynamic subtest: vf-random [151.083768] Dynamic subtest vf-random: FAIL (0.004s) [151.092817] Starting dynamic subtest: vf-last [151.151182] Dynamic subtest vf-last: FAIL (0.505s) [151.152862] Subtest bind-unbind-vf: FAIL (0.568s) [151.190706] [025/134] (866s left) gem_eio (hibernate) [151.419645] Starting subtest: hibernate [166.045884] Subtest hibernate: SUCCESS (14.662s) [173.242021] [026/134] (851s left) kms_vrr (seamless-rr-switch-virtual) [173.369996] Starting subtest: seamless-rr-switch-virtual [173.376303] Subtest seamless-rr-switch-virtual: SKIP (0.000s) [173.463364] [027/134] (851s left) api_intel_bb (render) [173.523073] Starting subtest: render [173.525299] Starting dynamic subtest: render-none-512 [173.684671] Dynamic subtest render-none-512: SUCCESS (0.162s) [173.696222] Starting dynamic subtest: render-none-1024 [174.081031] Dynamic subtest render-none-1024: SUCCESS (0.396s) [174.090408] Starting dynamic subtest: render-x-512 [174.164202] Dynamic subtest render-x-512: SUCCESS (0.084s) [174.174725] Starting dynamic subtest: render-x-1024 [174.522804] Dynamic subtest render-x-1024: SUCCESS (0.357s) [174.534678] Starting dynamic subtest: render-y-512 [174.607849] Dynamic subtest render-y-512: SUCCESS (0.086s) [174.617384] Starting dynamic subtest: render-y-1024 [174.942160] Dynamic subtest render-y-1024: SUCCESS (0.332s) [174.944879] Subtest render: SUCCESS (1.421s) [175.091351] [028/134] (849s left) kms_cursor_legacy (torture-bo) [175.220183] Starting subtest: torture-bo [175.222502] Starting dynamic subtest: pipe-A [181.245692] Dynamic subtest pipe-A: SUCCESS (6.028s) [181.258018] Starting dynamic subtest: pipe-B [187.662204] Dynamic subtest pipe-B: SUCCESS (6.418s) [187.674536] Starting dynamic subtest: pipe-C [193.264885] Dynamic subtest pipe-C: SUCCESS (5.606s) [193.276786] Starting dynamic subtest: pipe-D [199.454705] Dynamic subtest pipe-D: SUCCESS (6.189s) [199.466578] Starting dynamic subtest: all-pipes [206.890408] Dynamic subtest all-pipes: SUCCESS (7.438s) [206.892993] Subtest torture-bo: SUCCESS (31.687s) [207.072263] [029/134] (817s left) kms_rotation_crc (sprite-rotation-270) [207.169595] Starting subtest: sprite-rotation-270 [207.173713] Subtest sprite-rotation-270: SKIP (0.001s) [207.271426] [030/134] (817s left) kms_prime (basic-modeset-hybrid) [207.375544] Subtest basic-modeset-hybrid: SKIP (0.000s) [207.491353] [031/134] (817s left) gem_ctx_persistence (many-contexts) [207.541495] Starting subtest: many-contexts [252.743994] Subtest many-contexts: SUCCESS (45.225s) [252.847030] [032/134] (772s left) gem_create (busy-create) [252.909682] Starting subtest: busy-create [252.912923] Starting dynamic subtest: smem0 [285.855628] Dynamic subtest smem0: SUCCESS (32.960s) [285.858538] Subtest busy-create: SUCCESS (32.961s) [286.067220] [033/134] (738s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-mmap-gtt) [286.176791] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-mmap-gtt [286.180861] Subtest psr-2p-scndscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s) [286.297124] [034/134] (738s left) kms_psr (fbc-psr-cursor-blt) [286.405730] Starting subtest: fbc-psr-cursor-blt [286.408046] Starting dynamic subtest: eDP-1 [286.412076] Dynamic subtest eDP-1: SKIP (0.000s) [286.416141] Subtest fbc-psr-cursor-blt: SKIP (0.001s) [286.502771] [035/134] (738s left) gem_sync (basic-store-each) [286.583167] Starting subtest: basic-store-each [288.980396] Subtest basic-store-each: SUCCESS (2.408s) [289.188032] [036/134] (735s left) prime_mmap (test_userptr) [289.239717] Starting subtest: test_userptr [289.242015] Starting dynamic subtest: test_userptr-smem [289.244162] Dynamic subtest test_userptr-smem: SUCCESS (0.000s) [289.246337] Subtest test_userptr: SUCCESS (0.001s) [289.382369] [037/134] (735s left) kms_pipe_crc_basic (nonblocking-crc) [289.479653] Starting subtest: nonblocking-crc [289.481934] Starting dynamic subtest: pipe-A-eDP-1 [290.250195] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.770s) [290.259725] Starting dynamic subtest: pipe-B-eDP-1 [291.703882] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.452s) [291.714612] Starting dynamic subtest: pipe-C-eDP-1 [293.056373] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.351s) [293.067151] Starting dynamic subtest: pipe-D-eDP-1 [294.381605] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.327s) [294.384071] Subtest nonblocking-crc: SUCCESS (4.906s) [295.227193] [038/134] (729s left) perf (unprivileged-single-ctx-counters) [295.365351] Starting subtest: unprivileged-single-ctx-counters [295.369863] Subtest unprivileged-single-ctx-counters: SKIP (0.000s) [295.410732] [039/134] (729s left) kms_psr2_sf (psr2-overlay-primary-update-sf-dmg-area) [300.457260] Starting subtest: psr2-overlay-primary-update-sf-dmg-area [300.459577] Starting dynamic subtest: pipe-A-eDP-1 [306.932467] Dynamic subtest pipe-A-eDP-1: SUCCESS (6.461s) [306.943174] Starting dynamic subtest: pipe-B-eDP-1 [313.513764] Dynamic subtest pipe-B-eDP-1: SUCCESS (6.567s) [313.516131] Subtest psr2-overlay-primary-update-sf-dmg-area: SUCCESS (13.034s) [314.416772] [040/134] (710s left) kms_psr2_sf (pr-overlay-plane-move-continuous-sf) [319.490942] Starting subtest: pr-overlay-plane-move-continuous-sf [319.495700] Subtest pr-overlay-plane-move-continuous-sf: SKIP (0.002s) [320.363800] [041/134] (704s left) kms_psr (fbc-psr-sprite-blt) [320.460424] Starting subtest: fbc-psr-sprite-blt [320.462595] Starting dynamic subtest: eDP-1 [320.466547] Dynamic subtest eDP-1: SKIP (0.000s) [320.470560] Subtest fbc-psr-sprite-blt: SKIP (0.001s) [320.559824] [042/134] (704s left) sysfs_timeslice_duration (invalid) [320.629715] Starting subtest: invalid [320.631963] Starting dynamic subtest: vecs0 [320.634198] Dynamic subtest vecs0: SUCCESS (0.000s) [320.644911] Starting dynamic subtest: ccs0 [320.646751] Dynamic subtest ccs0: SUCCESS (0.000s) [320.655727] Starting dynamic subtest: vcs0 [320.657629] Dynamic subtest vcs0: SUCCESS (0.000s) [320.666396] Starting dynamic subtest: bcs0 [320.668282] Dynamic subtest bcs0: SUCCESS (0.000s) [320.677009] Starting dynamic subtest: rcs0 [320.678871] Dynamic subtest rcs0: SUCCESS (0.000s) [320.687940] Starting dynamic subtest: vcs1 [320.689845] Dynamic subtest vcs1: SUCCESS (0.000s) [320.691749] Subtest invalid: SUCCESS (0.005s) [320.779293] [043/134] (704s left) gem_barrier_race (remote-request) [320.839609] Starting subtest: remote-request [320.841695] Starting dynamic subtest: rcs0 [325.985322] Dynamic subtest rcs0: SUCCESS (5.139s) [325.987235] Subtest remote-request: SUCCESS (5.140s) [326.142687] [044/134] (699s left) kms_big_fb (yf-tiled-addfb-size-overflow) [326.255494] Starting subtest: yf-tiled-addfb-size-overflow [326.259128] Subtest yf-tiled-addfb-size-overflow: SKIP (0.000s) [326.383594] [045/134] (699s left) vgem_basic (busy-fence) [326.424725] Starting subtest: busy-fence [326.426567] Subtest busy-fence: SUCCESS (0.000s) [326.507843] [046/134] (699s left) gem_mmap (bad-object) [326.554702] Subtest bad-object: SKIP (0.000s) [326.620704] [047/134] (698s left) kms_big_fb (x-tiled-64bpp-rotate-180) [326.715002] Starting subtest: x-tiled-64bpp-rotate-180 [328.297526] Subtest x-tiled-64bpp-rotate-180: SUCCESS (1.579s) [328.494991] [048/134] (697s left) syncobj_timeline (etime-multi-wait-submitted) [328.559475] Starting subtest: etime-multi-wait-submitted [328.659782] Subtest etime-multi-wait-submitted: SUCCESS (0.101s) [328.764012] [049/134] (696s left) gem_readwrite (read-write) [328.817005] Subtest read-write: SKIP (0.000s) [328.900936] [050/134] (696s left) kms_content_protection (mei-interface) [329.058422] Starting subtest: mei-interface [329.061744] Subtest mei-interface: SKIP (0.001s) [329.228183] [051/134] (696s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip) [329.333577] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip [330.003270] Subtest 4-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip: SUCCESS (0.670s) [330.204481] [052/134] (695s left) gem_mmap_gtt (isolation) [330.266629] Subtest isolation: SKIP (0.000s) [330.339840] [053/134] (695s left) kms_cursor_edge_walk (64x64-top-edge) [330.441660] Starting subtest: 64x64-top-edge [330.443931] Starting dynamic subtest: pipe-A-eDP-1 [333.935002] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.487s) [333.945552] Starting dynamic subtest: pipe-D-eDP-1 [337.055628] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.118s) [337.057938] Subtest 64x64-top-edge: SUCCESS (6.609s) [337.886367] [054/134] (688s left) syncobj_wait (wait-all-snapshot) [337.939249] Starting subtest: wait-all-snapshot [338.019578] Subtest wait-all-snapshot: SUCCESS (0.081s) [338.117799] [055/134] (687s left) kms_frontbuffer_tracking (fbcpsr-argb161616f-draw-mmap-cpu) [338.217238] Starting subtest: fbcpsr-argb161616f-draw-mmap-cpu [338.221449] Subtest fbcpsr-argb161616f-draw-mmap-cpu: SKIP (0.000s) [338.357905] [056/134] (687s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-gtt) [338.446632] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-gtt [338.451109] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s) [338.577329] [057/134] (687s left) gem_create (create-invalid-size) [338.638503] Starting subtest: create-invalid-size [338.640454] Subtest create-invalid-size: SUCCESS (0.000s) [338.854291] [058/134] (687s left) gem_render_copy (y-tiled-ccs-to-yf-tiled) [338.921822] Starting subtest: y-tiled-ccs-to-yf-tiled [338.926286] Subtest y-tiled-ccs-to-yf-tiled: SKIP (0.000s) [339.131936] [059/134] (686s left) kms_frontbuffer_tracking (psr-argb161616f-draw-mmap-wc) [339.230034] Starting subtest: psr-argb161616f-draw-mmap-wc [339.234036] Subtest psr-argb161616f-draw-mmap-wc: SKIP (0.000s) [339.355201] [060/134] (686s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-mmap-cpu) [339.445686] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-mmap-cpu [339.449687] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s) [339.575136] [061/134] (686s left) kms_joiner (switch-modeset-ultra-joiner-big-joiner) [339.681917] Starting subtest: switch-modeset-ultra-joiner-big-joiner [339.686184] Subtest switch-modeset-ultra-joiner-big-joiner: SKIP (0.000s) [339.770502] [062/134] (686s left) sw_sync (sync_merge_same) [339.803982] Starting subtest: sync_merge_same [339.806119] Subtest sync_merge_same: SUCCESS (0.000s) [339.882376] [063/134] (686s left) kms_plane_scaling (planes-downscale-factor-0-75-unity-scaling) [339.969914] Starting subtest: planes-downscale-factor-0-75-unity-scaling [339.972177] Starting dynamic subtest: pipe-A [340.033148] Dynamic subtest pipe-A: SUCCESS (0.065s) [340.047607] Starting dynamic subtest: pipe-B [341.181931] Dynamic subtest pipe-B: SUCCESS (1.145s) [341.193630] Starting dynamic subtest: pipe-C [342.305022] Dynamic subtest pipe-C: SUCCESS (1.121s) [342.319462] Starting dynamic subtest: pipe-D [343.435086] Dynamic subtest pipe-D: SUCCESS (1.127s) [343.437480] Subtest planes-downscale-factor-0-75-unity-scaling: SUCCESS (3.465s) [344.623167] [064/134] (681s left) syncobj_timeline (multi-wait-for-submit-available-unsubmitted-submitted-signa [344.684007] Starting subtest: multi-wait-for-submit-available-unsubmitted-submitted-signaled [344.686402] Subtest multi-wait-for-submit-available-unsubmitted-submitted-signaled: SUCCESS (0.000s) [344.806146] [065/134] (681s left) gem_render_copy (linear-to-vebox-yf-tiled) [344.864014] Starting subtest: linear-to-vebox-yf-tiled [344.868455] Subtest linear-to-vebox-yf-tiled: SKIP (0.000s) [345.071269] [066/134] (681s left) kms_flip (flip-vs-dpms-off-vs-modeset-interruptible) [345.173863] Starting subtest: flip-vs-dpms-off-vs-modeset-interruptible [345.176226] Starting dynamic subtest: A-eDP1 [348.719286] Dynamic subtest A-eDP1: SUCCESS (3.541s) [348.729550] Starting dynamic subtest: B-eDP1 [351.920141] Dynamic subtest B-eDP1: SUCCESS (3.195s) [351.931150] Starting dynamic subtest: C-eDP1 [355.033366] Dynamic subtest C-eDP1: SUCCESS (3.111s) [355.043321] Starting dynamic subtest: D-eDP1 [358.131573] Dynamic subtest D-eDP1: SUCCESS (3.098s) [358.133851] Subtest flip-vs-dpms-off-vs-modeset-interruptible: SUCCESS (12.954s) [358.957368] [067/134] (667s left) kms_chamelium_color (ctm-limited-range) [359.078041] Subtest ctm-limited-range: SKIP (0.000s) [359.122710] [068/134] (667s left) gem_mmap_wc (write) [359.190927] Subtest write: SKIP (0.000s) [359.258056] [069/134] (667s left) prime_mmap (test_correct) [359.315005] Starting subtest: test_correct [359.316832] Starting dynamic subtest: test_correct-smem [359.359109] Dynamic subtest test_correct-smem: SUCCESS (0.046s) [359.361575] Subtest test_correct: SUCCESS (0.047s) [359.505242] [070/134] (667s left) device_reset (cold-reset-bound) [359.557245] Starting subtest: cold-reset-bound [359.565457] Subtest cold-reset-bound: SKIP (0.000s) [359.651093] [071/134] (666s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-blt) [359.751311] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-blt [366.668052] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-blt: SUCCESS (6.917s) [366.843603] [072/134] (659s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-mmap-cpu) [366.939292] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-mmap-cpu [371.235298] Subtest fbc-1p-primscrn-pri-indfb-draw-mmap-cpu: SUCCESS (4.298s) [372.405425] [073/134] (654s left) kms_ccs (crc-primary-basic-y-tiled-gen12-rc-ccs) [372.504058] Starting subtest: crc-primary-basic-y-tiled-gen12-rc-ccs [372.506407] Starting dynamic subtest: pipe-A-eDP-1 [372.530470] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [372.542226] Starting dynamic subtest: pipe-B-eDP-1 [372.565548] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [372.584637] Starting dynamic subtest: pipe-C-eDP-1 [372.606962] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [372.626111] Starting dynamic subtest: pipe-D-eDP-1 [372.649848] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [372.654554] Subtest crc-primary-basic-y-tiled-gen12-rc-ccs: SKIP (0.006s) [374.759194] [074/134] (651s left) gem_exec_fence (syncobj-channel) [375.209974] Starting subtest: syncobj-channel [376.228645] Subtest syncobj-channel: SUCCESS (1.015s) [376.942641] [075/134] (649s left) gem_exec_reloc (basic-gtt-noreloc) [377.018516] Subtest basic-gtt-noreloc: SKIP (0.000s) [377.119216] [076/134] (649s left) kms_flip (dpms-off-confusion-interruptible) [377.221030] Starting subtest: dpms-off-confusion-interruptible [377.223210] Starting dynamic subtest: A-eDP1 [385.851958] Dynamic subtest A-eDP1: SUCCESS (8.629s) [385.866076] Starting dynamic subtest: B-eDP1 [394.485187] Dynamic subtest B-eDP1: SUCCESS (8.630s) [394.498505] Starting dynamic subtest: C-eDP1 [403.116422] Dynamic subtest C-eDP1: SUCCESS (8.629s) [403.130476] Starting dynamic subtest: D-eDP1 [411.747252] Dynamic subtest D-eDP1: SUCCESS (8.629s) [411.749448] Subtest dpms-off-confusion-interruptible: SUCCESS (34.529s) [412.946036] [077/134] (613s left) kms_vblank (wait-forked-busy) [413.055829] Starting subtest: wait-forked-busy [413.057680] Starting dynamic subtest: pipe-A-eDP-1 [414.931579] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.875s) [414.947054] Starting dynamic subtest: pipe-D-eDP-1 [417.470075] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.538s) [417.472496] Subtest wait-forked-busy: SUCCESS (4.416s) [418.298661] [078/134] (608s left) kms_chamelium_frames (dp-frame-dump) [418.685776] Subtest dp-frame-dump: SKIP (0.000s) [419.472240] [079/134] (607s left) kms_ccs (crc-sprite-planes-basic-y-tiled-gen12-mc-ccs) [419.566234] Starting subtest: crc-sprite-planes-basic-y-tiled-gen12-mc-ccs [419.568487] Starting dynamic subtest: pipe-A-eDP-1 [419.630205] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s) [419.642282] Starting dynamic subtest: pipe-B-eDP-1 [419.699834] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s) [419.711577] Starting dynamic subtest: pipe-C-eDP-1 [419.771111] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s) [419.782374] Starting dynamic subtest: pipe-D-eDP-1 [419.838538] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s) [419.842917] Subtest crc-sprite-planes-basic-y-tiled-gen12-mc-ccs: SKIP (0.009s) [421.795886] [080/134] (605s left) kms_frontbuffer_tracking (fbc-2p-primscrn-indfb-plflip-blt) [421.891878] Starting subtest: fbc-2p-primscrn-indfb-plflip-blt [421.896198] Subtest fbc-2p-primscrn-indfb-plflip-blt: SKIP (0.000s) [422.029111] [081/134] (604s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-180) [422.133999] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-180 [422.138529] Subtest y-tiled-max-hw-stride-64bpp-rotate-180: SKIP (0.000s) [422.250492] [082/134] (604s left) gen7_exec_parse (cmd-crossing-page) [422.306837] Subtest cmd-crossing-page: SKIP (0.000s) [422.375811] [083/134] (604s left) kms_atomic_transition (modeset-transition-nonblocking) [422.461868] Starting subtest: modeset-transition-nonblocking [422.464153] Starting dynamic subtest: 1x-outputs [433.296977] Dynamic subtest 1x-outputs: SUCCESS (10.835s) [433.299550] Subtest modeset-transition-nonblocking: SUCCESS (10.836s) [434.178529] [084/134] (592s left) kms_draw_crc (draw-method-mmap-cpu) [434.276602] Starting subtest: draw-method-mmap-cpu [434.278775] Starting dynamic subtest: xrgb8888-untiled [434.511833] Dynamic subtest xrgb8888-untiled: SUCCESS (0.236s) [434.521743] Starting dynamic subtest: rgb565-untiled [434.745140] Dynamic subtest rgb565-untiled: SUCCESS (0.233s) [434.756877] Starting dynamic subtest: xrgb2101010-untiled [434.967077] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.221s) [434.977301] Starting dynamic subtest: xbgr16161616f-untiled [435.200338] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.232s) [435.210246] Starting dynamic subtest: xrgb8888-xtiled [435.345003] Dynamic subtest xrgb8888-xtiled: SUCCESS (0.144s) [435.354805] Starting dynamic subtest: rgb565-xtiled [435.478339] Dynamic subtest rgb565-xtiled: SUCCESS (0.132s) [435.488209] Starting dynamic subtest: xrgb2101010-xtiled [435.600334] Dynamic subtest xrgb2101010-xtiled: SUCCESS (0.121s) [435.610993] Starting dynamic subtest: xbgr16161616f-xtiled [435.733900] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (0.132s) [435.743321] Starting dynamic subtest: xrgb8888-4tiled [435.878238] Dynamic subtest xrgb8888-4tiled: SUCCESS (0.144s) [435.887105] Starting dynamic subtest: rgb565-4tiled [436.023252] Dynamic subtest rgb565-4tiled: SUCCESS (0.143s) [436.035133] Starting dynamic subtest: xrgb2101010-4tiled [436.145434] Dynamic subtest xrgb2101010-4tiled: SUCCESS (0.122s) [436.158022] Starting dynamic subtest: xbgr16161616f-4tiled [436.279126] Dynamic subtest xbgr16161616f-4tiled: SUCCESS (0.131s) [436.281112] Subtest draw-method-mmap-cpu: SUCCESS (2.004s) [436.415929] [085/134] (590s left) kms_ccs (bad-rotation-90-4-tiled-mtl-rc-ccs-cc) [436.534552] Starting subtest: bad-rotation-90-4-tiled-mtl-rc-ccs-cc [436.536538] Starting dynamic subtest: pipe-A-eDP-1 [436.703673] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.162s) [436.713087] Starting dynamic subtest: pipe-B-eDP-1 [436.729403] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.010s) [436.738514] Starting dynamic subtest: pipe-C-eDP-1 [436.755631] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.011s) [436.764618] Starting dynamic subtest: pipe-D-eDP-1 [436.780514] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.010s) [436.782107] Subtest bad-rotation-90-4-tiled-mtl-rc-ccs-cc: SUCCESS (0.198s) [439.044260] [086/134] (588s left) gem_exec_schedule (u-semaphore-user) [439.123175] Starting subtest: u-semaphore-user [439.172616] Subtest u-semaphore-user: SUCCESS (0.057s) [440.905088] [087/134] (586s left) gem_exec_fence (basic-await) [441.086738] Starting subtest: basic-await [441.088674] Starting dynamic subtest: rcs0 [441.160181] Dynamic subtest rcs0: SUCCESS (0.076s) [441.173081] Starting dynamic subtest: bcs0 [441.233780] Dynamic subtest bcs0: SUCCESS (0.072s) [441.245475] Starting dynamic subtest: vcs0 [441.307321] Dynamic subtest vcs0: SUCCESS (0.072s) [441.319773] Starting dynamic subtest: vcs1 [441.380218] Dynamic subtest vcs1: SUCCESS (0.071s) [441.392746] Starting dynamic subtest: vecs0 [441.453364] Dynamic subtest vecs0: SUCCESS (0.071s) [441.466283] Starting dynamic subtest: ccs0 [441.526274] Dynamic subtest ccs0: SUCCESS (0.072s) [441.528653] Subtest basic-await: SUCCESS (0.442s) [442.907198] [088/134] (584s left) kms_rotation_crc (cursor-rotation-180) [443.001206] Starting subtest: cursor-rotation-180 [444.499225] Subtest cursor-rotation-180: SUCCESS (1.497s) [445.715982] [089/134] (581s left) kms_cursor_crc (cursor-onscreen-512x170) [446.019123] Starting subtest: cursor-onscreen-512x170 [446.023433] Subtest cursor-onscreen-512x170: SKIP (0.001s) [446.184421] [090/134] (581s left) kms_big_fb (linear-addfb) [446.286291] Starting subtest: linear-addfb [446.288581] Subtest linear-addfb: SUCCESS (0.000s) [446.414358] [091/134] (581s left) gem_exec_whisper (basic-queues) [446.488924] Starting subtest: basic-queues [453.053978] Subtest basic-queues: SUCCESS (6.563s) [453.264234] [092/134] (574s left) gem_exec_reloc (basic-scanout) [453.334702] Subtest basic-scanout: SKIP (0.000s) [453.436682] [093/134] (574s left) kms_plane_lowres (tiling-4) [453.562443] Starting subtest: tiling-4 [453.564671] Starting dynamic subtest: pipe-A-eDP-1 [453.569145] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [453.858188] Starting dynamic subtest: pipe-B-eDP-1 [453.862704] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [453.874859] Starting dynamic subtest: pipe-C-eDP-1 [453.879719] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [453.891353] Starting dynamic subtest: pipe-D-eDP-1 [453.895261] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [453.899126] Subtest tiling-4: SKIP (0.294s) [454.743355] [094/134] (572s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-onoff) [454.859851] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-onoff [461.972227] Subtest fbcpsr-1p-primscrn-spr-indfb-onoff: SUCCESS (7.113s) [462.168513] [095/134] (565s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-mmap-cpu) [462.275884] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-mmap-cpu [465.840446] Subtest fbc-1p-primscrn-spr-indfb-draw-mmap-cpu: SUCCESS (3.568s) [467.076168] [096/134] (560s left) gem_ctx_create (basic) [467.148987] Starting subtest: basic [467.151439] Subtest basic: SUCCESS (0.000s) [467.360023] [097/134] (560s left) kms_flip_scaled_crc (flip-64bpp-xtile-to-32bpp-xtile-downscaling) [467.459863] Starting subtest: flip-64bpp-xtile-to-32bpp-xtile-downscaling [467.462167] Starting dynamic subtest: pipe-A-default-mode [468.592010] Dynamic subtest pipe-A-default-mode: SKIP (1.130s) [468.596445] Subtest flip-64bpp-xtile-to-32bpp-xtile-downscaling: SKIP (1.132s) [468.784272] [098/134] (558s left) gem_pwrite (basic-exhaustion) [468.852727] Subtest basic-exhaustion: SKIP (0.000s) [468.928708] [099/134] (558s left) kms_atomic_transition (plane-all-transition-nonblocking) [469.036725] Starting subtest: plane-all-transition-nonblocking [469.039097] Starting dynamic subtest: pipe-A-eDP-1 [471.529988] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.494s) [471.852794] Starting dynamic subtest: pipe-B-eDP-1 [475.099770] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.255s) [475.396740] Subtest plane-all-transition-nonblocking: SUCCESS (6.360s) [476.247511] [100/134] (551s left) kms_color_pipeline (plane-lut1d-lut1d) [476.352425] Starting subtest: plane-lut1d-lut1d [476.366616] Starting dynamic subtest: pipe-A-eDP-1 [477.085281] Dynamic subtest pipe-A-eDP-1: FAIL (0.316s) [477.803401] Starting dynamic subtest: pipe-B-eDP-1 [478.596505] Dynamic subtest pipe-B-eDP-1: FAIL (0.280s) [479.136480] Starting dynamic subtest: pipe-C-eDP-1 [479.979634] Dynamic subtest pipe-C-eDP-1: FAIL (0.246s) [480.475220] Starting dynamic subtest: pipe-D-eDP-1 [481.343809] Dynamic subtest pipe-D-eDP-1: FAIL (0.290s) [481.345893] Subtest plane-lut1d-lut1d: FAIL (4.692s) [481.873057] [101/134] (546s left) gem_lmem_swapping (verify-random) [481.924089] Subtest verify-random: SKIP (0.000s) [481.969463] [102/134] (545s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-mmap-wc) [482.060365] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-mmap-wc [482.064414] Subtest psr-2p-primscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s) [482.170415] [103/134] (545s left) sw_sync (sync_random_merge) [482.207741] Starting subtest: sync_random_merge [482.242732] Subtest sync_random_merge: SUCCESS (0.038s) [482.329015] [104/134] (545s left) syncobj_timeline (invalid-signal-bad-pad) [482.396741] Starting subtest: invalid-signal-bad-pad [482.399150] Subtest invalid-signal-bad-pad: SUCCESS (0.000s) [482.530583] [105/134] (545s left) gem_mmap_gtt (basic) [482.589849] Subtest basic: SKIP (0.000s) [482.648866] [106/134] (545s left) gem_exec_balancer (invalid-balancer) [482.717537] Starting subtest: invalid-balancer [483.573011] Subtest invalid-balancer: SUCCESS (0.857s) [483.903495] [107/134] (544s left) kms_big_fb (y-tiled-8bpp-rotate-90) [484.009716] Starting subtest: y-tiled-8bpp-rotate-90 [484.014070] Subtest y-tiled-8bpp-rotate-90: SKIP (0.000s) [484.128421] [108/134] (544s left) gem_render_linear_blits (basic) [484.186197] Starting subtest: basic [484.208080] Subtest basic: SUCCESS (0.021s) [484.323190] [109/134] (543s left) gem_ctx_shared (q-promotion) [484.387236] Starting subtest: Q-promotion [484.389465] Starting dynamic subtest: rcs0 [484.497751] Dynamic subtest rcs0: SUCCESS (0.108s) [484.517077] Starting dynamic subtest: vcs0 [484.580280] Dynamic subtest vcs0: SUCCESS (0.083s) [484.596114] Starting dynamic subtest: vcs1 [484.657693] Dynamic subtest vcs1: SUCCESS (0.077s) [484.674834] Starting dynamic subtest: vecs0 [484.736353] Dynamic subtest vecs0: SUCCESS (0.077s) [484.753055] Starting dynamic subtest: ccs0 [484.826013] Dynamic subtest ccs0: SUCCESS (0.089s) [484.828605] Subtest Q-promotion: SUCCESS (0.439s) [485.967054] [110/134] (542s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-pwrite) [486.069465] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-pwrite [486.073896] Subtest fbc-2p-primscrn-pri-shrfb-draw-pwrite: SKIP (0.000s) [486.187455] [111/134] (542s left) syncobj_timeline (single-wait-for-submit-available-submitted) [486.251675] Starting subtest: single-wait-for-submit-available-submitted [486.254016] Subtest single-wait-for-submit-available-submitted: SUCCESS (0.000s) [486.378423] [112/134] (541s left) gem_flink_basic (bad-open) [486.443185] Starting subtest: bad-open [486.445365] Subtest bad-open: SUCCESS (0.000s) [486.581769] [113/134] (541s left) kms_ccs (crc-primary-rotation-180-4-tiled-mtl-rc-ccs-cc) [486.676455] Starting subtest: crc-primary-rotation-180-4-tiled-mtl-rc-ccs-cc [486.678634] Starting dynamic subtest: pipe-A-eDP-1 [487.480494] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.797s) [487.491914] Starting dynamic subtest: pipe-B-eDP-1 [488.958933] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.476s) [488.969333] Starting dynamic subtest: pipe-C-eDP-1 [490.503007] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.542s) [490.514583] Starting dynamic subtest: pipe-D-eDP-1 [492.013876] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.511s) [492.016285] Subtest crc-primary-rotation-180-4-tiled-mtl-rc-ccs-cc: SUCCESS (5.331s) [493.284859] [114/134] (535s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-mmap-wc) [493.382144] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-mmap-wc [493.386106] Subtest psr-2p-scndscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s) [493.503512] [115/134] (534s left) kms_hdr (bpc-switch-dpms) [493.592901] Starting subtest: bpc-switch-dpms [494.633382] Starting dynamic subtest: pipe-A-eDP-1 [499.057582] Dynamic subtest pipe-A-eDP-1: SUCCESS (4.425s) [499.059797] Subtest bpc-switch-dpms: SUCCESS (5.468s) [499.220598] [116/134] (529s left) kms_chamelium_hpd (hdmi-hpd) [499.614088] Subtest hdmi-hpd: SKIP (0.000s) [500.439107] [117/134] (528s left) kms_rotation_crc (primary-yf-tiled-reflect-x-270) [500.538297] Starting subtest: primary-yf-tiled-reflect-x-270 [500.542403] Subtest primary-yf-tiled-reflect-x-270: SKIP (0.001s) [500.638027] [118/134] (527s left) prime_vgem (basic-write) [500.706379] Starting subtest: basic-write [500.711060] Subtest basic-write: SKIP (0.006s) [500.836082] [119/134] (527s left) gem_ctx_freq (sysfs) [500.906807] Starting subtest: sysfs [500.909061] Starting dynamic subtest: gt0 [506.427830] Dynamic subtest gt0: SUCCESS (5.520s) [506.440018] Starting dynamic subtest: gt1 [547.783846] Dynamic subtest gt1: SUCCESS (41.354s) [547.786500] Subtest sysfs: SUCCESS (46.877s) [547.940028] [120/134] (480s left) kms_cursor_crc (cursor-onscreen-max-size) [548.268628] Starting subtest: cursor-onscreen-max-size [548.275329] Subtest cursor-onscreen-max-size: SKIP (0.000s) [548.446610] [121/134] (480s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-shrfb-draw-mmap-gtt) [548.558645] Starting subtest: fbc-1p-offscreen-pri-shrfb-draw-mmap-gtt [548.563344] Subtest fbc-1p-offscreen-pri-shrfb-draw-mmap-gtt: SKIP (0.000s) [548.690390] [122/134] (480s left) perf (per-context-mode-unprivileged) [548.782362] Starting subtest: per-context-mode-unprivileged [548.786860] Subtest per-context-mode-unprivileged: SKIP (0.000s) [548.832019] [123/134] (479s left) kms_setmode (basic) [548.881583] Starting subtest: basic [549.198209] Starting dynamic subtest: pipe-A-eDP-1 [551.259868] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.057s) [551.612211] Starting dynamic subtest: pipe-B-eDP-1 [553.692656] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.085s) [553.999109] Subtest basic: SUCCESS (5.115s) [554.862262] [124/134] (473s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip) [554.973178] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip [555.641707] Subtest x-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip: SUCCESS (0.670s) [555.883419] [125/134] (472s left) kms_atomic_transition (plane-use-after-nonblocking-unbind) [555.976744] Starting subtest: plane-use-after-nonblocking-unbind [555.978904] Starting dynamic subtest: pipe-A-eDP-1 [556.037254] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.062s) [556.345224] Starting dynamic subtest: pipe-B-eDP-1 [557.142999] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.808s) [557.438220] Subtest plane-use-after-nonblocking-unbind: SUCCESS (1.461s) [558.325225] [126/134] (470s left) kms_atomic_interruptible (universal-setplane-primary) [558.425211] Starting subtest: universal-setplane-primary [558.427301] Starting dynamic subtest: pipe-A-eDP-1 [565.818044] Dynamic subtest pipe-A-eDP-1: SUCCESS (7.391s) [565.820369] Subtest universal-setplane-primary: SUCCESS (7.394s) [566.720217] [127/134] (462s left) kms_pm_backlight (fade-with-dpms) [566.825098] Starting subtest: fade-with-dpms [569.285087] Starting dynamic subtest: eDP-1 [571.973438] Dynamic subtest eDP-1: SUCCESS (2.688s) [571.975768] Subtest fade-with-dpms: SUCCESS (5.149s) [572.796832] [128/134] (456s left) perf_pmu (event-wait) [572.836005] Starting subtest: event-wait [572.838427] Starting dynamic subtest: rcs0 [572.843009] Dynamic subtest rcs0: SKIP (0.000s) [572.847569] Subtest event-wait: SKIP (0.001s) [572.981777] [129/134] (456s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-mmap-gtt) [573.101001] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-mmap-gtt [573.105299] Subtest fbc-2p-scndscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s) [573.235086] [130/134] (455s left) gem_exec_whisper (basic-contexts-all) [573.308327] Starting subtest: basic-contexts-all [582.011645] Subtest basic-contexts-all: SUCCESS (8.700s) [582.218811] [131/134] (446s left) gem_spin_batch (spin-each) [582.298868] Starting subtest: spin-each [585.663350] Subtest spin-each: SUCCESS (3.366s) [585.936187] [132/134] (443s left) kms_universal_plane (disable-primary-vs-flip) [586.048252] Starting subtest: disable-primary-vs-flip [586.050462] Starting dynamic subtest: pipe-A-eDP-1 [587.546562] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.497s) [587.558047] Starting dynamic subtest: pipe-B-eDP-1 [589.789462] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.244s) [589.800627] Starting dynamic subtest: pipe-C-eDP-1 [591.934205] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.144s) [591.945464] Starting dynamic subtest: pipe-D-eDP-1 [594.115432] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.179s) [594.117748] Subtest disable-primary-vs-flip: SUCCESS (8.069s) [594.954530] [133/134] (434s left) gem_exec_schedule (preemptive-hang) [595.144220] Starting subtest: preemptive-hang [595.147056] Starting dynamic subtest: rcs0 [603.960850] Dynamic subtest rcs0: SUCCESS (8.816s) [603.979028] Starting dynamic subtest: bcs0 [612.917203] Dynamic subtest bcs0: SUCCESS (8.956s) [612.929819] Starting dynamic subtest: vcs0 [621.936776] Dynamic subtest vcs0: SUCCESS (9.018s) [621.946748] Starting dynamic subtest: vcs1 [630.896606] Dynamic subtest vcs1: SUCCESS (8.958s) [630.909401] Starting dynamic subtest: vecs0 [639.918457] Dynamic subtest vecs0: SUCCESS (9.022s) [639.928437] Starting dynamic subtest: ccs0 [648.949418] Dynamic subtest ccs0: SUCCESS (9.030s) [648.951799] Subtest preemptive-hang: SUCCESS (53.810s) [649.235463] [134/134] (380s left) syncobj_wait (invalid-signal-bad-pad) [649.300780] Starting subtest: invalid-signal-bad-pad [649.303231] Subtest invalid-signal-bad-pad: SUCCESS (0.000s) [649.434061] 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.