[71.353094] Initializing watchdogs
[71.353218]   /dev/watchdog0
[71.375401] [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)
[71.383374] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[71.387087] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[71.390311] [001/131] (960s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-mmap-wc)
[71.703877] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-mmap-wc
[71.705927] Subtest psr-2p-scndscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[72.112317] [002/131] (959s left) kms_ccs (random-ccs-data-4-tiled-dg2-mc-ccs)
[72.165183] Subtest random-ccs-data-4-tiled-dg2-mc-ccs: SKIP (0.000s)
[72.223891] [003/131] (959s left) kms_frontbuffer_tracking (fbcpsr-indfb-scaledprimary)
[72.530722] Starting subtest: fbcpsr-indfb-scaledprimary
[72.533143] Subtest fbcpsr-indfb-scaledprimary: SKIP (0.000s)
[72.925361] [004/131] (959s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip)
[73.234392] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip
[73.238198] Subtest 4-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip: SKIP (0.000s)
[73.640763] [005/131] (958s left) gen9_exec_parse (valid-registers)
[73.706430] Subtest valid-registers: SKIP (0.000s)
[73.756421] [006/131] (958s left) core_auth (basic-auth)
[73.813498] Starting subtest: basic-auth
[73.814564] Subtest basic-auth: SUCCESS (0.001s)
[73.944759] [007/131] (958s left) dmabuf_sync_file (export-before-signal)
[74.048863] Starting subtest: export-before-signal
[74.051103] Subtest export-before-signal: SUCCESS (0.003s)
[74.157850] [FACT dmabuf_sync_file (export-before-signal)] new: kernel.kmod_is_loaded.vgem: true
[74.160542] [008/131] (958s left) kms_invalid_mode (int-max-clock)
[74.456247] Starting subtest: int-max-clock
[74.457342] Starting dynamic subtest: pipe-A-HDMI-A-1
[74.532390] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.075s)
[74.542480] Starting dynamic subtest: pipe-B-HDMI-A-1
[74.543544] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.000s)
[74.544665] Subtest int-max-clock: SUCCESS (0.078s)
[74.909499] [009/131] (957s left) gem_lmem_swapping (heavy-random)
[74.972212] Subtest heavy-random: SKIP (0.000s)
[75.036090] [010/131] (957s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-mmap-gtt)
[75.337545] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-mmap-gtt
[75.339736] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[75.756486] [011/131] (956s left) i915_pm_rpm (gem-pread)
[87.319807] Subtest gem-pread: SKIP (0.000s)
[87.513686] [012/131] (944s left) kms_big_fb (linear-8bpp-rotate-0)
[87.826438] Starting subtest: linear-8bpp-rotate-0
[89.086621] Subtest linear-8bpp-rotate-0: SUCCESS (1.260s)
[89.533215] [013/131] (942s left) kms_feature_discovery (display-1x)
[89.827510] Starting subtest: display-1x
[89.828485] Subtest display-1x: SUCCESS (0.000s)
[90.256577] [014/131] (942s left) kms_getfb (getfb-handle-valid)
[90.551357] Starting subtest: getfb-handle-valid
[90.552467] Subtest getfb-handle-valid: SUCCESS (0.000s)
[90.981051] [015/131] (941s left) gem_exec_reloc (basic-gtt-cpu-active)
[91.039843] Starting subtest: basic-gtt-cpu-active
[91.151770] Subtest basic-gtt-cpu-active: SUCCESS (0.111s)
[91.798602] [016/131] (940s left) gem_mmap_wc (coherency)
[91.856976] Starting subtest: coherency
[91.923582] Subtest coherency: SUCCESS (0.066s)
[92.061904] [017/131] (940s left) kms_async_flips (test-cursor)
[92.359728] Starting subtest: test-cursor
[92.498378] Starting dynamic subtest: pipe-A-HDMI-A-1
[92.643732] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.146s)
[92.804148] Starting dynamic subtest: pipe-B-HDMI-A-1
[92.894424] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.105s)
[92.895814] Subtest test-cursor: SUCCESS (0.536s)
[93.556106] [018/131] (939s left) kms_content_protection (uevent-hdcp14)
[93.873577] Starting subtest: uevent-hdcp14
[93.875922] Subtest uevent-hdcp14: SKIP (0.000s)
[94.288609] [019/131] (938s left) gem_ctx_param (invalid-get-engines)
[94.347019] Starting subtest: invalid-get-engines
[94.348127] Subtest invalid-get-engines: SUCCESS (0.000s)
[94.471372] [020/131] (938s left) perf (global-sseu-config)
[94.616105] Subtest global-sseu-config: SKIP (0.000s)
[94.668698] [021/131] (938s left) kms_plane_scaling (plane-upscale-factor-0-25-with-modifiers)
[94.966263] Starting subtest: plane-upscale-factor-0-25-with-modifiers
[94.967296] Starting dynamic subtest: pipe-A
[94.970546] Dynamic subtest pipe-A: SKIP (0.001s)
[94.982703] Starting dynamic subtest: pipe-B
[94.986049] Dynamic subtest pipe-B: SKIP (0.001s)
[94.988319] Subtest plane-upscale-factor-0-25-with-modifiers: SKIP (0.003s)
[95.369758] [022/131] (937s left) gem_create (create-valid-nonaligned)
[95.427284] Starting subtest: create-valid-nonaligned
[95.428325] Subtest create-valid-nonaligned: SUCCESS (0.000s)
[95.672751] [023/131] (937s left) kms_cursor_legacy (cursora-vs-flipa-atomic-transitions)
[95.961481] Starting subtest: cursorA-vs-flipA-atomic-transitions
[106.884366] Subtest cursorA-vs-flipA-atomic-transitions: SUCCESS (10.922s)
[107.408961] [024/131] (925s left) kms_pm_rpm (modeset-lpsp)
[118.907820] Subtest modeset-lpsp: SKIP (0.000s)
[119.095205] [025/131] (914s left) kms_color (degamma)
[119.384231] Starting subtest: degamma
[119.385349] Starting dynamic subtest: pipe-A-HDMI-A-1
[119.387345] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.001s)
[119.398324] Starting dynamic subtest: pipe-B-HDMI-A-1
[119.400489] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.001s)
[119.402544] Subtest degamma: SKIP (0.003s)
[119.811788] [026/131] (913s left) kms_flip (modeset-vs-vblank-race-interruptible)
[120.113842] Starting subtest: modeset-vs-vblank-race-interruptible
[120.114905] Starting dynamic subtest: A-VGA1
[123.154266] Dynamic subtest A-VGA1: SUCCESS (3.039s)
[123.165297] Starting dynamic subtest: B-VGA1
[126.163356] Dynamic subtest B-VGA1: SUCCESS (3.007s)
[126.176645] Starting dynamic subtest: A-HDMI-A1
[129.274111] Dynamic subtest A-HDMI-A1: SUCCESS (3.108s)
[129.285228] Starting dynamic subtest: B-HDMI-A1
[132.405366] Dynamic subtest B-HDMI-A1: SUCCESS (3.128s)
[132.408336] Subtest modeset-vs-vblank-race-interruptible: SUCCESS (12.292s)
[132.973402] [027/131] (900s left) gem_ctx_exec (basic-close-race)
[133.045210] Starting subtest: basic-close-race
[138.699516] Subtest basic-close-race: SUCCESS (5.650s)
[138.845147] [028/131] (894s left) kms_atomic_transition (plane-primary-toggle-with-vblank-wait)
[139.138103] Starting subtest: plane-primary-toggle-with-vblank-wait
[139.139206] Starting dynamic subtest: pipe-A-HDMI-A-1
[139.363062] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.224s)
[139.459618] Starting dynamic subtest: pipe-B-HDMI-A-1
[139.797829] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.351s)
[139.881650] Subtest plane-primary-toggle-with-vblank-wait: SUCCESS (0.743s)
[140.400641] [029/131] (892s left) kms_chamelium_color (ctm-green-to-red)
[140.695310] Subtest ctm-green-to-red: SKIP (0.000s)
[140.891902] [030/131] (892s left) kms_chamelium_hpd (vga-hpd-fast)
[141.265064] Subtest vga-hpd-fast: SKIP (0.000s)
[141.568291] [031/131] (891s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-blt)
[141.864246] Starting subtest: psr-1p-primscrn-cur-indfb-draw-blt
[141.866327] Subtest psr-1p-primscrn-cur-indfb-draw-blt: SKIP (0.000s)
[142.273762] [032/131] (891s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-mmap-gtt)
[142.575297] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-mmap-gtt
[142.577468] Subtest psr-2p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[143.007378] [033/131] (890s left) gem_render_copy (yf-tiled-ccs-to-y-tiled)
[143.073446] Starting subtest: yf-tiled-ccs-to-y-tiled
[143.074569] Starting dynamic subtest: smem
[143.076765] Dynamic subtest smem: SKIP (0.000s)
[143.079050] Subtest yf-tiled-ccs-to-y-tiled: SKIP (0.001s)
[143.303459] [034/131] (890s left) kms_getfb (getfb-reject-nv12)
[143.605346] Starting subtest: getfb-reject-nv12
[143.607466] Subtest getfb-reject-nv12: SKIP (0.000s)
[144.017241] [035/131] (889s left) kms_cursor_crc (cursor-offscreen-max-size)
[144.334542] Starting subtest: cursor-offscreen-max-size
[144.337716] Subtest cursor-offscreen-max-size: SKIP (0.000s)
[144.749048] [036/131] (888s left) fbdev (info)
[144.803347] Starting subtest: info
[144.804500] Subtest info: SUCCESS (0.000s)
[144.938177] [037/131] (888s left) gem_userptr_blits (probe)
[145.020519] Starting subtest: probe
[145.205947] Subtest probe: SUCCESS (0.185s)
[145.351939] [038/131] (888s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-180-hflip)
[145.665378] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-180-hflip
[145.668303] Subtest yf-tiled-max-hw-stride-32bpp-rotate-180-hflip: SKIP (0.000s)
[146.081324] [039/131] (887s left) api_intel_bb (reset-flags)
[146.136596] Starting subtest: reset-flags
[146.142099] Subtest reset-flags: SUCCESS (0.006s)
[146.296496] [040/131] (887s left) kms_dither (fb-8bpc-vs-panel-6bpc)
[146.589237] Starting subtest: fb-8bpc-vs-panel-6bpc
[146.590398] Starting dynamic subtest: pipe-A-HDMI-A-1
[146.667603] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.075s)
[146.669909] Subtest fb-8bpc-vs-panel-6bpc: SKIP (0.078s)
[147.179765] [041/131] (886s left) kms_flip (2x-flip-vs-modeset-vs-hang)
[147.477745] Starting subtest: 2x-flip-vs-modeset-vs-hang
[147.478853] Starting dynamic subtest: AB-VGA1-HDMI-A1
[162.872844] Dynamic subtest AB-VGA1-HDMI-A1: SUCCESS (15.395s)
[162.873941] Subtest 2x-flip-vs-modeset-vs-hang: SUCCESS (15.399s)
[163.412714] [042/131] (870s left) perf (gen8-unprivileged-single-ctx-counters)
[163.552238] Subtest gen8-unprivileged-single-ctx-counters: SKIP (0.000s)
[163.607265] [043/131] (870s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-blt)
[163.910978] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-blt
[163.913202] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[164.337833] [044/131] (869s left) kms_plane_scaling (plane-downscale-factor-0-5-with-rotation)
[164.631299] Starting subtest: plane-downscale-factor-0-5-with-rotation
[164.632308] Starting dynamic subtest: pipe-A
[164.635459] Dynamic subtest pipe-A: SKIP (0.001s)
[164.645525] Starting dynamic subtest: pipe-B
[164.648727] Dynamic subtest pipe-B: SKIP (0.001s)
[164.650877] Subtest plane-downscale-factor-0-5-with-rotation: SKIP (0.005s)
[165.042333] [045/131] (869s left) syncobj_timeline (etime-multi-wait-all-available-unsubmitted-signaled)
[165.100921] Starting subtest: etime-multi-wait-all-available-unsubmitted-signaled
[165.210120] Subtest etime-multi-wait-all-available-unsubmitted-signaled: SUCCESS (0.108s)
[165.355255] [046/131] (868s left) syncobj_wait (multi-wait-all-signaled)
[165.412529] Starting subtest: multi-wait-all-signaled
[165.413639] Subtest multi-wait-all-signaled: SUCCESS (0.001s)
[165.588262] [047/131] (868s left) kms_psr2_sf (psr2-overlay-primary-update-sf-dmg-area)
[165.885594] Subtest psr2-overlay-primary-update-sf-dmg-area: SKIP (0.000s)
[166.087819] [048/131] (868s left) kms_ccs (crc-primary-basic-y-tiled-ccs)
[166.144075] Subtest crc-primary-basic-y-tiled-ccs: SKIP (0.000s)
[166.201402] [049/131] (868s left) gem_mmap_offset (partial-unmap)
[166.259791] Starting subtest: partial-unmap
[166.260980] Starting dynamic subtest: smem0
[166.271479] Dynamic subtest smem0: SUCCESS (0.011s)
[166.272571] Subtest partial-unmap: SUCCESS (0.013s)
[166.442395] [050/131] (868s left) kms_frontbuffer_tracking (psr-shrfb-scaledprimary)
[166.737086] Starting subtest: psr-shrfb-scaledprimary
[166.739230] Subtest psr-shrfb-scaledprimary: SKIP (0.000s)
[167.139037] [051/131] (867s left) kms_cursor_edge_walk (256x256-top-edge)
[167.430417] Starting subtest: 256x256-top-edge
[167.431402] Starting dynamic subtest: pipe-A-HDMI-A-1
[170.861894] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (3.430s)
[170.871916] Starting dynamic subtest: pipe-B-HDMI-A-1
[174.193286] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (3.328s)
[174.194336] Subtest 256x256-top-edge: SUCCESS (6.762s)
[174.700415] [052/131] (859s left) syncobj_wait (multi-wait-all-for-submit-unsubmitted-submitted)
[174.758913] Starting subtest: multi-wait-all-for-submit-unsubmitted-submitted
[174.866046] Subtest multi-wait-all-for-submit-unsubmitted-submitted: SUCCESS (0.108s)
[174.994802] [053/131] (859s left) kms_flip_scaled_crc (flip-32bpp-xtile-to-64bpp-xtile-downscaling)
[175.052098] Subtest flip-32bpp-xtile-to-64bpp-xtile-downscaling: SKIP (0.000s)
[175.113410] [054/131] (859s left) gem_madvise (dontneed-before-pwrite)
[175.167133] Starting subtest: dontneed-before-pwrite
[175.169305] Subtest dontneed-before-pwrite: SUCCESS (0.003s)
[175.316774] [055/131] (859s left) gem_flink_race (flink_name)
[175.370018] Starting subtest: flink_name
[180.743549] Subtest flink_name: SUCCESS (5.373s)
[180.883347] [056/131] (853s left) gem_exec_fence (syncobj-invalid-wait)
[181.087517] Starting subtest: syncobj-invalid-wait
[181.088632] Subtest syncobj-invalid-wait: SUCCESS (0.001s)
[181.480114] [057/131] (853s left) kms_plane_cursor (primary)
[181.773726] Starting subtest: primary
[181.775873] Starting dynamic subtest: pipe-A-HDMI-A-1-size-64
[184.194396] Dynamic subtest pipe-A-HDMI-A-1-size-64: SUCCESS (2.419s)
[184.239918] Starting dynamic subtest: pipe-A-HDMI-A-1-size-128
[186.655987] Dynamic subtest pipe-A-HDMI-A-1-size-128: SUCCESS (2.427s)
[186.700052] Starting dynamic subtest: pipe-A-HDMI-A-1-size-256
[189.117718] Dynamic subtest pipe-A-HDMI-A-1-size-256: SUCCESS (2.427s)
[189.244319] Starting dynamic subtest: pipe-B-HDMI-A-1-size-64
[191.742631] Dynamic subtest pipe-B-HDMI-A-1-size-64: SUCCESS (2.507s)
[191.790092] Starting dynamic subtest: pipe-B-HDMI-A-1-size-128
[194.204430] Dynamic subtest pipe-B-HDMI-A-1-size-128: SUCCESS (2.427s)
[194.248201] Starting dynamic subtest: pipe-B-HDMI-A-1-size-256
[196.665989] Dynamic subtest pipe-B-HDMI-A-1-size-256: SUCCESS (2.427s)
[196.782384] Subtest primary: SUCCESS (15.009s)
[197.312074] [058/131] (837s left) syncobj_timeline (wait-any-snapshot)
[197.370396] Starting subtest: wait-any-snapshot
[197.453310] Subtest wait-any-snapshot: SUCCESS (0.082s)
[197.575491] [059/131] (837s left) kms_psr2_sf (fbc-pr-cursor-plane-update-sf)
[197.875105] Subtest fbc-pr-cursor-plane-update-sf: SKIP (0.000s)
[198.067389] [060/131] (836s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-180)
[198.371535] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-180
[198.373936] Subtest y-tiled-max-hw-stride-32bpp-rotate-180: SKIP (0.000s)
[198.772126] [061/131] (836s left) kms_cursor_legacy (cursor-vs-flip-atomic-transitions-varying-size)
[199.061281] Starting subtest: cursor-vs-flip-atomic-transitions-varying-size
[233.668694] Subtest cursor-vs-flip-atomic-transitions-varying-size: SUCCESS (34.608s)
[234.182757] [062/131] (800s left) kms_ccs (bad-rotation-90-4-tiled-dg2-rc-ccs)
[234.241070] Subtest bad-rotation-90-4-tiled-dg2-rc-ccs: SKIP (0.000s)
[234.296318] [063/131] (800s left) gem_mmap_wc (close)
[234.352092] Starting subtest: close
[234.385083] Subtest close: SUCCESS (0.035s)
[234.532685] [064/131] (800s left) kms_frontbuffer_tracking (fbc-2p-shrfb-fliptrack-mmap-gtt)
[234.824444] Starting subtest: fbc-2p-shrfb-fliptrack-mmap-gtt
[234.826608] Subtest fbc-2p-shrfb-fliptrack-mmap-gtt: SKIP (0.000s)
[235.230627] [065/131] (800s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-cpu)
[235.532670] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-cpu
[235.534845] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[235.947245] [066/131] (799s left) gem_mmap_wc (read-write-distinct)
[236.001365] Starting subtest: read-write-distinct
[236.015808] Subtest read-write-distinct: SUCCESS (0.015s)
[236.159851] [067/131] (799s left) gem_ctx_shared (q-promotion)
[236.219285] Subtest Q-promotion: SKIP (0.000s)
[236.343828] [068/131] (799s left) api_intel_allocator (reserve-simple)
[236.403267] Starting subtest: reserve-simple
[236.408943] Subtest reserve-simple: SUCCESS (0.006s)
[236.562302] [069/131] (798s left) kms_psr (fbc-pr-sprite-render)
[236.849193] Subtest fbc-pr-sprite-render: SKIP (0.000s)
[237.055557] [070/131] (798s left) syncobj_timeline (invalid-multi-wait-unsubmitted-signaled)
[237.112239] Starting subtest: invalid-multi-wait-unsubmitted-signaled
[237.113313] Subtest invalid-multi-wait-unsubmitted-signaled: SUCCESS (0.001s)
[237.241790] [071/131] (798s left) prime_vgem (basic-blt)
[237.315854] Starting subtest: basic-blt
[237.338271] Subtest basic-blt: SUCCESS (0.022s)
[237.492439] [072/131] (798s left) sw_sync (alloc_merge_fence)
[237.545699] Starting subtest: alloc_merge_fence
[237.546785] Subtest alloc_merge_fence: SUCCESS (0.000s)
[237.663913] [073/131] (798s left) kms_cursor_crc (cursor-rapid-movement-32x10)
[237.962286] Starting subtest: cursor-rapid-movement-32x10
[238.044417] Subtest cursor-rapid-movement-32x10: SKIP (0.080s)
[238.457622] [074/131] (797s left) kms_psr (psr2-primary-blt)
[238.758305] Subtest psr2-primary-blt: SKIP (0.000s)
[238.952133] [075/131] (796s left) gem_exec_schedule (implicit-boths)
[239.019756] Starting subtest: implicit-boths
[239.020914] Starting dynamic subtest: rcs0
[239.053332] Dynamic subtest rcs0: SUCCESS (0.033s)
[239.068025] Starting dynamic subtest: bcs0
[239.086654] Dynamic subtest bcs0: SUCCESS (0.031s)
[239.087815] Subtest implicit-boths: SUCCESS (0.068s)
[239.355498] [076/131] (796s left) i915_selftest (mock)
[240.269502] Starting subtest: mock
[240.270727] Starting dynamic subtest: sanitycheck
[241.431482] Dynamic subtest sanitycheck: SUCCESS (1.161s)
[241.444356] Starting dynamic subtest: shmem
[242.568817] Dynamic subtest shmem: SUCCESS (1.135s)
[242.583559] Starting dynamic subtest: fence
[251.001308] Dynamic subtest fence: SUCCESS (8.431s)
[251.013683] Starting dynamic subtest: scatterlist
[253.178147] Dynamic subtest scatterlist: SUCCESS (2.175s)
[253.190838] Starting dynamic subtest: syncmap
[256.352330] Dynamic subtest syncmap: SUCCESS (3.172s)
[256.365279] Starting dynamic subtest: uncore
[257.498449] Dynamic subtest uncore: SUCCESS (1.144s)
[257.515504] Starting dynamic subtest: ring
[258.672416] Dynamic subtest ring: SUCCESS (1.172s)
[258.686562] Starting dynamic subtest: engine
[259.777295] Dynamic subtest engine: SUCCESS (1.103s)
[259.789869] Starting dynamic subtest: timelines
[266.001738] Dynamic subtest timelines: SUCCESS (6.222s)
[266.016489] Starting dynamic subtest: requests
[269.292310] Dynamic subtest requests: SUCCESS (3.289s)
[269.304897] Starting dynamic subtest: objects
[270.565620] Dynamic subtest objects: SUCCESS (1.271s)
[270.575954] Starting dynamic subtest: phys
[271.843302] Dynamic subtest phys: SUCCESS (1.276s)
[271.855818] Starting dynamic subtest: dmabuf
[273.066323] Dynamic subtest dmabuf: SUCCESS (1.221s)
[273.083544] Starting dynamic subtest: vma
[284.692459] Dynamic subtest vma: SUCCESS (11.624s)
[284.704930] Starting dynamic subtest: evict
[287.280382] Dynamic subtest evict: SUCCESS (2.586s)
[287.292864] Starting dynamic subtest: gtt
[291.602316] Dynamic subtest gtt: SUCCESS (4.320s)
[291.614490] Starting dynamic subtest: hugepages
[293.112387] Dynamic subtest hugepages: SUCCESS (1.508s)
[293.125079] Starting dynamic subtest: memory_region
[298.278066] Dynamic subtest memory_region: SUCCESS (5.164s)
[298.279219] Subtest mock: SUCCESS (58.009s)
[298.317486] [FACT i915_selftest (mock)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[298.318746] [FACT i915_selftest (mock)] deleted: kernel.kmod_is_loaded.i915: true
[298.321548] [077/131] (737s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-mmap-wc)
[300.395388] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-mmap-wc
[300.397627] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[300.872738] [FACT kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-mmap-wc)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[300.874440] [FACT kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-mmap-wc)] new: kernel.kmod_is_loaded.i915: true
[300.879426] [078/131] (735s left) gem_pxp (create-protected-buffer)
[303.451987] Starting subtest: create-protected-buffer
[303.454497] Subtest create-protected-buffer: SKIP (0.000s)
[303.571538] [079/131] (732s left) gem_softpin (evict-active)
[303.633169] Starting subtest: evict-active
[303.639778] Subtest evict-active: SUCCESS (0.008s)
[303.811464] [080/131] (732s left) i915_query (query-topology-matches-eu-total)
[303.866742] Starting subtest: query-topology-matches-eu-total
[303.869017] Subtest query-topology-matches-eu-total: SKIP (0.000s)
[303.991602] [081/131] (732s left) kms_chamelium_edid (vga-edid-read)
[304.375707] Subtest vga-edid-read: SKIP (0.000s)
[304.668639] [082/131] (731s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-render)
[304.964173] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-render
[304.966441] Subtest psr-2p-scndscrn-pri-shrfb-draw-render: SKIP (0.000s)
[305.372074] [083/131] (730s left) i915_hangman (hangcheck-unterminated)
[305.435370] Starting subtest: hangcheck-unterminated
[305.437459] Subtest hangcheck-unterminated: SKIP (0.000s)
[305.530794] [084/131] (730s left) kms_addfb_basic (addfb25-framebuffer-vs-set-tiling)
[305.824155] Starting subtest: addfb25-framebuffer-vs-set-tiling
[305.825251] Subtest addfb25-framebuffer-vs-set-tiling: SUCCESS (0.000s)
[306.238626] [085/131] (730s left) gen9_exec_parse (cmd-crossing-page)
[306.297886] Subtest cmd-crossing-page: SKIP (0.000s)
[306.363418] [086/131] (729s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-render)
[306.668271] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-render
[306.670453] Subtest fbc-2p-scndscrn-pri-shrfb-draw-render: SKIP (0.000s)
[307.085792] [087/131] (729s left) kms_lease (lease-again)
[307.375912] Starting subtest: lease-again
[307.377047] Starting dynamic subtest: pipe-A-HDMI-A-1
[307.379872] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.002s)
[307.390510] Starting dynamic subtest: pipe-B-HDMI-A-1
[307.391545] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.001s)
[307.392644] Subtest lease-again: SUCCESS (0.008s)
[307.798349] [088/131] (728s left) kms_flip (2x-wf_vblank-ts-check)
[308.094821] Starting subtest: 2x-wf_vblank-ts-check
[308.097541] Starting dynamic subtest: AB-VGA1-HDMI-A1
[338.826559] Dynamic subtest AB-VGA1-HDMI-A1: SUCCESS (30.729s)
[338.829738] Subtest 2x-wf_vblank-ts-check: SUCCESS (30.734s)
[339.433037] [089/131] (697s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-render)
[339.735260] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-render
[339.737888] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-render: SKIP (0.000s)
[340.144665] [090/131] (696s left) gen3_mixed_blits
[340.256351] [091/131] (696s left) perf (invalid-oa-metric-set-id)
[340.401350] Subtest invalid-oa-metric-set-id: SKIP (0.000s)
[340.457295] [092/131] (696s left) gem_exec_schedule (fifo)
[340.525057] Starting subtest: fifo
[340.526139] Starting dynamic subtest: rcs0
[340.557777] Dynamic subtest rcs0: SUCCESS (0.032s)
[340.571564] Starting dynamic subtest: bcs0
[340.590108] Dynamic subtest bcs0: SUCCESS (0.030s)
[340.593555] Subtest fifo: SUCCESS (0.066s)
[340.879539] [093/131] (695s left) kms_busy (extended-pageflip-hang-oldfb)
[341.184467] Starting subtest: extended-pageflip-hang-oldfb
[341.185569] Starting dynamic subtest: pipe-A
[341.359426] Dynamic subtest pipe-A: SUCCESS (0.172s)
[341.369975] Starting dynamic subtest: pipe-B
[341.612191] Dynamic subtest pipe-B: SUCCESS (0.252s)
[341.615022] Subtest extended-pageflip-hang-oldfb: SUCCESS (0.430s)
[342.139812] [094/131] (694s left) perf (gen12-mi-rpc)
[342.274406] Subtest gen12-mi-rpc: SKIP (0.000s)
[342.331304] [095/131] (694s left) kms_async_flips (async-flip-with-page-flip-events-tiled-atomic)
[342.620400] Starting subtest: async-flip-with-page-flip-events-tiled-atomic
[342.768940] Starting dynamic subtest: pipe-A-HDMI-A-1-x
[344.912963] Dynamic subtest pipe-A-HDMI-A-1-x: SUCCESS (2.143s)
[345.067247] Starting dynamic subtest: pipe-B-HDMI-A-1-x
[347.160516] Dynamic subtest pipe-B-HDMI-A-1-x: SUCCESS (2.101s)
[347.161882] Subtest async-flip-with-page-flip-events-tiled-atomic: SUCCESS (4.542s)
[347.825307] [096/131] (689s left) kms_psr (fbc-psr-cursor-render)
[348.117996] Subtest fbc-psr-cursor-render: SKIP (0.000s)
[348.313257] [097/131] (688s left) syncobj_basic (bad-pad-fd-to-handle)
[348.369978] Starting subtest: bad-pad-fd-to-handle
[348.371025] Subtest bad-pad-fd-to-handle: SUCCESS (0.000s)
[348.504598] [098/131] (688s left) gem_eio (in-flight-contexts-1us)
[348.569791] Starting subtest: in-flight-contexts-1us
[351.906546] Subtest in-flight-contexts-1us: SUCCESS (3.336s)
[352.564495] [099/131] (684s left) kms_psr (psr-primary-render)
[352.856170] Subtest psr-primary-render: SKIP (0.000s)
[353.055385] [100/131] (684s left) gem_exec_schedule (wide)
[353.121661] Subtest wide: SKIP (0.000s)
[353.366145] [101/131] (683s left) gem_spin_batch (resubmit-new)
[353.428482] Starting subtest: resubmit-new
[353.429509] Starting dynamic subtest: rcs0
[353.431997] Dynamic subtest rcs0: SUCCESS (0.002s)
[353.442957] Starting dynamic subtest: bcs0
[353.443982] Dynamic subtest bcs0: SUCCESS (0.001s)
[353.454280] Starting dynamic subtest: vcs0
[353.455286] Dynamic subtest vcs0: SUCCESS (0.001s)
[353.456283] Subtest resubmit-new: SUCCESS (0.009s)
[353.683819] [102/131] (683s left) kms_frontbuffer_tracking (fbc-indfb-scaledprimary)
[353.979366] Starting subtest: fbc-indfb-scaledprimary
[353.981625] Subtest fbc-indfb-scaledprimary: SKIP (0.000s)
[354.392963] [103/131] (682s left) kms_cursor_legacy (short-flip-after-cursor-atomic-transitions)
[354.689891] Starting subtest: short-flip-after-cursor-atomic-transitions
[355.705258] Subtest short-flip-after-cursor-atomic-transitions: SUCCESS (1.014s)
[356.252148] [104/131] (681s left) kms_vblank (ts-continuation-idle)
[356.547733] Starting subtest: ts-continuation-idle
[356.549051] Starting dynamic subtest: pipe-A-HDMI-A-1
[356.747368] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.199s)
[356.760860] Starting dynamic subtest: pipe-B-HDMI-A-1
[356.974869] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.225s)
[356.975968] Subtest ts-continuation-idle: SUCCESS (0.429s)
[357.491326] [105/131] (679s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-mmap-gtt)
[357.788418] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-mmap-gtt
[357.790781] Subtest fbc-2p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[358.191464] [106/131] (679s left) gem_exec_balancer (parallel-bb-first)
[358.253367] Subtest parallel-bb-first: SKIP (0.000s)
[358.372766] [107/131] (679s left) kms_ccs (crc-primary-suspend-4-tiled-dg2-rc-ccs-cc)
[358.431036] Subtest crc-primary-suspend-4-tiled-dg2-rc-ccs-cc: SKIP (0.000s)
[358.500826] [108/131] (678s left) gem_exec_schedule (semaphore-noskip)
[358.568213] Subtest semaphore-noskip: SKIP (0.000s)
[358.808668] [109/131] (678s left) gem_pipe_control_store_loop (fresh-buffer)
[358.872053] Starting subtest: fresh-buffer
[361.022285] Subtest fresh-buffer: SUCCESS (2.149s)
[361.189169] [110/131] (676s left) kms_plane_multiple (2x-tiling-none)
[361.479749] Starting subtest: 2x-tiling-none
[361.482028] Subtest 2x-tiling-none: SKIP (0.000s)
[361.910723] [111/131] (675s left) syncobj_wait (invalid-signal-zero-handles)
[361.969493] Starting subtest: invalid-signal-zero-handles
[361.970581] Subtest invalid-signal-zero-handles: SUCCESS (0.000s)
[362.100353] [112/131] (675s left) kms_flip_scaled_crc (flip-64bpp-xtile-to-16bpp-xtile-downscaling)
[362.153745] Subtest flip-64bpp-xtile-to-16bpp-xtile-downscaling: SKIP (0.000s)
[362.209943] [113/131] (675s left) gem_ctx_persistence (heartbeat-many)
[362.265868] Subtest heartbeat-many: SKIP (0.000s)
[362.326024] [114/131] (675s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-mmap-cpu)
[362.626871] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-mmap-cpu
[362.629061] Subtest fbc-2p-scndscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[363.031918] [115/131] (674s left) gem_exec_flush (basic-batch-kernel-default-wb)
[363.098924] Starting subtest: basic-batch-kernel-default-wb
[368.680981] Subtest basic-batch-kernel-default-wb: SUCCESS (5.582s)
[368.916713] [116/131] (669s left) gem_exec_balancer (individual)
[368.978969] Subtest individual: SKIP (0.000s)
[369.103325] [117/131] (668s left) kms_psr2_sf (pr-cursor-plane-move-continuous-exceed-fully-sf)
[369.403984] Subtest pr-cursor-plane-move-continuous-exceed-fully-sf: SKIP (0.000s)
[369.593665] [118/131] (668s left) kms_rotation_crc (primary-4-tiled-reflect-x-0)
[369.886949] Starting subtest: primary-4-tiled-reflect-x-0
[369.889202] Subtest primary-4-tiled-reflect-x-0: SKIP (0.001s)
[370.297156] [119/131] (667s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-180-hflip)
[370.598863] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-180-hflip
[370.617041] Subtest x-tiled-max-hw-stride-64bpp-rotate-180-hflip: SKIP (0.017s)
[371.030770] [120/131] (667s left) gem_exec_await (wide-contexts)
[371.122211] Starting subtest: wide-contexts
[393.144903] Subtest wide-contexts: SUCCESS (22.022s)
[393.405036] [121/131] (644s left) gem_exec_nop (basic-series)
[393.585935] Starting subtest: basic-series
[396.362042] Subtest basic-series: SUCCESS (2.773s)
[396.631391] [122/131] (641s left) kms_addfb_basic (unused-modifier)
[396.689854] Starting subtest: unused-modifier
[396.692826] Subtest unused-modifier: SUCCESS (0.000s)
[397.345654] [123/131] (640s left) syncobj_timeline (multi-wait-available-signaled)
[397.411058] Starting subtest: multi-wait-available-signaled
[397.412187] Subtest multi-wait-available-signaled: SUCCESS (0.001s)
[397.549610] [124/131] (640s left) prime_vgem (busy)
[397.618861] Starting subtest: busy
[397.620020] Starting dynamic subtest: rcs0
[397.648743] Dynamic subtest rcs0: SUCCESS (0.031s)
[397.671154] Starting dynamic subtest: bcs0
[397.672363] Dynamic subtest bcs0: SUCCESS (0.018s)
[397.674956] Subtest busy: SUCCESS (0.054s)
[397.845475] [125/131] (640s left) gem_exec_params (dr4-dirt)
[397.905297] Starting subtest: DR4-dirt
[397.906404] Subtest DR4-dirt: SUCCESS (0.000s)
[398.044229] [126/131] (640s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-render)
[398.345987] Starting subtest: psr-1p-primscrn-spr-indfb-draw-render
[398.349510] Subtest psr-1p-primscrn-spr-indfb-draw-render: SKIP (0.000s)
[398.758714] [127/131] (639s left) kms_psr (fbc-psr-sprite-mmap-cpu)
[399.053443] Subtest fbc-psr-sprite-mmap-cpu: SKIP (0.000s)
[399.253560] [128/131] (639s left) kms_big_fb (x-tiled-64bpp-rotate-90)
[399.559359] Starting subtest: x-tiled-64bpp-rotate-90
[399.573872] Subtest x-tiled-64bpp-rotate-90: SKIP (0.015s)
[400.044219] [129/131] (638s left) gem_render_copy (x-tiled-to-vebox-yf-tiled)
[400.112019] Starting subtest: x-tiled-to-vebox-yf-tiled
[400.114634] Subtest x-tiled-to-vebox-yf-tiled: SKIP (0.000s)
[400.344295] [130/131] (638s left) gem_mmap_gtt (cpuset-basic-small-copy-odd)
[400.400968] Starting subtest: cpuset-basic-small-copy-odd
[401.247909] Subtest cpuset-basic-small-copy-odd: SUCCESS (0.847s)
[401.408926] [131/131] (637s left) syncobj_timeline (single-wait-all-for-submit-available-submitted)
[401.592945] Starting subtest: single-wait-all-for-submit-available-submitted
[401.594101] Subtest single-wait-all-for-submit-available-submitted: SUCCESS (0.000s)
[401.718863] Closing watchdogs
results: parsing output: 0/ for test: kms_frontbuffer_tracking
results: parsing output: 1/ for test: kms_ccs
results: parsing output: 2/ for test: kms_frontbuffer_tracking
results: parsing output: 3/ for test: kms_big_fb
results: parsing output: 4/ for test: gen9_exec_parse
results: parsing output: 5/ for test: core_auth
results: parsing output: 6/ for test: dmabuf_sync_file
results: parsing output: 7/ for test: kms_invalid_mode
results: parsing output: 8/ for test: gem_lmem_swapping
results: parsing output: 9/ for test: kms_frontbuffer_tracking
results: parsing output: 10/ for test: i915_pm_rpm
results: parsing output: 11/ for test: kms_big_fb
results: parsing output: 12/ for test: kms_feature_discovery
results: parsing output: 13/ for test: kms_getfb
results: parsing output: 14/ for test: gem_exec_reloc
results: parsing output: 15/ for test: gem_mmap_wc
results: parsing output: 16/ for test: kms_async_flips
results: parsing output: 17/ for test: kms_content_protection
results: parsing output: 18/ for test: gem_ctx_param
results: parsing output: 19/ for test: perf
results: parsing output: 20/ for test: kms_plane_scaling
results: parsing output: 21/ for test: gem_create
results: parsing output: 22/ for test: kms_cursor_legacy
results: parsing output: 23/ for test: kms_pm_rpm
results: parsing output: 24/ for test: kms_color
results: parsing output: 25/ for test: kms_flip
results: parsing output: 26/ for test: gem_ctx_exec
results: parsing output: 27/ for test: kms_atomic_transition
results: parsing output: 28/ for test: kms_chamelium_color
results: parsing output: 29/ for test: kms_chamelium_hpd
results: parsing output: 30/ for test: kms_frontbuffer_tracking
results: parsing output: 31/ for test: kms_frontbuffer_tracking
results: parsing output: 32/ for test: gem_render_copy
results: parsing output: 33/ for test: kms_getfb
results: parsing output: 34/ for test: kms_cursor_crc
results: parsing output: 35/ for test: fbdev
results: parsing output: 36/ for test: gem_userptr_blits
results: parsing output: 37/ for test: kms_big_fb
results: parsing output: 38/ for test: api_intel_bb
results: parsing output: 39/ for test: kms_dither
results: parsing output: 40/ for test: kms_flip
results: parsing output: 41/ for test: perf
results: parsing output: 42/ for test: kms_frontbuffer_tracking
results: parsing output: 43/ for test: kms_plane_scaling
results: parsing output: 44/ for test: syncobj_timeline
results: parsing output: 45/ for test: syncobj_wait
results: parsing output: 46/ for test: kms_psr2_sf
results: parsing output: 47/ for test: kms_ccs
results: parsing output: 48/ for test: gem_mmap_offset
results: parsing output: 49/ for test: kms_frontbuffer_tracking
results: parsing output: 50/ for test: kms_cursor_edge_walk
results: parsing output: 51/ for test: syncobj_wait
results: parsing output: 52/ for test: kms_flip_scaled_crc
results: parsing output: 53/ for test: gem_madvise
results: parsing output: 54/ for test: gem_flink_race
results: parsing output: 55/ for test: gem_exec_fence
results: parsing output: 56/ for test: kms_plane_cursor
results: parsing output: 57/ for test: syncobj_timeline
results: parsing output: 58/ for test: kms_psr2_sf
results: parsing output: 59/ for test: kms_big_fb
results: parsing output: 60/ for test: kms_cursor_legacy
results: parsing output: 61/ for test: kms_ccs
results: parsing output: 62/ for test: gem_mmap_wc
results: parsing output: 63/ for test: kms_frontbuffer_tracking
results: parsing output: 64/ for test: kms_frontbuffer_tracking
results: parsing output: 65/ for test: gem_mmap_wc
results: parsing output: 66/ for test: gem_ctx_shared
results: parsing output: 67/ for test: api_intel_allocator
results: parsing output: 68/ for test: kms_psr
results: parsing output: 69/ for test: syncobj_timeline
results: parsing output: 70/ for test: prime_vgem
results: parsing output: 71/ for test: sw_sync
results: parsing output: 72/ for test: kms_cursor_crc
results: parsing output: 73/ for test: kms_psr
results: parsing output: 74/ for test: gem_exec_schedule
results: parsing output: 75/ for test: i915_selftest
results: parsing output: 76/ for test: kms_frontbuffer_tracking
results: parsing output: 77/ for test: gem_pxp
results: parsing output: 78/ for test: gem_softpin
results: parsing output: 79/ for test: i915_query
results: parsing output: 80/ for test: kms_chamelium_edid
results: parsing output: 81/ for test: kms_frontbuffer_tracking
results: parsing output: 82/ for test: i915_hangman
results: parsing output: 83/ for test: kms_addfb_basic
results: parsing output: 84/ for test: gen9_exec_parse
results: parsing output: 85/ for test: kms_frontbuffer_tracking
results: parsing output: 86/ for test: kms_lease
results: parsing output: 87/ for test: kms_flip
results: parsing output: 88/ for test: kms_frontbuffer_tracking
results: parsing output: 89/ for test: gen3_mixed_blits
results: parsing output: 90/ for test: perf
results: parsing output: 91/ for test: gem_exec_schedule
results: parsing output: 92/ for test: kms_busy
results: parsing output: 93/ for test: perf
results: parsing output: 94/ for test: kms_async_flips
results: parsing output: 95/ for test: kms_psr
results: parsing output: 96/ for test: syncobj_basic
results: parsing output: 97/ for test: gem_eio
results: parsing output: 98/ for test: kms_psr
results: parsing output: 99/ for test: gem_exec_schedule
results: parsing output: 100/ for test: gem_spin_batch
results: parsing output: 101/ for test: kms_frontbuffer_tracking
results: parsing output: 102/ for test: kms_cursor_legacy
results: parsing output: 103/ for test: kms_vblank
results: parsing output: 104/ for test: kms_frontbuffer_tracking
results: parsing output: 105/ for test: gem_exec_balancer
results: parsing output: 106/ for test: kms_ccs
results: parsing output: 107/ for test: gem_exec_schedule
results: parsing output: 108/ for test: gem_pipe_control_store_loop
results: parsing output: 109/ for test: kms_plane_multiple
results: parsing output: 110/ for test: syncobj_wait
results: parsing output: 111/ for test: kms_flip_scaled_crc
results: parsing output: 112/ for test: gem_ctx_persistence
results: parsing output: 113/ for test: kms_frontbuffer_tracking
results: parsing output: 114/ for test: gem_exec_flush
results: parsing output: 115/ for test: gem_exec_balancer
results: parsing output: 116/ for test: kms_psr2_sf
results: parsing output: 117/ for test: kms_rotation_crc
results: parsing output: 118/ for test: kms_big_fb
results: parsing output: 119/ for test: gem_exec_await
results: parsing output: 120/ for test: gem_exec_nop
results: parsing output: 121/ for test: kms_addfb_basic
results: parsing output: 122/ for test: syncobj_timeline
results: parsing output: 123/ for test: prime_vgem
results: parsing output: 124/ for test: gem_exec_params
results: parsing output: 125/ for test: kms_frontbuffer_tracking
results: parsing output: 126/ for test: kms_psr
results: parsing output: 127/ for test: kms_big_fb
results: parsing output: 128/ for test: gem_render_copy
results: parsing output: 129/ for test: gem_mmap_gtt
results: parsing output: 130/ for test: syncobj_timeline
Done.