TracerBench/tracerbench

Latest chrome canary causes throws error

Closed this issue · 3 comments

could not find matching B phase for E phase event coming from

throw new Error('could not find matching B phase for E phase event');

is thrown when using the runner with chrome canary but not stable:

canary: Version 80.0.3964.0 (Official Build) canary (64-bit)
stable: Version 78.0.3904.97 (Official Build) (64-bit)

At the very least as a feature-add lets have the compare command include the version of chrome leveraged within the results

I'm seeing something maybe related on chrome 79 where tracerbench can't find Paint events.

Similar to #94 can we output what version the runner is using while the test is in progress? This is useful when we don't get a report since we can't complete a run.

[
  {
    "name": "http://localhost:4200/",
    "entryType": "navigation",
    "startTime": 0,
    "duration": 1359.0900000126567,
    "initiatorType": "navigation",
    "nextHopProtocol": "http/1.1",
    "workerStart": 0,
    "redirectStart": 0,
    "redirectEnd": 0,
    "fetchStart": 1.365000003715977,
    "domainLookupStart": 5.5050000082701445,
    "domainLookupEnd": 5.52500001504086,
    "connectStart": 5.52500001504086,
    "connectEnd": 5.680000002030283,
    "secureConnectionStart": 0,
    "requestStart": 5.735000013373792,
    "responseStart": 12.445000000298023,
    "responseEnd": 14.220000011846423,
    "transferSize": 857,
    "encodedBodySize": 524,
    "decodedBodySize": 1176,
    "serverTiming": [],
    "unloadEventStart": 92.1049999888055,
    "unloadEventEnd": 92.1049999888055,
    "domInteractive": 1354.2000000015832,
    "domContentLoadedEventStart": 1354.2799999995623,
    "domContentLoadedEventEnd": 1354.5349999913014,
    "domComplete": 1358.9349999965634,
    "loadEventStart": 1358.9499999943655,
    "loadEventEnd": 1359.0900000126567,
    "type": "reload",
    "redirectCount": 0
  },
  {
    "name": "http://localhost:4200/assets/vendor.css",
    "entryType": "resource",
    "startTime": 101.53000001446344,
    "duration": 11.51499999104999,
    "initiatorType": "link",
    "nextHopProtocol": "http/1.1",
    "workerStart": 0,
    "redirectStart": 0,
    "redirectEnd": 0,
    "fetchStart": 101.53000001446344,
    "domainLookupStart": 101.53000001446344,
    "domainLookupEnd": 101.53000001446344,
    "connectStart": 101.53000001446344,
    "connectEnd": 101.53000001446344,
    "secureConnectionStart": 0,
    "requestStart": 111.45500000566244,
    "responseStart": 112.74000001139939,
    "responseEnd": 113.04500000551343,
    "transferSize": 282,
    "encodedBodySize": 0,
    "decodedBodySize": 0,
    "serverTiming": []
  },
  {
    "name": "http://localhost:4200/assets/relationship-performance-test-app.css",
    "entryType": "resource",
    "startTime": 101.71499999705702,
    "duration": 12.199999997392297,
    "initiatorType": "link",
    "nextHopProtocol": "http/1.1",
    "workerStart": 0,
    "redirectStart": 0,
    "redirectEnd": 0,
    "fetchStart": 101.71499999705702,
    "domainLookupStart": 111.99500001384877,
    "domainLookupEnd": 112.01000001165085,
    "connectStart": 112.01000001165085,
    "connectEnd": 112.17999999644235,
    "secureConnectionStart": 0,
    "requestStart": 112.22000000998378,
    "responseStart": 113.61999998916872,
    "responseEnd": 113.91499999444932,
    "transferSize": 282,
    "encodedBodySize": 0,
    "decodedBodySize": 0,
    "serverTiming": []
  },
  {
    "name": "http://localhost:4200/assets/vendor.js",
    "entryType": "resource",
    "startTime": 101.8949999997858,
    "duration": 119.58500000764616,
    "initiatorType": "script",
    "nextHopProtocol": "http/1.1",
    "workerStart": 0,
    "redirectStart": 0,
    "redirectEnd": 0,
    "fetchStart": 101.8949999997858,
    "domainLookupStart": 101.8949999997858,
    "domainLookupEnd": 101.8949999997858,
    "connectStart": 101.8949999997858,
    "connectEnd": 101.8949999997858,
    "secureConnectionStart": 0,
    "requestStart": 129.4249999918975,
    "responseStart": 135.7399999978952,
    "responseEnd": 221.48000000743195,
    "transferSize": 596514,
    "encodedBodySize": 595876,
    "decodedBodySize": 2779408,
    "serverTiming": []
  },
  {
    "name": "http://localhost:4200/assets/relationship-performance-test-app.js",
    "entryType": "resource",
    "startTime": 102.07500000251457,
    "duration": 31.62500000325963,
    "initiatorType": "script",
    "nextHopProtocol": "http/1.1",
    "workerStart": 0,
    "redirectStart": 0,
    "redirectEnd": 0,
    "fetchStart": 102.07500000251457,
    "domainLookupStart": 102.07500000251457,
    "domainLookupEnd": 102.07500000251457,
    "connectStart": 102.07500000251457,
    "connectEnd": 102.07500000251457,
    "secureConnectionStart": 0,
    "requestStart": 129.48500001220964,
    "responseStart": 132.62499999837019,
    "responseEnd": 133.7000000057742,
    "transferSize": 4914,
    "encodedBodySize": 4567,
    "decodedBodySize": 23193,
    "serverTiming": []
  },
  {
    "name": "start-find-all",
    "entryType": "mark",
    "startTime": 308.8949999946635,
    "duration": 0
  },
  {
    "name": "start-fixture-generation",
    "entryType": "mark",
    "startTime": 312.1849999879487,
    "duration": 0
  },
  {
    "name": "end-fixture-generation",
    "entryType": "mark",
    "startTime": 330.420000012964,
    "duration": 0
  },
  {
    "name": "start-outer-materialization",
    "entryType": "mark",
    "startTime": 1067.574999993667,
    "duration": 0
  },
  {
    "name": "stop-outer-materialization",
    "entryType": "mark",
    "startTime": 1333.0100000021048,
    "duration": 0
  },
  {
    "name": "end-find-all",
    "entryType": "mark",
    "startTime": 1333.0199999909382,
    "duration": 0
  },
  {
    "name": "first-paint",
    "entryType": "paint",
    "startTime": 1372.4700000020675,
    "duration": 0
  },
  {
    "name": "first-contentful-paint",
    "entryType": "paint",
    "startTime": 1372.4700000020675,
    "duration": 0
  },
  {
    "name": "mousedown",
    "entryType": "first-input",
    "startTime": 1850.395000015851,
    "duration": 8,
    "processingStart": 1855.1250000018626,
    "processingEnd": 1855.1399999996647,
    "cancelable": true
  },
  {
    "name": "http://localhost:4200/assets/vendor.css",
    "entryType": "resource",
    "startTime": 4989.040000014938,
    "duration": 5.284999991999939,
    "initiatorType": "link",
    "nextHopProtocol": "http/1.1",
    "workerStart": 0,
    "redirectStart": 0,
    "redirectEnd": 0,
    "fetchStart": 4989.040000014938,
    "domainLookupStart": 4989.040000014938,
    "domainLookupEnd": 4989.040000014938,
    "connectStart": 4989.040000014938,
    "connectEnd": 4989.040000014938,
    "secureConnectionStart": 0,
    "requestStart": 4992.915000009816,
    "responseStart": 4994.080000004033,
    "responseEnd": 4994.325000006938,
    "transferSize": 211,
    "encodedBodySize": 0,
    "decodedBodySize": 0,
    "serverTiming": []
  },
  {
    "name": "http://localhost:4200/assets/relationship-performance-test-app.css",
    "entryType": "resource",
    "startTime": 4989.224999997532,
    "duration": 5.850000015925616,
    "initiatorType": "link",
    "nextHopProtocol": "http/1.1",
    "workerStart": 0,
    "redirectStart": 0,
    "redirectEnd": 0,
    "fetchStart": 4989.224999997532,
    "domainLookupStart": 4989.224999997532,
    "domainLookupEnd": 4989.224999997532,
    "connectStart": 4989.224999997532,
    "connectEnd": 4989.224999997532,
    "secureConnectionStart": 0,
    "requestStart": 4993.335000006482,
    "responseStart": 4994.490000011865,
    "responseEnd": 4995.075000013458,
    "transferSize": 211,
    "encodedBodySize": 0,
    "decodedBodySize": 0,
    "serverTiming": []
  }
]

This is the result of performance.getEntries() for the url the test is testing, where the last marker is end-find-all. The route in the Ember app in question uses afterModel to schedule two animation frames ahead to redirect to about:blank.