[47.610897] Initializing watchdogs [47.610958] /dev/watchdog0 [47.627328] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:9a49 Intel Tigerlake (Gen12) TigerLake-LP GT2 [Iris Xe Graphics] [47.632929] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [47.635616] [FACT before any test] new: kernel.kmod_is_loaded.i915: true [47.637449] [001/132] (960s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-move) [47.732621] Starting subtest: psr-1p-primscrn-cur-indfb-move [47.734018] Subtest psr-1p-primscrn-cur-indfb-move: SKIP (0.000s) [47.859522] [002/132] (960s left) kms_frontbuffer_tracking (fbc-1p-primscrn-shrfb-plflip-blt) [47.947515] Starting subtest: fbc-1p-primscrn-shrfb-plflip-blt [49.420770] Subtest fbc-1p-primscrn-shrfb-plflip-blt: SUCCESS (1.484s) [49.580933] [003/132] (958s left) kms_async_flips (async-flip-hang) [49.666416] Starting subtest: async-flip-hang [49.790520] Starting dynamic subtest: pipe-A-HDMI-A-1 [64.613127] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (14.853s) [64.749079] Starting dynamic subtest: pipe-B-HDMI-A-1 [79.485841] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (14.714s) [79.578286] Starting dynamic subtest: pipe-C-HDMI-A-1 [94.846270] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (15.241s) [94.936175] Starting dynamic subtest: pipe-D-HDMI-A-1 [109.693691] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (14.729s) [109.694386] Subtest async-flip-hang: SUCCESS (60.041s) [109.893783] [004/132] (898s left) perf (missing-sample-flags) [109.983562] Starting subtest: missing-sample-flags [109.984321] Subtest missing-sample-flags: SUCCESS (0.000s) [110.017739] [005/132] (898s left) kms_big_fb (x-tiled-addfb-size-overflow) [110.115242] Starting subtest: x-tiled-addfb-size-overflow [110.116048] Subtest x-tiled-addfb-size-overflow: SUCCESS (0.000s) [110.215788] [006/132] (898s left) gem_mmap_gtt (basic-copy) [110.248900] Starting subtest: basic-copy [110.721929] Subtest basic-copy: SUCCESS (0.465s) [110.823286] [007/132] (897s left) kms_dp_link_training (uhbr-mst) [110.906581] Starting subtest: uhbr-mst [110.907941] Subtest uhbr-mst: SKIP (0.000s) [110.987165] [008/132] (897s left) kms_flip_scaled_crc (flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling) [111.070709] Starting subtest: flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling [111.071400] Starting dynamic subtest: pipe-A-valid-mode [111.127268] Dynamic subtest pipe-A-valid-mode: SKIP (0.056s) [111.128747] Subtest flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling: SKIP (0.057s) [111.252210] [009/132] (897s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-render) [111.344537] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-render [111.345927] Subtest psr-2p-scndscrn-pri-shrfb-draw-render: SKIP (0.000s) [111.463626] [010/132] (896s left) perf_pmu (faulting-read) [111.498471] Starting subtest: faulting-read [111.499160] Starting dynamic subtest: gtt [111.499852] Dynamic subtest gtt: SUCCESS (0.001s) [111.505814] Starting dynamic subtest: wb [111.506498] Dynamic subtest wb: SUCCESS (0.001s) [111.512130] Starting dynamic subtest: wc [111.512820] Dynamic subtest wc: SUCCESS (0.000s) [111.518300] Starting dynamic subtest: uc [111.518976] Dynamic subtest uc: SUCCESS (0.000s) [111.519649] Subtest faulting-read: SUCCESS (0.003s) [111.613909] [011/132] (896s left) kms_cursor_crc (cursor-offscreen-512x512) [111.701547] Starting subtest: cursor-offscreen-512x512 [111.703762] Subtest cursor-offscreen-512x512: SKIP (0.001s) [111.814305] [012/132] (896s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-render) [111.902438] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-render [111.903804] Subtest psr-2p-scndscrn-cur-indfb-draw-render: SKIP (0.000s) [112.023167] [013/132] (896s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-pwrite) [112.110341] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-pwrite [113.343876] Subtest fbc-1p-primscrn-spr-indfb-draw-pwrite: SUCCESS (1.233s) [113.505862] [014/132] (895s left) gem_render_copy (x-tiled-to-vebox-yf-tiled) [113.543363] Starting subtest: x-tiled-to-vebox-yf-tiled [113.544384] Starting dynamic subtest: smem [113.609724] Dynamic subtest smem: SUCCESS (0.066s) [113.610447] Subtest x-tiled-to-vebox-yf-tiled: SUCCESS (0.066s) [113.801945] [015/132] (894s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-blt) [113.890702] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-blt [113.892132] Subtest fbc-2p-scndscrn-cur-indfb-draw-blt: SKIP (0.000s) [113.996711] [016/132] (894s left) perf (oa-formats) [114.079485] Starting subtest: oa-formats [114.080228] Starting dynamic subtest: 0-rcs0 [114.093388] Dynamic subtest 0-rcs0: SUCCESS (0.014s) [114.094113] Subtest oa-formats: SUCCESS (0.014s) [114.141130] [017/132] (894s left) kms_ccs (crc-primary-rotation-180-4-tiled-mtl-rc-ccs) [114.223502] Starting subtest: crc-primary-rotation-180-4-tiled-mtl-rc-ccs [114.224210] Starting dynamic subtest: pipe-A-HDMI-A-1 [114.230930] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.001s) [114.236751] Starting dynamic subtest: pipe-B-HDMI-A-1 [114.243367] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.001s) [114.249122] Starting dynamic subtest: pipe-C-HDMI-A-1 [114.255794] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.001s) [114.261424] Starting dynamic subtest: pipe-D-HDMI-A-1 [114.268137] Dynamic subtest pipe-D-HDMI-A-1: SKIP (0.001s) [114.269420] Subtest crc-primary-rotation-180-4-tiled-mtl-rc-ccs: SKIP (0.006s) [114.469372] [018/132] (894s left) kms_flip (basic-flip-vs-dpms) [114.556260] Starting subtest: basic-flip-vs-dpms [114.557788] Starting dynamic subtest: A-HDMI-A1 [115.288617] Dynamic subtest A-HDMI-A1: SUCCESS (0.730s) [115.294993] Starting dynamic subtest: B-HDMI-A1 [115.905727] Dynamic subtest B-HDMI-A1: SUCCESS (0.617s) [115.913279] Starting dynamic subtest: C-HDMI-A1 [116.616437] Dynamic subtest C-HDMI-A1: SUCCESS (0.710s) [116.622938] Starting dynamic subtest: D-HDMI-A1 [117.235377] Dynamic subtest D-HDMI-A1: SUCCESS (0.618s) [117.237073] Subtest basic-flip-vs-dpms: SUCCESS (2.681s) [117.369682] [019/132] (891s left) gem_exec_balancer (indices) [117.415767] Starting subtest: indices [118.720638] Subtest indices: SUCCESS (1.304s) [118.924377] [020/132] (889s left) gem_mmap_offset (open-flood) [118.956370] Starting subtest: open-flood [140.455783] Subtest open-flood: SUCCESS (21.500s) [140.590569] [021/132] (868s left) kms_color_pipeline (plane-lut1d-ctm3x4) [140.680639] Starting subtest: plane-lut1d-ctm3x4 [140.699215] Starting dynamic subtest: pipe-A-HDMI-A-1 [140.874082] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.175s) [140.991913] Starting dynamic subtest: pipe-B-HDMI-A-1 [141.142196] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.156s) [141.260530] Starting dynamic subtest: pipe-C-HDMI-A-1 [141.403599] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.148s) [141.526268] Starting dynamic subtest: pipe-D-HDMI-A-1 [141.668189] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.147s) [141.733614] Subtest plane-lut1d-ctm3x4: SUCCESS (1.053s) [141.850772] [022/132] (867s left) api_intel_bb (reset-bb) [141.889939] Starting subtest: reset-bb [141.891981] Subtest reset-bb: SUCCESS (0.003s) [142.037503] [023/132] (866s left) i915_hangman (detector) [142.078287] Starting subtest: detector [142.079088] Starting dynamic subtest: rcs0 [152.053926] Dynamic subtest rcs0: SUCCESS (9.975s) [152.070240] Starting dynamic subtest: bcs0 [161.056814] Dynamic subtest bcs0: SUCCESS (9.001s) [161.073792] Starting dynamic subtest: vcs0 [171.038944] Dynamic subtest vcs0: SUCCESS (9.980s) [171.048446] Starting dynamic subtest: vcs1 [180.043890] Dynamic subtest vcs1: SUCCESS (9.003s) [180.059575] Starting dynamic subtest: vecs0 [190.039147] Dynamic subtest vecs0: SUCCESS (9.993s) [190.040331] Subtest detector: SUCCESS (47.961s) [190.137951] [024/132] (818s left) kms_color (ctm-0-75) [190.223108] Starting subtest: ctm-0-75 [190.223833] Starting dynamic subtest: pipe-A-HDMI-A-1 [191.282125] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (1.059s) [191.289214] Starting dynamic subtest: pipe-B-HDMI-A-1 [192.333224] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (1.050s) [192.341059] Starting dynamic subtest: pipe-C-HDMI-A-1 [193.368280] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (1.034s) [193.374580] Starting dynamic subtest: pipe-D-HDMI-A-1 [194.403426] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (1.035s) [194.404096] Subtest ctm-0-75: SUCCESS (4.181s) [194.569871] [025/132] (814s left) gem_ccs (block-copy-uncompressed) [194.619115] Starting subtest: block-copy-uncompressed [194.620849] Starting dynamic subtest: linear-uncompressed-compfmt0-smem-smem [194.638913] Dynamic subtest linear-uncompressed-compfmt0-smem-smem: SUCCESS (0.019s) [194.646037] Starting dynamic subtest: ymajor-uncompressed-compfmt0-smem-smem [194.656659] Dynamic subtest ymajor-uncompressed-compfmt0-smem-smem: SUCCESS (0.016s) [194.657327] Subtest block-copy-uncompressed: SUCCESS (0.038s) [194.793504] [026/132] (814s left) gem_exec_params (invalid-ring) [194.829720] Starting subtest: invalid-ring [194.830404] Subtest invalid-ring: SUCCESS (0.000s) [194.943436] [027/132] (814s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip) [195.038672] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip [195.040037] Subtest 4-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip: SKIP (0.000s) [195.158966] [028/132] (813s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-shrfb-draw-mmap-gtt) [195.249500] Starting subtest: psr-1p-offscreen-pri-shrfb-draw-mmap-gtt [195.250890] Subtest psr-1p-offscreen-pri-shrfb-draw-mmap-gtt: SKIP (0.000s) [195.376416] [029/132] (813s left) i915_pm_rpm (system-suspend) [196.765466] Starting subtest: system-suspend [216.569072] Subtest system-suspend: SUCCESS (5.254s) [223.775872] [030/132] (792s left) gem_exec_flush (basic-uc-pro-default) [223.820815] Starting subtest: basic-uc-pro-default [229.225395] Subtest basic-uc-pro-default: SUCCESS (5.435s) [229.435783] [031/132] (786s left) gem_exec_params (invalid-bsd2-flag-on-vebox) [229.470608] Starting subtest: invalid-bsd2-flag-on-vebox [229.471339] Subtest invalid-bsd2-flag-on-vebox: SUCCESS (0.000s) [229.579131] [032/132] (786s left) gem_exec_create (basic) [229.621743] Starting subtest: basic [229.622452] Starting dynamic subtest: smem [231.669727] Dynamic subtest smem: SUCCESS (2.055s) [231.670479] Subtest basic: SUCCESS (2.056s) [231.875091] [033/132] (784s left) sysfs_preempt_timeout (timeout) [231.912851] Starting subtest: timeout [231.914610] Starting dynamic subtest: vecs0 [232.853349] Dynamic subtest vecs0: SUCCESS (0.941s) [232.867424] Starting dynamic subtest: vcs0 [233.780304] Dynamic subtest vcs0: SUCCESS (0.927s) [233.792898] Starting dynamic subtest: bcs0 [234.739327] Dynamic subtest bcs0: SUCCESS (0.958s) [234.753927] Starting dynamic subtest: rcs0 [235.678982] Dynamic subtest rcs0: SUCCESS (0.939s) [235.689110] Starting dynamic subtest: vcs1 [236.636018] Dynamic subtest vcs1: SUCCESS (0.956s) [236.639396] Subtest timeout: SUCCESS (4.735s) [236.725615] [034/132] (779s left) kms_joiner (switch-modeset-ultra-joiner-big-joiner) [236.814241] Starting subtest: switch-modeset-ultra-joiner-big-joiner [236.815579] Subtest switch-modeset-ultra-joiner-big-joiner: SKIP (0.000s) [236.900904] [035/132] (779s left) kms_draw_crc (draw-method-mmap-wc) [236.991320] Starting subtest: draw-method-mmap-wc [236.991997] Starting dynamic subtest: xrgb8888-untiled [237.139366] Dynamic subtest xrgb8888-untiled: SUCCESS (0.148s) [237.156235] Starting dynamic subtest: rgb565-untiled [237.297340] Dynamic subtest rgb565-untiled: SUCCESS (0.155s) [237.313148] Starting dynamic subtest: xrgb2101010-untiled [237.438585] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.139s) [237.453932] Starting dynamic subtest: xbgr16161616f-untiled [237.580027] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.139s) [237.595479] Starting dynamic subtest: xrgb8888-xtiled [237.671636] Dynamic subtest xrgb8888-xtiled: SUCCESS (0.089s) [237.687526] Starting dynamic subtest: rgb565-xtiled [237.763343] Dynamic subtest rgb565-xtiled: SUCCESS (0.090s) [237.773978] Starting dynamic subtest: xrgb2101010-xtiled [237.838306] Dynamic subtest xrgb2101010-xtiled: SUCCESS (0.073s) [237.852659] Starting dynamic subtest: xbgr16161616f-xtiled [237.921309] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (0.081s) [237.936098] Starting dynamic subtest: xrgb8888-ytiled [238.012640] Dynamic subtest xrgb8888-ytiled: SUCCESS (0.089s) [238.031095] Starting dynamic subtest: rgb565-ytiled [238.104447] Dynamic subtest rgb565-ytiled: SUCCESS (0.090s) [238.119103] Starting dynamic subtest: xrgb2101010-ytiled [238.187698] Dynamic subtest xrgb2101010-ytiled: SUCCESS (0.081s) [238.202777] Starting dynamic subtest: xbgr16161616f-ytiled [238.270748] Dynamic subtest xbgr16161616f-ytiled: SUCCESS (0.081s) [238.273744] Subtest draw-method-mmap-wc: SUCCESS (1.284s) [238.393195] [036/132] (778s left) kms_psr (pr-dpms) [238.484093] Subtest pr-dpms: SKIP (0.000s) [238.524140] [037/132] (778s left) kms_prop_blob (invalid-set-prop) [238.557873] Starting subtest: invalid-set-prop [238.558589] Subtest invalid-set-prop: SUCCESS (0.000s) [238.641983] [038/132] (777s left) kms_cursor_legacy (cursor-vs-flip-varying-size) [238.727509] Starting subtest: cursor-vs-flip-varying-size [270.562799] Subtest cursor-vs-flip-varying-size: SUCCESS (31.847s) [270.700222] [039/132] (745s left) kms_scaling_modes (scaling-mode-center) [270.794513] Starting subtest: scaling-mode-center [270.798558] Subtest scaling-mode-center: SKIP (0.001s) [270.873426] [040/132] (745s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-0-hflip) [270.971731] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-0-hflip [271.649311] Subtest y-tiled-max-hw-stride-32bpp-rotate-0-hflip: SUCCESS (0.678s) [271.813145] [041/132] (744s left) gem_ctx_persistence (legacy-engines-hang) [271.850318] Starting subtest: legacy-engines-hang [271.850989] Starting dynamic subtest: render [271.900168] Dynamic subtest render: SUCCESS (0.050s) [271.919919] Starting dynamic subtest: bsd1 [271.970245] Dynamic subtest bsd1: SUCCESS (0.067s) [271.989113] Starting dynamic subtest: bsd2 [272.019063] Dynamic subtest bsd2: SUCCESS (0.046s) [272.037169] Starting dynamic subtest: blt [272.079176] Dynamic subtest blt: SUCCESS (0.057s) [272.097448] Starting dynamic subtest: vebox [272.142068] Dynamic subtest vebox: SUCCESS (0.060s) [272.143180] Subtest legacy-engines-hang: SUCCESS (0.294s) [272.236513] [042/132] (744s left) kms_big_fb (yf-tiled-64bpp-rotate-0) [272.332667] Starting subtest: yf-tiled-64bpp-rotate-0 [272.334026] Subtest yf-tiled-64bpp-rotate-0: SKIP (0.000s) [272.437468] [043/132] (744s left) kms_flip (2x-flip-vs-absolute-wf_vblank) [272.523275] Starting subtest: 2x-flip-vs-absolute-wf_vblank [272.532075] Subtest 2x-flip-vs-absolute-wf_vblank: SKIP (0.009s) [272.636932] [044/132] (744s left) gen9_exec_parse (basic-rejected-ctx-param) [272.674310] Subtest basic-rejected-ctx-param: SKIP (0.000s) [272.710131] [045/132] (744s left) perf_pmu (pmu-read) [272.746402] Starting subtest: pmu-read [272.749298] Subtest pmu-read: SUCCESS (0.003s) [272.834578] [046/132] (744s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-mmap-wc) [272.923234] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-mmap-wc [272.924570] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-mmap-wc: SKIP (0.000s) [273.038707] [047/132] (743s left) gem_exec_reloc (basic-gtt) [273.075687] Starting subtest: basic-gtt [273.082607] Subtest basic-gtt: SUCCESS (0.007s) [273.210768] [048/132] (743s left) kms_universal_plane (disable-primary-vs-flip) [273.296643] Starting subtest: disable-primary-vs-flip [273.297321] Starting dynamic subtest: pipe-A-HDMI-A-1 [273.610742] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.313s) [273.619001] Starting dynamic subtest: pipe-B-HDMI-A-1 [273.918092] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.305s) [273.928511] Starting dynamic subtest: pipe-C-HDMI-A-1 [274.229871] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.308s) [274.237876] Starting dynamic subtest: pipe-D-HDMI-A-1 [274.546926] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.315s) [274.547692] Subtest disable-primary-vs-flip: SUCCESS (1.252s) [274.710350] [049/132] (742s left) kms_ccs (bad-rotation-90-4-tiled-bmg-ccs) [274.801484] Starting subtest: bad-rotation-90-4-tiled-bmg-ccs [274.802913] Subtest bad-rotation-90-4-tiled-bmg-ccs: SKIP (0.000s) [274.974645] [050/132] (742s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-180) [275.072088] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-180 [275.649907] Subtest y-tiled-max-hw-stride-64bpp-rotate-180: SUCCESS (0.577s) [275.779356] [051/132] (741s left) core_setmaster (master-drop-set-shared-fd) [275.857964] Starting subtest: master-drop-set-shared-fd [275.874454] Subtest master-drop-set-shared-fd: SUCCESS (0.016s) [275.908504] [052/132] (741s left) kms_chamelium_frames (dp-crc-multiple) [276.042351] Subtest dp-crc-multiple: SKIP (0.000s) [276.126238] [053/132] (741s left) kms_flip (2x-flip-vs-wf_vblank) [276.214649] Starting subtest: 2x-flip-vs-wf_vblank [276.223654] Subtest 2x-flip-vs-wf_vblank: SKIP (0.009s) [276.310012] [054/132] (740s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-mmap-gtt) [276.399832] Starting subtest: fbcpsr-rgb101010-draw-mmap-gtt [276.401243] Subtest fbcpsr-rgb101010-draw-mmap-gtt: SKIP (0.000s) [276.506774] [055/132] (740s left) gem_mmap_gtt (basic-write-read) [276.538922] Starting subtest: basic-write-read [276.540952] Subtest basic-write-read: SUCCESS (0.003s) [276.674382] [056/132] (740s left) gem_render_copy (y-tiled-mc-ccs-to-y-tiled-ccs) [276.712053] Starting subtest: y-tiled-mc-ccs-to-y-tiled-ccs [276.712789] Starting dynamic subtest: smem [276.834738] Dynamic subtest smem: SUCCESS (0.113s) [276.835654] Subtest y-tiled-mc-ccs-to-y-tiled-ccs: SUCCESS (0.114s) [277.019217] [057/132] (740s left) gem_exec_reloc (basic-write-gtt-noreloc) [277.057302] Starting subtest: basic-write-gtt-noreloc [277.060299] Subtest basic-write-gtt-noreloc: SUCCESS (0.003s) [277.198518] [058/132] (740s left) i915_suspend (basic-s2idle-without-i915) [277.229650] Starting subtest: basic-s2idle-without-i915 [295.499148] Subtest basic-s2idle-without-i915: SUCCESS (3.347s) [302.566656] [059/132] (721s left) perf (gen12-invalid-class-instance) [302.669391] Starting subtest: gen12-invalid-class-instance [302.679286] Subtest gen12-invalid-class-instance: SUCCESS (0.010s) [302.717615] [060/132] (721s left) prime_vgem (busy) [302.812914] Starting subtest: busy [302.813599] Starting dynamic subtest: rcs0 [302.853217] Dynamic subtest rcs0: SUCCESS (0.041s) [302.861249] Starting dynamic subtest: bcs0 [302.877994] Dynamic subtest bcs0: SUCCESS (0.024s) [302.885999] Starting dynamic subtest: vcs0 [302.901920] Dynamic subtest vcs0: SUCCESS (0.023s) [302.910203] Starting dynamic subtest: vcs1 [302.934443] Dynamic subtest vcs1: SUCCESS (0.031s) [302.947030] Starting dynamic subtest: vecs0 [302.965593] Dynamic subtest vecs0: SUCCESS (0.029s) [302.966678] Subtest busy: SUCCESS (0.156s) [303.099309] [FACT prime_vgem (busy)] new: kernel.kmod_is_loaded.vgem: true [303.101141] [061/132] (721s left) kms_content_protection (content-type-change) [303.191195] Starting subtest: content-type-change [303.204396] Subtest content-type-change: SKIP (0.012s) [303.315789] [062/132] (721s left) kms_flip (blocking-wf_vblank) [303.399730] Starting subtest: blocking-wf_vblank [303.401793] Starting dynamic subtest: A-HDMI-A1 [311.276447] Dynamic subtest A-HDMI-A1: SUCCESS (7.896s) [311.283191] Starting dynamic subtest: B-HDMI-A1 [319.131580] Dynamic subtest B-HDMI-A1: SUCCESS (7.885s) [319.140543] Starting dynamic subtest: C-HDMI-A1 [327.037419] Dynamic subtest C-HDMI-A1: SUCCESS (7.887s) [327.043890] Starting dynamic subtest: D-HDMI-A1 [334.898993] Dynamic subtest D-HDMI-A1: SUCCESS (7.890s) [334.901159] Subtest blocking-wf_vblank: SUCCESS (31.570s) [335.103547] [063/132] (689s left) i915_drm_fdinfo (all-busy-idle-check-all) [335.141007] Starting subtest: all-busy-idle-check-all [335.764832] Subtest all-busy-idle-check-all: SUCCESS (0.623s) [335.848990] [064/132] (688s left) syncobj_timeline (single-wait-available-submitted) [335.882189] Starting subtest: single-wait-available-submitted [335.882909] Subtest single-wait-available-submitted: SUCCESS (0.000s) [335.971991] [065/132] (688s left) kms_pipe_crc_basic (compare-crc-sanitycheck-nv12) [336.057603] Starting subtest: compare-crc-sanitycheck-nv12 [336.059389] Starting dynamic subtest: pipe-A-HDMI-A-1 [336.415398] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.355s) [336.424673] Starting dynamic subtest: pipe-B-HDMI-A-1 [336.731432] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.313s) [336.740321] Starting dynamic subtest: pipe-C-HDMI-A-1 [337.046305] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.313s) [337.055131] Starting dynamic subtest: pipe-D-HDMI-A-1 [337.357952] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.309s) [337.358673] Subtest compare-crc-sanitycheck-nv12: SUCCESS (1.299s) [337.543313] [066/132] (687s left) kms_psr (fbc-psr-dpms) [337.634258] Subtest fbc-psr-dpms: SKIP (0.000s) [337.679673] [067/132] (687s left) gem_exec_schedule (preempt-hang) [337.842314] Starting subtest: preempt-hang [337.843339] Starting dynamic subtest: rcs0 [338.038569] Dynamic subtest rcs0: SUCCESS (0.204s) [338.046629] Starting dynamic subtest: bcs0 [338.242681] Dynamic subtest bcs0: SUCCESS (0.203s) [338.251241] Starting dynamic subtest: vcs0 [338.447970] Dynamic subtest vcs0: SUCCESS (0.203s) [338.456598] Starting dynamic subtest: vcs1 [338.646927] Dynamic subtest vcs1: SUCCESS (0.198s) [338.655422] Starting dynamic subtest: vecs0 [338.840589] Dynamic subtest vecs0: SUCCESS (0.192s) [338.841382] Subtest preempt-hang: SUCCESS (1.008s) [339.049565] [068/132] (685s left) gem_mmap_offset (perf) [339.082466] Starting subtest: perf [339.083166] Starting dynamic subtest: smem0 [339.284995] Dynamic subtest smem0: SUCCESS (0.202s) [339.285715] Subtest perf: SUCCESS (0.203s) [339.409842] [069/132] (685s left) kms_psr2_sf (psr2-overlay-primary-update-sf-dmg-area) [339.501193] Subtest psr2-overlay-primary-update-sf-dmg-area: SKIP (0.000s) [339.543570] [070/132] (685s left) kms_cursor_crc (cursor-random-32x10) [339.630052] Starting subtest: cursor-random-32x10 [339.681621] Subtest cursor-random-32x10: SKIP (0.050s) [339.775323] [071/132] (685s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-mmap-cpu) [339.867155] Starting subtest: psr-2p-primscrn-cur-indfb-draw-mmap-cpu [339.868606] Subtest psr-2p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s) [339.982618] [072/132] (684s left) gem_ctx_persistence (engines-hostile-preempt) [340.019691] Starting subtest: engines-hostile-preempt [340.020468] Starting dynamic subtest: rcs0 [340.115381] Dynamic subtest rcs0: SUCCESS (0.095s) [340.134613] Starting dynamic subtest: bcs0 [340.226426] Dynamic subtest bcs0: SUCCESS (0.109s) [340.246614] Starting dynamic subtest: vcs0 [340.321422] Dynamic subtest vcs0: SUCCESS (0.092s) [340.340943] Starting dynamic subtest: vcs1 [340.448459] Dynamic subtest vcs1: SUCCESS (0.125s) [340.468598] Starting dynamic subtest: vecs0 [340.542377] Dynamic subtest vecs0: SUCCESS (0.091s) [340.543679] Subtest engines-hostile-preempt: SUCCESS (0.523s) [340.642282] [073/132] (684s left) kms_psr (psr2-sprite-blt) [340.726993] Subtest psr2-sprite-blt: SKIP (0.000s) [340.781538] [074/132] (684s left) syncobj_timeline (single-wait-signaled) [340.816187] Starting subtest: single-wait-signaled [340.816939] Subtest single-wait-signaled: SUCCESS (0.000s) [340.904059] [075/132] (684s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-mmap-wc) [340.996507] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-mmap-wc [340.998020] Subtest fbc-2p-scndscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s) [341.115442] [076/132] (683s left) kms_plane_scaling (plane-upscale-factor-0-25-with-modifiers) [341.200650] Starting subtest: plane-upscale-factor-0-25-with-modifiers [341.201339] Starting dynamic subtest: pipe-A [341.566480] Dynamic subtest pipe-A: SUCCESS (0.366s) [341.576776] Starting dynamic subtest: pipe-B [342.000952] Dynamic subtest pipe-B: SUCCESS (0.433s) [342.010232] Starting dynamic subtest: pipe-C [342.435012] Dynamic subtest pipe-C: SUCCESS (0.433s) [342.443514] Starting dynamic subtest: pipe-D [342.884978] Dynamic subtest pipe-D: SUCCESS (0.449s) [342.885691] Subtest plane-upscale-factor-0-25-with-modifiers: SUCCESS (1.685s) [343.078335] [077/132] (682s left) gem_close (basic) [343.115206] Starting subtest: basic [343.115912] Subtest basic: SUCCESS (0.000s) [343.235365] [078/132] (681s left) kms_ccs (crc-primary-rotation-180-4-tiled-dg2-rc-ccs-cc) [343.321662] Starting subtest: crc-primary-rotation-180-4-tiled-dg2-rc-ccs-cc [343.323428] Starting dynamic subtest: pipe-A-HDMI-A-1 [343.329992] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.001s) [343.336995] Starting dynamic subtest: pipe-B-HDMI-A-1 [343.343574] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.001s) [343.350730] Starting dynamic subtest: pipe-C-HDMI-A-1 [343.357352] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.001s) [343.364094] Starting dynamic subtest: pipe-D-HDMI-A-1 [343.370737] Dynamic subtest pipe-D-HDMI-A-1: SKIP (0.001s) [343.372042] Subtest crc-primary-rotation-180-4-tiled-dg2-rc-ccs-cc: SKIP (0.009s) [343.581959] [079/132] (681s left) gem_create (create-ext-cpu-access-sanity-check) [343.736089] Starting subtest: create-ext-cpu-access-sanity-check [343.738186] Subtest create-ext-cpu-access-sanity-check: SKIP (0.001s) [343.821686] [080/132] (681s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-mmap-cpu) [343.910452] Starting subtest: fbc-rgb101010-draw-mmap-cpu [346.398627] Subtest fbc-rgb101010-draw-mmap-cpu: SUCCESS (2.488s) [346.532599] [081/132] (678s left) syncobj_timeline (etime-single-wait-for-submit-submitted) [346.567498] Starting subtest: etime-single-wait-for-submit-submitted [346.675816] Subtest etime-single-wait-for-submit-submitted: SUCCESS (0.108s) [346.773445] [082/132] (678s left) kms_pm_rpm (modeset-lpsp) [348.171083] Starting subtest: modeset-lpsp [349.463798] Subtest modeset-lpsp: SUCCESS (1.293s) [349.591484] [083/132] (675s left) syncobj_timeline (etime-multi-wait-all-for-submit-unsubmitted-submitted-signa [349.629342] Starting subtest: etime-multi-wait-all-for-submit-unsubmitted-submitted-signaled [349.731243] Subtest etime-multi-wait-all-for-submit-unsubmitted-submitted-signaled: SUCCESS (0.101s) [349.824971] [084/132] (675s left) kms_flip (flip-vs-panning-vs-hang) [349.910309] Starting subtest: flip-vs-panning-vs-hang [349.912065] Starting dynamic subtest: A-HDMI-A1 [378.271823] Dynamic subtest A-HDMI-A1: SUCCESS (28.346s) [378.278377] Starting dynamic subtest: D-HDMI-A1 [405.918591] Dynamic subtest D-HDMI-A1: SUCCESS (27.638s) [405.919285] Subtest flip-vs-panning-vs-hang: SUCCESS (55.992s) [406.059175] [085/132] (619s left) kms_flip_scaled_crc (flip-64bpp-linear-to-16bpp-linear-downscaling) [406.145552] Starting subtest: flip-64bpp-linear-to-16bpp-linear-downscaling [406.147293] Starting dynamic subtest: pipe-A-valid-mode [407.321410] Dynamic subtest pipe-A-valid-mode: SUCCESS (1.173s) [407.322109] Subtest flip-64bpp-linear-to-16bpp-linear-downscaling: SUCCESS (1.175s) [407.457943] [086/132] (618s left) sw_sync (alloc_fence_invalid_timeline) [407.494092] Starting subtest: alloc_fence_invalid_timeline [407.494834] Subtest alloc_fence_invalid_timeline: SUCCESS (0.000s) [407.578079] [087/132] (617s left) gem_flink_race (flink_close) [407.609499] Starting subtest: flink_close [412.652470] Subtest flink_close: SUCCESS (5.030s) [412.746892] [088/132] (612s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-render) [412.839012] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-render [412.840439] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-render: SKIP (0.000s) [412.965317] [089/132] (612s left) kms_atomic (plane-primary-legacy) [413.049084] Starting subtest: plane-primary-legacy [413.051222] Starting dynamic subtest: pipe-A-HDMI-A-1 [413.266234] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.216s) [413.266924] Subtest plane-primary-legacy: SUCCESS (0.218s) [413.421396] [090/132] (612s left) gem_ctx_bad_destroy (invalid-ctx) [413.457889] Starting subtest: invalid-ctx [413.458601] Subtest invalid-ctx: SUCCESS (0.000s) [413.550133] [091/132] (612s left) gem_exec_schedule (wide) [413.715854] Starting subtest: wide [413.716848] Starting dynamic subtest: rcs0 [423.799159] Dynamic subtest rcs0: SUCCESS (10.047s) [423.808793] Starting dynamic subtest: bcs0 [434.889534] Dynamic subtest bcs0: SUCCESS (11.089s) [434.899566] Starting dynamic subtest: vcs0 [446.733514] Dynamic subtest vcs0: SUCCESS (11.843s) [446.743498] Starting dynamic subtest: vcs1 [458.212144] Dynamic subtest vcs1: SUCCESS (11.479s) [458.222031] Starting dynamic subtest: vecs0 [469.289457] Dynamic subtest vecs0: SUCCESS (11.078s) [469.290306] Subtest wide: SUCCESS (55.543s) [471.544315] [092/132] (554s left) gem_exec_fence (submit3) [471.708155] Starting subtest: submit3 [471.709164] Starting dynamic subtest: rcs0 [471.716172] Dynamic subtest rcs0: SUCCESS (0.007s) [471.725540] Starting dynamic subtest: bcs0 [471.726243] Dynamic subtest bcs0: SUCCESS (0.004s) [471.734127] Starting dynamic subtest: vcs0 [471.734808] Dynamic subtest vcs0: SUCCESS (0.004s) [471.742918] Starting dynamic subtest: vcs1 [471.743594] Dynamic subtest vcs1: SUCCESS (0.004s) [471.750824] Starting dynamic subtest: vecs0 [471.751501] Dynamic subtest vecs0: SUCCESS (0.005s) [471.752153] Subtest submit3: SUCCESS (0.031s) [472.241574] [093/132] (553s left) gem_softpin (allocator-evict) [472.278425] Starting subtest: allocator-evict [472.279160] Starting dynamic subtest: rcs0 [496.138091] Dynamic subtest rcs0: SUCCESS (23.864s) [496.148021] Starting dynamic subtest: bcs0 [519.094932] Dynamic subtest bcs0: SUCCESS (22.962s) [519.104893] Starting dynamic subtest: vcs0 [542.287242] Dynamic subtest vcs0: SUCCESS (23.189s) [542.296354] Starting dynamic subtest: vcs1 [565.625680] Dynamic subtest vcs1: SUCCESS (23.333s) [565.634934] Starting dynamic subtest: vecs0 [589.136942] Dynamic subtest vecs0: SUCCESS (23.508s) [589.138845] Subtest allocator-evict: SUCCESS (116.863s) [589.234884] [094/132] (436s left) gem_exec_fence (syncobj-timeline-unused-fence) [589.719714] Starting subtest: syncobj-timeline-unused-fence [589.720616] Subtest syncobj-timeline-unused-fence: SUCCESS (0.005s) [589.909746] [095/132] (435s left) gem_exec_endless (dispatch) [589.959552] Starting subtest: dispatch [589.960299] Starting dynamic subtest: rcs0 [589.964168] Dynamic subtest rcs0: SUCCESS (0.004s) [589.972839] Starting dynamic subtest: bcs0 [589.974174] Dynamic subtest bcs0: SUCCESS (0.003s) [589.983318] Starting dynamic subtest: vcs0 [589.984627] Dynamic subtest vcs0: SUCCESS (0.003s) [589.992797] Starting dynamic subtest: vcs1 [589.994256] Dynamic subtest vcs1: SUCCESS (0.003s) [590.002615] Starting dynamic subtest: vecs0 [590.003949] Dynamic subtest vecs0: SUCCESS (0.003s) [590.004623] Subtest dispatch: SUCCESS (0.020s) [590.121897] [096/132] (435s left) syncobj_timeline (multi-wait-for-submit-available-unsubmitted-signaled) [590.161280] Starting subtest: multi-wait-for-submit-available-unsubmitted-signaled [590.161976] Subtest multi-wait-for-submit-available-unsubmitted-signaled: SUCCESS (0.000s) [590.253320] [097/132] (435s left) gem_flink_basic (bad-open) [590.285561] Starting subtest: bad-open [590.286239] Subtest bad-open: SUCCESS (0.000s) [590.369006] [098/132] (435s left) gem_wait (await) [590.413021] Starting subtest: await [590.413768] Starting dynamic subtest: all-engines [591.463075] Dynamic subtest all-engines: SUCCESS (1.049s) [591.474366] Starting dynamic subtest: rcs0 [592.500189] Dynamic subtest rcs0: SUCCESS (1.035s) [592.511654] Starting dynamic subtest: bcs0 [593.530879] Dynamic subtest bcs0: SUCCESS (1.029s) [593.543036] Starting dynamic subtest: vcs0 [594.565112] Dynamic subtest vcs0: SUCCESS (1.032s) [594.579131] Starting dynamic subtest: vcs1 [595.593910] Dynamic subtest vcs1: SUCCESS (1.026s) [595.606368] Starting dynamic subtest: vecs0 [596.624183] Dynamic subtest vecs0: SUCCESS (1.029s) [596.627451] Subtest await: SUCCESS (6.212s) [596.835155] [099/132] (429s left) kms_cursor_legacy (forked-move) [596.926669] Starting subtest: forked-move [596.927417] Starting dynamic subtest: pipe-A [602.361851] Dynamic subtest pipe-A: SUCCESS (5.426s) [602.370093] Starting dynamic subtest: pipe-B [607.819896] Dynamic subtest pipe-B: SUCCESS (5.432s) [607.828928] Starting dynamic subtest: pipe-C [613.265033] Dynamic subtest pipe-C: SUCCESS (5.444s) [613.273762] Starting dynamic subtest: pipe-D [618.698051] Dynamic subtest pipe-D: SUCCESS (5.431s) [618.707473] Starting dynamic subtest: all-pipes [624.145001] Dynamic subtest all-pipes: SUCCESS (5.445s) [624.145940] Subtest forked-move: SUCCESS (27.186s) [624.195153] [100/132] (401s left) gem_exec_flush (basic-uc-rw-default) [624.237108] Starting subtest: basic-uc-rw-default [629.665272] Subtest basic-uc-rw-default: SUCCESS (5.429s) [629.882564] [101/132] (396s left) syncobj_wait (invalid-wait-illegal-handle) [629.916433] Starting subtest: invalid-wait-illegal-handle [629.917151] Subtest invalid-wait-illegal-handle: SUCCESS (0.000s) [630.009236] [102/132] (396s left) kms_psr2_sf (fbc-psr2-cursor-plane-update-sf) [630.100798] Subtest fbc-psr2-cursor-plane-update-sf: SKIP (0.000s) [630.141029] [103/132] (396s left) kms_psr (psr-sprite-blt) [630.226626] Subtest psr-sprite-blt: SKIP (0.000s) [630.266441] [104/132] (396s left) kms_frontbuffer_tracking (fbc-rgb565-draw-mmap-wc) [630.358005] Starting subtest: fbc-rgb565-draw-mmap-wc [631.618326] Subtest fbc-rgb565-draw-mmap-wc: SUCCESS (1.260s) [631.767528] [105/132] (394s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-blt) [631.864847] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-blt [631.866242] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-blt: SKIP (0.000s) [631.967836] [106/132] (394s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-indfb-pgflip-blt) [632.056386] Starting subtest: fbcpsr-2p-primscrn-indfb-pgflip-blt [632.057733] Subtest fbcpsr-2p-primscrn-indfb-pgflip-blt: SKIP (0.000s) [632.193938] [107/132] (394s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-move) [632.282422] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-move [632.283746] Subtest fbcpsr-1p-primscrn-cur-indfb-move: SKIP (0.000s) [632.393159] [108/132] (394s left) kms_plane_scaling (planes-downscale-factor-0-75-upscale-20x20) [632.476792] Starting subtest: planes-downscale-factor-0-75-upscale-20x20 [632.477625] Starting dynamic subtest: pipe-A [632.619456] Dynamic subtest pipe-A: SUCCESS (0.143s) [632.628990] Starting dynamic subtest: pipe-B [632.764452] Dynamic subtest pipe-B: SUCCESS (0.144s) [632.781963] Starting dynamic subtest: pipe-C [632.907388] Dynamic subtest pipe-C: SUCCESS (0.142s) [632.921353] Starting dynamic subtest: pipe-D [633.034936] Dynamic subtest pipe-D: SUCCESS (0.124s) [633.035726] Subtest planes-downscale-factor-0-75-upscale-20x20: SUCCESS (0.557s) [633.237897] [109/132] (393s left) kms_frontbuffer_tracking (fbc-tiling-y) [633.330898] Starting subtest: fbc-tiling-y [634.645446] Subtest fbc-tiling-y: SUCCESS (1.315s) [634.803224] [110/132] (391s left) gem_userptr_blits (stress-mm-invalidate-close-overlap) [634.847507] Starting subtest: stress-mm-invalidate-close-overlap [637.003887] Subtest stress-mm-invalidate-close-overlap: SUCCESS (2.148s) [637.130617] [111/132] (389s left) api_intel_allocator (fork-simple-once) [637.162429] Starting subtest: fork-simple-once [637.175877] Subtest fork-simple-once: SUCCESS (0.014s) [637.304127] [112/132] (389s left) kms_rotation_crc (primary-y-tiled-reflect-x-90) [637.393044] Starting subtest: primary-y-tiled-reflect-x-90 [642.247990] Subtest primary-y-tiled-reflect-x-90: SUCCESS (4.855s) [642.465951] [113/132] (384s left) prime_mmap (test_map_unmap) [642.501684] Starting subtest: test_map_unmap [642.502488] Starting dynamic subtest: test_map_unmap-smem [642.504589] Dynamic subtest test_map_unmap-smem: SUCCESS (0.002s) [642.505333] Subtest test_map_unmap: SUCCESS (0.003s) [642.617442] [114/132] (384s left) gem_mmap_gtt (cpuset-basic-small-copy-xy) [642.650468] Starting subtest: cpuset-basic-small-copy-XY [647.722011] Subtest cpuset-basic-small-copy-XY: SUCCESS (5.070s) [647.806653] [115/132] (378s left) gem_partial_pwrite_pread (write-display) [647.883059] Starting subtest: write-display [658.029516] Subtest write-display: SUCCESS (10.148s) [658.157022] [116/132] (368s left) syncobj_wait (multi-wait-all-for-submit-unsubmitted) [658.197171] Starting subtest: multi-wait-all-for-submit-unsubmitted [658.299454] Subtest multi-wait-all-for-submit-unsubmitted: SUCCESS (0.102s) [658.395368] [117/132] (368s left) gen3_render_tiledy_blits [658.468707] [118/132] (368s left) kms_ccs (missing-ccs-buffer-4-tiled-mtl-mc-ccs) [658.559688] Starting subtest: missing-ccs-buffer-4-tiled-mtl-mc-ccs [658.561440] Starting dynamic subtest: pipe-A-HDMI-A-1 [658.568008] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.000s) [658.576106] Starting dynamic subtest: pipe-B-HDMI-A-1 [658.582898] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.000s) [658.590965] Starting dynamic subtest: pipe-C-HDMI-A-1 [658.597805] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.000s) [658.608360] Starting dynamic subtest: pipe-D-HDMI-A-1 [658.615676] Dynamic subtest pipe-D-HDMI-A-1: SKIP (0.000s) [658.617071] Subtest missing-ccs-buffer-4-tiled-mtl-mc-ccs: SKIP (0.007s) [658.810920] [119/132] (368s left) kms_chamelium_audio (hdmi-audio) [658.948920] Subtest hdmi-audio: SKIP (0.000s) [659.039508] [120/132] (367s left) gem_exec_whisper (basic-queues-all) [659.086758] Starting subtest: basic-queues-all [660.388423] Subtest basic-queues-all: SUCCESS (1.300s) [660.591051] [121/132] (366s left) syncobj_wait (multi-wait-for-submit-unsubmitted) [660.625438] Starting subtest: multi-wait-for-submit-unsubmitted [660.731344] Subtest multi-wait-for-submit-unsubmitted: SUCCESS (0.106s) [660.821646] [122/132] (366s left) kms_pipe_crc_basic (nonblocking-crc-frame-sequence) [660.909552] Starting subtest: nonblocking-crc-frame-sequence [660.910499] Starting dynamic subtest: pipe-A-HDMI-A-1 [661.270945] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.360s) [661.283552] Starting dynamic subtest: pipe-B-HDMI-A-1 [661.609345] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.336s) [661.618866] Starting dynamic subtest: pipe-C-HDMI-A-1 [661.936598] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.326s) [661.949847] Starting dynamic subtest: pipe-D-HDMI-A-1 [662.277035] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.339s) [662.279120] Subtest nonblocking-crc-frame-sequence: SUCCESS (1.369s) [662.427293] [123/132] (364s left) kms_big_fb (linear-64bpp-rotate-0) [662.532456] Starting subtest: linear-64bpp-rotate-0 [664.473492] Subtest linear-64bpp-rotate-0: SUCCESS (1.941s) [664.624044] [124/132] (362s left) kms_addfb_basic (bad-pitch-65536) [664.656782] Starting subtest: bad-pitch-65536 [664.657517] Subtest bad-pitch-65536: SUCCESS (0.000s) [664.839931] [125/132] (362s left) syncobj_wait (invalid-signal-illegal-handle) [664.873550] Starting subtest: invalid-signal-illegal-handle [664.874232] Subtest invalid-signal-illegal-handle: SUCCESS (0.000s) [664.963090] [126/132] (362s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-0-hflip) [665.057202] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-0-hflip [665.058564] Subtest yf-tiled-max-hw-stride-32bpp-rotate-0-hflip: SKIP (0.000s) [665.176146] [127/132] (362s left) gem_exec_schedule (semaphore-power) [665.344100] Starting subtest: semaphore-power [666.406310] Subtest semaphore-power: SUCCESS (1.054s) [666.593229] [128/132] (360s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-render) [666.683215] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-render [666.684579] Subtest psr-2p-primscrn-pri-shrfb-draw-render: SKIP (0.000s) [666.799219] [129/132] (360s left) gem_exec_alignment (pi) [666.835767] Starting subtest: pi [729.788508] Subtest pi: SUCCESS (62.962s) [730.837354] [130/132] (296s left) kms_psr (fbc-psr2-basic) [730.986611] Subtest fbc-psr2-basic: SKIP (0.000s) [731.031464] [131/132] (296s left) kms_properties (connector-properties-legacy) [731.116177] Starting subtest: connector-properties-legacy [731.116912] Starting dynamic subtest: pipe-A-HDMI-A-1 [731.656464] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.539s) [731.664898] Starting dynamic subtest: pipe-None-DP-1 [731.666370] Dynamic subtest pipe-None-DP-1: SUCCESS (0.002s) [731.677338] Starting dynamic subtest: pipe-None-DP-2 [731.678833] Dynamic subtest pipe-None-DP-2: SUCCESS (0.001s) [731.689569] Starting dynamic subtest: pipe-None-DP-3 [731.691104] Dynamic subtest pipe-None-DP-3: SUCCESS (0.001s) [731.701638] Starting dynamic subtest: pipe-None-DP-4 [731.702990] Dynamic subtest pipe-None-DP-4: SUCCESS (0.002s) [731.703952] Subtest connector-properties-legacy: SUCCESS (0.552s) [731.790863] [132/132] (295s left) kms_plane (plane-panning-bottom-right-suspend) [731.882631] Starting subtest: plane-panning-bottom-right-suspend [731.883327] Starting dynamic subtest: pipe-A [748.451582] Dynamic subtest pipe-A: SUCCESS (1.575s) [748.462336] Starting dynamic subtest: pipe-B [765.473693] Dynamic subtest pipe-B: SUCCESS (1.553s) [765.474458] Subtest plane-panning-bottom-right-suspend: SUCCESS (3.132s) [774.648885] Closing watchdogs results: parsing output: 0/ for test: kms_frontbuffer_tracking results: parsing output: 1/ for test: kms_frontbuffer_tracking results: parsing output: 2/ for test: kms_async_flips results: parsing output: 3/ for test: perf results: parsing output: 4/ for test: kms_big_fb results: parsing output: 5/ for test: gem_mmap_gtt results: parsing output: 6/ for test: kms_dp_link_training results: parsing output: 7/ for test: kms_flip_scaled_crc results: parsing output: 8/ for test: kms_frontbuffer_tracking results: parsing output: 9/ for test: perf_pmu results: parsing output: 10/ for test: kms_cursor_crc results: parsing output: 11/ for test: kms_frontbuffer_tracking results: parsing output: 12/ for test: kms_frontbuffer_tracking results: parsing output: 13/ for test: gem_render_copy results: parsing output: 14/ for test: kms_frontbuffer_tracking results: parsing output: 15/ for test: perf results: parsing output: 16/ for test: kms_ccs results: parsing output: 17/ for test: kms_flip results: parsing output: 18/ for test: gem_exec_balancer results: parsing output: 19/ for test: gem_mmap_offset results: parsing output: 20/ for test: kms_color_pipeline results: parsing output: 21/ for test: api_intel_bb results: parsing output: 22/ for test: i915_hangman results: parsing output: 23/ for test: kms_color results: parsing output: 24/ for test: gem_ccs results: parsing output: 25/ for test: gem_exec_params results: parsing output: 26/ for test: kms_big_fb results: parsing output: 27/ for test: kms_frontbuffer_tracking results: parsing output: 28/ for test: i915_pm_rpm results: parsing output: 29/ for test: gem_exec_flush results: parsing output: 30/ for test: gem_exec_params results: parsing output: 31/ for test: gem_exec_create results: parsing output: 32/ for test: sysfs_preempt_timeout results: parsing output: 33/ for test: kms_joiner results: parsing output: 34/ for test: kms_draw_crc results: parsing output: 35/ for test: kms_psr results: parsing output: 36/ for test: kms_prop_blob results: parsing output: 37/ for test: kms_cursor_legacy results: parsing output: 38/ for test: kms_scaling_modes results: parsing output: 39/ for test: kms_big_fb results: parsing output: 40/ for test: gem_ctx_persistence results: parsing output: 41/ for test: kms_big_fb results: parsing output: 42/ for test: kms_flip results: parsing output: 43/ for test: gen9_exec_parse results: parsing output: 44/ for test: perf_pmu results: parsing output: 45/ for test: kms_frontbuffer_tracking results: parsing output: 46/ for test: gem_exec_reloc results: parsing output: 47/ for test: kms_universal_plane results: parsing output: 48/ for test: kms_ccs results: parsing output: 49/ for test: kms_big_fb results: parsing output: 50/ for test: core_setmaster results: parsing output: 51/ for test: kms_chamelium_frames results: parsing output: 52/ for test: kms_flip results: parsing output: 53/ for test: kms_frontbuffer_tracking results: parsing output: 54/ for test: gem_mmap_gtt results: parsing output: 55/ for test: gem_render_copy results: parsing output: 56/ for test: gem_exec_reloc results: parsing output: 57/ for test: i915_suspend results: parsing output: 58/ for test: perf results: parsing output: 59/ for test: prime_vgem results: parsing output: 60/ for test: kms_content_protection results: parsing output: 61/ for test: kms_flip results: parsing output: 62/ for test: i915_drm_fdinfo results: parsing output: 63/ for test: syncobj_timeline results: parsing output: 64/ for test: kms_pipe_crc_basic results: parsing output: 65/ for test: kms_psr results: parsing output: 66/ for test: gem_exec_schedule results: parsing output: 67/ for test: gem_mmap_offset results: parsing output: 68/ for test: kms_psr2_sf results: parsing output: 69/ for test: kms_cursor_crc results: parsing output: 70/ for test: kms_frontbuffer_tracking results: parsing output: 71/ for test: gem_ctx_persistence results: parsing output: 72/ for test: kms_psr results: parsing output: 73/ for test: syncobj_timeline results: parsing output: 74/ for test: kms_frontbuffer_tracking results: parsing output: 75/ for test: kms_plane_scaling results: parsing output: 76/ for test: gem_close results: parsing output: 77/ for test: kms_ccs results: parsing output: 78/ for test: gem_create results: parsing output: 79/ for test: kms_frontbuffer_tracking results: parsing output: 80/ for test: syncobj_timeline results: parsing output: 81/ for test: kms_pm_rpm results: parsing output: 82/ for test: syncobj_timeline results: parsing output: 83/ for test: kms_flip results: parsing output: 84/ for test: kms_flip_scaled_crc results: parsing output: 85/ for test: sw_sync results: parsing output: 86/ for test: gem_flink_race results: parsing output: 87/ for test: kms_frontbuffer_tracking results: parsing output: 88/ for test: kms_atomic results: parsing output: 89/ for test: gem_ctx_bad_destroy results: parsing output: 90/ for test: gem_exec_schedule results: parsing output: 91/ for test: gem_exec_fence results: parsing output: 92/ for test: gem_softpin results: parsing output: 93/ for test: gem_exec_fence results: parsing output: 94/ for test: gem_exec_endless results: parsing output: 95/ for test: syncobj_timeline results: parsing output: 96/ for test: gem_flink_basic results: parsing output: 97/ for test: gem_wait results: parsing output: 98/ for test: kms_cursor_legacy results: parsing output: 99/ for test: gem_exec_flush results: parsing output: 100/ for test: syncobj_wait results: parsing output: 101/ for test: kms_psr2_sf results: parsing output: 102/ for test: kms_psr results: parsing output: 103/ for test: kms_frontbuffer_tracking results: parsing output: 104/ for test: kms_frontbuffer_tracking results: parsing output: 105/ for test: kms_frontbuffer_tracking results: parsing output: 106/ for test: kms_frontbuffer_tracking results: parsing output: 107/ for test: kms_plane_scaling results: parsing output: 108/ for test: kms_frontbuffer_tracking results: parsing output: 109/ for test: gem_userptr_blits results: parsing output: 110/ for test: api_intel_allocator results: parsing output: 111/ for test: kms_rotation_crc results: parsing output: 112/ for test: prime_mmap results: parsing output: 113/ for test: gem_mmap_gtt results: parsing output: 114/ for test: gem_partial_pwrite_pread results: parsing output: 115/ for test: syncobj_wait results: parsing output: 116/ for test: gen3_render_tiledy_blits results: parsing output: 117/ for test: kms_ccs results: parsing output: 118/ for test: kms_chamelium_audio results: parsing output: 119/ for test: gem_exec_whisper results: parsing output: 120/ for test: syncobj_wait results: parsing output: 121/ for test: kms_pipe_crc_basic results: parsing output: 122/ for test: kms_big_fb results: parsing output: 123/ for test: kms_addfb_basic results: parsing output: 124/ for test: syncobj_wait results: parsing output: 125/ for test: kms_big_fb results: parsing output: 126/ for test: gem_exec_schedule results: parsing output: 127/ for test: kms_frontbuffer_tracking results: parsing output: 128/ for test: gem_exec_alignment results: parsing output: 129/ for test: kms_psr results: parsing output: 130/ for test: kms_properties results: parsing output: 131/ for test: kms_plane Done.