builder: mozilla-inbound_ubuntu64_hw_test-dromaeojs-pgo
slave: talos-linux64-ix-049
starttime: 1480075083.83
results: success (0)
buildid: 20161125034105
builduid: e7c6e63a3c6c49dbb3e25c78173d3de6
revision: 629069be312e79f7b50005adf6c68bf446f5064e
========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-11-25 03:58:03.827429) =========
master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/
========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-11-25 03:58:03.827994) =========
========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-25 03:58:03.828326) =========
========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-25 03:58:03.843224) =========
========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-25 03:58:03.843663) =========
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=db7e7c15f3ca076d53731445000001ba-1480075084.201619-1935419765
XPCOM_DEBUG_BREAK=warn
_=/tools/buildbot/bin/python
using PTY: False
--2016-11-25 03:58:04-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py
Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25
Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected.
HTTP request sent, awaiting response... 200 Script output follows
Length: 12179 (12K) [text/x-python]
Saving to: `archiver_client.py'
0K .......... . 100% 215M=0s
2016-11-25 03:58:05 (215 MB/s) - `archiver_client.py' saved [12179/12179]
program finished with exit code 0
elapsedTime=0.105187
========= master_lag: 0.01 =========
========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-25 03:58:03.963416) =========
========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-25 03:58:03.963847) =========
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=db7e7c15f3ca076d53731445000001ba-1480075084.201619-1935419765
XPCOM_DEBUG_BREAK=warn
_=/tools/buildbot/bin/python
using PTY: False
program finished with exit code 0
elapsedTime=0.016242
========= master_lag: 0.03 =========
========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-25 03:58:04.013957) =========
========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-25 03:58:04.014358) =========
bash -c 'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev 629069be312e79f7b50005adf6c68bf446f5064e --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 629069be312e79f7b50005adf6c68bf446f5064e --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=db7e7c15f3ca076d53731445000001ba-1480075084.201619-1935419765
XPCOM_DEBUG_BREAK=warn
_=/tools/buildbot/bin/python
using PTY: False
2016-11-25 03:58:05,146 truncating revision to first 12 chars
2016-11-25 03:58:05,146 Setting DEBUG logging.
2016-11-25 03:58:05,146 attempt 1/10
2016-11-25 03:58:05,147 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/629069be312e?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness
2016-11-25 03:58:05,627 unpacking tar archive at: mozilla-inbound-629069be312e/testing/mozharness/
program finished with exit code 0
elapsedTime=0.831118
========= master_lag: 0.01 =========
========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-25 03:58:04.859610) =========
========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-25 03:58:04.859984) =========
script_repo_revision: 629069be312e79f7b50005adf6c68bf446f5064e
========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-25 03:58:04.860439) =========
========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-25 03:58:04.860762) =========
========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-25 03:58:04.870456) =========
========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 38 secs) (at 2016-11-25 03:58:04.870823) =========
/tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --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', '--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=db7e7c15f3ca076d53731445000001ba-1480075084.201619-1935419765
XPCOM_DEBUG_BREAK=warn
_=/tools/buildbot/bin/python
using PTY: False
03:58:06 INFO - MultiFileLogger online at 20161125 03:58:06 in /builds/slave/test
03:58:06 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound
03:58:06 INFO - Dumping config to /builds/slave/test/logs/localconfig.json.
03:58:06 INFO - {'append_to_log': False,
03:58:06 INFO - 'base_work_dir': '/builds/slave/test',
03:58:06 INFO - 'blob_upload_branch': 'Mozilla-Inbound',
03:58:06 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt',
03:58:06 INFO - 'branch': 'Mozilla-Inbound',
03:58:06 INFO - 'buildbot_json_path': 'buildprops.json',
03:58:06 INFO - 'config_files': ('talos/linux_config.py',),
03:58:06 INFO - 'default_actions': ('clobber',
03:58:06 INFO - 'read-buildbot-config',
03:58:06 INFO - 'download-and-extract',
03:58:06 INFO - 'populate-webroot',
03:58:06 INFO - 'create-virtualenv',
03:58:06 INFO - 'install',
03:58:06 INFO - 'run-tests'),
03:58:06 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',),
03:58:06 INFO - 'download_minidump_stackwalk': True,
03:58:06 INFO - 'download_symbols': 'ondemand',
03:58:06 INFO - 'exes': {'python': '/tools/buildbot/bin/python',
03:58:06 INFO - 'tooltool.py': '/tools/tooltool.py',
03:58:06 INFO - 'virtualenv': ('/tools/buildbot/bin/python',
03:58:06 INFO - '/tools/misc-python/virtualenv.py')},
03:58:06 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub',
03:58:06 INFO - 'http://pypi.pub.build.mozilla.org/pub'),
03:58:06 INFO - 'installer_path': 'installer.exe',
03:58:06 INFO - 'log_level': 'info',
03:58:06 INFO - 'log_name': 'talos',
03:58:06 INFO - 'log_to_console': True,
03:58:06 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk',
03:58:06 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest',
03:58:06 INFO - 'opt_config_files': (),
03:58:06 INFO - 'pip_index': False,
03:58:06 INFO - 'sps_profile': False,
03:58:06 INFO - 'sps_profile_interval': 0,
03:58:06 INFO - 'suite': 'dromaeojs',
03:58:06 INFO - 'system_bits': '32',
03:58:06 INFO - 'talos_extra_options': ('--webServer', 'localhost'),
03:58:06 INFO - 'title': 'talos-linux64-ix-049',
03:58:06 INFO - 'tooltool_cache': '/builds/tooltool_cache',
03:58:06 INFO - 'use_talos_json': True,
03:58:06 INFO - 'virtualenv_path': '/builds/slave/test/build/venv',
03:58:06 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None},
03:58:06 INFO - 'work_dir': 'build'}
03:58:06 INFO - [mozharness: 2016-11-25 11:58:06.103421Z] Running clobber step.
03:58:06 INFO - Running pre-action listener: _resource_record_pre_action
03:58:06 INFO - Running main action method: clobber
03:58:06 INFO - rmtree: /builds/slave/test/build
03:58:06 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1
03:58:06 INFO - Running post-action listener: _resource_record_post_action
03:58:06 INFO - [mozharness: 2016-11-25 11:58:06.567283Z] Finished clobber step (success)
03:58:06 INFO - [mozharness: 2016-11-25 11:58:06.567382Z] Running read-buildbot-config step.
03:58:06 INFO - Running pre-action listener: _resource_record_pre_action
03:58:06 INFO - Running main action method: read_buildbot_config
03:58:06 INFO - Using buildbot properties:
03:58:06 INFO - {
03:58:06 INFO - "project": "",
03:58:06 INFO - "product": "firefox",
03:58:06 INFO - "script_repo_revision": "production",
03:58:06 INFO - "builddir": "mozilla-inbound_ubuntu64_hw_test-dromaeojs",
03:58:06 INFO - "repository": "",
03:58:06 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-inbound pgo talos dromaeojs",
03:58:06 INFO - "buildid": "20161125034105",
03:58:06 INFO - "stage_platform": "linux64-pgo",
03:58:06 INFO - "basedir": "/builds/slave/test",
03:58:06 INFO - "buildnumber": 2937,
03:58:06 INFO - "platform": "ubuntu64_hw",
03:58:06 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/",
03:58:06 INFO - "slavebuilddir": "test",
03:58:06 INFO - "branch": "mozilla-inbound",
03:58:06 INFO - "revision": "629069be312e79f7b50005adf6c68bf446f5064e",
03:58:06 INFO - "slavename": "talos-linux64-ix-049",
03:58:06 INFO - "builduid": "e7c6e63a3c6c49dbb3e25c78173d3de6",
03:58:06 INFO - "repo_path": "integration/mozilla-inbound"
03:58:06 INFO - }
03:58:06 INFO - Found installer url https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1480062604/firefox-53.0a1.en-US.linux-x86_64.tar.bz2.
03:58:06 INFO - Found a test packages url https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1480062604/firefox-53.0a1.en-US.linux-x86_64.test_packages.json.
03:58:06 INFO - Running post-action listener: _resource_record_post_action
03:58:06 INFO - [mozharness: 2016-11-25 11:58:06.570050Z] Finished read-buildbot-config step (success)
03:58:06 INFO - [mozharness: 2016-11-25 11:58:06.570138Z] Running download-and-extract step.
03:58:06 INFO - Running pre-action listener: _resource_record_pre_action
03:58:06 INFO - Running main action method: download_and_extract
03:58:06 INFO - mkdir: /builds/slave/test/build/tests
03:58:06 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')]}
03:58:06 INFO - trying https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1480062604/firefox-53.0a1.en-US.linux-x86_64.test_packages.json
03:58:06 INFO - Downloading https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1480062604/firefox-53.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json
03:58:06 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1480062604/firefox-53.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1
03:58:06 INFO - Downloaded 1361 bytes.
03:58:06 INFO - Reading from file /builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json
03:58:06 INFO - Using the following test package requirements:
03:58:06 INFO - {u'common': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'],
03:58:06 INFO - u'cppunittest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip',
03:58:06 INFO - u'firefox-53.0a1.en-US.linux-x86_64.cppunittest.tests.zip'],
03:58:06 INFO - u'gtest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip',
03:58:06 INFO - u'firefox-53.0a1.en-US.linux-x86_64.gtest.tests.zip'],
03:58:06 INFO - u'jittest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip',
03:58:06 INFO - u'jsshell-linux-x86_64.zip'],
03:58:06 INFO - u'mochitest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip',
03:58:06 INFO - u'firefox-53.0a1.en-US.linux-x86_64.mochitest.tests.zip'],
03:58:06 INFO - u'mozbase': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'],
03:58:06 INFO - u'reftest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip',
03:58:06 INFO - u'firefox-53.0a1.en-US.linux-x86_64.reftest.tests.zip'],
03:58:06 INFO - u'talos': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip',
03:58:06 INFO - u'firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip'],
03:58:06 INFO - u'web-platform': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip',
03:58:06 INFO - u'firefox-53.0a1.en-US.linux-x86_64.web-platform.tests.zip'],
03:58:06 INFO - u'xpcshell': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip',
03:58:06 INFO - u'firefox-53.0a1.en-US.linux-x86_64.xpcshell.tests.zip']}
03:58:06 INFO - Downloading packages: [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common
03:58:06 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/1480062604/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip
03:58:06 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1480062604/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1
03:58:06 INFO - Fetch https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1480062604/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip into memory
03:58:06 INFO - Http code: 200
03:58:06 INFO - via: 1.1 93ab344e1a3fa44edbf3f1bc5729427a.cloudfront.net (CloudFront)
03:58:06 INFO - x-amz-cf-id: _Nz8q2oTHQRBnOD6qKp671IRqrjMEIg-37Io7VQJUeUCOtqxR3qVew==
03:58:06 INFO - x-amz-replication-status: COMPLETED
03:58:06 INFO - x-amz-version-id: rgmN3CMiF48u9A.33yj9fO..QzLb.mHr
03:58:06 INFO - Expected file size: 21767256
03:58:06 INFO - Obtained file size: 21767256
03:58:10 INFO - Downloading packages: [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos
03:58:10 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/1480062604/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip
03:58:10 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1480062604/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1
03:58:10 INFO - Fetch https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1480062604/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip into memory
03:58:10 INFO - Http code: 200
03:58:10 INFO - via: 1.1 24b0e5a3429d07ef12381da50e07f70f.cloudfront.net (CloudFront)
03:58:10 INFO - x-amz-cf-id: fOxcwpCCQLkEVgOaW_ri6LiFEI2ujNU6qVM-PDrgPQHTKQhZQfJ8pg==
03:58:10 INFO - x-amz-replication-status: COMPLETED
03:58:10 INFO - x-amz-version-id: rgmN3CMiF48u9A.33yj9fO..QzLb.mHr
03:58:11 INFO - Expected file size: 21767256
03:58:11 INFO - Obtained file size: 21767256
03:58:15 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/1480062604/firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip
03:58:15 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1480062604/firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1
03:58:15 INFO - Fetch https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1480062604/firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip into memory
03:58:15 INFO - Http code: 200
03:58:15 INFO - via: 1.1 e1eb7447ab46f530f6009f1d93917c54.cloudfront.net (CloudFront)
03:58:15 INFO - x-amz-cf-id: mmwHmR3LA5AbyyAUCiLRBeBfc3rtmjNwjYs511erJu2QQVEGb2-epQ==
03:58:15 INFO - x-amz-replication-status: COMPLETED
03:58:15 INFO - x-amz-version-id: bVHpi84Bt78Hmpbh24ptYaMWivGP1Cz9
03:58:15 INFO - Expected file size: 14409702
03:58:15 INFO - Obtained file size: 14409702
03:58:16 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')]}
03:58:16 INFO - trying https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1480062604/firefox-53.0a1.en-US.linux-x86_64.tar.bz2
03:58:16 INFO - Downloading https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1480062604/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2
03:58:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1480062604/firefox-53.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1
03:58:16 INFO - Downloaded 59746547 bytes.
03:58:16 INFO - Setting buildbot property build_url to https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1480062604/firefox-53.0a1.en-US.linux-x86_64.tar.bz2
03:58:16 INFO - mkdir: /builds/slave/test/properties
03:58:16 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url
03:58:16 INFO - Writing to file /builds/slave/test/properties/build_url
03:58:16 INFO - Contents:
03:58:16 INFO - build_url:https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1480062604/firefox-53.0a1.en-US.linux-x86_64.tar.bz2
03:58:17 INFO - Running post-action listener: _resource_record_post_action
03:58:17 INFO - Running post-action listener: set_extra_try_arguments
03:58:17 INFO - [mozharness: 2016-11-25 11:58:17.096731Z] Finished download-and-extract step (success)
03:58:17 INFO - [mozharness: 2016-11-25 11:58:17.096958Z] Running populate-webroot step.
03:58:17 INFO - Running pre-action listener: _resource_record_pre_action
03:58:17 INFO - Running main action method: populate_webroot
03:58:17 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']},
03:58:17 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']},
03:58:17 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome',
03:58:17 INFO - '--tppagecycles',
03:58:17 INFO - '7'],
03:58:17 INFO - 'tests': ['tsvgm']}},
03:58:17 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'],
03:58:17 INFO - 'tests': ['tresize', 'tcanvasmark']},
03:58:17 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']},
03:58:17 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'],
03:58:17 INFO - 'tests': ['dromaeo_css', 'kraken']},
03:58:17 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']},
03:58:17 INFO - 'g1': {'pagesets_name': 'tp5n.zip',
03:58:17 INFO - 'talos_options': ['--disable-e10s'],
03:58:17 INFO - 'tests': ['tp5o_scroll', 'glterrain']},
03:58:17 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip',
03:58:17 INFO - 'tests': ['tp5o_scroll', 'glterrain']},
03:58:17 INFO - 'g2': {'pagesets_name': 'tp5n.zip',
03:58:17 INFO - 'talos_options': ['--disable-e10s'],
03:58:17 INFO - 'tests': ['damp', 'tps']},
03:58:17 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip',
03:58:17 INFO - 'tests': ['damp', 'tps']},
03:58:17 INFO - 'g3': {'talos_options': ['--disable-e10s'],
03:58:17 INFO - 'tests': ['dromaeo_dom']},
03:58:17 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']},
03:58:17 INFO - 'g4': {'talos_options': ['--disable-e10s'],
03:58:17 INFO - 'tests': ['basic_compositor_video']},
03:58:17 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']},
03:58:17 INFO - 'other': {'talos_options': ['--disable-e10s'],
03:58:17 INFO - 'tests': ['a11yr',
03:58:17 INFO - 'ts_paint',
03:58:17 INFO - 'tpaint',
03:58:17 INFO - 'sessionrestore',
03:58:17 INFO - 'sessionrestore_no_auto_restore',
03:58:17 INFO - 'tabpaint']},
03:58:17 INFO - 'other-e10s': {'tests': ['a11yr',
03:58:17 INFO - 'ts_paint',
03:58:17 INFO - 'tpaint',
03:58:17 INFO - 'sessionrestore',
03:58:17 INFO - 'sessionrestore_no_auto_restore',
03:58:17 INFO - 'tabpaint']},
03:58:17 INFO - 'other-e10s_l64': {'tests': ['a11yr',
03:58:17 INFO - 'ts_paint',
03:58:17 INFO - 'tpaint',
03:58:17 INFO - 'sessionrestore',
03:58:17 INFO - 'sessionrestore_no_auto_restore',
03:58:17 INFO - 'tabpaint']},
03:58:17 INFO - 'other-e10s_nol64': {'tests': ['a11yr',
03:58:17 INFO - 'ts_paint',
03:58:17 INFO - 'tpaint',
03:58:17 INFO - 'sessionrestore',
03:58:17 INFO - 'sessionrestore_no_auto_restore',
03:58:17 INFO - 'tabpaint']},
03:58:17 INFO - 'other_l64': {'talos_options': ['--disable-e10s'],
03:58:17 INFO - 'tests': ['a11yr',
03:58:17 INFO - 'ts_paint',
03:58:17 INFO - 'tpaint',
03:58:17 INFO - 'sessionrestore',
03:58:17 INFO - 'sessionrestore_no_auto_restore',
03:58:17 INFO - 'tabpaint']},
03:58:17 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'],
03:58:17 INFO - 'tests': ['a11yr',
03:58:17 INFO - 'ts_paint',
03:58:17 INFO - 'tpaint',
03:58:17 INFO - 'sessionrestore',
03:58:17 INFO - 'sessionrestore_no_auto_restore',
03:58:17 INFO - 'tabpaint']},
03:58:17 INFO - 'svgr': {'talos_options': ['--disable-e10s'],
03:58:17 INFO - 'tests': ['tsvgx',
03:58:17 INFO - 'tsvgr_opacity',
03:58:17 INFO - 'tart',
03:58:17 INFO - 'tscrollx',
03:58:17 INFO - 'cart',
03:58:17 INFO - 'tsvg_static']},
03:58:17 INFO - 'svgr-e10s': {'tests': ['tsvgx',
03:58:17 INFO - 'tsvgr_opacity',
03:58:17 INFO - 'tart',
03:58:17 INFO - 'tscrollx',
03:58:17 INFO - 'cart',
03:58:17 INFO - 'tsvg_static']},
03:58:17 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip',
03:58:17 INFO - 'talos_options': ['--disable-e10s'],
03:58:17 INFO - 'tests': ['tp5o']},
03:58:17 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']},
03:58:17 INFO - 'xperf': {'pagesets_name': 'tp5n.zip',
03:58:17 INFO - 'talos_options': ['--disable-e10s',
03:58:17 INFO - '--xperf_path',
03:58:17 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'],
03:58:17 INFO - 'tests': ['tp5n']},
03:58:17 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip',
03:58:17 INFO - 'talos_options': ['--xperf_path',
03:58:17 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'],
03:58:17 INFO - 'tests': ['tp5n']}},
03:58:17 INFO - 'talos.zip': {'path': '',
03:58:17 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}}
03:58:17 INFO - Running post-action listener: _resource_record_post_action
03:58:17 INFO - [mozharness: 2016-11-25 11:58:17.112806Z] Finished populate-webroot step (success)
03:58:17 INFO - [mozharness: 2016-11-25 11:58:17.112893Z] Running create-virtualenv step.
03:58:17 INFO - Running pre-action listener: _resource_record_pre_action
03:58:17 INFO - Running main action method: create_virtualenv
03:58:17 INFO - Creating virtualenv /builds/slave/test/build/venv
03:58:17 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
03:58:17 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv
03:58:17 INFO - The --no-site-packages flag is deprecated; it is now the default behavior.
03:58:17 INFO - Using real prefix '/usr'
03:58:17 INFO - New python executable in /builds/slave/test/build/venv/bin/python
03:58:17 INFO - Installing distribute.............................................................................................................................................................................................done.
03:58:19 INFO - Installing pip.................done.
03:58:19 INFO - Return code: 0
03:58:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version']
03:58:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version
03:58:19 INFO - Reading from file tmpfile_stdout
03:58:19 INFO - Output received:
03:58:19 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)
03:58:19 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv
03:58:19 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')]}
03:58:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org
03:58:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub
03:58:19 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')]}
03:58:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org
03:58:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub
03:58:19 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 0x7f17da3e0e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2991b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b2d130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bbbfc0>, '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 0x2bbcec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bbd350>, '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': 'db7e7c15f3ca076d53731445000001ba-1480075084.201619-1935419765', '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
03:58:19 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
03:58:19 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
03:58:19 INFO - Using env: {'DISPLAY': ':0',
03:58:19 INFO - 'HOME': '/home/cltbld',
03:58:19 INFO - 'LANG': 'en_US.UTF-8',
03:58:19 INFO - 'LANGUAGE': 'en_US:en',
03:58:19 INFO - 'LOGNAME': 'cltbld',
03:58:19 INFO - 'MAIL': '/var/mail/cltbld',
03:58:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1',
03:58:19 INFO - 'MOZ_NO_REMOTE': '1',
03:58:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript',
03:58:19 INFO - 'NO_EM_RESTART': '1',
03:58:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games',
03:58:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json',
03:58:19 INFO - 'PWD': '/builds/slave/test',
03:58:19 INFO - 'SHELL': '/bin/bash',
03:58:19 INFO - 'SHLVL': '1',
03:58:19 INFO - 'TERM': 'linux',
03:58:19 INFO - 'TMOUT': '86400',
03:58:19 INFO - 'USER': 'cltbld',
03:58:19 INFO - 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1480075084.201619-1935419765',
03:58:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn',
03:58:19 INFO - '_': '/tools/buildbot/bin/python'}
03:58:20 INFO - Ignoring indexes: https://pypi.python.org/simple/
03:58:20 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
03:58:20 INFO - Cleaning up...
03:58:20 INFO - Return code: 0
03:58:20 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv
03:58:20 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')]}
03:58:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org
03:58:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub
03:58:20 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')]}
03:58:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org
03:58:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub
03:58:20 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 0x7f17da3e0e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2991b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b2d130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bbbfc0>, '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 0x2bbcec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bbd350>, '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': 'db7e7c15f3ca076d53731445000001ba-1480075084.201619-1935419765', '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
03:58:20 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
03:58:20 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
03:58:20 INFO - Using env: {'DISPLAY': ':0',
03:58:20 INFO - 'HOME': '/home/cltbld',
03:58:20 INFO - 'LANG': 'en_US.UTF-8',
03:58:20 INFO - 'LANGUAGE': 'en_US:en',
03:58:20 INFO - 'LOGNAME': 'cltbld',
03:58:20 INFO - 'MAIL': '/var/mail/cltbld',
03:58:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1',
03:58:20 INFO - 'MOZ_NO_REMOTE': '1',
03:58:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript',
03:58:20 INFO - 'NO_EM_RESTART': '1',
03:58:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games',
03:58:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json',
03:58:20 INFO - 'PWD': '/builds/slave/test',
03:58:20 INFO - 'SHELL': '/bin/bash',
03:58:20 INFO - 'SHLVL': '1',
03:58:20 INFO - 'TERM': 'linux',
03:58:20 INFO - 'TMOUT': '86400',
03:58:20 INFO - 'USER': 'cltbld',
03:58:20 INFO - 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1480075084.201619-1935419765',
03:58:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn',
03:58:20 INFO - '_': '/tools/buildbot/bin/python'}
03:58:20 INFO - Ignoring indexes: https://pypi.python.org/simple/
03:58:20 INFO - Downloading/unpacking psutil>=3.1.1
03:58:20 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
03:58:20 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
03:58:20 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
03:58:20 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
03:58:20 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
03:58:20 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
03:58:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil
03:58:22 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build'
03:58:22 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects
...
03:58:22 INFO - Installing collected packages: psutil
03:58:22 INFO - Running setup.py install for psutil
03:58:22 INFO - building 'psutil._psutil_linux' extension
03:58:22 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
03:58:22 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
03:58:22 INFO - building 'psutil._psutil_posix' extension
03:58:22 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
03:58:22 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
03:58:22 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build'
03:58:22 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ...
03:58:22 INFO - Successfully installed psutil
03:58:22 INFO - Cleaning up...
03:58:22 INFO - Return code: 0
03:58:22 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv
03:58:22 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')]}
03:58:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org
03:58:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub
03:58:22 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')]}
03:58:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org
03:58:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub
03:58:23 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 0x7f17da3e0e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2991b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b2d130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bbbfc0>, '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 0x2bbcec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bbd350>, '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': 'db7e7c15f3ca076d53731445000001ba-1480075084.201619-1935419765', '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
03:58:23 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
03:58:23 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
03:58:23 INFO - Using env: {'DISPLAY': ':0',
03:58:23 INFO - 'HOME': '/home/cltbld',
03:58:23 INFO - 'LANG': 'en_US.UTF-8',
03:58:23 INFO - 'LANGUAGE': 'en_US:en',
03:58:23 INFO - 'LOGNAME': 'cltbld',
03:58:23 INFO - 'MAIL': '/var/mail/cltbld',
03:58:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1',
03:58:23 INFO - 'MOZ_NO_REMOTE': '1',
03:58:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript',
03:58:23 INFO - 'NO_EM_RESTART': '1',
03:58:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games',
03:58:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json',
03:58:23 INFO - 'PWD': '/builds/slave/test',
03:58:23 INFO - 'SHELL': '/bin/bash',
03:58:23 INFO - 'SHLVL': '1',
03:58:23 INFO - 'TERM': 'linux',
03:58:23 INFO - 'TMOUT': '86400',
03:58:23 INFO - 'USER': 'cltbld',
03:58:23 INFO - 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1480075084.201619-1935419765',
03:58:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn',
03:58:23 INFO - '_': '/tools/buildbot/bin/python'}
03:58:23 INFO - Ignoring indexes: https://pypi.python.org/simple/
03:58:23 INFO - Downloading/unpacking mozsystemmonitor==0.3
03:58:23 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
03:58:23 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
03:58:23 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
03:58:23 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
03:58:23 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
03:58:23 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
03:58:25 INFO - Downloading mozsystemmonitor-0.3.tar.gz
03:58:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor
03:58:25 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3)
03:58:25 INFO - Installing collected packages: mozsystemmonitor
03:58:25 INFO - Running setup.py install for mozsystemmonitor
03:58:25 INFO - Successfully installed mozsystemmonitor
03:58:25 INFO - Cleaning up...
03:58:25 INFO - Return code: 0
03:58:25 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv
03:58:25 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')]}
03:58:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org
03:58:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub
03:58:25 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')]}
03:58:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org
03:58:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub
03:58:25 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 0x7f17da3e0e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2991b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b2d130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bbbfc0>, '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 0x2bbcec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bbd350>, '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': 'db7e7c15f3ca076d53731445000001ba-1480075084.201619-1935419765', '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
03:58:25 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
03:58:25 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
03:58:25 INFO - Using env: {'DISPLAY': ':0',
03:58:25 INFO - 'HOME': '/home/cltbld',
03:58:25 INFO - 'LANG': 'en_US.UTF-8',
03:58:25 INFO - 'LANGUAGE': 'en_US:en',
03:58:25 INFO - 'LOGNAME': 'cltbld',
03:58:25 INFO - 'MAIL': '/var/mail/cltbld',
03:58:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1',
03:58:25 INFO - 'MOZ_NO_REMOTE': '1',
03:58:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript',
03:58:25 INFO - 'NO_EM_RESTART': '1',
03:58:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games',
03:58:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json',
03:58:25 INFO - 'PWD': '/builds/slave/test',
03:58:25 INFO - 'SHELL': '/bin/bash',
03:58:25 INFO - 'SHLVL': '1',
03:58:25 INFO - 'TERM': 'linux',
03:58:25 INFO - 'TMOUT': '86400',
03:58:25 INFO - 'USER': 'cltbld',
03:58:25 INFO - 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1480075084.201619-1935419765',
03:58:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn',
03:58:25 INFO - '_': '/tools/buildbot/bin/python'}
03:58:25 INFO - Ignoring indexes: https://pypi.python.org/simple/
03:58:25 INFO - Downloading/unpacking jsonschema==2.5.1
03:58:25 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
03:58:25 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
03:58:25 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
03:58:25 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
03:58:25 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
03:58:25 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
03:58:27 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl
03:58:27 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1)
03:58:27 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
03:58:27 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
03:58:27 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
03:58:27 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
03:58:27 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
03:58:27 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
03:58:27 INFO - Downloading functools32-3.2.3-2.tar.gz
03:58:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32
03:58:27 INFO - warning: no files found matching '*.txt'
03:58:27 INFO - no previously-included directories found matching 'build'
03:58:27 INFO - no previously-included directories found matching 'dist'
03:58:27 INFO - no previously-included directories found matching '.git*'
03:58:27 INFO - Installing collected packages: jsonschema, functools32
03:58:27 INFO - Running setup.py install for functools32
03:58:27 INFO - warning: no files found matching '*.txt'
03:58:27 INFO - no previously-included directories found matching 'build'
03:58:27 INFO - no previously-included directories found matching 'dist'
03:58:27 INFO - no previously-included directories found matching '.git*'
03:58:27 INFO - Successfully installed jsonschema functools32
03:58:27 INFO - Cleaning up...
03:58:28 INFO - Return code: 0
03:58:28 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv
03:58:28 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')]}
03:58:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org
03:58:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub
03:58:28 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')]}
03:58:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org
03:58:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub
03:58:28 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 0x7f17da3e0e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2991b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b2d130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bbbfc0>, '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 0x2bbcec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bbd350>, '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': 'db7e7c15f3ca076d53731445000001ba-1480075084.201619-1935419765', '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
03:58:28 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
03:58:28 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
03:58:28 INFO - Using env: {'DISPLAY': ':0',
03:58:28 INFO - 'HOME': '/home/cltbld',
03:58:28 INFO - 'LANG': 'en_US.UTF-8',
03:58:28 INFO - 'LANGUAGE': 'en_US:en',
03:58:28 INFO - 'LOGNAME': 'cltbld',
03:58:28 INFO - 'MAIL': '/var/mail/cltbld',
03:58:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1',
03:58:28 INFO - 'MOZ_NO_REMOTE': '1',
03:58:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript',
03:58:28 INFO - 'NO_EM_RESTART': '1',
03:58:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games',
03:58:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json',
03:58:28 INFO - 'PWD': '/builds/slave/test',
03:58:28 INFO - 'SHELL': '/bin/bash',
03:58:28 INFO - 'SHLVL': '1',
03:58:28 INFO - 'TERM': 'linux',
03:58:28 INFO - 'TMOUT': '86400',
03:58:28 INFO - 'USER': 'cltbld',
03:58:28 INFO - 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1480075084.201619-1935419765',
03:58:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn',
03:58:28 INFO - '_': '/tools/buildbot/bin/python'}
03:58:28 INFO - Ignoring indexes: https://pypi.python.org/simple/
03:58:28 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages
03:58:28 INFO - Cleaning up...
03:58:28 INFO - Return code: 0
03:58:28 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv
03:58:28 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')]}
03:58:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org
03:58:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub
03:58:28 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')]}
03:58:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org
03:58:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub
03:58:28 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 0x7f17da3e0e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2991b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b2d130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bbbfc0>, '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 0x2bbcec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bbd350>, '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': 'db7e7c15f3ca076d53731445000001ba-1480075084.201619-1935419765', '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
03:58:28 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
03:58:28 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
03:58:28 INFO - Using env: {'DISPLAY': ':0',
03:58:28 INFO - 'HOME': '/home/cltbld',
03:58:28 INFO - 'LANG': 'en_US.UTF-8',
03:58:28 INFO - 'LANGUAGE': 'en_US:en',
03:58:28 INFO - 'LOGNAME': 'cltbld',
03:58:28 INFO - 'MAIL': '/var/mail/cltbld',
03:58:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1',
03:58:28 INFO - 'MOZ_NO_REMOTE': '1',
03:58:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript',
03:58:28 INFO - 'NO_EM_RESTART': '1',
03:58:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games',
03:58:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json',
03:58:28 INFO - 'PWD': '/builds/slave/test',
03:58:28 INFO - 'SHELL': '/bin/bash',
03:58:28 INFO - 'SHLVL': '1',
03:58:28 INFO - 'TERM': 'linux',
03:58:28 INFO - 'TMOUT': '86400',
03:58:28 INFO - 'USER': 'cltbld',
03:58:28 INFO - 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1480075084.201619-1935419765',
03:58:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn',
03:58:28 INFO - '_': '/tools/buildbot/bin/python'}
03:58:28 INFO - Ignoring indexes: https://pypi.python.org/simple/
03:58:28 INFO - Downloading/unpacking blobuploader==1.2.4
03:58:28 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
03:58:28 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
03:58:28 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
03:58:28 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
03:58:28 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
03:58:28 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
03:58:30 INFO - Downloading blobuploader-1.2.4.tar.gz
03:58:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader
03:58:30 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4)
03:58:30 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
03:58:30 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
03:58:30 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
03:58:30 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
03:58:30 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
03:58:30 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
03:58:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests
03:58:31 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4)
03:58:31 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
03:58:31 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
03:58:31 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
03:58:31 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
03:58:31 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
03:58:31 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
03:58:31 INFO - Downloading docopt-0.6.1.tar.gz
03:58:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt
03:58:31 INFO - Installing collected packages: blobuploader, requests, docopt
03:58:31 INFO - Running setup.py install for blobuploader
03:58:31 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775
03:58:31 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775
03:58:31 INFO - Running setup.py install for requests
03:58:31 INFO - Running setup.py install for docopt
03:58:31 INFO - Successfully installed blobuploader requests docopt
03:58:31 INFO - Cleaning up...
03:58:32 INFO - Return code: 0
03:58:32 INFO - Installing None into virtualenv /builds/slave/test/build/venv
03:58: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')]}
03:58:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org
03:58:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub
03:58: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')]}
03:58:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org
03:58:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub
03:58:32 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 0x7f17da3e0e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2991b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b2d130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bbbfc0>, '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 0x2bbcec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bbd350>, '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': 'db7e7c15f3ca076d53731445000001ba-1480075084.201619-1935419765', '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
03:58:32 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
03:58:32 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
03:58:32 INFO - Using env: {'DISPLAY': ':0',
03:58:32 INFO - 'HOME': '/home/cltbld',
03:58:32 INFO - 'LANG': 'en_US.UTF-8',
03:58:32 INFO - 'LANGUAGE': 'en_US:en',
03:58:32 INFO - 'LOGNAME': 'cltbld',
03:58:32 INFO - 'MAIL': '/var/mail/cltbld',
03:58:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1',
03:58:32 INFO - 'MOZ_NO_REMOTE': '1',
03:58:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript',
03:58:32 INFO - 'NO_EM_RESTART': '1',
03:58:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games',
03:58:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json',
03:58:32 INFO - 'PWD': '/builds/slave/test',
03:58:32 INFO - 'SHELL': '/bin/bash',
03:58:32 INFO - 'SHLVL': '1',
03:58:32 INFO - 'TERM': 'linux',
03:58:32 INFO - 'TMOUT': '86400',
03:58:32 INFO - 'USER': 'cltbld',
03:58:32 INFO - 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1480075084.201619-1935419765',
03:58:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn',
03:58:32 INFO - '_': '/tools/buildbot/bin/python'}
03:58:32 INFO - Ignoring indexes: https://pypi.python.org/simple/
03:58:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser
03:58:32 INFO - Running setup.py (path:/tmp/pip-J_4Cwk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser
03:58:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash
03:58:32 INFO - Running setup.py (path:/tmp/pip-mUvMpF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash
03:58:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug
03:58:32 INFO - Running setup.py (path:/tmp/pip-JTUZAy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug
03:58:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice
03:58:32 INFO - Running setup.py (path:/tmp/pip-lR64oY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice
03:58:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile
03:58:32 INFO - Running setup.py (path:/tmp/pip-duzQfP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile
03:58:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd
03:58:32 INFO - Running setup.py (path:/tmp/pip-0I1kry-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd
03:58:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo
03:58:32 INFO - Running setup.py (path:/tmp/pip-qTsyr2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo
03:58:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall
03:58:32 INFO - Running setup.py (path:/tmp/pip-Hp7Mjz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall
03:58:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak
03:58:32 INFO - Running setup.py (path:/tmp/pip-ldkLpG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak
03:58:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog
03:58:32 INFO - Running setup.py (path:/tmp/pip-TInISo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog
03:58:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork
03:58:33 INFO - Running setup.py (path:/tmp/pip-RpO5LZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork
03:58:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess
03:58:33 INFO - Running setup.py (path:/tmp/pip-nGmwov-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess
03:58:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile
03:58:33 INFO - Running setup.py (path:/tmp/pip-Yy22N6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile
03:58:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner
03:58:33 INFO - Running setup.py (path:/tmp/pip-vMNf_Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner
03:58:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot
03:58:33 INFO - Running setup.py (path:/tmp/pip-qJ414W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot
03:58:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest
03:58:33 INFO - Running setup.py (path:/tmp/pip-ovUlvL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest
03:58:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion
03:58:33 INFO - Running setup.py (path:/tmp/pip-W_SA60-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion
03:58:33 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion
03:58:33 INFO - Running setup.py install for manifestparser
03:58:33 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin
03:58:33 INFO - Running setup.py install for mozcrash
03:58:33 INFO - Running setup.py install for mozdebug
03:58:33 INFO - Running setup.py install for mozdevice
03:58:33 INFO - Installing sutini script to /builds/slave/test/build/venv/bin
03:58:33 INFO - Installing dm script to /builds/slave/test/build/venv/bin
03:58:33 INFO - Running setup.py install for mozfile
03:58:34 INFO - Running setup.py install for mozhttpd
03:58:34 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin
03:58:34 INFO - Running setup.py install for mozinfo
03:58:34 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin
03:58:34 INFO - Running setup.py install for mozInstall
03:58:34 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin
03:58:34 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin
03:58:34 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin
03:58:34 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin
03:58:34 INFO - Running setup.py install for mozleak
03:58:34 INFO - Running setup.py install for mozlog
03:58:34 INFO - Installing structlog script to /builds/slave/test/build/venv/bin
03:58:34 INFO - Running setup.py install for moznetwork
03:58:34 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin
03:58:34 INFO - Running setup.py install for mozprocess
03:58:34 INFO - Running setup.py install for mozprofile
03:58:34 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin
03:58:34 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin
03:58:34 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin
03:58:34 INFO - Running setup.py install for mozrunner
03:58:34 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin
03:58:35 INFO - Running setup.py install for mozscreenshot
03:58:35 INFO - Running setup.py install for moztest
03:58:35 INFO - Running setup.py install for mozversion
03:58:35 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin
03:58:35 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion
03:58:35 INFO - Cleaning up...
03:58:35 INFO - Return code: 0
03:58:35 INFO - Installing None into virtualenv /builds/slave/test/build/venv
03:58:35 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')]}
03:58:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org
03:58:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub
03:58:35 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')]}
03:58:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org
03:58:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub
03:58:35 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 0x7f17da3e0e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2991b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b2d130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bbbfc0>, '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 0x2bbcec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bbd350>, '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': 'db7e7c15f3ca076d53731445000001ba-1480075084.201619-1935419765', '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
03:58:35 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
03:58:35 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
03:58:35 INFO - Using env: {'DISPLAY': ':0',
03:58:35 INFO - 'HOME': '/home/cltbld',
03:58:35 INFO - 'LANG': 'en_US.UTF-8',
03:58:35 INFO - 'LANGUAGE': 'en_US:en',
03:58:35 INFO - 'LOGNAME': 'cltbld',
03:58:35 INFO - 'MAIL': '/var/mail/cltbld',
03:58:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1',
03:58:35 INFO - 'MOZ_NO_REMOTE': '1',
03:58:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript',
03:58:35 INFO - 'NO_EM_RESTART': '1',
03:58:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games',
03:58:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json',
03:58:35 INFO - 'PWD': '/builds/slave/test',
03:58:35 INFO - 'SHELL': '/bin/bash',
03:58:35 INFO - 'SHLVL': '1',
03:58:35 INFO - 'TERM': 'linux',
03:58:35 INFO - 'TMOUT': '86400',
03:58:35 INFO - 'USER': 'cltbld',
03:58:35 INFO - 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1480075084.201619-1935419765',
03:58:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn',
03:58:35 INFO - '_': '/tools/buildbot/bin/python'}
03:58:35 INFO - Ignoring indexes: https://pypi.python.org/simple/
03:58:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser
03:58:35 INFO - Running setup.py (path:/tmp/pip-1MZ4Y1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser
03:58:35 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))
03:58:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash
03:58:35 INFO - Running setup.py (path:/tmp/pip-VDOATX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash
03:58:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2))
03:58:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug
03:58:35 INFO - Running setup.py (path:/tmp/pip-BtPB3q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug
03:58:35 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))
03:58:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice
03:58:35 INFO - Running setup.py (path:/tmp/pip-Q8BAEA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice
03:58:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.49 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))
03:58:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile
03:58:35 INFO - Running setup.py (path:/tmp/pip-RNSFdZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile
03:58:35 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))
03:58:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd
03:58:35 INFO - Running setup.py (path:/tmp/pip-UI5cC4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd
03:58:35 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))
03:58:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo
03:58:35 INFO - Running setup.py (path:/tmp/pip-1lv7ww-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo
03:58:36 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))
03:58:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall
03:58:36 INFO - Running setup.py (path:/tmp/pip-CgG5oz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall
03:58:36 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))
03:58:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak
03:58:36 INFO - Running setup.py (path:/tmp/pip-APk2Gq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak
03:58:36 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))
03:58:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog
03:58:36 INFO - Running setup.py (path:/tmp/pip-4Ov7Sc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog
03:58:36 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))
03:58:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork
03:58:36 INFO - Running setup.py (path:/tmp/pip-fSUSZP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork
03:58:36 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))
03:58:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess
03:58:36 INFO - Running setup.py (path:/tmp/pip-cT6Z0f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess
03:58:36 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))
03:58:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile
03:58:36 INFO - Running setup.py (path:/tmp/pip-mtVAHv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile
03:58:36 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))
03:58:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner
03:58:36 INFO - Running setup.py (path:/tmp/pip-uGLdIv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner
03:58:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14))
03:58:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot
03:58:36 INFO - Running setup.py (path:/tmp/pip-NGyVGp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot
03:58:36 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))
03:58:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest
03:58:36 INFO - Running setup.py (path:/tmp/pip-gVfoQD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest
03:58:36 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))
03:58:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion
03:58:36 INFO - Running setup.py (path:/tmp/pip-jQgpY_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion
03:58:36 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))
03:58:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2))
03:58:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2))
03:58:36 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))
03:58:36 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.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4))
03:58:36 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.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4))
03:58:36 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10))
03:58:36 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
03:58:36 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
03:58:36 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
03:58:36 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
03:58:36 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
03:58:36 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
03:58:38 INFO - Downloading blessings-1.6.tar.gz
03:58:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings
03:58:38 INFO - Installing collected packages: blessings
03:58:38 INFO - Running setup.py install for blessings
03:58:38 INFO - Successfully installed blessings
03:58:38 INFO - Cleaning up...
03:58:38 INFO - Return code: 0
03:58:38 INFO - Done creating virtualenv /builds/slave/test/build/venv.
03:58:38 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze']
03:58:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze
03:58:39 INFO - Reading from file tmpfile_stdout
03:58:39 INFO - Current package versions:
03:58:39 INFO - argparse == 1.2.1
03:58:39 INFO - blessings == 1.6
03:58:39 INFO - blobuploader == 1.2.4
03:58:39 INFO - docopt == 0.6.1
03:58:39 INFO - functools32 == 3.2.3-2
03:58:39 INFO - jsonschema == 2.5.1
03:58:39 INFO - manifestparser == 1.1
03:58:39 INFO - mozInstall == 1.12
03:58:39 INFO - mozcrash == 1.0
03:58:39 INFO - mozdebug == 0.1
03:58:39 INFO - mozdevice == 0.49
03:58:39 INFO - mozfile == 1.2
03:58:39 INFO - mozhttpd == 0.7
03:58:39 INFO - mozinfo == 0.9
03:58:39 INFO - mozleak == 0.1
03:58:39 INFO - mozlog == 3.4
03:58:39 INFO - moznetwork == 0.27
03:58:39 INFO - mozprocess == 0.23
03:58:39 INFO - mozprofile == 0.28
03:58:39 INFO - mozrunner == 6.13
03:58:39 INFO - mozscreenshot == 0.1
03:58:39 INFO - mozsystemmonitor == 0.3
03:58:39 INFO - moztest == 0.7
03:58:39 INFO - mozversion == 1.4
03:58:39 INFO - psutil == 3.1.1
03:58:39 INFO - requests == 1.2.3
03:58:39 INFO - wsgiref == 0.1.2
03:58:39 INFO - Installing None into virtualenv /builds/slave/test/build/venv
03:58:39 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')]}
03:58:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org
03:58:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub
03:58:39 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')]}
03:58:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org
03:58:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub
03:58:39 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 0x7f17da3e0e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2991b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b2d130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bbbfc0>, '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 0x2bbcec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bbd350>, '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': 'db7e7c15f3ca076d53731445000001ba-1480075084.201619-1935419765', '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
03:58:39 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
03:58:39 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
03:58:39 INFO - Using env: {'DISPLAY': ':0',
03:58:39 INFO - 'HOME': '/home/cltbld',
03:58:39 INFO - 'LANG': 'en_US.UTF-8',
03:58:39 INFO - 'LANGUAGE': 'en_US:en',
03:58:39 INFO - 'LOGNAME': 'cltbld',
03:58:39 INFO - 'MAIL': '/var/mail/cltbld',
03:58:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1',
03:58:39 INFO - 'MOZ_NO_REMOTE': '1',
03:58:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript',
03:58:39 INFO - 'NO_EM_RESTART': '1',
03:58:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games',
03:58:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json',
03:58:39 INFO - 'PWD': '/builds/slave/test',
03:58:39 INFO - 'SHELL': '/bin/bash',
03:58:39 INFO - 'SHLVL': '1',
03:58:39 INFO - 'TERM': 'linux',
03:58:39 INFO - 'TMOUT': '86400',
03:58:39 INFO - 'USER': 'cltbld',
03:58:39 INFO - 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1480075084.201619-1935419765',
03:58:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn',
03:58:39 INFO - '_': '/tools/buildbot/bin/python'}
03:58:39 INFO - Ignoring indexes: https://pypi.python.org/simple/
03:58:39 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))
03:58:39 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))
03:58:39 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))
03:58:39 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))
03:58:39 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))
03:58:39 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))
03:58:39 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))
03:58:39 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))
03:58:39 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))
03:58:39 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))
03:58:39 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))
03:58:39 INFO - Cleaning up...
03:58:39 INFO - Return code: 0
03:58:39 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv
03:58:39 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')]}
03:58:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org
03:58:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub
03:58:39 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')]}
03:58:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org
03:58:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub
03:58:39 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 0x7f17da3e0e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2991b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b2d130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bbbfc0>, '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 0x2bbcec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bbd350>, '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': 'db7e7c15f3ca076d53731445000001ba-1480075084.201619-1935419765', '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
03:58:39 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
03:58:39 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
03:58:39 INFO - Using env: {'DISPLAY': ':0',
03:58:39 INFO - 'HOME': '/home/cltbld',
03:58:39 INFO - 'LANG': 'en_US.UTF-8',
03:58:39 INFO - 'LANGUAGE': 'en_US:en',
03:58:39 INFO - 'LOGNAME': 'cltbld',
03:58:39 INFO - 'MAIL': '/var/mail/cltbld',
03:58:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1',
03:58:39 INFO - 'MOZ_NO_REMOTE': '1',
03:58:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript',
03:58:39 INFO - 'NO_EM_RESTART': '1',
03:58:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games',
03:58:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json',
03:58:39 INFO - 'PWD': '/builds/slave/test',
03:58:39 INFO - 'SHELL': '/bin/bash',
03:58:39 INFO - 'SHLVL': '1',
03:58:39 INFO - 'TERM': 'linux',
03:58:39 INFO - 'TMOUT': '86400',
03:58:39 INFO - 'USER': 'cltbld',
03:58:39 INFO - 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1480075084.201619-1935419765',
03:58:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn',
03:58:39 INFO - '_': '/tools/buildbot/bin/python'}
03:58:39 INFO - Ignoring indexes: https://pypi.python.org/simple/
03:58:39 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages
03:58:39 INFO - Cleaning up...
03:58:39 INFO - Return code: 0
03:58:39 INFO - Running post-action listener: _resource_record_post_action
03:58:39 INFO - Running post-action listener: _start_resource_monitoring
03:58:39 INFO - Starting resource monitoring.
03:58:39 INFO - [mozharness: 2016-11-25 11:58:39.713554Z] Finished create-virtualenv step (success)
03:58:39 INFO - [mozharness: 2016-11-25 11:58:39.714084Z] Running install step.
03:58:39 INFO - Running pre-action listener: _resource_record_pre_action
03:58:39 INFO - Running main action method: install
03:58:39 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze']
03:58:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze
03:58:39 INFO - Reading from file tmpfile_stdout
03:58:39 INFO - Detecting whether we're running mozinstall >=1.0...
03:58:39 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h']
03:58:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h
03:58:40 INFO - Reading from file tmpfile_stdout
03:58:40 INFO - Output received:
03:58:40 INFO - Usage: mozinstall [options] installer
03:58:40 INFO - Options:
03:58:40 INFO - -h, --help show this help message and exit
03:58:40 INFO - -d DEST, --destination=DEST
03:58:40 INFO - Directory to install application into. [default:
03:58:40 INFO - "/builds/slave/test"]
03:58:40 INFO - --app=APP Application being installed. [default: firefox]
03:58:40 INFO - mkdir: /builds/slave/test/build/application
03:58:40 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application']
03:58:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application
03:58:56 INFO - Reading from file tmpfile_stdout
03:58:56 INFO - Output received:
03:58:56 INFO - /builds/slave/test/build/application/firefox/firefox
03:58:56 INFO - Running post-action listener: _resource_record_post_action
03:58:56 INFO - [mozharness: 2016-11-25 11:58:56.972725Z] Finished install step (success)
03:58:56 INFO - [mozharness: 2016-11-25 11:58:56.972999Z] Running run-tests step.
03:58:56 INFO - Running pre-action listener: _resource_record_pre_action
03:58:56 INFO - Running main action method: run_tests
03:58:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version']
03:58:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version
03:58:56 INFO - Python 2.7.3
03:58:56 INFO - Return code: 0
03:58:56 INFO - grabbing minidump binary from tooltool
03:58:56 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')]}
03:58:56 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 0x2bbbfc0>, '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 0x2bbcec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bbd350>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1
03:58:56 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
03:58:56 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
03:58:56 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
03:58:57 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache
03:58:57 INFO - Return code: 0
03:58:57 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755
03:58:57 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir
03:58:57 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir
03:58:57 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk
03:58:57 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir
03:58:57 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', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1480062604/firefox-53.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-049', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build
03:58:57 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 --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1480062604/firefox-53.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-049 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log
03:58:57 INFO - Using env: {'DISPLAY': ':0',
03:58:57 INFO - 'HOME': '/home/cltbld',
03:58:57 INFO - 'LANG': 'en_US.UTF-8',
03:58:57 INFO - 'LANGUAGE': 'en_US:en',
03:58:57 INFO - 'LOGNAME': 'cltbld',
03:58:57 INFO - 'MAIL': '/var/mail/cltbld',
03:58:57 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir',
03:58:57 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk',
03:58:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1',
03:58:57 INFO - 'MOZ_NO_REMOTE': '1',
03:58:57 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir',
03:58:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript',
03:58:57 INFO - 'NO_EM_RESTART': '1',
03:58:57 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games',
03:58:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json',
03:58:57 INFO - 'PWD': '/builds/slave/test',
03:58:57 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos',
03:58:57 INFO - 'SHELL': '/bin/bash',
03:58:57 INFO - 'SHLVL': '1',
03:58:57 INFO - 'TERM': 'linux',
03:58:57 INFO - 'TMOUT': '86400',
03:58:57 INFO - 'USER': 'cltbld',
03:58:57 INFO - 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1480075084.201619-1935419765',
03:58:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn',
03:58:57 INFO - '_': '/tools/buildbot/bin/python'}
03:58:57 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1480062604/firefox-53.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-049', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600
03:58:57 INFO - mozversion application_buildid: 20161125003004
03:58:57 INFO - mozversion application_changeset: 629069be312e79f7b50005adf6c68bf446f5064e
03:58:57 INFO - mozversion application_display_name: Nightly
03:58:57 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384}
03:58:57 INFO - mozversion application_name: Firefox
03:58:57 INFO - mozversion application_remotingname: firefox
03:58:57 INFO - mozversion application_repository: https://hg.mozilla.org/integration/mozilla-inbound
03:58:57 INFO - mozversion application_vendor: Mozilla
03:58:57 INFO - mozversion application_version: 53.0a1
03:58:57 INFO - mozversion platform_buildid: 20161125003004
03:58:57 INFO - mozversion platform_changeset: 629069be312e79f7b50005adf6c68bf446f5064e
03:58:57 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/mozilla-inbound
03:58:57 INFO - mozversion platform_version: 53.0a1
03:58:57 INFO - using testdate: 1480075137
03:58:57 INFO - actual date: 1480075137
03:58:57 INFO - starting webserver on 'localhost:41636'
03:58:57 INFO - SUITE-START | Running 2 tests
03:58:57 INFO - TEST-START | dromaeo_css
03:58:57 INFO - operating with platform_type : linux_
03:58:57 INFO - Initialising browser for dromaeo_css test...
03:58:57 INFO - TEST-INFO | started process 10893 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpBWRgra/profile http://localhost:41636/getInfo.html)
03:59:01 INFO - PROCESS | 10893 | __metrics Screen width/height:1600/1200
03:59:01 INFO - PROCESS | 10893 | colorDepth:24
03:59:01 INFO - PROCESS | 10893 | Browser inner width/height: 1024/697
03:59:01 INFO - PROCESS | 10893 | __metrics
03:59:02 INFO - PROCESS | 10893 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows"
03:59:02 INFO - PROCESS | 10893 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver]
03:59:02 INFO - PROCESS | 10893 | console.error: PushService:
03:59:02 INFO - PROCESS | 10893 | stateChangeProcessEnqueue: Error transitioning state
03:59:02 INFO - PROCESS | 10893 | UnknownError
03:59:03 INFO - TEST-INFO | 10893: exit 0
03:59:03 INFO - Browser initialized.
03:59:03 INFO - Running cycle 1/1 for dromaeo_css test...
03:59:03 INFO - TEST-INFO | started process 10978 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpBWRgra/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1)
03:59:15 INFO - PROCESS | 10978 | RSS: Main: 174137344
03:59:15 INFO - PROCESS | 10978 |
04:00:07 INFO - PROCESS | 10978 | 1480075207166 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]
04:02:17 INFO - PROCESS | 10978 | Cycle 1(1): loaded http://localhost:41636/tests/dromaeo/cssquery-dojo.html (next: http://localhost:41636/tests/dromaeo/cssquery-ext.html)
04:02:19 INFO - PROCESS | 10978 | RSS: Main: 321507328
04:02:19 INFO - PROCESS | 10978 |
04:05:22 INFO - PROCESS | 10978 | Cycle 1(1): loaded http://localhost:41636/tests/dromaeo/cssquery-ext.html (next: http://localhost:41636/tests/dromaeo/cssquery-jquery.html)
04:05:22 INFO - PROCESS | 10978 | RSS: Main: 271843328
04:05:22 INFO - PROCESS | 10978 |
04:08:24 INFO - PROCESS | 10978 | Cycle 1(1): loaded http://localhost:41636/tests/dromaeo/cssquery-jquery.html (next: http://localhost:41636/tests/dromaeo/cssquery-mootools.html)
04:08:25 INFO - PROCESS | 10978 | RSS: Main: 258805760
04:08:25 INFO - PROCESS | 10978 |
04:11:27 INFO - PROCESS | 10978 | Cycle 1(1): loaded http://localhost:41636/tests/dromaeo/cssquery-mootools.html (next: http://localhost:41636/tests/dromaeo/cssquery-prototype.html)
04:11:28 INFO - PROCESS | 10978 | RSS: Main: 236871680
04:11:28 INFO - PROCESS | 10978 |
04:14:31 INFO - PROCESS | 10978 | Cycle 1(1): loaded http://localhost:41636/tests/dromaeo/cssquery-prototype.html (next: http://localhost:41636/tests/dromaeo/cssquery-yui.html)
04:14:31 INFO - PROCESS | 10978 | RSS: Main: 214335488
04:14:31 INFO - PROCESS | 10978 |
04:17:34 INFO - PROCESS | 10978 | Cycle 1(1): loaded http://localhost:41636/tests/dromaeo/cssquery-yui.html (next: http://localhost:41636/tests/dromaeo/cssquery-dojo.html)
04:17:34 INFO - PROCESS | 10978 | RSS: Main: 311611392
04:17:34 INFO - PROCESS | 10978 |
04:17:34 INFO - PROCESS | 10978 | __start_tp_report
04:17:34 INFO - PROCESS | 10978 | _x_x_mozilla_page_load
04:17:34 INFO - PROCESS | 10978 | _x_x_mozilla_page_load_details
04:17:34 INFO - PROCESS | 10978 | |i|pagename|runs|
04:17:34 INFO - PROCESS | 10978 | |0;dojo.html;2961.1856739396667;3011.0966709986997;3017.758579313655;3040.9239769005785;3051.771117166213;5239.816606418776;5246.501582349675;5289.761960711768;5316.3354580677415;5352.063388906945;5338.492843179902;5348.91976620351;5402.8919421611545;5433.673979561229;5480.095784195603;4801.831935882245;4839.782209800567;4879.878003049935;4883.487233840449;4935.0376676548085;4888.633352498577;4932.630052746041;5017.598592112622;5042.974785126069;5068.163752980772;4778.593819525345;4953.23224900141;4953.653244272902;5007.974960125194;5028.245763135523;4822.63830212732;4840.177169881129;4848.296996935424;4894.2903279024695;4902.2156454967035;4827.937853672186;4838.564529192355;4840.75796210188;4842.975785121087;4885.828995985159;5322.308099946982;5377.139657654757;5390.380106287748;5401.648892821954;5404.486573775485;5575.916361254584;5621.662700237958;5624.072028115356;5667.263255776723;5759;5756.827295181151;5777.220075289824;5786.334571524244;5813.709314534299;5832.62087964281;5351.117065684158;5360.758765855546;5361.544268737123;5361.651492652965;5365.302510673627;5618.073017951992;5624.578156638187;5672.262605861294;5866.911996320058;5874.500667443315;5543.944560554342;5546.4453554644215;5547.528460080938;5548.750306236229;5551.639143455663;5562.86092847674;5615.989121958087;5620.241267428844;5717.485426311652;5749.597528172988;5817.156512305692;5844.736986835603;5857.648541087548;5861.6189947653265;5866.1494083357675;5810.070388737866;5825.650460972355;5828.59199856006;5829.47534721877;5874.647521148745;4247.87256382309;4418;4430.246858034142;4431.623312018514;4469.9776501117285;3838.3858582626644;3843.6540711336115;3848.461215429842;3869.6710779583486;3872.1674839909556;5422.972885135549;5442.619016668875;5445.754941027584;5447.237386765856;5482.396936337;5771.220885180531;5771.711414429262;5784.132380143013;5785.681787501644;5787.189793428924;5233.738313084331;5289.68261904287;5397.298351214396;5426.375966763794;5431.103867861759;5008.574271186917;5016.799328026911;5026.271190677405;5036.823711170092;5061.848144555669;5959.553033522417;5963.463288304073;5963.79126730571;5971.164037034731;5973.37279585646;5597.916031259616;5657.717114144194;5667.5465962722055;5815.563832712648;5823.970880145572;5744.569157313134;5778.855528611818;5786.276715410574;5879.764809407576;5905.202797622266;5548.55611551083;5570.944290557042;5574.804881829116;5579.2746942897165;5585.882823435248;5615.550755939434;5660.066089095253;5681.0910254359105;5683.687397193194;5694.572907032072;5479.890402192013;5512.200730894078;5521.889562208653;5583.776648933997;5606.383297837317;5542.0855558832345;5547.611667183259;5554.222408862682;5565.471280228372;5607.41122182165;5508.20131080999;5513.8345849624575;5517.531009864207;5522.392536821027;5537.723113844372;5413.079776437936;5494.36814766291;5559.416261292506;5567.972160139173;5568.6658800472105;5510.145927381102;5581.386047534849;5606.271184745957;5619.269494965792;5620.690862002629
04:17:34 INFO - PROCESS | 10978 | |1;ext.html;541.5842735838083;587.7972099625629;595.940405959404;623.2614351992886;642.306309186079;32890.50664240035;33709.15727106821;42583.36124958128;43428;43433;40673.38989915154;45004.324935125915;45069.549304506945;45159;45182.09635807282;7930.286274235317;8412.495250284986;8556.486610803371;8560.357973152008;8564.143585641448;7891.802704932394;8123.1470695577;8134.186581341878;10188.59245630174;10442.060214580686;10517.158627309835;10565.471726413649;10570.312929659547;10571.577136914553;10573.894261057407;10397.532111055021;10423.374597524173;10456.68629941103;10458.424786636731;10461.424621645845;10334;10346.172306215485;10374.533146008447;10404.635837745718;10405.21960852939;41785.373219401736;41970.790146049076;42165.367519487234;42324.576754232374;42363.788181058895;3466.9826650866585;3604.855805767766;3751.362268414376;3764.9623503764888;3796.6393192646656;30183.849080754455;30464.69535304641;30626.84686576553;30732.69267307321;32363;4116.918503839484;4288.442502474658;4314.525402205755;4382.671299652507;4411.139827733593;339213;341370;342587;343460;343682;57237.71381143151;57424.71287643535;57425.42574574201;57460.425395746344;57849;60361;60422.69788651029;60440.697796510736;60443.09335359973;60492.09261861075;16666.33334666624;17008.659826803396;17015.744763828552;17024.14879256032;17026.404075857532;12069.939650301869;13181.406836692371;13223.801642975362;13253.337333133304;13255.933720331337;14593.708125837424;16130.354785808437;16210.43263485796;16536.586585335463;16588;5972.880542389128;5989.131575921467;6010.4891084258325;6010.519158467312;6196.752129914753;889.3863234368265;973.4889183178747;983.8868530118984;987.9308448408686;996.9052939970691;29261.7073829259;31512.527312090337;31617.367652647277;31734.365312693615;32490.83754581212;1043.7129789308;1059.5391004912888;1083.2742062817774;1101.6419663609358;1117.9664610061711;15925.920370398075;16664.916675416545;16734.83265167333;16750.497485075466;16778.412755553498;479204;480395;481558;482153;532346;52595.21107183395;55424;56673;56802.295931122135;62597;1287.658770425838;1334.19281334793;1336.672515233774;1347.2455424962052;1350.547566565192;30241.848790755907;32498.837505813266;32568.837155815017;32596.762420885134;32959.50560741543;50682;51193.744031281094;51240.48759512357;51259.487405125474;51269.48730512647;409200;411749;412610;413525;413776;39782;40451.797741011105;41292.1741565161;41426.171476570904;41440.3783943235;46722.29916551187;47696.523034769205;47780.522194779;47814.28278575894;48496.27255591098;39603.405948911364;40166.57334826414;40754.59245407508;40893;42099;39547.60452395439;40042.59957400505;41388.37917431301;41473.37789933093;42176.57823421727;38523.80738096291;39502.525540425726;39593.80203098966;39877.60122398739;40100.39849402203;34020.65979340274;36225.60411824911;36502.4524632136;37040.62959370372;37174.25651487009;26858;27187.59218611762;27325.316867078483;27409.862950685118;27554.311142221606
04:17:34 INFO - PROCESS | 10978 | |2;jquery.html;363.60367199752267;384.12611309271404;389.73692757388767;398.7268720926166;406.82303198108826;14068;15687;18586.81413185868;18716.251349946004;18784.15471303791;17562.385316513926;17632;17888.910555447204;17975.910120449378;17989.910050449762;4077.3068578341754;5374.7043912584695;5604.495595396414;5604.971975140119;5606.467385598362;4199.874003779892;5957.910631340534;6194.845128871769;6224.8443788905415;6340.809775706736;5956.4043595640305;6112.602680825755;6312.053192021188;6324.209473815773;6331.2085989251345;6193.2877719062435;6220.657863817488;6225.3463386344465;6228.5017198624455;6235.345288744685;5263.210518422229;5402.432744561843;5423.972880135613;5451.618386712932;5470.9452905470835;20136.697949530768;20896.164153433845;21039.8948005259;21744.673829892563;21902.12391504338;2230.944226394337;2239.361781892153;2316.3166865774638;2365.8817059146972;2806.775457963358;9290.303227257915;9564.90435095647;9629.903700963041;9970.20238380935;10175.389476631426;1789.5252855862514;1866.608012317415;1866.7853196882397;1883.8681292309543;1901.8668693191482;73845.26154738438;80903;82551.26833511605;82613.58693206495;84408.57795710982;9202.401843880127;9478.241740660731;9724.513774311397;9737.26970477217;9762.121409073217;12881.227126372447;12909.419076141596;12936.706329366987;12954.093213474966;12956.481740730454;7303.393253484225;7571.3942884569105;7632.809689411254;7801.102873169658;7822.921770782219;7479.588622625699;7524.473286869976;7598.962005189938;7685.692572297045;7776.494527855672;4059.512858456945;4073.7759423232005;4115.36211887158;4185.393117997874;4221.472315960505;1845.2526726675717;1957.9021048947495;2041.142560270147;2041.3365656161807;2049;847.6355167278007;926.7127190570944;957.4877440569262;967.2793768642406;1062.9521671524644;18255.634887302178;18953.336633217772;18996.43010709681;19026.42920712381;19306.32427865018;946.1248345280588;965.8020105878278;982.3761911186448;1013.8884722680499;1033.7260625934134;10035.197184225244;10329.586816527404;10403.84394234087;10430.478476076165;10559.524821383056;445320;445540;446045;459568;462009;89171.55414222888;89355.55322223347;89464;89733.55133224292;91274.54362728276;955.8805149356191;985.3693636072919;1005.939643621385;1009.6314845081492;1012.0688966151158;15806.9209653951;16294.918525407296;16319.59201019984;16355.918220408821;16730.163491825602;38630.80684596559;39854.80072599618;40948.79525602353;42019.36970945377;42309.788451057546;55188.72405638107;55555.722221388634;56883.43116568781;56968;60937;8120.066192387715;8363.581820908808;8446.577671116296;8536.231739143506;8702.347323950855;10095.394276343442;13094.345282736016;13123.475060997453;13276.86723132795;13291;5739.397363276796;6170.660613666291;10764.192685548458;11217.439128043401;11616.050542815483;11370.374629395463;11420.428978551205;11497.885021149681;11653.825192621947;11686.88313116892;11240.875912408694;11447.885521144683;11577.536898524302;11611.187216894736;11822.349770762346;8443.366747494085;8498.277646400125;8560.272376848037;8612.354073444392;8622.353323500636;9041.773955650899;10926.672199834018;10945.398003109905;11006.889931100906;11278.943605281922
04:17:34 INFO - PROCESS | 10978 | |3;mootools.html;1287.903407244457;1415.320646089877;1434.548117343037;1531.2573401900077;1725.6721222967635;7105.111861017373;7717.4597778155485;7927.563983980879;7982.52104873708;8170.387220958422;8003.719869804558;8060.153683863198;8062.7581172564915;8072.919270807291;8108.675652973889;1865.7947625761155;2209.856359336646;2243.248511748566;2247.1236217875044;2248.325502349297;1978.8416926645905;2182.967255491161;2237.7874101960288;2238.160689741347;2258.796708296253;2202.3392982105306;2229.554089182162;2229.9665505017438;2237.19460994042;2241.551689662066;2150.129197674944;2166.9566608667897;2168.8698678079286;2169.22992337721;2170.1644866726265;2177.5318306564163;2182.9890850545803;2183.759786423492;2213.247495851418;2219.7891200335944;8060.193980601893;8116.6347514361405;8118.63466144019;8125;8140.267375936135;4776.976115119437;4860.076585448789;4900.607951363882;4900.901981960376;4911.8772030699165;3065.20304720772;3196.8081915084936;3283.40898638245;3326.8170250636203;3334.9666503334897;1013.6300250408622;1087.7715679707271;1106.9059129973962;1108.501174471483;1150.8618965724168;10673.039426451656;10674.9466252669;10682.786344273149;10685.145188384988;10766.784664306748;4195.853145139906;4257.787110644517;4299.312110062375;4337.848175313912;4394.318880573516;9248.075192480697;9252.444853308823;9275.489848058422;9283.58223879927;9288.674896378594;4865.756712164449;4866.075445665312;4867.951320486821;4875.098106850244;4876.073546026244;4357.629601483909;4408.757518336458;4465.12929978651;4469.128519938646;4542.11428771393;3667.211549516867;3721.288207424561;3729.869454569077;3760.172761992357;3828.7511311764647;1197.550918405598;1206.5294535131306;1207.655818091857;1208.2629595946466;1215.8358621586149;772.7944406725526;791.8733002719653;871.1462766488877;921.2445794448622;980.9509524523745;5499.780008799603;5566.387697353288;5649.68926709035;5707.543396528268;5740.167675687002;918.2975024106564;985.4383001689112;991.0386924683046;1029.9639512617023;1064.797688439194;3752.249550089993;3792.2605092007348;3825.5409350877517;3832.693384529287;3860.845566177378;9659.613615455444;9827.459489728133;9903.55434005457;9945.751356216153;9957.751056223653;9736.172425343924;9769.804603907882;9808.21534277256;9855.35940163887;9898.257630677728;7416.480846340704;7432;7446.255374462618;7473.252674732592;7582;5481.561475081904;5501;5588.329400471969;5623.775048998158;5750.913736294043;9020.323475739215;9049.230815380766;9146.634134634805;9172.44965302084;9213.86179207299;8097.1497992712275;8509.74470765878;8897.154770296811;8920.73237802867;9055.27557795388;6605.636689981905;6816.625085620339;6941.097657304518;7011.404030657452;7160.711072007089;7713.2286771322415;7735.922640773745;7794.688212471665;7796.4932279401655;7872.803179920548;6944.375006249462;7048.436125110082;7049.929500705132;7088.503804733619;7120.359167674934;6923.826904327432;6926.203486599105;6946.16646002483;6946.79159625212;6987.895181572178;6336.271328797247;6360.045993101072;6364.6181229126405;6369.8726025480155;6372.534317106999;4732.52674732524;4748.620110391092;4805.8077676892535;4876.902461950812;4985.975070124626;4657.883552911204;4739.857804265877;4880.877978050435;4919.286703428054;4957.851264462072
04:17:34 INFO - PROCESS | 10978 | |4;prototype.html;314.20662826363446;323.345225917517;323.4808132946621;327.2081562618463;332.237514903297;5130.692158470494;5254.7635356408955;5281.551068159211;5317.787288508455;5320.334958130234;5069.034614750375;5235.528802407783;5235.764390602422;5249.527542521172;5278.234655974881;4154.792260386984;4167.208230436223;4169.833206671745;4171.476256864598;4186.204621121992;4081.755094694313;4130.772807495587;4194.937075943863;4212.283911734997;4232.915341693164;4065.166640838636;4100.077482566414;4107.815148318333;4119.382092686106;4136.565660605638;4105.548389677133;4115.320972039624;4139.77231252281;4141.461609990697;4147.336426171828;3693.169036966688;3700.4449332600057;3709.7588656737494;3715.8327875245677;3756.1924186299802;5047.747612619354;5105.0345616937375;5111.239930437559;5137.743112844343;5172.61205409592;4708.411448568929;4718.528147185289;4718.669693121483;4729.574338309569;4773.856784296477;5492.038893193715;5519.31008623922;5532.225488431623;5542.140968149903;5562.9443705562835;3753.8310776014873;3933.5476420211758;3966.365381538969;3968.3650615901315;3987.581303963071;5693.857653558694;5721.682718499014;5732.226149469851;5741.282339707536;5746.023176060038;4063.963689259279;4077.225327187825;4108.404281379183;4111.033907031845;4123.793810309473;3971.205758848242;4084.550699423061;4109.828698820881;4121.62905338521;4170.394398156732;4636.86089417318;4660.743659098782;4665.2768820832825;4682.204025315705;4704.200285951397;5527.010276300529;5534.4742249486235;5537.529310008614;5545.251391062155;5563.414426888317;1285.849164997341;1286.8289856230786;1368.548379034916;1368.6783605852618;1376.6902446949357;919.0120620333036;948.4783369146942;952.1002652493328;954.7660823098386;955.7897262602216;5132.485916654596;5143.3570803649545;5152.278680984665;5154.5103215194495;5169.741512924339;5358.33020872391;5418.647787893774;5460.672359658433;5469.835904922858;5493.285872836505;4905.9264111038365;5113.616478764107;5125.589952803767;5144.897102057937;5191.195364718475;2869.167941297042;2889.219910624162;2896.160113567084;2899.2606885244127;2909.738123568889;5603.831885043455;5615.9157612635845;5619.988402087663;5628.887422251532;5655.971720141373;5343.358796944314;5365.787856532681;5414.296141501658;5420.620556561003;5569.526590239794;5550.584600926738;5576.804811831566;5581.302337207849;5605.32736071674;5616.915746263891;5231.895362092813;5409.729513524387;5439.3200849893765;5488.4237155098135;5494.587905907153;5335.919961200508;5339.359276886798;5344.545713614386;5362.410134885237;5390.595705322038;5584.609077364546;5595.608307418442;5601.487598348342;5608.298962629671;5632.831015069554;3721.8834349695526;3918.451416801707;3939.92120157601;3941.975086477479;3952.7628342299554;5445.700486473282;5454.918176227439;5462.726863656721;5463.754131064032;5467.343918729778;5485.780568777204;5528.585356098389;5639.154126881001;5647.1529270609735;5665.405132461032;5548.195511650869;5578.581606379456;5580;5598.300212473441;5609.775608975759;5298.920516192183;5483.698396588226;5535.944640553704;5546.4453554644215;5563.388027316911;5574.108142697149;5591.412901645269;5593.720313984203;5597.15845793394;5617.634853734494;5464.562834973113;5511.366192887869;5551.7779288828;5582.860428489158;5603.691796951207
04:17:34 INFO - PROCESS | 10978 | |5;yui.html;760.3878877503607;760.7755712064941;764.5221736414742;789.3172405868925;817.8895849060377;13739.862601373983;14679;14686.339114739836;14701.55895323142;14790.334434950426;13277;13427.865721342809;13482.730345393085;13485.460581576725;13488.325583720823;650.4471199480428;668.3917634952195;747.4319517166965;759.4987308376473;774.3534148985603;777.0403551613753;777.2538363171362;779.6491578789539;779.851828152652;780.0171783552736;836.2014276366056;837.1879277101202;837.4514692876145;837.5100566168799;837.5142417397894;690.8169335126196;709.9467539934526;711.459290938885;714.1501613080418;828.1056459024239;586.7183751799117;599.337731806352;603.9245094363205;605.6093819486407;605.7970579855754;12699.111062225647;12775.425105870258;12796.872031279661;12826.61520154397;12919.289439080847;13126.671833204151;13185.736285274337;13312.400941957636;13320.134191277535;13391.933040334736;11586.246893951866;11631.27364942442;11850.644480665595;11999.760004799942;12356.62930112098;4196.244675958326;4218.240716670998;4271.380649805761;4435.401220835178;4461.776911154429;55431.44568554343;60392.39607603912;60418.39581604172;60809;61315;9944.204463642891;9962.302638815214;10321.84517232242;10419.791604167875;10671.35971841692;16174.029558226308;16176.029438233743;16211.756823647655;16225.18874056316;16225.59436014109;7736.187700291388;7771.72798952034;7997;8003.199680032067;8221.588920553948;4238.406623072772;4293.291606884892;4386.0789234261165;4412.691111622155;4417.160739459492;3303.768736188492;3396.745244106702;3401.659834016628;3405.1316914186723;3414.709749671306;598.4524160393191;607.7781609712512;621.4158690830604;629.7827249598881;630.1776182082426;668.9632070236087;671.7480944645757;680.3026897430174;717.2540557819913;722.151472020374;8742;8958.731238062868;9070.365074444726;9107.726768196964;9212.170904618617;585.3882692586258;636.9808905732835;699.4963626189136;728.070959603492;729.7993051910767;4363.585459381354;4537.342085397665;4682.41469816273;4728.243481043017;4828.03439312139;52804.97295903957;71142.2885771146;87192.56403718068;88915.55542222247;89698.55150724205;61308.69345653243;68148.6592567034;68800;69066.65466672635;77070.22929770742;42182.36726449044;43317;61135.694321528106;61558.076628850606;62952.685236573525;9200.585973631336;9203.539823008688;9512.619495220391;9556;9569.090936361035;44655.33017004682;44683;45040;45045;45113;52256;58130.4186958125;58147;60773.69613151906;62203.602513661885;10580;10583.894161058599;10838.132949363875;10884.891151088388;11070.225084244026;13054.874608698303;13104.737905242033;13140.934295328461;13532.616845788552;13792.448302068206;11535.192536522698;11851.274206932281;11877.58428455;12052.337121458404;12207;12206.938965305117;12740.74518509606;12809.487620495076;12818.294993775431;12953.481860725466;11523.250988685708;11800.76398472043;11930.582429614922;12004.339761313211;12615.621531354074;9779.315447918578;10717.839232411365;11015.504302306575;11184.328940263611;11382.317060976036;10066.496675166067;10388.37669739818;10451;10917.836232456679;11013.83479247796
04:17:34 INFO - PROCESS | 10978 | __end_tp_report
04:17:34 INFO - PROCESS | 10978 | __start_cc_report
04:17:34 INFO - PROCESS | 10978 | _x_x_mozilla_cycle_collect,1405
04:17:34 INFO - PROCESS | 10978 | __end_cc_report
04:17:34 INFO - PROCESS | 10978 | __startTimestamp1480076254851__endTimestamp
04:17:34 INFO - PROCESS | 10978 |
04:17:34 INFO - PROCESS | 10978 | ------- Summary: start -------
04:17:34 INFO - PROCESS | 10978 | Number of tests: 6
04:17:34 INFO - PROCESS | 10978 |
04:17:34 INFO - PROCESS | 10978 | [#0] dojo.html Cycles:165 Average:5313.69 Median:5517.53 stddev:606.55 (11.0%) stddev-sans-first:579.66
04:17:34 INFO - PROCESS | 10978 | Values: 2961.2 3011.1 3017.8 3040.9 3051.8 5239.8 5246.5 5289.8 5316.3 5352.1 5338.5 5348.9 5402.9 5433.7 5480.1 4801.8 4839.8 4879.9 4883.5 4935.0 4888.6 4932.6 5017.6 5043.0 5068.2 4778.6 4953.2 4953.7 5008.0 5028.2 4822.6 4840.2 4848.3 4894.3 4902.2 4827.9 4838.6 4840.8 4843.0 4885.8 5322.3 5377.1 5390.4 5401.6 5404.5 5575.9 5621.7 5624.1 5667.3 5759.0 5756.8 5777.2 5786.3 5813.7 5832.6 5351.1 5360.8 5361.5 5361.7 5365.3 5618.1 5624.6 5672.3 5866.9 5874.5 5543.9 5546.4 5547.5 5548.8 5551.6 5562.9 5616.0 5620.2 5717.5 5749.6 5817.2 5844.7 5857.6 5861.6 5866.1 5810.1 5825.7 5828.6 5829.5 5874.6 4247.9 4418.0 4430.2 4431.6 4470.0 3838.4 3843.7 3848.5 3869.7 3872.2 5423.0 5442.6 5445.8 5447.2 5482.4 5771.2 5771.7 5784.1 5785.7 5787.2 5233.7 5289.7 5397.3 5426.4 5431.1 5008.6 5016.8 5026.3 5036.8 5061.8 5959.6 5963.5 5963.8 5971.2 5973.4 5597.9 5657.7 5667.5 5815.6 5824.0 5744.6 5778.9 5786.3 5879.8 5905.2 5548.6 5570.9 5574.8 5579.3 5585.9 5615.6 5660.1 5681.1 5683.7 5694.6 5479.9 5512.2 5521.9 5583.8 5606.4 5542.1 5547.6 5554.2 5565.5 5607.4 5508.2 5513.8 5517.5 5522.4 5537.7 5413.1 5494.4 5559.4 5568.0 5568.7 5510.1 5581.4 5606.3 5619.3 5620.7
04:17:34 INFO - PROCESS | 10978 |
04:17:34 INFO - PROCESS | 10978 | [#1] ext.html Cycles:180 Average:58155.16 Median:39960.10 stddev:110899.55 (277.5%) stddev-sans-first:111126.29
04:17:34 INFO - PROCESS | 10978 | Values: 541.6 587.8 595.9 623.3 642.3 32890.5 33709.2 42583.4 43428.0 43433.0 40673.4 45004.3 45069.5 45159.0 45182.1 7930.3 8412.5 8556.5 8560.4 8564.1 7891.8 8123.1 8134.2 10188.6 10442.1 10517.2 10565.5 10570.3 10571.6 10573.9 10397.5 10423.4 10456.7 10458.4 10461.4 10334.0 10346.2 10374.5 10404.6 10405.2 41785.4 41970.8 42165.4 42324.6 42363.8 3467.0 3604.9 3751.4 3765.0 3796.6 30183.8 30464.7 30626.8 30732.7 32363.0 4116.9 4288.4 4314.5 4382.7 4411.1 339213.0 341370.0 342587.0 343460.0 343682.0 57237.7 57424.7 57425.4 57460.4 57849.0 60361.0 60422.7 60440.7 60443.1 60492.1 16666.3 17008.7 17015.7 17024.1 17026.4 12069.9 13181.4 13223.8 13253.3 13255.9 14593.7 16130.4 16210.4 16536.6 16588.0 5972.9 5989.1 6010.5 6010.5 6196.8 889.4 973.5 983.9 987.9 996.9 29261.7 31512.5 31617.4 31734.4 32490.8 1043.7 1059.5 1083.3 1101.6 1118.0 15925.9 16664.9 16734.8 16750.5 16778.4 479204.0 480395.0 481558.0 482153.0 532346.0 52595.2 55424.0 56673.0 56802.3 62597.0 1287.7 1334.2 1336.7 1347.2 1350.5 30241.8 32498.8 32568.8 32596.8 32959.5 50682.0 51193.7 51240.5 51259.5 51269.5 409200.0 411749.0 412610.0 413525.0 413776.0 39782.0 40451.8 41292.2 41426.2 41440.4 46722.3 47696.5 47780.5 47814.3 48496.3 39603.4 40166.6 40754.6 40893.0 42099.0 39547.6 40042.6 41388.4 41473.4 42176.6 38523.8 39502.5 39593.8 39877.6 40100.4 34020.7 36225.6 36502.5 37040.6 37174.3 26858.0 27187.6 27325.3 27409.9 27554.3
04:17:34 INFO - PROCESS | 10978 |
04:17:34 INFO - PROCESS | 10978 | [#2] jquery.html Cycles:180 Average:27341.78 Median:4150.38 stddev:74735.43 (1800.7%) stddev-sans-first:74917.63
04:17:34 INFO - PROCESS | 10978 | Values: 363.6 384.1 389.7 398.7 406.8 14068.0 15687.0 18586.8 18716.3 18784.2 17562.4 17632.0 17888.9 17975.9 17989.9 4077.3 5374.7 5604.5 5605.0 5606.5 4199.9 5957.9 6194.8 6224.8 6340.8 5956.4 6112.6 6312.1 6324.2 6331.2 6193.3 6220.7 6225.3 6228.5 6235.3 5263.2 5402.4 5424.0 5451.6 5470.9 20136.7 20896.2 21039.9 21744.7 21902.1 2230.9 2239.4 2316.3 2365.9 2806.8 9290.3 9564.9 9629.9 9970.2 10175.4 1789.5 1866.6 1866.8 1883.9 1901.9 73845.3 80903.0 82551.3 82613.6 84408.6 9202.4 9478.2 9724.5 9737.3 9762.1 12881.2 12909.4 12936.7 12954.1 12956.5 7303.4 7571.4 7632.8 7801.1 7822.9 7479.6 7524.5 7599.0 7685.7 7776.5 4059.5 4073.8 4115.4 4185.4 4221.5 1845.3 1957.9 2041.1 2041.3 2049.0 847.6 926.7 957.5 967.3 1063.0 18255.6 18953.3 18996.4 19026.4 19306.3 946.1 965.8 982.4 1013.9 1033.7 10035.2 10329.6 10403.8 10430.5 10559.5 445320.0 445540.0 446045.0 459568.0 462009.0 89171.6 89355.6 89464.0 89733.6 91274.5 955.9 985.4 1005.9 1009.6 1012.1 15806.9 16294.9 16319.6 16355.9 16730.2 38630.8 39854.8 40948.8 42019.4 42309.8 55188.7 55555.7 56883.4 56968.0 60937.0 8120.1 8363.6 8446.6 8536.2 8702.3 10095.4 13094.3 13123.5 13276.9 13291.0 5739.4 6170.7 10764.2 11217.4 11616.1 11370.4 11420.4 11497.9 11653.8 11686.9 11240.9 11447.9 11577.5 11611.2 11822.3 8443.4 8498.3 8560.3 8612.4 8622.4 9041.8 10926.7 10945.4 11006.9 11278.9
04:17:34 INFO - PROCESS | 10978 |
04:17:34 INFO - PROCESS | 10978 | [#3] mootools.html Cycles:180 Average:5296.30 Median:4971.91 stddev:2904.25 (58.4%) stddev-sans-first:2896.77
04:17:34 INFO - PROCESS | 10978 | Values: 1287.9 1415.3 1434.5 1531.3 1725.7 7105.1 7717.5 7927.6 7982.5 8170.4 8003.7 8060.2 8062.8 8072.9 8108.7 1865.8 2209.9 2243.2 2247.1 2248.3 1978.8 2183.0 2237.8 2238.2 2258.8 2202.3 2229.6 2230.0 2237.2 2241.6 2150.1 2167.0 2168.9 2169.2 2170.2 2177.5 2183.0 2183.8 2213.2 2219.8 8060.2 8116.6 8118.6 8125.0 8140.3 4777.0 4860.1 4900.6 4900.9 4911.9 3065.2 3196.8 3283.4 3326.8 3335.0 1013.6 1087.8 1106.9 1108.5 1150.9 10673.0 10674.9 10682.8 10685.1 10766.8 4195.9 4257.8 4299.3 4337.8 4394.3 9248.1 9252.4 9275.5 9283.6 9288.7 4865.8 4866.1 4868.0 4875.1 4876.1 4357.6 4408.8 4465.1 4469.1 4542.1 3667.2 3721.3 3729.9 3760.2 3828.8 1197.6 1206.5 1207.7 1208.3 1215.8 772.8 791.9 871.1 921.2 981.0 5499.8 5566.4 5649.7 5707.5 5740.2 918.3 985.4 991.0 1030.0 1064.8 3752.2 3792.3 3825.5 3832.7 3860.8 9659.6 9827.5 9903.6 9945.8 9957.8 9736.2 9769.8 9808.2 9855.4 9898.3 7416.5 7432.0 7446.3 7473.3 7582.0 5481.6 5501.0 5588.3 5623.8 5750.9 9020.3 9049.2 9146.6 9172.4 9213.9 8097.1 8509.7 8897.2 8920.7 9055.3 6605.6 6816.6 6941.1 7011.4 7160.7 7713.2 7735.9 7794.7 7796.5 7872.8 6944.4 7048.4 7049.9 7088.5 7120.4 6923.8 6926.2 6946.2 6946.8 6987.9 6336.3 6360.0 6364.6 6369.9 6372.5 4732.5 4748.6 4805.8 4876.9 4986.0 4657.9 4739.9 4880.9 4919.3 4957.9
04:17:34 INFO - PROCESS | 10978 |
04:17:34 INFO - PROCESS | 10978 | [#4] prototype.html Cycles:180 Average:4598.20 Median:5252.15 stddev:1337.44 (25.5%) stddev-sans-first:1301.97
04:17:34 INFO - PROCESS | 10978 | Values: 314.2 323.3 323.5 327.2 332.2 5130.7 5254.8 5281.6 5317.8 5320.3 5069.0 5235.5 5235.8 5249.5 5278.2 4154.8 4167.2 4169.8 4171.5 4186.2 4081.8 4130.8 4194.9 4212.3 4232.9 4065.2 4100.1 4107.8 4119.4 4136.6 4105.5 4115.3 4139.8 4141.5 4147.3 3693.2 3700.4 3709.8 3715.8 3756.2 5047.7 5105.0 5111.2 5137.7 5172.6 4708.4 4718.5 4718.7 4729.6 4773.9 5492.0 5519.3 5532.2 5542.1 5562.9 3753.8 3933.5 3966.4 3968.4 3987.6 5693.9 5721.7 5732.2 5741.3 5746.0 4064.0 4077.2 4108.4 4111.0 4123.8 3971.2 4084.6 4109.8 4121.6 4170.4 4636.9 4660.7 4665.3 4682.2 4704.2 5527.0 5534.5 5537.5 5545.3 5563.4 1285.8 1286.8 1368.5 1368.7 1376.7 919.0 948.5 952.1 954.8 955.8 5132.5 5143.4 5152.3 5154.5 5169.7 5358.3 5418.6 5460.7 5469.8 5493.3 4905.9 5113.6 5125.6 5144.9 5191.2 2869.2 2889.2 2896.2 2899.3 2909.7 5603.8 5615.9 5620.0 5628.9 5656.0 5343.4 5365.8 5414.3 5420.6 5569.5 5550.6 5576.8 5581.3 5605.3 5616.9 5231.9 5409.7 5439.3 5488.4 5494.6 5335.9 5339.4 5344.5 5362.4 5390.6 5584.6 5595.6 5601.5 5608.3 5632.8 3721.9 3918.5 3939.9 3942.0 3952.8 5445.7 5454.9 5462.7 5463.8 5467.3 5485.8 5528.6 5639.2 5647.2 5665.4 5548.2 5578.6 5580.0 5598.3 5609.8 5298.9 5483.7 5535.9 5546.4 5563.4 5574.1 5591.4 5593.7 5597.2 5617.6 5464.6 5511.4 5551.8 5582.9 5603.7
04:17:34 INFO - PROCESS | 10978 |
04:17:34 INFO - PROCESS | 10978 | [#5] yui.html Cycles:180 Average:16330.08 Median:4609.88 stddev:21134.61 (458.5%) stddev-sans-first:21161.56
04:17:34 INFO - PROCESS | 10978 | Values: 760.4 760.8 764.5 789.3 817.9 13739.9 14679.0 14686.3 14701.6 14790.3 13277.0 13427.9 13482.7 13485.5 13488.3 650.4 668.4 747.4 759.5 774.4 777.0 777.3 779.6 779.9 780.0 836.2 837.2 837.5 837.5 837.5 690.8 709.9 711.5 714.2 828.1 586.7 599.3 603.9 605.6 605.8 12699.1 12775.4 12796.9 12826.6 12919.3 13126.7 13185.7 13312.4 13320.1 13391.9 11586.2 11631.3 11850.6 11999.8 12356.6 4196.2 4218.2 4271.4 4435.4 4461.8 55431.4 60392.4 60418.4 60809.0 61315.0 9944.2 9962.3 10321.8 10419.8 10671.4 16174.0 16176.0 16211.8 16225.2 16225.6 7736.2 7771.7 7997.0 8003.2 8221.6 4238.4 4293.3 4386.1 4412.7 4417.2 3303.8 3396.7 3401.7 3405.1 3414.7 598.5 607.8 621.4 629.8 630.2 669.0 671.7 680.3 717.3 722.2 8742.0 8958.7 9070.4 9107.7 9212.2 585.4 637.0 699.5 728.1 729.8 4363.6 4537.3 4682.4 4728.2 4828.0 52805.0 71142.3 87192.6 88915.6 89698.6 61308.7 68148.7 68800.0 69066.7 77070.2 42182.4 43317.0 61135.7 61558.1 62952.7 9200.6 9203.5 9512.6 9556.0 9569.1 44655.3 44683.0 45040.0 45045.0 45113.0 52256.0 58130.4 58147.0 60773.7 62203.6 10580.0 10583.9 10838.1 10884.9 11070.2 13054.9 13104.7 13140.9 13532.6 13792.4 11535.2 11851.3 11877.6 12052.3 12207.0 12206.9 12740.7 12809.5 12818.3 12953.5 11523.3 11800.8 11930.6 12004.3 12615.6 9779.3 10717.8 11015.5 11184.3 11382.3 10066.5 10388.4 10451.0 10917.8 11013.8
04:17:34 INFO - PROCESS | 10978 | -------- Summary: end --------
04:17:34 INFO - PROCESS | 10978 |
04:17:35 INFO - TEST-INFO | 10978: exit 0
04:17:35 INFO - TEST-OK | dromaeo_css | took 1118655ms
04:17:35 INFO - TEST-START | kraken
04:17:35 INFO - operating with platform_type : linux_
04:17:35 INFO - Initialising browser for kraken test...
04:17:35 INFO - TEST-INFO | started process 11286 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp4Tc8Jo/profile http://localhost:41636/getInfo.html)
04:17:40 INFO - PROCESS | 11286 | __metrics Screen width/height:1600/1200
04:17:40 INFO - PROCESS | 11286 | colorDepth:24
04:17:40 INFO - PROCESS | 11286 | Browser inner width/height: 1024/697
04:17:40 INFO - PROCESS | 11286 | __metrics
04:17:40 INFO - PROCESS | 11286 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows"
04:17:40 INFO - PROCESS | 11286 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver]
04:17:41 INFO - PROCESS | 11286 | console.error: PushService:
04:17:41 INFO - PROCESS | 11286 | stateChangeProcessEnqueue: Error transitioning state
04:17:41 INFO - PROCESS | 11286 | UnknownError
04:17:42 INFO - TEST-INFO | 11286: exit 0
04:17:42 INFO - Browser initialized.
04:17:42 INFO - Running cycle 1/1 for kraken test...
04:17:42 INFO - TEST-INFO | started process 11372 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp4Tc8Jo/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1)
04:17:54 INFO - PROCESS | 11372 | RSS: Main: 173559808
04:17:54 INFO - PROCESS | 11372 |
04:17:56 INFO - PROCESS | 11372 | Cycle 1(1): loaded http://localhost:41636/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:41636/tests/kraken/driver.html?testName=audio-beat-detection)
04:17:57 INFO - PROCESS | 11372 | RSS: Main: 239636480
04:17:57 INFO - PROCESS | 11372 |
04:18:00 INFO - PROCESS | 11372 | Cycle 1(1): loaded http://localhost:41636/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:41636/tests/kraken/driver.html?testName=audio-dft)
04:18:00 INFO - PROCESS | 11372 | RSS: Main: 217350144
04:18:00 INFO - PROCESS | 11372 |
04:18:03 INFO - PROCESS | 11372 | Cycle 1(1): loaded http://localhost:41636/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:41636/tests/kraken/driver.html?testName=audio-fft)
04:18:04 INFO - PROCESS | 11372 | RSS: Main: 299245568
04:18:04 INFO - PROCESS | 11372 |
04:18:06 INFO - PROCESS | 11372 | Cycle 1(1): loaded http://localhost:41636/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:41636/tests/kraken/driver.html?testName=audio-oscillator)
04:18:07 INFO - PROCESS | 11372 | RSS: Main: 211025920
04:18:07 INFO - PROCESS | 11372 |
04:18:09 INFO - PROCESS | 11372 | Cycle 1(1): loaded http://localhost:41636/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:41636/tests/kraken/driver.html?testName=imaging-gaussian-blur)
04:18:09 INFO - PROCESS | 11372 | RSS: Main: 214667264
04:18:09 INFO - PROCESS | 11372 |
04:18:13 INFO - PROCESS | 11372 | Cycle 1(1): loaded http://localhost:41636/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:41636/tests/kraken/driver.html?testName=imaging-darkroom)
04:18:13 INFO - PROCESS | 11372 | RSS: Main: 253370368
04:18:13 INFO - PROCESS | 11372 |
04:18:16 INFO - PROCESS | 11372 | Cycle 1(1): loaded http://localhost:41636/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:41636/tests/kraken/driver.html?testName=imaging-desaturate)
04:18:17 INFO - PROCESS | 11372 | RSS: Main: 252997632
04:18:17 INFO - PROCESS | 11372 |
04:18:20 INFO - PROCESS | 11372 | Cycle 1(1): loaded http://localhost:41636/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:41636/tests/kraken/driver.html?testName=json-parse-financial)
04:18:20 INFO - PROCESS | 11372 | RSS: Main: 251981824
04:18:20 INFO - PROCESS | 11372 |
04:18:22 INFO - PROCESS | 11372 | Cycle 1(1): loaded http://localhost:41636/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:41636/tests/kraken/driver.html?testName=json-stringify-tinderbox)
04:18:23 INFO - PROCESS | 11372 | RSS: Main: 214396928
04:18:23 INFO - PROCESS | 11372 |
04:18:24 INFO - PROCESS | 11372 | Cycle 1(1): loaded http://localhost:41636/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:41636/tests/kraken/driver.html?testName=stanford-crypto-aes)
04:18:25 INFO - PROCESS | 11372 | RSS: Main: 221487104
04:18:25 INFO - PROCESS | 11372 |
04:18:27 INFO - PROCESS | 11372 | Cycle 1(1): loaded http://localhost:41636/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:41636/tests/kraken/driver.html?testName=stanford-crypto-ccm)
04:18:28 INFO - PROCESS | 11372 | RSS: Main: 230449152
04:18:28 INFO - PROCESS | 11372 |
04:18:30 INFO - PROCESS | 11372 | Cycle 1(1): loaded http://localhost:41636/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:41636/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2)
04:18:31 INFO - PROCESS | 11372 | RSS: Main: 239017984
04:18:31 INFO - PROCESS | 11372 |
04:18:34 INFO - PROCESS | 11372 | Cycle 1(1): loaded http://localhost:41636/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:41636/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative)
04:18:34 INFO - PROCESS | 11372 | RSS: Main: 235634688
04:18:34 INFO - PROCESS | 11372 |
04:18:36 INFO - PROCESS | 11372 | Cycle 1(1): loaded http://localhost:41636/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:41636/tests/kraken/driver.html?testName=ai-astar)
04:18:36 INFO - PROCESS | 11372 | RSS: Main: 286031872
04:18:36 INFO - PROCESS | 11372 |
04:18:36 INFO - PROCESS | 11372 | __start_tp_report
04:18:36 INFO - PROCESS | 11372 | _x_x_mozilla_page_load
04:18:36 INFO - PROCESS | 11372 | _x_x_mozilla_page_load_details
04:18:36 INFO - PROCESS | 11372 | |i|pagename|runs|
04:18:36 INFO - PROCESS | 11372 | |0;ai-astar;107;113;111;111;111;112;110;111;111;111
04:18:36 INFO - PROCESS | 11372 | |1;audio-beat-detection;149;126;130;169;130;129;128;124;142;135
04:18:36 INFO - PROCESS | 11372 | |2;audio-dft;162;162;162;162;161;165;163;162;164;163
04:18:36 INFO - PROCESS | 11372 | |3;audio-fft;74;76;76;111;75;75;75;75;92;75
04:18:36 INFO - PROCESS | 11372 | |4;audio-oscillator;82;82;106;82;83;83;95;82;83;110
04:18:36 INFO - PROCESS | 11372 | |5;imaging-gaussian-blur;116;116;116;117;117;117;118;117;116;117
04:18:36 INFO - PROCESS | 11372 | |6;imaging-darkroom;146;146;146;147;146;146;147;147;146;146
04:18:36 INFO - PROCESS | 11372 | |7;imaging-desaturate;95;95;95;95;95;95;95;95;96;95
04:18:36 INFO - PROCESS | 11372 | |8;json-parse-financial;51;52;51;52;54;53;53;52;52;53
04:18:36 INFO - PROCESS | 11372 | |9;json-stringify-tinderbox;63;63;63;62;63;62;63;63;65;64
04:18:36 INFO - PROCESS | 11372 | |10;stanford-crypto-aes;88;84;89;84;82;81;81;84;80;87
04:18:36 INFO - PROCESS | 11372 | |11;stanford-crypto-ccm;139;138;137;133;135;144;137;133;175;142
04:18:36 INFO - PROCESS | 11372 | |12;stanford-crypto-pbkdf2;169;165;164;165;174;164;164;167;167;164
04:18:36 INFO - PROCESS | 11372 | |13;stanford-crypto-sha256-iterative;72;65;65;66;65;65;66;75;64;65
04:18:36 INFO - PROCESS | 11372 | __end_tp_report
04:18:36 INFO - PROCESS | 11372 | __start_cc_report
04:18:36 INFO - PROCESS | 11372 | _x_x_mozilla_cycle_collect,1683
04:18:36 INFO - PROCESS | 11372 | __end_cc_report
04:18:36 INFO - PROCESS | 11372 | __startTimestamp1480076316915__endTimestamp
04:18:36 INFO - PROCESS | 11372 |
04:18:36 INFO - PROCESS | 11372 | ------- Summary: start -------
04:18:36 INFO - PROCESS | 11372 | Number of tests: 14
04:18:36 INFO - PROCESS | 11372 |
04:18:36 INFO - PROCESS | 11372 | [#0] ai-astar Cycles:10 Average:110.80 Median:111.00 stddev:1.55 (1.4%) stddev-sans-first:0.83
04:18:36 INFO - PROCESS | 11372 | Values: 107.0 113.0 111.0 111.0 111.0 112.0 110.0 111.0 111.0 111.0
04:18:36 INFO - PROCESS | 11372 |
04:18:36 INFO - PROCESS | 11372 | [#1] audio-beat-detection Cycles:10 Average:136.20 Median:132.50 stddev:13.84 (10.4%) stddev-sans-first:13.88
04:18:36 INFO - PROCESS | 11372 | Values: 149.0 126.0 130.0 169.0 130.0 129.0 128.0 124.0 142.0 135.0
04:18:36 INFO - PROCESS | 11372 |
04:18:36 INFO - PROCESS | 11372 | [#2] audio-dft Cycles:10 Average:162.60 Median:162.50 stddev:1.17 (0.7%) stddev-sans-first:1.22
04:18:36 INFO - PROCESS | 11372 | Values: 162.0 162.0 162.0 162.0 161.0 165.0 163.0 162.0 164.0 163.0
04:18:36 INFO - PROCESS | 11372 |
04:18:36 INFO - PROCESS | 11372 | [#3] audio-fft Cycles:10 Average:80.40 Median:75.00 stddev:12.00 (16.0%) stddev-sans-first:12.50
04:18:36 INFO - PROCESS | 11372 | Values: 74.0 76.0 76.0 111.0 75.0 75.0 75.0 75.0 92.0 75.0
04:18:36 INFO - PROCESS | 11372 |
04:18:36 INFO - PROCESS | 11372 | [#4] audio-oscillator Cycles:10 Average:88.80 Median:82.50 stddev:10.90 (13.2%) stddev-sans-first:11.28
04:18:36 INFO - PROCESS | 11372 | Values: 82.0 82.0 106.0 82.0 83.0 83.0 95.0 82.0 83.0 110.0
04:18:36 INFO - PROCESS | 11372 |
04:18:36 INFO - PROCESS | 11372 | [#5] imaging-gaussian-blur Cycles:10 Average:116.70 Median:117.00 stddev:0.67 (0.6%) stddev-sans-first:0.67
04:18:36 INFO - PROCESS | 11372 | Values: 116.0 116.0 116.0 117.0 117.0 117.0 118.0 117.0 116.0 117.0
04:18:36 INFO - PROCESS | 11372 |
04:18:36 INFO - PROCESS | 11372 | [#6] imaging-darkroom Cycles:10 Average:146.30 Median:146.00 stddev:0.48 (0.3%) stddev-sans-first:0.50
04:18:36 INFO - PROCESS | 11372 | Values: 146.0 146.0 146.0 147.0 146.0 146.0 147.0 147.0 146.0 146.0
04:18:36 INFO - PROCESS | 11372 |
04:18:36 INFO - PROCESS | 11372 | [#7] imaging-desaturate Cycles:10 Average:95.10 Median:95.00 stddev:0.32 (0.3%) stddev-sans-first:0.33
04:18:36 INFO - PROCESS | 11372 | Values: 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 96.0 95.0
04:18:36 INFO - PROCESS | 11372 |
04:18:36 INFO - PROCESS | 11372 | [#8] json-parse-financial Cycles:10 Average:52.30 Median:52.50 stddev:0.95 (1.8%) stddev-sans-first:0.88
04:18:36 INFO - PROCESS | 11372 | Values: 51.0 52.0 51.0 52.0 54.0 53.0 53.0 52.0 52.0 53.0
04:18:36 INFO - PROCESS | 11372 |
04:18:36 INFO - PROCESS | 11372 | [#9] json-stringify-tinderbox Cycles:10 Average:63.10 Median:63.00 stddev:0.88 (1.4%) stddev-sans-first:0.93
04:18:36 INFO - PROCESS | 11372 | Values: 63.0 63.0 63.0 62.0 63.0 62.0 63.0 63.0 65.0 64.0
04:18:36 INFO - PROCESS | 11372 |
04:18:36 INFO - PROCESS | 11372 | [#10] stanford-crypto-aes Cycles:10 Average:84.00 Median:84.00 stddev:3.13 (3.7%) stddev-sans-first:2.96
04:18:36 INFO - PROCESS | 11372 | Values: 88.0 84.0 89.0 84.0 82.0 81.0 81.0 84.0 80.0 87.0
04:18:36 INFO - PROCESS | 11372 |
04:18:36 INFO - PROCESS | 11372 | [#11] stanford-crypto-ccm Cycles:10 Average:141.30 Median:138.50 stddev:12.36 (8.9%) stddev-sans-first:13.08
04:18:36 INFO - PROCESS | 11372 | Values: 139.0 138.0 137.0 133.0 135.0 144.0 137.0 133.0 175.0 142.0
04:18:36 INFO - PROCESS | 11372 |
04:18:36 INFO - PROCESS | 11372 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:166.30 Median:166.00 stddev:3.20 (1.9%) stddev-sans-first:3.24
04:18:36 INFO - PROCESS | 11372 | Values: 169.0 165.0 164.0 165.0 174.0 164.0 164.0 167.0 167.0 164.0
04:18:36 INFO - PROCESS | 11372 |
04:18:36 INFO - PROCESS | 11372 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.80 Median:65.50 stddev:3.65 (5.6%) stddev-sans-first:3.35
04:18:36 INFO - PROCESS | 11372 | Values: 72.0 65.0 65.0 66.0 65.0 65.0 66.0 75.0 64.0 65.0
04:18:36 INFO - PROCESS | 11372 | -------- Summary: end --------
04:18:36 INFO - PROCESS | 11372 |
04:18:38 INFO - TEST-INFO | 11372: exit 0
04:18:38 INFO - TEST-OK | kraken | took 62252ms
04:18:38 INFO - SUITE-END | took 1180s
04:18:38 INFO - Completed test suite (00:19:41)
04:18:38 INFO - javascript benchmark
04:18:38 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2961.1856739396667, 3011.0966709986997, 3017.758579313655, 3040.9239769005785, 3051.771117166213, 5239.816606418776, 5246.501582349675, 5289.761960711768, 5316.3354580677415, 5352.063388906945, 5338.492843179902, 5348.91976620351, 5402.8919421611545, 5433.673979561229, 5480.095784195603, 4801.831935882245, 4839.782209800567, 4879.878003049935, 4883.487233840449, 4935.0376676548085, 4888.633352498577, 4932.630052746041, 5017.598592112622, 5042.974785126069, 5068.163752980772, 4778.593819525345, 4953.23224900141, 4953.653244272902, 5007.974960125194, 5028.245763135523, 4822.63830212732, 4840.177169881129, 4848.296996935424, 4894.2903279024695, 4902.2156454967035, 4827.937853672186, 4838.564529192355, 4840.75796210188, 4842.975785121087, 4885.828995985159, 5322.308099946982, 5377.139657654757, 5390.380106287748, 5401.648892821954, 5404.486573775485, 5575.916361254584, 5621.662700237958, 5624.072028115356, 5667.263255776723, 5759.0, 5756.827295181151, 5777.220075289824, 5786.334571524244, 5813.709314534299, 5832.62087964281, 5351.117065684158, 5360.758765855546, 5361.544268737123, 5361.651492652965, 5365.302510673627, 5618.073017951992, 5624.578156638187, 5672.262605861294, 5866.911996320058, 5874.500667443315, 5543.944560554342, 5546.4453554644215, 5547.528460080938, 5548.750306236229, 5551.639143455663, 5562.86092847674, 5615.989121958087, 5620.241267428844, 5717.485426311652, 5749.597528172988, 5817.156512305692, 5844.736986835603, 5857.648541087548, 5861.6189947653265, 5866.1494083357675, 5810.070388737866, 5825.650460972355, 5828.59199856006, 5829.47534721877, 5874.647521148745, 4247.87256382309, 4418.0, 4430.246858034142, 4431.623312018514, 4469.9776501117285, 3838.3858582626644, 3843.6540711336115, 3848.461215429842, 3869.6710779583486, 3872.1674839909556, 5422.972885135549, 5442.619016668875, 5445.754941027584, 5447.237386765856, 5482.396936337, 5771.220885180531, 5771.711414429262, 5784.132380143013, 5785.681787501644, 5787.189793428924, 5233.738313084331, 5289.68261904287, 5397.298351214396, 5426.375966763794, 5431.103867861759, 5008.574271186917, 5016.799328026911, 5026.271190677405, 5036.823711170092, 5061.848144555669, 5959.553033522417, 5963.463288304073, 5963.79126730571, 5971.164037034731, 5973.37279585646, 5597.916031259616, 5657.717114144194, 5667.5465962722055, 5815.563832712648, 5823.970880145572, 5744.569157313134, 5778.855528611818, 5786.276715410574, 5879.764809407576, 5905.202797622266, 5548.55611551083, 5570.944290557042, 5574.804881829116, 5579.2746942897165, 5585.882823435248, 5615.550755939434, 5660.066089095253, 5681.0910254359105, 5683.687397193194, 5694.572907032072, 5479.890402192013, 5512.200730894078, 5521.889562208653, 5583.776648933997, 5606.383297837317, 5542.0855558832345, 5547.611667183259, 5554.222408862682, 5565.471280228372, 5607.41122182165, 5508.20131080999, 5513.8345849624575, 5517.531009864207, 5522.392536821027, 5537.723113844372, 5413.079776437936, 5494.36814766291, 5559.416261292506, 5567.972160139173, 5568.6658800472105, 5510.145927381102, 5581.386047534849, 5606.271184745957, 5619.269494965792, 5620.690862002629], "value": 5271.734165144397, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [541.5842735838083, 587.7972099625629, 595.940405959404, 623.2614351992886, 642.306309186079, 32890.50664240035, 33709.15727106821, 42583.36124958128, 43428.0, 43433.0, 40673.38989915154, 45004.324935125915, 45069.549304506945, 45159.0, 45182.09635807282, 7930.286274235317, 8412.495250284986, 8556.486610803371, 8560.357973152008, 8564.143585641448, 7891.802704932394, 8123.1470695577, 8134.186581341878, 10188.59245630174, 10442.060214580686, 10517.158627309835, 10565.471726413649, 10570.312929659547, 10571.577136914553, 10573.894261057407, 10397.532111055021, 10423.374597524173, 10456.68629941103, 10458.424786636731, 10461.424621645845, 10334.0, 10346.172306215485, 10374.533146008447, 10404.635837745718, 10405.21960852939, 41785.373219401736, 41970.790146049076, 42165.367519487234, 42324.576754232374, 42363.788181058895, 3466.9826650866585, 3604.855805767766, 3751.362268414376, 3764.9623503764888, 3796.6393192646656, 30183.849080754455, 30464.69535304641, 30626.84686576553, 30732.69267307321, 32363.0, 4116.918503839484, 4288.442502474658, 4314.525402205755, 4382.671299652507, 4411.139827733593, 339213.0, 341370.0, 342587.0, 343460.0, 343682.0, 57237.71381143151, 57424.71287643535, 57425.42574574201, 57460.425395746344, 57849.0, 60361.0, 60422.69788651029, 60440.697796510736, 60443.09335359973, 60492.09261861075, 16666.33334666624, 17008.659826803396, 17015.744763828552, 17024.14879256032, 17026.404075857532, 12069.939650301869, 13181.406836692371, 13223.801642975362, 13253.337333133304, 13255.933720331337, 14593.708125837424, 16130.354785808437, 16210.43263485796, 16536.586585335463, 16588.0, 5972.880542389128, 5989.131575921467, 6010.4891084258325, 6010.519158467312, 6196.752129914753, 889.3863234368265, 973.4889183178747, 983.8868530118984, 987.9308448408686, 996.9052939970691, 29261.7073829259, 31512.527312090337, 31617.367652647277, 31734.365312693615, 32490.83754581212, 1043.7129789308, 1059.5391004912888, 1083.2742062817774, 1101.6419663609358, 1117.9664610061711, 15925.920370398075, 16664.916675416545, 16734.83265167333, 16750.497485075466, 16778.412755553498, 479204.0, 480395.0, 481558.0, 482153.0, 532346.0, 52595.21107183395, 55424.0, 56673.0, 56802.295931122135, 62597.0, 1287.658770425838, 1334.19281334793, 1336.672515233774, 1347.2455424962052, 1350.547566565192, 30241.848790755907, 32498.837505813266, 32568.837155815017, 32596.762420885134, 32959.50560741543, 50682.0, 51193.744031281094, 51240.48759512357, 51259.487405125474, 51269.48730512647, 409200.0, 411749.0, 412610.0, 413525.0, 413776.0, 39782.0, 40451.797741011105, 41292.1741565161, 41426.171476570904, 41440.3783943235, 46722.29916551187, 47696.523034769205, 47780.522194779, 47814.28278575894, 48496.27255591098, 39603.405948911364, 40166.57334826414, 40754.59245407508, 40893.0, 42099.0, 39547.60452395439, 40042.59957400505, 41388.37917431301, 41473.37789933093, 42176.57823421727, 38523.80738096291, 39502.525540425726, 39593.80203098966, 39877.60122398739, 40100.39849402203, 34020.65979340274, 36225.60411824911, 36502.4524632136, 37040.62959370372, 37174.25651487009, 26858.0, 27187.59218611762, 27325.316867078483, 27409.862950685118, 27554.311142221606], "value": 20089.850783960577, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [363.60367199752267, 384.12611309271404, 389.73692757388767, 398.7268720926166, 406.82303198108826, 14068.0, 15687.0, 18586.81413185868, 18716.251349946004, 18784.15471303791, 17562.385316513926, 17632.0, 17888.910555447204, 17975.910120449378, 17989.910050449762, 4077.3068578341754, 5374.7043912584695, 5604.495595396414, 5604.971975140119, 5606.467385598362, 4199.874003779892, 5957.910631340534, 6194.845128871769, 6224.8443788905415, 6340.809775706736, 5956.4043595640305, 6112.602680825755, 6312.053192021188, 6324.209473815773, 6331.2085989251345, 6193.2877719062435, 6220.657863817488, 6225.3463386344465, 6228.5017198624455, 6235.345288744685, 5263.210518422229, 5402.432744561843, 5423.972880135613, 5451.618386712932, 5470.9452905470835, 20136.697949530768, 20896.164153433845, 21039.8948005259, 21744.673829892563, 21902.12391504338, 2230.944226394337, 2239.361781892153, 2316.3166865774638, 2365.8817059146972, 2806.775457963358, 9290.303227257915, 9564.90435095647, 9629.903700963041, 9970.20238380935, 10175.389476631426, 1789.5252855862514, 1866.608012317415, 1866.7853196882397, 1883.8681292309543, 1901.8668693191482, 73845.26154738438, 80903.0, 82551.26833511605, 82613.58693206495, 84408.57795710982, 9202.401843880127, 9478.241740660731, 9724.513774311397, 9737.26970477217, 9762.121409073217, 12881.227126372447, 12909.419076141596, 12936.706329366987, 12954.093213474966, 12956.481740730454, 7303.393253484225, 7571.3942884569105, 7632.809689411254, 7801.102873169658, 7822.921770782219, 7479.588622625699, 7524.473286869976, 7598.962005189938, 7685.692572297045, 7776.494527855672, 4059.512858456945, 4073.7759423232005, 4115.36211887158, 4185.393117997874, 4221.472315960505, 1845.2526726675717, 1957.9021048947495, 2041.142560270147, 2041.3365656161807, 2049.0, 847.6355167278007, 926.7127190570944, 957.4877440569262, 967.2793768642406, 1062.9521671524644, 18255.634887302178, 18953.336633217772, 18996.43010709681, 19026.42920712381, 19306.32427865018, 946.1248345280588, 965.8020105878278, 982.3761911186448, 1013.8884722680499, 1033.7260625934134, 10035.197184225244, 10329.586816527404, 10403.84394234087, 10430.478476076165, 10559.524821383056, 445320.0, 445540.0, 446045.0, 459568.0, 462009.0, 89171.55414222888, 89355.55322223347, 89464.0, 89733.55133224292, 91274.54362728276, 955.8805149356191, 985.3693636072919, 1005.939643621385, 1009.6314845081492, 1012.0688966151158, 15806.9209653951, 16294.918525407296, 16319.59201019984, 16355.918220408821, 16730.163491825602, 38630.80684596559, 39854.80072599618, 40948.79525602353, 42019.36970945377, 42309.788451057546, 55188.72405638107, 55555.722221388634, 56883.43116568781, 56968.0, 60937.0, 8120.066192387715, 8363.581820908808, 8446.577671116296, 8536.231739143506, 8702.347323950855, 10095.394276343442, 13094.345282736016, 13123.475060997453, 13276.86723132795, 13291.0, 5739.397363276796, 6170.660613666291, 10764.192685548458, 11217.439128043401, 11616.050542815483, 11370.374629395463, 11420.428978551205, 11497.885021149681, 11653.825192621947, 11686.88313116892, 11240.875912408694, 11447.885521144683, 11577.536898524302, 11611.187216894736, 11822.349770762346, 8443.366747494085, 8498.277646400125, 8560.272376848037, 8612.354073444392, 8622.353323500636, 9041.773955650899, 10926.672199834018, 10945.398003109905, 11006.889931100906, 11278.943605281922], "value": 8820.187035602175, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1287.903407244457, 1415.320646089877, 1434.548117343037, 1531.2573401900077, 1725.6721222967635, 7105.111861017373, 7717.4597778155485, 7927.563983980879, 7982.52104873708, 8170.387220958422, 8003.719869804558, 8060.153683863198, 8062.7581172564915, 8072.919270807291, 8108.675652973889, 1865.7947625761155, 2209.856359336646, 2243.248511748566, 2247.1236217875044, 2248.325502349297, 1978.8416926645905, 2182.967255491161, 2237.7874101960288, 2238.160689741347, 2258.796708296253, 2202.3392982105306, 2229.554089182162, 2229.9665505017438, 2237.19460994042, 2241.551689662066, 2150.129197674944, 2166.9566608667897, 2168.8698678079286, 2169.22992337721, 2170.1644866726265, 2177.5318306564163, 2182.9890850545803, 2183.759786423492, 2213.247495851418, 2219.7891200335944, 8060.193980601893, 8116.6347514361405, 8118.63466144019, 8125.0, 8140.267375936135, 4776.976115119437, 4860.076585448789, 4900.607951363882, 4900.901981960376, 4911.8772030699165, 3065.20304720772, 3196.8081915084936, 3283.40898638245, 3326.8170250636203, 3334.9666503334897, 1013.6300250408622, 1087.7715679707271, 1106.9059129973962, 1108.501174471483, 1150.8618965724168, 10673.039426451656, 10674.9466252669, 10682.786344273149, 10685.145188384988, 10766.784664306748, 4195.853145139906, 4257.787110644517, 4299.312110062375, 4337.848175313912, 4394.318880573516, 9248.075192480697, 9252.444853308823, 9275.489848058422, 9283.58223879927, 9288.674896378594, 4865.756712164449, 4866.075445665312, 4867.951320486821, 4875.098106850244, 4876.073546026244, 4357.629601483909, 4408.757518336458, 4465.12929978651, 4469.128519938646, 4542.11428771393, 3667.211549516867, 3721.288207424561, 3729.869454569077, 3760.172761992357, 3828.7511311764647, 1197.550918405598, 1206.5294535131306, 1207.655818091857, 1208.2629595946466, 1215.8358621586149, 772.7944406725526, 791.8733002719653, 871.1462766488877, 921.2445794448622, 980.9509524523745, 5499.780008799603, 5566.387697353288, 5649.68926709035, 5707.543396528268, 5740.167675687002, 918.2975024106564, 985.4383001689112, 991.0386924683046, 1029.9639512617023, 1064.797688439194, 3752.249550089993, 3792.2605092007348, 3825.5409350877517, 3832.693384529287, 3860.845566177378, 9659.613615455444, 9827.459489728133, 9903.55434005457, 9945.751356216153, 9957.751056223653, 9736.172425343924, 9769.804603907882, 9808.21534277256, 9855.35940163887, 9898.257630677728, 7416.480846340704, 7432.0, 7446.255374462618, 7473.252674732592, 7582.0, 5481.561475081904, 5501.0, 5588.329400471969, 5623.775048998158, 5750.913736294043, 9020.323475739215, 9049.230815380766, 9146.634134634805, 9172.44965302084, 9213.86179207299, 8097.1497992712275, 8509.74470765878, 8897.154770296811, 8920.73237802867, 9055.27557795388, 6605.636689981905, 6816.625085620339, 6941.097657304518, 7011.404030657452, 7160.711072007089, 7713.2286771322415, 7735.922640773745, 7794.688212471665, 7796.4932279401655, 7872.803179920548, 6944.375006249462, 7048.436125110082, 7049.929500705132, 7088.503804733619, 7120.359167674934, 6923.826904327432, 6926.203486599105, 6946.16646002483, 6946.79159625212, 6987.895181572178, 6336.271328797247, 6360.045993101072, 6364.6181229126405, 6369.8726025480155, 6372.534317106999, 4732.52674732524, 4748.620110391092, 4805.8077676892535, 4876.902461950812, 4985.975070124626, 4657.883552911204, 4739.857804265877, 4880.877978050435, 4919.286703428054, 4957.851264462072], "value": 4298.684130970612, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [314.20662826363446, 323.345225917517, 323.4808132946621, 327.2081562618463, 332.237514903297, 5130.692158470494, 5254.7635356408955, 5281.551068159211, 5317.787288508455, 5320.334958130234, 5069.034614750375, 5235.528802407783, 5235.764390602422, 5249.527542521172, 5278.234655974881, 4154.792260386984, 4167.208230436223, 4169.833206671745, 4171.476256864598, 4186.204621121992, 4081.755094694313, 4130.772807495587, 4194.937075943863, 4212.283911734997, 4232.915341693164, 4065.166640838636, 4100.077482566414, 4107.815148318333, 4119.382092686106, 4136.565660605638, 4105.548389677133, 4115.320972039624, 4139.77231252281, 4141.461609990697, 4147.336426171828, 3693.169036966688, 3700.4449332600057, 3709.7588656737494, 3715.8327875245677, 3756.1924186299802, 5047.747612619354, 5105.0345616937375, 5111.239930437559, 5137.743112844343, 5172.61205409592, 4708.411448568929, 4718.528147185289, 4718.669693121483, 4729.574338309569, 4773.856784296477, 5492.038893193715, 5519.31008623922, 5532.225488431623, 5542.140968149903, 5562.9443705562835, 3753.8310776014873, 3933.5476420211758, 3966.365381538969, 3968.3650615901315, 3987.581303963071, 5693.857653558694, 5721.682718499014, 5732.226149469851, 5741.282339707536, 5746.023176060038, 4063.963689259279, 4077.225327187825, 4108.404281379183, 4111.033907031845, 4123.793810309473, 3971.205758848242, 4084.550699423061, 4109.828698820881, 4121.62905338521, 4170.394398156732, 4636.86089417318, 4660.743659098782, 4665.2768820832825, 4682.204025315705, 4704.200285951397, 5527.010276300529, 5534.4742249486235, 5537.529310008614, 5545.251391062155, 5563.414426888317, 1285.849164997341, 1286.8289856230786, 1368.548379034916, 1368.6783605852618, 1376.6902446949357, 919.0120620333036, 948.4783369146942, 952.1002652493328, 954.7660823098386, 955.7897262602216, 5132.485916654596, 5143.3570803649545, 5152.278680984665, 5154.5103215194495, 5169.741512924339, 5358.33020872391, 5418.647787893774, 5460.672359658433, 5469.835904922858, 5493.285872836505, 4905.9264111038365, 5113.616478764107, 5125.589952803767, 5144.897102057937, 5191.195364718475, 2869.167941297042, 2889.219910624162, 2896.160113567084, 2899.2606885244127, 2909.738123568889, 5603.831885043455, 5615.9157612635845, 5619.988402087663, 5628.887422251532, 5655.971720141373, 5343.358796944314, 5365.787856532681, 5414.296141501658, 5420.620556561003, 5569.526590239794, 5550.584600926738, 5576.804811831566, 5581.302337207849, 5605.32736071674, 5616.915746263891, 5231.895362092813, 5409.729513524387, 5439.3200849893765, 5488.4237155098135, 5494.587905907153, 5335.919961200508, 5339.359276886798, 5344.545713614386, 5362.410134885237, 5390.595705322038, 5584.609077364546, 5595.608307418442, 5601.487598348342, 5608.298962629671, 5632.831015069554, 3721.8834349695526, 3918.451416801707, 3939.92120157601, 3941.975086477479, 3952.7628342299554, 5445.700486473282, 5454.918176227439, 5462.726863656721, 5463.754131064032, 5467.343918729778, 5485.780568777204, 5528.585356098389, 5639.154126881001, 5647.1529270609735, 5665.405132461032, 5548.195511650869, 5578.581606379456, 5580.0, 5598.300212473441, 5609.775608975759, 5298.920516192183, 5483.698396588226, 5535.944640553704, 5546.4453554644215, 5563.388027316911, 5574.108142697149, 5591.412901645269, 5593.720313984203, 5597.15845793394, 5617.634853734494, 5464.562834973113, 5511.366192887869, 5551.7779288828, 5582.860428489158, 5603.691796951207], "value": 4168.192189211926, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [760.3878877503607, 760.7755712064941, 764.5221736414742, 789.3172405868925, 817.8895849060377, 13739.862601373983, 14679.0, 14686.339114739836, 14701.55895323142, 14790.334434950426, 13277.0, 13427.865721342809, 13482.730345393085, 13485.460581576725, 13488.325583720823, 650.4471199480428, 668.3917634952195, 747.4319517166965, 759.4987308376473, 774.3534148985603, 777.0403551613753, 777.2538363171362, 779.6491578789539, 779.851828152652, 780.0171783552736, 836.2014276366056, 837.1879277101202, 837.4514692876145, 837.5100566168799, 837.5142417397894, 690.8169335126196, 709.9467539934526, 711.459290938885, 714.1501613080418, 828.1056459024239, 586.7183751799117, 599.337731806352, 603.9245094363205, 605.6093819486407, 605.7970579855754, 12699.111062225647, 12775.425105870258, 12796.872031279661, 12826.61520154397, 12919.289439080847, 13126.671833204151, 13185.736285274337, 13312.400941957636, 13320.134191277535, 13391.933040334736, 11586.246893951866, 11631.27364942442, 11850.644480665595, 11999.760004799942, 12356.62930112098, 4196.244675958326, 4218.240716670998, 4271.380649805761, 4435.401220835178, 4461.776911154429, 55431.44568554343, 60392.39607603912, 60418.39581604172, 60809.0, 61315.0, 9944.204463642891, 9962.302638815214, 10321.84517232242, 10419.791604167875, 10671.35971841692, 16174.029558226308, 16176.029438233743, 16211.756823647655, 16225.18874056316, 16225.59436014109, 7736.187700291388, 7771.72798952034, 7997.0, 8003.199680032067, 8221.588920553948, 4238.406623072772, 4293.291606884892, 4386.0789234261165, 4412.691111622155, 4417.160739459492, 3303.768736188492, 3396.745244106702, 3401.659834016628, 3405.1316914186723, 3414.709749671306, 598.4524160393191, 607.7781609712512, 621.4158690830604, 629.7827249598881, 630.1776182082426, 668.9632070236087, 671.7480944645757, 680.3026897430174, 717.2540557819913, 722.151472020374, 8742.0, 8958.731238062868, 9070.365074444726, 9107.726768196964, 9212.170904618617, 585.3882692586258, 636.9808905732835, 699.4963626189136, 728.070959603492, 729.7993051910767, 4363.585459381354, 4537.342085397665, 4682.41469816273, 4728.243481043017, 4828.03439312139, 52804.97295903957, 71142.2885771146, 87192.56403718068, 88915.55542222247, 89698.55150724205, 61308.69345653243, 68148.6592567034, 68800.0, 69066.65466672635, 77070.22929770742, 42182.36726449044, 43317.0, 61135.694321528106, 61558.076628850606, 62952.685236573525, 9200.585973631336, 9203.539823008688, 9512.619495220391, 9556.0, 9569.090936361035, 44655.33017004682, 44683.0, 45040.0, 45045.0, 45113.0, 52256.0, 58130.4186958125, 58147.0, 60773.69613151906, 62203.602513661885, 10580.0, 10583.894161058599, 10838.132949363875, 10884.891151088388, 11070.225084244026, 13054.874608698303, 13104.737905242033, 13140.934295328461, 13532.616845788552, 13792.448302068206, 11535.192536522698, 11851.274206932281, 11877.58428455, 12052.337121458404, 12207.0, 12206.938965305117, 12740.74518509606, 12809.487620495076, 12818.294993775431, 12953.481860725466, 11523.250988685708, 11800.76398472043, 11930.582429614922, 12004.339761313211, 12615.621531354074, 9779.315447918578, 10717.839232411365, 11015.504302306575, 11184.328940263611, 11382.317060976036, 10066.496675166067, 10388.37669739818, 10451.0, 10917.836232456679, 11013.83479247796], "value": 6776.050870786766, "unit": "score"}], "name": "dromaeo_css", "value": 6957.49107660246, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [107.0, 113.0, 111.0, 111.0, 111.0, 112.0, 110.0, 111.0, 111.0, 111.0], "value": 110.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 126.0, 130.0, 169.0, 130.0, 129.0, 128.0, 124.0, 142.0, 135.0], "value": 136.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 162.0, 162.0, 162.0, 161.0, 165.0, 163.0, 162.0, 164.0, 163.0], "value": 162.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 76.0, 76.0, 111.0, 75.0, 75.0, 75.0, 75.0, 92.0, 75.0], "value": 80.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 82.0, 106.0, 82.0, 83.0, 83.0, 95.0, 82.0, 83.0, 110.0], "value": 88.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 116.0, 116.0, 117.0, 117.0, 117.0, 118.0, 117.0, 116.0, 117.0], "value": 116.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 146.0, 147.0, 146.0, 146.0, 147.0, 147.0, 146.0, 146.0], "value": 146.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 96.0, 95.0], "value": 95.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [51.0, 52.0, 51.0, 52.0, 54.0, 53.0, 53.0, 52.0, 52.0, 53.0], "value": 52.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 63.0, 63.0, 62.0, 63.0, 62.0, 63.0, 63.0, 65.0, 64.0], "value": 63.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 84.0, 89.0, 84.0, 82.0, 81.0, 81.0, 84.0, 80.0, 87.0], "value": 84.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [139.0, 138.0, 137.0, 133.0, 135.0, 144.0, 137.0, 133.0, 175.0, 142.0], "value": 141.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [169.0, 165.0, 164.0, 165.0, 174.0, 164.0, 164.0, 167.0, 167.0, 164.0], "value": 166.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 65.0, 65.0, 66.0, 65.0, 65.0, 66.0, 75.0, 64.0, 65.0], "value": 66.8, "unit": "score"}], "name": "kraken", "value": 1510.6999999999998, "alertThreshold": 2.0}]}
04:18:38 INFO - Return code: 0
04:18:38 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json
04:18:38 INFO - # TBPL SUCCESS #
04:18:38 INFO - Running post-action listener: _resource_record_post_action
04:18:38 INFO - [mozharness: 2016-11-25 12:18:38.723722Z] Finished run-tests step (success)
04:18:38 INFO - Running post-run listener: _resource_record_post_run
04:18:38 INFO - Total resource usage - Wall time: 1198s; CPU: 13.0%; Read bytes: 0; Write bytes: 400830464; Read time: 0; Write time: 253000
04:18:38 INFO - TinderboxPrint: CPU usage
13.1%
04:18:38 INFO - TinderboxPrint: I/O read bytes / time
0 / 0
04:18:38 INFO - TinderboxPrint: I/O write bytes / time
400,830,464 / 253,000
04:18:38 INFO - TinderboxPrint: CPU idle
8,302.5 (86.8%)
04:18:38 INFO - TinderboxPrint: CPU user
1,206.3 (12.6%)
04:18:38 INFO - TinderboxPrint: Swap in / out
0 / 0
04:18:38 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 104099840; Read time: 0; Write time: 84284
04:18:38 INFO - run-tests - Wall time: 1182s; CPU: 13.0%; Read bytes: 0; Write bytes: 293236736; Read time: 0; Write time: 168132
04:18:39 INFO - Running post-run listener: _upload_blobber_files
04:18:39 INFO - Blob upload gear active.
04:18:39 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir.
04:18:39 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
04:18:39 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']
04:18:39 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
04:18:39 INFO - (blobuploader) - INFO - Open directory for files ...
04:18:39 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ...
04:18:39 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com
04:18:39 INFO - (blobuploader) - INFO - Uploading, attempt #1.
04:18:40 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded
04:18:40 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded!
04:18:40 INFO - (blobuploader) - INFO - Done attempting.
04:18:40 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ...
04:18:40 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com
04:18:40 INFO - (blobuploader) - INFO - Uploading, attempt #1.
04:18:41 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded
04:18:41 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded!
04:18:41 INFO - (blobuploader) - INFO - Done attempting.
04:18:41 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ...
04:18:41 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com
04:18:41 INFO - (blobuploader) - INFO - Uploading, attempt #1.
04:18:44 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded
04:18:44 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded!
04:18:44 INFO - (blobuploader) - INFO - Done attempting.
04:18:44 INFO - (blobuploader) - INFO - Iteration through files over.
04:18:44 INFO - Return code: 0
04:18:44 INFO - rmtree: /builds/slave/test/build/uploaded_files.json
04:18:44 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1
04:18:44 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/09ffc5b0b40cc423e7b8862034e9ca253df522758d24226e83a44b69b1ad08f6f58b24f69beb64b3472d110bf6412dd1b8b80ed76d71fed2773b457d31bac211", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/986a00b67586e4cd12dade4da4cf44bc6b8fc01b942582173335ce5744950834604980011fe24212ae48552d882ba2b65d3968b3d6f4a35b49f4fc6451f9b328", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/9aebccada5ad2add3533610a75ffa399493e2719b8e71ad3ea1042515e504d5bd8dd0c90808c7cc6707764c4c8e7e9b5c047b18ba8965cbd7e49342308277ce7"}
04:18:44 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files
04:18:44 INFO - Writing to file /builds/slave/test/properties/blobber_files
04:18:44 INFO - Contents:
04:18:44 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/09ffc5b0b40cc423e7b8862034e9ca253df522758d24226e83a44b69b1ad08f6f58b24f69beb64b3472d110bf6412dd1b8b80ed76d71fed2773b457d31bac211", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/986a00b67586e4cd12dade4da4cf44bc6b8fc01b942582173335ce5744950834604980011fe24212ae48552d882ba2b65d3968b3d6f4a35b49f4fc6451f9b328", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/9aebccada5ad2add3533610a75ffa399493e2719b8e71ad3ea1042515e504d5bd8dd0c90808c7cc6707764c4c8e7e9b5c047b18ba8965cbd7e49342308277ce7"}
04:18:44 INFO - Running post-run listener: copy_logs_to_upload_dir
04:18:44 INFO - Copying logs to upload dir...
04:18:44 INFO - mkdir: /builds/slave/test/build/upload/logs
04:18:44 INFO - Copying logs to upload dir...
program finished with exit code 0
elapsedTime=1238.529199
========= master_lag: 0.01 =========
========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 38 secs) (at 2016-11-25 04:18:43.414959) =========
========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-25 04:18:43.417999) =========
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=db7e7c15f3ca076d53731445000001ba-1480075084.201619-1935419765
XPCOM_DEBUG_BREAK=warn
_=/tools/buildbot/bin/python
using PTY: False
blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/09ffc5b0b40cc423e7b8862034e9ca253df522758d24226e83a44b69b1ad08f6f58b24f69beb64b3472d110bf6412dd1b8b80ed76d71fed2773b457d31bac211", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/986a00b67586e4cd12dade4da4cf44bc6b8fc01b942582173335ce5744950834604980011fe24212ae48552d882ba2b65d3968b3d6f4a35b49f4fc6451f9b328", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/9aebccada5ad2add3533610a75ffa399493e2719b8e71ad3ea1042515e504d5bd8dd0c90808c7cc6707764c4c8e7e9b5c047b18ba8965cbd7e49342308277ce7"}
build_url:https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1480062604/firefox-53.0a1.en-US.linux-x86_64.tar.bz2
program finished with exit code 0
elapsedTime=0.011811
build_url: 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1480062604/firefox-53.0a1.en-US.linux-x86_64.tar.bz2'
blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/09ffc5b0b40cc423e7b8862034e9ca253df522758d24226e83a44b69b1ad08f6f58b24f69beb64b3472d110bf6412dd1b8b80ed76d71fed2773b457d31bac211", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/986a00b67586e4cd12dade4da4cf44bc6b8fc01b942582173335ce5744950834604980011fe24212ae48552d882ba2b65d3968b3d6f4a35b49f4fc6451f9b328", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/9aebccada5ad2add3533610a75ffa399493e2719b8e71ad3ea1042515e504d5bd8dd0c90808c7cc6707764c4c8e7e9b5c047b18ba8965cbd7e49342308277ce7"}'
========= master_lag: 0.01 =========
========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-25 04:18:43.443486) =========
========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-25 04:18:43.443831) =========
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=db7e7c15f3ca076d53731445000001ba-1480075084.201619-1935419765
XPCOM_DEBUG_BREAK=warn
_=/tools/buildbot/bin/python
using PTY: False
program finished with exit code 0
elapsedTime=0.004533
========= master_lag: 0.08 =========
========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-25 04:18:43.531918) =========
========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-25 04:18:43.532535) =========
========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-25 04:18:43.532882) =========
========= Total master_lag: 0.17 =========