[151.791183] Initializing watchdogs
[151.791302]   /dev/watchdog0
[151.815222] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:0102 Intel Sandybridge (Gen6) 2nd Generation Core Processor Family Integrated Graphics Controller (XPS 8300)
[151.828372] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[151.832130] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[151.836506] [001/130] (960s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-move)
[152.153468] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-move
[152.156613] Subtest fbcpsr-2p-primscrn-spr-indfb-move: SKIP (0.000s)
[152.551774] [002/130] (959s left) gem_exec_schedule (out-order)
[152.626692] Subtest out-order: SKIP (0.000s)
[152.861251] [003/130] (959s left) gem_mmap_gtt (cpuset-basic-small-copy-odd)
[152.924979] Starting subtest: cpuset-basic-small-copy-odd
[154.072925] Subtest cpuset-basic-small-copy-odd: SUCCESS (1.149s)
[154.209474] [004/130] (958s left) gem_exec_fence (syncobj-import)
[154.535692] Starting subtest: syncobj-import
[154.537460] Subtest syncobj-import: SUCCESS (0.003s)
[154.925555] [FACT gem_exec_fence (syncobj-import)] new: kernel.kmod_is_loaded.vgem: true
[154.929131] [005/130] (957s left) kms_big_fb (yf-tiled-8bpp-rotate-90)
[155.239091] Starting subtest: yf-tiled-8bpp-rotate-90
[155.242431] Subtest yf-tiled-8bpp-rotate-90: SKIP (0.000s)
[155.663316] [006/130] (956s left) kms_flip (2x-nonexisting-fb)
[155.955155] Starting subtest: 2x-nonexisting-fb
[155.957031] Starting dynamic subtest: AB-VGA1-HDMI-A1
[156.355433] Dynamic subtest AB-VGA1-HDMI-A1: SUCCESS (0.399s)
[156.357137] Subtest 2x-nonexisting-fb: SUCCESS (0.402s)
[156.998448] [007/130] (955s left) kms_flip (single-buffer-flip-vs-dpms-off-vs-modeset-interruptible)
[157.297433] Starting subtest: single-buffer-flip-vs-dpms-off-vs-modeset-interruptible
[157.299089] Starting dynamic subtest: A-VGA1
[158.048586] Dynamic subtest A-VGA1: SUCCESS (0.750s)
[158.060395] Starting dynamic subtest: B-VGA1
[158.717784] Dynamic subtest B-VGA1: SUCCESS (0.667s)
[158.728552] Starting dynamic subtest: A-HDMI-A1
[159.464994] Dynamic subtest A-HDMI-A1: SUCCESS (0.746s)
[159.475829] Starting dynamic subtest: B-HDMI-A1
[160.207943] Dynamic subtest B-HDMI-A1: SUCCESS (0.744s)
[160.209791] Subtest single-buffer-flip-vs-dpms-off-vs-modeset-interruptible: SUCCESS (2.911s)
[160.739897] [008/130] (951s left) gem_exec_reloc (basic-write-read)
[160.809651] Starting subtest: basic-write-read
[160.813044] Subtest basic-write-read: SUCCESS (0.003s)
[161.477607] [009/130] (951s left) kms_plane_scaling (planes-upscale-factor-0-25-downscale-factor-0-5)
[161.782286] Starting subtest: planes-upscale-factor-0-25-downscale-factor-0-5
[161.783963] Starting dynamic subtest: pipe-A
[161.788871] Dynamic subtest pipe-A: SKIP (0.002s)
[161.799837] Starting dynamic subtest: pipe-B
[161.804710] Dynamic subtest pipe-B: SKIP (0.001s)
[161.807801] Subtest planes-upscale-factor-0-25-downscale-factor-0-5: SKIP (0.004s)
[162.218792] [010/130] (950s left) gem_ctx_persistence (heartbeat-hostile)
[162.279741] Subtest heartbeat-hostile: SKIP (0.000s)
[162.342366] [011/130] (950s left) syncobj_wait (invalid-signal-one-illegal-handle)
[162.399989] Starting subtest: invalid-signal-one-illegal-handle
[162.401761] Subtest invalid-signal-one-illegal-handle: SUCCESS (0.000s)
[162.538405] [012/130] (950s left) kms_plane_alpha_blend (coverage-vs-premult-vs-constant)
[162.837275] Starting subtest: coverage-vs-premult-vs-constant
[162.999855] Subtest coverage-vs-premult-vs-constant: SKIP (0.163s)
[163.594648] [013/130] (949s left) kms_vrr (flip-suspend)
[163.890450] Starting subtest: flip-suspend
[163.897058] Subtest flip-suspend: SKIP (0.000s)
[164.295702] [014/130] (948s left) kms_ccs (bad-rotation-90-4-tiled-mtl-mc-ccs)
[164.356376] Subtest bad-rotation-90-4-tiled-mtl-mc-ccs: SKIP (0.000s)
[164.420935] [015/130] (948s left) gem_exec_flush (basic-wb-pro-default)
[164.490526] Starting subtest: basic-wb-pro-default
[169.933986] Subtest basic-wb-pro-default: SUCCESS (5.446s)
[170.166757] [016/130] (943s left) gem_partial_pwrite_pread (write-snoop)
[170.246916] Starting subtest: write-snoop
[174.015855] Subtest write-snoop: SUCCESS (3.789s)
[174.192948] [017/130] (939s left) syncobj_wait (multi-wait-all-signaled)
[174.253047] Starting subtest: multi-wait-all-signaled
[174.254822] Subtest multi-wait-all-signaled: SUCCESS (0.001s)
[174.395533] [018/130] (938s left) gem_exec_reloc (basic-cpu-wc-active)
[174.452718] Starting subtest: basic-cpu-wc-active
[174.564105] Subtest basic-cpu-wc-active: SUCCESS (0.110s)
[175.230586] [019/130] (938s left) kms_psr2_sf (pr-overlay-plane-update-continuous-sf)
[175.543388] Subtest pr-overlay-plane-update-continuous-sf: SKIP (0.000s)
[175.730285] [020/130] (937s left) kms_cursor_crc (cursor-rapid-movement-32x32)
[176.023060] Starting subtest: cursor-rapid-movement-32x32
[176.078679] Subtest cursor-rapid-movement-32x32: SKIP (0.052s)
[176.505686] [021/130] (937s left) kms_plane_alpha_blend (alpha-7efc)
[176.800282] Starting subtest: alpha-7efc
[176.954489] Subtest alpha-7efc: SKIP (0.155s)
[177.546225] [022/130] (936s left) kms_dsc (dsc-with-output-formats-with-bpc)
[177.843553] Subtest dsc-with-output-formats-with-bpc: SKIP (0.000s)
[178.037996] [023/130] (935s left) api_intel_allocator (simple-allocator)
[178.097744] Starting subtest: simple-allocator
[178.099438] Starting dynamic subtest: basic
[178.103797] Dynamic subtest basic: SUCCESS (0.007s)
[178.117494] Starting dynamic subtest: parallel-one
[178.406478] Dynamic subtest parallel-one: SUCCESS (0.301s)
[178.418140] Starting dynamic subtest: print
[178.419956] Dynamic subtest print: SUCCESS (0.000s)
[178.432989] Starting dynamic subtest: reuse
[178.435130] Dynamic subtest reuse: SUCCESS (0.000s)
[178.451355] Starting dynamic subtest: reserve
[178.453431] Dynamic subtest reserve: SUCCESS (0.000s)
[178.471247] Starting dynamic subtest: fork-reopen-allocator
[178.473603] Dynamic subtest fork-reopen-allocator: SUCCESS (0.019s)
[178.475867] Subtest simple-allocator: SUCCESS (0.331s)
[178.595786] [024/130] (935s left) kms_pm_rpm (dpms-mode-unset-non-lpsp)
[190.094721] Subtest dpms-mode-unset-non-lpsp: SKIP (0.000s)
[190.297672] [025/130] (923s left) syncobj_timeline (single-wait-for-submit-signaled)
[190.359330] Starting subtest: single-wait-for-submit-signaled
[190.360927] Subtest single-wait-for-submit-signaled: SUCCESS (0.001s)
[190.487270] [026/130] (923s left) kms_joiner (invalid-modeset-ultra-joiner)
[190.781483] Starting subtest: invalid-modeset-ultra-joiner
[190.784861] Subtest invalid-modeset-ultra-joiner: SKIP (0.000s)
[191.201894] [027/130] (922s left) kms_cursor_legacy (cursor-vs-flip-atomic)
[191.500247] Starting subtest: cursor-vs-flip-atomic
[222.267736] Subtest cursor-vs-flip-atomic: SUCCESS (30.767s)
[222.785222] [028/130] (891s left) kms_chamelium_hpd (hdmi-hpd-storm)
[223.164064] Subtest hdmi-hpd-storm: SKIP (0.000s)
[223.472699] [029/130] (890s left) gem_partial_pwrite_pread (reads)
[223.534947] Starting subtest: reads
[224.672157] Subtest reads: SUCCESS (1.137s)
[224.861481] [030/130] (889s left) kms_psr (psr-sprite-render)
[225.153411] Subtest psr-sprite-render: SKIP (0.000s)
[225.345378] [031/130] (888s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-render)
[225.650694] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-render
[227.597801] Subtest fbc-1p-primscrn-cur-indfb-draw-render: SUCCESS (1.949s)
[228.040053] [032/130] (886s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-pwrite)
[228.339251] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-pwrite
[228.342454] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[228.755290] [033/130] (885s left) i915_pm_rps (waitboost)
[228.821559] Starting subtest: waitboost
[232.352455] Subtest waitboost: SUCCESS (3.531s)
[232.525902] [034/130] (881s left) sw_sync (timeline_closed)
[232.582899] Starting subtest: timeline_closed
[232.584716] Subtest timeline_closed: SUCCESS (0.000s)
[232.695571] [035/130] (881s left) syncobj_timeline (multi-wait-available-unsubmitted-signaled)
[232.758963] Starting subtest: multi-wait-available-unsubmitted-signaled
[232.760851] Subtest multi-wait-available-unsubmitted-signaled: SUCCESS (0.001s)
[232.890653] [036/130] (881s left) kms_force_connector_basic (force-connector-state)
[232.960560] Starting subtest: force-connector-state
[233.349345] Subtest force-connector-state: SUCCESS (0.390s)
[233.901187] [037/130] (880s left) kms_plane_scaling (plane-scaler-unity-scaling-with-pixel-format)
[234.201478] Starting subtest: plane-scaler-unity-scaling-with-pixel-format
[234.203211] Starting dynamic subtest: pipe-A
[234.208111] Dynamic subtest pipe-A: SKIP (0.001s)
[234.221077] Starting dynamic subtest: pipe-B
[234.225804] Dynamic subtest pipe-B: SKIP (0.001s)
[234.228928] Subtest plane-scaler-unity-scaling-with-pixel-format: SKIP (0.005s)
[234.631535] [038/130] (879s left) kms_cursor_crc (cursor-sliding-64x21)
[234.927118] Starting subtest: cursor-sliding-64x21
[234.984511] Subtest cursor-sliding-64x21: SKIP (0.054s)
[235.411542] [039/130] (879s left) kms_flip_scaled_crc (flip-32bpp-linear-to-64bpp-linear-downscaling)
[235.474632] Subtest flip-32bpp-linear-to-64bpp-linear-downscaling: SKIP (0.000s)
[235.543530] [040/130] (879s left) syncobj_basic (bad-create-flags)
[235.601451] Starting subtest: bad-create-flags
[235.603113] Subtest bad-create-flags: SUCCESS (0.000s)
[235.730338] [041/130] (878s left) syncobj_timeline (etime-multi-wait-all-for-submit-available-unsubmitted-submi
[235.790919] Starting subtest: etime-multi-wait-all-for-submit-available-unsubmitted-submitted
[235.899810] Subtest etime-multi-wait-all-for-submit-available-unsubmitted-submitted: SUCCESS (0.108s)
[236.028492] [042/130] (878s left) fbdev (nullptr)
[236.090940] Starting subtest: nullptr
[236.092836] Subtest nullptr: SUCCESS (0.000s)
[236.208155] [043/130] (878s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-blt)
[236.510327] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-blt
[236.513686] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-blt: SKIP (0.000s)
[236.928576] [044/130] (877s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-blt)
[237.237502] Starting subtest: fbcpsr-rgb101010-draw-blt
[237.240690] Subtest fbcpsr-rgb101010-draw-blt: SKIP (0.000s)
[237.645720] [045/130] (877s left) kms_async_flips (async-flip-with-page-flip-events-tiled)
[237.946153] Starting subtest: async-flip-with-page-flip-events-tiled
[238.085959] Starting dynamic subtest: pipe-A-HDMI-A-1-x
[240.228824] Dynamic subtest pipe-A-HDMI-A-1-x: SUCCESS (2.141s)
[240.385842] Starting dynamic subtest: pipe-B-HDMI-A-1-x
[242.491695] Dynamic subtest pipe-B-HDMI-A-1-x: SUCCESS (2.117s)
[242.493600] Subtest async-flip-with-page-flip-events-tiled: SUCCESS (4.547s)
[243.151661] [046/130] (871s left) kms_rotation_crc (exhaust-fences)
[243.454197] Starting subtest: exhaust-fences
[243.457472] Subtest exhaust-fences: SKIP (0.000s)
[243.879440] [047/130] (871s left) kms_psr2_sf (fbc-psr2-overlay-plane-move-continuous-sf)
[244.178036] Subtest fbc-psr2-overlay-plane-move-continuous-sf: SKIP (0.000s)
[244.377043] [048/130] (870s left) kms_big_fb (4-tiled-16bpp-rotate-90)
[244.682856] Starting subtest: 4-tiled-16bpp-rotate-90
[244.686101] Subtest 4-tiled-16bpp-rotate-90: SKIP (0.000s)
[245.096443] [049/130] (870s left) kms_psr (psr2-primary-blt)
[245.388626] Subtest psr2-primary-blt: SKIP (0.000s)
[245.588208] [050/130] (869s left) kms_chamelium_frames (hdmi-crc-single)
[245.960881] Subtest hdmi-crc-single: SKIP (0.000s)
[246.279634] [051/130] (868s left) gem_pread (self)
[246.340356] Starting subtest: self
[246.363471] Subtest self: SUCCESS (0.024s)
[246.517606] [052/130] (868s left) gem_pxp (reject-modify-context-protection-off-1)
[249.098052] Starting subtest: reject-modify-context-protection-off-1
[249.102058] Subtest reject-modify-context-protection-off-1: SKIP (0.000s)
[249.228603] [053/130] (866s left) kms_ccs (crc-sprite-planes-basic-y-tiled-gen12-mc-ccs)
[249.287360] Subtest crc-sprite-planes-basic-y-tiled-gen12-mc-ccs: SKIP (0.000s)
[249.349789] [054/130] (866s left) gem_render_copy (y-tiled-ccs-to-y-tiled-ccs)
[249.422057] Starting subtest: y-tiled-ccs-to-y-tiled-ccs
[249.423895] Starting dynamic subtest: smem
[249.427655] Dynamic subtest smem: SKIP (0.000s)
[249.431517] Subtest y-tiled-ccs-to-y-tiled-ccs: SKIP (0.001s)
[249.662977] [055/130] (865s left) kms_ccs (crc-primary-suspend-4-tiled-bmg-ccs)
[249.719941] Subtest crc-primary-suspend-4-tiled-bmg-ccs: SKIP (0.000s)
[249.795416] [056/130] (865s left) gem_softpin (allocator-fork)
[249.863967] Subtest allocator-fork: SKIP (0.000s)
[249.989479] [057/130] (865s left) gem_ctx_param (invalid-set-ringsize)
[250.048157] Starting subtest: invalid-set-ringsize
[250.050041] Subtest invalid-set-ringsize: SUCCESS (0.000s)
[250.177512] [058/130] (865s left) kms_cursor_legacy (cursora-vs-flipa-varying-size)
[250.467827] Starting subtest: cursorA-vs-flipA-varying-size
[261.366213] Subtest cursorA-vs-flipA-varying-size: SUCCESS (10.898s)
[261.882031] [059/130] (853s left) gem_userptr_blits (sync-overlap)
[261.963020] Starting subtest: sync-overlap
[261.964710] Subtest sync-overlap: SUCCESS (0.000s)
[262.123322] [060/130] (853s left) gem_exec_capture (capture-invisible)
[262.185071] Subtest capture-invisible: SKIP (0.000s)
[262.263848] [061/130] (853s left) perf_pmu (interrupts)
[262.322344] Starting subtest: interrupts
[263.375774] Subtest interrupts: SUCCESS (1.053s)
[263.515067] [062/130] (852s left) gem_exec_reloc (basic-wc-gtt-active)
[263.577439] Starting subtest: basic-wc-gtt-active
[263.688699] Subtest basic-wc-gtt-active: SUCCESS (0.110s)
[264.336667] [063/130] (851s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-onoff)
[264.637274] Starting subtest: psr-1p-primscrn-cur-indfb-onoff
[264.640455] Subtest psr-1p-primscrn-cur-indfb-onoff: SKIP (0.000s)
[265.045076] [064/130] (850s left) i915_pm_rpm (debugfs-read)
[276.543400] Subtest debugfs-read: SKIP (0.000s)
[276.733487] [065/130] (839s left) kms_chamelium_audio (dp-audio)
[277.159208] Subtest dp-audio: SKIP (0.000s)
[277.607458] [066/130] (838s left) kms_addfb_basic (addfb25-bad-modifier)
[278.044245] Starting subtest: addfb25-bad-modifier
[278.045926] Subtest addfb25-bad-modifier: SUCCESS (0.001s)
[278.370094] [067/130] (837s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-indfb-draw-mmap-cpu)
[278.673356] Starting subtest: fbc-1p-offscreen-pri-indfb-draw-mmap-cpu
[280.112052] Subtest fbc-1p-offscreen-pri-indfb-draw-mmap-cpu: SUCCESS (1.442s)
[280.569908] [068/130] (835s left) gem_wait (await)
[280.645411] Starting subtest: await
[280.646965] Starting dynamic subtest: all-engines
[281.670379] Dynamic subtest all-engines: SUCCESS (1.024s)
[281.686193] Starting dynamic subtest: rcs0
[282.701476] Dynamic subtest rcs0: SUCCESS (1.028s)
[282.717353] Starting dynamic subtest: bcs0
[283.731206] Dynamic subtest bcs0: SUCCESS (1.027s)
[283.746767] Starting dynamic subtest: vcs0
[284.758264] Dynamic subtest vcs0: SUCCESS (1.024s)
[284.760165] Subtest await: SUCCESS (4.114s)
[285.032149] [069/130] (831s left) perf_pmu (event-wait)
[285.091124] Starting subtest: event-wait
[285.092898] Starting dynamic subtest: rcs0
[285.096821] Dynamic subtest rcs0: SKIP (0.000s)
[285.100677] Subtest event-wait: SKIP (0.002s)
[285.216804] [070/130] (831s left) kms_frontbuffer_tracking (fbc-1p-primscrn-indfb-msflip-blt)
[285.517234] Starting subtest: fbc-1p-primscrn-indfb-msflip-blt
[287.428608] Subtest fbc-1p-primscrn-indfb-msflip-blt: SUCCESS (1.912s)
[287.886614] [071/130] (828s left) kms_flip (2x-blocking-wf_vblank)
[288.187738] Starting subtest: 2x-blocking-wf_vblank
[288.189424] Starting dynamic subtest: AB-VGA1-HDMI-A1
[318.891124] Dynamic subtest AB-VGA1-HDMI-A1: SUCCESS (30.707s)
[318.892873] Subtest 2x-blocking-wf_vblank: SUCCESS (30.711s)
[319.501530] [072/130] (797s left) perf (invalid-oa-format-id)
[319.687569] Subtest invalid-oa-format-id: SKIP (0.000s)
[319.745868] [073/130] (796s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-cpu)
[320.047737] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-cpu
[320.051048] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[320.452878] [074/130] (796s left) gem_exec_reloc (basic-gtt-noreloc)
[320.512911] Starting subtest: basic-gtt-noreloc
[320.516880] Subtest basic-gtt-noreloc: SUCCESS (0.003s)
[321.165319] [075/130] (795s left) kms_ccs (crc-primary-basic-y-tiled-ccs)
[321.226438] Subtest crc-primary-basic-y-tiled-ccs: SKIP (0.000s)
[321.294431] [076/130] (795s left) syncobj_timeline (multi-wait-all-available-submitted-signaled)
[321.353916] Starting subtest: multi-wait-all-available-submitted-signaled
[321.356067] Subtest multi-wait-all-available-submitted-signaled: SUCCESS (0.001s)
[321.482043] [077/130] (795s left) kms_frontbuffer_tracking (psr-rgb565-draw-render)
[321.778842] Starting subtest: psr-rgb565-draw-render
[321.782070] Subtest psr-rgb565-draw-render: SKIP (0.000s)
[322.181888] [078/130] (794s left) syncobj_wait (invalid-single-wait-unsubmitted)
[322.242642] Starting subtest: invalid-single-wait-unsubmitted
[322.244584] Subtest invalid-single-wait-unsubmitted: SUCCESS (0.000s)
[322.374273] [079/130] (794s left) kms_psr (fbc-psr2-primary-mmap-cpu)
[322.666151] Subtest fbc-psr2-primary-mmap-cpu: SKIP (0.000s)
[322.878291] [080/130] (794s left) gem_mmap_offset (isolation)
[322.941106] Starting subtest: isolation
[322.958130] Subtest isolation: SUCCESS (0.006s)
[323.097699] [081/130] (794s left) kms_flip (2x-flip-vs-panning-interruptible)
[323.405085] Starting subtest: 2x-flip-vs-panning-interruptible
[323.409152] Starting dynamic subtest: AB-VGA1-HDMI-A1
[353.757842] Dynamic subtest AB-VGA1-HDMI-A1: SUCCESS (30.352s)
[353.762226] Subtest 2x-flip-vs-panning-interruptible: SUCCESS (30.356s)
[354.376655] [082/130] (762s left) gem_exec_reloc (basic-concurrent0)
[354.437492] Starting subtest: basic-concurrent0
[359.826298] Subtest basic-concurrent0: SUCCESS (5.390s)
[360.484650] [083/130] (756s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-0-async-flip)
[360.784382] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-0-async-flip
[361.335491] Subtest x-tiled-max-hw-stride-64bpp-rotate-0-async-flip: SUCCESS (0.550s)
[361.839868] [084/130] (755s left) kms_dirtyfb (fbc-dirtyfb-ioctl)
[362.138641] Starting subtest: fbc-dirtyfb-ioctl
[362.140355] Starting dynamic subtest: A-HDMI-A-1
[363.496176] Dynamic subtest A-HDMI-A-1: SUCCESS (1.357s)
[363.497900] Subtest fbc-dirtyfb-ioctl: SUCCESS (1.359s)
[364.014475] [085/130] (753s left) kms_invalid_mode (clock-too-high)
[364.310626] Starting subtest: clock-too-high
[364.312238] Starting dynamic subtest: pipe-A-HDMI-A-1
[364.377030] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.068s)
[364.391122] Starting dynamic subtest: pipe-B-HDMI-A-1
[364.392869] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.001s)
[364.394514] Subtest clock-too-high: SUCCESS (0.073s)
[364.763461] [086/130] (752s left) kms_psr2_sf (psr2-primary-plane-update-sf-dmg-area-big-fb)
[365.249969] Subtest psr2-primary-plane-update-sf-dmg-area-big-fb: SKIP (0.000s)
[365.440174] [087/130] (752s left) kms_universal_plane (universal-plane-functional)
[365.823421] Starting subtest: universal-plane-functional
[365.847904] Starting dynamic subtest: pipe-A-HDMI-A-1
[367.718073] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (1.937s)
[367.734027] Starting dynamic subtest: pipe-B-HDMI-A-1
[369.678651] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (1.957s)
[369.680527] Subtest universal-plane-functional: SUCCESS (3.900s)
[370.207576] [088/130] (747s left) kms_addfb_basic (unused-offsets)
[370.272720] Starting subtest: unused-offsets
[370.274363] Subtest unused-offsets: SUCCESS (0.000s)
[370.922312] [089/130] (746s left) gem_sync (basic-all)
[370.993734] Starting subtest: basic-all
[373.051607] Subtest basic-all: SUCCESS (2.058s)
[373.300755] [090/130] (744s left) gen9_exec_parse (bb-start-far)
[373.364527] Subtest bb-start-far: SKIP (0.000s)
[373.431945] [091/130] (744s left) gem_exec_store (basic)
[373.500853] Starting subtest: basic
[373.557805] Subtest basic: SUCCESS (0.056s)
[373.800334] [092/130] (744s left) gem_create (busy-create)
[373.864952] Starting subtest: busy-create
[373.866706] Starting dynamic subtest: smem0
[406.116538] Dynamic subtest smem0: SUCCESS (32.251s)
[406.118761] Subtest busy-create: SUCCESS (32.253s)
[406.362933] [093/130] (711s left) kms_prime (basic-crc-vgem)
[406.690117] Starting subtest: basic-crc-vgem
[406.691720] Starting dynamic subtest: second-to-first
[407.898561] Dynamic subtest second-to-first: SUCCESS (1.224s)
[407.900393] Subtest basic-crc-vgem: SUCCESS (1.226s)
[408.878721] [094/130] (709s left) gem_exec_alignment (pi-isolated)
[408.943835] Starting subtest: pi-isolated
[408.947723] Subtest pi-isolated: SKIP (0.000s)
[409.118894] [095/130] (708s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-0)
[409.423114] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-0
[410.523269] Subtest x-tiled-max-hw-stride-32bpp-rotate-0: SUCCESS (1.099s)
[410.976721] [096/130] (707s left) i915_module_load (reload)
[411.038581] Starting subtest: reload
[413.813664] Subtest reload: SUCCESS (2.776s)
[413.865187] [097/130] (704s left) kms_big_fb (y-tiled-addfb-size-overflow)
[414.197380] Starting subtest: y-tiled-addfb-size-overflow
[414.200618] Subtest y-tiled-addfb-size-overflow: SKIP (0.000s)
[414.621566] [098/130] (703s left) syncobj_timeline (etime-single-wait-all-for-submit-unsubmitted)
[414.680018] Starting subtest: etime-single-wait-all-for-submit-unsubmitted
[414.786509] Subtest etime-single-wait-all-for-submit-unsubmitted: SUCCESS (0.106s)
[414.915405] [099/130] (703s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-cpu)
[415.215862] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-cpu
[415.219149] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[415.643368] [100/130] (702s left) kms_psr (fbc-psr-basic)
[415.941519] Subtest fbc-psr-basic: SKIP (0.000s)
[416.146333] [101/130] (702s left) gem_exec_reloc (basic-write-gtt-active)
[416.209594] Starting subtest: basic-write-gtt-active
[416.322300] Subtest basic-write-gtt-active: SUCCESS (0.112s)
[416.957759] [102/130] (701s left) kms_flip (2x-flip-vs-modeset-vs-hang)
[417.252993] Starting subtest: 2x-flip-vs-modeset-vs-hang
[417.254840] Starting dynamic subtest: AB-VGA1-HDMI-A1
[429.873731] Dynamic subtest AB-VGA1-HDMI-A1: SUCCESS (12.619s)
[429.875333] Subtest 2x-flip-vs-modeset-vs-hang: SUCCESS (12.622s)
[430.412780] [103/130] (688s left) api_intel_bb (misplaced-blitter)
[430.475692] Starting subtest: misplaced-blitter
[430.480220] Subtest misplaced-blitter: SUCCESS (0.004s)
[430.643975] [104/130] (687s left) gem_exec_whisper (basic-sync-all)
[430.712692] Starting subtest: basic-sync-all
[431.702174] Subtest basic-sync-all: SUCCESS (0.988s)
[431.940293] [105/130] (686s left) kms_big_fb (linear-32bpp-rotate-0)
[432.247091] Starting subtest: linear-32bpp-rotate-0
[433.803415] Subtest linear-32bpp-rotate-0: SUCCESS (1.555s)
[434.253954] [106/130] (684s left) gem_exec_reloc (basic-gtt-cpu-noreloc)
[434.316214] Starting subtest: basic-gtt-cpu-noreloc
[434.320706] Subtest basic-gtt-cpu-noreloc: SUCCESS (0.003s)
[434.969605] [107/130] (683s left) kms_flip (2x-plain-flip-ts-check)
[435.261859] Starting subtest: 2x-plain-flip-ts-check
[435.266215] Starting dynamic subtest: AB-VGA1-HDMI-A1
[465.889062] Dynamic subtest AB-VGA1-HDMI-A1: SUCCESS (30.624s)
[465.893730] Subtest 2x-plain-flip-ts-check: SUCCESS (30.629s)
[466.531885] [108/130] (652s left) sriov_basic (enable-vfs-autoprobe-on)
[466.597822] Subtest enable-vfs-autoprobe-on: SKIP (0.000s)
[466.659809] [109/130] (652s left) kms_cursor_legacy (cursora-vs-flipa-atomic)
[466.953008] Starting subtest: cursorA-vs-flipA-atomic
[477.853363] Subtest cursorA-vs-flipA-atomic: SUCCESS (10.901s)
[478.380225] [110/130] (640s left) gem_exec_balancer (parallel)
[478.447539] Subtest parallel: SKIP (0.000s)
[478.578811] [111/130] (640s left) dmabuf_sync_file (import-multiple-read-only)
[478.654039] Starting subtest: import-multiple-read-only
[478.657782] Subtest import-multiple-read-only: SUCCESS (0.006s)
[478.776431] [112/130] (640s left) perf (gen12-group-exclusive-stream-ctx-handle)
[478.924851] Subtest gen12-group-exclusive-stream-ctx-handle: SKIP (0.000s)
[478.987365] [113/130] (640s left) kms_busy (extended-modeset-hang-oldfb-with-reset)
[479.289338] Starting subtest: extended-modeset-hang-oldfb-with-reset
[479.291044] Starting dynamic subtest: pipe-A
[489.845036] Dynamic subtest pipe-A: SUCCESS (10.555s)
[489.857727] Starting dynamic subtest: pipe-B
[500.599563] Dynamic subtest pipe-B: SUCCESS (10.752s)
[500.601182] Subtest extended-modeset-hang-oldfb-with-reset: SUCCESS (21.312s)
[501.107729] [114/130] (618s left) gem_exec_schedule (u-semaphore-noskip)
[501.184194] Subtest u-semaphore-noskip: SKIP (0.000s)
[501.429229] [115/130] (617s left) gem_gtt_cpu_tlb
[501.639633] [116/130] (617s left) kms_frontbuffer_tracking (pipe-fbc-rte)
[501.944318] Starting subtest: pipe-fbc-rte
[501.949293] Starting dynamic subtest: pipe-B-HDMI-A-1
[505.278182] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (3.335s)
[505.279909] Subtest pipe-fbc-rte: SUCCESS (3.338s)
[505.885828] [117/130] (613s left) kms_content_protection (mei-interface)
[506.203103] Starting subtest: mei-interface
[506.206311] Subtest mei-interface: SKIP (0.002s)
[506.619818] [118/130] (612s left) kms_frontbuffer_tracking (psr-2p-primscrn-indfb-pgflip-blt)
[506.919996] Starting subtest: psr-2p-primscrn-indfb-pgflip-blt
[506.923241] Subtest psr-2p-primscrn-indfb-pgflip-blt: SKIP (0.000s)
[507.342338] [119/130] (612s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-32bpp-4tile-upscaling)
[507.402746] Subtest flip-64bpp-4tile-to-32bpp-4tile-upscaling: SKIP (0.000s)
[507.462430] [120/130] (612s left) kms_color (invalid-gamma-lut-sizes)
[507.757764] Starting subtest: invalid-gamma-lut-sizes
[507.759475] Starting dynamic subtest: pipe-A
[507.827927] Dynamic subtest pipe-A: SUCCESS (0.070s)
[507.842570] Starting dynamic subtest: pipe-B
[507.844218] Dynamic subtest pipe-B: SUCCESS (0.001s)
[507.845937] Subtest invalid-gamma-lut-sizes: SUCCESS (0.074s)
[508.350577] [121/130] (611s left) kms_frontbuffer_tracking (psr-2p-scndscrn-indfb-plflip-blt)
[508.651642] Starting subtest: psr-2p-scndscrn-indfb-plflip-blt
[508.655160] Subtest psr-2p-scndscrn-indfb-plflip-blt: SKIP (0.000s)
[509.064717] [122/130] (610s left) gem_softpin (noreloc-interruptible)
[509.127926] Starting subtest: noreloc-interruptible
[514.513846] Subtest noreloc-interruptible: SUCCESS (5.386s)
[514.669819] [123/130] (605s left) kms_atomic_transition (modeset-transition-fencing)
[514.966089] Starting subtest: modeset-transition-fencing
[514.967806] Starting dynamic subtest: 1x-outputs
[515.929207] Dynamic subtest 1x-outputs: SUCCESS (0.962s)
[515.930882] Subtest modeset-transition-fencing: SUCCESS (0.964s)
[516.469230] [124/130] (603s left) gem_mmap_wc (coherency)
[516.528581] Starting subtest: coherency
[516.594952] Subtest coherency: SUCCESS (0.066s)
[516.760582] [125/130] (603s left) gem_fenced_exec_thrash (no-spare-fences-busy-interruptible)
[516.817641] Starting subtest: no-spare-fences-busy-interruptible
[518.994293] Subtest no-spare-fences-busy-interruptible: SUCCESS (2.176s)
[519.168244] [126/130] (600s left) gen9_exec_parse (valid-registers)
[519.234640] Subtest valid-registers: SKIP (0.000s)
[519.294494] [127/130] (600s left) perf (sysctl-defaults)
[519.431339] Starting subtest: sysctl-defaults
[519.433031] Subtest sysctl-defaults: SUCCESS (0.000s)
[519.496128] [128/130] (600s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-mmap-cpu)
[519.800581] Starting subtest: psr-1p-primscrn-spr-indfb-draw-mmap-cpu
[519.803797] Subtest psr-1p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[520.216515] [129/130] (599s left) kms_frontbuffer_tracking (psr-2p-scndscrn-shrfb-pgflip-blt)
[520.520076] Starting subtest: psr-2p-scndscrn-shrfb-pgflip-blt
[520.523248] Subtest psr-2p-scndscrn-shrfb-pgflip-blt: SKIP (0.000s)
[520.931386] [130/130] (599s left) kms_psr (psr2-cursor-plane-move)
[521.250761] Subtest psr2-cursor-plane-move: SKIP (0.000s)
[521.455822] Closing watchdogs
results: parsing output: 0/ for test: kms_frontbuffer_tracking
results: parsing output: 1/ for test: gem_exec_schedule
results: parsing output: 2/ for test: gem_mmap_gtt
results: parsing output: 3/ for test: gem_exec_fence
results: parsing output: 4/ for test: kms_big_fb
results: parsing output: 5/ for test: kms_flip
results: parsing output: 6/ for test: kms_flip
results: parsing output: 7/ for test: gem_exec_reloc
results: parsing output: 8/ for test: kms_plane_scaling
results: parsing output: 9/ for test: gem_ctx_persistence
results: parsing output: 10/ for test: syncobj_wait
results: parsing output: 11/ for test: kms_plane_alpha_blend
results: parsing output: 12/ for test: kms_vrr
results: parsing output: 13/ for test: kms_ccs
results: parsing output: 14/ for test: gem_exec_flush
results: parsing output: 15/ for test: gem_partial_pwrite_pread
results: parsing output: 16/ for test: syncobj_wait
results: parsing output: 17/ for test: gem_exec_reloc
results: parsing output: 18/ for test: kms_psr2_sf
results: parsing output: 19/ for test: kms_cursor_crc
results: parsing output: 20/ for test: kms_plane_alpha_blend
results: parsing output: 21/ for test: kms_dsc
results: parsing output: 22/ for test: api_intel_allocator
results: parsing output: 23/ for test: kms_pm_rpm
results: parsing output: 24/ for test: syncobj_timeline
results: parsing output: 25/ for test: kms_joiner
results: parsing output: 26/ for test: kms_cursor_legacy
results: parsing output: 27/ for test: kms_chamelium_hpd
results: parsing output: 28/ for test: gem_partial_pwrite_pread
results: parsing output: 29/ for test: kms_psr
results: parsing output: 30/ for test: kms_frontbuffer_tracking
results: parsing output: 31/ for test: kms_frontbuffer_tracking
results: parsing output: 32/ for test: i915_pm_rps
results: parsing output: 33/ for test: sw_sync
results: parsing output: 34/ for test: syncobj_timeline
results: parsing output: 35/ for test: kms_force_connector_basic
results: parsing output: 36/ for test: kms_plane_scaling
results: parsing output: 37/ for test: kms_cursor_crc
results: parsing output: 38/ for test: kms_flip_scaled_crc
results: parsing output: 39/ for test: syncobj_basic
results: parsing output: 40/ for test: syncobj_timeline
results: parsing output: 41/ for test: fbdev
results: parsing output: 42/ for test: kms_frontbuffer_tracking
results: parsing output: 43/ for test: kms_frontbuffer_tracking
results: parsing output: 44/ for test: kms_async_flips
results: parsing output: 45/ for test: kms_rotation_crc
results: parsing output: 46/ for test: kms_psr2_sf
results: parsing output: 47/ for test: kms_big_fb
results: parsing output: 48/ for test: kms_psr
results: parsing output: 49/ for test: kms_chamelium_frames
results: parsing output: 50/ for test: gem_pread
results: parsing output: 51/ for test: gem_pxp
results: parsing output: 52/ for test: kms_ccs
results: parsing output: 53/ for test: gem_render_copy
results: parsing output: 54/ for test: kms_ccs
results: parsing output: 55/ for test: gem_softpin
results: parsing output: 56/ for test: gem_ctx_param
results: parsing output: 57/ for test: kms_cursor_legacy
results: parsing output: 58/ for test: gem_userptr_blits
results: parsing output: 59/ for test: gem_exec_capture
results: parsing output: 60/ for test: perf_pmu
results: parsing output: 61/ for test: gem_exec_reloc
results: parsing output: 62/ for test: kms_frontbuffer_tracking
results: parsing output: 63/ for test: i915_pm_rpm
results: parsing output: 64/ for test: kms_chamelium_audio
results: parsing output: 65/ for test: kms_addfb_basic
results: parsing output: 66/ for test: kms_frontbuffer_tracking
results: parsing output: 67/ for test: gem_wait
results: parsing output: 68/ for test: perf_pmu
results: parsing output: 69/ for test: kms_frontbuffer_tracking
results: parsing output: 70/ for test: kms_flip
results: parsing output: 71/ for test: perf
results: parsing output: 72/ for test: kms_frontbuffer_tracking
results: parsing output: 73/ for test: gem_exec_reloc
results: parsing output: 74/ for test: kms_ccs
results: parsing output: 75/ for test: syncobj_timeline
results: parsing output: 76/ for test: kms_frontbuffer_tracking
results: parsing output: 77/ for test: syncobj_wait
results: parsing output: 78/ for test: kms_psr
results: parsing output: 79/ for test: gem_mmap_offset
results: parsing output: 80/ for test: kms_flip
results: parsing output: 81/ for test: gem_exec_reloc
results: parsing output: 82/ for test: kms_big_fb
results: parsing output: 83/ for test: kms_dirtyfb
results: parsing output: 84/ for test: kms_invalid_mode
results: parsing output: 85/ for test: kms_psr2_sf
results: parsing output: 86/ for test: kms_universal_plane
results: parsing output: 87/ for test: kms_addfb_basic
results: parsing output: 88/ for test: gem_sync
results: parsing output: 89/ for test: gen9_exec_parse
results: parsing output: 90/ for test: gem_exec_store
results: parsing output: 91/ for test: gem_create
results: parsing output: 92/ for test: kms_prime
results: parsing output: 93/ for test: gem_exec_alignment
results: parsing output: 94/ for test: kms_big_fb
results: parsing output: 95/ for test: i915_module_load
results: parsing output: 96/ for test: kms_big_fb
results: parsing output: 97/ for test: syncobj_timeline
results: parsing output: 98/ for test: kms_frontbuffer_tracking
results: parsing output: 99/ for test: kms_psr
results: parsing output: 100/ for test: gem_exec_reloc
results: parsing output: 101/ for test: kms_flip
results: parsing output: 102/ for test: api_intel_bb
results: parsing output: 103/ for test: gem_exec_whisper
results: parsing output: 104/ for test: kms_big_fb
results: parsing output: 105/ for test: gem_exec_reloc
results: parsing output: 106/ for test: kms_flip
results: parsing output: 107/ for test: sriov_basic
results: parsing output: 108/ for test: kms_cursor_legacy
results: parsing output: 109/ for test: gem_exec_balancer
results: parsing output: 110/ for test: dmabuf_sync_file
results: parsing output: 111/ for test: perf
results: parsing output: 112/ for test: kms_busy
results: parsing output: 113/ for test: gem_exec_schedule
results: parsing output: 114/ for test: gem_gtt_cpu_tlb
results: parsing output: 115/ for test: kms_frontbuffer_tracking
results: parsing output: 116/ for test: kms_content_protection
results: parsing output: 117/ for test: kms_frontbuffer_tracking
results: parsing output: 118/ for test: kms_flip_scaled_crc
results: parsing output: 119/ for test: kms_color
results: parsing output: 120/ for test: kms_frontbuffer_tracking
results: parsing output: 121/ for test: gem_softpin
results: parsing output: 122/ for test: kms_atomic_transition
results: parsing output: 123/ for test: gem_mmap_wc
results: parsing output: 124/ for test: gem_fenced_exec_thrash
results: parsing output: 125/ for test: gen9_exec_parse
results: parsing output: 126/ for test: perf
results: parsing output: 127/ for test: kms_frontbuffer_tracking
results: parsing output: 128/ for test: kms_frontbuffer_tracking
results: parsing output: 129/ for test: kms_psr
Done.