[60.660210] Initializing watchdogs
[60.660258]   /dev/watchdog0
[60.675295] [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.679798] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[60.682188] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[60.684568] [001/133] (960s left) kms_pm_rpm (fences)
[62.237724] Starting subtest: fences
[62.240349] Subtest fences: SKIP (0.000s)
[62.994208] [002/133] (958s left) i915_query (query-topology-coherent-slice-mask)
[63.050136] Starting subtest: query-topology-coherent-slice-mask
[63.051989] Subtest query-topology-coherent-slice-mask: SKIP (0.000s)
[63.155976] [003/133] (958s left) kms_ccs (random-ccs-data-y-tiled-gen12-rc-ccs)
[63.234649] Starting subtest: random-ccs-data-y-tiled-gen12-rc-ccs
[63.235828] Starting dynamic subtest: pipe-A-eDP-1
[63.245841] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[63.251796] Starting dynamic subtest: pipe-B-eDP-1
[63.261131] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[63.267281] Starting dynamic subtest: pipe-C-eDP-1
[63.276125] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[63.281411] Starting dynamic subtest: pipe-D-eDP-1
[63.290270] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[63.291936] Subtest random-ccs-data-y-tiled-gen12-rc-ccs: SKIP (0.003s)
[65.538999] [004/133] (955s left) gem_exec_schedule (fairslice)
[65.606608] Starting subtest: fairslice
[65.607738] Starting dynamic subtest: rcs0
[67.633104] Dynamic subtest rcs0: SUCCESS (2.025s)
[67.640941] Starting dynamic subtest: bcs0
[69.654471] Dynamic subtest bcs0: SUCCESS (2.024s)
[69.660961] Starting dynamic subtest: vcs0
[71.677987] Dynamic subtest vcs0: SUCCESS (2.025s)
[71.684056] Starting dynamic subtest: vcs1
[73.698515] Dynamic subtest vcs1: SUCCESS (2.021s)
[73.706693] Starting dynamic subtest: vecs0
[75.718539] Dynamic subtest vecs0: SUCCESS (2.020s)
[75.726819] Starting dynamic subtest: ccs0
[77.737200] Dynamic subtest ccs0: SUCCESS (2.023s)
[77.738146] Subtest fairslice: SUCCESS (12.140s)
[78.028625] [005/133] (943s left) kms_cursor_edge_walk (256x256-right-edge)
[78.110056] Starting subtest: 256x256-right-edge
[78.110947] Starting dynamic subtest: pipe-A-eDP-1
[81.597164] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.485s)
[81.604834] Starting dynamic subtest: pipe-D-eDP-1
[84.716773] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.119s)
[84.717738] Subtest 256x256-right-edge: SUCCESS (6.606s)
[85.520225] [006/133] (935s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-pwrite)
[85.610333] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-pwrite
[92.613153] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-pwrite: SUCCESS (7.004s)
[92.737738] [007/133] (928s left) gem_eio (in-flight-immediate)
[92.952390] Starting subtest: in-flight-immediate
[101.639213] Subtest in-flight-immediate: SUCCESS (8.687s)
[101.797176] [FACT gem_eio (in-flight-immediate)] new: kernel.kmod_is_loaded.vgem: true
[101.798866] [008/133] (919s left) kms_ccs (crc-primary-rotation-180-y-tiled-gen12-rc-ccs-cc)
[101.892264] Starting subtest: crc-primary-rotation-180-y-tiled-gen12-rc-ccs-cc
[101.893196] Starting dynamic subtest: pipe-A-eDP-1
[101.901796] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[101.913531] Starting dynamic subtest: pipe-B-eDP-1
[101.923074] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[101.930587] Starting dynamic subtest: pipe-C-eDP-1
[101.938557] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[101.944674] Starting dynamic subtest: pipe-D-eDP-1
[101.953230] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[101.954838] Subtest crc-primary-rotation-180-y-tiled-gen12-rc-ccs-cc: SKIP (0.004s)
[104.096463] [009/133] (917s left) gem_mmap_gtt (cpuset-medium-copy-xy)
[104.150263] Subtest cpuset-medium-copy-XY: SKIP (0.000s)
[104.202542] [010/133] (917s left) kms_rotation_crc (exhaust-fences)
[104.288430] Starting subtest: exhaust-fences
[104.290293] Subtest exhaust-fences: SKIP (0.000s)
[104.367167] [011/133] (917s left) gem_close (basic)
[104.413602] Starting subtest: basic
[104.414666] Subtest basic: SUCCESS (0.000s)
[104.507869] [012/133] (917s left) kms_chamelium_hpd (common-hpd-after-suspend)
[104.884245] Subtest common-hpd-after-suspend: SKIP (0.000s)
[105.692177] [013/133] (915s left) kms_cursor_legacy (short-flip-before-cursor-toggle)
[105.808662] Starting subtest: short-flip-before-cursor-toggle
[106.729049] Subtest short-flip-before-cursor-toggle: SUCCESS (0.920s)
[107.553217] [014/133] (914s left) core_setmaster_vs_auth
[107.711591] [015/133] (913s left) gem_pwrite (basic-random)
[107.774372] Subtest basic-random: SKIP (0.000s)
[107.836216] [016/133] (913s left) kms_frontbuffer_tracking (fbcpsr-2p-indfb-fliptrack-mmap-gtt)
[107.921137] Starting subtest: fbcpsr-2p-indfb-fliptrack-mmap-gtt
[107.922983] Subtest fbcpsr-2p-indfb-fliptrack-mmap-gtt: SKIP (0.000s)
[108.014225] [017/133] (913s left) kms_pm_rpm (modeset-non-lpsp-stress)
[110.038078] Starting subtest: modeset-non-lpsp-stress
[111.206952] Subtest modeset-non-lpsp-stress: SKIP (1.167s)
[111.582358] [018/133] (910s left) kms_flip (2x-flip-vs-expired-vblank)
[111.662454] Starting subtest: 2x-flip-vs-expired-vblank
[111.673443] Subtest 2x-flip-vs-expired-vblank: SKIP (0.011s)
[111.754570] [019/133] (910s left) kms_color_pipeline (plane-lut1d-ctm3x4-lut1d)
[111.852144] Starting subtest: plane-lut1d-ctm3x4-lut1d
[111.999935] Starting dynamic subtest: pipe-A-plane-0
[112.188827] Dynamic subtest pipe-A-plane-0: SUCCESS (0.189s)
[112.197513] Starting dynamic subtest: pipe-A-plane-1
[112.355289] Dynamic subtest pipe-A-plane-1: SUCCESS (0.166s)
[112.362986] Starting dynamic subtest: pipe-A-plane-2
[112.522063] Dynamic subtest pipe-A-plane-2: SUCCESS (0.166s)
[113.687852] Starting dynamic subtest: pipe-B-plane-0
[113.856143] Dynamic subtest pipe-B-plane-0: SUCCESS (0.178s)
[113.864286] Starting dynamic subtest: pipe-B-plane-1
[114.022945] Dynamic subtest pipe-B-plane-1: SUCCESS (0.166s)
[114.030616] Starting dynamic subtest: pipe-B-plane-2
[114.212376] Dynamic subtest pipe-B-plane-2: SUCCESS (0.188s)
[115.398360] Starting dynamic subtest: pipe-C-plane-0
[115.535262] Dynamic subtest pipe-C-plane-0: SUCCESS (0.144s)
[115.542571] Starting dynamic subtest: pipe-C-plane-1
[115.690910] Dynamic subtest pipe-C-plane-1: SUCCESS (0.155s)
[115.699115] Starting dynamic subtest: pipe-C-plane-2
[115.846125] Dynamic subtest pipe-C-plane-2: SUCCESS (0.155s)
[117.046821] Starting dynamic subtest: pipe-D-plane-0
[117.207047] Dynamic subtest pipe-D-plane-0: SUCCESS (0.167s)
[117.215170] Starting dynamic subtest: pipe-D-plane-1
[117.351234] Dynamic subtest pipe-D-plane-1: SUCCESS (0.144s)
[117.358582] Starting dynamic subtest: pipe-D-plane-2
[117.506845] Dynamic subtest pipe-D-plane-2: SUCCESS (0.155s)
[117.797550] Subtest plane-lut1d-ctm3x4-lut1d: SUCCESS (5.946s)
[118.592452] [020/133] (903s left) gem_spin_batch (spin-all-new)
[118.648600] Starting subtest: spin-all-new
[118.662233] Subtest spin-all-new: SUCCESS (0.013s)
[119.926400] [021/133] (901s left) kms_psr (psr-primary-render)
[120.025379] Starting subtest: psr-primary-render
[120.026295] Starting dynamic subtest: eDP-1
[121.812819] Dynamic subtest eDP-1: SUCCESS (1.788s)
[121.813762] Subtest psr-primary-render: SUCCESS (1.788s)
[122.675096] [022/133] (899s left) kms_plane_cursor (overlay)
[122.760607] Starting subtest: overlay
[122.762604] Starting dynamic subtest: pipe-A-eDP-1-size-64
[125.337927] Dynamic subtest pipe-A-eDP-1-size-64: SUCCESS (2.578s)
[125.397914] Starting dynamic subtest: pipe-A-eDP-1-size-128
[127.960456] Dynamic subtest pipe-A-eDP-1-size-128: SUCCESS (2.572s)
[128.021316] Starting dynamic subtest: pipe-A-eDP-1-size-256
[130.583527] Dynamic subtest pipe-A-eDP-1-size-256: SUCCESS (2.571s)
[130.940967] Starting dynamic subtest: pipe-B-eDP-1-size-64
[134.189273] Dynamic subtest pipe-B-eDP-1-size-64: SUCCESS (3.255s)
[134.248139] Starting dynamic subtest: pipe-B-eDP-1-size-128
[136.801890] Dynamic subtest pipe-B-eDP-1-size-128: SUCCESS (2.561s)
[136.862089] Starting dynamic subtest: pipe-B-eDP-1-size-256
[139.369050] Dynamic subtest pipe-B-eDP-1-size-256: SUCCESS (2.516s)
[139.727586] Starting dynamic subtest: pipe-C-eDP-1-size-64
[142.589384] Dynamic subtest pipe-C-eDP-1-size-64: SUCCESS (2.868s)
[142.627243] Starting dynamic subtest: pipe-C-eDP-1-size-128
[144.800090] Dynamic subtest pipe-C-eDP-1-size-128: SUCCESS (2.181s)
[144.836530] Starting dynamic subtest: pipe-C-eDP-1-size-256
[147.022216] Dynamic subtest pipe-C-eDP-1-size-256: SUCCESS (2.192s)
[147.359438] Starting dynamic subtest: pipe-D-eDP-1-size-64
[150.217638] Dynamic subtest pipe-D-eDP-1-size-64: SUCCESS (2.864s)
[150.254272] Starting dynamic subtest: pipe-D-eDP-1-size-128
[152.406155] Dynamic subtest pipe-D-eDP-1-size-128: SUCCESS (2.158s)
[152.443561] Starting dynamic subtest: pipe-D-eDP-1-size-256
[154.606417] Dynamic subtest pipe-D-eDP-1-size-256: SUCCESS (2.170s)
[154.928434] Subtest overlay: SUCCESS (32.169s)
[155.732862] [023/133] (866s left) gen9_exec_parse (batch-zero-length)
[155.790805] Subtest batch-zero-length: SKIP (0.000s)
[155.860346] [024/133] (866s left) gem_exec_balancer (parallel-contexts)
[156.128825] Starting subtest: parallel-contexts
[159.299354] Subtest parallel-contexts: SUCCESS (3.170s)
[160.098397] [025/133] (861s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-mmap-gtt)
[160.202257] Starting subtest: psr-1p-primscrn-pri-indfb-draw-mmap-gtt
[160.204043] Subtest psr-1p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[160.289437] [026/133] (861s left) gem_mmap_gtt (big-bo-tiledy)
[160.354621] Subtest big-bo-tiledY: SKIP (0.000s)
[160.414573] [027/133] (861s left) gem_wait (write-wait)
[160.483050] Starting subtest: write-wait
[160.484308] Starting dynamic subtest: all-engines
[161.593754] Dynamic subtest all-engines: SUCCESS (1.110s)
[161.605185] Starting dynamic subtest: rcs0
[162.656845] Dynamic subtest rcs0: SUCCESS (1.060s)
[162.674895] Starting dynamic subtest: bcs0
[163.716683] Dynamic subtest bcs0: SUCCESS (1.057s)
[163.734073] Starting dynamic subtest: vcs0
[164.772058] Dynamic subtest vcs0: SUCCESS (1.054s)
[164.789289] Starting dynamic subtest: vcs1
[165.826320] Dynamic subtest vcs1: SUCCESS (1.052s)
[165.843511] Starting dynamic subtest: vecs0
[166.880469] Dynamic subtest vecs0: SUCCESS (1.052s)
[166.897826] Starting dynamic subtest: ccs0
[167.937268] Dynamic subtest ccs0: SUCCESS (1.055s)
[167.940391] Subtest write-wait: SUCCESS (7.456s)
[168.144726] [028/133] (853s left) kms_psr (fbc-psr-sprite-plane-move)
[168.249361] Starting subtest: fbc-psr-sprite-plane-move
[168.250161] Starting dynamic subtest: eDP-1
[168.251722] Dynamic subtest eDP-1: SKIP (0.000s)
[168.253223] Subtest fbc-psr-sprite-plane-move: SKIP (0.001s)
[168.328334] [029/133] (853s left) sysfs_timeslice_duration (invalid)
[168.387603] Starting subtest: invalid
[168.388932] Starting dynamic subtest: vecs0
[168.389913] Dynamic subtest vecs0: SUCCESS (0.000s)
[168.397063] Starting dynamic subtest: ccs0
[168.397962] Dynamic subtest ccs0: SUCCESS (0.000s)
[168.404510] Starting dynamic subtest: vcs0
[168.405384] Dynamic subtest vcs0: SUCCESS (0.000s)
[168.411812] Starting dynamic subtest: bcs0
[168.412713] Dynamic subtest bcs0: SUCCESS (0.000s)
[168.419166] Starting dynamic subtest: rcs0
[168.419990] Dynamic subtest rcs0: SUCCESS (0.000s)
[168.426722] Starting dynamic subtest: vcs1
[168.427590] Dynamic subtest vcs1: SUCCESS (0.000s)
[168.428492] Subtest invalid: SUCCESS (0.006s)
[168.487525] [030/133] (853s left) kms_psr (pr-sprite-plane-onoff)
[168.580369] Starting subtest: pr-sprite-plane-onoff
[168.582087] Subtest pr-sprite-plane-onoff: SKIP (0.000s)
[168.651739] [031/133] (853s left) kms_cursor_crc (cursor-offscreen-256x256)
[168.888993] Starting subtest: cursor-offscreen-256x256
[168.894068] Starting dynamic subtest: pipe-A-eDP-1
[170.839012] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.945s)
[170.866846] Starting dynamic subtest: pipe-D-eDP-1
[173.428031] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.567s)
[173.428931] Subtest cursor-offscreen-256x256: SUCCESS (4.539s)
[174.288943] [032/133] (847s left) gem_ctx_persistence (engines-hostile)
[174.338156] Starting subtest: engines-hostile
[174.338871] Starting dynamic subtest: rcs0
[174.460067] Dynamic subtest rcs0: SUCCESS (0.122s)
[174.472470] Starting dynamic subtest: bcs0
[174.552350] Dynamic subtest bcs0: SUCCESS (0.091s)
[174.565868] Starting dynamic subtest: vcs0
[174.628341] Dynamic subtest vcs0: SUCCESS (0.073s)
[174.638075] Starting dynamic subtest: vcs1
[174.753431] Dynamic subtest vcs1: SUCCESS (0.123s)
[174.764381] Starting dynamic subtest: vecs0
[174.852691] Dynamic subtest vecs0: SUCCESS (0.097s)
[174.864940] Starting dynamic subtest: ccs0
[174.947972] Dynamic subtest ccs0: SUCCESS (0.093s)
[174.949213] Subtest engines-hostile: SUCCESS (0.612s)
[175.021281] [033/133] (847s left) gem_exec_reloc (basic-gtt-read-active)
[175.080543] Subtest basic-gtt-read-active: SKIP (0.000s)
[175.143784] [034/133] (847s left) gem_workarounds (basic-read)
[175.205980] Starting subtest: basic-read
[175.216882] Subtest basic-read: SUCCESS (0.011s)
[175.334982] [035/133] (846s left) syncobj_timeline (invalid-multi-wait-all-unsubmitted-signaled)
[175.377990] Starting subtest: invalid-multi-wait-all-unsubmitted-signaled
[175.379087] Subtest invalid-multi-wait-all-unsubmitted-signaled: SUCCESS (0.001s)
[175.486016] [036/133] (846s left) i915_drm_fdinfo (context-close-stress)
[175.523077] Starting subtest: context-close-stress
[186.276855] Subtest context-close-stress: SUCCESS (10.743s)
[186.338124] [037/133] (836s left) gem_ctx_persistence (legacy-engines-hang)
[186.545244] Starting subtest: legacy-engines-hang
[186.546574] Starting dynamic subtest: render
[186.678896] Dynamic subtest render: SUCCESS (0.137s)
[186.689913] Starting dynamic subtest: bsd1
[186.793527] Dynamic subtest bsd1: SUCCESS (0.112s)
[186.804622] Starting dynamic subtest: bsd2
[186.896484] Dynamic subtest bsd2: SUCCESS (0.100s)
[186.907098] Starting dynamic subtest: blt
[187.018526] Dynamic subtest blt: SUCCESS (0.119s)
[187.029568] Starting dynamic subtest: vebox
[187.116467] Dynamic subtest vebox: SUCCESS (0.095s)
[187.117678] Subtest legacy-engines-hang: SUCCESS (0.577s)
[187.189492] [038/133] (835s left) kms_plane (pixel-format-4-tiled-dg2-rc-ccs-modifier-source-clamping)
[187.284375] Starting subtest: pixel-format-4-tiled-dg2-rc-ccs-modifier-source-clamping
[187.286157] Subtest pixel-format-4-tiled-dg2-rc-ccs-modifier-source-clamping: SKIP (0.000s)
[187.355693] [039/133] (835s left) syncobj_wait (wait-delayed-signal)
[187.405953] Starting subtest: wait-delayed-signal
[187.508725] Subtest wait-delayed-signal: SUCCESS (0.102s)
[187.592368] [040/133] (834s left) gem_exec_schedule (noreorder)
[187.775049] Starting subtest: noreorder
[187.777482] Starting dynamic subtest: rcs0
[187.838482] Dynamic subtest rcs0: SUCCESS (0.063s)
[187.849164] Starting dynamic subtest: vcs0
[188.887716] Dynamic subtest vcs0: SUCCESS (1.038s)
[188.897555] Starting dynamic subtest: vcs1
[190.940648] Dynamic subtest vcs1: SUCCESS (2.051s)
[190.949646] Starting dynamic subtest: vecs0
[192.925481] Dynamic subtest vecs0: SUCCESS (1.983s)
[192.935055] Starting dynamic subtest: ccs0
[192.956062] Dynamic subtest ccs0: SUCCESS (0.037s)
[192.957914] Subtest noreorder: SUCCESS (5.182s)
[193.142953] [041/133] (829s left) gem_exec_schedule (preempt-self)
[193.206299] Starting subtest: preempt-self
[193.207263] Starting dynamic subtest: rcs0
[193.240913] Dynamic subtest rcs0: SUCCESS (0.034s)
[193.250931] Starting dynamic subtest: bcs0
[193.278684] Dynamic subtest bcs0: SUCCESS (0.037s)
[193.287255] Starting dynamic subtest: vcs0
[193.310952] Dynamic subtest vcs0: SUCCESS (0.032s)
[193.318550] Starting dynamic subtest: vcs1
[193.345017] Dynamic subtest vcs1: SUCCESS (0.033s)
[193.362835] Starting dynamic subtest: vecs0
[193.381688] Dynamic subtest vecs0: SUCCESS (0.035s)
[193.389061] Starting dynamic subtest: ccs0
[193.421568] Dynamic subtest ccs0: SUCCESS (0.038s)
[193.422944] Subtest preempt-self: SUCCESS (0.215s)
[194.977361] [042/133] (827s left) kms_flip_scaled_crc (flip-64bpp-xtile-to-32bpp-xtile-downscaling)
[195.078095] Starting subtest: flip-64bpp-xtile-to-32bpp-xtile-downscaling
[195.078929] Starting dynamic subtest: pipe-A-default-mode
[196.247961] Dynamic subtest pipe-A-default-mode: SKIP (1.167s)
[196.250036] Subtest flip-64bpp-xtile-to-32bpp-xtile-downscaling: SKIP (1.169s)
[196.404428] [043/133] (826s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-0-async-flip)
[196.502331] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-0-async-flip
[197.339878] Subtest x-tiled-max-hw-stride-64bpp-rotate-0-async-flip: SUCCESS (0.837s)
[197.504650] [044/133] (825s left) api_intel_bb (delta-check)
[197.552589] Starting subtest: delta-check
[197.557647] Subtest delta-check: SUCCESS (0.006s)
[197.649080] [045/133] (825s left) syncobj_timeline (multi-wait-for-submit-available-unsubmitted-submitted-signa
[197.711040] Starting subtest: multi-wait-for-submit-available-unsubmitted-submitted-signaled
[197.712089] Subtest multi-wait-for-submit-available-unsubmitted-submitted-signaled: SUCCESS (0.000s)
[197.808998] [046/133] (824s left) kms_dp_aux_dev (basic)
[197.859429] Starting subtest: basic
[198.085256] Subtest basic: SUCCESS (0.226s)
[198.155240] [047/133] (824s left) kms_psr (fbc-psr2-primary-blt)
[198.241240] Starting subtest: fbc-psr2-primary-blt
[198.242072] Starting dynamic subtest: eDP-1
[198.243871] Dynamic subtest eDP-1: SKIP (0.000s)
[198.245617] Subtest fbc-psr2-primary-blt: SKIP (0.001s)
[198.313964] [048/133] (824s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-mmap-gtt)
[198.404527] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-mmap-gtt
[198.406449] Subtest fbc-2p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[198.502175] [049/133] (824s left) gem_render_copy (yf-tiled)
[198.561675] Starting subtest: yf-tiled
[198.563442] Subtest yf-tiled: SKIP (0.000s)
[198.739406] [050/133] (824s left) kms_content_protection (dp-mst-type-0)
[198.873897] Starting subtest: dp-mst-type-0
[198.875730] Subtest dp-mst-type-0: SKIP (0.000s)
[198.981751] [051/133] (823s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-mmap-gtt)
[199.068513] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-mmap-gtt
[199.070246] Subtest fbc-1p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[199.154577] [052/133] (823s left) kms_hdr (bpc-switch-dpms)
[199.232549] Starting subtest: bpc-switch-dpms
[200.290475] Starting dynamic subtest: pipe-A-eDP-1
[204.718719] Dynamic subtest pipe-A-eDP-1: SUCCESS (4.430s)
[204.719605] Subtest bpc-switch-dpms: SUCCESS (5.488s)
[204.826782] [053/133] (818s left) gem_request_retire (retire-vma-not-inactive)
[204.880377] Starting subtest: retire-vma-not-inactive
[204.940409] Subtest retire-vma-not-inactive: SUCCESS (0.057s)
[205.068198] [054/133] (817s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-render)
[205.162965] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-render
[205.164637] Subtest psr-2p-scndscrn-pri-shrfb-draw-render: SKIP (0.000s)
[205.250423] [055/133] (817s left) gem_mmap_gtt (basic-write-gtt)
[205.306184] Subtest basic-write-gtt: SKIP (0.000s)
[205.359339] [056/133] (817s left) kms_lease (lease-unleased-connector)
[205.443311] Starting subtest: lease-unleased-connector
[205.444119] Starting dynamic subtest: pipe-A-eDP-1
[205.450385] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.006s)
[205.461859] Starting dynamic subtest: pipe-B-eDP-1
[205.463039] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.006s)
[205.474573] Starting dynamic subtest: pipe-C-eDP-1
[205.475614] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.006s)
[205.483285] Starting dynamic subtest: pipe-D-eDP-1
[205.484096] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.006s)
[205.484980] Subtest lease-unleased-connector: SUCCESS (0.030s)
[205.570525] [057/133] (817s left) syncobj_timeline (etime-multi-wait-all-available-unsubmitted-submitted)
[205.617583] Starting subtest: etime-multi-wait-all-available-unsubmitted-submitted
[205.721315] Subtest etime-multi-wait-all-available-unsubmitted-submitted: SUCCESS (0.103s)
[205.795592] [058/133] (817s left) kms_flip (blocking-wf_vblank)
[205.882028] Starting subtest: blocking-wf_vblank
[205.882914] Starting dynamic subtest: A-eDP1
[214.844969] Dynamic subtest A-eDP1: SUCCESS (8.937s)
[214.853978] Starting dynamic subtest: B-eDP1
[223.782219] Dynamic subtest B-eDP1: SUCCESS (8.934s)
[223.790188] Starting dynamic subtest: C-eDP1
[232.717679] Dynamic subtest C-eDP1: SUCCESS (8.923s)
[232.727589] Starting dynamic subtest: D-eDP1
[241.655515] Dynamic subtest D-eDP1: SUCCESS (8.934s)
[241.656818] Subtest blocking-wf_vblank: SUCCESS (35.743s)
[242.837573] [059/133] (780s left) gem_exec_store (cachelines)
[242.890411] Starting subtest: cachelines
[242.891418] Starting dynamic subtest: rcs0
[242.955510] Dynamic subtest rcs0: SUCCESS (0.064s)
[242.967815] Starting dynamic subtest: bcs0
[243.016606] Dynamic subtest bcs0: SUCCESS (0.059s)
[243.027596] Starting dynamic subtest: vcs0
[243.072555] Dynamic subtest vcs0: SUCCESS (0.054s)
[243.083079] Starting dynamic subtest: vcs1
[243.130644] Dynamic subtest vcs1: SUCCESS (0.056s)
[243.139885] Starting dynamic subtest: vecs0
[243.184544] Dynamic subtest vecs0: SUCCESS (0.052s)
[243.194327] Starting dynamic subtest: ccs0
[243.240808] Dynamic subtest ccs0: SUCCESS (0.054s)
[243.242337] Subtest cachelines: SUCCESS (0.351s)
[243.432882] [060/133] (779s left) perf (invalid-oa-metric-set-id)
[243.561959] Starting subtest: invalid-oa-metric-set-id
[243.573995] Subtest invalid-oa-metric-set-id: SUCCESS (0.012s)
[243.617912] [061/133] (779s left) kms_psr2_sf (fbc-pr-overlay-plane-update-continuous-sf)
[243.702877] Starting subtest: fbc-pr-overlay-plane-update-continuous-sf
[243.704563] Subtest fbc-pr-overlay-plane-update-continuous-sf: SKIP (0.000s)
[243.770027] [062/133] (779s left) kms_async_flips (async-flip-with-page-flip-events-linear-atomic)
[243.854231] Starting subtest: async-flip-with-page-flip-events-linear-atomic
[244.228125] Starting dynamic subtest: pipe-A-eDP-1
[247.016196] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.779s)
[247.374789] Starting dynamic subtest: pipe-B-eDP-1
[250.141785] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.765s)
[250.505224] Starting dynamic subtest: pipe-C-eDP-1
[253.269716] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.761s)
[253.630904] Starting dynamic subtest: pipe-D-eDP-1
[256.397721] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.764s)
[256.398710] Subtest async-flip-with-page-flip-events-linear-atomic: SUCCESS (12.536s)
[257.587473] [063/133] (765s left) kms_big_fb (4-tiled-64bpp-rotate-0)
[257.688766] Starting subtest: 4-tiled-64bpp-rotate-0
[259.246268] Subtest 4-tiled-64bpp-rotate-0: SUCCESS (1.558s)
[259.408754] [064/133] (763s left) prime_busy (before-wait)
[259.461148] Starting subtest: before-wait
[259.464564] Starting dynamic subtest: rcs0
[259.492911] Dynamic subtest rcs0: SUCCESS (0.028s)
[259.502043] Starting dynamic subtest: bcs0
[259.545764] Dynamic subtest bcs0: SUCCESS (0.052s)
[259.554318] Starting dynamic subtest: vcs0
[259.586477] Dynamic subtest vcs0: SUCCESS (0.040s)
[259.593987] Starting dynamic subtest: vcs1
[259.627920] Dynamic subtest vcs1: SUCCESS (0.041s)
[259.635759] Starting dynamic subtest: vecs0
[259.668795] Dynamic subtest vecs0: SUCCESS (0.040s)
[259.676058] Starting dynamic subtest: ccs0
[259.710495] Dynamic subtest ccs0: SUCCESS (0.041s)
[259.818499] Subtest before-wait: SUCCESS (0.356s)
[259.901768] [065/133] (763s left) kms_psr2_sf (psr2-overlay-plane-update-sf-dmg-area)
[259.987970] Starting subtest: psr2-overlay-plane-update-sf-dmg-area
[259.988962] Starting dynamic subtest: pipe-A-eDP-1
[265.870687] Dynamic subtest pipe-A-eDP-1: SUCCESS (5.882s)
[265.878110] Starting dynamic subtest: pipe-B-eDP-1
[272.534581] Dynamic subtest pipe-B-eDP-1: SUCCESS (6.662s)
[272.535585] Subtest psr2-overlay-plane-update-sf-dmg-area: SUCCESS (12.547s)
[273.412378] [066/133] (749s left) kms_atomic (plane-primary-overlay-mutable-zpos)
[273.497223] Starting subtest: plane-primary-overlay-mutable-zpos
[276.958887] Subtest plane-primary-overlay-mutable-zpos: SKIP (3.462s)
[278.142459] [067/133] (745s left) kms_draw_crc (draw-method-mmap-wc)
[278.232498] Starting subtest: draw-method-mmap-wc
[278.233430] Starting dynamic subtest: xrgb8888-untiled
[278.465227] Dynamic subtest xrgb8888-untiled: SUCCESS (0.233s)
[278.473756] Starting dynamic subtest: rgb565-untiled
[278.676500] Dynamic subtest rgb565-untiled: SUCCESS (0.210s)
[278.684969] Starting dynamic subtest: xrgb2101010-untiled
[278.899302] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.221s)
[278.914480] Starting dynamic subtest: xbgr16161616f-untiled
[279.132094] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.230s)
[279.139343] Starting dynamic subtest: xrgb8888-xtiled
[279.254388] Dynamic subtest xrgb8888-xtiled: SUCCESS (0.121s)
[279.261652] Starting dynamic subtest: rgb565-xtiled
[279.387486] Dynamic subtest rgb565-xtiled: SUCCESS (0.133s)
[279.396831] Starting dynamic subtest: xrgb2101010-xtiled
[279.520841] Dynamic subtest xrgb2101010-xtiled: SUCCESS (0.130s)
[279.529342] Starting dynamic subtest: xbgr16161616f-xtiled
[279.654216] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (0.131s)
[279.661292] Starting dynamic subtest: xrgb8888-4tiled
[279.820921] Dynamic subtest xrgb8888-4tiled: SUCCESS (0.166s)
[279.829712] Starting dynamic subtest: rgb565-4tiled
[279.965178] Dynamic subtest rgb565-4tiled: SUCCESS (0.143s)
[279.972423] Starting dynamic subtest: xrgb2101010-4tiled
[280.121056] Dynamic subtest xrgb2101010-4tiled: SUCCESS (0.155s)
[280.128480] Starting dynamic subtest: xbgr16161616f-4tiled
[280.309951] Dynamic subtest xbgr16161616f-4tiled: SUCCESS (0.188s)
[280.312155] Subtest draw-method-mmap-wc: SUCCESS (2.080s)
[280.397118] [068/133] (743s left) perf (blocking-parameterized)
[280.482319] Starting subtest: blocking-parameterized
[300.545846] Subtest blocking-parameterized: SUCCESS (20.017s)
[300.577339] [069/133] (722s left) kms_frontbuffer_tracking (psr-2p-pri-indfb-multidraw)
[300.683733] Starting subtest: psr-2p-pri-indfb-multidraw
[300.685372] Subtest psr-2p-pri-indfb-multidraw: SKIP (0.000s)
[300.784864] [070/133] (722s left) prime_vgem (fence-write-hang)
[300.846335] Subtest fence-write-hang: SKIP (0.000s)
[300.952257] [071/133] (722s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-180-async-flip)
[301.046442] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-180-async-flip
[301.875304] Subtest 4-tiled-max-hw-stride-64bpp-rotate-180-async-flip: SUCCESS (0.829s)
[302.023438] [072/133] (721s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-onoff)
[302.111887] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-onoff
[302.113551] Subtest fbcpsr-2p-scndscrn-cur-indfb-onoff: SKIP (0.000s)
[302.221640] [073/133] (721s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-blt)
[302.304742] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-blt
[306.874550] Subtest fbc-1p-primscrn-pri-shrfb-draw-blt: SUCCESS (4.570s)
[308.056061] [074/133] (715s left) kms_plane (plane-position-covered)
[308.136594] Starting subtest: plane-position-covered
[308.659863] Starting dynamic subtest: pipe-A-plane-1
[309.981448] Dynamic subtest pipe-A-plane-1: SUCCESS (1.321s)
[309.989078] Starting dynamic subtest: pipe-A-plane-2
[311.258973] Dynamic subtest pipe-A-plane-2: SUCCESS (1.276s)
[311.266665] Starting dynamic subtest: pipe-A-plane-3
[312.519707] Dynamic subtest pipe-A-plane-3: SUCCESS (1.260s)
[312.527388] Starting dynamic subtest: pipe-A-plane-4
[313.881222] Dynamic subtest pipe-A-plane-4: SUCCESS (1.361s)
[313.888506] Starting dynamic subtest: pipe-A-plane-5
[313.906308] Dynamic subtest pipe-A-plane-5: SUCCESS (0.024s)
[315.107059] Starting dynamic subtest: pipe-B-plane-1
[316.413796] Dynamic subtest pipe-B-plane-1: SUCCESS (1.315s)
[316.421514] Starting dynamic subtest: pipe-B-plane-2
[317.747773] Dynamic subtest pipe-B-plane-2: SUCCESS (1.333s)
[317.754796] Starting dynamic subtest: pipe-B-plane-3
[319.106579] Dynamic subtest pipe-B-plane-3: SUCCESS (1.357s)
[319.114084] Starting dynamic subtest: pipe-B-plane-4
[320.429729] Dynamic subtest pipe-B-plane-4: SUCCESS (1.322s)
[320.436921] Starting dynamic subtest: pipe-B-plane-5
[320.457489] Dynamic subtest pipe-B-plane-5: SUCCESS (0.027s)
[320.458274] Subtest plane-position-covered: SUCCESS (12.322s)
[321.292834] [075/133] (702s left) kms_cursor_crc (cursor-rapid-movement-128x128)
[321.515422] Starting subtest: cursor-rapid-movement-128x128
[321.518897] Starting dynamic subtest: pipe-A-eDP-1
[322.064118] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.545s)
[322.099355] Starting dynamic subtest: pipe-D-eDP-1
[323.316334] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.223s)
[323.317296] Subtest cursor-rapid-movement-128x128: SUCCESS (1.800s)
[324.166959] [076/133] (699s left) gem_ctx_param (invalid-param-get)
[324.219702] Starting subtest: invalid-param-get
[324.220649] Subtest invalid-param-get: SUCCESS (0.001s)
[324.309722] [077/133] (699s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-pwrite)
[324.401553] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-pwrite
[324.403334] Subtest psr-2p-scndscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[324.496876] [078/133] (699s left) kms_flip (2x-flip-vs-dpms-on-nop)
[324.590334] Starting subtest: 2x-flip-vs-dpms-on-nop
[324.601110] Subtest 2x-flip-vs-dpms-on-nop: SKIP (0.012s)
[324.679288] [079/133] (699s left) gem_ppgtt (blt-vs-render-ctxn)
[324.730139] Starting subtest: blt-vs-render-ctxN
[357.709958] Subtest blt-vs-render-ctxN: SUCCESS (32.970s)
[357.823179] [080/133] (666s left) perf (oa-exponents)
[357.984757] Starting subtest: oa-exponents
[357.985823] Starting dynamic subtest: 0-rcs0
[359.797201] Dynamic subtest 0-rcs0: SUCCESS (1.801s)
[359.807965] Starting dynamic subtest: 1-vecs0
[361.622953] Dynamic subtest 1-vecs0: SUCCESS (1.825s)
[361.624030] Subtest oa-exponents: SUCCESS (3.628s)
[361.666949] [081/133] (662s left) kms_psr2_sf (pr-cursor-plane-move-continuous-sf)
[361.783247] Starting subtest: pr-cursor-plane-move-continuous-sf
[361.784980] Subtest pr-cursor-plane-move-continuous-sf: SKIP (0.000s)
[361.851551] [082/133] (662s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-mmap-wc)
[361.937361] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-mmap-wc
[361.938926] Subtest fbc-2p-primscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[362.048423] [083/133] (661s left) kms_cursor_legacy (long-nonblocking-modeset-vs-cursor-atomic)
[362.160722] Starting subtest: long-nonblocking-modeset-vs-cursor-atomic
[379.669600] Subtest long-nonblocking-modeset-vs-cursor-atomic: SUCCESS (17.509s)
[380.467455] [084/133] (643s left) gem_close_race (multigpu-basic-process)
[380.532258] Starting subtest: multigpu-basic-process
[380.533916] Subtest multigpu-basic-process: SKIP (0.000s)
[380.764478] [085/133] (643s left) perf_pmu (pmu-read)
[380.807611] Starting subtest: pmu-read
[380.810339] Subtest pmu-read: SUCCESS (0.003s)
[380.909831] [086/133] (643s left) syncobj_timeline (invalid-multi-wait-unsubmitted)
[380.961788] Starting subtest: invalid-multi-wait-unsubmitted
[380.962759] Subtest invalid-multi-wait-unsubmitted: SUCCESS (0.000s)
[381.054438] [087/133] (643s left) gem_exec_fence (syncobj-import)
[381.478502] Starting subtest: syncobj-import
[381.481547] Subtest syncobj-import: SUCCESS (0.005s)
[382.962636] [088/133] (641s left) gem_mmap_offset (mmap-unmap)
[383.016848] Starting subtest: mmap-unmap
[383.017841] Starting dynamic subtest: smem0
[409.054207] Dynamic subtest smem0: SUCCESS (25.990s)
[409.055533] Subtest mmap-unmap: SUCCESS (25.992s)
[409.109354] [089/133] (615s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-0)
[409.210209] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-0
[409.212116] Subtest y-tiled-max-hw-stride-64bpp-rotate-0: SKIP (0.000s)
[409.308102] [090/133] (614s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-pwrite)
[409.397439] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-pwrite
[417.291666] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-pwrite: SUCCESS (7.895s)
[417.401639] [091/133] (606s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-indfb-draw-pwrite)
[417.500586] Starting subtest: fbc-1p-offscreen-pri-indfb-draw-pwrite
[422.562581] Subtest fbc-1p-offscreen-pri-indfb-draw-pwrite: SUCCESS (5.062s)
[423.704461] [092/133] (600s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-render)
[423.794397] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-render
[423.796165] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-render: SKIP (0.000s)
[423.881179] [093/133] (600s left) kms_ccs (bad-pixel-format-y-tiled-ccs)
[423.966589] Starting subtest: bad-pixel-format-y-tiled-ccs
[423.973705] Starting dynamic subtest: pipe-A-eDP-1
[423.984601] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[423.999256] Starting dynamic subtest: pipe-B-eDP-1
[424.008565] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[424.021785] Starting dynamic subtest: pipe-C-eDP-1
[424.030845] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[424.038357] Starting dynamic subtest: pipe-D-eDP-1
[424.047243] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[424.049442] Subtest bad-pixel-format-y-tiled-ccs: SKIP (0.005s)
[426.182474] [094/133] (598s left) gem_exec_flush (basic-uc-rw-default)
[426.236441] Starting subtest: basic-uc-rw-default
[431.695763] Subtest basic-uc-rw-default: SUCCESS (5.459s)
[431.879785] [095/133] (592s left) drm_read (short-buffer-block)
[432.023255] Starting subtest: short-buffer-block
[432.024434] Subtest short-buffer-block: SUCCESS (0.000s)
[432.157398] [096/133] (592s left) syncobj_timeline (wait-all-for-submit-snapshot)
[432.211328] Starting subtest: wait-all-for-submit-snapshot
[432.293982] Subtest wait-all-for-submit-snapshot: SUCCESS (0.082s)
[432.365544] [097/133] (592s left) kms_getfb (getfb-handle-not-fb)
[432.442996] Starting subtest: getfb-handle-not-fb
[432.443931] Subtest getfb-handle-not-fb: SUCCESS (0.000s)
[432.531789] [098/133] (591s left) i915_pm_rps (basic-api)
[432.589396] Starting subtest: basic-api
[432.591136] Subtest basic-api: SKIP (0.001s)
[432.677560] [099/133] (591s left) kms_ccs (crc-sprite-planes-basic-4-tiled-mtl-rc-ccs)
[432.773022] Starting subtest: crc-sprite-planes-basic-4-tiled-mtl-rc-ccs
[432.774085] Starting dynamic subtest: pipe-A-eDP-1
[433.322318] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.539s)
[433.330185] Starting dynamic subtest: pipe-B-eDP-1
[434.859541] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.534s)
[434.869165] Starting dynamic subtest: pipe-C-eDP-1
[436.276316] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.415s)
[436.285116] Starting dynamic subtest: pipe-D-eDP-1
[437.597557] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.320s)
[437.598389] Subtest crc-sprite-planes-basic-4-tiled-mtl-rc-ccs: SUCCESS (4.815s)
[438.796120] [100/133] (585s left) sw_sync (sync_random_merge)
[438.827696] Starting subtest: sync_random_merge
[438.876214] Subtest sync_random_merge: SUCCESS (0.048s)
[438.933485] [101/133] (585s left) gem_userptr_blits (map-fixed-invalidate-busy)
[438.990499] Starting subtest: map-fixed-invalidate-busy
[438.992284] Subtest map-fixed-invalidate-busy: SKIP (0.000s)
[439.102588] [102/133] (585s left) kms_sequence (queue-idle)
[439.203342] Starting subtest: queue-idle
[439.204342] Starting dynamic subtest: pipe-A-eDP-1
[441.026939] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.822s)
[441.035237] Starting dynamic subtest: pipe-B-eDP-1
[443.491131] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.464s)
[443.500063] Starting dynamic subtest: pipe-C-eDP-1
[445.982261] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.489s)
[445.990177] Starting dynamic subtest: pipe-D-eDP-1
[448.428359] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.445s)
[448.429239] Subtest queue-idle: SUCCESS (9.226s)
[449.245519] [103/133] (575s left) kms_ccs (ccs-on-another-bo-4-tiled-mtl-mc-ccs)
[449.345374] Starting subtest: ccs-on-another-bo-4-tiled-mtl-mc-ccs
[449.346263] Starting dynamic subtest: pipe-A-eDP-1
[449.368113] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.023s)
[449.376974] Starting dynamic subtest: pipe-B-eDP-1
[449.391997] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.022s)
[449.401034] Starting dynamic subtest: pipe-C-eDP-1
[449.415353] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.022s)
[449.424437] Starting dynamic subtest: pipe-D-eDP-1
[449.438503] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.022s)
[449.439409] Subtest ccs-on-another-bo-4-tiled-mtl-mc-ccs: SUCCESS (0.095s)
[451.599606] [104/133] (573s left) kms_getfb (getfb-handle-closed)
[451.697510] Starting subtest: getfb-handle-closed
[451.698462] Subtest getfb-handle-closed: SUCCESS (0.000s)
[451.827679] [105/133] (572s left) gem_caching (read-writes)
[451.890029] Subtest read-writes: SKIP (0.000s)
[451.963416] [106/133] (572s left) gem_mmap_gtt (basic-small-copy-xy)
[452.022740] Subtest basic-small-copy-XY: SKIP (0.000s)
[452.091384] [107/133] (572s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-mmap-cpu)
[452.198193] Starting subtest: fbc-rgb101010-draw-mmap-cpu
[456.791803] Subtest fbc-rgb101010-draw-mmap-cpu: SUCCESS (4.593s)
[457.901580] [108/133] (566s left) kms_joiner (invalid-modeset-force-big-joiner)
[457.995890] Starting subtest: invalid-modeset-force-big-joiner
[457.997613] Subtest invalid-modeset-force-big-joiner: SKIP (0.000s)
[458.060132] [109/133] (566s left) gem_eio (suspend)
[458.293574] Starting subtest: suspend
[470.635058] Subtest suspend: SUCCESS (12.342s)
[479.808454] [110/133] (554s left) gem_fence_thrash (bo-write-verify-threaded-x)
[479.855503] Starting subtest: bo-write-verify-threaded-x
[479.878106] Subtest bo-write-verify-threaded-x: SKIP (0.021s)
[479.939530] [111/133] (554s left) i915_pm_rps (thresholds)
[479.996671] Starting subtest: thresholds
[479.998419] Subtest thresholds: SKIP (0.001s)
[480.097762] [112/133] (554s left) kms_big_fb (yf-tiled-64bpp-rotate-0)
[480.209361] Starting subtest: yf-tiled-64bpp-rotate-0
[480.211253] Subtest yf-tiled-64bpp-rotate-0: SKIP (0.000s)
[480.306891] [113/133] (553s left) kms_vblank (wait-forked-busy)
[480.397154] Starting subtest: wait-forked-busy
[480.398118] Starting dynamic subtest: pipe-A-eDP-1
[482.285055] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.887s)
[482.295526] Starting dynamic subtest: pipe-D-eDP-1
[484.858683] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.571s)
[484.859416] Subtest wait-forked-busy: SUCCESS (4.462s)
[485.672263] [114/133] (548s left) gem_exec_balancer (nop)
[485.728071] Starting subtest: nop
[532.566751] Subtest nop: SUCCESS (46.837s)
[532.888532] [115/133] (501s left) i915_pm_freq_api (freq-basic-api)
[532.955761] Starting subtest: freq-basic-api
[532.956793] Starting dynamic subtest: gt0
[532.959929] Dynamic subtest gt0: SUCCESS (0.006s)
[532.969642] Starting dynamic subtest: gt1
[532.970629] Dynamic subtest gt1: SUCCESS (0.003s)
[532.971494] Subtest freq-basic-api: SUCCESS (0.010s)
[533.053987] [116/133] (501s left) gem_basic (multigpu-create-close)
[533.101026] Starting subtest: multigpu-create-close
[533.103370] Subtest multigpu-create-close: SKIP (0.000s)
[533.190782] [117/133] (501s left) kms_psr (psr2-cursor-render)
[533.283061] Starting subtest: psr2-cursor-render
[533.283809] Starting dynamic subtest: eDP-1
[534.946345] Dynamic subtest eDP-1: SUCCESS (1.663s)
[534.947283] Subtest psr2-cursor-render: SUCCESS (1.664s)
[535.751462] [118/133] (498s left) kms_frontbuffer_tracking (psr-2p-primscrn-indfb-plflip-blt)
[535.848451] Starting subtest: psr-2p-primscrn-indfb-plflip-blt
[535.849956] Subtest psr-2p-primscrn-indfb-plflip-blt: SKIP (0.000s)
[535.940304] [119/133] (498s left) kms_chamelium_frames (hdmi-crc-multiple)
[536.312620] Subtest hdmi-crc-multiple: SKIP (0.000s)
[537.139842] [120/133] (497s left) gem_ctx_shared (q-in-order)
[537.202580] Starting subtest: Q-in-order
[537.203581] Starting dynamic subtest: rcs0
[537.307512] Dynamic subtest rcs0: SUCCESS (0.104s)
[537.325553] Starting dynamic subtest: vcs0
[537.389496] Dynamic subtest vcs0: SUCCESS (0.081s)
[537.407268] Starting dynamic subtest: vcs1
[537.469951] Dynamic subtest vcs1: SUCCESS (0.079s)
[537.486418] Starting dynamic subtest: vecs0
[537.548035] Dynamic subtest vecs0: SUCCESS (0.077s)
[537.564848] Starting dynamic subtest: ccs0
[537.642420] Dynamic subtest ccs0: SUCCESS (0.094s)
[537.643831] Subtest Q-in-order: SUCCESS (0.440s)
[538.992294] [121/133] (495s left) drm_buddy (drm_buddy)
[539.025621] Starting subtest: drm_buddy
[539.027485] Subtest drm_buddy: SKIP (0.001s)
[539.107501] [122/133] (495s left) kms_pipe_stress (stress-xrgb8888-4tiled)
[539.187151] Starting subtest: stress-xrgb8888-4tiled
[545.166533] Subtest stress-xrgb8888-4tiled: SUCCESS (5.979s)
[545.216210] [123/133] (489s left) kms_frontbuffer_tracking (psr-suspend)
[545.312491] Starting subtest: psr-suspend
[584.393221] Subtest psr-suspend: SUCCESS (8.682s)
[590.537908] [124/133] (450s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-fullscreen)
[590.631011] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-fullscreen
[590.632753] Subtest fbcpsr-2p-scndscrn-spr-indfb-fullscreen: SKIP (0.000s)
[590.746132] [125/133] (449s left) gem_fence_thrash (bo-write-verify-none)
[590.780565] Starting subtest: bo-write-verify-none
[590.794197] Subtest bo-write-verify-none: SKIP (0.013s)
[590.852146] [126/133] (449s left) kms_big_fb (linear-max-hw-stride-32bpp-rotate-0-hflip)
[590.945800] Starting subtest: linear-max-hw-stride-32bpp-rotate-0-hflip
[590.947750] Subtest linear-max-hw-stride-32bpp-rotate-0-hflip: SKIP (0.000s)
[591.035028] [127/133] (449s left) perf (disabled-read-error)
[591.119554] Starting subtest: disabled-read-error
[591.130592] Subtest disabled-read-error: SUCCESS (0.011s)
[591.171578] [128/133] (449s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-0)
[591.261808] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-0
[591.263693] Subtest y-tiled-max-hw-stride-32bpp-rotate-0: SKIP (0.000s)
[591.346607] [129/133] (449s left) gem_huc_copy (huc-copy)
[591.402326] Starting subtest: huc-copy
[591.406023] Subtest huc-copy: SUCCESS (0.004s)
[591.520040] [130/133] (449s left) gem_userptr_blits (relocations)
[591.564800] Starting subtest: relocations
[591.566507] Subtest relocations: SKIP (0.001s)
[591.682315] [131/133] (449s left) kms_plane_scaling (plane-upscale-20x20-with-pixel-format)
[591.765025] Starting subtest: plane-upscale-20x20-with-pixel-format
[591.765764] Starting dynamic subtest: pipe-A
[592.789973] Dynamic subtest pipe-A: SUCCESS (1.050s)
[592.799033] Starting dynamic subtest: pipe-B
[594.908112] Dynamic subtest pipe-B: SUCCESS (2.159s)
[594.918273] Starting dynamic subtest: pipe-C
[596.073993] Dynamic subtest pipe-C: SUCCESS (1.182s)
[596.084271] Starting dynamic subtest: pipe-D
[597.287440] Dynamic subtest pipe-D: SUCCESS (1.228s)
[597.288336] Subtest plane-upscale-20x20-with-pixel-format: SUCCESS (5.623s)
[598.466480] [132/133] (442s left) gem_render_copy (y-tiled-to-vebox-linear)
[598.539516] Starting subtest: y-tiled-to-vebox-linear
[598.541864] Subtest y-tiled-to-vebox-linear: SKIP (0.000s)
[598.720741] [133/133] (442s left) syncobj_wait (single-wait-for-submit-unsubmitted)
[598.784235] Starting subtest: single-wait-for-submit-unsubmitted
[598.888361] Subtest single-wait-for-submit-unsubmitted: SUCCESS (0.104s)
[598.960473] Closing watchdogs
results: parsing output: 0/ for test: kms_pm_rpm
results: parsing output: 1/ for test: i915_query
results: parsing output: 2/ for test: kms_ccs
results: parsing output: 3/ for test: gem_exec_schedule
results: parsing output: 4/ for test: kms_cursor_edge_walk
results: parsing output: 5/ for test: kms_frontbuffer_tracking
results: parsing output: 6/ for test: gem_eio
results: parsing output: 7/ for test: kms_ccs
results: parsing output: 8/ for test: gem_mmap_gtt
results: parsing output: 9/ for test: kms_rotation_crc
results: parsing output: 10/ for test: gem_close
results: parsing output: 11/ for test: kms_chamelium_hpd
results: parsing output: 12/ for test: kms_cursor_legacy
results: parsing output: 13/ for test: core_setmaster_vs_auth
results: parsing output: 14/ for test: gem_pwrite
results: parsing output: 15/ for test: kms_frontbuffer_tracking
results: parsing output: 16/ for test: kms_pm_rpm
results: parsing output: 17/ for test: kms_flip
results: parsing output: 18/ for test: kms_color_pipeline
results: parsing output: 19/ for test: gem_spin_batch
results: parsing output: 20/ for test: kms_psr
results: parsing output: 21/ for test: kms_plane_cursor
results: parsing output: 22/ for test: gen9_exec_parse
results: parsing output: 23/ for test: gem_exec_balancer
results: parsing output: 24/ for test: kms_frontbuffer_tracking
results: parsing output: 25/ for test: gem_mmap_gtt
results: parsing output: 26/ for test: gem_wait
results: parsing output: 27/ for test: kms_psr
results: parsing output: 28/ for test: sysfs_timeslice_duration
results: parsing output: 29/ for test: kms_psr
results: parsing output: 30/ for test: kms_cursor_crc
results: parsing output: 31/ for test: gem_ctx_persistence
results: parsing output: 32/ for test: gem_exec_reloc
results: parsing output: 33/ for test: gem_workarounds
results: parsing output: 34/ for test: syncobj_timeline
results: parsing output: 35/ for test: i915_drm_fdinfo
results: parsing output: 36/ for test: gem_ctx_persistence
results: parsing output: 37/ for test: kms_plane
results: parsing output: 38/ for test: syncobj_wait
results: parsing output: 39/ for test: gem_exec_schedule
results: parsing output: 40/ for test: gem_exec_schedule
results: parsing output: 41/ for test: kms_flip_scaled_crc
results: parsing output: 42/ for test: kms_big_fb
results: parsing output: 43/ for test: api_intel_bb
results: parsing output: 44/ for test: syncobj_timeline
results: parsing output: 45/ for test: kms_dp_aux_dev
results: parsing output: 46/ for test: kms_psr
results: parsing output: 47/ for test: kms_frontbuffer_tracking
results: parsing output: 48/ for test: gem_render_copy
results: parsing output: 49/ for test: kms_content_protection
results: parsing output: 50/ for test: kms_frontbuffer_tracking
results: parsing output: 51/ for test: kms_hdr
results: parsing output: 52/ for test: gem_request_retire
results: parsing output: 53/ for test: kms_frontbuffer_tracking
results: parsing output: 54/ for test: gem_mmap_gtt
results: parsing output: 55/ for test: kms_lease
results: parsing output: 56/ for test: syncobj_timeline
results: parsing output: 57/ for test: kms_flip
results: parsing output: 58/ for test: gem_exec_store
results: parsing output: 59/ for test: perf
results: parsing output: 60/ for test: kms_psr2_sf
results: parsing output: 61/ for test: kms_async_flips
results: parsing output: 62/ for test: kms_big_fb
results: parsing output: 63/ for test: prime_busy
results: parsing output: 64/ for test: kms_psr2_sf
results: parsing output: 65/ for test: kms_atomic
results: parsing output: 66/ for test: kms_draw_crc
results: parsing output: 67/ for test: perf
results: parsing output: 68/ for test: kms_frontbuffer_tracking
results: parsing output: 69/ for test: prime_vgem
results: parsing output: 70/ for test: kms_big_fb
results: parsing output: 71/ for test: kms_frontbuffer_tracking
results: parsing output: 72/ for test: kms_frontbuffer_tracking
results: parsing output: 73/ for test: kms_plane
results: parsing output: 74/ for test: kms_cursor_crc
results: parsing output: 75/ for test: gem_ctx_param
results: parsing output: 76/ for test: kms_frontbuffer_tracking
results: parsing output: 77/ for test: kms_flip
results: parsing output: 78/ for test: gem_ppgtt
results: parsing output: 79/ for test: perf
results: parsing output: 80/ for test: kms_psr2_sf
results: parsing output: 81/ for test: kms_frontbuffer_tracking
results: parsing output: 82/ for test: kms_cursor_legacy
results: parsing output: 83/ for test: gem_close_race
results: parsing output: 84/ for test: perf_pmu
results: parsing output: 85/ for test: syncobj_timeline
results: parsing output: 86/ for test: gem_exec_fence
results: parsing output: 87/ for test: gem_mmap_offset
results: parsing output: 88/ for test: kms_big_fb
results: parsing output: 89/ for test: kms_frontbuffer_tracking
results: parsing output: 90/ for test: kms_frontbuffer_tracking
results: parsing output: 91/ for test: kms_frontbuffer_tracking
results: parsing output: 92/ for test: kms_ccs
results: parsing output: 93/ for test: gem_exec_flush
results: parsing output: 94/ for test: drm_read
results: parsing output: 95/ for test: syncobj_timeline
results: parsing output: 96/ for test: kms_getfb
results: parsing output: 97/ for test: i915_pm_rps
results: parsing output: 98/ for test: kms_ccs
results: parsing output: 99/ for test: sw_sync
results: parsing output: 100/ for test: gem_userptr_blits
results: parsing output: 101/ for test: kms_sequence
results: parsing output: 102/ for test: kms_ccs
results: parsing output: 103/ for test: kms_getfb
results: parsing output: 104/ for test: gem_caching
results: parsing output: 105/ for test: gem_mmap_gtt
results: parsing output: 106/ for test: kms_frontbuffer_tracking
results: parsing output: 107/ for test: kms_joiner
results: parsing output: 108/ for test: gem_eio
results: parsing output: 109/ for test: gem_fence_thrash
results: parsing output: 110/ for test: i915_pm_rps
results: parsing output: 111/ for test: kms_big_fb
results: parsing output: 112/ for test: kms_vblank
results: parsing output: 113/ for test: gem_exec_balancer
results: parsing output: 114/ for test: i915_pm_freq_api
results: parsing output: 115/ for test: gem_basic
results: parsing output: 116/ for test: kms_psr
results: parsing output: 117/ for test: kms_frontbuffer_tracking
results: parsing output: 118/ for test: kms_chamelium_frames
results: parsing output: 119/ for test: gem_ctx_shared
results: parsing output: 120/ for test: drm_buddy
results: parsing output: 121/ for test: kms_pipe_stress
results: parsing output: 122/ for test: kms_frontbuffer_tracking
results: parsing output: 123/ for test: kms_frontbuffer_tracking
results: parsing output: 124/ for test: gem_fence_thrash
results: parsing output: 125/ for test: kms_big_fb
results: parsing output: 126/ for test: perf
results: parsing output: 127/ for test: kms_big_fb
results: parsing output: 128/ for test: gem_huc_copy
results: parsing output: 129/ for test: gem_userptr_blits
results: parsing output: 130/ for test: kms_plane_scaling
results: parsing output: 131/ for test: gem_render_copy
results: parsing output: 132/ for test: syncobj_wait
Done.