[69.564735] Initializing watchdogs [69.564817] /dev/watchdog0 [69.596202] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:03:00.0: 8086:4905 Intel Dg1 (Gen12) DG1 [Iris Xe MAX Graphics] [69.611369] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card0 [69.616243] [FACT before any test] new: kernel.kmod_is_loaded.i915: true [69.619657] [001/156] (960s left) syncobj_timeline (multi-wait-all-available-submitted) [69.675894] Starting subtest: multi-wait-all-available-submitted [69.677568] Subtest multi-wait-all-available-submitted: SUCCESS (0.001s) [69.811447] [002/156] (960s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-mmap-wc) [71.319144] Starting subtest: psr-2p-primscrn-pri-indfb-draw-mmap-wc [71.323504] Subtest psr-2p-primscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s) [71.598136] [003/156] (958s left) kms_cursor_legacy (cursora-vs-flipb-toggle) [73.110820] Starting subtest: cursorA-vs-flipB-toggle [73.116047] Subtest cursorA-vs-flipB-toggle: SKIP (0.001s) [73.216458] [004/156] (957s left) kms_dirtyfb (default-dirtyfb-ioctl) [74.717774] Starting subtest: default-dirtyfb-ioctl [74.719352] Starting dynamic subtest: A-HDMI-A-4 [76.160185] Dynamic subtest A-HDMI-A-4: SUCCESS (1.442s) [76.161890] Subtest default-dirtyfb-ioctl: SUCCESS (1.443s) [76.325968] [005/156] (954s left) gem_exec_schedule (u-semaphore-resolve) [76.394532] Starting subtest: u-semaphore-resolve [76.462332] Subtest u-semaphore-resolve: SUCCESS (0.068s) [76.913564] [006/156] (953s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-mmap-wc) [78.413114] Starting subtest: psr-2p-primscrn-cur-indfb-draw-mmap-wc [78.416242] Subtest psr-2p-primscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s) [78.586406] [007/156] (952s left) kms_frontbuffer_tracking (hdr-suspend) [80.086625] Starting subtest: hdr-suspend [80.089619] Subtest hdr-suspend: SKIP (0.000s) [80.233495] [008/156] (950s left) gem_mmap_wc (invalid-flags) [80.297657] Subtest invalid-flags: SKIP (0.000s) [80.367434] [009/156] (950s left) gem_spin_batch (legacy) [80.429401] Starting subtest: legacy [80.431034] Starting dynamic subtest: default [83.681342] Dynamic subtest default: SUCCESS (3.245s) [83.691500] Starting dynamic subtest: render [86.916776] Dynamic subtest render: SUCCESS (3.233s) [86.926538] Starting dynamic subtest: bsd [90.151385] Dynamic subtest bsd: SUCCESS (3.232s) [90.160924] Starting dynamic subtest: bsd1 [93.384404] Dynamic subtest bsd1: SUCCESS (3.230s) [93.396407] Starting dynamic subtest: bsd2 [96.612510] Dynamic subtest bsd2: SUCCESS (3.230s) [96.622259] Starting dynamic subtest: blt [99.847117] Dynamic subtest blt: SUCCESS (3.232s) [99.857311] Starting dynamic subtest: vebox [103.082372] Dynamic subtest vebox: SUCCESS (3.230s) [103.085256] Subtest legacy: SUCCESS (22.649s) [103.342095] [010/156] (927s left) kms_ccs (bad-rotation-90-4-tiled-dg2-rc-ccs-cc) [104.833178] Starting subtest: bad-rotation-90-4-tiled-dg2-rc-ccs-cc [104.834746] Starting dynamic subtest: pipe-A-HDMI-A-4 [104.849740] Dynamic subtest pipe-A-HDMI-A-4: SKIP (0.000s) [104.859598] Starting dynamic subtest: pipe-B-HDMI-A-4 [104.874778] Dynamic subtest pipe-B-HDMI-A-4: SKIP (0.000s) [104.884303] Starting dynamic subtest: pipe-C-HDMI-A-4 [104.899739] Dynamic subtest pipe-C-HDMI-A-4: SKIP (0.000s) [104.909198] Starting dynamic subtest: pipe-D-HDMI-A-4 [104.925813] Dynamic subtest pipe-D-HDMI-A-4: SKIP (0.000s) [104.929488] Subtest bad-rotation-90-4-tiled-dg2-rc-ccs-cc: SKIP (0.005s) [105.102602] [011/156] (925s left) kms_big_fb (yf-tiled-8bpp-rotate-90) [106.617047] Starting subtest: yf-tiled-8bpp-rotate-90 [106.620507] Subtest yf-tiled-8bpp-rotate-90: SKIP (0.000s) [106.800853] [012/156] (924s left) kms_color_pipeline (plane-lut1d-post-ctm3x4) [108.291726] Starting subtest: plane-lut1d-post-ctm3x4 [108.489805] Starting dynamic subtest: pipe-A-plane-0 [108.755799] Dynamic subtest pipe-A-plane-0: SUCCESS (0.266s) [108.791435] Starting dynamic subtest: pipe-A-plane-1 [108.953648] Dynamic subtest pipe-A-plane-1: SUCCESS (0.198s) [108.963783] Starting dynamic subtest: pipe-A-plane-2 [109.138859] Dynamic subtest pipe-A-plane-2: SUCCESS (0.184s) [109.426885] Starting dynamic subtest: pipe-B-plane-0 [109.582926] Dynamic subtest pipe-B-plane-0: SUCCESS (0.166s) [109.597364] Starting dynamic subtest: pipe-B-plane-1 [109.766498] Dynamic subtest pipe-B-plane-1: SUCCESS (0.182s) [109.798739] Starting dynamic subtest: pipe-B-plane-2 [109.967463] Dynamic subtest pipe-B-plane-2: SUCCESS (0.199s) [110.290564] Starting dynamic subtest: pipe-C-plane-0 [110.458218] Dynamic subtest pipe-C-plane-0: SUCCESS (0.200s) [110.472337] Starting dynamic subtest: pipe-C-plane-1 [110.656947] Dynamic subtest pipe-C-plane-1: SUCCESS (0.199s) [110.685226] Starting dynamic subtest: pipe-C-plane-2 [110.876650] Dynamic subtest pipe-C-plane-2: SUCCESS (0.218s) [111.174724] Starting dynamic subtest: pipe-D-plane-0 [111.363592] Dynamic subtest pipe-D-plane-0: SUCCESS (0.216s) [111.390999] Starting dynamic subtest: pipe-D-plane-1 [111.563729] Dynamic subtest pipe-D-plane-1: SUCCESS (0.198s) [111.594845] Starting dynamic subtest: pipe-D-plane-2 [111.780441] Dynamic subtest pipe-D-plane-2: SUCCESS (0.215s) [111.835459] Subtest plane-lut1d-post-ctm3x4: SUCCESS (3.543s) [112.029813] [013/156] (919s left) kms_frontbuffer_tracking (fbchdr-1p-offscreen-pri-shrfb-draw-blt) [113.528070] Starting subtest: fbchdr-1p-offscreen-pri-shrfb-draw-blt [113.531040] Subtest fbchdr-1p-offscreen-pri-shrfb-draw-blt: SKIP (0.000s) [113.718812] [014/156] (917s left) syncobj_wait (wait-all-delayed-signal) [113.770324] Starting subtest: wait-all-delayed-signal [113.876494] Subtest wait-all-delayed-signal: SUCCESS (0.103s) [114.076818] [015/156] (917s left) kms_frontbuffer_tracking (hdr-2p-scndscrn-spr-indfb-fullscreen) [115.575495] Starting subtest: hdr-2p-scndscrn-spr-indfb-fullscreen [115.580885] Subtest hdr-2p-scndscrn-spr-indfb-fullscreen: SKIP (0.000s) [115.739647] [016/156] (915s left) gem_exec_capture (userptr) [115.801303] Starting subtest: userptr [116.698563] Subtest userptr: SUCCESS (0.897s) [116.907577] [017/156] (914s left) kms_frontbuffer_tracking (psrhdr-2p-primscrn-cur-indfb-draw-blt) [118.405204] Starting subtest: psrhdr-2p-primscrn-cur-indfb-draw-blt [118.408190] Subtest psrhdr-2p-primscrn-cur-indfb-draw-blt: SKIP (0.000s) [118.585834] [018/156] (913s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-primscrn-pri-shrfb-draw-blt) [120.087888] Starting subtest: fbcpsrhdr-1p-primscrn-pri-shrfb-draw-blt [120.090863] Subtest fbcpsrhdr-1p-primscrn-pri-shrfb-draw-blt: SKIP (0.000s) [120.226298] [019/156] (911s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-mmap-wc) [121.739093] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-mmap-wc [121.742151] Subtest psr-2p-scndscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s) [121.913497] [020/156] (909s left) gem_mmap_wc (write-cpu-read-wc-unflushed) [121.968128] Subtest write-cpu-read-wc-unflushed: SKIP (0.000s) [122.045801] [021/156] (909s left) gem_userptr_blits (nohangcheck) [122.118113] Starting subtest: nohangcheck [122.262165] Subtest nohangcheck: SUCCESS (0.142s) [122.448218] [022/156] (909s left) kms_content_protection (dp-mst-type-0-hdcp14) [123.996289] Starting subtest: dp-mst-type-0-hdcp14 [123.999846] Subtest dp-mst-type-0-hdcp14: SKIP (0.000s) [124.220186] [023/156] (907s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-primscrn-shrfb-msflip-blt) [125.724318] Starting subtest: fbcpsrhdr-2p-primscrn-shrfb-msflip-blt [125.727427] Subtest fbcpsrhdr-2p-primscrn-shrfb-msflip-blt: SKIP (0.000s) [125.885897] [024/156] (906s left) gem_mmap_gtt (cpuset-basic-small-copy) [125.944818] Subtest cpuset-basic-small-copy: SKIP (0.000s) [126.012214] [025/156] (906s left) kms_atomic_interruptible (legacy-cursor) [127.504573] Starting subtest: legacy-cursor [127.506162] Starting dynamic subtest: pipe-A-HDMI-A-4 [133.717237] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (6.213s) [133.719086] Subtest legacy-cursor: SUCCESS (6.214s) [133.929843] [026/156] (898s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-fullscreen) [135.430138] Starting subtest: fbc-2p-scndscrn-spr-indfb-fullscreen [135.432843] Subtest fbc-2p-scndscrn-spr-indfb-fullscreen: SKIP (0.000s) [135.599608] [027/156] (896s left) kms_frontbuffer_tracking (fbcpsr-1p-pri-indfb-multidraw) [137.102774] Starting subtest: fbcpsr-1p-pri-indfb-multidraw [137.106357] Subtest fbcpsr-1p-pri-indfb-multidraw: SKIP (0.000s) [137.271246] [028/156] (895s left) i915_query (query-regions-sanity-check) [137.327307] Starting subtest: query-regions-sanity-check [137.357606] Subtest query-regions-sanity-check: SUCCESS (0.031s) [137.568018] [029/156] (895s left) gem_eio (in-flight-contexts-10ms) [137.747844] Starting subtest: in-flight-contexts-10ms [150.905847] Subtest in-flight-contexts-10ms: SUCCESS (13.159s) [152.474625] [030/156] (880s left) kms_addfb_basic (invalid-get-prop-any) [152.536860] Starting subtest: invalid-get-prop-any [152.538617] Subtest invalid-get-prop-any: SUCCESS (0.000s) [154.192935] [031/156] (878s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-blt) [155.695861] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-blt [155.699160] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-blt: SKIP (0.000s) [155.835949] [032/156] (877s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-primscrn-cur-indfb-move) [157.345654] Starting subtest: fbcpsrhdr-2p-primscrn-cur-indfb-move [157.348821] Subtest fbcpsrhdr-2p-primscrn-cur-indfb-move: SKIP (0.000s) [157.525633] [033/156] (875s left) kms_frontbuffer_tracking (hdr-2p-primscrn-pri-shrfb-draw-mmap-gtt) [159.025455] Starting subtest: hdr-2p-primscrn-pri-shrfb-draw-mmap-gtt [159.028538] Subtest hdr-2p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s) [159.218640] [034/156] (873s left) kms_frontbuffer_tracking (hdr-2p-scndscrn-pri-indfb-draw-mmap-cpu) [160.718383] Starting subtest: hdr-2p-scndscrn-pri-indfb-draw-mmap-cpu [160.721760] Subtest hdr-2p-scndscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s) [160.887492] [035/156] (872s left) gem_render_copy (y-tiled-to-vebox-x-tiled) [160.946856] Starting subtest: y-tiled-to-vebox-x-tiled [160.948756] Starting dynamic subtest: smem [161.030240] Dynamic subtest smem: SUCCESS (0.083s) [161.041566] Starting dynamic subtest: lmem0 [161.784367] Dynamic subtest lmem0: SUCCESS (0.750s) [161.786222] Subtest y-tiled-to-vebox-x-tiled: SUCCESS (0.834s) [162.101901] [036/156] (871s left) kms_frontbuffer_tracking (psrhdr-2p-scndscrn-cur-indfb-move) [163.600124] Starting subtest: psrhdr-2p-scndscrn-cur-indfb-move [163.603414] Subtest psrhdr-2p-scndscrn-cur-indfb-move: SKIP (0.000s) [163.759761] [037/156] (869s left) syncobj_timeline (single-wait-available-signaled) [163.816042] Starting subtest: single-wait-available-signaled [163.817805] Subtest single-wait-available-signaled: SUCCESS (0.000s) [163.942592] [038/156] (869s left) kms_plane (pixel-format-y-tiled-modifier-source-clamping) [165.434193] Starting subtest: pixel-format-y-tiled-modifier-source-clamping [165.462238] Starting dynamic subtest: pipe-A-plane-0 [166.179736] Dynamic subtest pipe-A-plane-0: SUCCESS (0.717s) [166.216450] Starting dynamic subtest: pipe-A-plane-3 [166.712833] Dynamic subtest pipe-A-plane-3: SUCCESS (0.532s) [166.755725] Starting dynamic subtest: pipe-A-plane-5 [167.196100] Dynamic subtest pipe-A-plane-5: SUCCESS (0.482s) [167.389268] Starting dynamic subtest: pipe-B-plane-0 [167.929980] Dynamic subtest pipe-B-plane-0: SUCCESS (0.550s) [167.966976] Starting dynamic subtest: pipe-B-plane-3 [168.446673] Dynamic subtest pipe-B-plane-3: SUCCESS (0.515s) [168.476442] Starting dynamic subtest: pipe-B-plane-5 [168.963227] Dynamic subtest pipe-B-plane-5: SUCCESS (0.516s) [169.018970] Subtest pixel-format-y-tiled-modifier-source-clamping: SUCCESS (3.585s) [169.228782] [039/156] (864s left) kms_force_connector_basic (force-edid) [169.363237] Starting subtest: force-edid [169.385053] Subtest force-edid: SUCCESS (0.022s) [171.039657] [040/156] (862s left) kms_chamelium_color (ctm-negative) [172.561208] Subtest ctm-negative: SKIP (0.000s) [172.631844] [041/156] (861s left) gem_exec_params (rel-constants-invalid-rel-gen5) [172.685956] Starting subtest: rel-constants-invalid-rel-gen5 [172.687668] Subtest rel-constants-invalid-rel-gen5: SUCCESS (0.000s) [172.847740] [042/156] (861s left) gem_mmap_gtt (big-copy-xy) [172.919524] Subtest big-copy-XY: SKIP (0.000s) [172.996475] [043/156] (860s left) kms_addfb_basic (addfb25-bad-modifier) [174.487883] Starting subtest: addfb25-bad-modifier [174.489801] Subtest addfb25-bad-modifier: SUCCESS (0.000s) [174.619784] [044/156] (859s left) gem_exec_reloc (basic-write-read) [174.698693] Subtest basic-write-read: SKIP (0.000s) [174.859407] [045/156] (859s left) kms_frontbuffer_tracking (psrhdr-1p-offscreen-pri-shrfb-draw-pwrite) [176.358175] Starting subtest: psrhdr-1p-offscreen-pri-shrfb-draw-pwrite [176.361793] Subtest psrhdr-1p-offscreen-pri-shrfb-draw-pwrite: SKIP (0.000s) [176.536708] [046/156] (857s left) kms_psr2_sf (fbc-pr-overlay-primary-update-sf-dmg-area) [178.031315] Subtest fbc-pr-overlay-primary-update-sf-dmg-area: SKIP (0.000s) [178.112274] [047/156] (856s left) kms_plane_alpha_blend (coverage-vs-premult-vs-constant) [179.603603] Starting subtest: coverage-vs-premult-vs-constant [179.862847] Starting dynamic subtest: pipe-A-HDMI-A-4 [180.292938] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (0.430s) [180.304201] Starting dynamic subtest: pipe-D-HDMI-A-4 [180.743811] Dynamic subtest pipe-D-HDMI-A-4: SUCCESS (0.449s) [180.745251] Subtest coverage-vs-premult-vs-constant: SUCCESS (1.141s) [180.968803] [048/156] (853s left) gem_exec_reloc (basic-write-gtt) [181.044744] Subtest basic-write-gtt: SKIP (0.000s) [181.135764] [049/156] (853s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-move) [182.635363] Starting subtest: fbc-2p-scndscrn-cur-indfb-move [182.638402] Subtest fbc-2p-scndscrn-cur-indfb-move: SKIP (0.000s) [182.780398] [050/156] (851s left) gem_ctx_engines (execute-one) [182.845585] Starting subtest: execute-one [185.209338] Subtest execute-one: SUCCESS (2.364s) [185.505925] [051/156] (849s left) kms_chamelium_hpd (dp-hpd-with-enabled-mode) [187.038273] Subtest dp-hpd-with-enabled-mode: SKIP (0.000s) [187.162029] [052/156] (847s left) kms_flip_scaled_crc (flip-64bpp-linear-to-16bpp-linear-downscaling) [188.653740] Starting subtest: flip-64bpp-linear-to-16bpp-linear-downscaling [188.655260] Starting dynamic subtest: pipe-A-valid-mode [189.929828] Dynamic subtest pipe-A-valid-mode: SUCCESS (1.277s) [189.931485] Subtest flip-64bpp-linear-to-16bpp-linear-downscaling: SUCCESS (1.278s) [190.123568] [053/156] (844s left) kms_flip (flip-vs-suspend) [191.615124] Starting subtest: flip-vs-suspend [191.618982] Starting dynamic subtest: A-HDMI-A4 [234.410269] Dynamic subtest A-HDMI-A4: SUCCESS (20.330s) [234.411853] Subtest flip-vs-suspend: SUCCESS (20.334s) [239.628015] [054/156] (800s left) kms_big_fb (linear-16bpp-rotate-90) [241.143907] Starting subtest: linear-16bpp-rotate-90 [241.240452] Subtest linear-16bpp-rotate-90: SKIP (0.095s) [241.387129] [055/156] (798s left) kms_vblank (wait-forked) [242.880630] Starting subtest: wait-forked [242.882228] Starting dynamic subtest: pipe-A-HDMI-A-4 [245.294328] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (2.413s) [245.311465] Starting dynamic subtest: pipe-D-HDMI-A-4 [247.566704] Dynamic subtest pipe-D-HDMI-A-4: SUCCESS (2.268s) [247.568092] Subtest wait-forked: SUCCESS (4.688s) [247.757186] [056/156] (792s left) kms_ccs (crc-primary-basic-4-tiled-dg2-mc-ccs) [249.248377] Starting subtest: crc-primary-basic-4-tiled-dg2-mc-ccs [249.257087] Starting dynamic subtest: pipe-A-HDMI-A-4 [249.270283] Dynamic subtest pipe-A-HDMI-A-4: SKIP (0.001s) [249.283277] Starting dynamic subtest: pipe-B-HDMI-A-4 [249.296428] Dynamic subtest pipe-B-HDMI-A-4: SKIP (0.001s) [249.308854] Starting dynamic subtest: pipe-C-HDMI-A-4 [249.322631] Dynamic subtest pipe-C-HDMI-A-4: SKIP (0.001s) [249.335544] Starting dynamic subtest: pipe-D-HDMI-A-4 [249.351759] Dynamic subtest pipe-D-HDMI-A-4: SKIP (0.001s) [249.354694] Subtest crc-primary-basic-4-tiled-dg2-mc-ccs: SKIP (0.010s) [249.527166] [057/156] (790s left) prime_busy (before) [249.580839] Starting subtest: before [249.587025] Starting dynamic subtest: rcs0 [249.620252] Dynamic subtest rcs0: SUCCESS (0.033s) [249.633451] Starting dynamic subtest: bcs0 [249.659289] Dynamic subtest bcs0: SUCCESS (0.038s) [249.674212] Starting dynamic subtest: vcs0 [249.699304] Dynamic subtest vcs0: SUCCESS (0.039s) [249.719193] Starting dynamic subtest: vcs1 [249.741099] Dynamic subtest vcs1: SUCCESS (0.041s) [249.760985] Starting dynamic subtest: vecs0 [249.782637] Dynamic subtest vecs0: SUCCESS (0.040s) [249.891521] Subtest before: SUCCESS (0.310s) [250.080002] [058/156] (790s left) gem_exec_reloc (basic-scanout) [250.135547] Subtest basic-scanout: SKIP (0.000s) [250.237137] [059/156] (790s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-mmap-cpu) [251.738055] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-mmap-cpu [254.244030] Subtest fbc-1p-primscrn-pri-indfb-draw-mmap-cpu: SUCCESS (2.509s) [254.434518] [060/156] (785s left) kms_joiner (invalid-modeset-force-ultra-joiner) [255.929982] Starting subtest: invalid-modeset-force-ultra-joiner [255.932897] Subtest invalid-modeset-force-ultra-joiner: SKIP (0.000s) [256.080289] [061/156] (784s left) kms_cursor_crc (cursor-random-128x128) [257.779895] Starting subtest: cursor-random-128x128 [257.789014] Starting dynamic subtest: pipe-A-HDMI-A-4 [262.364710] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (4.579s) [262.399068] Starting dynamic subtest: pipe-D-HDMI-A-4 [266.888676] Dynamic subtest pipe-D-HDMI-A-4: SUCCESS (4.500s) [266.890348] Subtest cursor-random-128x128: SUCCESS (9.108s) [267.331046] [062/156] (773s left) syncobj_wait (multi-wait-signaled) [267.380421] Starting subtest: multi-wait-signaled [267.382446] Subtest multi-wait-signaled: SUCCESS (0.001s) [267.500330] [063/156] (773s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-blt) [269.001119] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-blt [269.006637] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-blt: SKIP (0.000s) [269.168500] [064/156] (771s left) kms_plane_scaling (plane-upscale-factor-0-25-with-pixel-format) [270.659635] Starting subtest: plane-upscale-factor-0-25-with-pixel-format [270.661273] Starting dynamic subtest: pipe-A [272.845916] Dynamic subtest pipe-A: SUCCESS (2.186s) [272.860104] Starting dynamic subtest: pipe-B [275.086872] Dynamic subtest pipe-B: SUCCESS (2.240s) [275.102293] Starting dynamic subtest: pipe-C [275.395041] Dynamic subtest pipe-C: SUCCESS (0.307s) [275.422312] Starting dynamic subtest: pipe-D [275.717846] Dynamic subtest pipe-D: SUCCESS (0.321s) [275.719579] Subtest plane-upscale-factor-0-25-with-pixel-format: SUCCESS (5.059s) [275.940433] [065/156] (764s left) kms_chamelium_frames (dp-crc-single) [277.484987] Subtest dp-crc-single: SKIP (0.000s) [277.609650] [066/156] (763s left) api_intel_bb (intel-bb-blit-y) [277.659679] Starting subtest: intel-bb-blit-y [279.254613] Subtest intel-bb-blit-y: SUCCESS (1.595s) [279.406671] [067/156] (761s left) kms_ccs (crc-primary-rotation-180-y-tiled-gen12-rc-ccs) [280.897083] Starting subtest: crc-primary-rotation-180-y-tiled-gen12-rc-ccs [280.899147] Starting dynamic subtest: pipe-A-HDMI-A-4 [283.323240] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (2.416s) [283.341122] Starting dynamic subtest: pipe-B-HDMI-A-4 [283.997457] Dynamic subtest pipe-B-HDMI-A-4: SUCCESS (0.668s) [284.037752] Starting dynamic subtest: pipe-C-HDMI-A-4 [284.704844] Dynamic subtest pipe-C-HDMI-A-4: SUCCESS (0.695s) [284.741663] Starting dynamic subtest: pipe-D-HDMI-A-4 [285.410481] Dynamic subtest pipe-D-HDMI-A-4: SUCCESS (0.696s) [285.413317] Subtest crc-primary-rotation-180-y-tiled-gen12-rc-ccs: SUCCESS (4.509s) [285.677385] [068/156] (755s left) gem_exec_schedule (independent) [285.742129] Starting subtest: independent [285.743843] Starting dynamic subtest: rcs0 [285.984399] Dynamic subtest rcs0: SUCCESS (0.242s) [285.998262] Starting dynamic subtest: bcs0 [286.186118] Dynamic subtest bcs0: SUCCESS (0.200s) [286.217207] Starting dynamic subtest: vcs0 [286.407105] Dynamic subtest vcs0: SUCCESS (0.219s) [286.427499] Starting dynamic subtest: vcs1 [286.621047] Dynamic subtest vcs1: SUCCESS (0.213s) [286.640343] Starting dynamic subtest: vecs0 [286.833839] Dynamic subtest vecs0: SUCCESS (0.211s) [286.835691] Subtest independent: SUCCESS (1.093s) [287.203713] [069/156] (753s left) kms_psr (fbc-psr2-cursor-render) [288.697658] Subtest fbc-psr2-cursor-render: SKIP (0.000s) [288.781733] [070/156] (752s left) kms_psr (fbc-psr-primary-render) [290.276502] Subtest fbc-psr-primary-render: SKIP (0.000s) [290.348497] [071/156] (750s left) i915_pm_freq_api (freq-suspend) [290.415016] Starting subtest: freq-suspend [290.416507] Starting dynamic subtest: gt0 [307.292459] Dynamic subtest gt0: SUCCESS (1.737s) [307.294132] Subtest freq-suspend: SUCCESS (1.739s) [314.541305] [072/156] (733s left) kms_big_fb (yf-tiled-16bpp-rotate-270) [316.052345] Starting subtest: yf-tiled-16bpp-rotate-270 [316.055304] Subtest yf-tiled-16bpp-rotate-270: SKIP (0.000s) [316.245469] [073/156] (732s left) gem_render_copy (mixed-tiled-to-y-tiled-ccs) [316.302477] Starting subtest: mixed-tiled-to-y-tiled-ccs [316.304027] Starting dynamic subtest: smem [316.411102] Dynamic subtest smem: SUCCESS (0.108s) [316.424698] Starting dynamic subtest: lmem0 [317.357926] Dynamic subtest lmem0: SUCCESS (0.947s) [317.359618] Subtest mixed-tiled-to-y-tiled-ccs: SUCCESS (1.058s) [317.662826] [074/156] (730s left) kms_addfb_basic (addfb25-y-tiled-small-legacy) [319.155760] Starting subtest: addfb25-y-tiled-small-legacy [319.159657] Subtest addfb25-y-tiled-small-legacy: SUCCESS (0.000s) [319.332903] [075/156] (729s left) gem_fence_thrash (bo-copy) [319.386057] Starting subtest: bo-copy [319.397401] Subtest bo-copy: SKIP (0.008s) [319.496166] [076/156] (729s left) gem_readwrite (beyond-eob) [319.544653] Subtest beyond-EOB: SKIP (0.000s) [319.633148] [077/156] (729s left) kms_getfb (getfb-reject-nv12) [321.122410] Starting subtest: getfb-reject-nv12 [321.123998] Subtest getfb-reject-nv12: SUCCESS (0.002s) [321.278760] [078/156] (727s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-mmap-wc) [322.785525] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-mmap-wc [322.788422] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-mmap-wc: SKIP (0.000s) [322.959317] [079/156] (726s left) gem_ctx_persistence (saturated-hostile-nopreempt) [323.014657] Starting subtest: saturated-hostile-nopreempt [323.016230] Starting dynamic subtest: rcs0 [323.830228] Dynamic subtest rcs0: SUCCESS (0.816s) [323.848023] Starting dynamic subtest: bcs0 [324.616416] Dynamic subtest bcs0: SUCCESS (0.785s) [324.632633] Starting dynamic subtest: vcs0 [325.401330] Dynamic subtest vcs0: SUCCESS (0.783s) [325.418327] Starting dynamic subtest: vcs1 [326.203467] Dynamic subtest vcs1: SUCCESS (0.800s) [326.222813] Starting dynamic subtest: vecs0 [326.996325] Dynamic subtest vecs0: SUCCESS (0.786s) [327.004360] Subtest saturated-hostile-nopreempt: SUCCESS (3.987s) [327.196903] [080/156] (721s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-wc) [328.698129] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-wc [328.701199] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s) [328.868013] [081/156] (720s left) kms_frontbuffer_tracking (fbchdr-1p-primscrn-spr-indfb-fullscreen) [330.367131] Starting subtest: fbchdr-1p-primscrn-spr-indfb-fullscreen [330.370227] Subtest fbchdr-1p-primscrn-spr-indfb-fullscreen: SKIP (0.000s) [330.536271] [082/156] (718s left) kms_frontbuffer_tracking (fbchdr-2p-pri-indfb-multidraw) [332.037746] Starting subtest: fbchdr-2p-pri-indfb-multidraw [332.040751] Subtest fbchdr-2p-pri-indfb-multidraw: SKIP (0.000s) [332.191152] [083/156] (717s left) dmabuf_sync_file (export-multiwait) [332.346159] Starting subtest: export-multiwait [332.347806] Subtest export-multiwait: SUCCESS (0.001s) [332.443788] [FACT dmabuf_sync_file (export-multiwait)] new: kernel.kmod_is_loaded.vgem: true [332.447446] [084/156] (717s left) kms_frontbuffer_tracking (hdr-1p-primscrn-pri-shrfb-draw-blt) [333.948113] Starting subtest: hdr-1p-primscrn-pri-shrfb-draw-blt [333.951157] Subtest hdr-1p-primscrn-pri-shrfb-draw-blt: SKIP (0.000s) [334.124020] [085/156] (715s left) kms_frontbuffer_tracking (psr-rgb101010-draw-mmap-gtt) [335.625903] Starting subtest: psr-rgb101010-draw-mmap-gtt [335.628882] Subtest psr-rgb101010-draw-mmap-gtt: SKIP (0.000s) [335.810355] [086/156] (713s left) kms_psr (pr-primary-render) [337.303575] Subtest pr-primary-render: SKIP (0.000s) [337.390134] [087/156] (712s left) kms_psr2_sf (pr-cursor-plane-move-continuous-exceed-sf) [338.884546] Subtest pr-cursor-plane-move-continuous-exceed-sf: SKIP (0.000s) [338.956938] [088/156] (710s left) syncobj_timeline (etime-single-wait-for-submit-submitted) [339.009683] Starting subtest: etime-single-wait-for-submit-submitted [339.121342] Subtest etime-single-wait-for-submit-submitted: SUCCESS (0.108s) [339.347050] [089/156] (710s left) kms_ccs (crc-sprite-planes-basic-4-tiled-dg2-rc-ccs) [340.840065] Starting subtest: crc-sprite-planes-basic-4-tiled-dg2-rc-ccs [340.841646] Starting dynamic subtest: pipe-A-HDMI-A-4 [340.883769] Dynamic subtest pipe-A-HDMI-A-4: SKIP (0.003s) [340.897203] Starting dynamic subtest: pipe-B-HDMI-A-4 [340.952011] Dynamic subtest pipe-B-HDMI-A-4: SKIP (0.003s) [340.965229] Starting dynamic subtest: pipe-C-HDMI-A-4 [341.002900] Dynamic subtest pipe-C-HDMI-A-4: SKIP (0.003s) [341.015579] Starting dynamic subtest: pipe-D-HDMI-A-4 [341.061947] Dynamic subtest pipe-D-HDMI-A-4: SKIP (0.003s) [341.065520] Subtest crc-sprite-planes-basic-4-tiled-dg2-rc-ccs: SKIP (0.021s) [341.146105] [090/156] (708s left) i915_drm_fdinfo (busy-hang) [341.200957] Starting subtest: busy-hang [341.202866] Starting dynamic subtest: rcs0 [341.206331] Dynamic subtest rcs0: SKIP (0.001s) [341.219695] Starting dynamic subtest: bcs0 [341.223098] Dynamic subtest bcs0: SKIP (0.001s) [341.236473] Starting dynamic subtest: vcs0 [341.240477] Dynamic subtest vcs0: SKIP (0.012s) [341.253996] Starting dynamic subtest: vcs1 [341.257735] Dynamic subtest vcs1: SKIP (0.001s) [341.272772] Starting dynamic subtest: vecs0 [341.276458] Dynamic subtest vecs0: SKIP (0.001s) [341.279804] Subtest busy-hang: SKIP (0.022s) [341.346103] [091/156] (708s left) kms_frontbuffer_tracking (psrhdr-rgb101010-draw-pwrite) [342.846598] Starting subtest: psrhdr-rgb101010-draw-pwrite [342.849813] Subtest psrhdr-rgb101010-draw-pwrite: SKIP (0.000s) [343.005582] [092/156] (707s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-180-async-flip) [344.520422] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-180-async-flip [345.184953] Subtest y-tiled-max-hw-stride-32bpp-rotate-180-async-flip: SUCCESS (0.665s) [345.422336] [093/156] (704s left) kms_async_flips (invalid-async-flip-atomic) [346.913567] Starting subtest: invalid-async-flip-atomic [347.108564] Starting dynamic subtest: pipe-A-HDMI-A-4 [347.559624] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (0.449s) [347.703676] Starting dynamic subtest: pipe-B-HDMI-A-4 [347.805079] Dynamic subtest pipe-B-HDMI-A-4: SUCCESS (0.114s) [347.980532] Starting dynamic subtest: pipe-C-HDMI-A-4 [348.092642] Dynamic subtest pipe-C-HDMI-A-4: SUCCESS (0.124s) [348.263101] Starting dynamic subtest: pipe-D-HDMI-A-4 [348.375074] Dynamic subtest pipe-D-HDMI-A-4: SUCCESS (0.124s) [348.376466] Subtest invalid-async-flip-atomic: SUCCESS (1.462s) [348.747929] [094/156] (701s left) kms_plane_scaling (plane-downscale-factor-0-5-with-modifiers) [350.241207] Starting subtest: plane-downscale-factor-0-5-with-modifiers [350.242698] Starting dynamic subtest: pipe-A [351.075290] Dynamic subtest pipe-A: SUCCESS (0.833s) [351.102123] Starting dynamic subtest: pipe-B [351.866186] Dynamic subtest pipe-B: SUCCESS (0.788s) [351.893343] Starting dynamic subtest: pipe-C [352.657123] Dynamic subtest pipe-C: SUCCESS (0.788s) [352.677698] Starting dynamic subtest: pipe-D [353.431440] Dynamic subtest pipe-D: SUCCESS (0.772s) [353.433253] Subtest plane-downscale-factor-0-5-with-modifiers: SUCCESS (3.190s) [353.664906] [095/156] (696s left) syncobj_timeline (device-signal-unordered) [353.718075] Starting subtest: device-signal-unordered [353.719589] Subtest device-signal-unordered: SUCCESS (0.001s) [353.844668] [096/156] (696s left) gem_linear_blits (interruptible) [354.394368] Starting subtest: interruptible [363.292163] Subtest interruptible: SUCCESS (8.897s) [363.515008] [097/156] (687s left) gem_exec_schedule (smoketest-all) [363.639618] Starting subtest: smoketest-all [395.940343] Subtest smoketest-all: SUCCESS (32.286s) [396.419736] [098/156] (654s left) kms_frontbuffer_tracking (fbchdr-2p-scndscrn-pri-indfb-draw-mmap-gtt) [397.929824] Starting subtest: fbchdr-2p-scndscrn-pri-indfb-draw-mmap-gtt [397.933205] Subtest fbchdr-2p-scndscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s) [398.137561] [099/156] (652s left) i915_pm_rc6_residency (rc6-accuracy) [398.202298] Starting subtest: rc6-accuracy [398.204537] Starting dynamic subtest: gt0 [401.379192] Dynamic subtest gt0: SUCCESS (3.172s) [401.381015] Subtest rc6-accuracy: SUCCESS (3.178s) [401.491194] [100/156] (649s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-shrfb-draw-mmap-cpu) [402.990187] Starting subtest: fbc-1p-offscreen-pri-shrfb-draw-mmap-cpu [405.169685] Subtest fbc-1p-offscreen-pri-shrfb-draw-mmap-cpu: SUCCESS (2.183s) [405.390056] [101/156] (645s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-0) [406.903169] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-0 [406.906140] Subtest 4-tiled-max-hw-stride-32bpp-rotate-0: SKIP (0.000s) [407.082086] [102/156] (644s left) prime_vgem (basic-fence-mmap) [407.153724] Starting subtest: basic-fence-mmap [407.156677] Subtest basic-fence-mmap: SKIP (0.000s) [407.327710] [103/156] (643s left) kms_lease (lease-invalid-connector) [408.822385] Starting subtest: lease-invalid-connector [408.824392] Starting dynamic subtest: pipe-A-HDMI-A-4 [408.826128] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (0.000s) [408.840776] Starting dynamic subtest: pipe-B-HDMI-A-4 [408.842667] Dynamic subtest pipe-B-HDMI-A-4: SUCCESS (0.000s) [408.856967] Starting dynamic subtest: pipe-C-HDMI-A-4 [408.858971] Dynamic subtest pipe-C-HDMI-A-4: SUCCESS (0.000s) [408.874935] Starting dynamic subtest: pipe-D-HDMI-A-4 [408.876910] Dynamic subtest pipe-D-HDMI-A-4: SUCCESS (0.000s) [408.878910] Subtest lease-invalid-connector: SUCCESS (0.010s) [408.945648] [104/156] (642s left) kms_big_fb (y-tiled-16bpp-rotate-180) [410.460212] Starting subtest: y-tiled-16bpp-rotate-180 [412.339207] Subtest y-tiled-16bpp-rotate-180: SUCCESS (1.875s) [412.583059] [105/156] (638s left) kms_pipe_b_c_ivb (from-pipe-c-to-b-with-3-lanes) [412.633358] Subtest from-pipe-C-to-B-with-3-lanes: SKIP (0.000s) [412.718143] [106/156] (638s left) kms_pm_dc (dc9-dpms) [415.220869] Starting subtest: dc9-dpms [415.579666] Subtest dc9-dpms: SUCCESS (0.356s) [416.488618] [107/156] (635s left) kms_big_fb (x-tiled-64bpp-rotate-180) [418.006616] Starting subtest: x-tiled-64bpp-rotate-180 [420.461085] Subtest x-tiled-64bpp-rotate-180: SUCCESS (2.452s) [420.677874] [108/156] (631s left) kms_frontbuffer_tracking (psr-1p-primscrn-indfb-pgflip-blt) [422.179057] Starting subtest: psr-1p-primscrn-indfb-pgflip-blt [422.182337] Subtest psr-1p-primscrn-indfb-pgflip-blt: SKIP (0.000s) [422.392278] [109/156] (629s left) gem_partial_pwrite_pread (write-snoop) [422.451058] Subtest write-snoop: SKIP (0.000s) [422.559904] [110/156] (629s left) gem_exec_whisper (basic-queues-forked-all) [422.620720] Starting subtest: basic-queues-forked-all [435.424674] Subtest basic-queues-forked-all: SUCCESS (12.799s) [435.749371] [111/156] (616s left) kms_frontbuffer_tracking (hdr-1p-primscrn-spr-indfb-draw-mmap-gtt) [437.257725] Starting subtest: hdr-1p-primscrn-spr-indfb-draw-mmap-gtt [437.260452] Subtest hdr-1p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s) [437.502646] [112/156] (614s left) gem_pread (display) [437.552655] Subtest display: SKIP (0.000s) [437.661633] [113/156] (614s left) kms_psr2_sf (psr2-plane-move-sf-dmg-area) [439.158235] Subtest psr2-plane-move-sf-dmg-area: SKIP (0.000s) [439.243841] [114/156] (613s left) api_intel_allocator (two-level-inception) [439.300226] Starting subtest: two-level-inception [444.724602] Subtest two-level-inception: SUCCESS (5.424s) [444.938763] [115/156] (607s left) gem_exec_whisper (basic-contexts-priority-all) [444.999342] Starting subtest: basic-contexts-priority-all [459.073396] Subtest basic-contexts-priority-all: SUCCESS (14.072s) [459.381074] [116/156] (593s left) kms_cursor_legacy (flip-vs-cursor-varying-size) [460.876839] Starting subtest: flip-vs-cursor-varying-size [475.312700] Subtest flip-vs-cursor-varying-size: SUCCESS (14.439s) [475.516472] [117/156] (577s left) gem_madvise (dontneed-before-exec) [475.564324] Starting subtest: dontneed-before-exec [475.569571] Subtest dontneed-before-exec: SKIP (0.002s) [475.687480] [118/156] (577s left) kms_frontbuffer_tracking (fbchdr-2p-scndscrn-indfb-msflip-blt) [477.198092] Starting subtest: fbchdr-2p-scndscrn-indfb-msflip-blt [477.201314] Subtest fbchdr-2p-scndscrn-indfb-msflip-blt: SKIP (0.000s) [477.377302] [119/156] (575s left) gem_ctx_sseu (engines) [477.430447] Subtest engines: SKIP (0.000s) [477.522115] [120/156] (575s left) kms_frontbuffer_tracking (psrhdr-2p-primscrn-pri-shrfb-draw-mmap-cpu) [479.023030] Starting subtest: psrhdr-2p-primscrn-pri-shrfb-draw-mmap-cpu [479.026007] Subtest psrhdr-2p-primscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s) [479.206374] [121/156] (573s left) gem_mmap_offset (partial-unmap) [479.256914] Starting subtest: partial-unmap [479.258338] Starting dynamic subtest: lmem0 [479.265524] Dynamic subtest lmem0: SUCCESS (0.009s) [479.281269] Starting dynamic subtest: smem0 [479.282893] Dynamic subtest smem0: SUCCESS (0.006s) [479.284633] Subtest partial-unmap: SUCCESS (0.018s) [479.465449] [122/156] (573s left) syncobj_timeline (multi-wait-available-submitted-signaled) [479.514521] Starting subtest: multi-wait-available-submitted-signaled [479.517997] Subtest multi-wait-available-submitted-signaled: SUCCESS (0.001s) [479.626313] [123/156] (573s left) kms_addfb_basic (bo-too-small-due-to-tiling) [481.117145] Starting subtest: bo-too-small-due-to-tiling [481.122270] Subtest bo-too-small-due-to-tiling: SKIP (0.000s) [481.314515] [124/156] (572s left) gem_ctx_param (invalid-get-ringsize) [481.362676] Starting subtest: invalid-get-ringsize [481.364231] Subtest invalid-get-ringsize: SUCCESS (0.001s) [481.477169] [125/156] (571s left) kms_frontbuffer_tracking (hdr-1p-offscreen-pri-indfb-draw-mmap-gtt) [482.975364] Starting subtest: hdr-1p-offscreen-pri-indfb-draw-mmap-gtt [482.978273] Subtest hdr-1p-offscreen-pri-indfb-draw-mmap-gtt: SKIP (0.000s) [483.159258] [126/156] (570s left) kms_cursor_crc (cursor-suspend) [484.710319] Starting subtest: cursor-suspend [484.714032] Starting dynamic subtest: pipe-A-HDMI-A-4 [528.073416] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (20.832s) [528.088653] Starting dynamic subtest: pipe-D-HDMI-A-4 [572.050369] Dynamic subtest pipe-D-HDMI-A-4: SUCCESS (20.288s) [572.051711] Subtest cursor-suspend: SUCCESS (41.126s) [578.674305] [127/156] (480s left) kms_pm_rpm (system-suspend-idle) [582.800160] Starting subtest: system-suspend-idle [601.450003] Subtest system-suspend-idle: SUCCESS (4.566s) [606.503610] [128/156] (457s left) kms_plane_lowres (tiling-y) [607.995407] Starting subtest: tiling-y [607.996985] Starting dynamic subtest: pipe-A-HDMI-A-4 [617.796453] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (9.812s) [617.902542] Starting dynamic subtest: pipe-B-HDMI-A-4 [627.449967] Dynamic subtest pipe-B-HDMI-A-4: SUCCESS (9.569s) [627.525884] Starting dynamic subtest: pipe-C-HDMI-A-4 [637.148053] Dynamic subtest pipe-C-HDMI-A-4: SUCCESS (9.641s) [637.249388] Starting dynamic subtest: pipe-D-HDMI-A-4 [646.852806] Dynamic subtest pipe-D-HDMI-A-4: SUCCESS (9.617s) [646.911957] Subtest tiling-y: SUCCESS (38.935s) [647.183562] [129/156] (416s left) gem_exec_fence (parallel) [647.368217] Starting subtest: parallel [647.369643] Starting dynamic subtest: rcs0 [649.517929] Dynamic subtest rcs0: SUCCESS (2.149s) [649.533029] Starting dynamic subtest: bcs0 [651.674671] Dynamic subtest bcs0: SUCCESS (2.155s) [651.691109] Starting dynamic subtest: vcs0 [653.827942] Dynamic subtest vcs0: SUCCESS (2.152s) [653.843427] Starting dynamic subtest: vcs1 [655.984217] Dynamic subtest vcs1: SUCCESS (2.155s) [655.998794] Starting dynamic subtest: vecs0 [658.133154] Dynamic subtest vecs0: SUCCESS (2.148s) [658.134907] Subtest parallel: SUCCESS (10.766s) [658.817954] [130/156] (405s left) gem_madvise (dontneed-before-mmap) [658.865490] Starting subtest: dontneed-before-mmap [658.868606] Subtest dontneed-before-mmap: SUCCESS (0.004s) [659.053206] [131/156] (404s left) kms_vblank (query-forked-busy) [660.542962] Starting subtest: query-forked-busy [660.547526] Starting dynamic subtest: pipe-A-HDMI-A-4 [663.081451] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (2.532s) [663.149838] Starting dynamic subtest: pipe-D-HDMI-A-4 [665.579342] Dynamic subtest pipe-D-HDMI-A-4: SUCCESS (2.474s) [665.582046] Subtest query-forked-busy: SUCCESS (5.038s) [665.804801] [132/156] (398s left) gem_exec_fence (basic-wait) [666.024709] Starting subtest: basic-wait [666.026652] Starting dynamic subtest: rcs0 [666.104203] Dynamic subtest rcs0: SUCCESS (0.078s) [666.127559] Starting dynamic subtest: bcs0 [666.157508] Dynamic subtest bcs0: SUCCESS (0.051s) [666.194097] Starting dynamic subtest: vcs0 [666.213321] Dynamic subtest vcs0: SUCCESS (0.053s) [666.237182] Starting dynamic subtest: vcs1 [666.267352] Dynamic subtest vcs1: SUCCESS (0.052s) [666.292665] Starting dynamic subtest: vecs0 [666.319392] Dynamic subtest vecs0: SUCCESS (0.050s) [666.321163] Subtest basic-wait: SUCCESS (0.296s) [666.926218] [133/156] (397s left) gem_exec_params (no-bsd) [666.981327] Starting subtest: no-bsd [666.983012] Subtest no-bsd: SUCCESS (0.002s) [667.164430] [134/156] (397s left) vgem_basic (unload) [667.213011] Starting subtest: unload [696.189230] Subtest unload: SUCCESS (28.979s) [696.336749] [135/156] (367s left) kms_frontbuffer_tracking (fbcpsr-farfromfence-mmap-gtt) [697.836907] Starting subtest: fbcpsr-farfromfence-mmap-gtt [697.839486] Subtest fbcpsr-farfromfence-mmap-gtt: SKIP (0.000s) [698.012506] [136/156] (366s left) perf_pmu (most-busy-idle-check-all) [698.066812] Starting subtest: most-busy-idle-check-all [698.068256] Starting dynamic subtest: rcs0 [698.742402] Dynamic subtest rcs0: SUCCESS (0.675s) [698.780937] Starting dynamic subtest: bcs0 [699.400632] Dynamic subtest bcs0: SUCCESS (0.655s) [699.455279] Starting dynamic subtest: vcs0 [700.077663] Dynamic subtest vcs0: SUCCESS (0.669s) [700.130516] Starting dynamic subtest: vcs1 [700.754672] Dynamic subtest vcs1: SUCCESS (0.669s) [700.783034] Starting dynamic subtest: vecs0 [701.415825] Dynamic subtest vecs0: SUCCESS (0.653s) [701.425680] Subtest most-busy-idle-check-all: SUCCESS (3.354s) [701.603381] [137/156] (362s left) kms_flip (2x-flip-vs-blocking-wf-vblank) [703.095149] Starting subtest: 2x-flip-vs-blocking-wf-vblank [703.112949] Subtest 2x-flip-vs-blocking-wf-vblank: SKIP (0.017s) [703.248650] [138/156] (361s left) gem_exec_flush (basic-uc-rw-default) [703.306293] Subtest basic-uc-rw-default: SKIP (0.000s) [703.466624] [139/156] (361s left) kms_cursor_legacy (cursora-vs-flipb-atomic-transitions-varying-size) [704.958062] Starting subtest: cursorA-vs-flipB-atomic-transitions-varying-size [704.960896] Subtest cursorA-vs-flipB-atomic-transitions-varying-size: SKIP (0.001s) [705.078527] [140/156] (359s left) kms_frontbuffer_tracking (fbcpsrhdr-modesetfrombusy) [706.595997] Starting subtest: fbcpsrhdr-modesetfrombusy [706.599021] Subtest fbcpsrhdr-modesetfrombusy: SKIP (0.000s) [706.804298] [141/156] (358s left) kms_cursor_crc (cursor-size-hints) [708.356649] Starting subtest: cursor-size-hints [708.358548] Starting dynamic subtest: pipe-A-HDMI-A-4 [708.912706] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (0.555s) [708.931394] Starting dynamic subtest: pipe-D-HDMI-A-4 [709.324705] Dynamic subtest pipe-D-HDMI-A-4: SUCCESS (0.409s) [709.326255] Subtest cursor-size-hints: SUCCESS (0.969s) [709.974404] [142/156] (355s left) gem_busy (parallel) [710.224967] Starting subtest: parallel [710.226736] Starting dynamic subtest: rcs0 [710.333994] Dynamic subtest rcs0: SUCCESS (0.108s) [710.369810] Starting dynamic subtest: bcs0 [710.404900] Dynamic subtest bcs0: SUCCESS (0.068s) [710.437167] Starting dynamic subtest: vcs0 [710.469804] Dynamic subtest vcs0: SUCCESS (0.062s) [710.496648] Starting dynamic subtest: vcs1 [710.528964] Dynamic subtest vcs1: SUCCESS (0.057s) [710.560692] Starting dynamic subtest: vecs0 [710.595922] Dynamic subtest vecs0: SUCCESS (0.065s) [710.597549] Subtest parallel: SUCCESS (0.372s) [710.916510] [143/156] (354s left) gem_render_copy_redux (normal) [710.972942] Starting subtest: normal [711.818940] Subtest normal: SUCCESS (0.846s) [712.023362] [144/156] (353s left) sysfs_timeslice_duration (timeout) [712.078141] Starting subtest: timeout [712.079686] Starting dynamic subtest: vecs0 [713.571134] Dynamic subtest vecs0: SUCCESS (1.490s) [713.587733] Starting dynamic subtest: vcs0 [715.041709] Dynamic subtest vcs0: SUCCESS (1.468s) [715.058837] Starting dynamic subtest: bcs0 [715.916889] Dynamic subtest bcs0: SUCCESS (0.874s) [715.933502] Starting dynamic subtest: rcs0 [716.826997] Dynamic subtest rcs0: SUCCESS (0.908s) [716.843753] Starting dynamic subtest: vcs1 [718.317191] Dynamic subtest vcs1: SUCCESS (1.488s) [718.318964] Subtest timeout: SUCCESS (6.238s) [718.465283] [145/156] (346s left) perf_pmu (busy-idle-check-all) [718.519255] Starting subtest: busy-idle-check-all [718.520947] Starting dynamic subtest: rcs0 [719.188575] Dynamic subtest rcs0: SUCCESS (0.668s) [719.211368] Starting dynamic subtest: bcs0 [719.846563] Dynamic subtest bcs0: SUCCESS (0.655s) [719.868906] Starting dynamic subtest: vcs0 [720.503827] Dynamic subtest vcs0: SUCCESS (0.655s) [720.522373] Starting dynamic subtest: vcs1 [721.161835] Dynamic subtest vcs1: SUCCESS (0.655s) [721.217499] Starting dynamic subtest: vecs0 [721.851847] Dynamic subtest vecs0: SUCCESS (0.682s) [721.861416] Subtest busy-idle-check-all: SUCCESS (3.336s) [722.035885] [146/156] (343s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-scndscrn-indfb-msflip-blt) [723.536592] Starting subtest: fbcpsrhdr-2p-scndscrn-indfb-msflip-blt [723.540145] Subtest fbcpsrhdr-2p-scndscrn-indfb-msflip-blt: SKIP (0.000s) [723.770309] [147/156] (341s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-pwrite) [725.305420] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-pwrite [725.308966] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-pwrite: SKIP (0.000s) [725.504558] [148/156] (340s left) gen9_exec_parse (bb-start-param) [725.559073] Subtest bb-start-param: SKIP (0.000s) [725.644838] [149/156] (340s left) gem_exec_reloc (basic-cpu-read-noreloc) [725.698684] Subtest basic-cpu-read-noreloc: SKIP (0.000s) [725.814217] [150/156] (340s left) gem_mmap_offset (ptrace) [725.861182] Starting subtest: ptrace [725.865635] Starting dynamic subtest: lmem0-fixed [725.991638] Dynamic subtest lmem0-fixed: SUCCESS (0.123s) [726.010127] Starting dynamic subtest: smem0-fixed [726.014285] Dynamic subtest smem0-fixed: SUCCESS (0.021s) [726.018021] Subtest ptrace: SUCCESS (0.154s) [726.157376] [151/156] (339s left) kms_psr (psr2-primary-blt) [727.660575] Subtest psr2-primary-blt: SKIP (0.000s) [727.743732] [152/156] (338s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-mmap-cpu) [729.244142] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-mmap-cpu [729.246697] Subtest fbc-2p-scndscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s) [729.432001] [153/156] (336s left) kms_setmode (basic-clone-single-crtc) [729.482545] Starting subtest: basic-clone-single-crtc [729.487063] Subtest basic-clone-single-crtc: SKIP (0.001s) [729.618003] [154/156] (336s left) gem_exec_balancer (hang) [730.041563] Starting subtest: hang [732.888532] Subtest hang: SUCCESS (2.851s) [733.101507] [155/156] (333s left) kms_feature_discovery (chamelium) [734.594107] Starting subtest: chamelium [734.597017] Subtest chamelium: SKIP (0.000s) [734.726179] [156/156] (331s left) kms_rotation_crc (primary-4-tiled-reflect-x-0) [736.228223] Starting subtest: primary-4-tiled-reflect-x-0 [736.327087] Subtest primary-4-tiled-reflect-x-0: SKIP (0.097s) [736.539288] Closing watchdogs results: parsing output: 0/ for test: syncobj_timeline results: parsing output: 1/ for test: kms_frontbuffer_tracking results: parsing output: 2/ for test: kms_cursor_legacy results: parsing output: 3/ for test: kms_dirtyfb results: parsing output: 4/ for test: gem_exec_schedule results: parsing output: 5/ for test: kms_frontbuffer_tracking results: parsing output: 6/ for test: kms_frontbuffer_tracking results: parsing output: 7/ for test: gem_mmap_wc results: parsing output: 8/ for test: gem_spin_batch results: parsing output: 9/ for test: kms_ccs results: parsing output: 10/ for test: kms_big_fb results: parsing output: 11/ for test: kms_color_pipeline results: parsing output: 12/ for test: kms_frontbuffer_tracking results: parsing output: 13/ for test: syncobj_wait results: parsing output: 14/ for test: kms_frontbuffer_tracking results: parsing output: 15/ for test: gem_exec_capture results: parsing output: 16/ for test: kms_frontbuffer_tracking results: parsing output: 17/ for test: kms_frontbuffer_tracking results: parsing output: 18/ for test: kms_frontbuffer_tracking results: parsing output: 19/ for test: gem_mmap_wc results: parsing output: 20/ for test: gem_userptr_blits results: parsing output: 21/ for test: kms_content_protection results: parsing output: 22/ for test: kms_frontbuffer_tracking results: parsing output: 23/ for test: gem_mmap_gtt results: parsing output: 24/ for test: kms_atomic_interruptible results: parsing output: 25/ for test: kms_frontbuffer_tracking results: parsing output: 26/ for test: kms_frontbuffer_tracking results: parsing output: 27/ for test: i915_query results: parsing output: 28/ for test: gem_eio results: parsing output: 29/ for test: kms_addfb_basic results: parsing output: 30/ for test: kms_frontbuffer_tracking results: parsing output: 31/ for test: kms_frontbuffer_tracking results: parsing output: 32/ for test: kms_frontbuffer_tracking results: parsing output: 33/ for test: kms_frontbuffer_tracking results: parsing output: 34/ for test: gem_render_copy results: parsing output: 35/ for test: kms_frontbuffer_tracking results: parsing output: 36/ for test: syncobj_timeline results: parsing output: 37/ for test: kms_plane results: parsing output: 38/ for test: kms_force_connector_basic results: parsing output: 39/ for test: kms_chamelium_color results: parsing output: 40/ for test: gem_exec_params results: parsing output: 41/ for test: gem_mmap_gtt results: parsing output: 42/ for test: kms_addfb_basic results: parsing output: 43/ for test: gem_exec_reloc results: parsing output: 44/ for test: kms_frontbuffer_tracking results: parsing output: 45/ for test: kms_psr2_sf results: parsing output: 46/ for test: kms_plane_alpha_blend results: parsing output: 47/ for test: gem_exec_reloc results: parsing output: 48/ for test: kms_frontbuffer_tracking results: parsing output: 49/ for test: gem_ctx_engines results: parsing output: 50/ for test: kms_chamelium_hpd results: parsing output: 51/ for test: kms_flip_scaled_crc results: parsing output: 52/ for test: kms_flip results: parsing output: 53/ for test: kms_big_fb results: parsing output: 54/ for test: kms_vblank results: parsing output: 55/ for test: kms_ccs results: parsing output: 56/ for test: prime_busy results: parsing output: 57/ for test: gem_exec_reloc results: parsing output: 58/ for test: kms_frontbuffer_tracking results: parsing output: 59/ for test: kms_joiner results: parsing output: 60/ for test: kms_cursor_crc results: parsing output: 61/ for test: syncobj_wait results: parsing output: 62/ for test: kms_frontbuffer_tracking results: parsing output: 63/ for test: kms_plane_scaling results: parsing output: 64/ for test: kms_chamelium_frames results: parsing output: 65/ for test: api_intel_bb results: parsing output: 66/ for test: kms_ccs results: parsing output: 67/ for test: gem_exec_schedule results: parsing output: 68/ for test: kms_psr results: parsing output: 69/ for test: kms_psr results: parsing output: 70/ for test: i915_pm_freq_api results: parsing output: 71/ for test: kms_big_fb results: parsing output: 72/ for test: gem_render_copy results: parsing output: 73/ for test: kms_addfb_basic results: parsing output: 74/ for test: gem_fence_thrash results: parsing output: 75/ for test: gem_readwrite results: parsing output: 76/ for test: kms_getfb results: parsing output: 77/ for test: kms_frontbuffer_tracking results: parsing output: 78/ for test: gem_ctx_persistence results: parsing output: 79/ for test: kms_frontbuffer_tracking results: parsing output: 80/ for test: kms_frontbuffer_tracking results: parsing output: 81/ for test: kms_frontbuffer_tracking results: parsing output: 82/ for test: dmabuf_sync_file results: parsing output: 83/ for test: kms_frontbuffer_tracking results: parsing output: 84/ for test: kms_frontbuffer_tracking results: parsing output: 85/ for test: kms_psr results: parsing output: 86/ for test: kms_psr2_sf results: parsing output: 87/ for test: syncobj_timeline results: parsing output: 88/ for test: kms_ccs results: parsing output: 89/ for test: i915_drm_fdinfo results: parsing output: 90/ for test: kms_frontbuffer_tracking results: parsing output: 91/ for test: kms_big_fb results: parsing output: 92/ for test: kms_async_flips results: parsing output: 93/ for test: kms_plane_scaling results: parsing output: 94/ for test: syncobj_timeline results: parsing output: 95/ for test: gem_linear_blits results: parsing output: 96/ for test: gem_exec_schedule results: parsing output: 97/ for test: kms_frontbuffer_tracking results: parsing output: 98/ for test: i915_pm_rc6_residency results: parsing output: 99/ for test: kms_frontbuffer_tracking results: parsing output: 100/ for test: kms_big_fb results: parsing output: 101/ for test: prime_vgem results: parsing output: 102/ for test: kms_lease results: parsing output: 103/ for test: kms_big_fb results: parsing output: 104/ for test: kms_pipe_b_c_ivb results: parsing output: 105/ for test: kms_pm_dc results: parsing output: 106/ for test: kms_big_fb results: parsing output: 107/ for test: kms_frontbuffer_tracking results: parsing output: 108/ for test: gem_partial_pwrite_pread results: parsing output: 109/ for test: gem_exec_whisper results: parsing output: 110/ for test: kms_frontbuffer_tracking results: parsing output: 111/ for test: gem_pread results: parsing output: 112/ for test: kms_psr2_sf results: parsing output: 113/ for test: api_intel_allocator results: parsing output: 114/ for test: gem_exec_whisper results: parsing output: 115/ for test: kms_cursor_legacy results: parsing output: 116/ for test: gem_madvise results: parsing output: 117/ for test: kms_frontbuffer_tracking results: parsing output: 118/ for test: gem_ctx_sseu results: parsing output: 119/ for test: kms_frontbuffer_tracking results: parsing output: 120/ for test: gem_mmap_offset results: parsing output: 121/ for test: syncobj_timeline results: parsing output: 122/ for test: kms_addfb_basic results: parsing output: 123/ for test: gem_ctx_param results: parsing output: 124/ for test: kms_frontbuffer_tracking results: parsing output: 125/ for test: kms_cursor_crc results: parsing output: 126/ for test: kms_pm_rpm results: parsing output: 127/ for test: kms_plane_lowres results: parsing output: 128/ for test: gem_exec_fence results: parsing output: 129/ for test: gem_madvise results: parsing output: 130/ for test: kms_vblank results: parsing output: 131/ for test: gem_exec_fence results: parsing output: 132/ for test: gem_exec_params results: parsing output: 133/ for test: vgem_basic results: parsing output: 134/ for test: kms_frontbuffer_tracking results: parsing output: 135/ for test: perf_pmu results: parsing output: 136/ for test: kms_flip results: parsing output: 137/ for test: gem_exec_flush results: parsing output: 138/ for test: kms_cursor_legacy results: parsing output: 139/ for test: kms_frontbuffer_tracking results: parsing output: 140/ for test: kms_cursor_crc results: parsing output: 141/ for test: gem_busy results: parsing output: 142/ for test: gem_render_copy_redux results: parsing output: 143/ for test: sysfs_timeslice_duration results: parsing output: 144/ for test: perf_pmu results: parsing output: 145/ for test: kms_frontbuffer_tracking results: parsing output: 146/ for test: kms_frontbuffer_tracking results: parsing output: 147/ for test: gen9_exec_parse results: parsing output: 148/ for test: gem_exec_reloc results: parsing output: 149/ for test: gem_mmap_offset results: parsing output: 150/ for test: kms_psr results: parsing output: 151/ for test: kms_frontbuffer_tracking results: parsing output: 152/ for test: kms_setmode results: parsing output: 153/ for test: gem_exec_balancer results: parsing output: 154/ for test: kms_feature_discovery results: parsing output: 155/ for test: kms_rotation_crc Done.