[77.504246] Initializing watchdogs
[77.504354]   /dev/watchdog0
[77.523631] [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)
[77.531414] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[77.535112] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[77.538558] [001/133] (960s left) syncobj_timeline (invalid-multi-wait-unsubmitted)
[77.636180] Starting subtest: invalid-multi-wait-unsubmitted
[77.637097] Subtest invalid-multi-wait-unsubmitted: SUCCESS (0.000s)
[77.732379] [002/133] (960s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-mmap-gtt)
[78.223306] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-mmap-gtt
[79.711822] Subtest fbc-2p-scndscrn-pri-shrfb-draw-mmap-gtt: SUCCESS (1.488s)
[79.842091] [003/133] (958s left) kms_ccs (bad-aux-stride-y-tiled-gen12-mc-ccs)
[79.903266] Subtest bad-aux-stride-y-tiled-gen12-mc-ccs: SKIP (0.000s)
[79.961083] [004/133] (958s left) gem_mmap_gtt (basic-small-copy-odd)
[80.021082] Starting subtest: basic-small-copy-odd
[80.667643] Subtest basic-small-copy-odd: SUCCESS (0.648s)
[80.777027] [005/133] (957s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-16bpp-ytile-upscaling)
[80.941542] Subtest flip-64bpp-ytile-to-16bpp-ytile-upscaling: SKIP (0.000s)
[81.002313] [006/133] (957s left) kms_big_fb (yf-tiled-32bpp-rotate-180)
[81.516769] Starting subtest: yf-tiled-32bpp-rotate-180
[81.518267] Subtest yf-tiled-32bpp-rotate-180: SKIP (0.000s)
[81.622408] [007/133] (956s left) syncobj_timeline (single-wait-available-signaled)
[81.698917] Starting subtest: single-wait-available-signaled
[81.699738] Subtest single-wait-available-signaled: SUCCESS (0.001s)
[81.790070] [008/133] (956s left) kms_cursor_legacy (flip-vs-cursor-atomic-transitions-varying-size)
[82.277091] Starting subtest: flip-vs-cursor-atomic-transitions-varying-size
[97.317123] Subtest flip-vs-cursor-atomic-transitions-varying-size: SUCCESS (15.039s)
[97.584617] [009/133] (940s left) gem_softpin (softpin)
[97.664946] Starting subtest: softpin
[129.907665] Subtest softpin: SUCCESS (32.242s)
[130.021438] [010/133] (908s left) gem_mmap_wc (read)
[130.085258] Starting subtest: read
[130.143183] Subtest read: SUCCESS (0.060s)
[130.258444] [011/133] (908s left) gem_flink_basic (basic)
[130.315608] Starting subtest: basic
[130.316419] Subtest basic: SUCCESS (0.000s)
[130.427454] [012/133] (908s left) gem_exec_params (invalid-bsd1-flag-on-render)
[130.490526] Starting subtest: invalid-bsd1-flag-on-render
[130.491307] Subtest invalid-bsd1-flag-on-render: SUCCESS (0.000s)
[130.598274] [013/133] (907s left) gem_mmap_gtt (cpuset-big-copy)
[130.657845] Starting subtest: cpuset-big-copy
[133.722726] Subtest cpuset-big-copy: SUCCESS (3.065s)
[133.944439] [014/133] (904s left) perf_pmu (busy-idle-check-all)
[134.105485] Starting subtest: busy-idle-check-all
[134.106186] Starting dynamic subtest: rcs0
[134.727613] Dynamic subtest rcs0: SUCCESS (0.623s)
[134.740246] Starting dynamic subtest: bcs0
[135.350553] Dynamic subtest bcs0: SUCCESS (0.622s)
[135.362753] Starting dynamic subtest: vcs0
[136.470387] Dynamic subtest vcs0: SUCCESS (1.119s)
[136.471611] Subtest busy-idle-check-all: SUCCESS (2.367s)
[136.568350] [015/133] (902s left) gem_render_copy_redux (flink)
[136.634148] Starting subtest: flink
[137.816171] Subtest flink: SUCCESS (1.182s)
[137.932877] [016/133] (900s left) kms_psr (fbc-psr-primary-blt)
[138.429952] Subtest fbc-psr-primary-blt: SKIP (0.000s)
[138.496676] [017/133] (900s left) kms_frontbuffer_tracking (fbc-rgb565-draw-mmap-cpu)
[138.991043] Starting subtest: fbc-rgb565-draw-mmap-cpu
[140.761820] Subtest fbc-rgb565-draw-mmap-cpu: SUCCESS (1.770s)
[140.992312] [018/133] (897s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-blt)
[141.485235] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-blt
[143.087631] Subtest fbc-2p-scndscrn-spr-indfb-draw-blt: SUCCESS (1.602s)
[143.248853] [019/133] (895s left) gem_ctx_param (invalid-size-get)
[143.317334] Starting subtest: invalid-size-get
[143.318100] Subtest invalid-size-get: SUCCESS (0.000s)
[143.413133] [020/133] (895s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-blt)
[143.905915] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-blt
[143.907956] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-blt: SKIP (0.000s)
[144.015388] [021/133] (894s left) kms_cursor_legacy (flip-vs-cursor-atomic)
[144.503254] Starting subtest: flip-vs-cursor-atomic
[154.461293] Subtest flip-vs-cursor-atomic: SUCCESS (9.955s)
[154.734287] [022/133] (884s left) kms_vblank (wait-busy-hang)
[155.227023] Starting subtest: wait-busy-hang
[155.228088] Starting dynamic subtest: pipe-A-VGA-1
[161.876700] Dynamic subtest pipe-A-VGA-1: SUCCESS (6.649s)
[161.889597] Starting dynamic subtest: pipe-A-HDMI-A-1
[167.930033] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (6.051s)
[167.942784] Starting dynamic subtest: pipe-B-VGA-1
[173.919284] Dynamic subtest pipe-B-VGA-1: SUCCESS (5.989s)
[173.935554] Starting dynamic subtest: pipe-B-HDMI-A-1
[179.960804] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (6.040s)
[179.961648] Subtest wait-busy-hang: SUCCESS (24.735s)
[180.242420] [023/133] (858s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-gtt)
[180.741213] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-gtt
[180.742993] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[180.852688] [024/133] (858s left) i915_query (test-query-geometry-subslices)
[180.912848] Starting subtest: test-query-geometry-subslices
[180.914637] Subtest test-query-geometry-subslices: SKIP (0.000s)
[181.004084] [025/133] (858s left) kms_chamelium_frames (hdmi-frame-dump)
[181.625776] Subtest hdmi-frame-dump: SKIP (0.000s)
[181.831125] [026/133] (857s left) kms_cursor_legacy (nonblocking-modeset-vs-cursor-atomic)
[182.320535] Starting subtest: nonblocking-modeset-vs-cursor-atomic
[182.600231] Subtest nonblocking-modeset-vs-cursor-atomic: SUCCESS (0.282s)
[182.860205] [027/133] (856s left) kms_psr (psr-dpms)
[183.345856] Subtest psr-dpms: SKIP (0.000s)
[183.401816] [028/133] (855s left) perf (buffer-fill)
[183.604402] Subtest buffer-fill: SKIP (0.000s)
[183.653372] [029/133] (855s left) kms_feature_discovery (display)
[184.133382] Starting subtest: display
[184.134213] Subtest display: SUCCESS (0.000s)
[184.225577] [030/133] (855s left) syncobj_wait (invalid-single-wait-unsubmitted)
[184.289111] Starting subtest: invalid-single-wait-unsubmitted
[184.289965] Subtest invalid-single-wait-unsubmitted: SUCCESS (0.000s)
[184.375217] [031/133] (855s left) syncobj_timeline (multi-wait-for-submit-submitted-signaled)
[184.433394] Starting subtest: multi-wait-for-submit-submitted-signaled
[184.435025] Subtest multi-wait-for-submit-submitted-signaled: SUCCESS (0.001s)
[184.529350] [032/133] (854s left) gem_exec_reloc (basic-concurrent0)
[184.594558] Starting subtest: basic-concurrent0
[189.984220] Subtest basic-concurrent0: SUCCESS (5.390s)
[190.511159] [033/133] (849s left) core_getversion (all-cards)
[190.571309] Starting subtest: all-cards
[190.584828] Subtest all-cards: SUCCESS (0.016s)
[190.644815] [034/133] (848s left) gem_request_retire (retire-vma-not-inactive)
[190.703648] Starting subtest: retire-vma-not-inactive
[190.707881] Subtest retire-vma-not-inactive: SUCCESS (0.004s)
[190.826928] [035/133] (848s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-mmap-cpu)
[191.320947] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-mmap-cpu
[192.775659] Subtest fbc-2p-scndscrn-pri-indfb-draw-mmap-cpu: SUCCESS (1.453s)
[192.920089] [036/133] (846s left) gem_exec_schedule (timeslicing)
[192.996147] Subtest timeslicing: SKIP (0.000s)
[193.186434] [037/133] (846s left) kms_psr (pr-sprite-render)
[193.670022] Subtest pr-sprite-render: SKIP (0.000s)
[193.729876] [038/133] (846s left) kms_frontbuffer_tracking (basic)
[194.222893] Starting subtest: basic
[196.600998] Subtest basic: SUCCESS (2.378s)
[196.819076] [039/133] (842s left) prime_vgem (sync)
[196.945592] Starting subtest: sync
[196.946435] Starting dynamic subtest: rcs0
[196.964990] Dynamic subtest rcs0: SUCCESS (0.019s)
[196.979636] Starting dynamic subtest: bcs0
[196.991258] Dynamic subtest bcs0: SUCCESS (0.026s)
[196.993548] Subtest sync: SUCCESS (0.046s)
[197.121574] [FACT prime_vgem (sync)] new: kernel.kmod_is_loaded.vgem: true
[197.124464] [040/133] (842s left) kms_cursor_legacy (cursora-vs-flipa-atomic)
[197.613778] Starting subtest: cursorA-vs-flipA-atomic
[208.557952] Subtest cursorA-vs-flipA-atomic: SUCCESS (10.944s)
[208.818304] [041/133] (831s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-mmap-wc)
[209.311385] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-mmap-wc
[209.312767] Subtest psr-1p-primscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[209.419396] [042/133] (830s left) prime_vgem (basic-gtt)
[209.491912] Starting subtest: basic-gtt
[209.511698] Subtest basic-gtt: SUCCESS (0.019s)
[209.616193] [043/133] (830s left) gem_ctx_persistence (hostile)
[209.677931] Subtest hostile: SKIP (0.000s)
[209.744950] [044/133] (830s left) kms_chamelium_hpd (dp-hpd-after-suspend)
[210.335055] Subtest dp-hpd-after-suspend: SKIP (0.000s)
[210.549115] [045/133] (829s left) kms_frontbuffer_tracking (psr-1p-rte)
[211.040706] Starting subtest: psr-1p-rte
[211.042787] Subtest psr-1p-rte: SKIP (0.000s)
[211.150593] [046/133] (829s left) kms_psr (fbc-pr-primary-mmap-gtt)
[211.630234] Subtest fbc-pr-primary-mmap-gtt: SKIP (0.000s)
[211.696131] [047/133] (828s left) kms_cursor_legacy (cursorb-vs-flipb-atomic)
[212.181601] Starting subtest: cursorB-vs-flipB-atomic
[223.126085] Subtest cursorB-vs-flipB-atomic: SUCCESS (10.945s)
[223.389168] [048/133] (816s left) gem_eio (in-flight-internal-10ms)
[223.458734] Starting subtest: in-flight-internal-10ms
[223.504622] Subtest in-flight-internal-10ms: SUCCESS (0.045s)
[224.041581] [049/133] (816s left) kms_cursor_crc (cursor-offscreen-64x64)
[224.533288] Starting subtest: cursor-offscreen-64x64
[224.550317] Starting dynamic subtest: pipe-A-VGA-1
[227.019038] Dynamic subtest pipe-A-VGA-1: SUCCESS (2.466s)
[227.065966] Starting dynamic subtest: pipe-B-HDMI-A-1
[229.448994] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (2.400s)
[229.449834] Subtest cursor-offscreen-64x64: SUCCESS (4.917s)
[229.720975] [050/133] (810s left) gen7_exec_parse (oacontrol-tracking)
[229.784685] Subtest oacontrol-tracking: SKIP (0.000s)
[229.847132] [051/133] (810s left) kms_flip_scaled_crc (flip-64bpp-linear-to-16bpp-linear-downscaling)
[229.909159] Subtest flip-64bpp-linear-to-16bpp-linear-downscaling: SKIP (0.000s)
[229.974293] [052/133] (810s left) kms_pipe_crc_basic (disable-crc-after-crtc)
[230.459310] Starting subtest: disable-crc-after-crtc
[230.461207] Starting dynamic subtest: pipe-A-VGA-1
[231.026851] Dynamic subtest pipe-A-VGA-1: SUCCESS (0.566s)
[231.042815] Starting dynamic subtest: pipe-B-HDMI-A-1
[231.601509] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.573s)
[231.602470] Subtest disable-crc-after-crtc: SUCCESS (1.143s)
[231.862343] [053/133] (808s left) kms_rotation_crc (primary-yf-tiled-reflect-x-0)
[232.348434] Starting subtest: primary-yf-tiled-reflect-x-0
[232.350233] Subtest primary-yf-tiled-reflect-x-0: SKIP (0.001s)
[232.440357] [054/133] (808s left) gem_ctx_persistence (engines-hang)
[232.508272] Subtest engines-hang: SKIP (0.000s)
[232.567463] [055/133] (808s left) gem_eio (in-flight-1us)
[232.629892] Starting subtest: in-flight-1us
[234.024265] Subtest in-flight-1us: SUCCESS (1.395s)
[234.554331] [056/133] (806s left) gem_mmap_wc (pf-nonblock)
[234.612166] Starting subtest: pf-nonblock
[234.612845] Subtest pf-nonblock: SUCCESS (0.001s)
[234.736227] [057/133] (806s left) kms_flip (plain-flip-fb-recreate-interruptible)
[235.221906] Starting subtest: plain-flip-fb-recreate-interruptible
[235.224173] Starting dynamic subtest: A-VGA1
[243.278498] Dynamic subtest A-VGA1: SUCCESS (8.056s)
[243.293251] Starting dynamic subtest: B-VGA1
[251.252440] Dynamic subtest B-VGA1: SUCCESS (7.972s)
[251.267702] Starting dynamic subtest: A-HDMI-A1
[259.259274] Dynamic subtest A-HDMI-A1: SUCCESS (8.005s)
[259.274924] Starting dynamic subtest: B-HDMI-A1
[267.301897] Dynamic subtest B-HDMI-A1: SUCCESS (8.038s)
[267.302940] Subtest plain-flip-fb-recreate-interruptible: SUCCESS (32.081s)
[267.490583] [058/133] (773s left) gem_exec_reloc (basic-wc-gtt-active)
[267.561973] Starting subtest: basic-wc-gtt-active
[267.673466] Subtest basic-wc-gtt-active: SUCCESS (0.111s)
[268.190529] [059/133] (772s left) kms_async_flips (async-flip-hang)
[268.671451] Starting subtest: async-flip-hang
[268.914731] Starting dynamic subtest: pipe-A-VGA-1
[275.889402] Dynamic subtest pipe-A-VGA-1: SUCCESS (6.974s)
[276.007651] Starting dynamic subtest: pipe-A-HDMI-A-1
[281.903738] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (5.911s)
[282.051531] Starting dynamic subtest: pipe-B-VGA-1
[287.855028] Dynamic subtest pipe-B-VGA-1: SUCCESS (5.816s)
[287.968498] Starting dynamic subtest: pipe-B-HDMI-A-1
[293.871828] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (5.915s)
[293.872983] Subtest async-flip-hang: SUCCESS (25.201s)
[294.243365] [060/133] (746s left) gem_exec_flush (basic-wb-set-default)
[294.318185] Starting subtest: basic-wb-set-default
[299.766433] Subtest basic-wb-set-default: SUCCESS (5.448s)
[299.970044] [061/133] (740s left) kms_cursor_edge_walk (128x128-top-edge)
[300.458553] Starting subtest: 128x128-top-edge
[300.459396] Starting dynamic subtest: pipe-A-VGA-1
[303.847209] Dynamic subtest pipe-A-VGA-1: SUCCESS (3.388s)
[303.861903] Starting dynamic subtest: pipe-B-HDMI-A-1
[307.182140] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (3.332s)
[307.182852] Subtest 128x128-top-edge: SUCCESS (6.725s)
[307.467351] [062/133] (733s left) kms_big_fb (x-tiled-8bpp-rotate-180)
[307.958242] Starting subtest: x-tiled-8bpp-rotate-180
[309.218081] Subtest x-tiled-8bpp-rotate-180: SUCCESS (1.259s)
[309.462140] [063/133] (731s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-move)
[309.951318] Starting subtest: psr-2p-scndscrn-spr-indfb-move
[309.953519] Subtest psr-2p-scndscrn-spr-indfb-move: SKIP (0.000s)
[310.075690] [064/133] (731s left) kms_ccs (crc-primary-basic-y-tiled-gen12-mc-ccs)
[310.134274] Subtest crc-primary-basic-y-tiled-gen12-mc-ccs: SKIP (0.000s)
[310.199202] [065/133] (730s left) kms_big_fb (4-tiled-32bpp-rotate-180)
[310.689609] Starting subtest: 4-tiled-32bpp-rotate-180
[310.691661] Subtest 4-tiled-32bpp-rotate-180: SKIP (0.000s)
[310.806561] [066/133] (730s left) gem_exec_fence (syncobj-channel)
[311.012466] Starting subtest: syncobj-channel
[312.041825] Subtest syncobj-channel: SUCCESS (1.028s)
[312.401742] [067/133] (728s left) kms_mmap_write_crc (main)
[312.887352] Starting subtest: main
[312.891879] Starting dynamic subtest: pipe-A-VGA-1
[315.557604] Dynamic subtest pipe-A-VGA-1: SUCCESS (2.668s)
[315.561063] Subtest main: SUCCESS (2.670s)
[315.824286] [068/133] (725s left) kms_big_fb (y-tiled-32bpp-rotate-180)
[316.321590] Starting subtest: y-tiled-32bpp-rotate-180
[316.323628] Subtest y-tiled-32bpp-rotate-180: SKIP (0.000s)
[316.436798] [069/133] (724s left) kms_pm_rpm (fences-dpms)
[328.211077] Subtest fences-dpms: SKIP (0.000s)
[328.278546] [070/133] (713s left) gem_ctx_param (set-priority-range)
[328.344791] Subtest set-priority-range: SKIP (0.000s)
[328.440086] [071/133] (713s left) api_intel_allocator (alloc-simple)
[328.503818] Starting subtest: alloc-simple
[328.508383] Subtest alloc-simple: SUCCESS (0.005s)
[328.631177] [072/133] (712s left) gem_exec_schedule (preempt-other-chain)
[328.706031] Subtest preempt-other-chain: SKIP (0.000s)
[328.917800] [073/133] (712s left) kms_addfb_basic (too-wide)
[329.394096] Starting subtest: too-wide
[329.394935] Subtest too-wide: SUCCESS (0.000s)
[329.515876] [074/133] (712s left) gem_userptr_blits (set-cache-level)
[329.577276] Starting subtest: set-cache-level
[329.577976] Subtest set-cache-level: SUCCESS (0.000s)
[329.714583] [075/133] (711s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-pwrite)
[330.202659] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-pwrite
[330.203854] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[330.311709] [076/133] (711s left) kms_ccs (crc-primary-suspend-4-tiled-dg2-rc-ccs-cc)
[330.369488] Subtest crc-primary-suspend-4-tiled-dg2-rc-ccs-cc: SKIP (0.000s)
[330.443731] [077/133] (711s left) kms_flip (2x-blocking-absolute-wf_vblank-interruptible)
[330.929097] Starting subtest: 2x-blocking-absolute-wf_vblank-interruptible
[330.932368] Starting dynamic subtest: AB-VGA1-HDMI-A1
[361.381761] Dynamic subtest AB-VGA1-HDMI-A1: SUCCESS (30.449s)
[361.385847] Subtest 2x-blocking-absolute-wf_vblank-interruptible: SUCCESS (30.454s)
[361.632610] [078/133] (680s left) kms_plane (pixel-format-4-tiled-modifier-source-clamping)
[362.118476] Starting subtest: pixel-format-4-tiled-modifier-source-clamping
[362.119900] Subtest pixel-format-4-tiled-modifier-source-clamping: SKIP (0.000s)
[362.220960] [079/133] (679s left) gem_exec_params (rsvd2-dirt)
[362.282309] Starting subtest: rsvd2-dirt
[362.283970] Subtest rsvd2-dirt: SKIP (0.000s)
[362.400239] [080/133] (679s left) kms_ccs (crc-sprite-planes-basic-4-tiled-mtl-rc-ccs)
[362.458814] Subtest crc-sprite-planes-basic-4-tiled-mtl-rc-ccs: SKIP (0.000s)
[362.524341] [081/133] (679s left) kms_big_fb (linear-16bpp-rotate-90)
[363.009630] Starting subtest: linear-16bpp-rotate-90
[363.104903] Subtest linear-16bpp-rotate-90: SKIP (0.094s)
[363.328487] [082/133] (678s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-move)
[363.817650] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-move
[363.819896] Subtest fbcpsr-1p-primscrn-cur-indfb-move: SKIP (0.000s)
[363.924442] [083/133] (678s left) kms_chamelium_audio (dp-audio)
[364.524467] Subtest dp-audio: SKIP (0.000s)
[364.744574] [084/133] (677s left) gem_bad_reloc (negative-reloc-lut)
[364.810811] Starting subtest: negative-reloc-lut
[364.812654] Subtest negative-reloc-lut: SKIP (0.000s)
[364.934471] [085/133] (677s left) kms_psr2_sf (pr-primary-plane-update-sf-dmg-area-big-fb)
[365.414462] Subtest pr-primary-plane-update-sf-dmg-area-big-fb: SKIP (0.000s)
[365.478347] [086/133] (676s left) i915_hangman (detector)
[365.544447] Starting subtest: detector
[365.545139] Starting dynamic subtest: rcs0
[369.021047] Dynamic subtest rcs0: SUCCESS (3.476s)
[369.037609] Starting dynamic subtest: bcs0
[372.992166] Dynamic subtest bcs0: SUCCESS (3.966s)
[373.008675] Starting dynamic subtest: vcs0
[377.013999] Dynamic subtest vcs0: SUCCESS (4.023s)
[377.017503] Subtest detector: SUCCESS (11.471s)
[377.086471] [087/133] (665s left) sysfs_heartbeat_interval (mixed)
[377.150711] Starting subtest: mixed
[377.152733] Starting dynamic subtest: vcs0
[377.154049] Dynamic subtest vcs0: SKIP (0.000s)
[377.170444] Starting dynamic subtest: bcs0
[377.172577] Dynamic subtest bcs0: SKIP (0.000s)
[377.187346] Starting dynamic subtest: rcs0
[377.189301] Dynamic subtest rcs0: SKIP (0.000s)
[377.191307] Subtest mixed: SKIP (0.006s)
[377.256136] [088/133] (665s left) kms_universal_plane (universal-plane-pageflip-windowed)
[377.739285] Starting subtest: universal-plane-pageflip-windowed
[377.741502] Subtest universal-plane-pageflip-windowed: SKIP (0.000s)
[377.839662] [089/133] (664s left) kms_dp_link_training (uhbr-sst)
[378.322366] Starting subtest: uhbr-sst
[378.325350] Subtest uhbr-sst: SKIP (0.000s)
[378.421745] [090/133] (664s left) gem_exec_balancer (bonded-pair)
[378.483648] Subtest bonded-pair: SKIP (0.000s)
[378.585462] [091/133] (663s left) gem_exec_fence (invalid-fence-array)
[378.794676] Starting subtest: invalid-fence-array
[378.799452] Subtest invalid-fence-array: SUCCESS (0.003s)
[379.140488] [092/133] (663s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-fullscreen)
[379.621685] Starting subtest: fbc-2p-scndscrn-spr-indfb-fullscreen
[380.776843] Subtest fbc-2p-scndscrn-spr-indfb-fullscreen: SUCCESS (1.155s)
[380.931957] [093/133] (661s left) kms_psr (psr-cursor-plane-onoff)
[381.412811] Subtest psr-cursor-plane-onoff: SKIP (0.000s)
[381.472990] [094/133] (661s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-gtt)
[381.959365] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-gtt
[381.960865] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[382.078013] [095/133] (660s left) kms_busy (basic)
[382.564875] Starting subtest: basic
[382.565763] Starting dynamic subtest: flip
[383.035248] Dynamic subtest flip: SUCCESS (0.469s)
[383.052192] Starting dynamic subtest: modeset
[383.584826] Dynamic subtest modeset: SUCCESS (0.547s)
[383.585567] Subtest basic: SUCCESS (1.021s)
[383.875428] [096/133] (658s left) gem_exec_async (forked-writes)
[383.951016] Starting subtest: forked-writes
[383.953481] Starting dynamic subtest: rcs0
[383.968496] Dynamic subtest rcs0: SUCCESS (0.016s)
[383.984430] Starting dynamic subtest: bcs0
[383.985175] Dynamic subtest bcs0: SUCCESS (0.015s)
[384.001330] Starting dynamic subtest: vcs0
[384.009307] Dynamic subtest vcs0: SUCCESS (0.022s)
[384.011981] Subtest forked-writes: SUCCESS (0.060s)
[384.240882] [097/133] (658s left) prime_vgem (coherency-gtt)
[384.310424] Starting subtest: coherency-gtt
[384.326976] Subtest coherency-gtt: SUCCESS (0.017s)
[384.472372] [098/133] (658s left) kms_properties (colorop-properties-legacy)
[384.949766] Starting subtest: colorop-properties-legacy
[384.951188] Starting dynamic subtest: pipe-A-VGA-1
[385.107840] Dynamic subtest pipe-A-VGA-1: SUCCESS (0.157s)
[385.127464] Starting dynamic subtest: pipe-A-HDMI-A-1
[385.323147] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.211s)
[385.342143] Starting dynamic subtest: pipe-B-VGA-1
[385.457816] Dynamic subtest pipe-B-VGA-1: SUCCESS (0.131s)
[385.472107] Starting dynamic subtest: pipe-B-HDMI-A-1
[385.661130] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.202s)
[385.663668] Subtest colorop-properties-legacy: SUCCESS (0.713s)
[385.958897] [099/133] (657s left) gem_mmap_wc (set-cache-level)
[386.024513] Starting subtest: set-cache-level
[386.025277] Subtest set-cache-level: SUCCESS (0.001s)
[386.145804] [100/133] (656s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-indfb-draw-render)
[386.636759] Starting subtest: psr-1p-offscreen-pri-indfb-draw-render
[386.638247] Subtest psr-1p-offscreen-pri-indfb-draw-render: SKIP (0.000s)
[386.755209] [101/133] (656s left) kms_psr (fbc-psr2-primary-mmap-cpu)
[387.232063] Subtest fbc-psr2-primary-mmap-cpu: SKIP (0.000s)
[387.301605] [102/133] (655s left) syncobj_timeline (32bits-limit)
[387.363572] Starting subtest: 32bits-limit
[387.364415] Subtest 32bits-limit: SUCCESS (0.001s)
[387.457778] [103/133] (655s left) perf_pmu (busy-accuracy-98)
[387.517585] Starting subtest: busy-accuracy-98
[387.518440] Starting dynamic subtest: rcs0
[387.519964] Dynamic subtest rcs0: SKIP (0.000s)
[387.534116] Starting dynamic subtest: bcs0
[387.535885] Dynamic subtest bcs0: SKIP (0.000s)
[387.550843] Starting dynamic subtest: vcs0
[387.552872] Dynamic subtest vcs0: SKIP (0.000s)
[387.554743] Subtest busy-accuracy-98: SKIP (0.005s)
[387.624079] [104/133] (655s left) kms_plane_scaling (planes-downscale-factor-0-5-upscale-20x20)
[388.107460] Starting subtest: planes-downscale-factor-0-5-upscale-20x20
[388.108316] Starting dynamic subtest: pipe-A
[388.111309] Dynamic subtest pipe-A: SKIP (0.002s)
[388.127815] Starting dynamic subtest: pipe-B
[388.131889] Dynamic subtest pipe-B: SKIP (0.002s)
[388.133923] Subtest planes-downscale-factor-0-5-upscale-20x20: SKIP (0.007s)
[388.209922] [105/133] (655s left) gem_exec_whisper (basic-normal-all)
[388.285348] Starting subtest: basic-normal-all
[389.301285] Subtest basic-normal-all: SUCCESS (1.014s)
[389.517108] [106/133] (653s left) gem_pxp (verify-pxp-execution-after-suspend-resume)
[392.092583] Starting subtest: verify-pxp-execution-after-suspend-resume
[392.094185] Subtest verify-pxp-execution-after-suspend-resume: SKIP (0.000s)
[392.196896] [107/133] (651s left) gem_exec_reloc (basic-range-active)
[392.264672] Starting subtest: basic-range-active
[392.288031] Subtest basic-range-active: SUCCESS (0.023s)
[392.829496] [108/133] (650s left) kms_content_protection (dp-mst-type-1)
[393.327313] Starting subtest: dp-mst-type-1
[393.329549] Subtest dp-mst-type-1: SKIP (0.000s)
[393.453935] [109/133] (650s left) kms_invalid_mode (bad-htotal)
[393.932319] Starting subtest: bad-htotal
[393.935599] Starting dynamic subtest: pipe-A-VGA-1
[394.058029] Dynamic subtest pipe-A-VGA-1: SUCCESS (0.123s)
[394.072700] Starting dynamic subtest: pipe-A-HDMI-A-1
[394.073762] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.001s)
[394.087861] Starting dynamic subtest: pipe-B-VGA-1
[394.088679] Dynamic subtest pipe-B-VGA-1: SUCCESS (0.000s)
[394.102512] Starting dynamic subtest: pipe-B-HDMI-A-1
[394.103184] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.000s)
[394.103824] Subtest bad-htotal: SUCCESS (0.133s)
[394.341932] [110/133] (649s left) gem_userptr_blits (unsync-unmap-after-close)
[394.411762] Subtest unsync-unmap-after-close: SKIP (0.000s)
[394.543894] [111/133] (649s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-mmap-cpu)
[395.023318] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-mmap-cpu
[395.024760] Subtest psr-2p-scndscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[395.141984] [112/133] (648s left) gem_exec_whisper (basic-queues-priority)
[395.212369] Starting subtest: basic-queues-priority
[395.214503] Subtest basic-queues-priority: SKIP (0.001s)
[395.424060] [113/133] (648s left) kms_flip (2x-flip-vs-suspend)
[395.905093] Starting subtest: 2x-flip-vs-suspend
[395.906792] Starting dynamic subtest: AB-VGA1-HDMI-A1
[430.018194] Dynamic subtest AB-VGA1-HDMI-A1: SUCCESS (1.892s)
[430.076264] Subtest 2x-flip-vs-suspend: SUCCESS (2.081s)
[438.335472] [114/133] (613s left) gem_ctx_engines (execute-one)
[438.430852] Starting subtest: execute-one
[438.805897] Subtest execute-one: SUCCESS (0.364s)
[439.015795] [115/133] (612s left) kms_color_pipeline (plane-ctm3x4)
[439.510475] Starting subtest: plane-ctm3x4
[440.180907] Subtest plane-ctm3x4: SKIP (0.645s)
[440.469710] [116/133] (611s left) kms_plane (plane-position-hole-dpms)
[440.965068] Starting subtest: plane-position-hole-dpms
[441.320242] Starting dynamic subtest: pipe-A-plane-1
[441.798572] Dynamic subtest pipe-A-plane-1: SUCCESS (0.464s)
[441.815729] Starting dynamic subtest: pipe-A-plane-2
[441.817586] Dynamic subtest pipe-A-plane-2: SUCCESS (0.004s)
[442.144658] Starting dynamic subtest: pipe-B-plane-1
[442.744537] Dynamic subtest pipe-B-plane-1: SUCCESS (0.600s)
[442.763882] Starting dynamic subtest: pipe-B-plane-2
[442.765333] Dynamic subtest pipe-B-plane-2: SUCCESS (0.010s)
[442.766196] Subtest plane-position-hole-dpms: SUCCESS (1.740s)
[443.019104] [117/133] (609s left) kms_plane_cursor (primary)
[443.511189] Starting subtest: primary
[443.512772] Starting dynamic subtest: pipe-A-VGA-1-size-64
[446.068926] Dynamic subtest pipe-A-VGA-1-size-64: SUCCESS (2.503s)
[446.120357] Starting dynamic subtest: pipe-A-VGA-1-size-128
[448.581278] Dynamic subtest pipe-A-VGA-1-size-128: SUCCESS (2.439s)
[448.631789] Starting dynamic subtest: pipe-A-VGA-1-size-256
[451.081411] Dynamic subtest pipe-A-VGA-1-size-256: SUCCESS (2.438s)
[451.170508] Starting dynamic subtest: pipe-B-HDMI-A-1-size-64
[453.698208] Dynamic subtest pipe-B-HDMI-A-1-size-64: SUCCESS (2.523s)
[453.750391] Starting dynamic subtest: pipe-B-HDMI-A-1-size-128
[456.191092] Dynamic subtest pipe-B-HDMI-A-1-size-128: SUCCESS (2.444s)
[456.241030] Starting dynamic subtest: pipe-B-HDMI-A-1-size-256
[458.679811] Dynamic subtest pipe-B-HDMI-A-1-size-256: SUCCESS (2.444s)
[458.796750] Subtest primary: SUCCESS (15.123s)
[459.057719] [118/133] (593s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-180-async-flip)
[459.549942] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-180-async-flip
[459.551680] Subtest yf-tiled-max-hw-stride-64bpp-rotate-180-async-flip: SKIP (0.000s)
[459.670329] [119/133] (592s left) gen9_exec_parse (unaligned-access)
[459.732997] Subtest unaligned-access: SKIP (0.000s)
[459.807813] [120/133] (592s left) gem_render_copy (y-tiled-mc-ccs-to-y-tiled-ccs)
[459.873733] Starting subtest: y-tiled-mc-ccs-to-y-tiled-ccs
[459.876191] Subtest y-tiled-mc-ccs-to-y-tiled-ccs: SKIP (0.000s)
[460.074724] [121/133] (592s left) kms_cursor_crc (cursor-random-64x64)
[460.562198] Starting subtest: cursor-random-64x64
[460.580151] Starting dynamic subtest: pipe-A-VGA-1
[464.348492] Dynamic subtest pipe-A-VGA-1: SUCCESS (3.758s)
[464.396525] Starting dynamic subtest: pipe-B-HDMI-A-1
[468.072874] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (3.688s)
[468.076395] Subtest cursor-random-64x64: SUCCESS (7.495s)
[468.350043] [122/133] (583s left) dumb_buffer (create-valid-dumb)
[468.420914] Starting subtest: create-valid-dumb
[468.421667] Subtest create-valid-dumb: SUCCESS (0.000s)
[468.528692] [123/133] (583s left) syncobj_timeline (etime-multi-wait-all-submitted-signaled)
[468.590897] Starting subtest: etime-multi-wait-all-submitted-signaled
[468.697362] Subtest etime-multi-wait-all-submitted-signaled: SUCCESS (0.107s)
[468.799160] [124/133] (583s left) kms_big_fb (4-tiled-16bpp-rotate-180)
[469.277758] Starting subtest: 4-tiled-16bpp-rotate-180
[469.279397] Subtest 4-tiled-16bpp-rotate-180: SKIP (0.000s)
[469.396449] [125/133] (583s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-gtt)
[469.883925] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-gtt
[469.885536] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[469.998947] [126/133] (582s left) i915_pm_rc6_residency (rc6-idle)
[470.058998] Starting subtest: rc6-idle
[470.063687] Subtest rc6-idle: SKIP (0.004s)
[470.169914] [127/133] (582s left) kms_pm_rpm (universal-planes-dpms)
[481.936775] Subtest universal-planes-dpms: SKIP (0.000s)
[482.004674] [128/133] (570s left) gem_mmap_offset (bad-object)
[482.068758] Starting subtest: bad-object
[482.069963] Subtest bad-object: SUCCESS (0.002s)
[482.191691] [129/133] (570s left) kms_frontbuffer_tracking (fbc-modesetfrombusy)
[482.670645] Starting subtest: fbc-modesetfrombusy
[483.661165] Subtest fbc-modesetfrombusy: SUCCESS (0.991s)
[483.903773] [130/133] (568s left) kms_properties (invalid-properties-legacy)
[484.385428] Starting subtest: invalid-properties-legacy
[484.397673] Subtest invalid-properties-legacy: SUCCESS (0.013s)
[484.505686] [131/133] (568s left) syncobj_wait (invalid-multi-wait-all-unsubmitted-submitted-signaled)
[484.569635] Starting subtest: invalid-multi-wait-all-unsubmitted-submitted-signaled
[484.570430] Subtest invalid-multi-wait-all-unsubmitted-submitted-signaled: SUCCESS (0.000s)
[484.672628] [132/133] (568s left) gem_softpin (evict-single-offset)
[484.736825] Subtest evict-single-offset: SKIP (0.000s)
[484.842049] [133/133] (568s left) kms_frontbuffer_tracking (psr-2p-primscrn-shrfb-pgflip-blt)
[485.326176] Starting subtest: psr-2p-primscrn-shrfb-pgflip-blt
[485.328526] Subtest psr-2p-primscrn-shrfb-pgflip-blt: SKIP (0.000s)
[485.438835] Closing watchdogs
results: parsing output: 0/ for test: syncobj_timeline
results: parsing output: 1/ for test: kms_frontbuffer_tracking
results: parsing output: 2/ for test: kms_ccs
results: parsing output: 3/ for test: gem_mmap_gtt
results: parsing output: 4/ for test: kms_flip_scaled_crc
results: parsing output: 5/ for test: kms_big_fb
results: parsing output: 6/ for test: syncobj_timeline
results: parsing output: 7/ for test: kms_cursor_legacy
results: parsing output: 8/ for test: gem_softpin
results: parsing output: 9/ for test: gem_mmap_wc
results: parsing output: 10/ for test: gem_flink_basic
results: parsing output: 11/ for test: gem_exec_params
results: parsing output: 12/ for test: gem_mmap_gtt
results: parsing output: 13/ for test: perf_pmu
results: parsing output: 14/ for test: gem_render_copy_redux
results: parsing output: 15/ for test: kms_psr
results: parsing output: 16/ for test: kms_frontbuffer_tracking
results: parsing output: 17/ for test: kms_frontbuffer_tracking
results: parsing output: 18/ for test: gem_ctx_param
results: parsing output: 19/ for test: kms_frontbuffer_tracking
results: parsing output: 20/ for test: kms_cursor_legacy
results: parsing output: 21/ for test: kms_vblank
results: parsing output: 22/ for test: kms_frontbuffer_tracking
results: parsing output: 23/ for test: i915_query
results: parsing output: 24/ for test: kms_chamelium_frames
results: parsing output: 25/ for test: kms_cursor_legacy
results: parsing output: 26/ for test: kms_psr
results: parsing output: 27/ for test: perf
results: parsing output: 28/ for test: kms_feature_discovery
results: parsing output: 29/ for test: syncobj_wait
results: parsing output: 30/ for test: syncobj_timeline
results: parsing output: 31/ for test: gem_exec_reloc
results: parsing output: 32/ for test: core_getversion
results: parsing output: 33/ for test: gem_request_retire
results: parsing output: 34/ for test: kms_frontbuffer_tracking
results: parsing output: 35/ for test: gem_exec_schedule
results: parsing output: 36/ for test: kms_psr
results: parsing output: 37/ for test: kms_frontbuffer_tracking
results: parsing output: 38/ for test: prime_vgem
results: parsing output: 39/ for test: kms_cursor_legacy
results: parsing output: 40/ for test: kms_frontbuffer_tracking
results: parsing output: 41/ for test: prime_vgem
results: parsing output: 42/ for test: gem_ctx_persistence
results: parsing output: 43/ for test: kms_chamelium_hpd
results: parsing output: 44/ for test: kms_frontbuffer_tracking
results: parsing output: 45/ for test: kms_psr
results: parsing output: 46/ for test: kms_cursor_legacy
results: parsing output: 47/ for test: gem_eio
results: parsing output: 48/ for test: kms_cursor_crc
results: parsing output: 49/ for test: gen7_exec_parse
results: parsing output: 50/ for test: kms_flip_scaled_crc
results: parsing output: 51/ for test: kms_pipe_crc_basic
results: parsing output: 52/ for test: kms_rotation_crc
results: parsing output: 53/ for test: gem_ctx_persistence
results: parsing output: 54/ for test: gem_eio
results: parsing output: 55/ for test: gem_mmap_wc
results: parsing output: 56/ for test: kms_flip
results: parsing output: 57/ for test: gem_exec_reloc
results: parsing output: 58/ for test: kms_async_flips
results: parsing output: 59/ for test: gem_exec_flush
results: parsing output: 60/ for test: kms_cursor_edge_walk
results: parsing output: 61/ for test: kms_big_fb
results: parsing output: 62/ for test: kms_frontbuffer_tracking
results: parsing output: 63/ for test: kms_ccs
results: parsing output: 64/ for test: kms_big_fb
results: parsing output: 65/ for test: gem_exec_fence
results: parsing output: 66/ for test: kms_mmap_write_crc
results: parsing output: 67/ for test: kms_big_fb
results: parsing output: 68/ for test: kms_pm_rpm
results: parsing output: 69/ for test: gem_ctx_param
results: parsing output: 70/ for test: api_intel_allocator
results: parsing output: 71/ for test: gem_exec_schedule
results: parsing output: 72/ for test: kms_addfb_basic
results: parsing output: 73/ for test: gem_userptr_blits
results: parsing output: 74/ for test: kms_frontbuffer_tracking
results: parsing output: 75/ for test: kms_ccs
results: parsing output: 76/ for test: kms_flip
results: parsing output: 77/ for test: kms_plane
results: parsing output: 78/ for test: gem_exec_params
results: parsing output: 79/ for test: kms_ccs
results: parsing output: 80/ for test: kms_big_fb
results: parsing output: 81/ for test: kms_frontbuffer_tracking
results: parsing output: 82/ for test: kms_chamelium_audio
results: parsing output: 83/ for test: gem_bad_reloc
results: parsing output: 84/ for test: kms_psr2_sf
results: parsing output: 85/ for test: i915_hangman
results: parsing output: 86/ for test: sysfs_heartbeat_interval
results: parsing output: 87/ for test: kms_universal_plane
results: parsing output: 88/ for test: kms_dp_link_training
results: parsing output: 89/ for test: gem_exec_balancer
results: parsing output: 90/ for test: gem_exec_fence
results: parsing output: 91/ for test: kms_frontbuffer_tracking
results: parsing output: 92/ for test: kms_psr
results: parsing output: 93/ for test: kms_frontbuffer_tracking
results: parsing output: 94/ for test: kms_busy
results: parsing output: 95/ for test: gem_exec_async
results: parsing output: 96/ for test: prime_vgem
results: parsing output: 97/ for test: kms_properties
results: parsing output: 98/ for test: gem_mmap_wc
results: parsing output: 99/ for test: kms_frontbuffer_tracking
results: parsing output: 100/ for test: kms_psr
results: parsing output: 101/ for test: syncobj_timeline
results: parsing output: 102/ for test: perf_pmu
results: parsing output: 103/ for test: kms_plane_scaling
results: parsing output: 104/ for test: gem_exec_whisper
results: parsing output: 105/ for test: gem_pxp
results: parsing output: 106/ for test: gem_exec_reloc
results: parsing output: 107/ for test: kms_content_protection
results: parsing output: 108/ for test: kms_invalid_mode
results: parsing output: 109/ for test: gem_userptr_blits
results: parsing output: 110/ for test: kms_frontbuffer_tracking
results: parsing output: 111/ for test: gem_exec_whisper
results: parsing output: 112/ for test: kms_flip
results: parsing output: 113/ for test: gem_ctx_engines
results: parsing output: 114/ for test: kms_color_pipeline
results: parsing output: 115/ for test: kms_plane
results: parsing output: 116/ for test: kms_plane_cursor
results: parsing output: 117/ for test: kms_big_fb
results: parsing output: 118/ for test: gen9_exec_parse
results: parsing output: 119/ for test: gem_render_copy
results: parsing output: 120/ for test: kms_cursor_crc
results: parsing output: 121/ for test: dumb_buffer
results: parsing output: 122/ for test: syncobj_timeline
results: parsing output: 123/ for test: kms_big_fb
results: parsing output: 124/ for test: kms_frontbuffer_tracking
results: parsing output: 125/ for test: i915_pm_rc6_residency
results: parsing output: 126/ for test: kms_pm_rpm
results: parsing output: 127/ for test: gem_mmap_offset
results: parsing output: 128/ for test: kms_frontbuffer_tracking
results: parsing output: 129/ for test: kms_properties
results: parsing output: 130/ for test: syncobj_wait
results: parsing output: 131/ for test: gem_softpin
results: parsing output: 132/ for test: kms_frontbuffer_tracking
Done.