[40.367480] Initializing watchdogs
[40.367615]   /dev/watchdog0
[40.398461] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:1916 Intel Skylake (Gen9) Skylake GT2 [HD Graphics 520]
[40.407173] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[40.414641] [001/162] (960s left) i915_module_load (load)
[40.493380] Starting subtest: load
[42.214771] Subtest load: SUCCESS (1.722s)
[42.270170] [FACT i915_module_load (load)] changed: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 -> card1
[42.273433] [FACT i915_module_load (load)] new: kernel.kmod_is_loaded.i915: true
[42.277490] [002/162] (958s left) core_auth (basic-auth)
[42.363381] Starting subtest: basic-auth
[42.364418] Subtest basic-auth: SUCCESS (0.001s)
[42.526488] [003/162] (958s left) core_debugfs (read-all-entries)
[42.634207] Starting subtest: read-all-entries
[42.755841] Subtest read-all-entries: SUCCESS (0.125s)
[42.903773] [004/162] (958s left) core_sysfs (read-all-entries)
[42.990403] Starting subtest: read-all-entries
[42.997349] Subtest read-all-entries: SUCCESS (0.008s)
[43.121451] [005/162] (958s left) fbdev (eof)
[43.219344] Starting subtest: eof
[43.220426] Subtest eof: SUCCESS (0.001s)
[43.312902] [006/162] (957s left) fbdev (info)
[43.378424] Starting subtest: info
[43.379593] Subtest info: SUCCESS (0.000s)
[43.479927] [007/162] (957s left) fbdev (nullptr)
[43.551463] Starting subtest: nullptr
[43.552569] Subtest nullptr: SUCCESS (0.000s)
[43.648942] [008/162] (957s left) fbdev (read)
[43.717586] Starting subtest: read
[44.628073] Subtest read: SUCCESS (0.909s)
[44.730984] [009/162] (956s left) fbdev (write)
[44.801426] Starting subtest: write
[45.280937] Subtest write: SUCCESS (0.471s)
[45.367157] [010/162] (956s left) gem_basic (bad-close)
[45.436518] Starting subtest: bad-close
[45.438202] Subtest bad-close: SUCCESS (0.000s)
[45.594655] [011/162] (956s left) gem_basic (create-close)
[45.661364] Starting subtest: create-close
[45.663133] Subtest create-close: SUCCESS (0.000s)
[45.829297] [012/162] (955s left) gem_basic (create-fd-close)
[45.897096] Starting subtest: create-fd-close
[45.899101] Subtest create-fd-close: SUCCESS (0.000s)
[46.068108] [013/162] (955s left) gem_busy (busy@all-engines)
[46.162523] Starting subtest: busy
[46.163476] Starting dynamic subtest: all-engines
[46.229711] Dynamic subtest all-engines: SUCCESS (0.067s)
[46.231227] Subtest busy: SUCCESS (0.067s)
[46.729430] [014/162] (955s left) gem_close_race (basic-process)
[46.820270] Starting subtest: basic-process
[46.894717] Subtest basic-process: SUCCESS (0.075s)
[47.160266] [015/162] (954s left) gem_close_race (basic-threads)
[47.248803] Starting subtest: basic-threads
[48.519840] Subtest basic-threads: SUCCESS (1.271s)
[48.833367] [016/162] (953s left) gem_ctx_create (basic)
[48.917659] Starting subtest: basic
[48.918818] Subtest basic: SUCCESS (0.000s)
[49.186921] [017/162] (952s left) gem_ctx_create (basic-files)
[49.270094] Starting subtest: basic-files
[51.289400] Subtest basic-files: SUCCESS (2.019s)
[51.613702] [018/162] (950s left) gem_ctx_exec (basic)
[51.685790] Starting subtest: basic
[51.692786] Subtest basic: SUCCESS (0.007s)
[51.878398] [019/162] (950s left) gem_exec_basic (basic)
[51.954455] Starting subtest: basic
[51.955845] Starting dynamic subtest: rcs0-smem
[51.958335] Dynamic subtest rcs0-smem: SUCCESS (0.003s)
[51.971913] Starting dynamic subtest: bcs0-smem
[51.973273] Dynamic subtest bcs0-smem: SUCCESS (0.002s)
[51.985625] Starting dynamic subtest: vcs0-smem
[51.986924] Dynamic subtest vcs0-smem: SUCCESS (0.001s)
[51.999509] Starting dynamic subtest: vecs0-smem
[52.000859] Dynamic subtest vecs0-smem: SUCCESS (0.001s)
[52.002096] Subtest basic: SUCCESS (0.008s)
[52.269828] [020/162] (949s left) gem_exec_create (basic)
[52.358525] Starting subtest: basic
[52.359554] Starting dynamic subtest: smem
[54.408561] Dynamic subtest smem: SUCCESS (1.979s)
[54.409553] Subtest basic: SUCCESS (1.979s)
[54.693920] [021/162] (947s left) gem_exec_fence (basic-busy)
[54.934574] Starting subtest: basic-busy
[54.935807] Starting dynamic subtest: rcs0
[54.962370] Dynamic subtest rcs0: SUCCESS (0.027s)
[54.975693] Starting dynamic subtest: bcs0
[54.989418] Dynamic subtest bcs0: SUCCESS (0.026s)
[55.002987] Starting dynamic subtest: vcs0
[55.015366] Dynamic subtest vcs0: SUCCESS (0.025s)
[55.029050] Starting dynamic subtest: vecs0
[55.037501] Dynamic subtest vecs0: SUCCESS (0.021s)
[55.038546] Subtest basic-busy: SUCCESS (0.100s)
[55.832904] [FACT gem_exec_fence (basic-busy)] new: kernel.kmod_is_loaded.vgem: true
[55.835891] [022/162] (946s left) gem_exec_fence (basic-wait)
[56.073970] Starting subtest: basic-wait
[56.075680] Starting dynamic subtest: rcs0
[56.112461] Dynamic subtest rcs0: SUCCESS (0.038s)
[56.130251] Starting dynamic subtest: bcs0
[56.141352] Dynamic subtest bcs0: SUCCESS (0.028s)
[56.156880] Starting dynamic subtest: vcs0
[56.163455] Dynamic subtest vcs0: SUCCESS (0.021s)
[56.176920] Starting dynamic subtest: vecs0
[56.188291] Dynamic subtest vecs0: SUCCESS (0.024s)
[56.189489] Subtest basic-wait: SUCCESS (0.113s)
[56.940886] [023/162] (945s left) gem_exec_fence (basic-await)
[57.178694] Starting subtest: basic-await
[57.181120] Starting dynamic subtest: rcs0
[57.289491] Dynamic subtest rcs0: SUCCESS (0.109s)
[57.303406] Starting dynamic subtest: bcs0
[57.387513] Dynamic subtest bcs0: SUCCESS (0.096s)
[57.405287] Starting dynamic subtest: vcs0
[57.491931] Dynamic subtest vcs0: SUCCESS (0.101s)
[57.506943] Starting dynamic subtest: vecs0
[57.595979] Dynamic subtest vecs0: SUCCESS (0.102s)
[57.597423] Subtest basic-await: SUCCESS (0.410s)
[58.445629] [024/162] (944s left) gem_exec_fence (nb-await)
[58.668593] Starting subtest: nb-await
[58.669996] Starting dynamic subtest: rcs0
[58.743182] Dynamic subtest rcs0: SUCCESS (0.074s)
[58.771779] Starting dynamic subtest: bcs0
[58.827219] Dynamic subtest bcs0: SUCCESS (0.079s)
[58.887531] Starting dynamic subtest: vcs0
[58.936271] Dynamic subtest vcs0: SUCCESS (0.104s)
[58.997490] Starting dynamic subtest: vecs0
[59.042201] Dynamic subtest vecs0: SUCCESS (0.104s)
[59.045654] Subtest nb-await: SUCCESS (0.368s)
[59.790651] [025/162] (942s left) gem_exec_gttfill (basic)
[59.885246] Starting subtest: basic
[65.305252] Subtest basic: SUCCESS (5.364s)
[65.647992] [026/162] (937s left) gem_exec_parallel (engines)
[65.809115] Starting subtest: engines
[65.809999] Starting dynamic subtest: basic
[68.969930] Dynamic subtest basic: SUCCESS (3.136s)
[68.983804] Starting dynamic subtest: contexts
[77.600944] Dynamic subtest contexts: SUCCESS (8.594s)
[77.618449] Starting dynamic subtest: fds
[85.231435] Dynamic subtest fds: SUCCESS (7.645s)
[85.246284] Starting dynamic subtest: userptr
[87.775843] Dynamic subtest userptr: SUCCESS (2.523s)
[87.777065] Subtest engines: SUCCESS (21.899s)
[88.115334] [027/162] (914s left) gem_exec_store (basic)
[88.241382] Starting subtest: basic
[88.316133] Subtest basic: SUCCESS (0.075s)
[88.674178] [028/162] (914s left) gem_flink_basic (bad-flink)
[88.742248] Starting subtest: bad-flink
[88.743276] Subtest bad-flink: SUCCESS (0.000s)
[88.872400] [029/162] (914s left) gem_flink_basic (bad-open)
[88.940710] Starting subtest: bad-open
[88.941988] Subtest bad-open: SUCCESS (0.000s)
[89.079374] [030/162] (914s left) gem_flink_basic (basic)
[89.145470] Starting subtest: basic
[89.146350] Subtest basic: SUCCESS (0.000s)
[89.318215] [031/162] (913s left) gem_flink_basic (double-flink)
[89.387517] Starting subtest: double-flink
[89.388519] Subtest double-flink: SUCCESS (0.000s)
[89.586557] [032/162] (913s left) gem_flink_basic (flink-lifetime)
[89.652158] Starting subtest: flink-lifetime
[89.656218] Subtest flink-lifetime: SUCCESS (0.003s)
[89.816298] [033/162] (913s left) gem_huc_copy (huc-copy)
[89.893771] Starting subtest: huc-copy
[89.895805] Subtest huc-copy: SKIP (0.000s)
[90.097209] [034/162] (913s left) gem_linear_blits (basic)
[90.303571] Starting subtest: basic
[90.317478] Subtest basic: SUCCESS (0.015s)
[90.545260] [035/162] (913s left) gem_mmap (basic)
[90.683630] Starting subtest: basic
[90.688430] Subtest basic: SUCCESS (0.000s)
[90.847705] [036/162] (912s left) gem_mmap_gtt (basic)
[90.917488] Starting subtest: basic
[90.918647] Subtest basic: SUCCESS (0.001s)
[91.046475] [037/162] (912s left) gem_render_linear_blits (basic)
[91.124624] Starting subtest: basic
[91.176342] Subtest basic: SUCCESS (0.052s)
[91.277158] [038/162] (912s left) gem_render_tiled_blits (basic)
[91.357348] Starting subtest: basic
[91.409556] Subtest basic: SUCCESS (0.052s)
[91.508978] [039/162] (912s left) gem_ringfill (basic-all)
[91.787352] Starting subtest: basic-all
[92.956805] Subtest basic-all: SUCCESS (1.160s)
[93.175516] [040/162] (910s left) gem_softpin (allocator-basic)
[93.252548] Starting subtest: allocator-basic
[93.439884] Subtest allocator-basic: SUCCESS (0.179s)
[93.636551] [041/162] (910s left) gem_softpin (allocator-basic-reserve)
[93.711234] Starting subtest: allocator-basic-reserve
[93.885697] Subtest allocator-basic-reserve: SUCCESS (0.165s)
[94.067997] [042/162] (910s left) gem_softpin (safe-alignment)
[94.145438] Starting subtest: safe-alignment
[94.164704] Subtest safe-alignment: SUCCESS (0.019s)
[94.350313] [043/162] (909s left) gem_sync (basic-all)
[94.437264] Starting subtest: basic-all
[96.537845] Subtest basic-all: SUCCESS (2.099s)
[96.816162] [044/162] (907s left) gem_sync (basic-each)
[96.902327] Starting subtest: basic-each
[99.107756] Subtest basic-each: SUCCESS (2.204s)
[99.514974] [045/162] (904s left) gem_tiled_blits (basic)
[99.674752] Starting subtest: basic
[99.696232] Subtest basic: SUCCESS (0.022s)
[99.889325] [046/162] (904s left) gem_tiled_fence_blits (basic)
[100.129977] Starting subtest: basic
[100.143086] Subtest basic: SUCCESS (0.013s)
[100.343517] [047/162] (904s left) gem_tiled_pread_basic
[100.763691] [048/162] (903s left) gem_wait (busy@all-engines)
[100.857587] Starting subtest: busy
[100.858661] Starting dynamic subtest: all-engines
[101.395334] Dynamic subtest all-engines: SUCCESS (0.537s)
[101.396335] Subtest busy: SUCCESS (0.538s)
[101.704281] [049/162] (903s left) gem_wait (wait@all-engines)
[101.795452] Starting subtest: wait
[101.796536] Starting dynamic subtest: all-engines
[102.846332] Dynamic subtest all-engines: SUCCESS (1.049s)
[102.849877] Subtest wait: SUCCESS (1.050s)
[103.191027] [050/162] (901s left) i915_getparams_basic (basic-eu-total)
[103.273401] Starting subtest: basic-eu-total
[103.275366] Subtest basic-eu-total: SUCCESS (0.000s)
[103.391795] [051/162] (901s left) i915_getparams_basic (basic-subslice-total)
[103.462334] Starting subtest: basic-subslice-total
[103.464538] Subtest basic-subslice-total: SUCCESS (0.000s)
[103.611306] [052/162] (901s left) i915_hangman (error-state-basic)
[103.704693] Starting subtest: error-state-basic
[103.716133] Subtest error-state-basic: SUCCESS (0.010s)
[103.853334] [053/162] (901s left) i915_pciid
[104.096904] [054/162] (901s left) intel_hwmon (hwmon-read)
[104.168222] Subtest hwmon-read: SKIP (0.000s)
[104.260657] [055/162] (901s left) intel_hwmon (hwmon-write)
[104.329341] Subtest hwmon-write: SKIP (0.000s)
[104.411529] [056/162] (900s left) kms_addfb_basic (addfb25-4-tiled)
[104.551799] Starting subtest: addfb25-4-tiled
[104.552874] Subtest addfb25-4-tiled: SUCCESS (0.000s)
[104.735996] [057/162] (900s left) kms_addfb_basic (addfb25-bad-modifier)
[104.858852] Starting subtest: addfb25-bad-modifier
[104.860172] Subtest addfb25-bad-modifier: SUCCESS (0.000s)
[105.023098] [058/162] (900s left) kms_addfb_basic (addfb25-framebuffer-vs-set-tiling)
[105.146984] Starting subtest: addfb25-framebuffer-vs-set-tiling
[105.148155] Subtest addfb25-framebuffer-vs-set-tiling: SUCCESS (0.000s)
[105.312635] [059/162] (900s left) kms_addfb_basic (addfb25-modifier-no-flag)
[105.435467] Starting subtest: addfb25-modifier-no-flag
[105.436489] Subtest addfb25-modifier-no-flag: SUCCESS (0.000s)
[105.624507] [060/162] (900s left) kms_addfb_basic (addfb25-x-tiled-legacy)
[105.750233] Starting subtest: addfb25-x-tiled-legacy
[105.751131] Subtest addfb25-x-tiled-legacy: SUCCESS (0.000s)
[105.927970] [061/162] (899s left) kms_addfb_basic (addfb25-x-tiled-mismatch-legacy)
[106.052456] Starting subtest: addfb25-x-tiled-mismatch-legacy
[106.053637] Subtest addfb25-x-tiled-mismatch-legacy: SUCCESS (0.000s)
[106.210970] [062/162] (899s left) kms_addfb_basic (addfb25-yf-tiled-legacy)
[106.337464] Starting subtest: addfb25-yf-tiled-legacy
[106.338489] Subtest addfb25-yf-tiled-legacy: SUCCESS (0.000s)
[106.528198] [063/162] (899s left) kms_addfb_basic (addfb25-y-tiled-legacy)
[106.651361] Starting subtest: addfb25-y-tiled-legacy
[106.652397] Subtest addfb25-y-tiled-legacy: SUCCESS (0.000s)
[106.836129] [064/162] (899s left) kms_addfb_basic (addfb25-y-tiled-small-legacy)
[106.959246] Starting subtest: addfb25-y-tiled-small-legacy
[106.960284] Subtest addfb25-y-tiled-small-legacy: SUCCESS (0.000s)
[107.135915] [065/162] (898s left) kms_addfb_basic (bad-pitch-0)
[107.205018] Starting subtest: bad-pitch-0
[107.206064] Subtest bad-pitch-0: SUCCESS (0.000s)
[107.450172] [066/162] (898s left) kms_addfb_basic (bad-pitch-1024)
[107.518827] Starting subtest: bad-pitch-1024
[107.519919] Subtest bad-pitch-1024: SUCCESS (0.000s)
[107.756976] [067/162] (898s left) kms_addfb_basic (bad-pitch-128)
[107.824711] Starting subtest: bad-pitch-128
[107.825901] Subtest bad-pitch-128: SUCCESS (0.000s)
[108.080250] [068/162] (898s left) kms_addfb_basic (bad-pitch-256)
[108.150385] Starting subtest: bad-pitch-256
[108.151338] Subtest bad-pitch-256: SUCCESS (0.000s)
[108.360302] [069/162] (898s left) kms_addfb_basic (bad-pitch-32)
[108.428261] Starting subtest: bad-pitch-32
[108.429209] Subtest bad-pitch-32: SUCCESS (0.000s)
[108.647304] [070/162] (897s left) kms_addfb_basic (bad-pitch-63)
[108.716053] Starting subtest: bad-pitch-63
[108.717122] Subtest bad-pitch-63: SUCCESS (0.000s)
[108.949845] [071/162] (897s left) kms_addfb_basic (bad-pitch-65536)
[109.017797] Starting subtest: bad-pitch-65536
[109.018876] Subtest bad-pitch-65536: SUCCESS (0.000s)
[109.256405] [072/162] (897s left) kms_addfb_basic (bad-pitch-999)
[109.324282] Starting subtest: bad-pitch-999
[109.325238] Subtest bad-pitch-999: SUCCESS (0.000s)
[109.534443] [073/162] (897s left) kms_addfb_basic (basic)
[109.602599] Starting subtest: basic
[109.603674] Subtest basic: SUCCESS (0.000s)
[109.828273] [074/162] (897s left) kms_addfb_basic (basic-x-tiled-legacy)
[109.897577] Starting subtest: basic-x-tiled-legacy
[109.898723] Subtest basic-x-tiled-legacy: SUCCESS (0.000s)
[110.152271] [075/162] (896s left) kms_addfb_basic (basic-y-tiled-legacy)
[110.221952] Starting subtest: basic-y-tiled-legacy
[110.222876] Subtest basic-y-tiled-legacy: SUCCESS (0.000s)
[110.463191] [076/162] (896s left) kms_addfb_basic (bo-too-small)
[110.587760] Starting subtest: bo-too-small
[110.588894] Subtest bo-too-small: SUCCESS (0.000s)
[110.759300] [077/162] (896s left) kms_addfb_basic (bo-too-small-due-to-tiling)
[110.881485] Starting subtest: bo-too-small-due-to-tiling
[110.882497] Subtest bo-too-small-due-to-tiling: SUCCESS (0.000s)
[111.068318] [078/162] (896s left) kms_addfb_basic (clobberred-modifier)
[111.135998] Starting subtest: clobberred-modifier
[111.137217] Subtest clobberred-modifier: SUCCESS (0.000s)
[111.375390] [079/162] (895s left) kms_addfb_basic (framebuffer-vs-set-tiling)
[111.445037] Starting subtest: framebuffer-vs-set-tiling
[111.446024] Subtest framebuffer-vs-set-tiling: SUCCESS (0.000s)
[111.697793] [080/162] (895s left) kms_addfb_basic (invalid-get-prop)
[111.766838] Starting subtest: invalid-get-prop
[111.767926] Subtest invalid-get-prop: SUCCESS (0.000s)
[112.001687] [081/162] (895s left) kms_addfb_basic (invalid-get-prop-any)
[112.069496] Starting subtest: invalid-get-prop-any
[112.070427] Subtest invalid-get-prop-any: SUCCESS (0.000s)
[112.280770] [082/162] (895s left) kms_addfb_basic (invalid-set-prop)
[112.350116] Starting subtest: invalid-set-prop
[112.351136] Subtest invalid-set-prop: SUCCESS (0.000s)
[112.595874] [083/162] (894s left) kms_addfb_basic (invalid-set-prop-any)
[112.664397] Starting subtest: invalid-set-prop-any
[112.665326] Subtest invalid-set-prop-any: SUCCESS (0.000s)
[112.884751] [084/162] (894s left) kms_addfb_basic (no-handle)
[112.954099] Starting subtest: no-handle
[112.955110] Subtest no-handle: SUCCESS (0.000s)
[113.172967] [085/162] (894s left) kms_addfb_basic (size-max)
[113.300169] Starting subtest: size-max
[113.301110] Subtest size-max: SUCCESS (0.000s)
[113.445788] [086/162] (894s left) kms_addfb_basic (small-bo)
[113.569716] Starting subtest: small-bo
[113.570785] Subtest small-bo: SUCCESS (0.000s)
[113.787693] [087/162] (894s left) kms_addfb_basic (tile-pitch-mismatch)
[113.854287] Starting subtest: tile-pitch-mismatch
[113.855353] Subtest tile-pitch-mismatch: SUCCESS (0.000s)
[114.050653] [088/162] (893s left) kms_addfb_basic (too-high)
[114.173747] Starting subtest: too-high
[114.174868] Subtest too-high: SUCCESS (0.001s)
[114.324608] [089/162] (893s left) kms_addfb_basic (too-wide)
[114.447436] Starting subtest: too-wide
[114.448492] Subtest too-wide: SUCCESS (0.000s)
[114.630078] [090/162] (893s left) kms_addfb_basic (unused-handle)
[114.697199] Starting subtest: unused-handle
[114.698384] Subtest unused-handle: SUCCESS (0.000s)
[114.940486] [091/162] (893s left) kms_addfb_basic (unused-modifier)
[115.007561] Starting subtest: unused-modifier
[115.008625] Subtest unused-modifier: SUCCESS (0.000s)
[115.205383] [092/162] (893s left) kms_addfb_basic (unused-offsets)
[115.273688] Starting subtest: unused-offsets
[115.275348] Subtest unused-offsets: SUCCESS (0.000s)
[115.504511] [093/162] (892s left) kms_addfb_basic (unused-pitches)
[115.573418] Starting subtest: unused-pitches
[115.574383] Subtest unused-pitches: SUCCESS (0.000s)
[115.811876] [094/162] (892s left) kms_busy (basic)
[115.940237] Starting subtest: basic
[115.941348] Starting dynamic subtest: flip
[116.831814] Dynamic subtest flip: SUCCESS (0.889s)
[116.850096] Starting dynamic subtest: modeset
[120.601251] Dynamic subtest modeset: SUCCESS (3.767s)
[120.603907] Subtest basic: SUCCESS (4.660s)
[121.634819] [095/162] (886s left) kms_prop_blob (basic)
[121.704630] Starting subtest: basic
[121.705743] Subtest basic: SUCCESS (0.000s)
[121.813199] [096/162] (886s left) kms_cursor_legacy (basic-busy-flip-before-cursor-atomic)
[121.939241] Starting subtest: basic-busy-flip-before-cursor-atomic
[121.940975] Subtest basic-busy-flip-before-cursor-atomic: SKIP (0.000s)
[122.083311] [097/162] (886s left) kms_cursor_legacy (basic-busy-flip-before-cursor-legacy)
[122.205498] Starting subtest: basic-busy-flip-before-cursor-legacy
[122.207583] Subtest basic-busy-flip-before-cursor-legacy: SKIP (0.000s)
[122.362473] [098/162] (886s left) kms_cursor_legacy (basic-flip-after-cursor-atomic)
[122.484502] Starting subtest: basic-flip-after-cursor-atomic
[123.762653] Subtest basic-flip-after-cursor-atomic: SUCCESS (1.277s)
[124.688141] [099/162] (884s left) kms_cursor_legacy (basic-flip-after-cursor-legacy)
[124.812307] Starting subtest: basic-flip-after-cursor-legacy
[126.154941] Subtest basic-flip-after-cursor-legacy: SUCCESS (1.340s)
[127.124335] [100/162] (881s left) kms_cursor_legacy (basic-flip-after-cursor-varying-size)
[127.249236] Starting subtest: basic-flip-after-cursor-varying-size
[128.561379] Subtest basic-flip-after-cursor-varying-size: SUCCESS (1.311s)
[129.462209] [101/162] (879s left) kms_cursor_legacy (basic-flip-before-cursor-atomic)
[129.583163] Starting subtest: basic-flip-before-cursor-atomic
[130.837309] Subtest basic-flip-before-cursor-atomic: SUCCESS (1.251s)
[131.763015] [102/162] (877s left) kms_cursor_legacy (basic-flip-before-cursor-legacy)
[131.883335] Starting subtest: basic-flip-before-cursor-legacy
[133.191684] Subtest basic-flip-before-cursor-legacy: SUCCESS (1.307s)
[134.092485] [103/162] (875s left) kms_cursor_legacy (basic-flip-before-cursor-varying-size)
[134.213410] Starting subtest: basic-flip-before-cursor-varying-size
[135.518483] Subtest basic-flip-before-cursor-varying-size: SUCCESS (1.300s)
[136.458532] [104/162] (872s left) kms_dsc (dsc-basic)
[136.582625] Subtest dsc-basic: SKIP (0.000s)
[136.662258] [105/162] (872s left) kms_flip (basic-flip-vs-dpms)
[136.785291] Starting subtest: basic-flip-vs-dpms
[136.787618] Starting dynamic subtest: A-eDP1
[139.606941] Dynamic subtest A-eDP1: SUCCESS (2.817s)
[139.682337] Starting dynamic subtest: B-eDP1
[141.887189] Dynamic subtest B-eDP1: SUCCESS (2.275s)
[141.957701] Starting dynamic subtest: C-eDP1
[144.179246] Dynamic subtest C-eDP1: SUCCESS (2.283s)
[144.191688] Subtest basic-flip-vs-dpms: SUCCESS (7.404s)
[145.206801] [106/162] (864s left) kms_flip (basic-flip-vs-modeset)
[145.334253] Starting subtest: basic-flip-vs-modeset
[145.338594] Starting dynamic subtest: A-eDP1
[148.027673] Dynamic subtest A-eDP1: SUCCESS (2.680s)
[148.106735] Starting dynamic subtest: B-eDP1
[150.398668] Dynamic subtest B-eDP1: SUCCESS (2.371s)
[150.457216] Starting dynamic subtest: C-eDP1
[152.698852] Dynamic subtest C-eDP1: SUCCESS (2.291s)
[152.706490] Subtest basic-flip-vs-modeset: SUCCESS (7.371s)
[153.674060] [107/162] (855s left) kms_flip (basic-flip-vs-wf_vblank)
[153.798834] Starting subtest: basic-flip-vs-wf_vblank
[153.801344] Starting dynamic subtest: A-eDP1
[155.961145] Dynamic subtest A-eDP1: SUCCESS (2.160s)
[155.983828] Starting dynamic subtest: B-eDP1
[158.145074] Dynamic subtest B-eDP1: SUCCESS (2.182s)
[158.168146] Starting dynamic subtest: C-eDP1
[160.278990] Dynamic subtest C-eDP1: SUCCESS (2.132s)
[160.282740] Subtest basic-flip-vs-wf_vblank: SUCCESS (6.485s)
[161.611470] [108/162] (848s left) kms_flip (basic-plain-flip)
[161.734663] Starting subtest: basic-plain-flip
[161.737193] Starting dynamic subtest: A-eDP1
[163.600547] Dynamic subtest A-eDP1: SUCCESS (1.856s)
[163.665135] Starting dynamic subtest: B-eDP1
[165.517406] Dynamic subtest B-eDP1: SUCCESS (1.913s)
[165.578165] Starting dynamic subtest: C-eDP1
[167.430102] Dynamic subtest C-eDP1: SUCCESS (1.910s)
[167.433394] Subtest basic-plain-flip: SUCCESS (5.700s)
[168.749976] [109/162] (841s left) kms_force_connector_basic (force-connector-state)
[168.856416] Starting subtest: force-connector-state
[169.444142] Subtest force-connector-state: SUCCESS (0.586s)
[170.739052] [110/162] (839s left) kms_force_connector_basic (force-edid)
[170.836669] Starting subtest: force-edid
[170.872870] Subtest force-edid: SUCCESS (0.035s)
[171.091436] [111/162] (838s left) kms_force_connector_basic (force-load-detect)
[171.188213] Starting subtest: force-load-detect
[171.190341] Subtest force-load-detect: SKIP (0.000s)
[171.371184] [112/162] (838s left) kms_force_connector_basic (prune-stale-modes)
[171.473055] Starting subtest: prune-stale-modes
[171.506228] Subtest prune-stale-modes: SUCCESS (0.035s)
[171.723523] [113/162] (838s left) kms_frontbuffer_tracking (basic)
[171.854559] Starting subtest: basic
[175.580340] Subtest basic: SUCCESS (3.725s)
[175.792851] [114/162] (834s left) kms_hdmi_inject (inject-audio)
[176.184499] Starting subtest: inject-audio
[176.315971] Subtest inject-audio: SUCCESS (0.133s)
[177.132220] [115/162] (833s left) kms_pipe_crc_basic (compare-crc-sanitycheck-xr24)
[177.258505] Starting subtest: compare-crc-sanitycheck-xr24
[177.261110] Starting dynamic subtest: pipe-A-eDP-1
[178.054905] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.787s)
[178.137386] Starting dynamic subtest: pipe-B-eDP-1
[179.565854] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.485s)
[179.643459] Starting dynamic subtest: pipe-C-eDP-1
[181.077931] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.493s)
[181.080970] Subtest compare-crc-sanitycheck-xr24: SUCCESS (3.818s)
[181.989502] [116/162] (828s left) kms_pipe_crc_basic (compare-crc-sanitycheck-nv12)
[182.111560] Starting subtest: compare-crc-sanitycheck-nv12
[182.114077] Starting dynamic subtest: pipe-A-eDP-1
[182.115896] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[182.132048] Starting dynamic subtest: pipe-B-eDP-1
[182.133871] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[182.148279] Starting dynamic subtest: pipe-C-eDP-1
[182.150483] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[182.152249] Subtest compare-crc-sanitycheck-nv12: SKIP (0.013s)
[182.257643] [117/162] (828s left) kms_pipe_crc_basic (hang-read-crc)
[182.382357] Starting subtest: hang-read-crc
[182.383370] Starting dynamic subtest: pipe-A-eDP-1
[184.847740] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.461s)
[184.927036] Starting dynamic subtest: pipe-B-eDP-1
[187.883892] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.022s)
[187.959525] Starting dynamic subtest: pipe-C-eDP-1
[191.114054] Dynamic subtest pipe-C-eDP-1: SUCCESS (3.219s)
[191.121583] Subtest hang-read-crc: SUCCESS (8.736s)
[192.033244] [118/162] (818s left) kms_pipe_crc_basic (nonblocking-crc)
[192.162220] Starting subtest: nonblocking-crc
[192.163254] Starting dynamic subtest: pipe-A-eDP-1
[193.172915] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.008s)
[193.200102] Starting dynamic subtest: pipe-B-eDP-1
[194.905699] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.723s)
[194.979518] Starting dynamic subtest: pipe-C-eDP-1
[196.615583] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.694s)
[196.618156] Subtest nonblocking-crc: SUCCESS (4.453s)
[197.535340] [119/162] (813s left) kms_pipe_crc_basic (nonblocking-crc-frame-sequence)
[197.666948] Starting subtest: nonblocking-crc-frame-sequence
[197.669602] Starting dynamic subtest: pipe-A-eDP-1
[198.681675] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.007s)
[198.766191] Starting dynamic subtest: pipe-B-eDP-1
[200.407275] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.711s)
[200.485708] Starting dynamic subtest: pipe-C-eDP-1
[202.105556] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.686s)
[202.108416] Subtest nonblocking-crc-frame-sequence: SUCCESS (4.440s)
[203.011727] [120/162] (807s left) kms_pipe_crc_basic (read-crc)
[203.138439] Starting subtest: read-crc
[203.139423] Starting dynamic subtest: pipe-A-eDP-1
[203.971054] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.828s)
[204.055191] Starting dynamic subtest: pipe-B-eDP-1
[205.591878] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.606s)
[205.675949] Starting dynamic subtest: pipe-C-eDP-1
[207.254152] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.638s)
[207.256863] Subtest read-crc: SUCCESS (4.112s)
[208.210877] [121/162] (802s left) kms_pipe_crc_basic (read-crc-frame-sequence)
[208.393488] Starting subtest: read-crc-frame-sequence
[208.394621] Starting dynamic subtest: pipe-A-eDP-1
[209.338509] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.935s)
[209.418729] Starting dynamic subtest: pipe-B-eDP-1
[211.065924] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.711s)
[211.153133] Starting dynamic subtest: pipe-C-eDP-1
[212.619489] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.532s)
[212.622243] Subtest read-crc-frame-sequence: SUCCESS (4.225s)
[213.569840] [122/162] (797s left) kms_pm_backlight (basic-brightness)
[213.696645] Starting subtest: basic-brightness
[213.746703] Starting dynamic subtest: eDP-1
[214.364579] Dynamic subtest eDP-1: SUCCESS (0.617s)
[214.376862] Subtest basic-brightness: SUCCESS (0.672s)
[215.282277] [123/162] (795s left) kms_pm_rpm (basic-pci-d3-state)
[217.019074] Starting subtest: basic-pci-d3-state
[217.648270] Subtest basic-pci-d3-state: SUCCESS (0.623s)
[217.840587] [124/162] (793s left) kms_pm_rpm (basic-rte)
[217.906738] Starting subtest: basic-rte
[220.190273] Subtest basic-rte: SUCCESS (2.280s)
[221.577419] [125/162] (789s left) kms_psr (psr-primary-page-flip)
[221.720349] Starting subtest: psr-primary-page-flip
[221.724115] Starting dynamic subtest: eDP-1
[223.630272] Dynamic subtest eDP-1: SUCCESS (1.900s)
[223.632786] Subtest psr-primary-page-flip: SUCCESS (1.906s)
[224.508338] [126/162] (786s left) kms_psr (psr-cursor-plane-move)
[224.633466] Starting subtest: psr-cursor-plane-move
[224.634449] Starting dynamic subtest: eDP-1
[226.640610] Dynamic subtest eDP-1: SUCCESS (2.002s)
[226.643250] Subtest psr-cursor-plane-move: SUCCESS (2.009s)
[227.589443] [127/162] (783s left) kms_psr (psr-sprite-plane-onoff)
[227.719371] Starting subtest: psr-sprite-plane-onoff
[227.722228] Starting dynamic subtest: eDP-1
[229.730144] Dynamic subtest eDP-1: SUCCESS (2.000s)
[229.732520] Subtest psr-sprite-plane-onoff: SUCCESS (2.008s)
[230.728358] [128/162] (780s left) kms_psr (psr-primary-mmap-gtt)
[230.855613] Starting subtest: psr-primary-mmap-gtt
[230.856606] Starting dynamic subtest: eDP-1
[232.902928] Dynamic subtest eDP-1: SUCCESS (2.028s)
[232.905991] Subtest psr-primary-mmap-gtt: SUCCESS (2.036s)
[233.854779] [129/162] (777s left) kms_setmode (basic-clone-single-crtc)
[233.928201] Starting subtest: basic-clone-single-crtc
[233.930989] Subtest basic-clone-single-crtc: SKIP (0.000s)
[234.068196] [130/162] (777s left) i915_pm_rps (basic-api)
[234.150171] Starting subtest: basic-api
[234.155794] Subtest basic-api: SUCCESS (0.006s)
[234.344867] [131/162] (777s left) prime_self_import (basic-llseek-bad)
[234.413417] Starting subtest: basic-llseek-bad
[234.415343] Subtest basic-llseek-bad: SUCCESS (0.003s)
[234.602692] [132/162] (777s left) prime_self_import (basic-llseek-size)
[234.669204] Starting subtest: basic-llseek-size
[234.674227] Subtest basic-llseek-size: SUCCESS (0.005s)
[234.872741] [133/162] (777s left) prime_self_import (basic-with_fd_dup)
[234.939213] Starting subtest: basic-with_fd_dup
[234.946844] Subtest basic-with_fd_dup: SUCCESS (0.006s)
[235.100342] [134/162] (777s left) prime_self_import (basic-with_one_bo)
[235.167019] Starting subtest: basic-with_one_bo
[235.172578] Subtest basic-with_one_bo: SUCCESS (0.006s)
[235.304501] [135/162] (776s left) prime_self_import (basic-with_one_bo_two_files)
[235.371146] Starting subtest: basic-with_one_bo_two_files
[235.376996] Subtest basic-with_one_bo_two_files: SUCCESS (0.005s)
[235.512980] [136/162] (776s left) prime_self_import (basic-with_two_bos)
[235.580370] Starting subtest: basic-with_two_bos
[235.587075] Subtest basic-with_two_bos: SUCCESS (0.006s)
[235.769408] [137/162] (776s left) prime_vgem (basic-fence-flip)
[235.845557] Starting subtest: basic-fence-flip
[236.377053] Subtest basic-fence-flip: SUCCESS (0.528s)
[236.572134] [138/162] (775s left) prime_vgem (basic-fence-mmap)
[236.648420] Starting subtest: basic-fence-mmap
[236.681618] Subtest basic-fence-mmap: SUCCESS (0.033s)
[236.834932] [139/162] (775s left) prime_vgem (basic-fence-read)
[236.914611] Starting subtest: basic-fence-read
[236.988464] Subtest basic-fence-read: SUCCESS (0.076s)
[237.143023] [140/162] (775s left) prime_vgem (basic-gtt)
[237.219190] Starting subtest: basic-gtt
[237.235539] Subtest basic-gtt: SUCCESS (0.016s)
[237.384034] [141/162] (775s left) prime_vgem (basic-read)
[237.461179] Starting subtest: basic-read
[237.498172] Subtest basic-read: SUCCESS (0.037s)
[237.682312] [142/162] (775s left) prime_vgem (basic-write)
[237.761189] Starting subtest: basic-write
[237.799179] Subtest basic-write: SUCCESS (0.040s)
[237.942980] [143/162] (774s left) vgem_basic (setversion)
[238.013589] Starting subtest: setversion
[238.015324] Subtest setversion: SUCCESS (0.000s)
[238.185131] [144/162] (774s left) vgem_basic (create)
[238.267230] Starting subtest: create
[238.268290] Subtest create: SUCCESS (0.000s)
[238.369068] [145/162] (774s left) vgem_basic (debugfs)
[238.436977] Starting subtest: debugfs
[238.437969] Subtest debugfs: SUCCESS (0.001s)
[238.565943] [146/162] (774s left) vgem_basic (dmabuf-export)
[238.634308] Starting subtest: dmabuf-export
[238.636363] Subtest dmabuf-export: SUCCESS (0.003s)
[238.829036] [147/162] (774s left) vgem_basic (dmabuf-fence)
[238.896206] Starting subtest: dmabuf-fence
[238.897581] Subtest dmabuf-fence: SUCCESS (0.001s)
[239.018935] [148/162] (774s left) vgem_basic (dmabuf-fence-before)
[239.087272] Starting subtest: dmabuf-fence-before
[239.088720] Subtest dmabuf-fence-before: SUCCESS (0.001s)
[239.211974] [149/162] (774s left) vgem_basic (dmabuf-mmap)
[239.280201] Starting subtest: dmabuf-mmap
[239.294483] Subtest dmabuf-mmap: SUCCESS (0.016s)
[239.414798] [150/162] (774s left) vgem_basic (mmap)
[239.483318] Starting subtest: mmap
[239.493030] Subtest mmap: SUCCESS (0.011s)
[239.618066] [151/162] (773s left) vgem_basic (second-client)
[239.685801] Starting subtest: second-client
[239.716031] Subtest second-client: SUCCESS (0.028s)
[239.825902] [152/162] (773s left) vgem_basic (sysfs)
[239.895570] Starting subtest: sysfs
[239.896506] Subtest sysfs: SUCCESS (0.001s)
[240.014303] [153/162] (773s left) core_hotunplug (unbind-rebind)
[240.174193] Starting subtest: unbind-rebind
[245.146767] Subtest unbind-rebind: SUCCESS (4.974s)
[245.223715] [154/162] (768s left) vgem_basic (unload)
[245.294248] Starting subtest: unload
[274.352846] Subtest unload: SUCCESS (29.022s)
[274.495276] [155/162] (739s left) i915_module_load (reload)
[274.558684] Starting subtest: reload
[278.566024] Subtest reload: SUCCESS (4.007s)
[278.725798] [156/162] (735s left) gem_lmem_swapping (basic)
[278.814346] Subtest basic: SKIP (0.000s)
[278.972051] [157/162] (735s left) gem_lmem_swapping (parallel-random-engines)
[279.058831] Subtest parallel-random-engines: SKIP (0.000s)
[279.153913] [158/162] (735s left) gem_lmem_swapping (random-engines)
[279.230909] Subtest random-engines: SKIP (0.000s)
[279.320535] [159/162] (734s left) gem_lmem_swapping (verify-random)
[279.397360] Subtest verify-random: SKIP (0.000s)
[279.487922] [160/162] (734s left) i915_pm_rpm (module-reload)
[281.836590] Starting subtest: module-reload
[294.757954] Subtest module-reload: SUCCESS (12.923s)
[294.803015] [FACT i915_pm_rpm (module-reload)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card1
[294.805251] [FACT i915_pm_rpm (module-reload)] deleted: kernel.kmod_is_loaded.i915: true
[294.810340] [161/162] (719s left) i915_selftest (live)