builder: mozilla-central_ubuntu64_hw_qr_test-dromaeojs-e10s
slave: talos-linux64-ix-080
starttime: 1505240425.67
results: success (0)
revision: a73cc4e08bf5a005722c95b43f84ab0c8ff2bc7c
========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-09-12 11:20:25.667269) =========
master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/
========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-09-12 11:20:25.668053) =========
========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-12 11:20:25.668320) =========
========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-12 11:20:25.791552) =========
========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-12 11:20:25.794861) =========
bash -c 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py'
in dir /builds/slave/test/. (timeout 1200 secs)
watching logfiles {}
argv: ['bash', '-c', 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py']
environment:
DISPLAY=:0
HOME=/home/cltbld
LANG=en_US.UTF-8
LANGUAGE=en_US:en
LOGNAME=cltbld
MAIL=/var/mail/cltbld
MOZ_CRASHREPORTER_NO_REPORT=1
MOZ_NO_REMOTE=1
NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript
NO_EM_RESTART=1
PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games
PWD=/builds/slave/test
SHELL=/bin/bash
SHLVL=1
TERM=linux
TMOUT=86400
USER=cltbld
XDG_SESSION_COOKIE=781b77c4c33858b1f599d705000001c1-1505217657.506684-1238802230
XPCOM_DEBUG_BREAK=warn
_=/tools/buildbot/bin/python
using PTY: False
--2017-09-12 11:20:26-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py
Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25
Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected.
HTTP request sent, awaiting response... 200 Script output follows
Length: 12179 (12K) [text/x-python]
Saving to: `archiver_client.py'
0K .......... . 100% 92.6M=0s
2017-09-12 11:20:26 (92.6 MB/s) - `archiver_client.py' saved [12179/12179]
program finished with exit code 0
elapsedTime=0.141545
========= master_lag: 0.04 =========
========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-12 11:20:25.972218) =========
========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-12 11:20:25.972523) =========
rm -rf scripts properties
in dir /builds/slave/test/. (timeout 1200 secs)
watching logfiles {}
argv: ['rm', '-rf', 'scripts', 'properties']
environment:
DISPLAY=:0
HOME=/home/cltbld
LANG=en_US.UTF-8
LANGUAGE=en_US:en
LOGNAME=cltbld
MAIL=/var/mail/cltbld
MOZ_CRASHREPORTER_NO_REPORT=1
MOZ_NO_REMOTE=1
NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript
NO_EM_RESTART=1
PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games
PWD=/builds/slave/test
SHELL=/bin/bash
SHLVL=1
TERM=linux
TMOUT=86400
USER=cltbld
XDG_SESSION_COOKIE=781b77c4c33858b1f599d705000001c1-1505217657.506684-1238802230
XPCOM_DEBUG_BREAK=warn
_=/tools/buildbot/bin/python
using PTY: False
program finished with exit code 0
elapsedTime=0.020382
========= master_lag: 0.07 =========
========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-12 11:20:26.059022) =========
========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-12 11:20:26.059402) =========
bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev a73cc4e08bf5a005722c95b43f84ab0c8ff2bc7c --destination scripts --debug'
in dir /builds/slave/test/. (timeout 1200 secs)
watching logfiles {}
argv: ['bash', '-c', 'python archiver_client.py mozharness --repo mozilla-central --rev a73cc4e08bf5a005722c95b43f84ab0c8ff2bc7c --destination scripts --debug']
environment:
DISPLAY=:0
HOME=/home/cltbld
LANG=en_US.UTF-8
LANGUAGE=en_US:en
LOGNAME=cltbld
MAIL=/var/mail/cltbld
MOZ_CRASHREPORTER_NO_REPORT=1
MOZ_NO_REMOTE=1
NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript
NO_EM_RESTART=1
PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games
PWD=/builds/slave/test
SHELL=/bin/bash
SHLVL=1
TERM=linux
TMOUT=86400
USER=cltbld
XDG_SESSION_COOKIE=781b77c4c33858b1f599d705000001c1-1505217657.506684-1238802230
XPCOM_DEBUG_BREAK=warn
_=/tools/buildbot/bin/python
using PTY: False
2017-09-12 11:20:26,555 truncating revision to first 12 chars
2017-09-12 11:20:26,555 Setting DEBUG logging.
2017-09-12 11:20:26,555 attempt 1/10
2017-09-12 11:20:26,555 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/a73cc4e08bf5?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness
2017-09-12 11:20:26,825 unpacking tar archive at: mozilla-central-a73cc4e08bf5/testing/mozharness/
program finished with exit code 0
elapsedTime=0.550389
========= master_lag: 0.02 =========
========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-12 11:20:26.630685) =========
========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-12 11:20:26.634085) =========
script_repo_revision: a73cc4e08bf5a005722c95b43f84ab0c8ff2bc7c
========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-12 11:20:26.634495) =========
========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-12 11:20:26.634812) =========
========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-12 11:20:26.677864) =========
========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 54 secs) (at 2017-09-12 11:20:26.678245) =========
/tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox
in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs)
watching logfiles {}
argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox']
environment:
DISPLAY=:0
HOME=/home/cltbld
LANG=en_US.UTF-8
LANGUAGE=en_US:en
LOGNAME=cltbld
MAIL=/var/mail/cltbld
MOZ_CRASHREPORTER_NO_REPORT=1
MOZ_NO_REMOTE=1
NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript
NO_EM_RESTART=1
PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games
PROPERTIES_FILE=/builds/slave/test/buildprops.json
PWD=/builds/slave/test
SHELL=/bin/bash
SHLVL=1
TERM=linux
TMOUT=86400
USER=cltbld
XDG_SESSION_COOKIE=781b77c4c33858b1f599d705000001c1-1505217657.506684-1238802230
XPCOM_DEBUG_BREAK=warn
_=/tools/buildbot/bin/python
using PTY: False
11:20:27 INFO - MultiFileLogger online at 20170912 11:20:27 in /builds/slave/test
11:20:27 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox
11:20:27 INFO - Dumping config to /builds/slave/test/logs/localconfig.json.
11:20:27 INFO - {'append_to_log': False,
11:20:27 INFO - 'base_work_dir': '/builds/slave/test',
11:20:27 INFO - 'blob_upload_branch': 'Firefox',
11:20:27 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt',
11:20:27 INFO - 'branch': 'Firefox',
11:20:27 INFO - 'buildbot_json_path': 'buildprops.json',
11:20:27 INFO - 'code_coverage': False,
11:20:27 INFO - 'config_files': ('talos/linux_config.py',),
11:20:27 INFO - 'default_actions': ('clobber',
11:20:27 INFO - 'read-buildbot-config',
11:20:27 INFO - 'download-and-extract',
11:20:27 INFO - 'populate-webroot',
11:20:27 INFO - 'create-virtualenv',
11:20:27 INFO - 'install',
11:20:27 INFO - 'setup-mitmproxy',
11:20:27 INFO - 'run-tests'),
11:20:27 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',),
11:20:27 INFO - 'disable_ccov_upload': False,
11:20:27 INFO - 'disable_stylo': False,
11:20:27 INFO - 'download_minidump_stackwalk': True,
11:20:27 INFO - 'download_symbols': 'ondemand',
11:20:27 INFO - 'enable_stylo': False,
11:20:27 INFO - 'enable_webrender': False,
11:20:27 INFO - 'exes': {'tooltool.py': '/tools/tooltool.py'},
11:20:27 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub',
11:20:27 INFO - 'http://pypi.pub.build.mozilla.org/pub'),
11:20:27 INFO - 'gecko_profile': False,
11:20:27 INFO - 'gecko_profile_interval': 0,
11:20:27 INFO - 'installer_path': 'installer.exe',
11:20:27 INFO - 'log_level': 'info',
11:20:27 INFO - 'log_name': 'talos',
11:20:27 INFO - 'log_to_console': True,
11:20:27 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk',
11:20:27 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest',
11:20:27 INFO - 'opt_config_files': (),
11:20:27 INFO - 'pip_index': False,
11:20:27 INFO - 'suite': 'dromaeojs-e10s',
11:20:27 INFO - 'system_bits': '32',
11:20:27 INFO - 'talos_extra_options': ('--webServer', 'localhost'),
11:20:27 INFO - 'title': 'talos-linux64-ix-080',
11:20:27 INFO - 'tooltool_cache': '/builds/tooltool_cache',
11:20:27 INFO - 'use_talos_json': True,
11:20:27 INFO - 'verify': 'False',
11:20:27 INFO - 'virtualenv_path': '/builds/slave/test/build/venv',
11:20:27 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None},
11:20:27 INFO - 'work_dir': 'build'}
11:20:27 INFO - [mozharness: 2017-09-12 18:20:27.308123Z] Running clobber step.
11:20:27 INFO - Running pre-action listener: _resource_record_pre_action
11:20:27 INFO - Running main action method: clobber
11:20:27 INFO - rmtree: /builds/slave/test/build
11:20:27 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1
11:20:28 INFO - Running post-action listener: _resource_record_post_action
11:20:28 INFO - [mozharness: 2017-09-12 18:20:28.834440Z] Finished clobber step (success)
11:20:28 INFO - [mozharness: 2017-09-12 18:20:28.834538Z] Running read-buildbot-config step.
11:20:28 INFO - Running pre-action listener: _resource_record_pre_action
11:20:28 INFO - Running main action method: read_buildbot_config
11:20:28 INFO - Using buildbot properties:
11:20:28 INFO - {
11:20:28 INFO - "project": "",
11:20:28 INFO - "product": "firefox",
11:20:28 INFO - "who": "ffxbld@noreply.mozilla.org",
11:20:28 INFO - "installer_path": "public/build/target.tar.bz2",
11:20:28 INFO - "builddir": "mozilla-central_ubuntu64_hw_qr_test-dromaeojs-e10s",
11:20:28 INFO - "repository": "https://hg.mozilla.org/mozilla-central",
11:20:28 INFO - "buildername": "Ubuntu HW 12.04 x64 qr mozilla-central talos dromaeojs-e10s",
11:20:28 INFO - "stage_platform": "linux64-qr",
11:20:28 INFO - "basedir": "/builds/slave/test",
11:20:28 INFO - "buildnumber": 45,
11:20:28 INFO - "platform": "ubuntu64_hw_qr",
11:20:28 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/",
11:20:28 INFO - "slavebuilddir": "test",
11:20:28 INFO - "taskId": "epwNeZfYSHeeUmNW0lPT2g",
11:20:28 INFO - "branch": "mozilla-central",
11:20:28 INFO - "script_repo_revision": "production",
11:20:28 INFO - "revision": "a73cc4e08bf5a005722c95b43f84ab0c8ff2bc7c",
11:20:28 INFO - "slavename": "talos-linux64-ix-080",
11:20:28 INFO - "repo_path": "mozilla-central"
11:20:28 INFO - }
11:20:28 INFO - Finding installer, test and symbols from parent task.
11:20:28 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/epwNeZfYSHeeUmNW0lPT2g'}, attempt #1
11:20:29 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/epwNeZfYSHeeUmNW0lPT2g'}, attempt #1
11:20:29 INFO - Task dependencies: eW846iPkS8eiD1elPeIpkA
11:20:29 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/eW846iPkS8eiD1elPeIpkA'}, attempt #1
11:20:30 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/eW846iPkS8eiD1elPeIpkA/artifacts/public/build/target.tar.bz2
11:20:30 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/eW846iPkS8eiD1elPeIpkA/artifacts/public/build/target.test_packages.json
11:20:30 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/eW846iPkS8eiD1elPeIpkA/artifacts/public/build/target.crashreporter-symbols.zip
11:20:30 INFO - Running post-action listener: _resource_record_post_action
11:20:30 INFO - [mozharness: 2017-09-12 18:20:30.224589Z] Finished read-buildbot-config step (success)
11:20:30 INFO - [mozharness: 2017-09-12 18:20:30.224806Z] Running download-and-extract step.
11:20:30 INFO - Running pre-action listener: _resource_record_pre_action
11:20:30 INFO - Running main action method: download_and_extract
11:20:30 INFO - mkdir: /builds/slave/test/build/tests
11:20:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]}
11:20:30 INFO - trying https://queue.taskcluster.net/v1/task/eW846iPkS8eiD1elPeIpkA/artifacts/public/build/target.test_packages.json
11:20:30 INFO - Downloading https://queue.taskcluster.net/v1/task/eW846iPkS8eiD1elPeIpkA/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json
11:20:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/eW846iPkS8eiD1elPeIpkA/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1
11:20:30 INFO - Downloaded 989 bytes.
11:20:30 INFO - Reading from file /builds/slave/test/build/target.test_packages.json
11:20:30 INFO - Using the following test package requirements:
11:20:30 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'],
11:20:30 INFO - u'common': [u'target.common.tests.zip'],
11:20:30 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'],
11:20:30 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'],
11:20:30 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'],
11:20:30 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'],
11:20:30 INFO - u'mozbase': [u'target.common.tests.zip'],
11:20:30 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'],
11:20:30 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'],
11:20:30 INFO - u'web-platform': [u'target.common.tests.zip',
11:20:30 INFO - u'target.web-platform.tests.tar.gz'],
11:20:30 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']}
11:20:30 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite categories: ['common', 'talos']
11:20:30 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/eW846iPkS8eiD1elPeIpkA/artifacts/public/build/target.common.tests.zip
11:20:30 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/eW846iPkS8eiD1elPeIpkA/artifacts/public/build/target.common.tests.zip'}, attempt #1
11:20:30 INFO - Fetch https://queue.taskcluster.net/v1/task/eW846iPkS8eiD1elPeIpkA/artifacts/public/build/target.common.tests.zip into memory
11:20:32 INFO - Content-Length response header: 55043913
11:20:32 INFO - Bytes received: 55043913
11:20:43 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/eW846iPkS8eiD1elPeIpkA/artifacts/public/build/target.talos.tests.zip
11:20:43 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/eW846iPkS8eiD1elPeIpkA/artifacts/public/build/target.talos.tests.zip'}, attempt #1
11:20:43 INFO - Fetch https://queue.taskcluster.net/v1/task/eW846iPkS8eiD1elPeIpkA/artifacts/public/build/target.talos.tests.zip into memory
11:20:44 INFO - Content-Length response header: 14499231
11:20:44 INFO - Bytes received: 14499231
11:20:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]}
11:20:45 INFO - trying https://queue.taskcluster.net/v1/task/eW846iPkS8eiD1elPeIpkA/artifacts/public/build/target.tar.bz2
11:20:45 INFO - Downloading https://queue.taskcluster.net/v1/task/eW846iPkS8eiD1elPeIpkA/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2
11:20:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/eW846iPkS8eiD1elPeIpkA/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1
11:20:48 INFO - Downloaded 62894850 bytes.
11:20:48 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/eW846iPkS8eiD1elPeIpkA/artifacts/public/build/target.tar.bz2
11:20:48 INFO - mkdir: /builds/slave/test/properties
11:20:48 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url
11:20:48 INFO - Writing to file /builds/slave/test/properties/build_url
11:20:48 INFO - Contents:
11:20:48 INFO - build_url:https://queue.taskcluster.net/v1/task/eW846iPkS8eiD1elPeIpkA/artifacts/public/build/target.tar.bz2
11:20:48 INFO - Running post-action listener: _resource_record_post_action
11:20:48 INFO - Running post-action listener: find_tests_for_verification
11:20:48 INFO - Running post-action listener: set_extra_try_arguments
11:20:48 INFO - [mozharness: 2017-09-12 18:20:48.558198Z] Finished download-and-extract step (success)
11:20:48 INFO - [mozharness: 2017-09-12 18:20:48.558426Z] Running populate-webroot step.
11:20:48 INFO - Running pre-action listener: _resource_record_pre_action
11:20:48 INFO - Running main action method: populate_webroot
11:20:48 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']},
11:20:48 INFO - 'chromez-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'],
11:20:48 INFO - 'tests': ['tresize',
11:20:48 INFO - 'tcanvasmark']},
11:20:48 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']},
11:20:48 INFO - 'dromaeojs-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'],
11:20:48 INFO - 'tests': ['dromaeo_css',
11:20:48 INFO - 'kraken']},
11:20:48 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip',
11:20:48 INFO - 'tests': ['tp5o_scroll', 'glterrain']},
11:20:48 INFO - 'g1-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip',
11:20:48 INFO - 'talos_options': ['--disable-stylo'],
11:20:48 INFO - 'tests': ['tp5o_scroll', 'glterrain']},
11:20:48 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip',
11:20:48 INFO - 'tests': ['damp', 'tps']},
11:20:48 INFO - 'g2-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip',
11:20:48 INFO - 'talos_options': ['--disable-stylo'],
11:20:48 INFO - 'tests': ['damp', 'tps']},
11:20:48 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']},
11:20:48 INFO - 'g3-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'],
11:20:48 INFO - 'tests': ['dromaeo_dom']},
11:20:48 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']},
11:20:48 INFO - 'g4-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'],
11:20:48 INFO - 'tests': ['basic_compositor_video',
11:20:48 INFO - 'glvideo']},
11:20:48 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip',
11:20:48 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']},
11:20:48 INFO - 'g5-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip',
11:20:48 INFO - 'talos_options': ['--disable-stylo'],
11:20:48 INFO - 'tests': ['ts_paint_webext',
11:20:48 INFO - 'tp5o_webext']},
11:20:48 INFO - 'other-e10s': {'tests': ['a11yr',
11:20:48 INFO - 'ts_paint',
11:20:48 INFO - 'tpaint',
11:20:48 INFO - 'sessionrestore',
11:20:48 INFO - 'sessionrestore_many_windows',
11:20:48 INFO - 'sessionrestore_no_auto_restore',
11:20:48 INFO - 'tabpaint']},
11:20:48 INFO - 'other-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'],
11:20:48 INFO - 'tests': ['a11yr',
11:20:48 INFO - 'ts_paint',
11:20:48 INFO - 'tpaint',
11:20:48 INFO - 'sessionrestore',
11:20:48 INFO - 'sessionrestore_many_windows',
11:20:48 INFO - 'sessionrestore_no_auto_restore',
11:20:48 INFO - 'tabpaint']},
11:20:48 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']},
11:20:48 INFO - 'perf-reftest-singletons-e10s': {'tests': ['bloom_basic_singleton']},
11:20:48 INFO - 'perf-reftest-singletons-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'],
11:20:48 INFO - 'tests': ['bloom_basic_singleton']},
11:20:48 INFO - 'perf-reftest-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'],
11:20:48 INFO - 'tests': ['bloom_basic']},
11:20:48 INFO - 'svgr-e10s': {'tests': ['tsvgx',
11:20:48 INFO - 'tsvgr_opacity',
11:20:48 INFO - 'tart',
11:20:48 INFO - 'tscrollx',
11:20:48 INFO - 'tsvg_static']},
11:20:48 INFO - 'svgr-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'],
11:20:48 INFO - 'tests': ['tsvgx',
11:20:48 INFO - 'tsvgr_opacity',
11:20:48 INFO - 'tart',
11:20:48 INFO - 'tscrollx',
11:20:48 INFO - 'tsvg_static']},
11:20:48 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']},
11:20:48 INFO - 'tp5o-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip',
11:20:48 INFO - 'talos_options': ['--disable-stylo'],
11:20:48 INFO - 'tests': ['tp5o']},
11:20:48 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip',
11:20:48 INFO - 'talos_options': ['--mitmproxy',
11:20:48 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp',
11:20:48 INFO - '--firstNonBlankPaint'],
11:20:48 INFO - 'tests': ['tp6_google',
11:20:48 INFO - 'tp6_youtube',
11:20:48 INFO - 'tp6_amazon',
11:20:48 INFO - 'tp6_facebook']},
11:20:48 INFO - 'tp6-stylo-disabled-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip',
11:20:48 INFO - 'talos_options': ['--disable-stylo',
11:20:48 INFO - '--mitmproxy',
11:20:48 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp',
11:20:48 INFO - '--firstNonBlankPaint'],
11:20:48 INFO - 'tests': ['tp6_google',
11:20:48 INFO - 'tp6_youtube',
11:20:48 INFO - 'tp6_amazon',
11:20:48 INFO - 'tp6_facebook']},
11:20:48 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip',
11:20:48 INFO - 'talos_options': ['--stylo-threads=1',
11:20:48 INFO - '--mitmproxy',
11:20:48 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp',
11:20:48 INFO - '--firstNonBlankPaint'],
11:20:48 INFO - 'tests': ['tp6_google',
11:20:48 INFO - 'tp6_youtube',
11:20:48 INFO - 'tp6_amazon',
11:20:48 INFO - 'tp6_facebook']},
11:20:48 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip',
11:20:48 INFO - 'talos_options': ['--xperf_path',
11:20:48 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'],
11:20:48 INFO - 'tests': ['tp5n']},
11:20:48 INFO - 'xperf-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip',
11:20:48 INFO - 'talos_options': ['--disable-stylo',
11:20:48 INFO - '--xperf_path',
11:20:48 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'],
11:20:48 INFO - 'tests': ['tp5n']}}}
11:20:48 INFO - Running post-action listener: _resource_record_post_action
11:20:48 INFO - [mozharness: 2017-09-12 18:20:48.577279Z] Finished populate-webroot step (success)
11:20:48 INFO - [mozharness: 2017-09-12 18:20:48.577369Z] Running create-virtualenv step.
11:20:48 INFO - Running pre-action listener: _resource_record_pre_action
11:20:48 INFO - Running main action method: create_virtualenv
11:20:48 INFO - Creating virtualenv /builds/slave/test/build/venv
11:20:48 INFO - Running command: ['virtualenv', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build
11:20:48 INFO - Copy/paste: virtualenv --no-site-packages --distribute /builds/slave/test/build/venv
11:20:48 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'}
11:20:48 INFO - The --no-site-packages flag is deprecated; it is now the default behavior.
11:20:48 INFO - New python executable in /builds/slave/test/build/venv/bin/python
11:20:49 INFO - Installing distribute.............................................................................................................................................................................................done.
11:20:49 INFO - Installing pip...............done.
11:20:49 INFO - Return code: 0
11:20:49 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version']
11:20:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version
11:20:49 INFO - Reading from file tmpfile_stdout
11:20:49 INFO - Output received:
11:20:49 INFO - pip 1.1 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.1-py2.7.egg (python 2.7)
11:20:49 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv
11:20:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]}
11:20:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org
11:20:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]}
11:20:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org
11:20:49 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d0d1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ed6a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2079a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x207d090>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x207dd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2077f90>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '781b77c4c33858b1f599d705000001c1-1505217657.506684-1238802230', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1
11:20:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build
11:20:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5
11:20:49 INFO - Using env: {'DISPLAY': ':0',
11:20:49 INFO - 'HOME': '/home/cltbld',
11:20:49 INFO - 'LANG': 'en_US.UTF-8',
11:20:49 INFO - 'LANGUAGE': 'en_US:en',
11:20:49 INFO - 'LOGNAME': 'cltbld',
11:20:49 INFO - 'MAIL': '/var/mail/cltbld',
11:20:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1',
11:20:49 INFO - 'MOZ_NO_REMOTE': '1',
11:20:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript',
11:20:49 INFO - 'NO_EM_RESTART': '1',
11:20:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games',
11:20:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json',
11:20:49 INFO - 'PWD': '/builds/slave/test',
11:20:49 INFO - 'SHELL': '/bin/bash',
11:20:49 INFO - 'SHLVL': '1',
11:20:49 INFO - 'TERM': 'linux',
11:20:49 INFO - 'TMOUT': '86400',
11:20:49 INFO - 'USER': 'cltbld',
11:20:49 INFO - 'XDG_SESSION_COOKIE': '781b77c4c33858b1f599d705000001c1-1505217657.506684-1238802230',
11:20:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn',
11:20:49 INFO - '_': '/tools/buildbot/bin/python'}
11:20:50 INFO - Ignoring indexes: http://pypi.python.org/simple/
11:20:50 INFO - Downloading/unpacking pip>=1.5
11:20:50 INFO - Running setup.py egg_info for package pip
11:20:50 INFO - /usr/lib/python2.7/distutils/dist.py:267: UserWarning: Unknown distribution option: 'python_requires'
11:20:50 INFO - warnings.warn(msg)
11:20:50 INFO - warning: no previously-included files found matching '.coveragerc'
11:20:50 INFO - warning: no previously-included files found matching '.mailmap'
11:20:50 INFO - warning: no previously-included files found matching '.travis.yml'
11:20:50 INFO - warning: no previously-included files found matching '.landscape.yml'
11:20:50 INFO - warning: no previously-included files found matching 'pip/_vendor/Makefile'
11:20:50 INFO - warning: no previously-included files found matching 'tox.ini'
11:20:50 INFO - warning: no previously-included files found matching 'dev-requirements.txt'
11:20:50 INFO - warning: no previously-included files found matching 'appveyor.yml'
11:20:50 INFO - no previously-included directories found matching '.github'
11:20:50 INFO - no previously-included directories found matching '.travis'
11:20:50 INFO - no previously-included directories found matching 'docs/_build'
11:20:50 INFO - no previously-included directories found matching 'contrib'
11:20:50 INFO - no previously-included directories found matching 'tasks'
11:20:50 INFO - no previously-included directories found matching 'tests'
11:20:50 INFO - Installing collected packages: pip
11:20:50 INFO - Found existing installation: pip 1.1
11:20:50 INFO - Uninstalling pip:
11:20:50 INFO - Successfully uninstalled pip
11:20:50 INFO - Running setup.py install for pip
11:20:50 INFO - /usr/lib/python2.7/distutils/dist.py:267: UserWarning: Unknown distribution option: 'python_requires'
11:20:50 INFO - warnings.warn(msg)
11:20:50 INFO - warning: no previously-included files found matching '.coveragerc'
11:20:50 INFO - warning: no previously-included files found matching '.mailmap'
11:20:50 INFO - warning: no previously-included files found matching '.travis.yml'
11:20:50 INFO - warning: no previously-included files found matching '.landscape.yml'
11:20:50 INFO - warning: no previously-included files found matching 'pip/_vendor/Makefile'
11:20:50 INFO - warning: no previously-included files found matching 'tox.ini'
11:20:50 INFO - warning: no previously-included files found matching 'dev-requirements.txt'
11:20:50 INFO - warning: no previously-included files found matching 'appveyor.yml'
11:20:50 INFO - no previously-included directories found matching '.github'
11:20:50 INFO - no previously-included directories found matching '.travis'
11:20:50 INFO - no previously-included directories found matching 'docs/_build'
11:20:50 INFO - no previously-included directories found matching 'contrib'
11:20:50 INFO - no previously-included directories found matching 'tasks'
11:20:50 INFO - no previously-included directories found matching 'tests'
11:20:50 INFO - Installing pip script to /builds/slave/test/build/venv/bin
11:20:50 INFO - Installing pip2.7 script to /builds/slave/test/build/venv/bin
11:20:50 INFO - Installing pip2 script to /builds/slave/test/build/venv/bin
11:20:50 INFO - Successfully installed pip
11:20:50 INFO - Cleaning up...
11:20:50 INFO - Return code: 0
11:20:50 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv
11:20:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]}
11:20:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org
11:20:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]}
11:20:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org
11:20:50 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d0d1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ed6a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2079a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x207d090>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x207dd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2077f90>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '781b77c4c33858b1f599d705000001c1-1505217657.506684-1238802230', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1
11:20:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build
11:20:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1
11:20:50 INFO - Using env: {'DISPLAY': ':0',
11:20:50 INFO - 'HOME': '/home/cltbld',
11:20:50 INFO - 'LANG': 'en_US.UTF-8',
11:20:50 INFO - 'LANGUAGE': 'en_US:en',
11:20:50 INFO - 'LOGNAME': 'cltbld',
11:20:50 INFO - 'MAIL': '/var/mail/cltbld',
11:20:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1',
11:20:50 INFO - 'MOZ_NO_REMOTE': '1',
11:20:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript',
11:20:50 INFO - 'NO_EM_RESTART': '1',
11:20:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games',
11:20:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json',
11:20:50 INFO - 'PWD': '/builds/slave/test',
11:20:50 INFO - 'SHELL': '/bin/bash',
11:20:50 INFO - 'SHLVL': '1',
11:20:50 INFO - 'TERM': 'linux',
11:20:50 INFO - 'TMOUT': '86400',
11:20:50 INFO - 'USER': 'cltbld',
11:20:50 INFO - 'XDG_SESSION_COOKIE': '781b77c4c33858b1f599d705000001c1-1505217657.506684-1238802230',
11:20:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn',
11:20:50 INFO - '_': '/tools/buildbot/bin/python'}
11:20:51 INFO - Collecting psutil>=3.1.1
11:20:52 INFO - Downloading http://pypi.pvt.build.mozilla.org/pub/psutil-3.1.1.tar.gz (247kB)
11:20:53 INFO - Installing collected packages: psutil
11:20:53 INFO - Running setup.py install for psutil: started
11:20:55 INFO - Running setup.py install for psutil: finished with status 'done'
11:20:55 INFO - Successfully installed psutil-3.1.1
11:20:55 INFO - Return code: 0
11:20:55 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv
11:20:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]}
11:20:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org
11:20:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]}
11:20:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org
11:20:55 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d0d1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ed6a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2079a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x207d090>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x207dd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2077f90>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '781b77c4c33858b1f599d705000001c1-1505217657.506684-1238802230', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1
11:20:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build
11:20:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3
11:20:55 INFO - Using env: {'DISPLAY': ':0',
11:20:55 INFO - 'HOME': '/home/cltbld',
11:20:55 INFO - 'LANG': 'en_US.UTF-8',
11:20:55 INFO - 'LANGUAGE': 'en_US:en',
11:20:55 INFO - 'LOGNAME': 'cltbld',
11:20:55 INFO - 'MAIL': '/var/mail/cltbld',
11:20:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1',
11:20:55 INFO - 'MOZ_NO_REMOTE': '1',
11:20:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript',
11:20:55 INFO - 'NO_EM_RESTART': '1',
11:20:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games',
11:20:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json',
11:20:55 INFO - 'PWD': '/builds/slave/test',
11:20:55 INFO - 'SHELL': '/bin/bash',
11:20:55 INFO - 'SHLVL': '1',
11:20:55 INFO - 'TERM': 'linux',
11:20:55 INFO - 'TMOUT': '86400',
11:20:55 INFO - 'USER': 'cltbld',
11:20:55 INFO - 'XDG_SESSION_COOKIE': '781b77c4c33858b1f599d705000001c1-1505217657.506684-1238802230',
11:20:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn',
11:20:55 INFO - '_': '/tools/buildbot/bin/python'}
11:20:56 INFO - Collecting mozsystemmonitor==0.3
11:20:57 INFO - Downloading http://pypi.pvt.build.mozilla.org/pub/mozsystemmonitor-0.3.tar.gz
11:20:57 INFO - Requirement already satisfied: psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3)
11:20:57 INFO - Installing collected packages: mozsystemmonitor
11:20:57 INFO - Running setup.py install for mozsystemmonitor: started
11:20:57 INFO - Running setup.py install for mozsystemmonitor: finished with status 'done'
11:20:57 INFO - Successfully installed mozsystemmonitor-0.3
11:20:57 INFO - Return code: 0
11:20:57 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv
11:20:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]}
11:20:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org
11:20:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]}
11:20:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org
11:20:57 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d0d1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ed6a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2079a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x207d090>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x207dd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2077f90>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '781b77c4c33858b1f599d705000001c1-1505217657.506684-1238802230', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1
11:20:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build
11:20:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1
11:20:57 INFO - Using env: {'DISPLAY': ':0',
11:20:57 INFO - 'HOME': '/home/cltbld',
11:20:57 INFO - 'LANG': 'en_US.UTF-8',
11:20:57 INFO - 'LANGUAGE': 'en_US:en',
11:20:57 INFO - 'LOGNAME': 'cltbld',
11:20:57 INFO - 'MAIL': '/var/mail/cltbld',
11:20:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1',
11:20:57 INFO - 'MOZ_NO_REMOTE': '1',
11:20:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript',
11:20:57 INFO - 'NO_EM_RESTART': '1',
11:20:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games',
11:20:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json',
11:20:57 INFO - 'PWD': '/builds/slave/test',
11:20:57 INFO - 'SHELL': '/bin/bash',
11:20:57 INFO - 'SHLVL': '1',
11:20:57 INFO - 'TERM': 'linux',
11:20:57 INFO - 'TMOUT': '86400',
11:20:57 INFO - 'USER': 'cltbld',
11:20:57 INFO - 'XDG_SESSION_COOKIE': '781b77c4c33858b1f599d705000001c1-1505217657.506684-1238802230',
11:20:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn',
11:20:57 INFO - '_': '/tools/buildbot/bin/python'}
11:20:58 INFO - Collecting jsonschema==2.5.1
11:20:59 INFO - Downloading http://pypi.pvt.build.mozilla.org/pub/jsonschema-2.5.1-py2.py3-none-any.whl
11:20:59 INFO - Collecting functools32; python_version == "2.7" (from jsonschema==2.5.1)
11:21:00 INFO - Downloading http://pypi.pvt.build.mozilla.org/pub/functools32-3.2.3-2.tar.gz
11:21:01 INFO - Installing collected packages: functools32, jsonschema
11:21:01 INFO - Running setup.py install for functools32: started
11:21:01 INFO - Running setup.py install for functools32: finished with status 'done'
11:21:01 INFO - Successfully installed functools32-3.2.3.post2 jsonschema-2.5.1
11:21:01 INFO - Return code: 0
11:21:01 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv
11:21:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]}
11:21:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org
11:21:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]}
11:21:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org
11:21:01 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d0d1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ed6a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2079a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x207d090>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x207dd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2077f90>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '781b77c4c33858b1f599d705000001c1-1505217657.506684-1238802230', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1
11:21:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build
11:21:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2
11:21:01 INFO - Using env: {'DISPLAY': ':0',
11:21:01 INFO - 'HOME': '/home/cltbld',
11:21:01 INFO - 'LANG': 'en_US.UTF-8',
11:21:01 INFO - 'LANGUAGE': 'en_US:en',
11:21:01 INFO - 'LOGNAME': 'cltbld',
11:21:01 INFO - 'MAIL': '/var/mail/cltbld',
11:21:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1',
11:21:01 INFO - 'MOZ_NO_REMOTE': '1',
11:21:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript',
11:21:01 INFO - 'NO_EM_RESTART': '1',
11:21:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games',
11:21:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json',
11:21:01 INFO - 'PWD': '/builds/slave/test',
11:21:01 INFO - 'SHELL': '/bin/bash',
11:21:01 INFO - 'SHLVL': '1',
11:21:01 INFO - 'TERM': 'linux',
11:21:01 INFO - 'TMOUT': '86400',
11:21:01 INFO - 'USER': 'cltbld',
11:21:01 INFO - 'XDG_SESSION_COOKIE': '781b77c4c33858b1f599d705000001c1-1505217657.506684-1238802230',
11:21:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn',
11:21:01 INFO - '_': '/tools/buildbot/bin/python'}
11:21:01 INFO - Requirement already satisfied: functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages
11:21:01 INFO - Return code: 0
11:21:01 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv
11:21:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]}
11:21:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org
11:21:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]}
11:21:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org
11:21:01 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d0d1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ed6a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2079a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x207d090>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x207dd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2077f90>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '781b77c4c33858b1f599d705000001c1-1505217657.506684-1238802230', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1
11:21:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build
11:21:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4
11:21:01 INFO - Using env: {'DISPLAY': ':0',
11:21:01 INFO - 'HOME': '/home/cltbld',
11:21:01 INFO - 'LANG': 'en_US.UTF-8',
11:21:01 INFO - 'LANGUAGE': 'en_US:en',
11:21:01 INFO - 'LOGNAME': 'cltbld',
11:21:01 INFO - 'MAIL': '/var/mail/cltbld',
11:21:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1',
11:21:01 INFO - 'MOZ_NO_REMOTE': '1',
11:21:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript',
11:21:01 INFO - 'NO_EM_RESTART': '1',
11:21:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games',
11:21:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json',
11:21:01 INFO - 'PWD': '/builds/slave/test',
11:21:01 INFO - 'SHELL': '/bin/bash',
11:21:01 INFO - 'SHLVL': '1',
11:21:01 INFO - 'TERM': 'linux',
11:21:01 INFO - 'TMOUT': '86400',
11:21:01 INFO - 'USER': 'cltbld',
11:21:01 INFO - 'XDG_SESSION_COOKIE': '781b77c4c33858b1f599d705000001c1-1505217657.506684-1238802230',
11:21:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn',
11:21:01 INFO - '_': '/tools/buildbot/bin/python'}
11:21:02 INFO - Collecting blobuploader==1.2.4
11:21:03 INFO - Downloading http://pypi.pvt.build.mozilla.org/pub/blobuploader-1.2.4.tar.gz
11:21:03 INFO - Collecting requests==1.2.3. (from blobuploader==1.2.4)
11:21:04 INFO - Downloading http://pypi.pvt.build.mozilla.org/pub/requests-1.2.3.tar.gz (348kB)
11:21:04 INFO - Collecting docopt==0.6.1 (from blobuploader==1.2.4)
11:21:06 INFO - Downloading http://pypi.pvt.build.mozilla.org/pub/docopt-0.6.1.tar.gz
11:21:06 INFO - Installing collected packages: requests, docopt, blobuploader
11:21:06 INFO - Running setup.py install for requests: started
11:21:06 INFO - Running setup.py install for requests: finished with status 'done'
11:21:06 INFO - Running setup.py install for docopt: started
11:21:06 INFO - Running setup.py install for docopt: finished with status 'done'
11:21:06 INFO - Running setup.py install for blobuploader: started
11:21:06 INFO - Running setup.py install for blobuploader: finished with status 'done'
11:21:07 INFO - Successfully installed blobuploader-1.2.4 docopt-0.6.1 requests-1.2.3
11:21:07 INFO - Return code: 0
11:21:07 INFO - Installing None into virtualenv /builds/slave/test/build/venv
11:21:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]}
11:21:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org
11:21:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]}
11:21:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org
11:21:07 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d0d1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ed6a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2079a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x207d090>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x207dd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2077f90>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '781b77c4c33858b1f599d705000001c1-1505217657.506684-1238802230', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1
11:21:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config
11:21:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub
11:21:07 INFO - Using env: {'DISPLAY': ':0',
11:21:07 INFO - 'HOME': '/home/cltbld',
11:21:07 INFO - 'LANG': 'en_US.UTF-8',
11:21:07 INFO - 'LANGUAGE': 'en_US:en',
11:21:07 INFO - 'LOGNAME': 'cltbld',
11:21:07 INFO - 'MAIL': '/var/mail/cltbld',
11:21:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1',
11:21:07 INFO - 'MOZ_NO_REMOTE': '1',
11:21:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript',
11:21:07 INFO - 'NO_EM_RESTART': '1',
11:21:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games',
11:21:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json',
11:21:07 INFO - 'PWD': '/builds/slave/test',
11:21:07 INFO - 'SHELL': '/bin/bash',
11:21:07 INFO - 'SHLVL': '1',
11:21:07 INFO - 'TERM': 'linux',
11:21:07 INFO - 'TMOUT': '86400',
11:21:07 INFO - 'USER': 'cltbld',
11:21:07 INFO - 'XDG_SESSION_COOKIE': '781b77c4c33858b1f599d705000001c1-1505217657.506684-1238802230',
11:21:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn',
11:21:07 INFO - '_': '/tools/buildbot/bin/python'}
11:21:07 INFO - Processing /builds/slave/test/build/tests/mozbase/manifestparser
11:21:07 INFO - Processing /builds/slave/test/build/tests/mozbase/mozcrash
11:21:07 INFO - Processing /builds/slave/test/build/tests/mozbase/mozdebug
11:21:07 INFO - Processing /builds/slave/test/build/tests/mozbase/mozdevice
11:21:07 INFO - Processing /builds/slave/test/build/tests/mozbase/mozfile
11:21:08 INFO - Processing /builds/slave/test/build/tests/mozbase/mozhttpd
11:21:08 INFO - Processing /builds/slave/test/build/tests/mozbase/mozinfo
11:21:08 INFO - Processing /builds/slave/test/build/tests/mozbase/mozinstall
11:21:08 INFO - Processing /builds/slave/test/build/tests/mozbase/mozleak
11:21:08 INFO - Processing /builds/slave/test/build/tests/mozbase/mozlog
11:21:08 INFO - Processing /builds/slave/test/build/tests/mozbase/moznetwork
11:21:08 INFO - Processing /builds/slave/test/build/tests/mozbase/mozprocess
11:21:08 INFO - Processing /builds/slave/test/build/tests/mozbase/mozprofile
11:21:08 INFO - Processing /builds/slave/test/build/tests/mozbase/mozrunner
11:21:08 INFO - Processing /builds/slave/test/build/tests/mozbase/mozscreenshot
11:21:09 INFO - Processing /builds/slave/test/build/tests/mozbase/moztest
11:21:09 INFO - Processing /builds/slave/test/build/tests/mozbase/mozversion
11:21:09 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion
11:21:09 INFO - Running setup.py install for manifestparser: started
11:21:09 INFO - Running setup.py install for manifestparser: finished with status 'done'
11:21:09 INFO - Running setup.py install for mozcrash: started
11:21:09 INFO - Running setup.py install for mozcrash: finished with status 'done'
11:21:09 INFO - Running setup.py install for mozdebug: started
11:21:09 INFO - Running setup.py install for mozdebug: finished with status 'done'
11:21:09 INFO - Running setup.py install for mozdevice: started
11:21:09 INFO - Running setup.py install for mozdevice: finished with status 'done'
11:21:09 INFO - Running setup.py install for mozfile: started
11:21:09 INFO - Running setup.py install for mozfile: finished with status 'done'
11:21:09 INFO - Running setup.py install for mozhttpd: started
11:21:09 INFO - Running setup.py install for mozhttpd: finished with status 'done'
11:21:09 INFO - Running setup.py install for mozinfo: started
11:21:09 INFO - Running setup.py install for mozinfo: finished with status 'done'
11:21:09 INFO - Running setup.py install for mozInstall: started
11:21:10 INFO - Running setup.py install for mozInstall: finished with status 'done'
11:21:10 INFO - Running setup.py install for mozleak: started
11:21:10 INFO - Running setup.py install for mozleak: finished with status 'done'
11:21:10 INFO - Running setup.py install for mozlog: started
11:21:10 INFO - Running setup.py install for mozlog: finished with status 'done'
11:21:10 INFO - Running setup.py install for moznetwork: started
11:21:10 INFO - Running setup.py install for moznetwork: finished with status 'done'
11:21:10 INFO - Running setup.py install for mozprocess: started
11:21:10 INFO - Running setup.py install for mozprocess: finished with status 'done'
11:21:10 INFO - Running setup.py install for mozprofile: started
11:21:10 INFO - Running setup.py install for mozprofile: finished with status 'done'
11:21:10 INFO - Running setup.py install for mozrunner: started
11:21:10 INFO - Running setup.py install for mozrunner: finished with status 'done'
11:21:10 INFO - Running setup.py install for mozscreenshot: started
11:21:10 INFO - Running setup.py install for mozscreenshot: finished with status 'done'
11:21:10 INFO - Running setup.py install for moztest: started
11:21:10 INFO - Running setup.py install for moztest: finished with status 'done'
11:21:10 INFO - Running setup.py install for mozversion: started
11:21:11 INFO - Running setup.py install for mozversion: finished with status 'done'
11:21:11 INFO - Successfully installed manifestparser-1.1 mozInstall-1.13 mozcrash-1.0 mozdebug-0.1 mozdevice-0.51 mozfile-1.2 mozhttpd-0.7 mozinfo-0.10 mozleak-0.1 mozlog-3.5 moznetwork-0.27 mozprocess-0.25 mozprofile-0.28 mozrunner-6.13 mozscreenshot-0.1 moztest-0.8 mozversion-1.4
11:21:11 INFO - Return code: 0
11:21:11 INFO - Installing None into virtualenv /builds/slave/test/build/venv
11:21:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]}
11:21:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org
11:21:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]}
11:21:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org
11:21:11 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d0d1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ed6a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2079a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x207d090>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x207dd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2077f90>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '781b77c4c33858b1f599d705000001c1-1505217657.506684-1238802230', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1
11:21:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config
11:21:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub
11:21:11 INFO - Using env: {'DISPLAY': ':0',
11:21:11 INFO - 'HOME': '/home/cltbld',
11:21:11 INFO - 'LANG': 'en_US.UTF-8',
11:21:11 INFO - 'LANGUAGE': 'en_US:en',
11:21:11 INFO - 'LOGNAME': 'cltbld',
11:21:11 INFO - 'MAIL': '/var/mail/cltbld',
11:21:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1',
11:21:11 INFO - 'MOZ_NO_REMOTE': '1',
11:21:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript',
11:21:11 INFO - 'NO_EM_RESTART': '1',
11:21:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games',
11:21:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json',
11:21:11 INFO - 'PWD': '/builds/slave/test',
11:21:11 INFO - 'SHELL': '/bin/bash',
11:21:11 INFO - 'SHLVL': '1',
11:21:11 INFO - 'TERM': 'linux',
11:21:11 INFO - 'TMOUT': '86400',
11:21:11 INFO - 'USER': 'cltbld',
11:21:11 INFO - 'XDG_SESSION_COOKIE': '781b77c4c33858b1f599d705000001c1-1505217657.506684-1238802230',
11:21:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn',
11:21:11 INFO - '_': '/tools/buildbot/bin/python'}
11:21:11 INFO - Processing /builds/slave/test/build/tests/mozbase/manifestparser
11:21:11 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1))
11:21:11 INFO - Processing /builds/slave/test/build/tests/mozbase/mozcrash
11:21:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2))
11:21:11 INFO - Processing /builds/slave/test/build/tests/mozbase/mozdebug
11:21:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3))
11:21:12 INFO - Processing /builds/slave/test/build/tests/mozbase/mozdevice
11:21:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.51 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4))
11:21:12 INFO - Processing /builds/slave/test/build/tests/mozbase/mozfile
11:21:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5))
11:21:12 INFO - Processing /builds/slave/test/build/tests/mozbase/mozhttpd
11:21:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6))
11:21:12 INFO - Processing /builds/slave/test/build/tests/mozbase/mozinfo
11:21:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.10 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7))
11:21:12 INFO - Processing /builds/slave/test/build/tests/mozbase/mozinstall
11:21:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.13 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8))
11:21:12 INFO - Processing /builds/slave/test/build/tests/mozbase/mozleak
11:21:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9))
11:21:12 INFO - Processing /builds/slave/test/build/tests/mozbase/mozlog
11:21:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.5 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10))
11:21:12 INFO - Processing /builds/slave/test/build/tests/mozbase/moznetwork
11:21:12 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11))
11:21:12 INFO - Processing /builds/slave/test/build/tests/mozbase/mozprocess
11:21:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.25 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12))
11:21:12 INFO - Processing /builds/slave/test/build/tests/mozbase/mozprofile
11:21:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13))
11:21:12 INFO - Processing /builds/slave/test/build/tests/mozbase/mozrunner
11:21:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14))
11:21:12 INFO - Processing /builds/slave/test/build/tests/mozbase/mozscreenshot
11:21:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15))
11:21:13 INFO - Processing /builds/slave/test/build/tests/mozbase/moztest
11:21:13 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16))
11:21:13 INFO - Processing /builds/slave/test/build/tests/mozbase/mozversion
11:21:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17))
11:21:13 INFO - Requirement already satisfied: mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2))
11:21:13 INFO - Requirement already satisfied: mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2))
11:21:13 INFO - Requirement already satisfied: mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3))
11:21:13 INFO - Requirement already satisfied: moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.51->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4))
11:21:13 INFO - Requirement already satisfied: mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.51->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4))
11:21:13 INFO - Requirement already satisfied: requests in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozInstall==1.13->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8))
11:21:13 INFO - Collecting blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10))
11:21:14 INFO - Downloading http://pypi.pvt.build.mozilla.org/pub/blessings-1.6.tar.gz
11:21:14 INFO - Installing collected packages: blessings
11:21:14 INFO - Running setup.py install for blessings: started
11:21:14 INFO - Running setup.py install for blessings: finished with status 'done'
11:21:14 INFO - Successfully installed blessings-1.6
11:21:14 INFO - Return code: 0
11:21:14 INFO - Done creating virtualenv /builds/slave/test/build/venv.
11:21:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze']
11:21:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze
11:21:15 INFO - Reading from file tmpfile_stdout
11:21:15 INFO - Reading from file tmpfile_stderr
11:21:15 INFO - Current package versions:
11:21:15 INFO - blessings == 1.6
11:21:15 INFO - blobuploader == 1.2.4
11:21:15 INFO - docopt == 0.6.1
11:21:15 INFO - functools32 == 3.2.3.post2
11:21:15 INFO - jsonschema == 2.5.1
11:21:15 INFO - manifestparser == 1.1
11:21:15 INFO - mozInstall == 1.13
11:21:15 INFO - mozcrash == 1.0
11:21:15 INFO - mozdebug == 0.1
11:21:15 INFO - mozdevice == 0.51
11:21:15 INFO - mozfile == 1.2
11:21:15 INFO - mozhttpd == 0.7
11:21:15 INFO - mozinfo == 0.10
11:21:15 INFO - mozleak == 0.1
11:21:15 INFO - mozlog == 3.5
11:21:15 INFO - moznetwork == 0.27
11:21:15 INFO - mozprocess == 0.25
11:21:15 INFO - mozprofile == 0.28
11:21:15 INFO - mozrunner == 6.13
11:21:15 INFO - mozscreenshot == 0.1
11:21:15 INFO - mozsystemmonitor == 0.3
11:21:15 INFO - moztest == 0.8
11:21:15 INFO - mozversion == 1.4
11:21:15 INFO - psutil == 3.1.1
11:21:15 INFO - requests == 1.2.3
11:21:15 INFO - Installing None into virtualenv /builds/slave/test/build/venv
11:21:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]}
11:21:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org
11:21:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]}
11:21:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org
11:21:15 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d0d1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ed6a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2079a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x207d090>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x207dd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2077f90>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/talos', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '781b77c4c33858b1f599d705000001c1-1505217657.506684-1238802230', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1
11:21:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos
11:21:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub
11:21:15 INFO - Using env: {'DISPLAY': ':0',
11:21:15 INFO - 'HOME': '/home/cltbld',
11:21:15 INFO - 'LANG': 'en_US.UTF-8',
11:21:15 INFO - 'LANGUAGE': 'en_US:en',
11:21:15 INFO - 'LOGNAME': 'cltbld',
11:21:15 INFO - 'MAIL': '/var/mail/cltbld',
11:21:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1',
11:21:15 INFO - 'MOZ_NO_REMOTE': '1',
11:21:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript',
11:21:15 INFO - 'NO_EM_RESTART': '1',
11:21:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games',
11:21:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json',
11:21:15 INFO - 'PWD': '/builds/slave/test',
11:21:15 INFO - 'SHELL': '/bin/bash',
11:21:15 INFO - 'SHLVL': '1',
11:21:15 INFO - 'TERM': 'linux',
11:21:15 INFO - 'TMOUT': '86400',
11:21:15 INFO - 'USER': 'cltbld',
11:21:15 INFO - 'XDG_SESSION_COOKIE': '781b77c4c33858b1f599d705000001c1-1505217657.506684-1238802230',
11:21:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn',
11:21:15 INFO - '_': '/tools/buildbot/bin/python'}
11:21:15 INFO - Requirement already satisfied: mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1))
11:21:15 INFO - Requirement already satisfied: mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2))
11:21:15 INFO - Requirement already satisfied: mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3))
11:21:15 INFO - Requirement already satisfied: mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4))
11:21:15 INFO - Requirement already satisfied: mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5))
11:21:15 INFO - Requirement already satisfied: mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6))
11:21:15 INFO - Requirement already satisfied: mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7))
11:21:15 INFO - Requirement already satisfied: mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8))
11:21:15 INFO - Requirement already satisfied: psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9))
11:21:15 INFO - Collecting simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10))
11:21:17 INFO - Downloading http://pypi.pvt.build.mozilla.org/pub/simplejson-3.3.0.tar.gz (67kB)
11:21:17 INFO - Requirement already satisfied: blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1))
11:21:17 INFO - Requirement already satisfied: moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4))
11:21:17 INFO - Installing collected packages: simplejson
11:21:17 INFO - Running setup.py install for simplejson: started
11:21:18 INFO - Running setup.py install for simplejson: finished with status 'done'
11:21:18 INFO - Successfully installed simplejson-3.3.0
11:21:18 INFO - Return code: 0
11:21:18 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv
11:21:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]}
11:21:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org
11:21:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]}
11:21:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org
11:21:18 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d0d1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ed6a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2079a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x207d090>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x207dd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2077f90>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '781b77c4c33858b1f599d705000001c1-1505217657.506684-1238802230', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1
11:21:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build
11:21:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema
11:21:18 INFO - Using env: {'DISPLAY': ':0',
11:21:18 INFO - 'HOME': '/home/cltbld',
11:21:18 INFO - 'LANG': 'en_US.UTF-8',
11:21:18 INFO - 'LANGUAGE': 'en_US:en',
11:21:18 INFO - 'LOGNAME': 'cltbld',
11:21:18 INFO - 'MAIL': '/var/mail/cltbld',
11:21:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1',
11:21:18 INFO - 'MOZ_NO_REMOTE': '1',
11:21:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript',
11:21:18 INFO - 'NO_EM_RESTART': '1',
11:21:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games',
11:21:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json',
11:21:18 INFO - 'PWD': '/builds/slave/test',
11:21:18 INFO - 'SHELL': '/bin/bash',
11:21:18 INFO - 'SHLVL': '1',
11:21:18 INFO - 'TERM': 'linux',
11:21:18 INFO - 'TMOUT': '86400',
11:21:18 INFO - 'USER': 'cltbld',
11:21:18 INFO - 'XDG_SESSION_COOKIE': '781b77c4c33858b1f599d705000001c1-1505217657.506684-1238802230',
11:21:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn',
11:21:18 INFO - '_': '/tools/buildbot/bin/python'}
11:21:18 INFO - Requirement already satisfied: jsonschema in ./venv/lib/python2.7/site-packages
11:21:18 INFO - Requirement already satisfied: functools32; python_version == "2.7" in ./venv/lib/python2.7/site-packages (from jsonschema)
11:21:18 INFO - Return code: 0
11:21:18 INFO - Running post-action listener: _resource_record_post_action
11:21:18 INFO - Running post-action listener: _start_resource_monitoring
11:21:18 INFO - Starting resource monitoring.
11:21:18 INFO - [mozharness: 2017-09-12 18:21:18.926637Z] Finished create-virtualenv step (success)
11:21:18 INFO - [mozharness: 2017-09-12 18:21:18.927156Z] Running install step.
11:21:18 INFO - Running pre-action listener: _resource_record_pre_action
11:21:18 INFO - Running main action method: install
11:21:18 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze']
11:21:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze
11:21:19 INFO - Reading from file tmpfile_stdout
11:21:19 INFO - Detecting whether we're running mozinstall >=1.0...
11:21:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h']
11:21:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h
11:21:19 INFO - Reading from file tmpfile_stdout
11:21:19 INFO - Output received:
11:21:19 INFO - Usage: mozinstall [options] installer
11:21:19 INFO - Options:
11:21:19 INFO - -h, --help show this help message and exit
11:21:19 INFO - -d DEST, --destination=DEST
11:21:19 INFO - Directory to install application into. [default:
11:21:19 INFO - "/builds/slave/test"]
11:21:19 INFO - --app=APP Application being installed. [default: firefox]
11:21:19 INFO - mkdir: /builds/slave/test/build/application
11:21:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/target.tar.bz2', '--destination', '/builds/slave/test/build/application']
11:21:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application
11:21:36 INFO - Reading from file tmpfile_stdout
11:21:36 INFO - Output received:
11:21:36 INFO - /builds/slave/test/build/application/firefox/firefox
11:21:36 INFO - Running post-action listener: _resource_record_post_action
11:21:36 INFO - [mozharness: 2017-09-12 18:21:36.285527Z] Finished install step (success)
11:21:36 INFO - [mozharness: 2017-09-12 18:21:36.285779Z] Running setup-mitmproxy step.
11:21:36 INFO - Running pre-action listener: _resource_record_pre_action
11:21:36 INFO - Running main action method: setup_mitmproxy
11:21:36 INFO - Skipping: mitmproxy is not required
11:21:36 INFO - Running post-action listener: _resource_record_post_action
11:21:36 INFO - [mozharness: 2017-09-12 18:21:36.286897Z] Finished setup-mitmproxy step (success)
11:21:36 INFO - [mozharness: 2017-09-12 18:21:36.287115Z] Running run-tests step.
11:21:36 INFO - Running pre-action listener: _resource_record_pre_action
11:21:36 INFO - Running pre-action listener: _set_gcov_prefix
11:21:36 INFO - Running main action method: run_tests
11:21:36 WARNING - Try message not found.
11:21:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version']
11:21:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version
11:21:36 INFO - Python 2.7.3
11:21:36 INFO - Return code: 0
11:21:36 INFO - grabbing minidump binary from tooltool
11:21:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]}
11:21:36 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://tooltool.mozilla-releng.net/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x207d090>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x207dd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2077f90>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1
11:21:36 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://tooltool.mozilla-releng.net/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build
11:21:36 INFO - Copy/paste: /tools/tooltool.py --url https://tooltool.mozilla-releng.net/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache
11:21:36 INFO - Calling ['/tools/tooltool.py', '--url', 'https://tooltool.mozilla-releng.net/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600
11:21:36 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache
11:21:36 INFO - Return code: 0
11:21:36 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755
11:21:36 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir
11:21:36 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir
11:21:36 INFO - ENV: RUST_BACKTRACE is now full
11:21:36 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk
11:21:36 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir
11:21:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/eW846iPkS8eiD1elPeIpkA/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-080', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build
11:21:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/eW846iPkS8eiD1elPeIpkA/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-080 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log
11:21:36 INFO - Using env: {'DISPLAY': ':0',
11:21:36 INFO - 'HOME': '/home/cltbld',
11:21:36 INFO - 'LANG': 'en_US.UTF-8',
11:21:36 INFO - 'LANGUAGE': 'en_US:en',
11:21:36 INFO - 'LOGNAME': 'cltbld',
11:21:36 INFO - 'MAIL': '/var/mail/cltbld',
11:21:36 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir',
11:21:36 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk',
11:21:36 INFO - 'MOZ_ACCELERATED': '1',
11:21:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1',
11:21:36 INFO - 'MOZ_NO_REMOTE': '1',
11:21:36 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir',
11:21:36 INFO - 'MOZ_WEBRENDER': '1',
11:21:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript',
11:21:36 INFO - 'NO_EM_RESTART': '1',
11:21:36 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games',
11:21:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json',
11:21:36 INFO - 'PWD': '/builds/slave/test',
11:21:36 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos',
11:21:36 INFO - 'RUST_BACKTRACE': 'full',
11:21:36 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts',
11:21:36 INFO - 'SHELL': '/bin/bash',
11:21:36 INFO - 'SHLVL': '1',
11:21:36 INFO - 'TERM': 'linux',
11:21:36 INFO - 'TMOUT': '86400',
11:21:36 INFO - 'USER': 'cltbld',
11:21:36 INFO - 'XDG_SESSION_COOKIE': '781b77c4c33858b1f599d705000001c1-1505217657.506684-1238802230',
11:21:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn',
11:21:36 INFO - '_': '/tools/buildbot/bin/python'}
11:21:36 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/eW846iPkS8eiD1elPeIpkA/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-080', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600
11:21:36 INFO - mozversion application_buildid: 20170912172933
11:21:36 INFO - mozversion application_changeset: a73cc4e08bf5a005722c95b43f84ab0c8ff2bc7c
11:21:36 INFO - mozversion application_display_name: Nightly
11:21:36 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384}
11:21:36 INFO - mozversion application_name: Firefox
11:21:36 INFO - mozversion application_remotingname: firefox
11:21:36 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central
11:21:36 INFO - mozversion application_vendor: Mozilla
11:21:36 INFO - mozversion application_version: 57.0a1
11:21:36 INFO - mozversion platform_buildid: 20170912172933
11:21:36 INFO - mozversion platform_changeset: a73cc4e08bf5a005722c95b43f84ab0c8ff2bc7c
11:21:36 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central
11:21:36 INFO - mozversion platform_version: 57.0a1
11:21:36 INFO - using testdate: 1505240496
11:21:36 INFO - actual date: 1505240496
11:21:36 INFO - starting webserver on 'localhost:49341'
11:21:36 INFO - SUITE-START | Running 2 tests
11:21:36 INFO - TEST-START | dromaeo_css
11:21:36 INFO - Initialising browser for dromaeo_css test...
11:21:36 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:49341/getInfo.html -profile /tmp/tmp5iPcBr/profile
11:21:36 INFO - TEST-INFO | started process 16198 (/builds/slave/test/build/application/firefox/firefox http://localhost:49341/getInfo.html)
11:21:44 INFO - TEST-INFO | 16198: exit 0
11:21:44 INFO - Browser initialized.
11:21:44 INFO - Running cycle 1/1 for dromaeo_css test...
11:21:44 INFO - Using env: {'DISPLAY': ':0',
11:21:44 INFO - 'HOME': '/home/cltbld',
11:21:44 INFO - 'JSGC_DISABLE_POISONING': '1',
11:21:44 INFO - 'LANG': 'en_US.UTF-8',
11:21:44 INFO - 'LANGUAGE': 'en_US:en',
11:21:44 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox',
11:21:44 INFO - 'LOGNAME': 'cltbld',
11:21:44 INFO - 'MAIL': '/var/mail/cltbld',
11:21:44 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir',
11:21:44 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk',
11:21:44 INFO - 'MOZ_ACCELERATED': '1',
11:21:44 INFO - 'MOZ_CRASHREPORTER': '1',
11:21:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1',
11:21:44 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1',
11:21:44 INFO - 'MOZ_NO_REMOTE': '1',
11:21:44 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir',
11:21:44 INFO - 'MOZ_WEBRENDER': '1',
11:21:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript',
11:21:44 INFO - 'NO_EM_RESTART': '1',
11:21:44 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games',
11:21:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json',
11:21:44 INFO - 'PWD': '/builds/slave/test',
11:21:44 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos',
11:21:44 INFO - 'RUST_BACKTRACE': 'full',
11:21:44 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts',
11:21:44 INFO - 'SHELL': '/bin/bash',
11:21:44 INFO - 'SHLVL': '1',
11:21:44 INFO - 'TERM': 'linux',
11:21:44 INFO - 'TMOUT': '86400',
11:21:44 INFO - 'USER': 'cltbld',
11:21:44 INFO - 'XDG_SESSION_COOKIE': '781b77c4c33858b1f599d705000001c1-1505217657.506684-1238802230',
11:21:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn',
11:21:44 INFO - '_': '/tools/buildbot/bin/python'}
11:21:44 INFO - TEST-INFO | started process 16403 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp5iPcBr/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1)
11:21:45 INFO - PID 16403 | WebRender - OpenGL version new 3.2.0 NVIDIA 361.42
11:21:45 INFO - PID 16403 | WebRender - OpenGL version new 3.2.0 NVIDIA 361.42
11:21:45 INFO - PID 16403 |
11:21:45 INFO - PID 16403 | (/builds/slave/test/build/application/firefox/firefox:16463): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied
11:21:45 INFO - PID 16403 |
11:21:56 INFO - PID 16403 | RSS: Main: 217407488
11:21:56 INFO - PID 16403 |
11:24:53 INFO - PID 16403 | Cycle 1(1): loaded http://localhost:49341/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49341/tests/dromaeo/cssquery-ext.html)
11:24:54 INFO - PID 16403 | RSS: Main: 225529856
11:24:54 INFO - PID 16403 |
11:27:56 INFO - PID 16403 | Cycle 1(1): loaded http://localhost:49341/tests/dromaeo/cssquery-ext.html (next: http://localhost:49341/tests/dromaeo/cssquery-jquery.html)
11:27:57 INFO - PID 16403 | RSS: Main: 222822400
11:27:57 INFO - PID 16403 |
11:30:59 INFO - PID 16403 | Cycle 1(1): loaded http://localhost:49341/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49341/tests/dromaeo/cssquery-mootools.html)
11:30:59 INFO - PID 16403 | RSS: Main: 225259520
11:30:59 INFO - PID 16403 |
11:34:01 INFO - PID 16403 | Cycle 1(1): loaded http://localhost:49341/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49341/tests/dromaeo/cssquery-prototype.html)
11:34:02 INFO - PID 16403 | RSS: Main: 223567872
11:34:02 INFO - PID 16403 |
11:37:06 INFO - PID 16403 | Cycle 1(1): loaded http://localhost:49341/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49341/tests/dromaeo/cssquery-yui.html)
11:37:06 INFO - PID 16403 | RSS: Main: 226906112
11:37:06 INFO - PID 16403 |
11:40:08 INFO - PID 16403 | Cycle 1(1): loaded http://localhost:49341/tests/dromaeo/cssquery-yui.html (next: http://localhost:49341/tests/dromaeo/cssquery-dojo.html)
11:40:09 INFO - PID 16403 | RSS: Main: 227483648
11:40:09 INFO - PID 16403 |
11:40:09 INFO - PID 16403 | __start_tp_report
11:40:09 INFO - PID 16403 | _x_x_mozilla_page_load
11:40:09 INFO - PID 16403 | _x_x_mozilla_page_load_details
11:40:09 INFO - PID 16403 | |i|pagename|runs|
11:40:09 INFO - PID 16403 | |0;dojo.html;3101.6743241959593;3112.937741245175;3130.733887619552;3134.8275844828527;3142.135912624028;6101.0848372744;6139.969300153504;6174.598651087676;6210.913090209212;6268.655223962686;6112.877742445148;6175.845603859906;6180.752769889199;6194.349593292707;6221.253449586045;5708.486236238738;5781.13283007549;5787;5815.418458154193;5849.941500584982;225.02530121163113;5667.234923285345;5718.971405142968;5726.226959360475;5734.225879506276;5623.409541998113;5626.859328516799;5627.7186140693;5682.488576028136;5693.516051135638;5622.775088996435;5629.183768353566;5697.1169468732;5708.029634962067;5714.914276285859;5592.664440133564;5594.14698503762;5680.289963754531;5680.6591604503865;5684.744186511617;6061.939380606225;6080.118382834465;6181.876362472771;6217.720202590849;6221.377862213742;6559.540832141752;6578.671066446658;6633.237177724575;6648.9667551662415;6667.033280174348;6671;6680.365365290289;6757.493188010919;6769.458443324522;6770.932290677079;6138.202033735631;6182.876342473171;6198.070289456573;6205.193324867783;6216.222972128484;6776.08522849409;6782.491313151533;6787.66061696923;6806.183258008971;6807.795766127024;6609.6364699941005;6633.568818026813;6652.600843949379;6655.567388119756;6659.733610655519;6658.201015878029;6672.332766723289;6746.0892779475125;6750.223724271772;6761.830954226184;6585.5832084554995;6634.038064480624;6655.900161497581;6738.865222695518;6756.324367563303;6481.578697384655;6605.70274337656;6641.335866413417;6664.466842652673;6764.3573860483175;5222.112240919053;5230.712310822865;5243.134882744381;5284.841454756363;5305.840824775263;4606.930896036562;4624.30635404692;4661.487236403993;4695.741734204652;4716.716996980193;5780.046292361713;5781.219535362672;5834.970825145932;5856.443637854397;5862.530997520188;6568.573042752206;6692.397684208445;6699.9665001674675;6724.226713927863;6802.625855577891;5653.830385088454;5694.6583205007;5713.342965558931;5730.684812335361;5733.168690539848;5651.604387692904;5660.462256085665;5681.0626246668835;5714.657120572779;5813.651180929158;6505.121808555879;6563.573367731177;6579.572327798678;6601.603903765789;6616.206055273302;6665.533412661067;6674.766383176566;6692.431143352869;6777.830554235987;6786.728530858711;6359.173307470184;6441.452476539546;6448.613083215022;6449;6460;6435.420812126931;6440.516961228021;6514.511411644051;6529.836754081186;6536.640484773383;6760.695768690519;6771.322867713189;6772.729090836311;6808.7276508939085;6821.761238356634;6483.286838447862;6498;6560;6562.376574225441;6586.70359833799;6412.775552855627;6469.253301608445;6537.7058032389605;6570.5400621957915;6573.769918052845;6235.532335074797;6321.96839015802;6336.683165841781;6406.743730250738;6434.581752186093;6437.420632143129;6562.114114594659;6603.240627327918;6606.240282367397;6636.701348439428;6263.74945002213;6272.655003974825;6342.587731797418;6351.872962540816;6358.936410635834
11:40:09 INFO - PID 16403 | |1;ext.html;797.1749239537079;801.3308887079285;805.0822062848354;807.5598798654732;820.5897051474263;39721.40417893734;40207.79896100519;40258.19483610326;40265.59734402655;40589.59410405895;37339;37481.25037499255;37604.247915041684;37694.434583481205;40398.19203615933;7569.545827250355;7700.6919723211;7727.497712648688;7734.1492435832015;7755.728549500768;7626.923730762677;7735.265149810759;7768.7669369918995;7769.728059517918;7797.922020779804;7747.6513556889795;7780.02749656293;7794.727184548542;7800.882986755203;7800.960995195016;7648.158702542716;7729.497582657137;7738.110117336466;7754.457187996843;7779.7666070017995;7564.735234266775;7630.504017238862;7652.655630496585;7670.4247181461615;7683.231676832272;37524.43713344302;37539.249215015545;37596.24807503835;37663;37728;3438.896833095011;3494.1614012637037;3504.8083651558336;3506.403911335079;3513.7189024878203;31261.84369078163;31506;31566.684333156605;31611.52582711261;31679.524807127913;5010.924836127461;5150.690958542499;5244.239585260116;5269.525742683139;5329.387120481117;178114.10942945332;178812;180243;180308;182413;40912.38631420531;41082.58917410847;48058.51941480541;49280;49460.75269623629;51769.48230517722;51823.74088129535;51850.48149518532;51883.22175167376;51883.22175167376;13711.931440342734;13765.655858603615;13911.65220869466;13991.58025259244;14016.229107399191;11243.887561124284;11313.604023859125;11315.717107072225;11337.093032557375;11338.319700817812;13367.398467069006;13477.528286509925;13522.459101636021;13631.113977591425;13695.246761428018;5225.346831646044;5269.710165940834;5280.788768449296;5348.331458567679;5366.928252801144;1012.4330374990029;1017.1862509991977;1021.341234903483;1037.8339465685606;1056.1972900595604;22710.886445567998;22965.770342296364;23086.42283942915;23182.072717091465;23220.656528411546;1103.7847619714078;1119.5969450997798;1121.7644294698205;1134.3364131982717;1135.5401062569672;12081.214721043105;12149.817752733716;12323.876761232452;12359.75280494403;12414;223098;224985;225259;226088;226557;51482.742586287575;51637.483625164015;51744.74127629413;51793.48206517962;51964;1391.589481103077;1461.8026566413612;1469.4048910191389;1476.5791749351383;1479.2012313350886;21700.565988680453;22145.667814982466;22193.334199974026;22685.659715104615;22699.432514187276;32883.34233315368;32900.1774955628;35509.11227219237;36491;36803.81598091992;190102;191127;191870;191873;191970;30744.077677669706;31060;31120.688793112684;31157.37685246237;34058.318833623685;37884.43173352457;42636.36045459383;43136.35295470508;43490.78254608833;43883.78058109689;31217.53173702351;31541.526877096403;31690.524642130847;31904.521432179;32391.51412728858;31422.37155256928;31493.370132597676;31537.684623154393;31790.841045794623;32254;35046;35884.10289742777;36372;36541;36550;30957;30998.22504437407;31125.844370778002;31281;31648.841755791073;22273;22321;22482.213122540634;22920.541589168457;23065.65401519012
11:40:09 INFO - PID 16403 | |2;jquery.html;552.8700755322499;565.7850016993542;570.5093619487243;573.698808125734;588.5115354255968;21632.89183554082;22013.33959981201;22173;22272.443188920264;22310.33069007928;22718.204862829803;23938.76061239387;23983.520329593397;24142;24271.75728242717;6366.968165159179;6494.415502604765;6500.382463665967;6542.803715888531;6572.112764776742;6400.359964003609;6491.285958544557;6540.640264785435;6545.803625891231;6549.34506549346;6223.471004964584;6364.554481186319;6455;6458.192725909262;6498.44763195129;6461.7738379156735;6468.676566171673;6515.967420162869;6531.281559028503;6542.640154791485;6013.54898382623;6033.849153771191;6037.577369584131;6047.818565443044;6072.362401947776;27380.45239095227;28325.85837070822;28501.85749071262;28565.57151642727;28657.140285791458;2035.5521785207231;2065.9483512912147;2079.313826437272;2085.0825636719946;2088.488320361506;18648.720269195837;19023;19444.416667499856;19473.318433854747;19477.220911163535;2324.604817181066;2365.44412063165;2395.161693407311;2406.843555168926;2409.6265078912797;114668;119944.40027799805;125606;133836;134049;14207.857921420653;14356.569302920929;14440.133591984515;14777.891658125469;14877.181755003363;21894.78105218959;22070.558588828135;22147.778522214572;22183;22198.55602887933;8282.50304981703;8561.571921403905;8754.124587541322;8763;8830.337724670675;7705;7709.151993280735;7719.498232614862;7739.613019349123;7772.844543109106;8828.382013259139;8842.867356989651;8925.241354484811;9032.8645070324;9057.230135438562;2676.0929043596566;2679.5176868163526;2683.4767220391836;2728.3357152137182;2759.9448011039667;974.3861367338532;976.9951150244203;986.4180133721139;993.6025589764153;1010.8281592129356;18552.536186595444;18806.580453593393;19188.520286992658;19409.9324537149;19483.415497535098;1007.3955626623967;1008.1632245236436;1026.7638443157966;1027.157730660851;1033.8449232615017;10492.580296788195;10585.894141058645;10618.203634727426;10737.51681174349;10774.515146818256;447872;459733;459774;462677;470489;108305;109825;113028;113262.43368783103;115235;1036.4662198967537;1086.9130469562417;1137.8862113788555;1155.064397837754;1203.4825025239231;19929.402117936486;20023.29918452847;20116.89941550283;20196.899015504827;20651.380458586267;52634;53060.4693953071;53138;54221.18668219901;54563.727181363836;66725;67388.6630566844;67594.66202668955;68082;68083;13850.16898986064;14215.218163001135;14310.928445357707;14332.85667143357;14427.711445770816;22253.21974242089;22557.43606409853;22610.547789044456;22645.773542264367;22659.43351416228;17443.127843607515;17799.822001780336;18062.819371806112;18208.544786380447;18493;15017.32422040989;15881;16263.756043659117;16290;16765.91617041907;16619.41832035873;17216.483505494856;17325.82674173242;18093.728594070835;18481.53796155107;14052.016358854782;14090.22503762303;14171.929140354232;14181.290935453393;14290.785638215642;17445.38941137105;17447.47657570275;17540.649187016443;17833.46499605014;17934
11:40:09 INFO - PID 16403 | |3;mootools.html;1254.6612414648046;1341.5572860955886;1347.416785277299;1347.7102422979065;1357.633438971477;14784.704305913876;15315.617109572238;15468.303926323315;15475.69048619027;15487.922560387211;15127.924360378183;15203.695926081471;15229.543113706606;15242.314095865684;15248.542543723679;2716.5517689581197;2769.0446795855446;2789.3723912119713;2792.45547118312;2793.4413117376503;2716.4431291585274;2747.0659975608287;2759.434315965232;2765.3224959884856;2767.1836808141647;2331.3239160643393;2424.369663887393;2444.3644652390417;2726.2230264374657;2730.9180724578196;2648.139354709727;2780.110364683302;2780.430011847566;2782.0541016054435;2786.1084452975056;2534.556452620784;2543.0844895837486;2592.3648706066947;2592.688877334713;2599.8570078645666;14711;14773;14820.851791482162;14837.258137093102;14848.183349915751;7584.810379740496;7785.338246249075;7811.765647030598;7847.0975837778815;7854.057513098408;5184.9740751296;5202.413263954492;5313.468653134656;5427.864303392407;5456.317960254968;1942.417274817549;1959.1583911123641;1993.7607487101495;2017.3040301096098;2031.9898400507902;25803.612945805828;25889.482210355876;25951.74048259512;26001.609975850377;26045.479090418274;7024.859502810017;7095.538789978738;7104.6447677615915;7315.963420182865;7317.15852676949;19741.309054183035;19780.90109549443;19838.603227935648;19852.801471985385;19868;7841.5687137208;7970.123286438487;7973;7979.561124138112;7983.5209887406945;7040.401565866856;7152.749653762197;7261.41908647307;7296.7810965671115;7313.976043353829;5426.131818908955;5631.887362252814;5638.464345887134;5660.915086273709;5681.062624666966;1759.542518945058;1776.085316062229;1789.185920406212;1816.500462372858;1832.0564909071838;813.1015228172902;823.3618945317427;847.0343808058818;853.1511146409363;862.3704695572268;7187.31720486553;7213.783586492414;7234.457415693844;7258.782236532912;7296.306850849161;682.9009793579903;704.6089420371641;719.8452332748484;726.0488759724672;727.9090113735783;4354.368616550582;4380.540043295408;4429.623482004002;4469.351943968171;4496.5503449655425;20750;21052;21872.671909921362;21943.780562194173;22085.889570552365;20780.376588702362;21355.57288854214;21386.465338366354;21871.45321366947;22170.445738856335;11082.833757493645;11289.661310160709;11357.26177798457;11431.59989400367;11471.885281147248;7859.410544209093;7900.68397264103;7965.601719914097;7971.840563188588;8027.036755589366;17785.46643600694;18348.63302733911;18910;18993.145308460877;19179.94510301947;19158.425247242605;19270.61458770845;19965.401037968884;20053.197872085537;20323.79676203219;12105.152639315163;12396.070294727751;12400.689982750504;12400.937995309965;12402.627921162019;13572.117812342167;13576.456941722616;13589.592312230649;13621.523246686318;13768.65578360549;10836.403997780199;11234.382108983757;11251.49368278413;11506.482208300815;11686.590969316374;11540.365279909685;11603.825942610698;11629.127815414047;11694.88305116938;11753.529858805552;9419.670311539063;9667.129958303505;9710.6115755369;9731.805363892541;9755.414675119515;6997.335253150943;7144.678489467882;7196.928030719626;7306.232845551141;7341.302576255247;7124.465665075037;7200.207977122617;7227.891581626174;7228.674709637974;7232.674529646284
11:40:09 INFO - PID 16403 | |4;prototype.html;494.9905763317134;499.2885138677384;524.1220954900541;524.8425472358291;530.9362876454826;6136.846578835532;6220.160278362419;6303.590266632671;6317.83023204685;6337.524685648572;6013.338532761392;6194.132821404995;6201.224846894138;6202;6247.6251424914535;5004.8999020019755;5065.848024559269;5069.264956581312;5086.415062267831;5088.974555127219;4904.681195722284;5048.368953880765;5068.949310506885;5081.695098294114;5108.795648174068;4995.750212489379;5039.916417970136;5047.570956468705;5060.443351231362;5067.366579177603;5022.146235140035;5026.623003274733;5034.244863270502;5044.545990860804;5046.924296135561;4452.463899954543;4477.104579084196;4507.4365704286965;4524.68327217095;4539.523350048264;6125.663088530129;6138.263408390977;6185.443310102112;6195.535334849904;6246.281677607088;5775.88448231033;5785.4214578541805;5797.391273916221;5810;5836.824895253149;6540.4767618590395;6596.637184954826;6606.669666516703;6628.701708423133;6658.10115634388;4814.855554333376;4847.466778654345;4857.465678775332;4858.732769697665;4898.804047838118;6912.343327383891;6968.79093627192;6973.407260382823;6978.825529361756;7028.4025857801635;5057.317262169634;5064.41759197697;5073.594112470993;5093.656917817845;5094.643374963717;5068.974655126774;5105.923411148836;5128.230765385222;5129.538341549279;5141.997310524486;5666.490015898589;5685.488306052475;5761.942380576224;5783.855403614859;5805.738741756547;6551.672416379162;6679.198496180392;6705.966470167618;6706.865862682719;6751.797446076625;1677.2703873814685;1700.6343636118295;1726.48205538338;1729.8789084764198;1748.9212985415686;1194.5639841457805;1220.1641875315438;1231.347385885482;1245.7729136800244;1249.4252643783962;5549.1676248562235;5583.916241256385;5742.425757424224;5762.164486149485;5858.502027327725;6536.379043990813;6546.214454265519;6552;6641.089430406942;6646.335366463411;5762.481376676119;5762.625429347079;5772.740226689725;5849.707514624251;5865.296164460292;3534.6288639692975;3574.766705486603;3589.5692516897616;3637.3270944875285;3651.6165802590344;6547.312532184147;6547.4286171318545;6608.768693095719;6616.735330586819;6622.304658010936;6801.625910574966;6908.758193463204;6966.198887127944;6982.26686197952;7039.260877607778;6449.290578036413;6502.187226596676;6519.282878883224;6562.507811914125;6580.76967306142;6561.835954100995;6588.748137853792;6723.764668236784;6782.25395206517;6802.489813264124;6659.833504162435;6662.367075127855;6665.866682666417;6685.197776266879;6730.4952128589575;6377.808665740035;6473.902891456538;6557.590118124626;6573.704183311666;6573.80278591643;5438.102713052302;5504.394516603091;5524.475174858382;5587.441255874543;5593.888122237614;6631.3700198481065;6760.864782704417;6786.710525000234;6805.897911531232;6824.897626535705;6401.647909364843;6425.871482570229;6430.742770289136;6488.377905523619;6520.413162815369;6387.936120638734;6423.678816059085;6451.806445806634;6457.935420645921;6477.490122426931;6162.414570615784;6242.563020588515;6401.935980640134;6453.838654033499;6495.090687303876;6497.772577959938;6560.507961902972;6576.605403675795;6635.236947750877;6743.662816859235;6269.153664255267;6300.369963003663;6359.395857393541;6381.298057213796;6423.550351475352
11:40:09 INFO - PID 16403 | |5;yui.html;834.3617132893338;859.2548494319589;887.0907319997002;894.3515950935569;901.5492253873066;15598.610034749123;16096;16134.870559060884;16136.677266454664;16158.7576186357;16567.83432165681;16929.49211523653;16979.32082716693;17072.658546829058;17137.57156071099;945;951.1534734086669;959.7696552827341;960.159860122393;960.255801753643;964.3827950111934;966.4539535162646;967.1585720423242;967.762898089969;968.1141755293897;970.8883478400004;1024.5031159887449;1024.9128824049928;1034.6275340877278;1036.507658862042;1022.8312328465794;1023.8720159980003;1025.1644909398817;1027.2449749434234;1027.368168576324;710.9502334836563;740.5482655580092;741.0699572037113;742.610129681916;742.858856817203;14821.333040013225;14839.851601483955;14890.851091489054;14961.102333860003;15071.397144114222;21189.470263243544;21290.148394064217;21534.246301379375;21634.350969470783;21767.67348489774;17703.73444398335;17963;18110.185041673158;18153.7276940846;18512.814871851242;3778.149916268845;3811.942820857689;3814.828332725034;3816.542014958195;3817.4464702617965;135839.32080339635;138379;140899;143112.28443857818;144751;16663;16796.664066718597;17036.403725869535;17260.82739172592;17456.65086698259;30651.08046758601;31665.366692666477;31705;32356.35287294241;32365.676343236268;8167.795805104801;8302.335813134934;8316.6673333066;8407.915920840836;8437.662493500315;4047.3119569673227;4113.095119073799;4114.670826333886;4137.606927341898;4145.689073319513;4811.9518804812205;4936.75316234194;4947.233178857283;4966.379202599675;4970.552650261494;938.2681508423441;963.4363897120123;973.5229737428609;979.9608015679436;984.3404918704485;658.6542065415599;660.6993817812884;664.1167247560733;678.7047634279104;689.2074114768056;10775.461226938622;10981.630654220533;11275.54897804095;11666.358350290646;11836.349000804867;657.3787770556778;674.9055132281386;682.8634273145391;685.3934268172703;685.9265249883915;5432.701201433959;5495.505404513533;5504.22940788282;5533.916991245134;5617.410171931889;117137;117343.41328293303;119375;123988.38005809914;124325;108099.45950270355;108166.45916770524;108247.45876270568;109066.45466772615;109121;91471;93017.534912325;94399.52800236092;95117.0488295122;95826.52086739521;10134;10201.234907381828;10289.84565231537;10291.33106348085;10455.424951627734;42901.356479653456;42929.35605965975;42952.78523607362;43995.78002109969;44714.55285447104;55953.440465594824;56533.71733141308;57821.170401031086;58259;58922.410775891694;14841.183734894685;15021;15063.096214227182;15187.468438604596;15292.311845966735;16251;16387.42644007454;16397.91801040987;16415.015099094093;16636.16819159013;13306.534271300845;13314.201147931155;13397.397117129947;13483.865161348262;13639.863601363859;14525.418983240552;14546.127232366092;14673.779893301822;14720.337584808494;14872.033317834306;12631.11582189238;12652.43064062101;12694.555690550786;12806.167599106027;12812.167209131376;12014.219075760397;12163;12421.19262247951;12471.002319814574;12556.623301300975;11461.656150315504;11489.195756297313;11506.597269095877;11682.123840712151;11757.882421175678
11:40:09 INFO - PID 16403 | __end_tp_report
11:40:09 INFO - PID 16403 | __start_cc_report
11:40:09 INFO - PID 16403 | _x_x_mozilla_cycle_collect,369
11:40:09 INFO - PID 16403 | __end_cc_report
11:40:09 INFO - PID 16403 | __startTimestamp1505241609068__endTimestamp
11:40:09 INFO - PID 16403 |
11:40:09 INFO - PID 16403 | ------- Summary: start -------
11:40:09 INFO - PID 16403 | Number of tests: 6
11:40:09 INFO - PID 16403 |
11:40:09 INFO - PID 16403 | [#0] dojo.html Cycles:165 Average:6095.06 Median:6358.94 stddev:866.94 (13.6%) stddev-sans-first:837.20
11:40:09 INFO - PID 16403 | Values: 3101.7 3112.9 3130.7 3134.8 3142.1 6101.1 6140.0 6174.6 6210.9 6268.7 6112.9 6175.8 6180.8 6194.3 6221.3 5708.5 5781.1 5787.0 5815.4 5849.9 225.0 5667.2 5719.0 5726.2 5734.2 5623.4 5626.9 5627.7 5682.5 5693.5 5622.8 5629.2 5697.1 5708.0 5714.9 5592.7 5594.1 5680.3 5680.7 5684.7 6061.9 6080.1 6181.9 6217.7 6221.4 6559.5 6578.7 6633.2 6649.0 6667.0 6671.0 6680.4 6757.5 6769.5 6770.9 6138.2 6182.9 6198.1 6205.2 6216.2 6776.1 6782.5 6787.7 6806.2 6807.8 6609.6 6633.6 6652.6 6655.6 6659.7 6658.2 6672.3 6746.1 6750.2 6761.8 6585.6 6634.0 6655.9 6738.9 6756.3 6481.6 6605.7 6641.3 6664.5 6764.4 5222.1 5230.7 5243.1 5284.8 5305.8 4606.9 4624.3 4661.5 4695.7 4716.7 5780.0 5781.2 5835.0 5856.4 5862.5 6568.6 6692.4 6700.0 6724.2 6802.6 5653.8 5694.7 5713.3 5730.7 5733.2 5651.6 5660.5 5681.1 5714.7 5813.7 6505.1 6563.6 6579.6 6601.6 6616.2 6665.5 6674.8 6692.4 6777.8 6786.7 6359.2 6441.5 6448.6 6449.0 6460.0 6435.4 6440.5 6514.5 6529.8 6536.6 6760.7 6771.3 6772.7 6808.7 6821.8 6483.3 6498.0 6560.0 6562.4 6586.7 6412.8 6469.3 6537.7 6570.5 6573.8 6235.5 6322.0 6336.7 6406.7 6434.6 6437.4 6562.1 6603.2 6606.2 6636.7 6263.7 6272.7 6342.6 6351.9 6358.9
11:40:09 INFO - PID 16403 |
11:40:09 INFO - PID 16403 | [#1] ext.html Cycles:180 Average:36353.87 Median:33479.25 stddev:51777.04 (154.7%) stddev-sans-first:51853.45
11:40:09 INFO - PID 16403 | Values: 797.2 801.3 805.1 807.6 820.6 39721.4 40207.8 40258.2 40265.6 40589.6 37339.0 37481.3 37604.2 37694.4 40398.2 7569.5 7700.7 7727.5 7734.1 7755.7 7626.9 7735.3 7768.8 7769.7 7797.9 7747.7 7780.0 7794.7 7800.9 7801.0 7648.2 7729.5 7738.1 7754.5 7779.8 7564.7 7630.5 7652.7 7670.4 7683.2 37524.4 37539.2 37596.2 37663.0 37728.0 3438.9 3494.2 3504.8 3506.4 3513.7 31261.8 31506.0 31566.7 31611.5 31679.5 5010.9 5150.7 5244.2 5269.5 5329.4 178114.1 178812.0 180243.0 180308.0 182413.0 40912.4 41082.6 48058.5 49280.0 49460.8 51769.5 51823.7 51850.5 51883.2 51883.2 13711.9 13765.7 13911.7 13991.6 14016.2 11243.9 11313.6 11315.7 11337.1 11338.3 13367.4 13477.5 13522.5 13631.1 13695.2 5225.3 5269.7 5280.8 5348.3 5366.9 1012.4 1017.2 1021.3 1037.8 1056.2 22710.9 22965.8 23086.4 23182.1 23220.7 1103.8 1119.6 1121.8 1134.3 1135.5 12081.2 12149.8 12323.9 12359.8 12414.0 223098.0 224985.0 225259.0 226088.0 226557.0 51482.7 51637.5 51744.7 51793.5 51964.0 1391.6 1461.8 1469.4 1476.6 1479.2 21700.6 22145.7 22193.3 22685.7 22699.4 32883.3 32900.2 35509.1 36491.0 36803.8 190102.0 191127.0 191870.0 191873.0 191970.0 30744.1 31060.0 31120.7 31157.4 34058.3 37884.4 42636.4 43136.4 43490.8 43883.8 31217.5 31541.5 31690.5 31904.5 32391.5 31422.4 31493.4 31537.7 31790.8 32254.0 35046.0 35884.1 36372.0 36541.0 36550.0 30957.0 30998.2 31125.8 31281.0 31648.8 22273.0 22321.0 22482.2 22920.5 23065.7
11:40:09 INFO - PID 16403 |
11:40:09 INFO - PID 16403 | [#2] jquery.html Cycles:180 Average:32971.32 Median:22291.39 stddev:77456.81 (347.5%) stddev-sans-first:77635.85
11:40:09 INFO - PID 16403 | Values: 552.9 565.8 570.5 573.7 588.5 21632.9 22013.3 22173.0 22272.4 22310.3 22718.2 23938.8 23983.5 24142.0 24271.8 6367.0 6494.4 6500.4 6542.8 6572.1 6400.4 6491.3 6540.6 6545.8 6549.3 6223.5 6364.6 6455.0 6458.2 6498.4 6461.8 6468.7 6516.0 6531.3 6542.6 6013.5 6033.8 6037.6 6047.8 6072.4 27380.5 28325.9 28501.9 28565.6 28657.1 2035.6 2065.9 2079.3 2085.1 2088.5 18648.7 19023.0 19444.4 19473.3 19477.2 2324.6 2365.4 2395.2 2406.8 2409.6 114668.0 119944.4 125606.0 133836.0 134049.0 14207.9 14356.6 14440.1 14777.9 14877.2 21894.8 22070.6 22147.8 22183.0 22198.6 8282.5 8561.6 8754.1 8763.0 8830.3 7705.0 7709.2 7719.5 7739.6 7772.8 8828.4 8842.9 8925.2 9032.9 9057.2 2676.1 2679.5 2683.5 2728.3 2759.9 974.4 977.0 986.4 993.6 1010.8 18552.5 18806.6 19188.5 19409.9 19483.4 1007.4 1008.2 1026.8 1027.2 1033.8 10492.6 10585.9 10618.2 10737.5 10774.5 447872.0 459733.0 459774.0 462677.0 470489.0 108305.0 109825.0 113028.0 113262.4 115235.0 1036.5 1086.9 1137.9 1155.1 1203.5 19929.4 20023.3 20116.9 20196.9 20651.4 52634.0 53060.5 53138.0 54221.2 54563.7 66725.0 67388.7 67594.7 68082.0 68083.0 13850.2 14215.2 14310.9 14332.9 14427.7 22253.2 22557.4 22610.5 22645.8 22659.4 17443.1 17799.8 18062.8 18208.5 18493.0 15017.3 15881.0 16263.8 16290.0 16765.9 16619.4 17216.5 17325.8 18093.7 18481.5 14052.0 14090.2 14171.9 14181.3 14290.8 17445.4 17447.5 17540.6 17833.5 17934.0
11:40:09 INFO - PID 16403 |
11:40:09 INFO - PID 16403 | [#3] mootools.html Cycles:180 Average:9375.32 Median:14300.73 stddev:6781.32 (47.4%) stddev-sans-first:6772.89
11:40:09 INFO - PID 16403 | Values: 1254.7 1341.6 1347.4 1347.7 1357.6 14784.7 15315.6 15468.3 15475.7 15487.9 15127.9 15203.7 15229.5 15242.3 15248.5 2716.6 2769.0 2789.4 2792.5 2793.4 2716.4 2747.1 2759.4 2765.3 2767.2 2331.3 2424.4 2444.4 2726.2 2730.9 2648.1 2780.1 2780.4 2782.1 2786.1 2534.6 2543.1 2592.4 2592.7 2599.9 14711.0 14773.0 14820.9 14837.3 14848.2 7584.8 7785.3 7811.8 7847.1 7854.1 5185.0 5202.4 5313.5 5427.9 5456.3 1942.4 1959.2 1993.8 2017.3 2032.0 25803.6 25889.5 25951.7 26001.6 26045.5 7024.9 7095.5 7104.6 7316.0 7317.2 19741.3 19780.9 19838.6 19852.8 19868.0 7841.6 7970.1 7973.0 7979.6 7983.5 7040.4 7152.7 7261.4 7296.8 7314.0 5426.1 5631.9 5638.5 5660.9 5681.1 1759.5 1776.1 1789.2 1816.5 1832.1 813.1 823.4 847.0 853.2 862.4 7187.3 7213.8 7234.5 7258.8 7296.3 682.9 704.6 719.8 726.0 727.9 4354.4 4380.5 4429.6 4469.4 4496.6 20750.0 21052.0 21872.7 21943.8 22085.9 20780.4 21355.6 21386.5 21871.5 22170.4 11082.8 11289.7 11357.3 11431.6 11471.9 7859.4 7900.7 7965.6 7971.8 8027.0 17785.5 18348.6 18910.0 18993.1 19179.9 19158.4 19270.6 19965.4 20053.2 20323.8 12105.2 12396.1 12400.7 12400.9 12402.6 13572.1 13576.5 13589.6 13621.5 13768.7 10836.4 11234.4 11251.5 11506.5 11686.6 11540.4 11603.8 11629.1 11694.9 11753.5 9419.7 9667.1 9710.6 9731.8 9755.4 6997.3 7144.7 7196.9 7306.2 7341.3 7124.5 7200.2 7227.9 7228.7 7232.7
11:40:09 INFO - PID 16403 |
11:40:09 INFO - PID 16403 | [#4] prototype.html Cycles:180 Average:5547.40 Median:6189.79 stddev:1545.89 (25.0%) stddev-sans-first:1502.99
11:40:09 INFO - PID 16403 | Values: 495.0 499.3 524.1 524.8 530.9 6136.8 6220.2 6303.6 6317.8 6337.5 6013.3 6194.1 6201.2 6202.0 6247.6 5004.9 5065.8 5069.3 5086.4 5089.0 4904.7 5048.4 5068.9 5081.7 5108.8 4995.8 5039.9 5047.6 5060.4 5067.4 5022.1 5026.6 5034.2 5044.5 5046.9 4452.5 4477.1 4507.4 4524.7 4539.5 6125.7 6138.3 6185.4 6195.5 6246.3 5775.9 5785.4 5797.4 5810.0 5836.8 6540.5 6596.6 6606.7 6628.7 6658.1 4814.9 4847.5 4857.5 4858.7 4898.8 6912.3 6968.8 6973.4 6978.8 7028.4 5057.3 5064.4 5073.6 5093.7 5094.6 5069.0 5105.9 5128.2 5129.5 5142.0 5666.5 5685.5 5761.9 5783.9 5805.7 6551.7 6679.2 6706.0 6706.9 6751.8 1677.3 1700.6 1726.5 1729.9 1748.9 1194.6 1220.2 1231.3 1245.8 1249.4 5549.2 5583.9 5742.4 5762.2 5858.5 6536.4 6546.2 6552.0 6641.1 6646.3 5762.5 5762.6 5772.7 5849.7 5865.3 3534.6 3574.8 3589.6 3637.3 3651.6 6547.3 6547.4 6608.8 6616.7 6622.3 6801.6 6908.8 6966.2 6982.3 7039.3 6449.3 6502.2 6519.3 6562.5 6580.8 6561.8 6588.7 6723.8 6782.3 6802.5 6659.8 6662.4 6665.9 6685.2 6730.5 6377.8 6473.9 6557.6 6573.7 6573.8 5438.1 5504.4 5524.5 5587.4 5593.9 6631.4 6760.9 6786.7 6805.9 6824.9 6401.6 6425.9 6430.7 6488.4 6520.4 6387.9 6423.7 6451.8 6457.9 6477.5 6162.4 6242.6 6401.9 6453.8 6495.1 6497.8 6560.5 6576.6 6635.2 6743.7 6269.2 6300.4 6359.4 6381.3 6423.6
11:40:09 INFO - PID 16403 |
11:40:09 INFO - PID 16403 | [#5] yui.html Cycles:180 Average:23698.80 Median:18036.59 stddev:35247.15 (195.4%) stddev-sans-first:35304.22
11:40:09 INFO - PID 16403 | Values: 834.4 859.3 887.1 894.4 901.5 15598.6 16096.0 16134.9 16136.7 16158.8 16567.8 16929.5 16979.3 17072.7 17137.6 945.0 951.2 959.8 960.2 960.3 964.4 966.5 967.2 967.8 968.1 970.9 1024.5 1024.9 1034.6 1036.5 1022.8 1023.9 1025.2 1027.2 1027.4 711.0 740.5 741.1 742.6 742.9 14821.3 14839.9 14890.9 14961.1 15071.4 21189.5 21290.1 21534.2 21634.4 21767.7 17703.7 17963.0 18110.2 18153.7 18512.8 3778.1 3811.9 3814.8 3816.5 3817.4 135839.3 138379.0 140899.0 143112.3 144751.0 16663.0 16796.7 17036.4 17260.8 17456.7 30651.1 31665.4 31705.0 32356.4 32365.7 8167.8 8302.3 8316.7 8407.9 8437.7 4047.3 4113.1 4114.7 4137.6 4145.7 4812.0 4936.8 4947.2 4966.4 4970.6 938.3 963.4 973.5 980.0 984.3 658.7 660.7 664.1 678.7 689.2 10775.5 10981.6 11275.5 11666.4 11836.3 657.4 674.9 682.9 685.4 685.9 5432.7 5495.5 5504.2 5533.9 5617.4 117137.0 117343.4 119375.0 123988.4 124325.0 108099.5 108166.5 108247.5 109066.5 109121.0 91471.0 93017.5 94399.5 95117.0 95826.5 10134.0 10201.2 10289.8 10291.3 10455.4 42901.4 42929.4 42952.8 43995.8 44714.6 55953.4 56533.7 57821.2 58259.0 58922.4 14841.2 15021.0 15063.1 15187.5 15292.3 16251.0 16387.4 16397.9 16415.0 16636.2 13306.5 13314.2 13397.4 13483.9 13639.9 14525.4 14546.1 14673.8 14720.3 14872.0 12631.1 12652.4 12694.6 12806.2 12812.2 12014.2 12163.0 12421.2 12471.0 12556.6 11461.7 11489.2 11506.6 11682.1 11757.9
11:40:09 INFO - PID 16403 | -------- Summary: end --------
11:40:09 INFO - PID 16403 |
11:40:09 INFO - PID 16403 |
11:40:09 INFO - PID 16403 | ###!!! [Parent][RunMessage] Error: Channel closing: too late to send/recv, messages will be lost
11:40:09 INFO - PID 16403 |
11:40:10 INFO - TEST-INFO | 16403: exit 0
11:40:10 INFO - TEST-OK | dromaeo_css | took 1113374ms
11:40:10 INFO - TEST-START | kraken
11:40:10 INFO - Initialising browser for kraken test...
11:40:10 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:49341/getInfo.html -profile /tmp/tmpF9ItKc/profile
11:40:10 INFO - TEST-INFO | started process 16791 (/builds/slave/test/build/application/firefox/firefox http://localhost:49341/getInfo.html)
11:40:16 INFO - TEST-INFO | 16791: exit 0
11:40:16 INFO - Browser initialized.
11:40:16 INFO - Running cycle 1/1 for kraken test...
11:40:16 INFO - Using env: {'DISPLAY': ':0',
11:40:16 INFO - 'HOME': '/home/cltbld',
11:40:16 INFO - 'JSGC_DISABLE_POISONING': '1',
11:40:16 INFO - 'LANG': 'en_US.UTF-8',
11:40:16 INFO - 'LANGUAGE': 'en_US:en',
11:40:16 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox',
11:40:16 INFO - 'LOGNAME': 'cltbld',
11:40:16 INFO - 'MAIL': '/var/mail/cltbld',
11:40:16 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir',
11:40:16 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk',
11:40:16 INFO - 'MOZ_ACCELERATED': '1',
11:40:16 INFO - 'MOZ_CRASHREPORTER': '1',
11:40:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1',
11:40:16 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1',
11:40:16 INFO - 'MOZ_NO_REMOTE': '1',
11:40:16 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir',
11:40:16 INFO - 'MOZ_WEBRENDER': '1',
11:40:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript',
11:40:16 INFO - 'NO_EM_RESTART': '1',
11:40:16 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games',
11:40:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json',
11:40:16 INFO - 'PWD': '/builds/slave/test',
11:40:16 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos',
11:40:16 INFO - 'RUST_BACKTRACE': 'full',
11:40:16 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts',
11:40:16 INFO - 'SHELL': '/bin/bash',
11:40:16 INFO - 'SHLVL': '1',
11:40:16 INFO - 'TERM': 'linux',
11:40:16 INFO - 'TMOUT': '86400',
11:40:16 INFO - 'USER': 'cltbld',
11:40:16 INFO - 'XDG_SESSION_COOKIE': '781b77c4c33858b1f599d705000001c1-1505217657.506684-1238802230',
11:40:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn',
11:40:16 INFO - '_': '/tools/buildbot/bin/python'}
11:40:16 INFO - TEST-INFO | started process 16994 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpF9ItKc/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1)
11:40:17 INFO - PID 16994 | WebRender - OpenGL version new 3.2.0 NVIDIA 361.42
11:40:17 INFO - PID 16994 | WebRender - OpenGL version new 3.2.0 NVIDIA 361.42
11:40:17 INFO - PID 16994 |
11:40:17 INFO - PID 16994 | (/builds/slave/test/build/application/firefox/firefox:17055): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied
11:40:17 INFO - PID 16994 |
11:40:27 INFO - PID 16994 | RSS: Main: 216903680
11:40:27 INFO - PID 16994 |
11:40:30 INFO - PID 16994 | Cycle 1(1): loaded http://localhost:49341/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49341/tests/kraken/driver.html?testName=audio-beat-detection)
11:40:31 INFO - PID 16994 | RSS: Main: 222720000
11:40:31 INFO - PID 16994 |
11:40:34 INFO - PID 16994 | Cycle 1(1): loaded http://localhost:49341/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49341/tests/kraken/driver.html?testName=audio-dft)
11:40:34 INFO - PID 16994 | RSS: Main: 222711808
11:40:34 INFO - PID 16994 |
11:40:38 INFO - PID 16994 | Cycle 1(1): loaded http://localhost:49341/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49341/tests/kraken/driver.html?testName=audio-fft)
11:40:38 INFO - PID 16994 | RSS: Main: 218525696
11:40:38 INFO - PID 16994 |
11:40:40 INFO - PID 16994 | Cycle 1(1): loaded http://localhost:49341/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49341/tests/kraken/driver.html?testName=audio-oscillator)
11:40:41 INFO - PID 16994 | RSS: Main: 219672576
11:40:41 INFO - PID 16994 |
11:40:43 INFO - PID 16994 | Cycle 1(1): loaded http://localhost:49341/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49341/tests/kraken/driver.html?testName=imaging-gaussian-blur)
11:40:44 INFO - PID 16994 | RSS: Main: 218628096
11:40:44 INFO - PID 16994 |
11:40:47 INFO - PID 16994 | Cycle 1(1): loaded http://localhost:49341/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49341/tests/kraken/driver.html?testName=imaging-darkroom)
11:40:48 INFO - PID 16994 | RSS: Main: 222195712
11:40:48 INFO - PID 16994 |
11:40:51 INFO - PID 16994 | Cycle 1(1): loaded http://localhost:49341/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49341/tests/kraken/driver.html?testName=imaging-desaturate)
11:40:52 INFO - PID 16994 | RSS: Main: 220737536
11:40:52 INFO - PID 16994 |
11:40:55 INFO - PID 16994 | Cycle 1(1): loaded http://localhost:49341/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49341/tests/kraken/driver.html?testName=json-parse-financial)
11:40:56 INFO - PID 16994 | RSS: Main: 222384128
11:40:56 INFO - PID 16994 |
11:40:57 INFO - PID 16994 | Cycle 1(1): loaded http://localhost:49341/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49341/tests/kraken/driver.html?testName=json-stringify-tinderbox)
11:40:58 INFO - PID 16994 | RSS: Main: 221622272
11:40:58 INFO - PID 16994 |
11:41:00 INFO - PID 16994 | Cycle 1(1): loaded http://localhost:49341/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49341/tests/kraken/driver.html?testName=stanford-crypto-aes)
11:41:00 INFO - PID 16994 | RSS: Main: 219308032
11:41:00 INFO - PID 16994 |
11:41:03 INFO - PID 16994 | Cycle 1(1): loaded http://localhost:49341/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49341/tests/kraken/driver.html?testName=stanford-crypto-ccm)
11:41:03 INFO - PID 16994 | RSS: Main: 219557888
11:41:03 INFO - PID 16994 |
11:41:06 INFO - PID 16994 | Cycle 1(1): loaded http://localhost:49341/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49341/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2)
11:41:07 INFO - PID 16994 | RSS: Main: 219832320
11:41:07 INFO - PID 16994 |
11:41:10 INFO - PID 16994 | Cycle 1(1): loaded http://localhost:49341/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49341/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative)
11:41:10 INFO - PID 16994 | RSS: Main: 220401664
11:41:10 INFO - PID 16994 |
11:41:12 INFO - PID 16994 | Cycle 1(1): loaded http://localhost:49341/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49341/tests/kraken/driver.html?testName=ai-astar)
11:41:12 INFO - PID 16994 | RSS: Main: 222302208
11:41:12 INFO - PID 16994 |
11:41:12 INFO - PID 16994 | __start_tp_report
11:41:12 INFO - PID 16994 | _x_x_mozilla_page_load
11:41:12 INFO - PID 16994 | _x_x_mozilla_page_load_details
11:41:12 INFO - PID 16994 | |i|pagename|runs|
11:41:12 INFO - PID 16994 | |0;ai-astar;116;116;108;108;108;111;109;121;108;113
11:41:12 INFO - PID 16994 | |1;audio-beat-detection;120;116;117;117;129;115;117;117;122;117
11:41:12 INFO - PID 16994 | |2;audio-dft;166;163;167;163;167;169;166;163;166;171
11:41:12 INFO - PID 16994 | |3;audio-fft;76;74;81;74;80;75;83;82;78;81
11:41:12 INFO - PID 16994 | |4;audio-oscillator;81;92;89;82;85;79;88;86;79;82
11:41:12 INFO - PID 16994 | |5;imaging-gaussian-blur;117;114;124;114;114;113;117;114;112;115
11:41:12 INFO - PID 16994 | |6;imaging-darkroom;148;147;152;150;149;150;150;148;153;149
11:41:12 INFO - PID 16994 | |7;imaging-desaturate;95;99;99;94;94;94;97;96;96;94
11:41:12 INFO - PID 16994 | |8;json-parse-financial;64;54;61;63;62;55;56;54;53;53
11:41:12 INFO - PID 16994 | |9;json-stringify-tinderbox;43;39;50;45;39;48;38;48;45;38
11:41:12 INFO - PID 16994 | |10;stanford-crypto-aes;80;76;76;78;85;75;81;81;77;77
11:41:12 INFO - PID 16994 | |11;stanford-crypto-ccm;130;116;113;110;117;117;125;113;115;115
11:41:12 INFO - PID 16994 | |12;stanford-crypto-pbkdf2;176;172;171;170;168;174;172;169;177;179
11:41:12 INFO - PID 16994 | |13;stanford-crypto-sha256-iterative;71;64;64;69;66;65;65;65;68;64
11:41:12 INFO - PID 16994 | __end_tp_report
11:41:12 INFO - PID 16994 | __start_cc_report
11:41:12 INFO - PID 16994 | _x_x_mozilla_cycle_collect,964
11:41:12 INFO - PID 16994 | __end_cc_report
11:41:12 INFO - PID 16994 | __startTimestamp1505241672940__endTimestamp
11:41:12 INFO - PID 16994 |
11:41:12 INFO - PID 16994 | ------- Summary: start -------
11:41:12 INFO - PID 16994 | Number of tests: 14
11:41:12 INFO - PID 16994 |
11:41:12 INFO - PID 16994 | [#0] ai-astar Cycles:10 Average:111.80 Median:112.00 stddev:4.57 (4.1%) stddev-sans-first:4.58
11:41:12 INFO - PID 16994 | Values: 116.0 116.0 108.0 108.0 108.0 111.0 109.0 121.0 108.0 113.0
11:41:12 INFO - PID 16994 |
11:41:12 INFO - PID 16994 | [#1] audio-beat-detection Cycles:10 Average:118.70 Median:117.00 stddev:4.14 (3.5%) stddev-sans-first:4.36
11:41:12 INFO - PID 16994 | Values: 120.0 116.0 117.0 117.0 129.0 115.0 117.0 117.0 122.0 117.0
11:41:12 INFO - PID 16994 |
11:41:12 INFO - PID 16994 | [#2] audio-dft Cycles:10 Average:166.10 Median:166.50 stddev:2.64 (1.6%) stddev-sans-first:2.80
11:41:12 INFO - PID 16994 | Values: 166.0 163.0 167.0 163.0 167.0 169.0 166.0 163.0 166.0 171.0
11:41:12 INFO - PID 16994 |
11:41:12 INFO - PID 16994 | [#3] audio-fft Cycles:10 Average:78.40 Median:80.50 stddev:3.44 (4.3%) stddev-sans-first:3.54
11:41:12 INFO - PID 16994 | Values: 76.0 74.0 81.0 74.0 80.0 75.0 83.0 82.0 78.0 81.0
11:41:12 INFO - PID 16994 |
11:41:12 INFO - PID 16994 | [#4] audio-oscillator Cycles:10 Average:84.30 Median:85.50 stddev:4.42 (5.2%) stddev-sans-first:4.53
11:41:12 INFO - PID 16994 | Values: 81.0 92.0 89.0 82.0 85.0 79.0 88.0 86.0 79.0 82.0
11:41:12 INFO - PID 16994 |
11:41:12 INFO - PID 16994 | [#5] imaging-gaussian-blur Cycles:10 Average:115.40 Median:114.50 stddev:3.41 (3.0%) stddev-sans-first:3.56
11:41:12 INFO - PID 16994 | Values: 117.0 114.0 124.0 114.0 114.0 113.0 117.0 114.0 112.0 115.0
11:41:12 INFO - PID 16994 |
11:41:12 INFO - PID 16994 | [#6] imaging-darkroom Cycles:10 Average:149.60 Median:150.00 stddev:1.84 (1.2%) stddev-sans-first:1.86
11:41:12 INFO - PID 16994 | Values: 148.0 147.0 152.0 150.0 149.0 150.0 150.0 148.0 153.0 149.0
11:41:12 INFO - PID 16994 |
11:41:12 INFO - PID 16994 | [#7] imaging-desaturate Cycles:10 Average:95.80 Median:96.00 stddev:1.99 (2.1%) stddev-sans-first:2.09
11:41:12 INFO - PID 16994 | Values: 95.0 99.0 99.0 94.0 94.0 94.0 97.0 96.0 96.0 94.0
11:41:12 INFO - PID 16994 |
11:41:12 INFO - PID 16994 | [#8] json-parse-financial Cycles:10 Average:57.50 Median:58.50 stddev:4.45 (7.6%) stddev-sans-first:4.06
11:41:12 INFO - PID 16994 | Values: 64.0 54.0 61.0 63.0 62.0 55.0 56.0 54.0 53.0 53.0
11:41:12 INFO - PID 16994 |
11:41:12 INFO - PID 16994 | [#9] json-stringify-tinderbox Cycles:10 Average:43.30 Median:45.00 stddev:4.57 (10.2%) stddev-sans-first:4.85
11:41:12 INFO - PID 16994 | Values: 43.0 39.0 50.0 45.0 39.0 48.0 38.0 48.0 45.0 38.0
11:41:12 INFO - PID 16994 |
11:41:12 INFO - PID 16994 | [#10] stanford-crypto-aes Cycles:10 Average:78.60 Median:79.00 stddev:3.10 (3.9%) stddev-sans-first:3.24
11:41:12 INFO - PID 16994 | Values: 80.0 76.0 76.0 78.0 85.0 75.0 81.0 81.0 77.0 77.0
11:41:12 INFO - PID 16994 |
11:41:12 INFO - PID 16994 | [#11] stanford-crypto-ccm Cycles:10 Average:117.10 Median:116.50 stddev:5.99 (5.1%) stddev-sans-first:4.15
11:41:12 INFO - PID 16994 | Values: 130.0 116.0 113.0 110.0 117.0 117.0 125.0 113.0 115.0 115.0
11:41:12 INFO - PID 16994 |
11:41:12 INFO - PID 16994 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:172.80 Median:173.00 stddev:3.61 (2.1%) stddev-sans-first:3.64
11:41:12 INFO - PID 16994 | Values: 176.0 172.0 171.0 170.0 168.0 174.0 172.0 169.0 177.0 179.0
11:41:12 INFO - PID 16994 |
11:41:12 INFO - PID 16994 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.10 Median:65.50 stddev:2.42 (3.7%) stddev-sans-first:1.81
11:41:12 INFO - PID 16994 | Values: 71.0 64.0 64.0 69.0 66.0 65.0 65.0 65.0 68.0 64.0
11:41:12 INFO - PID 16994 | -------- Summary: end --------
11:41:12 INFO - PID 16994 |
11:41:13 INFO - PID 16994 |
11:41:13 INFO - PID 16994 | ###!!! [Parent][RunMessage] Error: Channel closing: too late to send/recv, messages will be lost
11:41:13 INFO - PID 16994 |
11:41:13 INFO - PID 16994 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping
11:41:13 INFO - TEST-INFO | 16994: exit 0
11:41:14 INFO - TEST-OK | kraken | took 64002ms
11:41:14 INFO - SUITE-END | took 1177s
11:41:14 INFO - Completed test suite (00:19:37)
11:41:14 INFO - javascript benchmark
11:41:14 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8338.152859234553, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3101.6743241959593, 3112.937741245175, 3130.733887619552, 3134.8275844828527, 3142.135912624028, 6101.0848372744, 6139.969300153504, 6174.598651087676, 6210.913090209212, 6268.655223962686, 6112.877742445148, 6175.845603859906, 6180.752769889199, 6194.349593292707, 6221.253449586045, 5708.486236238738, 5781.13283007549, 5787.0, 5815.418458154193, 5849.941500584982, 225.02530121163113, 5667.234923285345, 5718.971405142968, 5726.226959360475, 5734.225879506276, 5623.409541998113, 5626.859328516799, 5627.7186140693, 5682.488576028136, 5693.516051135638, 5622.775088996435, 5629.183768353566, 5697.1169468732, 5708.029634962067, 5714.914276285859, 5592.664440133564, 5594.14698503762, 5680.289963754531, 5680.6591604503865, 5684.744186511617, 6061.939380606225, 6080.118382834465, 6181.876362472771, 6217.720202590849, 6221.377862213742, 6559.540832141752, 6578.671066446658, 6633.237177724575, 6648.9667551662415, 6667.033280174348, 6671.0, 6680.365365290289, 6757.493188010919, 6769.458443324522, 6770.932290677079, 6138.202033735631, 6182.876342473171, 6198.070289456573, 6205.193324867783, 6216.222972128484, 6776.08522849409, 6782.491313151533, 6787.66061696923, 6806.183258008971, 6807.795766127024, 6609.6364699941005, 6633.568818026813, 6652.600843949379, 6655.567388119756, 6659.733610655519, 6658.201015878029, 6672.332766723289, 6746.0892779475125, 6750.223724271772, 6761.830954226184, 6585.5832084554995, 6634.038064480624, 6655.900161497581, 6738.865222695518, 6756.324367563303, 6481.578697384655, 6605.70274337656, 6641.335866413417, 6664.466842652673, 6764.3573860483175, 5222.112240919053, 5230.712310822865, 5243.134882744381, 5284.841454756363, 5305.840824775263, 4606.930896036562, 4624.30635404692, 4661.487236403993, 4695.741734204652, 4716.716996980193, 5780.046292361713, 5781.219535362672, 5834.970825145932, 5856.443637854397, 5862.530997520188, 6568.573042752206, 6692.397684208445, 6699.9665001674675, 6724.226713927863, 6802.625855577891, 5653.830385088454, 5694.6583205007, 5713.342965558931, 5730.684812335361, 5733.168690539848, 5651.604387692904, 5660.462256085665, 5681.0626246668835, 5714.657120572779, 5813.651180929158, 6505.121808555879, 6563.573367731177, 6579.572327798678, 6601.603903765789, 6616.206055273302, 6665.533412661067, 6674.766383176566, 6692.431143352869, 6777.830554235987, 6786.728530858711, 6359.173307470184, 6441.452476539546, 6448.613083215022, 6449.0, 6460.0, 6435.420812126931, 6440.516961228021, 6514.511411644051, 6529.836754081186, 6536.640484773383, 6760.695768690519, 6771.322867713189, 6772.729090836311, 6808.7276508939085, 6821.761238356634, 6483.286838447862, 6498.0, 6560.0, 6562.376574225441, 6586.70359833799, 6412.775552855627, 6469.253301608445, 6537.7058032389605, 6570.5400621957915, 6573.769918052845, 6235.532335074797, 6321.96839015802, 6336.683165841781, 6406.743730250738, 6434.581752186093, 6437.420632143129, 6562.114114594659, 6603.240627327918, 6606.240282367397, 6636.701348439428, 6263.74945002213, 6272.655003974825, 6342.587731797418, 6351.872962540816, 6358.936410635834], "value": 6033.150305073848, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [797.1749239537079, 801.3308887079285, 805.0822062848354, 807.5598798654732, 820.5897051474263, 39721.40417893734, 40207.79896100519, 40258.19483610326, 40265.59734402655, 40589.59410405895, 37339.0, 37481.25037499255, 37604.247915041684, 37694.434583481205, 40398.19203615933, 7569.545827250355, 7700.6919723211, 7727.497712648688, 7734.1492435832015, 7755.728549500768, 7626.923730762677, 7735.265149810759, 7768.7669369918995, 7769.728059517918, 7797.922020779804, 7747.6513556889795, 7780.02749656293, 7794.727184548542, 7800.882986755203, 7800.960995195016, 7648.158702542716, 7729.497582657137, 7738.110117336466, 7754.457187996843, 7779.7666070017995, 7564.735234266775, 7630.504017238862, 7652.655630496585, 7670.4247181461615, 7683.231676832272, 37524.43713344302, 37539.249215015545, 37596.24807503835, 37663.0, 37728.0, 3438.896833095011, 3494.1614012637037, 3504.8083651558336, 3506.403911335079, 3513.7189024878203, 31261.84369078163, 31506.0, 31566.684333156605, 31611.52582711261, 31679.524807127913, 5010.924836127461, 5150.690958542499, 5244.239585260116, 5269.525742683139, 5329.387120481117, 178114.10942945332, 178812.0, 180243.0, 180308.0, 182413.0, 40912.38631420531, 41082.58917410847, 48058.51941480541, 49280.0, 49460.75269623629, 51769.48230517722, 51823.74088129535, 51850.48149518532, 51883.22175167376, 51883.22175167376, 13711.931440342734, 13765.655858603615, 13911.65220869466, 13991.58025259244, 14016.229107399191, 11243.887561124284, 11313.604023859125, 11315.717107072225, 11337.093032557375, 11338.319700817812, 13367.398467069006, 13477.528286509925, 13522.459101636021, 13631.113977591425, 13695.246761428018, 5225.346831646044, 5269.710165940834, 5280.788768449296, 5348.331458567679, 5366.928252801144, 1012.4330374990029, 1017.1862509991977, 1021.341234903483, 1037.8339465685606, 1056.1972900595604, 22710.886445567998, 22965.770342296364, 23086.42283942915, 23182.072717091465, 23220.656528411546, 1103.7847619714078, 1119.5969450997798, 1121.7644294698205, 1134.3364131982717, 1135.5401062569672, 12081.214721043105, 12149.817752733716, 12323.876761232452, 12359.75280494403, 12414.0, 223098.0, 224985.0, 225259.0, 226088.0, 226557.0, 51482.742586287575, 51637.483625164015, 51744.74127629413, 51793.48206517962, 51964.0, 1391.589481103077, 1461.8026566413612, 1469.4048910191389, 1476.5791749351383, 1479.2012313350886, 21700.565988680453, 22145.667814982466, 22193.334199974026, 22685.659715104615, 22699.432514187276, 32883.34233315368, 32900.1774955628, 35509.11227219237, 36491.0, 36803.81598091992, 190102.0, 191127.0, 191870.0, 191873.0, 191970.0, 30744.077677669706, 31060.0, 31120.688793112684, 31157.37685246237, 34058.318833623685, 37884.43173352457, 42636.36045459383, 43136.35295470508, 43490.78254608833, 43883.78058109689, 31217.53173702351, 31541.526877096403, 31690.524642130847, 31904.521432179, 32391.51412728858, 31422.37155256928, 31493.370132597676, 31537.684623154393, 31790.841045794623, 32254.0, 35046.0, 35884.10289742777, 36372.0, 36541.0, 36550.0, 30957.0, 30998.22504437407, 31125.844370778002, 31281.0, 31648.841755791073, 22273.0, 22321.0, 22482.213122540634, 22920.541589168457, 23065.65401519012], "value": 16676.96400105409, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [552.8700755322499, 565.7850016993542, 570.5093619487243, 573.698808125734, 588.5115354255968, 21632.89183554082, 22013.33959981201, 22173.0, 22272.443188920264, 22310.33069007928, 22718.204862829803, 23938.76061239387, 23983.520329593397, 24142.0, 24271.75728242717, 6366.968165159179, 6494.415502604765, 6500.382463665967, 6542.803715888531, 6572.112764776742, 6400.359964003609, 6491.285958544557, 6540.640264785435, 6545.803625891231, 6549.34506549346, 6223.471004964584, 6364.554481186319, 6455.0, 6458.192725909262, 6498.44763195129, 6461.7738379156735, 6468.676566171673, 6515.967420162869, 6531.281559028503, 6542.640154791485, 6013.54898382623, 6033.849153771191, 6037.577369584131, 6047.818565443044, 6072.362401947776, 27380.45239095227, 28325.85837070822, 28501.85749071262, 28565.57151642727, 28657.140285791458, 2035.5521785207231, 2065.9483512912147, 2079.313826437272, 2085.0825636719946, 2088.488320361506, 18648.720269195837, 19023.0, 19444.416667499856, 19473.318433854747, 19477.220911163535, 2324.604817181066, 2365.44412063165, 2395.161693407311, 2406.843555168926, 2409.6265078912797, 114668.0, 119944.40027799805, 125606.0, 133836.0, 134049.0, 14207.857921420653, 14356.569302920929, 14440.133591984515, 14777.891658125469, 14877.181755003363, 21894.78105218959, 22070.558588828135, 22147.778522214572, 22183.0, 22198.55602887933, 8282.50304981703, 8561.571921403905, 8754.124587541322, 8763.0, 8830.337724670675, 7705.0, 7709.151993280735, 7719.498232614862, 7739.613019349123, 7772.844543109106, 8828.382013259139, 8842.867356989651, 8925.241354484811, 9032.8645070324, 9057.230135438562, 2676.0929043596566, 2679.5176868163526, 2683.4767220391836, 2728.3357152137182, 2759.9448011039667, 974.3861367338532, 976.9951150244203, 986.4180133721139, 993.6025589764153, 1010.8281592129356, 18552.536186595444, 18806.580453593393, 19188.520286992658, 19409.9324537149, 19483.415497535098, 1007.3955626623967, 1008.1632245236436, 1026.7638443157966, 1027.157730660851, 1033.8449232615017, 10492.580296788195, 10585.894141058645, 10618.203634727426, 10737.51681174349, 10774.515146818256, 447872.0, 459733.0, 459774.0, 462677.0, 470489.0, 108305.0, 109825.0, 113028.0, 113262.43368783103, 115235.0, 1036.4662198967537, 1086.9130469562417, 1137.8862113788555, 1155.064397837754, 1203.4825025239231, 19929.402117936486, 20023.29918452847, 20116.89941550283, 20196.899015504827, 20651.380458586267, 52634.0, 53060.4693953071, 53138.0, 54221.18668219901, 54563.727181363836, 66725.0, 67388.6630566844, 67594.66202668955, 68082.0, 68083.0, 13850.16898986064, 14215.218163001135, 14310.928445357707, 14332.85667143357, 14427.711445770816, 22253.21974242089, 22557.43606409853, 22610.547789044456, 22645.773542264367, 22659.43351416228, 17443.127843607515, 17799.822001780336, 18062.819371806112, 18208.544786380447, 18493.0, 15017.32422040989, 15881.0, 16263.756043659117, 16290.0, 16765.91617041907, 16619.41832035873, 17216.483505494856, 17325.82674173242, 18093.728594070835, 18481.53796155107, 14052.016358854782, 14090.22503762303, 14171.929140354232, 14181.290935453393, 14290.785638215642, 17445.38941137105, 17447.47657570275, 17540.649187016443, 17833.46499605014, 17934.0], "value": 11579.67654498588, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1254.6612414648046, 1341.5572860955886, 1347.416785277299, 1347.7102422979065, 1357.633438971477, 14784.704305913876, 15315.617109572238, 15468.303926323315, 15475.69048619027, 15487.922560387211, 15127.924360378183, 15203.695926081471, 15229.543113706606, 15242.314095865684, 15248.542543723679, 2716.5517689581197, 2769.0446795855446, 2789.3723912119713, 2792.45547118312, 2793.4413117376503, 2716.4431291585274, 2747.0659975608287, 2759.434315965232, 2765.3224959884856, 2767.1836808141647, 2331.3239160643393, 2424.369663887393, 2444.3644652390417, 2726.2230264374657, 2730.9180724578196, 2648.139354709727, 2780.110364683302, 2780.430011847566, 2782.0541016054435, 2786.1084452975056, 2534.556452620784, 2543.0844895837486, 2592.3648706066947, 2592.688877334713, 2599.8570078645666, 14711.0, 14773.0, 14820.851791482162, 14837.258137093102, 14848.183349915751, 7584.810379740496, 7785.338246249075, 7811.765647030598, 7847.0975837778815, 7854.057513098408, 5184.9740751296, 5202.413263954492, 5313.468653134656, 5427.864303392407, 5456.317960254968, 1942.417274817549, 1959.1583911123641, 1993.7607487101495, 2017.3040301096098, 2031.9898400507902, 25803.612945805828, 25889.482210355876, 25951.74048259512, 26001.609975850377, 26045.479090418274, 7024.859502810017, 7095.538789978738, 7104.6447677615915, 7315.963420182865, 7317.15852676949, 19741.309054183035, 19780.90109549443, 19838.603227935648, 19852.801471985385, 19868.0, 7841.5687137208, 7970.123286438487, 7973.0, 7979.561124138112, 7983.5209887406945, 7040.401565866856, 7152.749653762197, 7261.41908647307, 7296.7810965671115, 7313.976043353829, 5426.131818908955, 5631.887362252814, 5638.464345887134, 5660.915086273709, 5681.062624666966, 1759.542518945058, 1776.085316062229, 1789.185920406212, 1816.500462372858, 1832.0564909071838, 813.1015228172902, 823.3618945317427, 847.0343808058818, 853.1511146409363, 862.3704695572268, 7187.31720486553, 7213.783586492414, 7234.457415693844, 7258.782236532912, 7296.306850849161, 682.9009793579903, 704.6089420371641, 719.8452332748484, 726.0488759724672, 727.9090113735783, 4354.368616550582, 4380.540043295408, 4429.623482004002, 4469.351943968171, 4496.5503449655425, 20750.0, 21052.0, 21872.671909921362, 21943.780562194173, 22085.889570552365, 20780.376588702362, 21355.57288854214, 21386.465338366354, 21871.45321366947, 22170.445738856335, 11082.833757493645, 11289.661310160709, 11357.26177798457, 11431.59989400367, 11471.885281147248, 7859.410544209093, 7900.68397264103, 7965.601719914097, 7971.840563188588, 8027.036755589366, 17785.46643600694, 18348.63302733911, 18910.0, 18993.145308460877, 19179.94510301947, 19158.425247242605, 19270.61458770845, 19965.401037968884, 20053.197872085537, 20323.79676203219, 12105.152639315163, 12396.070294727751, 12400.689982750504, 12400.937995309965, 12402.627921162019, 13572.117812342167, 13576.456941722616, 13589.592312230649, 13621.523246686318, 13768.65578360549, 10836.403997780199, 11234.382108983757, 11251.49368278413, 11506.482208300815, 11686.590969316374, 11540.365279909685, 11603.825942610698, 11629.127815414047, 11694.88305116938, 11753.529858805552, 9419.670311539063, 9667.129958303505, 9710.6115755369, 9731.805363892541, 9755.414675119515, 6997.335253150943, 7144.678489467882, 7196.928030719626, 7306.232845551141, 7341.302576255247, 7124.465665075037, 7200.207977122617, 7227.891581626174, 7228.674709637974, 7232.674529646284], "value": 6621.7361937135565, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [494.9905763317134, 499.2885138677384, 524.1220954900541, 524.8425472358291, 530.9362876454826, 6136.846578835532, 6220.160278362419, 6303.590266632671, 6317.83023204685, 6337.524685648572, 6013.338532761392, 6194.132821404995, 6201.224846894138, 6202.0, 6247.6251424914535, 5004.8999020019755, 5065.848024559269, 5069.264956581312, 5086.415062267831, 5088.974555127219, 4904.681195722284, 5048.368953880765, 5068.949310506885, 5081.695098294114, 5108.795648174068, 4995.750212489379, 5039.916417970136, 5047.570956468705, 5060.443351231362, 5067.366579177603, 5022.146235140035, 5026.623003274733, 5034.244863270502, 5044.545990860804, 5046.924296135561, 4452.463899954543, 4477.104579084196, 4507.4365704286965, 4524.68327217095, 4539.523350048264, 6125.663088530129, 6138.263408390977, 6185.443310102112, 6195.535334849904, 6246.281677607088, 5775.88448231033, 5785.4214578541805, 5797.391273916221, 5810.0, 5836.824895253149, 6540.4767618590395, 6596.637184954826, 6606.669666516703, 6628.701708423133, 6658.10115634388, 4814.855554333376, 4847.466778654345, 4857.465678775332, 4858.732769697665, 4898.804047838118, 6912.343327383891, 6968.79093627192, 6973.407260382823, 6978.825529361756, 7028.4025857801635, 5057.317262169634, 5064.41759197697, 5073.594112470993, 5093.656917817845, 5094.643374963717, 5068.974655126774, 5105.923411148836, 5128.230765385222, 5129.538341549279, 5141.997310524486, 5666.490015898589, 5685.488306052475, 5761.942380576224, 5783.855403614859, 5805.738741756547, 6551.672416379162, 6679.198496180392, 6705.966470167618, 6706.865862682719, 6751.797446076625, 1677.2703873814685, 1700.6343636118295, 1726.48205538338, 1729.8789084764198, 1748.9212985415686, 1194.5639841457805, 1220.1641875315438, 1231.347385885482, 1245.7729136800244, 1249.4252643783962, 5549.1676248562235, 5583.916241256385, 5742.425757424224, 5762.164486149485, 5858.502027327725, 6536.379043990813, 6546.214454265519, 6552.0, 6641.089430406942, 6646.335366463411, 5762.481376676119, 5762.625429347079, 5772.740226689725, 5849.707514624251, 5865.296164460292, 3534.6288639692975, 3574.766705486603, 3589.5692516897616, 3637.3270944875285, 3651.6165802590344, 6547.312532184147, 6547.4286171318545, 6608.768693095719, 6616.735330586819, 6622.304658010936, 6801.625910574966, 6908.758193463204, 6966.198887127944, 6982.26686197952, 7039.260877607778, 6449.290578036413, 6502.187226596676, 6519.282878883224, 6562.507811914125, 6580.76967306142, 6561.835954100995, 6588.748137853792, 6723.764668236784, 6782.25395206517, 6802.489813264124, 6659.833504162435, 6662.367075127855, 6665.866682666417, 6685.197776266879, 6730.4952128589575, 6377.808665740035, 6473.902891456538, 6557.590118124626, 6573.704183311666, 6573.80278591643, 5438.102713052302, 5504.394516603091, 5524.475174858382, 5587.441255874543, 5593.888122237614, 6631.3700198481065, 6760.864782704417, 6786.710525000234, 6805.897911531232, 6824.897626535705, 6401.647909364843, 6425.871482570229, 6430.742770289136, 6488.377905523619, 6520.413162815369, 6387.936120638734, 6423.678816059085, 6451.806445806634, 6457.935420645921, 6477.490122426931, 6162.414570615784, 6242.563020588515, 6401.935980640134, 6453.838654033499, 6495.090687303876, 6497.772577959938, 6560.507961902972, 6576.605403675795, 6635.236947750877, 6743.662816859235, 6269.153664255267, 6300.369963003663, 6359.395857393541, 6381.298057213796, 6423.550351475352], "value": 5089.317848195018, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [834.3617132893338, 859.2548494319589, 887.0907319997002, 894.3515950935569, 901.5492253873066, 15598.610034749123, 16096.0, 16134.870559060884, 16136.677266454664, 16158.7576186357, 16567.83432165681, 16929.49211523653, 16979.32082716693, 17072.658546829058, 17137.57156071099, 945.0, 951.1534734086669, 959.7696552827341, 960.159860122393, 960.255801753643, 964.3827950111934, 966.4539535162646, 967.1585720423242, 967.762898089969, 968.1141755293897, 970.8883478400004, 1024.5031159887449, 1024.9128824049928, 1034.6275340877278, 1036.507658862042, 1022.8312328465794, 1023.8720159980003, 1025.1644909398817, 1027.2449749434234, 1027.368168576324, 710.9502334836563, 740.5482655580092, 741.0699572037113, 742.610129681916, 742.858856817203, 14821.333040013225, 14839.851601483955, 14890.851091489054, 14961.102333860003, 15071.397144114222, 21189.470263243544, 21290.148394064217, 21534.246301379375, 21634.350969470783, 21767.67348489774, 17703.73444398335, 17963.0, 18110.185041673158, 18153.7276940846, 18512.814871851242, 3778.149916268845, 3811.942820857689, 3814.828332725034, 3816.542014958195, 3817.4464702617965, 135839.32080339635, 138379.0, 140899.0, 143112.28443857818, 144751.0, 16663.0, 16796.664066718597, 17036.403725869535, 17260.82739172592, 17456.65086698259, 30651.08046758601, 31665.366692666477, 31705.0, 32356.35287294241, 32365.676343236268, 8167.795805104801, 8302.335813134934, 8316.6673333066, 8407.915920840836, 8437.662493500315, 4047.3119569673227, 4113.095119073799, 4114.670826333886, 4137.606927341898, 4145.689073319513, 4811.9518804812205, 4936.75316234194, 4947.233178857283, 4966.379202599675, 4970.552650261494, 938.2681508423441, 963.4363897120123, 973.5229737428609, 979.9608015679436, 984.3404918704485, 658.6542065415599, 660.6993817812884, 664.1167247560733, 678.7047634279104, 689.2074114768056, 10775.461226938622, 10981.630654220533, 11275.54897804095, 11666.358350290646, 11836.349000804867, 657.3787770556778, 674.9055132281386, 682.8634273145391, 685.3934268172703, 685.9265249883915, 5432.701201433959, 5495.505404513533, 5504.22940788282, 5533.916991245134, 5617.410171931889, 117137.0, 117343.41328293303, 119375.0, 123988.38005809914, 124325.0, 108099.45950270355, 108166.45916770524, 108247.45876270568, 109066.45466772615, 109121.0, 91471.0, 93017.534912325, 94399.52800236092, 95117.0488295122, 95826.52086739521, 10134.0, 10201.234907381828, 10289.84565231537, 10291.33106348085, 10455.424951627734, 42901.356479653456, 42929.35605965975, 42952.78523607362, 43995.78002109969, 44714.55285447104, 55953.440465594824, 56533.71733141308, 57821.170401031086, 58259.0, 58922.410775891694, 14841.183734894685, 15021.0, 15063.096214227182, 15187.468438604596, 15292.311845966735, 16251.0, 16387.42644007454, 16397.91801040987, 16415.015099094093, 16636.16819159013, 13306.534271300845, 13314.201147931155, 13397.397117129947, 13483.865161348262, 13639.863601363859, 14525.418983240552, 14546.127232366092, 14673.779893301822, 14720.337584808494, 14872.033317834306, 12631.11582189238, 12652.43064062101, 12694.555690550786, 12806.167599106027, 12812.167209131376, 12014.219075760397, 12163.0, 12421.19262247951, 12471.002319814574, 12556.623301300975, 11461.656150315504, 11489.195756297313, 11506.597269095877, 11682.123840712151, 11757.882421175678], "value": 8558.653077982228, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1455.4999999999995, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 116.0, 108.0, 108.0, 108.0, 111.0, 109.0, 121.0, 108.0, 113.0], "value": 111.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [120.0, 116.0, 117.0, 117.0, 129.0, 115.0, 117.0, 117.0, 122.0, 117.0], "value": 118.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [166.0, 163.0, 167.0, 163.0, 167.0, 169.0, 166.0, 163.0, 166.0, 171.0], "value": 166.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 74.0, 81.0, 74.0, 80.0, 75.0, 83.0, 82.0, 78.0, 81.0], "value": 78.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 92.0, 89.0, 82.0, 85.0, 79.0, 88.0, 86.0, 79.0, 82.0], "value": 84.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 114.0, 124.0, 114.0, 114.0, 113.0, 117.0, 114.0, 112.0, 115.0], "value": 115.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 147.0, 152.0, 150.0, 149.0, 150.0, 150.0, 148.0, 153.0, 149.0], "value": 149.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 99.0, 99.0, 94.0, 94.0, 94.0, 97.0, 96.0, 96.0, 94.0], "value": 95.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 54.0, 61.0, 63.0, 62.0, 55.0, 56.0, 54.0, 53.0, 53.0], "value": 57.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [43.0, 39.0, 50.0, 45.0, 39.0, 48.0, 38.0, 48.0, 45.0, 38.0], "value": 43.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 76.0, 76.0, 78.0, 85.0, 75.0, 81.0, 81.0, 77.0, 77.0], "value": 78.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [130.0, 116.0, 113.0, 110.0, 117.0, 117.0, 125.0, 113.0, 115.0, 115.0], "value": 117.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [176.0, 172.0, 171.0, 170.0, 168.0, 174.0, 172.0, 169.0, 177.0, 179.0], "value": 172.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 64.0, 64.0, 69.0, 66.0, 65.0, 65.0, 65.0, 68.0, 64.0], "value": 66.1, "unit": "score"}]}]}
11:41:14 INFO - Return code: 0
11:41:14 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json
11:41:14 INFO - # TBPL SUCCESS #
11:41:14 INFO - Running post-action listener: _package_coverage_data
11:41:14 INFO - Running post-action listener: _resource_record_post_action
11:41:14 INFO - [mozharness: 2017-09-12 18:41:14.226243Z] Finished run-tests step (success)
11:41:14 INFO - Running post-run listener: _resource_record_post_run
11:41:14 INFO - Total resource usage - Wall time: 1195s; CPU: 13.0%; Read bytes: 9822208; Write bytes: 304963584; Read time: 6532; Write time: 334328
11:41:14 INFO - TinderboxPrint: CPU usage
13.3%
11:41:14 INFO - TinderboxPrint: I/O read bytes / time
9,822,208 / 6,532
11:41:14 INFO - TinderboxPrint: I/O write bytes / time
304,963,584 / 334,328
11:41:14 INFO - TinderboxPrint: CPU idle
8,255.4 (86.7%)
11:41:14 INFO - TinderboxPrint: CPU user
1,200.5 (12.6%)
11:41:14 INFO - TinderboxPrint: Swap in / out
0 / 0
11:41:14 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 15966208; Read time: 0; Write time: 3516
11:41:14 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0
11:41:14 INFO - run-tests - Wall time: 1178s; CPU: 13.0%; Read bytes: 9801728; Write bytes: 288497664; Read time: 6496; Write time: 330700
11:41:14 INFO - Running post-run listener: _upload_blobber_files
11:41:14 INFO - Blob upload gear active.
11:41:14 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir.
11:41:14 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com
11:41:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json']
11:41:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json
11:41:15 INFO - (blobuploader) - INFO - Open directory for files ...
11:41:15 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ...
11:41:15 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com
11:41:15 INFO - (blobuploader) - INFO - Uploading, attempt #1.
11:41:16 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded
11:41:16 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded!
11:41:16 INFO - (blobuploader) - INFO - Done attempting.
11:41:16 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ...
11:41:16 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com
11:41:16 INFO - (blobuploader) - INFO - Uploading, attempt #1.
11:41:17 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded
11:41:17 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded!
11:41:17 INFO - (blobuploader) - INFO - Done attempting.
11:41:17 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ...
11:41:17 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com
11:41:17 INFO - (blobuploader) - INFO - Uploading, attempt #1.
11:41:18 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded
11:41:18 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded!
11:41:18 INFO - (blobuploader) - INFO - Done attempting.
11:41:18 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ...
11:41:18 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com
11:41:18 INFO - (blobuploader) - INFO - Uploading, attempt #1.
11:41:21 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded
11:41:21 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded!
11:41:21 INFO - (blobuploader) - INFO - Done attempting.
11:41:21 INFO - (blobuploader) - INFO - Iteration through files over.
11:41:21 INFO - Return code: 0
11:41:21 INFO - rmtree: /builds/slave/test/build/uploaded_files.json
11:41:21 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1
11:41:21 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9b0810b23989f0c200a747c379c4a5fd941ccedc9d7fa31964c1ef09de710f08f77bf93e2834d2f242b185d1f4f013f36942334430cc152eb33ba2b9d959d53f", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7ebc7ecedeff436c3f867d81b151904af7c180b70d8abbb3e73123eb369eb11552ebc07203b0c299fbc4009bdd9df4933e42ec7a5cc915effe02dbd3ac177265", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/68e604153334f5161044f20d48d6b07a449aeae9df175ad277f9dc5344b01afedc4001c86f41e8e7e1d98ee661471b4d9d4015ad941e7859fef0954daa965efe", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/09a22861a75b2ad8794587063fcfc31edde40fa9a0d07a994196f8456d1f52226728a164602554b9fd2cf5dfa69f0b9a4871dd228c70d7078920d604cd61a158"}
11:41:21 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files
11:41:21 INFO - Writing to file /builds/slave/test/properties/blobber_files
11:41:21 INFO - Contents:
11:41:21 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9b0810b23989f0c200a747c379c4a5fd941ccedc9d7fa31964c1ef09de710f08f77bf93e2834d2f242b185d1f4f013f36942334430cc152eb33ba2b9d959d53f", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7ebc7ecedeff436c3f867d81b151904af7c180b70d8abbb3e73123eb369eb11552ebc07203b0c299fbc4009bdd9df4933e42ec7a5cc915effe02dbd3ac177265", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/68e604153334f5161044f20d48d6b07a449aeae9df175ad277f9dc5344b01afedc4001c86f41e8e7e1d98ee661471b4d9d4015ad941e7859fef0954daa965efe", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/09a22861a75b2ad8794587063fcfc31edde40fa9a0d07a994196f8456d1f52226728a164602554b9fd2cf5dfa69f0b9a4871dd228c70d7078920d604cd61a158"}
11:41:21 INFO - Running post-run listener: copy_logs_to_upload_dir
11:41:21 INFO - Copying logs to upload dir...
11:41:21 INFO - mkdir: /builds/slave/test/build/upload/logs
11:41:21 INFO - Copying logs to upload dir...
program finished with exit code 0
elapsedTime=1254.841958
========= master_lag: 0.11 =========
========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 54 secs) (at 2017-09-12 11:41:21.627617) =========
========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-12 11:41:21.631368) =========
bash -c 'for file in `ls -1`; do cat $file; done'
in dir /builds/slave/test/properties (timeout 1200 secs)
watching logfiles {}
argv: ['bash', '-c', 'for file in `ls -1`; do cat $file; done']
environment:
DISPLAY=:0
HOME=/home/cltbld
LANG=en_US.UTF-8
LANGUAGE=en_US:en
LOGNAME=cltbld
MAIL=/var/mail/cltbld
MOZ_CRASHREPORTER_NO_REPORT=1
MOZ_NO_REMOTE=1
NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript
NO_EM_RESTART=1
PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games
PWD=/builds/slave/test/properties
SHELL=/bin/bash
SHLVL=1
TERM=linux
TMOUT=86400
USER=cltbld
XDG_SESSION_COOKIE=781b77c4c33858b1f599d705000001c1-1505217657.506684-1238802230
XPCOM_DEBUG_BREAK=warn
_=/tools/buildbot/bin/python
using PTY: False
blobber_files:{"dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9b0810b23989f0c200a747c379c4a5fd941ccedc9d7fa31964c1ef09de710f08f77bf93e2834d2f242b185d1f4f013f36942334430cc152eb33ba2b9d959d53f", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7ebc7ecedeff436c3f867d81b151904af7c180b70d8abbb3e73123eb369eb11552ebc07203b0c299fbc4009bdd9df4933e42ec7a5cc915effe02dbd3ac177265", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/68e604153334f5161044f20d48d6b07a449aeae9df175ad277f9dc5344b01afedc4001c86f41e8e7e1d98ee661471b4d9d4015ad941e7859fef0954daa965efe", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/09a22861a75b2ad8794587063fcfc31edde40fa9a0d07a994196f8456d1f52226728a164602554b9fd2cf5dfa69f0b9a4871dd228c70d7078920d604cd61a158"}
build_url:https://queue.taskcluster.net/v1/task/eW846iPkS8eiD1elPeIpkA/artifacts/public/build/target.tar.bz2
program finished with exit code 0
elapsedTime=0.011790
build_url: 'https://queue.taskcluster.net/v1/task/eW846iPkS8eiD1elPeIpkA/artifacts/public/build/target.tar.bz2'
blobber_files: '{"dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9b0810b23989f0c200a747c379c4a5fd941ccedc9d7fa31964c1ef09de710f08f77bf93e2834d2f242b185d1f4f013f36942334430cc152eb33ba2b9d959d53f", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7ebc7ecedeff436c3f867d81b151904af7c180b70d8abbb3e73123eb369eb11552ebc07203b0c299fbc4009bdd9df4933e42ec7a5cc915effe02dbd3ac177265", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/68e604153334f5161044f20d48d6b07a449aeae9df175ad277f9dc5344b01afedc4001c86f41e8e7e1d98ee661471b4d9d4015ad941e7859fef0954daa965efe", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/09a22861a75b2ad8794587063fcfc31edde40fa9a0d07a994196f8456d1f52226728a164602554b9fd2cf5dfa69f0b9a4871dd228c70d7078920d604cd61a158"}'
========= master_lag: 0.02 =========
========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-12 11:41:21.666230) =========
========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-12 11:41:21.666601) =========
rm -f oauth.txt
in dir /builds/slave/test/. (timeout 1200 secs)
watching logfiles {}
argv: ['rm', '-f', 'oauth.txt']
environment:
DISPLAY=:0
HOME=/home/cltbld
LANG=en_US.UTF-8
LANGUAGE=en_US:en
LOGNAME=cltbld
MAIL=/var/mail/cltbld
MOZ_CRASHREPORTER_NO_REPORT=1
MOZ_NO_REMOTE=1
NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript
NO_EM_RESTART=1
PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games
PWD=/builds/slave/test
SHELL=/bin/bash
SHLVL=1
TERM=linux
TMOUT=86400
USER=cltbld
XDG_SESSION_COOKIE=781b77c4c33858b1f599d705000001c1-1505217657.506684-1238802230
XPCOM_DEBUG_BREAK=warn
_=/tools/buildbot/bin/python
using PTY: False
program finished with exit code 0
elapsedTime=0.004511
========= master_lag: 0.05 =========
========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-12 11:41:21.716992) =========
========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-12 11:41:21.717337) =========
========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-12 11:41:21.717643) =========
========= Total master_lag: 0.30 =========