[59.186716] Initializing watchdogs [59.186775] /dev/watchdog0 [59.200865] [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] [59.205280] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [59.208200] [FACT before any test] new: kernel.kmod_is_loaded.i915: true [59.211625] [001/133] (960s left) kms_flip_scaled_crc (flip-64bpp-xtile-to-32bpp-xtile-downscaling) [59.338790] Starting subtest: flip-64bpp-xtile-to-32bpp-xtile-downscaling [59.341044] Starting dynamic subtest: pipe-A-default-mode [60.523178] Dynamic subtest pipe-A-default-mode: SKIP (1.182s) [60.528876] Subtest flip-64bpp-xtile-to-32bpp-xtile-downscaling: SKIP (1.183s) [60.651987] [002/133] (959s left) kms_ccs (bad-rotation-90-y-tiled-gen12-mc-ccs) [60.741058] Starting subtest: bad-rotation-90-y-tiled-gen12-mc-ccs [60.743415] Starting dynamic subtest: pipe-A-eDP-1 [60.766527] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [60.775547] Starting dynamic subtest: pipe-B-eDP-1 [60.797076] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [60.803902] Starting dynamic subtest: pipe-C-eDP-1 [60.826400] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [60.832965] Starting dynamic subtest: pipe-D-eDP-1 [60.854330] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [60.858670] Subtest bad-rotation-90-y-tiled-gen12-mc-ccs: SKIP (0.003s) [62.948271] [003/133] (956s left) kms_content_protection (uevent-hdcp14) [63.095873] Starting subtest: uevent-hdcp14 [63.100936] Subtest uevent-hdcp14: SKIP (0.000s) [63.230083] [004/133] (956s left) kms_psr (fbc-psr-cursor-plane-onoff) [63.337848] Starting subtest: fbc-psr-cursor-plane-onoff [63.340253] Starting dynamic subtest: eDP-1 [63.344740] Dynamic subtest eDP-1: SKIP (0.000s) [63.349399] Subtest fbc-psr-cursor-plane-onoff: SKIP (0.001s) [63.407197] [005/133] (956s left) kms_getfb (getfb-handle-zero) [63.501315] Starting subtest: getfb-handle-zero [63.503569] Subtest getfb-handle-zero: SUCCESS (0.000s) [63.600647] [006/133] (956s left) sriov_basic (enable-vfs-bind-unbind-each-numvfs-all) [63.657080] Starting subtest: enable-vfs-bind-unbind-each-numvfs-all [63.736469] Subtest enable-vfs-bind-unbind-each-numvfs-all: FAIL (0.030s) [63.769661] [007/133] (956s left) gem_render_copy (y-tiled-mc-ccs-to-y-tiled-ccs) [63.820171] Starting subtest: y-tiled-mc-ccs-to-y-tiled-ccs [63.823858] Subtest y-tiled-mc-ccs-to-y-tiled-ccs: SKIP (0.000s) [64.001557] [008/133] (955s left) gem_exec_schedule (independent) [64.076043] Starting subtest: independent [64.078027] Starting dynamic subtest: rcs0 [65.942741] Dynamic subtest rcs0: SUCCESS (1.872s) [65.953781] Starting dynamic subtest: vcs0 [68.046712] Dynamic subtest vcs0: SUCCESS (2.049s) [68.058046] Starting dynamic subtest: vcs1 [69.926042] Dynamic subtest vcs1: SUCCESS (1.932s) [69.937364] Starting dynamic subtest: vecs0 [71.901531] Dynamic subtest vecs0: SUCCESS (1.975s) [71.911454] Starting dynamic subtest: ccs0 [73.876980] Dynamic subtest ccs0: SUCCESS (1.974s) [73.879931] Subtest independent: SUCCESS (9.806s) [74.179072] [009/133] (945s left) gem_exec_params (invalid-bsd-ring) [74.255165] Starting subtest: invalid-bsd-ring [74.257612] Subtest invalid-bsd-ring: SUCCESS (0.000s) [74.349597] [010/133] (945s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-pwrite) [74.451958] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-pwrite [83.013935] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-pwrite: SUCCESS (8.564s) [83.122187] [011/133] (936s left) gem_reg_read (timestamp-monotonic) [83.180749] Starting subtest: timestamp-monotonic [87.528044] Subtest timestamp-monotonic: SUCCESS (4.347s) [87.600736] [012/133] (932s left) kms_big_fb (y-tiled-32bpp-rotate-270) [87.706395] Starting subtest: y-tiled-32bpp-rotate-270 [87.710681] Subtest y-tiled-32bpp-rotate-270: SKIP (0.000s) [87.798032] [013/133] (932s left) kms_lease (lease-invalid-crtc) [87.886116] Starting subtest: lease-invalid-crtc [87.888421] Starting dynamic subtest: pipe-A-eDP-1 [87.890631] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s) [87.897998] Starting dynamic subtest: pipe-B-eDP-1 [87.899833] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s) [87.906871] Starting dynamic subtest: pipe-C-eDP-1 [87.908920] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s) [87.915829] Starting dynamic subtest: pipe-D-eDP-1 [87.917626] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s) [87.919469] Subtest lease-invalid-crtc: SUCCESS (0.002s) [87.960155] [014/133] (932s left) gem_render_copy (linear) [88.019398] Starting subtest: linear [88.021813] Starting dynamic subtest: smem [88.057613] Dynamic subtest smem: SUCCESS (0.038s) [88.059966] Subtest linear: SUCCESS (0.039s) [88.290625] [015/133] (931s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-mmap-wc) [88.384716] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-mmap-wc [95.426054] Subtest psr-1p-primscrn-pri-shrfb-draw-mmap-wc: SUCCESS (7.043s) [95.534603] [016/133] (924s left) gem_eio (create-ext) [95.777741] Starting subtest: create-ext [96.102286] Subtest create-ext: SUCCESS (0.324s) [96.233052] [017/133] (924s left) core_getstats (basic) [96.290675] Starting subtest: basic [96.292613] Subtest basic: SUCCESS (0.000s) [96.389723] [018/133] (923s left) kms_big_fb (x-tiled-64bpp-rotate-270) [96.491942] Starting subtest: x-tiled-64bpp-rotate-270 [96.510158] Subtest x-tiled-64bpp-rotate-270: SKIP (0.018s) [96.620136] [019/133] (923s left) syncobj_wait (invalid-single-wait-unsubmitted) [96.670048] Starting subtest: invalid-single-wait-unsubmitted [96.672068] Subtest invalid-single-wait-unsubmitted: SUCCESS (0.000s) [96.781469] [020/133] (923s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-cpu) [96.882697] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-cpu [96.886254] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s) [96.985452] [021/133] (923s left) kms_invalid_mode (zero-hdisplay) [97.081037] Starting subtest: zero-hdisplay [97.084047] Starting dynamic subtest: pipe-A-eDP-1 [97.366417] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.288s) [97.374890] Starting dynamic subtest: pipe-B-eDP-1 [97.377148] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s) [97.384522] Starting dynamic subtest: pipe-C-eDP-1 [97.386723] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s) [97.394219] Starting dynamic subtest: pipe-D-eDP-1 [97.396100] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s) [97.397972] Subtest zero-hdisplay: SUCCESS (0.292s) [98.230957] [022/133] (922s left) kms_flip (2x-flip-vs-modeset-vs-hang) [98.327681] Starting subtest: 2x-flip-vs-modeset-vs-hang [98.335521] Subtest 2x-flip-vs-modeset-vs-hang: SKIP (0.010s) [98.444182] [023/133] (922s left) kms_pipe_crc_basic (nonblocking-crc-frame-sequence) [98.532665] Starting subtest: nonblocking-crc-frame-sequence [98.534880] Starting dynamic subtest: pipe-A-eDP-1 [99.273299] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.739s) [99.283453] Starting dynamic subtest: pipe-B-eDP-1 [100.657578] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.384s) [100.666857] Starting dynamic subtest: pipe-C-eDP-1 [102.026045] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.368s) [102.035801] Starting dynamic subtest: pipe-D-eDP-1 [103.382762] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.355s) [103.385160] Subtest nonblocking-crc-frame-sequence: SUCCESS (4.851s) [104.177070] [024/133] (916s left) i915_drm_fdinfo (isolation) [104.218232] Starting subtest: isolation [104.220159] Starting dynamic subtest: rcs0 [104.242913] Dynamic subtest rcs0: SKIP (0.024s) [104.250904] Starting dynamic subtest: bcs0 [104.254823] Dynamic subtest bcs0: SKIP (0.000s) [104.262046] Starting dynamic subtest: vcs0 [104.266571] Dynamic subtest vcs0: SKIP (0.000s) [104.273635] Starting dynamic subtest: vcs1 [104.277795] Dynamic subtest vcs1: SKIP (0.000s) [104.284521] Starting dynamic subtest: vecs0 [104.288668] Dynamic subtest vecs0: SKIP (0.000s) [104.295654] Starting dynamic subtest: ccs0 [104.299887] Dynamic subtest ccs0: SKIP (0.000s) [104.304057] Subtest isolation: SKIP (0.027s) [104.337956] [025/133] (916s left) kms_chamelium_edid (hdmi-edid-stress-resolution-non-4k) [104.719448] Subtest hdmi-edid-stress-resolution-non-4k: SKIP (0.000s) [105.488158] [026/133] (915s left) gem_pxp (hw-rejects-pxp-buffer) [105.610731] Starting subtest: hw-rejects-pxp-buffer [105.615481] Subtest hw-rejects-pxp-buffer: SKIP (0.000s) [105.725140] [027/133] (914s left) kms_frontbuffer_tracking (fbc-tiling-4) [105.819339] Starting subtest: fbc-tiling-4 [110.032074] Subtest fbc-tiling-4: SUCCESS (4.216s) [111.215096] [028/133] (909s left) gem_fence_thrash (bo-write-verify-threaded-none) [111.254977] Starting subtest: bo-write-verify-threaded-none [111.282420] Subtest bo-write-verify-threaded-none: SKIP (0.025s) [111.343206] [029/133] (909s left) kms_plane (pixel-format-y-tiled-gen12-rc-ccs-modifier) [111.435852] Starting subtest: pixel-format-y-tiled-gen12-rc-ccs-modifier [111.439881] Subtest pixel-format-y-tiled-gen12-rc-ccs-modifier: SKIP (0.000s) [111.503039] [030/133] (909s left) gen9_exec_parse (basic-rejected-ctx-param) [111.571642] Subtest basic-rejected-ctx-param: SKIP (0.000s) [111.648558] [031/133] (909s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-mmap-gtt) [111.748364] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-mmap-gtt [111.752530] Subtest fbc-1p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s) [111.849604] [032/133] (909s left) kms_psr (pr-dpms) [111.946892] Starting subtest: pr-dpms [111.951448] Subtest pr-dpms: SKIP (0.000s) [112.024149] [033/133] (908s left) i915_selftest (live) [115.215947] Starting subtest: live [115.218699] Starting dynamic subtest: sanitycheck [119.479314] Dynamic subtest sanitycheck: SUCCESS (4.266s) [119.486441] Starting dynamic subtest: uncore [123.758437] Dynamic subtest uncore: SUCCESS (4.278s) [123.765988] Starting dynamic subtest: workarounds [126.849542] Dynamic subtest workarounds: SUCCESS (3.090s) [126.858437] Starting dynamic subtest: gt_engines [129.863805] Dynamic subtest gt_engines: SUCCESS (3.013s) [129.872901] Starting dynamic subtest: gt_timelines [145.576349] Dynamic subtest gt_timelines: SUCCESS (15.711s) [145.585135] Starting dynamic subtest: gt_contexts [149.869359] Dynamic subtest gt_contexts: SUCCESS (4.291s) [149.878028] Starting dynamic subtest: gt_lrc [155.982218] Dynamic subtest gt_lrc: SUCCESS (6.112s) [155.995095] Starting dynamic subtest: gt_mocs [158.885521] Dynamic subtest gt_mocs: SUCCESS (2.901s) [158.894606] Starting dynamic subtest: gt_pm [163.646110] Dynamic subtest gt_pm: SUCCESS (4.759s) [163.654809] Starting dynamic subtest: gt_heartbeat [168.014427] Dynamic subtest gt_heartbeat: SUCCESS (4.367s) [168.022727] Starting dynamic subtest: gt_tlb [177.327499] Dynamic subtest gt_tlb: SUCCESS (9.311s) [177.336054] Starting dynamic subtest: requests [188.717642] Dynamic subtest requests: SUCCESS (11.388s) [188.726422] Starting dynamic subtest: migrate [194.467449] Dynamic subtest migrate: SUCCESS (5.748s) [194.476454] Starting dynamic subtest: active [198.745979] Dynamic subtest active: SUCCESS (4.277s) [198.754588] Starting dynamic subtest: objects [201.893760] Dynamic subtest objects: SUCCESS (3.147s) [201.901169] Starting dynamic subtest: mman [205.141411] Dynamic subtest mman: SUCCESS (3.245s) [205.155207] Starting dynamic subtest: dmabuf [207.821967] Dynamic subtest dmabuf: SUCCESS (2.679s) [207.829352] Starting dynamic subtest: vma [212.134053] Dynamic subtest vma: SUCCESS (4.310s) [212.142902] Starting dynamic subtest: coherency [217.202050] Dynamic subtest coherency: SUCCESS (5.067s) [217.209564] Starting dynamic subtest: gtt [227.009634] Dynamic subtest gtt: SUCCESS (9.805s) [227.018092] Starting dynamic subtest: gem [234.591592] Dynamic subtest gem: SUCCESS (7.580s) [234.601102] Starting dynamic subtest: evict [238.542339] Dynamic subtest evict: SUCCESS (3.949s) [238.550851] Starting dynamic subtest: hugepages [247.470212] Dynamic subtest hugepages: SUCCESS (8.925s) [247.479664] Starting dynamic subtest: gem_contexts [274.069960] Dynamic subtest gem_contexts: SUCCESS (26.597s) [274.079651] Starting dynamic subtest: client [276.759286] Dynamic subtest client: SUCCESS (2.688s) [276.773342] Starting dynamic subtest: gem_migrate [281.048756] Dynamic subtest gem_migrate: SUCCESS (4.287s) [281.056825] Starting dynamic subtest: reset [283.783765] Dynamic subtest reset: SUCCESS (2.733s) [283.792722] Starting dynamic subtest: memory_region [288.110060] Dynamic subtest memory_region: SUCCESS (4.325s) [288.122393] Starting dynamic subtest: hangcheck [300.960861] Dynamic subtest hangcheck: SUCCESS (12.849s) [300.969753] Starting dynamic subtest: execlists [305.288069] Dynamic subtest execlists: SUCCESS (4.324s) [305.296816] Starting dynamic subtest: ring_submission [309.525524] Dynamic subtest ring_submission: SUCCESS (4.235s) [309.534482] Starting dynamic subtest: perf [312.364312] Dynamic subtest perf: SUCCESS (2.838s) [312.373242] Starting dynamic subtest: slpc [326.400052] Dynamic subtest slpc: SUCCESS (14.033s) [326.406039] Starting dynamic subtest: guc [330.319292] Dynamic subtest guc: SUCCESS (3.917s) [330.328394] Starting dynamic subtest: guc_multi_lrc [334.595609] Dynamic subtest guc_multi_lrc: SUCCESS (4.274s) [334.604539] Starting dynamic subtest: guc_hang [339.479075] Dynamic subtest guc_hang: SUCCESS (4.881s) [339.487923] Starting dynamic subtest: late_gt_pm [343.797325] Dynamic subtest late_gt_pm: SUCCESS (4.316s) [343.799703] Subtest live: SUCCESS (228.577s) [343.824733] [FACT i915_selftest (live)] deleted: kernel.kmod_is_loaded.i915: true [343.827815] [034/133] (677s left) kms_addfb_basic (bo-too-small-due-to-tiling) [345.334669] Starting subtest: bo-too-small-due-to-tiling [345.338909] Subtest bo-too-small-due-to-tiling: SKIP (0.000s) [345.401149] [FACT kms_addfb_basic (bo-too-small-due-to-tiling)] new: kernel.kmod_is_loaded.i915: true [345.404653] [035/133] (675s left) gem_exec_store (cachelines) [345.465958] Starting subtest: cachelines [345.468299] Starting dynamic subtest: rcs0 [345.553920] Dynamic subtest rcs0: SUCCESS (0.087s) [345.563778] Starting dynamic subtest: bcs0 [345.614534] Dynamic subtest bcs0: SUCCESS (0.058s) [345.623622] Starting dynamic subtest: vcs0 [345.674698] Dynamic subtest vcs0: SUCCESS (0.058s) [345.683529] Starting dynamic subtest: vcs1 [345.722379] Dynamic subtest vcs1: SUCCESS (0.046s) [345.730909] Starting dynamic subtest: vecs0 [345.792504] Dynamic subtest vecs0: SUCCESS (0.068s) [345.801616] Starting dynamic subtest: ccs0 [345.850360] Dynamic subtest ccs0: SUCCESS (0.056s) [345.852797] Subtest cachelines: SUCCESS (0.386s) [346.044508] [036/133] (674s left) kms_frontbuffer_tracking (fbc-1p-primscrn-indfb-pgflip-blt) [346.139057] Starting subtest: fbc-1p-primscrn-indfb-pgflip-blt [350.618984] Subtest fbc-1p-primscrn-indfb-pgflip-blt: SUCCESS (4.484s) [351.779081] [037/133] (669s left) gem_wait (await) [351.850358] Starting subtest: await [351.852780] Starting dynamic subtest: all-engines [352.980770] Dynamic subtest all-engines: SUCCESS (1.130s) [352.997066] Starting dynamic subtest: rcs0 [354.035942] Dynamic subtest rcs0: SUCCESS (1.053s) [354.052041] Starting dynamic subtest: bcs0 [355.092702] Dynamic subtest bcs0: SUCCESS (1.055s) [355.109455] Starting dynamic subtest: vcs0 [356.149238] Dynamic subtest vcs0: SUCCESS (1.055s) [356.163819] Starting dynamic subtest: vcs1 [357.204714] Dynamic subtest vcs1: SUCCESS (1.053s) [357.219061] Starting dynamic subtest: vecs0 [358.258638] Dynamic subtest vecs0: SUCCESS (1.052s) [358.272754] Starting dynamic subtest: ccs0 [359.317212] Dynamic subtest ccs0: SUCCESS (1.056s) [359.320024] Subtest await: SUCCESS (7.467s) [359.518959] [FACT gem_wait (await)] new: kernel.kmod_is_loaded.vgem: true [359.524197] [038/133] (661s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-pwrite) [359.625678] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-pwrite [359.630223] Subtest psr-2p-scndscrn-pri-indfb-draw-pwrite: SKIP (0.000s) [359.704849] [039/133] (661s left) syncobj_wait (wait-all-for-submit-complex) [359.759721] Starting subtest: wait-all-for-submit-complex [359.973342] Subtest wait-all-for-submit-complex: SUCCESS (0.213s) [360.047333] [040/133] (661s left) syncobj_timeline (etime-multi-wait-for-submit-available-unsubmitted) [360.101066] Starting subtest: etime-multi-wait-for-submit-available-unsubmitted [360.209161] Subtest etime-multi-wait-for-submit-available-unsubmitted: SUCCESS (0.107s) [360.299905] [041/133] (660s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip) [360.395199] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip [360.399771] Subtest yf-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip: SKIP (0.000s) [360.483583] [042/133] (660s left) kms_big_fb (linear-16bpp-rotate-90) [360.580295] Starting subtest: linear-16bpp-rotate-90 [360.600510] Subtest linear-16bpp-rotate-90: SKIP (0.020s) [360.700105] [043/133] (660s left) gem_exec_reloc (basic-write-read-active) [360.752327] Subtest basic-write-read-active: SKIP (0.000s) [360.827183] [044/133] (660s left) gem_create (create-ext-cpu-access-big) [360.986040] Starting subtest: create-ext-cpu-access-big [360.990905] Subtest create-ext-cpu-access-big: SKIP (0.002s) [361.062529] [045/133] (660s left) gem_mmap_wc (bad-size) [361.133060] Subtest bad-size: SKIP (0.000s) [361.183472] [046/133] (660s left) api_intel_allocator (gem-pool) [361.231293] Starting subtest: gem-pool [361.237319] Subtest gem-pool: SUCCESS (0.009s) [361.330910] [047/133] (660s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-render) [361.427910] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-render [361.432193] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-render: SKIP (0.000s) [361.528163] [048/133] (659s left) syncobj_timeline (etime-multi-wait-all-available-unsubmitted) [361.586902] Starting subtest: etime-multi-wait-all-available-unsubmitted [361.688316] Subtest etime-multi-wait-all-available-unsubmitted: SUCCESS (0.102s) [361.778403] [049/133] (659s left) gem_mmap_offset (clear) [361.834842] Starting subtest: clear [361.837625] Starting dynamic subtest: smem0 [387.299284] Dynamic subtest smem0: SUCCESS (25.459s) [387.301788] Subtest clear: SUCCESS (25.461s) [387.445184] [050/133] (634s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-fullscreen) [387.603899] Starting subtest: fbc-2p-primscrn-spr-indfb-fullscreen [387.608018] Subtest fbc-2p-primscrn-spr-indfb-fullscreen: SKIP (0.000s) [387.711424] [051/133] (633s left) kms_ccs (bad-pixel-format-4-tiled-dg2-rc-ccs) [387.803034] Starting subtest: bad-pixel-format-4-tiled-dg2-rc-ccs [387.805243] Starting dynamic subtest: pipe-A-eDP-1 [387.827811] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [387.836845] Starting dynamic subtest: pipe-B-eDP-1 [387.858238] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [387.866356] Starting dynamic subtest: pipe-C-eDP-1 [387.887994] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [387.895476] Starting dynamic subtest: pipe-D-eDP-1 [387.917363] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [387.921743] Subtest bad-pixel-format-4-tiled-dg2-rc-ccs: SKIP (0.004s) [390.145380] [052/133] (631s left) kms_addfb_basic (no-handle) [390.209245] Starting subtest: no-handle [390.211533] Subtest no-handle: SUCCESS (0.000s) [390.346961] [053/133] (631s left) kms_flip (flip-vs-suspend-interruptible) [390.444250] Starting subtest: flip-vs-suspend-interruptible [390.448992] Starting dynamic subtest: A-eDP1 [439.100794] Dynamic subtest A-eDP1: SUCCESS (4.668s) [439.110395] Starting dynamic subtest: B-eDP1 [488.110349] Dynamic subtest B-eDP1: SUCCESS (4.513s) [488.124821] Starting dynamic subtest: C-eDP1 [537.091605] Dynamic subtest C-eDP1: SUCCESS (4.514s) [537.106749] Starting dynamic subtest: D-eDP1 [586.125592] Dynamic subtest D-eDP1: SUCCESS (4.529s) [586.131081] Subtest flip-vs-suspend-interruptible: SUCCESS (18.236s) [587.308389] [054/133] (434s left) i915_pm_rpm (debugfs-read) [589.347431] Starting subtest: debugfs-read [590.523101] Subtest debugfs-read: SUCCESS (1.167s) [590.902739] [055/133] (430s left) gem_exec_balancer (sliced) [590.975599] Starting subtest: sliced [590.980857] Subtest sliced: SKIP (0.000s) [591.274746] [056/133] (430s left) syncobj_timeline (multi-wait-available-unsubmitted-signaled) [591.340872] Starting subtest: multi-wait-available-unsubmitted-signaled [591.343833] Subtest multi-wait-available-unsubmitted-signaled: SUCCESS (0.000s) [591.421327] [057/133] (430s left) kms_cursor_legacy (2x-nonblocking-modeset-vs-cursor-atomic) [591.565817] Starting subtest: 2x-nonblocking-modeset-vs-cursor-atomic [591.570909] Subtest 2x-nonblocking-modeset-vs-cursor-atomic: SKIP (0.003s) [591.718089] [058/133] (430s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-onoff) [591.822870] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-onoff [598.914779] Subtest fbcpsr-1p-primscrn-spr-indfb-onoff: SUCCESS (7.081s) [599.049234] [059/133] (422s left) kms_cursor_crc (cursor-offscreen-256x256) [599.292357] Starting subtest: cursor-offscreen-256x256 [599.294844] Starting dynamic subtest: pipe-A-eDP-1 [601.234671] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.935s) [601.266030] Starting dynamic subtest: pipe-D-eDP-1 [603.914062] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.652s) [603.916606] Subtest cursor-offscreen-256x256: SUCCESS (4.614s) [604.721983] [060/133] (417s left) syncobj_wait (multi-wait-for-submit-submitted-signaled) [604.784865] Starting subtest: multi-wait-for-submit-submitted-signaled [604.787688] Subtest multi-wait-for-submit-submitted-signaled: SUCCESS (0.000s) [604.888889] [061/133] (417s left) perf (oa-exponents) [605.038634] Starting subtest: oa-exponents [605.040806] Starting dynamic subtest: 0-rcs0 [606.836970] Dynamic subtest 0-rcs0: SUCCESS (1.798s) [606.847647] Starting dynamic subtest: 1-vecs0 [608.668575] Dynamic subtest 1-vecs0: SUCCESS (1.829s) [608.671354] Subtest oa-exponents: SUCCESS (3.629s) [608.720373] [062/133] (413s left) gem_workarounds (reset) [608.795574] Starting subtest: reset [608.980010] Subtest reset: SUCCESS (0.184s) [609.111207] [063/133] (413s left) prime_mmap (test_correct) [609.167687] Starting subtest: test_correct [609.169950] Starting dynamic subtest: test_correct-smem [609.197197] Dynamic subtest test_correct-smem: SUCCESS (0.032s) [609.200068] Subtest test_correct: SUCCESS (0.033s) [609.305888] [064/133] (412s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-180) [609.415904] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-180 [610.550907] Subtest x-tiled-max-hw-stride-32bpp-rotate-180: SUCCESS (1.135s) [610.664860] [065/133] (411s left) kms_vrr (seamless-rr-switch-virtual) [610.754636] Starting subtest: seamless-rr-switch-virtual [610.761312] Subtest seamless-rr-switch-virtual: SKIP (0.000s) [610.838321] [066/133] (411s left) kms_cursor_edge_walk (256x256-right-edge) [610.920666] Starting subtest: 256x256-right-edge [610.922704] Starting dynamic subtest: pipe-A-eDP-1 [614.379065] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.455s) [614.389217] Starting dynamic subtest: pipe-D-eDP-1 [617.521363] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.125s) [617.523676] Subtest 256x256-right-edge: SUCCESS (6.583s) [618.344448] [067/133] (403s left) kms_flip (2x-plain-flip-ts-check) [618.451265] Starting subtest: 2x-plain-flip-ts-check [618.462041] Subtest 2x-plain-flip-ts-check: SKIP (0.010s) [618.545473] [068/133] (403s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-blt) [618.660909] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-blt [618.665971] Subtest fbc-2p-scndscrn-cur-indfb-draw-blt: SKIP (0.000s) [618.749318] [069/133] (403s left) sw_sync (sync_multi_producer_single_consumer) [618.791291] Starting subtest: sync_multi_producer_single_consumer [619.874585] Subtest sync_multi_producer_single_consumer: SUCCESS (1.075s) [619.947054] [070/133] (402s left) kms_plane_scaling (planes-scaler-unity-scaling) [620.052951] Starting subtest: planes-scaler-unity-scaling [620.055793] Starting dynamic subtest: pipe-A [620.114185] Dynamic subtest pipe-A: SUCCESS (0.063s) [620.124550] Starting dynamic subtest: pipe-B [621.279427] Dynamic subtest pipe-B: SUCCESS (1.154s) [621.289908] Starting dynamic subtest: pipe-C [622.405686] Dynamic subtest pipe-C: SUCCESS (1.118s) [622.421044] Starting dynamic subtest: pipe-D [623.531841] Dynamic subtest pipe-D: SUCCESS (1.118s) [623.534742] Subtest planes-scaler-unity-scaling: SUCCESS (3.459s) [624.701818] [071/133] (397s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-mmap-cpu) [624.799814] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-mmap-cpu [629.447453] Subtest fbc-1p-primscrn-spr-indfb-draw-mmap-cpu: SUCCESS (4.635s) [630.665845] [072/133] (391s left) kms_psr (psr2-cursor-mmap-cpu) [630.757793] Starting subtest: psr2-cursor-mmap-cpu [630.760769] Starting dynamic subtest: eDP-1 [632.441940] Dynamic subtest eDP-1: SUCCESS (1.680s) [632.444946] Subtest psr2-cursor-mmap-cpu: SUCCESS (1.681s) [633.336876] [073/133] (389s left) kms_psr (psr-sprite-plane-move) [633.440829] Starting subtest: psr-sprite-plane-move [633.443734] Starting dynamic subtest: eDP-1 [635.278393] Dynamic subtest eDP-1: SUCCESS (1.835s) [635.281084] Subtest psr-sprite-plane-move: SUCCESS (1.836s) [636.096677] [074/133] (386s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-mmap-wc) [636.210522] Starting subtest: psr-1p-primscrn-cur-indfb-draw-mmap-wc [642.736303] Subtest psr-1p-primscrn-cur-indfb-draw-mmap-wc: SUCCESS (6.522s) [642.849840] [075/133] (379s left) kms_cursor_crc (cursor-random-64x21) [643.052093] Starting subtest: cursor-random-64x21 [643.100478] Subtest cursor-random-64x21: SKIP (0.039s) [643.333262] [076/133] (379s left) perf (disabled-read-error) [643.430960] Starting subtest: disabled-read-error [643.445817] Subtest disabled-read-error: SUCCESS (0.014s) [643.493153] [077/133] (379s left) gem_wait (invalid-flags) [643.553765] Starting subtest: invalid-flags [643.556605] Subtest invalid-flags: SUCCESS (0.000s) [643.792769] [078/133] (378s left) gem_spin_batch (spin-all-new) [643.861068] Starting subtest: spin-all-new [643.882419] Subtest spin-all-new: SUCCESS (0.020s) [645.214547] [079/133] (377s left) kms_async_flips (invalid-async-flip-atomic) [645.306870] Starting subtest: invalid-async-flip-atomic [645.679837] Starting dynamic subtest: pipe-A-eDP-1 [646.540877] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.862s) [646.899277] Starting dynamic subtest: pipe-B-eDP-1 [647.677512] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.786s) [648.033423] Starting dynamic subtest: pipe-C-eDP-1 [648.816598] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.791s) [649.189920] Starting dynamic subtest: pipe-D-eDP-1 [650.032768] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.853s) [650.035459] Subtest invalid-async-flip-atomic: SUCCESS (4.723s) [651.186947] [080/133] (371s left) prime_mmap_kms (buffer-sharing) [651.286269] Starting subtest: buffer-sharing [651.750849] Subtest buffer-sharing: SUCCESS (0.464s) [652.625454] [081/133] (370s left) kms_plane (pixel-format-4-tiled-dg2-rc-ccs-modifier-source-clamping) [652.727234] Starting subtest: pixel-format-4-tiled-dg2-rc-ccs-modifier-source-clamping [652.732229] Subtest pixel-format-4-tiled-dg2-rc-ccs-modifier-source-clamping: SKIP (0.000s) [652.799214] [082/133] (370s left) syncobj_timeline (invalid-query-illegal-handle) [652.843843] Starting subtest: invalid-query-illegal-handle [652.845922] Subtest invalid-query-illegal-handle: SUCCESS (0.000s) [652.939955] [083/133] (369s left) kms_hdr (bpc-switch) [653.027696] Starting subtest: bpc-switch [654.110456] Starting dynamic subtest: pipe-A-eDP-1 [657.617986] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.510s) [657.620814] Subtest bpc-switch: SUCCESS (4.594s) [657.726603] [084/133] (365s left) gem_exec_fence (invalid-timeline-fence-array) [658.278023] Starting subtest: invalid-timeline-fence-array [658.285048] Subtest invalid-timeline-fence-array: SUCCESS (0.006s) [659.207768] [085/133] (363s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-render) [659.313100] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-render [659.318050] Subtest fbc-2p-primscrn-pri-shrfb-draw-render: SKIP (0.000s) [659.402876] [086/133] (363s left) kms_prop_blob (blob-prop-core) [659.465894] Starting subtest: blob-prop-core [659.468447] Subtest blob-prop-core: SUCCESS (0.000s) [659.581839] [087/133] (363s left) fbdev (unaligned-write) [659.631272] Starting subtest: unaligned-write [659.732272] Subtest unaligned-write: SUCCESS (0.101s) [659.796208] [088/133] (363s left) kms_frontbuffer_tracking (psr-2p-primscrn-shrfb-plflip-blt) [659.899785] Starting subtest: psr-2p-primscrn-shrfb-plflip-blt [659.905077] Subtest psr-2p-primscrn-shrfb-plflip-blt: SKIP (0.000s) [660.001304] [089/133] (363s left) kms_ccs (crc-sprite-planes-basic-y-tiled-gen12-mc-ccs) [660.090402] Starting subtest: crc-sprite-planes-basic-y-tiled-gen12-mc-ccs [660.093038] Starting dynamic subtest: pipe-A-eDP-1 [660.161500] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s) [660.175679] Starting dynamic subtest: pipe-B-eDP-1 [660.242950] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s) [660.253057] Starting dynamic subtest: pipe-C-eDP-1 [660.319983] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s) [660.329847] Starting dynamic subtest: pipe-D-eDP-1 [660.395830] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s) [660.400871] Subtest crc-sprite-planes-basic-y-tiled-gen12-mc-ccs: SKIP (0.009s) [662.252542] [090/133] (360s left) kms_plane (pixel-format-4-tiled-dg2-rc-ccs-cc-modifier) [662.352108] Starting subtest: pixel-format-4-tiled-dg2-rc-ccs-cc-modifier [662.357100] Subtest pixel-format-4-tiled-dg2-rc-ccs-cc-modifier: SKIP (0.000s) [662.425819] [091/133] (360s left) kms_psr2_sf (pr-primary-plane-update-sf-dmg-area-big-fb) [662.522902] Starting subtest: pr-primary-plane-update-sf-dmg-area-big-fb [662.528666] Subtest pr-primary-plane-update-sf-dmg-area-big-fb: SKIP (0.000s) [662.588704] [092/133] (360s left) kms_pm_dc (dc5-retention-flops) [663.680075] Starting subtest: dc5-retention-flops [663.685093] Subtest dc5-retention-flops: SKIP (0.000s) [663.751598] [093/133] (359s left) kms_color (ctm-blue-to-red) [663.844862] Starting subtest: ctm-blue-to-red [663.847086] Starting dynamic subtest: pipe-A-eDP-1 [664.556465] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.711s) [664.567732] Starting dynamic subtest: pipe-B-eDP-1 [665.946839] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.389s) [665.956726] Starting dynamic subtest: pipe-C-eDP-1 [667.323401] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.378s) [667.335046] Starting dynamic subtest: pipe-D-eDP-1 [668.625215] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.301s) [668.627932] Subtest ctm-blue-to-red: SUCCESS (4.782s) [669.467929] [094/133] (353s left) kms_chamelium_hpd (dp-hpd-fast) [669.875548] Subtest dp-hpd-fast: SKIP (0.000s) [670.680334] [095/133] (352s left) perf_pmu (busy-start) [670.722189] Starting subtest: busy-start [670.725473] Starting dynamic subtest: rcs0 [673.273732] Dynamic subtest rcs0: SUCCESS (2.551s) [673.287057] Starting dynamic subtest: bcs0 [675.846220] Dynamic subtest bcs0: SUCCESS (2.548s) [675.859298] Starting dynamic subtest: vcs0 [679.160854] Dynamic subtest vcs0: SUCCESS (3.331s) [679.174901] Starting dynamic subtest: vcs1 [683.192542] Dynamic subtest vcs1: SUCCESS (4.028s) [683.205072] Starting dynamic subtest: vecs0 [687.160783] Dynamic subtest vecs0: SUCCESS (3.964s) [687.174377] Starting dynamic subtest: ccs0 [689.734037] Dynamic subtest ccs0: SUCCESS (2.548s) [689.736813] Subtest busy-start: SUCCESS (18.985s) [689.820031] [096/133] (333s left) kms_pm_rpm (system-suspend-idle) [691.347464] Starting subtest: system-suspend-idle [711.608257] Subtest system-suspend-idle: SUCCESS (4.564s) [711.977849] [097/133] (311s left) kms_psr2_sf (psr2-primary-plane-update-sf-dmg-area) [712.076732] Starting subtest: psr2-primary-plane-update-sf-dmg-area [712.079383] Starting dynamic subtest: pipe-A-eDP-1 [717.944695] Dynamic subtest pipe-A-eDP-1: SUCCESS (5.879s) [717.954995] Starting dynamic subtest: pipe-B-eDP-1 [724.603301] Dynamic subtest pipe-B-eDP-1: SUCCESS (6.660s) [724.606152] Subtest psr2-primary-plane-update-sf-dmg-area: SUCCESS (12.541s) [725.482281] [098/133] (298s left) kms_setmode (basic) [725.543815] Starting subtest: basic [725.880519] Starting dynamic subtest: pipe-A-eDP-1 [728.003463] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.119s) [728.355962] Starting dynamic subtest: pipe-B-eDP-1 [730.436303] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.085s) [730.758353] Subtest basic: SUCCESS (5.216s) [731.585011] [099/133] (292s left) kms_psr (fbc-pr-sprite-blt) [731.687450] Starting subtest: fbc-pr-sprite-blt [731.693019] Subtest fbc-pr-sprite-blt: SKIP (0.000s) [731.779953] [100/133] (291s left) kms_flip (flip-vs-panning) [731.865653] Starting subtest: flip-vs-panning [731.868358] Starting dynamic subtest: A-eDP1 [740.621204] Dynamic subtest A-eDP1: SUCCESS (8.755s) [740.635147] Starting dynamic subtest: B-eDP1 [749.340158] Dynamic subtest B-eDP1: SUCCESS (8.713s) [749.351393] Starting dynamic subtest: C-eDP1 [758.059780] Dynamic subtest C-eDP1: SUCCESS (8.717s) [758.071777] Starting dynamic subtest: D-eDP1 [766.791665] Dynamic subtest D-eDP1: SUCCESS (8.728s) [766.796816] Subtest flip-vs-panning: SUCCESS (34.925s) [767.953305] [101/133] (255s left) kms_vblank (ts-continuation-modeset) [768.043403] Starting subtest: ts-continuation-modeset [768.046166] Starting dynamic subtest: pipe-A-eDP-1 [769.518204] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.474s) [769.533558] Starting dynamic subtest: pipe-D-eDP-1 [771.674322] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.155s) [771.677065] Subtest ts-continuation-modeset: SUCCESS (3.633s) [772.475749] [102/133] (251s left) kms_pipe_b_c_ivb (from-pipe-c-to-b-with-3-lanes) [772.536405] Subtest from-pipe-C-to-B-with-3-lanes: SKIP (0.000s) [772.597090] [103/133] (251s left) kms_async_flips (async-flip-hang) [772.690182] Starting subtest: async-flip-hang [773.062927] Starting dynamic subtest: pipe-A-eDP-1 [788.344513] Dynamic subtest pipe-A-eDP-1: SUCCESS (15.268s) [788.705556] Starting dynamic subtest: pipe-B-eDP-1 [804.327323] Dynamic subtest pipe-B-eDP-1: SUCCESS (15.626s) [804.717340] Starting dynamic subtest: pipe-C-eDP-1 [820.338522] Dynamic subtest pipe-C-eDP-1: SUCCESS (15.615s) [820.705916] Starting dynamic subtest: pipe-D-eDP-1 [836.394040] Dynamic subtest pipe-D-eDP-1: SUCCESS (15.694s) [836.396794] Subtest async-flip-hang: SUCCESS (63.700s) [837.629767] [104/133] (186s left) gem_exec_balancer (bonded-semaphore) [837.692400] Starting subtest: bonded-semaphore [837.698570] Subtest bonded-semaphore: SKIP (0.000s) [838.005711] [105/133] (185s left) gem_userptr_blits (sync-overlap) [838.080172] Starting subtest: sync-overlap [838.082413] Subtest sync-overlap: SUCCESS (0.000s) [838.209873] [106/133] (185s left) kms_flip (2x-flip-vs-modeset) [838.306539] Starting subtest: 2x-flip-vs-modeset [838.314425] Subtest 2x-flip-vs-modeset: SKIP (0.010s) [838.407983] [107/133] (185s left) kms_busy (extended-pageflip-modeset-hang-oldfb) [838.498042] Starting subtest: extended-pageflip-modeset-hang-oldfb [838.500064] Starting dynamic subtest: pipe-A [847.184823] Dynamic subtest pipe-A: SUCCESS (8.683s) [847.196922] Starting dynamic subtest: pipe-D [855.323988] Dynamic subtest pipe-D: SUCCESS (8.138s) [855.326342] Subtest extended-pageflip-modeset-hang-oldfb: SUCCESS (16.828s) [856.177197] [108/133] (167s left) kms_ccs (crc-primary-rotation-180-y-tiled-gen12-rc-ccs) [856.277175] Starting subtest: crc-primary-rotation-180-y-tiled-gen12-rc-ccs [856.279665] Starting dynamic subtest: pipe-A-eDP-1 [856.302797] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [856.317210] Starting dynamic subtest: pipe-B-eDP-1 [856.342065] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [856.351818] Starting dynamic subtest: pipe-C-eDP-1 [856.377707] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [856.386938] Starting dynamic subtest: pipe-D-eDP-1 [856.413266] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [856.418304] Subtest crc-primary-rotation-180-y-tiled-gen12-rc-ccs: SKIP (0.006s) [858.540057] [109/133] (165s left) kms_vblank (query-busy) [858.635348] Starting subtest: query-busy [858.637819] Starting dynamic subtest: pipe-A-eDP-1 [860.510237] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.876s) [860.525365] Starting dynamic subtest: pipe-D-eDP-1 [863.110308] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.596s) [863.112796] Subtest query-busy: SUCCESS (4.475s) [863.915249] [110/133] (160s left) syncobj_timeline (wait-all-snapshot) [863.968567] Starting subtest: wait-all-snapshot [864.049923] Subtest wait-all-snapshot: SUCCESS (0.083s) [864.128904] [111/133] (159s left) kms_cursor_legacy (cursora-vs-flipb-atomic) [864.245703] Starting subtest: cursorA-vs-flipB-atomic [864.251031] Subtest cursorA-vs-flipB-atomic: SKIP (0.001s) [864.391379] [112/133] (159s left) gem_ctx_persistence (legacy-engines-queued) [864.451801] Starting subtest: legacy-engines-queued [864.454537] Starting dynamic subtest: render [864.519338] Dynamic subtest render: SUCCESS (0.067s) [864.531570] Starting dynamic subtest: bsd1 [865.837878] Dynamic subtest bsd1: SUCCESS (1.315s) [865.851235] Starting dynamic subtest: bsd2 [867.818392] Dynamic subtest bsd2: SUCCESS (1.977s) [867.831328] Starting dynamic subtest: blt [867.876771] Dynamic subtest blt: SUCCESS (0.056s) [867.889448] Starting dynamic subtest: vebox [869.805159] Dynamic subtest vebox: SUCCESS (1.925s) [869.808312] Subtest legacy-engines-queued: SUCCESS (5.354s) [869.902605] [113/133] (154s left) gem_ctx_bad_destroy (double-destroy) [869.972290] Starting subtest: double-destroy [869.975345] Subtest double-destroy: SUCCESS (0.000s) [870.050897] [114/133] (154s left) gem_mmap_wc (read-write-distinct) [870.124530] Subtest read-write-distinct: SKIP (0.000s) [870.188530] [115/133] (154s left) kms_draw_crc (draw-method-pwrite) [870.293321] Starting subtest: draw-method-pwrite [870.295435] Starting dynamic subtest: xrgb8888-untiled [870.839655] Dynamic subtest xrgb8888-untiled: SUCCESS (0.545s) [870.849513] Starting dynamic subtest: rgb565-untiled [871.303893] Dynamic subtest rgb565-untiled: SUCCESS (0.465s) [871.316154] Starting dynamic subtest: xrgb2101010-untiled [871.871024] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.566s) [871.883030] Starting dynamic subtest: xbgr16161616f-untiled [872.627383] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.753s) [872.641822] Starting dynamic subtest: xrgb8888-xtiled [874.371157] Dynamic subtest xrgb8888-xtiled: SUCCESS (1.744s) [874.382047] Starting dynamic subtest: rgb565-xtiled [875.437652] Dynamic subtest rgb565-xtiled: SUCCESS (1.066s) [875.448296] Starting dynamic subtest: xrgb2101010-xtiled [877.192994] Dynamic subtest xrgb2101010-xtiled: SUCCESS (1.755s) [877.204041] Starting dynamic subtest: xbgr16161616f-xtiled [880.438327] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (3.244s) [880.448506] Starting dynamic subtest: xrgb8888-4tiled [881.516018] Dynamic subtest xrgb8888-4tiled: SUCCESS (1.077s) [881.525750] Starting dynamic subtest: rgb565-4tiled [882.071465] Dynamic subtest rgb565-4tiled: SUCCESS (0.555s) [882.082539] Starting dynamic subtest: xrgb2101010-4tiled [883.150275] Dynamic subtest xrgb2101010-4tiled: SUCCESS (1.077s) [883.161508] Starting dynamic subtest: xbgr16161616f-4tiled [886.116162] Dynamic subtest xbgr16161616f-4tiled: SUCCESS (2.964s) [886.118808] Subtest draw-method-pwrite: SUCCESS (15.824s) [886.231438] [116/133] (138s left) kms_frontbuffer_tracking (fbc-indfb-scaledprimary) [886.325147] Starting subtest: fbc-indfb-scaledprimary [889.281992] Subtest fbc-indfb-scaledprimary: SUCCESS (2.959s) [890.417587] [117/133] (133s left) gem_exec_schedule (u-submit-early-slice) [890.494265] Starting subtest: u-submit-early-slice [890.497110] Starting dynamic subtest: rcs0 [890.526717] Dynamic subtest rcs0: SUCCESS (0.044s) [890.538534] Starting dynamic subtest: bcs0 [890.562750] Dynamic subtest bcs0: SUCCESS (0.035s) [890.573384] Starting dynamic subtest: vcs0 [890.600614] Dynamic subtest vcs0: SUCCESS (0.038s) [890.613359] Starting dynamic subtest: vcs1 [890.636418] Dynamic subtest vcs1: SUCCESS (0.035s) [890.646726] Starting dynamic subtest: vecs0 [890.680115] Dynamic subtest vecs0: SUCCESS (0.044s) [890.690266] Starting dynamic subtest: ccs0 [890.722259] Dynamic subtest ccs0: SUCCESS (0.041s) [890.725162] Subtest u-submit-early-slice: SUCCESS (0.240s) [891.937520] [118/133] (132s left) gem_mmap_gtt (cpuset-basic-small-copy-odd) [892.003494] Subtest cpuset-basic-small-copy-odd: SKIP (0.000s) [892.073726] [119/133] (132s left) gem_exec_whisper (basic-queues-priority-all) [892.138224] Starting subtest: basic-queues-priority-all [914.282498] Subtest basic-queues-priority-all: SUCCESS (22.140s) [914.468351] [120/133] (110s left) kms_frontbuffer_tracking (psr-indfb-scaledprimary) [914.581961] Starting subtest: psr-indfb-scaledprimary [920.366536] Subtest psr-indfb-scaledprimary: SUCCESS (5.787s) [920.491023] [121/133] (104s left) gem_exec_reloc (basic-active) [920.553512] Subtest basic-active: SKIP (0.000s) [920.631916] [122/133] (103s left) kms_rotation_crc (primary-rotation-90) [920.723330] Starting subtest: primary-rotation-90 [920.728340] Subtest primary-rotation-90: SKIP (0.001s) [920.796668] [123/133] (103s left) kms_cursor_legacy (short-flip-before-cursor-atomic-transitions) [920.912177] Starting subtest: short-flip-before-cursor-atomic-transitions [921.862701] Subtest short-flip-before-cursor-atomic-transitions: SUCCESS (0.949s) [922.679900] [124/133] (102s left) sysfs_preempt_timeout (invalid) [922.749241] Starting subtest: invalid [922.752187] Starting dynamic subtest: vecs0 [922.755028] Dynamic subtest vecs0: SUCCESS (0.000s) [922.766410] Starting dynamic subtest: ccs0 [922.769248] Dynamic subtest ccs0: SUCCESS (0.000s) [922.779542] Starting dynamic subtest: vcs0 [922.782300] Dynamic subtest vcs0: SUCCESS (0.000s) [922.792459] Starting dynamic subtest: bcs0 [922.795312] Dynamic subtest bcs0: SUCCESS (0.000s) [922.809269] Starting dynamic subtest: rcs0 [922.812090] Dynamic subtest rcs0: SUCCESS (0.000s) [922.822075] Starting dynamic subtest: vcs1 [922.824551] Dynamic subtest vcs1: SUCCESS (0.000s) [922.827412] Subtest invalid: SUCCESS (0.005s) [922.868799] [125/133] (101s left) kms_big_fb (4-tiled-16bpp-rotate-270) [922.971682] Starting subtest: 4-tiled-16bpp-rotate-270 [922.992467] Subtest 4-tiled-16bpp-rotate-270: SKIP (0.019s) [923.109748] [126/133] (101s left) kms_dp_aux_dev [923.456463] [127/133] (101s left) kms_frontbuffer_tracking (fbc-1p-shrfb-fliptrack-mmap-gtt) [923.547571] Starting subtest: fbc-1p-shrfb-fliptrack-mmap-gtt [923.552761] Subtest fbc-1p-shrfb-fliptrack-mmap-gtt: SKIP (0.000s) [923.652177] [128/133] (101s left) kms_chamelium_audio (dp-audio) [924.043651] Subtest dp-audio: SKIP (0.000s) [924.867449] [129/133] (100s left) dmabuf_sync_file (export-basic) [924.914440] Starting subtest: export-basic [924.917616] Subtest export-basic: SUCCESS (0.002s) [924.972878] [130/133] ( 99s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-indfb-plflip-blt) [925.068180] Starting subtest: fbcpsr-2p-scndscrn-indfb-plflip-blt [925.073187] Subtest fbcpsr-2p-scndscrn-indfb-plflip-blt: SKIP (0.000s) [925.167554] [131/133] ( 99s left) gem_sync (basic-store-each) [925.246302] Starting subtest: basic-store-each [927.732506] Subtest basic-store-each: SUCCESS (2.499s) [927.915045] [132/133] ( 97s left) i915_drm_fdinfo (virtual-busy-hang-all) [927.961172] Starting subtest: virtual-busy-hang-all [927.966542] Subtest virtual-busy-hang-all: SKIP (0.000s) [928.027804] [133/133] ( 97s left) gem_ctx_param (invalid-set-ringsize) [928.088435] Starting subtest: invalid-set-ringsize [928.092179] Subtest invalid-set-ringsize: SUCCESS (0.000s) [928.161138] Closing watchdogs results: parsing output: 0/ for test: kms_flip_scaled_crc results: parsing output: 1/ for test: kms_ccs results: parsing output: 2/ for test: kms_content_protection results: parsing output: 3/ for test: kms_psr results: parsing output: 4/ for test: kms_getfb results: parsing output: 5/ for test: sriov_basic results: parsing output: 6/ for test: gem_render_copy results: parsing output: 7/ for test: gem_exec_schedule results: parsing output: 8/ for test: gem_exec_params results: parsing output: 9/ for test: kms_frontbuffer_tracking results: parsing output: 10/ for test: gem_reg_read results: parsing output: 11/ for test: kms_big_fb results: parsing output: 12/ for test: kms_lease results: parsing output: 13/ for test: gem_render_copy results: parsing output: 14/ for test: kms_frontbuffer_tracking results: parsing output: 15/ for test: gem_eio results: parsing output: 16/ for test: core_getstats results: parsing output: 17/ for test: kms_big_fb results: parsing output: 18/ for test: syncobj_wait results: parsing output: 19/ for test: kms_frontbuffer_tracking results: parsing output: 20/ for test: kms_invalid_mode results: parsing output: 21/ for test: kms_flip results: parsing output: 22/ for test: kms_pipe_crc_basic results: parsing output: 23/ for test: i915_drm_fdinfo results: parsing output: 24/ for test: kms_chamelium_edid results: parsing output: 25/ for test: gem_pxp results: parsing output: 26/ for test: kms_frontbuffer_tracking results: parsing output: 27/ for test: gem_fence_thrash results: parsing output: 28/ for test: kms_plane results: parsing output: 29/ for test: gen9_exec_parse results: parsing output: 30/ for test: kms_frontbuffer_tracking results: parsing output: 31/ for test: kms_psr results: parsing output: 32/ for test: i915_selftest results: parsing output: 33/ for test: kms_addfb_basic results: parsing output: 34/ for test: gem_exec_store results: parsing output: 35/ for test: kms_frontbuffer_tracking results: parsing output: 36/ for test: gem_wait results: parsing output: 37/ for test: kms_frontbuffer_tracking results: parsing output: 38/ for test: syncobj_wait results: parsing output: 39/ for test: syncobj_timeline results: parsing output: 40/ for test: kms_big_fb results: parsing output: 41/ for test: kms_big_fb results: parsing output: 42/ for test: gem_exec_reloc results: parsing output: 43/ for test: gem_create results: parsing output: 44/ for test: gem_mmap_wc results: parsing output: 45/ for test: api_intel_allocator results: parsing output: 46/ for test: kms_frontbuffer_tracking results: parsing output: 47/ for test: syncobj_timeline results: parsing output: 48/ for test: gem_mmap_offset results: parsing output: 49/ for test: kms_frontbuffer_tracking results: parsing output: 50/ for test: kms_ccs results: parsing output: 51/ for test: kms_addfb_basic results: parsing output: 52/ for test: kms_flip results: parsing output: 53/ for test: i915_pm_rpm results: parsing output: 54/ for test: gem_exec_balancer results: parsing output: 55/ for test: syncobj_timeline results: parsing output: 56/ for test: kms_cursor_legacy results: parsing output: 57/ for test: kms_frontbuffer_tracking results: parsing output: 58/ for test: kms_cursor_crc results: parsing output: 59/ for test: syncobj_wait results: parsing output: 60/ for test: perf results: parsing output: 61/ for test: gem_workarounds results: parsing output: 62/ for test: prime_mmap results: parsing output: 63/ for test: kms_big_fb results: parsing output: 64/ for test: kms_vrr results: parsing output: 65/ for test: kms_cursor_edge_walk results: parsing output: 66/ for test: kms_flip results: parsing output: 67/ for test: kms_frontbuffer_tracking results: parsing output: 68/ for test: sw_sync results: parsing output: 69/ for test: kms_plane_scaling results: parsing output: 70/ for test: kms_frontbuffer_tracking results: parsing output: 71/ for test: kms_psr results: parsing output: 72/ for test: kms_psr results: parsing output: 73/ for test: kms_frontbuffer_tracking results: parsing output: 74/ for test: kms_cursor_crc results: parsing output: 75/ for test: perf results: parsing output: 76/ for test: gem_wait results: parsing output: 77/ for test: gem_spin_batch results: parsing output: 78/ for test: kms_async_flips results: parsing output: 79/ for test: prime_mmap_kms results: parsing output: 80/ for test: kms_plane results: parsing output: 81/ for test: syncobj_timeline results: parsing output: 82/ for test: kms_hdr results: parsing output: 83/ for test: gem_exec_fence results: parsing output: 84/ for test: kms_frontbuffer_tracking results: parsing output: 85/ for test: kms_prop_blob results: parsing output: 86/ for test: fbdev results: parsing output: 87/ for test: kms_frontbuffer_tracking results: parsing output: 88/ for test: kms_ccs results: parsing output: 89/ for test: kms_plane results: parsing output: 90/ for test: kms_psr2_sf results: parsing output: 91/ for test: kms_pm_dc results: parsing output: 92/ for test: kms_color results: parsing output: 93/ for test: kms_chamelium_hpd results: parsing output: 94/ for test: perf_pmu results: parsing output: 95/ for test: kms_pm_rpm results: parsing output: 96/ for test: kms_psr2_sf results: parsing output: 97/ for test: kms_setmode results: parsing output: 98/ for test: kms_psr results: parsing output: 99/ for test: kms_flip results: parsing output: 100/ for test: kms_vblank results: parsing output: 101/ for test: kms_pipe_b_c_ivb results: parsing output: 102/ for test: kms_async_flips results: parsing output: 103/ for test: gem_exec_balancer results: parsing output: 104/ for test: gem_userptr_blits results: parsing output: 105/ for test: kms_flip results: parsing output: 106/ for test: kms_busy results: parsing output: 107/ for test: kms_ccs results: parsing output: 108/ for test: kms_vblank results: parsing output: 109/ for test: syncobj_timeline results: parsing output: 110/ for test: kms_cursor_legacy results: parsing output: 111/ for test: gem_ctx_persistence results: parsing output: 112/ for test: gem_ctx_bad_destroy results: parsing output: 113/ for test: gem_mmap_wc results: parsing output: 114/ for test: kms_draw_crc results: parsing output: 115/ for test: kms_frontbuffer_tracking results: parsing output: 116/ for test: gem_exec_schedule results: parsing output: 117/ for test: gem_mmap_gtt results: parsing output: 118/ for test: gem_exec_whisper results: parsing output: 119/ for test: kms_frontbuffer_tracking results: parsing output: 120/ for test: gem_exec_reloc results: parsing output: 121/ for test: kms_rotation_crc results: parsing output: 122/ for test: kms_cursor_legacy results: parsing output: 123/ for test: sysfs_preempt_timeout results: parsing output: 124/ for test: kms_big_fb results: parsing output: 125/ for test: kms_dp_aux_dev results: parsing output: 126/ for test: kms_frontbuffer_tracking results: parsing output: 127/ for test: kms_chamelium_audio results: parsing output: 128/ for test: dmabuf_sync_file results: parsing output: 129/ for test: kms_frontbuffer_tracking results: parsing output: 130/ for test: gem_sync results: parsing output: 131/ for test: i915_drm_fdinfo results: parsing output: 132/ for test: gem_ctx_param Done.