[68.180056] Initializing watchdogs
[68.180170]   /dev/watchdog0
[68.201795] [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)
[68.210918] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[68.216800] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[68.221706] [001/134] (960s left) kms_cursor_crc (cursor-offscreen-256x85)
[68.738526] Starting subtest: cursor-offscreen-256x85
[68.797709] Subtest cursor-offscreen-256x85: SKIP (0.059s)
[69.397796] [002/134] (959s left) gem_mmap_gtt (cpuset-big-copy-odd)
[69.453941] Starting subtest: cpuset-big-copy-odd
[72.947965] Subtest cpuset-big-copy-odd: SUCCESS (3.496s)
[73.193248] [003/134] (955s left) gem_ctx_engines (execute-allforone)
[73.336373] Starting subtest: execute-allforone
[73.338277] Subtest execute-allforone: SUCCESS (0.002s)
[73.609532] [004/134] (955s left) perf_pmu (busy-idle)
[73.666403] Starting subtest: busy-idle
[73.667407] Starting dynamic subtest: rcs0
[74.299274] Dynamic subtest rcs0: SUCCESS (0.633s)
[74.318578] Starting dynamic subtest: bcs0
[74.940347] Dynamic subtest bcs0: SUCCESS (0.640s)
[74.958892] Starting dynamic subtest: vcs0
[76.080376] Dynamic subtest vcs0: SUCCESS (1.139s)
[76.081562] Subtest busy-idle: SUCCESS (2.416s)
[76.200829] [005/134] (952s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip)
[76.713918] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip
[76.715986] Subtest x-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip: SKIP (0.001s)
[77.320983] [006/134] (951s left) api_intel_bb (lot-of-buffers)
[77.384452] Starting subtest: lot-of-buffers
[78.107605] Subtest lot-of-buffers: SUCCESS (0.724s)
[78.428245] [007/134] (950s left) gem_render_copy (yf-tiled-to-vebox-x-tiled)
[78.492204] Starting subtest: yf-tiled-to-vebox-x-tiled
[78.493352] Subtest yf-tiled-to-vebox-x-tiled: SKIP (0.000s)
[78.722742] [008/134] (950s left) kms_plane (plane-panning-top-left)
[79.215862] Starting subtest: plane-panning-top-left
[79.216589] Starting dynamic subtest: pipe-A
[79.942876] Dynamic subtest pipe-A: SUCCESS (0.727s)
[79.953844] Starting dynamic subtest: pipe-B
[80.543834] Dynamic subtest pipe-B: SUCCESS (0.600s)
[80.544405] Subtest plane-panning-top-left: SUCCESS (1.329s)
[81.266939] [009/134] (947s left) kms_psr (fbc-psr-cursor-plane-onoff)
[81.759056] Subtest fbc-psr-cursor-plane-onoff: SKIP (0.000s)
[82.042919] [010/134] (947s left) kms_cursor_crc (cursor-tearing-position-change)
[82.534482] Starting subtest: cursor-tearing-position-change
[82.535116] Starting dynamic subtest: pipe-A-HDMI-A-1
[82.919085] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.384s)
[82.931648] Starting dynamic subtest: pipe-B-HDMI-A-1
[83.283206] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.362s)
[83.283819] Subtest cursor-tearing-position-change: SUCCESS (0.749s)
[84.008606] [011/134] (945s left) kms_frontbuffer_tracking (basic)
[84.507077] Starting subtest: basic
[86.908622] Subtest basic: SUCCESS (2.402s)
[87.532988] [012/134] (941s left) gem_spin_batch (spin-each)
[87.598677] Starting subtest: spin-each
[90.932096] Subtest spin-each: SUCCESS (3.334s)
[91.174469] [013/134] (938s left) gem_exec_reloc (basic-gtt-cpu)
[91.235934] Starting subtest: basic-gtt-cpu
[91.239892] Subtest basic-gtt-cpu: SUCCESS (0.004s)
[92.274814] [014/134] (937s left) kms_plane (pixel-format-4-tiled-mtl-rc-ccs-modifier)
[92.766803] Starting subtest: pixel-format-4-tiled-mtl-rc-ccs-modifier
[92.812835] Starting dynamic subtest: pipe-A-plane-0
[92.814921] Dynamic subtest pipe-A-plane-0: SKIP (0.000s)
[92.826768] Starting dynamic subtest: pipe-A-plane-1
[92.827891] Dynamic subtest pipe-A-plane-1: SKIP (0.000s)
[92.838654] Starting dynamic subtest: pipe-A-plane-2
[92.839781] Dynamic subtest pipe-A-plane-2: SKIP (0.000s)
[93.091569] Starting dynamic subtest: pipe-B-plane-0
[93.092679] Dynamic subtest pipe-B-plane-0: SKIP (0.000s)
[93.103239] Starting dynamic subtest: pipe-B-plane-1
[93.104437] Dynamic subtest pipe-B-plane-1: SKIP (0.000s)
[93.114714] Starting dynamic subtest: pipe-B-plane-2
[93.115696] Dynamic subtest pipe-B-plane-2: SKIP (0.000s)
[93.179490] Subtest pixel-format-4-tiled-mtl-rc-ccs-modifier: SKIP (0.413s)
[93.875295] [015/134] (935s left) gem_render_copy (y-tiled-ccs-to-linear)
[93.934977] Starting subtest: y-tiled-ccs-to-linear
[93.935718] Starting dynamic subtest: smem
[93.937516] Dynamic subtest smem: SKIP (0.000s)
[93.939325] Subtest y-tiled-ccs-to-linear: SKIP (0.000s)
[94.157529] [016/134] (935s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip)
[94.654821] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip
[94.655797] Subtest yf-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip: SKIP (0.000s)
[95.241269] [017/134] (934s left) kms_psr (pr-sprite-render)
[95.730616] Subtest pr-sprite-render: SKIP (0.000s)
[96.014679] [018/134] (933s left) gen9_exec_parse (shadow-peek)
[96.071151] Subtest shadow-peek: SKIP (0.000s)
[96.132671] [019/134] (933s left) perf (invalid-remove-userspace-config)
[96.318165] Subtest invalid-remove-userspace-config: SKIP (0.000s)
[96.363983] [020/134] (933s left) gem_ctx_param (invalid-size-set)
[96.419235] Starting subtest: invalid-size-set
[96.419810] Subtest invalid-size-set: SUCCESS (0.000s)
[96.522217] [021/134] (933s left) kms_ccs (bad-rotation-90-y-tiled-gen12-rc-ccs-cc)
[96.575569] Subtest bad-rotation-90-y-tiled-gen12-rc-ccs-cc: SKIP (0.000s)
[96.631327] [022/134] (933s left) gem_exec_params (invalid-bsd2-flag-on-blt)
[96.684106] Starting subtest: invalid-bsd2-flag-on-blt
[96.684646] Subtest invalid-bsd2-flag-on-blt: SUCCESS (0.000s)
[96.801316] [023/134] (932s left) gem_render_copy (yf-tiled-ccs-to-linear)
[96.861383] Starting subtest: yf-tiled-ccs-to-linear
[96.862245] Starting dynamic subtest: smem
[96.863902] Dynamic subtest smem: SKIP (0.000s)
[96.865713] Subtest yf-tiled-ccs-to-linear: SKIP (0.001s)
[97.085605] [024/134] (932s left) syncobj_timeline (etime-multi-wait-for-submit-unsubmitted)
[97.139047] Starting subtest: etime-multi-wait-for-submit-unsubmitted
[97.245512] Subtest etime-multi-wait-for-submit-unsubmitted: SUCCESS (0.106s)
[97.369850] [025/134] (932s left) gem_exec_fence (invalid-timeline-fence-array)
[97.721348] Starting subtest: invalid-timeline-fence-array
[97.724995] Subtest invalid-timeline-fence-array: SUCCESS (0.005s)
[97.983583] [FACT gem_exec_fence (invalid-timeline-fence-array)] new: kernel.kmod_is_loaded.vgem: true
[97.986243] [026/134] (931s left) kms_chamelium_edid (dp-edid-read)
[98.557983] Subtest dp-edid-read: SKIP (0.000s)
[98.961808] [027/134] (930s left) gem_exec_params (invalid-bsd1-flag-on-render)
[99.019663] Starting subtest: invalid-bsd1-flag-on-render
[99.020366] Subtest invalid-bsd1-flag-on-render: SUCCESS (0.000s)
[99.166521] [028/134] (930s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-180)
[99.669288] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-180
[99.670310] Subtest 4-tiled-max-hw-stride-64bpp-rotate-180: SKIP (0.000s)
[100.279411] [029/134] (929s left) kms_ccs (crc-primary-rotation-180-y-tiled-ccs)
[100.333916] Subtest crc-primary-rotation-180-y-tiled-ccs: SKIP (0.000s)
[100.388893] [030/134] (929s left) gem_eio (kms)
[100.888405] Starting subtest: kms
[105.741048] Subtest kms: SUCCESS (4.854s)
[106.508682] [031/134] (923s left) kms_cursor_legacy (torture-move)
[106.999224] Starting subtest: torture-move
[106.999815] Starting dynamic subtest: pipe-A
[112.526583] Dynamic subtest pipe-A: SUCCESS (5.527s)
[112.538967] Starting dynamic subtest: pipe-B
[118.136410] Dynamic subtest pipe-B: SUCCESS (5.610s)
[118.148944] Starting dynamic subtest: all-pipes
[123.807497] Dynamic subtest all-pipes: SUCCESS (5.670s)
[123.808322] Subtest torture-move: SUCCESS (16.810s)
[124.398713] [032/134] (905s left) kms_ccs (bad-pixel-format-yf-tiled-ccs)
[124.450340] Subtest bad-pixel-format-yf-tiled-ccs: SKIP (0.000s)
[124.511164] [033/134] (905s left) gem_exec_capture (pi)
[124.570104] Subtest pi: SKIP (0.000s)
[124.642230] [034/134] (905s left) syncobj_timeline (wait-all-snapshot)
[124.697815] Starting subtest: wait-all-snapshot
[124.779709] Subtest wait-all-snapshot: SUCCESS (0.082s)
[124.916607] [035/134] (905s left) kms_async_flips (test-cursor-atomic)
[125.402934] Starting subtest: test-cursor-atomic
[125.549074] Starting dynamic subtest: pipe-A-HDMI-A-1
[125.721864] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.173s)
[125.882235] Starting dynamic subtest: pipe-B-HDMI-A-1
[125.974178] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.105s)
[125.974766] Subtest test-cursor-atomic: SUCCESS (0.573s)
[126.849858] [036/134] (903s left) kms_big_fb (x-tiled-32bpp-rotate-180)
[127.357267] Starting subtest: x-tiled-32bpp-rotate-180
[128.803925] Subtest x-tiled-32bpp-rotate-180: SUCCESS (1.447s)
[129.433459] [037/134] (900s left) i915_pm_freq_api (freq-reset)
[129.492292] Subtest freq-reset: SKIP (0.000s)
[129.544634] [038/134] (900s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-mmap-wc)
[130.032243] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-mmap-wc
[131.865247] Subtest fbc-1p-primscrn-pri-indfb-draw-mmap-wc: SUCCESS (1.832s)
[132.511527] [039/134] (897s left) kms_ccs (random-ccs-data-y-tiled-gen12-rc-ccs-cc)
[132.570384] Subtest random-ccs-data-y-tiled-gen12-rc-ccs-cc: SKIP (0.000s)
[132.624497] [040/134] (897s left) gem_mmap (short-mmap)
[132.678732] Starting subtest: short-mmap
[132.679495] Subtest short-mmap: SUCCESS (0.000s)
[132.826821] [041/134] (897s left) vgem_basic (dmabuf-export)
[132.878951] Starting subtest: dmabuf-export
[132.881711] Subtest dmabuf-export: SUCCESS (0.003s)
[133.027138] [042/134] (897s left) gem_render_copy (y-tiled)
[133.087228] Starting subtest: y-tiled
[133.087856] Starting dynamic subtest: smem
[133.151381] Dynamic subtest smem: SUCCESS (0.064s)
[133.152181] Subtest y-tiled: SUCCESS (0.065s)
[133.395276] [043/134] (897s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-pwrite)
[133.887979] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-pwrite
[133.889091] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[134.474562] [044/134] (896s left) gem_exec_schedule (implicit-write-read)
[134.541483] Starting subtest: implicit-write-read
[134.541955] Starting dynamic subtest: rcs0
[134.573193] Dynamic subtest rcs0: SUCCESS (0.031s)
[134.587982] Starting dynamic subtest: bcs0
[134.602955] Dynamic subtest bcs0: SUCCESS (0.029s)
[134.603751] Subtest implicit-write-read: SUCCESS (0.062s)
[134.875242] [045/134] (895s left) kms_big_fb (4-tiled-64bpp-rotate-90)
[135.371190] Starting subtest: 4-tiled-64bpp-rotate-90
[135.372405] Subtest 4-tiled-64bpp-rotate-90: SKIP (0.000s)
[135.971512] [046/134] (894s left) kms_flip (flip-vs-absolute-wf_vblank-interruptible)
[136.471073] Starting subtest: flip-vs-absolute-wf_vblank-interruptible
[136.472559] Starting dynamic subtest: A-VGA1
[144.512575] Dynamic subtest A-VGA1: SUCCESS (8.040s)
[144.525828] Starting dynamic subtest: B-VGA1
[152.486559] Dynamic subtest B-VGA1: SUCCESS (7.972s)
[152.500069] Starting dynamic subtest: A-HDMI-A1
[160.651806] Dynamic subtest A-HDMI-A1: SUCCESS (8.162s)
[160.665174] Starting dynamic subtest: B-HDMI-A1
[168.836506] Dynamic subtest B-HDMI-A1: SUCCESS (8.182s)
[168.843145] Subtest flip-vs-absolute-wf_vblank-interruptible: SUCCESS (32.366s)
[169.586545] [047/134] (861s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-mmap-gtt)
[170.070250] Starting subtest: psr-1p-primscrn-pri-indfb-draw-mmap-gtt
[170.071214] Subtest psr-1p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[170.670021] [048/134] (860s left) kms_color_pipeline (plane-lut1d)
[171.162580] Starting subtest: plane-lut1d
[171.435573] Subtest plane-lut1d: SKIP (0.272s)
[172.142303] [049/134] (858s left) i915_pm_rc6_residency (rc6-accuracy)
[172.198570] Starting subtest: rc6-accuracy
[172.199151] Starting dynamic subtest: gt0
[175.369788] Dynamic subtest gt0: SUCCESS (3.169s)
[175.371033] Subtest rc6-accuracy: SUCCESS (3.171s)
[175.503460] [050/134] (855s left) kms_cursor_legacy (basic-flip-before-cursor-atomic)
[175.986840] Starting subtest: basic-flip-before-cursor-atomic
[176.968571] Subtest basic-flip-before-cursor-atomic: SUCCESS (0.981s)
[177.678470] [051/134] (853s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-move)
[178.164964] Starting subtest: psr-2p-primscrn-spr-indfb-move
[178.165942] Subtest psr-2p-primscrn-spr-indfb-move: SKIP (0.000s)
[178.776291] [052/134] (852s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-mmap-cpu)
[179.268561] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-mmap-cpu
[179.271850] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[179.873750] [053/134] (851s left) kms_psr2_sf (fbc-pr-cursor-plane-move-continuous-exceed-fully-sf)
[180.357460] Subtest fbc-pr-cursor-plane-move-continuous-exceed-fully-sf: SKIP (0.000s)
[180.649163] [054/134] (850s left) syncobj_timeline (etime-multi-wait-all-for-submit-available-unsubmitted-signa
[180.704546] Starting subtest: etime-multi-wait-all-for-submit-available-unsubmitted-signaled
[180.805572] Subtest etime-multi-wait-all-for-submit-available-unsubmitted-signaled: SUCCESS (0.101s)
[180.956101] [055/134] (850s left) gem_mmap_wc (bad-size)
[181.012913] Starting subtest: bad-size
[181.013665] Subtest bad-size: SUCCESS (0.001s)
[181.157134] [056/134] (850s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip)
[181.648062] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip
[181.649414] Subtest y-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip: SKIP (0.000s)
[182.253983] [057/134] (849s left) kms_frontbuffer_tracking (psr-2p-scndscrn-shrfb-msflip-blt)
[182.744041] Starting subtest: psr-2p-scndscrn-shrfb-msflip-blt
[182.745168] Subtest psr-2p-scndscrn-shrfb-msflip-blt: SKIP (0.000s)
[183.332603] [058/134] (848s left) kms_cursor_legacy (cursora-vs-flipb-atomic)
[183.818871] Starting subtest: cursorA-vs-flipB-atomic
[183.820164] Subtest cursorA-vs-flipB-atomic: SKIP (0.001s)
[184.416310] [059/134] (847s left) sysfs_heartbeat_interval (nopreempt)
[184.473890] Starting subtest: nopreempt
[184.476216] Starting dynamic subtest: vcs0
[184.477521] Dynamic subtest vcs0: SKIP (0.000s)
[184.491884] Starting dynamic subtest: bcs0
[184.494022] Dynamic subtest bcs0: SKIP (0.000s)
[184.510500] Starting dynamic subtest: rcs0
[184.512656] Dynamic subtest rcs0: SKIP (0.000s)
[184.514354] Subtest nopreempt: SKIP (0.005s)
[184.612221] [060/134] (846s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-180-hflip)
[185.100860] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-180-hflip
[185.102150] Subtest yf-tiled-max-hw-stride-32bpp-rotate-180-hflip: SKIP (0.000s)
[185.679562] [061/134] (845s left) gem_wait (busy)
[185.748477] Starting subtest: busy
[185.749206] Starting dynamic subtest: all-engines
[186.272559] Dynamic subtest all-engines: SUCCESS (0.523s)
[186.286147] Starting dynamic subtest: rcs0
[186.796325] Dynamic subtest rcs0: SUCCESS (0.521s)
[186.809651] Starting dynamic subtest: bcs0
[187.319281] Dynamic subtest bcs0: SUCCESS (0.521s)
[187.332867] Starting dynamic subtest: vcs0
[187.841401] Dynamic subtest vcs0: SUCCESS (0.520s)
[187.844170] Subtest busy: SUCCESS (2.094s)
[188.091610] [062/134] (843s left) kms_setmode (clone-exclusive-crtc)
[188.143380] Starting subtest: clone-exclusive-crtc
[188.144955] Subtest clone-exclusive-crtc: SKIP (0.000s)
[188.273495] [063/134] (843s left) kms_psr2_sf (pr-overlay-plane-move-continuous-exceed-fully-sf)
[188.757624] Subtest pr-overlay-plane-move-continuous-exceed-fully-sf: SKIP (0.000s)
[189.051628] [064/134] (842s left) sw_sync (sync_merge_same)
[189.109167] Starting subtest: sync_merge_same
[189.109886] Subtest sync_merge_same: SUCCESS (0.000s)
[189.203580] [065/134] (842s left) kms_hdr (static-toggle)
[189.686435] Starting subtest: static-toggle
[189.688132] Subtest static-toggle: SKIP (0.000s)
[190.290580] [066/134] (841s left) gem_exec_await (wide-contexts)
[190.375796] Starting subtest: wide-contexts
[212.130757] Subtest wide-contexts: SUCCESS (21.755s)
[212.364769] [067/134] (819s left) kms_invalid_mode (uint-max-clock)
[212.941911] Starting subtest: uint-max-clock
[212.943236] Starting dynamic subtest: pipe-A-HDMI-A-1
[213.023571] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.081s)
[213.036906] Starting dynamic subtest: pipe-B-HDMI-A-1
[213.037529] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.000s)
[213.037994] Subtest uint-max-clock: SUCCESS (0.086s)
[213.742507] [068/134] (818s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-blt)
[214.225447] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-blt
[216.137127] Subtest fbc-1p-primscrn-cur-indfb-draw-blt: SUCCESS (1.911s)
[216.773225] [069/134] (815s left) kms_pm_rpm (modeset-non-lpsp)
[228.605671] Subtest modeset-non-lpsp: SKIP (0.000s)
[228.909406] [070/134] (803s left) kms_psr (fbc-pr-cursor-mmap-cpu)
[229.389056] Subtest fbc-pr-cursor-mmap-cpu: SKIP (0.000s)
[229.685022] [071/134] (802s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-indfb-draw-mmap-wc)
[230.166184] Starting subtest: fbc-1p-offscreen-pri-indfb-draw-mmap-wc
[231.624363] Subtest fbc-1p-offscreen-pri-indfb-draw-mmap-wc: SUCCESS (1.458s)
[232.271370] [072/134] (799s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-mmap-wc)
[232.759415] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-mmap-wc
[232.760522] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[233.368670] [073/134] (798s left) i915_pm_rps (thresholds-idle)
[233.428033] Starting subtest: thresholds-idle
[233.430588] Starting dynamic subtest: gt0
[243.785991] Dynamic subtest gt0: SUCCESS (10.357s)
[243.788933] Subtest thresholds-idle: SUCCESS (10.359s)
[243.913531] [074/134] (788s left) kms_vblank (query-idle-hang)
[244.399383] Starting subtest: query-idle-hang
[244.400652] Starting dynamic subtest: pipe-A-HDMI-A-1
[250.950200] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (6.549s)
[250.963156] Starting dynamic subtest: pipe-B-HDMI-A-1
[256.967020] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (6.015s)
[256.967677] Subtest query-idle-hang: SUCCESS (12.569s)
[257.674606] [075/134] (774s left) perf_pmu (most-busy-idle-check-all)
[257.731508] Starting subtest: most-busy-idle-check-all
[257.732170] Starting dynamic subtest: rcs0
[258.344559] Dynamic subtest rcs0: SUCCESS (0.612s)
[258.360428] Starting dynamic subtest: bcs0
[258.966401] Dynamic subtest bcs0: SUCCESS (0.618s)
[258.981857] Starting dynamic subtest: vcs0
[259.585148] Dynamic subtest vcs0: SUCCESS (0.616s)
[259.587118] Subtest most-busy-idle-check-all: SUCCESS (1.855s)
[259.733524] [076/134] (772s left) kms_atomic_interruptible (universal-setplane-cursor)
[260.224916] Starting subtest: universal-setplane-cursor
[260.226794] Starting dynamic subtest: pipe-A-HDMI-A-1
[266.535898] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (6.309s)
[266.536561] Subtest universal-setplane-cursor: SUCCESS (6.311s)
[267.257680] [077/134] (765s left) gem_userptr_blits (process-exit-busy)
[267.333126] Starting subtest: process-exit-busy
[267.351353] Subtest process-exit-busy: SUCCESS (0.020s)
[267.525731] [078/134] (764s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-pwrite)
[268.019403] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-pwrite
[268.020605] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[268.621262] [079/134] (763s left) gem_lmem_swapping (heavy-verify-multi)
[268.677985] Subtest heavy-verify-multi: SKIP (0.000s)
[268.731711] [080/134] (763s left) gen9_exec_parse (bb-start-cmd)
[268.788246] Subtest bb-start-cmd: SKIP (0.000s)
[268.849418] [081/134] (763s left) fbdev (unaligned-read)
[268.906727] Starting subtest: unaligned-read
[268.917668] Subtest unaligned-read: SUCCESS (0.011s)
[269.022215] [082/134] (763s left) kms_chamelium_hpd (dp-hpd-with-enabled-mode)
[269.586576] Subtest dp-hpd-with-enabled-mode: SKIP (0.000s)
[270.003591] [083/134] (762s left) gem_ppgtt (blt-vs-render-ctx0)
[270.062855] Starting subtest: blt-vs-render-ctx0
[302.618709] Subtest blt-vs-render-ctx0: SUCCESS (32.554s)
[302.778733] [084/134] (730s left) core_setmaster_vs_auth
[303.006288] [085/134] (729s left) prime_busy (hang)
[303.066961] Starting subtest: hang
[303.069101] Starting dynamic subtest: rcs0
[308.854302] Dynamic subtest rcs0: SUCCESS (5.784s)
[308.871294] Starting dynamic subtest: bcs0
[314.867801] Dynamic subtest bcs0: SUCCESS (6.012s)
[314.881161] Starting dynamic subtest: vcs0
[320.888425] Dynamic subtest vcs0: SUCCESS (6.018s)
[320.890890] Subtest hang: SUCCESS (17.822s)
[321.038328] [086/134] (711s left) gem_eio (unwedge-stress)
[321.101568] Starting subtest: unwedge-stress
[321.102274] Starting dynamic subtest: render
[322.811102] Dynamic subtest render: SUCCESS (1.708s)
[322.824771] Starting dynamic subtest: bsd
[324.617293] Dynamic subtest bsd: FAIL (1.776s)
[324.617986] Subtest unwedge-stress: FAIL (3.488s)
[325.598163] [087/134] (707s left) kms_cursor_crc (cursor-random-256x256)
[326.104924] Starting subtest: cursor-random-256x256
[326.107684] Starting dynamic subtest: pipe-A-HDMI-A-1
[329.817488] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (3.709s)
[329.863589] Starting dynamic subtest: pipe-B-HDMI-A-1
[333.537152] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (3.686s)
[333.537843] Subtest cursor-random-256x256: SUCCESS (7.431s)
[334.250160] [088/134] (698s left) syncobj_timeline (multi-wait-submitted-signaled)
[334.313899] Starting subtest: multi-wait-submitted-signaled
[334.315604] Subtest multi-wait-submitted-signaled: SUCCESS (0.001s)
[334.449588] [089/134] (698s left) kms_dsc (dsc-with-formats)
[334.934792] Subtest dsc-with-formats: SKIP (0.000s)
[335.223640] [090/134] (697s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-shrfb-draw-mmap-wc)
[335.708365] Starting subtest: psr-1p-offscreen-pri-shrfb-draw-mmap-wc
[335.709526] Subtest psr-1p-offscreen-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[336.312162] [091/134] (696s left) api_intel_allocator (reopen-fork)
[336.367846] Starting subtest: reopen-fork
[339.861607] Subtest reopen-fork: SUCCESS (3.494s)
[339.986434] [092/134] (693s left) gem_exec_whisper (basic-fds-priority-all)
[340.052536] Starting subtest: basic-fds-priority-all
[340.053876] Subtest basic-fds-priority-all: SKIP (0.001s)
[340.273994] [093/134] (692s left) gem_exec_fence (basic-wait-all)
[340.339233] Starting subtest: basic-wait-all
[340.382352] Subtest basic-wait-all: SUCCESS (0.043s)
[340.905651] [094/134] (692s left) kms_ccs (crc-sprite-planes-basic-4-tiled-dg2-rc-ccs-cc)
[340.958568] Subtest crc-sprite-planes-basic-4-tiled-dg2-rc-ccs-cc: SKIP (0.000s)
[341.015121] [095/134] (692s left) kms_psr (fbc-psr2-no-drrs)
[341.499846] Subtest fbc-psr2-no-drrs: SKIP (0.000s)
[341.795126] [096/134] (691s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-mmap-gtt)
[342.283360] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-mmap-gtt
[342.284493] Subtest psr-1p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[342.882430] [097/134] (690s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-pwrite)
[343.365733] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-pwrite
[343.366921] Subtest fbc-2p-scndscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[343.963889] [098/134] (689s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-mmap-cpu)
[344.445908] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-mmap-cpu
[346.375395] Subtest fbc-1p-primscrn-spr-indfb-draw-mmap-cpu: SUCCESS (1.929s)
[347.032915] [099/134] (686s left) kms_plane_scaling (planes-upscale-factor-0-25-downscale-factor-0-5)
[347.514992] Starting subtest: planes-upscale-factor-0-25-downscale-factor-0-5
[347.515971] Starting dynamic subtest: pipe-A
[347.517632] Dynamic subtest pipe-A: SKIP (0.001s)
[347.531482] Starting dynamic subtest: pipe-B
[347.533175] Dynamic subtest pipe-B: SKIP (0.001s)
[347.534267] Subtest planes-upscale-factor-0-25-downscale-factor-0-5: SKIP (0.006s)
[348.122770] [100/134] (685s left) kms_flip_scaled_crc (flip-32bpp-yftile-to-32bpp-yftileccs-upscaling)
[348.174768] Subtest flip-32bpp-yftile-to-32bpp-yftileccs-upscaling: SKIP (0.000s)
[348.234295] [101/134] (685s left) kms_cursor_legacy (flip-vs-cursor-busy-crc-atomic)
[348.723153] Starting subtest: flip-vs-cursor-busy-crc-atomic
[349.286937] Subtest flip-vs-cursor-busy-crc-atomic: SUCCESS (0.563s)
[350.011533] [102/134] (683s left) core_getstats (basic)
[350.069024] Starting subtest: basic
[350.069767] Subtest basic: SUCCESS (0.000s)
[350.203586] [103/134] (683s left) gem_mmap_gtt (hang-busy)
[350.257448] Starting subtest: hang-busy
[355.894137] Subtest hang-busy: SUCCESS (5.637s)
[356.032511] [104/134] (677s left) kms_flip (flip-vs-expired-vblank-interruptible)
[356.526347] Starting subtest: flip-vs-expired-vblank-interruptible
[356.528756] Starting dynamic subtest: A-VGA1
[364.250537] Dynamic subtest A-VGA1: SUCCESS (7.721s)
[364.265368] Starting dynamic subtest: B-VGA1
[371.923048] Dynamic subtest B-VGA1: SUCCESS (7.669s)
[371.938896] Starting dynamic subtest: A-HDMI-A1
[379.629862] Dynamic subtest A-HDMI-A1: SUCCESS (7.704s)
[379.648038] Starting dynamic subtest: B-HDMI-A1
[387.389674] Dynamic subtest B-HDMI-A1: SUCCESS (7.756s)
[387.392196] Subtest flip-vs-expired-vblank-interruptible: SUCCESS (30.865s)
[388.161541] [105/134] (645s left) gem_exec_schedule (preempt-queue-contexts)
[388.229681] Subtest preempt-queue-contexts: SKIP (0.000s)
[388.461206] [106/134] (645s left) perf (oa-formats)
[388.617540] Subtest oa-formats: SKIP (0.000s)
[388.689846] [107/134] (645s left) kms_frontbuffer_tracking (fbcpsr-modesetfrombusy)
[389.177629] Starting subtest: fbcpsr-modesetfrombusy
[389.178645] Subtest fbcpsr-modesetfrombusy: SKIP (0.000s)
[389.772646] [108/134] (644s left) kms_flip (2x-dpms-vs-vblank-race)
[390.254218] Starting subtest: 2x-dpms-vs-vblank-race
[390.255710] Starting dynamic subtest: AB-VGA1-HDMI-A1
[401.004607] Dynamic subtest AB-VGA1-HDMI-A1: SUCCESS (10.745s)
[401.005287] Subtest 2x-dpms-vs-vblank-race: SUCCESS (10.748s)
[401.746804] [109/134] (632s left) gem_exec_params (readonly)
[401.818560] Starting subtest: readonly
[401.819268] Subtest readonly: SUCCESS (0.001s)
[401.978731] [110/134] (632s left) kms_vblank (invalid)
[402.464297] Starting subtest: invalid
[402.465383] Starting dynamic subtest: pipe-A-HDMI-A-1
[402.661705] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.196s)
[402.662400] Subtest invalid: SUCCESS (0.199s)
[403.371969] [111/134] (630s left) gem_exec_reloc (basic-cpu-read-noreloc)
[403.435697] Starting subtest: basic-cpu-read-noreloc
[403.437442] Subtest basic-cpu-read-noreloc: SUCCESS (0.002s)
[404.453500] [112/134] (629s left) gem_ctx_persistence (engines-hostile)
[404.513200] Subtest engines-hostile: SKIP (0.000s)
[404.583338] [113/134] (629s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-mmap-gtt)
[405.068960] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-mmap-gtt
[406.996284] Subtest fbc-1p-primscrn-spr-indfb-draw-mmap-gtt: SUCCESS (1.928s)
[407.663307] [114/134] (626s left) kms_frontbuffer_tracking (fbcpsr-2p-shrfb-fliptrack-mmap-gtt)
[408.153837] Starting subtest: fbcpsr-2p-shrfb-fliptrack-mmap-gtt
[408.154813] Subtest fbcpsr-2p-shrfb-fliptrack-mmap-gtt: SKIP (0.000s)
[408.760742] [115/134] (625s left) gem_caching (writes)
[408.817873] Starting subtest: writes
[411.791920] Subtest writes: SUCCESS (2.974s)
[411.969258] [116/134] (622s left) kms_pm_backlight (fade-with-suspend)
[412.445318] Subtest fade-with-suspend: SKIP (0.000s)
[412.756803] [117/134] (621s left) kms_plane_alpha_blend (coverage-vs-premult-vs-constant)
[413.244482] Starting subtest: coverage-vs-premult-vs-constant
[413.405793] Subtest coverage-vs-premult-vs-constant: SKIP (0.162s)
[414.212263] [118/134] (620s left) kms_lease (master-vs-lease)
[414.701344] Starting subtest: master-vs-lease
[414.701884] Subtest master-vs-lease: SUCCESS (0.002s)
[415.309551] [119/134] (619s left) kms_frontbuffer_tracking (psr-rgb565-draw-mmap-wc)
[415.793822] Starting subtest: psr-rgb565-draw-mmap-wc
[415.794929] Subtest psr-rgb565-draw-mmap-wc: SKIP (0.000s)
[416.407668] [120/134] (618s left) kms_addfb_basic (addfb25-4-tiled)
[416.894196] Starting subtest: addfb25-4-tiled
[416.894744] Subtest addfb25-4-tiled: SUCCESS (0.001s)
[417.505878] [121/134] (617s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-downscaling)
[417.562831] Subtest flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-downscaling: SKIP (0.000s)
[417.621373] [122/134] (617s left) kms_plane_multiple (2x-tiling-x)
[418.096423] Starting subtest: 2x-tiling-x
[418.097809] Subtest 2x-tiling-x: SKIP (0.000s)
[418.701655] [123/134] (616s left) kms_psr (psr2-primary-render)
[419.187763] Subtest psr2-primary-render: SKIP (0.000s)
[419.483724] [124/134] (615s left) syncobj_wait (multi-wait-all-for-submit-submitted-signaled)
[419.538380] Starting subtest: multi-wait-all-for-submit-submitted-signaled
[419.648047] Subtest multi-wait-all-for-submit-submitted-signaled: SUCCESS (0.107s)
[419.770519] [125/134] (615s left) gem_exec_balancer (full)
[419.826757] Subtest full: SKIP (0.000s)
[419.952464] [126/134] (615s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-render)
[420.438839] Starting subtest: psr-2p-primscrn-spr-indfb-draw-render
[420.439946] Subtest psr-2p-primscrn-spr-indfb-draw-render: SKIP (0.000s)
[421.063330] [127/134] (614s left) gem_mmap_wc (write-read)
[421.116281] Starting subtest: write-read
[421.131784] Subtest write-read: SUCCESS (0.015s)
[421.277273] [128/134] (613s left) gem_ctx_persistence (process)
[421.331226] Subtest process: SKIP (0.000s)
[421.399382] [129/134] (613s left) gem_ctx_param (non-root-set)
[421.456984] Starting subtest: non-root-set
[421.479426] Subtest non-root-set: SUCCESS (0.022s)
[421.613688] [130/134] (613s left) sw_sync (timeline_closed)
[421.668882] Starting subtest: timeline_closed
[421.669552] Subtest timeline_closed: SUCCESS (0.000s)
[421.780230] [131/134] (613s left) kms_rotation_crc (primary-4-tiled-reflect-x-180)
[422.268273] Starting subtest: primary-4-tiled-reflect-x-180
[422.270186] Subtest primary-4-tiled-reflect-x-180: SKIP (0.001s)
[422.878822] [132/134] (612s left) gem_exec_parallel (basic)
[422.943446] Starting subtest: basic
[422.944183] Starting dynamic subtest: rcs0
[424.407554] Dynamic subtest rcs0: SUCCESS (1.463s)
[424.426066] Starting dynamic subtest: bcs0
[425.954972] Dynamic subtest bcs0: SUCCESS (1.544s)
[425.957511] Subtest basic: SUCCESS (3.013s)
[426.188220] [133/134] (609s left) kms_content_protection (uevent-hdcp14)
[426.685538] Starting subtest: uevent-hdcp14
[426.687625] Subtest uevent-hdcp14: SKIP (0.001s)
[427.285935] [134/134] (608s left) syncobj_timeline (multi-wait-all-for-submit-available-signaled)
[427.342177] Starting subtest: multi-wait-all-for-submit-available-signaled
[427.343901] Subtest multi-wait-all-for-submit-available-signaled: SUCCESS (0.001s)
[427.449017] Closing watchdogs
results: parsing output: 0/ for test: kms_cursor_crc
results: parsing output: 1/ for test: gem_mmap_gtt
results: parsing output: 2/ for test: gem_ctx_engines
results: parsing output: 3/ for test: perf_pmu
results: parsing output: 4/ for test: kms_big_fb
results: parsing output: 5/ for test: api_intel_bb
results: parsing output: 6/ for test: gem_render_copy
results: parsing output: 7/ for test: kms_plane
results: parsing output: 8/ for test: kms_psr
results: parsing output: 9/ for test: kms_cursor_crc
results: parsing output: 10/ for test: kms_frontbuffer_tracking
results: parsing output: 11/ for test: gem_spin_batch
results: parsing output: 12/ for test: gem_exec_reloc
results: parsing output: 13/ for test: kms_plane
results: parsing output: 14/ for test: gem_render_copy
results: parsing output: 15/ for test: kms_big_fb
results: parsing output: 16/ for test: kms_psr
results: parsing output: 17/ for test: gen9_exec_parse
results: parsing output: 18/ for test: perf
results: parsing output: 19/ for test: gem_ctx_param
results: parsing output: 20/ for test: kms_ccs
results: parsing output: 21/ for test: gem_exec_params
results: parsing output: 22/ for test: gem_render_copy
results: parsing output: 23/ for test: syncobj_timeline
results: parsing output: 24/ for test: gem_exec_fence
results: parsing output: 25/ for test: kms_chamelium_edid
results: parsing output: 26/ for test: gem_exec_params
results: parsing output: 27/ for test: kms_big_fb
results: parsing output: 28/ for test: kms_ccs
results: parsing output: 29/ for test: gem_eio
results: parsing output: 30/ for test: kms_cursor_legacy
results: parsing output: 31/ for test: kms_ccs
results: parsing output: 32/ for test: gem_exec_capture
results: parsing output: 33/ for test: syncobj_timeline
results: parsing output: 34/ for test: kms_async_flips
results: parsing output: 35/ for test: kms_big_fb
results: parsing output: 36/ for test: i915_pm_freq_api
results: parsing output: 37/ for test: kms_frontbuffer_tracking
results: parsing output: 38/ for test: kms_ccs
results: parsing output: 39/ for test: gem_mmap
results: parsing output: 40/ for test: vgem_basic
results: parsing output: 41/ for test: gem_render_copy
results: parsing output: 42/ for test: kms_frontbuffer_tracking
results: parsing output: 43/ for test: gem_exec_schedule
results: parsing output: 44/ for test: kms_big_fb
results: parsing output: 45/ for test: kms_flip
results: parsing output: 46/ for test: kms_frontbuffer_tracking
results: parsing output: 47/ for test: kms_color_pipeline
results: parsing output: 48/ for test: i915_pm_rc6_residency
results: parsing output: 49/ for test: kms_cursor_legacy
results: parsing output: 50/ for test: kms_frontbuffer_tracking
results: parsing output: 51/ for test: kms_frontbuffer_tracking
results: parsing output: 52/ for test: kms_psr2_sf
results: parsing output: 53/ for test: syncobj_timeline
results: parsing output: 54/ for test: gem_mmap_wc
results: parsing output: 55/ for test: kms_big_fb
results: parsing output: 56/ for test: kms_frontbuffer_tracking
results: parsing output: 57/ for test: kms_cursor_legacy
results: parsing output: 58/ for test: sysfs_heartbeat_interval
results: parsing output: 59/ for test: kms_big_fb
results: parsing output: 60/ for test: gem_wait
results: parsing output: 61/ for test: kms_setmode
results: parsing output: 62/ for test: kms_psr2_sf
results: parsing output: 63/ for test: sw_sync
results: parsing output: 64/ for test: kms_hdr
results: parsing output: 65/ for test: gem_exec_await
results: parsing output: 66/ for test: kms_invalid_mode
results: parsing output: 67/ for test: kms_frontbuffer_tracking
results: parsing output: 68/ for test: kms_pm_rpm
results: parsing output: 69/ for test: kms_psr
results: parsing output: 70/ for test: kms_frontbuffer_tracking
results: parsing output: 71/ for test: kms_frontbuffer_tracking
results: parsing output: 72/ for test: i915_pm_rps
results: parsing output: 73/ for test: kms_vblank
results: parsing output: 74/ for test: perf_pmu
results: parsing output: 75/ for test: kms_atomic_interruptible
results: parsing output: 76/ for test: gem_userptr_blits
results: parsing output: 77/ for test: kms_frontbuffer_tracking
results: parsing output: 78/ for test: gem_lmem_swapping
results: parsing output: 79/ for test: gen9_exec_parse
results: parsing output: 80/ for test: fbdev
results: parsing output: 81/ for test: kms_chamelium_hpd
results: parsing output: 82/ for test: gem_ppgtt
results: parsing output: 83/ for test: core_setmaster_vs_auth
results: parsing output: 84/ for test: prime_busy
results: parsing output: 85/ for test: gem_eio
results: parsing output: 86/ for test: kms_cursor_crc
results: parsing output: 87/ for test: syncobj_timeline
results: parsing output: 88/ for test: kms_dsc
results: parsing output: 89/ for test: kms_frontbuffer_tracking
results: parsing output: 90/ for test: api_intel_allocator
results: parsing output: 91/ for test: gem_exec_whisper
results: parsing output: 92/ for test: gem_exec_fence
results: parsing output: 93/ for test: kms_ccs
results: parsing output: 94/ for test: kms_psr
results: parsing output: 95/ for test: kms_frontbuffer_tracking
results: parsing output: 96/ for test: kms_frontbuffer_tracking
results: parsing output: 97/ for test: kms_frontbuffer_tracking
results: parsing output: 98/ for test: kms_plane_scaling
results: parsing output: 99/ for test: kms_flip_scaled_crc
results: parsing output: 100/ for test: kms_cursor_legacy
results: parsing output: 101/ for test: core_getstats
results: parsing output: 102/ for test: gem_mmap_gtt
results: parsing output: 103/ for test: kms_flip
results: parsing output: 104/ for test: gem_exec_schedule
results: parsing output: 105/ for test: perf
results: parsing output: 106/ for test: kms_frontbuffer_tracking
results: parsing output: 107/ for test: kms_flip
results: parsing output: 108/ for test: gem_exec_params
results: parsing output: 109/ for test: kms_vblank
results: parsing output: 110/ for test: gem_exec_reloc
results: parsing output: 111/ for test: gem_ctx_persistence
results: parsing output: 112/ for test: kms_frontbuffer_tracking
results: parsing output: 113/ for test: kms_frontbuffer_tracking
results: parsing output: 114/ for test: gem_caching
results: parsing output: 115/ for test: kms_pm_backlight
results: parsing output: 116/ for test: kms_plane_alpha_blend
results: parsing output: 117/ for test: kms_lease
results: parsing output: 118/ for test: kms_frontbuffer_tracking
results: parsing output: 119/ for test: kms_addfb_basic
results: parsing output: 120/ for test: kms_flip_scaled_crc
results: parsing output: 121/ for test: kms_plane_multiple
results: parsing output: 122/ for test: kms_psr
results: parsing output: 123/ for test: syncobj_wait
results: parsing output: 124/ for test: gem_exec_balancer
results: parsing output: 125/ for test: kms_frontbuffer_tracking
results: parsing output: 126/ for test: gem_mmap_wc
results: parsing output: 127/ for test: gem_ctx_persistence
results: parsing output: 128/ for test: gem_ctx_param
results: parsing output: 129/ for test: sw_sync
results: parsing output: 130/ for test: kms_rotation_crc
results: parsing output: 131/ for test: gem_exec_parallel
results: parsing output: 132/ for test: kms_content_protection
results: parsing output: 133/ for test: syncobj_timeline
Done.