[103.528038] Initializing watchdogs [103.528088] /dev/watchdog0 [103.543774] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:7d55 Intel Meteorlake (Gen12) Meteor Lake-P [Intel Arc Graphics] [103.548474] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [103.550649] [FACT before any test] new: kernel.kmod_is_loaded.i915: true [103.553879] [001/153] (960s left) kms_atomic_transition (modeset-transition-fencing) [103.687758] Starting subtest: modeset-transition-fencing [103.689835] Starting dynamic subtest: 1x-outputs [114.821748] Dynamic subtest 1x-outputs: SUCCESS (11.132s) [114.824290] Subtest modeset-transition-fencing: SUCCESS (11.133s) [115.675079] [002/153] (948s left) kms_frontbuffer_tracking (fbchdr-2p-scndscrn-spr-indfb-draw-render) [115.788067] Starting subtest: fbchdr-2p-scndscrn-spr-indfb-draw-render [115.792596] Subtest fbchdr-2p-scndscrn-spr-indfb-draw-render: SKIP (0.000s) [115.884609] [003/153] (948s left) kms_psr (fbc-psr-sprite-mmap-cpu) [115.992126] Starting subtest: fbc-psr-sprite-mmap-cpu [115.994446] Starting dynamic subtest: eDP-1 [115.998658] Dynamic subtest eDP-1: SKIP (0.000s) [116.002947] Subtest fbc-psr-sprite-mmap-cpu: SKIP (0.000s) [116.076975] [004/153] (948s left) prime_mmap (test_refcounting) [116.134415] Starting subtest: test_refcounting [116.136433] Starting dynamic subtest: test_refcounting-smem [116.166251] Dynamic subtest test_refcounting-smem: SUCCESS (0.033s) [116.168675] Subtest test_refcounting: SUCCESS (0.033s) [116.256618] [005/153] (947s left) gem_readwrite (beyond-eob) [116.317393] Subtest beyond-EOB: SKIP (0.000s) [116.379698] [006/153] (947s left) kms_fence_pin_leak [116.545969] [007/153] (947s left) kms_plane (pixel-format-4-tiled-dg2-mc-ccs-modifier) [116.646431] Starting subtest: pixel-format-4-tiled-dg2-mc-ccs-modifier [116.649825] Subtest pixel-format-4-tiled-dg2-mc-ccs-modifier: SKIP (0.000s) [116.712310] [008/153] (947s left) syncobj_eventfd (invalid-bad-pad) [116.763131] Starting subtest: invalid-bad-pad [116.764910] Subtest invalid-bad-pad: SUCCESS (0.000s) [116.849799] [009/153] (947s left) perf_pmu (busy) [116.888400] Starting subtest: busy [116.890063] Starting dynamic subtest: rcs0 [117.479472] Dynamic subtest rcs0: SUCCESS (0.592s) [117.490517] Starting dynamic subtest: bcs0 [118.037716] Dynamic subtest bcs0: SUCCESS (0.558s) [118.048805] Starting dynamic subtest: vcs0 [119.334029] Dynamic subtest vcs0: SUCCESS (1.293s) [119.347065] Starting dynamic subtest: vcs1 [121.318331] Dynamic subtest vcs1: SUCCESS (1.983s) [121.329626] Starting dynamic subtest: vecs0 [123.301795] Dynamic subtest vecs0: SUCCESS (1.982s) [123.312836] Starting dynamic subtest: ccs0 [123.878308] Dynamic subtest ccs0: SUCCESS (0.577s) [123.881586] Subtest busy: SUCCESS (6.991s) [124.002735] [010/153] (940s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-mmap-cpu) [124.125166] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-mmap-cpu [130.782993] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-mmap-cpu: SUCCESS (6.663s) [130.927226] [011/153] (933s left) gen9_exec_parse (batch-invalid-length) [130.990206] Subtest batch-invalid-length: SKIP (0.000s) [131.055764] [012/153] (933s left) kms_frontbuffer_tracking (psrhdr-2p-scndscrn-spr-indfb-draw-blt) [131.149693] Starting subtest: psrhdr-2p-scndscrn-spr-indfb-draw-blt [131.153716] Subtest psrhdr-2p-scndscrn-spr-indfb-draw-blt: SKIP (0.000s) [131.255653] [013/153] (933s left) gem_workarounds (suspend-resume) [131.327403] Starting subtest: suspend-resume [147.754517] Subtest suspend-resume: SUCCESS (1.712s) [154.899866] [014/153] (916s left) kms_big_fb (y-tiled-16bpp-rotate-0) [155.020910] Starting subtest: y-tiled-16bpp-rotate-0 [155.024874] Subtest y-tiled-16bpp-rotate-0: SKIP (0.000s) [155.120653] [015/153] (916s left) kms_plane_cursor (viewport) [155.224491] Starting subtest: viewport [155.229548] Starting dynamic subtest: pipe-A-eDP-1-size-64 [157.764306] Dynamic subtest pipe-A-eDP-1-size-64: SUCCESS (2.572s) [157.825469] Starting dynamic subtest: pipe-A-eDP-1-size-128 [160.431141] Dynamic subtest pipe-A-eDP-1-size-128: SUCCESS (2.639s) [160.490953] Starting dynamic subtest: pipe-A-eDP-1-size-256 [163.072375] Dynamic subtest pipe-A-eDP-1-size-256: SUCCESS (2.606s) [163.418458] Starting dynamic subtest: pipe-B-eDP-1-size-64 [166.715897] Dynamic subtest pipe-B-eDP-1-size-64: SUCCESS (3.321s) [166.776932] Starting dynamic subtest: pipe-B-eDP-1-size-128 [169.375994] Dynamic subtest pipe-B-eDP-1-size-128: SUCCESS (2.616s) [169.435946] Starting dynamic subtest: pipe-B-eDP-1-size-256 [172.026965] Dynamic subtest pipe-B-eDP-1-size-256: SUCCESS (2.605s) [172.386246] Starting dynamic subtest: pipe-C-eDP-1-size-64 [175.259250] Dynamic subtest pipe-C-eDP-1-size-64: SUCCESS (2.889s) [175.297842] Starting dynamic subtest: pipe-C-eDP-1-size-128 [177.522968] Dynamic subtest pipe-C-eDP-1-size-128: SUCCESS (2.236s) [177.561346] Starting dynamic subtest: pipe-C-eDP-1-size-256 [179.787038] Dynamic subtest pipe-C-eDP-1-size-256: SUCCESS (2.236s) [180.122857] Starting dynamic subtest: pipe-D-eDP-1-size-64 [183.011289] Dynamic subtest pipe-D-eDP-1-size-64: SUCCESS (2.899s) [183.049284] Starting dynamic subtest: pipe-D-eDP-1-size-128 [185.278021] Dynamic subtest pipe-D-eDP-1-size-128: SUCCESS (2.237s) [185.316628] Starting dynamic subtest: pipe-D-eDP-1-size-256 [187.567767] Dynamic subtest pipe-D-eDP-1-size-256: SUCCESS (2.259s) [187.890424] Subtest viewport: SUCCESS (32.777s) [188.764534] [016/153] (882s left) kms_addfb_basic (bad-pitch-65536) [188.818575] Starting subtest: bad-pitch-65536 [188.821015] Subtest bad-pitch-65536: SUCCESS (0.000s) [188.971652] [017/153] (882s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-mmap-cpu) [189.069930] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-mmap-cpu [189.074338] Subtest fbc-2p-scndscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s) [189.168131] [018/153] (882s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-pwrite) [189.261823] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-pwrite [189.265677] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-pwrite: SKIP (0.000s) [189.355436] [019/153] (882s left) gem_exec_params (invalid-bsd1-flag-on-render) [189.419541] Starting subtest: invalid-bsd1-flag-on-render [189.422031] Subtest invalid-bsd1-flag-on-render: SUCCESS (0.000s) [189.534877] [020/153] (882s left) kms_flip_scaled_crc (flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling) [189.632816] Starting subtest: flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling [189.637245] Subtest flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling: SKIP (0.000s) [189.701820] [021/153] (882s left) gem_userptr_blits (sd-probe) [189.768360] Starting subtest: sd-probe [189.770434] Subtest sd-probe: SUCCESS (0.000s) [189.886706] [022/153] (881s left) kms_draw_crc (draw-method-mmap-cpu) [189.972022] Starting subtest: draw-method-mmap-cpu [189.973646] Starting dynamic subtest: xrgb8888-untiled [190.236905] Dynamic subtest xrgb8888-untiled: SUCCESS (0.266s) [190.246640] Starting dynamic subtest: rgb565-untiled [190.460194] Dynamic subtest rgb565-untiled: SUCCESS (0.221s) [190.469347] Starting dynamic subtest: xrgb2101010-untiled [190.682143] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.221s) [190.695693] Starting dynamic subtest: xbgr16161616f-untiled [190.914364] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.233s) [190.923584] Starting dynamic subtest: xrgb8888-xtiled [191.058676] Dynamic subtest xrgb8888-xtiled: SUCCESS (0.144s) [191.067782] Starting dynamic subtest: rgb565-xtiled [191.203167] Dynamic subtest rgb565-xtiled: SUCCESS (0.144s) [191.214214] Starting dynamic subtest: xrgb2101010-xtiled [191.336613] Dynamic subtest xrgb2101010-xtiled: SUCCESS (0.133s) [191.346035] Starting dynamic subtest: xbgr16161616f-xtiled [191.470065] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (0.133s) [191.482031] Starting dynamic subtest: xrgb8888-4tiled [191.625757] Dynamic subtest xrgb8888-4tiled: SUCCESS (0.153s) [191.636753] Starting dynamic subtest: rgb565-4tiled [191.770185] Dynamic subtest rgb565-4tiled: SUCCESS (0.144s) [191.779026] Starting dynamic subtest: xrgb2101010-4tiled [191.891825] Dynamic subtest xrgb2101010-4tiled: SUCCESS (0.122s) [191.900756] Starting dynamic subtest: xbgr16161616f-4tiled [192.036345] Dynamic subtest xbgr16161616f-4tiled: SUCCESS (0.144s) [192.038258] Subtest draw-method-mmap-cpu: SUCCESS (2.067s) [192.129123] [023/153] (879s left) kms_frontbuffer_tracking (fbcpsr-shrfb-scaledprimary) [192.225727] Starting subtest: fbcpsr-shrfb-scaledprimary [198.070829] Subtest fbcpsr-shrfb-scaledprimary: SUCCESS (5.851s) [198.206563] [024/153] (873s left) api_intel_bb (intel-bb-blit-y) [198.258858] Starting subtest: intel-bb-blit-y [201.987402] Subtest intel-bb-blit-y: SUCCESS (3.730s) [202.117626] [025/153] (869s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-primscrn-indfb-msflip-blt) [202.212212] Starting subtest: fbcpsrhdr-1p-primscrn-indfb-msflip-blt [202.216503] Subtest fbcpsrhdr-1p-primscrn-indfb-msflip-blt: SKIP (0.000s) [202.314662] [026/153] (869s left) gen3_render_tiledx_blits [202.436730] [027/153] (869s left) fbdev (unaligned-write) [202.481231] Starting subtest: unaligned-write [202.587340] Subtest unaligned-write: SUCCESS (0.105s) [202.648071] [028/153] (869s left) kms_getfb (getfb2-accept-nv12) [202.743844] Starting subtest: getfb2-accept-nv12 [202.746150] Subtest getfb2-accept-nv12: SUCCESS (0.001s) [202.846715] [029/153] (869s left) gem_exec_capture (pi) [202.899956] Starting subtest: pi [202.902460] Starting dynamic subtest: rcs0 [207.307267] Dynamic subtest rcs0: SUCCESS (4.408s) [207.318361] Starting dynamic subtest: bcs0 [211.457613] Dynamic subtest bcs0: SUCCESS (4.151s) [211.469297] Starting dynamic subtest: vcs0 [215.594314] Dynamic subtest vcs0: SUCCESS (4.136s) [215.606339] Starting dynamic subtest: vcs1 [219.693752] Dynamic subtest vcs1: SUCCESS (4.099s) [219.703667] Starting dynamic subtest: vecs0 [223.811331] Dynamic subtest vecs0: SUCCESS (4.118s) [223.823617] Starting dynamic subtest: ccs0 [227.899015] Dynamic subtest ccs0: SUCCESS (4.088s) [227.901920] Subtest pi: SUCCESS (25.009s) [227.990853] [030/153] (844s left) gem_exec_balancer (nop) [228.104164] Starting subtest: nop [274.896526] Subtest nop: SUCCESS (46.790s) [275.195292] [031/153] (797s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-render) [275.312997] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-render [282.190390] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-render: SUCCESS (6.882s) [282.338972] [032/153] (789s left) i915_module_load (reload-no-display) [282.374454] Starting subtest: reload-no-display [289.699185] Subtest reload-no-display: SUCCESS (7.325s) [289.732039] [FACT i915_module_load (reload-no-display)] deleted: kernel.kmod_is_loaded.i915: true [289.735168] [033/153] (782s left) gem_softpin (safe-alignment) [291.269875] Starting subtest: safe-alignment [291.305099] Subtest safe-alignment: SUCCESS (0.036s) [293.058295] [FACT gem_softpin (safe-alignment)] new: kernel.kmod_is_loaded.i915: true [293.061972] [034/153] (779s left) kms_plane_scaling (planes-downscale-factor-0-75) [293.166154] Starting subtest: planes-downscale-factor-0-75 [293.168534] Starting dynamic subtest: pipe-A [293.190849] Dynamic subtest pipe-A: SKIP (0.021s) [293.201409] Starting dynamic subtest: pipe-B [293.230359] Dynamic subtest pipe-B: SKIP (0.038s) [293.240330] Starting dynamic subtest: pipe-C [293.270268] Dynamic subtest pipe-C: SKIP (0.039s) [293.280155] Starting dynamic subtest: pipe-D [293.309958] Dynamic subtest pipe-D: SKIP (0.038s) [293.314577] Subtest planes-downscale-factor-0-75: SKIP (0.139s) [293.393510] [035/153] (779s left) kms_color_pipeline (plane-ctm3x4) [293.485385] Starting subtest: plane-ctm3x4 [293.676099] Starting dynamic subtest: pipe-A-plane-0 [293.819210] Dynamic subtest pipe-A-plane-0: SUCCESS (0.144s) [293.829939] Starting dynamic subtest: pipe-A-plane-1 [293.953363] Dynamic subtest pipe-A-plane-1: SUCCESS (0.133s) [293.964394] Starting dynamic subtest: pipe-A-plane-2 [294.085589] Dynamic subtest pipe-A-plane-2: SUCCESS (0.132s) [295.269066] Starting dynamic subtest: pipe-B-plane-0 [295.404041] Dynamic subtest pipe-B-plane-0: SUCCESS (0.144s) [295.414411] Starting dynamic subtest: pipe-B-plane-1 [295.560394] Dynamic subtest pipe-B-plane-1: SUCCESS (0.155s) [295.576570] Starting dynamic subtest: pipe-B-plane-2 [295.692079] Dynamic subtest pipe-B-plane-2: SUCCESS (0.133s) [296.878091] Starting dynamic subtest: pipe-C-plane-0 [296.978598] Dynamic subtest pipe-C-plane-0: SUCCESS (0.111s) [296.988655] Starting dynamic subtest: pipe-C-plane-1 [297.122946] Dynamic subtest pipe-C-plane-1: SUCCESS (0.144s) [297.132865] Starting dynamic subtest: pipe-C-plane-2 [297.233988] Dynamic subtest pipe-C-plane-2: SUCCESS (0.110s) [298.408135] Starting dynamic subtest: pipe-D-plane-0 [298.510943] Dynamic subtest pipe-D-plane-0: SUCCESS (0.111s) [298.520949] Starting dynamic subtest: pipe-D-plane-1 [298.622814] Dynamic subtest pipe-D-plane-1: SUCCESS (0.110s) [298.636112] Starting dynamic subtest: pipe-D-plane-2 [298.744135] Dynamic subtest pipe-D-plane-2: SUCCESS (0.120s) [299.032250] Subtest plane-ctm3x4: SUCCESS (5.547s) [299.908639] [036/153] (772s left) gem_mmap_wc (bad-size) [299.967328] Subtest bad-size: SKIP (0.000s) [300.024049] [037/153] (772s left) gem_exec_fence (syncobj-repeat) [300.455131] Starting subtest: syncobj-repeat [300.645109] Subtest syncobj-repeat: SUCCESS (0.188s) [302.133340] [FACT gem_exec_fence (syncobj-repeat)] new: kernel.kmod_is_loaded.vgem: true [302.136798] [038/153] (770s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-mmap-wc) [302.242338] Starting subtest: psr-1p-primscrn-pri-indfb-draw-mmap-wc [309.680755] Subtest psr-1p-primscrn-pri-indfb-draw-mmap-wc: SUCCESS (7.445s) [309.808414] [039/153] (762s left) kms_chamelium_frames (hdmi-crc-single) [310.189293] Subtest hdmi-crc-single: SKIP (0.000s) [311.048464] [040/153] (761s left) kms_chamelium_hpd (vga-hpd-without-ddc) [311.441646] Subtest vga-hpd-without-ddc: SKIP (0.000s) [312.272345] [041/153] (760s left) gem_exec_reloc (basic-cpu-wc-active) [312.335314] Subtest basic-cpu-wc-active: SKIP (0.000s) [312.398047] [042/153] (760s left) syncobj_wait (multi-wait-all-submitted-signaled) [312.442901] Starting subtest: multi-wait-all-submitted-signaled [312.545667] Subtest multi-wait-all-submitted-signaled: SUCCESS (0.101s) [312.625630] [043/153] (760s left) gem_exec_suspend (basic-s3-devices) [312.684911] Starting subtest: basic-S3-devices [312.686856] Starting dynamic subtest: smem [324.062949] Dynamic subtest smem: SUCCESS (11.381s) [324.065644] Subtest basic-S3-devices: SUCCESS (11.383s) [333.268472] [044/153] (748s left) kms_force_connector_basic (force-load-detect) [333.364901] Starting subtest: force-load-detect [333.369570] Subtest force-load-detect: SKIP (0.000s) [333.482722] [045/153] (748s left) kms_flip (flip-vs-absolute-wf_vblank) [333.572862] Starting subtest: flip-vs-absolute-wf_vblank [333.575125] Starting dynamic subtest: A-eDP1 [342.574756] Dynamic subtest A-eDP1: SUCCESS (9.002s) [342.591468] Starting dynamic subtest: B-eDP1 [351.510056] Dynamic subtest B-eDP1: SUCCESS (8.934s) [351.521478] Starting dynamic subtest: C-eDP1 [360.437008] Dynamic subtest C-eDP1: SUCCESS (8.925s) [360.447470] Starting dynamic subtest: D-eDP1 [369.361668] Dynamic subtest D-eDP1: SUCCESS (8.925s) [369.363967] Subtest flip-vs-absolute-wf_vblank: SUCCESS (35.795s) [370.596336] [046/153] (711s left) gem_pxp (reject-modify-context-protection-on) [370.714091] Starting subtest: reject-modify-context-protection-on [370.717123] Subtest reject-modify-context-protection-on: SUCCESS (0.002s) [370.818658] [047/153] (711s left) perf_pmu (most-busy-idle-check-all) [370.862314] Starting subtest: most-busy-idle-check-all [370.864747] Starting dynamic subtest: rcs0 [372.062892] Dynamic subtest rcs0: SUCCESS (1.199s) [372.077299] Starting dynamic subtest: bcs0 [374.047359] Dynamic subtest bcs0: SUCCESS (1.981s) [374.062214] Starting dynamic subtest: vcs0 [376.032074] Dynamic subtest vcs0: SUCCESS (1.981s) [376.043610] Starting dynamic subtest: vcs1 [378.015292] Dynamic subtest vcs1: SUCCESS (1.981s) [378.031175] Starting dynamic subtest: vecs0 [380.062508] Dynamic subtest vecs0: SUCCESS (2.044s) [380.074919] Starting dynamic subtest: ccs0 [382.047153] Dynamic subtest ccs0: SUCCESS (1.982s) [382.052506] Subtest most-busy-idle-check-all: SUCCESS (11.186s) [382.148536] [048/153] (699s left) syncobj_timeline (single-wait-available-signaled) [382.208353] Starting subtest: single-wait-available-signaled [382.210705] Subtest single-wait-available-signaled: SUCCESS (0.000s) [382.310032] [049/153] (699s left) gem_partial_pwrite_pread (writes-after-reads-uncached) [382.371656] Subtest writes-after-reads-uncached: SKIP (0.000s) [382.445796] [050/153] (699s left) kms_plane (pixel-format-linear-modifier-source-clamping) [382.540470] Starting subtest: pixel-format-linear-modifier-source-clamping [382.566774] Starting dynamic subtest: pipe-A-plane-0 [383.155152] Dynamic subtest pipe-A-plane-0: SUCCESS (0.589s) [383.165722] Starting dynamic subtest: pipe-A-plane-3 [383.588184] Dynamic subtest pipe-A-plane-3: SUCCESS (0.432s) [384.684289] Starting dynamic subtest: pipe-B-plane-0 [385.241391] Dynamic subtest pipe-B-plane-0: SUCCESS (0.566s) [385.252194] Starting dynamic subtest: pipe-B-plane-3 [385.663486] Dynamic subtest pipe-B-plane-3: SUCCESS (0.422s) [385.971437] Subtest pixel-format-linear-modifier-source-clamping: SUCCESS (3.433s) [386.851237] [051/153] (695s left) kms_vblank (query-forked-busy-hang) [386.953869] Starting subtest: query-forked-busy-hang [386.956109] Starting dynamic subtest: pipe-A-eDP-1 [413.855830] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.904s) [413.873891] Starting dynamic subtest: pipe-D-eDP-1 [438.815631] Dynamic subtest pipe-D-eDP-1: SUCCESS (24.964s) [438.818012] Subtest query-forked-busy-hang: SUCCESS (51.873s) [439.688599] [052/153] (642s left) kms_psr (fbc-pr-sprite-blt) [439.785857] Starting subtest: fbc-pr-sprite-blt [439.790205] Subtest fbc-pr-sprite-blt: SKIP (0.000s) [439.872926] [053/153] (642s left) kms_frontbuffer_tracking (psrhdr-2p-primscrn-spr-indfb-draw-mmap-wc) [439.984004] Starting subtest: psrhdr-2p-primscrn-spr-indfb-draw-mmap-wc [439.988028] Subtest psrhdr-2p-primscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s) [440.081103] [054/153] (642s left) kms_ccs (bad-aux-stride-y-tiled-gen12-rc-ccs-cc) [440.166992] Starting subtest: bad-aux-stride-y-tiled-gen12-rc-ccs-cc [440.169278] Starting dynamic subtest: pipe-A-eDP-1 [440.192188] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [440.204390] Starting dynamic subtest: pipe-B-eDP-1 [440.225840] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [440.238762] Starting dynamic subtest: pipe-C-eDP-1 [440.259982] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [440.269896] Starting dynamic subtest: pipe-D-eDP-1 [440.291416] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [440.295815] Subtest bad-aux-stride-y-tiled-gen12-rc-ccs-cc: SKIP (0.004s) [442.450644] [055/153] (639s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-pwrite) [442.552435] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-pwrite [446.913561] Subtest fbc-1p-primscrn-cur-indfb-draw-pwrite: SUCCESS (4.367s) [448.081126] [056/153] (634s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-shrfb-draw-mmap-cpu) [448.188636] Starting subtest: fbc-1p-offscreen-pri-shrfb-draw-mmap-cpu [452.187619] Subtest fbc-1p-offscreen-pri-shrfb-draw-mmap-cpu: SUCCESS (4.005s) [453.358862] [057/153] (629s left) kms_psr (psr2-cursor-mmap-gtt) [453.464918] Starting subtest: psr2-cursor-mmap-gtt [453.467216] Starting dynamic subtest: eDP-1 [455.237141] Dynamic subtest eDP-1: SUCCESS (1.771s) [455.239285] Subtest psr2-cursor-mmap-gtt: SUCCESS (1.772s) [456.123798] [058/153] (626s left) kms_frontbuffer_tracking (fbchdr-rgb565-draw-mmap-wc) [456.224480] Starting subtest: fbchdr-rgb565-draw-mmap-wc [456.228512] Subtest fbchdr-rgb565-draw-mmap-wc: SKIP (0.000s) [456.314618] [059/153] (626s left) syncobj_timeline (etime-single-wait-for-submit-available-unsubmitted) [456.366731] Starting subtest: etime-single-wait-for-submit-available-unsubmitted [456.474755] Subtest etime-single-wait-for-submit-available-unsubmitted: SUCCESS (0.107s) [456.553576] [060/153] (625s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-blt) [456.664274] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-blt [461.084706] Subtest fbc-1p-primscrn-pri-indfb-draw-blt: SUCCESS (4.425s) [462.243336] [061/153] (620s left) gem_eio (in-flight-contexts-immediate) [462.452673] Starting subtest: in-flight-contexts-immediate [474.030215] Subtest in-flight-contexts-immediate: SUCCESS (11.575s) [474.167702] [062/153] (608s left) syncobj_wait (multi-wait-for-submit-unsubmitted-signaled) [474.216576] Starting subtest: multi-wait-for-submit-unsubmitted-signaled [474.218755] Subtest multi-wait-for-submit-unsubmitted-signaled: SUCCESS (0.000s) [474.332048] [063/153] (608s left) gem_ctx_persistence (userptr) [474.393197] Starting subtest: userptr [474.582882] Subtest userptr: SUCCESS (0.189s) [474.664159] [064/153] (608s left) gem_exec_reloc (basic-wc-read) [474.724276] Subtest basic-wc-read: SKIP (0.000s) [474.799336] [065/153] (607s left) syncobj_timeline (multi-wait-all-available-submitted-signaled) [474.847908] Starting subtest: multi-wait-all-available-submitted-signaled [474.850277] Subtest multi-wait-all-available-submitted-signaled: SUCCESS (0.000s) [474.964637] [066/153] (607s left) kms_frontbuffer_tracking (psrhdr-1p-offscreen-pri-indfb-draw-mmap-cpu) [475.069820] Starting subtest: psrhdr-1p-offscreen-pri-indfb-draw-mmap-cpu [475.073312] Subtest psrhdr-1p-offscreen-pri-indfb-draw-mmap-cpu: SKIP (0.000s) [475.181864] [067/153] (607s left) kms_plane (plane-panning-top-left) [475.277927] Starting subtest: plane-panning-top-left [475.279877] Starting dynamic subtest: pipe-A [476.972923] Dynamic subtest pipe-A: SUCCESS (1.694s) [476.985781] Starting dynamic subtest: pipe-B [479.364139] Dynamic subtest pipe-B: SUCCESS (2.389s) [479.366288] Subtest plane-panning-top-left: SUCCESS (4.085s) [480.187940] [068/153] (602s left) kms_frontbuffer_tracking (psrhdr-1p-offscreen-pri-shrfb-draw-pwrite) [480.294890] Starting subtest: psrhdr-1p-offscreen-pri-shrfb-draw-pwrite [480.299397] Subtest psrhdr-1p-offscreen-pri-shrfb-draw-pwrite: SKIP (0.000s) [480.393287] [069/153] (602s left) kms_frontbuffer_tracking (psr-rgb101010-draw-blt) [480.495752] Starting subtest: psr-rgb101010-draw-blt [487.854997] Subtest psr-rgb101010-draw-blt: SUCCESS (7.364s) [487.974972] [070/153] (594s left) syncobj_timeline (multi-wait-for-submit-available-submitted-signaled) [488.033664] Starting subtest: multi-wait-for-submit-available-submitted-signaled [488.035924] Subtest multi-wait-for-submit-available-submitted-signaled: SUCCESS (0.000s) [488.130476] [071/153] (594s left) kms_rotation_crc (primary-y-tiled-reflect-x-270) [488.219680] Starting subtest: primary-y-tiled-reflect-x-270 [488.224179] Subtest primary-y-tiled-reflect-x-270: SKIP (0.001s) [488.294977] [072/153] (594s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-0-hflip) [488.393448] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-0-hflip [488.397859] Subtest y-tiled-max-hw-stride-64bpp-rotate-0-hflip: SKIP (0.000s) [488.497705] [073/153] (594s left) gem_lmem_swapping (heavy-multi) [488.540673] Subtest heavy-multi: SKIP (0.000s) [488.591537] [074/153] (594s left) kms_cursor_legacy (nonblocking-modeset-vs-cursor-atomic) [488.713203] Starting subtest: nonblocking-modeset-vs-cursor-atomic [490.109596] Subtest nonblocking-modeset-vs-cursor-atomic: SUCCESS (1.396s) [490.999109] [075/153] (592s left) kms_big_fb (linear-max-hw-stride-32bpp-rotate-180-hflip) [491.094073] Starting subtest: linear-max-hw-stride-32bpp-rotate-180-hflip [491.098174] Subtest linear-max-hw-stride-32bpp-rotate-180-hflip: SKIP (0.000s) [491.182227] [076/153] (592s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-move) [491.275290] Starting subtest: psr-2p-scndscrn-cur-indfb-move [491.279325] Subtest psr-2p-scndscrn-cur-indfb-move: SKIP (0.000s) [491.372864] [077/153] (591s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-wc) [491.470697] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-wc [491.474960] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s) [491.554205] [078/153] (591s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-mmap-wc) [491.657832] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-mmap-wc [491.661836] Subtest fbc-2p-primscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s) [491.754069] [079/153] (591s left) i915_drm_fdinfo (virtual-busy) [491.799759] Starting subtest: virtual-busy [491.804116] Subtest virtual-busy: SKIP (0.000s) [491.864731] [080/153] (591s left) gem_exec_parallel (contexts) [491.921808] Starting subtest: contexts [491.923650] Starting dynamic subtest: rcs0 [495.188035] Dynamic subtest rcs0: SUCCESS (3.264s) [495.199675] Starting dynamic subtest: bcs0 [499.406091] Dynamic subtest bcs0: SUCCESS (4.215s) [499.417720] Starting dynamic subtest: vcs0 [503.547050] Dynamic subtest vcs0: SUCCESS (4.137s) [503.561479] Starting dynamic subtest: vcs1 [509.418266] Dynamic subtest vcs1: SUCCESS (5.870s) [509.432357] Starting dynamic subtest: vecs0 [513.606787] Dynamic subtest vecs0: SUCCESS (4.187s) [513.621895] Starting dynamic subtest: ccs0 [517.594138] Dynamic subtest ccs0: SUCCESS (3.986s) [517.597044] Subtest contexts: SUCCESS (25.671s) [517.786580] [081/153] (565s left) kms_frontbuffer_tracking (hdr-2p-primscrn-cur-indfb-draw-mmap-wc) [517.896884] Starting subtest: hdr-2p-primscrn-cur-indfb-draw-mmap-wc [517.900878] Subtest hdr-2p-primscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s) [517.993116] [082/153] (565s left) perf_pmu (invalid-init) [518.031854] Starting subtest: invalid-init [518.034253] Subtest invalid-init: SUCCESS (0.000s) [518.133995] [083/153] (565s left) kms_fbcon_fbt (fbc-suspend) [518.181844] Starting subtest: fbc-suspend [567.832814] Subtest fbc-suspend: SUCCESS (19.938s) [569.215774] [084/153] (514s left) kms_chamelium_audio (dp-audio) [569.601781] Subtest dp-audio: SKIP (0.000s) [570.440506] [085/153] (513s left) sysfs_defaults (readonly) [570.495798] Starting subtest: readonly [570.498551] Starting dynamic subtest: vecs0 [570.500891] Dynamic subtest vecs0: SUCCESS (0.000s) [570.512915] Starting dynamic subtest: ccs0 [570.515290] Dynamic subtest ccs0: SUCCESS (0.000s) [570.526317] Starting dynamic subtest: vcs0 [570.528702] Dynamic subtest vcs0: SUCCESS (0.000s) [570.539566] Starting dynamic subtest: bcs0 [570.541768] Dynamic subtest bcs0: SUCCESS (0.000s) [570.552812] Starting dynamic subtest: rcs0 [570.555625] Dynamic subtest rcs0: SUCCESS (0.000s) [570.568885] Starting dynamic subtest: vcs1 [570.571491] Dynamic subtest vcs1: SUCCESS (0.000s) [570.573878] Subtest readonly: SUCCESS (0.006s) [570.616280] [086/153] (513s left) gem_exec_nop (basic-sequential) [570.696889] Starting subtest: basic-sequential [585.325049] Subtest basic-sequential: SUCCESS (14.688s) [585.547015] [087/153] (498s left) kms_ccs (bad-rotation-90-y-tiled-gen12-rc-ccs) [585.653315] Starting subtest: bad-rotation-90-y-tiled-gen12-rc-ccs [585.655622] Starting dynamic subtest: pipe-A-eDP-1 [585.679109] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [585.693105] Starting dynamic subtest: pipe-B-eDP-1 [585.718464] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [585.729875] Starting dynamic subtest: pipe-C-eDP-1 [585.755634] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [585.769813] Starting dynamic subtest: pipe-D-eDP-1 [585.796292] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [585.800910] Subtest bad-rotation-90-y-tiled-gen12-rc-ccs: SKIP (0.005s) [587.955599] [088/153] (495s left) kms_cursor_legacy (torture-bo) [588.080605] Starting subtest: torture-bo [588.083107] Starting dynamic subtest: pipe-A [594.296721] Dynamic subtest pipe-A: SUCCESS (6.220s) [594.311335] Starting dynamic subtest: pipe-B [600.062692] Dynamic subtest pipe-B: SUCCESS (5.766s) [600.082592] Starting dynamic subtest: pipe-C [607.114483] Dynamic subtest pipe-C: SUCCESS (7.046s) [607.135580] Starting dynamic subtest: pipe-D [614.154166] Dynamic subtest pipe-D: SUCCESS (7.036s) [614.177448] Starting dynamic subtest: all-pipes [621.603526] Dynamic subtest all-pipes: SUCCESS (7.449s) [621.605794] Subtest torture-bo: SUCCESS (33.526s) [621.764073] [089/153] (462s left) gem_mmap_gtt (cpuset-basic-small-copy-xy) [621.822494] Subtest cpuset-basic-small-copy-XY: SKIP (0.000s) [621.883396] [090/153] (461s left) gem_userptr_blits (stress-mm) [621.948764] Starting subtest: stress-mm [627.314541] Subtest stress-mm: SUCCESS (5.369s) [627.437476] [091/153] (456s left) i915_selftest (perf) [629.216598] Starting subtest: perf [629.219189] Starting dynamic subtest: engine_cs [632.946547] Dynamic subtest engine_cs: SUCCESS (3.731s) [632.957364] Starting dynamic subtest: request [641.153909] Dynamic subtest request: SUCCESS (8.208s) [641.165285] Starting dynamic subtest: migrate [644.977197] Dynamic subtest migrate: SUCCESS (3.822s) [644.989019] Starting dynamic subtest: region [650.028586] Dynamic subtest region: SUCCESS (5.052s) [650.031377] Subtest perf: SUCCESS (20.820s) [650.065936] [FACT i915_selftest (perf)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [650.066634] [FACT i915_selftest (perf)] deleted: kernel.kmod_is_loaded.i915: true [650.070093] [092/153] (433s left) kms_async_flips (async-flip-hang) [652.581935] Starting subtest: async-flip-hang [652.944576] Starting dynamic subtest: pipe-A-eDP-1 [666.332524] Dynamic subtest pipe-A-eDP-1: SUCCESS (13.390s) [666.717914] Starting dynamic subtest: pipe-B-eDP-1 [682.332883] Dynamic subtest pipe-B-eDP-1: SUCCESS (15.615s) [682.708806] Starting dynamic subtest: pipe-C-eDP-1 [698.327716] Dynamic subtest pipe-C-eDP-1: SUCCESS (15.624s) [698.704359] Starting dynamic subtest: pipe-D-eDP-1 [714.324807] Dynamic subtest pipe-D-eDP-1: SUCCESS (15.632s) [714.327834] Subtest async-flip-hang: SUCCESS (61.741s) [715.527737] [FACT kms_async_flips (async-flip-hang)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [715.529006] [FACT kms_async_flips (async-flip-hang)] new: kernel.kmod_is_loaded.i915: true [715.533167] [093/153] (368s left) kms_frontbuffer_tracking (fbchdr-1p-primscrn-spr-indfb-draw-mmap-cpu) [715.633003] Starting subtest: fbchdr-1p-primscrn-spr-indfb-draw-mmap-cpu [715.638276] Subtest fbchdr-1p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s) [715.736068] [094/153] (368s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-primscrn-spr-indfb-move) [715.833730] Starting subtest: fbcpsrhdr-1p-primscrn-spr-indfb-move [715.838638] Subtest fbcpsrhdr-1p-primscrn-spr-indfb-move: SKIP (0.000s) [715.931950] [095/153] (368s left) gem_partial_pwrite_pread (writes-after-reads-display) [715.989178] Subtest writes-after-reads-display: SKIP (0.000s) [716.066343] [096/153] (368s left) perf (short-reads) [716.209552] Starting subtest: short-reads [716.226909] Subtest short-reads: SUCCESS (0.017s) [716.278303] [097/153] (367s left) kms_frontbuffer_tracking (fbchdr-2p-scndscrn-cur-indfb-draw-mmap-cpu) [716.375115] Starting subtest: fbchdr-2p-scndscrn-cur-indfb-draw-mmap-cpu [716.379779] Subtest fbchdr-2p-scndscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s) [716.464449] [098/153] (367s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-180) [716.561491] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-180 [717.640792] Subtest x-tiled-max-hw-stride-64bpp-rotate-180: SUCCESS (1.079s) [717.756170] [099/153] (366s left) kms_rotation_crc (primary-4-tiled-reflect-x-180) [717.843480] Starting subtest: primary-4-tiled-reflect-x-180 [724.957148] Subtest primary-4-tiled-reflect-x-180: SUCCESS (7.117s) [726.162995] [100/153] (358s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-0) [726.272875] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-0 [726.278000] Subtest yf-tiled-max-hw-stride-64bpp-rotate-0: SKIP (0.000s) [726.367943] [101/153] (357s left) kms_cursor_crc (cursor-random-128x42) [726.590800] Starting subtest: cursor-random-128x42 [726.640625] Subtest cursor-random-128x42: SKIP (0.045s) [726.842621] [102/153] (357s left) kms_ccs (crc-sprite-planes-basic-4-tiled-dg2-rc-ccs-cc) [726.935409] Starting subtest: crc-sprite-planes-basic-4-tiled-dg2-rc-ccs-cc [726.937896] Starting dynamic subtest: pipe-A-eDP-1 [727.003617] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s) [727.014702] Starting dynamic subtest: pipe-B-eDP-1 [727.082003] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s) [727.093656] Starting dynamic subtest: pipe-C-eDP-1 [727.152670] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s) [727.163586] Starting dynamic subtest: pipe-D-eDP-1 [727.220656] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s) [727.225345] Subtest crc-sprite-planes-basic-4-tiled-dg2-rc-ccs-cc: SKIP (0.009s) [729.207710] [103/153] (355s left) kms_frontbuffer_tracking (hdr-2p-scndscrn-spr-indfb-draw-mmap-gtt) [729.309164] Starting subtest: hdr-2p-scndscrn-spr-indfb-draw-mmap-gtt [729.313811] Subtest hdr-2p-scndscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s) [729.415440] [104/153] (355s left) kms_cursor_legacy (basic-busy-flip-before-cursor-varying-size) [729.543304] Starting subtest: basic-busy-flip-before-cursor-varying-size [729.548431] Subtest basic-busy-flip-before-cursor-varying-size: SKIP (0.000s) [729.695594] [105/153] (354s left) kms_frontbuffer_tracking (fbchdr-1p-primscrn-cur-indfb-draw-mmap-gtt) [729.796600] Starting subtest: fbchdr-1p-primscrn-cur-indfb-draw-mmap-gtt [729.801666] Subtest fbchdr-1p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s) [729.903246] [106/153] (354s left) kms_frontbuffer_tracking (psr-2p-primscrn-shrfb-pgflip-blt) [729.991973] Starting subtest: psr-2p-primscrn-shrfb-pgflip-blt [729.997639] Subtest psr-2p-primscrn-shrfb-pgflip-blt: SKIP (0.000s) [730.079445] [107/153] (354s left) kms_content_protection (dp-mst-type-0-hdcp14) [730.225373] Starting subtest: dp-mst-type-0-hdcp14 [730.230272] Subtest dp-mst-type-0-hdcp14: SKIP (0.000s) [730.335554] [108/153] (354s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-render) [730.434722] Starting subtest: psr-1p-primscrn-spr-indfb-draw-render [737.243676] Subtest psr-1p-primscrn-spr-indfb-draw-render: SUCCESS (6.814s) [737.367837] [109/153] (347s left) gem_exec_schedule (submit-early-slice) [737.439336] Starting subtest: submit-early-slice [737.441702] Starting dynamic subtest: rcs0 [737.471181] Dynamic subtest rcs0: SUCCESS (0.044s) [737.485492] Starting dynamic subtest: bcs0 [737.509813] Dynamic subtest bcs0: SUCCESS (0.038s) [737.522366] Starting dynamic subtest: vcs0 [737.554481] Dynamic subtest vcs0: SUCCESS (0.044s) [737.565765] Starting dynamic subtest: vcs1 [737.595193] Dynamic subtest vcs1: SUCCESS (0.040s) [737.606808] Starting dynamic subtest: vecs0 [737.634975] Dynamic subtest vecs0: SUCCESS (0.039s) [737.646448] Starting dynamic subtest: ccs0 [737.673217] Dynamic subtest ccs0: SUCCESS (0.037s) [737.675905] Subtest submit-early-slice: SUCCESS (0.247s) [738.890613] [110/153] (345s left) i915_pm_rps (fence-order) [738.948768] Starting subtest: fence-order [742.150899] Subtest fence-order: SUCCESS (3.200s) [742.257223] [111/153] (342s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-16bpp-ytile-downscaling) [742.353219] Starting subtest: flip-64bpp-ytile-to-16bpp-ytile-downscaling [742.358118] Subtest flip-64bpp-ytile-to-16bpp-ytile-downscaling: SKIP (0.000s) [742.427389] [112/153] (342s left) kms_prop_blob (blob-multiple) [742.475192] Starting subtest: blob-multiple [742.477627] Subtest blob-multiple: SUCCESS (0.002s) [742.576267] [113/153] (342s left) kms_vblank (query-idle-hang) [742.664755] Starting subtest: query-idle-hang [742.667388] Starting dynamic subtest: pipe-A-eDP-1 [770.626209] Dynamic subtest pipe-A-eDP-1: SUCCESS (27.968s) [770.645386] Starting dynamic subtest: pipe-D-eDP-1 [785.586668] Dynamic subtest pipe-D-eDP-1: SUCCESS (14.963s) [785.589473] Subtest query-idle-hang: SUCCESS (42.935s) [786.402048] [114/153] (298s left) gem_userptr_blits (sync-overlap) [786.469684] Starting subtest: sync-overlap [786.472274] Subtest sync-overlap: SUCCESS (0.000s) [786.597228] [115/153] (298s left) kms_frontbuffer_tracking (psrhdr-1p-primscrn-shrfb-msflip-blt) [786.695155] Starting subtest: psrhdr-1p-primscrn-shrfb-msflip-blt [786.699887] Subtest psrhdr-1p-primscrn-shrfb-msflip-blt: SKIP (0.000s) [786.793588] [116/153] (298s left) kms_cursor_crc (cursor-offscreen-256x85) [787.053685] Starting subtest: cursor-offscreen-256x85 [787.109474] Subtest cursor-offscreen-256x85: SKIP (0.050s) [787.283324] [117/153] (297s left) kms_flip (2x-flip-vs-wf_vblank-interruptible) [787.376425] Starting subtest: 2x-flip-vs-wf_vblank-interruptible [787.389682] Subtest 2x-flip-vs-wf_vblank-interruptible: SKIP (0.010s) [787.466564] [118/153] (297s left) kms_psr2_sf (fbc-psr2-overlay-plane-update-sf-dmg-area) [787.567913] Starting subtest: fbc-psr2-overlay-plane-update-sf-dmg-area [787.570121] Starting dynamic subtest: pipe-A-eDP-1 [787.665233] Dynamic subtest pipe-A-eDP-1: SKIP (0.100s) [787.676230] Starting dynamic subtest: pipe-B-eDP-1 [788.796468] Dynamic subtest pipe-B-eDP-1: SKIP (1.127s) [788.801691] Subtest fbc-psr2-overlay-plane-update-sf-dmg-area: SKIP (1.230s) [789.991358] [119/153] (295s left) kms_psr (psr-cursor-plane-onoff) [790.083480] Starting subtest: psr-cursor-plane-onoff [790.085891] Starting dynamic subtest: eDP-1 [791.790438] Dynamic subtest eDP-1: SUCCESS (1.707s) [791.793187] Subtest psr-cursor-plane-onoff: SUCCESS (1.708s) [792.682119] [120/153] (292s left) gem_exec_reloc (basic-write-cpu-noreloc) [792.742632] Subtest basic-write-cpu-noreloc: SKIP (0.000s) [792.822846] [121/153] (292s left) gem_exec_schedule (manyslice) [792.898044] Starting subtest: manyslice [792.900291] Starting dynamic subtest: rcs0 [798.027944] Dynamic subtest rcs0: SUCCESS (5.140s) [798.043802] Starting dynamic subtest: bcs0 [805.197488] Dynamic subtest bcs0: SUCCESS (7.165s) [805.214412] Starting dynamic subtest: vcs0 [810.293100] Dynamic subtest vcs0: SUCCESS (5.092s) [810.308368] Starting dynamic subtest: vcs1 [815.899642] Dynamic subtest vcs1: SUCCESS (5.603s) [815.915470] Starting dynamic subtest: vecs0 [821.492114] Dynamic subtest vecs0: SUCCESS (5.589s) [821.505917] Starting dynamic subtest: ccs0 [828.195127] Dynamic subtest ccs0: SUCCESS (6.700s) [828.198022] Subtest manyslice: SUCCESS (35.301s) [828.501750] [122/153] (256s left) kms_frontbuffer_tracking (hdr-1p-offscreen-pri-indfb-draw-blt) [828.606459] Starting subtest: hdr-1p-offscreen-pri-indfb-draw-blt [828.611346] Subtest hdr-1p-offscreen-pri-indfb-draw-blt: SKIP (0.000s) [828.702582] [123/153] (256s left) kms_big_fb (4-tiled-64bpp-rotate-270) [828.804354] Starting subtest: 4-tiled-64bpp-rotate-270 [828.823952] Subtest 4-tiled-64bpp-rotate-270: SKIP (0.020s) [828.956748] [124/153] (256s left) kms_joiner (switch-modeset-ultra-joiner-big-joiner) [829.066676] Starting subtest: switch-modeset-ultra-joiner-big-joiner [829.071632] Subtest switch-modeset-ultra-joiner-big-joiner: SKIP (0.000s) [829.133234] [125/153] (256s left) kms_frontbuffer_tracking (hdr-2p-primscrn-pri-indfb-draw-mmap-wc) [829.240452] Starting subtest: hdr-2p-primscrn-pri-indfb-draw-mmap-wc [829.245448] Subtest hdr-2p-primscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s) [829.335915] [126/153] (256s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-indfb-pgflip-blt) [829.435691] Starting subtest: fbcpsr-1p-primscrn-indfb-pgflip-blt [836.862162] Subtest fbcpsr-1p-primscrn-indfb-pgflip-blt: SUCCESS (7.431s) [836.988576] [127/153] (248s left) gem_sync (basic-many-each) [837.065593] Starting subtest: basic-many-each [839.352076] Subtest basic-many-each: SUCCESS (2.300s) [839.569152] [128/153] (245s left) kms_frontbuffer_tracking (psrhdr-2p-scndscrn-pri-shrfb-draw-blt) [839.671875] Starting subtest: psrhdr-2p-scndscrn-pri-shrfb-draw-blt [839.676766] Subtest psrhdr-2p-scndscrn-pri-shrfb-draw-blt: SKIP (0.000s) [839.795456] [129/153] (245s left) gem_exec_reloc (basic-cpu-active) [839.856946] Subtest basic-cpu-active: SKIP (0.000s) [839.927300] [130/153] (245s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-primscrn-spr-indfb-draw-pwrite) [840.015242] Starting subtest: fbcpsrhdr-2p-primscrn-spr-indfb-draw-pwrite [840.019740] Subtest fbcpsrhdr-2p-primscrn-spr-indfb-draw-pwrite: SKIP (0.000s) [840.110106] [131/153] (245s left) gem_ctx_persistence (engines-mixed-process) [840.159946] Starting subtest: engines-mixed-process [840.163211] Starting dynamic subtest: rcs0 [841.850757] Dynamic subtest rcs0: SUCCESS (1.691s) [841.863921] Starting dynamic subtest: bcs0 [843.846403] Dynamic subtest bcs0: SUCCESS (1.995s) [843.858910] Starting dynamic subtest: vcs0 [845.829028] Dynamic subtest vcs0: SUCCESS (1.982s) [845.843034] Starting dynamic subtest: vcs1 [847.849132] Dynamic subtest vcs1: SUCCESS (2.018s) [847.862132] Starting dynamic subtest: vecs0 [849.860817] Dynamic subtest vecs0: SUCCESS (2.011s) [849.872894] Starting dynamic subtest: ccs0 [851.842893] Dynamic subtest ccs0: SUCCESS (1.980s) [851.845870] Subtest engines-mixed-process: SUCCESS (11.683s) [851.924415] [132/153] (233s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-scndscrn-pri-shrfb-draw-mmap-wc) [852.030902] Starting subtest: fbcpsrhdr-2p-scndscrn-pri-shrfb-draw-mmap-wc [852.036529] Subtest fbcpsrhdr-2p-scndscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s) [852.116907] [133/153] (233s left) sw_sync (alloc_merge_fence) [852.153557] Starting subtest: alloc_merge_fence [852.156148] Subtest alloc_merge_fence: SUCCESS (0.000s) [852.213065] [134/153] (233s left) kms_ccs (crc-primary-suspend-y-tiled-gen12-rc-ccs-cc) [852.297869] Starting subtest: crc-primary-suspend-y-tiled-gen12-rc-ccs-cc [852.300623] Starting dynamic subtest: pipe-A-eDP-1 [852.309775] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [852.322226] Starting dynamic subtest: pipe-B-eDP-1 [852.331049] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [852.342422] Starting dynamic subtest: pipe-C-eDP-1 [852.352060] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [852.363069] Starting dynamic subtest: pipe-D-eDP-1 [852.372879] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [852.377661] Subtest crc-primary-suspend-y-tiled-gen12-rc-ccs-cc: SKIP (0.004s) [854.567281] [135/153] (231s left) kms_frontbuffer_tracking (hdr-2p-scndscrn-cur-indfb-draw-mmap-wc) [854.670762] Starting subtest: hdr-2p-scndscrn-cur-indfb-draw-mmap-wc [854.675555] Subtest hdr-2p-scndscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s) [854.764750] [136/153] (231s left) gem_create (create-clear) [854.818485] Starting subtest: create-clear [854.820848] Starting dynamic subtest: smem0 [887.748639] Dynamic subtest smem0: SUCCESS (32.927s) [887.751194] Subtest create-clear: SUCCESS (32.928s) [887.938193] [137/153] (197s left) core_setmaster (master-drop-set-shared-fd) [888.019876] Starting subtest: master-drop-set-shared-fd [888.042161] Subtest master-drop-set-shared-fd: SUCCESS (0.022s) [888.083582] [138/153] (197s left) kms_big_fb (linear-16bpp-rotate-180) [888.183693] Starting subtest: linear-16bpp-rotate-180 [888.897651] Subtest linear-16bpp-rotate-180: FAIL (0.051s) [888.940164] [139/153] (197s left) gem_exec_reloc (basic-active) [888.996633] Subtest basic-active: SKIP (0.000s) [889.072193] [140/153] (196s left) kms_frontbuffer_tracking (fbcpsrhdr-rgb565-draw-mmap-wc) [889.163732] Starting subtest: fbcpsrhdr-rgb565-draw-mmap-wc [889.167876] Subtest fbcpsrhdr-rgb565-draw-mmap-wc: SKIP (0.000s) [889.281439] [141/153] (196s left) kms_frontbuffer_tracking (fbchdr-2p-primscrn-indfb-pgflip-blt) [889.378655] Starting subtest: fbchdr-2p-primscrn-indfb-pgflip-blt [889.383451] Subtest fbchdr-2p-primscrn-indfb-pgflip-blt: SKIP (0.000s) [889.478297] [142/153] (196s left) gem_userptr_blits (sync-unmap-after-close) [889.542811] Starting subtest: sync-unmap-after-close [889.554344] Subtest sync-unmap-after-close: SUCCESS (0.012s) [889.692579] [143/153] (196s left) kms_psr (fbc-psr2-sprite-mmap-cpu) [889.779326] Starting subtest: fbc-psr2-sprite-mmap-cpu [889.781518] Starting dynamic subtest: eDP-1 [889.785610] Dynamic subtest eDP-1: SKIP (0.000s) [889.789713] Subtest fbc-psr2-sprite-mmap-cpu: SKIP (0.001s) [889.857439] [144/153] (196s left) gem_mmap_offset (close-race) [889.911397] Starting subtest: close-race [910.019415] Subtest close-race: SUCCESS (20.109s) [910.152934] [145/153] (176s left) syncobj_wait (invalid-multi-wait-all-unsubmitted-signaled) [910.202683] Starting subtest: invalid-multi-wait-all-unsubmitted-signaled [910.205447] Subtest invalid-multi-wait-all-unsubmitted-signaled: SUCCESS (0.000s) [910.304416] [146/153] (176s left) kms_pipe_crc_basic (compare-crc-sanitycheck-nv12) [910.392542] Starting subtest: compare-crc-sanitycheck-nv12 [910.394585] Starting dynamic subtest: pipe-A-eDP-1 [911.110392] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.719s) [911.123625] Starting dynamic subtest: pipe-B-eDP-1 [912.458926] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.346s) [912.471884] Starting dynamic subtest: pipe-C-eDP-1 [913.714181] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.253s) [913.726585] Starting dynamic subtest: pipe-D-eDP-1 [914.954969] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.243s) [914.957688] Subtest compare-crc-sanitycheck-nv12: SUCCESS (4.566s) [915.781260] [147/153] (170s left) sriov_basic (bind-unbind-vf) [915.836139] Starting subtest: bind-unbind-vf [915.838578] Starting dynamic subtest: vf-1 [915.843489] Dynamic subtest vf-1: SKIP (0.001s) [915.855371] Starting dynamic subtest: vf-2 [915.860323] Dynamic subtest vf-2: SKIP (0.001s) [915.871883] Starting dynamic subtest: vf-3 [915.876381] Dynamic subtest vf-3: SKIP (0.000s) [915.887217] Starting dynamic subtest: vf-4 [915.891455] Dynamic subtest vf-4: SKIP (0.000s) [915.902224] Starting dynamic subtest: vf-5 [915.906721] Dynamic subtest vf-5: SKIP (0.001s) [915.917647] Starting dynamic subtest: vf-6 [915.922327] Dynamic subtest vf-6: SKIP (0.000s) [915.933205] Starting dynamic subtest: vf-7 [915.937809] Dynamic subtest vf-7: SKIP (0.001s) [915.948568] Starting dynamic subtest: vf-random [915.953218] Dynamic subtest vf-random: SKIP (0.000s) [915.964014] Starting dynamic subtest: vf-last [915.968568] Dynamic subtest vf-last: SKIP (0.000s) [915.973022] Subtest bind-unbind-vf: SKIP (0.011s) [916.014160] [148/153] (170s left) kms_psr2_sf (fbc-pr-cursor-plane-move-continuous-exceed-sf) [916.105052] Starting subtest: fbc-pr-cursor-plane-move-continuous-exceed-sf [916.110125] Subtest fbc-pr-cursor-plane-move-continuous-exceed-sf: SKIP (0.000s) [916.181104] [149/153] (170s left) api_intel_allocator (execbuf-with-allocator) [916.228637] Starting subtest: execbuf-with-allocator [916.230766] Subtest execbuf-with-allocator: SUCCESS (0.005s) [916.343023] [150/153] (170s left) gem_exec_store (cachelines) [916.407737] Starting subtest: cachelines [916.410137] Starting dynamic subtest: rcs0 [916.467931] Dynamic subtest rcs0: SUCCESS (0.063s) [916.480701] Starting dynamic subtest: bcs0 [916.524812] Dynamic subtest bcs0: SUCCESS (0.055s) [916.536697] Starting dynamic subtest: vcs0 [916.586061] Dynamic subtest vcs0: SUCCESS (0.060s) [916.597906] Starting dynamic subtest: vcs1 [916.642515] Dynamic subtest vcs1: SUCCESS (0.055s) [916.654717] Starting dynamic subtest: vecs0 [916.698155] Dynamic subtest vecs0: SUCCESS (0.055s) [916.709709] Starting dynamic subtest: ccs0 [916.753545] Dynamic subtest ccs0: SUCCESS (0.054s) [916.755898] Subtest cachelines: SUCCESS (0.350s) [916.942112] [151/153] (169s left) gem_render_copy (y-tiled-to-vebox-yf-tiled) [916.997157] Starting subtest: y-tiled-to-vebox-yf-tiled [917.002149] Subtest y-tiled-to-vebox-yf-tiled: SKIP (0.000s) [917.183068] [152/153] (169s left) gem_render_copy (y-tiled-ccs-to-x-tiled) [917.232225] Starting subtest: y-tiled-ccs-to-x-tiled [917.237057] Subtest y-tiled-ccs-to-x-tiled: SKIP (0.000s) [917.412953] [153/153] (169s left) kms_frontbuffer_tracking (hdr-1p-primscrn-cur-indfb-draw-mmap-cpu) [917.519315] Starting subtest: hdr-1p-primscrn-cur-indfb-draw-mmap-cpu [917.523777] Subtest hdr-1p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s) [917.594302] Closing watchdogs results: parsing output: 0/ for test: kms_atomic_transition results: parsing output: 1/ for test: kms_frontbuffer_tracking results: parsing output: 2/ for test: kms_psr results: parsing output: 3/ for test: prime_mmap results: parsing output: 4/ for test: gem_readwrite results: parsing output: 5/ for test: kms_fence_pin_leak results: parsing output: 6/ for test: kms_plane results: parsing output: 7/ for test: syncobj_eventfd results: parsing output: 8/ for test: perf_pmu results: parsing output: 9/ for test: kms_frontbuffer_tracking results: parsing output: 10/ for test: gen9_exec_parse results: parsing output: 11/ for test: kms_frontbuffer_tracking results: parsing output: 12/ for test: gem_workarounds results: parsing output: 13/ for test: kms_big_fb results: parsing output: 14/ for test: kms_plane_cursor results: parsing output: 15/ for test: kms_addfb_basic results: parsing output: 16/ for test: kms_frontbuffer_tracking results: parsing output: 17/ for test: kms_frontbuffer_tracking results: parsing output: 18/ for test: gem_exec_params results: parsing output: 19/ for test: kms_flip_scaled_crc results: parsing output: 20/ for test: gem_userptr_blits results: parsing output: 21/ for test: kms_draw_crc results: parsing output: 22/ for test: kms_frontbuffer_tracking results: parsing output: 23/ for test: api_intel_bb results: parsing output: 24/ for test: kms_frontbuffer_tracking results: parsing output: 25/ for test: gen3_render_tiledx_blits results: parsing output: 26/ for test: fbdev results: parsing output: 27/ for test: kms_getfb results: parsing output: 28/ for test: gem_exec_capture results: parsing output: 29/ for test: gem_exec_balancer results: parsing output: 30/ for test: kms_frontbuffer_tracking results: parsing output: 31/ for test: i915_module_load results: parsing output: 32/ for test: gem_softpin results: parsing output: 33/ for test: kms_plane_scaling results: parsing output: 34/ for test: kms_color_pipeline results: parsing output: 35/ for test: gem_mmap_wc results: parsing output: 36/ for test: gem_exec_fence results: parsing output: 37/ for test: kms_frontbuffer_tracking results: parsing output: 38/ for test: kms_chamelium_frames results: parsing output: 39/ for test: kms_chamelium_hpd results: parsing output: 40/ for test: gem_exec_reloc results: parsing output: 41/ for test: syncobj_wait results: parsing output: 42/ for test: gem_exec_suspend results: parsing output: 43/ for test: kms_force_connector_basic results: parsing output: 44/ for test: kms_flip results: parsing output: 45/ for test: gem_pxp results: parsing output: 46/ for test: perf_pmu results: parsing output: 47/ for test: syncobj_timeline results: parsing output: 48/ for test: gem_partial_pwrite_pread results: parsing output: 49/ for test: kms_plane results: parsing output: 50/ for test: kms_vblank results: parsing output: 51/ for test: kms_psr results: parsing output: 52/ for test: kms_frontbuffer_tracking results: parsing output: 53/ for test: kms_ccs results: parsing output: 54/ for test: kms_frontbuffer_tracking results: parsing output: 55/ for test: kms_frontbuffer_tracking results: parsing output: 56/ for test: kms_psr results: parsing output: 57/ for test: kms_frontbuffer_tracking results: parsing output: 58/ for test: syncobj_timeline results: parsing output: 59/ for test: kms_frontbuffer_tracking results: parsing output: 60/ for test: gem_eio results: parsing output: 61/ for test: syncobj_wait results: parsing output: 62/ for test: gem_ctx_persistence results: parsing output: 63/ for test: gem_exec_reloc results: parsing output: 64/ for test: syncobj_timeline results: parsing output: 65/ for test: kms_frontbuffer_tracking results: parsing output: 66/ for test: kms_plane results: parsing output: 67/ for test: kms_frontbuffer_tracking results: parsing output: 68/ for test: kms_frontbuffer_tracking results: parsing output: 69/ for test: syncobj_timeline results: parsing output: 70/ for test: kms_rotation_crc results: parsing output: 71/ for test: kms_big_fb results: parsing output: 72/ for test: gem_lmem_swapping results: parsing output: 73/ for test: kms_cursor_legacy results: parsing output: 74/ for test: kms_big_fb results: parsing output: 75/ for test: kms_frontbuffer_tracking results: parsing output: 76/ for test: kms_frontbuffer_tracking results: parsing output: 77/ for test: kms_frontbuffer_tracking results: parsing output: 78/ for test: i915_drm_fdinfo results: parsing output: 79/ for test: gem_exec_parallel results: parsing output: 80/ for test: kms_frontbuffer_tracking results: parsing output: 81/ for test: perf_pmu results: parsing output: 82/ for test: kms_fbcon_fbt results: parsing output: 83/ for test: kms_chamelium_audio results: parsing output: 84/ for test: sysfs_defaults results: parsing output: 85/ for test: gem_exec_nop results: parsing output: 86/ for test: kms_ccs results: parsing output: 87/ for test: kms_cursor_legacy results: parsing output: 88/ for test: gem_mmap_gtt results: parsing output: 89/ for test: gem_userptr_blits results: parsing output: 90/ for test: i915_selftest results: parsing output: 91/ for test: kms_async_flips results: parsing output: 92/ for test: kms_frontbuffer_tracking results: parsing output: 93/ for test: kms_frontbuffer_tracking results: parsing output: 94/ for test: gem_partial_pwrite_pread results: parsing output: 95/ for test: perf results: parsing output: 96/ for test: kms_frontbuffer_tracking results: parsing output: 97/ for test: kms_big_fb results: parsing output: 98/ for test: kms_rotation_crc results: parsing output: 99/ for test: kms_big_fb results: parsing output: 100/ for test: kms_cursor_crc results: parsing output: 101/ for test: kms_ccs results: parsing output: 102/ for test: kms_frontbuffer_tracking results: parsing output: 103/ for test: kms_cursor_legacy results: parsing output: 104/ for test: kms_frontbuffer_tracking results: parsing output: 105/ for test: kms_frontbuffer_tracking results: parsing output: 106/ for test: kms_content_protection results: parsing output: 107/ for test: kms_frontbuffer_tracking results: parsing output: 108/ for test: gem_exec_schedule results: parsing output: 109/ for test: i915_pm_rps results: parsing output: 110/ for test: kms_flip_scaled_crc results: parsing output: 111/ for test: kms_prop_blob results: parsing output: 112/ for test: kms_vblank results: parsing output: 113/ for test: gem_userptr_blits results: parsing output: 114/ for test: kms_frontbuffer_tracking results: parsing output: 115/ for test: kms_cursor_crc results: parsing output: 116/ for test: kms_flip results: parsing output: 117/ for test: kms_psr2_sf results: parsing output: 118/ for test: kms_psr results: parsing output: 119/ for test: gem_exec_reloc results: parsing output: 120/ for test: gem_exec_schedule results: parsing output: 121/ for test: kms_frontbuffer_tracking results: parsing output: 122/ for test: kms_big_fb results: parsing output: 123/ for test: kms_joiner results: parsing output: 124/ for test: kms_frontbuffer_tracking results: parsing output: 125/ for test: kms_frontbuffer_tracking results: parsing output: 126/ for test: gem_sync results: parsing output: 127/ for test: kms_frontbuffer_tracking results: parsing output: 128/ for test: gem_exec_reloc results: parsing output: 129/ for test: kms_frontbuffer_tracking results: parsing output: 130/ for test: gem_ctx_persistence results: parsing output: 131/ for test: kms_frontbuffer_tracking results: parsing output: 132/ for test: sw_sync results: parsing output: 133/ for test: kms_ccs results: parsing output: 134/ for test: kms_frontbuffer_tracking results: parsing output: 135/ for test: gem_create results: parsing output: 136/ for test: core_setmaster results: parsing output: 137/ for test: kms_big_fb results: parsing output: 138/ for test: gem_exec_reloc results: parsing output: 139/ for test: kms_frontbuffer_tracking results: parsing output: 140/ for test: kms_frontbuffer_tracking results: parsing output: 141/ for test: gem_userptr_blits results: parsing output: 142/ for test: kms_psr results: parsing output: 143/ for test: gem_mmap_offset results: parsing output: 144/ for test: syncobj_wait results: parsing output: 145/ for test: kms_pipe_crc_basic results: parsing output: 146/ for test: sriov_basic results: parsing output: 147/ for test: kms_psr2_sf results: parsing output: 148/ for test: api_intel_allocator results: parsing output: 149/ for test: gem_exec_store results: parsing output: 150/ for test: gem_render_copy results: parsing output: 151/ for test: gem_render_copy results: parsing output: 152/ for test: kms_frontbuffer_tracking Done.