[58.777034] Initializing watchdogs
[58.777079]   /dev/watchdog0
[58.791566] [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]
[58.796468] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[58.799998] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[58.803638] [001/133] (960s left) gem_exec_whisper (basic-queues-forked)
[58.884568] Starting subtest: basic-queues-forked
[82.249598] Subtest basic-queues-forked: SUCCESS (23.360s)
[82.439482] [002/133] (936s left) i915_getparams_basic (basic-eu-total)
[82.494074] Starting subtest: basic-eu-total
[82.498522] Subtest basic-eu-total: SUCCESS (0.000s)
[82.575700] [003/133] (936s left) gem_exec_balancer (parallel-keep-in-fence)
[82.823077] Starting subtest: parallel-keep-in-fence
[83.962474] Subtest parallel-keep-in-fence: SUCCESS (1.139s)
[84.060588] [004/133] (935s left) kms_frontbuffer_tracking (psr-slowdraw)
[84.165122] Starting subtest: psr-slowdraw
[109.343231] Subtest psr-slowdraw: SUCCESS (25.180s)
[109.456311] [005/133] (909s left) kms_big_fb (y-tiled-addfb-size-offset-overflow)
[109.562071] Starting subtest: y-tiled-addfb-size-offset-overflow
[109.566396] Subtest y-tiled-addfb-size-offset-overflow: SKIP (0.000s)
[109.655109] [006/133] (909s left) gem_ctx_persistence (engines-hostile)
[109.721756] Starting subtest: engines-hostile
[109.724284] Starting dynamic subtest: rcs0
[109.837771] Dynamic subtest rcs0: SUCCESS (0.115s)
[109.849781] Starting dynamic subtest: bcs0
[109.860393] Dynamic subtest bcs0: SUCCESS (0.022s)
[109.868191] Starting dynamic subtest: vcs0
[109.972762] Dynamic subtest vcs0: SUCCESS (0.112s)
[109.982334] Starting dynamic subtest: vcs1
[110.067058] Dynamic subtest vcs1: SUCCESS (0.093s)
[110.076671] Starting dynamic subtest: vecs0
[110.164554] Dynamic subtest vecs0: SUCCESS (0.097s)
[110.173190] Starting dynamic subtest: ccs0
[110.254278] Dynamic subtest ccs0: SUCCESS (0.089s)
[110.256365] Subtest engines-hostile: SUCCESS (0.533s)
[110.329756] [007/133] (909s left) kms_color (deep-color)
[110.412893] Starting subtest: deep-color
[111.507988] Starting dynamic subtest: pipe-A-eDP-1-gamma
[112.246511] Dynamic subtest pipe-A-eDP-1-gamma: SUCCESS (0.737s)
[112.255936] Starting dynamic subtest: pipe-A-eDP-1-degamma
[113.710476] Dynamic subtest pipe-A-eDP-1-degamma: SUCCESS (1.464s)
[113.720182] Starting dynamic subtest: pipe-A-eDP-1-ctm
[115.133562] Dynamic subtest pipe-A-eDP-1-ctm: SUCCESS (1.421s)
[115.912060] Starting dynamic subtest: pipe-B-eDP-1-gamma
[116.636481] Dynamic subtest pipe-B-eDP-1-gamma: SUCCESS (0.730s)
[116.648296] Starting dynamic subtest: pipe-B-eDP-1-degamma
[118.111721] Dynamic subtest pipe-B-eDP-1-degamma: SUCCESS (1.474s)
[118.120680] Starting dynamic subtest: pipe-B-eDP-1-ctm
[119.535657] Dynamic subtest pipe-B-eDP-1-ctm: SUCCESS (1.424s)
[120.306570] Starting dynamic subtest: pipe-C-eDP-1-gamma
[120.993730] Dynamic subtest pipe-C-eDP-1-gamma: SUCCESS (0.692s)
[121.002856] Starting dynamic subtest: pipe-C-eDP-1-degamma
[122.372810] Dynamic subtest pipe-C-eDP-1-degamma: SUCCESS (1.378s)
[122.382234] Starting dynamic subtest: pipe-C-eDP-1-ctm
[123.797278] Dynamic subtest pipe-C-eDP-1-ctm: SUCCESS (1.426s)
[124.604007] Starting dynamic subtest: pipe-D-eDP-1-gamma
[125.319956] Dynamic subtest pipe-D-eDP-1-gamma: SUCCESS (0.721s)
[125.328463] Starting dynamic subtest: pipe-D-eDP-1-degamma
[126.767508] Dynamic subtest pipe-D-eDP-1-degamma: SUCCESS (1.448s)
[126.776647] Starting dynamic subtest: pipe-D-eDP-1-ctm
[128.186289] Dynamic subtest pipe-D-eDP-1-ctm: SUCCESS (1.417s)
[128.188645] Subtest deep-color: SUCCESS (17.772s)
[129.036099] [008/133] (890s left) gem_pxp (create-regular-context-1)
[129.165335] Starting subtest: create-regular-context-1
[129.168042] Subtest create-regular-context-1: SUCCESS (0.002s)
[129.268708] [009/133] (890s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-pwrite)
[129.364763] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-pwrite
[133.700579] Subtest fbc-1p-primscrn-cur-indfb-draw-pwrite: SUCCESS (4.340s)
[134.880580] [010/133] (884s left) device_reset (unbind-cold-reset-rebind)
[134.931955] Starting subtest: unbind-cold-reset-rebind
[134.936477] Subtest unbind-cold-reset-rebind: SKIP (0.000s)
[135.002666] [011/133] (884s left) gem_blits (basic)
[135.067459] Starting subtest: basic
[136.469091] Subtest basic: SUCCESS (1.400s)
[136.590871] [012/133] (883s left) gem_exec_schedule (preempt-queue-chain)
[136.662799] Subtest preempt-queue-chain: SKIP (0.000s)
[136.946230] [013/133] (882s left) gem_exec_reloc (basic-gtt-cpu)
[137.018084] Subtest basic-gtt-cpu: SKIP (0.000s)
[137.094609] [014/133] (882s left) kms_ccs (missing-ccs-buffer-y-tiled-gen12-rc-ccs-cc)
[137.198049] Starting subtest: missing-ccs-buffer-y-tiled-gen12-rc-ccs-cc
[137.200249] Starting dynamic subtest: pipe-A-eDP-1
[137.222024] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[137.232101] Starting dynamic subtest: pipe-B-eDP-1
[137.253168] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[137.260634] Starting dynamic subtest: pipe-C-eDP-1
[137.281914] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[137.291617] Starting dynamic subtest: pipe-D-eDP-1
[137.312485] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[137.316665] Subtest missing-ccs-buffer-y-tiled-gen12-rc-ccs-cc: SKIP (0.003s)
[139.543403] [015/133] (880s left) kms_prop_blob (invalid-set-prop-any)
[139.605041] Starting subtest: invalid-set-prop-any
[139.607562] Subtest invalid-set-prop-any: SUCCESS (0.000s)
[139.703542] [016/133] (880s left) gem_exec_schedule (preempt-queue-contexts-chain)
[139.780571] Subtest preempt-queue-contexts-chain: SKIP (0.000s)
[140.066254] [017/133] (879s left) kms_fbcon_fbt (fbc)
[140.125770] Starting subtest: fbc
[146.481321] Subtest fbc: SUCCESS (6.356s)
[147.646781] [018/133] (872s left) kms_draw_crc (draw-method-mmap-cpu)
[147.736151] Starting subtest: draw-method-mmap-cpu
[147.738109] Starting dynamic subtest: xrgb8888-untiled
[147.979726] Dynamic subtest xrgb8888-untiled: SUCCESS (0.244s)
[147.989261] Starting dynamic subtest: rgb565-untiled
[148.267974] Dynamic subtest rgb565-untiled: SUCCESS (0.288s)
[148.276899] Starting dynamic subtest: xrgb2101010-untiled
[148.490247] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.221s)
[148.498733] Starting dynamic subtest: xbgr16161616f-untiled
[148.722936] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.233s)
[148.731088] Starting dynamic subtest: xrgb8888-xtiled
[148.867573] Dynamic subtest xrgb8888-xtiled: SUCCESS (0.144s)
[148.876384] Starting dynamic subtest: rgb565-xtiled
[149.001024] Dynamic subtest rgb565-xtiled: SUCCESS (0.133s)
[149.008726] Starting dynamic subtest: xrgb2101010-xtiled
[149.123128] Dynamic subtest xrgb2101010-xtiled: SUCCESS (0.121s)
[149.131717] Starting dynamic subtest: xbgr16161616f-xtiled
[149.257072] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (0.133s)
[149.265110] Starting dynamic subtest: xrgb8888-4tiled
[149.412033] Dynamic subtest xrgb8888-4tiled: SUCCESS (0.154s)
[149.420693] Starting dynamic subtest: rgb565-4tiled
[149.556356] Dynamic subtest rgb565-4tiled: SUCCESS (0.143s)
[149.564731] Starting dynamic subtest: xrgb2101010-4tiled
[149.689790] Dynamic subtest xrgb2101010-4tiled: SUCCESS (0.132s)
[149.697667] Starting dynamic subtest: xbgr16161616f-4tiled
[149.834151] Dynamic subtest xbgr16161616f-4tiled: SUCCESS (0.144s)
[149.836066] Subtest draw-method-mmap-cpu: SUCCESS (2.100s)
[149.923589] [019/133] (870s left) gem_fence_thrash (bo-write-verify-none)
[149.957218] Starting subtest: bo-write-verify-none
[149.978329] Subtest bo-write-verify-none: SKIP (0.019s)
[150.043275] [020/133] (870s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-shrfb-msflip-blt)
[150.151149] Starting subtest: fbcpsr-2p-scndscrn-shrfb-msflip-blt
[150.154605] Subtest fbcpsr-2p-scndscrn-shrfb-msflip-blt: SKIP (0.000s)
[150.240866] [021/133] (869s left) kms_flip (2x-modeset-vs-vblank-race-interruptible)
[150.326405] Starting subtest: 2x-modeset-vs-vblank-race-interruptible
[150.337714] Subtest 2x-modeset-vs-vblank-race-interruptible: SKIP (0.011s)
[150.410033] [022/133] (869s left) kms_frontbuffer_tracking (fbc-rgb565-draw-mmap-wc)
[150.503237] Starting subtest: fbc-rgb565-draw-mmap-wc
[154.469639] Subtest fbc-rgb565-draw-mmap-wc: SUCCESS (3.968s)
[155.652081] [023/133] (864s left) sysfs_heartbeat_interval (mixed)
[155.722628] Starting subtest: mixed
[155.725084] Starting dynamic subtest: vecs0
[160.923526] Dynamic subtest vecs0: SUCCESS (5.200s)
[160.934775] Starting dynamic subtest: ccs0
[166.100549] Dynamic subtest ccs0: SUCCESS (5.175s)
[166.111055] Starting dynamic subtest: vcs0
[171.316036] Dynamic subtest vcs0: SUCCESS (5.214s)
[171.326715] Starting dynamic subtest: bcs0
[176.513783] Dynamic subtest bcs0: SUCCESS (5.196s)
[176.524427] Starting dynamic subtest: rcs0
[181.665921] Dynamic subtest rcs0: SUCCESS (5.151s)
[181.675219] Starting dynamic subtest: vcs1
[186.870393] Dynamic subtest vcs1: SUCCESS (5.203s)
[186.873065] Subtest mixed: SUCCESS (31.147s)
[186.946707] [024/133] (833s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-blt)
[187.039292] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-blt
[187.043411] Subtest psr-2p-primscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[187.174620] [025/133] (833s left) i915_pm_freq_mult (media-freq)
[187.232363] Starting subtest: media-freq
[187.234824] Starting dynamic subtest: gt0
[187.239434] Dynamic subtest gt0: SKIP (0.000s)
[187.250600] Starting dynamic subtest: gt1
[187.255074] Dynamic subtest gt1: SKIP (0.000s)
[187.259514] Subtest media-freq: SKIP (0.001s)
[187.323800] [026/133] (832s left) kms_vblank (query-idle-hang)
[187.417055] Starting subtest: query-idle-hang
[187.419238] Starting dynamic subtest: pipe-A-eDP-1
[194.230184] Dynamic subtest pipe-A-eDP-1: SUCCESS (6.812s)
[194.243425] Starting dynamic subtest: pipe-D-eDP-1
[201.262823] Dynamic subtest pipe-D-eDP-1: SUCCESS (7.032s)
[201.265220] Subtest query-idle-hang: SUCCESS (13.848s)
[202.124759] [027/133] (818s left) api_intel_allocator (reloc-allocator)
[202.186246] Starting subtest: reloc-allocator
[202.188531] Starting dynamic subtest: basic
[202.190761] Dynamic subtest basic: SUCCESS (0.003s)
[202.200263] Starting dynamic subtest: parallel-one
[202.202125] Dynamic subtest parallel-one: SUCCESS (0.009s)
[202.210280] Starting dynamic subtest: print
[202.212505] Dynamic subtest print: SUCCESS (0.000s)
[202.220357] Starting dynamic subtest: reuse
[202.222604] Dynamic subtest reuse: SUCCESS (0.000s)
[202.230305] Starting dynamic subtest: fork-reopen-allocator
[202.232525] Dynamic subtest fork-reopen-allocator: SUCCESS (0.012s)
[202.234748] Subtest reloc-allocator: SUCCESS (0.027s)
[202.336546] [028/133] (818s left) kms_ccs (crc-primary-rotation-180-4-tiled-mtl-rc-ccs-cc)
[202.427258] Starting subtest: crc-primary-rotation-180-4-tiled-mtl-rc-ccs-cc
[202.429602] Starting dynamic subtest: pipe-A-eDP-1
[203.340167] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.908s)
[203.349355] Starting dynamic subtest: pipe-B-eDP-1
[204.981078] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.639s)
[204.989170] Starting dynamic subtest: pipe-C-eDP-1
[206.459470] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.476s)
[206.468802] Starting dynamic subtest: pipe-D-eDP-1
[208.049694] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.588s)
[208.051630] Subtest crc-primary-rotation-180-4-tiled-mtl-rc-ccs-cc: SUCCESS (5.616s)
[209.261322] [029/133] (811s left) syncobj_timeline (multi-wait-all-for-submit-available-submitted-signaled)
[209.325552] Starting subtest: multi-wait-all-for-submit-available-submitted-signaled
[209.327935] Subtest multi-wait-all-for-submit-available-submitted-signaled: SUCCESS (0.002s)
[209.433389] [030/133] (811s left) kms_plane (pixel-format-y-tiled-gen12-rc-ccs-modifier-source-clamping)
[209.523187] Starting subtest: pixel-format-y-tiled-gen12-rc-ccs-modifier-source-clamping
[209.527619] Subtest pixel-format-y-tiled-gen12-rc-ccs-modifier-source-clamping: SKIP (0.000s)
[209.595070] [031/133] (810s left) gem_exec_whisper (basic-contexts-forked-all)
[209.659695] Starting subtest: basic-contexts-forked-all
[229.836251] Subtest basic-contexts-forked-all: SUCCESS (20.172s)
[230.026835] [032/133] (790s left) syncobj_timeline (multi-wait-all-for-submit-available-signaled)
[230.077181] Starting subtest: multi-wait-all-for-submit-available-signaled
[230.079424] Subtest multi-wait-all-for-submit-available-signaled: SUCCESS (0.000s)
[230.170879] [033/133] (790s left) kms_psr (fbc-psr2-suspend)
[230.256813] Starting subtest: fbc-psr2-suspend
[230.259158] Starting dynamic subtest: eDP-1
[230.263340] Dynamic subtest eDP-1: SKIP (0.000s)
[230.267561] Subtest fbc-psr2-suspend: SKIP (0.001s)
[230.331807] [034/133] (790s left) kms_psr (fbc-pr-primary-page-flip)
[230.415501] Starting subtest: fbc-pr-primary-page-flip
[230.419858] Subtest fbc-pr-primary-page-flip: SKIP (0.000s)
[230.485818] [035/133] (790s left) kms_pipe_crc_basic (read-crc)
[230.569773] Starting subtest: read-crc
[230.572102] Starting dynamic subtest: pipe-A-eDP-1
[231.287501] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.717s)
[231.295970] Starting dynamic subtest: pipe-B-eDP-1
[232.633645] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.342s)
[232.642153] Starting dynamic subtest: pipe-C-eDP-1
[233.933880] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.301s)
[233.942835] Starting dynamic subtest: pipe-D-eDP-1
[235.266716] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.329s)
[235.269062] Subtest read-crc: SUCCESS (4.696s)
[236.151434] [036/133] (784s left) gem_userptr_blits (vma-merge)
[236.233991] Starting subtest: vma-merge
[236.274336] Subtest vma-merge: SUCCESS (0.040s)
[236.415907] [037/133] (784s left) gem_softpin (evict-single-offset)
[236.474649] Starting subtest: evict-single-offset
[265.877033] Subtest evict-single-offset: SUCCESS (29.399s)
[265.980219] [038/133] (754s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-mmap-cpu)
[266.122034] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-mmap-cpu
[272.691327] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-mmap-cpu: SUCCESS (6.572s)
[272.814827] [039/133] (748s left) perf (per-context-mode-unprivileged)
[272.961203] Starting subtest: per-context-mode-unprivileged
[272.965309] Subtest per-context-mode-unprivileged: SKIP (0.000s)
[273.019277] [040/133] (747s left) kms_chamelium_audio (dp-audio-edid)
[273.414846] Subtest dp-audio-edid: SKIP (0.000s)
[274.224829] [041/133] (746s left) gem_exec_flush (basic-uc-set-default)
[274.280070] Starting subtest: basic-uc-set-default
[279.734403] Subtest basic-uc-set-default: SUCCESS (5.455s)
[279.924247] [042/133] (741s left) gem_mmap_gtt (basic-read-write)
[279.978777] Subtest basic-read-write: SKIP (0.000s)
[280.039946] [043/133] (740s left) kms_prime (basic-crc-vgem)
[280.170629] Starting subtest: basic-crc-vgem
[280.172744] Starting dynamic subtest: second-to-first
[281.181662] Dynamic subtest second-to-first: SUCCESS (1.013s)
[281.183584] Subtest basic-crc-vgem: SUCCESS (1.014s)
[281.277757] [FACT kms_prime (basic-crc-vgem)] new: kernel.kmod_is_loaded.vgem: true
[281.281284] [044/133] (739s left) gem_exec_reloc (basic-write-read-noreloc)
[281.376955] Subtest basic-write-read-noreloc: SKIP (0.000s)
[281.458008] [045/133] (739s left) gem_render_copy (yf-tiled-to-vebox-x-tiled)
[281.513485] Starting subtest: yf-tiled-to-vebox-x-tiled
[281.517055] Subtest yf-tiled-to-vebox-x-tiled: SKIP (0.000s)
[281.698599] [046/133] (739s left) kms_cursor_crc (cursor-alpha-transparent)
[281.786244] Starting subtest: cursor-alpha-transparent
[281.788183] Starting dynamic subtest: pipe-A-eDP-1
[282.468810] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.680s)
[282.477802] Starting dynamic subtest: pipe-D-eDP-1
[283.766092] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.296s)
[283.768360] Subtest cursor-alpha-transparent: SUCCESS (1.980s)
[284.623048] [047/133] (736s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-mmap-wc)
[284.718696] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-mmap-wc
[284.722804] Subtest fbc-2p-primscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[284.825845] [048/133] (736s left) kms_big_fb (4-tiled-addfb-size-overflow)
[284.931678] Starting subtest: 4-tiled-addfb-size-overflow
[284.933851] Subtest 4-tiled-addfb-size-overflow: SUCCESS (0.000s)
[285.033443] [049/133] (736s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-mmap-cpu)
[285.134740] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-mmap-cpu
[288.717599] Subtest fbc-1p-primscrn-spr-indfb-draw-mmap-cpu: SUCCESS (3.589s)
[289.934400] [050/133] (731s left) gem_pxp (verify-pxp-stale-ctx-execution)
[289.985863] Starting subtest: verify-pxp-stale-ctx-execution
[291.051706] Subtest verify-pxp-stale-ctx-execution: SUCCESS (1.063s)
[291.174038] [051/133] (730s left) perf_pmu (interrupts)
[291.215481] Starting subtest: interrupts
[292.293391] Subtest interrupts: SUCCESS (1.079s)
[292.404032] [052/133] (729s left) gem_create (create-clear)
[292.463140] Starting subtest: create-clear
[292.465257] Starting dynamic subtest: smem0
[325.141609] Dynamic subtest smem0: SUCCESS (32.675s)
[325.144022] Subtest create-clear: SUCCESS (32.677s)
[325.331962] [053/133] (696s left) gem_ctx_persistence (heartbeat-stop)
[325.418083] Starting subtest: heartbeat-stop
[325.422813] Subtest heartbeat-stop: SKIP (0.000s)
[325.522942] [054/133] (695s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-0-async-flip)
[325.650384] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-0-async-flip
[325.654815] Subtest yf-tiled-max-hw-stride-64bpp-rotate-0-async-flip: SKIP (0.000s)
[325.751769] [055/133] (695s left) kms_flip (blocking-absolute-wf_vblank)
[325.847360] Starting subtest: blocking-absolute-wf_vblank
[325.849577] Starting dynamic subtest: A-eDP1
[334.579926] Dynamic subtest A-eDP1: SUCCESS (8.733s)
[334.594701] Starting dynamic subtest: B-eDP1
[343.304757] Dynamic subtest B-eDP1: SUCCESS (8.722s)
[343.318117] Starting dynamic subtest: C-eDP1
[352.018583] Dynamic subtest C-eDP1: SUCCESS (8.710s)
[352.028697] Starting dynamic subtest: D-eDP1
[360.752505] Dynamic subtest D-eDP1: SUCCESS (8.731s)
[360.758406] Subtest blocking-absolute-wf_vblank: SUCCESS (34.913s)
[361.974074] [056/133] (659s left) gem_ctx_shared (disjoint-timelines)
[362.043335] Starting subtest: disjoint-timelines
[362.077811] Subtest disjoint-timelines: SUCCESS (0.034s)
[362.309465] [057/133] (659s left) kms_flip (flip-vs-panning-vs-hang)
[362.417451] Starting subtest: flip-vs-panning-vs-hang
[362.419878] Starting dynamic subtest: A-eDP1
[413.375059] Dynamic subtest A-eDP1: SUCCESS (50.956s)
[413.386818] Starting dynamic subtest: D-eDP1
[452.412848] Dynamic subtest D-eDP1: SUCCESS (39.033s)
[452.418209] Subtest flip-vs-panning-vs-hang: SUCCESS (89.998s)
[453.568114] [058/133] (568s left) kms_lease (atomic-implicit-crtc)
[453.660599] Starting subtest: atomic-implicit-crtc
[453.662928] Starting dynamic subtest: pipe-A-eDP-1
[453.674291] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.002s)
[453.683242] Starting dynamic subtest: pipe-B-eDP-1
[453.694465] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.010s)
[453.703357] Starting dynamic subtest: pipe-C-eDP-1
[453.714362] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.010s)
[453.722726] Starting dynamic subtest: pipe-D-eDP-1
[453.733398] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.010s)
[453.735288] Subtest atomic-implicit-crtc: SUCCESS (0.038s)
[453.793433] [059/133] (567s left) kms_rotation_crc (primary-4-tiled-reflect-x-180)
[453.895043] Starting subtest: primary-4-tiled-reflect-x-180
[460.873540] Subtest primary-4-tiled-reflect-x-180: SUCCESS (6.981s)
[462.041592] [060/133] (559s left) kms_plane (pixel-format-linear-modifier-source-clamping)
[462.137197] Starting subtest: pixel-format-linear-modifier-source-clamping
[462.162948] Starting dynamic subtest: pipe-A-plane-0
[465.662216] Dynamic subtest pipe-A-plane-0: SUCCESS (3.500s)
[465.675569] Starting dynamic subtest: pipe-A-plane-3
[467.362366] Dynamic subtest pipe-A-plane-3: SUCCESS (1.698s)
[468.435491] Starting dynamic subtest: pipe-B-plane-0
[472.106547] Dynamic subtest pipe-B-plane-0: SUCCESS (3.678s)
[472.121242] Starting dynamic subtest: pipe-B-plane-3
[473.839149] Dynamic subtest pipe-B-plane-3: SUCCESS (1.730s)
[474.154535] Subtest pixel-format-linear-modifier-source-clamping: SUCCESS (12.017s)
[475.037024] [061/133] (546s left) kms_chamelium_edid (hdmi-edid-change-during-suspend)
[475.442235] Subtest hdmi-edid-change-during-suspend: SKIP (0.000s)
[476.231412] [062/133] (545s left) i915_query (engine-info)
[476.278171] Starting subtest: engine-info
[476.280148] Subtest engine-info: SUCCESS (0.004s)
[476.402167] [063/133] (545s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-pwrite)
[476.494875] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-pwrite
[476.499326] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[476.580719] [064/133] (545s left) prime_mmap_coherency (read)
[476.639593] Starting subtest: read
[482.016939] Subtest read: SUCCESS (5.375s)
[482.127594] [065/133] (539s left) kms_frontbuffer_tracking (fbc-2p-primscrn-indfb-plflip-blt)
[482.229453] Starting subtest: fbc-2p-primscrn-indfb-plflip-blt
[482.233553] Subtest fbc-2p-primscrn-indfb-plflip-blt: SKIP (0.000s)
[482.310886] [066/133] (539s left) kms_cursor_crc (cursor-sliding-max-size)
[482.627824] Starting subtest: cursor-sliding-max-size
[482.634254] Subtest cursor-sliding-max-size: SKIP (0.000s)
[482.737752] [067/133] (539s left) kms_frontbuffer_tracking (psr-2p-scndscrn-shrfb-msflip-blt)
[482.831357] Starting subtest: psr-2p-scndscrn-shrfb-msflip-blt
[482.835578] Subtest psr-2p-scndscrn-shrfb-msflip-blt: SKIP (0.000s)
[482.928290] [068/133] (539s left) kms_tiled_display (basic-test-pattern-with-chamelium)
[483.030228] Subtest basic-test-pattern-with-chamelium: SKIP (0.000s)
[483.079598] [069/133] (539s left) gem_caching (read-writes)
[483.131493] Subtest read-writes: SKIP (0.000s)
[483.201476] [070/133] (538s left) gem_exec_params (sol-reset-not-gen7)
[483.251850] Starting subtest: sol-reset-not-gen7
[483.256172] Subtest sol-reset-not-gen7: SUCCESS (0.003s)
[483.362701] [071/133] (538s left) kms_invalid_mode (bad-htotal)
[483.448468] Starting subtest: bad-htotal
[483.450513] Starting dynamic subtest: pipe-A-eDP-1
[483.737470] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.286s)
[483.747214] Starting dynamic subtest: pipe-B-eDP-1
[483.749367] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[483.758118] Starting dynamic subtest: pipe-C-eDP-1
[483.760458] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[483.769525] Starting dynamic subtest: pipe-D-eDP-1
[483.771781] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[483.773990] Subtest bad-htotal: SUCCESS (0.292s)
[484.576976] [072/133] (537s left) syncobj_timeline (etime-single-wait-for-submit-available-unsubmitted)
[484.627909] Starting subtest: etime-single-wait-for-submit-available-unsubmitted
[484.736972] Subtest etime-single-wait-for-submit-available-unsubmitted: SUCCESS (0.108s)
[484.813151] [073/133] (537s left) perf (short-reads)
[484.915739] Starting subtest: short-reads
[484.931846] Subtest short-reads: SUCCESS (0.016s)
[484.977841] [074/133] (537s left) gem_ctx_param (invalid-param-set)
[485.037910] Starting subtest: invalid-param-set
[485.040233] Subtest invalid-param-set: SUCCESS (0.000s)
[485.109966] [075/133] (537s left) kms_getfb (getfb2-handle-zero)
[485.201162] Starting subtest: getfb2-handle-zero
[485.203326] Subtest getfb2-handle-zero: SUCCESS (0.000s)
[485.296128] [076/133] (537s left) gem_exec_reloc (basic-wc-gtt)
[485.352755] Subtest basic-wc-gtt: SKIP (0.000s)
[485.431780] [077/133] (537s left) kms_psr2_sf (fbc-psr2-plane-move-sf-dmg-area)
[485.532078] Starting subtest: fbc-psr2-plane-move-sf-dmg-area
[485.534350] Starting dynamic subtest: pipe-A-eDP-1
[485.628406] Dynamic subtest pipe-A-eDP-1: SKIP (0.100s)
[485.639111] Starting dynamic subtest: pipe-B-eDP-1
[486.761064] Dynamic subtest pipe-B-eDP-1: SKIP (1.131s)
[486.765672] Subtest fbc-psr2-plane-move-sf-dmg-area: SKIP (1.234s)
[488.040991] [078/133] (534s left) kms_frontbuffer_tracking (psr-1p-rte)
[488.153418] Starting subtest: psr-1p-rte
[493.560863] Subtest psr-1p-rte: SUCCESS (5.411s)
[493.708404] [079/133] (528s left) gem_mmap_gtt (basic-copy)
[493.763780] Subtest basic-copy: SKIP (0.000s)
[493.828038] [080/133] (528s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-mmap-gtt)
[493.933590] Starting subtest: psr-1p-primscrn-cur-indfb-draw-mmap-gtt
[493.937963] Subtest psr-1p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[494.051680] [081/133] (528s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-32bpp-ytilercccs-downscaling)
[494.149402] Starting subtest: flip-64bpp-ytile-to-32bpp-ytilercccs-downscaling
[494.153812] Subtest flip-64bpp-ytile-to-32bpp-ytilercccs-downscaling: SKIP (0.000s)
[494.221575] [082/133] (528s left) kms_rotation_crc (sprite-rotation-90-pos-100-0)
[494.318387] Starting subtest: sprite-rotation-90-pos-100-0
[494.322817] Subtest sprite-rotation-90-pos-100-0: SKIP (0.001s)
[494.392363] [083/133] (528s left) kms_pm_backlight (fade-with-suspend)
[494.484603] Starting subtest: fade-with-suspend
[511.153189] Starting dynamic subtest: eDP-1
[513.847753] Dynamic subtest eDP-1: SUCCESS (2.696s)
[513.850062] Subtest fade-with-suspend: SUCCESS (4.442s)
[520.668980] [084/133] (508s left) kms_addfb_basic (bad-pitch-0)
[520.759435] Starting subtest: bad-pitch-0
[520.761336] Subtest bad-pitch-0: SUCCESS (0.000s)
[520.946943] [085/133] (507s left) gem_mmap_wc (read-write)
[521.017064] Subtest read-write: SKIP (0.000s)
[521.093706] [086/133] (507s left) syncobj_timeline (signal-point-0)
[521.149132] Starting subtest: signal-point-0
[521.151380] Subtest signal-point-0: SUCCESS (0.000s)
[521.263596] [087/133] (507s left) perf_pmu (most-busy-check-all)
[521.306690] Starting subtest: most-busy-check-all
[521.308923] Starting dynamic subtest: rcs0
[522.846597] Dynamic subtest rcs0: SUCCESS (1.536s)
[522.859755] Starting dynamic subtest: bcs0
[524.830661] Dynamic subtest bcs0: SUCCESS (1.979s)
[524.843592] Starting dynamic subtest: vcs0
[526.814245] Dynamic subtest vcs0: SUCCESS (1.979s)
[526.830592] Starting dynamic subtest: vcs1
[528.797798] Dynamic subtest vcs1: SUCCESS (1.979s)
[528.810455] Starting dynamic subtest: vecs0
[530.846367] Dynamic subtest vecs0: SUCCESS (2.044s)
[530.859204] Starting dynamic subtest: ccs0
[532.830779] Dynamic subtest ccs0: SUCCESS (1.981s)
[532.833693] Subtest most-busy-check-all: SUCCESS (11.513s)
[532.950673] [088/133] (496s left) kms_flip (2x-flip-vs-dpms-on-nop)
[533.049893] Starting subtest: 2x-flip-vs-dpms-on-nop
[533.058628] Subtest 2x-flip-vs-dpms-on-nop: SKIP (0.011s)
[533.140211] [089/133] (495s left) kms_plane_multiple (2x-tiling-yf)
[533.239178] Starting subtest: 2x-tiling-yf
[533.243176] Subtest 2x-tiling-yf: SKIP (0.000s)
[533.312833] [090/133] (495s left) kms_chamelium_hpd (dp-hpd)
[533.711368] Subtest dp-hpd: SKIP (0.000s)
[534.498043] [091/133] (494s left) gen9_exec_parse (batch-without-end)
[534.558135] Subtest batch-without-end: SKIP (0.000s)
[534.627252] [092/133] (494s left) gem_exec_balancer (bonded-dual)
[534.697021] Starting subtest: bonded-dual
[534.701640] Subtest bonded-dual: SKIP (0.000s)
[534.988778] [093/133] (494s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-0-hflip)
[535.093607] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-0-hflip
[536.150697] Subtest x-tiled-max-hw-stride-32bpp-rotate-0-hflip: SUCCESS (1.056s)
[536.260152] [094/133] (493s left) gem_mmap_gtt (basic-small-bo-tiledx)
[536.320562] Subtest basic-small-bo-tiledX: SKIP (0.000s)
[536.388664] [095/133] (492s left) kms_plane_scaling (planes-downscale-factor-0-5-upscale-20x20)
[536.481609] Starting subtest: planes-downscale-factor-0-5-upscale-20x20
[536.483531] Starting dynamic subtest: pipe-A
[536.505973] Dynamic subtest pipe-A: SKIP (0.021s)
[536.516059] Starting dynamic subtest: pipe-B
[536.550386] Dynamic subtest pipe-B: SKIP (0.043s)
[536.559836] Starting dynamic subtest: pipe-C
[536.599160] Dynamic subtest pipe-C: SKIP (0.046s)
[536.608429] Starting dynamic subtest: pipe-D
[536.631015] Dynamic subtest pipe-D: SKIP (0.033s)
[536.634042] Subtest planes-downscale-factor-0-5-upscale-20x20: SKIP (0.148s)
[536.737316] [096/133] (492s left) kms_ccs (bad-pixel-format-4-tiled-dg2-rc-ccs-cc)
[536.821809] Starting subtest: bad-pixel-format-4-tiled-dg2-rc-ccs-cc
[536.823823] Starting dynamic subtest: pipe-A-eDP-1
[536.842150] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[536.852681] Starting dynamic subtest: pipe-B-eDP-1
[536.870231] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[536.880155] Starting dynamic subtest: pipe-C-eDP-1
[536.897098] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[536.905873] Starting dynamic subtest: pipe-D-eDP-1
[536.923594] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[536.926964] Subtest bad-pixel-format-4-tiled-dg2-rc-ccs-cc: SKIP (0.008s)
[538.996135] [097/133] (490s left) perf (non-zero-reason)
[539.077428] Starting subtest: non-zero-reason
[539.079785] Starting dynamic subtest: 0-rcs0
[544.507092] Dynamic subtest 0-rcs0: SUCCESS (5.426s)
[544.526444] Starting dynamic subtest: 1-vcs1
[548.422328] Dynamic subtest 1-vcs1: SUCCESS (3.913s)
[548.425323] Subtest non-zero-reason: SUCCESS (9.341s)
[548.466364] [098/133] (480s left) intel_hwmon (hwmon-write)
[548.530334] Subtest hwmon-write: SKIP (0.000s)
[548.589693] [099/133] (480s left) api_intel_bb (reset-flags)
[548.649581] Starting subtest: reset-flags
[548.659926] Subtest reset-flags: SUCCESS (0.013s)
[548.799003] [100/133] (480s left) gem_exec_fence (syncobj-timeline-signal)
[549.371553] Starting subtest: syncobj-timeline-signal
[549.381406] Subtest syncobj-timeline-signal: SUCCESS (0.011s)
[550.869069] [101/133] (478s left) gem_basic (create-fd-close)
[550.934921] Starting subtest: create-fd-close
[550.939087] Subtest create-fd-close: SUCCESS (0.000s)
[551.034593] [102/133] (478s left) kms_ccs (ccs-on-another-bo-y-tiled-ccs)
[551.134427] Starting subtest: ccs-on-another-bo-y-tiled-ccs
[551.136663] Starting dynamic subtest: pipe-A-eDP-1
[551.159301] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[551.175675] Starting dynamic subtest: pipe-B-eDP-1
[551.198015] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[551.208829] Starting dynamic subtest: pipe-C-eDP-1
[551.231098] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[551.240869] Starting dynamic subtest: pipe-D-eDP-1
[551.263166] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[551.267308] Subtest ccs-on-another-bo-y-tiled-ccs: SKIP (0.005s)
[553.484928] [103/133] (476s left) gem_eio (in-flight-internal-10ms)
[553.698291] Starting subtest: in-flight-internal-10ms
[554.916815] Subtest in-flight-internal-10ms: SUCCESS (1.218s)
[555.047896] [104/133] (474s left) kms_psr (fbc-psr-sprite-render)
[555.151327] Starting subtest: fbc-psr-sprite-render
[555.153620] Starting dynamic subtest: eDP-1
[555.157979] Dynamic subtest eDP-1: SKIP (0.000s)
[555.162364] Subtest fbc-psr-sprite-render: SKIP (0.001s)
[555.225196] [105/133] (474s left) gem_mmap_gtt (medium-copy-xy)
[555.279450] Subtest medium-copy-XY: SKIP (0.000s)
[555.342392] [106/133] (474s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-mmap-gtt)
[555.459803] Starting subtest: fbc-rgb101010-draw-mmap-gtt
[555.463932] Subtest fbc-rgb101010-draw-mmap-gtt: SKIP (0.000s)
[555.555706] [107/133] (474s left) gen3_mixed_blits
[555.672264] [108/133] (474s left) gen9_exec_parse (shadow-peek)
[555.727531] Subtest shadow-peek: SKIP (0.000s)
[555.814101] [109/133] (474s left) kms_psr (psr2-sprite-plane-move)
[555.901495] Starting subtest: psr2-sprite-plane-move
[555.903402] Starting dynamic subtest: eDP-1
[557.687542] Dynamic subtest eDP-1: SUCCESS (1.782s)
[557.689831] Subtest psr2-sprite-plane-move: SUCCESS (1.783s)
[558.531269] [110/133] (471s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-cpu)
[558.640368] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-cpu
[558.644387] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[558.725873] [111/133] (471s left) kms_cursor_crc (cursor-random-32x10)
[558.884963] Starting subtest: cursor-random-32x10
[558.934218] Subtest cursor-random-32x10: SKIP (0.044s)
[559.253689] [112/133] (470s left) kms_big_fb (linear-addfb)
[559.367555] Starting subtest: linear-addfb
[559.369459] Subtest linear-addfb: SUCCESS (0.000s)
[559.461507] [113/133] (470s left) kms_dp_link_training (uhbr-mst)
[559.556658] Starting subtest: uhbr-mst
[559.564051] Subtest uhbr-mst: SKIP (0.000s)
[559.636174] [114/133] (470s left) kms_flip (basic-plain-flip)
[559.731724] Starting subtest: basic-plain-flip
[559.733283] Starting dynamic subtest: A-eDP1
[561.412032] Dynamic subtest A-eDP1: SUCCESS (1.678s)
[561.425344] Starting dynamic subtest: B-eDP1
[563.056170] Dynamic subtest B-eDP1: SUCCESS (1.641s)
[563.069335] Starting dynamic subtest: C-eDP1
[564.673805] Dynamic subtest C-eDP1: SUCCESS (1.615s)
[564.686446] Starting dynamic subtest: D-eDP1
[566.309084] Dynamic subtest D-eDP1: SUCCESS (1.632s)
[566.314265] Subtest basic-plain-flip: SUCCESS (6.580s)
[567.485418] [115/133] (462s left) prime_busy (before-wait)
[567.548033] Starting subtest: before-wait
[567.550235] Starting dynamic subtest: rcs0
[567.576401] Dynamic subtest rcs0: SUCCESS (0.027s)
[567.587400] Starting dynamic subtest: bcs0
[567.626461] Dynamic subtest bcs0: SUCCESS (0.049s)
[567.636758] Starting dynamic subtest: vcs0
[567.666877] Dynamic subtest vcs0: SUCCESS (0.040s)
[567.676813] Starting dynamic subtest: vcs1
[567.708237] Dynamic subtest vcs1: SUCCESS (0.041s)
[567.718025] Starting dynamic subtest: vecs0
[567.748996] Dynamic subtest vecs0: SUCCESS (0.040s)
[567.758861] Starting dynamic subtest: ccs0
[567.789362] Dynamic subtest ccs0: SUCCESS (0.040s)
[567.899077] Subtest before-wait: SUCCESS (0.351s)
[567.993290] [116/133] (462s left) gem_exec_fence (parallel)
[568.188334] Starting subtest: parallel
[568.190600] Starting dynamic subtest: rcs0
[570.332991] Dynamic subtest rcs0: SUCCESS (2.148s)
[570.347511] Starting dynamic subtest: bcs0
[572.481908] Dynamic subtest bcs0: SUCCESS (2.148s)
[572.493653] Starting dynamic subtest: vcs0
[574.634396] Dynamic subtest vcs0: SUCCESS (2.151s)
[574.645956] Starting dynamic subtest: vcs1
[576.789980] Dynamic subtest vcs1: SUCCESS (2.154s)
[576.800980] Starting dynamic subtest: vecs0
[578.942535] Dynamic subtest vecs0: SUCCESS (2.151s)
[578.954019] Starting dynamic subtest: ccs0
[581.097518] Dynamic subtest ccs0: SUCCESS (2.154s)
[581.099373] Subtest parallel: SUCCESS (12.911s)
[581.945667] [117/133] (448s left) kms_flip (2x-flip-vs-expired-vblank)
[582.055216] Starting subtest: 2x-flip-vs-expired-vblank
[582.064884] Subtest 2x-flip-vs-expired-vblank: SKIP (0.011s)
[582.147931] [118/133] (448s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-mmap-wc)
[582.249649] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-mmap-wc
[582.253927] Subtest psr-2p-scndscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[582.349051] [119/133] (448s left) perf_pmu (all-busy-check-all)
[582.389169] Starting subtest: all-busy-check-all
[583.839592] Subtest all-busy-check-all: SUCCESS (1.449s)
[583.949357] [120/133] (446s left) syncobj_timeline (etime-multi-wait-all-for-submit-unsubmitted-signaled)
[584.000471] Starting subtest: etime-multi-wait-all-for-submit-unsubmitted-signaled
[584.106013] Subtest etime-multi-wait-all-for-submit-unsubmitted-signaled: SUCCESS (0.104s)
[584.185120] [121/133] (446s left) perf (gen8-unprivileged-single-ctx-counters)
[584.271587] Starting subtest: gen8-unprivileged-single-ctx-counters
[584.276055] Subtest gen8-unprivileged-single-ctx-counters: SKIP (0.000s)
[584.317212] [122/133] (446s left) gem_render_copy (y-tiled-ccs-to-y-tiled)
[584.377119] Starting subtest: y-tiled-ccs-to-y-tiled
[584.381032] Subtest y-tiled-ccs-to-y-tiled: SKIP (0.000s)
[584.559259] [123/133] (445s left) kms_ccs (bad-aux-stride-4-tiled-mtl-mc-ccs)
[584.663488] Starting subtest: bad-aux-stride-4-tiled-mtl-mc-ccs
[584.665671] Starting dynamic subtest: pipe-A-eDP-1
[584.731031] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.069s)
[584.741364] Starting dynamic subtest: pipe-B-eDP-1
[584.793674] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.061s)
[584.803832] Starting dynamic subtest: pipe-C-eDP-1
[584.855990] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.061s)
[584.866108] Starting dynamic subtest: pipe-D-eDP-1
[584.919943] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.063s)
[584.922247] Subtest bad-aux-stride-4-tiled-mtl-mc-ccs: SUCCESS (0.259s)
[587.078118] [124/133] (443s left) kms_content_protection (content-type-change)
[587.229678] Starting subtest: content-type-change
[587.234534] Subtest content-type-change: SKIP (0.000s)
[587.346231] [125/133] (443s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-pwrite)
[587.451577] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-pwrite
[594.646594] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-pwrite: SUCCESS (7.196s)
[594.786541] [126/133] (435s left) kms_psr (fbc-pr-primary-mmap-cpu)
[594.877533] Starting subtest: fbc-pr-primary-mmap-cpu
[594.881956] Subtest fbc-pr-primary-mmap-cpu: SKIP (0.000s)
[594.966470] [127/133] (435s left) gem_linear_blits (basic)
[595.208264] Starting subtest: basic
[595.216477] Subtest basic: SUCCESS (0.009s)
[595.361734] [128/133] (435s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-mmap-cpu)
[595.502894] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-mmap-cpu
[602.097672] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-mmap-cpu: SUCCESS (6.597s)
[602.209665] [129/133] (428s left) gem_mmap_offset (bad-extensions)
[602.267473] Starting subtest: bad-extensions
[602.269397] Subtest bad-extensions: SUCCESS (0.000s)
[602.363415] [130/133] (428s left) kms_flip_scaled_crc (flip-64bpp-linear-to-16bpp-linear-downscaling)
[602.446267] Starting subtest: flip-64bpp-linear-to-16bpp-linear-downscaling
[602.448517] Starting dynamic subtest: pipe-A-default-mode
[603.609361] Dynamic subtest pipe-A-default-mode: SKIP (1.161s)
[603.613541] Subtest flip-64bpp-linear-to-16bpp-linear-downscaling: SKIP (1.162s)
[603.754711] [131/133] (427s left) gem_lmem_swapping (random-engines)
[603.809182] Subtest random-engines: SKIP (0.000s)
[603.860876] [132/133] (427s left) kms_atomic (crtc-invalid-params-fence)
[603.965158] Starting subtest: crtc-invalid-params-fence
[603.967477] Starting dynamic subtest: pipe-A-eDP-1
[604.403357] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.437s)
[604.405285] Subtest crtc-invalid-params-fence: SUCCESS (0.438s)
[605.216565] [133/133] (425s left) kms_big_fb (x-tiled-16bpp-rotate-270)
[605.317702] Starting subtest: x-tiled-16bpp-rotate-270
[605.338464] Subtest x-tiled-16bpp-rotate-270: SKIP (0.019s)
[605.440509] Closing watchdogs
results: parsing output: 0/ for test: gem_exec_whisper
results: parsing output: 1/ for test: i915_getparams_basic
results: parsing output: 2/ for test: gem_exec_balancer
results: parsing output: 3/ for test: kms_frontbuffer_tracking
results: parsing output: 4/ for test: kms_big_fb
results: parsing output: 5/ for test: gem_ctx_persistence
results: parsing output: 6/ for test: kms_color
results: parsing output: 7/ for test: gem_pxp
results: parsing output: 8/ for test: kms_frontbuffer_tracking
results: parsing output: 9/ for test: device_reset
results: parsing output: 10/ for test: gem_blits
results: parsing output: 11/ for test: gem_exec_schedule
results: parsing output: 12/ for test: gem_exec_reloc
results: parsing output: 13/ for test: kms_ccs
results: parsing output: 14/ for test: kms_prop_blob
results: parsing output: 15/ for test: gem_exec_schedule
results: parsing output: 16/ for test: kms_fbcon_fbt
results: parsing output: 17/ for test: kms_draw_crc
results: parsing output: 18/ for test: gem_fence_thrash
results: parsing output: 19/ for test: kms_frontbuffer_tracking
results: parsing output: 20/ for test: kms_flip
results: parsing output: 21/ for test: kms_frontbuffer_tracking
results: parsing output: 22/ for test: sysfs_heartbeat_interval
results: parsing output: 23/ for test: kms_frontbuffer_tracking
results: parsing output: 24/ for test: i915_pm_freq_mult
results: parsing output: 25/ for test: kms_vblank
results: parsing output: 26/ for test: api_intel_allocator
results: parsing output: 27/ for test: kms_ccs
results: parsing output: 28/ for test: syncobj_timeline
results: parsing output: 29/ for test: kms_plane
results: parsing output: 30/ for test: gem_exec_whisper
results: parsing output: 31/ for test: syncobj_timeline
results: parsing output: 32/ for test: kms_psr
results: parsing output: 33/ for test: kms_psr
results: parsing output: 34/ for test: kms_pipe_crc_basic
results: parsing output: 35/ for test: gem_userptr_blits
results: parsing output: 36/ for test: gem_softpin
results: parsing output: 37/ for test: kms_frontbuffer_tracking
results: parsing output: 38/ for test: perf
results: parsing output: 39/ for test: kms_chamelium_audio
results: parsing output: 40/ for test: gem_exec_flush
results: parsing output: 41/ for test: gem_mmap_gtt
results: parsing output: 42/ for test: kms_prime
results: parsing output: 43/ for test: gem_exec_reloc
results: parsing output: 44/ for test: gem_render_copy
results: parsing output: 45/ for test: kms_cursor_crc
results: parsing output: 46/ for test: kms_frontbuffer_tracking
results: parsing output: 47/ for test: kms_big_fb
results: parsing output: 48/ for test: kms_frontbuffer_tracking
results: parsing output: 49/ for test: gem_pxp
results: parsing output: 50/ for test: perf_pmu
results: parsing output: 51/ for test: gem_create
results: parsing output: 52/ for test: gem_ctx_persistence
results: parsing output: 53/ for test: kms_big_fb
results: parsing output: 54/ for test: kms_flip
results: parsing output: 55/ for test: gem_ctx_shared
results: parsing output: 56/ for test: kms_flip
results: parsing output: 57/ for test: kms_lease
results: parsing output: 58/ for test: kms_rotation_crc
results: parsing output: 59/ for test: kms_plane
results: parsing output: 60/ for test: kms_chamelium_edid
results: parsing output: 61/ for test: i915_query
results: parsing output: 62/ for test: kms_frontbuffer_tracking
results: parsing output: 63/ for test: prime_mmap_coherency
results: parsing output: 64/ for test: kms_frontbuffer_tracking
results: parsing output: 65/ for test: kms_cursor_crc
results: parsing output: 66/ for test: kms_frontbuffer_tracking
results: parsing output: 67/ for test: kms_tiled_display
results: parsing output: 68/ for test: gem_caching
results: parsing output: 69/ for test: gem_exec_params
results: parsing output: 70/ for test: kms_invalid_mode
results: parsing output: 71/ for test: syncobj_timeline
results: parsing output: 72/ for test: perf
results: parsing output: 73/ for test: gem_ctx_param
results: parsing output: 74/ for test: kms_getfb
results: parsing output: 75/ for test: gem_exec_reloc
results: parsing output: 76/ for test: kms_psr2_sf
results: parsing output: 77/ for test: kms_frontbuffer_tracking
results: parsing output: 78/ for test: gem_mmap_gtt
results: parsing output: 79/ for test: kms_frontbuffer_tracking
results: parsing output: 80/ for test: kms_flip_scaled_crc
results: parsing output: 81/ for test: kms_rotation_crc
results: parsing output: 82/ for test: kms_pm_backlight
results: parsing output: 83/ for test: kms_addfb_basic
results: parsing output: 84/ for test: gem_mmap_wc
results: parsing output: 85/ for test: syncobj_timeline
results: parsing output: 86/ for test: perf_pmu
results: parsing output: 87/ for test: kms_flip
results: parsing output: 88/ for test: kms_plane_multiple
results: parsing output: 89/ for test: kms_chamelium_hpd
results: parsing output: 90/ for test: gen9_exec_parse
results: parsing output: 91/ for test: gem_exec_balancer
results: parsing output: 92/ for test: kms_big_fb
results: parsing output: 93/ for test: gem_mmap_gtt
results: parsing output: 94/ for test: kms_plane_scaling
results: parsing output: 95/ for test: kms_ccs
results: parsing output: 96/ for test: perf
results: parsing output: 97/ for test: intel_hwmon
results: parsing output: 98/ for test: api_intel_bb
results: parsing output: 99/ for test: gem_exec_fence
results: parsing output: 100/ for test: gem_basic
results: parsing output: 101/ for test: kms_ccs
results: parsing output: 102/ for test: gem_eio
results: parsing output: 103/ for test: kms_psr
results: parsing output: 104/ for test: gem_mmap_gtt
results: parsing output: 105/ for test: kms_frontbuffer_tracking
results: parsing output: 106/ for test: gen3_mixed_blits
results: parsing output: 107/ for test: gen9_exec_parse
results: parsing output: 108/ for test: kms_psr
results: parsing output: 109/ for test: kms_frontbuffer_tracking
results: parsing output: 110/ for test: kms_cursor_crc
results: parsing output: 111/ for test: kms_big_fb
results: parsing output: 112/ for test: kms_dp_link_training
results: parsing output: 113/ for test: kms_flip
results: parsing output: 114/ for test: prime_busy
results: parsing output: 115/ for test: gem_exec_fence
results: parsing output: 116/ for test: kms_flip
results: parsing output: 117/ for test: kms_frontbuffer_tracking
results: parsing output: 118/ for test: perf_pmu
results: parsing output: 119/ for test: syncobj_timeline
results: parsing output: 120/ for test: perf
results: parsing output: 121/ for test: gem_render_copy
results: parsing output: 122/ for test: kms_ccs
results: parsing output: 123/ for test: kms_content_protection
results: parsing output: 124/ for test: kms_frontbuffer_tracking
results: parsing output: 125/ for test: kms_psr
results: parsing output: 126/ for test: gem_linear_blits
results: parsing output: 127/ for test: kms_frontbuffer_tracking
results: parsing output: 128/ for test: gem_mmap_offset
results: parsing output: 129/ for test: kms_flip_scaled_crc
results: parsing output: 130/ for test: gem_lmem_swapping
results: parsing output: 131/ for test: kms_atomic
results: parsing output: 132/ for test: kms_big_fb
Done.