feat: print duration in the console when clicking on the command

Author: bahmutov

__snapshots__/cypress-failed-log-spec.js

@@ -45,9 +45,9 @@ exports['saved commands from long-name-spec.js 184-188-192-196-200-204-208-212-2
 ]
 
 exports['spec a.js finished with'] = {
-  "totalTests": 3,
+  "totalTests": 4,
   "totalFailed": 2,
-  "totalPassed": 1,
+  "totalPassed": 2,
   "totalPending": 0,
   "totalSkipped": 0
 }

cypress/integration/a.js

@@ -10,7 +10,14 @@ describe('root suite', () => {
       cy.wrap(person).its('name').should('equal', 'Mo')
       setTimeout(() => {
         person.name = 'Mo'
+
+        setTimeout(() => {
+          person.name = 'Joe'
+        }, 2000)
       }, 2000)
+
+      cy.wrap(person).its('name').should('equal', 'Joe')
+
     })
 
     it('has second test (failing)', () => {

src/index.js

@@ -80,6 +80,9 @@ function startLogging () {
 
   Cypress.on('log:changed', options => {
     if (options.instrument === 'command' && options.consoleProps) {
+      // This is NOT the exact command duration, since we are only
+      // getting an event some time after the command finishes.
+      // Still better to have approximate value than nothing
       options.wallClockStoppedAt = Date.now()
       options.duration = +options.wallClockStoppedAt - (+ new Date(options.wallClockStartedAt))
       options.consoleProps.Duration = options.duration