[58.688117] Initializing watchdogs [58.688170] /dev/watchdog0 [58.706301] [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] [58.710682] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [58.712874] [FACT before any test] new: kernel.kmod_is_loaded.i915: true [58.716060] [001/134] (960s left) kms_addfb_basic (addfb25-y-tiled-small-legacy) [58.836891] Starting subtest: addfb25-y-tiled-small-legacy [58.841328] Subtest addfb25-y-tiled-small-legacy: SKIP (0.000s) [58.953717] [002/134] (960s left) kms_plane_scaling (plane-downscale-factor-0-75-with-modifiers) [59.045810] Starting subtest: plane-downscale-factor-0-75-with-modifiers [59.048192] Starting dynamic subtest: pipe-A [59.416681] Dynamic subtest pipe-A: SUCCESS (0.375s) [59.423759] Starting dynamic subtest: pipe-B [60.870458] Dynamic subtest pipe-B: SUCCESS (1.462s) [60.877682] Starting dynamic subtest: pipe-C [62.313605] Dynamic subtest pipe-C: SUCCESS (1.450s) [62.322072] Starting dynamic subtest: pipe-D [63.726939] Dynamic subtest pipe-D: SUCCESS (1.418s) [63.729305] Subtest plane-downscale-factor-0-75-with-modifiers: SUCCESS (4.708s) [64.914772] [003/134] (954s left) i915_drm_fdinfo (virtual-idle) [64.967623] Starting subtest: virtual-idle [68.053230] Subtest virtual-idle: SUCCESS (3.092s) [68.148839] [004/134] (951s left) gem_userptr_blits (huge-split) [68.214725] Starting subtest: huge-split [68.226240] Subtest huge-split: SUCCESS (0.012s) [68.388558] [005/134] (950s left) kms_psr (fbc-pr-no-drrs) [68.505774] Starting subtest: fbc-pr-no-drrs [68.510252] Subtest fbc-pr-no-drrs: SKIP (0.000s) [68.598900] [006/134] (950s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-mmap-cpu) [68.694352] Starting subtest: psr-1p-primscrn-pri-indfb-draw-mmap-cpu [75.744900] Subtest psr-1p-primscrn-pri-indfb-draw-mmap-cpu: SUCCESS (7.062s) [75.865519] [007/134] (943s left) kms_cursor_legacy (cursora-vs-flipa-legacy) [75.982858] Starting subtest: cursorA-vs-flipA-legacy [87.158482] Subtest cursorA-vs-flipA-legacy: SUCCESS (11.174s) [88.019583] [008/134] (931s left) kms_psr (psr2-primary-page-flip) [88.117067] Starting subtest: psr2-primary-page-flip [88.119468] Starting dynamic subtest: eDP-1 [89.892091] Dynamic subtest eDP-1: SUCCESS (1.775s) [89.894437] Subtest psr2-primary-page-flip: SUCCESS (1.776s) [90.802292] [009/134] (928s left) i915_pm_rc6_residency (rc6-accuracy) [90.862787] Starting subtest: rc6-accuracy [90.864746] Starting dynamic subtest: gt0 [94.036235] Dynamic subtest gt0: SUCCESS (3.170s) [94.046820] Starting dynamic subtest: gt1 [97.256478] Dynamic subtest gt1: SUCCESS (3.169s) [97.258544] Subtest rc6-accuracy: SUCCESS (6.341s) [97.300745] [010/134] (922s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-blt) [97.415143] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-blt [104.741117] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-blt: SUCCESS (7.328s) [104.915464] [011/134] (914s left) kms_feature_discovery (psr2) [105.015962] Starting subtest: psr2 [105.018167] Subtest psr2: SUCCESS (0.000s) [105.109071] [012/134] (914s left) syncobj_wait (single-wait-all-for-submit-submitted) [105.168259] Starting subtest: single-wait-all-for-submit-submitted [105.273371] Subtest single-wait-all-for-submit-submitted: SUCCESS (0.105s) [105.368370] [013/134] (914s left) kms_flip (2x-wf_vblank-ts-check-interruptible) [105.466072] Starting subtest: 2x-wf_vblank-ts-check-interruptible [105.477418] Subtest 2x-wf_vblank-ts-check-interruptible: SKIP (0.011s) [105.612491] [014/134] (914s left) kms_psr_stress_test (flip-primary-invalidate-overlay) [105.712848] Starting subtest: flip-primary-invalidate-overlay [117.324804] Subtest flip-primary-invalidate-overlay: SUCCESS (11.614s) [117.471757] [015/134] (902s left) i915_drm_fdinfo (busy-idle) [117.508706] Starting subtest: busy-idle [117.510240] Starting dynamic subtest: rcs0 [117.547488] Dynamic subtest rcs0: SKIP (0.038s) [117.556828] Starting dynamic subtest: bcs0 [117.560080] Dynamic subtest bcs0: SKIP (0.001s) [117.566991] Starting dynamic subtest: vcs0 [117.570424] Dynamic subtest vcs0: SKIP (0.000s) [117.577099] Starting dynamic subtest: vcs1 [117.580347] Dynamic subtest vcs1: SKIP (0.000s) [117.587070] Starting dynamic subtest: vecs0 [117.590562] Dynamic subtest vecs0: SKIP (0.000s) [117.597140] Starting dynamic subtest: ccs0 [117.600513] Dynamic subtest ccs0: SKIP (0.000s) [117.603973] Subtest busy-idle: SKIP (0.043s) [117.646591] [016/134] (902s left) gem_exec_params (invalid-bsd2-flag-on-vebox) [117.710900] Starting subtest: invalid-bsd2-flag-on-vebox [117.713125] Subtest invalid-bsd2-flag-on-vebox: SUCCESS (0.000s) [117.848739] [017/134] (901s left) syncobj_wait (single-wait-all-for-submit-signaled) [117.912507] Starting subtest: single-wait-all-for-submit-signaled [117.914583] Subtest single-wait-all-for-submit-signaled: SUCCESS (0.000s) [118.030907] [018/134] (901s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-blt) [118.124525] Starting subtest: fbcpsr-rgb101010-draw-blt [124.852813] Subtest fbcpsr-rgb101010-draw-blt: SUCCESS (6.731s) [125.007257] [019/134] (894s left) kms_pm_rpm (modeset-lpsp) [127.042387] Starting subtest: modeset-lpsp [128.519734] Subtest modeset-lpsp: SUCCESS (1.476s) [128.630401] [020/134] (891s left) i915_suspend (sysfs-reader) [128.694268] Starting subtest: sysfs-reader [146.876158] Subtest sysfs-reader: SUCCESS (3.282s) [146.971428] [021/134] (873s left) prime_vgem (sync) [147.123227] Starting subtest: sync [147.125164] Starting dynamic subtest: rcs0 [147.174689] Dynamic subtest rcs0: SUCCESS (0.053s) [147.182634] Starting dynamic subtest: bcs0 [147.245227] Dynamic subtest bcs0: SUCCESS (0.073s) [147.253640] Starting dynamic subtest: vcs0 [147.296229] Dynamic subtest vcs0: SUCCESS (0.052s) [147.304235] Starting dynamic subtest: vcs1 [147.345268] Dynamic subtest vcs1: SUCCESS (0.050s) [147.353465] Starting dynamic subtest: vecs0 [147.391934] Dynamic subtest vecs0: SUCCESS (0.047s) [147.400007] Starting dynamic subtest: ccs0 [147.440669] Dynamic subtest ccs0: SUCCESS (0.050s) [147.442714] Subtest sync: SUCCESS (0.328s) [147.589494] [FACT prime_vgem (sync)] new: kernel.kmod_is_loaded.vgem: true [147.592066] [022/134] (872s left) api_intel_allocator (two-level-inception) [147.645452] Starting subtest: two-level-inception [152.972884] Subtest two-level-inception: SUCCESS (5.399s) [153.071285] [023/134] (866s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-move) [153.178095] Starting subtest: psr-2p-primscrn-cur-indfb-move [153.182466] Subtest psr-2p-primscrn-cur-indfb-move: SKIP (0.000s) [153.318045] [024/134] (866s left) sriov_basic (bind-unbind-vf) [153.378407] Starting subtest: bind-unbind-vf [153.380859] Starting dynamic subtest: vf-1 [153.455210] Dynamic subtest vf-1: FAIL (0.017s) [153.465664] Starting dynamic subtest: vf-2 [153.539248] Dynamic subtest vf-2: FAIL (0.004s) [153.550172] Starting dynamic subtest: vf-3 [153.622717] Dynamic subtest vf-3: FAIL (0.004s) [153.633403] Starting dynamic subtest: vf-4 [153.707085] Dynamic subtest vf-4: FAIL (0.005s) [153.720653] Starting dynamic subtest: vf-5 [153.792158] Dynamic subtest vf-5: FAIL (0.004s) [153.802286] Starting dynamic subtest: vf-6 [153.873558] Dynamic subtest vf-6: FAIL (0.004s) [153.883075] Starting dynamic subtest: vf-7 [153.949693] Dynamic subtest vf-7: FAIL (0.004s) [153.957868] Starting dynamic subtest: vf-random [154.013117] Dynamic subtest vf-random: FAIL (0.004s) [154.021315] Starting dynamic subtest: vf-last [154.077323] Dynamic subtest vf-last: FAIL (0.519s) [154.078902] Subtest bind-unbind-vf: FAIL (0.569s) [154.114977] [025/134] (866s left) gem_eio (hibernate) [154.352252] Starting subtest: hibernate [169.068798] Subtest hibernate: SUCCESS (14.803s) [177.263920] [026/134] (850s left) kms_vrr (seamless-rr-switch-virtual) [177.375160] Starting subtest: seamless-rr-switch-virtual [177.381516] Subtest seamless-rr-switch-virtual: SKIP (0.000s) [177.473266] [027/134] (850s left) api_intel_bb (render) [177.531465] Starting subtest: render [177.533650] Starting dynamic subtest: render-none-512 [177.639108] Dynamic subtest render-none-512: SUCCESS (0.107s) [177.649739] Starting dynamic subtest: render-none-1024 [178.019595] Dynamic subtest render-none-1024: SUCCESS (0.379s) [178.029900] Starting dynamic subtest: render-x-512 [178.104526] Dynamic subtest render-x-512: SUCCESS (0.085s) [178.115981] Starting dynamic subtest: render-x-1024 [178.441190] Dynamic subtest render-x-1024: SUCCESS (0.336s) [178.452796] Starting dynamic subtest: render-y-512 [178.528544] Dynamic subtest render-y-512: SUCCESS (0.087s) [178.540490] Starting dynamic subtest: render-y-1024 [178.866997] Dynamic subtest render-y-1024: SUCCESS (0.337s) [178.869433] Subtest render: SUCCESS (1.335s) [178.991467] [028/134] (849s left) kms_cursor_legacy (torture-bo) [179.112066] Starting subtest: torture-bo [179.114102] Starting dynamic subtest: pipe-A [184.800986] Dynamic subtest pipe-A: SUCCESS (5.634s) [184.813265] Starting dynamic subtest: pipe-B [192.192440] Dynamic subtest pipe-B: SUCCESS (7.444s) [192.206402] Starting dynamic subtest: pipe-C [198.298557] Dynamic subtest pipe-C: SUCCESS (6.106s) [198.310823] Starting dynamic subtest: pipe-D [204.887493] Dynamic subtest pipe-D: SUCCESS (6.588s) [204.900901] Starting dynamic subtest: all-pipes [212.177166] Dynamic subtest all-pipes: SUCCESS (7.290s) [212.179838] Subtest torture-bo: SUCCESS (33.070s) [212.358603] [029/134] (815s left) kms_rotation_crc (sprite-rotation-270) [212.453296] Starting subtest: sprite-rotation-270 [212.457265] Subtest sprite-rotation-270: SKIP (0.001s) [212.547899] [030/134] (815s left) kms_prime (basic-modeset-hybrid) [212.626159] Subtest basic-modeset-hybrid: SKIP (0.000s) [212.741269] [031/134] (815s left) gem_ctx_persistence (many-contexts) [212.806813] Starting subtest: many-contexts [258.041260] Subtest many-contexts: SUCCESS (45.247s) [258.154874] [032/134] (770s left) gem_create (busy-create) [258.216001] Starting subtest: busy-create [258.218182] Starting dynamic subtest: smem0 [291.910301] Dynamic subtest smem0: SUCCESS (33.705s) [291.912657] Subtest busy-create: SUCCESS (33.706s) [292.122934] [033/134] (736s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-mmap-gtt) [292.219468] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-mmap-gtt [292.223755] Subtest psr-2p-scndscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s) [292.343847] [034/134] (736s left) kms_psr (fbc-psr-cursor-blt) [292.444162] Starting subtest: fbc-psr-cursor-blt [292.446335] Starting dynamic subtest: eDP-1 [292.450256] Dynamic subtest eDP-1: SKIP (0.000s) [292.454182] Subtest fbc-psr-cursor-blt: SKIP (0.001s) [292.540024] [035/134] (736s left) gem_sync (basic-store-each) [292.614909] Starting subtest: basic-store-each [295.089264] Subtest basic-store-each: SUCCESS (2.485s) [295.296463] [036/134] (733s left) prime_mmap (test_userptr) [295.357849] Starting subtest: test_userptr [295.360154] Starting dynamic subtest: test_userptr-smem [295.362442] Dynamic subtest test_userptr-smem: SUCCESS (0.000s) [295.364715] Subtest test_userptr: SUCCESS (0.001s) [295.473371] [037/134] (733s left) kms_pipe_crc_basic (nonblocking-crc) [295.572142] Starting subtest: nonblocking-crc [295.574495] Starting dynamic subtest: pipe-A-eDP-1 [296.327005] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.755s) [296.338854] Starting dynamic subtest: pipe-B-eDP-1 [297.741781] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.416s) [297.752596] Starting dynamic subtest: pipe-C-eDP-1 [299.076981] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.334s) [299.088565] Starting dynamic subtest: pipe-D-eDP-1 [300.418713] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.341s) [300.421115] Subtest nonblocking-crc: SUCCESS (4.851s) [301.243663] [038/134] (727s left) perf (unprivileged-single-ctx-counters) [301.402971] Starting subtest: unprivileged-single-ctx-counters [301.406820] Subtest unprivileged-single-ctx-counters: SKIP (0.000s) [301.443653] [039/134] (727s left) kms_psr2_sf (psr2-overlay-primary-update-sf-dmg-area) [306.497336] Starting subtest: psr2-overlay-primary-update-sf-dmg-area [306.499608] Starting dynamic subtest: pipe-A-eDP-1 [313.112692] Dynamic subtest pipe-A-eDP-1: SUCCESS (6.615s) [313.123468] Starting dynamic subtest: pipe-B-eDP-1 [319.779620] Dynamic subtest pipe-B-eDP-1: SUCCESS (6.666s) [319.781975] Subtest psr2-overlay-primary-update-sf-dmg-area: SUCCESS (13.286s) [320.673254] [040/134] (708s left) kms_psr2_sf (pr-overlay-plane-move-continuous-sf) [325.716888] Starting subtest: pr-overlay-plane-move-continuous-sf [325.721323] Subtest pr-overlay-plane-move-continuous-sf: SKIP (0.002s) [326.585876] [041/134] (702s left) kms_psr (fbc-psr-sprite-blt) [326.697540] Starting subtest: fbc-psr-sprite-blt [326.699772] Starting dynamic subtest: eDP-1 [326.704183] Dynamic subtest eDP-1: SKIP (0.000s) [326.708597] Subtest fbc-psr-sprite-blt: SKIP (0.001s) [326.800225] [042/134] (702s left) sysfs_timeslice_duration (invalid) [326.864433] Starting subtest: invalid [326.866787] Starting dynamic subtest: vecs0 [326.869106] Dynamic subtest vecs0: SUCCESS (0.000s) [326.880147] Starting dynamic subtest: ccs0 [326.882346] Dynamic subtest ccs0: SUCCESS (0.000s) [326.893794] Starting dynamic subtest: vcs0 [326.895843] Dynamic subtest vcs0: SUCCESS (0.000s) [326.905255] Starting dynamic subtest: bcs0 [326.907373] Dynamic subtest bcs0: SUCCESS (0.000s) [326.916758] Starting dynamic subtest: rcs0 [326.918819] Dynamic subtest rcs0: SUCCESS (0.000s) [326.927733] Starting dynamic subtest: vcs1 [326.929558] Dynamic subtest vcs1: SUCCESS (0.000s) [326.931809] Subtest invalid: SUCCESS (0.005s) [327.002712] [043/134] (701s left) gem_barrier_race (remote-request) [327.067421] Starting subtest: remote-request [327.069291] Starting dynamic subtest: rcs0 [332.222456] Dynamic subtest rcs0: SUCCESS (5.159s) [332.224521] Subtest remote-request: SUCCESS (5.160s) [332.381657] [044/134] (696s left) kms_big_fb (yf-tiled-addfb-size-overflow) [332.483028] Starting subtest: yf-tiled-addfb-size-overflow [332.486728] Subtest yf-tiled-addfb-size-overflow: SKIP (0.000s) [332.615758] [045/134] (696s left) vgem_basic (busy-fence) [332.655465] Starting subtest: busy-fence [332.657154] Subtest busy-fence: SUCCESS (0.000s) [332.734292] [046/134] (696s left) gem_mmap (bad-object) [332.793256] Subtest bad-object: SKIP (0.000s) [332.864574] [047/134] (696s left) kms_big_fb (x-tiled-64bpp-rotate-180) [332.963736] Starting subtest: x-tiled-64bpp-rotate-180 [334.498192] Subtest x-tiled-64bpp-rotate-180: SUCCESS (1.534s) [334.722694] [048/134] (694s left) syncobj_timeline (etime-multi-wait-submitted) [334.783184] Starting subtest: etime-multi-wait-submitted [334.892020] Subtest etime-multi-wait-submitted: SUCCESS (0.108s) [334.996037] [049/134] (694s left) gem_readwrite (read-write) [335.051181] Subtest read-write: SKIP (0.000s) [335.121608] [050/134] (694s left) kms_content_protection (mei-interface) [335.257536] Starting subtest: mei-interface [335.262049] Subtest mei-interface: SKIP (0.001s) [335.441528] [051/134] (693s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip) [335.540210] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip [336.197644] Subtest 4-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip: SUCCESS (0.659s) [336.408618] [052/134] (692s left) gem_mmap_gtt (isolation) [336.478768] Subtest isolation: SKIP (0.000s) [336.547627] [053/134] (692s left) kms_cursor_edge_walk (64x64-top-edge) [336.658261] Starting subtest: 64x64-top-edge [336.660444] Starting dynamic subtest: pipe-A-eDP-1 [340.121957] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.465s) [340.132510] Starting dynamic subtest: pipe-D-eDP-1 [343.233920] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.113s) [343.236133] Subtest 64x64-top-edge: SUCCESS (6.580s) [344.079863] [054/134] (685s left) syncobj_wait (wait-all-snapshot) [344.145139] Starting subtest: wait-all-snapshot [344.226557] Subtest wait-all-snapshot: SUCCESS (0.081s) [344.328126] [055/134] (685s left) kms_frontbuffer_tracking (fbcpsr-argb161616f-draw-mmap-cpu) [344.427718] Starting subtest: fbcpsr-argb161616f-draw-mmap-cpu [344.431718] Subtest fbcpsr-argb161616f-draw-mmap-cpu: SKIP (0.000s) [344.566645] [056/134] (684s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-gtt) [344.676421] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-gtt [344.680958] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s) [344.824712] [057/134] (684s left) gem_create (create-invalid-size) [344.887127] Starting subtest: create-invalid-size [344.889067] Subtest create-invalid-size: SUCCESS (0.000s) [345.093672] [058/134] (684s left) gem_render_copy (y-tiled-ccs-to-yf-tiled) [345.165991] Starting subtest: y-tiled-ccs-to-yf-tiled [345.170665] Subtest y-tiled-ccs-to-yf-tiled: SKIP (0.000s) [345.371310] [059/134] (684s left) kms_frontbuffer_tracking (psr-argb161616f-draw-mmap-wc) [345.471956] Starting subtest: psr-argb161616f-draw-mmap-wc [345.475922] Subtest psr-argb161616f-draw-mmap-wc: SKIP (0.000s) [345.614388] [060/134] (683s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-mmap-cpu) [345.724266] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-mmap-cpu [345.728344] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s) [345.876184] [061/134] (683s left) kms_joiner (switch-modeset-ultra-joiner-big-joiner) [345.993556] Starting subtest: switch-modeset-ultra-joiner-big-joiner [345.997953] Subtest switch-modeset-ultra-joiner-big-joiner: SKIP (0.000s) [346.083220] [062/134] (683s left) sw_sync (sync_merge_same) [346.124845] Starting subtest: sync_merge_same [346.127262] Subtest sync_merge_same: SUCCESS (0.000s) [346.204919] [063/134] (683s left) kms_plane_scaling (planes-downscale-factor-0-75-unity-scaling) [346.305634] Starting subtest: planes-downscale-factor-0-75-unity-scaling [346.307519] Starting dynamic subtest: pipe-A [346.369455] Dynamic subtest pipe-A: SUCCESS (0.065s) [346.380861] Starting dynamic subtest: pipe-B [347.476994] Dynamic subtest pipe-B: SUCCESS (1.107s) [347.487866] Starting dynamic subtest: pipe-C [348.593493] Dynamic subtest pipe-C: SUCCESS (1.115s) [348.604084] Starting dynamic subtest: pipe-D [349.719063] Dynamic subtest pipe-D: SUCCESS (1.125s) [349.721443] Subtest planes-downscale-factor-0-75-unity-scaling: SUCCESS (3.417s) [350.910466] [064/134] (678s left) syncobj_timeline (multi-wait-for-submit-available-unsubmitted-submitted-signa [350.972500] Starting subtest: multi-wait-for-submit-available-unsubmitted-submitted-signaled [350.974709] Subtest multi-wait-for-submit-available-unsubmitted-submitted-signaled: SUCCESS (0.000s) [351.105320] [065/134] (678s left) gem_render_copy (linear-to-vebox-yf-tiled) [351.171016] Starting subtest: linear-to-vebox-yf-tiled [351.175550] Subtest linear-to-vebox-yf-tiled: SKIP (0.000s) [351.378824] [066/134] (678s left) kms_flip (flip-vs-dpms-off-vs-modeset-interruptible) [351.486512] Starting subtest: flip-vs-dpms-off-vs-modeset-interruptible [351.488799] Starting dynamic subtest: A-eDP1 [355.091516] Dynamic subtest A-eDP1: SUCCESS (3.604s) [355.103040] Starting dynamic subtest: B-eDP1 [358.288846] Dynamic subtest B-eDP1: SUCCESS (3.196s) [358.300394] Starting dynamic subtest: C-eDP1 [361.423468] Dynamic subtest C-eDP1: SUCCESS (3.134s) [361.434995] Starting dynamic subtest: D-eDP1 [364.536951] Dynamic subtest D-eDP1: SUCCESS (3.115s) [364.539324] Subtest flip-vs-dpms-off-vs-modeset-interruptible: SUCCESS (13.056s) [365.360647] [067/134] (664s left) kms_chamelium_color (ctm-limited-range) [365.449371] Subtest ctm-limited-range: SKIP (0.000s) [365.506019] [068/134] (664s left) gem_mmap_wc (write) [365.566906] Subtest write: SKIP (0.000s) [365.637538] [069/134] (664s left) prime_mmap (test_correct) [365.695070] Starting subtest: test_correct [365.697359] Starting dynamic subtest: test_correct-smem [365.728910] Dynamic subtest test_correct-smem: SUCCESS (0.034s) [365.731276] Subtest test_correct: SUCCESS (0.034s) [365.865510] [070/134] (664s left) device_reset (cold-reset-bound) [365.911089] Starting subtest: cold-reset-bound [365.915987] Subtest cold-reset-bound: SKIP (0.000s) [366.003629] [071/134] (664s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-blt) [366.100989] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-blt [373.103221] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-blt: SUCCESS (7.007s) [373.293947] [072/134] (656s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-mmap-cpu) [373.406931] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-mmap-cpu [377.679546] Subtest fbc-1p-primscrn-pri-indfb-draw-mmap-cpu: SUCCESS (4.278s) [378.895783] [073/134] (651s left) kms_ccs (crc-primary-basic-y-tiled-gen12-rc-ccs) [378.997468] Starting subtest: crc-primary-basic-y-tiled-gen12-rc-ccs [378.999722] Starting dynamic subtest: pipe-A-eDP-1 [379.022980] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [379.034776] Starting dynamic subtest: pipe-B-eDP-1 [379.056013] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [379.065935] Starting dynamic subtest: pipe-C-eDP-1 [379.087456] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [379.096986] Starting dynamic subtest: pipe-D-eDP-1 [379.118828] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [379.122888] Subtest crc-primary-basic-y-tiled-gen12-rc-ccs: SKIP (0.006s) [381.249910] [074/134] (648s left) gem_exec_fence (syncobj-channel) [381.671256] Starting subtest: syncobj-channel [382.689609] Subtest syncobj-channel: SUCCESS (1.015s) [382.999098] [075/134] (647s left) gem_exec_reloc (basic-gtt-noreloc) [383.070129] Subtest basic-gtt-noreloc: SKIP (0.000s) [383.159947] [076/134] (647s left) kms_flip (dpms-off-confusion-interruptible) [383.270264] Starting subtest: dpms-off-confusion-interruptible [383.272505] Starting dynamic subtest: A-eDP1 [392.217824] Dynamic subtest A-eDP1: SUCCESS (8.915s) [392.228969] Starting dynamic subtest: B-eDP1 [400.835909] Dynamic subtest B-eDP1: SUCCESS (8.621s) [400.847754] Starting dynamic subtest: C-eDP1 [409.457726] Dynamic subtest C-eDP1: SUCCESS (8.616s) [409.469710] Starting dynamic subtest: D-eDP1 [418.096077] Dynamic subtest D-eDP1: SUCCESS (8.635s) [418.098235] Subtest dpms-off-confusion-interruptible: SUCCESS (34.796s) [419.329818] [077/134] (610s left) kms_vblank (wait-forked-busy) [419.426127] Starting subtest: wait-forked-busy [419.428005] Starting dynamic subtest: pipe-A-eDP-1 [421.298910] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.874s) [421.319035] Starting dynamic subtest: pipe-D-eDP-1 [423.852874] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.551s) [423.855259] Subtest wait-forked-busy: SUCCESS (4.430s) [424.678402] [078/134] (605s left) kms_chamelium_frames (dp-frame-dump) [425.060892] Subtest dp-frame-dump: SKIP (0.000s) [425.855620] [079/134] (604s left) kms_ccs (crc-sprite-planes-basic-y-tiled-gen12-mc-ccs) [425.965423] Starting subtest: crc-sprite-planes-basic-y-tiled-gen12-mc-ccs [425.967815] Starting dynamic subtest: pipe-A-eDP-1 [426.027074] Dynamic subtest pipe-A-eDP-1: SKIP (0.003s) [426.038850] Starting dynamic subtest: pipe-B-eDP-1 [426.095936] Dynamic subtest pipe-B-eDP-1: SKIP (0.003s) [426.107354] Starting dynamic subtest: pipe-C-eDP-1 [426.164736] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s) [426.175717] Starting dynamic subtest: pipe-D-eDP-1 [426.233042] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s) [426.237238] Subtest crc-sprite-planes-basic-y-tiled-gen12-mc-ccs: SKIP (0.019s) [428.170664] [080/134] (602s left) kms_frontbuffer_tracking (fbc-2p-primscrn-indfb-plflip-blt) [428.282337] Starting subtest: fbc-2p-primscrn-indfb-plflip-blt [428.286763] Subtest fbc-2p-primscrn-indfb-plflip-blt: SKIP (0.000s) [428.431406] [081/134] (602s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-180) [428.539931] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-180 [428.544438] Subtest y-tiled-max-hw-stride-64bpp-rotate-180: SKIP (0.000s) [428.679236] [082/134] (601s left) gen7_exec_parse (cmd-crossing-page) [428.743067] Subtest cmd-crossing-page: SKIP (0.000s) [428.814288] [083/134] (601s left) kms_atomic_transition (modeset-transition-nonblocking) [428.904617] Starting subtest: modeset-transition-nonblocking [428.906572] Starting dynamic subtest: 1x-outputs [439.776407] Dynamic subtest 1x-outputs: SUCCESS (10.879s) [439.778685] Subtest modeset-transition-nonblocking: SUCCESS (10.881s) [440.664993] [084/134] (589s left) kms_draw_crc (draw-method-mmap-cpu) [440.752548] Starting subtest: draw-method-mmap-cpu [440.754717] Starting dynamic subtest: xrgb8888-untiled [441.017348] Dynamic subtest xrgb8888-untiled: SUCCESS (0.266s) [441.028017] Starting dynamic subtest: rgb565-untiled [441.228515] Dynamic subtest rgb565-untiled: SUCCESS (0.210s) [441.238867] Starting dynamic subtest: xrgb2101010-untiled [441.450783] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.221s) [441.461384] Starting dynamic subtest: xbgr16161616f-untiled [441.683470] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.232s) [441.693507] Starting dynamic subtest: xrgb8888-xtiled [441.805685] Dynamic subtest xrgb8888-xtiled: SUCCESS (0.121s) [441.815256] Starting dynamic subtest: rgb565-xtiled [441.927910] Dynamic subtest rgb565-xtiled: SUCCESS (0.121s) [441.937565] Starting dynamic subtest: xrgb2101010-xtiled [442.050492] Dynamic subtest xrgb2101010-xtiled: SUCCESS (0.122s) [442.060336] Starting dynamic subtest: xbgr16161616f-xtiled [442.183014] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (0.131s) [442.195750] Starting dynamic subtest: xrgb8888-4tiled [442.338830] Dynamic subtest xrgb8888-4tiled: SUCCESS (0.155s) [442.348874] Starting dynamic subtest: rgb565-4tiled [442.483095] Dynamic subtest rgb565-4tiled: SUCCESS (0.144s) [442.493065] Starting dynamic subtest: xrgb2101010-4tiled [442.616358] Dynamic subtest xrgb2101010-4tiled: SUCCESS (0.133s) [442.626818] Starting dynamic subtest: xbgr16161616f-4tiled [442.761423] Dynamic subtest xbgr16161616f-4tiled: SUCCESS (0.144s) [442.763606] Subtest draw-method-mmap-cpu: SUCCESS (2.012s) [442.910782] [085/134] (587s left) kms_ccs (bad-rotation-90-4-tiled-mtl-rc-ccs-cc) [443.004670] Starting subtest: bad-rotation-90-4-tiled-mtl-rc-ccs-cc [443.006454] Starting dynamic subtest: pipe-A-eDP-1 [443.156799] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.146s) [443.170249] Starting dynamic subtest: pipe-B-eDP-1 [443.185773] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.010s) [443.197759] Starting dynamic subtest: pipe-C-eDP-1 [443.214058] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.012s) [443.223522] Starting dynamic subtest: pipe-D-eDP-1 [443.239096] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.011s) [443.240910] Subtest bad-rotation-90-4-tiled-mtl-rc-ccs-cc: SUCCESS (0.183s) [445.510178] [086/134] (585s left) gem_exec_schedule (u-semaphore-user) [445.592409] Starting subtest: u-semaphore-user [445.642741] Subtest u-semaphore-user: SUCCESS (0.056s) [446.878944] [087/134] (583s left) gem_exec_fence (basic-await) [447.057759] Starting subtest: basic-await [447.060242] Starting dynamic subtest: rcs0 [447.141441] Dynamic subtest rcs0: SUCCESS (0.084s) [447.154990] Starting dynamic subtest: bcs0 [447.216744] Dynamic subtest bcs0: SUCCESS (0.073s) [447.229582] Starting dynamic subtest: vcs0 [447.289256] Dynamic subtest vcs0: SUCCESS (0.071s) [447.302382] Starting dynamic subtest: vcs1 [447.362325] Dynamic subtest vcs1: SUCCESS (0.072s) [447.374628] Starting dynamic subtest: vecs0 [447.435296] Dynamic subtest vecs0: SUCCESS (0.072s) [447.448663] Starting dynamic subtest: ccs0 [447.512012] Dynamic subtest ccs0: SUCCESS (0.075s) [447.514300] Subtest basic-await: SUCCESS (0.456s) [448.996958] [088/134] (581s left) kms_rotation_crc (cursor-rotation-180) [449.111988] Starting subtest: cursor-rotation-180 [450.586782] Subtest cursor-rotation-180: SUCCESS (1.476s) [451.783518] [089/134] (579s left) kms_cursor_crc (cursor-onscreen-512x170) [452.095885] Starting subtest: cursor-onscreen-512x170 [452.099912] Subtest cursor-onscreen-512x170: SKIP (0.001s) [452.299792] [090/134] (578s left) kms_big_fb (linear-addfb) [452.411216] Starting subtest: linear-addfb [452.413347] Subtest linear-addfb: SUCCESS (0.000s) [452.532134] [091/134] (578s left) gem_exec_whisper (basic-queues) [452.601036] Starting subtest: basic-queues [459.275871] Subtest basic-queues: SUCCESS (6.675s) [459.482187] [092/134] (571s left) gem_exec_reloc (basic-scanout) [459.544803] Subtest basic-scanout: SKIP (0.000s) [459.635267] [093/134] (571s left) kms_plane_lowres (tiling-4) [459.743983] Starting subtest: tiling-4 [459.746106] Starting dynamic subtest: pipe-A-eDP-1 [459.750361] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [460.039677] Starting dynamic subtest: pipe-B-eDP-1 [460.044136] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [460.054374] Starting dynamic subtest: pipe-C-eDP-1 [460.059983] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [460.071868] Starting dynamic subtest: pipe-D-eDP-1 [460.076207] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [460.080425] Subtest tiling-4: SKIP (0.294s) [460.908469] [094/134] (570s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-onoff) [461.014419] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-onoff [468.173895] Subtest fbcpsr-1p-primscrn-spr-indfb-onoff: SUCCESS (7.149s) [468.366748] [095/134] (562s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-mmap-cpu) [468.476734] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-mmap-cpu [472.105906] Subtest fbc-1p-primscrn-spr-indfb-draw-mmap-cpu: SUCCESS (3.627s) [473.290072] [096/134] (557s left) gem_ctx_create (basic) [473.357726] Starting subtest: basic [473.360255] Subtest basic: SUCCESS (0.000s) [473.570078] [097/134] (557s left) kms_flip_scaled_crc (flip-64bpp-xtile-to-32bpp-xtile-downscaling) [473.665616] Starting subtest: flip-64bpp-xtile-to-32bpp-xtile-downscaling [473.668109] Starting dynamic subtest: pipe-A-default-mode [474.818954] Dynamic subtest pipe-A-default-mode: SKIP (1.153s) [474.823134] Subtest flip-64bpp-xtile-to-32bpp-xtile-downscaling: SKIP (1.155s) [475.000742] [098/134] (556s left) gem_pwrite (basic-exhaustion) [475.059786] Subtest basic-exhaustion: SKIP (0.000s) [475.127192] [099/134] (556s left) kms_atomic_transition (plane-all-transition-nonblocking) [475.228189] Starting subtest: plane-all-transition-nonblocking [475.230508] Starting dynamic subtest: pipe-A-eDP-1 [477.725670] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.495s) [478.039642] Starting dynamic subtest: pipe-B-eDP-1 [481.235227] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.203s) [481.541027] Subtest plane-all-transition-nonblocking: SUCCESS (6.304s) [482.387040] [100/134] (548s left) kms_color_pipeline (plane-lut1d-lut1d) [482.489967] Starting subtest: plane-lut1d-lut1d [482.506616] Starting dynamic subtest: pipe-A-eDP-1 [483.235464] Dynamic subtest pipe-A-eDP-1: FAIL (0.326s) [483.937633] Starting dynamic subtest: pipe-B-eDP-1 [484.739144] Dynamic subtest pipe-B-eDP-1: FAIL (0.291s) [485.268863] Starting dynamic subtest: pipe-C-eDP-1 [486.087809] Dynamic subtest pipe-C-eDP-1: FAIL (0.247s) [486.598576] Starting dynamic subtest: pipe-D-eDP-1 [487.430910] Dynamic subtest pipe-D-eDP-1: FAIL (0.257s) [487.432830] Subtest plane-lut1d-lut1d: FAIL (4.658s) [488.012510] [101/134] (543s left) gem_lmem_swapping (verify-random) [488.053256] Subtest verify-random: SKIP (0.000s) [488.098770] [102/134] (543s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-mmap-wc) [488.199074] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-mmap-wc [488.203186] Subtest psr-2p-primscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s) [488.334951] [103/134] (543s left) sw_sync (sync_random_merge) [488.377518] Starting subtest: sync_random_merge [488.414677] Subtest sync_random_merge: SUCCESS (0.038s) [488.501754] [104/134] (542s left) syncobj_timeline (invalid-signal-bad-pad) [488.560154] Starting subtest: invalid-signal-bad-pad [488.562374] Subtest invalid-signal-bad-pad: SUCCESS (0.000s) [488.692238] [105/134] (542s left) gem_mmap_gtt (basic) [488.757444] Subtest basic: SKIP (0.000s) [488.829691] [106/134] (542s left) gem_exec_balancer (invalid-balancer) [488.899705] Starting subtest: invalid-balancer [489.789937] Subtest invalid-balancer: SUCCESS (0.887s) [490.138524] [107/134] (541s left) kms_big_fb (y-tiled-8bpp-rotate-90) [490.242144] Starting subtest: y-tiled-8bpp-rotate-90 [490.246392] Subtest y-tiled-8bpp-rotate-90: SKIP (0.000s) [490.372221] [108/134] (541s left) gem_render_linear_blits (basic) [490.430576] Starting subtest: basic [490.452924] Subtest basic: SUCCESS (0.025s) [490.540582] [109/134] (541s left) gem_ctx_shared (q-promotion) [490.614969] Starting subtest: Q-promotion [490.617417] Starting dynamic subtest: rcs0 [490.724433] Dynamic subtest rcs0: SUCCESS (0.109s) [490.743361] Starting dynamic subtest: vcs0 [490.805796] Dynamic subtest vcs0: SUCCESS (0.081s) [490.822901] Starting dynamic subtest: vcs1 [490.884271] Dynamic subtest vcs1: SUCCESS (0.078s) [490.902679] Starting dynamic subtest: vecs0 [490.964979] Dynamic subtest vecs0: SUCCESS (0.079s) [490.982144] Starting dynamic subtest: ccs0 [491.058682] Dynamic subtest ccs0: SUCCESS (0.093s) [491.060776] Subtest Q-promotion: SUCCESS (0.444s) [491.965783] [110/134] (539s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-pwrite) [492.070776] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-pwrite [492.074877] Subtest fbc-2p-primscrn-pri-shrfb-draw-pwrite: SKIP (0.000s) [492.205109] [111/134] (539s left) syncobj_timeline (single-wait-for-submit-available-submitted) [492.264037] Starting subtest: single-wait-for-submit-available-submitted [492.266386] Subtest single-wait-for-submit-available-submitted: SUCCESS (0.000s) [492.397546] [112/134] (539s left) gem_flink_basic (bad-open) [492.454901] Starting subtest: bad-open [492.456841] Subtest bad-open: SUCCESS (0.000s) [492.574348] [113/134] (539s left) kms_ccs (crc-primary-rotation-180-4-tiled-mtl-rc-ccs-cc) [492.687548] Starting subtest: crc-primary-rotation-180-4-tiled-mtl-rc-ccs-cc [492.689719] Starting dynamic subtest: pipe-A-eDP-1 [493.566802] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.872s) [493.578250] Starting dynamic subtest: pipe-B-eDP-1 [495.194708] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.622s) [495.205593] Starting dynamic subtest: pipe-C-eDP-1 [496.728455] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.532s) [496.739975] Starting dynamic subtest: pipe-D-eDP-1 [498.282949] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.553s) [498.285092] Subtest crc-primary-rotation-180-4-tiled-mtl-rc-ccs-cc: SUCCESS (5.584s) [499.562823] [114/134] (532s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-mmap-wc) [499.682006] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-mmap-wc [499.686121] Subtest psr-2p-scndscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s) [499.821817] [115/134] (532s left) kms_hdr (bpc-switch-dpms) [499.915382] Starting subtest: bpc-switch-dpms [501.009527] Starting dynamic subtest: pipe-A-eDP-1 [505.541015] Dynamic subtest pipe-A-eDP-1: SUCCESS (4.527s) [505.543394] Subtest bpc-switch-dpms: SUCCESS (5.623s) [505.694020] [116/134] (526s left) kms_chamelium_hpd (hdmi-hpd) [506.092929] Subtest hdmi-hpd: SKIP (0.000s) [506.916225] [117/134] (525s left) kms_rotation_crc (primary-yf-tiled-reflect-x-270) [507.017417] Starting subtest: primary-yf-tiled-reflect-x-270 [507.021918] Subtest primary-yf-tiled-reflect-x-270: SKIP (0.001s) [507.118618] [118/134] (524s left) prime_vgem (basic-write) [507.201908] Starting subtest: basic-write [507.209998] Subtest basic-write: SKIP (0.007s) [507.366732] [119/134] (524s left) gem_ctx_freq (sysfs) [507.433708] Starting subtest: sysfs [507.436066] Starting dynamic subtest: gt0 [512.943763] Dynamic subtest gt0: SUCCESS (5.505s) [512.957040] Starting dynamic subtest: gt1 [554.846978] Dynamic subtest gt1: SUCCESS (41.882s) [554.849352] Subtest sysfs: SUCCESS (47.389s) [554.985889] [120/134] (477s left) kms_cursor_crc (cursor-onscreen-max-size) [555.320863] Starting subtest: cursor-onscreen-max-size [555.327386] Subtest cursor-onscreen-max-size: SKIP (0.000s) [555.487694] [121/134] (476s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-shrfb-draw-mmap-gtt) [555.587753] Starting subtest: fbc-1p-offscreen-pri-shrfb-draw-mmap-gtt [555.591776] Subtest fbc-1p-offscreen-pri-shrfb-draw-mmap-gtt: SKIP (0.000s) [555.725359] [122/134] (476s left) perf (per-context-mode-unprivileged) [555.846620] Starting subtest: per-context-mode-unprivileged [555.851008] Subtest per-context-mode-unprivileged: SKIP (0.000s) [555.894750] [123/134] (476s left) kms_setmode (basic) [555.962917] Starting subtest: basic [556.296094] Starting dynamic subtest: pipe-A-eDP-1 [558.362586] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.062s) [558.709114] Starting dynamic subtest: pipe-B-eDP-1 [560.794122] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.089s) [561.106719] Subtest basic: SUCCESS (5.137s) [561.960825] [124/134] (470s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip) [562.079713] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip [562.762933] Subtest x-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip: SUCCESS (0.685s) [562.987582] [125/134] (469s left) kms_atomic_transition (plane-use-after-nonblocking-unbind) [563.075990] Starting subtest: plane-use-after-nonblocking-unbind [563.078248] Starting dynamic subtest: pipe-A-eDP-1 [563.137566] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.063s) [563.459914] Starting dynamic subtest: pipe-B-eDP-1 [564.249468] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.802s) [564.558802] Subtest plane-use-after-nonblocking-unbind: SUCCESS (1.484s) [565.460610] [126/134] (467s left) kms_atomic_interruptible (universal-setplane-primary) [565.550462] Starting subtest: universal-setplane-primary [565.552726] Starting dynamic subtest: pipe-A-eDP-1 [572.924829] Dynamic subtest pipe-A-eDP-1: SUCCESS (7.371s) [572.927150] Subtest universal-setplane-primary: SUCCESS (7.372s) [573.802076] [127/134] (458s left) kms_pm_backlight (fade-with-dpms) [573.903272] Starting subtest: fade-with-dpms [576.250359] Starting dynamic subtest: eDP-1 [578.920853] Dynamic subtest eDP-1: SUCCESS (2.668s) [578.922770] Subtest fade-with-dpms: SUCCESS (5.015s) [579.754295] [128/134] (452s left) perf_pmu (event-wait) [579.796043] Starting subtest: event-wait [579.798485] Starting dynamic subtest: rcs0 [579.803156] Dynamic subtest rcs0: SKIP (0.000s) [579.807708] Subtest event-wait: SKIP (0.001s) [579.949296] [129/134] (452s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-mmap-gtt) [580.056828] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-mmap-gtt [580.061430] Subtest fbc-2p-scndscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s) [580.189116] [130/134] (452s left) gem_exec_whisper (basic-contexts-all) [580.254131] Starting subtest: basic-contexts-all [589.825279] Subtest basic-contexts-all: SUCCESS (9.566s) [590.030712] [131/134] (442s left) gem_spin_batch (spin-each) [590.091568] Starting subtest: spin-each [593.420583] Subtest spin-each: SUCCESS (3.268s) [593.890482] [132/134] (438s left) kms_universal_plane (disable-primary-vs-flip) [593.999215] Starting subtest: disable-primary-vs-flip [594.001608] Starting dynamic subtest: pipe-A-eDP-1 [595.503670] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.503s) [595.515871] Starting dynamic subtest: pipe-B-eDP-1 [597.688443] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.183s) [597.699554] Starting dynamic subtest: pipe-C-eDP-1 [599.935561] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.246s) [599.947036] Starting dynamic subtest: pipe-D-eDP-1 [602.109508] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.173s) [602.111843] Subtest disable-primary-vs-flip: SUCCESS (8.112s) [602.936058] [133/134] (429s left) gem_exec_schedule (preemptive-hang) [603.118677] Starting subtest: preemptive-hang [603.120995] Starting dynamic subtest: rcs0 [612.030807] Dynamic subtest rcs0: SUCCESS (8.914s) [612.042681] Starting dynamic subtest: bcs0 [620.936077] Dynamic subtest bcs0: SUCCESS (8.905s) [620.948639] Starting dynamic subtest: vcs0 [629.962145] Dynamic subtest vcs0: SUCCESS (9.023s) [629.976034] Starting dynamic subtest: vcs1 [638.924628] Dynamic subtest vcs1: SUCCESS (8.957s) [638.939159] Starting dynamic subtest: vecs0 [647.948966] Dynamic subtest vecs0: SUCCESS (9.021s) [647.962616] Starting dynamic subtest: ccs0 [656.971502] Dynamic subtest ccs0: SUCCESS (9.031s) [656.974097] Subtest preemptive-hang: SUCCESS (53.863s) [657.263779] [134/134] (375s left) syncobj_wait (invalid-signal-bad-pad) [657.324526] Starting subtest: invalid-signal-bad-pad [657.326953] Subtest invalid-signal-bad-pad: SUCCESS (0.000s) [657.436896] 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.