[59.517067] Initializing watchdogs [59.517112] /dev/watchdog0 [59.532129] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:7d55 Intel Meteorlake (Gen12) Meteor Lake-P [Intel Arc Graphics] [59.536562] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [59.539045] [FACT before any test] new: kernel.kmod_is_loaded.i915: true [59.542558] [001/131] (960s left) kms_cursor_edge_walk (128x128-left-edge) [59.674052] Starting subtest: 128x128-left-edge [59.676536] Starting dynamic subtest: pipe-A-eDP-1 [63.167782] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.497s) [63.175091] Starting dynamic subtest: pipe-D-eDP-1 [66.310359] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.141s) [66.312757] Subtest 128x128-left-edge: SUCCESS (6.640s) [67.157987] [002/131] (952s left) prime_mmap (test_refcounting) [67.305441] Starting subtest: test_refcounting [67.307874] Starting dynamic subtest: test_refcounting-smem [67.374919] Dynamic subtest test_refcounting-smem: SUCCESS (0.070s) [67.377529] Subtest test_refcounting: SUCCESS (0.071s) [67.660737] [003/131] (952s left) gem_exec_fence (syncobj-invalid-flags) [68.199102] Starting subtest: syncobj-invalid-flags [68.201412] Subtest syncobj-invalid-flags: SUCCESS (0.000s) [69.986794] [FACT gem_exec_fence (syncobj-invalid-flags)] new: kernel.kmod_is_loaded.vgem: true [69.989731] [004/131] (950s left) gem_reg_read (timestamp-moving) [70.038734] Starting subtest: timestamp-moving [71.041110] Subtest timestamp-moving: SUCCESS (1.001s) [71.133204] [005/131] (949s left) kms_color (ctm-0-50) [71.232913] Starting subtest: ctm-0-50 [71.234954] Starting dynamic subtest: pipe-A-eDP-1 [74.753049] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.520s) [74.761676] Starting dynamic subtest: pipe-B-eDP-1 [79.017488] Dynamic subtest pipe-B-eDP-1: SUCCESS (4.265s) [79.026279] Starting dynamic subtest: pipe-C-eDP-1 [83.075517] Dynamic subtest pipe-C-eDP-1: SUCCESS (4.057s) [83.084306] Starting dynamic subtest: pipe-D-eDP-1 [87.060288] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.985s) [87.062634] Subtest ctm-0-50: SUCCESS (15.828s) [87.881236] [006/131] (932s left) gem_exec_whisper (basic-forked-all) [87.944374] Starting subtest: basic-forked-all [101.098747] Subtest basic-forked-all: SUCCESS (13.156s) [101.286741] [007/131] (919s left) gem_spin_batch (spin-each) [101.359669] Starting subtest: spin-each [104.730093] Subtest spin-each: SUCCESS (3.370s) [104.996952] [008/131] (915s left) sriov_basic (bind-unbind-vf) [105.054851] Starting subtest: bind-unbind-vf [105.057258] Starting dynamic subtest: vf-1 [105.129694] Dynamic subtest vf-1: FAIL (0.017s) [105.139573] Starting dynamic subtest: vf-2 [105.212091] Dynamic subtest vf-2: FAIL (0.004s) [105.219570] Starting dynamic subtest: vf-3 [105.290742] Dynamic subtest vf-3: FAIL (0.004s) [105.298608] Starting dynamic subtest: vf-4 [105.367148] Dynamic subtest vf-4: FAIL (0.004s) [105.374934] Starting dynamic subtest: vf-5 [105.444171] Dynamic subtest vf-5: FAIL (0.004s) [105.451657] Starting dynamic subtest: vf-6 [105.520969] Dynamic subtest vf-6: FAIL (0.004s) [105.529401] Starting dynamic subtest: vf-7 [105.601456] Dynamic subtest vf-7: FAIL (0.005s) [105.610865] Starting dynamic subtest: vf-random [105.682923] Dynamic subtest vf-random: FAIL (0.004s) [105.692106] Starting dynamic subtest: vf-last [105.763800] Dynamic subtest vf-last: FAIL (0.482s) [105.766259] Subtest bind-unbind-vf: FAIL (0.530s) [105.804385] [009/131] (914s left) gem_mmap_gtt (basic-short) [105.865875] Subtest basic-short: SKIP (0.000s) [105.935815] [010/131] (914s left) kms_psr (psr2-sprite-mmap-gtt) [106.020200] Starting subtest: psr2-sprite-mmap-gtt [106.022053] Starting dynamic subtest: eDP-1 [107.481977] Dynamic subtest eDP-1: SKIP (1.457s) [107.486859] Subtest psr2-sprite-mmap-gtt: SKIP (1.458s) [107.638671] [011/131] (912s left) kms_psr (fbc-pr-sprite-plane-onoff) [107.732578] Starting subtest: fbc-pr-sprite-plane-onoff [107.736877] Subtest fbc-pr-sprite-plane-onoff: SKIP (0.000s) [107.803268] [012/131] (912s left) kms_plane_scaling (plane-upscale-factor-0-25-with-rotation) [107.895563] Starting subtest: plane-upscale-factor-0-25-with-rotation [107.897756] Starting dynamic subtest: pipe-A [108.121221] Dynamic subtest pipe-A: SUCCESS (0.227s) [108.128696] Starting dynamic subtest: pipe-B [109.385638] Dynamic subtest pipe-B: SUCCESS (1.263s) [109.398061] Starting dynamic subtest: pipe-C [110.713752] Dynamic subtest pipe-C: SUCCESS (1.327s) [110.722550] Starting dynamic subtest: pipe-D [112.046902] Dynamic subtest pipe-D: SUCCESS (1.332s) [112.049201] Subtest plane-upscale-factor-0-25-with-rotation: SUCCESS (4.153s) [113.227976] [013/131] (907s left) kms_cursor_crc (cursor-onscreen-max-size) [113.515669] Starting subtest: cursor-onscreen-max-size [113.522346] Subtest cursor-onscreen-max-size: SKIP (0.000s) [113.664147] [014/131] (906s left) gem_render_copy (y-tiled-ccs-to-y-tiled-ccs) [113.722093] Starting subtest: y-tiled-ccs-to-y-tiled-ccs [113.726588] Subtest y-tiled-ccs-to-y-tiled-ccs: SKIP (0.000s) [113.918856] [015/131] (906s left) gem_vm_create (execbuf) [113.985705] Starting subtest: execbuf [113.992332] Subtest execbuf: SUCCESS (0.007s) [114.131684] [016/131] (906s left) kms_plane_scaling (plane-downscale-factor-0-5-with-modifiers) [114.220348] Starting subtest: plane-downscale-factor-0-5-with-modifiers [114.222701] Starting dynamic subtest: pipe-A [114.244519] Dynamic subtest pipe-A: SKIP (0.018s) [114.252143] Starting dynamic subtest: pipe-B [114.276543] Dynamic subtest pipe-B: SKIP (0.031s) [114.284390] Starting dynamic subtest: pipe-C [114.306522] Dynamic subtest pipe-C: SKIP (0.032s) [114.313901] Starting dynamic subtest: pipe-D [114.338112] Dynamic subtest pipe-D: SKIP (0.032s) [114.341879] Subtest plane-downscale-factor-0-5-with-modifiers: SKIP (0.114s) [114.434321] [017/131] (906s left) perf (global-sseu-config-invalid) [114.565343] Starting subtest: global-sseu-config-invalid [114.569025] Subtest global-sseu-config-invalid: SKIP (0.000s) [114.606452] [018/131] (906s left) kms_big_fb (linear-max-hw-stride-32bpp-rotate-180-hflip) [114.707063] Starting subtest: linear-max-hw-stride-32bpp-rotate-180-hflip [114.711474] Subtest linear-max-hw-stride-32bpp-rotate-180-hflip: SKIP (0.000s) [114.812972] [019/131] (906s left) kms_psr (fbc-pr-cursor-mmap-gtt) [114.901525] Starting subtest: fbc-pr-cursor-mmap-gtt [114.905157] Subtest fbc-pr-cursor-mmap-gtt: SKIP (0.000s) [114.972077] [020/131] (905s left) gem_mmap_gtt (basic-small-copy-xy) [115.032531] Subtest basic-small-copy-XY: SKIP (0.000s) [115.086647] [021/131] (905s left) i915_suspend (forcewake) [115.142635] Starting subtest: forcewake [147.418996] Subtest forcewake: SUCCESS (3.100s) [148.491536] [022/131] (873s left) core_setmaster (master-drop-set-user) [148.574110] Starting subtest: master-drop-set-user [148.587667] Subtest master-drop-set-user: SUCCESS (0.014s) [148.626799] [023/131] (873s left) kms_content_protection (legacy-hdcp14) [148.779418] Starting subtest: legacy-hdcp14 [148.783893] Subtest legacy-hdcp14: SKIP (0.000s) [148.916502] [024/131] (873s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-move) [149.017259] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-move [149.021643] Subtest fbcpsr-2p-scndscrn-cur-indfb-move: SKIP (0.000s) [149.120511] [025/131] (872s left) kms_flip (dpms-vs-vblank-race) [149.218410] Starting subtest: dpms-vs-vblank-race [149.220630] Starting dynamic subtest: A-eDP1 [154.145499] Dynamic subtest A-eDP1: SUCCESS (4.923s) [154.155272] Starting dynamic subtest: B-eDP1 [158.771567] Dynamic subtest B-eDP1: SUCCESS (4.624s) [158.780741] Starting dynamic subtest: C-eDP1 [163.382065] Dynamic subtest C-eDP1: SUCCESS (4.608s) [163.390758] Starting dynamic subtest: D-eDP1 [168.000297] Dynamic subtest D-eDP1: SUCCESS (4.614s) [168.002692] Subtest dpms-vs-vblank-race: SUCCESS (18.777s) [168.870434] [026/131] (853s left) gem_exec_schedule (manyslice) [168.945341] Starting subtest: manyslice [168.947311] Starting dynamic subtest: rcs0 [174.084693] Dynamic subtest rcs0: SUCCESS (5.145s) [174.102191] Starting dynamic subtest: bcs0 [180.209183] Dynamic subtest bcs0: SUCCESS (6.121s) [180.217749] Starting dynamic subtest: vcs0 [186.308412] Dynamic subtest vcs0: SUCCESS (6.099s) [186.319284] Starting dynamic subtest: vcs1 [192.384213] Dynamic subtest vcs1: SUCCESS (6.075s) [192.395792] Starting dynamic subtest: vecs0 [197.970590] Dynamic subtest vecs0: SUCCESS (5.584s) [197.983074] Starting dynamic subtest: ccs0 [203.640622] Dynamic subtest ccs0: SUCCESS (5.669s) [203.643273] Subtest manyslice: SUCCESS (34.703s) [203.949700] [027/131] (818s left) i915_drm_fdinfo (busy-idle) [203.999340] Starting subtest: busy-idle [204.001606] Starting dynamic subtest: rcs0 [204.016419] Dynamic subtest rcs0: SKIP (0.017s) [204.026753] Starting dynamic subtest: bcs0 [204.031388] Dynamic subtest bcs0: SKIP (0.011s) [204.039414] Starting dynamic subtest: vcs0 [204.043609] Dynamic subtest vcs0: SKIP (0.000s) [204.051629] Starting dynamic subtest: vcs1 [204.056106] Dynamic subtest vcs1: SKIP (0.000s) [204.064043] Starting dynamic subtest: vecs0 [204.068201] Dynamic subtest vecs0: SKIP (0.000s) [204.075811] Starting dynamic subtest: ccs0 [204.079906] Dynamic subtest ccs0: SKIP (0.000s) [204.084057] Subtest busy-idle: SKIP (0.033s) [204.120039] [028/131] (818s left) gem_ctx_persistence (heartbeat-many) [204.181211] Starting subtest: heartbeat-many [204.185814] Subtest heartbeat-many: SKIP (0.000s) [204.300888] [029/131] (817s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-indfb-draw-blt) [204.395194] Starting subtest: fbc-1p-offscreen-pri-indfb-draw-blt [208.544503] Subtest fbc-1p-offscreen-pri-indfb-draw-blt: SUCCESS (4.152s) [209.679236] [030/131] (812s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-pwrite) [209.782878] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-pwrite [219.162309] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-pwrite: SUCCESS (9.380s) [219.306622] [031/131] (803s left) kms_flip (bo-too-big) [219.409607] Starting subtest: bo-too-big [219.412019] Starting dynamic subtest: A-eDP1 [220.733756] Dynamic subtest A-eDP1: SUCCESS (1.323s) [220.742399] Starting dynamic subtest: B-eDP1 [222.077726] Dynamic subtest B-eDP1: SUCCESS (1.342s) [222.089612] Starting dynamic subtest: C-eDP1 [223.420058] Dynamic subtest C-eDP1: SUCCESS (1.341s) [223.430444] Starting dynamic subtest: D-eDP1 [224.743510] Dynamic subtest D-eDP1: SUCCESS (1.322s) [224.746465] Subtest bo-too-big: SUCCESS (5.337s) [225.957362] [032/131] (796s left) fbdev (nullptr) [226.023294] Starting subtest: nullptr [226.025523] Subtest nullptr: SUCCESS (0.000s) [226.090035] [033/131] (796s left) kms_flip (2x-dpms-vs-vblank-race-interruptible) [226.182043] Starting subtest: 2x-dpms-vs-vblank-race-interruptible [226.193425] Subtest 2x-dpms-vs-vblank-race-interruptible: SKIP (0.010s) [226.286285] [034/131] (796s left) vgem_basic (dmabuf-export) [226.335666] Starting subtest: dmabuf-export [226.363105] Subtest dmabuf-export: SUCCESS (0.026s) [226.466005] [035/131] (796s left) gem_exec_await (wide-all) [226.668123] Starting subtest: wide-all [249.977164] Subtest wide-all: SUCCESS (23.303s) [250.182507] [036/131] (772s left) kms_fb_coherency (memset-crc) [250.323103] Starting subtest: memset-crc [250.325544] Starting dynamic subtest: mmap-offset-wc [250.771616] Dynamic subtest mmap-offset-wc: SUCCESS (0.447s) [251.073471] Starting dynamic subtest: mmap-offset-uc [257.277186] Dynamic subtest mmap-offset-uc: SUCCESS (6.210s) [257.568376] Subtest memset-crc: SUCCESS (7.245s) [258.409812] [037/131] (764s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-fullscreen) [258.512051] Starting subtest: psr-2p-primscrn-spr-indfb-fullscreen [258.516215] Subtest psr-2p-primscrn-spr-indfb-fullscreen: SKIP (0.000s) [258.617358] [038/131] (764s left) syncobj_wait (wait-all-for-submit-complex) [258.690277] Starting subtest: wait-all-for-submit-complex [258.905697] Subtest wait-all-for-submit-complex: SUCCESS (0.214s) [258.993258] [039/131] (763s left) kms_vblank (wait-forked-hang) [259.088824] Starting subtest: wait-forked-hang [259.091158] Starting dynamic subtest: pipe-A-eDP-1 [285.848175] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.755s) [285.861755] Starting dynamic subtest: pipe-D-eDP-1 [310.860624] Dynamic subtest pipe-D-eDP-1: SUCCESS (25.005s) [310.862570] Subtest wait-forked-hang: SUCCESS (51.768s) [311.724730] [040/131] (711s left) perf (gen8-unprivileged-single-ctx-counters) [311.840575] Starting subtest: gen8-unprivileged-single-ctx-counters [311.845276] Subtest gen8-unprivileged-single-ctx-counters: SKIP (0.000s) [311.891939] [041/131] (710s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-mmap-gtt) [311.985696] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-mmap-gtt [311.989654] Subtest fbc-2p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s) [312.085493] [042/131] (710s left) i915_pm_rpm (sysfs-read) [314.212984] Starting subtest: sysfs-read [315.359167] Subtest sysfs-read: SUCCESS (1.148s) [315.728964] [043/131] (707s left) kms_flip (2x-flip-vs-dpms-on-nop-interruptible) [315.818521] Starting subtest: 2x-flip-vs-dpms-on-nop-interruptible [315.830409] Subtest 2x-flip-vs-dpms-on-nop-interruptible: SKIP (0.011s) [315.907729] [044/131] (707s left) kms_ccs (bad-rotation-90-y-tiled-gen12-mc-ccs) [316.011923] Starting subtest: bad-rotation-90-y-tiled-gen12-mc-ccs [316.014056] Starting dynamic subtest: pipe-A-eDP-1 [316.035997] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [316.046551] Starting dynamic subtest: pipe-B-eDP-1 [316.067120] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [316.075821] Starting dynamic subtest: pipe-C-eDP-1 [316.097069] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [316.107502] Starting dynamic subtest: pipe-D-eDP-1 [316.129397] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [316.133408] Subtest bad-rotation-90-y-tiled-gen12-mc-ccs: SKIP (0.004s) [318.270843] [045/131] (704s left) gem_mmap_gtt (basic-read-write-distinct) [318.336275] Subtest basic-read-write-distinct: SKIP (0.000s) [318.392283] [046/131] (704s left) kms_pm_dc (dc5-psr) [319.488374] Starting subtest: dc5-psr [322.374731] Subtest dc5-psr: SUCCESS (2.886s) [323.208715] [047/131] (699s left) kms_async_flips (alternate-sync-async-flip) [323.309349] Starting subtest: alternate-sync-async-flip [323.683640] Starting dynamic subtest: pipe-A-eDP-1 [326.493122] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.811s) [326.876264] Starting dynamic subtest: pipe-B-eDP-1 [329.611373] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.743s) [329.980699] Starting dynamic subtest: pipe-C-eDP-1 [332.741427] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.768s) [333.112044] Starting dynamic subtest: pipe-D-eDP-1 [335.873681] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.771s) [335.875668] Subtest alternate-sync-async-flip: SUCCESS (12.567s) [337.041419] [048/131] (686s left) gem_ctx_isolation (preservation-reset) [337.221317] Starting subtest: preservation-reset [337.223912] Starting dynamic subtest: rcs0 [337.496273] Dynamic subtest rcs0: SUCCESS (0.275s) [337.506624] Starting dynamic subtest: bcs0 [337.802266] Dynamic subtest bcs0: SUCCESS (0.305s) [337.811862] Starting dynamic subtest: vcs0 [338.100653] Dynamic subtest vcs0: SUCCESS (0.297s) [338.113851] Starting dynamic subtest: vcs1 [339.330912] Dynamic subtest vcs1: SUCCESS (1.229s) [339.342888] Starting dynamic subtest: vecs0 [341.325118] Dynamic subtest vecs0: SUCCESS (1.993s) [341.337657] Starting dynamic subtest: ccs0 [343.321219] Dynamic subtest ccs0: SUCCESS (1.994s) [343.323993] Subtest preservation-reset: SUCCESS (6.102s) [343.451289] [049/131] (679s left) gem_create (create-ext-placement-each) [343.634300] Starting subtest: create-ext-placement-each [343.636846] Subtest create-ext-placement-each: SUCCESS (0.000s) [343.726818] [050/131] (679s left) kms_psr (pr-cursor-mmap-gtt) [343.836313] Starting subtest: pr-cursor-mmap-gtt [343.840737] Subtest pr-cursor-mmap-gtt: SKIP (0.000s) [343.910628] [051/131] (679s left) kms_chamelium_hpd (vga-hpd-fast) [344.298742] Subtest vga-hpd-fast: SKIP (0.000s) [345.150223] [052/131] (678s left) syncobj_timeline (invalid-query-illegal-handle) [345.206377] Starting subtest: invalid-query-illegal-handle [345.208778] Subtest invalid-query-illegal-handle: SUCCESS (0.000s) [345.317471] [053/131] (678s left) syncobj_basic (bad-pad-fd-to-handle) [345.382407] Starting subtest: bad-pad-fd-to-handle [345.384319] Subtest bad-pad-fd-to-handle: SUCCESS (0.000s) [345.490811] [054/131] (677s left) kms_psr (fbc-psr-primary-render) [345.589764] Starting subtest: fbc-psr-primary-render [345.591881] Starting dynamic subtest: eDP-1 [345.595839] Dynamic subtest eDP-1: SKIP (0.000s) [345.599801] Subtest fbc-psr-primary-render: SKIP (0.001s) [345.665235] [055/131] (677s left) gem_exec_balancer (smoke) [345.726069] Starting subtest: smoke [368.314867] Subtest smoke: SUCCESS (22.586s) [370.102831] [056/131] (653s left) gem_exec_nop (basic-parallel) [370.170800] Starting subtest: basic-parallel [386.053769] Subtest basic-parallel: SUCCESS (15.890s) [386.279704] [057/131] (637s left) kms_ccs (bad-aux-stride-yf-tiled-ccs) [386.377033] Starting subtest: bad-aux-stride-yf-tiled-ccs [386.379306] Starting dynamic subtest: pipe-A-eDP-1 [386.401193] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [386.412409] Starting dynamic subtest: pipe-B-eDP-1 [386.432427] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [386.441170] Starting dynamic subtest: pipe-C-eDP-1 [386.462670] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [386.473217] Starting dynamic subtest: pipe-D-eDP-1 [386.493947] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [386.498020] Subtest bad-aux-stride-yf-tiled-ccs: SKIP (0.006s) [388.619625] [058/131] (634s left) kms_psr2_sf (fbc-pr-overlay-primary-update-sf-dmg-area) [388.727633] Starting subtest: fbc-pr-overlay-primary-update-sf-dmg-area [388.731944] Subtest fbc-pr-overlay-primary-update-sf-dmg-area: SKIP (0.000s) [388.809558] [059/131] (634s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-mmap-gtt) [388.901136] Starting subtest: psr-2p-primscrn-cur-indfb-draw-mmap-gtt [388.905309] Subtest psr-2p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s) [388.997840] [060/131] (634s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-move) [389.104413] Starting subtest: fbc-2p-scndscrn-cur-indfb-move [389.108434] Subtest fbc-2p-scndscrn-cur-indfb-move: SKIP (0.000s) [389.200102] [061/131] (634s left) kms_ccs (crc-primary-suspend-yf-tiled-ccs) [389.295066] Starting subtest: crc-primary-suspend-yf-tiled-ccs [389.297221] Starting dynamic subtest: pipe-A-eDP-1 [389.305855] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [389.316331] Starting dynamic subtest: pipe-B-eDP-1 [389.324933] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [389.334370] Starting dynamic subtest: pipe-C-eDP-1 [389.342376] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [389.350990] Starting dynamic subtest: pipe-D-eDP-1 [389.359197] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [389.363030] Subtest crc-primary-suspend-yf-tiled-ccs: SKIP (0.005s) [391.591915] [062/131] (632s left) gem_readwrite (read-write) [391.659982] Subtest read-write: SKIP (0.000s) [391.716721] [063/131] (632s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-mmap-cpu) [391.805658] Starting subtest: fbcpsr-rgb565-draw-mmap-cpu [398.598491] Subtest fbcpsr-rgb565-draw-mmap-cpu: SUCCESS (6.796s) [398.715763] [064/131] (625s left) kms_invalid_mode (zero-clock) [398.809727] Starting subtest: zero-clock [398.811951] Starting dynamic subtest: pipe-A-eDP-1 [399.095498] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.288s) [399.105062] Starting dynamic subtest: pipe-B-eDP-1 [399.107079] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s) [399.115592] Starting dynamic subtest: pipe-C-eDP-1 [399.117920] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s) [399.127315] Starting dynamic subtest: pipe-D-eDP-1 [399.129192] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s) [399.131185] Subtest zero-clock: SUCCESS (0.295s) [399.935922] [065/131] (623s left) gem_fenced_exec_thrash (no-spare-fences-interruptible) [400.002883] Subtest no-spare-fences-interruptible: SKIP (0.000s) [400.084379] [066/131] (623s left) gem_mmap_gtt (basic-write-cpu-read-gtt) [400.136910] Subtest basic-write-cpu-read-gtt: SKIP (0.000s) [400.206769] [067/131] (623s left) sysfs_heartbeat_interval (precise) [400.265753] Starting subtest: precise [400.267992] Starting dynamic subtest: vecs0 [408.064330] Dynamic subtest vecs0: SUCCESS (7.794s) [408.075686] Starting dynamic subtest: ccs0 [409.221428] Dynamic subtest ccs0: SUCCESS (1.157s) [409.232773] Starting dynamic subtest: vcs0 [417.085876] Dynamic subtest vcs0: SUCCESS (7.864s) [417.097882] Starting dynamic subtest: bcs0 [418.243167] Dynamic subtest bcs0: SUCCESS (1.152s) [418.254025] Starting dynamic subtest: rcs0 [419.401332] Dynamic subtest rcs0: SUCCESS (1.158s) [419.412112] Starting dynamic subtest: vcs1 [427.080282] Dynamic subtest vcs1: SUCCESS (7.677s) [427.082792] Subtest precise: SUCCESS (26.814s) [427.173702] [068/131] (596s left) kms_psr2_sf (pr-overlay-primary-update-sf-dmg-area) [427.269564] Starting subtest: pr-overlay-primary-update-sf-dmg-area [427.273698] Subtest pr-overlay-primary-update-sf-dmg-area: SKIP (0.000s) [427.340027] [069/131] (596s left) kms_legacy_colorkey (basic) [427.434192] Starting subtest: basic [427.436356] Starting dynamic subtest: pipe-A [427.477977] Dynamic subtest pipe-A: SUCCESS (0.045s) [427.490499] Starting dynamic subtest: pipe-B [427.492501] Dynamic subtest pipe-B: SUCCESS (0.001s) [427.506301] Starting dynamic subtest: pipe-C [427.508237] Dynamic subtest pipe-C: SUCCESS (0.000s) [427.516810] Starting dynamic subtest: pipe-D [427.518748] Dynamic subtest pipe-D: SUCCESS (0.000s) [427.520654] Subtest basic: SUCCESS (0.051s) [427.558729] [070/131] (596s left) gem_exec_schedule (submit-golden-slice) [427.644438] Starting subtest: submit-golden-slice [427.646636] Starting dynamic subtest: rcs0 [427.671447] Dynamic subtest rcs0: SUCCESS (0.036s) [427.683396] Starting dynamic subtest: bcs0 [427.715025] Dynamic subtest bcs0: SUCCESS (0.043s) [427.725178] Starting dynamic subtest: vcs0 [427.752859] Dynamic subtest vcs0: SUCCESS (0.037s) [427.765896] Starting dynamic subtest: vcs1 [427.791691] Dynamic subtest vcs1: SUCCESS (0.037s) [427.802326] Starting dynamic subtest: vecs0 [427.827956] Dynamic subtest vecs0: SUCCESS (0.035s) [427.838028] Starting dynamic subtest: ccs0 [427.866911] Dynamic subtest ccs0: SUCCESS (0.038s) [427.869205] Subtest submit-golden-slice: SUCCESS (0.232s) [429.158003] [071/131] (594s left) kms_plane_alpha_blend (alpha-transparent-fb) [429.253293] Starting subtest: alpha-transparent-fb [429.543625] Starting dynamic subtest: pipe-A-eDP-1 [430.147610] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.603s) [430.157969] Starting dynamic subtest: pipe-D-eDP-1 [431.510638] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.359s) [431.512978] Subtest alpha-transparent-fb: SUCCESS (2.257s) [432.327788] [072/131] (591s left) gem_exec_balancer (bonded-false-hang) [432.607115] Starting subtest: bonded-false-hang [432.612905] Subtest bonded-false-hang: SKIP (0.000s) [432.715551] [073/131] (591s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-0-async-flip) [432.835335] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-0-async-flip [432.839992] Subtest yf-tiled-max-hw-stride-64bpp-rotate-0-async-flip: SKIP (0.000s) [432.927633] [074/131] (591s left) kms_big_fb (4-tiled-64bpp-rotate-0) [433.038088] Starting subtest: 4-tiled-64bpp-rotate-0 [434.551365] Subtest 4-tiled-64bpp-rotate-0: SUCCESS (1.513s) [434.750859] [075/131] (589s left) syncobj_wait (invalid-multi-wait-unsubmitted) [434.807058] Starting subtest: invalid-multi-wait-unsubmitted [434.809343] Subtest invalid-multi-wait-unsubmitted: SUCCESS (0.000s) [434.902673] [076/131] (589s left) kms_atomic_interruptible (universal-setplane-primary) [434.997681] Starting subtest: universal-setplane-primary [434.999931] Starting dynamic subtest: pipe-A-eDP-1 [442.432353] Dynamic subtest pipe-A-eDP-1: SUCCESS (7.432s) [442.434831] Subtest universal-setplane-primary: SUCCESS (7.434s) [443.263059] [077/131] (581s left) kms_flip (nonexisting-fb) [443.360596] Starting subtest: nonexisting-fb [443.362848] Starting dynamic subtest: A-eDP1 [444.554829] Dynamic subtest A-eDP1: SUCCESS (1.193s) [444.565327] Starting dynamic subtest: B-eDP1 [445.687877] Dynamic subtest B-eDP1: SUCCESS (1.131s) [445.707002] Starting dynamic subtest: C-eDP1 [446.819691] Dynamic subtest C-eDP1: SUCCESS (1.129s) [446.830384] Starting dynamic subtest: D-eDP1 [447.951382] Dynamic subtest D-eDP1: SUCCESS (1.129s) [447.956618] Subtest nonexisting-fb: SUCCESS (4.597s) [449.122554] [078/131] (575s left) gem_softpin (evict-active-interruptible) [449.202805] Starting subtest: evict-active-interruptible [449.206212] Subtest evict-active-interruptible: SUCCESS (0.006s) [449.324830] [079/131] (575s left) kms_plane (pixel-format-y-tiled-gen12-mc-ccs-modifier) [449.420286] Starting subtest: pixel-format-y-tiled-gen12-mc-ccs-modifier [449.424360] Subtest pixel-format-y-tiled-gen12-mc-ccs-modifier: SKIP (0.000s) [449.508011] [080/131] (574s left) kms_psr (psr-suspend) [449.607232] Starting subtest: psr-suspend [449.609539] Starting dynamic subtest: eDP-1 [467.847548] Dynamic subtest eDP-1: SUCCESS (2.919s) [467.849767] Subtest psr-suspend: SUCCESS (2.920s) [468.713650] [081/131] (555s left) kms_frontbuffer_tracking (psr-rgb565-draw-mmap-cpu) [468.811412] Starting subtest: psr-rgb565-draw-mmap-cpu [475.579819] Subtest psr-rgb565-draw-mmap-cpu: SUCCESS (6.767s) [475.710213] [082/131] (548s left) gem_userptr_blits (stress-mm) [475.779597] Starting subtest: stress-mm [481.153357] Subtest stress-mm: SUCCESS (5.369s) [481.293784] [083/131] (543s left) syncobj_timeline (etime-single-wait-available-unsubmitted) [481.353650] Starting subtest: etime-single-wait-available-unsubmitted [481.459170] Subtest etime-single-wait-available-unsubmitted: SUCCESS (0.104s) [481.534070] [084/131] (543s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-downscaling) [481.640804] Starting subtest: flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-downscaling [481.645451] Subtest flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-downscaling: SKIP (0.000s) [481.710410] [085/131] (543s left) gem_lmem_swapping (basic) [481.755790] Subtest basic: SKIP (0.000s) [481.800931] [086/131] (542s left) gem_exec_reloc (basic-range) [481.872982] Subtest basic-range: SKIP (0.000s) [481.948089] [087/131] (542s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-pwrite) [482.043726] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-pwrite [482.048022] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-pwrite: SKIP (0.000s) [482.143597] [088/131] (542s left) gem_exec_params (mmapped) [482.211003] Starting subtest: mmapped [482.216332] Subtest mmapped: SUCCESS (0.003s) [482.345187] [089/131] (542s left) kms_atomic_transition (plane-use-after-nonblocking-unbind-fencing) [482.440587] Starting subtest: plane-use-after-nonblocking-unbind-fencing [482.442812] Starting dynamic subtest: pipe-A-eDP-1 [482.502035] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.062s) [482.816372] Starting dynamic subtest: pipe-B-eDP-1 [483.619268] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.815s) [483.917320] Subtest plane-use-after-nonblocking-unbind-fencing: SUCCESS (1.476s) [484.814721] [090/131] (540s left) kms_addfb_basic (bad-pitch-999) [484.863315] Starting subtest: bad-pitch-999 [484.865387] Subtest bad-pitch-999: SUCCESS (0.000s) [485.006625] [091/131] (539s left) gem_pxp (reject-modify-context-protection-off-1) [485.126684] Starting subtest: reject-modify-context-protection-off-1 [485.128890] Subtest reject-modify-context-protection-off-1: SUCCESS (0.002s) [485.242673] [092/131] (539s left) api_intel_allocator (gem-pool) [485.303273] Starting subtest: gem-pool [485.309791] Subtest gem-pool: SUCCESS (0.008s) [485.441220] [093/131] (539s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-mmap-cpu) [485.537897] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-mmap-cpu [489.746287] Subtest fbc-1p-primscrn-pri-shrfb-draw-mmap-cpu: SUCCESS (4.209s) [490.896281] [094/131] (534s left) kms_chamelium_color (degamma) [490.990242] Subtest degamma: SKIP (0.000s) [491.035321] [095/131] (534s left) kms_big_fb (y-tiled-64bpp-rotate-180) [491.132100] Starting subtest: y-tiled-64bpp-rotate-180 [491.136597] Subtest y-tiled-64bpp-rotate-180: SKIP (0.000s) [491.231549] [096/131] (533s left) kms_cursor_crc (cursor-random-128x128) [491.450041] Starting subtest: cursor-random-128x128 [491.452230] Starting dynamic subtest: pipe-A-eDP-1 [494.863724] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.408s) [494.895883] Starting dynamic subtest: pipe-D-eDP-1 [498.888293] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.998s) [498.890259] Subtest cursor-random-128x128: SUCCESS (7.434s) [499.747211] [097/131] (525s left) kms_plane_multiple (tiling-4) [499.850403] Starting subtest: tiling-4 [499.852659] Starting dynamic subtest: pipe-A-eDP-1 [503.588567] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.739s) [503.598603] Starting dynamic subtest: pipe-B-eDP-1 [508.015635] Dynamic subtest pipe-B-eDP-1: SUCCESS (4.427s) [508.025727] Starting dynamic subtest: pipe-C-eDP-1 [512.375308] Dynamic subtest pipe-C-eDP-1: SUCCESS (4.357s) [512.385520] Starting dynamic subtest: pipe-D-eDP-1 [516.707874] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.332s) [516.710323] Subtest tiling-4: SUCCESS (16.860s) [517.528874] [098/131] (507s left) kms_rotation_crc (primary-x-tiled-reflect-x-180) [517.630093] Starting subtest: primary-x-tiled-reflect-x-180 [524.591998] Subtest primary-x-tiled-reflect-x-180: SUCCESS (6.962s) [525.780343] [099/131] (499s left) gem_lmem_swapping (parallel-random-verify) [525.824021] Subtest parallel-random-verify: SKIP (0.000s) [525.879601] [100/131] (499s left) kms_chamelium_color (ctm-0-50) [525.982340] Subtest ctm-0-50: SKIP (0.000s) [526.028064] [101/131] (499s left) kms_addfb_basic (invalid-set-prop) [526.084580] Starting subtest: invalid-set-prop [526.086473] Subtest invalid-set-prop: SUCCESS (0.000s) [526.220359] [102/131] (499s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-mmap-gtt) [526.319673] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-mmap-gtt [526.323869] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s) [526.428279] [103/131] (499s left) api_intel_bb (render-ccs) [526.492926] Starting subtest: render-ccs [526.861611] Subtest render-ccs: SUCCESS (0.369s) [526.944059] [104/131] (498s left) gem_mmap_wc (bad-object) [527.004832] Subtest bad-object: SKIP (0.000s) [527.067931] [105/131] (498s left) gem_render_copy (y-tiled-ccs-to-x-tiled) [527.142025] Starting subtest: y-tiled-ccs-to-x-tiled [527.146584] Subtest y-tiled-ccs-to-x-tiled: SKIP (0.000s) [527.321345] [106/131] (498s left) kms_flip (2x-flip-vs-fences-interruptible) [527.420711] Starting subtest: 2x-flip-vs-fences-interruptible [527.424954] Subtest 2x-flip-vs-fences-interruptible: SKIP (0.000s) [527.531640] [107/131] (498s left) kms_ccs (bad-aux-stride-4-tiled-mtl-rc-ccs-cc) [527.630560] Starting subtest: bad-aux-stride-4-tiled-mtl-rc-ccs-cc [527.632869] Starting dynamic subtest: pipe-A-eDP-1 [527.653171] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s) [527.664249] Starting dynamic subtest: pipe-B-eDP-1 [527.683893] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s) [527.693473] Starting dynamic subtest: pipe-C-eDP-1 [527.713119] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s) [527.722619] Starting dynamic subtest: pipe-D-eDP-1 [527.741623] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s) [527.743690] Subtest bad-aux-stride-4-tiled-mtl-rc-ccs-cc: SUCCESS (0.008s) [529.873010] [108/131] (495s left) syncobj_timeline (single-wait-available-signaled) [529.939291] Starting subtest: single-wait-available-signaled [529.941603] Subtest single-wait-available-signaled: SUCCESS (0.000s) [530.053848] [109/131] (495s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-180-hflip) [530.164919] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-180-hflip [531.189585] Subtest x-tiled-max-hw-stride-64bpp-rotate-180-hflip: SUCCESS (1.023s) [531.322323] [110/131] (494s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-move) [531.419580] Starting subtest: fbc-2p-primscrn-cur-indfb-move [531.423162] Subtest fbc-2p-primscrn-cur-indfb-move: SKIP (0.000s) [531.515207] [111/131] (494s left) gem_mmap_offset (clear) [531.568747] Starting subtest: clear [531.570692] Starting dynamic subtest: smem0 [555.254196] Dynamic subtest smem0: SUCCESS (23.678s) [555.256673] Subtest clear: SUCCESS (23.680s) [555.379346] [112/131] (470s left) gem_mmap_gtt (big-bo) [555.481325] Subtest big-bo: SKIP (0.000s) [555.535969] [113/131] (470s left) kms_pm_rpm (modeset-lpsp-stress-no-wait) [557.513893] Starting subtest: modeset-lpsp-stress-no-wait [567.199134] Subtest modeset-lpsp-stress-no-wait: SUCCESS (9.685s) [567.277050] [114/131] (458s left) i915_getparams_basic (basic-eu-total) [567.330606] Starting subtest: basic-eu-total [567.334699] Subtest basic-eu-total: SUCCESS (0.000s) [567.422230] [115/131] (458s left) syncobj_wait (multi-wait-all-signaled) [567.475306] Starting subtest: multi-wait-all-signaled [567.477663] Subtest multi-wait-all-signaled: SUCCESS (0.000s) [567.553121] [116/131] (458s left) kms_rotation_crc (sprite-rotation-270) [567.649040] Starting subtest: sprite-rotation-270 [567.653308] Subtest sprite-rotation-270: SKIP (0.001s) [567.721872] [117/131] (458s left) kms_atomic_transition (modeset-transition-nonblocking-fencing) [567.830948] Starting subtest: modeset-transition-nonblocking-fencing [567.833299] Starting dynamic subtest: 1x-outputs [578.961751] Dynamic subtest 1x-outputs: SUCCESS (11.127s) [578.964367] Subtest modeset-transition-nonblocking-fencing: SUCCESS (11.129s) [579.823200] [118/131] (446s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-pwrite) [579.927574] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-pwrite [579.931744] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-pwrite: SKIP (0.000s) [580.025946] [119/131] (446s left) kms_big_fb (linear-32bpp-rotate-180) [580.124308] Starting subtest: linear-32bpp-rotate-180 [581.724629] Subtest linear-32bpp-rotate-180: SUCCESS (1.601s) [581.859086] [120/131] (444s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-move) [581.953404] Starting subtest: psr-2p-primscrn-spr-indfb-move [581.957022] Subtest psr-2p-primscrn-spr-indfb-move: SKIP (0.000s) [582.046961] [121/131] (444s left) kms_universal_plane (cursor-fb-leak) [582.130804] Starting subtest: cursor-fb-leak [582.132629] Starting dynamic subtest: pipe-A-eDP-1 [582.481045] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.351s) [582.495598] Starting dynamic subtest: pipe-B-eDP-1 [583.866602] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.381s) [583.880582] Starting dynamic subtest: pipe-C-eDP-1 [585.165854] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.297s) [585.178329] Starting dynamic subtest: pipe-D-eDP-1 [586.489499] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.321s) [586.491857] Subtest cursor-fb-leak: SUCCESS (4.360s) [587.658247] [122/131] (438s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-indfb-draw-mmap-wc) [587.764958] Starting subtest: psr-1p-offscreen-pri-indfb-draw-mmap-wc [594.468207] Subtest psr-1p-offscreen-pri-indfb-draw-mmap-wc: SUCCESS (6.703s) [594.586625] [123/131] (431s left) kms_flip (flip-vs-panning) [594.694128] Starting subtest: flip-vs-panning [594.696469] Starting dynamic subtest: A-eDP1 [603.391289] Dynamic subtest A-eDP1: SUCCESS (8.697s) [603.404477] Starting dynamic subtest: B-eDP1 [612.117719] Dynamic subtest B-eDP1: SUCCESS (8.721s) [612.133615] Starting dynamic subtest: C-eDP1 [620.853269] Dynamic subtest C-eDP1: SUCCESS (8.731s) [620.863604] Starting dynamic subtest: D-eDP1 [629.588421] Dynamic subtest D-eDP1: SUCCESS (8.732s) [629.592583] Subtest flip-vs-panning: SUCCESS (34.893s) [630.760418] [124/131] (395s left) syncobj_timeline (multi-wait-available-unsubmitted-submitted-signaled) [630.813646] Starting subtest: multi-wait-available-unsubmitted-submitted-signaled [630.815922] Subtest multi-wait-available-unsubmitted-submitted-signaled: SUCCESS (0.000s) [630.912260] [125/131] (395s left) kms_dither (fb-8bpc-vs-panel-8bpc) [631.009583] Starting subtest: fb-8bpc-vs-panel-8bpc [631.011754] Starting dynamic subtest: pipe-A-eDP-1 [632.452554] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.443s) [632.454834] Subtest fb-8bpc-vs-panel-8bpc: SUCCESS (1.444s) [633.320952] [126/131] (393s left) gen9_exec_parse (basic-rejected-ctx-param) [633.390810] Subtest basic-rejected-ctx-param: SKIP (0.000s) [633.467637] [127/131] (393s left) syncobj_wait (multi-wait-for-submit-unsubmitted-submitted-signaled) [633.526546] Starting subtest: multi-wait-for-submit-unsubmitted-submitted-signaled [633.528751] Subtest multi-wait-for-submit-unsubmitted-submitted-signaled: SUCCESS (0.000s) [633.621602] [128/131] (392s left) kms_ccs (crc-sprite-planes-basic-y-tiled-gen12-rc-ccs-cc) [633.717422] Starting subtest: crc-sprite-planes-basic-y-tiled-gen12-rc-ccs-cc [633.719821] Starting dynamic subtest: pipe-A-eDP-1 [633.777250] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s) [633.790021] Starting dynamic subtest: pipe-B-eDP-1 [633.845605] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s) [633.859125] Starting dynamic subtest: pipe-C-eDP-1 [633.916227] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s) [633.927320] Starting dynamic subtest: pipe-D-eDP-1 [633.982726] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s) [633.986966] Subtest crc-sprite-planes-basic-y-tiled-gen12-rc-ccs-cc: SKIP (0.010s) [635.897147] [129/131] (390s left) syncobj_timeline (etime-multi-wait-all-available-unsubmitted-signaled) [635.946584] Starting subtest: etime-multi-wait-all-available-unsubmitted-signaled [636.050796] Subtest etime-multi-wait-all-available-unsubmitted-signaled: SUCCESS (0.103s) [636.127895] [130/131] (390s left) perf_pmu (render-node-busy-idle) [636.206122] Starting subtest: render-node-busy-idle [636.208531] Starting dynamic subtest: rcs0 [636.908456] Dynamic subtest rcs0: SUCCESS (0.702s) [636.921384] Starting dynamic subtest: bcs0 [637.580496] Dynamic subtest bcs0: SUCCESS (0.669s) [637.593591] Starting dynamic subtest: vcs0 [639.390910] Dynamic subtest vcs0: SUCCESS (1.806s) [639.405074] Starting dynamic subtest: vcs1 [640.110638] Dynamic subtest vcs1: FAIL (0.666s) [640.122648] Starting dynamic subtest: vecs0 [642.061025] Dynamic subtest vecs0: FAIL (1.936s) [642.072390] Starting dynamic subtest: ccs0 [644.108229] Dynamic subtest ccs0: FAIL (2.046s) [644.110584] Subtest render-node-busy-idle: FAIL (7.836s) [644.152702] [131/131] (382s left) kms_frontbuffer_tracking (fbcpsr-slowdraw) [644.274036] Starting subtest: fbcpsr-slowdraw [669.541459] Subtest fbcpsr-slowdraw: SUCCESS (25.264s) [669.703322] Closing watchdogs results: parsing output: 0/ for test: kms_cursor_edge_walk results: parsing output: 1/ for test: prime_mmap results: parsing output: 2/ for test: gem_exec_fence results: parsing output: 3/ for test: gem_reg_read results: parsing output: 4/ for test: kms_color results: parsing output: 5/ for test: gem_exec_whisper results: parsing output: 6/ for test: gem_spin_batch results: parsing output: 7/ for test: sriov_basic results: parsing output: 8/ for test: gem_mmap_gtt results: parsing output: 9/ for test: kms_psr results: parsing output: 10/ for test: kms_psr results: parsing output: 11/ for test: kms_plane_scaling results: parsing output: 12/ for test: kms_cursor_crc results: parsing output: 13/ for test: gem_render_copy results: parsing output: 14/ for test: gem_vm_create results: parsing output: 15/ for test: kms_plane_scaling results: parsing output: 16/ for test: perf results: parsing output: 17/ for test: kms_big_fb results: parsing output: 18/ for test: kms_psr results: parsing output: 19/ for test: gem_mmap_gtt results: parsing output: 20/ for test: i915_suspend results: parsing output: 21/ for test: core_setmaster results: parsing output: 22/ for test: kms_content_protection results: parsing output: 23/ for test: kms_frontbuffer_tracking results: parsing output: 24/ for test: kms_flip results: parsing output: 25/ for test: gem_exec_schedule results: parsing output: 26/ for test: i915_drm_fdinfo results: parsing output: 27/ for test: gem_ctx_persistence results: parsing output: 28/ for test: kms_frontbuffer_tracking results: parsing output: 29/ for test: kms_frontbuffer_tracking results: parsing output: 30/ for test: kms_flip results: parsing output: 31/ for test: fbdev results: parsing output: 32/ for test: kms_flip results: parsing output: 33/ for test: vgem_basic results: parsing output: 34/ for test: gem_exec_await results: parsing output: 35/ for test: kms_fb_coherency results: parsing output: 36/ for test: kms_frontbuffer_tracking results: parsing output: 37/ for test: syncobj_wait results: parsing output: 38/ for test: kms_vblank results: parsing output: 39/ for test: perf results: parsing output: 40/ for test: kms_frontbuffer_tracking results: parsing output: 41/ for test: i915_pm_rpm results: parsing output: 42/ for test: kms_flip results: parsing output: 43/ for test: kms_ccs results: parsing output: 44/ for test: gem_mmap_gtt results: parsing output: 45/ for test: kms_pm_dc results: parsing output: 46/ for test: kms_async_flips results: parsing output: 47/ for test: gem_ctx_isolation results: parsing output: 48/ for test: gem_create results: parsing output: 49/ for test: kms_psr results: parsing output: 50/ for test: kms_chamelium_hpd results: parsing output: 51/ for test: syncobj_timeline results: parsing output: 52/ for test: syncobj_basic results: parsing output: 53/ for test: kms_psr results: parsing output: 54/ for test: gem_exec_balancer results: parsing output: 55/ for test: gem_exec_nop results: parsing output: 56/ for test: kms_ccs results: parsing output: 57/ for test: kms_psr2_sf 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_ccs results: parsing output: 61/ for test: gem_readwrite results: parsing output: 62/ for test: kms_frontbuffer_tracking results: parsing output: 63/ for test: kms_invalid_mode results: parsing output: 64/ for test: gem_fenced_exec_thrash results: parsing output: 65/ for test: gem_mmap_gtt results: parsing output: 66/ for test: sysfs_heartbeat_interval results: parsing output: 67/ for test: kms_psr2_sf results: parsing output: 68/ for test: kms_legacy_colorkey results: parsing output: 69/ for test: gem_exec_schedule results: parsing output: 70/ for test: kms_plane_alpha_blend results: parsing output: 71/ for test: gem_exec_balancer results: parsing output: 72/ for test: kms_big_fb results: parsing output: 73/ for test: kms_big_fb results: parsing output: 74/ for test: syncobj_wait results: parsing output: 75/ for test: kms_atomic_interruptible results: parsing output: 76/ for test: kms_flip results: parsing output: 77/ for test: gem_softpin results: parsing output: 78/ for test: kms_plane results: parsing output: 79/ for test: kms_psr results: parsing output: 80/ for test: kms_frontbuffer_tracking results: parsing output: 81/ for test: gem_userptr_blits results: parsing output: 82/ for test: syncobj_timeline results: parsing output: 83/ for test: kms_flip_scaled_crc results: parsing output: 84/ for test: gem_lmem_swapping results: parsing output: 85/ for test: gem_exec_reloc results: parsing output: 86/ for test: kms_frontbuffer_tracking results: parsing output: 87/ for test: gem_exec_params results: parsing output: 88/ for test: kms_atomic_transition results: parsing output: 89/ for test: kms_addfb_basic results: parsing output: 90/ for test: gem_pxp results: parsing output: 91/ for test: api_intel_allocator results: parsing output: 92/ for test: kms_frontbuffer_tracking results: parsing output: 93/ for test: kms_chamelium_color results: parsing output: 94/ for test: kms_big_fb results: parsing output: 95/ for test: kms_cursor_crc results: parsing output: 96/ for test: kms_plane_multiple results: parsing output: 97/ for test: kms_rotation_crc results: parsing output: 98/ for test: gem_lmem_swapping results: parsing output: 99/ for test: kms_chamelium_color results: parsing output: 100/ for test: kms_addfb_basic results: parsing output: 101/ for test: kms_frontbuffer_tracking results: parsing output: 102/ for test: api_intel_bb results: parsing output: 103/ for test: gem_mmap_wc results: parsing output: 104/ for test: gem_render_copy results: parsing output: 105/ for test: kms_flip results: parsing output: 106/ for test: kms_ccs results: parsing output: 107/ for test: syncobj_timeline results: parsing output: 108/ for test: kms_big_fb results: parsing output: 109/ for test: kms_frontbuffer_tracking results: parsing output: 110/ for test: gem_mmap_offset results: parsing output: 111/ for test: gem_mmap_gtt results: parsing output: 112/ for test: kms_pm_rpm results: parsing output: 113/ for test: i915_getparams_basic results: parsing output: 114/ for test: syncobj_wait results: parsing output: 115/ for test: kms_rotation_crc results: parsing output: 116/ for test: kms_atomic_transition results: parsing output: 117/ for test: kms_frontbuffer_tracking results: parsing output: 118/ for test: kms_big_fb results: parsing output: 119/ for test: kms_frontbuffer_tracking results: parsing output: 120/ for test: kms_universal_plane results: parsing output: 121/ for test: kms_frontbuffer_tracking results: parsing output: 122/ for test: kms_flip results: parsing output: 123/ for test: syncobj_timeline results: parsing output: 124/ for test: kms_dither results: parsing output: 125/ for test: gen9_exec_parse results: parsing output: 126/ for test: syncobj_wait results: parsing output: 127/ for test: kms_ccs results: parsing output: 128/ for test: syncobj_timeline results: parsing output: 129/ for test: perf_pmu results: parsing output: 130/ for test: kms_frontbuffer_tracking Done.