[58.721617] Initializing watchdogs [58.721666] /dev/watchdog0 [58.735586] [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.740132] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [58.742302] [FACT before any test] new: kernel.kmod_is_loaded.i915: true [58.745656] [001/131] (960s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-180-async-flip) [58.890627] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-180-async-flip [58.895170] Subtest y-tiled-max-hw-stride-64bpp-rotate-180-async-flip: SKIP (0.002s) [59.018614] [002/131] (960s left) gem_exec_fence (submit3) [59.207886] Starting subtest: submit3 [59.212445] Subtest submit3: SKIP (0.000s) [61.014921] [FACT gem_exec_fence (submit3)] new: kernel.kmod_is_loaded.vgem: true [61.019439] [003/131] (958s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-mmap-gtt) [61.149665] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-mmap-gtt [61.153753] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s) [61.304842] [004/131] (958s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-mmap-wc) [61.414564] Starting subtest: fbc-rgb101010-draw-mmap-wc [66.008207] Subtest fbc-rgb101010-draw-mmap-wc: SUCCESS (4.596s) [67.203717] [005/131] (952s left) gem_exec_balancer (noheartbeat) [67.627384] Starting subtest: noheartbeat [67.632662] Subtest noheartbeat: SKIP (0.000s) [67.741163] [006/131] (951s left) kms_chamelium_color (ctm-blue-to-red) [67.844526] Subtest ctm-blue-to-red: SKIP (0.000s) [67.922041] [007/131] (951s left) gem_workarounds (suspend-resume) [68.103756] Starting subtest: suspend-resume [84.602656] Subtest suspend-resume: SUCCESS (4.890s) [84.814817] [008/131] (934s left) kms_plane_scaling (planes-downscale-factor-0-75-unity-scaling) [84.929023] Starting subtest: planes-downscale-factor-0-75-unity-scaling [84.931550] Starting dynamic subtest: pipe-A [84.992380] Dynamic subtest pipe-A: SUCCESS (0.065s) [85.001683] Starting dynamic subtest: pipe-B [86.187998] Dynamic subtest pipe-B: SUCCESS (1.194s) [86.199750] Starting dynamic subtest: pipe-C [87.302441] Dynamic subtest pipe-C: SUCCESS (1.113s) [87.312356] Starting dynamic subtest: pipe-D [88.426540] Dynamic subtest pipe-D: SUCCESS (1.123s) [88.428836] Subtest planes-downscale-factor-0-75-unity-scaling: SUCCESS (3.497s) [89.610965] [009/131] (930s left) gem_pxp (create-regular-buffer) [89.738961] Starting subtest: create-regular-buffer [89.741217] Subtest create-regular-buffer: SUCCESS (0.000s) [89.867579] [010/131] (929s left) gem_exec_params (rel-constants-invalid-rel-gen5) [89.930388] Starting subtest: rel-constants-invalid-rel-gen5 [89.932825] Subtest rel-constants-invalid-rel-gen5: SUCCESS (0.000s) [90.065740] [011/131] (929s left) gem_exec_nop (basic-series) [90.151890] Starting subtest: basic-series [106.482339] Subtest basic-series: SUCCESS (16.334s) [106.743293] [012/131] (913s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-mmap-wc) [106.857201] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-mmap-wc [106.861731] Subtest fbc-2p-primscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s) [106.983638] [013/131] (912s left) kms_psr (fbc-psr-primary-page-flip) [107.079492] Starting subtest: fbc-psr-primary-page-flip [107.081723] Starting dynamic subtest: eDP-1 [107.086111] Dynamic subtest eDP-1: SKIP (0.000s) [107.090465] Subtest fbc-psr-primary-page-flip: SKIP (0.000s) [107.190557] [014/131] (912s left) i915_pm_rps (engine-order) [107.251687] Starting subtest: engine-order [112.308489] Subtest engine-order: SUCCESS (5.055s) [112.484453] [015/131] (907s left) gem_softpin (evict-active) [112.552849] Starting subtest: evict-active [112.562170] Subtest evict-active: SUCCESS (0.009s) [112.728833] [016/131] (907s left) syncobj_timeline (wait-delayed-signal) [112.791990] Starting subtest: wait-delayed-signal [112.895776] Subtest wait-delayed-signal: SUCCESS (0.103s) [113.005157] [017/131] (907s left) kms_panel_fitting (atomic-fastset) [113.106875] Starting subtest: atomic-fastset [113.109254] Starting dynamic subtest: pipe-A-eDP-1 [113.246035] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.141s) [113.257716] Starting dynamic subtest: pipe-B-eDP-1 [114.446930] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.201s) [114.458336] Starting dynamic subtest: pipe-C-eDP-1 [115.633010] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.183s) [115.643576] Starting dynamic subtest: pipe-D-eDP-1 [116.771162] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.138s) [116.773568] Subtest atomic-fastset: SUCCESS (3.665s) [118.042490] [018/131] (902s left) kms_big_fb (x-tiled-16bpp-rotate-270) [118.154185] Starting subtest: x-tiled-16bpp-rotate-270 [118.174017] Subtest x-tiled-16bpp-rotate-270: SKIP (0.019s) [118.335134] [019/131] (901s left) api_intel_bb (render-ccs) [118.402935] Starting subtest: render-ccs [118.764825] Subtest render-ccs: SUCCESS (0.361s) [118.902935] [020/131] (901s left) kms_ccs (crc-primary-rotation-180-y-tiled-gen12-rc-ccs-cc) [118.999163] Starting subtest: crc-primary-rotation-180-y-tiled-gen12-rc-ccs-cc [119.001479] Starting dynamic subtest: pipe-A-eDP-1 [119.027558] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [119.037200] Starting dynamic subtest: pipe-B-eDP-1 [119.058251] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [119.066972] Starting dynamic subtest: pipe-C-eDP-1 [119.087815] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [119.096112] Starting dynamic subtest: pipe-D-eDP-1 [119.117951] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [119.122063] Subtest crc-primary-rotation-180-y-tiled-gen12-rc-ccs-cc: SKIP (0.004s) [121.293091] [021/131] (898s left) syncobj_wait (multi-wait-all-for-submit-unsubmitted-signaled) [121.353287] Starting subtest: multi-wait-all-for-submit-unsubmitted-signaled [121.458193] Subtest multi-wait-all-for-submit-unsubmitted-signaled: SUCCESS (0.104s) [121.560104] [022/131] (898s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-move) [121.668794] Starting subtest: psr-2p-primscrn-cur-indfb-move [121.673429] Subtest psr-2p-primscrn-cur-indfb-move: SKIP (0.000s) [121.805087] [023/131] (898s left) gem_lmem_swapping (heavy-multi) [121.848091] Subtest heavy-multi: SKIP (0.000s) [121.889754] [024/131] (898s left) kms_async_flips (test-cursor) [121.987911] Starting subtest: test-cursor [121.992070] Subtest test-cursor: SKIP (0.000s) [123.215165] [025/131] (897s left) kms_psr2_sf (fbc-psr2-overlay-plane-move-continuous-exceed-sf) [128.304396] Starting subtest: fbc-psr2-overlay-plane-move-continuous-exceed-sf [128.306821] Starting dynamic subtest: pipe-A-eDP-1 [129.100558] Dynamic subtest pipe-A-eDP-1: SKIP (0.792s) [129.110199] Starting dynamic subtest: pipe-B-eDP-1 [130.225188] Dynamic subtest pipe-B-eDP-1: SKIP (1.123s) [130.229584] Subtest fbc-psr2-overlay-plane-move-continuous-exceed-sf: SKIP (1.919s) [131.441356] [026/131] (888s left) kms_plane_multiple (2x-tiling-4) [131.552588] Starting subtest: 2x-tiling-4 [131.556998] Subtest 2x-tiling-4: SKIP (0.000s) [131.646244] [027/131] (888s left) gem_ctx_param (invalid-param-set) [131.697700] Starting subtest: invalid-param-set [131.700042] Subtest invalid-param-set: SUCCESS (0.000s) [131.792676] [028/131] (888s left) kms_ccs (bad-pixel-format-y-tiled-ccs) [131.897355] Starting subtest: bad-pixel-format-y-tiled-ccs [131.899663] Starting dynamic subtest: pipe-A-eDP-1 [131.922720] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [131.934094] Starting dynamic subtest: pipe-B-eDP-1 [131.956160] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [131.965493] Starting dynamic subtest: pipe-C-eDP-1 [131.987336] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [131.996233] Starting dynamic subtest: pipe-D-eDP-1 [132.018395] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [132.022452] Subtest bad-pixel-format-y-tiled-ccs: SKIP (0.003s) [134.209327] [029/131] (886s left) kms_plane_scaling (plane-downscale-factor-0-5-with-modifiers) [134.314853] Starting subtest: plane-downscale-factor-0-5-with-modifiers [134.317111] Starting dynamic subtest: pipe-A [134.336324] Dynamic subtest pipe-A: SKIP (0.017s) [134.347594] Starting dynamic subtest: pipe-B [134.367357] Dynamic subtest pipe-B: SKIP (0.032s) [134.377792] Starting dynamic subtest: pipe-C [134.401868] Dynamic subtest pipe-C: SKIP (0.034s) [134.410985] Starting dynamic subtest: pipe-D [134.437233] Dynamic subtest pipe-D: SKIP (0.033s) [134.441364] Subtest plane-downscale-factor-0-5-with-modifiers: SKIP (0.118s) [134.553965] [030/131] (886s left) syncobj_timeline (multi-wait-all-available-submitted-signaled) [134.612791] Starting subtest: multi-wait-all-available-submitted-signaled [134.615048] Subtest multi-wait-all-available-submitted-signaled: SUCCESS (0.000s) [134.729917] [031/131] (885s left) perf (missing-sample-flags) [134.859264] Starting subtest: missing-sample-flags [134.861540] Subtest missing-sample-flags: SUCCESS (0.000s) [134.902809] [032/131] (885s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-pwrite) [134.996331] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-pwrite [141.264424] Subtest fbc-1p-primscrn-pri-shrfb-draw-pwrite: SUCCESS (6.271s) [142.399161] [033/131] (878s left) kms_pm_rpm (system-suspend-idle) [144.656744] Starting subtest: system-suspend-idle [164.133890] Subtest system-suspend-idle: SUCCESS (4.621s) [164.537625] [034/131] (856s left) kms_vblank (wait-forked) [164.636652] Starting subtest: wait-forked [164.638934] Starting dynamic subtest: pipe-A-eDP-1 [166.461200] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.821s) [166.476508] Starting dynamic subtest: pipe-D-eDP-1 [168.996457] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.532s) [168.999100] Subtest wait-forked: SUCCESS (4.356s) [169.899647] [035/131] (850s left) kms_big_fb (y-tiled-32bpp-rotate-0) [170.001064] Starting subtest: y-tiled-32bpp-rotate-0 [170.005750] Subtest y-tiled-32bpp-rotate-0: SKIP (0.000s) [170.116543] [036/131] (850s left) kms_pipe_crc_basic (read-crc) [170.207044] Starting subtest: read-crc [170.208986] Starting dynamic subtest: pipe-A-eDP-1 [170.920419] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.712s) [170.938900] Starting dynamic subtest: pipe-B-eDP-1 [172.347036] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.423s) [172.358428] Starting dynamic subtest: pipe-C-eDP-1 [173.709896] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.362s) [173.719889] Starting dynamic subtest: pipe-D-eDP-1 [175.054591] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.343s) [175.057142] Subtest read-crc: SUCCESS (4.846s) [175.906017] [037/131] (844s left) kms_cursor_legacy (single-move) [176.041534] Starting subtest: single-move [176.043942] Starting dynamic subtest: pipe-A [181.478094] Dynamic subtest pipe-A: SUCCESS (5.378s) [181.489420] Starting dynamic subtest: pipe-B [186.863045] Dynamic subtest pipe-B: SUCCESS (5.381s) [186.875031] Starting dynamic subtest: pipe-C [192.245042] Dynamic subtest pipe-C: SUCCESS (5.380s) [192.256896] Starting dynamic subtest: pipe-D [197.626772] Dynamic subtest pipe-D: SUCCESS (5.380s) [197.637598] Starting dynamic subtest: all-pipes [203.014638] Dynamic subtest all-pipes: SUCCESS (5.387s) [203.017049] Subtest single-move: SUCCESS (26.914s) [203.133075] [038/131] (817s left) kms_psr2_sf (pr-overlay-plane-move-continuous-exceed-sf) [208.183404] Starting subtest: pr-overlay-plane-move-continuous-exceed-sf [208.187874] Subtest pr-overlay-plane-move-continuous-exceed-sf: SKIP (0.002s) [209.077814] [039/131] (811s left) gem_unref_active_buffers [209.341137] [040/131] (811s left) kms_psr (fbc-psr2-primary-mmap-gtt) [209.434964] Starting subtest: fbc-psr2-primary-mmap-gtt [209.437161] Starting dynamic subtest: eDP-1 [209.441164] Dynamic subtest eDP-1: SKIP (0.000s) [209.445225] Subtest fbc-psr2-primary-mmap-gtt: SKIP (0.001s) [209.535675] [041/131] (811s left) syncobj_wait (invalid-signal-zero-handles) [209.604178] Starting subtest: invalid-signal-zero-handles [209.606511] Subtest invalid-signal-zero-handles: SUCCESS (0.000s) [209.743129] [042/131] (811s left) gen9_exec_parse (bb-oversize) [209.801318] Subtest bb-oversize: SKIP (0.000s) [209.884068] [043/131] (811s left) syncobj_timeline (etime-multi-wait-all-for-submit-available-unsubmitted) [209.938894] Starting subtest: etime-multi-wait-all-for-submit-available-unsubmitted [210.040230] Subtest etime-multi-wait-all-for-submit-available-unsubmitted: SUCCESS (0.101s) [210.139135] [044/131] (811s left) gem_exec_reloc (basic-write-cpu-noreloc) [210.209033] Subtest basic-write-cpu-noreloc: SKIP (0.000s) [210.303184] [045/131] (810s left) gem_mmap_offset (bad-flags) [210.361471] Starting subtest: bad-flags [210.363203] Subtest bad-flags: SUCCESS (0.000s) [210.491582] [046/131] (810s left) kms_cursor_legacy (cursor-vs-flip-legacy) [210.611960] Starting subtest: cursor-vs-flip-legacy [239.920291] Subtest cursor-vs-flip-legacy: SUCCESS (29.304s) [240.810979] [047/131] (780s left) kms_rotation_crc (sprite-rotation-90-pos-100-0) [240.919144] Starting subtest: sprite-rotation-90-pos-100-0 [240.923267] Subtest sprite-rotation-90-pos-100-0: SKIP (0.001s) [241.016764] [048/131] (780s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-0-hflip) [241.116725] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-0-hflip [242.128899] Subtest x-tiled-max-hw-stride-64bpp-rotate-0-hflip: SUCCESS (1.011s) [242.310138] [049/131] (779s left) gem_create (busy-create) [242.377594] Starting subtest: busy-create [242.379682] Starting dynamic subtest: smem0 [276.446046] Dynamic subtest smem0: SUCCESS (34.065s) [276.448528] Subtest busy-create: SUCCESS (34.066s) [276.659511] [050/131] (744s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-indfb-draw-render) [276.769324] Starting subtest: fbc-1p-offscreen-pri-indfb-draw-render [280.935732] Subtest fbc-1p-offscreen-pri-indfb-draw-render: SUCCESS (4.170s) [282.098977] [051/131] (739s left) perf (invalid-open-flags) [282.208307] Starting subtest: invalid-open-flags [282.210785] Subtest invalid-open-flags: SUCCESS (0.001s) [282.253611] [052/131] (739s left) perf (oa-formats) [282.361592] Starting subtest: oa-formats [282.364066] Starting dynamic subtest: 0-rcs0 [282.378482] Dynamic subtest 0-rcs0: SUCCESS (0.017s) [282.389018] Starting dynamic subtest: 1-vcs0 [282.401068] Dynamic subtest 1-vcs0: SUCCESS (0.022s) [282.403314] Subtest oa-formats: SUCCESS (0.040s) [282.441235] [053/131] (739s left) kms_big_fb (4-tiled-8bpp-rotate-270) [282.547886] Starting subtest: 4-tiled-8bpp-rotate-270 [282.571323] Subtest 4-tiled-8bpp-rotate-270: SKIP (0.020s) [282.741521] [054/131] (738s left) kms_cursor_crc (cursor-onscreen-64x21) [282.922483] Starting subtest: cursor-onscreen-64x21 [282.974807] Subtest cursor-onscreen-64x21: SKIP (0.046s) [283.214290] [055/131] (738s left) kms_rotation_crc (primary-4-tiled-reflect-x-180) [283.301374] Starting subtest: primary-4-tiled-reflect-x-180 [290.376855] Subtest primary-4-tiled-reflect-x-180: SUCCESS (7.076s) [291.656644] [056/131] (730s left) kms_cursor_crc (cursor-onscreen-256x256) [291.891861] Starting subtest: cursor-onscreen-256x256 [291.896805] Starting dynamic subtest: pipe-A-eDP-1 [294.066120] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.169s) [294.119364] Starting dynamic subtest: pipe-D-eDP-1 [296.804916] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.692s) [296.807235] Subtest cursor-onscreen-256x256: SUCCESS (4.911s) [297.637593] [057/131] (724s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-shrfb-msflip-blt) [297.748250] Starting subtest: fbcpsr-1p-primscrn-shrfb-msflip-blt [305.117058] Subtest fbcpsr-1p-primscrn-shrfb-msflip-blt: SUCCESS (7.371s) [305.287750] [058/131] (716s left) kms_async_flips (async-flip-with-page-flip-events-tiled) [305.392510] Starting subtest: async-flip-with-page-flip-events-tiled [305.762482] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs [308.559991] Dynamic subtest pipe-A-eDP-1-4-rc-ccs: SUCCESS (2.742s) [308.571238] Starting dynamic subtest: pipe-A-eDP-1-4 [310.734389] Dynamic subtest pipe-A-eDP-1-4: SUCCESS (2.174s) [310.749962] Starting dynamic subtest: pipe-A-eDP-1-4 [312.691570] Dynamic subtest pipe-A-eDP-1-4: SUCCESS (2.008s) [312.701337] Starting dynamic subtest: pipe-A-eDP-1-x [314.934688] Dynamic subtest pipe-A-eDP-1-x: SUCCESS (2.190s) [315.263112] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs [318.087055] Dynamic subtest pipe-B-eDP-1-4-rc-ccs: SUCCESS (2.781s) [318.099496] Starting dynamic subtest: pipe-B-eDP-1-4 [320.262313] Dynamic subtest pipe-B-eDP-1-4: SUCCESS (2.174s) [320.272806] Starting dynamic subtest: pipe-B-eDP-1-4 [322.219502] Dynamic subtest pipe-B-eDP-1-4: SUCCESS (2.008s) [322.229712] Starting dynamic subtest: pipe-B-eDP-1-x [324.450509] Dynamic subtest pipe-B-eDP-1-x: SUCCESS (2.178s) [324.792937] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs [327.625439] Dynamic subtest pipe-C-eDP-1-4-rc-ccs: SUCCESS (2.787s) [327.639546] Starting dynamic subtest: pipe-C-eDP-1-4 [329.788340] Dynamic subtest pipe-C-eDP-1-4: SUCCESS (2.163s) [329.800237] Starting dynamic subtest: pipe-C-eDP-1-4 [331.748297] Dynamic subtest pipe-C-eDP-1-4: SUCCESS (2.009s) [331.759449] Starting dynamic subtest: pipe-C-eDP-1-x [333.926903] Dynamic subtest pipe-C-eDP-1-x: SUCCESS (2.178s) [334.289527] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs [337.103713] Dynamic subtest pipe-D-eDP-1-4-rc-ccs: SUCCESS (2.820s) [337.113951] Starting dynamic subtest: pipe-D-eDP-1-4 [339.320894] Dynamic subtest pipe-D-eDP-1-4: SUCCESS (2.163s) [339.337937] Starting dynamic subtest: pipe-D-eDP-1-4 [341.277722] Dynamic subtest pipe-D-eDP-1-4: SUCCESS (2.009s) [341.289435] Starting dynamic subtest: pipe-D-eDP-1-x [343.508902] Dynamic subtest pipe-D-eDP-1-x: SUCCESS (2.178s) [343.511351] Subtest async-flip-with-page-flip-events-tiled: SUCCESS (38.062s) [344.646398] [059/131] (677s left) perf (polling) [344.752125] Starting subtest: polling [344.754553] Starting dynamic subtest: 0-rcs0 [354.834843] Dynamic subtest 0-rcs0: SUCCESS (10.028s) [354.850502] Starting dynamic subtest: 1-vcs0 [364.858406] Dynamic subtest 1-vcs0: SUCCESS (10.019s) [364.860526] Subtest polling: SUCCESS (20.050s) [364.899176] [060/131] (656s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-mmap-wc) [365.024418] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-mmap-wc [365.028495] Subtest psr-2p-primscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s) [365.167063] [061/131] (656s left) syncobj_timeline (reset-signaled) [365.225275] Starting subtest: reset-signaled [365.227431] Subtest reset-signaled: SUCCESS (0.000s) [365.342964] [062/131] (656s left) kms_rmfb (rmfb-ioctl) [365.441705] Starting subtest: rmfb-ioctl [365.443850] Starting dynamic subtest: pipe-A-eDP-1 [365.545749] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.105s) [365.555663] Starting dynamic subtest: pipe-B-eDP-1 [366.756663] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.208s) [366.766944] Starting dynamic subtest: pipe-C-eDP-1 [367.881147] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.123s) [367.891713] Starting dynamic subtest: pipe-D-eDP-1 [369.015200] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.133s) [369.017479] Subtest rmfb-ioctl: SUCCESS (3.576s) [370.249615] [063/131] (651s left) gem_userptr_blits (create-destroy-sync) [370.316905] Starting subtest: create-destroy-sync [375.383780] Subtest create-destroy-sync: SUCCESS (5.015s) [375.502097] [064/131] (646s left) gem_exec_reloc (basic-gtt-cpu-active) [375.576425] Subtest basic-gtt-cpu-active: SKIP (0.000s) [375.685312] [065/131] (646s left) api_intel_allocator (execbuf-with-allocator) [375.751414] Starting subtest: execbuf-with-allocator [375.758345] Subtest execbuf-with-allocator: SUCCESS (0.010s) [375.940257] [066/131] (646s left) kms_lease (cursor-implicit-plane) [376.044768] Starting subtest: cursor-implicit-plane [376.047088] Starting dynamic subtest: pipe-A-eDP-1 [376.504379] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.458s) [376.514283] Starting dynamic subtest: pipe-B-eDP-1 [377.642377] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.139s) [377.652543] Starting dynamic subtest: pipe-C-eDP-1 [378.732578] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.088s) [378.743093] Starting dynamic subtest: pipe-D-eDP-1 [379.865932] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.130s) [379.868540] Subtest cursor-implicit-plane: SUCCESS (3.822s) [380.766775] [067/131] (641s left) kms_cursor_legacy (cursora-vs-flipb-atomic-transitions-varying-size) [380.877395] Starting subtest: cursorA-vs-flipB-atomic-transitions-varying-size [380.881964] Subtest cursorA-vs-flipB-atomic-transitions-varying-size: SKIP (0.001s) [381.050203] [068/131] (641s left) syncobj_wait (invalid-signal-illegal-handle) [381.109713] Starting subtest: invalid-signal-illegal-handle [381.111647] Subtest invalid-signal-illegal-handle: SUCCESS (0.000s) [381.244148] [069/131] (641s left) kms_psr (psr-primary-blt) [381.341017] Starting subtest: psr-primary-blt [381.343276] Starting dynamic subtest: eDP-1 [383.027298] Dynamic subtest eDP-1: SUCCESS (1.684s) [383.029599] Subtest psr-primary-blt: SUCCESS (1.686s) [383.921855] [070/131] (638s left) kms_ccs (crc-sprite-planes-basic-y-tiled-gen12-rc-ccs) [384.028818] Starting subtest: crc-sprite-planes-basic-y-tiled-gen12-rc-ccs [384.031118] Starting dynamic subtest: pipe-A-eDP-1 [384.089159] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s) [384.100634] Starting dynamic subtest: pipe-B-eDP-1 [384.158577] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s) [384.169427] Starting dynamic subtest: pipe-C-eDP-1 [384.226691] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s) [384.237405] Starting dynamic subtest: pipe-D-eDP-1 [384.295156] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s) [384.299335] Subtest crc-sprite-planes-basic-y-tiled-gen12-rc-ccs: SKIP (0.009s) [386.305060] [071/131] (636s left) kms_psr (pr-primary-blt) [386.412053] Starting subtest: pr-primary-blt [386.416389] Subtest pr-primary-blt: SKIP (0.000s) [386.506040] [072/131] (635s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-move) [386.615339] Starting subtest: psr-2p-primscrn-spr-indfb-move [386.619482] Subtest psr-2p-primscrn-spr-indfb-move: SKIP (0.000s) [386.731256] [073/131] (635s left) kms_flip_scaled_crc (flip-64bpp-linear-to-16bpp-linear-downscaling) [386.825802] Starting subtest: flip-64bpp-linear-to-16bpp-linear-downscaling [386.828123] Starting dynamic subtest: pipe-A-default-mode [387.943773] Dynamic subtest pipe-A-default-mode: SKIP (1.116s) [387.948251] Subtest flip-64bpp-linear-to-16bpp-linear-downscaling: SKIP (1.117s) [388.127906] [074/131] (634s left) gem_exec_schedule (u-semaphore-noskip) [388.195691] Starting subtest: u-semaphore-noskip [388.584861] Subtest u-semaphore-noskip: SUCCESS (0.396s) [388.939949] [075/131] (633s left) i915_drm_fdinfo (memory-info-idle) [388.983053] Starting subtest: memory-info-idle [388.985338] Starting dynamic subtest: smem0 [389.046649] Dynamic subtest smem0: SUCCESS (0.064s) [389.049198] Subtest memory-info-idle: SUCCESS (0.065s) [389.145061] [076/131] (633s left) i915_selftest (live) [392.744349] Starting subtest: live [392.746796] Starting dynamic subtest: sanitycheck [397.244287] Dynamic subtest sanitycheck: SUCCESS (4.500s) [397.254764] Starting dynamic subtest: uncore [401.716083] Dynamic subtest uncore: SUCCESS (4.470s) [401.726417] Starting dynamic subtest: workarounds [404.963069] Dynamic subtest workarounds: SUCCESS (3.245s) [404.972569] Starting dynamic subtest: gt_engines [409.589185] Dynamic subtest gt_engines: SUCCESS (4.623s) [409.599379] Starting dynamic subtest: gt_timelines [425.616160] Dynamic subtest gt_timelines: SUCCESS (16.025s) [425.626729] Starting dynamic subtest: gt_contexts [430.130429] Dynamic subtest gt_contexts: SUCCESS (4.511s) [430.145937] Starting dynamic subtest: gt_lrc [436.415790] Dynamic subtest gt_lrc: SUCCESS (6.284s) [436.426884] Starting dynamic subtest: gt_mocs [439.631817] Dynamic subtest gt_mocs: SUCCESS (3.213s) [439.642062] Starting dynamic subtest: gt_pm [444.536367] Dynamic subtest gt_pm: SUCCESS (4.902s) [444.546591] Starting dynamic subtest: gt_heartbeat [449.015919] Dynamic subtest gt_heartbeat: SUCCESS (4.477s) [449.026032] Starting dynamic subtest: gt_tlb [458.499238] Dynamic subtest gt_tlb: SUCCESS (9.481s) [458.509694] Starting dynamic subtest: requests [470.004425] Dynamic subtest requests: SUCCESS (11.502s) [470.013003] Starting dynamic subtest: migrate [476.143151] Dynamic subtest migrate: SUCCESS (6.136s) [476.153624] Starting dynamic subtest: active [480.659907] Dynamic subtest active: SUCCESS (4.514s) [480.669466] Starting dynamic subtest: objects [485.499381] Dynamic subtest objects: SUCCESS (4.837s) [485.509548] Starting dynamic subtest: mman [490.482770] Dynamic subtest mman: SUCCESS (4.981s) [490.493497] Starting dynamic subtest: dmabuf [494.926799] Dynamic subtest dmabuf: SUCCESS (4.441s) [494.937362] Starting dynamic subtest: vma [499.350328] Dynamic subtest vma: SUCCESS (4.421s) [499.360726] Starting dynamic subtest: coherency [504.646712] Dynamic subtest coherency: SUCCESS (5.294s) [504.663231] Starting dynamic subtest: gtt [514.610158] Dynamic subtest gtt: SUCCESS (9.960s) [514.620535] Starting dynamic subtest: gem [522.235815] Dynamic subtest gem: SUCCESS (7.623s) [522.246111] Starting dynamic subtest: evict [527.837136] Dynamic subtest evict: SUCCESS (5.599s) [527.846880] Starting dynamic subtest: hugepages [538.944858] Dynamic subtest hugepages: SUCCESS (11.104s) [538.954852] Starting dynamic subtest: gem_contexts [568.218856] Dynamic subtest gem_contexts: SUCCESS (29.269s) [568.229132] Starting dynamic subtest: client [572.726643] Dynamic subtest client: SUCCESS (4.506s) [572.737130] Starting dynamic subtest: gem_migrate [577.239295] Dynamic subtest gem_migrate: SUCCESS (4.510s) [577.249533] Starting dynamic subtest: reset [580.158360] Dynamic subtest reset: SUCCESS (2.916s) [580.174349] Starting dynamic subtest: memory_region [584.644940] Dynamic subtest memory_region: SUCCESS (4.484s) [584.655425] Starting dynamic subtest: hangcheck [598.031989] Dynamic subtest hangcheck: SUCCESS (13.360s) [598.040589] Starting dynamic subtest: execlists [602.459230] Dynamic subtest execlists: SUCCESS (4.449s) [602.469357] Starting dynamic subtest: ring_submission [606.983902] Dynamic subtest ring_submission: SUCCESS (4.522s) [606.993342] Starting dynamic subtest: perf [611.435752] Dynamic subtest perf: SUCCESS (4.449s) [611.444282] Starting dynamic subtest: slpc [625.691872] Dynamic subtest slpc: SUCCESS (14.252s) [625.702013] Starting dynamic subtest: guc [629.679327] Dynamic subtest guc: SUCCESS (3.984s) [629.689802] Starting dynamic subtest: guc_multi_lrc [634.162882] Dynamic subtest guc_multi_lrc: SUCCESS (4.481s) [634.172890] Starting dynamic subtest: guc_hang [639.261720] Dynamic subtest guc_hang: SUCCESS (5.096s) [639.271762] Starting dynamic subtest: late_gt_pm [643.749043] Dynamic subtest late_gt_pm: SUCCESS (4.484s) [643.751899] Subtest live: SUCCESS (250.988s) [643.781367] [FACT i915_selftest (live)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [643.782116] [FACT i915_selftest (live)] deleted: kernel.kmod_is_loaded.i915: true [643.785205] [077/131] (378s left) gem_userptr_blits (nohangcheck) [645.365007] Starting subtest: nohangcheck [645.642607] Subtest nohangcheck: SUCCESS (0.277s) [645.728511] [FACT gem_userptr_blits (nohangcheck)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [645.729714] [FACT gem_userptr_blits (nohangcheck)] new: kernel.kmod_is_loaded.i915: true [645.733233] [078/131] (376s left) kms_ccs (crc-primary-basic-4-tiled-mtl-rc-ccs) [645.847135] Starting subtest: crc-primary-basic-4-tiled-mtl-rc-ccs [645.849417] Starting dynamic subtest: pipe-A-eDP-1 [646.668127] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.814s) [646.677861] Starting dynamic subtest: pipe-B-eDP-1 [648.308722] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.637s) [648.318278] Starting dynamic subtest: pipe-C-eDP-1 [649.811248] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.485s) [649.822895] Starting dynamic subtest: pipe-D-eDP-1 [651.341527] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.545s) [651.343643] Subtest crc-primary-basic-4-tiled-mtl-rc-ccs: SUCCESS (5.487s) [652.617800] [079/131] (370s left) gem_softpin (allocator-nopin) [652.685892] Starting subtest: allocator-nopin [652.778129] Subtest allocator-nopin: SUCCESS (0.094s) [652.930863] [080/131] (369s left) kms_draw_crc (draw-method-pwrite) [653.027992] Starting subtest: draw-method-pwrite [653.030175] Starting dynamic subtest: xrgb8888-untiled [653.582326] Dynamic subtest xrgb8888-untiled: SUCCESS (0.555s) [653.592076] Starting dynamic subtest: rgb565-untiled [654.060174] Dynamic subtest rgb565-untiled: SUCCESS (0.477s) [654.071476] Starting dynamic subtest: xrgb2101010-untiled [654.582308] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.521s) [654.591929] Starting dynamic subtest: xbgr16161616f-untiled [655.315172] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.732s) [655.324966] Starting dynamic subtest: xrgb8888-xtiled [657.060085] Dynamic subtest xrgb8888-xtiled: SUCCESS (1.744s) [657.070861] Starting dynamic subtest: rgb565-xtiled [658.148752] Dynamic subtest rgb565-xtiled: SUCCESS (1.087s) [658.158632] Starting dynamic subtest: xrgb2101010-xtiled [659.870867] Dynamic subtest xrgb2101010-xtiled: SUCCESS (1.722s) [659.883394] Starting dynamic subtest: xbgr16161616f-xtiled [663.048799] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (3.175s) [663.058214] Starting dynamic subtest: xrgb8888-4tiled [664.093025] Dynamic subtest xrgb8888-4tiled: SUCCESS (1.044s) [664.102936] Starting dynamic subtest: rgb565-4tiled [664.637304] Dynamic subtest rgb565-4tiled: SUCCESS (0.544s) [664.646920] Starting dynamic subtest: xrgb2101010-4tiled [665.671685] Dynamic subtest xrgb2101010-4tiled: SUCCESS (1.033s) [665.687124] Starting dynamic subtest: xbgr16161616f-4tiled [668.560042] Dynamic subtest xbgr16161616f-4tiled: SUCCESS (2.887s) [668.562337] Subtest draw-method-pwrite: SUCCESS (15.534s) [668.701660] [081/131] (354s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-180-hflip) [668.816163] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-180-hflip [668.820674] Subtest yf-tiled-max-hw-stride-64bpp-rotate-180-hflip: SKIP (0.000s) [668.964564] [082/131] (353s left) kms_frontbuffer_tracking (fbc-2p-primscrn-indfb-plflip-blt) [669.071910] Starting subtest: fbc-2p-primscrn-indfb-plflip-blt [669.076308] Subtest fbc-2p-primscrn-indfb-plflip-blt: SKIP (0.000s) [669.198254] [083/131] (353s left) syncobj_timeline (host-signal-points) [669.265391] Starting subtest: host-signal-points [669.270479] Subtest host-signal-points: SUCCESS (0.004s) [669.411233] [084/131] (353s left) gem_mmap_gtt (basic-small-bo) [669.471111] Subtest basic-small-bo: SKIP (0.000s) [669.547682] [085/131] (353s left) perf_pmu (semaphore-wait-idle) [669.582607] Starting subtest: semaphore-wait-idle [669.584504] Starting dynamic subtest: rcs0 [670.097800] Dynamic subtest rcs0: SUCCESS (0.514s) [670.110238] Starting dynamic subtest: bcs0 [670.611937] Dynamic subtest bcs0: SUCCESS (0.511s) [670.624305] Starting dynamic subtest: vcs0 [671.126999] Dynamic subtest vcs0: SUCCESS (0.512s) [671.139480] Starting dynamic subtest: vcs1 [671.639199] Dynamic subtest vcs1: SUCCESS (0.510s) [671.651437] Starting dynamic subtest: vecs0 [672.154355] Dynamic subtest vecs0: SUCCESS (0.511s) [672.166967] Starting dynamic subtest: ccs0 [672.669101] Dynamic subtest ccs0: SUCCESS (0.512s) [672.671810] Subtest semaphore-wait-idle: SUCCESS (3.087s) [672.838160] [086/131] (350s left) kms_addfb_basic (no-handle) [672.900430] Starting subtest: no-handle [672.903081] Subtest no-handle: SUCCESS (0.000s) [673.063434] [087/131] (349s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-pwrite) [673.162934] Starting subtest: fbcpsr-rgb101010-draw-pwrite [680.226982] Subtest fbcpsr-rgb101010-draw-pwrite: SUCCESS (7.068s) [680.364650] [088/131] (342s left) gem_render_copy (yf-tiled-ccs-to-linear) [680.427592] Starting subtest: yf-tiled-ccs-to-linear [680.432098] Subtest yf-tiled-ccs-to-linear: SKIP (0.000s) [680.634074] [089/131] (342s left) kms_flip (wf_vblank-ts-check) [680.723417] Starting subtest: wf_vblank-ts-check [680.725619] Starting dynamic subtest: A-eDP1 [689.707251] Dynamic subtest A-eDP1: SUCCESS (8.953s) [689.716912] Starting dynamic subtest: B-eDP1 [698.644837] Dynamic subtest B-eDP1: SUCCESS (8.934s) [698.655243] Starting dynamic subtest: C-eDP1 [707.570593] Dynamic subtest C-eDP1: SUCCESS (8.914s) [707.583386] Starting dynamic subtest: D-eDP1 [716.502663] Dynamic subtest D-eDP1: SUCCESS (8.930s) [716.505142] Subtest wf_vblank-ts-check: SUCCESS (35.739s) [717.715441] [090/131] (305s left) gem_exec_schedule (deep) [717.903953] Starting subtest: deep [717.906395] Starting dynamic subtest: rcs0 [723.425126] Dynamic subtest rcs0: SKIP (5.519s) [723.437513] Starting dynamic subtest: vcs0 [733.709355] Dynamic subtest vcs0: SUCCESS (10.285s) [733.723374] Starting dynamic subtest: vcs1 [744.514881] Dynamic subtest vcs1: SUCCESS (10.803s) [744.526566] Starting dynamic subtest: vecs0 [755.693434] Dynamic subtest vecs0: SUCCESS (11.177s) [755.708943] Starting dynamic subtest: ccs0 [767.424585] Dynamic subtest ccs0: SUCCESS (11.729s) [767.427006] Subtest deep: SUCCESS (49.519s) [768.509499] [091/131] (254s left) kms_sequence (queue-idle) [768.610722] Starting subtest: queue-idle [768.612965] Starting dynamic subtest: pipe-A-eDP-1 [770.425052] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.815s) [770.434547] Starting dynamic subtest: pipe-B-eDP-1 [772.931244] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.503s) [772.941513] Starting dynamic subtest: pipe-C-eDP-1 [775.368738] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.435s) [775.381570] Starting dynamic subtest: pipe-D-eDP-1 [777.788408] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.421s) [777.790886] Subtest queue-idle: SUCCESS (9.180s) [778.621993] [092/131] (244s left) gem_gtt_cpu_tlb [778.757086] [093/131] (244s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-mmap-wc) [778.867194] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-mmap-wc [785.465636] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-mmap-wc: SUCCESS (6.599s) [785.629329] [094/131] (237s left) gem_eio (create-ext) [785.864334] Starting subtest: create-ext [786.196002] Subtest create-ext: SUCCESS (0.330s) [786.354792] [095/131] (237s left) gem_partial_pwrite_pread (writes-after-reads-uncached) [786.424125] Subtest writes-after-reads-uncached: SKIP (0.000s) [786.507480] [096/131] (236s left) sysfs_preempt_timeout (idempotent) [786.568780] Starting subtest: idempotent [786.570849] Starting dynamic subtest: vecs0 [786.572729] Dynamic subtest vecs0: SUCCESS (0.000s) [786.584452] Starting dynamic subtest: ccs0 [786.586189] Dynamic subtest ccs0: SUCCESS (0.000s) [786.595713] Starting dynamic subtest: vcs0 [786.597514] Dynamic subtest vcs0: SUCCESS (0.000s) [786.606621] Starting dynamic subtest: bcs0 [786.608431] Dynamic subtest bcs0: SUCCESS (0.000s) [786.617588] Starting dynamic subtest: rcs0 [786.619392] Dynamic subtest rcs0: SUCCESS (0.000s) [786.628888] Starting dynamic subtest: vcs1 [786.630666] Dynamic subtest vcs1: SUCCESS (0.000s) [786.632469] Subtest idempotent: SUCCESS (0.007s) [786.715520] [097/131] (236s left) gem_busy (semaphore) [786.910015] Subtest semaphore: SKIP (0.000s) [787.151364] [098/131] (236s left) sriov_basic (enable-vfs-bind-unbind-each) [787.213500] Starting subtest: enable-vfs-bind-unbind-each [787.215901] Starting dynamic subtest: numvfs-1 [787.294633] Dynamic subtest numvfs-1: FAIL (0.029s) [787.306130] Starting dynamic subtest: numvfs-2 [787.376634] Dynamic subtest numvfs-2: FAIL (0.004s) [787.388888] Starting dynamic subtest: numvfs-3 [787.461484] Dynamic subtest numvfs-3: FAIL (0.003s) [787.472774] Starting dynamic subtest: numvfs-4 [787.545070] Dynamic subtest numvfs-4: FAIL (0.003s) [787.556801] Starting dynamic subtest: numvfs-5 [787.629493] Dynamic subtest numvfs-5: FAIL (0.003s) [787.640645] Starting dynamic subtest: numvfs-6 [787.713858] Dynamic subtest numvfs-6: FAIL (0.003s) [787.725132] Starting dynamic subtest: numvfs-7 [787.798286] Dynamic subtest numvfs-7: FAIL (0.004s) [787.809877] Starting dynamic subtest: numvfs-random [787.882722] Dynamic subtest numvfs-random: FAIL (0.003s) [787.885088] Subtest enable-vfs-bind-unbind-each: FAIL (0.059s) [787.925272] [099/131] (235s left) kms_pm_lpsp (screens-disabled) [789.044246] Starting subtest: screens-disabled [789.048635] Subtest screens-disabled: SKIP (0.000s) [789.142327] [100/131] (234s left) gem_exec_capture (capture-invisible) [789.208204] Starting subtest: capture-invisible [789.210102] Starting dynamic subtest: smem0 [789.214091] Dynamic subtest smem0: SKIP (0.000s) [789.218097] Subtest capture-invisible: SKIP (0.001s) [789.341234] [101/131] (234s left) gem_lmem_swapping (verify-ccs) [789.383980] Subtest verify-ccs: SKIP (0.000s) [789.434870] [102/131] (234s left) kms_joiner (basic-force-ultra-joiner) [789.533092] Starting subtest: basic-force-ultra-joiner [789.537401] Subtest basic-force-ultra-joiner: SKIP (0.000s) [789.628837] [103/131] (234s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-mmap-wc) [789.720964] Starting subtest: psr-1p-primscrn-cur-indfb-draw-mmap-wc [796.272775] Subtest psr-1p-primscrn-cur-indfb-draw-mmap-wc: SUCCESS (6.553s) [796.423121] [104/131] (227s left) kms_color (legacy-gamma) [796.532655] Starting subtest: legacy-gamma [796.534470] Starting dynamic subtest: pipe-A-eDP-1 [797.243243] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.708s) [797.254004] Starting dynamic subtest: pipe-B-eDP-1 [798.664586] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.421s) [798.674934] Starting dynamic subtest: pipe-C-eDP-1 [800.016439] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.352s) [800.027652] Starting dynamic subtest: pipe-D-eDP-1 [801.360429] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.343s) [801.362815] Subtest legacy-gamma: SUCCESS (4.829s) [802.206766] [105/131] (221s left) gem_exec_schedule (wide) [802.389567] Starting subtest: wide [802.392209] Starting dynamic subtest: rcs0 [812.786200] Dynamic subtest rcs0: SUCCESS (10.344s) [812.799550] Starting dynamic subtest: vcs0 [824.228573] Dynamic subtest vcs0: SUCCESS (11.492s) [824.242841] Starting dynamic subtest: vcs1 [835.088505] Dynamic subtest vcs1: SUCCESS (10.859s) [835.101874] Starting dynamic subtest: vecs0 [844.624156] Dynamic subtest vecs0: SUCCESS (9.533s) [844.637703] Starting dynamic subtest: ccs0 [859.292068] Dynamic subtest ccs0: SUCCESS (14.614s) [859.294752] Subtest wide: SUCCESS (56.848s) [860.559766] [106/131] (163s left) kms_flip_scaled_crc (flip-32bpp-yftileccs-to-64bpp-yftile-upscaling) [860.675366] Starting subtest: flip-32bpp-yftileccs-to-64bpp-yftile-upscaling [860.677758] Starting dynamic subtest: pipe-A-default-mode [860.971302] Dynamic subtest pipe-A-default-mode: SKIP (0.294s) [860.975902] Subtest flip-32bpp-yftileccs-to-64bpp-yftile-upscaling: SKIP (0.296s) [861.828597] [107/131] (162s left) kms_big_fb (linear-64bpp-rotate-180) [861.923934] Starting subtest: linear-64bpp-rotate-180 [863.480649] Subtest linear-64bpp-rotate-180: SUCCESS (1.556s) [863.685484] [108/131] (160s left) gem_ppgtt (blt-vs-render-ctxn) [863.748179] Starting subtest: blt-vs-render-ctxN [896.912169] Subtest blt-vs-render-ctxN: SUCCESS (33.160s) [897.095025] [109/131] (126s left) kms_frontbuffer_tracking (psr-2p-scndscrn-shrfb-plflip-blt) [897.260275] Starting subtest: psr-2p-scndscrn-shrfb-plflip-blt [897.264479] Subtest psr-2p-scndscrn-shrfb-plflip-blt: SKIP (0.000s) [897.403076] [110/131] (126s left) kms_chamelium_frames (dp-frame-dump) [897.784586] Subtest dp-frame-dump: SKIP (0.000s) [898.603316] [111/131] (125s left) kms_psr2_su (page_flip-nv12) [898.659337] Subtest page_flip-NV12: SKIP (0.000s) [898.721720] [112/131] (125s left) gem_tiling_max_stride [898.842041] [113/131] (125s left) perf_pmu (busy-idle) [898.886558] Starting subtest: busy-idle [898.888800] Starting dynamic subtest: rcs0 [899.606120] Dynamic subtest rcs0: SUCCESS (0.722s) [899.619954] Starting dynamic subtest: bcs0 [900.278556] Dynamic subtest bcs0: SUCCESS (0.671s) [900.291919] Starting dynamic subtest: vcs0 [901.365869] Dynamic subtest vcs0: SUCCESS (1.083s) [901.379112] Starting dynamic subtest: vcs1 [903.350376] Dynamic subtest vcs1: SUCCESS (1.981s) [903.363869] Starting dynamic subtest: vecs0 [905.333887] Dynamic subtest vecs0: SUCCESS (1.980s) [905.346887] Starting dynamic subtest: ccs0 [906.017890] Dynamic subtest ccs0: SUCCESS (0.682s) [906.020766] Subtest busy-idle: SUCCESS (7.135s) [906.144767] [114/131] (118s left) dmabuf_sync_file (export-before-signal) [906.201510] Starting subtest: export-before-signal [906.203778] Subtest export-before-signal: SUCCESS (0.001s) [906.285333] [115/131] (118s left) gem_exec_reloc (basic-cpu-read) [906.362120] Subtest basic-cpu-read: SKIP (0.000s) [906.459753] [116/131] (117s left) kms_hdr (bpc-switch) [906.554800] Starting subtest: bpc-switch [907.590467] Starting dynamic subtest: pipe-A-eDP-1 [911.074613] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.484s) [911.076923] Subtest bpc-switch: SUCCESS (4.521s) [911.225579] [117/131] (113s left) perf (i915-ref-count) [911.337706] Starting subtest: i915-ref-count [911.403868] Subtest i915-ref-count: SUCCESS (0.067s) [911.463523] [118/131] (112s left) gem_ctx_isolation (nonpriv) [911.538898] Starting subtest: nonpriv [911.541214] Starting dynamic subtest: rcs0 [911.774126] Dynamic subtest rcs0: SUCCESS (0.235s) [911.786460] Starting dynamic subtest: bcs0 [912.046086] Dynamic subtest bcs0: SUCCESS (0.270s) [912.057057] Starting dynamic subtest: vcs0 [912.313810] Dynamic subtest vcs0: SUCCESS (0.267s) [912.326529] Starting dynamic subtest: vcs1 [913.653644] Dynamic subtest vcs1: SUCCESS (1.338s) [913.666659] Starting dynamic subtest: vecs0 [915.651420] Dynamic subtest vecs0: SUCCESS (1.997s) [915.663948] Starting dynamic subtest: ccs0 [917.660756] Dynamic subtest ccs0: SUCCESS (2.008s) [917.663076] Subtest nonpriv: SUCCESS (6.122s) [917.919275] [119/131] (106s left) gem_render_copy (y-tiled-to-vebox-x-tiled) [917.977545] Starting subtest: y-tiled-to-vebox-x-tiled [917.982004] Subtest y-tiled-to-vebox-x-tiled: SKIP (0.000s) [918.189248] [120/131] (106s left) kms_atomic_transition (plane-use-after-nonblocking-unbind) [918.287648] Starting subtest: plane-use-after-nonblocking-unbind [918.289900] Starting dynamic subtest: pipe-A-eDP-1 [918.349459] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.062s) [918.657187] Starting dynamic subtest: pipe-B-eDP-1 [919.439506] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.793s) [919.751144] Subtest plane-use-after-nonblocking-unbind: SUCCESS (1.463s) [920.624854] [121/131] (103s left) i915_hangman (engine-error-state-capture) [920.701315] Starting subtest: engine-error-state-capture [920.703600] Starting dynamic subtest: rcs0 [924.308460] Dynamic subtest rcs0: SUCCESS (3.605s) [924.321668] Starting dynamic subtest: bcs0 [930.325856] Dynamic subtest bcs0: SUCCESS (6.014s) [930.338481] Starting dynamic subtest: vcs0 [935.313928] Dynamic subtest vcs0: SUCCESS (4.987s) [935.328340] Starting dynamic subtest: vcs1 [941.266765] Dynamic subtest vcs1: SUCCESS (5.949s) [941.280388] Starting dynamic subtest: vecs0 [946.259912] Dynamic subtest vecs0: SUCCESS (4.990s) [946.272775] Starting dynamic subtest: ccs0 [951.315671] Dynamic subtest ccs0: SUCCESS (5.052s) [951.318700] Subtest engine-error-state-capture: SUCCESS (30.612s) [951.425259] [122/131] ( 73s left) gem_exec_schedule (pi-shared-iova) [951.619902] Starting subtest: pi-shared-iova [951.622124] Starting dynamic subtest: rcs0 [951.746414] Dynamic subtest rcs0: SUCCESS (0.128s) [951.760500] Starting dynamic subtest: vcs0 [951.829574] Dynamic subtest vcs0: SUCCESS (0.083s) [951.843031] Starting dynamic subtest: vcs1 [951.911355] Dynamic subtest vcs1: SUCCESS (0.081s) [951.925604] Starting dynamic subtest: vecs0 [951.993087] Dynamic subtest vecs0: SUCCESS (0.081s) [952.006969] Starting dynamic subtest: ccs0 [952.111213] Dynamic subtest ccs0: SUCCESS (0.117s) [952.113780] Subtest pi-shared-iova: SUCCESS (0.494s) [953.536613] [123/131] ( 71s left) syncobj_wait (invalid-reset-illegal-handle) [953.604217] Starting subtest: invalid-reset-illegal-handle [953.606435] Subtest invalid-reset-illegal-handle: SUCCESS (0.000s) [953.749407] [124/131] ( 70s left) syncobj_wait (single-wait-all-for-submit-signaled) [953.817475] Starting subtest: single-wait-all-for-submit-signaled [953.819763] Subtest single-wait-all-for-submit-signaled: SUCCESS (0.000s) [953.958326] [125/131] ( 70s left) kms_cursor_crc (cursor-sliding-512x170) [954.258609] Starting subtest: cursor-sliding-512x170 [954.262653] Subtest cursor-sliding-512x170: SKIP (0.001s) [954.443672] [126/131] ( 70s left) kms_chamelium_hpd (hdmi-hpd-fast) [954.837445] Subtest hdmi-hpd-fast: SKIP (0.000s) [955.612470] [127/131] ( 69s left) gem_ctx_persistence (hostile) [955.673337] Starting subtest: hostile [965.834752] Subtest hostile: SUCCESS (10.155s) [966.001543] [128/131] ( 58s left) kms_frontbuffer_tracking (fbc-rgb565-draw-blt) [966.112022] Starting subtest: fbc-rgb565-draw-blt [970.325805] Subtest fbc-rgb565-draw-blt: SUCCESS (4.217s) [971.553286] [129/131] ( 53s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-pwrite) [971.657142] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-pwrite [980.929776] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-pwrite: SUCCESS (9.274s) [981.108466] [130/131] ( 43s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-gtt) [981.219077] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-gtt [981.222970] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s) [981.336667] [131/131] ( 43s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-move) [981.443730] Starting subtest: fbc-2p-scndscrn-spr-indfb-move [981.448085] Subtest fbc-2p-scndscrn-spr-indfb-move: SKIP (0.000s) [981.577571] Closing watchdogs results: parsing output: 0/ for test: kms_big_fb results: parsing output: 1/ for test: gem_exec_fence results: parsing output: 2/ for test: kms_frontbuffer_tracking results: parsing output: 3/ for test: kms_frontbuffer_tracking results: parsing output: 4/ for test: gem_exec_balancer results: parsing output: 5/ for test: kms_chamelium_color results: parsing output: 6/ for test: gem_workarounds results: parsing output: 7/ for test: kms_plane_scaling results: parsing output: 8/ for test: gem_pxp results: parsing output: 9/ for test: gem_exec_params results: parsing output: 10/ for test: gem_exec_nop results: parsing output: 11/ for test: kms_frontbuffer_tracking results: parsing output: 12/ for test: kms_psr results: parsing output: 13/ for test: i915_pm_rps results: parsing output: 14/ for test: gem_softpin results: parsing output: 15/ for test: syncobj_timeline results: parsing output: 16/ for test: kms_panel_fitting results: parsing output: 17/ for test: kms_big_fb results: parsing output: 18/ for test: api_intel_bb results: parsing output: 19/ for test: kms_ccs results: parsing output: 20/ for test: syncobj_wait results: parsing output: 21/ for test: kms_frontbuffer_tracking results: parsing output: 22/ for test: gem_lmem_swapping results: parsing output: 23/ for test: kms_async_flips results: parsing output: 24/ for test: kms_psr2_sf results: parsing output: 25/ for test: kms_plane_multiple results: parsing output: 26/ for test: gem_ctx_param results: parsing output: 27/ for test: kms_ccs results: parsing output: 28/ for test: kms_plane_scaling results: parsing output: 29/ for test: syncobj_timeline results: parsing output: 30/ for test: perf results: parsing output: 31/ for test: kms_frontbuffer_tracking results: parsing output: 32/ for test: kms_pm_rpm results: parsing output: 33/ for test: kms_vblank results: parsing output: 34/ for test: kms_big_fb results: parsing output: 35/ for test: kms_pipe_crc_basic results: parsing output: 36/ for test: kms_cursor_legacy results: parsing output: 37/ for test: kms_psr2_sf results: parsing output: 38/ for test: gem_unref_active_buffers results: parsing output: 39/ for test: kms_psr results: parsing output: 40/ for test: syncobj_wait results: parsing output: 41/ for test: gen9_exec_parse results: parsing output: 42/ for test: syncobj_timeline results: parsing output: 43/ for test: gem_exec_reloc results: parsing output: 44/ for test: gem_mmap_offset results: parsing output: 45/ for test: kms_cursor_legacy results: parsing output: 46/ for test: kms_rotation_crc results: parsing output: 47/ for test: kms_big_fb results: parsing output: 48/ for test: gem_create results: parsing output: 49/ for test: kms_frontbuffer_tracking results: parsing output: 50/ for test: perf results: parsing output: 51/ for test: perf results: parsing output: 52/ for test: kms_big_fb results: parsing output: 53/ for test: kms_cursor_crc results: parsing output: 54/ for test: kms_rotation_crc results: parsing output: 55/ for test: kms_cursor_crc results: parsing output: 56/ for test: kms_frontbuffer_tracking results: parsing output: 57/ for test: kms_async_flips results: parsing output: 58/ for test: perf results: parsing output: 59/ for test: kms_frontbuffer_tracking results: parsing output: 60/ for test: syncobj_timeline results: parsing output: 61/ for test: kms_rmfb results: parsing output: 62/ for test: gem_userptr_blits results: parsing output: 63/ for test: gem_exec_reloc results: parsing output: 64/ for test: api_intel_allocator results: parsing output: 65/ for test: kms_lease results: parsing output: 66/ for test: kms_cursor_legacy results: parsing output: 67/ for test: syncobj_wait results: parsing output: 68/ for test: kms_psr results: parsing output: 69/ for test: kms_ccs results: parsing output: 70/ for test: kms_psr results: parsing output: 71/ for test: kms_frontbuffer_tracking results: parsing output: 72/ for test: kms_flip_scaled_crc results: parsing output: 73/ for test: gem_exec_schedule results: parsing output: 74/ for test: i915_drm_fdinfo results: parsing output: 75/ for test: i915_selftest results: parsing output: 76/ for test: gem_userptr_blits results: parsing output: 77/ for test: kms_ccs results: parsing output: 78/ for test: gem_softpin results: parsing output: 79/ for test: kms_draw_crc results: parsing output: 80/ for test: kms_big_fb results: parsing output: 81/ for test: kms_frontbuffer_tracking results: parsing output: 82/ for test: syncobj_timeline results: parsing output: 83/ for test: gem_mmap_gtt results: parsing output: 84/ for test: perf_pmu results: parsing output: 85/ for test: kms_addfb_basic results: parsing output: 86/ for test: kms_frontbuffer_tracking results: parsing output: 87/ for test: gem_render_copy results: parsing output: 88/ for test: kms_flip results: parsing output: 89/ for test: gem_exec_schedule results: parsing output: 90/ for test: kms_sequence results: parsing output: 91/ for test: gem_gtt_cpu_tlb results: parsing output: 92/ for test: kms_frontbuffer_tracking results: parsing output: 93/ for test: gem_eio results: parsing output: 94/ for test: gem_partial_pwrite_pread results: parsing output: 95/ for test: sysfs_preempt_timeout results: parsing output: 96/ for test: gem_busy results: parsing output: 97/ for test: sriov_basic results: parsing output: 98/ for test: kms_pm_lpsp results: parsing output: 99/ for test: gem_exec_capture results: parsing output: 100/ for test: gem_lmem_swapping results: parsing output: 101/ for test: kms_joiner results: parsing output: 102/ for test: kms_frontbuffer_tracking results: parsing output: 103/ for test: kms_color results: parsing output: 104/ for test: gem_exec_schedule results: parsing output: 105/ for test: kms_flip_scaled_crc results: parsing output: 106/ for test: kms_big_fb results: parsing output: 107/ for test: gem_ppgtt results: parsing output: 108/ for test: kms_frontbuffer_tracking results: parsing output: 109/ for test: kms_chamelium_frames results: parsing output: 110/ for test: kms_psr2_su results: parsing output: 111/ for test: gem_tiling_max_stride results: parsing output: 112/ for test: perf_pmu results: parsing output: 113/ for test: dmabuf_sync_file results: parsing output: 114/ for test: gem_exec_reloc results: parsing output: 115/ for test: kms_hdr results: parsing output: 116/ for test: perf results: parsing output: 117/ for test: gem_ctx_isolation results: parsing output: 118/ for test: gem_render_copy results: parsing output: 119/ for test: kms_atomic_transition results: parsing output: 120/ for test: i915_hangman results: parsing output: 121/ for test: gem_exec_schedule results: parsing output: 122/ for test: syncobj_wait results: parsing output: 123/ for test: syncobj_wait results: parsing output: 124/ for test: kms_cursor_crc results: parsing output: 125/ for test: kms_chamelium_hpd results: parsing output: 126/ for test: gem_ctx_persistence results: parsing output: 127/ for test: kms_frontbuffer_tracking results: parsing output: 128/ for test: kms_frontbuffer_tracking results: parsing output: 129/ for test: kms_frontbuffer_tracking results: parsing output: 130/ for test: kms_frontbuffer_tracking Done.