[60.810627] Initializing watchdogs [60.810677] /dev/watchdog0 [60.825392] [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] [60.830182] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [60.832503] [FACT before any test] new: kernel.kmod_is_loaded.i915: true [60.835880] [001/132] (960s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-onoff) [60.969283] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-onoff [60.973488] Subtest fbcpsr-2p-scndscrn-cur-indfb-onoff: SKIP (0.000s) [61.046995] [002/132] (960s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-indfb-draw-pwrite) [61.150283] Starting subtest: psr-1p-offscreen-pri-indfb-draw-pwrite [68.270096] Subtest psr-1p-offscreen-pri-indfb-draw-pwrite: SUCCESS (7.164s) [68.391659] [003/132] (953s left) kms_atomic_transition (plane-use-after-nonblocking-unbind) [68.488644] Starting subtest: plane-use-after-nonblocking-unbind [68.490888] Starting dynamic subtest: pipe-A-eDP-1 [68.548741] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.062s) [68.842161] Starting dynamic subtest: pipe-B-eDP-1 [69.680730] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.849s) [69.964791] Subtest plane-use-after-nonblocking-unbind: SUCCESS (1.480s) [70.836689] [004/132] (950s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-mmap-gtt) [70.935464] Starting subtest: psr-2p-primscrn-cur-indfb-draw-mmap-gtt [70.939795] Subtest psr-2p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s) [71.044656] [005/132] (950s left) gem_exec_balancer (fairslice) [71.133009] Starting subtest: fairslice [74.161102] Subtest fairslice: SUCCESS (3.033s) [74.472937] [006/132] (947s left) kms_flip_scaled_crc (flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling) [74.573829] Starting subtest: flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling [74.578057] Subtest flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling: SKIP (0.000s) [74.643214] [007/132] (946s left) gem_exec_params (rsvd2-dirt) [74.707661] Starting subtest: rsvd2-dirt [74.711970] Subtest rsvd2-dirt: SKIP (0.000s) [74.802863] [008/132] (946s left) gem_exec_reloc (basic-write-cpu) [74.860621] Subtest basic-write-cpu: SKIP (0.000s) [74.925882] [009/132] (946s left) kms_cursor_edge_walk (256x256-right-edge) [75.013029] Starting subtest: 256x256-right-edge [75.015435] Starting dynamic subtest: pipe-A-eDP-1 [78.482349] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.474s) [78.491958] Starting dynamic subtest: pipe-D-eDP-1 [81.606756] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.126s) [81.609194] Subtest 256x256-right-edge: SUCCESS (6.602s) [82.403083] [010/132] (939s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-onoff) [82.509589] Starting subtest: psr-2p-scndscrn-spr-indfb-onoff [82.513908] Subtest psr-2p-scndscrn-spr-indfb-onoff: SKIP (0.000s) [82.615093] [011/132] (939s left) kms_frontbuffer_tracking (psr-1p-primscrn-indfb-msflip-blt) [82.717594] Starting subtest: psr-1p-primscrn-indfb-msflip-blt [90.051042] Subtest psr-1p-primscrn-indfb-msflip-blt: SUCCESS (7.337s) [90.162522] [012/132] (931s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-mmap-wc) [90.266448] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-mmap-wc [90.270461] Subtest fbc-2p-primscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s) [90.379302] [013/132] (931s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-0) [90.485531] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-0 [91.585578] Subtest 4-tiled-max-hw-stride-64bpp-rotate-0: SUCCESS (1.101s) [91.704777] [014/132] (930s left) kms_ccs (crc-primary-rotation-180-4-tiled-dg2-rc-ccs) [91.798064] Starting subtest: crc-primary-rotation-180-4-tiled-dg2-rc-ccs [91.799972] Starting dynamic subtest: pipe-A-eDP-1 [91.819929] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [91.829460] Starting dynamic subtest: pipe-B-eDP-1 [91.846726] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [91.853963] Starting dynamic subtest: pipe-C-eDP-1 [91.871243] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [91.878466] Starting dynamic subtest: pipe-D-eDP-1 [91.897994] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [91.901948] Subtest crc-primary-rotation-180-4-tiled-dg2-rc-ccs: SKIP (0.005s) [94.084111] [015/132] (927s left) kms_joiner (basic-force-big-joiner) [94.194052] Starting subtest: basic-force-big-joiner [94.198279] Subtest basic-force-big-joiner: SKIP (0.000s) [94.259612] [016/132] (927s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-mmap-wc) [94.359595] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-mmap-wc [94.364293] Subtest psr-2p-primscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s) [94.450220] [017/132] (927s left) kms_flip (plain-flip-ts-check-interruptible) [94.542659] Starting subtest: plain-flip-ts-check-interruptible [94.544905] Starting dynamic subtest: A-eDP1 [103.406377] Dynamic subtest A-eDP1: SUCCESS (8.830s) [103.416941] Starting dynamic subtest: B-eDP1 [112.246150] Dynamic subtest B-eDP1: SUCCESS (8.836s) [112.256503] Starting dynamic subtest: C-eDP1 [121.074309] Dynamic subtest C-eDP1: SUCCESS (8.815s) [121.083858] Starting dynamic subtest: D-eDP1 [129.905058] Dynamic subtest D-eDP1: SUCCESS (8.828s) [129.907157] Subtest plain-flip-ts-check-interruptible: SUCCESS (35.320s) [131.048216] [018/132] (890s left) gem_exec_reloc (basic-write-gtt-noreloc) [131.133603] Subtest basic-write-gtt-noreloc: SKIP (0.000s) [131.206764] [019/132] (890s left) kms_plane_scaling (planes-downscale-factor-0-75-upscale-factor-0-25) [131.307843] Starting subtest: planes-downscale-factor-0-75-upscale-factor-0-25 [131.310125] Starting dynamic subtest: pipe-A [131.371297] Dynamic subtest pipe-A: SUCCESS (0.065s) [131.379937] Starting dynamic subtest: pipe-B [132.491106] Dynamic subtest pipe-B: SUCCESS (1.119s) [132.501589] Starting dynamic subtest: pipe-C [133.607781] Dynamic subtest pipe-C: SUCCESS (1.115s) [133.617038] Starting dynamic subtest: pipe-D [134.734336] Dynamic subtest pipe-D: SUCCESS (1.126s) [134.736721] Subtest planes-downscale-factor-0-75-upscale-factor-0-25: SUCCESS (3.428s) [135.900375] [020/132] (886s left) kms_content_protection (dp-mst-type-0-hdcp14) [136.042916] Starting subtest: dp-mst-type-0-hdcp14 [136.048232] Subtest dp-mst-type-0-hdcp14: SKIP (0.000s) [136.178661] [021/132] (885s left) syncobj_timeline (invalid-multi-wait-unsubmitted) [136.231142] Starting subtest: invalid-multi-wait-unsubmitted [136.233103] Subtest invalid-multi-wait-unsubmitted: SUCCESS (0.000s) [136.308059] [022/132] (885s left) fbdev (write) [136.354486] Starting subtest: write [136.716953] Subtest write: SUCCESS (0.363s) [136.775549] [023/132] (885s left) kms_pipe_crc_basic (read-crc-frame-sequence) [136.878265] Starting subtest: read-crc-frame-sequence [136.880676] Starting dynamic subtest: pipe-A-eDP-1 [137.585973] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.705s) [137.595703] Starting dynamic subtest: pipe-B-eDP-1 [138.976201] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.388s) [138.985603] Starting dynamic subtest: pipe-C-eDP-1 [140.277794] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.302s) [140.286905] Starting dynamic subtest: pipe-D-eDP-1 [141.613638] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.334s) [141.616158] Subtest read-crc-frame-sequence: SUCCESS (4.734s) [142.430065] [024/132] (879s left) gem_gpgpu_fill (offset-16x16) [142.496530] Starting subtest: offset-16x16 [142.502898] Subtest offset-16x16: SUCCESS (0.008s) [142.646284] [025/132] (879s left) perf (buffer-fill) [142.770842] Starting subtest: buffer-fill [142.773095] Starting dynamic subtest: 0-rcs0 [145.019967] Dynamic subtest 0-rcs0: SUCCESS (2.250s) [145.028178] Starting dynamic subtest: 1-vecs0 [149.452611] Dynamic subtest 1-vecs0: SUCCESS (4.430s) [149.455393] Subtest buffer-fill: SUCCESS (6.682s) [149.500883] [026/132] (872s left) kms_legacy_colorkey (basic) [149.602093] Starting subtest: basic [149.604339] Starting dynamic subtest: pipe-A [149.644824] Dynamic subtest pipe-A: SUCCESS (0.045s) [149.655887] Starting dynamic subtest: pipe-B [149.658224] Dynamic subtest pipe-B: SUCCESS (0.001s) [149.666053] Starting dynamic subtest: pipe-C [149.668343] Dynamic subtest pipe-C: SUCCESS (0.000s) [149.675725] Starting dynamic subtest: pipe-D [149.678649] Dynamic subtest pipe-D: SUCCESS (0.000s) [149.680613] Subtest basic: SUCCESS (0.049s) [149.714984] [027/132] (872s left) api_intel_bb (intel-bb-blit-y) [149.773437] Starting subtest: intel-bb-blit-y [153.275056] Subtest intel-bb-blit-y: SUCCESS (3.500s) [153.394028] [028/132] (868s left) kms_ccs (random-ccs-data-4-tiled-dg2-rc-ccs) [153.488298] Starting subtest: random-ccs-data-4-tiled-dg2-rc-ccs [153.490568] Starting dynamic subtest: pipe-A-eDP-1 [153.515163] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [153.524687] Starting dynamic subtest: pipe-B-eDP-1 [153.547164] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [153.554574] Starting dynamic subtest: pipe-C-eDP-1 [153.577067] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [153.584626] Starting dynamic subtest: pipe-D-eDP-1 [153.607587] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [153.611426] Subtest random-ccs-data-4-tiled-dg2-rc-ccs: SKIP (0.003s) [155.804625] [029/132] (866s left) kms_pm_rpm (dpms-non-lpsp) [157.424966] Starting subtest: dpms-non-lpsp [157.430139] Subtest dpms-non-lpsp: SKIP (0.001s) [158.039973] [030/132] (864s left) kms_flip (2x-flip-vs-expired-vblank-interruptible) [158.131457] Starting subtest: 2x-flip-vs-expired-vblank-interruptible [158.144861] Subtest 2x-flip-vs-expired-vblank-interruptible: SKIP (0.011s) [158.222109] [031/132] (864s left) gem_media_vme [158.336878] [032/132] (864s left) syncobj_timeline (single-wait-available-signaled) [158.400127] Starting subtest: single-wait-available-signaled [158.402482] Subtest single-wait-available-signaled: SUCCESS (0.000s) [158.498324] [033/132] (864s left) gem_exec_reloc (basic-wc-gtt-noreloc) [158.564790] Subtest basic-wc-gtt-noreloc: SKIP (0.000s) [158.636747] [034/132] (863s left) vgem_basic (bad-flag) [158.714845] Starting subtest: bad-flag [158.716949] Subtest bad-flag: SUCCESS (0.000s) [158.770985] [FACT vgem_basic (bad-flag)] new: kernel.kmod_is_loaded.vgem: true [158.774251] [035/132] (863s left) kms_frontbuffer_tracking (fbc-2p-shrfb-fliptrack-mmap-gtt) [158.871426] Starting subtest: fbc-2p-shrfb-fliptrack-mmap-gtt [158.875970] Subtest fbc-2p-shrfb-fliptrack-mmap-gtt: SKIP (0.000s) [158.981317] [036/132] (863s left) kms_frontbuffer_tracking (fbcpsr-indfb-scaledprimary) [159.083901] Starting subtest: fbcpsr-indfb-scaledprimary [164.827842] Subtest fbcpsr-indfb-scaledprimary: SUCCESS (5.745s) [164.990555] [037/132] (857s left) kms_ccs (bad-pixel-format-4-tiled-dg2-mc-ccs) [165.090394] Starting subtest: bad-pixel-format-4-tiled-dg2-mc-ccs [165.092762] Starting dynamic subtest: pipe-A-eDP-1 [165.116269] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [165.126343] Starting dynamic subtest: pipe-B-eDP-1 [165.146968] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [165.154631] Starting dynamic subtest: pipe-C-eDP-1 [165.175890] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [165.183343] Starting dynamic subtest: pipe-D-eDP-1 [165.206185] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [165.210569] Subtest bad-pixel-format-4-tiled-dg2-mc-ccs: SKIP (0.004s) [167.333205] [038/132] (855s left) kms_psr2_sf (psr2-overlay-plane-update-sf-dmg-area) [167.426060] Starting subtest: psr2-overlay-plane-update-sf-dmg-area [167.428327] Starting dynamic subtest: pipe-A-eDP-1 [173.326341] Dynamic subtest pipe-A-eDP-1: SUCCESS (5.900s) [173.335137] Starting dynamic subtest: pipe-B-eDP-1 [179.966086] Dynamic subtest pipe-B-eDP-1: SUCCESS (6.639s) [179.968494] Subtest psr2-overlay-plane-update-sf-dmg-area: SUCCESS (12.541s) [180.837141] [039/132] (841s left) gem_pread (bench) [180.895776] Subtest bench: SKIP (0.000s) [180.951678] [040/132] (841s left) kms_psr (psr2-sprite-plane-move) [181.032897] Starting subtest: psr2-sprite-plane-move [181.035224] Starting dynamic subtest: eDP-1 [182.762722] Dynamic subtest eDP-1: SUCCESS (1.730s) [182.765235] Subtest psr2-sprite-plane-move: SUCCESS (1.731s) [183.605346] [041/132] (839s left) gem_mmap (bad-object) [183.657125] Subtest bad-object: SKIP (0.000s) [183.715505] [042/132] (839s left) gem_exec_reloc (basic-cpu-gtt-active) [183.789619] Subtest basic-cpu-gtt-active: SKIP (0.000s) [183.854880] [043/132] (839s left) kms_frontbuffer_tracking (fbc-2p-primscrn-indfb-plflip-blt) [183.940061] Starting subtest: fbc-2p-primscrn-indfb-plflip-blt [183.944282] Subtest fbc-2p-primscrn-indfb-plflip-blt: SKIP (0.000s) [184.040086] [044/132] (838s left) kms_flip (2x-wf_vblank-ts-check) [184.140142] Starting subtest: 2x-wf_vblank-ts-check [184.151579] Subtest 2x-wf_vblank-ts-check: SKIP (0.011s) [184.272606] [045/132] (838s left) kms_plane (pixel-format-4-tiled-mtl-mc-ccs-modifier-source-clamping) [184.373425] Starting subtest: pixel-format-4-tiled-mtl-mc-ccs-modifier-source-clamping [184.400598] Starting dynamic subtest: pipe-A-plane-0 [184.822074] Dynamic subtest pipe-A-plane-0: SUCCESS (0.422s) [184.830217] Starting dynamic subtest: pipe-A-plane-3 [185.077743] Dynamic subtest pipe-A-plane-3: SUCCESS (0.255s) [186.205279] Starting dynamic subtest: pipe-B-plane-0 [186.624138] Dynamic subtest pipe-B-plane-0: SUCCESS (0.433s) [186.634470] Starting dynamic subtest: pipe-B-plane-3 [186.879566] Dynamic subtest pipe-B-plane-3: SUCCESS (0.255s) [187.191416] Subtest pixel-format-4-tiled-mtl-mc-ccs-modifier-source-clamping: SUCCESS (2.816s) [188.073699] [046/132] (835s left) perf (gen8-unprivileged-single-ctx-counters) [188.184894] Starting subtest: gen8-unprivileged-single-ctx-counters [188.189708] Subtest gen8-unprivileged-single-ctx-counters: SKIP (0.000s) [188.236755] [047/132] (834s left) kms_async_flips (async-flip-with-page-flip-events-linear) [188.326295] Starting subtest: async-flip-with-page-flip-events-linear [188.701112] Starting dynamic subtest: pipe-A-eDP-1 [191.493852] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.737s) [191.807718] Starting dynamic subtest: pipe-B-eDP-1 [194.614708] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.764s) [194.922868] Starting dynamic subtest: pipe-C-eDP-1 [197.740687] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.771s) [198.047656] Starting dynamic subtest: pipe-D-eDP-1 [200.868782] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.774s) [200.870902] Subtest async-flip-with-page-flip-events-linear: SUCCESS (12.489s) [202.004077] [048/132] (821s left) syncobj_wait (multi-wait-for-submit-submitted-signaled) [202.056366] Starting subtest: multi-wait-for-submit-submitted-signaled [202.058626] Subtest multi-wait-for-submit-submitted-signaled: SUCCESS (0.000s) [202.174273] [049/132] (821s left) syncobj_timeline (multi-wait-for-submit-available-unsubmitted-submitted-signa [202.229029] Starting subtest: multi-wait-for-submit-available-unsubmitted-submitted-signaled [202.231297] Subtest multi-wait-for-submit-available-unsubmitted-submitted-signaled: SUCCESS (0.000s) [202.327772] [050/132] (820s left) gem_fence_thrash (bo-write-verify-x) [202.365794] Starting subtest: bo-write-verify-x [202.383286] Subtest bo-write-verify-x: SKIP (0.015s) [202.436307] [051/132] (820s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-mmap-gtt) [202.534725] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-mmap-gtt [202.538778] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s) [202.626803] [052/132] (820s left) gem_create (create-ext-set-pat) [202.802989] Starting subtest: create-ext-set-pat [202.805636] Subtest create-ext-set-pat: SUCCESS (0.001s) [202.904427] [053/132] (820s left) gem_exec_store (cachelines) [202.975120] Starting subtest: cachelines [202.977058] Starting dynamic subtest: rcs0 [203.041081] Dynamic subtest rcs0: SUCCESS (0.067s) [203.051601] Starting dynamic subtest: bcs0 [203.095805] Dynamic subtest bcs0: SUCCESS (0.053s) [203.106081] Starting dynamic subtest: vcs0 [203.150230] Dynamic subtest vcs0: SUCCESS (0.052s) [203.160220] Starting dynamic subtest: vcs1 [203.205662] Dynamic subtest vcs1: SUCCESS (0.053s) [203.215765] Starting dynamic subtest: vecs0 [203.261401] Dynamic subtest vecs0: SUCCESS (0.054s) [203.271546] Starting dynamic subtest: ccs0 [203.316666] Dynamic subtest ccs0: SUCCESS (0.053s) [203.319150] Subtest cachelines: SUCCESS (0.345s) [203.500323] [054/132] (819s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-mmap-wc) [203.610054] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-mmap-wc [203.614339] Subtest psr-2p-scndscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s) [203.712853] [055/132] (819s left) gem_exec_fence (syncobj-wait) [204.144477] Starting subtest: syncobj-wait [205.333118] Subtest syncobj-wait: SUCCESS (1.188s) [205.672830] [056/132] (817s left) gem_mmap_gtt (medium-copy) [205.737207] Subtest medium-copy: SKIP (0.000s) [205.805111] [057/132] (817s left) kms_vblank (wait-busy-hang) [205.902638] Starting subtest: wait-busy-hang [205.904922] Starting dynamic subtest: pipe-A-eDP-1 [232.070232] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.163s) [232.084085] Starting dynamic subtest: pipe-D-eDP-1 [257.013892] Dynamic subtest pipe-D-eDP-1: SUCCESS (24.942s) [257.016376] Subtest wait-busy-hang: SUCCESS (51.109s) [257.862530] [058/132] (765s left) perf_pmu (render-node-busy) [257.935159] Starting subtest: render-node-busy [257.937606] Starting dynamic subtest: rcs0 [258.510754] Dynamic subtest rcs0: SUCCESS (0.575s) [258.522239] Starting dynamic subtest: bcs0 [259.073971] Dynamic subtest bcs0: SUCCESS (0.561s) [259.085810] Starting dynamic subtest: vcs0 [260.284826] Dynamic subtest vcs0: SUCCESS (1.207s) [260.299369] Starting dynamic subtest: vcs1 [262.270670] Dynamic subtest vcs1: SUCCESS (1.983s) [262.282283] Starting dynamic subtest: vecs0 [264.316650] Dynamic subtest vecs0: SUCCESS (2.043s) [264.326674] Starting dynamic subtest: ccs0 [264.878849] Dynamic subtest ccs0: SUCCESS (0.561s) [264.881834] Subtest render-node-busy: SUCCESS (6.944s) [264.957422] [059/132] (758s left) kms_addfb_basic (bad-pitch-32) [265.004873] Starting subtest: bad-pitch-32 [265.007205] Subtest bad-pitch-32: SUCCESS (0.000s) [265.176169] [060/132] (758s left) gem_exec_parallel (basic) [265.228588] Starting subtest: basic [265.230983] Starting dynamic subtest: rcs0 [266.648765] Dynamic subtest rcs0: SUCCESS (1.420s) [266.658105] Starting dynamic subtest: bcs0 [268.106429] Dynamic subtest bcs0: SUCCESS (1.457s) [268.115924] Starting dynamic subtest: vcs0 [270.268559] Dynamic subtest vcs0: SUCCESS (2.159s) [270.280176] Starting dynamic subtest: vcs1 [272.252398] Dynamic subtest vcs1: SUCCESS (1.981s) [272.262075] Starting dynamic subtest: vecs0 [274.236970] Dynamic subtest vecs0: SUCCESS (1.981s) [274.249071] Starting dynamic subtest: ccs0 [275.710672] Dynamic subtest ccs0: SUCCESS (1.472s) [275.713726] Subtest basic: SUCCESS (10.483s) [275.910135] [061/132] (747s left) gem_tiled_partial_pwrite_pread (reads) [275.976898] Subtest reads: SKIP (0.000s) [276.041549] [062/132] (747s left) kms_big_fb (yf-tiled-64bpp-rotate-270) [276.147052] Starting subtest: yf-tiled-64bpp-rotate-270 [276.151389] Subtest yf-tiled-64bpp-rotate-270: SKIP (0.000s) [276.247016] [063/132] (747s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-0-async-flip) [276.345285] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-0-async-flip [276.969632] Subtest x-tiled-max-hw-stride-32bpp-rotate-0-async-flip: SUCCESS (0.626s) [277.168630] [064/132] (746s left) syncobj_wait (multi-wait-for-submit-signaled) [277.224036] Starting subtest: multi-wait-for-submit-signaled [277.226274] Subtest multi-wait-for-submit-signaled: SUCCESS (0.000s) [277.309493] [065/132] (746s left) prime_busy (hang-wait) [277.370782] Starting subtest: hang-wait [277.373080] Starting dynamic subtest: rcs0 [303.776294] Dynamic subtest rcs0: SUCCESS (26.393s) [303.785344] Starting dynamic subtest: bcs0 [310.931315] Dynamic subtest bcs0: SUCCESS (7.152s) [310.940848] Starting dynamic subtest: vcs0 [317.900049] Dynamic subtest vcs0: SUCCESS (6.972s) [317.914281] Starting dynamic subtest: vcs1 [324.875079] Dynamic subtest vcs1: SUCCESS (6.978s) [324.885312] Starting dynamic subtest: vecs0 [331.912967] Dynamic subtest vecs0: SUCCESS (7.031s) [331.922457] Starting dynamic subtest: ccs0 [345.755022] Dynamic subtest ccs0: SUCCESS (13.839s) [345.757162] Subtest hang-wait: SUCCESS (68.379s) [345.876290] [066/132] (678s left) gem_exec_basic (basic) [345.942175] Starting subtest: basic [345.944589] Starting dynamic subtest: rcs0-smem [345.946897] Dynamic subtest rcs0-smem: SUCCESS (0.005s) [345.960367] Starting dynamic subtest: bcs0-smem [345.962546] Dynamic subtest bcs0-smem: SUCCESS (0.003s) [345.973639] Starting dynamic subtest: vcs0-smem [345.975498] Dynamic subtest vcs0-smem: SUCCESS (0.003s) [345.983640] Starting dynamic subtest: vcs1-smem [345.985502] Dynamic subtest vcs1-smem: SUCCESS (0.002s) [345.993642] Starting dynamic subtest: vecs0-smem [345.995495] Dynamic subtest vecs0-smem: SUCCESS (0.002s) [346.003633] Starting dynamic subtest: ccs0-smem [346.005488] Dynamic subtest ccs0-smem: SUCCESS (0.003s) [346.007273] Subtest basic: SUCCESS (0.022s) [347.381406] [067/132] (676s left) gem_userptr_blits (vma-merge) [347.474454] Starting subtest: vma-merge [347.519310] Subtest vma-merge: SUCCESS (0.045s) [347.664971] [068/132] (676s left) kms_psr2_sf (pr-overlay-plane-update-sf-dmg-area) [347.764376] Starting subtest: pr-overlay-plane-update-sf-dmg-area [347.768612] Subtest pr-overlay-plane-update-sf-dmg-area: SKIP (0.000s) [347.871320] [069/132] (676s left) syncobj_timeline (invalid-multi-wait-all-unsubmitted-submitted-signaled) [347.926446] Starting subtest: invalid-multi-wait-all-unsubmitted-submitted-signaled [347.928384] Subtest invalid-multi-wait-all-unsubmitted-submitted-signaled: SUCCESS (0.000s) [348.022817] [070/132] (676s left) kms_psr (fbc-psr2-no-drrs) [348.110158] Starting subtest: fbc-psr2-no-drrs [348.112300] Starting dynamic subtest: eDP-1 [348.116218] Dynamic subtest eDP-1: SKIP (0.000s) [348.120149] Subtest fbc-psr2-no-drrs: SKIP (0.001s) [348.183583] [071/132] (676s left) kms_cursor_legacy (modeset-atomic-cursor-hotspot) [348.298176] Starting subtest: modeset-atomic-cursor-hotspot [348.302569] Subtest modeset-atomic-cursor-hotspot: SKIP (0.000s) [348.446522] [072/132] (675s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-blt) [348.547085] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-blt [348.550394] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-blt: SKIP (0.000s) [348.634045] [073/132] (675s left) i915_fb_tiling (basic-x-tiling) [348.696477] Subtest basic-x-tiling: SKIP (0.000s) [348.756709] [074/132] (675s left) prime_mmap (test_aperture_limit) [348.815588] Starting subtest: test_aperture_limit [348.817390] Starting dynamic subtest: test_aperture_limit-smem [348.829099] Dynamic subtest test_aperture_limit-smem: SKIP (0.013s) [348.832817] Subtest test_aperture_limit: SKIP (0.015s) [348.935526] [075/132] (675s left) i915_pm_rpm (reg-read-ioctl) [350.456371] Starting subtest: reg-read-ioctl [352.755615] Subtest reg-read-ioctl: SUCCESS (2.300s) [353.129720] [076/132] (671s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-blt) [353.232697] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-blt [353.236913] Subtest fbc-2p-scndscrn-spr-indfb-draw-blt: SKIP (0.000s) [353.329484] [077/132] (671s left) gem_ctx_param (invalid-set-ringsize) [353.387075] Starting subtest: invalid-set-ringsize [353.389191] Subtest invalid-set-ringsize: SUCCESS (0.000s) [353.467178] [078/132] (671s left) kms_cursor_crc (cursor-offscreen-32x32) [353.608200] Starting subtest: cursor-offscreen-32x32 [353.654246] Subtest cursor-offscreen-32x32: SKIP (0.043s) [353.930847] [079/132] (670s left) kms_atomic (atomic-plane-damage) [354.022726] Starting subtest: atomic-plane-damage [354.071796] Starting dynamic subtest: pipe-A-eDP-1 [354.612958] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.541s) [354.615323] Subtest atomic-plane-damage: SUCCESS (0.590s) [355.457707] [080/132] (669s left) gem_pipe_control_store_loop (reused-buffer) [355.511126] Starting subtest: reused-buffer [357.715549] Subtest reused-buffer: SUCCESS (2.151s) [357.770767] [081/132] (666s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-move) [357.877477] Starting subtest: fbc-1p-primscrn-spr-indfb-move [362.103280] Subtest fbc-1p-primscrn-spr-indfb-move: SUCCESS (4.229s) [363.245612] [082/132] (661s left) kms_ccs (random-ccs-data-y-tiled-ccs) [363.351139] Starting subtest: random-ccs-data-y-tiled-ccs [363.353444] Starting dynamic subtest: pipe-A-eDP-1 [363.379588] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [363.391615] Starting dynamic subtest: pipe-B-eDP-1 [363.415819] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [363.424777] Starting dynamic subtest: pipe-C-eDP-1 [363.448054] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [363.456971] Starting dynamic subtest: pipe-D-eDP-1 [363.481771] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [363.486553] Subtest random-ccs-data-y-tiled-ccs: SKIP (0.005s) [365.590307] [083/132] (659s left) kms_cursor_legacy (cursorb-vs-flipb-atomic-transitions-varying-size) [365.710328] Starting subtest: cursorB-vs-flipB-atomic-transitions-varying-size [365.714825] Subtest cursorB-vs-flipB-atomic-transitions-varying-size: SKIP (0.001s) [365.859307] [084/132] (658s left) kms_plane (pixel-format-4-tiled-bmg-ccs-modifier) [365.947338] Starting subtest: pixel-format-4-tiled-bmg-ccs-modifier [365.951318] Subtest pixel-format-4-tiled-bmg-ccs-modifier: SKIP (0.000s) [366.021799] [085/132] (658s left) syncobj_wait (single-wait-all-signaled) [366.073317] Starting subtest: single-wait-all-signaled [366.075258] Subtest single-wait-all-signaled: SUCCESS (0.000s) [366.187999] [086/132] (658s left) core_setmaster (master-drop-set-user) [366.282281] Starting subtest: master-drop-set-user [366.296307] Subtest master-drop-set-user: SUCCESS (0.015s) [366.337236] [087/132] (658s left) kms_cursor_crc (cursor-rapid-movement-128x42) [366.547539] Starting subtest: cursor-rapid-movement-128x42 [366.596521] Subtest cursor-rapid-movement-128x42: SKIP (0.042s) [366.802616] [088/132] (658s left) kms_color (ctm-0-25) [366.890046] Starting subtest: ctm-0-25 [366.891767] Starting dynamic subtest: pipe-A-eDP-1 [370.398044] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.507s) [370.407208] Starting dynamic subtest: pipe-B-eDP-1 [374.597079] Dynamic subtest pipe-B-eDP-1: SUCCESS (4.196s) [374.606945] Starting dynamic subtest: pipe-C-eDP-1 [378.647022] Dynamic subtest pipe-C-eDP-1: SUCCESS (4.051s) [378.663545] Starting dynamic subtest: pipe-D-eDP-1 [382.652246] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.003s) [382.654594] Subtest ctm-0-25: SUCCESS (15.760s) [383.493676] [089/132] (641s left) kms_chamelium_frames (hdmi-cmp-planar-formats) [383.894207] Subtest hdmi-cmp-planar-formats: SKIP (0.000s) [384.700758] [090/132] (640s left) kms_selftest (drm_damage_helper) [384.743844] Starting subtest: drm_damage_helper [384.802426] Starting dynamic subtest: drm_test_damage_iter_no_damage [384.889123] Dynamic subtest drm_test_damage_iter_no_damage: SUCCESS (0.086s) [384.899990] Starting dynamic subtest: drm_test_damage_iter_no_damage_fractional_src [384.995817] Dynamic subtest drm_test_damage_iter_no_damage_fractional_src: SUCCESS (0.105s) [385.005199] Starting dynamic subtest: drm_test_damage_iter_no_damage_src_moved [385.089910] Dynamic subtest drm_test_damage_iter_no_damage_src_moved: SUCCESS (0.091s) [385.098502] Starting dynamic subtest: drm_test_damage_iter_no_damage_fractional_src_moved [385.196213] Dynamic subtest drm_test_damage_iter_no_damage_fractional_src_moved: SUCCESS (0.105s) [385.205114] Starting dynamic subtest: drm_test_damage_iter_no_damage_not_visible [385.284071] Dynamic subtest drm_test_damage_iter_no_damage_not_visible: SUCCESS (0.087s) [385.294409] Starting dynamic subtest: drm_test_damage_iter_no_damage_no_crtc [385.370941] Dynamic subtest drm_test_damage_iter_no_damage_no_crtc: SUCCESS (0.086s) [385.380098] Starting dynamic subtest: drm_test_damage_iter_no_damage_no_fb [385.472027] Dynamic subtest drm_test_damage_iter_no_damage_no_fb: SUCCESS (0.100s) [385.481169] Starting dynamic subtest: drm_test_damage_iter_simple_damage [385.571088] Dynamic subtest drm_test_damage_iter_simple_damage: SUCCESS (0.098s) [385.580123] Starting dynamic subtest: drm_test_damage_iter_single_damage [385.666725] Dynamic subtest drm_test_damage_iter_single_damage: SUCCESS (0.097s) [385.675295] Starting dynamic subtest: drm_test_damage_iter_single_damage_intersect_src [385.770591] Dynamic subtest drm_test_damage_iter_single_damage_intersect_src: SUCCESS (0.102s) [385.779097] Starting dynamic subtest: drm_test_damage_iter_single_damage_outside_src [385.865676] Dynamic subtest drm_test_damage_iter_single_damage_outside_src: SUCCESS (0.096s) [385.874436] Starting dynamic subtest: drm_test_damage_iter_single_damage_fractional_src [385.955491] Dynamic subtest drm_test_damage_iter_single_damage_fractional_src: SUCCESS (0.089s) [385.965688] Starting dynamic subtest: drm_test_damage_iter_single_damage_intersect_fractional_src [386.046851] Dynamic subtest drm_test_damage_iter_single_damage_intersect_fractional_src: SUCCESS (0.090s) [386.055514] Starting dynamic subtest: drm_test_damage_iter_single_damage_outside_fractional_src [386.139455] Dynamic subtest drm_test_damage_iter_single_damage_outside_fractional_src: SUCCESS (0.091s) [386.148261] Starting dynamic subtest: drm_test_damage_iter_single_damage_src_moved [386.231673] Dynamic subtest drm_test_damage_iter_single_damage_src_moved: SUCCESS (0.092s) [386.240121] Starting dynamic subtest: drm_test_damage_iter_single_damage_fractional_src_moved [386.322442] Dynamic subtest drm_test_damage_iter_single_damage_fractional_src_moved: SUCCESS (0.089s) [386.331137] Starting dynamic subtest: drm_test_damage_iter_damage [386.411659] Dynamic subtest drm_test_damage_iter_damage: SUCCESS (0.089s) [386.420165] Starting dynamic subtest: drm_test_damage_iter_damage_one_intersect [386.516483] Dynamic subtest drm_test_damage_iter_damage_one_intersect: SUCCESS (0.104s) [386.526674] Starting dynamic subtest: drm_test_damage_iter_damage_one_outside [386.612794] Dynamic subtest drm_test_damage_iter_damage_one_outside: SUCCESS (0.094s) [386.621479] Starting dynamic subtest: drm_test_damage_iter_damage_src_moved [386.703587] Dynamic subtest drm_test_damage_iter_damage_src_moved: SUCCESS (0.090s) [386.712137] Starting dynamic subtest: drm_test_damage_iter_damage_not_visible [386.799472] Dynamic subtest drm_test_damage_iter_damage_not_visible: SUCCESS (0.095s) [386.801102] Subtest drm_damage_helper: SUCCESS (2.055s) [386.980618] [091/132] (638s left) gem_render_copy (linear-to-vebox-y-tiled) [387.046430] Starting subtest: linear-to-vebox-y-tiled [387.051018] Subtest linear-to-vebox-y-tiled: SKIP (0.000s) [387.226360] [092/132] (637s left) gem_close_race (basic-process) [387.296844] Starting subtest: basic-process [387.358885] Subtest basic-process: SUCCESS (0.062s) [387.562746] [093/132] (637s left) kms_busy (extended-pageflip-hang-oldfb) [387.659221] Starting subtest: extended-pageflip-hang-oldfb [387.661535] Starting dynamic subtest: pipe-A [388.066540] Dynamic subtest pipe-A: SUCCESS (0.404s) [388.075809] Starting dynamic subtest: pipe-D [389.232927] Dynamic subtest pipe-D: SUCCESS (1.163s) [389.235289] Subtest extended-pageflip-hang-oldfb: SUCCESS (1.572s) [390.088423] [094/132] (635s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-render) [390.181504] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-render [397.011765] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-render: SUCCESS (6.833s) [397.149643] [095/132] (628s left) api_intel_bb (add-remove-objects) [397.200627] Starting subtest: add-remove-objects [397.205452] Subtest add-remove-objects: SUCCESS (0.006s) [397.316443] [096/132] (627s left) perf (gen12-invalid-class-instance) [397.411622] Starting subtest: gen12-invalid-class-instance [397.420520] Subtest gen12-invalid-class-instance: SUCCESS (0.008s) [397.472512] [097/132] (627s left) kms_big_fb (y-tiled-addfb-size-offset-overflow) [397.567276] Starting subtest: y-tiled-addfb-size-offset-overflow [397.571241] Subtest y-tiled-addfb-size-offset-overflow: SKIP (0.000s) [397.669515] [098/132] (627s left) kms_big_fb (linear-max-hw-stride-32bpp-rotate-0-hflip) [397.774058] Starting subtest: linear-max-hw-stride-32bpp-rotate-0-hflip [397.778706] Subtest linear-max-hw-stride-32bpp-rotate-0-hflip: SKIP (0.000s) [397.885947] [099/132] (627s left) kms_psr2_sf (fbc-pr-overlay-plane-move-continuous-exceed-sf) [397.990590] Starting subtest: fbc-pr-overlay-plane-move-continuous-exceed-sf [397.994684] Subtest fbc-pr-overlay-plane-move-continuous-exceed-sf: SKIP (0.000s) [398.072165] [100/132] (627s left) prime_udl [398.159490] [101/132] (627s left) i915_suspend (basic-s3-without-i915) [398.196084] Starting subtest: basic-s3-without-i915 [399.888892] Subtest basic-s3-without-i915: SKIP (1.690s) [401.447344] [102/132] (624s left) kms_ccs (crc-primary-basic-4-tiled-mtl-rc-ccs) [401.543801] Starting subtest: crc-primary-basic-4-tiled-mtl-rc-ccs [401.546084] Starting dynamic subtest: pipe-A-eDP-1 [402.382766] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.833s) [402.391328] Starting dynamic subtest: pipe-B-eDP-1 [404.026255] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.639s) [404.036077] Starting dynamic subtest: pipe-C-eDP-1 [405.579068] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.553s) [405.589909] Starting dynamic subtest: pipe-D-eDP-1 [407.083065] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.502s) [407.084977] Subtest crc-primary-basic-4-tiled-mtl-rc-ccs: SUCCESS (5.532s) [408.260374] [103/132] (617s left) gem_mmap_offset (blt-coherency) [408.337182] Starting subtest: blt-coherency [408.343087] Subtest blt-coherency: SUCCESS (0.007s) [408.470452] [104/132] (617s left) gem_mmap (basic-small-bo) [408.533380] Subtest basic-small-bo: SKIP (0.000s) [408.616841] [105/132] (617s left) kms_psr (pr-cursor-mmap-cpu) [408.710859] Starting subtest: pr-cursor-mmap-cpu [408.715274] Subtest pr-cursor-mmap-cpu: SKIP (0.000s) [408.797663] [106/132] (616s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-pwrite) [408.898601] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-pwrite [416.644231] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-pwrite: SUCCESS (7.748s) [416.785488] [107/132] (608s left) gem_exec_parallel (fds) [416.857049] Starting subtest: fds [416.859416] Starting dynamic subtest: rcs0 [419.319923] Dynamic subtest rcs0: SUCCESS (2.462s) [419.331466] Starting dynamic subtest: bcs0 [422.703230] Dynamic subtest bcs0: SUCCESS (3.379s) [422.713215] Starting dynamic subtest: vcs0 [426.632039] Dynamic subtest vcs0: SUCCESS (3.926s) [426.642622] Starting dynamic subtest: vcs1 [430.564296] Dynamic subtest vcs1: SUCCESS (3.930s) [430.576215] Starting dynamic subtest: vecs0 [434.553849] Dynamic subtest vecs0: SUCCESS (3.986s) [434.565917] Starting dynamic subtest: ccs0 [438.018412] Dynamic subtest ccs0: SUCCESS (3.464s) [438.020974] Subtest fds: SUCCESS (21.161s) [438.212264] [108/132] (587s left) gem_softpin (allocator-nopin) [438.278584] Starting subtest: allocator-nopin [438.403725] Subtest allocator-nopin: SUCCESS (0.124s) [438.539983] [109/132] (587s left) kms_psr (fbc-psr-sprite-mmap-gtt) [438.629983] Starting subtest: fbc-psr-sprite-mmap-gtt [438.632327] Starting dynamic subtest: eDP-1 [438.636793] Dynamic subtest eDP-1: SKIP (0.000s) [438.641223] Subtest fbc-psr-sprite-mmap-gtt: SKIP (0.001s) [438.706026] [110/132] (587s left) gem_exec_schedule (u-fairslice) [438.775101] Starting subtest: u-fairslice [438.777376] Starting dynamic subtest: rcs0 [440.791403] Dynamic subtest rcs0: SUCCESS (2.020s) [440.800917] Starting dynamic subtest: bcs0 [442.813151] Dynamic subtest bcs0: SUCCESS (2.024s) [442.827801] Starting dynamic subtest: vcs0 [444.886454] Dynamic subtest vcs0: SUCCESS (2.023s) [444.897311] Starting dynamic subtest: vcs1 [446.857056] Dynamic subtest vcs1: SUCCESS (2.017s) [446.867380] Starting dynamic subtest: vecs0 [448.924251] Dynamic subtest vecs0: SUCCESS (2.018s) [448.935252] Starting dynamic subtest: ccs0 [450.949672] Dynamic subtest ccs0: SUCCESS (2.022s) [450.951813] Subtest u-fairslice: SUCCESS (12.129s) [451.196815] [111/132] (574s left) gem_exec_fence (parallel) [451.379757] Starting subtest: parallel [451.382327] Starting dynamic subtest: rcs0 [453.538867] Dynamic subtest rcs0: SUCCESS (2.160s) [453.549171] Starting dynamic subtest: bcs0 [455.691971] Dynamic subtest bcs0: SUCCESS (2.151s) [455.702658] Starting dynamic subtest: vcs0 [457.842389] Dynamic subtest vcs0: SUCCESS (2.150s) [457.852722] Starting dynamic subtest: vcs1 [459.997245] Dynamic subtest vcs1: SUCCESS (2.154s) [460.007874] Starting dynamic subtest: vecs0 [462.153533] Dynamic subtest vecs0: SUCCESS (2.155s) [462.162245] Starting dynamic subtest: ccs0 [464.306510] Dynamic subtest ccs0: SUCCESS (2.152s) [464.308410] Subtest parallel: SUCCESS (12.928s) [466.386923] [112/132] (559s left) kms_addfb_basic (tile-pitch-mismatch) [466.435919] Starting subtest: tile-pitch-mismatch [466.440993] Subtest tile-pitch-mismatch: SKIP (0.000s) [466.574450] [113/132] (559s left) kms_plane (pixel-format-y-tiled-modifier-source-clamping) [466.657800] Starting subtest: pixel-format-y-tiled-modifier-source-clamping [466.662153] Subtest pixel-format-y-tiled-modifier-source-clamping: SKIP (0.000s) [466.733520] [114/132] (559s left) syncobj_wait (invalid-signal-one-illegal-handle) [466.782047] Starting subtest: invalid-signal-one-illegal-handle [466.784347] Subtest invalid-signal-one-illegal-handle: SUCCESS (0.000s) [466.874793] [115/132] (559s left) kms_draw_crc (draw-method-render) [466.969182] Starting subtest: draw-method-render [466.971060] Starting dynamic subtest: xrgb8888-untiled [467.257586] Dynamic subtest xrgb8888-untiled: SUCCESS (0.290s) [467.267749] Starting dynamic subtest: rgb565-untiled [467.557087] Dynamic subtest rgb565-untiled: SUCCESS (0.298s) [467.566357] Starting dynamic subtest: xrgb2101010-untiled [467.812536] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.255s) [467.822102] Starting dynamic subtest: xbgr16161616f-untiled [468.057164] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.244s) [468.066707] Starting dynamic subtest: xrgb8888-xtiled [468.190467] Dynamic subtest xrgb8888-xtiled: SUCCESS (0.133s) [468.199825] Starting dynamic subtest: rgb565-xtiled [468.301586] Dynamic subtest rgb565-xtiled: SUCCESS (0.110s) [468.311053] Starting dynamic subtest: xrgb2101010-xtiled [468.423581] Dynamic subtest xrgb2101010-xtiled: SUCCESS (0.121s) [468.432934] Starting dynamic subtest: xbgr16161616f-xtiled [468.560964] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (0.133s) [468.576118] Starting dynamic subtest: xrgb8888-4tiled [468.701966] Dynamic subtest xrgb8888-4tiled: SUCCESS (0.141s) [468.717229] Starting dynamic subtest: rgb565-4tiled [468.812808] Dynamic subtest rgb565-4tiled: SUCCESS (0.109s) [468.823786] Starting dynamic subtest: xrgb2101010-4tiled [468.934851] Dynamic subtest xrgb2101010-4tiled: SUCCESS (0.120s) [468.944729] Starting dynamic subtest: xbgr16161616f-4tiled [469.068225] Dynamic subtest xbgr16161616f-4tiled: SUCCESS (0.133s) [469.070098] Subtest draw-method-render: SUCCESS (2.101s) [469.198048] [116/132] (556s left) kms_color_pipeline (plane-lut1d) [469.294466] Starting subtest: plane-lut1d [469.428150] Starting dynamic subtest: pipe-A-plane-0 [469.594826] Dynamic subtest pipe-A-plane-0: SUCCESS (0.166s) [469.604140] Starting dynamic subtest: pipe-A-plane-1 [469.749898] Dynamic subtest pipe-A-plane-1: SUCCESS (0.155s) [469.759059] Starting dynamic subtest: pipe-A-plane-2 [469.928277] Dynamic subtest pipe-A-plane-2: SUCCESS (0.177s) [471.113030] Starting dynamic subtest: pipe-B-plane-0 [471.283650] Dynamic subtest pipe-B-plane-0: SUCCESS (0.178s) [471.295173] Starting dynamic subtest: pipe-B-plane-1 [471.449656] Dynamic subtest pipe-B-plane-1: SUCCESS (0.166s) [471.459301] Starting dynamic subtest: pipe-B-plane-2 [471.605311] Dynamic subtest pipe-B-plane-2: SUCCESS (0.155s) [472.827083] Starting dynamic subtest: pipe-C-plane-0 [472.974696] Dynamic subtest pipe-C-plane-0: SUCCESS (0.155s) [472.984734] Starting dynamic subtest: pipe-C-plane-1 [473.120091] Dynamic subtest pipe-C-plane-1: SUCCESS (0.144s) [473.129618] Starting dynamic subtest: pipe-C-plane-2 [473.274341] Dynamic subtest pipe-C-plane-2: SUCCESS (0.155s) [474.483581] Starting dynamic subtest: pipe-D-plane-0 [474.619165] Dynamic subtest pipe-D-plane-0: SUCCESS (0.144s) [474.637859] Starting dynamic subtest: pipe-D-plane-1 [474.762029] Dynamic subtest pipe-D-plane-1: SUCCESS (0.143s) [474.771617] Starting dynamic subtest: pipe-D-plane-2 [474.917536] Dynamic subtest pipe-D-plane-2: SUCCESS (0.155s) [475.205669] Subtest plane-lut1d: SUCCESS (5.911s) [476.024459] [117/132] (550s left) kms_hdmi_inject (inject-audio) [476.388252] Starting subtest: inject-audio [476.663185] Subtest inject-audio: SUCCESS (0.277s) [477.285358] [118/132] (548s left) gen9_exec_parse (batch-without-end) [477.333311] Subtest batch-without-end: SKIP (0.000s) [477.403628] [119/132] (548s left) gem_eio (in-flight-contexts-1us) [477.639666] Starting subtest: in-flight-contexts-1us [491.286288] Subtest in-flight-contexts-1us: SUCCESS (13.645s) [491.422439] [120/132] (534s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-downscaling) [491.514150] Starting subtest: flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-downscaling [491.518798] Subtest flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-downscaling: SKIP (0.000s) [491.588152] [121/132] (534s left) kms_cursor_legacy (flip-vs-cursor-atomic-transitions) [491.696428] Starting subtest: flip-vs-cursor-atomic-transitions [499.657455] Subtest flip-vs-cursor-atomic-transitions: SUCCESS (7.959s) [500.452501] [122/132] (525s left) gem_mmap_wc (write) [500.523414] Subtest write: SKIP (0.000s) [500.586158] [123/132] (525s left) kms_force_connector_basic (force-edid) [500.658778] Starting subtest: force-edid [501.021575] Subtest force-edid: SUCCESS (0.365s) [501.159811] [124/132] (525s left) gem_ctx_shared (q-independent) [501.211669] Starting subtest: Q-independent [501.213896] Starting dynamic subtest: rcs0 [501.275428] Dynamic subtest rcs0: SUCCESS (0.063s) [501.289406] Starting dynamic subtest: vcs0 [501.316378] Dynamic subtest vcs0: SUCCESS (0.040s) [501.326707] Starting dynamic subtest: vcs1 [501.366147] Dynamic subtest vcs1: SUCCESS (0.049s) [501.378885] Starting dynamic subtest: vecs0 [501.414832] Dynamic subtest vecs0: SUCCESS (0.048s) [501.424233] Starting dynamic subtest: ccs0 [501.471262] Dynamic subtest ccs0: SUCCESS (0.055s) [501.473548] Subtest Q-independent: SUCCESS (0.260s) [502.358777] [125/132] (524s left) gem_ctx_persistence (idempotent) [502.413736] Starting subtest: idempotent [502.416426] Subtest idempotent: SUCCESS (0.000s) [502.508450] [126/132] (524s left) syncobj_eventfd (binary-wait-before-signal) [502.570221] Starting subtest: binary-wait-before-signal [502.599520] Subtest binary-wait-before-signal: SUCCESS (0.031s) [502.691584] [127/132] (523s left) kms_scaling_modes (scaling-mode-full) [502.786714] Starting subtest: scaling-mode-full [502.788970] Starting dynamic subtest: pipe-A-eDP-1 [502.877976] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.093s) [502.888747] Starting dynamic subtest: pipe-B-eDP-1 [504.047118] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.167s) [504.057436] Starting dynamic subtest: pipe-C-eDP-1 [505.229632] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.181s) [505.242280] Starting dynamic subtest: pipe-D-eDP-1 [506.425565] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.193s) [506.427997] Subtest scaling-mode-full: SUCCESS (3.642s) [507.653444] [128/132] (518s left) i915_drm_fdinfo (memory-info-idle) [507.690894] Starting subtest: memory-info-idle [507.693208] Starting dynamic subtest: smem0 [507.746432] Dynamic subtest smem0: SUCCESS (0.056s) [507.748934] Subtest memory-info-idle: SUCCESS (0.057s) [507.825368] [129/132] (518s left) kms_rotation_crc (sprite-rotation-270) [507.914660] Starting subtest: sprite-rotation-270 [507.919025] Subtest sprite-rotation-270: SKIP (0.001s) [507.990428] [130/132] (518s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-180-hflip) [508.097319] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-180-hflip [509.098102] Subtest 4-tiled-max-hw-stride-64bpp-rotate-180-hflip: SUCCESS (1.001s) [509.255600] [131/132] (517s left) gem_softpin (32b-excludes-last-page) [509.315197] Starting subtest: 32b-excludes-last-page [509.319793] Subtest 32b-excludes-last-page: SUCCESS (0.003s) [509.440542] [132/132] (517s left) gem_exec_schedule (preempt-queue-contexts-chain) [509.523260] Subtest preempt-queue-contexts-chain: SKIP (0.000s) [509.815867] Closing watchdogs results: parsing output: 0/ for test: kms_frontbuffer_tracking results: parsing output: 1/ for test: kms_frontbuffer_tracking results: parsing output: 2/ for test: kms_atomic_transition results: parsing output: 3/ for test: kms_frontbuffer_tracking results: parsing output: 4/ for test: gem_exec_balancer results: parsing output: 5/ for test: kms_flip_scaled_crc results: parsing output: 6/ for test: gem_exec_params results: parsing output: 7/ for test: gem_exec_reloc results: parsing output: 8/ for test: kms_cursor_edge_walk results: parsing output: 9/ for test: kms_frontbuffer_tracking results: parsing output: 10/ for test: kms_frontbuffer_tracking results: parsing output: 11/ for test: kms_frontbuffer_tracking results: parsing output: 12/ for test: kms_big_fb results: parsing output: 13/ for test: kms_ccs results: parsing output: 14/ for test: kms_joiner results: parsing output: 15/ for test: kms_frontbuffer_tracking results: parsing output: 16/ for test: kms_flip results: parsing output: 17/ for test: gem_exec_reloc results: parsing output: 18/ for test: kms_plane_scaling results: parsing output: 19/ for test: kms_content_protection results: parsing output: 20/ for test: syncobj_timeline results: parsing output: 21/ for test: fbdev results: parsing output: 22/ for test: kms_pipe_crc_basic results: parsing output: 23/ for test: gem_gpgpu_fill results: parsing output: 24/ for test: perf results: parsing output: 25/ for test: kms_legacy_colorkey results: parsing output: 26/ for test: api_intel_bb results: parsing output: 27/ for test: kms_ccs results: parsing output: 28/ for test: kms_pm_rpm results: parsing output: 29/ for test: kms_flip results: parsing output: 30/ for test: gem_media_vme results: parsing output: 31/ for test: syncobj_timeline results: parsing output: 32/ for test: gem_exec_reloc results: parsing output: 33/ for test: vgem_basic results: parsing output: 34/ for test: kms_frontbuffer_tracking results: parsing output: 35/ for test: kms_frontbuffer_tracking results: parsing output: 36/ for test: kms_ccs results: parsing output: 37/ for test: kms_psr2_sf results: parsing output: 38/ for test: gem_pread results: parsing output: 39/ for test: kms_psr results: parsing output: 40/ for test: gem_mmap results: parsing output: 41/ for test: gem_exec_reloc results: parsing output: 42/ for test: kms_frontbuffer_tracking results: parsing output: 43/ for test: kms_flip results: parsing output: 44/ for test: kms_plane results: parsing output: 45/ for test: perf results: parsing output: 46/ for test: kms_async_flips results: parsing output: 47/ for test: syncobj_wait results: parsing output: 48/ for test: syncobj_timeline results: parsing output: 49/ for test: gem_fence_thrash results: parsing output: 50/ for test: kms_frontbuffer_tracking results: parsing output: 51/ for test: gem_create results: parsing output: 52/ for test: gem_exec_store results: parsing output: 53/ for test: kms_frontbuffer_tracking results: parsing output: 54/ for test: gem_exec_fence results: parsing output: 55/ for test: gem_mmap_gtt results: parsing output: 56/ for test: kms_vblank results: parsing output: 57/ for test: perf_pmu results: parsing output: 58/ for test: kms_addfb_basic results: parsing output: 59/ for test: gem_exec_parallel results: parsing output: 60/ for test: gem_tiled_partial_pwrite_pread results: parsing output: 61/ for test: kms_big_fb results: parsing output: 62/ for test: kms_big_fb results: parsing output: 63/ for test: syncobj_wait results: parsing output: 64/ for test: prime_busy results: parsing output: 65/ for test: gem_exec_basic results: parsing output: 66/ for test: gem_userptr_blits results: parsing output: 67/ for test: kms_psr2_sf results: parsing output: 68/ for test: syncobj_timeline results: parsing output: 69/ for test: kms_psr results: parsing output: 70/ for test: kms_cursor_legacy results: parsing output: 71/ for test: kms_frontbuffer_tracking results: parsing output: 72/ for test: i915_fb_tiling results: parsing output: 73/ for test: prime_mmap results: parsing output: 74/ for test: i915_pm_rpm results: parsing output: 75/ for test: kms_frontbuffer_tracking results: parsing output: 76/ for test: gem_ctx_param results: parsing output: 77/ for test: kms_cursor_crc results: parsing output: 78/ for test: kms_atomic results: parsing output: 79/ for test: gem_pipe_control_store_loop results: parsing output: 80/ for test: kms_frontbuffer_tracking results: parsing output: 81/ for test: kms_ccs results: parsing output: 82/ for test: kms_cursor_legacy results: parsing output: 83/ for test: kms_plane results: parsing output: 84/ for test: syncobj_wait results: parsing output: 85/ for test: core_setmaster results: parsing output: 86/ for test: kms_cursor_crc results: parsing output: 87/ for test: kms_color results: parsing output: 88/ for test: kms_chamelium_frames results: parsing output: 89/ for test: kms_selftest results: parsing output: 90/ for test: gem_render_copy results: parsing output: 91/ for test: gem_close_race results: parsing output: 92/ for test: kms_busy results: parsing output: 93/ for test: kms_frontbuffer_tracking results: parsing output: 94/ for test: api_intel_bb results: parsing output: 95/ for test: perf results: parsing output: 96/ for test: kms_big_fb results: parsing output: 97/ for test: kms_big_fb results: parsing output: 98/ for test: kms_psr2_sf results: parsing output: 99/ for test: prime_udl results: parsing output: 100/ for test: i915_suspend results: parsing output: 101/ for test: kms_ccs results: parsing output: 102/ for test: gem_mmap_offset results: parsing output: 103/ for test: gem_mmap results: parsing output: 104/ for test: kms_psr results: parsing output: 105/ for test: kms_frontbuffer_tracking results: parsing output: 106/ for test: gem_exec_parallel results: parsing output: 107/ for test: gem_softpin results: parsing output: 108/ for test: kms_psr results: parsing output: 109/ for test: gem_exec_schedule results: parsing output: 110/ for test: gem_exec_fence results: parsing output: 111/ for test: kms_addfb_basic results: parsing output: 112/ for test: kms_plane results: parsing output: 113/ for test: syncobj_wait results: parsing output: 114/ for test: kms_draw_crc results: parsing output: 115/ for test: kms_color_pipeline results: parsing output: 116/ for test: kms_hdmi_inject results: parsing output: 117/ for test: gen9_exec_parse results: parsing output: 118/ for test: gem_eio results: parsing output: 119/ for test: kms_flip_scaled_crc results: parsing output: 120/ for test: kms_cursor_legacy results: parsing output: 121/ for test: gem_mmap_wc results: parsing output: 122/ for test: kms_force_connector_basic results: parsing output: 123/ for test: gem_ctx_shared results: parsing output: 124/ for test: gem_ctx_persistence results: parsing output: 125/ for test: syncobj_eventfd results: parsing output: 126/ for test: kms_scaling_modes results: parsing output: 127/ for test: i915_drm_fdinfo results: parsing output: 128/ for test: kms_rotation_crc results: parsing output: 129/ for test: kms_big_fb results: parsing output: 130/ for test: gem_softpin results: parsing output: 131/ for test: gem_exec_schedule Done.