[48.764675] Initializing watchdogs
[48.764843]   /dev/watchdog0
[48.802913] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:2e12 Intel Eaglelake (Gen4) 4 Series Chipset Integrated Graphics Controller
[48.806101] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.1: 8086:2e13  4 Series Chipset Integrated Graphics Controller
[48.814839] [001/162] (960s left) i915_module_load (load)
[48.922170] Starting subtest: load
[52.036096] Subtest load: SUCCESS (3.114s)
[52.106884] [FACT i915_module_load (load)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[52.109548] [FACT i915_module_load (load)] new: kernel.kmod_is_loaded.i915: true
[52.116346] [002/162] (957s left) core_auth (basic-auth)
[52.219591] Starting subtest: basic-auth
[52.221463] Subtest basic-auth: SUCCESS (0.002s)
[52.353284] [003/162] (957s left) core_debugfs (read-all-entries)
[52.440240] Starting subtest: read-all-entries
[52.517785] Subtest read-all-entries: SUCCESS (0.076s)
[52.654396] [004/162] (956s left) core_sysfs (read-all-entries)
[52.735087] Starting subtest: read-all-entries
[52.742070] Subtest read-all-entries: SUCCESS (0.005s)
[52.852202] [005/162] (956s left) fbdev (eof)
[52.952817] Starting subtest: eof
[52.954979] Subtest eof: SUCCESS (0.001s)
[53.068876] [006/162] (956s left) fbdev (info)
[53.148235] Starting subtest: info
[53.150259] Subtest info: SUCCESS (0.000s)
[53.270596] [007/162] (956s left) fbdev (nullptr)
[53.364401] Starting subtest: nullptr
[53.367314] Subtest nullptr: SUCCESS (0.000s)
[53.468975] [008/162] (956s left) fbdev (read)
[53.562988] Starting subtest: read
[53.791275] Subtest read: SUCCESS (0.227s)
[53.901592] [009/162] (956s left) fbdev (write)
[54.030594] Starting subtest: write
[54.143684] Subtest write: SUCCESS (0.113s)
[54.249901] [010/162] (955s left) gem_basic (bad-close)
[54.333089] Starting subtest: bad-close
[54.336506] Subtest bad-close: SUCCESS (0.000s)
[54.448205] [011/162] (955s left) gem_basic (create-close)
[54.530858] Starting subtest: create-close
[54.534808] Subtest create-close: SUCCESS (0.000s)
[54.649181] [012/162] (955s left) gem_basic (create-fd-close)
[54.735021] Starting subtest: create-fd-close
[54.738544] Subtest create-fd-close: SUCCESS (0.001s)
[54.848510] [013/162] (955s left) gem_busy (busy@all-engines)
[54.961598] Starting subtest: busy
[54.968063] Starting dynamic subtest: all-engines
[55.016855] Dynamic subtest all-engines: SUCCESS (0.063s)
[55.018884] Subtest busy: SUCCESS (0.064s)
[55.379979] [014/162] (954s left) gem_close_race (basic-process)
[55.491639] Starting subtest: basic-process
[55.538237] Subtest basic-process: SUCCESS (0.048s)
[55.764767] [015/162] (954s left) gem_close_race (basic-threads)
[55.869647] Starting subtest: basic-threads
[57.006742] Subtest basic-threads: SUCCESS (1.141s)
[57.227552] [016/162] (953s left) gem_ctx_create (basic)
[57.328464] Starting subtest: basic
[57.330483] Subtest basic: SUCCESS (0.000s)
[57.559582] [017/162] (952s left) gem_ctx_create (basic-files)
[57.661617] Starting subtest: basic-files
[59.684034] Subtest basic-files: SUCCESS (2.023s)
[59.953955] [018/162] (950s left) gem_ctx_exec (basic)
[60.045118] Starting subtest: basic
[60.048067] Subtest basic: SUCCESS (0.001s)
[60.171787] [019/162] (950s left) gem_exec_basic (basic)
[60.265629] Starting subtest: basic
[60.267451] Starting dynamic subtest: rcs0-smem
[60.269145] Dynamic subtest rcs0-smem: SUCCESS (0.001s)
[60.282535] Starting dynamic subtest: vcs0-smem
[60.284535] Dynamic subtest vcs0-smem: SUCCESS (0.000s)
[60.286521] Subtest basic: SUCCESS (0.002s)
[60.488851] [020/162] (950s left) gem_exec_create (basic)
[60.586133] Starting subtest: basic
[60.588989] Starting dynamic subtest: smem
[62.617888] Dynamic subtest smem: SUCCESS (2.033s)
[62.619853] Subtest basic: SUCCESS (2.034s)
[62.855051] [021/162] (947s left) gem_exec_fence (basic-busy)
[63.100630] Starting subtest: basic-busy
[63.103852] Starting dynamic subtest: rcs0
[63.141397] Dynamic subtest rcs0: SUCCESS (0.023s)
[63.190212] Starting dynamic subtest: vcs0
[63.206072] Dynamic subtest vcs0: SUCCESS (0.047s)
[63.212203] Subtest basic-busy: SUCCESS (0.086s)
[63.998766] [FACT gem_exec_fence (basic-busy)] new: kernel.kmod_is_loaded.vgem: true
[64.008611] [022/162] (946s left) gem_exec_fence (basic-wait)
[64.349628] Starting subtest: basic-wait
[64.355328] Starting dynamic subtest: rcs0
[64.373088] Dynamic subtest rcs0: SUCCESS (0.021s)
[64.406613] Starting dynamic subtest: vcs0
[64.409643] Dynamic subtest vcs0: SUCCESS (0.024s)
[64.412613] Subtest basic-wait: SUCCESS (0.046s)
[64.921486] [023/162] (946s left) gem_exec_fence (basic-await)
[65.152521] Starting subtest: basic-await
[65.154324] Starting dynamic subtest: rcs0
[65.225103] Dynamic subtest rcs0: SUCCESS (0.078s)
[65.245071] Starting dynamic subtest: vcs0
[65.303909] Dynamic subtest vcs0: SUCCESS (0.078s)
[65.305893] Subtest basic-await: SUCCESS (0.158s)
[65.818697] [024/162] (945s left) gem_exec_fence (nb-await)
[66.036162] Starting subtest: nb-await
[66.037961] Starting dynamic subtest: rcs0
[66.092058] Dynamic subtest rcs0: SUCCESS (0.055s)
[66.106214] Starting dynamic subtest: vcs0
[66.146773] Dynamic subtest vcs0: SUCCESS (0.054s)
[66.148804] Subtest nb-await: SUCCESS (0.110s)
[66.651567] [025/162] (944s left) gem_exec_gttfill (basic)
[66.750421] Starting subtest: basic
[74.652154] Subtest basic: SUCCESS (7.899s)
[74.893084] [026/162] (936s left) gem_exec_parallel (engines)
[75.080015] Starting subtest: engines
[75.082016] Starting dynamic subtest: basic
[78.309844] Dynamic subtest basic: SUCCESS (3.226s)
[78.325661] Starting dynamic subtest: contexts
[80.283590] Dynamic subtest contexts: SUCCESS (1.975s)
[80.301187] Starting dynamic subtest: fds
[80.309131] Dynamic subtest fds: SKIP (0.001s)
[80.325059] Starting dynamic subtest: userptr
[102.926979] Dynamic subtest userptr: SUCCESS (22.640s)
[102.928835] Subtest engines: SUCCESS (27.846s)
[103.170454] [027/162] (908s left) gem_exec_store (basic)
[103.302507] Starting subtest: basic
[103.332661] Subtest basic: SUCCESS (0.031s)
[103.578751] [028/162] (907s left) gem_flink_basic (bad-flink)
[103.664632] Starting subtest: bad-flink
[103.666609] Subtest bad-flink: SUCCESS (0.000s)
[103.793135] [029/162] (907s left) gem_flink_basic (bad-open)
[103.873422] Starting subtest: bad-open
[103.875625] Subtest bad-open: SUCCESS (0.000s)
[103.992299] [030/162] (907s left) gem_flink_basic (basic)
[104.076229] Starting subtest: basic
[104.078020] Subtest basic: SUCCESS (0.000s)
[104.207832] [031/162] (907s left) gem_flink_basic (double-flink)
[104.290801] Starting subtest: double-flink
[104.293398] Subtest double-flink: SUCCESS (0.000s)
[104.409461] [032/162] (907s left) gem_flink_basic (flink-lifetime)
[104.496340] Starting subtest: flink-lifetime
[104.498135] Subtest flink-lifetime: SUCCESS (0.002s)
[104.625190] [033/162] (907s left) gem_huc_copy (huc-copy)
[104.719379] Subtest huc-copy: SKIP (0.000s)
[104.800233] [034/162] (907s left) gem_linear_blits (basic)
[104.976645] Starting subtest: basic
[104.994166] Subtest basic: SUCCESS (0.016s)
[105.155673] [035/162] (906s left) gem_mmap (basic)
[105.340211] Starting subtest: basic
[105.349755] Subtest basic: SUCCESS (0.001s)
[105.473458] [036/162] (906s left) gem_mmap_gtt (basic)
[105.560207] Starting subtest: basic
[105.561985] Subtest basic: SUCCESS (0.001s)
[105.716207] [037/162] (906s left) gem_render_linear_blits (basic)
[105.801167] Starting subtest: basic
[105.843431] Subtest basic: SUCCESS (0.039s)
[105.948275] [038/162] (906s left) gem_render_tiled_blits (basic)
[106.034722] Starting subtest: basic
[106.078188] Subtest basic: SUCCESS (0.042s)
[106.182488] [039/162] (906s left) gem_ringfill (basic-all)
[106.350812] Starting subtest: basic-all
[107.462925] Subtest basic-all: SUCCESS (1.113s)
[107.583904] [040/162] (904s left) gem_softpin (allocator-basic)
[107.673124] Subtest allocator-basic: SKIP (0.000s)
[107.802325] [041/162] (904s left) gem_softpin (allocator-basic-reserve)
[107.892200] Subtest allocator-basic-reserve: SKIP (0.000s)
[108.019482] [042/162] (904s left) gem_softpin (safe-alignment)
[108.108293] Starting subtest: safe-alignment
[108.114030] Subtest safe-alignment: SUCCESS (0.009s)
[108.286367] [043/162] (904s left) gem_sync (basic-all)
[108.390029] Starting subtest: basic-all
[110.569916] Subtest basic-all: SUCCESS (2.181s)
[110.796925] [044/162] (902s left) gem_sync (basic-each)
[110.898591] Starting subtest: basic-each
[112.946717] Subtest basic-each: SUCCESS (2.050s)
[113.175456] [045/162] (899s left) gem_tiled_blits (basic)
[113.342031] Starting subtest: basic
[113.368622] Subtest basic: SUCCESS (0.027s)
[113.516777] [046/162] (899s left) gem_tiled_fence_blits (basic)
[113.798805] Starting subtest: basic
[113.814605] Subtest basic: SUCCESS (0.013s)
[113.957323] [047/162] (899s left) gem_tiled_pread_basic (basic)
[114.140029] Starting subtest: basic
[114.372100] Subtest basic: SUCCESS (0.232s)
[114.505896] [048/162] (898s left) gem_wait (busy@all-engines)
[114.613369] Starting subtest: busy
[114.639240] Starting dynamic subtest: all-engines
[115.151090] Dynamic subtest all-engines: SUCCESS (0.538s)
[115.154107] Subtest busy: SUCCESS (0.539s)
[115.403855] [049/162] (897s left) gem_wait (wait@all-engines)
[115.512948] Starting subtest: wait
[115.515098] Starting dynamic subtest: all-engines
[116.528112] Dynamic subtest all-engines: SUCCESS (1.018s)
[116.533623] Subtest wait: SUCCESS (1.019s)
[116.785196] [050/162] (896s left) i915_getparams_basic (basic-eu-total)
[116.871506] Starting subtest: basic-eu-total
[116.875036] Subtest basic-eu-total: SUCCESS (0.000s)
[117.000476] [051/162] (896s left) i915_getparams_basic (basic-subslice-total)
[117.083229] Starting subtest: basic-subslice-total
[117.086932] Subtest basic-subslice-total: SUCCESS (0.000s)
[117.198732] [052/162] (896s left) i915_hangman (error-state-basic)
[117.291184] Starting subtest: error-state-basic
[117.310623] Subtest error-state-basic: SUCCESS (0.017s)
[117.407862] [053/162] (896s left) i915_pciid
[117.615637] [054/162] (896s left) intel_hwmon (hwmon-read)
[117.705751] Subtest hwmon-read: SKIP (0.000s)
[117.792121] [055/162] (896s left) intel_hwmon (hwmon-write)
[117.880077] Subtest hwmon-write: SKIP (0.000s)
[117.976534] [056/162] (895s left) kms_addfb_basic (addfb25-4-tiled)
[118.746064] Starting subtest: addfb25-4-tiled
[118.747937] Subtest addfb25-4-tiled: SUCCESS (0.001s)
[119.431288] [057/162] (894s left) kms_addfb_basic (addfb25-bad-modifier)
[120.180575] Starting subtest: addfb25-bad-modifier
[120.183063] Subtest addfb25-bad-modifier: SUCCESS (0.001s)
[120.859910] [058/162] (893s left) kms_addfb_basic (addfb25-framebuffer-vs-set-tiling)
[121.609813] Starting subtest: addfb25-framebuffer-vs-set-tiling
[121.611862] Subtest addfb25-framebuffer-vs-set-tiling: SUCCESS (0.000s)
[122.292277] [059/162] (891s left) kms_addfb_basic (addfb25-modifier-no-flag)
[123.040573] Starting subtest: addfb25-modifier-no-flag
[123.042467] Subtest addfb25-modifier-no-flag: SUCCESS (0.000s)
[123.754604] [060/162] (890s left) kms_addfb_basic (addfb25-x-tiled-legacy)
[124.508532] Starting subtest: addfb25-x-tiled-legacy
[124.514032] Subtest addfb25-x-tiled-legacy: SUCCESS (0.000s)
[125.184874] [061/162] (889s left) kms_addfb_basic (addfb25-x-tiled-mismatch-legacy)
[125.944138] Starting subtest: addfb25-x-tiled-mismatch-legacy
[125.946030] Subtest addfb25-x-tiled-mismatch-legacy: SUCCESS (0.001s)
[126.632196] [062/162] (887s left) kms_addfb_basic (addfb25-yf-tiled-legacy)
[127.376849] Starting subtest: addfb25-yf-tiled-legacy
[127.378688] Subtest addfb25-yf-tiled-legacy: SUCCESS (0.001s)
[128.060986] [063/162] (886s left) kms_addfb_basic (addfb25-y-tiled-legacy)
[128.810481] Starting subtest: addfb25-y-tiled-legacy
[128.812331] Subtest addfb25-y-tiled-legacy: SUCCESS (0.001s)
[129.491023] [064/162] (885s left) kms_addfb_basic (addfb25-y-tiled-small-legacy)
[130.242354] Starting subtest: addfb25-y-tiled-small-legacy
[130.246193] Subtest addfb25-y-tiled-small-legacy: SKIP (0.000s)
[130.923559] [065/162] (883s left) kms_addfb_basic (bad-pitch-0)
[131.030088] Starting subtest: bad-pitch-0
[131.032165] Subtest bad-pitch-0: SUCCESS (0.000s)
[132.372341] [066/162] (882s left) kms_addfb_basic (bad-pitch-1024)
[132.460072] Starting subtest: bad-pitch-1024
[132.462671] Subtest bad-pitch-1024: SUCCESS (0.000s)
[133.817857] [067/162] (881s left) kms_addfb_basic (bad-pitch-128)
[133.904890] Starting subtest: bad-pitch-128
[133.907080] Subtest bad-pitch-128: SUCCESS (0.000s)
[135.247227] [068/162] (879s left) kms_addfb_basic (bad-pitch-256)
[135.333129] Starting subtest: bad-pitch-256
[135.335080] Subtest bad-pitch-256: SUCCESS (0.000s)
[136.695460] [069/162] (878s left) kms_addfb_basic (bad-pitch-32)
[136.781897] Starting subtest: bad-pitch-32
[136.783738] Subtest bad-pitch-32: SUCCESS (0.000s)
[138.141743] [070/162] (876s left) kms_addfb_basic (bad-pitch-63)
[138.228148] Starting subtest: bad-pitch-63
[138.230827] Subtest bad-pitch-63: SUCCESS (0.000s)
[139.572760] [071/162] (875s left) kms_addfb_basic (bad-pitch-65536)
[139.658155] Starting subtest: bad-pitch-65536
[139.661094] Subtest bad-pitch-65536: SUCCESS (0.001s)
[141.019878] [072/162] (874s left) kms_addfb_basic (bad-pitch-999)
[141.107081] Starting subtest: bad-pitch-999
[141.108903] Subtest bad-pitch-999: SUCCESS (0.000s)
[142.483189] [073/162] (872s left) kms_addfb_basic (basic)
[142.569609] Starting subtest: basic
[142.572777] Subtest basic: SUCCESS (0.000s)
[143.947436] [074/162] (871s left) kms_addfb_basic (basic-x-tiled-legacy)
[144.033081] Starting subtest: basic-x-tiled-legacy
[144.036169] Subtest basic-x-tiled-legacy: SUCCESS (0.000s)
[145.411144] [075/162] (870s left) kms_addfb_basic (basic-y-tiled-legacy)
[145.497292] Starting subtest: basic-y-tiled-legacy
[145.500111] Subtest basic-y-tiled-legacy: SUCCESS (0.001s)
[146.924982] [076/162] (868s left) kms_addfb_basic (bo-too-small)
[147.702327] Starting subtest: bo-too-small
[147.704811] Subtest bo-too-small: SUCCESS (0.001s)
[148.421982] [077/162] (867s left) kms_addfb_basic (bo-too-small-due-to-tiling)
[149.209295] Starting subtest: bo-too-small-due-to-tiling
[149.211212] Subtest bo-too-small-due-to-tiling: SUCCESS (0.001s)
[149.918764] [078/162] (865s left) kms_addfb_basic (clobberred-modifier)
[150.030087] Starting subtest: clobberred-modifier
[150.031852] Subtest clobberred-modifier: SUCCESS (0.000s)
[151.415081] [079/162] (864s left) kms_addfb_basic (framebuffer-vs-set-tiling)
[151.504222] Starting subtest: framebuffer-vs-set-tiling
[151.506065] Subtest framebuffer-vs-set-tiling: SUCCESS (0.000s)
[152.895471] [080/162] (863s left) kms_addfb_basic (invalid-get-prop)
[152.981074] Starting subtest: invalid-get-prop
[152.983187] Subtest invalid-get-prop: SUCCESS (0.000s)
[154.391877] [081/162] (861s left) kms_addfb_basic (invalid-get-prop-any)
[154.479394] Starting subtest: invalid-get-prop-any
[154.481690] Subtest invalid-get-prop-any: SUCCESS (0.000s)
[155.889133] [082/162] (860s left) kms_addfb_basic (invalid-set-prop)
[155.975159] Starting subtest: invalid-set-prop
[155.977134] Subtest invalid-set-prop: SUCCESS (0.000s)
[157.388219] [083/162] (858s left) kms_addfb_basic (invalid-set-prop-any)
[157.477113] Starting subtest: invalid-set-prop-any
[157.479107] Subtest invalid-set-prop-any: SUCCESS (0.000s)
[158.899578] [084/162] (857s left) kms_addfb_basic (no-handle)
[158.988645] Starting subtest: no-handle
[158.991360] Subtest no-handle: SUCCESS (0.000s)
[160.414804] [085/162] (855s left) kms_addfb_basic (size-max)
[161.212115] Starting subtest: size-max
[161.214091] Subtest size-max: SUCCESS (0.000s)
[161.946112] [086/162] (854s left) kms_addfb_basic (small-bo)
[162.744337] Starting subtest: small-bo
[162.746322] Subtest small-bo: SUCCESS (0.000s)
[163.491706] [087/162] (853s left) kms_addfb_basic (tile-pitch-mismatch)
[163.582284] Starting subtest: tile-pitch-mismatch
[163.584178] Subtest tile-pitch-mismatch: SUCCESS (0.001s)
[165.006645] [088/162] (851s left) kms_addfb_basic (too-high)
[165.806266] Starting subtest: too-high
[165.811309] Subtest too-high: SUCCESS (0.004s)
[166.552892] [089/162] (850s left) kms_addfb_basic (too-wide)
[167.374737] Starting subtest: too-wide
[167.377287] Subtest too-wide: SUCCESS (0.000s)
[168.133810] [090/162] (848s left) kms_addfb_basic (unused-handle)
[168.222769] Starting subtest: unused-handle
[168.225809] Subtest unused-handle: SUCCESS (0.000s)
[169.697569] [091/162] (847s left) kms_addfb_basic (unused-modifier)
[169.787078] Starting subtest: unused-modifier
[169.789095] Subtest unused-modifier: SUCCESS (0.000s)
[171.276419] [092/162] (845s left) kms_addfb_basic (unused-offsets)
[171.364297] Starting subtest: unused-offsets
[171.366258] Subtest unused-offsets: SUCCESS (0.000s)
[172.825920] [093/162] (844s left) kms_addfb_basic (unused-pitches)
[172.920126] Starting subtest: unused-pitches
[172.922083] Subtest unused-pitches: SUCCESS (0.000s)
[174.388405] [094/162] (842s left) kms_busy (basic)
[175.186039] Starting subtest: basic
[175.189050] Starting dynamic subtest: flip
[175.837080] Dynamic subtest flip: SUCCESS (0.640s)
[175.857049] Starting dynamic subtest: modeset
[176.608688] Dynamic subtest modeset: SUCCESS (0.766s)
[176.614160] Subtest basic: SUCCESS (1.415s)
[177.430782] [095/162] (839s left) kms_prop_blob (basic)
[177.522941] Starting subtest: basic
[177.525889] Subtest basic: SUCCESS (0.000s)
[177.662647] [096/162] (839s left) kms_cursor_legacy (basic-busy-flip-before-cursor-atomic)
[178.472870] Starting subtest: basic-busy-flip-before-cursor-atomic
[179.484115] Subtest basic-busy-flip-before-cursor-atomic: SUCCESS (1.009s)
[180.328561] [097/162] (837s left) kms_cursor_legacy (basic-busy-flip-before-cursor-legacy)
[181.140079] Starting subtest: basic-busy-flip-before-cursor-legacy
[182.166735] Subtest basic-busy-flip-before-cursor-legacy: SUCCESS (1.024s)
[183.005616] [098/162] (834s left) kms_cursor_legacy (basic-flip-after-cursor-atomic)
[183.831091] Starting subtest: basic-flip-after-cursor-atomic
[184.877501] Subtest basic-flip-after-cursor-atomic: SUCCESS (1.055s)
[185.719207] [099/162] (831s left) kms_cursor_legacy (basic-flip-after-cursor-legacy)
[186.528607] Starting subtest: basic-flip-after-cursor-legacy
[187.538427] Subtest basic-flip-after-cursor-legacy: SUCCESS (1.011s)
[188.424943] [100/162] (829s left) kms_cursor_legacy (basic-flip-after-cursor-varying-size)
[189.238661] Starting subtest: basic-flip-after-cursor-varying-size
[190.260559] Subtest basic-flip-after-cursor-varying-size: SUCCESS (1.024s)
[191.088944] [101/162] (826s left) kms_cursor_legacy (basic-flip-before-cursor-atomic)
[191.905604] Starting subtest: basic-flip-before-cursor-atomic
[192.929585] Subtest basic-flip-before-cursor-atomic: SUCCESS (1.020s)
[193.782851] [102/162] (824s left) kms_cursor_legacy (basic-flip-before-cursor-legacy)
[194.580763] Starting subtest: basic-flip-before-cursor-legacy
[195.603357] Subtest basic-flip-before-cursor-legacy: SUCCESS (1.019s)
[196.442188] [103/162] (821s left) kms_cursor_legacy (basic-flip-before-cursor-varying-size)
[197.269341] Starting subtest: basic-flip-before-cursor-varying-size
[198.280041] Subtest basic-flip-before-cursor-varying-size: SUCCESS (1.010s)
[199.124476] [104/162] (818s left) kms_dsc (dsc-basic)
[199.936551] Subtest dsc-basic: SKIP (0.000s)
[200.384677] [105/162] (817s left) kms_flip (basic-flip-vs-dpms)
[201.212799] Starting subtest: basic-flip-vs-dpms
[201.216627] Starting dynamic subtest: A-VGA1
[201.996149] Dynamic subtest A-VGA1: SUCCESS (0.775s)
[202.013671] Starting dynamic subtest: B-VGA1
[202.696749] Dynamic subtest B-VGA1: SUCCESS (0.697s)
[202.714856] Starting dynamic subtest: A-HDMI-A1
[203.427831] Dynamic subtest A-HDMI-A1: SUCCESS (0.735s)
[203.458339] Starting dynamic subtest: B-HDMI-A1
[204.191484] Dynamic subtest B-HDMI-A1: SUCCESS (0.732s)
[204.193877] Subtest basic-flip-vs-dpms: SUCCESS (2.961s)
[205.056954] [106/162] (813s left) kms_flip (basic-flip-vs-modeset)
[205.892729] Starting subtest: basic-flip-vs-modeset
[205.894960] Starting dynamic subtest: A-VGA1
[206.661059] Dynamic subtest A-VGA1: SUCCESS (0.757s)
[206.686082] Starting dynamic subtest: B-VGA1
[207.343128] Dynamic subtest B-VGA1: SUCCESS (0.676s)
[207.361726] Starting dynamic subtest: A-HDMI-A1
[208.138031] Dynamic subtest A-HDMI-A1: SUCCESS (0.787s)
[208.165076] Starting dynamic subtest: B-HDMI-A1
[208.987322] Dynamic subtest B-HDMI-A1: SUCCESS (0.815s)
[208.989099] Subtest basic-flip-vs-modeset: SUCCESS (3.075s)
[209.827776] [107/162] (808s left) kms_flip (basic-flip-vs-wf_vblank)
[210.656921] Starting subtest: basic-flip-vs-wf_vblank
[210.658999] Starting dynamic subtest: A-VGA1
[211.705871] Dynamic subtest A-VGA1: SUCCESS (1.046s)
[211.727556] Starting dynamic subtest: B-VGA1
[212.701421] Dynamic subtest B-VGA1: SUCCESS (0.990s)
[212.723855] Starting dynamic subtest: A-HDMI-A1
[213.909123] Dynamic subtest A-HDMI-A1: SUCCESS (1.195s)
[213.926685] Starting dynamic subtest: B-HDMI-A1
[215.145410] Dynamic subtest B-HDMI-A1: SUCCESS (1.237s)
[215.153927] Subtest basic-flip-vs-wf_vblank: SUCCESS (4.490s)
[216.080165] [108/162] (802s left) kms_flip (basic-plain-flip)
[216.883438] Starting subtest: basic-plain-flip
[216.886594] Starting dynamic subtest: A-VGA1
[217.671230] Dynamic subtest A-VGA1: SUCCESS (0.782s)
[217.687270] Starting dynamic subtest: B-VGA1
[218.364085] Dynamic subtest B-VGA1: SUCCESS (0.690s)
[218.388156] Starting dynamic subtest: A-HDMI-A1
[219.159203] Dynamic subtest A-HDMI-A1: SUCCESS (0.787s)
[219.181327] Starting dynamic subtest: B-HDMI-A1
[219.970043] Dynamic subtest B-HDMI-A1: SUCCESS (0.806s)
[219.975444] Subtest basic-plain-flip: SUCCESS (3.087s)
[220.903524] [109/162] (797s left) kms_force_connector_basic (force-connector-state)
[221.054100] Starting subtest: force-connector-state
[222.059475] Subtest force-connector-state: SUCCESS (1.005s)
[222.975893] [110/162] (795s left) kms_force_connector_basic (force-edid)
[223.140649] Starting subtest: force-edid
[223.449921] Subtest force-edid: SUCCESS (0.315s)
[224.288992] [111/162] (794s left) kms_force_connector_basic (force-load-detect)
[224.449492] Starting subtest: force-load-detect
[224.663769] Subtest force-load-detect: SUCCESS (0.213s)
[225.284546] [112/162] (793s left) kms_force_connector_basic (prune-stale-modes)
[225.453813] Starting subtest: prune-stale-modes
[225.763981] Subtest prune-stale-modes: SUCCESS (0.321s)
[226.598948] [113/162] (792s left) kms_frontbuffer_tracking (basic)
[227.495530] Starting subtest: basic
[229.914040] Subtest basic: SUCCESS (2.549s)
[230.691959] [114/162] (788s left) kms_hdmi_inject (inject-audio)
[230.867231] Starting subtest: inject-audio
[230.879305] Subtest inject-audio: SKIP (0.000s)
[231.072892] [115/162] (787s left) kms_pipe_crc_basic (compare-crc-sanitycheck-xr24)
[231.892627] Starting subtest: compare-crc-sanitycheck-xr24
[231.895600] Starting dynamic subtest: pipe-A-HDMI-A-1
[232.307100] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.407s)
[232.323715] Starting dynamic subtest: pipe-B-HDMI-A-1
[232.721784] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.418s)
[232.726627] Subtest compare-crc-sanitycheck-xr24: SUCCESS (0.836s)
[233.562796] [116/162] (785s left) kms_pipe_crc_basic (compare-crc-sanitycheck-nv12)
[234.357755] Starting subtest: compare-crc-sanitycheck-nv12
[234.363454] Starting dynamic subtest: pipe-A-HDMI-A-1
[234.367209] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.000s)
[234.384378] Starting dynamic subtest: pipe-B-HDMI-A-1
[234.389201] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.000s)
[234.399320] Subtest compare-crc-sanitycheck-nv12: SKIP (0.012s)
[235.158858] [117/162] (784s left) kms_pipe_crc_basic (hang-read-crc)
[235.980044] Starting subtest: hang-read-crc
[235.985901] Starting dynamic subtest: pipe-A-HDMI-A-1
[237.063993] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (1.078s)
[237.085590] Starting dynamic subtest: pipe-B-HDMI-A-1
[238.174192] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (1.104s)
[238.176169] Subtest hang-read-crc: SUCCESS (2.194s)
[239.014701] [118/162] (780s left) kms_pipe_crc_basic (nonblocking-crc)
[239.820607] Starting subtest: nonblocking-crc
[239.822712] Starting dynamic subtest: pipe-A-HDMI-A-1
[240.417818] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.591s)
[240.435841] Starting dynamic subtest: pipe-B-HDMI-A-1
[241.028074] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.608s)
[241.030687] Subtest nonblocking-crc: SUCCESS (1.208s)
[241.854107] [119/162] (777s left) kms_pipe_crc_basic (nonblocking-crc-frame-sequence)
[242.673427] Starting subtest: nonblocking-crc-frame-sequence
[242.675451] Starting dynamic subtest: pipe-A-HDMI-A-1
[243.241743] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.563s)
[243.261425] Starting dynamic subtest: pipe-B-HDMI-A-1
[243.863179] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.615s)
[243.865201] Subtest nonblocking-crc-frame-sequence: SUCCESS (1.188s)
[244.695836] [120/162] (774s left) kms_pipe_crc_basic (read-crc)
[245.499116] Starting subtest: read-crc
[245.500991] Starting dynamic subtest: pipe-A-HDMI-A-1
[246.017338] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.514s)
[246.035019] Starting dynamic subtest: pipe-B-HDMI-A-1
[246.561189] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.537s)
[246.563821] Subtest read-crc: SUCCESS (1.062s)
[247.424239] [121/162] (772s left) kms_pipe_crc_basic (read-crc-frame-sequence)
[248.236269] Starting subtest: read-crc-frame-sequence
[248.242620] Starting dynamic subtest: pipe-A-HDMI-A-1
[248.775109] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.535s)
[248.798606] Starting dynamic subtest: pipe-B-HDMI-A-1
[249.297161] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.516s)
[249.299136] Subtest read-crc-frame-sequence: SUCCESS (1.061s)
[250.136287] [122/162] (769s left) kms_pm_backlight (basic-brightness)
[250.947576] Subtest basic-brightness: SKIP (0.000s)
[251.362894] [123/162] (768s left) kms_pm_rpm (basic-pci-d3-state)
[263.634842] Subtest basic-pci-d3-state: SKIP (0.000s)
[264.066532] [124/162] (755s left) kms_pm_rpm (basic-rte)
[264.154768] Starting subtest: basic-rte
[276.363841] Subtest basic-rte: SKIP (12.203s)
[276.779608] [125/162] (743s left) kms_psr (psr-primary-page-flip)
[277.609601] Subtest psr-primary-page-flip: SKIP (0.000s)
[278.025880] [126/162] (741s left) kms_psr (psr-cursor-plane-move)
[278.842628] Subtest psr-cursor-plane-move: SKIP (0.000s)
[279.270994] [127/162] (740s left) kms_psr (psr-sprite-plane-onoff)
[280.071225] Subtest psr-sprite-plane-onoff: SKIP (0.000s)
[280.488430] [128/162] (739s left) kms_psr (psr-primary-mmap-gtt)
[281.299325] Subtest psr-primary-mmap-gtt: SKIP (0.000s)
[281.715908] [129/162] (738s left) kms_setmode (basic-clone-single-crtc)
[281.805226] Starting subtest: basic-clone-single-crtc
[281.810697] Subtest basic-clone-single-crtc: SKIP (0.000s)
[281.939911] [130/162] (738s left) i915_pm_rps (basic-api)
[282.034406] Subtest basic-api: SKIP (0.000s)
[282.133326] [131/162] (738s left) prime_self_import (basic-llseek-bad)
[282.223489] Starting subtest: basic-llseek-bad
[282.229114] Subtest basic-llseek-bad: SUCCESS (0.004s)
[282.389058] [132/162] (738s left) prime_self_import (basic-llseek-size)
[282.474647] Starting subtest: basic-llseek-size
[282.478959] Subtest basic-llseek-size: SUCCESS (0.006s)
[282.604915] [133/162] (737s left) prime_self_import (basic-with_fd_dup)
[282.688942] Starting subtest: basic-with_fd_dup
[282.693696] Subtest basic-with_fd_dup: SUCCESS (0.005s)
[282.821055] [134/162] (737s left) prime_self_import (basic-with_one_bo)
[282.908219] Starting subtest: basic-with_one_bo
[282.912293] Subtest basic-with_one_bo: SUCCESS (0.005s)
[283.066971] [135/162] (737s left) prime_self_import (basic-with_one_bo_two_files)
[283.168892] Starting subtest: basic-with_one_bo_two_files
[283.174181] Subtest basic-with_one_bo_two_files: SUCCESS (0.005s)
[283.304518] [136/162] (737s left) prime_self_import (basic-with_two_bos)
[283.388291] Starting subtest: basic-with_two_bos
[283.392844] Subtest basic-with_two_bos: SUCCESS (0.005s)
[283.521444] [137/162] (737s left) prime_vgem (basic-fence-flip)
[283.631380] Starting subtest: basic-fence-flip
[284.908268] Subtest basic-fence-flip: SUCCESS (1.277s)
[285.793998] [138/162] (735s left) prime_vgem (basic-fence-mmap)
[285.905632] Starting subtest: basic-fence-mmap
[285.951229] Subtest basic-fence-mmap: SUCCESS (0.044s)
[286.075973] [139/162] (735s left) prime_vgem (basic-fence-read)
[286.189632] Starting subtest: basic-fence-read
[286.247376] Subtest basic-fence-read: SUCCESS (0.058s)
[286.377293] [140/162] (734s left) prime_vgem (basic-gtt)
[286.490631] Starting subtest: basic-gtt
[286.508747] Subtest basic-gtt: SUCCESS (0.023s)
[286.641763] [141/162] (734s left) prime_vgem (basic-read)
[286.748431] Starting subtest: basic-read
[286.761788] Subtest basic-read: SUCCESS (0.028s)
[286.893638] [142/162] (734s left) prime_vgem (basic-write)
[287.000980] Starting subtest: basic-write
[287.025492] Subtest basic-write: SUCCESS (0.026s)
[287.158236] [143/162] (734s left) vgem_basic (setversion)
[287.261347] Starting subtest: setversion
[287.265278] Subtest setversion: SUCCESS (0.000s)
[287.374495] [144/162] (734s left) vgem_basic (create)
[287.462290] Starting subtest: create
[287.464239] Subtest create: SUCCESS (0.000s)
[287.574245] [145/162] (734s left) vgem_basic (debugfs)
[287.664989] Starting subtest: debugfs
[287.667097] Subtest debugfs: SUCCESS (0.001s)
[287.775913] [146/162] (733s left) vgem_basic (dmabuf-export)
[287.883081] Starting subtest: dmabuf-export
[287.888865] Subtest dmabuf-export: SUCCESS (0.004s)
[288.006210] [147/162] (733s left) vgem_basic (dmabuf-fence)
[288.094272] Starting subtest: dmabuf-fence
[288.096240] Subtest dmabuf-fence: SUCCESS (0.001s)
[288.207383] [148/162] (733s left) vgem_basic (dmabuf-fence-before)
[288.308920] Starting subtest: dmabuf-fence-before
[288.310928] Subtest dmabuf-fence-before: SUCCESS (0.001s)
[288.421987] [149/162] (733s left) vgem_basic (dmabuf-mmap)
[288.531607] Starting subtest: dmabuf-mmap
[288.544767] Subtest dmabuf-mmap: SUCCESS (0.021s)
[288.657161] [150/162] (733s left) vgem_basic (mmap)
[288.761703] Starting subtest: mmap
[288.773325] Subtest mmap: SUCCESS (0.015s)
[288.891176] [151/162] (733s left) vgem_basic (second-client)
[288.989784] Starting subtest: second-client
[289.024224] Subtest second-client: SUCCESS (0.032s)
[289.136236] [152/162] (733s left) vgem_basic (sysfs)
[289.243912] Starting subtest: sysfs
[289.246111] Subtest sysfs: SUCCESS (0.001s)
[289.353599] [153/162] (733s left) core_hotunplug (unbind-rebind)
[289.558243] Starting subtest: unbind-rebind
[293.321861] Subtest unbind-rebind: SUCCESS (3.768s)
[293.414312] [154/162] (729s left) vgem_basic (unload)
[293.503326] Starting subtest: unload
[322.376158] Subtest unload: SUCCESS (28.873s)
[322.548952] [155/162] (699s left) i915_module_load (reload)
[322.642161] Starting subtest: reload
[326.429884] Subtest reload: SUCCESS (3.788s)
[326.521911] [156/162] (696s left) gem_lmem_swapping (basic)
[326.617877] Subtest basic: SKIP (0.000s)
[326.720931] [157/162] (695s left) gem_lmem_swapping (parallel-random-engines)
[326.817582] Subtest parallel-random-engines: SKIP (0.000s)
[326.903872] [158/162] (695s left) gem_lmem_swapping (random-engines)
[326.993111] Subtest random-engines: SKIP (0.000s)
[327.089503] [159/162] (695s left) gem_lmem_swapping (verify-random)
[327.181734] Subtest verify-random: SKIP (0.000s)
[327.287779] [160/162] (695s left) i915_pm_rpm (module-reload)
[339.568913] Subtest module-reload: SKIP (0.000s)
[339.993969] [161/162] (683s left) i915_selftest (live)