builder: mozilla-inbound_ubuntu64_hw_test-dromaeojs-e10s-pgo
slave: talos-linux64-ix-031
starttime: 1477776390.32
results: success (0)
buildid: 20161029132624
builduid: 307e051107b0495698e10645e25d24a8
revision: ee15183d057288ccd8b6b22b13b85c540229f736
========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-29 14:26:30.322465) =========
master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/
========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-29 14:26:30.322924) =========
========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-29 14:26:30.323201) =========
========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-29 14:26:30.335476) =========
========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-29 14:26:30.335850) =========
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=db0483c52d987ecb441a263b000001ad-1477776389.587184-235884091
XPCOM_DEBUG_BREAK=warn
_=/tools/buildbot/bin/python
using PTY: False
--2016-10-29 14:26:30-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py
Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102
Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected.
HTTP request sent, awaiting response... 200 Script output follows
Length: 12179 (12K) [text/x-python]
Saving to: `archiver_client.py'
0K .......... . 100% 223M=0s
2016-10-29 14:26:30 (223 MB/s) - `archiver_client.py' saved [12179/12179]
program finished with exit code 0
elapsedTime=0.128837
========= master_lag: 0.01 =========
========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-29 14:26:30.476651) =========
========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-29 14:26:30.476969) =========
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=db0483c52d987ecb441a263b000001ad-1477776389.587184-235884091
XPCOM_DEBUG_BREAK=warn
_=/tools/buildbot/bin/python
using PTY: False
program finished with exit code 0
elapsedTime=0.014191
========= master_lag: 0.04 =========
========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-29 14:26:30.526483) =========
========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-29 14:26:30.526848) =========
bash -c 'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev ee15183d057288ccd8b6b22b13b85c540229f736 --destination scripts --debug'
in dir /builds/slave/test/. (timeout 1200 secs)
watching logfiles {}
argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev ee15183d057288ccd8b6b22b13b85c540229f736 --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=db0483c52d987ecb441a263b000001ad-1477776389.587184-235884091
XPCOM_DEBUG_BREAK=warn
_=/tools/buildbot/bin/python
using PTY: False
2016-10-29 14:26:30,583 truncating revision to first 12 chars
2016-10-29 14:26:30,583 Setting DEBUG logging.
2016-10-29 14:26:30,583 attempt 1/10
2016-10-29 14:26:30,583 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/ee15183d0572?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness
2016-10-29 14:26:31,840 unpacking tar archive at: mozilla-inbound-ee15183d0572/testing/mozharness/
program finished with exit code 0
elapsedTime=1.596848
========= master_lag: 0.01 =========
========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-29 14:26:32.137125) =========
========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-29 14:26:32.137456) =========
script_repo_revision: ee15183d057288ccd8b6b22b13b85c540229f736
========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-29 14:26:32.137837) =========
========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-29 14:26:32.138098) =========
========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-29 14:26:32.147812) =========
========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 37 secs) (at 2016-10-29 14:26:32.148197) =========
/tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound
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', 'Mozilla-Inbound', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Inbound']
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=db0483c52d987ecb441a263b000001ad-1477776389.587184-235884091
XPCOM_DEBUG_BREAK=warn
_=/tools/buildbot/bin/python
using PTY: False
14:26:32 INFO - MultiFileLogger online at 20161029 14:26:32 in /builds/slave/test
14:26:32 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound
14:26:32 INFO - Dumping config to /builds/slave/test/logs/localconfig.json.
14:26:32 INFO - {'append_to_log': False,
14:26:32 INFO - 'base_work_dir': '/builds/slave/test',
14:26:32 INFO - 'blob_upload_branch': 'Mozilla-Inbound',
14:26:32 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt',
14:26:32 INFO - 'branch': 'Mozilla-Inbound',
14:26:32 INFO - 'buildbot_json_path': 'buildprops.json',
14:26:32 INFO - 'config_files': ('talos/linux_config.py',),
14:26:32 INFO - 'default_actions': ('clobber',
14:26:32 INFO - 'read-buildbot-config',
14:26:32 INFO - 'download-and-extract',
14:26:32 INFO - 'populate-webroot',
14:26:32 INFO - 'create-virtualenv',
14:26:32 INFO - 'install',
14:26:32 INFO - 'run-tests'),
14:26:32 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',),
14:26:32 INFO - 'download_minidump_stackwalk': True,
14:26:32 INFO - 'download_symbols': 'ondemand',
14:26:32 INFO - 'exes': {'python': '/tools/buildbot/bin/python',
14:26:32 INFO - 'tooltool.py': '/tools/tooltool.py',
14:26:32 INFO - 'virtualenv': ('/tools/buildbot/bin/python',
14:26:32 INFO - '/tools/misc-python/virtualenv.py')},
14:26:32 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub',
14:26:32 INFO - 'http://pypi.pub.build.mozilla.org/pub'),
14:26:32 INFO - 'installer_path': 'installer.exe',
14:26:32 INFO - 'log_level': 'info',
14:26:32 INFO - 'log_name': 'talos',
14:26:32 INFO - 'log_to_console': True,
14:26:32 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk',
14:26:32 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest',
14:26:32 INFO - 'opt_config_files': (),
14:26:32 INFO - 'pip_index': False,
14:26:32 INFO - 'sps_profile': False,
14:26:32 INFO - 'sps_profile_interval': 0,
14:26:32 INFO - 'suite': 'dromaeojs-e10s',
14:26:32 INFO - 'system_bits': '32',
14:26:32 INFO - 'talos_extra_options': ('--webServer', 'localhost'),
14:26:32 INFO - 'title': 'talos-linux64-ix-031',
14:26:32 INFO - 'tooltool_cache': '/builds/tooltool_cache',
14:26:32 INFO - 'use_talos_json': True,
14:26:32 INFO - 'virtualenv_path': '/builds/slave/test/build/venv',
14:26:32 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None},
14:26:32 INFO - 'work_dir': 'build'}
14:26:32 INFO - [mozharness: 2016-10-29 21:26:32.304582Z] Running clobber step.
14:26:32 INFO - Running pre-action listener: _resource_record_pre_action
14:26:32 INFO - Running main action method: clobber
14:26:32 INFO - rmtree: /builds/slave/test/build
14:26:32 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1
14:26:32 INFO - Running post-action listener: _resource_record_post_action
14:26:32 INFO - [mozharness: 2016-10-29 21:26:32.765219Z] Finished clobber step (success)
14:26:32 INFO - [mozharness: 2016-10-29 21:26:32.765318Z] Running read-buildbot-config step.
14:26:32 INFO - Running pre-action listener: _resource_record_pre_action
14:26:32 INFO - Running main action method: read_buildbot_config
14:26:32 INFO - Using buildbot properties:
14:26:32 INFO - {
14:26:32 INFO - "project": "",
14:26:32 INFO - "product": "firefox",
14:26:32 INFO - "script_repo_revision": "production",
14:26:32 INFO - "builddir": "mozilla-inbound_ubuntu64_hw_test-dromaeojs-e10s",
14:26:32 INFO - "repository": "",
14:26:32 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-inbound pgo talos dromaeojs-e10s",
14:26:32 INFO - "buildid": "20161029132624",
14:26:32 INFO - "stage_platform": "linux64-pgo",
14:26:32 INFO - "basedir": "/builds/slave/test",
14:26:32 INFO - "buildnumber": 1671,
14:26:32 INFO - "platform": "ubuntu64_hw",
14:26:32 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/",
14:26:32 INFO - "slavebuilddir": "test",
14:26:32 INFO - "branch": "mozilla-inbound",
14:26:32 INFO - "revision": "ee15183d057288ccd8b6b22b13b85c540229f736",
14:26:32 INFO - "slavename": "talos-linux64-ix-031",
14:26:32 INFO - "builduid": "307e051107b0495698e10645e25d24a8",
14:26:32 INFO - "repo_path": "integration/mozilla-inbound"
14:26:32 INFO - }
14:26:32 INFO - Found installer url https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1477704608/firefox-52.0a1.en-US.linux-x86_64.tar.bz2.
14:26:32 INFO - Found a test packages url https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1477704608/firefox-52.0a1.en-US.linux-x86_64.test_packages.json.
14:26:32 INFO - Running post-action listener: _resource_record_post_action
14:26:32 INFO - [mozharness: 2016-10-29 21:26:32.767725Z] Finished read-buildbot-config step (success)
14:26:32 INFO - [mozharness: 2016-10-29 21:26:32.767815Z] Running download-and-extract step.
14:26:32 INFO - Running pre-action listener: _resource_record_pre_action
14:26:32 INFO - Running main action method: download_and_extract
14:26:32 INFO - mkdir: /builds/slave/test/build/tests
14:26:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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')]}
14:26:32 INFO - trying https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1477704608/firefox-52.0a1.en-US.linux-x86_64.test_packages.json
14:26:32 INFO - Downloading https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1477704608/firefox-52.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json
14:26:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1477704608/firefox-52.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1
14:26:32 INFO - Downloaded 1361 bytes.
14:26:32 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json
14:26:32 INFO - Using the following test package requirements:
14:26:32 INFO - {u'common': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'],
14:26:32 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip',
14:26:32 INFO - u'firefox-52.0a1.en-US.linux-x86_64.cppunittest.tests.zip'],
14:26:32 INFO - u'gtest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip',
14:26:32 INFO - u'firefox-52.0a1.en-US.linux-x86_64.gtest.tests.zip'],
14:26:32 INFO - u'jittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip',
14:26:32 INFO - u'jsshell-linux-x86_64.zip'],
14:26:32 INFO - u'mochitest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip',
14:26:32 INFO - u'firefox-52.0a1.en-US.linux-x86_64.mochitest.tests.zip'],
14:26:32 INFO - u'mozbase': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'],
14:26:32 INFO - u'reftest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip',
14:26:32 INFO - u'firefox-52.0a1.en-US.linux-x86_64.reftest.tests.zip'],
14:26:32 INFO - u'talos': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip',
14:26:32 INFO - u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'],
14:26:32 INFO - u'web-platform': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip',
14:26:32 INFO - u'firefox-52.0a1.en-US.linux-x86_64.web-platform.tests.zip'],
14:26:32 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip',
14:26:32 INFO - u'firefox-52.0a1.en-US.linux-x86_64.xpcshell.tests.zip']}
14:26:32 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common
14:26:32 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1477704608/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip
14:26:32 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1477704608/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1
14:26:32 INFO - Fetch https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1477704608/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory
14:26:32 INFO - Http code: 200
14:26:32 INFO - via: 1.1 e30ae5b3d9f6779a9b8bc992faad0b09.cloudfront.net (CloudFront)
14:26:32 INFO - x-amz-cf-id: KQtFW0vll_njyW2mb2VtS9ksy-N96GhJZsD1gA1rC8l2tBzdI44QCA==
14:26:32 INFO - x-amz-replication-status: PENDING
14:26:32 INFO - x-amz-version-id: 7meENsawwlOmV1YgTRh39SVSK2r9bqk6
14:26:33 INFO - Expected file size: 22012607
14:26:33 INFO - Obtained file size: 22012607
14:26:37 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos
14:26:37 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1477704608/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip
14:26:37 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1477704608/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1
14:26:37 INFO - Fetch https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1477704608/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory
14:26:37 INFO - Http code: 200
14:26:37 INFO - via: 1.1 336f0e6ef9a3462f682d6ca49029b665.cloudfront.net (CloudFront)
14:26:37 INFO - x-amz-cf-id: QMA1mq1cA-UOSNwhMbw5WqD0gPA8bCC5UpSK7FSfG93d6pH_mKYHBw==
14:26:37 INFO - x-amz-replication-status: PENDING
14:26:37 INFO - x-amz-version-id: 7meENsawwlOmV1YgTRh39SVSK2r9bqk6
14:26:37 INFO - Expected file size: 22012607
14:26:37 INFO - Obtained file size: 22012607
14:26:42 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1477704608/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip
14:26:42 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1477704608/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1
14:26:42 INFO - Fetch https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1477704608/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip into memory
14:26:42 INFO - Http code: 200
14:26:42 INFO - via: 1.1 c54d7f08e2f3dab1918454910cc8aad0.cloudfront.net (CloudFront)
14:26:42 INFO - x-amz-cf-id: vfeFHN6x4EEEwTEQefoU7NeB23uR5XEh20Kn79_ZqPnT3sUirg4_9w==
14:26:42 INFO - x-amz-replication-status: PENDING
14:26:42 INFO - x-amz-version-id: cqa0lcBJqzRihuqe1oSM7Rl6Mxj_hvgF
14:26:42 INFO - Expected file size: 14409030
14:26:42 INFO - Obtained file size: 14409030
14:26:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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')]}
14:26:42 INFO - trying https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1477704608/firefox-52.0a1.en-US.linux-x86_64.tar.bz2
14:26:42 INFO - Downloading https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1477704608/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2
14:26:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1477704608/firefox-52.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1
14:26:43 INFO - Downloaded 59636283 bytes.
14:26:43 INFO - Setting buildbot property build_url to https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1477704608/firefox-52.0a1.en-US.linux-x86_64.tar.bz2
14:26:43 INFO - mkdir: /builds/slave/test/properties
14:26:43 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url
14:26:43 INFO - Writing to file /builds/slave/test/properties/build_url
14:26:43 INFO - Contents:
14:26:43 INFO - build_url:https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1477704608/firefox-52.0a1.en-US.linux-x86_64.tar.bz2
14:26:43 INFO - Running post-action listener: _resource_record_post_action
14:26:43 INFO - Running post-action listener: set_extra_try_arguments
14:26:43 INFO - [mozharness: 2016-10-29 21:26:43.662570Z] Finished download-and-extract step (success)
14:26:43 INFO - [mozharness: 2016-10-29 21:26:43.662796Z] Running populate-webroot step.
14:26:43 INFO - Running pre-action listener: _resource_record_pre_action
14:26:43 INFO - Running main action method: populate_webroot
14:26:43 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']},
14:26:43 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']},
14:26:43 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome',
14:26:43 INFO - '--tppagecycles',
14:26:43 INFO - '7'],
14:26:43 INFO - 'tests': ['tsvgm']}},
14:26:43 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'],
14:26:43 INFO - 'tests': ['tresize', 'tcanvasmark']},
14:26:43 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']},
14:26:43 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'],
14:26:43 INFO - 'tests': ['dromaeo_css', 'kraken']},
14:26:43 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']},
14:26:43 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip',
14:26:43 INFO - 'talos_options': ['--disable-e10s'],
14:26:43 INFO - 'tests': ['tp5o_scroll', 'glterrain']},
14:26:43 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip',
14:26:43 INFO - 'tests': ['tp5o_scroll', 'glterrain']},
14:26:43 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip',
14:26:43 INFO - 'talos_options': ['--disable-e10s'],
14:26:43 INFO - 'tests': ['damp', 'tps']},
14:26:43 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip',
14:26:43 INFO - 'tests': ['damp', 'tps']},
14:26:43 INFO - 'g3': {'talos_options': ['--disable-e10s'],
14:26:43 INFO - 'tests': ['dromaeo_dom']},
14:26:43 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']},
14:26:43 INFO - 'g4': {'talos_options': ['--disable-e10s'],
14:26:43 INFO - 'tests': ['basic_compositor_video']},
14:26:43 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']},
14:26:43 INFO - 'other': {'talos_options': ['--disable-e10s'],
14:26:43 INFO - 'tests': ['a11yr',
14:26:43 INFO - 'ts_paint',
14:26:43 INFO - 'tpaint',
14:26:43 INFO - 'sessionrestore',
14:26:43 INFO - 'sessionrestore_no_auto_restore',
14:26:43 INFO - 'tabpaint']},
14:26:43 INFO - 'other-e10s': {'tests': ['a11yr',
14:26:43 INFO - 'ts_paint',
14:26:43 INFO - 'tpaint',
14:26:43 INFO - 'sessionrestore',
14:26:43 INFO - 'sessionrestore_no_auto_restore',
14:26:43 INFO - 'tabpaint']},
14:26:43 INFO - 'other-e10s_l64': {'tests': ['a11yr',
14:26:43 INFO - 'ts_paint',
14:26:43 INFO - 'tpaint',
14:26:43 INFO - 'sessionrestore',
14:26:43 INFO - 'sessionrestore_no_auto_restore',
14:26:43 INFO - 'tabpaint']},
14:26:43 INFO - 'other-e10s_nol64': {'tests': ['a11yr',
14:26:43 INFO - 'ts_paint',
14:26:43 INFO - 'tpaint',
14:26:43 INFO - 'sessionrestore',
14:26:43 INFO - 'sessionrestore_no_auto_restore',
14:26:43 INFO - 'tabpaint']},
14:26:43 INFO - 'other_l64': {'talos_options': ['--disable-e10s'],
14:26:43 INFO - 'tests': ['a11yr',
14:26:43 INFO - 'ts_paint',
14:26:43 INFO - 'tpaint',
14:26:43 INFO - 'sessionrestore',
14:26:43 INFO - 'sessionrestore_no_auto_restore',
14:26:43 INFO - 'tabpaint']},
14:26:43 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'],
14:26:43 INFO - 'tests': ['a11yr',
14:26:43 INFO - 'ts_paint',
14:26:43 INFO - 'tpaint',
14:26:43 INFO - 'sessionrestore',
14:26:43 INFO - 'sessionrestore_no_auto_restore',
14:26:43 INFO - 'tabpaint']},
14:26:43 INFO - 'svgr': {'talos_options': ['--disable-e10s'],
14:26:43 INFO - 'tests': ['tsvgx',
14:26:43 INFO - 'tsvgr_opacity',
14:26:43 INFO - 'tart',
14:26:43 INFO - 'tscrollx',
14:26:43 INFO - 'cart']},
14:26:43 INFO - 'svgr-e10s': {'tests': ['tsvgx',
14:26:43 INFO - 'tsvgr_opacity',
14:26:43 INFO - 'tart',
14:26:43 INFO - 'tscrollx',
14:26:43 INFO - 'cart']},
14:26:43 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip',
14:26:43 INFO - 'talos_options': ['--disable-e10s'],
14:26:43 INFO - 'tests': ['tp5o']},
14:26:43 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip',
14:26:43 INFO - 'tests': ['tp5o']},
14:26:43 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip',
14:26:43 INFO - 'talos_options': ['--disable-e10s',
14:26:43 INFO - '--xperf_path',
14:26:43 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'],
14:26:43 INFO - 'tests': ['tp5n']},
14:26:43 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip',
14:26:43 INFO - 'talos_options': ['--xperf_path',
14:26:43 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'],
14:26:43 INFO - 'tests': ['tp5n']}},
14:26:43 INFO - 'talos.zip': {'path': '',
14:26:43 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}}
14:26:43 INFO - Running post-action listener: _resource_record_post_action
14:26:43 INFO - [mozharness: 2016-10-29 21:26:43.685321Z] Finished populate-webroot step (success)
14:26:43 INFO - [mozharness: 2016-10-29 21:26:43.685419Z] Running create-virtualenv step.
14:26:43 INFO - Running pre-action listener: _resource_record_pre_action
14:26:43 INFO - Running main action method: create_virtualenv
14:26:43 INFO - Creating virtualenv /builds/slave/test/build/venv
14:26:43 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build
14:26:43 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv
14:26:43 INFO - The --no-site-packages flag is deprecated; it is now the default behavior.
14:26:43 INFO - Using real prefix '/usr'
14:26:43 INFO - New python executable in /builds/slave/test/build/venv/bin/python
14:26:44 INFO - Installing distribute.............................................................................................................................................................................................done.
14:26:46 INFO - Installing pip.................done.
14:26:46 INFO - Return code: 0
14:26:46 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version']
14:26:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version
14:26:46 INFO - Reading from file tmpfile_stdout
14:26:46 INFO - Output received:
14:26:46 INFO - pip 1.5.5 from /builds/slave/test/build/venv/local/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7)
14:26:46 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv
14:26:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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')]}
14:26:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org
14:26:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub
14:26:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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')]}
14:26:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org
14:26:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub
14:26:46 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.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 0x7f5e83e52f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x143f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x150cca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1509f60>, '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 0x150ad40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x150b1d0>, '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': 'db0483c52d987ecb441a263b000001ad-1477776389.587184-235884091', '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
14:26:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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
14:26:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5
14:26:46 INFO - Using env: {'DISPLAY': ':0',
14:26:46 INFO - 'HOME': '/home/cltbld',
14:26:46 INFO - 'LANG': 'en_US.UTF-8',
14:26:46 INFO - 'LANGUAGE': 'en_US:en',
14:26:46 INFO - 'LOGNAME': 'cltbld',
14:26:46 INFO - 'MAIL': '/var/mail/cltbld',
14:26:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1',
14:26:46 INFO - 'MOZ_NO_REMOTE': '1',
14:26:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript',
14:26:46 INFO - 'NO_EM_RESTART': '1',
14:26:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games',
14:26:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json',
14:26:46 INFO - 'PWD': '/builds/slave/test',
14:26:46 INFO - 'SHELL': '/bin/bash',
14:26:46 INFO - 'SHLVL': '1',
14:26:46 INFO - 'TERM': 'linux',
14:26:46 INFO - 'TMOUT': '86400',
14:26:46 INFO - 'USER': 'cltbld',
14:26:46 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1477776389.587184-235884091',
14:26:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn',
14:26:46 INFO - '_': '/tools/buildbot/bin/python'}
14:26:46 INFO - Ignoring indexes: https://pypi.python.org/simple/
14:26:46 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg
14:26:46 INFO - Cleaning up...
14:26:46 INFO - Return code: 0
14:26:46 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv
14:26:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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')]}
14:26:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org
14:26:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub
14:26:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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')]}
14:26:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org
14:26:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub
14:26:46 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.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 0x7f5e83e52f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x143f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x150cca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1509f60>, '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 0x150ad40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x150b1d0>, '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': 'db0483c52d987ecb441a263b000001ad-1477776389.587184-235884091', '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
14:26:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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
14:26:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1
14:26:46 INFO - Using env: {'DISPLAY': ':0',
14:26:46 INFO - 'HOME': '/home/cltbld',
14:26:46 INFO - 'LANG': 'en_US.UTF-8',
14:26:46 INFO - 'LANGUAGE': 'en_US:en',
14:26:46 INFO - 'LOGNAME': 'cltbld',
14:26:46 INFO - 'MAIL': '/var/mail/cltbld',
14:26:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1',
14:26:46 INFO - 'MOZ_NO_REMOTE': '1',
14:26:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript',
14:26:46 INFO - 'NO_EM_RESTART': '1',
14:26:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games',
14:26:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json',
14:26:46 INFO - 'PWD': '/builds/slave/test',
14:26:46 INFO - 'SHELL': '/bin/bash',
14:26:46 INFO - 'SHLVL': '1',
14:26:46 INFO - 'TERM': 'linux',
14:26:46 INFO - 'TMOUT': '86400',
14:26:46 INFO - 'USER': 'cltbld',
14:26:46 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1477776389.587184-235884091',
14:26:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn',
14:26:46 INFO - '_': '/tools/buildbot/bin/python'}
14:26:46 INFO - Ignoring indexes: https://pypi.python.org/simple/
14:26:46 INFO - Downloading/unpacking psutil>=3.1.1
14:26:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available
14:26:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available
14:26:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available
14:26:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available
14:26:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available
14:26:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available
14:26:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil
14:26:48 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build'
14:26:48 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects
...
14:26:48 INFO - Installing collected packages: psutil
14:26:48 INFO - Running setup.py install for psutil
14:26:49 INFO - building 'psutil._psutil_linux' extension
14:26:49 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o
14:26:49 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so
14:26:49 INFO - building 'psutil._psutil_posix' extension
14:26:49 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o
14:26:49 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so
14:26:49 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build'
14:26:49 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ...
14:26:49 INFO - Successfully installed psutil
14:26:49 INFO - Cleaning up...
14:26:49 INFO - Return code: 0
14:26:49 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv
14:26:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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')]}
14:26:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org
14:26:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub
14:26:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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')]}
14:26:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org
14:26:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub
14:26: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.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 0x7f5e83e52f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x143f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x150cca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1509f60>, '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 0x150ad40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x150b1d0>, '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': 'db0483c52d987ecb441a263b000001ad-1477776389.587184-235884091', '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
14:26:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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
14:26:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3
14:26:49 INFO - Using env: {'DISPLAY': ':0',
14:26:49 INFO - 'HOME': '/home/cltbld',
14:26:49 INFO - 'LANG': 'en_US.UTF-8',
14:26:49 INFO - 'LANGUAGE': 'en_US:en',
14:26:49 INFO - 'LOGNAME': 'cltbld',
14:26:49 INFO - 'MAIL': '/var/mail/cltbld',
14:26:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1',
14:26:49 INFO - 'MOZ_NO_REMOTE': '1',
14:26:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript',
14:26:49 INFO - 'NO_EM_RESTART': '1',
14:26:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games',
14:26:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json',
14:26:49 INFO - 'PWD': '/builds/slave/test',
14:26:49 INFO - 'SHELL': '/bin/bash',
14:26:49 INFO - 'SHLVL': '1',
14:26:49 INFO - 'TERM': 'linux',
14:26:49 INFO - 'TMOUT': '86400',
14:26:49 INFO - 'USER': 'cltbld',
14:26:49 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1477776389.587184-235884091',
14:26:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn',
14:26:49 INFO - '_': '/tools/buildbot/bin/python'}
14:26:49 INFO - Ignoring indexes: https://pypi.python.org/simple/
14:26:49 INFO - Downloading/unpacking mozsystemmonitor==0.3
14:26:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available
14:26:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available
14:26:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available
14:26:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available
14:26:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available
14:26:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available
14:26:51 INFO - Downloading mozsystemmonitor-0.3.tar.gz
14:26:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor
14:26:51 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3)
14:26:51 INFO - Installing collected packages: mozsystemmonitor
14:26:51 INFO - Running setup.py install for mozsystemmonitor
14:26:51 INFO - Successfully installed mozsystemmonitor
14:26:51 INFO - Cleaning up...
14:26:51 INFO - Return code: 0
14:26:51 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv
14:26:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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')]}
14:26:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org
14:26:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub
14:26:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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')]}
14:26:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org
14:26:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub
14:26:51 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.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 0x7f5e83e52f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x143f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x150cca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1509f60>, '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 0x150ad40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x150b1d0>, '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': 'db0483c52d987ecb441a263b000001ad-1477776389.587184-235884091', '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
14:26:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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
14:26:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1
14:26:51 INFO - Using env: {'DISPLAY': ':0',
14:26:51 INFO - 'HOME': '/home/cltbld',
14:26:51 INFO - 'LANG': 'en_US.UTF-8',
14:26:51 INFO - 'LANGUAGE': 'en_US:en',
14:26:51 INFO - 'LOGNAME': 'cltbld',
14:26:51 INFO - 'MAIL': '/var/mail/cltbld',
14:26:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1',
14:26:51 INFO - 'MOZ_NO_REMOTE': '1',
14:26:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript',
14:26:51 INFO - 'NO_EM_RESTART': '1',
14:26:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games',
14:26:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json',
14:26:51 INFO - 'PWD': '/builds/slave/test',
14:26:51 INFO - 'SHELL': '/bin/bash',
14:26:51 INFO - 'SHLVL': '1',
14:26:51 INFO - 'TERM': 'linux',
14:26:51 INFO - 'TMOUT': '86400',
14:26:51 INFO - 'USER': 'cltbld',
14:26:51 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1477776389.587184-235884091',
14:26:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn',
14:26:51 INFO - '_': '/tools/buildbot/bin/python'}
14:26:52 INFO - Ignoring indexes: https://pypi.python.org/simple/
14:26:52 INFO - Downloading/unpacking jsonschema==2.5.1
14:26:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available
14:26:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available
14:26:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available
14:26:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available
14:26:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available
14:26:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available
14:26:54 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl
14:26:54 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1)
14:26:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available
14:26:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available
14:26:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available
14:26:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available
14:26:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available
14:26:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available
14:26:54 INFO - Downloading functools32-3.2.3-2.tar.gz
14:26:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32
14:26:54 INFO - warning: no files found matching '*.txt'
14:26:54 INFO - no previously-included directories found matching 'build'
14:26:54 INFO - no previously-included directories found matching 'dist'
14:26:54 INFO - no previously-included directories found matching '.git*'
14:26:54 INFO - Installing collected packages: jsonschema, functools32
14:26:54 INFO - Running setup.py install for functools32
14:26:54 INFO - warning: no files found matching '*.txt'
14:26:54 INFO - no previously-included directories found matching 'build'
14:26:54 INFO - no previously-included directories found matching 'dist'
14:26:54 INFO - no previously-included directories found matching '.git*'
14:26:54 INFO - Successfully installed jsonschema functools32
14:26:54 INFO - Cleaning up...
14:26:54 INFO - Return code: 0
14:26:54 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv
14:26:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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')]}
14:26:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org
14:26:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub
14:26:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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')]}
14:26:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org
14:26:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub
14:26:54 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.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 0x7f5e83e52f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x143f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x150cca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1509f60>, '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 0x150ad40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x150b1d0>, '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': 'db0483c52d987ecb441a263b000001ad-1477776389.587184-235884091', '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
14:26:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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
14:26:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2
14:26:54 INFO - Using env: {'DISPLAY': ':0',
14:26:54 INFO - 'HOME': '/home/cltbld',
14:26:54 INFO - 'LANG': 'en_US.UTF-8',
14:26:54 INFO - 'LANGUAGE': 'en_US:en',
14:26:54 INFO - 'LOGNAME': 'cltbld',
14:26:54 INFO - 'MAIL': '/var/mail/cltbld',
14:26:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1',
14:26:54 INFO - 'MOZ_NO_REMOTE': '1',
14:26:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript',
14:26:54 INFO - 'NO_EM_RESTART': '1',
14:26:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games',
14:26:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json',
14:26:54 INFO - 'PWD': '/builds/slave/test',
14:26:54 INFO - 'SHELL': '/bin/bash',
14:26:54 INFO - 'SHLVL': '1',
14:26:54 INFO - 'TERM': 'linux',
14:26:54 INFO - 'TMOUT': '86400',
14:26:54 INFO - 'USER': 'cltbld',
14:26:54 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1477776389.587184-235884091',
14:26:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn',
14:26:54 INFO - '_': '/tools/buildbot/bin/python'}
14:26:54 INFO - Ignoring indexes: https://pypi.python.org/simple/
14:26:54 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages
14:26:54 INFO - Cleaning up...
14:26:54 INFO - Return code: 0
14:26:54 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv
14:26:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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')]}
14:26:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org
14:26:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub
14:26:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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')]}
14:26:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org
14:26:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub
14:26:54 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.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 0x7f5e83e52f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x143f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x150cca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1509f60>, '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 0x150ad40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x150b1d0>, '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': 'db0483c52d987ecb441a263b000001ad-1477776389.587184-235884091', '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
14:26:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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
14:26:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4
14:26:54 INFO - Using env: {'DISPLAY': ':0',
14:26:54 INFO - 'HOME': '/home/cltbld',
14:26:54 INFO - 'LANG': 'en_US.UTF-8',
14:26:54 INFO - 'LANGUAGE': 'en_US:en',
14:26:54 INFO - 'LOGNAME': 'cltbld',
14:26:54 INFO - 'MAIL': '/var/mail/cltbld',
14:26:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1',
14:26:54 INFO - 'MOZ_NO_REMOTE': '1',
14:26:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript',
14:26:54 INFO - 'NO_EM_RESTART': '1',
14:26:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games',
14:26:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json',
14:26:54 INFO - 'PWD': '/builds/slave/test',
14:26:54 INFO - 'SHELL': '/bin/bash',
14:26:54 INFO - 'SHLVL': '1',
14:26:54 INFO - 'TERM': 'linux',
14:26:54 INFO - 'TMOUT': '86400',
14:26:54 INFO - 'USER': 'cltbld',
14:26:54 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1477776389.587184-235884091',
14:26:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn',
14:26:54 INFO - '_': '/tools/buildbot/bin/python'}
14:26:54 INFO - Ignoring indexes: https://pypi.python.org/simple/
14:26:54 INFO - Downloading/unpacking blobuploader==1.2.4
14:26:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available
14:26:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available
14:26:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available
14:26:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available
14:26:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available
14:26:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available
14:26:56 INFO - Downloading blobuploader-1.2.4.tar.gz
14:26:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader
14:26:56 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4)
14:26:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available
14:26:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available
14:26:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available
14:26:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available
14:26:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available
14:26:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available
14:26:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests
14:26:57 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4)
14:26:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available
14:26:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available
14:26:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available
14:26:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available
14:26:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available
14:26:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available
14:26:57 INFO - Downloading docopt-0.6.1.tar.gz
14:26:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt
14:26:57 INFO - Installing collected packages: blobuploader, requests, docopt
14:26:57 INFO - Running setup.py install for blobuploader
14:26:57 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775
14:26:57 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775
14:26:57 INFO - Running setup.py install for requests
14:26:58 INFO - Running setup.py install for docopt
14:26:58 INFO - Successfully installed blobuploader requests docopt
14:26:58 INFO - Cleaning up...
14:26:58 INFO - Return code: 0
14:26:58 INFO - Installing None into virtualenv /builds/slave/test/build/venv
14:26:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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')]}
14:26:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org
14:26:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub
14:26:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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')]}
14:26:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org
14:26:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub
14:26:58 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.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 0x7f5e83e52f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x143f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x150cca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1509f60>, '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 0x150ad40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x150b1d0>, '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': 'db0483c52d987ecb441a263b000001ad-1477776389.587184-235884091', '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
14:26:58 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.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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
14:26:58 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.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub
14:26:58 INFO - Using env: {'DISPLAY': ':0',
14:26:58 INFO - 'HOME': '/home/cltbld',
14:26:58 INFO - 'LANG': 'en_US.UTF-8',
14:26:58 INFO - 'LANGUAGE': 'en_US:en',
14:26:58 INFO - 'LOGNAME': 'cltbld',
14:26:58 INFO - 'MAIL': '/var/mail/cltbld',
14:26:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1',
14:26:58 INFO - 'MOZ_NO_REMOTE': '1',
14:26:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript',
14:26:58 INFO - 'NO_EM_RESTART': '1',
14:26:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games',
14:26:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json',
14:26:58 INFO - 'PWD': '/builds/slave/test',
14:26:58 INFO - 'SHELL': '/bin/bash',
14:26:58 INFO - 'SHLVL': '1',
14:26:58 INFO - 'TERM': 'linux',
14:26:58 INFO - 'TMOUT': '86400',
14:26:58 INFO - 'USER': 'cltbld',
14:26:58 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1477776389.587184-235884091',
14:26:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn',
14:26:58 INFO - '_': '/tools/buildbot/bin/python'}
14:26:58 INFO - Ignoring indexes: https://pypi.python.org/simple/
14:26:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser
14:26:58 INFO - Running setup.py (path:/tmp/pip-Fw7LA7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser
14:26:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash
14:26:58 INFO - Running setup.py (path:/tmp/pip-h0aZBC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash
14:26:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug
14:26:58 INFO - Running setup.py (path:/tmp/pip-XpoDhn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug
14:26:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice
14:26:58 INFO - Running setup.py (path:/tmp/pip-AQaISu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice
14:26:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile
14:26:58 INFO - Running setup.py (path:/tmp/pip-5Zsr62-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile
14:26:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd
14:26:58 INFO - Running setup.py (path:/tmp/pip-1Pl0z4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd
14:26:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo
14:26:58 INFO - Running setup.py (path:/tmp/pip-zqwOH1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo
14:26:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall
14:26:58 INFO - Running setup.py (path:/tmp/pip-akYdAa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall
14:26:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak
14:26:59 INFO - Running setup.py (path:/tmp/pip-wZ8y9c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak
14:26:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog
14:26:59 INFO - Running setup.py (path:/tmp/pip-KCPbXG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog
14:26:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork
14:26:59 INFO - Running setup.py (path:/tmp/pip-cqYGYR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork
14:26:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess
14:26:59 INFO - Running setup.py (path:/tmp/pip-gFOid_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess
14:26:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile
14:26:59 INFO - Running setup.py (path:/tmp/pip-hguVg2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile
14:26:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner
14:26:59 INFO - Running setup.py (path:/tmp/pip-5iuvkF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner
14:26:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot
14:26:59 INFO - Running setup.py (path:/tmp/pip-_GPoPj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot
14:26:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest
14:26:59 INFO - Running setup.py (path:/tmp/pip-Ikomat-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest
14:26:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion
14:26:59 INFO - Running setup.py (path:/tmp/pip-NNns5J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion
14:26:59 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion
14:26:59 INFO - Running setup.py install for manifestparser
14:26:59 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin
14:26:59 INFO - Running setup.py install for mozcrash
14:26:59 INFO - Running setup.py install for mozdebug
14:27:00 INFO - Running setup.py install for mozdevice
14:27:00 INFO - Installing sutini script to /builds/slave/test/build/venv/bin
14:27:00 INFO - Installing dm script to /builds/slave/test/build/venv/bin
14:27:00 INFO - Running setup.py install for mozfile
14:27:00 INFO - Running setup.py install for mozhttpd
14:27:00 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin
14:27:00 INFO - Running setup.py install for mozinfo
14:27:00 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin
14:27:00 INFO - Running setup.py install for mozInstall
14:27:00 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin
14:27:00 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin
14:27:00 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin
14:27:00 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin
14:27:00 INFO - Running setup.py install for mozleak
14:27:00 INFO - Running setup.py install for mozlog
14:27:00 INFO - Installing structlog script to /builds/slave/test/build/venv/bin
14:27:00 INFO - Running setup.py install for moznetwork
14:27:00 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin
14:27:00 INFO - Running setup.py install for mozprocess
14:27:00 INFO - Running setup.py install for mozprofile
14:27:01 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin
14:27:01 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin
14:27:01 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin
14:27:01 INFO - Running setup.py install for mozrunner
14:27:01 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin
14:27:01 INFO - Running setup.py install for mozscreenshot
14:27:01 INFO - Running setup.py install for moztest
14:27:01 INFO - Running setup.py install for mozversion
14:27:01 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin
14:27:01 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion
14:27:01 INFO - Cleaning up...
14:27:01 INFO - Return code: 0
14:27:01 INFO - Installing None into virtualenv /builds/slave/test/build/venv
14:27:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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')]}
14:27:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org
14:27:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub
14:27:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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')]}
14:27:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org
14:27:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub
14:27:01 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.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 0x7f5e83e52f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x143f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x150cca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1509f60>, '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 0x150ad40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x150b1d0>, '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': 'db0483c52d987ecb441a263b000001ad-1477776389.587184-235884091', '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
14:27:01 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.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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
14:27:01 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.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub
14:27:01 INFO - Using env: {'DISPLAY': ':0',
14:27:01 INFO - 'HOME': '/home/cltbld',
14:27:01 INFO - 'LANG': 'en_US.UTF-8',
14:27:01 INFO - 'LANGUAGE': 'en_US:en',
14:27:01 INFO - 'LOGNAME': 'cltbld',
14:27:01 INFO - 'MAIL': '/var/mail/cltbld',
14:27:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1',
14:27:01 INFO - 'MOZ_NO_REMOTE': '1',
14:27:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript',
14:27:01 INFO - 'NO_EM_RESTART': '1',
14:27:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games',
14:27:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json',
14:27:01 INFO - 'PWD': '/builds/slave/test',
14:27:01 INFO - 'SHELL': '/bin/bash',
14:27:01 INFO - 'SHLVL': '1',
14:27:01 INFO - 'TERM': 'linux',
14:27:01 INFO - 'TMOUT': '86400',
14:27:01 INFO - 'USER': 'cltbld',
14:27:01 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1477776389.587184-235884091',
14:27:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn',
14:27:01 INFO - '_': '/tools/buildbot/bin/python'}
14:27:01 INFO - Ignoring indexes: https://pypi.python.org/simple/
14:27:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser
14:27:01 INFO - Running setup.py (path:/tmp/pip-ZxP5DG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser
14:27:01 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))
14:27:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash
14:27:01 INFO - Running setup.py (path:/tmp/pip-Amhjgl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash
14:27:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 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))
14:27:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug
14:27:01 INFO - Running setup.py (path:/tmp/pip-asTlu5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug
14:27:01 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))
14:27:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice
14:27:01 INFO - Running setup.py (path:/tmp/pip-D9SsrJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice
14:27:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 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))
14:27:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile
14:27:02 INFO - Running setup.py (path:/tmp/pip-z8XXB_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile
14:27:02 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))
14:27:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd
14:27:02 INFO - Running setup.py (path:/tmp/pip-WtfmZB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd
14:27:02 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))
14:27:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo
14:27:02 INFO - Running setup.py (path:/tmp/pip-WsIKSk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo
14:27:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 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))
14:27:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall
14:27:02 INFO - Running setup.py (path:/tmp/pip-ut9Fir-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall
14:27:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 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))
14:27:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak
14:27:02 INFO - Running setup.py (path:/tmp/pip-WugFwN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak
14:27:02 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))
14:27:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog
14:27:02 INFO - Running setup.py (path:/tmp/pip-fVGoCi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog
14:27:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 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))
14:27:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork
14:27:02 INFO - Running setup.py (path:/tmp/pip-z2siFz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork
14:27:02 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))
14:27:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess
14:27:02 INFO - Running setup.py (path:/tmp/pip-bJOEMZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess
14:27:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 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))
14:27:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile
14:27:02 INFO - Running setup.py (path:/tmp/pip-liYRPz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile
14:27:02 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))
14:27:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner
14:27:02 INFO - Running setup.py (path:/tmp/pip-quQQC9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner
14:27:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 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))
14:27:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot
14:27:02 INFO - Running setup.py (path:/tmp/pip-aR7WJf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot
14:27:02 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))
14:27:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest
14:27:02 INFO - Running setup.py (path:/tmp/pip-i21dpH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest
14:27:02 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 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))
14:27:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion
14:27:02 INFO - Running setup.py (path:/tmp/pip-C64DFg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion
14:27:02 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))
14:27:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2))
14:27:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2))
14:27:02 INFO - Requirement already satisfied (use --upgrade to upgrade): 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))
14:27:02 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4))
14:27:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4))
14:27:02 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10))
14:27:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available
14:27:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available
14:27:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available
14:27:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available
14:27:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available
14:27:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available
14:27:04 INFO - Downloading blessings-1.6.tar.gz
14:27:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings
14:27:04 INFO - Installing collected packages: blessings
14:27:04 INFO - Running setup.py install for blessings
14:27:05 INFO - Successfully installed blessings
14:27:05 INFO - Cleaning up...
14:27:05 INFO - Return code: 0
14:27:05 INFO - Done creating virtualenv /builds/slave/test/build/venv.
14:27:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze']
14:27:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze
14:27:05 INFO - Reading from file tmpfile_stdout
14:27:05 INFO - Current package versions:
14:27:05 INFO - argparse == 1.2.1
14:27:05 INFO - blessings == 1.6
14:27:05 INFO - blobuploader == 1.2.4
14:27:05 INFO - docopt == 0.6.1
14:27:05 INFO - functools32 == 3.2.3-2
14:27:05 INFO - jsonschema == 2.5.1
14:27:05 INFO - manifestparser == 1.1
14:27:05 INFO - mozInstall == 1.12
14:27:05 INFO - mozcrash == 0.17
14:27:05 INFO - mozdebug == 0.1
14:27:05 INFO - mozdevice == 0.48
14:27:05 INFO - mozfile == 1.2
14:27:05 INFO - mozhttpd == 0.7
14:27:05 INFO - mozinfo == 0.9
14:27:05 INFO - mozleak == 0.1
14:27:05 INFO - mozlog == 3.4
14:27:05 INFO - moznetwork == 0.27
14:27:05 INFO - mozprocess == 0.23
14:27:05 INFO - mozprofile == 0.28
14:27:05 INFO - mozrunner == 6.12
14:27:05 INFO - mozscreenshot == 0.1
14:27:05 INFO - mozsystemmonitor == 0.3
14:27:05 INFO - moztest == 0.7
14:27:05 INFO - mozversion == 1.4
14:27:05 INFO - psutil == 3.1.1
14:27:05 INFO - requests == 1.2.3
14:27:05 INFO - wsgiref == 0.1.2
14:27:05 INFO - Installing None into virtualenv /builds/slave/test/build/venv
14:27:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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')]}
14:27:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org
14:27:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub
14:27:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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')]}
14:27:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org
14:27:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub
14:27:05 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.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 0x7f5e83e52f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x143f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x150cca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1509f60>, '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 0x150ad40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x150b1d0>, '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': 'db0483c52d987ecb441a263b000001ad-1477776389.587184-235884091', '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
14:27:05 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.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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
14:27:05 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.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub
14:27:05 INFO - Using env: {'DISPLAY': ':0',
14:27:05 INFO - 'HOME': '/home/cltbld',
14:27:05 INFO - 'LANG': 'en_US.UTF-8',
14:27:05 INFO - 'LANGUAGE': 'en_US:en',
14:27:05 INFO - 'LOGNAME': 'cltbld',
14:27:05 INFO - 'MAIL': '/var/mail/cltbld',
14:27:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1',
14:27:05 INFO - 'MOZ_NO_REMOTE': '1',
14:27:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript',
14:27:05 INFO - 'NO_EM_RESTART': '1',
14:27:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games',
14:27:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json',
14:27:05 INFO - 'PWD': '/builds/slave/test',
14:27:05 INFO - 'SHELL': '/bin/bash',
14:27:05 INFO - 'SHLVL': '1',
14:27:05 INFO - 'TERM': 'linux',
14:27:05 INFO - 'TMOUT': '86400',
14:27:05 INFO - 'USER': 'cltbld',
14:27:05 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1477776389.587184-235884091',
14:27:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn',
14:27:05 INFO - '_': '/tools/buildbot/bin/python'}
14:27:05 INFO - Ignoring indexes: https://pypi.python.org/simple/
14:27:05 INFO - Requirement already satisfied (use --upgrade to upgrade): 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))
14:27:05 INFO - Requirement already satisfied (use --upgrade to upgrade): 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))
14:27:05 INFO - Requirement already satisfied (use --upgrade to upgrade): 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))
14:27:05 INFO - Requirement already satisfied (use --upgrade to upgrade): 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))
14:27:05 INFO - Requirement already satisfied (use --upgrade to upgrade): 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))
14:27:05 INFO - Requirement already satisfied (use --upgrade to upgrade): 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))
14:27:05 INFO - Requirement already satisfied (use --upgrade to upgrade): 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))
14:27:05 INFO - Requirement already satisfied (use --upgrade to upgrade): 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))
14:27:05 INFO - Requirement already satisfied (use --upgrade to upgrade): 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))
14:27:05 INFO - Requirement already satisfied (use --upgrade to upgrade): 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))
14:27:05 INFO - Requirement already satisfied (use --upgrade to upgrade): 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))
14:27:05 INFO - Cleaning up...
14:27:05 INFO - Return code: 0
14:27:05 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv
14:27:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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')]}
14:27:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org
14:27:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub
14:27:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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')]}
14:27:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org
14:27:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub
14:27:05 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.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 0x7f5e83e52f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x143f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x150cca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1509f60>, '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 0x150ad40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x150b1d0>, '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': 'db0483c52d987ecb441a263b000001ad-1477776389.587184-235884091', '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
14:27:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build
14:27:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema
14:27:05 INFO - Using env: {'DISPLAY': ':0',
14:27:05 INFO - 'HOME': '/home/cltbld',
14:27:05 INFO - 'LANG': 'en_US.UTF-8',
14:27:05 INFO - 'LANGUAGE': 'en_US:en',
14:27:05 INFO - 'LOGNAME': 'cltbld',
14:27:05 INFO - 'MAIL': '/var/mail/cltbld',
14:27:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1',
14:27:05 INFO - 'MOZ_NO_REMOTE': '1',
14:27:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript',
14:27:05 INFO - 'NO_EM_RESTART': '1',
14:27:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games',
14:27:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json',
14:27:05 INFO - 'PWD': '/builds/slave/test',
14:27:05 INFO - 'SHELL': '/bin/bash',
14:27:05 INFO - 'SHLVL': '1',
14:27:05 INFO - 'TERM': 'linux',
14:27:05 INFO - 'TMOUT': '86400',
14:27:05 INFO - 'USER': 'cltbld',
14:27:05 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1477776389.587184-235884091',
14:27:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn',
14:27:05 INFO - '_': '/tools/buildbot/bin/python'}
14:27:05 INFO - Ignoring indexes: https://pypi.python.org/simple/
14:27:05 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages
14:27:05 INFO - Cleaning up...
14:27:05 INFO - Return code: 0
14:27:05 INFO - Running post-action listener: _resource_record_post_action
14:27:05 INFO - Running post-action listener: _start_resource_monitoring
14:27:05 INFO - Starting resource monitoring.
14:27:05 INFO - [mozharness: 2016-10-29 21:27:05.870133Z] Finished create-virtualenv step (success)
14:27:05 INFO - [mozharness: 2016-10-29 21:27:05.870631Z] Running install step.
14:27:05 INFO - Running pre-action listener: _resource_record_pre_action
14:27:05 INFO - Running main action method: install
14:27:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze']
14:27:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze
14:27:06 INFO - Reading from file tmpfile_stdout
14:27:06 INFO - Detecting whether we're running mozinstall >=1.0...
14:27:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h']
14:27:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h
14:27:06 INFO - Reading from file tmpfile_stdout
14:27:06 INFO - Output received:
14:27:06 INFO - Usage: mozinstall [options] installer
14:27:06 INFO - Options:
14:27:06 INFO - -h, --help show this help message and exit
14:27:06 INFO - -d DEST, --destination=DEST
14:27:06 INFO - Directory to install application into. [default:
14:27:06 INFO - "/builds/slave/test"]
14:27:06 INFO - --app=APP Application being installed. [default: firefox]
14:27:06 INFO - mkdir: /builds/slave/test/build/application
14:27:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application']
14:27:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application
14:27:23 INFO - Reading from file tmpfile_stdout
14:27:23 INFO - Output received:
14:27:23 INFO - /builds/slave/test/build/application/firefox/firefox
14:27:23 INFO - Running post-action listener: _resource_record_post_action
14:27:23 INFO - [mozharness: 2016-10-29 21:27:23.120163Z] Finished install step (success)
14:27:23 INFO - [mozharness: 2016-10-29 21:27:23.120435Z] Running run-tests step.
14:27:23 INFO - Running pre-action listener: _resource_record_pre_action
14:27:23 INFO - Running main action method: run_tests
14:27:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version']
14:27:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version
14:27:23 INFO - Python 2.7.3
14:27:23 INFO - Return code: 0
14:27:23 INFO - grabbing minidump binary from tooltool
14:27:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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')]}
14:27:23 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--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 0x1509f60>, '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 0x150ad40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x150b1d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1
14:27:23 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--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
14:27:23 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache
14:27:23 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--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
14:27:23 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache
14:27:23 INFO - Return code: 0
14:27:23 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755
14:27:23 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir
14:27:23 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir
14:27:23 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk
14:27:23 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir
14:27:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1477704608/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-031', '--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
14:27:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Inbound --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1477704608/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-031 --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
14:27:23 INFO - Using env: {'DISPLAY': ':0',
14:27:23 INFO - 'HOME': '/home/cltbld',
14:27:23 INFO - 'LANG': 'en_US.UTF-8',
14:27:23 INFO - 'LANGUAGE': 'en_US:en',
14:27:23 INFO - 'LOGNAME': 'cltbld',
14:27:23 INFO - 'MAIL': '/var/mail/cltbld',
14:27:23 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir',
14:27:23 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk',
14:27:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1',
14:27:23 INFO - 'MOZ_NO_REMOTE': '1',
14:27:23 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir',
14:27:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript',
14:27:23 INFO - 'NO_EM_RESTART': '1',
14:27:23 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games',
14:27:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json',
14:27:23 INFO - 'PWD': '/builds/slave/test',
14:27:23 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos',
14:27:23 INFO - 'SHELL': '/bin/bash',
14:27:23 INFO - 'SHLVL': '1',
14:27:23 INFO - 'TERM': 'linux',
14:27:23 INFO - 'TMOUT': '86400',
14:27:23 INFO - 'USER': 'cltbld',
14:27:23 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1477776389.587184-235884091',
14:27:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn',
14:27:23 INFO - '_': '/tools/buildbot/bin/python'}
14:27:23 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1477704608/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-031', '--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
14:27:23 INFO - mozversion application_buildid: 20161028183008
14:27:23 INFO - mozversion application_changeset: ee15183d057288ccd8b6b22b13b85c540229f736
14:27:23 INFO - mozversion application_display_name: Nightly
14:27:23 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384}
14:27:23 INFO - mozversion application_name: Firefox
14:27:23 INFO - mozversion application_remotingname: firefox
14:27:23 INFO - mozversion application_repository: https://hg.mozilla.org/integration/mozilla-inbound
14:27:23 INFO - mozversion application_vendor: Mozilla
14:27:23 INFO - mozversion application_version: 52.0a1
14:27:23 INFO - mozversion platform_buildid: 20161028183008
14:27:23 INFO - mozversion platform_changeset: ee15183d057288ccd8b6b22b13b85c540229f736
14:27:23 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/mozilla-inbound
14:27:23 INFO - mozversion platform_version: 52.0a1
14:27:23 INFO - using testdate: 1477776443
14:27:23 INFO - actual date: 1477776443
14:27:23 INFO - starting webserver on 'localhost:49411'
14:27:23 INFO - SUITE-START | Running 2 tests
14:27:23 INFO - TEST-START | dromaeo_css
14:27:23 INFO - operating with platform_type : linux_
14:27:23 INFO - Initialising browser for dromaeo_css test...
14:27:23 INFO - TEST-INFO | started process 22377 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpFZCpEf/profile http://localhost:49411/getInfo.html)
14:27:28 INFO - PROCESS | 22377 | __metrics Screen width/height:1600/1200
14:27:28 INFO - PROCESS | 22377 | colorDepth:24
14:27:28 INFO - PROCESS | 22377 | Browser inner width/height: 1024/697
14:27:28 INFO - PROCESS | 22377 | __metrics
14:27:28 ERROR - PROCESS | 22377 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3131: TypeError: this.tabs is undefined
14:27:29 INFO - TEST-INFO | 22377: exit 0
14:27:29 INFO - Browser initialized.
14:27:29 INFO - Running cycle 1/1 for dromaeo_css test...
14:27:29 INFO - TEST-INFO | started process 22498 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpFZCpEf/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1)
14:27:41 INFO - PROCESS | 22498 | RSS: Main: 185970688
14:27:41 INFO - PROCESS | 22498 |
14:28:31 INFO - PROCESS | 22498 | 1477776511555 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no]
14:30:42 INFO - PROCESS | 22498 | Cycle 1(1): loaded http://localhost:49411/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49411/tests/dromaeo/cssquery-ext.html)
14:30:44 INFO - PROCESS | 22498 | RSS: Main: 198545408
14:30:44 INFO - PROCESS | 22498 |
14:33:46 INFO - PROCESS | 22498 | Cycle 1(1): loaded http://localhost:49411/tests/dromaeo/cssquery-ext.html (next: http://localhost:49411/tests/dromaeo/cssquery-jquery.html)
14:33:46 INFO - PROCESS | 22498 | RSS: Main: 196653056
14:33:46 INFO - PROCESS | 22498 |
14:36:48 INFO - PROCESS | 22498 | Cycle 1(1): loaded http://localhost:49411/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49411/tests/dromaeo/cssquery-mootools.html)
14:36:49 INFO - PROCESS | 22498 | RSS: Main: 199098368
14:36:49 INFO - PROCESS | 22498 |
14:39:51 INFO - PROCESS | 22498 | Cycle 1(1): loaded http://localhost:49411/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49411/tests/dromaeo/cssquery-prototype.html)
14:39:51 INFO - PROCESS | 22498 | RSS: Main: 195768320
14:39:51 INFO - PROCESS | 22498 |
14:42:54 INFO - PROCESS | 22498 | Cycle 1(1): loaded http://localhost:49411/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49411/tests/dromaeo/cssquery-yui.html)
14:42:55 INFO - PROCESS | 22498 | RSS: Main: 199282688
14:42:55 INFO - PROCESS | 22498 |
14:45:58 INFO - PROCESS | 22498 | Cycle 1(1): loaded http://localhost:49411/tests/dromaeo/cssquery-yui.html (next: http://localhost:49411/tests/dromaeo/cssquery-dojo.html)
14:45:58 INFO - PROCESS | 22498 | RSS: Main: 198291456
14:45:58 INFO - PROCESS | 22498 |
14:45:58 INFO - PROCESS | 22498 | __start_tp_report
14:45:58 INFO - PROCESS | 22498 | _x_x_mozilla_page_load
14:45:58 INFO - PROCESS | 22498 | _x_x_mozilla_page_load_details
14:45:58 INFO - PROCESS | 22498 | |i|pagename|runs|
14:45:58 INFO - PROCESS | 22498 | |0;dojo.html;3077.907662770117;3093.164845491716;3100.1009707184903;3106.130283520615;3132.2795756975893;5371.731413429333;5423.593230507713;5438.782448702057;5470.8085217017315;5561.443855614437;5371.838844834661;5472.069748142815;5493.176023596463;5504.311961004874;5514.283143191379;4934.777934992934;4983.676061056038;5031.169856973595;5046.621503387242;5046.646734728571;4919.557239848413;4957.305977163182;4983;5021.071101846152;5028.522290382408;4961.553460188582;4982.501749825006;5006.674566153189;5069.467705890884;5082.085224659579;4990.550850423461;5013.473585273567;5020.196768517038;5022.221555658843;5074.3657042869645;560.2818043569283;4871.805127794884;4893.09477746618;4925.852224433237;4964.826231081931;5313.043652142613;5405.567554595623;5406.107992181285;5410.5401040911565;5424.267723857268;5830.591858569902;5832.854178645568;5833.183354330397;5833.329167145747;5843.29880414353;5660.2075709400715;5733.3406658234;5834.883302333929;5866.061430171195;5885.79399721012;5485.945140548623;5496.367917689517;5525.944740552583;5557.888842223173;5558.888822223533;6034.818955431344;6039.577229593886;6045.486133678599;6048.123022161762;6052.878942421127;5596.888062238732;5649.717514124277;5788.18965344852;5797.623154494944;5804.912926306109;5851.824445266649;5865.472107510344;5875.823725288248;5882.55880808941;5958.897603943285;5812.418758124239;5813.157092221604;5860.384659610765;5863.179154918314;5871.178035075093;5565.944340556543;5835.2122463466885;5842.123681447817;5886.676232807236;5902.2622172228475;4302.311630139226;4436.068425630589;4451.888702782457;4468.21806183923;4511.548845115528;3952.565217826037;3953.9802300988313;3955.841766329372;4002.399640053957;4010.057636455431;5363.061464243741;5424.349078110573;5563.443655634485;5596.356419011784;5603.047481928001;5784.82645520635;5807.767689292381;5834.416558344132;5847.795327163529;5864.03243464832;5550.361708403585;5559.360673522597;5560.165975103686;5571.164325351229;5636.549076073904;4945.307656928033;4950.158473059589;4950.801967921243;4964.379452568429;4999.400071991312;5802.071668533014;5824.330202026821;6022.247219097613;6046.153538504613;6060.515158787374;5876.118582212703;5898.528117750484;5946.108083787466;5960.165576819162;5963.3142188647125;6018.879622407615;6048.153258543719;6062.636241825505;6065;6075.574709770273;5587.469190426903;5620.85947851307;5739.081746920473;5805.709714514173;5809.099589563624;5867.295924489089;5922.170896074467;5924.289085309618;5948.791792287249;6021.42796434338;5690.402507736793;5745.712714364181;5749;5751.942480575308;5768.134779783066;5460.6996615186545;5746.569007324384;5749.885002300014;5788.392218816964;5798.391168927202;5492.231087647812;5643.435656434323;5649.971750141223;5654.575906806924;5729.914051289151;5757.0788673811985;5793.797217097382;5811.360750317546;5813.186153938367;5822.970885145547;5638.126090455986;5688.658680479184;5688.829335119953;5690.8577285566535;5695.373508913934
14:45:58 INFO - PROCESS | 22498 | |1;ext.html;552.5431214269943;588.7988503452955;594.7829042399522;614.1310046284508;622.2160078301339;42314.32556325953;43625.34561981573;43681.56318436815;47031;47031;44497.55502444974;45564;45630.54369456304;45683.314750278776;45845;8805.119488051192;9035.322350823682;9042.638294468214;9111.772205694844;9120.270378369747;8895.599698013604;8988.955055224747;8997.100289971017;9011.459312441242;9031.503267320295;8993.460392376479;9044.547772611377;9048.773780655503;9059.456432614064;9059.776930114449;8872.556372181365;8994.145556172152;8996.415233009833;9019.729408117733;9026.684066057722;8859.424137431046;8918.241949434307;8987.415817971876;9022.18800307969;9028.683996060106;42927.57072429267;43240.56759432428;43314.783426082984;43320.783396083134;43506.564934350565;3307.5534802801794;3488.2325888304786;3840.9353924737597;3885.6891448684037;4102.528209255914;32265;32377.51433728496;32399.676003239903;32413.35173296521;33363.499547506806;4340.848070317524;4413.867583972486;4518.254488009475;4546.499885012646;4649.907001859944;324964;332041;334873;335315;335862;60062.399376005684;60174.09738853921;60329.09506357408;60498.092528612106;60546;62729.68635156795;62978;63112.36887631065;63267;63296.367036329044;14286.428542858377;14403.279836008158;14462.927685361507;14611.269436528131;14625.0493717908;11674.70813229676;11707.88292117068;11798.115141364431;11855.940720296343;11864.644060678194;18203.095544707096;18261.54346141357;18328.358507452176;18360.449186524427;18672.439826805217;6064.0073105804195;6149.600275982047;6254.153695477249;6304.432601065926;6337.704393715242;971.2278738402987;1052.4369462337766;1111.2276967507505;1134.5631931706353;1184.9644510664693;32030.359392812014;32160.191141701536;32429;32461.675383245863;32865.67134328626;1069.0325255643654;1069.983950240747;1077.4774234496263;1087.543231842628;1131.5643477261149;16568.6686266274;17029.659406811796;17138;17149.314027439013;17360.565985850455;530219;534727;536353;536843;540621;59036;59897;59924.40075599188;60006.69996649989;60150;1254.4856608790353;1286.1254347043912;1297.9805302920463;1298.2859427314938;1305.4843336882068;30462.695373045986;31248.687513124576;31984.68015319817;32153.517697234092;32654.34691306113;52897.471025289255;53282;53375;53405.46594534005;53681;449974;452074;452372;453050;454153;42033.78983105065;42530;42728.78635606802;42915.785421073946;43807.34288985604;47476.7626161867;48740;48793.512064878894;49094.26358604695;50377;40776.79611601923;41565.79217103895;41764;41805;42734.786326069414;40623.59376406316;40912;41059.58940410677;41904;41919.371209432495;41013.1797364057;41542.376864347665;41542.58457415387;42526.574734253496;42826.78586607047;35430.29139417146;36582;36803.44794828026;37200.44199337066;37656.24687506289;27861.721382785912;28408.57387139153;28567;28717.856410717814;28749.425011499236
14:45:58 INFO - PROCESS | 22498 | |2;jquery.html;378.1114381204169;379.1866446472317;381.51166506871203;406.1389853510558;412.37936904958036;18072.99999999998;19738.90130549345;20024.0989155488;20244.898775506103;20363.389098327054;19157.329493467732;19544.31594894179;19652.41042768719;19718.507037324074;19779;5415.10650742627;5627.7467513961765;5720.8283751487525;5830.096335068071;5879.294484661847;5779.682117483537;5787.074068149097;5827.35899051104;5850.385709500505;5856.882862342772;5561.860953476155;5707.686077265748;5718.399568045358;5731.4555117264;5816.534677225833;5695.7152142392715;5746.511546518551;5747.339056008571;5752.194692742998;5756.050251708463;5089.720065396402;5362.410134885159;5393.1370980642905;5436.836894893159;5443.319585051869;22055.889720551295;22343;22624.660630090562;22743.88628056849;22928.54142917149;2097.192580856366;2263.739669937962;2325.5697695926306;2425.5755242832433;2788.1217416513937;9775.51122443882;9831.115199631997;9945.651902183388;10094.343867648653;13836.446542138303;1798.694221982253;1939.0886283446757;1977.0905383523595;1981.28673677476;1991.5817678287576;84618.57690711568;86227;86854;87881;87910.56044719735;10482.161427085815;10837.295575787548;10887.564497420173;11143.888561114447;11233.213675042669;15450.150241736588;15488.767668484981;15494.612634684223;15502.689946201013;15533.533993980198;7422.257774222535;7523.210062943422;7719.382449404146;7720.922790772132;7791.766247012599;6880.346367095118;6984;7129.60787156701;7174.533655312388;7222.891656625155;4513.413256276663;4615.330777037311;4683.531646835358;4762.476127625959;4810.302506136591;1928.3829174663972;1947;1988.2444671024919;1990.741203643517;2023.666095094293;872.7120050383359;947.3084648206848;1000.4897502273893;1000.7998400319965;1058.9629362972414;19840.801591984186;19950.800491994894;20154.395368138685;20206.797932020785;20273.79726202719;950.8288508068475;999.4253304350028;1007;1021.4586269277295;1038.9896101039044;10564.841527377095;11210.439478026066;11260.26808257477;11276.492557834918;11310.264832785842;448861;459688;468510;470021;471206;91520;92217.53891230501;92275;92902;94037.5298123505;1020.4183615339185;1057.1067448006422;1077.7251800790748;1093.2565855218527;1098.505672447386;16838.326466941184;17099.658006839545;17272.74090888663;17956.281748730427;18188.81695703273;42332.36501452419;42510.26111475035;43186.35220471758;43324.783376082916;43831.561684382745;57587.4241257582;58990.70504647449;59514;60265;60764;7173.529426467666;7517.736879209201;8029.357651387758;8117.147699491468;8478.406511544134;11809.291442513477;12700.428480718205;12765.234085954873;12881;13208.933955330162;11384.14618903569;11494.367809770209;11597.18819682614;11652.94173529127;12006.459709312927;10687.30532515384;10945.616903408343;11038.724031899266;11245.943770281423;11633.709157271136;11467.369294688871;11577.247478913843;11654.94172529166;11664.475098620753;11687.08577022412;7596;7667.731629393167;7684.364383739443;7773.3004029637605;7908.802279943047;8568.843206167337;11409;11484.483198256266;11520;11600.709982250512
14:45:58 INFO - PROCESS | 22498 | |3;mootools.html;1483.8590333918278;1520.3842443810256;1669.2404955745137;1743.093591332508;1780.1811166863233;7969.481983671058;8182.140875208107;8428.494290342584;8461.280791132745;8497.447665901713;8461.153884611536;8610.655573777058;8623.396362254645;8623.439476434043;8633.48199108054;2253.7746225377414;2261.51377453847;2269.1150451323997;2273.54529094181;2275.4083938176027;2285.8514196577253;2319.2926157521947;2333.4166458385403;2350.976490235093;2361.090979972714;2233.4974630708043;2236.351458077164;2282.2696737044153;2282.9200977965775;2286.6455699366543;2236.563870045342;2242.7532971373134;2244.2706120510898;2256.4810093678384;2259.7062381890332;2279.361778701966;2298.310506847939;2315.8378913476063;2323.6863023491783;2326.278853555403;8444.071152173256;8486.575671216415;8542.786430339229;8586.22723954847;8603.956980215122;4978.7012779233;5074.517920797518;5098;5099.107656160157;5101.872453188663;3131.984340078285;3235.369103024911;3393.151712071982;3421.7775844570274;3429.9314013719586;1208.4199584199546;1231.2673958994385;1886.6509695706338;2013.7684166320914;2094.2565389286738;10949.288296260796;10951.178661600332;10995.560177592966;11111.00000999914;11123;4178.582141785858;4219.746815191037;4341.218580655513;4352.042550638855;4426.468823741172;9172.082791720908;9221.40060896053;9222.878737890323;9233.261339092856;9251.121143491358;5077.162268225701;5149.76826042829;5156.149235376196;5159.793608255703;5169.7932082717025;4586.243269860503;4738.5261473853025;4758.095961767253;4807.591354734886;4822.324874517571;3535.416656251741;3582.265635544707;3586.8744593939086;3590.515280437108;3659.182429529301;1160.6169963912057;1167.6672148437824;1168.3690806964314;1174.3423682737694;1174.8590169179754;889.3818795936891;959.8656188133667;977.6187286958092;1004.231762701534;1004.2668851738272;5742.224799652077;5842.415758424124;5875.823725288248;5887.676177810176;5935.762569497172;421.0736379964091;425.9936100958488;440.05827529087776;453.58270391240137;455.14887161008465;3952.6245006724316;4074.7351422157467;4093.16090201508;4137.234611596864;4145.440365550672;9906.20750339971;10213.285070045175;10218.437985910847;10271.126954208827;10372.636957706443;10011.49942502872;10136.746581335377;10189.643362482277;10241.334313269763;10256.12822910061;7485.663145158481;7676.11724651661;7806.3364614007305;7807.375409967189;7863.174366691529;5563.165525171256;5684.175794509855;5730.9713451434145;5780.7398667060925;6006.849828754316;9156.862647060432;9166.908330916605;9191.816163676824;9262.305327100628;9392.95303523478;9432.43405395651;9459.10138536838;9513.619455221713;9561.043895610383;9698.660546880825;7240.05879235696;7501.849963000818;7624;7800.297973182214;7850.921490785019;7741.419393545394;8046.637901294339;8116.350691944512;8127.6748930044505;8145.674173033012;6756.087928129639;6790.879504881639;7225.518182946506;7234.457415693949;7620.161782204064;7073.82315442118;7194.748183813542;7250.492465527363;7304.890426643711;7381.594012329373;6743.966280168764;6847.1783385994;6882.8623427530165;6894.448444124559;6899.379055884994;4999.975000124976;5098.821541246039;5194.105229537737;5261.184516399964;5298.125809241432;4930.10191076431;4997.750112494434;5021.5229553192385;5197.636165468381;5244.5279924806955
14:45:58 INFO - PROCESS | 22498 | |4;prototype.html;302.85311623862424;315.07211262830964;315.8562853901475;318.85970173123826;321.7249251889633;5316.6544174628625;5513.889722205554;5542.009752977855;5592.021396255659;5605.215269862218;5339.264738959834;5374.140137577989;5476.069068258395;5486.478784515474;5488.53347465466;4209;4249.277622804131;4284.121755040209;4296.140771845628;4297.634701050414;4185.539590645027;4280.3793449949735;4288.270993931023;4303.376010478479;4311.63351115154;4264.275073237542;4269.274223382017;4270.957290427103;4272.3124365875465;4277.52425413232;4254.680898932593;4271.252530807112;4272.867690062105;4309.439772829513;4325.718828276184;3665.248624032067;3835.827387767557;3842;3843.615638436134;3845.5385353757447;5338.813141540067;5358.169483730028;5366.872956679102;5368.70472124033;5388.946110538884;4904.253617973946;4931.914978704679;4944.678595891256;4956.801727930879;4961.7022978621035;5549.833504994856;5759.5968282220265;5772.538196944234;5784.913226301609;5787.247657804501;4150.381351273006;4159.667226621863;4167.874963751093;4168.812403441852;4184.686148538872;5969.641821490681;6015.30823955242;6021.2473440819895;6026.397360263983;6064.361383170107;4009;4177.4778152730905;4288.699791014599;4306.461692288464;4311.827526898889;4239.97880010598;4240.809163587646;4243.702940794176;4250.766207858535;4252.234597772431;4837.371141751621;4868.367112275452;4872.902541949141;4880.853574392703;4914.483979182134;5645.830625081254;5815.244018277597;5819.709014549256;5826.41735826414;5829.387914269026;1487.256371814093;1499.415228061057;1517.7799219113167;1520.787089807428;1521.2849960518538;930.6091441594547;953.823542644613;956.0439560439561;972.5963725054023;985.0100648847862;4797.472278049412;4823.97393094901;4846.273059041101;4906.975465122651;4966.870871351026;5180.274761533388;5202.71385073817;5212.98346822366;5228.816991405282;5253.816116435906;4707.575598566741;4848.8302909398;4859.684120532154;4881.242752609129;4888.411266338454;2704.350955770601;2795.7279437855727;2801.3836955869674;2801.5571980430095;2818.5208514552573;5217.834343999413;5371.549681586028;5373.167159090347;5390.218418329398;5421.783128674809;4979.253112033151;5248.667096393818;5263.499967503081;5267.446918073547;5328.733563321896;5334.839954801362;5355.768173320158;5367.355917289872;5371.838844834661;5379.462053794589;5138.486151384981;5191.572317612687;5198.532132108128;5216.452272511484;5231.843044708665;5134.818991632021;5496.450354964471;5903.26209223847;5927.4665280125;5952.315483719428;6194.473469754941;6209.223847019122;6249.78125765596;6262.405071518198;6265.937340626535;3948.8025598719373;4264.6375058119165;4292.248856450171;4307.719998200232;4310.849120280775;5693.747375577366;5853.590248682722;5870.765169393177;5894.6757928314355;5971.3132989705;5687.715614219355;5821.854453638693;5835.649861008353;5839.854003649943;5840.474357307863;5824.534037276923;5851.736671849691;5857.47282744555;5864.501517370901;5904.911426328695;5633.211769995635;5745.856353591026;5762.596618236683;5770.307563092456;5777.653340799566;5856.853578660568;5866;5870.618409803349;5871.178035075179;5875.177475153397;5486.945130548803;5734.741936612779;5741.598088133791;5742.569307301886;5762.366139724543
14:45:58 INFO - PROCESS | 22498 | |5;yui.html;744.7951813251356;769.3306823063932;780.6760194519278;808.1796976069294;859.2009431228954;13109.868901310983;13817.723645527096;13864.098833575823;13930.721385572282;13966.371513281902;12466.501339946391;12525.185862918905;12527.812082818742;12538.811917821216;12543.247405155675;793.218679600593;801.9719309824143;828.8010877389413;836.0343802907652;838.0571856661256;825.6532256452274;826.409117481001;829.6059371798408;831.580052073702;833.2251006563893;859.3855393393723;867.1068799136867;872.9301655867515;879.5294517433175;880.3837313880277;859.6260626627437;867.2195024477958;868.1752335281476;873.5413907698477;874.7288340614366;629.4492319220682;632.1529150937765;632.2034236861541;634.390984654732;634.9936500634981;14175.503857364944;14188.929055354658;14243.145411275356;14271.143731376047;14283.714325713532;13783.51757688486;14603.269836508132;14830.629234269121;14857.257137143208;14920.7317378023;11296.049601592675;11360.48877800501;11450.885491145065;11532.711682207928;11646.592369267035;3826.3112639724836;3874.767513949144;3875.7907992444316;4024.9195016099807;4036.495438070241;62659.6867015662;64113;64871;65575.99999999952;65610;10513.9474302628;10557.260991730505;10653.84019239712;10788.622398216025;10897.83653245202;21266.893665531574;21315.056714507864;21498.247561335593;21528.56942861134;21579.13683452644;8264.628091735887;8285.751427457186;8302.54336011525;8343.332533397313;8492.872606910902;4424.601785839225;4541.568550987651;4552.704074235164;4554.95445045552;4575.656825738083;3383.3064221834466;3457.550518432638;3470.16715988161;3470.236547959445;3477.94783078254;589.9823005309847;601.2184160591302;618.0543768034913;622.8131560531822;628.9654069026247;576.6684156609966;686.3342557719004;701.2846896165883;708.6633848921824;711.8754218011827;9050.86423703645;9189.908100918905;9278.67524636648;9605.279604029725;9692.41845489273;563.0906086669999;576.3631187537794;641.2529403245167;647.3397134922353;685.8491131950963;4466.479074545515;4613.561711637389;4649.930251046237;4649.953500464952;4751.121042607128;70675.29324706687;70790.2920970794;74173.629131854;78933;91530;70016.29983700199;71885;71967;72815.63592182005;72858;67188;67342.66328668325;67854.66072669605;68560.3143968564;70785.2921470789;9142.177204051668;9437.150656440679;9546.331756776959;9581.281403894596;9799.167070798776;42553.7233882984;43235.567644324416;43673;43975.340369893835;44534.10931781411;53919.73040134774;59081.11378329243;59614.70192649009;60433.39566604278;62733.37266627275;12039.4582243801;12225.510979560719;12273.386330683252;12372.566960156351;12692.301923393932;13700.24648644334;13876.653083672989;13985.58043258704;14035.719285614026;14296.270407908367;13108.410121544744;13367.465301388225;13405;13420.865791342352;13871.930640346734;12866.228026318451;13185.208887466782;13500.594982150551;13590.137602132441;13953.326609397134;12685.8097128545;13100.672483187996;13290.069695121249;13339.19964802115;13575.660608484866;10499;11022.393768342818;11053.557857685602;11179.487689728501;11193.282835073931;9543.900341924766;10734.302270352402;11005.504752286006;11039.172062095535;11066.833997490205
14:45:58 INFO - PROCESS | 22498 | __end_tp_report
14:45:58 INFO - PROCESS | 22498 | __start_cc_report
14:45:58 INFO - PROCESS | 22498 | _x_x_mozilla_cycle_collect,329
14:45:58 INFO - PROCESS | 22498 | __end_cc_report
14:45:58 INFO - PROCESS | 22498 | __startTimestamp1477777558380__endTimestamp
14:45:58 INFO - PROCESS | 22498 |
14:45:58 INFO - PROCESS | 22498 | ------- Summary: start -------
14:45:58 INFO - PROCESS | 22498 | Number of tests: 6
14:45:58 INFO - PROCESS | 22498 |
14:45:58 INFO - PROCESS | 22498 | [#0] dojo.html Cycles:165 Average:5405.84 Median:5643.44 stddev:733.70 (13.0%) stddev-sans-first:712.86
14:45:58 INFO - PROCESS | 22498 | Values: 3077.9 3093.2 3100.1 3106.1 3132.3 5371.7 5423.6 5438.8 5470.8 5561.4 5371.8 5472.1 5493.2 5504.3 5514.3 4934.8 4983.7 5031.2 5046.6 5046.6 4919.6 4957.3 4983.0 5021.1 5028.5 4961.6 4982.5 5006.7 5069.5 5082.1 4990.6 5013.5 5020.2 5022.2 5074.4 560.3 4871.8 4893.1 4925.9 4964.8 5313.0 5405.6 5406.1 5410.5 5424.3 5830.6 5832.9 5833.2 5833.3 5843.3 5660.2 5733.3 5834.9 5866.1 5885.8 5485.9 5496.4 5525.9 5557.9 5558.9 6034.8 6039.6 6045.5 6048.1 6052.9 5596.9 5649.7 5788.2 5797.6 5804.9 5851.8 5865.5 5875.8 5882.6 5958.9 5812.4 5813.2 5860.4 5863.2 5871.2 5565.9 5835.2 5842.1 5886.7 5902.3 4302.3 4436.1 4451.9 4468.2 4511.5 3952.6 3954.0 3955.8 4002.4 4010.1 5363.1 5424.3 5563.4 5596.4 5603.0 5784.8 5807.8 5834.4 5847.8 5864.0 5550.4 5559.4 5560.2 5571.2 5636.5 4945.3 4950.2 4950.8 4964.4 4999.4 5802.1 5824.3 6022.2 6046.2 6060.5 5876.1 5898.5 5946.1 5960.2 5963.3 6018.9 6048.2 6062.6 6065.0 6075.6 5587.5 5620.9 5739.1 5805.7 5809.1 5867.3 5922.2 5924.3 5948.8 6021.4 5690.4 5745.7 5749.0 5751.9 5768.1 5460.7 5746.6 5749.9 5788.4 5798.4 5492.2 5643.4 5650.0 5654.6 5729.9 5757.1 5793.8 5811.4 5813.2 5823.0 5638.1 5688.7 5688.8 5690.9 5695.4
14:45:58 INFO - PROCESS | 22498 |
14:45:58 INFO - PROCESS | 22498 | [#1] ext.html Cycles:180 Average:60952.26 Median:43277.68 stddev:118731.85 (274.3%) stddev-sans-first:118978.32
14:45:58 INFO - PROCESS | 22498 | Values: 552.5 588.8 594.8 614.1 622.2 42314.3 43625.3 43681.6 47031.0 47031.0 44497.6 45564.0 45630.5 45683.3 45845.0 8805.1 9035.3 9042.6 9111.8 9120.3 8895.6 8989.0 8997.1 9011.5 9031.5 8993.5 9044.5 9048.8 9059.5 9059.8 8872.6 8994.1 8996.4 9019.7 9026.7 8859.4 8918.2 8987.4 9022.2 9028.7 42927.6 43240.6 43314.8 43320.8 43506.6 3307.6 3488.2 3840.9 3885.7 4102.5 32265.0 32377.5 32399.7 32413.4 33363.5 4340.8 4413.9 4518.3 4546.5 4649.9 324964.0 332041.0 334873.0 335315.0 335862.0 60062.4 60174.1 60329.1 60498.1 60546.0 62729.7 62978.0 63112.4 63267.0 63296.4 14286.4 14403.3 14462.9 14611.3 14625.0 11674.7 11707.9 11798.1 11855.9 11864.6 18203.1 18261.5 18328.4 18360.4 18672.4 6064.0 6149.6 6254.2 6304.4 6337.7 971.2 1052.4 1111.2 1134.6 1185.0 32030.4 32160.2 32429.0 32461.7 32865.7 1069.0 1070.0 1077.5 1087.5 1131.6 16568.7 17029.7 17138.0 17149.3 17360.6 530219.0 534727.0 536353.0 536843.0 540621.0 59036.0 59897.0 59924.4 60006.7 60150.0 1254.5 1286.1 1298.0 1298.3 1305.5 30462.7 31248.7 31984.7 32153.5 32654.3 52897.5 53282.0 53375.0 53405.5 53681.0 449974.0 452074.0 452372.0 453050.0 454153.0 42033.8 42530.0 42728.8 42915.8 43807.3 47476.8 48740.0 48793.5 49094.3 50377.0 40776.8 41565.8 41764.0 41805.0 42734.8 40623.6 40912.0 41059.6 41904.0 41919.4 41013.2 41542.4 41542.6 42526.6 42826.8 35430.3 36582.0 36803.4 37200.4 37656.2 27861.7 28408.6 28567.0 28717.9 28749.4
14:45:58 INFO - PROCESS | 22498 |
14:45:58 INFO - PROCESS | 22498 | [#2] jquery.html Cycles:180 Average:28443.09 Median:2606.85 stddev:76788.56 (2945.6%) stddev-sans-first:76975.06
14:45:58 INFO - PROCESS | 22498 | Values: 378.1 379.2 381.5 406.1 412.4 18073.0 19738.9 20024.1 20244.9 20363.4 19157.3 19544.3 19652.4 19718.5 19779.0 5415.1 5627.7 5720.8 5830.1 5879.3 5779.7 5787.1 5827.4 5850.4 5856.9 5561.9 5707.7 5718.4 5731.5 5816.5 5695.7 5746.5 5747.3 5752.2 5756.1 5089.7 5362.4 5393.1 5436.8 5443.3 22055.9 22343.0 22624.7 22743.9 22928.5 2097.2 2263.7 2325.6 2425.6 2788.1 9775.5 9831.1 9945.7 10094.3 13836.4 1798.7 1939.1 1977.1 1981.3 1991.6 84618.6 86227.0 86854.0 87881.0 87910.6 10482.2 10837.3 10887.6 11143.9 11233.2 15450.2 15488.8 15494.6 15502.7 15533.5 7422.3 7523.2 7719.4 7720.9 7791.8 6880.3 6984.0 7129.6 7174.5 7222.9 4513.4 4615.3 4683.5 4762.5 4810.3 1928.4 1947.0 1988.2 1990.7 2023.7 872.7 947.3 1000.5 1000.8 1059.0 19840.8 19950.8 20154.4 20206.8 20273.8 950.8 999.4 1007.0 1021.5 1039.0 10564.8 11210.4 11260.3 11276.5 11310.3 448861.0 459688.0 468510.0 470021.0 471206.0 91520.0 92217.5 92275.0 92902.0 94037.5 1020.4 1057.1 1077.7 1093.3 1098.5 16838.3 17099.7 17272.7 17956.3 18188.8 42332.4 42510.3 43186.4 43324.8 43831.6 57587.4 58990.7 59514.0 60265.0 60764.0 7173.5 7517.7 8029.4 8117.1 8478.4 11809.3 12700.4 12765.2 12881.0 13208.9 11384.1 11494.4 11597.2 11652.9 12006.5 10687.3 10945.6 11038.7 11245.9 11633.7 11467.4 11577.2 11654.9 11664.5 11687.1 7596.0 7667.7 7684.4 7773.3 7908.8 8568.8 11409.0 11484.5 11520.0 11600.7
14:45:58 INFO - PROCESS | 22498 |
14:45:58 INFO - PROCESS | 22498 | [#3] mootools.html Cycles:180 Average:5522.93 Median:5048.02 stddev:3027.87 (60.0%) stddev-sans-first:3021.15
14:45:58 INFO - PROCESS | 22498 | Values: 1483.9 1520.4 1669.2 1743.1 1780.2 7969.5 8182.1 8428.5 8461.3 8497.4 8461.2 8610.7 8623.4 8623.4 8633.5 2253.8 2261.5 2269.1 2273.5 2275.4 2285.9 2319.3 2333.4 2351.0 2361.1 2233.5 2236.4 2282.3 2282.9 2286.6 2236.6 2242.8 2244.3 2256.5 2259.7 2279.4 2298.3 2315.8 2323.7 2326.3 8444.1 8486.6 8542.8 8586.2 8604.0 4978.7 5074.5 5098.0 5099.1 5101.9 3132.0 3235.4 3393.2 3421.8 3429.9 1208.4 1231.3 1886.7 2013.8 2094.3 10949.3 10951.2 10995.6 11111.0 11123.0 4178.6 4219.7 4341.2 4352.0 4426.5 9172.1 9221.4 9222.9 9233.3 9251.1 5077.2 5149.8 5156.1 5159.8 5169.8 4586.2 4738.5 4758.1 4807.6 4822.3 3535.4 3582.3 3586.9 3590.5 3659.2 1160.6 1167.7 1168.4 1174.3 1174.9 889.4 959.9 977.6 1004.2 1004.3 5742.2 5842.4 5875.8 5887.7 5935.8 421.1 426.0 440.1 453.6 455.1 3952.6 4074.7 4093.2 4137.2 4145.4 9906.2 10213.3 10218.4 10271.1 10372.6 10011.5 10136.7 10189.6 10241.3 10256.1 7485.7 7676.1 7806.3 7807.4 7863.2 5563.2 5684.2 5731.0 5780.7 6006.8 9156.9 9166.9 9191.8 9262.3 9393.0 9432.4 9459.1 9513.6 9561.0 9698.7 7240.1 7501.8 7624.0 7800.3 7850.9 7741.4 8046.6 8116.4 8127.7 8145.7 6756.1 6790.9 7225.5 7234.5 7620.2 7073.8 7194.7 7250.5 7304.9 7381.6 6744.0 6847.2 6882.9 6894.4 6899.4 5000.0 5098.8 5194.1 5261.2 5298.1 4930.1 4997.8 5021.5 5197.6 5244.5
14:45:58 INFO - PROCESS | 22498 |
14:45:58 INFO - PROCESS | 22498 | [#4] prototype.html Cycles:180 Average:4716.23 Median:5230.33 stddev:1376.54 (26.3%) stddev-sans-first:1339.95
14:45:58 INFO - PROCESS | 22498 | Values: 302.9 315.1 315.9 318.9 321.7 5316.7 5513.9 5542.0 5592.0 5605.2 5339.3 5374.1 5476.1 5486.5 5488.5 4209.0 4249.3 4284.1 4296.1 4297.6 4185.5 4280.4 4288.3 4303.4 4311.6 4264.3 4269.3 4271.0 4272.3 4277.5 4254.7 4271.3 4272.9 4309.4 4325.7 3665.2 3835.8 3842.0 3843.6 3845.5 5338.8 5358.2 5366.9 5368.7 5388.9 4904.3 4931.9 4944.7 4956.8 4961.7 5549.8 5759.6 5772.5 5784.9 5787.2 4150.4 4159.7 4167.9 4168.8 4184.7 5969.6 6015.3 6021.2 6026.4 6064.4 4009.0 4177.5 4288.7 4306.5 4311.8 4240.0 4240.8 4243.7 4250.8 4252.2 4837.4 4868.4 4872.9 4880.9 4914.5 5645.8 5815.2 5819.7 5826.4 5829.4 1487.3 1499.4 1517.8 1520.8 1521.3 930.6 953.8 956.0 972.6 985.0 4797.5 4824.0 4846.3 4907.0 4966.9 5180.3 5202.7 5213.0 5228.8 5253.8 4707.6 4848.8 4859.7 4881.2 4888.4 2704.4 2795.7 2801.4 2801.6 2818.5 5217.8 5371.5 5373.2 5390.2 5421.8 4979.3 5248.7 5263.5 5267.4 5328.7 5334.8 5355.8 5367.4 5371.8 5379.5 5138.5 5191.6 5198.5 5216.5 5231.8 5134.8 5496.5 5903.3 5927.5 5952.3 6194.5 6209.2 6249.8 6262.4 6265.9 3948.8 4264.6 4292.2 4307.7 4310.8 5693.7 5853.6 5870.8 5894.7 5971.3 5687.7 5821.9 5835.6 5839.9 5840.5 5824.5 5851.7 5857.5 5864.5 5904.9 5633.2 5745.9 5762.6 5770.3 5777.7 5856.9 5866.0 5870.6 5871.2 5875.2 5486.9 5734.7 5741.6 5742.6 5762.4
14:45:58 INFO - PROCESS | 22498 |
14:45:58 INFO - PROCESS | 22498 | [#5] yui.html Cycles:180 Average:17276.18 Median:4631.75 stddev:22177.55 (478.8%) stddev-sans-first:22205.03
14:45:58 INFO - PROCESS | 22498 | Values: 744.8 769.3 780.7 808.2 859.2 13109.9 13817.7 13864.1 13930.7 13966.4 12466.5 12525.2 12527.8 12538.8 12543.2 793.2 802.0 828.8 836.0 838.1 825.7 826.4 829.6 831.6 833.2 859.4 867.1 872.9 879.5 880.4 859.6 867.2 868.2 873.5 874.7 629.4 632.2 632.2 634.4 635.0 14175.5 14188.9 14243.1 14271.1 14283.7 13783.5 14603.3 14830.6 14857.3 14920.7 11296.0 11360.5 11450.9 11532.7 11646.6 3826.3 3874.8 3875.8 4024.9 4036.5 62659.7 64113.0 64871.0 65576.0 65610.0 10513.9 10557.3 10653.8 10788.6 10897.8 21266.9 21315.1 21498.2 21528.6 21579.1 8264.6 8285.8 8302.5 8343.3 8492.9 4424.6 4541.6 4552.7 4555.0 4575.7 3383.3 3457.6 3470.2 3470.2 3477.9 590.0 601.2 618.1 622.8 629.0 576.7 686.3 701.3 708.7 711.9 9050.9 9189.9 9278.7 9605.3 9692.4 563.1 576.4 641.3 647.3 685.8 4466.5 4613.6 4649.9 4650.0 4751.1 70675.3 70790.3 74173.6 78933.0 91530.0 70016.3 71885.0 71967.0 72815.6 72858.0 67188.0 67342.7 67854.7 68560.3 70785.3 9142.2 9437.2 9546.3 9581.3 9799.2 42553.7 43235.6 43673.0 43975.3 44534.1 53919.7 59081.1 59614.7 60433.4 62733.4 12039.5 12225.5 12273.4 12372.6 12692.3 13700.2 13876.7 13985.6 14035.7 14296.3 13108.4 13367.5 13405.0 13420.9 13871.9 12866.2 13185.2 13500.6 13590.1 13953.3 12685.8 13100.7 13290.1 13339.2 13575.7 10499.0 11022.4 11053.6 11179.5 11193.3 9543.9 10734.3 11005.5 11039.2 11066.8
14:45:58 INFO - PROCESS | 22498 | -------- Summary: end --------
14:45:58 INFO - PROCESS | 22498 |
14:45:59 INFO - TEST-INFO | 22498: exit 0
14:45:59 INFO - TEST-OK | dromaeo_css | took 1116019ms
14:45:59 INFO - TEST-START | kraken
14:45:59 INFO - operating with platform_type : linux_
14:45:59 INFO - Initialising browser for kraken test...
14:45:59 INFO - TEST-INFO | started process 22861 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpEvHgZ6/profile http://localhost:49411/getInfo.html)
14:46:03 INFO - PROCESS | 22861 | __metrics Screen width/height:1600/1200
14:46:03 INFO - PROCESS | 22861 | colorDepth:24
14:46:03 INFO - PROCESS | 22861 | Browser inner width/height: 1024/697
14:46:03 INFO - PROCESS | 22861 | __metrics
14:46:04 ERROR - PROCESS | 22861 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3131: TypeError: this.tabs is undefined
14:46:05 INFO - TEST-INFO | 22861: exit 0
14:46:05 INFO - Browser initialized.
14:46:05 INFO - Running cycle 1/1 for kraken test...
14:46:05 INFO - TEST-INFO | started process 22982 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpEvHgZ6/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1)
14:46:17 INFO - PROCESS | 22982 | RSS: Main: 185528320
14:46:17 INFO - PROCESS | 22982 |
14:46:20 INFO - PROCESS | 22982 | Cycle 1(1): loaded http://localhost:49411/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49411/tests/kraken/driver.html?testName=audio-beat-detection)
14:46:21 INFO - PROCESS | 22982 | RSS: Main: 198545408
14:46:21 INFO - PROCESS | 22982 |
14:46:23 INFO - PROCESS | 22982 | Cycle 1(1): loaded http://localhost:49411/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49411/tests/kraken/driver.html?testName=audio-dft)
14:46:24 INFO - PROCESS | 22982 | RSS: Main: 196423680
14:46:24 INFO - PROCESS | 22982 |
14:46:27 INFO - PROCESS | 22982 | Cycle 1(1): loaded http://localhost:49411/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49411/tests/kraken/driver.html?testName=audio-fft)
14:46:28 INFO - PROCESS | 22982 | RSS: Main: 192888832
14:46:28 INFO - PROCESS | 22982 |
14:46:30 INFO - PROCESS | 22982 | Cycle 1(1): loaded http://localhost:49411/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49411/tests/kraken/driver.html?testName=audio-oscillator)
14:46:30 INFO - PROCESS | 22982 | RSS: Main: 193204224
14:46:30 INFO - PROCESS | 22982 |
14:46:33 INFO - PROCESS | 22982 | Cycle 1(1): loaded http://localhost:49411/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49411/tests/kraken/driver.html?testName=imaging-gaussian-blur)
14:46:33 INFO - PROCESS | 22982 | RSS: Main: 193036288
14:46:33 INFO - PROCESS | 22982 |
14:46:36 INFO - PROCESS | 22982 | Cycle 1(1): loaded http://localhost:49411/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49411/tests/kraken/driver.html?testName=imaging-darkroom)
14:46:37 INFO - PROCESS | 22982 | RSS: Main: 193933312
14:46:37 INFO - PROCESS | 22982 |
14:46:40 INFO - PROCESS | 22982 | Cycle 1(1): loaded http://localhost:49411/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49411/tests/kraken/driver.html?testName=imaging-desaturate)
14:46:41 INFO - PROCESS | 22982 | RSS: Main: 193990656
14:46:41 INFO - PROCESS | 22982 |
14:46:44 INFO - PROCESS | 22982 | Cycle 1(1): loaded http://localhost:49411/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49411/tests/kraken/driver.html?testName=json-parse-financial)
14:46:44 INFO - PROCESS | 22982 | RSS: Main: 193863680
14:46:44 INFO - PROCESS | 22982 |
14:46:46 INFO - PROCESS | 22982 | Cycle 1(1): loaded http://localhost:49411/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49411/tests/kraken/driver.html?testName=json-stringify-tinderbox)
14:46:46 INFO - PROCESS | 22982 | RSS: Main: 193597440
14:46:46 INFO - PROCESS | 22982 |
14:46:48 INFO - PROCESS | 22982 | Cycle 1(1): loaded http://localhost:49411/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49411/tests/kraken/driver.html?testName=stanford-crypto-aes)
14:46:49 INFO - PROCESS | 22982 | RSS: Main: 193691648
14:46:49 INFO - PROCESS | 22982 |
14:46:51 INFO - PROCESS | 22982 | Cycle 1(1): loaded http://localhost:49411/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49411/tests/kraken/driver.html?testName=stanford-crypto-ccm)
14:46:52 INFO - PROCESS | 22982 | RSS: Main: 194056192
14:46:52 INFO - PROCESS | 22982 |
14:46:54 INFO - PROCESS | 22982 | Cycle 1(1): loaded http://localhost:49411/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49411/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2)
14:46:55 INFO - PROCESS | 22982 | RSS: Main: 194019328
14:46:55 INFO - PROCESS | 22982 |
14:46:58 INFO - PROCESS | 22982 | Cycle 1(1): loaded http://localhost:49411/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49411/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative)
14:46:58 INFO - PROCESS | 22982 | RSS: Main: 194232320
14:46:58 INFO - PROCESS | 22982 |
14:47:00 INFO - PROCESS | 22982 | Cycle 1(1): loaded http://localhost:49411/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49411/tests/kraken/driver.html?testName=ai-astar)
14:47:00 INFO - PROCESS | 22982 | RSS: Main: 195342336
14:47:00 INFO - PROCESS | 22982 |
14:47:00 INFO - PROCESS | 22982 | __start_tp_report
14:47:00 INFO - PROCESS | 22982 | _x_x_mozilla_page_load
14:47:00 INFO - PROCESS | 22982 | _x_x_mozilla_page_load_details
14:47:00 INFO - PROCESS | 22982 | |i|pagename|runs|
14:47:00 INFO - PROCESS | 22982 | |0;ai-astar;105;113;113;112;114;114;112;114;114;113
14:47:00 INFO - PROCESS | 22982 | |1;audio-beat-detection;157;125;125;179;127;126;128;127;163;136
14:47:00 INFO - PROCESS | 22982 | |2;audio-dft;164;166;168;171;166;165;164;162;163;162
14:47:00 INFO - PROCESS | 22982 | |3;audio-fft;85;78;76;110;77;77;76;76;104;75
14:47:00 INFO - PROCESS | 22982 | |4;audio-oscillator;82;82;111;83;82;84;99;85;82;113
14:47:00 INFO - PROCESS | 22982 | |5;imaging-gaussian-blur;118;119;117;118;117;118;118;118;119;117
14:47:00 INFO - PROCESS | 22982 | |6;imaging-darkroom;148;147;147;147;148;146;150;148;147;146
14:47:00 INFO - PROCESS | 22982 | |7;imaging-desaturate;86;85;85;87;85;86;85;85;86;85
14:47:00 INFO - PROCESS | 22982 | |8;json-parse-financial;54;54;57;54;56;55;55;58;55;57
14:47:00 INFO - PROCESS | 22982 | |9;json-stringify-tinderbox;61;62;63;62;64;62;62;62;62;63
14:47:00 INFO - PROCESS | 22982 | |10;stanford-crypto-aes;81;85;86;89;81;81;88;81;80;86
14:47:00 INFO - PROCESS | 22982 | |11;stanford-crypto-ccm;133;137;138;139;144;132;137;141;179;151
14:47:00 INFO - PROCESS | 22982 | |12;stanford-crypto-pbkdf2;166;168;167;172;167;164;164;167;164;169
14:47:00 INFO - PROCESS | 22982 | |13;stanford-crypto-sha256-iterative;64;68;65;63;70;68;63;64;63;63
14:47:00 INFO - PROCESS | 22982 | __end_tp_report
14:47:00 INFO - PROCESS | 22982 | __start_cc_report
14:47:00 INFO - PROCESS | 22982 | _x_x_mozilla_cycle_collect,833
14:47:00 INFO - PROCESS | 22982 | __end_cc_report
14:47:00 INFO - PROCESS | 22982 | __startTimestamp1477777620903__endTimestamp
14:47:00 INFO - PROCESS | 22982 |
14:47:00 INFO - PROCESS | 22982 | ------- Summary: start -------
14:47:00 INFO - PROCESS | 22982 | Number of tests: 14
14:47:00 INFO - PROCESS | 22982 |
14:47:00 INFO - PROCESS | 22982 | [#0] ai-astar Cycles:10 Average:112.40 Median:113.50 stddev:2.72 (2.4%) stddev-sans-first:0.83
14:47:00 INFO - PROCESS | 22982 | Values: 105.0 113.0 113.0 112.0 114.0 114.0 112.0 114.0 114.0 113.0
14:47:00 INFO - PROCESS | 22982 |
14:47:00 INFO - PROCESS | 22982 | [#1] audio-beat-detection Cycles:10 Average:139.30 Median:132.00 stddev:19.66 (14.9%) stddev-sans-first:19.78
14:47:00 INFO - PROCESS | 22982 | Values: 157.0 125.0 125.0 179.0 127.0 126.0 128.0 127.0 163.0 136.0
14:47:00 INFO - PROCESS | 22982 |
14:47:00 INFO - PROCESS | 22982 | [#2] audio-dft Cycles:10 Average:165.10 Median:165.50 stddev:2.81 (1.7%) stddev-sans-first:2.95
14:47:00 INFO - PROCESS | 22982 | Values: 164.0 166.0 168.0 171.0 166.0 165.0 164.0 162.0 163.0 162.0
14:47:00 INFO - PROCESS | 22982 |
14:47:00 INFO - PROCESS | 22982 | [#3] audio-fft Cycles:10 Average:83.40 Median:76.50 stddev:12.83 (16.8%) stddev-sans-first:13.59
14:47:00 INFO - PROCESS | 22982 | Values: 85.0 78.0 76.0 110.0 77.0 77.0 76.0 76.0 104.0 75.0
14:47:00 INFO - PROCESS | 22982 |
14:47:00 INFO - PROCESS | 22982 | [#4] audio-oscillator Cycles:10 Average:90.30 Median:82.50 stddev:12.54 (15.2%) stddev-sans-first:12.94
14:47:00 INFO - PROCESS | 22982 | Values: 82.0 82.0 111.0 83.0 82.0 84.0 99.0 85.0 82.0 113.0
14:47:00 INFO - PROCESS | 22982 |
14:47:00 INFO - PROCESS | 22982 | [#5] imaging-gaussian-blur Cycles:10 Average:117.90 Median:118.00 stddev:0.74 (0.6%) stddev-sans-first:0.78
14:47:00 INFO - PROCESS | 22982 | Values: 118.0 119.0 117.0 118.0 117.0 118.0 118.0 118.0 119.0 117.0
14:47:00 INFO - PROCESS | 22982 |
14:47:00 INFO - PROCESS | 22982 | [#6] imaging-darkroom Cycles:10 Average:147.40 Median:147.50 stddev:1.17 (0.8%) stddev-sans-first:1.22
14:47:00 INFO - PROCESS | 22982 | Values: 148.0 147.0 147.0 147.0 148.0 146.0 150.0 148.0 147.0 146.0
14:47:00 INFO - PROCESS | 22982 |
14:47:00 INFO - PROCESS | 22982 | [#7] imaging-desaturate Cycles:10 Average:85.50 Median:85.50 stddev:0.71 (0.8%) stddev-sans-first:0.73
14:47:00 INFO - PROCESS | 22982 | Values: 86.0 85.0 85.0 87.0 85.0 86.0 85.0 85.0 86.0 85.0
14:47:00 INFO - PROCESS | 22982 |
14:47:00 INFO - PROCESS | 22982 | [#8] json-parse-financial Cycles:10 Average:55.50 Median:55.50 stddev:1.43 (2.6%) stddev-sans-first:1.41
14:47:00 INFO - PROCESS | 22982 | Values: 54.0 54.0 57.0 54.0 56.0 55.0 55.0 58.0 55.0 57.0
14:47:00 INFO - PROCESS | 22982 |
14:47:00 INFO - PROCESS | 22982 | [#9] json-stringify-tinderbox Cycles:10 Average:62.30 Median:62.00 stddev:0.82 (1.3%) stddev-sans-first:0.73
14:47:00 INFO - PROCESS | 22982 | Values: 61.0 62.0 63.0 62.0 64.0 62.0 62.0 62.0 62.0 63.0
14:47:00 INFO - PROCESS | 22982 |
14:47:00 INFO - PROCESS | 22982 | [#10] stanford-crypto-aes Cycles:10 Average:83.80 Median:85.50 stddev:3.36 (3.9%) stddev-sans-first:3.41
14:47:00 INFO - PROCESS | 22982 | Values: 81.0 85.0 86.0 89.0 81.0 81.0 88.0 81.0 80.0 86.0
14:47:00 INFO - PROCESS | 22982 |
14:47:00 INFO - PROCESS | 22982 | [#11] stanford-crypto-ccm Cycles:10 Average:143.10 Median:140.00 stddev:13.74 (9.8%) stddev-sans-first:14.08
14:47:00 INFO - PROCESS | 22982 | Values: 133.0 137.0 138.0 139.0 144.0 132.0 137.0 141.0 179.0 151.0
14:47:00 INFO - PROCESS | 22982 |
14:47:00 INFO - PROCESS | 22982 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:166.80 Median:167.00 stddev:2.53 (1.5%) stddev-sans-first:2.67
14:47:00 INFO - PROCESS | 22982 | Values: 166.0 168.0 167.0 172.0 167.0 164.0 164.0 167.0 164.0 169.0
14:47:00 INFO - PROCESS | 22982 |
14:47:00 INFO - PROCESS | 22982 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.10 Median:64.50 stddev:2.60 (4.0%) stddev-sans-first:2.73
14:47:00 INFO - PROCESS | 22982 | Values: 64.0 68.0 65.0 63.0 70.0 68.0 63.0 64.0 63.0 63.0
14:47:00 INFO - PROCESS | 22982 | -------- Summary: end --------
14:47:00 INFO - PROCESS | 22982 |
14:47:02 INFO - TEST-INFO | 22982: exit 0
14:47:02 INFO - TEST-OK | kraken | took 62734ms
14:47:02 INFO - SUITE-END | took 1178s
14:47:02 INFO - Completed test suite (00:19:39)
14:47:02 INFO - javascript benchmark
14:47:02 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7152.672499707101, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3077.907662770117, 3093.164845491716, 3100.1009707184903, 3106.130283520615, 3132.2795756975893, 5371.731413429333, 5423.593230507713, 5438.782448702057, 5470.8085217017315, 5561.443855614437, 5371.838844834661, 5472.069748142815, 5493.176023596463, 5504.311961004874, 5514.283143191379, 4934.777934992934, 4983.676061056038, 5031.169856973595, 5046.621503387242, 5046.646734728571, 4919.557239848413, 4957.305977163182, 4983.0, 5021.071101846152, 5028.522290382408, 4961.553460188582, 4982.501749825006, 5006.674566153189, 5069.467705890884, 5082.085224659579, 4990.550850423461, 5013.473585273567, 5020.196768517038, 5022.221555658843, 5074.3657042869645, 560.2818043569283, 4871.805127794884, 4893.09477746618, 4925.852224433237, 4964.826231081931, 5313.043652142613, 5405.567554595623, 5406.107992181285, 5410.5401040911565, 5424.267723857268, 5830.591858569902, 5832.854178645568, 5833.183354330397, 5833.329167145747, 5843.29880414353, 5660.2075709400715, 5733.3406658234, 5834.883302333929, 5866.061430171195, 5885.79399721012, 5485.945140548623, 5496.367917689517, 5525.944740552583, 5557.888842223173, 5558.888822223533, 6034.818955431344, 6039.577229593886, 6045.486133678599, 6048.123022161762, 6052.878942421127, 5596.888062238732, 5649.717514124277, 5788.18965344852, 5797.623154494944, 5804.912926306109, 5851.824445266649, 5865.472107510344, 5875.823725288248, 5882.55880808941, 5958.897603943285, 5812.418758124239, 5813.157092221604, 5860.384659610765, 5863.179154918314, 5871.178035075093, 5565.944340556543, 5835.2122463466885, 5842.123681447817, 5886.676232807236, 5902.2622172228475, 4302.311630139226, 4436.068425630589, 4451.888702782457, 4468.21806183923, 4511.548845115528, 3952.565217826037, 3953.9802300988313, 3955.841766329372, 4002.399640053957, 4010.057636455431, 5363.061464243741, 5424.349078110573, 5563.443655634485, 5596.356419011784, 5603.047481928001, 5784.82645520635, 5807.767689292381, 5834.416558344132, 5847.795327163529, 5864.03243464832, 5550.361708403585, 5559.360673522597, 5560.165975103686, 5571.164325351229, 5636.549076073904, 4945.307656928033, 4950.158473059589, 4950.801967921243, 4964.379452568429, 4999.400071991312, 5802.071668533014, 5824.330202026821, 6022.247219097613, 6046.153538504613, 6060.515158787374, 5876.118582212703, 5898.528117750484, 5946.108083787466, 5960.165576819162, 5963.3142188647125, 6018.879622407615, 6048.153258543719, 6062.636241825505, 6065.0, 6075.574709770273, 5587.469190426903, 5620.85947851307, 5739.081746920473, 5805.709714514173, 5809.099589563624, 5867.295924489089, 5922.170896074467, 5924.289085309618, 5948.791792287249, 6021.42796434338, 5690.402507736793, 5745.712714364181, 5749.0, 5751.942480575308, 5768.134779783066, 5460.6996615186545, 5746.569007324384, 5749.885002300014, 5788.392218816964, 5798.391168927202, 5492.231087647812, 5643.435656434323, 5649.971750141223, 5654.575906806924, 5729.914051289151, 5757.0788673811985, 5793.797217097382, 5811.360750317546, 5813.186153938367, 5822.970885145547, 5638.126090455986, 5688.658680479184, 5688.829335119953, 5690.8577285566535, 5695.373508913934], "value": 5356.814289102972, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [552.5431214269943, 588.7988503452955, 594.7829042399522, 614.1310046284508, 622.2160078301339, 42314.32556325953, 43625.34561981573, 43681.56318436815, 47031.0, 47031.0, 44497.55502444974, 45564.0, 45630.54369456304, 45683.314750278776, 45845.0, 8805.119488051192, 9035.322350823682, 9042.638294468214, 9111.772205694844, 9120.270378369747, 8895.599698013604, 8988.955055224747, 8997.100289971017, 9011.459312441242, 9031.503267320295, 8993.460392376479, 9044.547772611377, 9048.773780655503, 9059.456432614064, 9059.776930114449, 8872.556372181365, 8994.145556172152, 8996.415233009833, 9019.729408117733, 9026.684066057722, 8859.424137431046, 8918.241949434307, 8987.415817971876, 9022.18800307969, 9028.683996060106, 42927.57072429267, 43240.56759432428, 43314.783426082984, 43320.783396083134, 43506.564934350565, 3307.5534802801794, 3488.2325888304786, 3840.9353924737597, 3885.6891448684037, 4102.528209255914, 32265.0, 32377.51433728496, 32399.676003239903, 32413.35173296521, 33363.499547506806, 4340.848070317524, 4413.867583972486, 4518.254488009475, 4546.499885012646, 4649.907001859944, 324964.0, 332041.0, 334873.0, 335315.0, 335862.0, 60062.399376005684, 60174.09738853921, 60329.09506357408, 60498.092528612106, 60546.0, 62729.68635156795, 62978.0, 63112.36887631065, 63267.0, 63296.367036329044, 14286.428542858377, 14403.279836008158, 14462.927685361507, 14611.269436528131, 14625.0493717908, 11674.70813229676, 11707.88292117068, 11798.115141364431, 11855.940720296343, 11864.644060678194, 18203.095544707096, 18261.54346141357, 18328.358507452176, 18360.449186524427, 18672.439826805217, 6064.0073105804195, 6149.600275982047, 6254.153695477249, 6304.432601065926, 6337.704393715242, 971.2278738402987, 1052.4369462337766, 1111.2276967507505, 1134.5631931706353, 1184.9644510664693, 32030.359392812014, 32160.191141701536, 32429.0, 32461.675383245863, 32865.67134328626, 1069.0325255643654, 1069.983950240747, 1077.4774234496263, 1087.543231842628, 1131.5643477261149, 16568.6686266274, 17029.659406811796, 17138.0, 17149.314027439013, 17360.565985850455, 530219.0, 534727.0, 536353.0, 536843.0, 540621.0, 59036.0, 59897.0, 59924.40075599188, 60006.69996649989, 60150.0, 1254.4856608790353, 1286.1254347043912, 1297.9805302920463, 1298.2859427314938, 1305.4843336882068, 30462.695373045986, 31248.687513124576, 31984.68015319817, 32153.517697234092, 32654.34691306113, 52897.471025289255, 53282.0, 53375.0, 53405.46594534005, 53681.0, 449974.0, 452074.0, 452372.0, 453050.0, 454153.0, 42033.78983105065, 42530.0, 42728.78635606802, 42915.785421073946, 43807.34288985604, 47476.7626161867, 48740.0, 48793.512064878894, 49094.26358604695, 50377.0, 40776.79611601923, 41565.79217103895, 41764.0, 41805.0, 42734.786326069414, 40623.59376406316, 40912.0, 41059.58940410677, 41904.0, 41919.371209432495, 41013.1797364057, 41542.376864347665, 41542.58457415387, 42526.574734253496, 42826.78586607047, 35430.29139417146, 36582.0, 36803.44794828026, 37200.44199337066, 37656.24687506289, 27861.721382785912, 28408.57387139153, 28567.0, 28717.856410717814, 28749.425011499236], "value": 20382.91793196001, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [378.1114381204169, 379.1866446472317, 381.51166506871203, 406.1389853510558, 412.37936904958036, 18072.99999999998, 19738.90130549345, 20024.0989155488, 20244.898775506103, 20363.389098327054, 19157.329493467732, 19544.31594894179, 19652.41042768719, 19718.507037324074, 19779.0, 5415.10650742627, 5627.7467513961765, 5720.8283751487525, 5830.096335068071, 5879.294484661847, 5779.682117483537, 5787.074068149097, 5827.35899051104, 5850.385709500505, 5856.882862342772, 5561.860953476155, 5707.686077265748, 5718.399568045358, 5731.4555117264, 5816.534677225833, 5695.7152142392715, 5746.511546518551, 5747.339056008571, 5752.194692742998, 5756.050251708463, 5089.720065396402, 5362.410134885159, 5393.1370980642905, 5436.836894893159, 5443.319585051869, 22055.889720551295, 22343.0, 22624.660630090562, 22743.88628056849, 22928.54142917149, 2097.192580856366, 2263.739669937962, 2325.5697695926306, 2425.5755242832433, 2788.1217416513937, 9775.51122443882, 9831.115199631997, 9945.651902183388, 10094.343867648653, 13836.446542138303, 1798.694221982253, 1939.0886283446757, 1977.0905383523595, 1981.28673677476, 1991.5817678287576, 84618.57690711568, 86227.0, 86854.0, 87881.0, 87910.56044719735, 10482.161427085815, 10837.295575787548, 10887.564497420173, 11143.888561114447, 11233.213675042669, 15450.150241736588, 15488.767668484981, 15494.612634684223, 15502.689946201013, 15533.533993980198, 7422.257774222535, 7523.210062943422, 7719.382449404146, 7720.922790772132, 7791.766247012599, 6880.346367095118, 6984.0, 7129.60787156701, 7174.533655312388, 7222.891656625155, 4513.413256276663, 4615.330777037311, 4683.531646835358, 4762.476127625959, 4810.302506136591, 1928.3829174663972, 1947.0, 1988.2444671024919, 1990.741203643517, 2023.666095094293, 872.7120050383359, 947.3084648206848, 1000.4897502273893, 1000.7998400319965, 1058.9629362972414, 19840.801591984186, 19950.800491994894, 20154.395368138685, 20206.797932020785, 20273.79726202719, 950.8288508068475, 999.4253304350028, 1007.0, 1021.4586269277295, 1038.9896101039044, 10564.841527377095, 11210.439478026066, 11260.26808257477, 11276.492557834918, 11310.264832785842, 448861.0, 459688.0, 468510.0, 470021.0, 471206.0, 91520.0, 92217.53891230501, 92275.0, 92902.0, 94037.5298123505, 1020.4183615339185, 1057.1067448006422, 1077.7251800790748, 1093.2565855218527, 1098.505672447386, 16838.326466941184, 17099.658006839545, 17272.74090888663, 17956.281748730427, 18188.81695703273, 42332.36501452419, 42510.26111475035, 43186.35220471758, 43324.783376082916, 43831.561684382745, 57587.4241257582, 58990.70504647449, 59514.0, 60265.0, 60764.0, 7173.529426467666, 7517.736879209201, 8029.357651387758, 8117.147699491468, 8478.406511544134, 11809.291442513477, 12700.428480718205, 12765.234085954873, 12881.0, 13208.933955330162, 11384.14618903569, 11494.367809770209, 11597.18819682614, 11652.94173529127, 12006.459709312927, 10687.30532515384, 10945.616903408343, 11038.724031899266, 11245.943770281423, 11633.709157271136, 11467.369294688871, 11577.247478913843, 11654.94172529166, 11664.475098620753, 11687.08577022412, 7596.0, 7667.731629393167, 7684.364383739443, 7773.3004029637605, 7908.802279943047, 8568.843206167337, 11409.0, 11484.483198256266, 11520.0, 11600.709982250512], "value": 9148.236059646413, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1483.8590333918278, 1520.3842443810256, 1669.2404955745137, 1743.093591332508, 1780.1811166863233, 7969.481983671058, 8182.140875208107, 8428.494290342584, 8461.280791132745, 8497.447665901713, 8461.153884611536, 8610.655573777058, 8623.396362254645, 8623.439476434043, 8633.48199108054, 2253.7746225377414, 2261.51377453847, 2269.1150451323997, 2273.54529094181, 2275.4083938176027, 2285.8514196577253, 2319.2926157521947, 2333.4166458385403, 2350.976490235093, 2361.090979972714, 2233.4974630708043, 2236.351458077164, 2282.2696737044153, 2282.9200977965775, 2286.6455699366543, 2236.563870045342, 2242.7532971373134, 2244.2706120510898, 2256.4810093678384, 2259.7062381890332, 2279.361778701966, 2298.310506847939, 2315.8378913476063, 2323.6863023491783, 2326.278853555403, 8444.071152173256, 8486.575671216415, 8542.786430339229, 8586.22723954847, 8603.956980215122, 4978.7012779233, 5074.517920797518, 5098.0, 5099.107656160157, 5101.872453188663, 3131.984340078285, 3235.369103024911, 3393.151712071982, 3421.7775844570274, 3429.9314013719586, 1208.4199584199546, 1231.2673958994385, 1886.6509695706338, 2013.7684166320914, 2094.2565389286738, 10949.288296260796, 10951.178661600332, 10995.560177592966, 11111.00000999914, 11123.0, 4178.582141785858, 4219.746815191037, 4341.218580655513, 4352.042550638855, 4426.468823741172, 9172.082791720908, 9221.40060896053, 9222.878737890323, 9233.261339092856, 9251.121143491358, 5077.162268225701, 5149.76826042829, 5156.149235376196, 5159.793608255703, 5169.7932082717025, 4586.243269860503, 4738.5261473853025, 4758.095961767253, 4807.591354734886, 4822.324874517571, 3535.416656251741, 3582.265635544707, 3586.8744593939086, 3590.515280437108, 3659.182429529301, 1160.6169963912057, 1167.6672148437824, 1168.3690806964314, 1174.3423682737694, 1174.8590169179754, 889.3818795936891, 959.8656188133667, 977.6187286958092, 1004.231762701534, 1004.2668851738272, 5742.224799652077, 5842.415758424124, 5875.823725288248, 5887.676177810176, 5935.762569497172, 421.0736379964091, 425.9936100958488, 440.05827529087776, 453.58270391240137, 455.14887161008465, 3952.6245006724316, 4074.7351422157467, 4093.16090201508, 4137.234611596864, 4145.440365550672, 9906.20750339971, 10213.285070045175, 10218.437985910847, 10271.126954208827, 10372.636957706443, 10011.49942502872, 10136.746581335377, 10189.643362482277, 10241.334313269763, 10256.12822910061, 7485.663145158481, 7676.11724651661, 7806.3364614007305, 7807.375409967189, 7863.174366691529, 5563.165525171256, 5684.175794509855, 5730.9713451434145, 5780.7398667060925, 6006.849828754316, 9156.862647060432, 9166.908330916605, 9191.816163676824, 9262.305327100628, 9392.95303523478, 9432.43405395651, 9459.10138536838, 9513.619455221713, 9561.043895610383, 9698.660546880825, 7240.05879235696, 7501.849963000818, 7624.0, 7800.297973182214, 7850.921490785019, 7741.419393545394, 8046.637901294339, 8116.350691944512, 8127.6748930044505, 8145.674173033012, 6756.087928129639, 6790.879504881639, 7225.518182946506, 7234.457415693949, 7620.161782204064, 7073.82315442118, 7194.748183813542, 7250.492465527363, 7304.890426643711, 7381.594012329373, 6743.966280168764, 6847.1783385994, 6882.8623427530165, 6894.448444124559, 6899.379055884994, 4999.975000124976, 5098.821541246039, 5194.105229537737, 5261.184516399964, 5298.125809241432, 4930.10191076431, 4997.750112494434, 5021.5229553192385, 5197.636165468381, 5244.5279924806955], "value": 4429.008174260339, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [302.85311623862424, 315.07211262830964, 315.8562853901475, 318.85970173123826, 321.7249251889633, 5316.6544174628625, 5513.889722205554, 5542.009752977855, 5592.021396255659, 5605.215269862218, 5339.264738959834, 5374.140137577989, 5476.069068258395, 5486.478784515474, 5488.53347465466, 4209.0, 4249.277622804131, 4284.121755040209, 4296.140771845628, 4297.634701050414, 4185.539590645027, 4280.3793449949735, 4288.270993931023, 4303.376010478479, 4311.63351115154, 4264.275073237542, 4269.274223382017, 4270.957290427103, 4272.3124365875465, 4277.52425413232, 4254.680898932593, 4271.252530807112, 4272.867690062105, 4309.439772829513, 4325.718828276184, 3665.248624032067, 3835.827387767557, 3842.0, 3843.615638436134, 3845.5385353757447, 5338.813141540067, 5358.169483730028, 5366.872956679102, 5368.70472124033, 5388.946110538884, 4904.253617973946, 4931.914978704679, 4944.678595891256, 4956.801727930879, 4961.7022978621035, 5549.833504994856, 5759.5968282220265, 5772.538196944234, 5784.913226301609, 5787.247657804501, 4150.381351273006, 4159.667226621863, 4167.874963751093, 4168.812403441852, 4184.686148538872, 5969.641821490681, 6015.30823955242, 6021.2473440819895, 6026.397360263983, 6064.361383170107, 4009.0, 4177.4778152730905, 4288.699791014599, 4306.461692288464, 4311.827526898889, 4239.97880010598, 4240.809163587646, 4243.702940794176, 4250.766207858535, 4252.234597772431, 4837.371141751621, 4868.367112275452, 4872.902541949141, 4880.853574392703, 4914.483979182134, 5645.830625081254, 5815.244018277597, 5819.709014549256, 5826.41735826414, 5829.387914269026, 1487.256371814093, 1499.415228061057, 1517.7799219113167, 1520.787089807428, 1521.2849960518538, 930.6091441594547, 953.823542644613, 956.0439560439561, 972.5963725054023, 985.0100648847862, 4797.472278049412, 4823.97393094901, 4846.273059041101, 4906.975465122651, 4966.870871351026, 5180.274761533388, 5202.71385073817, 5212.98346822366, 5228.816991405282, 5253.816116435906, 4707.575598566741, 4848.8302909398, 4859.684120532154, 4881.242752609129, 4888.411266338454, 2704.350955770601, 2795.7279437855727, 2801.3836955869674, 2801.5571980430095, 2818.5208514552573, 5217.834343999413, 5371.549681586028, 5373.167159090347, 5390.218418329398, 5421.783128674809, 4979.253112033151, 5248.667096393818, 5263.499967503081, 5267.446918073547, 5328.733563321896, 5334.839954801362, 5355.768173320158, 5367.355917289872, 5371.838844834661, 5379.462053794589, 5138.486151384981, 5191.572317612687, 5198.532132108128, 5216.452272511484, 5231.843044708665, 5134.818991632021, 5496.450354964471, 5903.26209223847, 5927.4665280125, 5952.315483719428, 6194.473469754941, 6209.223847019122, 6249.78125765596, 6262.405071518198, 6265.937340626535, 3948.8025598719373, 4264.6375058119165, 4292.248856450171, 4307.719998200232, 4310.849120280775, 5693.747375577366, 5853.590248682722, 5870.765169393177, 5894.6757928314355, 5971.3132989705, 5687.715614219355, 5821.854453638693, 5835.649861008353, 5839.854003649943, 5840.474357307863, 5824.534037276923, 5851.736671849691, 5857.47282744555, 5864.501517370901, 5904.911426328695, 5633.211769995635, 5745.856353591026, 5762.596618236683, 5770.307563092456, 5777.653340799566, 5856.853578660568, 5866.0, 5870.618409803349, 5871.178035075179, 5875.177475153397, 5486.945130548803, 5734.741936612779, 5741.598088133791, 5742.569307301886, 5762.366139724543], "value": 4273.388862771634, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [744.7951813251356, 769.3306823063932, 780.6760194519278, 808.1796976069294, 859.2009431228954, 13109.868901310983, 13817.723645527096, 13864.098833575823, 13930.721385572282, 13966.371513281902, 12466.501339946391, 12525.185862918905, 12527.812082818742, 12538.811917821216, 12543.247405155675, 793.218679600593, 801.9719309824143, 828.8010877389413, 836.0343802907652, 838.0571856661256, 825.6532256452274, 826.409117481001, 829.6059371798408, 831.580052073702, 833.2251006563893, 859.3855393393723, 867.1068799136867, 872.9301655867515, 879.5294517433175, 880.3837313880277, 859.6260626627437, 867.2195024477958, 868.1752335281476, 873.5413907698477, 874.7288340614366, 629.4492319220682, 632.1529150937765, 632.2034236861541, 634.390984654732, 634.9936500634981, 14175.503857364944, 14188.929055354658, 14243.145411275356, 14271.143731376047, 14283.714325713532, 13783.51757688486, 14603.269836508132, 14830.629234269121, 14857.257137143208, 14920.7317378023, 11296.049601592675, 11360.48877800501, 11450.885491145065, 11532.711682207928, 11646.592369267035, 3826.3112639724836, 3874.767513949144, 3875.7907992444316, 4024.9195016099807, 4036.495438070241, 62659.6867015662, 64113.0, 64871.0, 65575.99999999952, 65610.0, 10513.9474302628, 10557.260991730505, 10653.84019239712, 10788.622398216025, 10897.83653245202, 21266.893665531574, 21315.056714507864, 21498.247561335593, 21528.56942861134, 21579.13683452644, 8264.628091735887, 8285.751427457186, 8302.54336011525, 8343.332533397313, 8492.872606910902, 4424.601785839225, 4541.568550987651, 4552.704074235164, 4554.95445045552, 4575.656825738083, 3383.3064221834466, 3457.550518432638, 3470.16715988161, 3470.236547959445, 3477.94783078254, 589.9823005309847, 601.2184160591302, 618.0543768034913, 622.8131560531822, 628.9654069026247, 576.6684156609966, 686.3342557719004, 701.2846896165883, 708.6633848921824, 711.8754218011827, 9050.86423703645, 9189.908100918905, 9278.67524636648, 9605.279604029725, 9692.41845489273, 563.0906086669999, 576.3631187537794, 641.2529403245167, 647.3397134922353, 685.8491131950963, 4466.479074545515, 4613.561711637389, 4649.930251046237, 4649.953500464952, 4751.121042607128, 70675.29324706687, 70790.2920970794, 74173.629131854, 78933.0, 91530.0, 70016.29983700199, 71885.0, 71967.0, 72815.63592182005, 72858.0, 67188.0, 67342.66328668325, 67854.66072669605, 68560.3143968564, 70785.2921470789, 9142.177204051668, 9437.150656440679, 9546.331756776959, 9581.281403894596, 9799.167070798776, 42553.7233882984, 43235.567644324416, 43673.0, 43975.340369893835, 44534.10931781411, 53919.73040134774, 59081.11378329243, 59614.70192649009, 60433.39566604278, 62733.37266627275, 12039.4582243801, 12225.510979560719, 12273.386330683252, 12372.566960156351, 12692.301923393932, 13700.24648644334, 13876.653083672989, 13985.58043258704, 14035.719285614026, 14296.270407908367, 13108.410121544744, 13367.465301388225, 13405.0, 13420.865791342352, 13871.930640346734, 12866.228026318451, 13185.208887466782, 13500.594982150551, 13590.137602132441, 13953.326609397134, 12685.8097128545, 13100.672483187996, 13290.069695121249, 13339.19964802115, 13575.660608484866, 10499.0, 11022.393768342818, 11053.557857685602, 11179.487689728501, 11193.282835073931, 9543.900341924766, 10734.302270352402, 11005.504752286006, 11039.172062095535, 11066.833997490205], "value": 7082.299663162446, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1517.8999999999996, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [105.0, 113.0, 113.0, 112.0, 114.0, 114.0, 112.0, 114.0, 114.0, 113.0], "value": 112.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [157.0, 125.0, 125.0, 179.0, 127.0, 126.0, 128.0, 127.0, 163.0, 136.0], "value": 139.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 166.0, 168.0, 171.0, 166.0, 165.0, 164.0, 162.0, 163.0, 162.0], "value": 165.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 78.0, 76.0, 110.0, 77.0, 77.0, 76.0, 76.0, 104.0, 75.0], "value": 83.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 82.0, 111.0, 83.0, 82.0, 84.0, 99.0, 85.0, 82.0, 113.0], "value": 90.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 119.0, 117.0, 118.0, 117.0, 118.0, 118.0, 118.0, 119.0, 117.0], "value": 117.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 147.0, 147.0, 147.0, 148.0, 146.0, 150.0, 148.0, 147.0, 146.0], "value": 147.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 85.0, 85.0, 87.0, 85.0, 86.0, 85.0, 85.0, 86.0, 85.0], "value": 85.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 54.0, 57.0, 54.0, 56.0, 55.0, 55.0, 58.0, 55.0, 57.0], "value": 55.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 62.0, 63.0, 62.0, 64.0, 62.0, 62.0, 62.0, 62.0, 63.0], "value": 62.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 85.0, 86.0, 89.0, 81.0, 81.0, 88.0, 81.0, 80.0, 86.0], "value": 83.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [133.0, 137.0, 138.0, 139.0, 144.0, 132.0, 137.0, 141.0, 179.0, 151.0], "value": 143.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [166.0, 168.0, 167.0, 172.0, 167.0, 164.0, 164.0, 167.0, 164.0, 169.0], "value": 166.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 68.0, 65.0, 63.0, 70.0, 68.0, 63.0, 64.0, 63.0, 63.0], "value": 65.1, "unit": "score"}]}]}
14:47:02 INFO - Return code: 0
14:47:02 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json
14:47:02 ERROR - # TBPL SUCCESS #
14:47:02 INFO - Running post-action listener: _resource_record_post_action
14:47:02 INFO - [mozharness: 2016-10-29 21:47:02.704534Z] Finished run-tests step (success)
14:47:02 INFO - Running post-run listener: _resource_record_post_run
14:47:02 INFO - Total resource usage - Wall time: 1196s; CPU: 13.0%; Read bytes: 8192; Write bytes: 393547776; Read time: 12; Write time: 353740
14:47:02 INFO - TinderboxPrint: CPU usage
13.5%
14:47:02 INFO - TinderboxPrint: I/O read bytes / time
8,192 / 12
14:47:02 INFO - TinderboxPrint: I/O write bytes / time
393,547,776 / 353,740
14:47:02 INFO - TinderboxPrint: CPU idle
8,250.9 (86.5%)
14:47:02 INFO - TinderboxPrint: CPU user
1,223.2 (12.8%)
14:47:02 INFO - TinderboxPrint: Swap in / out
0 / 0
14:47:02 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 103829504; Read time: 0; Write time: 100104
14:47:02 INFO - run-tests - Wall time: 1180s; CPU: 13.0%; Read bytes: 0; Write bytes: 289718272; Read time: 0; Write time: 253636
14:47:03 INFO - Running post-run listener: _upload_blobber_files
14:47:03 INFO - Blob upload gear active.
14:47:03 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir.
14:47:03 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
14:47:03 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', 'Mozilla-Inbound', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json']
14:47:03 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 Mozilla-Inbound -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json
14:47:03 INFO - (blobuploader) - INFO - Open directory for files ...
14:47:03 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ...
14:47:03 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com
14:47:03 INFO - (blobuploader) - INFO - Uploading, attempt #1.
14:47:04 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded
14:47:04 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded!
14:47:04 INFO - (blobuploader) - INFO - Done attempting.
14:47:04 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ...
14:47:04 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com
14:47:04 INFO - (blobuploader) - INFO - Uploading, attempt #1.
14:47:09 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded
14:47:09 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded!
14:47:09 INFO - (blobuploader) - INFO - Done attempting.
14:47:09 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ...
14:47:09 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com
14:47:09 INFO - (blobuploader) - INFO - Uploading, attempt #1.
14:47:09 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded
14:47:09 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded!
14:47:09 INFO - (blobuploader) - INFO - Done attempting.
14:47:09 INFO - (blobuploader) - INFO - Iteration through files over.
14:47:09 INFO - Return code: 0
14:47:09 INFO - rmtree: /builds/slave/test/build/uploaded_files.json
14:47:09 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1
14:47:09 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/f3900a13107c5d6add69df6c1801d2052c48a42c55a11b169ff5e50a13d31d4a8a33161a91a894260fb83fd3fe18b6193f708e5b090cb89305dcf071650ec7c4", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/3cd75eec21c70335de77a23396336290bc1b818286b070115c21e3f6564f8463f31c3e15088e441a2b4a6f829e501c4d4bcd8b33bb394bb2de5a3d363327f213", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/9afbb088a66e2d80676db890664331eea2dc634cc48ed1caba95b36adcd85b32c3b3853175e09fc4301861ddec8461e05bbef207018afc9e916b78cb49e15557"}
14:47:09 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files
14:47:09 INFO - Writing to file /builds/slave/test/properties/blobber_files
14:47:09 INFO - Contents:
14:47:09 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/f3900a13107c5d6add69df6c1801d2052c48a42c55a11b169ff5e50a13d31d4a8a33161a91a894260fb83fd3fe18b6193f708e5b090cb89305dcf071650ec7c4", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/3cd75eec21c70335de77a23396336290bc1b818286b070115c21e3f6564f8463f31c3e15088e441a2b4a6f829e501c4d4bcd8b33bb394bb2de5a3d363327f213", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/9afbb088a66e2d80676db890664331eea2dc634cc48ed1caba95b36adcd85b32c3b3853175e09fc4301861ddec8461e05bbef207018afc9e916b78cb49e15557"}
14:47:09 INFO - Running post-run listener: copy_logs_to_upload_dir
14:47:09 INFO - Copying logs to upload dir...
14:47:09 INFO - mkdir: /builds/slave/test/build/upload/logs
14:47:09 INFO - Copying logs to upload dir...
program finished with exit code 0
elapsedTime=1237.713501
========= master_lag: 0.02 =========
========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 37 secs) (at 2016-10-29 14:47:09.879406) =========
========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-29 14:47:09.882876) =========
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=db0483c52d987ecb441a263b000001ad-1477776389.587184-235884091
XPCOM_DEBUG_BREAK=warn
_=/tools/buildbot/bin/python
using PTY: False
blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/f3900a13107c5d6add69df6c1801d2052c48a42c55a11b169ff5e50a13d31d4a8a33161a91a894260fb83fd3fe18b6193f708e5b090cb89305dcf071650ec7c4", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/3cd75eec21c70335de77a23396336290bc1b818286b070115c21e3f6564f8463f31c3e15088e441a2b4a6f829e501c4d4bcd8b33bb394bb2de5a3d363327f213", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/9afbb088a66e2d80676db890664331eea2dc634cc48ed1caba95b36adcd85b32c3b3853175e09fc4301861ddec8461e05bbef207018afc9e916b78cb49e15557"}
build_url:https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1477704608/firefox-52.0a1.en-US.linux-x86_64.tar.bz2
program finished with exit code 0
elapsedTime=0.011481
build_url: 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1477704608/firefox-52.0a1.en-US.linux-x86_64.tar.bz2'
blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/f3900a13107c5d6add69df6c1801d2052c48a42c55a11b169ff5e50a13d31d4a8a33161a91a894260fb83fd3fe18b6193f708e5b090cb89305dcf071650ec7c4", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/3cd75eec21c70335de77a23396336290bc1b818286b070115c21e3f6564f8463f31c3e15088e441a2b4a6f829e501c4d4bcd8b33bb394bb2de5a3d363327f213", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/9afbb088a66e2d80676db890664331eea2dc634cc48ed1caba95b36adcd85b32c3b3853175e09fc4301861ddec8461e05bbef207018afc9e916b78cb49e15557"}'
========= master_lag: 0.01 =========
========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-29 14:47:09.907985) =========
========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-29 14:47:09.908297) =========
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=db0483c52d987ecb441a263b000001ad-1477776389.587184-235884091
XPCOM_DEBUG_BREAK=warn
_=/tools/buildbot/bin/python
using PTY: False
program finished with exit code 0
elapsedTime=0.004467
========= master_lag: 0.08 =========
========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-29 14:47:09.992369) =========
========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-29 14:47:09.992690) =========
========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-29 14:47:09.993104) =========
========= Total master_lag: 0.17 =========