[57.293263] Initializing watchdogs [57.293306] /dev/watchdog0 [57.306848] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:7d55 Intel Meteorlake (Gen12) Meteor Lake-P [Intel Arc Graphics] [57.311041] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [57.313332] [FACT before any test] new: kernel.kmod_is_loaded.i915: true [57.316883] [001/134] (960s left) kms_addfb_basic (addfb25-y-tiled-small-legacy) [57.448467] Starting subtest: addfb25-y-tiled-small-legacy [57.453054] Subtest addfb25-y-tiled-small-legacy: SKIP (0.000s) [57.570480] [002/134] (960s left) kms_plane_scaling (plane-downscale-factor-0-75-with-modifiers) [57.673853] Starting subtest: plane-downscale-factor-0-75-with-modifiers [57.676329] Starting dynamic subtest: pipe-A [58.049789] Dynamic subtest pipe-A: SUCCESS (0.377s) [58.058785] Starting dynamic subtest: pipe-B [59.547216] Dynamic subtest pipe-B: SUCCESS (1.494s) [59.554021] Starting dynamic subtest: pipe-C [60.963817] Dynamic subtest pipe-C: SUCCESS (1.414s) [60.972831] Starting dynamic subtest: pipe-D [62.390700] Dynamic subtest pipe-D: SUCCESS (1.425s) [62.393073] Subtest plane-downscale-factor-0-75-with-modifiers: SUCCESS (4.712s) [63.584981] [003/134] (954s left) i915_drm_fdinfo (virtual-idle) [63.627632] Starting subtest: virtual-idle [66.720045] Subtest virtual-idle: SUCCESS (3.088s) [66.824657] [004/134] (951s left) gem_userptr_blits (huge-split) [66.899674] Starting subtest: huge-split [66.914425] Subtest huge-split: SUCCESS (0.015s) [67.377726] [005/134] (950s left) kms_psr (fbc-pr-no-drrs) [67.565776] Starting subtest: fbc-pr-no-drrs [67.570306] Subtest fbc-pr-no-drrs: SKIP (0.000s) [67.754766] [006/134] (950s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-mmap-cpu) [67.889755] Starting subtest: psr-1p-primscrn-pri-indfb-draw-mmap-cpu [74.833686] Subtest psr-1p-primscrn-pri-indfb-draw-mmap-cpu: SUCCESS (6.945s) [74.958895] [007/134] (943s left) kms_cursor_legacy (cursora-vs-flipa-legacy) [75.085676] Starting subtest: cursorA-vs-flipA-legacy [86.241931] Subtest cursorA-vs-flipA-legacy: SUCCESS (11.154s) [87.061007] [008/134] (931s left) kms_psr (psr2-primary-page-flip) [87.159208] Starting subtest: psr2-primary-page-flip [87.161576] Starting dynamic subtest: eDP-1 [88.922386] Dynamic subtest eDP-1: SUCCESS (1.763s) [88.924390] Subtest psr2-primary-page-flip: SUCCESS (1.763s) [89.818361] [009/134] (928s left) i915_pm_rc6_residency (rc6-accuracy) [89.876962] Starting subtest: rc6-accuracy [89.879172] Starting dynamic subtest: gt0 [93.047525] Dynamic subtest gt0: SUCCESS (3.168s) [93.057383] Starting dynamic subtest: gt1 [96.217713] Dynamic subtest gt1: SUCCESS (3.168s) [96.220147] Subtest rc6-accuracy: SUCCESS (6.339s) [96.313886] [010/134] (921s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-blt) [96.429658] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-blt [103.645141] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-blt: SUCCESS (7.219s) [103.824463] [011/134] (914s left) kms_feature_discovery (psr2) [103.917589] Starting subtest: psr2 [103.919816] Subtest psr2: SUCCESS (0.000s) [104.013104] [012/134] (914s left) syncobj_wait (single-wait-all-for-submit-submitted) [104.079093] Starting subtest: single-wait-all-for-submit-submitted [104.185779] Subtest single-wait-all-for-submit-submitted: SUCCESS (0.106s) [104.277713] [013/134] (914s left) kms_flip (2x-wf_vblank-ts-check-interruptible) [104.390114] Starting subtest: 2x-wf_vblank-ts-check-interruptible [104.400123] Subtest 2x-wf_vblank-ts-check-interruptible: SKIP (0.011s) [104.544715] [014/134] (913s left) kms_psr_stress_test (flip-primary-invalidate-overlay) [104.644567] Starting subtest: flip-primary-invalidate-overlay [116.254937] Subtest flip-primary-invalidate-overlay: SUCCESS (11.613s) [116.460771] [015/134] (901s left) i915_drm_fdinfo (busy-idle) [116.495631] Starting subtest: busy-idle [116.497652] Starting dynamic subtest: rcs0 [116.518217] Dynamic subtest rcs0: SKIP (0.021s) [116.526882] Starting dynamic subtest: bcs0 [116.542030] Dynamic subtest bcs0: SKIP (0.024s) [116.549225] Starting dynamic subtest: vcs0 [116.552897] Dynamic subtest vcs0: SKIP (0.002s) [116.559728] Starting dynamic subtest: vcs1 [116.563546] Dynamic subtest vcs1: SKIP (0.001s) [116.571277] Starting dynamic subtest: vecs0 [116.575251] Dynamic subtest vecs0: SKIP (0.001s) [116.587220] Starting dynamic subtest: ccs0 [116.592513] Dynamic subtest ccs0: SKIP (0.001s) [116.595778] Subtest busy-idle: SKIP (0.054s) [116.648782] [016/134] (901s left) gem_exec_params (invalid-bsd2-flag-on-vebox) [116.706340] Starting subtest: invalid-bsd2-flag-on-vebox [116.708448] Subtest invalid-bsd2-flag-on-vebox: SUCCESS (0.000s) [116.828664] [017/134] (901s left) syncobj_wait (single-wait-all-for-submit-signaled) [116.885817] Starting subtest: single-wait-all-for-submit-signaled [116.887860] Subtest single-wait-all-for-submit-signaled: SUCCESS (0.000s) [117.018066] [018/134] (901s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-blt) [117.124763] Starting subtest: fbcpsr-rgb101010-draw-blt [123.901208] Subtest fbcpsr-rgb101010-draw-blt: SUCCESS (6.777s) [124.072147] [019/134] (894s left) kms_pm_rpm (modeset-lpsp) [126.110507] Starting subtest: modeset-lpsp [127.566677] Subtest modeset-lpsp: SUCCESS (1.458s) [127.687104] [020/134] (890s left) i915_suspend (sysfs-reader) [127.742199] Starting subtest: sysfs-reader [146.054132] Subtest sysfs-reader: SUCCESS (3.259s) [146.145959] [021/134] (872s left) prime_vgem (sync) [146.287615] Starting subtest: sync [146.289321] Starting dynamic subtest: rcs0 [146.351481] Dynamic subtest rcs0: SUCCESS (0.065s) [146.359984] Starting dynamic subtest: bcs0 [146.405925] Dynamic subtest bcs0: SUCCESS (0.053s) [146.414034] Starting dynamic subtest: vcs0 [146.454992] Dynamic subtest vcs0: SUCCESS (0.048s) [146.463134] Starting dynamic subtest: vcs1 [146.497201] Dynamic subtest vcs1: SUCCESS (0.041s) [146.505696] Starting dynamic subtest: vecs0 [146.544067] Dynamic subtest vecs0: SUCCESS (0.046s) [146.555861] Starting dynamic subtest: ccs0 [146.587618] Dynamic subtest ccs0: SUCCESS (0.043s) [146.589725] Subtest sync: SUCCESS (0.300s) [146.758204] [FACT prime_vgem (sync)] new: kernel.kmod_is_loaded.vgem: true [146.761383] [022/134] (871s left) api_intel_allocator (two-level-inception) [146.823300] Starting subtest: two-level-inception [152.253249] Subtest two-level-inception: SUCCESS (5.400s) [152.378868] [023/134] (866s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-move) [152.487761] Starting subtest: psr-2p-primscrn-cur-indfb-move [152.491876] Subtest psr-2p-primscrn-cur-indfb-move: SKIP (0.000s) [152.635258] [024/134] (866s left) sriov_basic (bind-unbind-vf) [152.694294] Starting subtest: bind-unbind-vf [152.696865] Starting dynamic subtest: vf-1 [152.778462] Dynamic subtest vf-1: FAIL (0.031s) [152.788775] Starting dynamic subtest: vf-2 [152.862594] Dynamic subtest vf-2: FAIL (0.004s) [152.873721] Starting dynamic subtest: vf-3 [152.947312] Dynamic subtest vf-3: FAIL (0.004s) [152.957305] Starting dynamic subtest: vf-4 [153.029935] Dynamic subtest vf-4: FAIL (0.004s) [153.040411] Starting dynamic subtest: vf-5 [153.115905] Dynamic subtest vf-5: FAIL (0.004s) [153.126417] Starting dynamic subtest: vf-6 [153.200470] Dynamic subtest vf-6: FAIL (0.003s) [153.210898] Starting dynamic subtest: vf-7 [153.283217] Dynamic subtest vf-7: FAIL (0.004s) [153.292567] Starting dynamic subtest: vf-random [153.352489] Dynamic subtest vf-random: FAIL (0.004s) [153.363064] Starting dynamic subtest: vf-last [153.423732] Dynamic subtest vf-last: FAIL (0.517s) [153.425446] Subtest bind-unbind-vf: FAIL (0.579s) [153.467856] [025/134] (865s left) gem_eio (hibernate) [153.701675] Starting subtest: hibernate [168.328813] Subtest hibernate: SUCCESS (14.599s) [175.485119] [026/134] (850s left) kms_vrr (seamless-rr-switch-virtual) [175.608069] Starting subtest: seamless-rr-switch-virtual [175.615914] Subtest seamless-rr-switch-virtual: SKIP (0.000s) [175.702665] [027/134] (850s left) api_intel_bb (render) [175.758135] Starting subtest: render [175.760452] Starting dynamic subtest: render-none-512 [175.874610] Dynamic subtest render-none-512: SUCCESS (0.115s) [175.886060] Starting dynamic subtest: render-none-1024 [176.242491] Dynamic subtest render-none-1024: SUCCESS (0.367s) [176.254807] Starting dynamic subtest: render-x-512 [176.325683] Dynamic subtest render-x-512: SUCCESS (0.084s) [176.337276] Starting dynamic subtest: render-x-1024 [176.668931] Dynamic subtest render-x-1024: SUCCESS (0.329s) [176.679725] Starting dynamic subtest: render-y-512 [176.739739] Dynamic subtest render-y-512: SUCCESS (0.084s) [176.749967] Starting dynamic subtest: render-y-1024 [177.188308] Dynamic subtest render-y-1024: SUCCESS (0.447s) [177.191131] Subtest render: SUCCESS (1.429s) [177.344975] [028/134] (848s left) kms_cursor_legacy (torture-bo) [177.473704] Starting subtest: torture-bo [177.475975] Starting dynamic subtest: pipe-A [183.668722] Dynamic subtest pipe-A: SUCCESS (6.189s) [183.681373] Starting dynamic subtest: pipe-B [190.082950] Dynamic subtest pipe-B: SUCCESS (6.409s) [190.095429] Starting dynamic subtest: pipe-C [196.940448] Dynamic subtest pipe-C: SUCCESS (6.853s) [196.957622] Starting dynamic subtest: pipe-D [204.347189] Dynamic subtest pipe-D: SUCCESS (7.401s) [204.363061] Starting dynamic subtest: all-pipes [210.894576] Dynamic subtest all-pipes: SUCCESS (6.546s) [210.896918] Subtest torture-bo: SUCCESS (33.405s) [211.078387] [029/134] (814s left) kms_rotation_crc (sprite-rotation-270) [211.188231] Starting subtest: sprite-rotation-270 [211.192585] Subtest sprite-rotation-270: SKIP (0.001s) [211.285018] [030/134] (814s left) kms_prime (basic-modeset-hybrid) [211.361138] Subtest basic-modeset-hybrid: SKIP (0.000s) [211.466767] [031/134] (814s left) gem_ctx_persistence (many-contexts) [211.531101] Starting subtest: many-contexts [249.239127] Subtest many-contexts: SUCCESS (37.702s) [249.344667] [032/134] (776s left) gem_create (busy-create) [249.410263] Starting subtest: busy-create [249.412714] Starting dynamic subtest: smem0 [282.991527] Dynamic subtest smem0: SUCCESS (33.569s) [282.994112] Subtest busy-create: SUCCESS (33.571s) [283.211392] [033/134] (742s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-mmap-gtt) [283.327314] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-mmap-gtt [283.331733] Subtest psr-2p-scndscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s) [283.465290] [034/134] (742s left) kms_psr (fbc-psr-cursor-blt) [283.559799] Starting subtest: fbc-psr-cursor-blt [283.562099] Starting dynamic subtest: eDP-1 [283.566276] Dynamic subtest eDP-1: SKIP (0.000s) [283.570423] Subtest fbc-psr-cursor-blt: SKIP (0.001s) [283.662424] [035/134] (742s left) gem_sync (basic-store-each) [283.735582] Starting subtest: basic-store-each [286.073389] Subtest basic-store-each: SUCCESS (2.347s) [286.281544] [036/134] (740s left) prime_mmap (test_userptr) [286.344912] Starting subtest: test_userptr [286.347553] Starting dynamic subtest: test_userptr-smem [286.349786] Dynamic subtest test_userptr-smem: SUCCESS (0.000s) [286.352013] Subtest test_userptr: SUCCESS (0.001s) [286.484944] [037/134] (739s left) kms_pipe_crc_basic (nonblocking-crc) [286.583713] Starting subtest: nonblocking-crc [286.585680] Starting dynamic subtest: pipe-A-eDP-1 [287.334986] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.750s) [287.345930] Starting dynamic subtest: pipe-B-eDP-1 [288.723893] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.386s) [288.735049] Starting dynamic subtest: pipe-C-eDP-1 [290.117706] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.395s) [290.128895] Starting dynamic subtest: pipe-D-eDP-1 [291.461059] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.340s) [291.463759] Subtest nonblocking-crc: SUCCESS (4.876s) [292.296758] [038/134] (734s left) perf (unprivileged-single-ctx-counters) [292.435302] Starting subtest: unprivileged-single-ctx-counters [292.439501] Subtest unprivileged-single-ctx-counters: SKIP (0.000s) [292.483564] [039/134] (733s left) kms_psr2_sf (psr2-overlay-primary-update-sf-dmg-area) [297.465407] Starting subtest: psr2-overlay-primary-update-sf-dmg-area [297.467859] Starting dynamic subtest: pipe-A-eDP-1 [304.016440] Dynamic subtest pipe-A-eDP-1: SUCCESS (6.547s) [304.026929] Starting dynamic subtest: pipe-B-eDP-1 [310.588607] Dynamic subtest pipe-B-eDP-1: SUCCESS (6.568s) [310.591253] Subtest psr2-overlay-primary-update-sf-dmg-area: SUCCESS (13.119s) [311.502573] [040/134] (714s left) kms_psr2_sf (pr-overlay-plane-move-continuous-sf) [316.563060] Starting subtest: pr-overlay-plane-move-continuous-sf [316.567821] Subtest pr-overlay-plane-move-continuous-sf: SKIP (0.003s) [317.425585] [041/134] (709s left) kms_psr (fbc-psr-sprite-blt) [317.529012] Starting subtest: fbc-psr-sprite-blt [317.531142] Starting dynamic subtest: eDP-1 [317.535043] Dynamic subtest eDP-1: SKIP (0.000s) [317.538963] Subtest fbc-psr-sprite-blt: SKIP (0.001s) [317.627354] [042/134] (708s left) sysfs_timeslice_duration (invalid) [317.694015] Starting subtest: invalid [317.696222] Starting dynamic subtest: vecs0 [317.698482] Dynamic subtest vecs0: SUCCESS (0.000s) [317.708340] Starting dynamic subtest: ccs0 [317.710152] Dynamic subtest ccs0: SUCCESS (0.000s) [317.718739] Starting dynamic subtest: vcs0 [317.720580] Dynamic subtest vcs0: SUCCESS (0.000s) [317.729120] Starting dynamic subtest: bcs0 [317.730914] Dynamic subtest bcs0: SUCCESS (0.000s) [317.739452] Starting dynamic subtest: rcs0 [317.741225] Dynamic subtest rcs0: SUCCESS (0.000s) [317.750176] Starting dynamic subtest: vcs1 [317.752263] Dynamic subtest vcs1: SUCCESS (0.000s) [317.754340] Subtest invalid: SUCCESS (0.005s) [317.833426] [043/134] (708s left) gem_barrier_race (remote-request) [317.889716] Starting subtest: remote-request [317.891839] Starting dynamic subtest: rcs0 [323.053250] Dynamic subtest rcs0: SUCCESS (5.163s) [323.056503] Subtest remote-request: SUCCESS (5.164s) [323.200972] [044/134] (703s left) kms_big_fb (yf-tiled-addfb-size-overflow) [323.312152] Starting subtest: yf-tiled-addfb-size-overflow [323.315868] Subtest yf-tiled-addfb-size-overflow: SKIP (0.000s) [323.426121] [045/134] (703s left) vgem_basic (busy-fence) [323.470112] Starting subtest: busy-fence [323.471741] Subtest busy-fence: SUCCESS (0.000s) [323.547041] [046/134] (703s left) gem_mmap (bad-object) [323.604558] Subtest bad-object: SKIP (0.000s) [323.665415] [047/134] (703s left) kms_big_fb (x-tiled-64bpp-rotate-180) [323.760156] Starting subtest: x-tiled-64bpp-rotate-180 [325.451912] Subtest x-tiled-64bpp-rotate-180: SUCCESS (1.690s) [325.631473] [048/134] (701s left) syncobj_timeline (etime-multi-wait-submitted) [325.684216] Starting subtest: etime-multi-wait-submitted [325.789665] Subtest etime-multi-wait-submitted: SUCCESS (0.104s) [325.889611] [049/134] (700s left) gem_readwrite (read-write) [325.940123] Subtest read-write: SKIP (0.000s) [326.021800] [050/134] (700s left) kms_content_protection (mei-interface) [326.165888] Starting subtest: mei-interface [326.170230] Subtest mei-interface: SKIP (0.001s) [326.331029] [051/134] (700s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip) [326.426951] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip [327.095698] Subtest 4-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip: SUCCESS (0.670s) [327.306878] [052/134] (699s left) gem_mmap_gtt (isolation) [327.361778] Subtest isolation: SKIP (0.000s) [327.417653] [053/134] (699s left) kms_cursor_edge_walk (64x64-top-edge) [327.503894] Starting subtest: 64x64-top-edge [327.506107] Starting dynamic subtest: pipe-A-eDP-1 [330.964760] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.461s) [330.974660] Starting dynamic subtest: pipe-D-eDP-1 [334.087139] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.119s) [334.089623] Subtest 64x64-top-edge: SUCCESS (6.583s) [334.921488] [054/134] (692s left) syncobj_wait (wait-all-snapshot) [334.986403] Starting subtest: wait-all-snapshot [335.066792] Subtest wait-all-snapshot: SUCCESS (0.081s) [335.166386] [055/134] (691s left) kms_frontbuffer_tracking (fbcpsr-argb161616f-draw-mmap-cpu) [335.262882] Starting subtest: fbcpsr-argb161616f-draw-mmap-cpu [335.266838] Subtest fbcpsr-argb161616f-draw-mmap-cpu: SKIP (0.000s) [335.387419] [056/134] (691s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-gtt) [335.481472] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-gtt [335.485414] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s) [335.618444] [057/134] (691s left) gem_create (create-invalid-size) [335.684394] Starting subtest: create-invalid-size [335.686325] Subtest create-invalid-size: SUCCESS (0.000s) [335.893703] [058/134] (691s left) gem_render_copy (y-tiled-ccs-to-yf-tiled) [335.951371] Starting subtest: y-tiled-ccs-to-yf-tiled [335.955986] Subtest y-tiled-ccs-to-yf-tiled: SKIP (0.000s) [336.161636] [059/134] (691s left) kms_frontbuffer_tracking (psr-argb161616f-draw-mmap-wc) [336.261153] Starting subtest: psr-argb161616f-draw-mmap-wc [336.265732] Subtest psr-argb161616f-draw-mmap-wc: SKIP (0.000s) [336.386808] [060/134] (690s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-mmap-cpu) [336.488692] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-mmap-cpu [336.493145] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s) [336.639344] [061/134] (690s left) kms_joiner (switch-modeset-ultra-joiner-big-joiner) [336.744356] Starting subtest: switch-modeset-ultra-joiner-big-joiner [336.748706] Subtest switch-modeset-ultra-joiner-big-joiner: SKIP (0.000s) [336.831983] [062/134] (690s left) sw_sync (sync_merge_same) [336.871594] Starting subtest: sync_merge_same [336.873561] Subtest sync_merge_same: SUCCESS (0.000s) [336.945314] [063/134] (690s left) kms_plane_scaling (planes-downscale-factor-0-75-unity-scaling) [337.036683] Starting subtest: planes-downscale-factor-0-75-unity-scaling [337.038905] Starting dynamic subtest: pipe-A [337.099443] Dynamic subtest pipe-A: SUCCESS (0.065s) [337.113900] Starting dynamic subtest: pipe-B [338.225719] Dynamic subtest pipe-B: SUCCESS (1.124s) [338.237323] Starting dynamic subtest: pipe-C [339.333317] Dynamic subtest pipe-C: SUCCESS (1.106s) [339.343253] Starting dynamic subtest: pipe-D [340.473625] Dynamic subtest pipe-D: SUCCESS (1.139s) [340.476121] Subtest planes-downscale-factor-0-75-unity-scaling: SUCCESS (3.438s) [341.659936] [064/134] (685s left) syncobj_timeline (multi-wait-for-submit-available-unsubmitted-submitted-signa [341.726711] Starting subtest: multi-wait-for-submit-available-unsubmitted-submitted-signaled [341.728907] Subtest multi-wait-for-submit-available-unsubmitted-submitted-signaled: SUCCESS (0.000s) [341.851866] [065/134] (685s left) gem_render_copy (linear-to-vebox-yf-tiled) [341.906135] Starting subtest: linear-to-vebox-yf-tiled [341.910596] Subtest linear-to-vebox-yf-tiled: SKIP (0.000s) [342.130290] [066/134] (685s left) kms_flip (flip-vs-dpms-off-vs-modeset-interruptible) [342.235947] Starting subtest: flip-vs-dpms-off-vs-modeset-interruptible [342.238295] Starting dynamic subtest: A-eDP1 [345.877464] Dynamic subtest A-eDP1: SUCCESS (3.637s) [345.887827] Starting dynamic subtest: B-eDP1 [349.067576] Dynamic subtest B-eDP1: SUCCESS (3.189s) [349.077434] Starting dynamic subtest: C-eDP1 [352.168196] Dynamic subtest C-eDP1: SUCCESS (3.098s) [352.183935] Starting dynamic subtest: D-eDP1 [355.298989] Dynamic subtest D-eDP1: SUCCESS (3.126s) [355.301026] Subtest flip-vs-dpms-off-vs-modeset-interruptible: SUCCESS (13.057s) [356.106889] [067/134] (671s left) kms_chamelium_color (ctm-limited-range) [356.213176] Subtest ctm-limited-range: SKIP (0.000s) [356.257495] [068/134] (671s left) gem_mmap_wc (write) [356.315802] Subtest write: SKIP (0.000s) [356.385094] [069/134] (671s left) prime_mmap (test_correct) [356.449047] Starting subtest: test_correct [356.450913] Starting dynamic subtest: test_correct-smem [356.500789] Dynamic subtest test_correct-smem: SUCCESS (0.052s) [356.503337] Subtest test_correct: SUCCESS (0.053s) [356.648747] [070/134] (671s left) device_reset (cold-reset-bound) [356.700439] Starting subtest: cold-reset-bound [356.705050] Subtest cold-reset-bound: SKIP (0.000s) [356.800645] [071/134] (671s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-blt) [356.902880] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-blt [363.844654] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-blt: SUCCESS (6.941s) [364.049181] [072/134] (663s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-mmap-cpu) [364.155667] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-mmap-cpu [368.389499] Subtest fbc-1p-primscrn-pri-indfb-draw-mmap-cpu: SUCCESS (4.236s) [369.549682] [073/134] (658s left) kms_ccs (crc-primary-basic-y-tiled-gen12-rc-ccs) [369.641446] Starting subtest: crc-primary-basic-y-tiled-gen12-rc-ccs [369.643744] Starting dynamic subtest: pipe-A-eDP-1 [369.666732] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s) [369.682948] Starting dynamic subtest: pipe-B-eDP-1 [369.704832] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s) [369.714245] Starting dynamic subtest: pipe-C-eDP-1 [369.737254] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s) [369.748584] Starting dynamic subtest: pipe-D-eDP-1 [369.770245] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s) [369.774274] Subtest crc-primary-basic-y-tiled-gen12-rc-ccs: SKIP (0.010s) [371.917044] [074/134] (656s left) gem_exec_fence (syncobj-channel) [372.342276] Starting subtest: syncobj-channel [373.359001] Subtest syncobj-channel: SUCCESS (1.014s) [374.113424] [075/134] (653s left) gem_exec_reloc (basic-gtt-noreloc) [374.185151] Subtest basic-gtt-noreloc: SKIP (0.000s) [374.288573] [076/134] (653s left) kms_flip (dpms-off-confusion-interruptible) [374.386481] Starting subtest: dpms-off-confusion-interruptible [374.388828] Starting dynamic subtest: A-eDP1 [383.086673] Dynamic subtest A-eDP1: SUCCESS (8.695s) [383.106261] Starting dynamic subtest: B-eDP1 [391.729119] Dynamic subtest B-eDP1: SUCCESS (8.636s) [391.743732] Starting dynamic subtest: C-eDP1 [400.351973] Dynamic subtest C-eDP1: SUCCESS (8.616s) [400.361888] Starting dynamic subtest: D-eDP1 [408.997643] Dynamic subtest D-eDP1: SUCCESS (8.640s) [409.003552] Subtest dpms-off-confusion-interruptible: SUCCESS (34.601s) [410.196035] [077/134] (617s left) kms_vblank (wait-forked-busy) [410.292847] Starting subtest: wait-forked-busy [410.295161] Starting dynamic subtest: pipe-A-eDP-1 [412.165585] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.873s) [412.180900] Starting dynamic subtest: pipe-D-eDP-1 [414.728735] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.557s) [414.730638] Subtest wait-forked-busy: SUCCESS (4.435s) [415.552027] [078/134] (612s left) kms_chamelium_frames (dp-frame-dump) [415.942498] Subtest dp-frame-dump: SKIP (0.000s) [416.744022] [079/134] (611s left) kms_ccs (crc-sprite-planes-basic-y-tiled-gen12-mc-ccs) [416.842455] Starting subtest: crc-sprite-planes-basic-y-tiled-gen12-mc-ccs [416.844828] Starting dynamic subtest: pipe-A-eDP-1 [416.902165] Dynamic subtest pipe-A-eDP-1: SKIP (0.002s) [416.911655] Starting dynamic subtest: pipe-B-eDP-1 [416.968143] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s) [416.979256] Starting dynamic subtest: pipe-C-eDP-1 [417.035147] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s) [417.045349] Starting dynamic subtest: pipe-D-eDP-1 [417.103510] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s) [417.107725] Subtest crc-sprite-planes-basic-y-tiled-gen12-mc-ccs: SKIP (0.010s) [419.052431] [080/134] (609s left) kms_frontbuffer_tracking (fbc-2p-primscrn-indfb-plflip-blt) [419.164080] Starting subtest: fbc-2p-primscrn-indfb-plflip-blt [419.168341] Subtest fbc-2p-primscrn-indfb-plflip-blt: SKIP (0.000s) [419.298699] [081/134] (608s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-180) [419.406780] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-180 [419.411257] Subtest y-tiled-max-hw-stride-64bpp-rotate-180: SKIP (0.000s) [419.522007] [082/134] (608s left) gen7_exec_parse (cmd-crossing-page) [419.575625] Subtest cmd-crossing-page: SKIP (0.000s) [419.664125] [083/134] (608s left) kms_atomic_transition (modeset-transition-nonblocking) [419.769420] Starting subtest: modeset-transition-nonblocking [419.771358] Starting dynamic subtest: 1x-outputs [430.563905] Dynamic subtest 1x-outputs: SUCCESS (10.791s) [430.566396] Subtest modeset-transition-nonblocking: SUCCESS (10.792s) [431.441559] [084/134] (596s left) kms_draw_crc (draw-method-mmap-cpu) [431.544290] Starting subtest: draw-method-mmap-cpu [431.546547] Starting dynamic subtest: xrgb8888-untiled [431.764648] Dynamic subtest xrgb8888-untiled: SUCCESS (0.222s) [431.774967] Starting dynamic subtest: rgb565-untiled [431.998072] Dynamic subtest rgb565-untiled: SUCCESS (0.231s) [432.008415] Starting dynamic subtest: xrgb2101010-untiled [432.220393] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.220s) [432.230694] Starting dynamic subtest: xbgr16161616f-untiled [432.431348] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.210s) [432.441385] Starting dynamic subtest: xrgb8888-xtiled [432.553332] Dynamic subtest xrgb8888-xtiled: SUCCESS (0.121s) [432.563164] Starting dynamic subtest: rgb565-xtiled [432.676055] Dynamic subtest rgb565-xtiled: SUCCESS (0.121s) [432.686001] Starting dynamic subtest: xrgb2101010-xtiled [432.787839] Dynamic subtest xrgb2101010-xtiled: SUCCESS (0.111s) [432.804157] Starting dynamic subtest: xbgr16161616f-xtiled [432.909511] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (0.120s) [432.922326] Starting dynamic subtest: xrgb8888-4tiled [433.053794] Dynamic subtest xrgb8888-4tiled: SUCCESS (0.142s) [433.066111] Starting dynamic subtest: rgb565-4tiled [433.198297] Dynamic subtest rgb565-4tiled: SUCCESS (0.142s) [433.207985] Starting dynamic subtest: xrgb2101010-4tiled [433.320253] Dynamic subtest xrgb2101010-4tiled: SUCCESS (0.121s) [433.330270] Starting dynamic subtest: xbgr16161616f-4tiled [433.464987] Dynamic subtest xbgr16161616f-4tiled: SUCCESS (0.144s) [433.466969] Subtest draw-method-mmap-cpu: SUCCESS (1.923s) [433.583343] [085/134] (594s left) kms_ccs (bad-rotation-90-4-tiled-mtl-rc-ccs-cc) [433.683478] Starting subtest: bad-rotation-90-4-tiled-mtl-rc-ccs-cc [433.685450] Starting dynamic subtest: pipe-A-eDP-1 [433.832886] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.141s) [433.844156] Starting dynamic subtest: pipe-B-eDP-1 [433.859379] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.011s) [433.868770] Starting dynamic subtest: pipe-C-eDP-1 [433.885222] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.010s) [433.894558] Starting dynamic subtest: pipe-D-eDP-1 [433.909823] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.010s) [433.911316] Subtest bad-rotation-90-4-tiled-mtl-rc-ccs-cc: SUCCESS (0.177s) [436.108258] [086/134] (592s left) gem_exec_schedule (u-semaphore-user) [436.188069] Starting subtest: u-semaphore-user [436.236327] Subtest u-semaphore-user: SUCCESS (0.057s) [438.052997] [087/134] (590s left) gem_exec_fence (basic-await) [438.238249] Starting subtest: basic-await [438.240412] Starting dynamic subtest: rcs0 [438.313155] Dynamic subtest rcs0: SUCCESS (0.075s) [438.326414] Starting dynamic subtest: bcs0 [438.390847] Dynamic subtest bcs0: SUCCESS (0.075s) [438.402804] Starting dynamic subtest: vcs0 [438.463014] Dynamic subtest vcs0: SUCCESS (0.070s) [438.474925] Starting dynamic subtest: vcs1 [438.534548] Dynamic subtest vcs1: SUCCESS (0.070s) [438.546537] Starting dynamic subtest: vecs0 [438.608202] Dynamic subtest vecs0: SUCCESS (0.072s) [438.621049] Starting dynamic subtest: ccs0 [438.688446] Dynamic subtest ccs0: SUCCESS (0.078s) [438.691452] Subtest basic-await: SUCCESS (0.451s) [441.055569] [088/134] (587s left) kms_rotation_crc (cursor-rotation-180) [441.155782] Starting subtest: cursor-rotation-180 [442.657537] Subtest cursor-rotation-180: SUCCESS (1.501s) [443.899683] [089/134] (584s left) kms_cursor_crc (cursor-onscreen-512x170) [444.219308] Starting subtest: cursor-onscreen-512x170 [444.223660] Subtest cursor-onscreen-512x170: SKIP (0.001s) [444.406746] [090/134] (584s left) kms_big_fb (linear-addfb) [444.508525] Starting subtest: linear-addfb [444.510423] Subtest linear-addfb: SUCCESS (0.000s) [444.647110] [091/134] (584s left) gem_exec_whisper (basic-queues) [444.721378] Starting subtest: basic-queues [451.336156] Subtest basic-queues: SUCCESS (6.607s) [451.544156] [092/134] (577s left) gem_exec_reloc (basic-scanout) [451.611534] Subtest basic-scanout: SKIP (0.000s) [451.703561] [093/134] (577s left) kms_plane_lowres (tiling-4) [451.809126] Starting subtest: tiling-4 [451.811450] Starting dynamic subtest: pipe-A-eDP-1 [451.816114] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [452.111929] Starting dynamic subtest: pipe-B-eDP-1 [452.117286] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [452.130369] Starting dynamic subtest: pipe-C-eDP-1 [452.135129] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [452.145245] Starting dynamic subtest: pipe-D-eDP-1 [452.149736] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [452.154199] Subtest tiling-4: SKIP (0.296s) [452.924129] [094/134] (575s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-onoff) [453.027182] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-onoff [460.148362] Subtest fbcpsr-1p-primscrn-spr-indfb-onoff: SUCCESS (7.120s) [460.340501] [095/134] (568s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-mmap-cpu) [460.450988] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-mmap-cpu [464.040787] Subtest fbc-1p-primscrn-spr-indfb-draw-mmap-cpu: SUCCESS (3.598s) [465.232373] [096/134] (563s left) gem_ctx_create (basic) [465.308003] Starting subtest: basic [465.310418] Subtest basic: SUCCESS (0.000s) [465.529775] [097/134] (563s left) kms_flip_scaled_crc (flip-64bpp-xtile-to-32bpp-xtile-downscaling) [465.632043] Starting subtest: flip-64bpp-xtile-to-32bpp-xtile-downscaling [465.634276] Starting dynamic subtest: pipe-A-default-mode [466.756185] Dynamic subtest pipe-A-default-mode: SKIP (1.123s) [466.760639] Subtest flip-64bpp-xtile-to-32bpp-xtile-downscaling: SKIP (1.125s) [466.949891] [098/134] (562s left) gem_pwrite (basic-exhaustion) [467.011423] Subtest basic-exhaustion: SKIP (0.000s) [467.063399] [099/134] (561s left) kms_atomic_transition (plane-all-transition-nonblocking) [467.161263] Starting subtest: plane-all-transition-nonblocking [467.163509] Starting dynamic subtest: pipe-A-eDP-1 [469.650300] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.494s) [469.976477] Starting dynamic subtest: pipe-B-eDP-1 [473.171893] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.209s) [473.469828] Subtest plane-all-transition-nonblocking: SUCCESS (6.317s) [474.315141] [100/134] (554s left) kms_color_pipeline (plane-lut1d-lut1d) [474.428002] Starting subtest: plane-lut1d-lut1d [474.441236] Starting dynamic subtest: pipe-A-eDP-1 [475.132718] Dynamic subtest pipe-A-eDP-1: FAIL (0.295s) [475.785152] Starting dynamic subtest: pipe-B-eDP-1 [476.626589] Dynamic subtest pipe-B-eDP-1: FAIL (0.324s) [477.211189] Starting dynamic subtest: pipe-C-eDP-1 [478.037161] Dynamic subtest pipe-C-eDP-1: FAIL (0.235s) [478.542831] Starting dynamic subtest: pipe-D-eDP-1 [479.371528] Dynamic subtest pipe-D-eDP-1: FAIL (0.246s) [479.373864] Subtest plane-lut1d-lut1d: FAIL (4.644s) [479.943485] [101/134] (549s left) gem_lmem_swapping (verify-random) [479.991544] Subtest verify-random: SKIP (0.000s) [480.035060] [102/134] (549s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-mmap-wc) [480.136150] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-mmap-wc [480.140414] Subtest psr-2p-primscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s) [480.276999] [103/134] (548s left) sw_sync (sync_random_merge) [480.313681] Starting subtest: sync_random_merge [480.362828] Subtest sync_random_merge: SUCCESS (0.050s) [480.449531] [104/134] (548s left) syncobj_timeline (invalid-signal-bad-pad) [480.517795] Starting subtest: invalid-signal-bad-pad [480.520139] Subtest invalid-signal-bad-pad: SUCCESS (0.000s) [480.644929] [105/134] (548s left) gem_mmap_gtt (basic) [480.705675] Subtest basic: SKIP (0.000s) [480.776947] [106/134] (548s left) gem_exec_balancer (invalid-balancer) [480.836178] Starting subtest: invalid-balancer [481.690207] Subtest invalid-balancer: SUCCESS (0.853s) [482.015228] [107/134] (547s left) kms_big_fb (y-tiled-8bpp-rotate-90) [482.115448] Starting subtest: y-tiled-8bpp-rotate-90 [482.119652] Subtest y-tiled-8bpp-rotate-90: SKIP (0.000s) [482.227587] [108/134] (547s left) gem_render_linear_blits (basic) [482.290452] Starting subtest: basic [482.310823] Subtest basic: SUCCESS (0.021s) [482.417407] [109/134] (547s left) gem_ctx_shared (q-promotion) [482.485999] Starting subtest: Q-promotion [482.488406] Starting dynamic subtest: rcs0 [482.594775] Dynamic subtest rcs0: SUCCESS (0.107s) [482.614487] Starting dynamic subtest: vcs0 [482.679455] Dynamic subtest vcs0: SUCCESS (0.084s) [482.698290] Starting dynamic subtest: vcs1 [482.758320] Dynamic subtest vcs1: SUCCESS (0.078s) [482.774932] Starting dynamic subtest: vecs0 [482.837486] Dynamic subtest vecs0: SUCCESS (0.078s) [482.854275] Starting dynamic subtest: ccs0 [482.928464] Dynamic subtest ccs0: SUCCESS (0.091s) [482.930825] Subtest Q-promotion: SUCCESS (0.443s) [484.075249] [110/134] (545s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-pwrite) [484.190593] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-pwrite [484.194617] Subtest fbc-2p-primscrn-pri-shrfb-draw-pwrite: SKIP (0.000s) [484.317444] [111/134] (545s left) syncobj_timeline (single-wait-for-submit-available-submitted) [484.376695] Starting subtest: single-wait-for-submit-available-submitted [484.378657] Subtest single-wait-for-submit-available-submitted: SUCCESS (0.000s) [484.505580] [112/134] (545s left) gem_flink_basic (bad-open) [484.567706] Starting subtest: bad-open [484.569609] Subtest bad-open: SUCCESS (0.000s) [484.675355] [113/134] (544s left) kms_ccs (crc-primary-rotation-180-4-tiled-mtl-rc-ccs-cc) [484.764355] Starting subtest: crc-primary-rotation-180-4-tiled-mtl-rc-ccs-cc [484.766664] Starting dynamic subtest: pipe-A-eDP-1 [485.580414] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.809s) [485.590133] Starting dynamic subtest: pipe-B-eDP-1 [487.151957] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.567s) [487.164072] Starting dynamic subtest: pipe-C-eDP-1 [488.614444] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.463s) [488.625997] Starting dynamic subtest: pipe-D-eDP-1 [490.139999] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.525s) [490.142286] Subtest crc-primary-rotation-180-4-tiled-mtl-rc-ccs-cc: SUCCESS (5.371s) [491.352771] [114/134] (538s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-mmap-wc) [491.457966] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-mmap-wc [491.462192] Subtest psr-2p-scndscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s) [491.580470] [115/134] (538s left) kms_hdr (bpc-switch-dpms) [491.676611] Starting subtest: bpc-switch-dpms [492.706634] Starting dynamic subtest: pipe-A-eDP-1 [497.240801] Dynamic subtest pipe-A-eDP-1: SUCCESS (4.539s) [497.243170] Subtest bpc-switch-dpms: SUCCESS (5.568s) [497.390225] [116/134] (532s left) kms_chamelium_hpd (hdmi-hpd) [497.783287] Subtest hdmi-hpd: SKIP (0.000s) [498.607500] [117/134] (531s left) kms_rotation_crc (primary-yf-tiled-reflect-x-270) [498.710150] Starting subtest: primary-yf-tiled-reflect-x-270 [498.714576] Subtest primary-yf-tiled-reflect-x-270: SKIP (0.001s) [498.805871] [118/134] (531s left) prime_vgem (basic-write) [498.871242] Starting subtest: basic-write [498.877227] Subtest basic-write: SKIP (0.007s) [498.997247] [119/134] (530s left) gem_ctx_freq (sysfs) [499.049892] Starting subtest: sysfs [499.052469] Starting dynamic subtest: gt0 [504.575428] Dynamic subtest gt0: SUCCESS (5.528s) [504.587527] Starting dynamic subtest: gt1 [545.952104] Dynamic subtest gt1: SUCCESS (41.391s) [545.955425] Subtest sysfs: SUCCESS (46.922s) [546.105846] [120/134] (483s left) kms_cursor_crc (cursor-onscreen-max-size) [546.403790] Starting subtest: cursor-onscreen-max-size [546.409813] Subtest cursor-onscreen-max-size: SKIP (0.000s) [546.557231] [121/134] (483s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-shrfb-draw-mmap-gtt) [546.657598] Starting subtest: fbc-1p-offscreen-pri-shrfb-draw-mmap-gtt [546.661882] Subtest fbc-1p-offscreen-pri-shrfb-draw-mmap-gtt: SKIP (0.000s) [546.765030] [122/134] (483s left) perf (per-context-mode-unprivileged) [546.868791] Starting subtest: per-context-mode-unprivileged [546.873351] Subtest per-context-mode-unprivileged: SKIP (0.000s) [546.916698] [123/134] (483s left) kms_setmode (basic) [546.979363] Starting subtest: basic [547.299287] Starting dynamic subtest: pipe-A-eDP-1 [549.410102] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.107s) [549.758438] Starting dynamic subtest: pipe-B-eDP-1 [551.841939] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.089s) [552.155680] Subtest basic: SUCCESS (5.175s) [553.012195] [124/134] (477s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip) [553.129278] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip [553.798446] Subtest x-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip: SUCCESS (0.671s) [553.997758] [125/134] (476s left) kms_atomic_transition (plane-use-after-nonblocking-unbind) [554.092173] Starting subtest: plane-use-after-nonblocking-unbind [554.094458] Starting dynamic subtest: pipe-A-eDP-1 [554.155735] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.065s) [554.468149] Starting dynamic subtest: pipe-B-eDP-1 [555.286690] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.829s) [555.571578] Subtest plane-use-after-nonblocking-unbind: SUCCESS (1.481s) [556.460350] [126/134] (473s left) kms_atomic_interruptible (universal-setplane-primary) [556.561171] Starting subtest: universal-setplane-primary [556.563359] Starting dynamic subtest: pipe-A-eDP-1 [563.940193] Dynamic subtest pipe-A-eDP-1: SUCCESS (7.379s) [563.942553] Subtest universal-setplane-primary: SUCCESS (7.381s) [564.809702] [127/134] (465s left) kms_pm_backlight (fade-with-dpms) [564.906158] Starting subtest: fade-with-dpms [567.467754] Starting dynamic subtest: eDP-1 [570.150004] Dynamic subtest eDP-1: SUCCESS (2.683s) [570.152520] Subtest fade-with-dpms: SUCCESS (5.246s) [570.988517] [128/134] (459s left) perf_pmu (event-wait) [571.029011] Starting subtest: event-wait [571.031328] Starting dynamic subtest: rcs0 [571.035656] Dynamic subtest rcs0: SKIP (0.000s) [571.039735] Subtest event-wait: SKIP (0.001s) [571.170244] [129/134] (459s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-mmap-gtt) [571.274804] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-mmap-gtt [571.278771] Subtest fbc-2p-scndscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s) [571.382323] [130/134] (458s left) gem_exec_whisper (basic-contexts-all) [571.445566] Starting subtest: basic-contexts-all [580.929636] Subtest basic-contexts-all: SUCCESS (9.480s) [581.137477] [131/134] (449s left) gem_spin_batch (spin-each) [581.198055] Starting subtest: spin-each [584.579613] Subtest spin-each: SUCCESS (3.377s) [585.074472] [132/134] (445s left) kms_universal_plane (disable-primary-vs-flip) [585.176266] Starting subtest: disable-primary-vs-flip [585.178567] Starting dynamic subtest: pipe-A-eDP-1 [586.755400] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.576s) [586.766265] Starting dynamic subtest: pipe-B-eDP-1 [588.973471] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.217s) [588.984631] Starting dynamic subtest: pipe-C-eDP-1 [591.120201] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.144s) [591.131900] Starting dynamic subtest: pipe-D-eDP-1 [593.304596] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.184s) [593.306751] Subtest disable-primary-vs-flip: SUCCESS (8.127s) [594.125984] [133/134] (436s left) gem_exec_schedule (preemptive-hang) [594.306016] Starting subtest: preemptive-hang [594.308802] Starting dynamic subtest: rcs0 [603.083359] Dynamic subtest rcs0: SUCCESS (8.776s) [603.095939] Starting dynamic subtest: bcs0 [612.106924] Dynamic subtest bcs0: SUCCESS (9.022s) [612.117201] Starting dynamic subtest: vcs0 [621.063661] Dynamic subtest vcs0: SUCCESS (8.953s) [621.077693] Starting dynamic subtest: vcs1 [630.088401] Dynamic subtest vcs1: SUCCESS (9.023s) [630.101825] Starting dynamic subtest: vecs0 [639.048138] Dynamic subtest vecs0: SUCCESS (8.958s) [639.059571] Starting dynamic subtest: ccs0 [648.074952] Dynamic subtest ccs0: SUCCESS (9.024s) [648.077394] Subtest preemptive-hang: SUCCESS (53.765s) [648.369011] [134/134] (382s left) syncobj_wait (invalid-signal-bad-pad) [648.433857] Starting subtest: invalid-signal-bad-pad [648.436335] Subtest invalid-signal-bad-pad: SUCCESS (0.000s) [648.587573] 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.