[75.915686] Initializing watchdogs
[75.915811]   /dev/watchdog0
[75.938786] [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)
[75.946764] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[75.950596] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[75.954061] [001/134] (960s left) kms_cursor_crc (cursor-offscreen-256x85)
[76.503900] Starting subtest: cursor-offscreen-256x85
[76.589334] Subtest cursor-offscreen-256x85: SKIP (0.081s)
[77.193725] [002/134] (959s left) gem_mmap_gtt (cpuset-big-copy-odd)
[77.255951] Starting subtest: cpuset-big-copy-odd
[80.852187] Subtest cpuset-big-copy-odd: SUCCESS (3.597s)
[81.087973] [003/134] (955s left) gem_ctx_engines (execute-allforone)
[81.261234] Starting subtest: execute-allforone
[81.264681] Subtest execute-allforone: SUCCESS (0.003s)
[81.519751] [004/134] (955s left) perf_pmu (busy-idle)
[81.578997] Starting subtest: busy-idle
[81.581357] Starting dynamic subtest: rcs0
[82.216457] Dynamic subtest rcs0: SUCCESS (0.637s)
[82.233598] Starting dynamic subtest: bcs0
[82.847868] Dynamic subtest bcs0: SUCCESS (0.630s)
[82.863764] Starting dynamic subtest: vcs0
[83.983141] Dynamic subtest vcs0: SUCCESS (1.134s)
[83.984097] Subtest busy-idle: SUCCESS (2.403s)
[84.098324] [005/134] (952s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip)
[84.610769] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip
[84.616785] Subtest x-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip: SKIP (0.001s)
[85.211697] [006/134] (951s left) api_intel_bb (lot-of-buffers)
[85.275879] Starting subtest: lot-of-buffers
[85.999961] Subtest lot-of-buffers: SUCCESS (0.724s)
[86.311309] [007/134] (950s left) gem_render_copy (yf-tiled-to-vebox-x-tiled)
[86.373786] Starting subtest: yf-tiled-to-vebox-x-tiled
[86.376098] Subtest yf-tiled-to-vebox-x-tiled: SKIP (0.000s)
[86.607759] [008/134] (950s left) kms_plane (plane-panning-top-left)
[87.102362] Starting subtest: plane-panning-top-left
[87.103147] Starting dynamic subtest: pipe-A
[87.844139] Dynamic subtest pipe-A: SUCCESS (0.739s)
[87.854717] Starting dynamic subtest: pipe-B
[88.440724] Dynamic subtest pipe-B: SUCCESS (0.598s)
[88.441377] Subtest plane-panning-top-left: SUCCESS (1.339s)
[89.148476] [009/134] (947s left) kms_psr (fbc-psr-cursor-plane-onoff)
[89.649999] Subtest fbc-psr-cursor-plane-onoff: SKIP (0.000s)
[89.944890] [010/134] (946s left) kms_cursor_crc (cursor-tearing-position-change)
[90.439802] Starting subtest: cursor-tearing-position-change
[90.440727] Starting dynamic subtest: pipe-A-HDMI-A-1
[90.853996] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.412s)
[90.864838] Starting dynamic subtest: pipe-B-HDMI-A-1
[91.215636] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.361s)
[91.216311] Subtest cursor-tearing-position-change: SUCCESS (0.776s)
[91.975318] [011/134] (944s left) kms_frontbuffer_tracking (basic)
[92.475705] Starting subtest: basic
[94.890300] Subtest basic: SUCCESS (2.415s)
[95.534675] [012/134] (941s left) gem_spin_batch (spin-each)
[95.606731] Starting subtest: spin-each
[98.942143] Subtest spin-each: SUCCESS (3.335s)
[99.194280] [013/134] (937s left) gem_exec_reloc (basic-gtt-cpu)
[99.253131] Starting subtest: basic-gtt-cpu
[99.257230] Subtest basic-gtt-cpu: SUCCESS (0.004s)
[100.291700] [014/134] (936s left) kms_plane (pixel-format-4-tiled-mtl-rc-ccs-modifier)
[100.787171] Starting subtest: pixel-format-4-tiled-mtl-rc-ccs-modifier
[100.828642] Starting dynamic subtest: pipe-A-plane-0
[100.831179] Dynamic subtest pipe-A-plane-0: SKIP (0.000s)
[100.844222] Starting dynamic subtest: pipe-A-plane-1
[100.846498] Dynamic subtest pipe-A-plane-1: SKIP (0.000s)
[100.857420] Starting dynamic subtest: pipe-A-plane-2
[100.858758] Dynamic subtest pipe-A-plane-2: SKIP (0.000s)
[101.070845] Starting dynamic subtest: pipe-B-plane-0
[101.072080] Dynamic subtest pipe-B-plane-0: SKIP (0.000s)
[101.082944] Starting dynamic subtest: pipe-B-plane-1
[101.084217] Dynamic subtest pipe-B-plane-1: SKIP (0.000s)
[101.094690] Starting dynamic subtest: pipe-B-plane-2
[101.096206] Dynamic subtest pipe-B-plane-2: SKIP (0.000s)
[101.146504] Subtest pixel-format-4-tiled-mtl-rc-ccs-modifier: SKIP (0.354s)
[101.872517] [015/134] (935s left) gem_render_copy (y-tiled-ccs-to-linear)
[101.940692] Starting subtest: y-tiled-ccs-to-linear
[101.941624] Starting dynamic subtest: smem
[101.943940] Dynamic subtest smem: SKIP (0.000s)
[101.945931] Subtest y-tiled-ccs-to-linear: SKIP (0.001s)
[102.163733] [016/134] (934s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip)
[102.665139] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip
[102.666781] Subtest yf-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip: SKIP (0.000s)
[103.281616] [017/134] (933s left) kms_psr (pr-sprite-render)
[103.776218] Subtest pr-sprite-render: SKIP (0.000s)
[104.068319] [018/134] (933s left) gen9_exec_parse (shadow-peek)
[104.126287] Subtest shadow-peek: SKIP (0.000s)
[104.188843] [019/134] (933s left) perf (invalid-remove-userspace-config)
[104.389864] Subtest invalid-remove-userspace-config: SKIP (0.000s)
[104.436036] [020/134] (932s left) gem_ctx_param (invalid-size-set)
[104.493067] Starting subtest: invalid-size-set
[104.493856] Subtest invalid-size-set: SUCCESS (0.000s)
[104.614906] [021/134] (932s left) kms_ccs (bad-rotation-90-y-tiled-gen12-rc-ccs-cc)
[104.670654] Subtest bad-rotation-90-y-tiled-gen12-rc-ccs-cc: SKIP (0.000s)
[104.725657] [022/134] (932s left) gem_exec_params (invalid-bsd2-flag-on-blt)
[104.783655] Starting subtest: invalid-bsd2-flag-on-blt
[104.784714] Subtest invalid-bsd2-flag-on-blt: SUCCESS (0.000s)
[104.928243] [023/134] (932s left) gem_render_copy (yf-tiled-ccs-to-linear)
[104.990274] Starting subtest: yf-tiled-ccs-to-linear
[104.991493] Starting dynamic subtest: smem
[104.993535] Dynamic subtest smem: SKIP (0.000s)
[104.995457] Subtest yf-tiled-ccs-to-linear: SKIP (0.001s)
[105.227278] [024/134] (932s left) syncobj_timeline (etime-multi-wait-for-submit-unsubmitted)
[105.285480] Starting subtest: etime-multi-wait-for-submit-unsubmitted
[105.394342] Subtest etime-multi-wait-for-submit-unsubmitted: SUCCESS (0.108s)
[105.525931] [025/134] (932s left) gem_exec_fence (invalid-timeline-fence-array)
[105.891519] Starting subtest: invalid-timeline-fence-array
[105.895187] Subtest invalid-timeline-fence-array: SUCCESS (0.004s)
[106.145727] [FACT gem_exec_fence (invalid-timeline-fence-array)] new: kernel.kmod_is_loaded.vgem: true
[106.148262] [026/134] (931s left) kms_chamelium_edid (dp-edid-read)
[106.729138] Subtest dp-edid-read: SKIP (0.000s)
[107.149700] [027/134] (930s left) gem_exec_params (invalid-bsd1-flag-on-render)
[107.212558] Starting subtest: invalid-bsd1-flag-on-render
[107.213298] Subtest invalid-bsd1-flag-on-render: SUCCESS (0.000s)
[107.353289] [028/134] (930s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-180)
[107.853825] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-180
[107.855577] Subtest 4-tiled-max-hw-stride-64bpp-rotate-180: SKIP (0.000s)
[108.455070] [029/134] (929s left) kms_ccs (crc-primary-rotation-180-y-tiled-ccs)
[108.514699] Subtest crc-primary-rotation-180-y-tiled-ccs: SKIP (0.000s)
[108.579126] [030/134] (929s left) gem_eio (kms)
[109.083273] Starting subtest: kms
[114.013220] Subtest kms: SUCCESS (4.930s)
[114.675087] [031/134] (923s left) kms_cursor_legacy (torture-move)
[115.169267] Starting subtest: torture-move
[115.170315] Starting dynamic subtest: pipe-A
[120.688929] Dynamic subtest pipe-A: SUCCESS (5.518s)
[120.702330] Starting dynamic subtest: pipe-B
[126.373568] Dynamic subtest pipe-B: SUCCESS (5.684s)
[126.386996] Starting dynamic subtest: all-pipes
[132.227880] Dynamic subtest all-pipes: SUCCESS (5.853s)
[132.228828] Subtest torture-move: SUCCESS (17.058s)
[132.836590] [032/134] (905s left) kms_ccs (bad-pixel-format-yf-tiled-ccs)
[132.892267] Subtest bad-pixel-format-yf-tiled-ccs: SKIP (0.000s)
[132.944941] [033/134] (905s left) gem_exec_capture (pi)
[133.001197] Subtest pi: SKIP (0.000s)
[133.077015] [034/134] (904s left) syncobj_timeline (wait-all-snapshot)
[133.132068] Starting subtest: wait-all-snapshot
[133.215650] Subtest wait-all-snapshot: SUCCESS (0.082s)
[133.358553] [035/134] (904s left) kms_async_flips (test-cursor-atomic)
[133.848863] Starting subtest: test-cursor-atomic
[133.984086] Starting dynamic subtest: pipe-A-HDMI-A-1
[134.126653] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.143s)
[134.283935] Starting dynamic subtest: pipe-B-HDMI-A-1
[134.374913] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.102s)
[134.375677] Subtest test-cursor-atomic: SUCCESS (0.529s)
[135.237580] [036/134] (902s left) kms_big_fb (x-tiled-32bpp-rotate-180)
[135.735294] Starting subtest: x-tiled-32bpp-rotate-180
[137.183419] Subtest x-tiled-32bpp-rotate-180: SUCCESS (1.447s)
[137.814808] [037/134] (900s left) i915_pm_freq_api (freq-reset)
[137.874806] Subtest freq-reset: SKIP (0.000s)
[137.945466] [038/134] (900s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-mmap-wc)
[138.438895] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-mmap-wc
[140.278031] Subtest fbc-1p-primscrn-pri-indfb-draw-mmap-wc: SUCCESS (1.838s)
[140.931240] [039/134] (897s left) kms_ccs (random-ccs-data-y-tiled-gen12-rc-ccs-cc)
[140.986875] Subtest random-ccs-data-y-tiled-gen12-rc-ccs-cc: SKIP (0.000s)
[141.055686] [040/134] (897s left) gem_mmap (short-mmap)
[141.111374] Starting subtest: short-mmap
[141.112179] Subtest short-mmap: SUCCESS (0.000s)
[141.264184] [041/134] (897s left) vgem_basic (dmabuf-export)
[141.326383] Starting subtest: dmabuf-export
[141.328949] Subtest dmabuf-export: SUCCESS (0.003s)
[141.459321] [042/134] (896s left) gem_render_copy (y-tiled)
[141.522017] Starting subtest: y-tiled
[141.522931] Starting dynamic subtest: smem
[141.587106] Dynamic subtest smem: SUCCESS (0.065s)
[141.588018] Subtest y-tiled: SUCCESS (0.066s)
[141.811238] [043/134] (896s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-pwrite)
[142.301886] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-pwrite
[142.303287] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[142.907878] [044/134] (895s left) gem_exec_schedule (implicit-write-read)
[142.980672] Starting subtest: implicit-write-read
[142.981580] Starting dynamic subtest: rcs0
[143.012982] Dynamic subtest rcs0: SUCCESS (0.032s)
[143.033961] Starting dynamic subtest: bcs0
[143.044170] Dynamic subtest bcs0: SUCCESS (0.030s)
[143.045123] Subtest implicit-write-read: SUCCESS (0.064s)
[143.304919] [045/134] (895s left) kms_big_fb (4-tiled-64bpp-rotate-90)
[143.799570] Starting subtest: 4-tiled-64bpp-rotate-90
[143.800906] Subtest 4-tiled-64bpp-rotate-90: SKIP (0.000s)
[144.404911] [046/134] (894s left) kms_flip (flip-vs-absolute-wf_vblank-interruptible)
[144.903984] Starting subtest: flip-vs-absolute-wf_vblank-interruptible
[144.904863] Starting dynamic subtest: A-VGA1
[152.934376] Dynamic subtest A-VGA1: SUCCESS (8.030s)
[152.947873] Starting dynamic subtest: B-VGA1
[160.924824] Dynamic subtest B-VGA1: SUCCESS (7.989s)
[160.938753] Starting dynamic subtest: A-HDMI-A1
[169.081422] Dynamic subtest A-HDMI-A1: SUCCESS (8.155s)
[169.096920] Starting dynamic subtest: B-HDMI-A1
[177.265126] Dynamic subtest B-HDMI-A1: SUCCESS (8.182s)
[177.266360] Subtest flip-vs-absolute-wf_vblank-interruptible: SUCCESS (32.365s)
[178.021787] [047/134] (860s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-mmap-gtt)
[178.530924] Starting subtest: psr-1p-primscrn-pri-indfb-draw-mmap-gtt
[178.532201] Subtest psr-1p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[179.138906] [048/134] (859s left) kms_color_pipeline (plane-lut1d)
[179.634733] Starting subtest: plane-lut1d
[179.946880] Subtest plane-lut1d: SKIP (0.312s)
[180.659742] [049/134] (858s left) i915_pm_rc6_residency (rc6-accuracy)
[180.719833] Starting subtest: rc6-accuracy
[180.720552] Starting dynamic subtest: gt0
[183.889195] Dynamic subtest gt0: SUCCESS (3.168s)
[183.890084] Subtest rc6-accuracy: SUCCESS (3.170s)
[184.017597] [050/134] (854s left) kms_cursor_legacy (basic-flip-before-cursor-atomic)
[184.506531] Starting subtest: basic-flip-before-cursor-atomic
[185.478666] Subtest basic-flip-before-cursor-atomic: SUCCESS (0.973s)
[186.193413] [051/134] (852s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-move)
[186.687949] Starting subtest: psr-2p-primscrn-spr-indfb-move
[186.689287] Subtest psr-2p-primscrn-spr-indfb-move: SKIP (0.000s)
[187.294378] [052/134] (851s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-mmap-cpu)
[187.785216] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-mmap-cpu
[187.786546] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[188.387688] [053/134] (850s left) kms_psr2_sf (fbc-pr-cursor-plane-move-continuous-exceed-fully-sf)
[188.879232] Subtest fbc-pr-cursor-plane-move-continuous-exceed-fully-sf: SKIP (0.000s)
[189.181597] [054/134] (849s left) syncobj_timeline (etime-multi-wait-all-for-submit-available-unsubmitted-signa
[189.237999] Starting subtest: etime-multi-wait-all-for-submit-available-unsubmitted-signaled
[189.346207] Subtest etime-multi-wait-all-for-submit-available-unsubmitted-signaled: SUCCESS (0.108s)
[189.468454] [055/134] (849s left) gem_mmap_wc (bad-size)
[189.523270] Starting subtest: bad-size
[189.524928] Subtest bad-size: SUCCESS (0.001s)
[189.670439] [056/134] (849s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip)
[190.165026] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip
[190.166221] Subtest y-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip: SKIP (0.000s)
[190.766337] [057/134] (848s left) kms_frontbuffer_tracking (psr-2p-scndscrn-shrfb-msflip-blt)
[191.253977] Starting subtest: psr-2p-scndscrn-shrfb-msflip-blt
[191.255268] Subtest psr-2p-scndscrn-shrfb-msflip-blt: SKIP (0.000s)
[191.866676] [058/134] (847s left) kms_cursor_legacy (cursora-vs-flipb-atomic)
[192.351649] Starting subtest: cursorA-vs-flipB-atomic
[192.353209] Subtest cursorA-vs-flipB-atomic: SKIP (0.001s)
[192.961957] [059/134] (846s left) sysfs_heartbeat_interval (nopreempt)
[193.019202] Starting subtest: nopreempt
[193.021738] Starting dynamic subtest: vcs0
[193.023074] Dynamic subtest vcs0: SKIP (0.000s)
[193.038264] Starting dynamic subtest: bcs0
[193.040292] Dynamic subtest bcs0: SKIP (0.000s)
[193.058915] Starting dynamic subtest: rcs0
[193.060927] Dynamic subtest rcs0: SKIP (0.000s)
[193.062851] Subtest nopreempt: SKIP (0.005s)
[193.132489] [060/134] (846s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-180-hflip)
[193.625291] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-180-hflip
[193.627362] Subtest yf-tiled-max-hw-stride-32bpp-rotate-180-hflip: SKIP (0.000s)
[194.228637] [061/134] (845s left) gem_wait (busy)
[194.302326] Starting subtest: busy
[194.303067] Starting dynamic subtest: all-engines
[194.821672] Dynamic subtest all-engines: SUCCESS (0.520s)
[194.835832] Starting dynamic subtest: rcs0
[195.340663] Dynamic subtest rcs0: SUCCESS (0.516s)
[195.354851] Starting dynamic subtest: bcs0
[195.857607] Dynamic subtest bcs0: SUCCESS (0.515s)
[195.871797] Starting dynamic subtest: vcs0
[196.384442] Dynamic subtest vcs0: SUCCESS (0.524s)
[196.387386] Subtest busy: SUCCESS (2.085s)
[196.622519] [062/134] (842s left) kms_setmode (clone-exclusive-crtc)
[196.681506] Starting subtest: clone-exclusive-crtc
[196.683388] Subtest clone-exclusive-crtc: SKIP (0.000s)
[196.810453] [063/134] (842s left) kms_psr2_sf (pr-overlay-plane-move-continuous-exceed-fully-sf)
[197.294436] Subtest pr-overlay-plane-move-continuous-exceed-fully-sf: SKIP (0.000s)
[197.597371] [064/134] (842s left) sw_sync (sync_merge_same)
[197.655912] Starting subtest: sync_merge_same
[197.656612] Subtest sync_merge_same: SUCCESS (0.000s)
[197.768977] [065/134] (841s left) kms_hdr (static-toggle)
[198.253073] Starting subtest: static-toggle
[198.255588] Subtest static-toggle: SKIP (0.000s)
[198.867457] [066/134] (840s left) gem_exec_await (wide-contexts)
[198.955450] Starting subtest: wide-contexts
[220.712505] Subtest wide-contexts: SUCCESS (21.757s)
[220.970301] [067/134] (818s left) kms_invalid_mode (uint-max-clock)
[221.578230] Starting subtest: uint-max-clock
[221.579194] Starting dynamic subtest: pipe-A-HDMI-A-1
[221.654754] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.076s)
[221.671459] Starting dynamic subtest: pipe-B-HDMI-A-1
[221.672222] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.001s)
[221.672920] Subtest uint-max-clock: SUCCESS (0.081s)
[222.160726] [068/134] (817s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-blt)
[222.659335] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-blt
[224.590867] Subtest fbc-1p-primscrn-cur-indfb-draw-blt: SUCCESS (1.931s)
[225.206969] [069/134] (814s left) kms_pm_rpm (modeset-non-lpsp)
[237.061698] Subtest modeset-non-lpsp: SKIP (0.000s)
[237.359592] [070/134] (802s left) kms_psr (fbc-pr-cursor-mmap-cpu)
[237.852965] Subtest fbc-pr-cursor-mmap-cpu: SKIP (0.000s)
[238.160727] [071/134] (801s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-indfb-draw-mmap-wc)
[238.647926] Starting subtest: fbc-1p-offscreen-pri-indfb-draw-mmap-wc
[240.078962] Subtest fbc-1p-offscreen-pri-indfb-draw-mmap-wc: SUCCESS (1.430s)
[240.712429] [072/134] (799s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-mmap-wc)
[241.198565] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-mmap-wc
[241.200236] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[241.787395] [073/134] (798s left) i915_pm_rps (thresholds-idle)
[241.851657] Starting subtest: thresholds-idle
[241.853843] Starting dynamic subtest: gt0
[252.201094] Dynamic subtest gt0: SUCCESS (10.348s)
[252.204421] Subtest thresholds-idle: SUCCESS (10.351s)
[252.338950] [074/134] (787s left) kms_vblank (query-idle-hang)
[252.822238] Starting subtest: query-idle-hang
[252.823130] Starting dynamic subtest: pipe-A-HDMI-A-1
[258.935755] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (6.112s)
[258.949933] Starting dynamic subtest: pipe-B-HDMI-A-1
[264.950788] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (6.012s)
[264.951654] Subtest query-idle-hang: SUCCESS (12.130s)
[265.626417] [075/134] (774s left) perf_pmu (most-busy-idle-check-all)
[265.692766] Starting subtest: most-busy-idle-check-all
[265.693421] Starting dynamic subtest: rcs0
[266.310634] Dynamic subtest rcs0: SUCCESS (0.617s)
[266.327882] Starting dynamic subtest: bcs0
[266.933315] Dynamic subtest bcs0: SUCCESS (0.619s)
[266.949352] Starting dynamic subtest: vcs0
[267.559586] Dynamic subtest vcs0: SUCCESS (0.623s)
[267.564270] Subtest most-busy-idle-check-all: SUCCESS (1.869s)
[267.690741] [076/134] (772s left) kms_atomic_interruptible (universal-setplane-cursor)
[268.182661] Starting subtest: universal-setplane-cursor
[268.184788] Starting dynamic subtest: pipe-A-HDMI-A-1
[274.467724] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (6.284s)
[274.468440] Subtest universal-setplane-cursor: SUCCESS (6.286s)
[275.174735] [077/134] (765s left) gem_userptr_blits (process-exit-busy)
[275.252964] Starting subtest: process-exit-busy
[275.272159] Subtest process-exit-busy: SUCCESS (0.020s)
[275.463529] [078/134] (764s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-pwrite)
[275.948258] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-pwrite
[275.949386] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[276.559505] [079/134] (763s left) gem_lmem_swapping (heavy-verify-multi)
[276.623735] Subtest heavy-verify-multi: SKIP (0.000s)
[276.688261] [080/134] (763s left) gen9_exec_parse (bb-start-cmd)
[276.747652] Subtest bb-start-cmd: SKIP (0.000s)
[276.814641] [081/134] (763s left) fbdev (unaligned-read)
[276.895700] Starting subtest: unaligned-read
[276.904864] Subtest unaligned-read: SUCCESS (0.011s)
[277.025573] [082/134] (763s left) kms_chamelium_hpd (dp-hpd-with-enabled-mode)
[277.590063] Subtest dp-hpd-with-enabled-mode: SKIP (0.000s)
[277.997791] [083/134] (762s left) gem_ppgtt (blt-vs-render-ctx0)
[278.058145] Starting subtest: blt-vs-render-ctx0
[310.638627] Subtest blt-vs-render-ctx0: SUCCESS (32.580s)
[310.810583] [084/134] (729s left) core_setmaster_vs_auth
[311.100147] [085/134] (729s left) prime_busy (hang)
[311.159494] Starting subtest: hang
[311.160453] Starting dynamic subtest: rcs0
[316.854671] Dynamic subtest rcs0: SUCCESS (5.694s)
[316.868319] Starting dynamic subtest: bcs0
[322.867908] Dynamic subtest bcs0: SUCCESS (6.011s)
[322.881522] Starting dynamic subtest: vcs0
[328.879063] Dynamic subtest vcs0: SUCCESS (6.010s)
[328.881900] Subtest hang: SUCCESS (17.722s)
[329.034942] [086/134] (711s left) gem_eio (unwedge-stress)
[329.112994] Starting subtest: unwedge-stress
[329.115177] Starting dynamic subtest: render
[330.834249] Dynamic subtest render: SUCCESS (1.720s)
[330.848829] Starting dynamic subtest: bsd
[332.654898] Dynamic subtest bsd: FAIL (1.785s)
[332.655741] Subtest unwedge-stress: FAIL (3.509s)
[333.687461] [087/134] (707s left) kms_cursor_crc (cursor-random-256x256)
[334.200717] Starting subtest: cursor-random-256x256
[334.203028] Starting dynamic subtest: pipe-A-HDMI-A-1
[337.946461] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (3.743s)
[337.987680] Starting dynamic subtest: pipe-B-HDMI-A-1
[341.663215] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (3.688s)
[341.663914] Subtest cursor-random-256x256: SUCCESS (7.464s)
[342.377167] [088/134] (698s left) syncobj_timeline (multi-wait-submitted-signaled)
[342.454603] Starting subtest: multi-wait-submitted-signaled
[342.456602] Subtest multi-wait-submitted-signaled: SUCCESS (0.002s)
[342.585651] [089/134] (698s left) kms_dsc (dsc-with-formats)
[343.067934] Subtest dsc-with-formats: SKIP (0.000s)
[343.365745] [090/134] (697s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-shrfb-draw-mmap-wc)
[343.853850] Starting subtest: psr-1p-offscreen-pri-shrfb-draw-mmap-wc
[343.855184] Subtest psr-1p-offscreen-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[344.452578] [091/134] (696s left) api_intel_allocator (reopen-fork)
[344.509852] Starting subtest: reopen-fork
[347.904055] Subtest reopen-fork: SUCCESS (3.393s)
[348.029498] [092/134] (693s left) gem_exec_whisper (basic-fds-priority-all)
[348.100174] Starting subtest: basic-fds-priority-all
[348.103084] Subtest basic-fds-priority-all: SKIP (0.001s)
[348.329663] [093/134] (692s left) gem_exec_fence (basic-wait-all)
[348.394389] Starting subtest: basic-wait-all
[348.437454] Subtest basic-wait-all: SUCCESS (0.043s)
[348.967785] [094/134] (692s left) kms_ccs (crc-sprite-planes-basic-4-tiled-dg2-rc-ccs-cc)
[349.026698] Subtest crc-sprite-planes-basic-4-tiled-dg2-rc-ccs-cc: SKIP (0.000s)
[349.087678] [095/134] (692s left) kms_psr (fbc-psr2-no-drrs)
[349.569958] Subtest fbc-psr2-no-drrs: SKIP (0.000s)
[349.870917] [096/134] (691s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-mmap-gtt)
[350.360843] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-mmap-gtt
[350.362112] Subtest psr-1p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[350.978018] [097/134] (690s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-pwrite)
[351.469219] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-pwrite
[351.470729] Subtest fbc-2p-scndscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[352.086866] [098/134] (689s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-mmap-cpu)
[352.582698] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-mmap-cpu
[354.512876] Subtest fbc-1p-primscrn-spr-indfb-draw-mmap-cpu: SUCCESS (1.931s)
[355.164892] [099/134] (686s left) kms_plane_scaling (planes-upscale-factor-0-25-downscale-factor-0-5)
[355.653244] Starting subtest: planes-upscale-factor-0-25-downscale-factor-0-5
[355.654102] Starting dynamic subtest: pipe-A
[355.656223] Dynamic subtest pipe-A: SKIP (0.001s)
[355.672187] Starting dynamic subtest: pipe-B
[355.674354] Dynamic subtest pipe-B: SKIP (0.001s)
[355.675546] Subtest planes-upscale-factor-0-25-downscale-factor-0-5: SKIP (0.006s)
[356.260579] [100/134] (685s left) kms_flip_scaled_crc (flip-32bpp-yftile-to-32bpp-yftileccs-upscaling)
[356.318875] Subtest flip-32bpp-yftile-to-32bpp-yftileccs-upscaling: SKIP (0.000s)
[356.391388] [101/134] (685s left) kms_cursor_legacy (flip-vs-cursor-busy-crc-atomic)
[356.877767] Starting subtest: flip-vs-cursor-busy-crc-atomic
[357.439695] Subtest flip-vs-cursor-busy-crc-atomic: SUCCESS (0.562s)
[358.160813] [102/134] (683s left) core_getstats (basic)
[358.219101] Starting subtest: basic
[358.219766] Subtest basic: SUCCESS (0.000s)
[358.346788] [103/134] (683s left) gem_mmap_gtt (hang-busy)
[358.401772] Starting subtest: hang-busy
[364.853114] Subtest hang-busy: SUCCESS (6.451s)
[365.000206] [104/134] (676s left) kms_flip (flip-vs-expired-vblank-interruptible)
[365.498504] Starting subtest: flip-vs-expired-vblank-interruptible
[365.500745] Starting dynamic subtest: A-VGA1
[373.232705] Dynamic subtest A-VGA1: SUCCESS (7.732s)
[373.247898] Starting dynamic subtest: B-VGA1
[380.916556] Dynamic subtest B-VGA1: SUCCESS (7.680s)
[380.932528] Starting dynamic subtest: A-HDMI-A1
[388.639653] Dynamic subtest A-HDMI-A1: SUCCESS (7.719s)
[388.658908] Starting dynamic subtest: B-HDMI-A1
[396.390115] Dynamic subtest B-HDMI-A1: SUCCESS (7.746s)
[396.393256] Subtest flip-vs-expired-vblank-interruptible: SUCCESS (30.894s)
[397.147715] [105/134] (644s left) gem_exec_schedule (preempt-queue-contexts)
[397.221514] Subtest preempt-queue-contexts: SKIP (0.000s)
[397.464442] [106/134] (644s left) perf (oa-formats)
[397.666757] Subtest oa-formats: SKIP (0.000s)
[397.724956] [107/134] (644s left) kms_frontbuffer_tracking (fbcpsr-modesetfrombusy)
[398.214380] Starting subtest: fbcpsr-modesetfrombusy
[398.216052] Subtest fbcpsr-modesetfrombusy: SKIP (0.000s)
[398.828898] [108/134] (643s left) kms_flip (2x-dpms-vs-vblank-race)
[399.312584] Starting subtest: 2x-dpms-vs-vblank-race
[399.313689] Starting dynamic subtest: AB-VGA1-HDMI-A1
[409.944646] Dynamic subtest AB-VGA1-HDMI-A1: SUCCESS (10.630s)
[409.945370] Subtest 2x-dpms-vs-vblank-race: SUCCESS (10.633s)
[410.687750] [109/134] (631s left) gem_exec_params (readonly)
[410.781153] Starting subtest: readonly
[410.781911] Subtest readonly: SUCCESS (0.001s)
[410.968899] [110/134] (631s left) kms_vblank (invalid)
[411.452790] Starting subtest: invalid
[411.453579] Starting dynamic subtest: pipe-A-HDMI-A-1
[411.664892] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.210s)
[411.665749] Subtest invalid: SUCCESS (0.213s)
[412.388548] [111/134] (629s left) gem_exec_reloc (basic-cpu-read-noreloc)
[412.450146] Starting subtest: basic-cpu-read-noreloc
[412.452721] Subtest basic-cpu-read-noreloc: SUCCESS (0.002s)
[413.488795] [112/134] (628s left) gem_ctx_persistence (engines-hostile)
[413.548775] Subtest engines-hostile: SKIP (0.000s)
[413.614456] [113/134] (628s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-mmap-gtt)
[414.105511] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-mmap-gtt
[416.030772] Subtest fbc-1p-primscrn-spr-indfb-draw-mmap-gtt: SUCCESS (1.925s)
[416.680381] [114/134] (625s left) kms_frontbuffer_tracking (fbcpsr-2p-shrfb-fliptrack-mmap-gtt)
[417.164808] Starting subtest: fbcpsr-2p-shrfb-fliptrack-mmap-gtt
[417.166135] Subtest fbcpsr-2p-shrfb-fliptrack-mmap-gtt: SKIP (0.000s)
[417.760189] [115/134] (624s left) gem_caching (writes)
[417.822150] Starting subtest: writes
[420.775693] Subtest writes: SUCCESS (2.955s)
[420.939167] [116/134] (621s left) kms_pm_backlight (fade-with-suspend)
[421.430138] Subtest fade-with-suspend: SKIP (0.000s)
[421.732574] [117/134] (620s left) kms_plane_alpha_blend (coverage-vs-premult-vs-constant)
[422.216651] Starting subtest: coverage-vs-premult-vs-constant
[422.369590] Subtest coverage-vs-premult-vs-constant: SKIP (0.153s)
[423.166844] [118/134] (619s left) kms_lease (master-vs-lease)
[423.653769] Starting subtest: master-vs-lease
[423.654623] Subtest master-vs-lease: SUCCESS (0.002s)
[424.247382] [119/134] (618s left) kms_frontbuffer_tracking (psr-rgb565-draw-mmap-wc)
[424.739542] Starting subtest: psr-rgb565-draw-mmap-wc
[424.740802] Subtest psr-rgb565-draw-mmap-wc: SKIP (0.000s)
[425.355696] [120/134] (617s left) kms_addfb_basic (addfb25-4-tiled)
[425.841147] Starting subtest: addfb25-4-tiled
[425.843279] Subtest addfb25-4-tiled: SUCCESS (0.000s)
[426.445691] [121/134] (616s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-downscaling)
[426.501362] Subtest flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-downscaling: SKIP (0.000s)
[426.555423] [122/134] (616s left) kms_plane_multiple (2x-tiling-x)
[427.043650] Starting subtest: 2x-tiling-x
[427.045210] Subtest 2x-tiling-x: SKIP (0.000s)
[427.660383] [123/134] (615s left) kms_psr (psr2-primary-render)
[428.143454] Subtest psr2-primary-render: SKIP (0.000s)
[428.451098] [124/134] (614s left) syncobj_wait (multi-wait-all-for-submit-submitted-signaled)
[428.507380] Starting subtest: multi-wait-all-for-submit-submitted-signaled
[428.610043] Subtest multi-wait-all-for-submit-submitted-signaled: SUCCESS (0.102s)
[428.721900] [125/134] (614s left) gem_exec_balancer (full)
[428.779947] Subtest full: SKIP (0.000s)
[428.905257] [126/134] (614s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-render)
[429.394334] Starting subtest: psr-2p-primscrn-spr-indfb-draw-render
[429.395706] Subtest psr-2p-primscrn-spr-indfb-draw-render: SKIP (0.000s)
[430.007686] [127/134] (612s left) gem_mmap_wc (write-read)
[430.064697] Starting subtest: write-read
[430.078874] Subtest write-read: SUCCESS (0.015s)
[430.234118] [128/134] (612s left) gem_ctx_persistence (process)
[430.292305] Subtest process: SKIP (0.000s)
[430.369923] [129/134] (612s left) gem_ctx_param (non-root-set)
[430.425779] Starting subtest: non-root-set
[430.449673] Subtest non-root-set: SUCCESS (0.024s)
[430.586562] [130/134] (612s left) sw_sync (timeline_closed)
[430.644283] Starting subtest: timeline_closed
[430.645054] Subtest timeline_closed: SUCCESS (0.000s)
[430.750922] [131/134] (612s left) kms_rotation_crc (primary-4-tiled-reflect-x-180)
[431.234317] Starting subtest: primary-4-tiled-reflect-x-180
[431.235829] Subtest primary-4-tiled-reflect-x-180: SKIP (0.001s)
[431.851329] [132/134] (611s left) gem_exec_parallel (basic)
[431.918703] Starting subtest: basic
[431.919581] Starting dynamic subtest: rcs0
[433.761281] Dynamic subtest rcs0: SUCCESS (1.841s)
[433.779390] Starting dynamic subtest: bcs0
[435.455399] Dynamic subtest bcs0: SUCCESS (1.691s)
[435.459133] Subtest basic: SUCCESS (3.539s)
[435.695385] [133/134] (607s left) kms_content_protection (uevent-hdcp14)
[436.200311] Starting subtest: uevent-hdcp14
[436.202403] Subtest uevent-hdcp14: SKIP (0.000s)
[436.823379] [134/134] (606s left) syncobj_timeline (multi-wait-all-for-submit-available-signaled)
[436.881111] Starting subtest: multi-wait-all-for-submit-available-signaled
[436.881964] Subtest multi-wait-all-for-submit-available-signaled: SUCCESS (0.001s)
[436.986836] 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.