[60.608914] Initializing watchdogs [60.608974] /dev/watchdog0 [60.628550] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:03:00.0: 8086:56a0 Intel Dg2 (Gen12) DG2 [Arc A770] [60.639472] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card0 [60.643357] [FACT before any test] new: kernel.kmod_is_loaded.i915: true [60.645703] [001/131] (960s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-180-async-flip) [60.844060] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-180-async-flip [60.846019] Subtest y-tiled-max-hw-stride-64bpp-rotate-180-async-flip: SKIP (0.000s) [61.027286] [002/131] (960s left) gem_exec_fence (submit3) [61.226928] Starting subtest: submit3 [61.228990] Subtest submit3: SKIP (0.000s) [61.992798] [FACT gem_exec_fence (submit3)] new: kernel.kmod_is_loaded.vgem: true [61.995020] [003/131] (959s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-mmap-gtt) [62.182763] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-mmap-gtt [62.184429] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s) [62.375033] [004/131] (959s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-mmap-wc) [62.568274] Starting subtest: fbc-rgb101010-draw-mmap-wc [62.569917] Subtest fbc-rgb101010-draw-mmap-wc: SKIP (0.000s) [62.755983] [005/131] (958s left) gem_exec_balancer (noheartbeat) [63.107170] Starting subtest: noheartbeat [63.108966] Subtest noheartbeat: SKIP (0.000s) [63.287451] [006/131] (958s left) kms_chamelium_color (ctm-blue-to-red) [63.472005] Subtest ctm-blue-to-red: SKIP (0.000s) [63.531488] [007/131] (958s left) gem_workarounds (suspend-resume) [63.624201] Starting subtest: suspend-resume [83.496562] Subtest suspend-resume: SUCCESS (3.820s) [84.650109] [008/131] (937s left) kms_plane_scaling (planes-downscale-factor-0-75-unity-scaling) [84.837538] Starting subtest: planes-downscale-factor-0-75-unity-scaling [84.838318] Starting dynamic subtest: pipe-A [84.930141] Dynamic subtest pipe-A: SUCCESS (0.093s) [84.941807] Starting dynamic subtest: pipe-B [85.126554] Dynamic subtest pipe-B: SUCCESS (0.196s) [85.143064] Starting dynamic subtest: pipe-C [85.339521] Dynamic subtest pipe-C: SUCCESS (0.213s) [85.356014] Starting dynamic subtest: pipe-D [85.552342] Dynamic subtest pipe-D: SUCCESS (0.213s) [85.553110] Subtest planes-downscale-factor-0-75-unity-scaling: SUCCESS (0.715s) [85.883120] [009/131] (936s left) gem_pxp (create-regular-buffer) [88.487992] Starting subtest: create-regular-buffer [88.490457] Subtest create-regular-buffer: SKIP (0.000s) [88.657427] [010/131] (934s left) gem_exec_params (rel-constants-invalid-rel-gen5) [88.740227] Starting subtest: rel-constants-invalid-rel-gen5 [88.741184] Subtest rel-constants-invalid-rel-gen5: SUCCESS (0.000s) [88.905340] [011/131] (933s left) gem_exec_nop (basic-series) [89.001695] Starting subtest: basic-series [93.345600] Subtest basic-series: SUCCESS (4.344s) [93.645186] [012/131] (929s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-mmap-wc) [93.833221] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-mmap-wc [93.835017] Subtest fbc-2p-primscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s) [94.034777] [013/131] (928s left) kms_psr (fbc-psr-primary-page-flip) [94.220221] Subtest fbc-psr-primary-page-flip: SKIP (0.000s) [94.276677] [014/131] (928s left) i915_pm_rps (engine-order) [94.357374] Starting subtest: engine-order [105.061052] Subtest engine-order: SUCCESS (10.703s) [105.282065] [015/131] (917s left) gem_softpin (evict-active) [105.366025] Starting subtest: evict-active [105.382516] Subtest evict-active: SUCCESS (0.016s) [105.601803] [016/131] (917s left) syncobj_timeline (wait-delayed-signal) [105.678972] Starting subtest: wait-delayed-signal [105.781983] Subtest wait-delayed-signal: SUCCESS (0.102s) [105.919781] [017/131] (917s left) kms_panel_fitting (atomic-fastset) [106.114976] Starting subtest: atomic-fastset [106.116762] Subtest atomic-fastset: SKIP (0.000s) [106.288229] [018/131] (916s left) kms_big_fb (x-tiled-16bpp-rotate-270) [106.492648] Starting subtest: x-tiled-16bpp-rotate-270 [106.552062] Subtest x-tiled-16bpp-rotate-270: SKIP (0.059s) [106.768304] [019/131] (916s left) api_intel_bb (render-ccs) [106.851063] Starting subtest: render-ccs [106.946405] Subtest render-ccs: SUCCESS (0.095s) [107.166771] [020/131] (916s left) kms_ccs (crc-primary-rotation-180-y-tiled-gen12-rc-ccs-cc) [107.352009] Starting subtest: crc-primary-rotation-180-y-tiled-gen12-rc-ccs-cc [107.352939] Starting dynamic subtest: pipe-A-DP-3 [107.361248] Dynamic subtest pipe-A-DP-3: SKIP (0.001s) [107.372085] Starting dynamic subtest: pipe-B-DP-3 [107.380422] Dynamic subtest pipe-B-DP-3: SKIP (0.001s) [107.391120] Starting dynamic subtest: pipe-C-DP-3 [107.399287] Dynamic subtest pipe-C-DP-3: SKIP (0.001s) [107.410111] Starting dynamic subtest: pipe-D-DP-3 [107.421077] Dynamic subtest pipe-D-DP-3: SKIP (0.001s) [107.423142] Subtest crc-primary-rotation-180-y-tiled-gen12-rc-ccs-cc: SKIP (0.006s) [107.846050] [021/131] (915s left) syncobj_wait (multi-wait-all-for-submit-unsubmitted-signaled) [107.928793] Starting subtest: multi-wait-all-for-submit-unsubmitted-signaled [108.034568] Subtest multi-wait-all-for-submit-unsubmitted-signaled: SUCCESS (0.105s) [108.185608] [022/131] (915s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-move) [108.377265] Starting subtest: psr-2p-primscrn-cur-indfb-move [108.378943] Subtest psr-2p-primscrn-cur-indfb-move: SKIP (0.000s) [108.592897] [023/131] (915s left) gem_lmem_swapping (heavy-multi) [111.254734] Starting subtest: heavy-multi [111.257557] Starting dynamic subtest: lmem0 [116.640060] Dynamic subtest lmem0: SUCCESS (5.385s) [116.640979] Subtest heavy-multi: SUCCESS (5.386s) [118.031932] [FACT gem_lmem_swapping (heavy-multi)] deleted: hardware.pci.drm_card_at_addr.0000:03:00.0: card0 [118.033393] [FACT gem_lmem_swapping (heavy-multi)] deleted: kernel.kmod_is_loaded.i915: true [118.035403] [024/131] (905s left) kms_async_flips (test-cursor) [119.678586] Starting subtest: test-cursor [119.909282] Starting dynamic subtest: pipe-A-DP-3 [120.225160] Dynamic subtest pipe-A-DP-3: SUCCESS (0.316s) [120.466365] Starting dynamic subtest: pipe-B-DP-3 [120.584963] Dynamic subtest pipe-B-DP-3: SUCCESS (0.130s) [120.798543] Starting dynamic subtest: pipe-C-DP-3 [120.909637] Dynamic subtest pipe-C-DP-3: SUCCESS (0.122s) [121.118450] Starting dynamic subtest: pipe-D-DP-3 [121.228663] Dynamic subtest pipe-D-DP-3: SUCCESS (0.120s) [121.229583] Subtest test-cursor: SUCCESS (1.551s) [121.759720] [FACT kms_async_flips (test-cursor)] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card0 [121.761973] [FACT kms_async_flips (test-cursor)] new: kernel.kmod_is_loaded.i915: true [121.764429] [025/131] (902s left) kms_psr2_sf (fbc-psr2-overlay-plane-move-continuous-exceed-sf) [121.953195] Subtest fbc-psr2-overlay-plane-move-continuous-exceed-sf: SKIP (0.000s) [122.002161] [026/131] (901s left) kms_plane_multiple (2x-tiling-4) [122.186699] Starting subtest: 2x-tiling-4 [122.188461] Subtest 2x-tiling-4: SKIP (0.000s) [122.343813] [027/131] (901s left) gem_ctx_param (invalid-param-set) [122.417163] Starting subtest: invalid-param-set [122.418106] Subtest invalid-param-set: SUCCESS (0.000s) [122.556396] [028/131] (901s left) kms_ccs (bad-pixel-format-y-tiled-ccs) [122.739119] Starting subtest: bad-pixel-format-y-tiled-ccs [122.740023] Starting dynamic subtest: pipe-A-DP-3 [122.748298] Dynamic subtest pipe-A-DP-3: SKIP (0.000s) [122.759348] Starting dynamic subtest: pipe-B-DP-3 [122.767791] Dynamic subtest pipe-B-DP-3: SKIP (0.000s) [122.778525] Starting dynamic subtest: pipe-C-DP-3 [122.786697] Dynamic subtest pipe-C-DP-3: SKIP (0.000s) [122.797543] Starting dynamic subtest: pipe-D-DP-3 [122.815103] Dynamic subtest pipe-D-DP-3: SKIP (0.000s) [122.817409] Subtest bad-pixel-format-y-tiled-ccs: SKIP (0.004s) [123.197504] [029/131] (900s left) kms_plane_scaling (plane-downscale-factor-0-5-with-modifiers) [123.379528] Starting subtest: plane-downscale-factor-0-5-with-modifiers [123.380325] Starting dynamic subtest: pipe-A [123.933102] Dynamic subtest pipe-A: SUCCESS (0.553s) [123.953950] Starting dynamic subtest: pipe-B [124.579169] Dynamic subtest pipe-B: SUCCESS (0.645s) [124.602506] Starting dynamic subtest: pipe-C [125.225445] Dynamic subtest pipe-C: SUCCESS (0.645s) [125.238687] Starting dynamic subtest: pipe-D [125.854130] Dynamic subtest pipe-D: SUCCESS (0.628s) [125.855225] Subtest plane-downscale-factor-0-5-with-modifiers: SUCCESS (2.475s) [126.216867] [030/131] (897s left) syncobj_timeline (multi-wait-all-available-submitted-signaled) [126.297944] Starting subtest: multi-wait-all-available-submitted-signaled [126.298887] Subtest multi-wait-all-available-submitted-signaled: SUCCESS (0.000s) [126.486873] [031/131] (897s left) perf (missing-sample-flags) [126.915329] Starting subtest: missing-sample-flags [126.916160] Subtest missing-sample-flags: SUCCESS (0.000s) [126.967376] [032/131] (897s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-pwrite) [127.157434] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-pwrite [130.219986] Subtest fbc-1p-primscrn-pri-shrfb-draw-pwrite: SUCCESS (3.064s) [130.472186] [033/131] (893s left) kms_pm_rpm (system-suspend-idle) [132.115956] Starting subtest: system-suspend-idle [152.148863] Subtest system-suspend-idle: SUCCESS (5.400s) [152.508934] [034/131] (871s left) kms_vblank (wait-forked) [152.685487] Starting subtest: wait-forked [152.687342] Starting dynamic subtest: pipe-A-DP-3 [154.982503] Dynamic subtest pipe-A-DP-3: SUCCESS (2.373s) [155.003311] Starting dynamic subtest: pipe-D-DP-3 [157.242653] Dynamic subtest pipe-D-DP-3: SUCCESS (2.312s) [157.243772] Subtest wait-forked: SUCCESS (4.693s) [157.514557] [035/131] (867s left) kms_big_fb (y-tiled-32bpp-rotate-0) [157.705441] Starting subtest: y-tiled-32bpp-rotate-0 [157.707211] Subtest y-tiled-32bpp-rotate-0: SKIP (0.000s) [157.906380] [036/131] (866s left) kms_pipe_crc_basic (read-crc) [158.090613] Starting subtest: read-crc [158.092708] Starting dynamic subtest: pipe-A-DP-3 [158.763155] Dynamic subtest pipe-A-DP-3: SUCCESS (0.683s) [158.776861] Starting dynamic subtest: pipe-B-DP-3 [159.313530] Dynamic subtest pipe-B-DP-3: SUCCESS (0.557s) [159.340078] Starting dynamic subtest: pipe-C-DP-3 [159.889352] Dynamic subtest pipe-C-DP-3: SUCCESS (0.582s) [159.903506] Starting dynamic subtest: pipe-D-DP-3 [160.403427] Dynamic subtest pipe-D-DP-3: SUCCESS (0.520s) [160.404319] Subtest read-crc: SUCCESS (2.351s) [160.725431] [037/131] (864s left) kms_cursor_legacy (single-move) [160.909718] Starting subtest: single-move [160.910587] Starting dynamic subtest: pipe-A [166.238769] Dynamic subtest pipe-A: SUCCESS (5.379s) [166.251337] Starting dynamic subtest: pipe-B [171.591461] Dynamic subtest pipe-B: SUCCESS (5.379s) [171.603609] Starting dynamic subtest: pipe-C [176.956414] Dynamic subtest pipe-C: SUCCESS (5.378s) [176.968633] Starting dynamic subtest: pipe-D [182.327152] Dynamic subtest pipe-D: SUCCESS (5.378s) [182.339864] Starting dynamic subtest: all-pipes [187.706964] Dynamic subtest all-pipes: SUCCESS (5.379s) [187.708012] Subtest single-move: SUCCESS (26.897s) [187.838596] [038/131] (836s left) kms_psr2_sf (pr-overlay-plane-move-continuous-exceed-sf) [188.030380] Subtest pr-overlay-plane-move-continuous-exceed-sf: SKIP (0.000s) [188.082297] [039/131] (836s left) gem_unref_active_buffers [188.492175] [040/131] (836s left) kms_psr (fbc-psr2-primary-mmap-gtt) [188.680567] Subtest fbc-psr2-primary-mmap-gtt: SKIP (0.000s) [188.749561] [041/131] (836s left) syncobj_wait (invalid-signal-zero-handles) [188.827279] Starting subtest: invalid-signal-zero-handles [188.828307] Subtest invalid-signal-zero-handles: SUCCESS (0.000s) [189.019921] [042/131] (836s left) gen9_exec_parse (bb-oversize) [189.106207] Subtest bb-oversize: SKIP (0.000s) [189.211572] [043/131] (835s left) syncobj_timeline (etime-multi-wait-all-for-submit-available-unsubmitted) [189.287414] Starting subtest: etime-multi-wait-all-for-submit-available-unsubmitted [189.393383] Subtest etime-multi-wait-all-for-submit-available-unsubmitted: SUCCESS (0.105s) [189.573160] [044/131] (835s left) gem_exec_reloc (basic-write-cpu-noreloc) [189.654056] Subtest basic-write-cpu-noreloc: SKIP (0.000s) [189.731959] [045/131] (835s left) gem_mmap_offset (bad-flags) [189.815294] Starting subtest: bad-flags [189.816217] Subtest bad-flags: SUCCESS (0.000s) [189.969444] [046/131] (835s left) kms_cursor_legacy (cursor-vs-flip-legacy) [190.155144] Starting subtest: cursor-vs-flip-legacy [220.434051] Subtest cursor-vs-flip-legacy: SUCCESS (30.277s) [220.752815] [047/131] (804s left) kms_rotation_crc (sprite-rotation-90-pos-100-0) [220.940513] Starting subtest: sprite-rotation-90-pos-100-0 [220.943307] Subtest sprite-rotation-90-pos-100-0: SKIP (0.001s) [221.110649] [048/131] (804s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-0-hflip) [221.308022] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-0-hflip [222.571996] Subtest x-tiled-max-hw-stride-64bpp-rotate-0-hflip: SUCCESS (1.264s) [222.804876] [049/131] (802s left) gem_create (busy-create) [222.886409] Starting subtest: busy-create [222.887340] Starting dynamic subtest: lmem0 [255.191261] Dynamic subtest lmem0: SUCCESS (32.309s) [255.204449] Starting dynamic subtest: smem0 [287.459235] Dynamic subtest smem0: SUCCESS (32.262s) [287.460181] Subtest busy-create: SUCCESS (64.572s) [287.754824] [050/131] (737s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-indfb-draw-render) [287.951643] Starting subtest: fbc-1p-offscreen-pri-indfb-draw-render [290.247089] Subtest fbc-1p-offscreen-pri-indfb-draw-render: SUCCESS (2.296s) [290.528658] [051/131] (735s left) perf (invalid-open-flags) [290.790573] Starting subtest: invalid-open-flags [290.791451] Subtest invalid-open-flags: SUCCESS (0.000s) [290.855405] [052/131] (734s left) perf (oa-formats) [291.073171] Starting subtest: oa-formats [291.074104] Starting dynamic subtest: 0-rcs0 [291.098450] Dynamic subtest 0-rcs0: SUCCESS (0.026s) [291.099426] Subtest oa-formats: SUCCESS (0.027s) [291.155195] [053/131] (734s left) kms_big_fb (4-tiled-8bpp-rotate-270) [291.345475] Starting subtest: 4-tiled-8bpp-rotate-270 [291.409776] Subtest 4-tiled-8bpp-rotate-270: SKIP (0.064s) [291.658903] [054/131] (734s left) kms_cursor_crc (cursor-onscreen-64x21) [292.007814] Starting subtest: cursor-onscreen-64x21 [292.012143] Starting dynamic subtest: pipe-A-DP-3 [294.636828] Dynamic subtest pipe-A-DP-3: SUCCESS (2.624s) [294.685475] Starting dynamic subtest: pipe-D-DP-3 [297.410917] Dynamic subtest pipe-D-DP-3: SUCCESS (2.738s) [297.411915] Subtest cursor-onscreen-64x21: SUCCESS (5.404s) [297.918685] [055/131] (728s left) kms_rotation_crc (primary-4-tiled-reflect-x-180) [298.102337] Starting subtest: primary-4-tiled-reflect-x-180 [308.445606] Subtest primary-4-tiled-reflect-x-180: SUCCESS (10.343s) [308.838641] [056/131] (717s left) kms_cursor_crc (cursor-onscreen-256x256) [309.241958] Starting subtest: cursor-onscreen-256x256 [309.246571] Starting dynamic subtest: pipe-A-DP-3 [312.030456] Dynamic subtest pipe-A-DP-3: SUCCESS (2.784s) [312.066227] Starting dynamic subtest: pipe-D-DP-3 [314.773690] Dynamic subtest pipe-D-DP-3: SUCCESS (2.719s) [314.774647] Subtest cursor-onscreen-256x256: SUCCESS (5.533s) [315.189131] [057/131] (710s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-shrfb-msflip-blt) [315.383510] Starting subtest: fbcpsr-1p-primscrn-shrfb-msflip-blt [315.385205] Subtest fbcpsr-1p-primscrn-shrfb-msflip-blt: SKIP (0.000s) [315.610530] [058/131] (710s left) kms_async_flips (async-flip-with-page-flip-events-tiled) [315.796247] Starting subtest: async-flip-with-page-flip-events-tiled [316.017881] Starting dynamic subtest: pipe-A-DP-3-4 [318.279583] Dynamic subtest pipe-A-DP-3-4: SUCCESS (2.262s) [318.292808] Starting dynamic subtest: pipe-A-DP-3-x [320.461160] Dynamic subtest pipe-A-DP-3-x: SUCCESS (2.181s) [320.705324] Starting dynamic subtest: pipe-B-DP-3-4 [322.920822] Dynamic subtest pipe-B-DP-3-4: SUCCESS (2.228s) [322.939534] Starting dynamic subtest: pipe-B-DP-3-x [325.085142] Dynamic subtest pipe-B-DP-3-x: SUCCESS (2.164s) [325.275625] Starting dynamic subtest: pipe-C-DP-3-4 [327.494023] Dynamic subtest pipe-C-DP-3-4: SUCCESS (2.233s) [327.513089] Starting dynamic subtest: pipe-C-DP-3-x [329.658110] Dynamic subtest pipe-C-DP-3-x: SUCCESS (2.163s) [329.868841] Starting dynamic subtest: pipe-D-DP-3-4 [332.085491] Dynamic subtest pipe-D-DP-3-4: SUCCESS (2.228s) [332.126704] Starting dynamic subtest: pipe-D-DP-3-x [334.265830] Dynamic subtest pipe-D-DP-3-x: SUCCESS (2.177s) [334.266637] Subtest async-flip-with-page-flip-events-tiled: SUCCESS (18.474s) [334.776780] [059/131] (691s left) perf (polling) [335.011347] Starting subtest: polling [335.012317] Starting dynamic subtest: 0-rcs0 [345.034600] Dynamic subtest 0-rcs0: SUCCESS (10.025s) [345.035474] Subtest polling: SUCCESS (10.025s) [345.087492] [060/131] (681s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-mmap-wc) [345.278875] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-mmap-wc [345.280536] Subtest psr-2p-primscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s) [345.465540] [061/131] (681s left) syncobj_timeline (reset-signaled) [345.543205] Starting subtest: reset-signaled [345.544160] Subtest reset-signaled: SUCCESS (0.000s) [345.743941] [062/131] (680s left) kms_rmfb (rmfb-ioctl) [345.930176] Starting subtest: rmfb-ioctl [345.931083] Starting dynamic subtest: pipe-A-DP-3 [346.072553] Dynamic subtest pipe-A-DP-3: SUCCESS (0.142s) [346.089603] Starting dynamic subtest: pipe-B-DP-3 [346.334476] Dynamic subtest pipe-B-DP-3: SUCCESS (0.260s) [346.348697] Starting dynamic subtest: pipe-C-DP-3 [346.580450] Dynamic subtest pipe-C-DP-3: SUCCESS (0.245s) [346.594577] Starting dynamic subtest: pipe-D-DP-3 [346.826472] Dynamic subtest pipe-D-DP-3: SUCCESS (0.244s) [346.827417] Subtest rmfb-ioctl: SUCCESS (0.898s) [347.188822] [063/131] (679s left) gem_userptr_blits (create-destroy-sync) [347.284307] Starting subtest: create-destroy-sync [352.298106] Subtest create-destroy-sync: SUCCESS (5.015s) [352.484910] [064/131] (674s left) gem_exec_reloc (basic-gtt-cpu-active) [352.567218] Subtest basic-gtt-cpu-active: SKIP (0.000s) [352.650065] [065/131] (674s left) api_intel_allocator (execbuf-with-allocator) [352.731458] Starting subtest: execbuf-with-allocator [352.763971] Subtest execbuf-with-allocator: SUCCESS (0.034s) [352.964822] [066/131] (673s left) kms_lease (cursor-implicit-plane) [353.152539] Starting subtest: cursor-implicit-plane [353.154880] Starting dynamic subtest: pipe-A-DP-3 [353.511108] Dynamic subtest pipe-A-DP-3: SUCCESS (0.357s) [353.527528] Starting dynamic subtest: pipe-B-DP-3 [353.794856] Dynamic subtest pipe-B-DP-3: SUCCESS (0.281s) [353.810609] Starting dynamic subtest: pipe-C-DP-3 [354.084438] Dynamic subtest pipe-C-DP-3: SUCCESS (0.288s) [354.103121] Starting dynamic subtest: pipe-D-DP-3 [354.383549] Dynamic subtest pipe-D-DP-3: SUCCESS (0.297s) [354.384523] Subtest cursor-implicit-plane: SUCCESS (1.232s) [354.733526] [067/131] (672s left) kms_cursor_legacy (cursora-vs-flipb-atomic-transitions-varying-size) [354.925231] Starting subtest: cursorA-vs-flipB-atomic-transitions-varying-size [354.926997] Subtest cursorA-vs-flipB-atomic-transitions-varying-size: SKIP (0.001s) [355.101130] [068/131] (671s left) syncobj_wait (invalid-signal-illegal-handle) [355.176234] Starting subtest: invalid-signal-illegal-handle [355.177173] Subtest invalid-signal-illegal-handle: SUCCESS (0.000s) [355.374003] [069/131] (671s left) kms_psr (psr-primary-blt) [355.557275] Subtest psr-primary-blt: SKIP (0.000s) [355.619834] [070/131] (671s left) kms_ccs (crc-sprite-planes-basic-y-tiled-gen12-rc-ccs) [355.803403] Starting subtest: crc-sprite-planes-basic-y-tiled-gen12-rc-ccs [355.804271] Starting dynamic subtest: pipe-A-DP-3 [355.825470] Dynamic subtest pipe-A-DP-3: SKIP (0.002s) [355.838331] Starting dynamic subtest: pipe-B-DP-3 [355.859583] Dynamic subtest pipe-B-DP-3: SKIP (0.002s) [355.872122] Starting dynamic subtest: pipe-C-DP-3 [355.897942] Dynamic subtest pipe-C-DP-3: SKIP (0.002s) [355.911139] Starting dynamic subtest: pipe-D-DP-3 [355.934165] Dynamic subtest pipe-D-DP-3: SKIP (0.002s) [355.935737] Subtest crc-sprite-planes-basic-y-tiled-gen12-rc-ccs: SKIP (0.014s) [356.278217] [071/131] (671s left) kms_psr (pr-primary-blt) [356.461536] Subtest pr-primary-blt: SKIP (0.000s) [356.528816] [072/131] (670s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-move) [356.718055] Starting subtest: psr-2p-primscrn-spr-indfb-move [356.719853] Subtest psr-2p-primscrn-spr-indfb-move: SKIP (0.000s) [356.917292] [073/131] (670s left) kms_flip_scaled_crc (flip-64bpp-linear-to-16bpp-linear-downscaling) [357.105447] Starting subtest: flip-64bpp-linear-to-16bpp-linear-downscaling [357.106365] Starting dynamic subtest: pipe-A-valid-mode [359.628724] Dynamic subtest pipe-A-valid-mode: SUCCESS (2.522s) [359.630488] Subtest flip-64bpp-linear-to-16bpp-linear-downscaling: SUCCESS (2.525s) [359.919353] [074/131] (667s left) gem_exec_schedule (u-semaphore-noskip) [360.016772] Starting subtest: u-semaphore-noskip [360.770466] Subtest u-semaphore-noskip: SUCCESS (0.754s) [361.183949] [075/131] (666s left) i915_drm_fdinfo (memory-info-idle) [361.252521] Starting subtest: memory-info-idle [361.253447] Starting dynamic subtest: lmem0 [361.335536] Dynamic subtest lmem0: SUCCESS (0.082s) [361.351106] Starting dynamic subtest: smem0 [361.394968] Dynamic subtest smem0: SUCCESS (0.058s) [361.396068] Subtest memory-info-idle: SUCCESS (0.143s) [361.583732] [076/131] (666s left) i915_selftest (live) [362.749803] Starting subtest: live [362.750760] Starting dynamic subtest: sanitycheck [364.261169] Dynamic subtest sanitycheck: SUCCESS (1.511s) [364.273579] Starting dynamic subtest: uncore [365.739758] Dynamic subtest uncore: SUCCESS (1.477s) [365.752595] Starting dynamic subtest: workarounds [381.660154] Dynamic subtest workarounds: FAIL (15.716s) [381.669338] Starting dynamic subtest: gt_engines [383.724938] Dynamic subtest gt_engines: SUCCESS (2.264s) [383.735727] Starting dynamic subtest: gt_timelines [403.128917] Dynamic subtest gt_timelines: SUCCESS (19.398s) [403.140506] Starting dynamic subtest: gt_contexts [404.692189] Dynamic subtest gt_contexts: SUCCESS (1.562s) [404.706344] Starting dynamic subtest: gt_lrc [410.963885] Dynamic subtest gt_lrc: SUCCESS (6.269s) [410.974364] Starting dynamic subtest: gt_mocs [413.831167] Dynamic subtest gt_mocs: SUCCESS (2.866s) [413.842357] Starting dynamic subtest: gt_pm [417.929885] Dynamic subtest gt_pm: SUCCESS (4.097s) [417.940332] Starting dynamic subtest: gt_heartbeat [419.420077] Dynamic subtest gt_heartbeat: SUCCESS (1.489s) [419.430882] Starting dynamic subtest: gt_tlb [431.897169] Dynamic subtest gt_tlb: SUCCESS (12.475s) [431.908467] Starting dynamic subtest: requests [445.013170] Dynamic subtest requests: SUCCESS (13.114s) [445.024388] Starting dynamic subtest: migrate [450.271083] Dynamic subtest migrate: SUCCESS (5.257s) [450.282258] Starting dynamic subtest: active [451.767875] Dynamic subtest active: SUCCESS (1.496s) [451.778806] Starting dynamic subtest: objects [453.995186] Dynamic subtest objects: SUCCESS (2.226s) [454.010992] Starting dynamic subtest: mman [460.578238] Dynamic subtest mman: SUCCESS (6.582s) [460.589510] Starting dynamic subtest: dmabuf [462.193276] Dynamic subtest dmabuf: SUCCESS (1.614s) [462.204512] Starting dynamic subtest: vma [463.681062] Dynamic subtest vma: SUCCESS (1.486s) [463.691798] Starting dynamic subtest: coherency [467.911857] Dynamic subtest coherency: SUCCESS (4.230s) [467.922508] Starting dynamic subtest: gtt [478.014001] Dynamic subtest gtt: SUCCESS (10.102s) [478.027723] Starting dynamic subtest: gem [479.699851] Dynamic subtest gem: SUCCESS (1.684s) [479.710502] Starting dynamic subtest: evict [482.601075] Dynamic subtest evict: SUCCESS (2.900s) [482.611634] Starting dynamic subtest: hugepages [500.547961] Dynamic subtest hugepages: SUCCESS (17.947s) [500.559027] Starting dynamic subtest: gem_contexts [533.620106] Dynamic subtest gem_contexts: SUCCESS (33.075s) [533.631118] Starting dynamic subtest: client [535.157036] Dynamic subtest client: SUCCESS (1.536s) [535.168199] Starting dynamic subtest: gem_migrate [538.577983] Dynamic subtest gem_migrate: SUCCESS (3.420s) [538.588740] Starting dynamic subtest: reset [540.149098] Dynamic subtest reset: SUCCESS (1.570s) [540.160085] Starting dynamic subtest: memory_region [543.274057] Dynamic subtest memory_region: SUCCESS (3.124s) [543.285032] Starting dynamic subtest: hangcheck [573.522180] Dynamic subtest hangcheck: SUCCESS (30.251s) [573.535013] Starting dynamic subtest: execlists [575.046078] Dynamic subtest execlists: SUCCESS (1.523s) [575.058121] Starting dynamic subtest: ring_submission [576.546852] Dynamic subtest ring_submission: SUCCESS (1.500s) [576.557497] Starting dynamic subtest: perf [578.145799] Dynamic subtest perf: SUCCESS (1.598s) [578.156575] Starting dynamic subtest: slpc [585.317942] Dynamic subtest slpc: SUCCESS (7.172s) [585.328779] Starting dynamic subtest: guc [588.206981] Dynamic subtest guc: SUCCESS (2.888s) [588.219160] Starting dynamic subtest: guc_multi_lrc [589.751909] Dynamic subtest guc_multi_lrc: SUCCESS (1.544s) [589.762756] Starting dynamic subtest: guc_hang [592.033948] Dynamic subtest guc_hang: SUCCESS (2.281s) [592.044682] Starting dynamic subtest: late_gt_pm [593.566081] Dynamic subtest late_gt_pm: SUCCESS (1.531s) [593.567033] Subtest live: FAIL (230.827s) [593.598635] [FACT i915_selftest (live)] deleted: hardware.pci.drm_card_at_addr.0000:03:00.0: card0 [593.599565] [FACT i915_selftest (live)] deleted: kernel.kmod_is_loaded.i915: true [593.601375] [077/131] (434s left) gem_userptr_blits (nohangcheck) [595.140959] Starting subtest: nohangcheck [595.474135] Subtest nohangcheck: SUCCESS (0.333s) [595.633728] [FACT gem_userptr_blits (nohangcheck)] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card0 [595.635992] [FACT gem_userptr_blits (nohangcheck)] new: kernel.kmod_is_loaded.i915: true [595.638575] [078/131] (432s left) kms_ccs (crc-primary-basic-4-tiled-mtl-rc-ccs) [595.830211] Starting subtest: crc-primary-basic-4-tiled-mtl-rc-ccs [595.831066] Starting dynamic subtest: pipe-A-DP-3 [595.839203] Dynamic subtest pipe-A-DP-3: SKIP (0.001s) [595.851138] Starting dynamic subtest: pipe-B-DP-3 [595.859387] Dynamic subtest pipe-B-DP-3: SKIP (0.001s) [595.871927] Starting dynamic subtest: pipe-C-DP-3 [595.880091] Dynamic subtest pipe-C-DP-3: SKIP (0.001s) [595.891627] Starting dynamic subtest: pipe-D-DP-3 [595.908863] Dynamic subtest pipe-D-DP-3: SKIP (0.001s) [595.911172] Subtest crc-primary-basic-4-tiled-mtl-rc-ccs: SKIP (0.009s) [596.371761] [079/131] (431s left) gem_softpin (allocator-nopin) [596.455465] Starting subtest: allocator-nopin [596.693060] Subtest allocator-nopin: SUCCESS (0.237s) [596.910903] [080/131] (431s left) kms_draw_crc (draw-method-pwrite) [597.100356] Starting subtest: draw-method-pwrite [597.101185] Starting dynamic subtest: xrgb8888-untiled [597.529847] Dynamic subtest xrgb8888-untiled: SUCCESS (0.430s) [597.544956] Starting dynamic subtest: rgb565-untiled [597.946600] Dynamic subtest rgb565-untiled: SUCCESS (0.415s) [597.963069] Starting dynamic subtest: xrgb2101010-untiled [598.346153] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.398s) [598.359345] Starting dynamic subtest: xbgr16161616f-untiled [598.762752] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.416s) [598.780599] Starting dynamic subtest: xrgb8888-xtiled [599.313085] Dynamic subtest xrgb8888-xtiled: SUCCESS (0.549s) [599.329438] Starting dynamic subtest: rgb565-xtiled [599.879593] Dynamic subtest rgb565-xtiled: SUCCESS (0.565s) [599.896047] Starting dynamic subtest: xrgb2101010-xtiled [600.395874] Dynamic subtest xrgb2101010-xtiled: SUCCESS (0.515s) [600.410301] Starting dynamic subtest: xbgr16161616f-xtiled [600.995740] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (0.599s) [601.009810] Starting dynamic subtest: xrgb8888-4tiled [601.395866] Dynamic subtest xrgb8888-4tiled: SUCCESS (0.399s) [601.420296] Starting dynamic subtest: rgb565-4tiled [601.745766] Dynamic subtest rgb565-4tiled: SUCCESS (0.348s) [601.772294] Starting dynamic subtest: xrgb2101010-4tiled [602.162351] Dynamic subtest xrgb2101010-4tiled: SUCCESS (0.415s) [602.179359] Starting dynamic subtest: xbgr16161616f-4tiled [602.778892] Dynamic subtest xbgr16161616f-4tiled: SUCCESS (0.616s) [602.779841] Subtest draw-method-pwrite: SUCCESS (5.681s) [602.954490] [081/131] (425s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-180-hflip) [603.150529] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-180-hflip [603.152256] Subtest yf-tiled-max-hw-stride-64bpp-rotate-180-hflip: SKIP (0.000s) [603.365099] [082/131] (424s left) kms_frontbuffer_tracking (fbc-2p-primscrn-indfb-plflip-blt) [603.556172] Starting subtest: fbc-2p-primscrn-indfb-plflip-blt [603.557893] Subtest fbc-2p-primscrn-indfb-plflip-blt: SKIP (0.000s) [603.747233] [083/131] (424s left) syncobj_timeline (host-signal-points) [603.830401] Starting subtest: host-signal-points [603.837213] Subtest host-signal-points: SUCCESS (0.007s) [604.007439] [084/131] (424s left) gem_mmap_gtt (basic-small-bo) [604.082136] Subtest basic-small-bo: SKIP (0.000s) [604.157326] [085/131] (424s left) perf_pmu (semaphore-wait-idle) [604.228287] Starting subtest: semaphore-wait-idle [604.229170] Starting dynamic subtest: rcs0 [604.768504] Dynamic subtest rcs0: SUCCESS (0.540s) [604.784207] Starting dynamic subtest: bcs0 [605.282058] Dynamic subtest bcs0: SUCCESS (0.509s) [605.298651] Starting dynamic subtest: vcs0 [605.796611] Dynamic subtest vcs0: SUCCESS (0.510s) [605.813066] Starting dynamic subtest: vcs1 [606.311152] Dynamic subtest vcs1: SUCCESS (0.510s) [606.327680] Starting dynamic subtest: vecs0 [606.825939] Dynamic subtest vecs0: SUCCESS (0.510s) [606.842472] Starting dynamic subtest: vecs1 [607.340898] Dynamic subtest vecs1: SUCCESS (0.510s) [607.357172] Starting dynamic subtest: ccs0 [607.854328] Dynamic subtest ccs0: SUCCESS (0.509s) [607.858450] Subtest semaphore-wait-idle: SUCCESS (3.629s) [608.058412] [086/131] (420s left) kms_addfb_basic (no-handle) [608.135566] Starting subtest: no-handle [608.136454] Subtest no-handle: SUCCESS (0.000s) [608.419071] [087/131] (420s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-pwrite) [608.606125] Starting subtest: fbcpsr-rgb101010-draw-pwrite [608.607831] Subtest fbcpsr-rgb101010-draw-pwrite: SKIP (0.000s) [608.812987] [088/131] (419s left) gem_render_copy (yf-tiled-ccs-to-linear) [608.896757] Starting subtest: yf-tiled-ccs-to-linear [608.898779] Subtest yf-tiled-ccs-to-linear: SKIP (0.000s) [609.181557] [089/131] (419s left) kms_flip (wf_vblank-ts-check) [609.364225] Starting subtest: wf_vblank-ts-check [609.368900] Starting dynamic subtest: A-DP3 [617.631184] Dynamic subtest A-DP3: SUCCESS (8.264s) [617.646410] Starting dynamic subtest: B-DP3 [625.850000] Dynamic subtest B-DP3: SUCCESS (8.219s) [625.865434] Starting dynamic subtest: C-DP3 [633.896851] Dynamic subtest C-DP3: SUCCESS (8.045s) [633.911739] Starting dynamic subtest: D-DP3 [641.952371] Dynamic subtest D-DP3: SUCCESS (8.049s) [641.954584] Subtest wf_vblank-ts-check: SUCCESS (32.587s) [642.357298] [090/131] (386s left) gem_exec_schedule (deep) [642.564340] Starting subtest: deep [642.565278] Starting dynamic subtest: rcs0 [657.623769] Dynamic subtest rcs0: SUCCESS (15.051s) [657.636603] Starting dynamic subtest: bcs0 [672.733828] Dynamic subtest bcs0: SUCCESS (15.103s) [672.747180] Starting dynamic subtest: vcs0 [687.981749] Dynamic subtest vcs0: SUCCESS (15.242s) [687.995637] Starting dynamic subtest: vcs1 [703.183481] Dynamic subtest vcs1: SUCCESS (15.197s) [703.196717] Starting dynamic subtest: vecs0 [718.889556] Dynamic subtest vecs0: SUCCESS (15.702s) [718.902794] Starting dynamic subtest: vecs1 [734.914142] Dynamic subtest vecs1: SUCCESS (16.021s) [734.927462] Starting dynamic subtest: ccs0 [750.077254] Dynamic subtest ccs0: SUCCESS (15.162s) [750.078171] Subtest deep: SUCCESS (107.485s) [751.154903] [091/131] (277s left) kms_sequence (queue-idle) [751.344551] Starting subtest: queue-idle [751.346927] Starting dynamic subtest: pipe-A-DP-3 [753.703696] Dynamic subtest pipe-A-DP-3: SUCCESS (2.357s) [753.717226] Starting dynamic subtest: pipe-B-DP-3 [756.000830] Dynamic subtest pipe-B-DP-3: SUCCESS (2.295s) [756.017282] Starting dynamic subtest: pipe-C-DP-3 [758.287607] Dynamic subtest pipe-C-DP-3: SUCCESS (2.285s) [758.305988] Starting dynamic subtest: pipe-D-DP-3 [760.581635] Dynamic subtest pipe-D-DP-3: SUCCESS (2.291s) [760.582528] Subtest queue-idle: SUCCESS (9.236s) [760.918106] [092/131] (268s left) gem_gtt_cpu_tlb [761.114666] [093/131] (267s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-mmap-wc) [761.304121] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-mmap-wc [761.305865] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s) [761.521963] [094/131] (267s left) gem_eio (create-ext) [761.840374] Starting subtest: create-ext [762.347503] Subtest create-ext: SUCCESS (0.507s) [762.640445] [095/131] (266s left) gem_partial_pwrite_pread (writes-after-reads-uncached) [762.722871] Subtest writes-after-reads-uncached: SKIP (0.000s) [762.846267] [096/131] (266s left) sysfs_preempt_timeout (idempotent) [762.931317] Starting subtest: idempotent [762.932231] Starting dynamic subtest: vecs0 [762.933118] Dynamic subtest vecs0: SUCCESS (0.001s) [762.947506] Starting dynamic subtest: ccs0 [762.948623] Dynamic subtest ccs0: SUCCESS (0.001s) [762.962400] Starting dynamic subtest: vcs0 [762.963633] Dynamic subtest vcs0: SUCCESS (0.001s) [762.977386] Starting dynamic subtest: bcs0 [762.978645] Dynamic subtest bcs0: SUCCESS (0.001s) [762.991896] Starting dynamic subtest: vecs1 [762.993197] Dynamic subtest vecs1: SUCCESS (0.001s) [763.006484] Starting dynamic subtest: rcs0 [763.007798] Dynamic subtest rcs0: SUCCESS (0.001s) [763.021046] Starting dynamic subtest: vcs1 [763.022336] Dynamic subtest vcs1: SUCCESS (0.001s) [763.023609] Subtest idempotent: SUCCESS (0.013s) [763.076824] [097/131] (266s left) gem_busy (semaphore) [763.354424] Subtest semaphore: SKIP (0.000s) [763.707625] [098/131] (265s left) sriov_basic (enable-vfs-bind-unbind-each) [763.785140] Subtest enable-vfs-bind-unbind-each: SKIP (0.000s) [763.855014] [099/131] (265s left) kms_pm_lpsp (screens-disabled) [765.052430] Starting subtest: screens-disabled [765.054401] Subtest screens-disabled: SKIP (0.000s) [765.205705] [100/131] (264s left) gem_exec_capture (capture-invisible) [765.292260] Starting subtest: capture-invisible [765.293176] Starting dynamic subtest: lmem0 [765.295201] Dynamic subtest lmem0: SKIP (0.000s) [765.308969] Starting dynamic subtest: smem0 [765.311099] Dynamic subtest smem0: SKIP (0.000s) [765.313094] Subtest capture-invisible: SKIP (0.002s) [765.489989] [101/131] (264s left) gem_lmem_swapping (verify-ccs) [768.139209] Starting subtest: verify-ccs [768.140172] Starting dynamic subtest: lmem0 [813.365507] Dynamic subtest lmem0: SUCCESS (45.226s) [813.366430] Subtest verify-ccs: SUCCESS (45.227s) [815.232681] [FACT gem_lmem_swapping (verify-ccs)] deleted: hardware.pci.drm_card_at_addr.0000:03:00.0: card0 [815.233762] [FACT gem_lmem_swapping (verify-ccs)] deleted: kernel.kmod_is_loaded.i915: true [815.235944] [102/131] (214s left) kms_joiner (basic-force-ultra-joiner) [816.866194] Starting subtest: basic-force-ultra-joiner [816.867942] Subtest basic-force-ultra-joiner: SKIP (0.000s) [817.062405] [FACT kms_joiner (basic-force-ultra-joiner)] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card0 [817.064673] [FACT kms_joiner (basic-force-ultra-joiner)] new: kernel.kmod_is_loaded.i915: true [817.067925] [103/131] (212s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-mmap-wc) [817.260862] Starting subtest: psr-1p-primscrn-cur-indfb-draw-mmap-wc [817.262450] Subtest psr-1p-primscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s) [817.456849] [104/131] (212s left) kms_color (legacy-gamma) [817.649392] Starting subtest: legacy-gamma [817.650238] Starting dynamic subtest: pipe-A-DP-3 [818.327254] Dynamic subtest pipe-A-DP-3: SUCCESS (0.677s) [818.345466] Starting dynamic subtest: pipe-B-DP-3 [818.877803] Dynamic subtest pipe-B-DP-3: SUCCESS (0.548s) [818.891135] Starting dynamic subtest: pipe-C-DP-3 [819.465453] Dynamic subtest pipe-C-DP-3: SUCCESS (0.586s) [819.484729] Starting dynamic subtest: pipe-D-DP-3 [820.077154] Dynamic subtest pipe-D-DP-3: SUCCESS (0.611s) [820.078168] Subtest legacy-gamma: SUCCESS (2.429s) [820.410993] [105/131] (209s left) gem_exec_schedule (wide) [820.636498] Starting subtest: wide [820.637441] Starting dynamic subtest: rcs0 [833.855366] Dynamic subtest rcs0: SUCCESS (13.226s) [833.872957] Starting dynamic subtest: bcs0 [847.740007] Dynamic subtest bcs0: SUCCESS (13.830s) [847.775814] Starting dynamic subtest: vcs0 [861.945717] Dynamic subtest vcs0: SUCCESS (14.260s) [861.960695] Starting dynamic subtest: vcs1 [875.909898] Dynamic subtest vcs1: SUCCESS (13.964s) [875.925767] Starting dynamic subtest: vecs0 [890.284750] Dynamic subtest vecs0: SUCCESS (14.373s) [890.299457] Starting dynamic subtest: vecs1 [904.364845] Dynamic subtest vecs1: SUCCESS (14.076s) [904.393264] Starting dynamic subtest: ccs0 [918.693531] Dynamic subtest ccs0: SUCCESS (14.327s) [918.694329] Subtest wide: SUCCESS (98.065s) [920.382567] [106/131] (109s left) kms_flip_scaled_crc (flip-32bpp-yftileccs-to-64bpp-yftile-upscaling) [920.569292] Starting subtest: flip-32bpp-yftileccs-to-64bpp-yftile-upscaling [920.570239] Starting dynamic subtest: pipe-A-valid-mode [920.660417] Dynamic subtest pipe-A-valid-mode: SKIP (0.089s) [920.662388] Subtest flip-32bpp-yftileccs-to-64bpp-yftile-upscaling: SKIP (0.091s) [920.911335] [107/131] (109s left) kms_big_fb (linear-64bpp-rotate-180) [921.108929] Starting subtest: linear-64bpp-rotate-180 [923.417942] Subtest linear-64bpp-rotate-180: SUCCESS (2.308s) [923.634232] [108/131] (106s left) gem_ppgtt (blt-vs-render-ctxn) [923.718341] Starting subtest: blt-vs-render-ctxN [956.756514] Subtest blt-vs-render-ctxN: SUCCESS (33.036s) [956.959952] [109/131] ( 73s left) kms_frontbuffer_tracking (psr-2p-scndscrn-shrfb-plflip-blt) [957.193145] Starting subtest: psr-2p-scndscrn-shrfb-plflip-blt [957.194946] Subtest psr-2p-scndscrn-shrfb-plflip-blt: SKIP (0.000s) [957.381375] [110/131] ( 72s left) kms_chamelium_frames (dp-frame-dump) [957.645511] Subtest dp-frame-dump: SKIP (0.000s) [957.792774] [111/131] ( 72s left) kms_psr2_su (page_flip-nv12) [957.876270] Subtest page_flip-NV12: SKIP (0.000s) [957.952480] [112/131] ( 72s left) gem_tiling_max_stride [958.125158] [113/131] ( 72s left) perf_pmu (busy-idle) [958.200012] Starting subtest: busy-idle [958.200994] Starting dynamic subtest: rcs0 [958.913431] Dynamic subtest rcs0: SUCCESS (0.712s) [958.932661] Starting dynamic subtest: bcs0 [959.581637] Dynamic subtest bcs0: SUCCESS (0.664s) [959.601160] Starting dynamic subtest: vcs0 [960.248579] Dynamic subtest vcs0: SUCCESS (0.663s) [960.266137] Starting dynamic subtest: vcs1 [960.915655] Dynamic subtest vcs1: SUCCESS (0.663s) [960.935245] Starting dynamic subtest: vecs0 [961.583727] Dynamic subtest vecs0: SUCCESS (0.664s) [961.601346] Starting dynamic subtest: vecs1 [962.246541] Dynamic subtest vecs1: SUCCESS (0.658s) [962.264437] Starting dynamic subtest: ccs0 [962.913663] Dynamic subtest ccs0: SUCCESS (0.663s) [962.918276] Subtest busy-idle: SUCCESS (4.715s) [963.102532] [114/131] ( 67s left) dmabuf_sync_file (export-before-signal) [963.174129] Starting subtest: export-before-signal [963.175846] Subtest export-before-signal: SUCCESS (0.002s) [963.302629] [115/131] ( 67s left) gem_exec_reloc (basic-cpu-read) [963.386384] Subtest basic-cpu-read: SKIP (0.000s) [963.484014] [116/131] ( 67s left) kms_hdr (bpc-switch) [963.677364] Starting subtest: bpc-switch [966.882112] Starting dynamic subtest: pipe-A-DP-3 [967.945284] Dynamic subtest pipe-A-DP-3: SUCCESS (1.062s) [967.950782] Subtest bpc-switch: SUCCESS (4.270s) [968.332758] [117/131] ( 62s left) perf (i915-ref-count) [968.510602] Starting subtest: i915-ref-count [968.801424] Subtest i915-ref-count: SUCCESS (0.290s) [968.984679] [118/131] ( 61s left) gem_ctx_isolation (nonpriv) [969.078103] Starting subtest: nonpriv [969.079096] Starting dynamic subtest: rcs0 [969.933413] Dynamic subtest rcs0: SUCCESS (0.855s) [969.950443] Starting dynamic subtest: bcs0 [970.836398] Dynamic subtest bcs0: SUCCESS (0.902s) [970.852612] Starting dynamic subtest: vcs0 [971.723234] Dynamic subtest vcs0: SUCCESS (0.886s) [971.739881] Starting dynamic subtest: vcs1 [972.629196] Dynamic subtest vcs1: SUCCESS (0.905s) [972.645491] Starting dynamic subtest: vecs0 [973.547319] Dynamic subtest vecs0: SUCCESS (0.917s) [973.563711] Starting dynamic subtest: vecs1 [974.449886] Dynamic subtest vecs1: SUCCESS (0.901s) [974.465460] Starting dynamic subtest: ccs0 [975.332071] Dynamic subtest ccs0: SUCCESS (0.881s) [975.333035] Subtest nonpriv: SUCCESS (6.254s) [975.665029] [119/131] ( 55s left) gem_render_copy (y-tiled-to-vebox-x-tiled) [975.750734] Starting subtest: y-tiled-to-vebox-x-tiled [975.752924] Subtest y-tiled-to-vebox-x-tiled: SKIP (0.000s) [976.016901] [120/131] ( 54s left) kms_atomic_transition (plane-use-after-nonblocking-unbind) [976.220406] Starting subtest: plane-use-after-nonblocking-unbind [976.221386] Starting dynamic subtest: pipe-A-DP-3 [976.300239] Dynamic subtest pipe-A-DP-3: SUCCESS (0.080s) [976.403288] Starting dynamic subtest: pipe-B-DP-3 [976.600043] Dynamic subtest pipe-B-DP-3: SUCCESS (0.221s) [976.674994] Subtest plane-use-after-nonblocking-unbind: SUCCESS (0.455s) [976.968037] [121/131] ( 54s left) i915_hangman (engine-error-state-capture) [977.061303] Starting subtest: engine-error-state-capture [977.062193] Starting dynamic subtest: rcs0 [979.297337] Dynamic subtest rcs0: SUCCESS (2.236s) [979.312883] Starting dynamic subtest: bcs0 [983.250580] Dynamic subtest bcs0: SUCCESS (3.952s) [983.266531] Starting dynamic subtest: vcs0 [987.283342] Dynamic subtest vcs0: SUCCESS (4.031s) [987.299450] Starting dynamic subtest: vcs1 [991.294608] Dynamic subtest vcs1: SUCCESS (4.010s) [991.314420] Starting dynamic subtest: vecs0 [994.292748] Dynamic subtest vecs0: SUCCESS (2.996s) [994.320930] Starting dynamic subtest: vecs1 [998.287333] Dynamic subtest vecs1: SUCCESS (3.993s) [998.303400] Starting dynamic subtest: ccs0 [1002.294666] Dynamic subtest ccs0: SUCCESS (4.006s) [1002.295732] Subtest engine-error-state-capture: SUCCESS (25.234s) [1002.522149] [122/131] ( 28s left) gem_exec_schedule (pi-shared-iova) [1002.759645] Starting subtest: pi-shared-iova [1002.764359] Starting dynamic subtest: rcs0 [1003.032565] Dynamic subtest rcs0: SUCCESS (0.272s) [1003.047022] Starting dynamic subtest: bcs0 [1003.209041] Dynamic subtest bcs0: SUCCESS (0.175s) [1003.223541] Starting dynamic subtest: vcs0 [1003.402498] Dynamic subtest vcs0: SUCCESS (0.192s) [1003.417133] Starting dynamic subtest: vcs1 [1003.589388] Dynamic subtest vcs1: SUCCESS (0.186s) [1003.604000] Starting dynamic subtest: vecs0 [1003.775282] Dynamic subtest vecs0: SUCCESS (0.185s) [1003.789995] Starting dynamic subtest: vecs1 [1003.963763] Dynamic subtest vecs1: SUCCESS (0.187s) [1003.978378] Starting dynamic subtest: ccs0 [1004.154417] Dynamic subtest ccs0: SUCCESS (0.190s) [1004.155465] Subtest pi-shared-iova: SUCCESS (1.396s) [1004.588819] [123/131] ( 26s left) syncobj_wait (invalid-reset-illegal-handle) [1004.668258] Starting subtest: invalid-reset-illegal-handle [1004.669176] Subtest invalid-reset-illegal-handle: SUCCESS (0.000s) [1004.869480] [124/131] ( 26s left) syncobj_wait (single-wait-all-for-submit-signaled) [1004.966352] Starting subtest: single-wait-all-for-submit-signaled [1004.967284] Subtest single-wait-all-for-submit-signaled: SUCCESS (0.000s) [1005.186212] [125/131] ( 26s left) kms_cursor_crc (cursor-sliding-512x170) [1005.666570] Starting subtest: cursor-sliding-512x170 [1005.669932] Subtest cursor-sliding-512x170: SKIP (0.001s) [1005.940837] [126/131] ( 25s left) kms_chamelium_hpd (hdmi-hpd-fast) [1006.217813] Subtest hdmi-hpd-fast: SKIP (0.000s) [1006.371768] [127/131] ( 25s left) gem_ctx_persistence (hostile) [1006.460525] Starting subtest: hostile [1014.710500] Subtest hostile: SUCCESS (8.245s) [1014.947146] [128/131] ( 16s left) kms_frontbuffer_tracking (fbc-rgb565-draw-blt) [1015.135242] Starting subtest: fbc-rgb565-draw-blt [1017.829598] Subtest fbc-rgb565-draw-blt: SUCCESS (2.695s) [1018.033726] [129/131] ( 13s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-pwrite) [1018.234312] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-pwrite [1018.236125] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-pwrite: SKIP (0.000s) [1018.429644] [130/131] ( 13s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-gtt) [1018.621310] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-gtt [1018.623086] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s) [1018.830066] [131/131] ( 12s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-move) [1019.028041] Starting subtest: fbc-2p-scndscrn-spr-indfb-move [1019.029860] Subtest fbc-2p-scndscrn-spr-indfb-move: SKIP (0.000s) [1019.231465] 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.