[50.706401] Initializing watchdogs
[50.706881]   /dev/watchdog0
[50.763973] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:5a85 Intel Broxton (Gen9) HD Graphics 500
[50.796085] [001/161] (960s left) i915_module_load (load)
[51.489550] Starting subtest: load
[55.846045] Subtest load: SUCCESS (4.365s)
[55.988252] [FACT i915_module_load (load)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[55.991768] [FACT i915_module_load (load)] new: kernel.kmod_is_loaded.i915: true
[56.035979] [002/161] (955s left) core_auth (basic-auth)
[56.344728] Starting subtest: basic-auth
[56.367440] Subtest basic-auth: SUCCESS (0.002s)
[56.521837] [003/161] (955s left) debugfs_test (read_all_entries)
[56.771043] Starting subtest: read_all_entries
[56.939894] Subtest read_all_entries: SUCCESS (0.157s)
[57.267509] [004/161] (954s left) debugfs_test (basic-hwmon)
[57.513743] Starting subtest: basic-hwmon
[57.556217] Subtest basic-hwmon: SKIP (0.000s)
[57.796539] [005/161] (954s left) debugfs_test (sysfs)
[58.044625] Starting subtest: sysfs
[58.201244] Subtest sysfs: SUCCESS (0.171s)
[58.495706] [006/161] (953s left) fbdev (eof)
[58.758794] Starting subtest: eof
[58.782363] Subtest eof: SUCCESS (0.002s)
[58.952166] [007/161] (953s left) fbdev (info)
[59.191876] Starting subtest: info
[59.217092] Subtest info: SUCCESS (0.000s)
[59.400168] [008/161] (953s left) fbdev (nullptr)
[59.664142] Starting subtest: nullptr
[59.692422] Subtest nullptr: SUCCESS (0.000s)
[59.859744] [009/161] (952s left) fbdev (read)
[60.071385] Starting subtest: read
[61.562273] Subtest read: SUCCESS (1.493s)
[61.741752] [010/161] (951s left) fbdev (write)
[61.993540] Starting subtest: write
[62.727513] Subtest write: SUCCESS (0.773s)
[62.891975] [011/161] (950s left) gem_basic (bad-close)
[63.125649] Starting subtest: bad-close
[63.171665] Subtest bad-close: SUCCESS (0.000s)
[63.335659] [012/161] (949s left) gem_basic (create-close)
[63.613057] Starting subtest: create-close
[63.657964] Subtest create-close: SUCCESS (0.000s)
[63.815359] [013/161] (949s left) gem_basic (create-fd-close)
[64.067635] Starting subtest: create-fd-close
[64.115238] Subtest create-fd-close: SUCCESS (0.000s)
[64.269110] [014/161] (949s left) gem_busy (busy@all-engines)
[64.542406] Starting subtest: busy
[64.565674] Starting dynamic subtest: all-engines
[64.649195] Dynamic subtest all-engines: SUCCESS (0.127s)
[64.670754] Subtest busy: SUCCESS (0.128s)
[65.133790] [015/161] (948s left) gem_close_race (basic-process)
[65.406843] Starting subtest: basic-process
[65.515056] Subtest basic-process: SUCCESS (0.122s)
[65.813783] [016/161] (948s left) gem_close_race (basic-threads)
[66.063942] Starting subtest: basic-threads
[67.324865] Subtest basic-threads: SUCCESS (1.265s)
[67.622445] [017/161] (946s left) gem_ctx_create (basic)
[68.037790] Starting subtest: basic
[68.061410] Subtest basic: SUCCESS (0.000s)
[68.449227] [018/161] (945s left) gem_ctx_create (basic-files)
[68.881813] Starting subtest: basic-files
[70.979643] Subtest basic-files: SUCCESS (2.101s)
[71.296259] [019/161] (943s left) gem_ctx_exec (basic)
[71.549053] Starting subtest: basic
[71.570136] Subtest basic: SUCCESS (0.011s)
[71.730197] [020/161] (942s left) gem_exec_basic (basic)
[72.007274] Starting subtest: basic
[72.029665] Starting dynamic subtest: rcs0-smem
[72.051812] Dynamic subtest rcs0-smem: SUCCESS (0.003s)
[72.101363] Starting dynamic subtest: bcs0-smem
[72.124908] Dynamic subtest bcs0-smem: SUCCESS (0.003s)
[72.177128] Starting dynamic subtest: vcs0-smem
[72.198544] Dynamic subtest vcs0-smem: SUCCESS (0.002s)
[72.254192] Starting dynamic subtest: vecs0-smem
[72.278542] Dynamic subtest vecs0-smem: SUCCESS (0.002s)
[72.301555] Subtest basic: SUCCESS (0.013s)
[72.459865] [021/161] (942s left) gem_exec_create (basic)
[72.729999] Starting subtest: basic
[72.752787] Starting dynamic subtest: smem
[74.798708] Dynamic subtest smem: SUCCESS (2.083s)
[74.821132] Subtest basic: SUCCESS (2.084s)
[75.087361] [022/161] (939s left) gem_exec_fence (basic-busy)
[75.493867] Starting subtest: basic-busy
[75.517192] Starting dynamic subtest: rcs0
[75.560407] Dynamic subtest rcs0: SUCCESS (0.039s)
[75.613052] Starting dynamic subtest: bcs0
[75.657980] Dynamic subtest bcs0: SUCCESS (0.029s)
[75.706103] Starting dynamic subtest: vcs0
[75.755426] Dynamic subtest vcs0: SUCCESS (0.033s)
[75.799283] Starting dynamic subtest: vecs0
[75.845213] Dynamic subtest vecs0: SUCCESS (0.056s)
[75.866769] Subtest basic-busy: SUCCESS (0.161s)
[76.532441] [FACT gem_exec_fence (basic-busy)] new: kernel.kmod_is_loaded.vgem: true
[76.557354] [023/161] (938s left) gem_exec_fence (basic-wait)
[76.949475] Starting subtest: basic-wait
[76.971202] Starting dynamic subtest: rcs0
[76.991846] Dynamic subtest rcs0: SUCCESS (0.033s)
[77.041982] Starting dynamic subtest: bcs0
[77.065691] Dynamic subtest bcs0: SUCCESS (0.029s)
[77.124123] Starting dynamic subtest: vcs0
[77.145110] Dynamic subtest vcs0: SUCCESS (0.056s)
[77.206662] Starting dynamic subtest: vecs0
[77.232517] Dynamic subtest vecs0: SUCCESS (0.033s)
[77.254236] Subtest basic-wait: SUCCESS (0.156s)
[77.935462] [024/161] (937s left) gem_exec_fence (basic-await)
[78.321810] Starting subtest: basic-await
[78.345064] Starting dynamic subtest: rcs0
[78.493174] Dynamic subtest rcs0: SUCCESS (0.170s)
[78.539907] Starting dynamic subtest: bcs0
[78.660468] Dynamic subtest bcs0: SUCCESS (0.168s)
[78.705931] Starting dynamic subtest: vcs0
[78.831594] Dynamic subtest vcs0: SUCCESS (0.168s)
[78.876086] Starting dynamic subtest: vecs0
[79.000301] Dynamic subtest vecs0: SUCCESS (0.168s)
[79.022214] Subtest basic-await: SUCCESS (0.678s)
[79.829258] [025/161] (935s left) gem_exec_fence (nb-await)
[80.220262] Starting subtest: nb-await
[80.242779] Starting dynamic subtest: rcs0
[80.303619] Dynamic subtest rcs0: SUCCESS (0.081s)
[80.365258] Starting dynamic subtest: bcs0
[80.388543] Dynamic subtest bcs0: SUCCESS (0.074s)
[80.449281] Starting dynamic subtest: vcs0
[80.471782] Dynamic subtest vcs0: SUCCESS (0.073s)
[80.533772] Starting dynamic subtest: vecs0
[80.556431] Dynamic subtest vecs0: SUCCESS (0.075s)
[80.580282] Subtest nb-await: SUCCESS (0.305s)
[81.349869] [026/161] (934s left) gem_exec_gttfill (basic)
[81.620340] Starting subtest: basic
[112.093213] Subtest basic: SUCCESS (30.491s)
[112.411938] [027/161] (903s left) gem_exec_parallel (engines)
[112.829902] Starting subtest: engines
[112.849708] Starting dynamic subtest: basic
[117.061275] Dynamic subtest basic: SUCCESS (4.220s)
[117.105176] Starting dynamic subtest: contexts
[123.233780] Dynamic subtest contexts: SUCCESS (6.062s)
[123.282254] Starting dynamic subtest: fds
[128.889609] Dynamic subtest fds: SUCCESS (5.641s)
[128.933633] Starting dynamic subtest: userptr
[132.996524] Dynamic subtest userptr: SUCCESS (4.087s)
[133.019853] Subtest engines: SUCCESS (20.012s)
[133.196644] [028/161] (882s left) gem_exec_store (basic)
[133.522196] Starting subtest: basic
[133.567079] Subtest basic: SUCCESS (0.090s)
[133.863798] [029/161] (882s left) gem_flink_basic (bad-flink)
[134.140946] Starting subtest: bad-flink
[134.161486] Subtest bad-flink: SUCCESS (0.000s)
[134.329421] [030/161] (881s left) gem_flink_basic (bad-open)
[134.571919] Starting subtest: bad-open
[134.594276] Subtest bad-open: SUCCESS (0.000s)
[134.762321] [031/161] (881s left) gem_flink_basic (basic)
[135.029191] Starting subtest: basic
[135.052235] Subtest basic: SUCCESS (0.000s)
[135.216396] [032/161] (881s left) gem_flink_basic (double-flink)
[135.481200] Starting subtest: double-flink
[135.501557] Subtest double-flink: SUCCESS (0.000s)
[135.672712] [033/161] (881s left) gem_flink_basic (flink-lifetime)
[135.936611] Starting subtest: flink-lifetime
[135.956878] Subtest flink-lifetime: SUCCESS (0.003s)
[136.124652] [034/161] (880s left) gem_huc_copy (huc-copy)
[136.369106] Starting subtest: huc-copy
[136.415258] Subtest huc-copy: SKIP (0.000s)
[136.584118] [035/161] (880s left) gem_linear_blits (basic)
[137.001343] Starting subtest: basic
[137.047166] Subtest basic: SUCCESS (0.027s)
[137.318754] [036/161] (880s left) gem_mmap (basic)
[137.739793] Starting subtest: basic
[137.847460] Subtest basic: SUCCESS (0.001s)
[138.017568] [037/161] (879s left) gem_mmap_gtt (basic)
[138.299651] Starting subtest: basic
[138.319792] Subtest basic: SUCCESS (0.002s)
[138.487657] [038/161] (879s left) gem_render_linear_blits (basic)
[138.748908] Starting subtest: basic
[138.856929] Subtest basic: SUCCESS (0.101s)
[139.029626] [039/161] (878s left) gem_render_tiled_blits (basic)
[139.282804] Starting subtest: basic
[139.411682] Subtest basic: SUCCESS (0.139s)
[139.601492] [040/161] (878s left) gem_ringfill (basic-all)
[140.184979] Starting subtest: basic-all
[141.379162] Subtest basic-all: SUCCESS (1.226s)
[141.588361] [041/161] (876s left) gem_softpin (allocator-basic)
[141.841831] Starting subtest: allocator-basic
[142.104184] Subtest allocator-basic: SUCCESS (0.283s)
[142.325203] [042/161] (876s left) gem_softpin (allocator-basic-reserve)
[142.587587] Starting subtest: allocator-basic-reserve
[142.822413] Subtest allocator-basic-reserve: SUCCESS (0.278s)
[143.046655] [043/161] (875s left) gem_softpin (safe-alignment)
[143.335788] Starting subtest: safe-alignment
[143.359113] Subtest safe-alignment: SUCCESS (0.036s)
[143.568133] [044/161] (875s left) gem_sync (basic-all)
[143.995571] Starting subtest: basic-all
[146.345605] Subtest basic-all: SUCCESS (2.374s)
[146.513078] [045/161] (872s left) gem_sync (basic-each)
[146.966972] Starting subtest: basic-each
[149.047649] Subtest basic-each: SUCCESS (2.284s)
[149.347925] [046/161] (869s left) gem_tiled_blits (basic)
[149.694235] Starting subtest: basic
[149.757876] Subtest basic: SUCCESS (0.060s)
[150.045477] [047/161] (869s left) gem_tiled_fence_blits (basic)
[150.565345] Starting subtest: basic
[150.612560] Subtest basic: SUCCESS (0.045s)
[150.912425] [048/161] (868s left) gem_tiled_pread_basic
[151.761863] [049/161] (867s left) gem_wait (busy@all-engines)
[152.064448] Starting subtest: busy
[152.085598] Starting dynamic subtest: all-engines
[152.591400] Dynamic subtest all-engines: SUCCESS (0.534s)
[152.612332] Subtest busy: SUCCESS (0.535s)
[152.937604] [050/161] (866s left) gem_wait (wait@all-engines)
[153.210588] Starting subtest: wait
[153.234174] Starting dynamic subtest: all-engines
[154.260491] Dynamic subtest all-engines: SUCCESS (1.048s)
[154.283784] Subtest wait: SUCCESS (1.049s)
[154.609643] [051/161] (865s left) i915_getparams_basic (basic-eu-total)
[154.861975] Starting subtest: basic-eu-total
[154.903677] Subtest basic-eu-total: SUCCESS (0.000s)
[155.073229] [052/161] (865s left) i915_getparams_basic (basic-subslice-total)
[155.320623] Starting subtest: basic-subslice-total
[155.360849] Subtest basic-subslice-total: SUCCESS (0.000s)
[155.536755] [053/161] (864s left) i915_hangman (error-state-basic)
[155.811222] Starting subtest: error-state-basic
[155.830888] Subtest error-state-basic: SUCCESS (0.018s)
[156.021786] [054/161] (864s left) i915_pciid
[156.488746] [055/161] (864s left) kms_addfb_basic (addfb25-4-tiled)
[156.923382] Starting subtest: addfb25-4-tiled
[156.942970] Subtest addfb25-4-tiled: SUCCESS (0.001s)
[157.119659] [056/161] (863s left) kms_addfb_basic (addfb25-bad-modifier)
[157.474581] Starting subtest: addfb25-bad-modifier
[157.494706] Subtest addfb25-bad-modifier: SUCCESS (0.001s)
[157.678090] [057/161] (863s left) kms_addfb_basic (addfb25-framebuffer-vs-set-tiling)
[158.032315] Starting subtest: addfb25-framebuffer-vs-set-tiling
[158.054833] Subtest addfb25-framebuffer-vs-set-tiling: SUCCESS (0.000s)
[158.245436] [058/161] (862s left) kms_addfb_basic (addfb25-modifier-no-flag)
[158.598355] Starting subtest: addfb25-modifier-no-flag
[158.618470] Subtest addfb25-modifier-no-flag: SUCCESS (0.000s)
[158.800850] [059/161] (862s left) kms_addfb_basic (addfb25-x-tiled-legacy)
[159.485818] Starting subtest: addfb25-x-tiled-legacy
[159.508462] Subtest addfb25-x-tiled-legacy: SUCCESS (0.000s)
[159.691840] [060/161] (861s left) kms_addfb_basic (addfb25-x-tiled-mismatch-legacy)
[160.049629] Starting subtest: addfb25-x-tiled-mismatch-legacy
[160.073901] Subtest addfb25-x-tiled-mismatch-legacy: SUCCESS (0.001s)
[160.283463] [061/161] (861s left) kms_addfb_basic (addfb25-yf-tiled-legacy)
[160.634173] Starting subtest: addfb25-yf-tiled-legacy
[160.657911] Subtest addfb25-yf-tiled-legacy: SUCCESS (0.000s)
[160.836319] [062/161] (861s left) kms_addfb_basic (addfb25-y-tiled-legacy)
[161.197334] Starting subtest: addfb25-y-tiled-legacy
[161.217915] Subtest addfb25-y-tiled-legacy: SUCCESS (0.000s)
[161.389228] [063/161] (860s left) kms_addfb_basic (addfb25-y-tiled-small-legacy)
[161.744214] Starting subtest: addfb25-y-tiled-small-legacy
[161.765112] Subtest addfb25-y-tiled-small-legacy: SUCCESS (0.001s)
[161.947540] [064/161] (860s left) kms_addfb_basic (bad-pitch-0)
[162.211477] Starting subtest: bad-pitch-0
[162.233500] Subtest bad-pitch-0: SUCCESS (0.000s)
[162.494672] [065/161] (859s left) kms_addfb_basic (bad-pitch-1024)
[162.753956] Starting subtest: bad-pitch-1024
[162.775215] Subtest bad-pitch-1024: SUCCESS (0.000s)
[163.039763] [066/161] (859s left) kms_addfb_basic (bad-pitch-128)
[163.304314] Starting subtest: bad-pitch-128
[163.324039] Subtest bad-pitch-128: SUCCESS (0.000s)
[163.593290] [067/161] (859s left) kms_addfb_basic (bad-pitch-256)
[163.841488] Starting subtest: bad-pitch-256
[163.864233] Subtest bad-pitch-256: SUCCESS (0.000s)
[164.159595] [068/161] (858s left) kms_addfb_basic (bad-pitch-32)
[164.418502] Starting subtest: bad-pitch-32
[164.440469] Subtest bad-pitch-32: SUCCESS (0.000s)
[164.709978] [069/161] (858s left) kms_addfb_basic (bad-pitch-63)
[164.979366] Starting subtest: bad-pitch-63
[165.001340] Subtest bad-pitch-63: SUCCESS (0.000s)
[165.276515] [070/161] (857s left) kms_addfb_basic (bad-pitch-65536)
[165.547779] Starting subtest: bad-pitch-65536
[165.570872] Subtest bad-pitch-65536: SUCCESS (0.001s)
[165.844169] [071/161] (857s left) kms_addfb_basic (bad-pitch-999)
[166.085319] Starting subtest: bad-pitch-999
[166.105128] Subtest bad-pitch-999: SUCCESS (0.000s)
[166.394621] [072/161] (857s left) kms_addfb_basic (basic)
[166.639432] Starting subtest: basic
[166.660110] Subtest basic: SUCCESS (0.000s)
[166.963910] [073/161] (856s left) kms_addfb_basic (basic-x-tiled-legacy)
[167.230565] Starting subtest: basic-x-tiled-legacy
[167.250176] Subtest basic-x-tiled-legacy: SUCCESS (0.000s)
[167.516277] [074/161] (856s left) kms_addfb_basic (basic-y-tiled-legacy)
[167.783919] Starting subtest: basic-y-tiled-legacy
[167.803470] Subtest basic-y-tiled-legacy: SUCCESS (0.001s)
[168.079376] [075/161] (856s left) kms_addfb_basic (bo-too-small)
[168.428162] Starting subtest: bo-too-small
[168.451544] Subtest bo-too-small: SUCCESS (0.001s)
[168.635343] [076/161] (855s left) kms_addfb_basic (bo-too-small-due-to-tiling)
[168.989171] Starting subtest: bo-too-small-due-to-tiling
[169.014166] Subtest bo-too-small-due-to-tiling: SUCCESS (0.001s)
[169.201890] [077/161] (855s left) kms_addfb_basic (clobberred-modifier)
[169.495710] Starting subtest: clobberred-modifier
[169.526523] Subtest clobberred-modifier: SUCCESS (0.000s)
[169.776239] [078/161] (854s left) kms_addfb_basic (framebuffer-vs-set-tiling)
[170.046818] Starting subtest: framebuffer-vs-set-tiling
[170.069232] Subtest framebuffer-vs-set-tiling: SUCCESS (0.000s)
[170.327750] [079/161] (854s left) kms_addfb_basic (invalid-get-prop)
[170.570621] Starting subtest: invalid-get-prop
[170.590443] Subtest invalid-get-prop: SUCCESS (0.000s)
[170.874294] [080/161] (854s left) kms_addfb_basic (invalid-get-prop-any)
[171.137771] Starting subtest: invalid-get-prop-any
[171.157410] Subtest invalid-get-prop-any: SUCCESS (0.000s)
[171.426867] [081/161] (853s left) kms_addfb_basic (invalid-set-prop)
[171.666891] Starting subtest: invalid-set-prop
[171.688723] Subtest invalid-set-prop: SUCCESS (0.000s)
[171.982630] [082/161] (853s left) kms_addfb_basic (invalid-set-prop-any)
[172.247183] Starting subtest: invalid-set-prop-any
[172.269063] Subtest invalid-set-prop-any: SUCCESS (0.000s)
[172.532511] [083/161] (852s left) kms_addfb_basic (no-handle)
[172.779507] Starting subtest: no-handle
[172.802291] Subtest no-handle: SUCCESS (0.000s)
[173.091936] [084/161] (852s left) kms_addfb_basic (size-max)
[173.448090] Starting subtest: size-max
[173.469975] Subtest size-max: SUCCESS (0.000s)
[173.643534] [085/161] (852s left) kms_addfb_basic (small-bo)
[173.997528] Starting subtest: small-bo
[174.023338] Subtest small-bo: SUCCESS (0.000s)
[174.192839] [086/161] (851s left) kms_addfb_basic (tile-pitch-mismatch)
[174.453466] Starting subtest: tile-pitch-mismatch
[174.474049] Subtest tile-pitch-mismatch: SUCCESS (0.001s)
[174.734498] [087/161] (851s left) kms_addfb_basic (too-high)
[175.088668] Starting subtest: too-high
[175.111164] Subtest too-high: SUCCESS (0.002s)
[175.307571] [088/161] (851s left) kms_addfb_basic (too-wide)
[175.648984] Starting subtest: too-wide
[175.669551] Subtest too-wide: SUCCESS (0.000s)
[175.843648] [089/161] (850s left) kms_addfb_basic (unused-handle)
[176.088717] Starting subtest: unused-handle
[176.110995] Subtest unused-handle: SUCCESS (0.000s)
[176.395997] [090/161] (850s left) kms_addfb_basic (unused-modifier)
[176.637614] Starting subtest: unused-modifier
[176.658603] Subtest unused-modifier: SUCCESS (0.000s)
[176.922695] [091/161] (849s left) kms_addfb_basic (unused-offsets)
[177.186343] Starting subtest: unused-offsets
[177.205851] Subtest unused-offsets: SUCCESS (0.000s)
[177.475565] [092/161] (849s left) kms_addfb_basic (unused-pitches)
[177.718160] Starting subtest: unused-pitches
[177.739940] Subtest unused-pitches: SUCCESS (0.000s)
[178.026302] [093/161] (849s left) kms_busy (basic)
[178.430194] Starting subtest: basic
[178.450661] Starting dynamic subtest: flip
[179.252258] Dynamic subtest flip: SUCCESS (0.831s)
[179.312250] Starting dynamic subtest: modeset
[180.749174] Dynamic subtest modeset: SUCCESS (1.504s)
[180.769193] Subtest basic: SUCCESS (2.340s)
[181.233462] [094/161] (846s left) kms_prop_blob (basic)
[181.508132] Starting subtest: basic
[181.529127] Subtest basic: SUCCESS (0.000s)
[181.702057] [095/161] (845s left) kms_cursor_legacy (basic-busy-flip-before-cursor-atomic)
[182.058878] Starting subtest: basic-busy-flip-before-cursor-atomic
[182.099777] Subtest basic-busy-flip-before-cursor-atomic: SKIP (0.000s)
[182.277628] [096/161] (845s left) kms_cursor_legacy (basic-busy-flip-before-cursor-legacy)
[182.633832] Starting subtest: basic-busy-flip-before-cursor-legacy
[182.673301] Subtest basic-busy-flip-before-cursor-legacy: SKIP (0.000s)
[182.842707] [097/161] (845s left) kms_cursor_legacy (basic-flip-after-cursor-atomic)
[183.213681] Starting subtest: basic-flip-after-cursor-atomic
[184.192108] Subtest basic-flip-after-cursor-atomic: SUCCESS (1.000s)
[184.639512] [098/161] (843s left) kms_cursor_legacy (basic-flip-after-cursor-legacy)
[185.000571] Starting subtest: basic-flip-after-cursor-legacy
[185.977223] Subtest basic-flip-after-cursor-legacy: SUCCESS (0.990s)
[186.428653] [099/161] (841s left) kms_cursor_legacy (basic-flip-after-cursor-varying-size)
[186.781879] Starting subtest: basic-flip-after-cursor-varying-size
[187.764362] Subtest basic-flip-after-cursor-varying-size: SUCCESS (0.996s)
[188.222475] [100/161] (840s left) kms_cursor_legacy (basic-flip-before-cursor-atomic)
[188.580213] Starting subtest: basic-flip-before-cursor-atomic
[189.557310] Subtest basic-flip-before-cursor-atomic: SUCCESS (0.991s)
[190.006622] [101/161] (838s left) kms_cursor_legacy (basic-flip-before-cursor-legacy)
[190.396637] Starting subtest: basic-flip-before-cursor-legacy
[191.357768] Subtest basic-flip-before-cursor-legacy: SUCCESS (0.990s)
[191.828690] [102/161] (836s left) kms_cursor_legacy (basic-flip-before-cursor-varying-size)
[192.193111] Starting subtest: basic-flip-before-cursor-varying-size
[193.186277] Subtest basic-flip-before-cursor-varying-size: SUCCESS (1.002s)
[193.644773] [103/161] (835s left) kms_dsc (dsc-basic)
[194.039829] Subtest dsc-basic: SKIP (0.000s)
[194.210731] [104/161] (834s left) kms_flip (basic-flip-vs-dpms)
[194.602548] Starting subtest: basic-flip-vs-dpms
[194.622487] Starting dynamic subtest: A-DP1
[195.855097] Dynamic subtest A-DP1: SUCCESS (1.272s)
[195.904126] Starting dynamic subtest: B-DP1
[197.003950] Dynamic subtest B-DP1: SUCCESS (1.155s)
[197.052694] Starting dynamic subtest: C-DP1
[198.211050] Dynamic subtest C-DP1: SUCCESS (1.184s)
[198.231363] Subtest basic-flip-vs-dpms: SUCCESS (3.623s)
[198.687655] [105/161] (830s left) kms_flip (basic-flip-vs-modeset)
[199.057837] Starting subtest: basic-flip-vs-modeset
[199.085340] Starting dynamic subtest: A-DP1
[200.306801] Dynamic subtest A-DP1: SUCCESS (1.274s)
[200.354543] Starting dynamic subtest: B-DP1
[201.459655] Dynamic subtest B-DP1: SUCCESS (1.161s)
[201.508242] Starting dynamic subtest: C-DP1
[202.636158] Dynamic subtest C-DP1: SUCCESS (1.159s)
[202.659339] Subtest basic-flip-vs-modeset: SUCCESS (3.605s)
[203.095733] [106/161] (826s left) kms_flip (basic-flip-vs-wf_vblank)
[203.482699] Starting subtest: basic-flip-vs-wf_vblank
[203.505201] Starting dynamic subtest: A-DP1
[204.904118] Dynamic subtest A-DP1: SUCCESS (1.451s)
[204.950242] Starting dynamic subtest: B-DP1
[206.329873] Dynamic subtest B-DP1: SUCCESS (1.421s)
[206.377276] Starting dynamic subtest: C-DP1
[207.756758] Dynamic subtest C-DP1: SUCCESS (1.422s)
[207.779300] Subtest basic-flip-vs-wf_vblank: SUCCESS (4.306s)
[208.301501] [107/161] (821s left) kms_flip (basic-plain-flip)
[208.696969] Starting subtest: basic-plain-flip
[208.724956] Starting dynamic subtest: A-DP1
[209.834354] Dynamic subtest A-DP1: SUCCESS (1.154s)
[209.887171] Starting dynamic subtest: B-DP1
[210.961405] Dynamic subtest B-DP1: SUCCESS (1.137s)
[211.010270] Starting dynamic subtest: C-DP1
[212.101989] Dynamic subtest C-DP1: SUCCESS (1.132s)
[212.173531] Subtest basic-plain-flip: SUCCESS (3.436s)
[212.643798] [108/161] (817s left) kms_force_connector_basic (force-connector-state)
[212.940847] Subtest force-connector-state: SKIP (0.000s)
[213.114132] [109/161] (816s left) kms_force_connector_basic (force-edid)
[213.383393] Subtest force-edid: SKIP (0.000s)
[213.555492] [110/161] (816s left) kms_force_connector_basic (force-load-detect)
[213.841695] Subtest force-load-detect: SKIP (0.000s)
[214.013957] [111/161] (816s left) kms_force_connector_basic (prune-stale-modes)
[214.303127] Subtest prune-stale-modes: SKIP (0.000s)
[214.473592] [112/161] (816s left) kms_frontbuffer_tracking (basic)
[214.906995] Starting subtest: basic
[218.700912] Subtest basic: SUCCESS (3.855s)
[218.918681] [113/161] (811s left) kms_hdmi_inject (inject-audio)
[219.214331] Subtest inject-audio: SKIP (0.000s)
[219.393537] [114/161] (811s left) kms_pipe_crc_basic (compare-crc-sanitycheck-xr24)
[219.756642] Starting subtest: compare-crc-sanitycheck-xr24
[219.777838] Starting dynamic subtest: pipe-A-DP-1
[220.203381] Dynamic subtest pipe-A-DP-1: SUCCESS (0.460s)
[220.251118] Starting dynamic subtest: pipe-B-DP-1
[220.842049] Dynamic subtest pipe-B-DP-1: SUCCESS (0.631s)
[220.890513] Starting dynamic subtest: pipe-C-DP-1
[221.502190] Dynamic subtest pipe-C-DP-1: SUCCESS (0.643s)
[221.541301] Subtest compare-crc-sanitycheck-xr24: SUCCESS (1.748s)
[221.963200] [115/161] (809s left) kms_pipe_crc_basic (compare-crc-sanitycheck-nv12)
[222.334807] Starting subtest: compare-crc-sanitycheck-nv12
[222.356515] Starting dynamic subtest: pipe-A-DP-1
[222.396627] Dynamic subtest pipe-A-DP-1: SKIP (0.001s)
[222.464253] Starting dynamic subtest: pipe-B-DP-1
[222.508482] Dynamic subtest pipe-B-DP-1: SKIP (0.001s)
[222.554451] Starting dynamic subtest: pipe-C-DP-1
[222.600546] Dynamic subtest pipe-C-DP-1: SKIP (0.001s)
[222.642838] Subtest compare-crc-sanitycheck-nv12: SKIP (0.017s)
[222.821404] [116/161] (808s left) kms_pipe_crc_basic (hang-read-crc)
[223.188072] Starting subtest: hang-read-crc
[223.208192] Starting dynamic subtest: pipe-A-DP-1
[224.499440] Dynamic subtest pipe-A-DP-1: SUCCESS (1.305s)
[224.569120] Starting dynamic subtest: pipe-B-DP-1
[225.956435] Dynamic subtest pipe-B-DP-1: SUCCESS (1.453s)
[226.026472] Starting dynamic subtest: pipe-C-DP-1
[227.451306] Dynamic subtest pipe-C-DP-1: SUCCESS (1.505s)
[227.474327] Subtest hang-read-crc: SUCCESS (4.278s)
[227.897311] [117/161] (803s left) kms_pipe_crc_basic (nonblocking-crc)
[228.263944] Starting subtest: nonblocking-crc
[228.284601] Starting dynamic subtest: pipe-A-DP-1
[228.919737] Dynamic subtest pipe-A-DP-1: SUCCESS (0.651s)
[228.982527] Starting dynamic subtest: pipe-B-DP-1
[229.731672] Dynamic subtest pipe-B-DP-1: SUCCESS (0.806s)
[229.778436] Starting dynamic subtest: pipe-C-DP-1
[230.562184] Dynamic subtest pipe-C-DP-1: SUCCESS (0.816s)
[230.588536] Subtest nonblocking-crc: SUCCESS (2.288s)
[230.977077] [118/161] (800s left) kms_pipe_crc_basic (nonblocking-crc-frame-sequence)
[231.340246] Starting subtest: nonblocking-crc-frame-sequence
[231.361698] Starting dynamic subtest: pipe-A-DP-1
[231.952860] Dynamic subtest pipe-A-DP-1: SUCCESS (0.622s)
[232.013078] Starting dynamic subtest: pipe-B-DP-1
[232.750696] Dynamic subtest pipe-B-DP-1: SUCCESS (0.791s)
[232.798228] Starting dynamic subtest: pipe-C-DP-1
[233.589484] Dynamic subtest pipe-C-DP-1: SUCCESS (0.816s)
[233.610626] Subtest nonblocking-crc-frame-sequence: SUCCESS (2.244s)
[234.012608] [119/161] (797s left) kms_pipe_crc_basic (read-crc)
[234.379552] Starting subtest: read-crc
[234.402407] Starting dynamic subtest: pipe-A-DP-1
[234.921843] Dynamic subtest pipe-A-DP-1: SUCCESS (0.557s)
[234.971280] Starting dynamic subtest: pipe-B-DP-1
[235.662528] Dynamic subtest pipe-B-DP-1: SUCCESS (0.729s)
[235.723618] Starting dynamic subtest: pipe-C-DP-1
[236.453463] Dynamic subtest pipe-C-DP-1: SUCCESS (0.735s)
[236.473415] Subtest read-crc: SUCCESS (2.037s)
[236.837516] [120/161] (795s left) kms_pipe_crc_basic (read-crc-frame-sequence)
[237.193514] Starting subtest: read-crc-frame-sequence
[237.214653] Starting dynamic subtest: pipe-A-DP-1
[237.782423] Dynamic subtest pipe-A-DP-1: SUCCESS (0.582s)
[237.831677] Starting dynamic subtest: pipe-B-DP-1
[238.522768] Dynamic subtest pipe-B-DP-1: SUCCESS (0.735s)
[238.570432] Starting dynamic subtest: pipe-C-DP-1
[239.282808] Dynamic subtest pipe-C-DP-1: SUCCESS (0.748s)
[239.304993] Subtest read-crc-frame-sequence: SUCCESS (2.082s)
[239.733832] [121/161] (792s left) kms_pm_backlight (basic-brightness)
[240.111938] Subtest basic-brightness: SKIP (0.000s)
[240.286211] [122/161] (792s left) kms_pm_rpm (basic-pci-d3-state)
[242.131260] Starting subtest: basic-pci-d3-state
[242.813808] Subtest basic-pci-d3-state: SUCCESS (0.674s)
[243.132697] [123/161] (789s left) kms_pm_rpm (basic-rte)
[243.381212] Starting subtest: basic-rte
[245.601081] Subtest basic-rte: SUCCESS (2.248s)
[246.589438] [124/161] (786s left) kms_psr (psr-primary-page-flip)
[246.983453] Subtest psr-primary-page-flip: SKIP (0.000s)
[247.155721] [125/161] (785s left) kms_psr (psr-cursor-plane-move)
[247.535026] Subtest psr-cursor-plane-move: SKIP (0.000s)
[247.728969] [126/161] (785s left) kms_psr (psr-sprite-plane-onoff)
[248.109877] Subtest psr-sprite-plane-onoff: SKIP (0.000s)
[248.287814] [127/161] (784s left) kms_psr (psr-primary-mmap-gtt)
[248.668748] Subtest psr-primary-mmap-gtt: SKIP (0.000s)
[248.844970] [128/161] (784s left) kms_setmode (basic-clone-single-crtc)
[249.121783] Starting subtest: basic-clone-single-crtc
[249.186303] Subtest basic-clone-single-crtc: SKIP (0.000s)
[249.369787] [129/161] (784s left) i915_pm_rps (basic-api)
[249.625575] Starting subtest: basic-api
[249.649279] Subtest basic-api: SUCCESS (0.008s)
[249.879720] [130/161] (783s left) prime_self_import (basic-llseek-bad)
[250.269132] Starting subtest: basic-llseek-bad
[250.328940] Subtest basic-llseek-bad: SUCCESS (0.005s)
[250.538231] [131/161] (783s left) prime_self_import (basic-llseek-size)
[250.798430] Starting subtest: basic-llseek-size
[250.858733] Subtest basic-llseek-size: SUCCESS (0.008s)
[251.063256] [132/161] (783s left) prime_self_import (basic-with_fd_dup)
[251.345967] Starting subtest: basic-with_fd_dup
[251.401069] Subtest basic-with_fd_dup: SUCCESS (0.007s)
[251.604378] [133/161] (782s left) prime_self_import (basic-with_one_bo)
[251.861217] Starting subtest: basic-with_one_bo
[251.918381] Subtest basic-with_one_bo: SUCCESS (0.008s)
[252.105552] [134/161] (782s left) prime_self_import (basic-with_one_bo_two_files)
[252.379143] Starting subtest: basic-with_one_bo_two_files
[252.432431] Subtest basic-with_one_bo_two_files: SUCCESS (0.006s)
[252.630888] [135/161] (782s left) prime_self_import (basic-with_two_bos)
[252.895108] Starting subtest: basic-with_two_bos
[252.953622] Subtest basic-with_two_bos: SUCCESS (0.008s)
[253.138454] [136/161] (781s left) prime_vgem (basic-fence-flip)
[253.437170] Starting subtest: basic-fence-flip
[254.066066] Subtest basic-fence-flip: SUCCESS (0.665s)
[254.286911] [137/161] (780s left) prime_vgem (basic-fence-mmap)
[254.559632] Starting subtest: basic-fence-mmap
[254.603884] Subtest basic-fence-mmap: SUCCESS (0.078s)
[254.804895] [138/161] (780s left) prime_vgem (basic-fence-read)
[255.072344] Starting subtest: basic-fence-read
[255.175503] Subtest basic-fence-read: SUCCESS (0.143s)
[255.373802] [139/161] (780s left) prime_vgem (basic-gtt)
[255.644043] Starting subtest: basic-gtt
[255.665716] Subtest basic-gtt: SUCCESS (0.033s)
[255.859927] [140/161] (779s left) prime_vgem (basic-read)
[256.150284] Starting subtest: basic-read
[256.170974] Subtest basic-read: SUCCESS (0.067s)
[256.391321] [141/161] (779s left) prime_vgem (basic-write)
[256.679690] Starting subtest: basic-write
[256.726802] Subtest basic-write: SUCCESS (0.093s)
[256.927274] [142/161] (779s left) vgem_basic (setversion)
[257.183772] Starting subtest: setversion
[257.226291] Subtest setversion: SUCCESS (0.000s)
[257.401417] [143/161] (778s left) vgem_basic (create)
[257.661213] Starting subtest: create
[257.683209] Subtest create: SUCCESS (0.001s)
[257.858811] [144/161] (778s left) vgem_basic (debugfs)
[258.111854] Starting subtest: debugfs
[258.134194] Subtest debugfs: SUCCESS (0.001s)
[258.308633] [145/161] (778s left) vgem_basic (dmabuf-export)
[258.574518] Starting subtest: dmabuf-export
[258.617250] Subtest dmabuf-export: SUCCESS (0.018s)
[258.791670] [146/161] (778s left) vgem_basic (dmabuf-fence)
[259.062676] Starting subtest: dmabuf-fence
[259.083398] Subtest dmabuf-fence: SUCCESS (0.002s)
[259.261144] [147/161] (777s left) vgem_basic (dmabuf-fence-before)
[259.535477] Starting subtest: dmabuf-fence-before
[259.556334] Subtest dmabuf-fence-before: SUCCESS (0.001s)
[259.732731] [148/161] (777s left) vgem_basic (dmabuf-mmap)
[260.004301] Starting subtest: dmabuf-mmap
[260.025526] Subtest dmabuf-mmap: SUCCESS (0.040s)
[260.204183] [149/161] (777s left) vgem_basic (mmap)
[260.471458] Starting subtest: mmap
[260.494294] Subtest mmap: SUCCESS (0.023s)
[260.668709] [150/161] (776s left) vgem_basic (second-client)
[260.974129] Starting subtest: second-client
[261.028241] Subtest second-client: SUCCESS (0.032s)
[261.220149] [151/161] (776s left) vgem_basic (sysfs)
[261.563421] Starting subtest: sysfs
[261.590771] Subtest sysfs: SUCCESS (0.001s)
[261.785644] [152/161] (776s left) core_hotunplug (unbind-rebind)
[262.155332] Starting subtest: unbind-rebind
[266.741987] Subtest unbind-rebind: SUCCESS (4.591s)
[266.919946] [153/161] (771s left) vgem_basic (unload)
[267.165664] Starting subtest: unload
[296.525798] Subtest unload: SUCCESS (29.202s)
[296.703343] [154/161] (741s left) i915_module_load (reload)
[296.953804] Starting subtest: reload
[303.090549] Subtest reload: SUCCESS (6.171s)
[303.356856] [155/161] (735s left) gem_lmem_swapping (basic)
[303.678471] Subtest basic: SKIP (0.000s)
[303.873326] [156/161] (735s left) gem_lmem_swapping (parallel-random-engines)
[304.151518] Subtest parallel-random-engines: SKIP (0.000s)
[304.324556] [157/161] (734s left) gem_lmem_swapping (random-engines)
[304.617428] Subtest random-engines: SKIP (0.000s)
[304.803055] [158/161] (734s left) gem_lmem_swapping (verify-random)
[305.104357] Subtest verify-random: SKIP (0.000s)
[305.275622] [159/161] (734s left) i915_pm_rpm (module-reload)
[307.474344] Starting subtest: module-reload
[322.344111] Subtest module-reload: SUCCESS (14.892s)
[322.470555] [FACT i915_pm_rpm (module-reload)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[322.474369] [FACT i915_pm_rpm (module-reload)] deleted: kernel.kmod_is_loaded.i915: true
[322.498685] [160/161] (717s left) i915_selftest (live)
[322.774126] Starting subtest: live
[322.794809] Starting dynamic subtest: sanitycheck
[326.579782] Dynamic subtest sanitycheck: SUCCESS (3.802s)
[326.621278] Starting dynamic subtest: uncore
[330.525097] Dynamic subtest uncore: SUCCESS (3.940s)
[330.584603] Starting dynamic subtest: workarounds
[334.553368] Dynamic subtest workarounds: SUCCESS (4.020s)
[334.602871] Starting dynamic subtest: gt_engines
[338.970299] Dynamic subtest gt_engines: SUCCESS (4.410s)
[339.031377] Starting dynamic subtest: gt_timelines
[362.583507] Dynamic subtest gt_timelines: SUCCESS (23.616s)
[362.624862] Starting dynamic subtest: gt_contexts
[366.800415] Dynamic subtest gt_contexts: SUCCESS (4.212s)
[366.859990] Starting dynamic subtest: gt_lrc
[373.496543] Dynamic subtest gt_lrc: SUCCESS (6.692s)
[373.540202] Starting dynamic subtest: gt_mocs
[377.629758] Dynamic subtest gt_mocs: SUCCESS (4.127s)
[377.671113] Starting dynamic subtest: gt_pm
[390.467585] Dynamic subtest gt_pm: SUCCESS (12.835s)
[390.510953] Starting dynamic subtest: gt_heartbeat
[394.566998] Dynamic subtest gt_heartbeat: SUCCESS (4.094s)
[394.627307] Starting dynamic subtest: gt_tlb
[399.479132] Dynamic subtest gt_tlb: SUCCESS (4.901s)
[399.539830] Starting dynamic subtest: requests
[409.964342] Dynamic subtest requests: SUCCESS (10.485s)
[410.008312] Starting dynamic subtest: migrate
[417.305120] Dynamic subtest migrate: SUCCESS (7.337s)
[417.346917] Starting dynamic subtest: active
[421.292425] Dynamic subtest active: SUCCESS (3.983s)
[421.351516] Starting dynamic subtest: objects
[427.640055] Dynamic subtest objects: SUCCESS (6.341s)
[427.682276] Starting dynamic subtest: mman
[437.281927] Dynamic subtest mman: SUCCESS (9.637s)
[437.340452] Starting dynamic subtest: dmabuf
[441.115836] Dynamic subtest dmabuf: SUCCESS (3.829s)
[441.201789] Starting dynamic subtest: vma
[445.174903] Dynamic subtest vma: SUCCESS (4.055s)
[445.230120] Starting dynamic subtest: coherency
[452.815562] Dynamic subtest coherency: SUCCESS (7.635s)
[452.874857] Starting dynamic subtest: gtt
[464.348077] Dynamic subtest gtt: SUCCESS (11.528s)
[464.438973] Starting dynamic subtest: gem
[469.968121] Dynamic subtest gem: SUCCESS (5.618s)
[470.013476] Starting dynamic subtest: evict
[478.755567] Dynamic subtest evict: SUCCESS (8.782s)
[478.796967] Starting dynamic subtest: hugepages
[489.238389] Dynamic subtest hugepages: SUCCESS (10.476s)
[489.298448] Starting dynamic subtest: gem_contexts
[515.617244] Dynamic subtest gem_contexts: SUCCESS (26.374s)
[515.678859] Starting dynamic subtest: client
[519.489129] Dynamic subtest client: SUCCESS (3.867s)
[519.532994] Starting dynamic subtest: gem_migrate
[523.256935] Dynamic subtest gem_migrate: SUCCESS (3.762s)
[523.323342] Starting dynamic subtest: reset
[537.889245] Dynamic subtest reset: SUCCESS (14.627s)
[537.933138] Starting dynamic subtest: memory_region
[543.684273] Dynamic subtest memory_region: SUCCESS (5.792s)
[543.768686] Starting dynamic subtest: hangcheck
[570.812837] Dynamic subtest hangcheck: SUCCESS (27.126s)
[570.872924] Starting dynamic subtest: execlists
[585.950881] Dynamic subtest execlists: SUCCESS (15.131s)
[586.011329] Starting dynamic subtest: ring_submission
[589.923149] Dynamic subtest ring_submission: SUCCESS (3.971s)
[589.988346] Starting dynamic subtest: perf
[594.313892] Dynamic subtest perf: SUCCESS (4.379s)
[594.372489] Starting dynamic subtest: slpc
[598.267392] Dynamic subtest slpc: SUCCESS (3.953s)
[598.324709] Starting dynamic subtest: guc
[602.303835] Dynamic subtest guc: SUCCESS (4.034s)
[602.345733] Starting dynamic subtest: guc_multi_lrc
[606.026941] Dynamic subtest guc_multi_lrc: SUCCESS (3.720s)
[606.068675] Starting dynamic subtest: guc_hang
[609.909381] Dynamic subtest guc_hang: SUCCESS (3.874s)
[609.952728] Starting dynamic subtest: late_gt_pm
[613.717670] Dynamic subtest late_gt_pm: SUCCESS (3.806s)
[613.738668] Subtest live: SUCCESS (290.942s)
[613.896318] [161/161] (425s left) dmabuf (all-tests)
�������������������������������������������������������������������������������������������������������������������������������������������������������������������������������������������������������������������������������������