builder: mozilla-inbound_ubuntu64_hw_test-dromaeojs-pgo
slave: talos-linux64-ix-022
starttime: 1479802969.25
results: success (0)
buildid: 20161122002153
builduid: 4c778b517b9642948b342f01972f9d64
revision: 68240063e11a7274c5b593aaa3fda9b714a4b139
========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-11-22 00:22:49.246483) =========
master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/
========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-11-22 00:22:49.246962) =========
========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-22 00:22:49.247425) =========
========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-22 00:22:49.270714) =========
========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-22 00:22:49.271014) =========
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=9c43b49b387003dc8f5b4e5c000001c4-1479794234.66368-1222926869
XPCOM_DEBUG_BREAK=warn
_=/tools/buildbot/bin/python
using PTY: False
--2016-11-22 00:22:49-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py
Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102
Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected.
HTTP request sent, awaiting response... 200 Script output follows
Length: 12179 (12K) [text/x-python]
Saving to: `archiver_client.py'
0K .......... . 100% 113M=0s
2016-11-22 00:22:49 (113 MB/s) - `archiver_client.py' saved [12179/12179]
program finished with exit code 0
elapsedTime=0.146107
========= master_lag: 0.02 =========
========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-22 00:22:49.432979) =========
========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-22 00:22:49.433272) =========
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=9c43b49b387003dc8f5b4e5c000001c4-1479794234.66368-1222926869
XPCOM_DEBUG_BREAK=warn
_=/tools/buildbot/bin/python
using PTY: False
program finished with exit code 0
elapsedTime=0.019712
========= master_lag: 0.03 =========
========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-22 00:22:49.483923) =========
========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-22 00:22:49.484372) =========
bash -c 'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev 68240063e11a7274c5b593aaa3fda9b714a4b139 --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 68240063e11a7274c5b593aaa3fda9b714a4b139 --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=9c43b49b387003dc8f5b4e5c000001c4-1479794234.66368-1222926869
XPCOM_DEBUG_BREAK=warn
_=/tools/buildbot/bin/python
using PTY: False
2016-11-22 00:22:50,044 truncating revision to first 12 chars
2016-11-22 00:22:50,045 Setting DEBUG logging.
2016-11-22 00:22:50,045 attempt 1/10
2016-11-22 00:22:50,045 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/68240063e11a?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness
2016-11-22 00:22:50,357 unpacking tar archive at: mozilla-inbound-68240063e11a/testing/mozharness/
program finished with exit code 0
elapsedTime=0.627521
========= master_lag: 0.01 =========
========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-22 00:22:50.125844) =========
========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-22 00:22:50.126153) =========
script_repo_revision: 68240063e11a7274c5b593aaa3fda9b714a4b139
========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-22 00:22:50.126522) =========
========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-22 00:22:50.126789) =========
========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-22 00:22:50.136329) =========
========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 38 secs) (at 2016-11-22 00:22:50.136634) =========
/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=9c43b49b387003dc8f5b4e5c000001c4-1479794234.66368-1222926869
XPCOM_DEBUG_BREAK=warn
_=/tools/buildbot/bin/python
using PTY: False
00:22:50 INFO - MultiFileLogger online at 20161122 00:22:50 in /builds/slave/test
00:22:50 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
00:22:50 INFO - Dumping config to /builds/slave/test/logs/localconfig.json.
00:22:50 INFO - {'append_to_log': False,
00:22:50 INFO - 'base_work_dir': '/builds/slave/test',
00:22:50 INFO - 'blob_upload_branch': 'Mozilla-Inbound',
00:22:50 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt',
00:22:50 INFO - 'branch': 'Mozilla-Inbound',
00:22:50 INFO - 'buildbot_json_path': 'buildprops.json',
00:22:50 INFO - 'config_files': ('talos/linux_config.py',),
00:22:50 INFO - 'default_actions': ('clobber',
00:22:50 INFO - 'read-buildbot-config',
00:22:50 INFO - 'download-and-extract',
00:22:50 INFO - 'populate-webroot',
00:22:50 INFO - 'create-virtualenv',
00:22:50 INFO - 'install',
00:22:50 INFO - 'run-tests'),
00:22:50 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',),
00:22:50 INFO - 'download_minidump_stackwalk': True,
00:22:50 INFO - 'download_symbols': 'ondemand',
00:22:50 INFO - 'exes': {'python': '/tools/buildbot/bin/python',
00:22:50 INFO - 'tooltool.py': '/tools/tooltool.py',
00:22:50 INFO - 'virtualenv': ('/tools/buildbot/bin/python',
00:22:50 INFO - '/tools/misc-python/virtualenv.py')},
00:22:50 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub',
00:22:50 INFO - 'http://pypi.pub.build.mozilla.org/pub'),
00:22:50 INFO - 'installer_path': 'installer.exe',
00:22:50 INFO - 'log_level': 'info',
00:22:50 INFO - 'log_name': 'talos',
00:22:50 INFO - 'log_to_console': True,
00:22:50 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk',
00:22:50 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest',
00:22:50 INFO - 'opt_config_files': (),
00:22:50 INFO - 'pip_index': False,
00:22:50 INFO - 'sps_profile': False,
00:22:50 INFO - 'sps_profile_interval': 0,
00:22:50 INFO - 'suite': 'dromaeojs',
00:22:50 INFO - 'system_bits': '32',
00:22:50 INFO - 'talos_extra_options': ('--webServer', 'localhost'),
00:22:50 INFO - 'title': 'talos-linux64-ix-022',
00:22:50 INFO - 'tooltool_cache': '/builds/tooltool_cache',
00:22:50 INFO - 'use_talos_json': True,
00:22:50 INFO - 'virtualenv_path': '/builds/slave/test/build/venv',
00:22:50 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None},
00:22:50 INFO - 'work_dir': 'build'}
00:22:50 INFO - [mozharness: 2016-11-22 08:22:50.793399Z] Running clobber step.
00:22:50 INFO - Running pre-action listener: _resource_record_pre_action
00:22:50 INFO - Running main action method: clobber
00:22:50 INFO - rmtree: /builds/slave/test/build
00:22:50 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1
00:22:51 INFO - Running post-action listener: _resource_record_post_action
00:22:51 INFO - [mozharness: 2016-11-22 08:22:51.252847Z] Finished clobber step (success)
00:22:51 INFO - [mozharness: 2016-11-22 08:22:51.252947Z] Running read-buildbot-config step.
00:22:51 INFO - Running pre-action listener: _resource_record_pre_action
00:22:51 INFO - Running main action method: read_buildbot_config
00:22:51 INFO - Using buildbot properties:
00:22:51 INFO - {
00:22:51 INFO - "project": "",
00:22:51 INFO - "product": "firefox",
00:22:51 INFO - "script_repo_revision": "production",
00:22:51 INFO - "builddir": "mozilla-inbound_ubuntu64_hw_test-dromaeojs",
00:22:51 INFO - "repository": "",
00:22:51 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-inbound pgo talos dromaeojs",
00:22:51 INFO - "buildid": "20161122002153",
00:22:51 INFO - "stage_platform": "linux64-pgo",
00:22:51 INFO - "basedir": "/builds/slave/test",
00:22:51 INFO - "buildnumber": 2104,
00:22:51 INFO - "platform": "ubuntu64_hw",
00:22:51 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/",
00:22:51 INFO - "slavebuilddir": "test",
00:22:51 INFO - "branch": "mozilla-inbound",
00:22:51 INFO - "revision": "68240063e11a7274c5b593aaa3fda9b714a4b139",
00:22:51 INFO - "slavename": "talos-linux64-ix-022",
00:22:51 INFO - "builduid": "4c778b517b9642948b342f01972f9d64",
00:22:51 INFO - "repo_path": "integration/mozilla-inbound"
00:22:51 INFO - }
00:22:51 INFO - Found installer url https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1479792618/firefox-53.0a1.en-US.linux-x86_64.tar.bz2.
00:22:51 INFO - Found a test packages url https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1479792618/firefox-53.0a1.en-US.linux-x86_64.test_packages.json.
00:22:51 INFO - Running post-action listener: _resource_record_post_action
00:22:51 INFO - [mozharness: 2016-11-22 08:22:51.255289Z] Finished read-buildbot-config step (success)
00:22:51 INFO - [mozharness: 2016-11-22 08:22:51.255377Z] Running download-and-extract step.
00:22:51 INFO - Running pre-action listener: _resource_record_pre_action
00:22:51 INFO - Running main action method: download_and_extract
00:22:51 INFO - mkdir: /builds/slave/test/build/tests
00:22:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]}
00:22:51 INFO - trying https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1479792618/firefox-53.0a1.en-US.linux-x86_64.test_packages.json
00:22:51 INFO - Downloading https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1479792618/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
00:22:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1479792618/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
00:22:51 INFO - Downloaded 1361 bytes.
00:22:51 INFO - Reading from file /builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json
00:22:51 INFO - Using the following test package requirements:
00:22:51 INFO - {u'common': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'],
00:22:51 INFO - u'cppunittest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip',
00:22:51 INFO - u'firefox-53.0a1.en-US.linux-x86_64.cppunittest.tests.zip'],
00:22:51 INFO - u'gtest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip',
00:22:51 INFO - u'firefox-53.0a1.en-US.linux-x86_64.gtest.tests.zip'],
00:22:51 INFO - u'jittest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip',
00:22:51 INFO - u'jsshell-linux-x86_64.zip'],
00:22:51 INFO - u'mochitest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip',
00:22:51 INFO - u'firefox-53.0a1.en-US.linux-x86_64.mochitest.tests.zip'],
00:22:51 INFO - u'mozbase': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'],
00:22:51 INFO - u'reftest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip',
00:22:51 INFO - u'firefox-53.0a1.en-US.linux-x86_64.reftest.tests.zip'],
00:22:51 INFO - u'talos': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip',
00:22:51 INFO - u'firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip'],
00:22:51 INFO - u'web-platform': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip',
00:22:51 INFO - u'firefox-53.0a1.en-US.linux-x86_64.web-platform.tests.zip'],
00:22:51 INFO - u'xpcshell': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip',
00:22:51 INFO - u'firefox-53.0a1.en-US.linux-x86_64.xpcshell.tests.zip']}
00:22:51 INFO - Downloading packages: [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common
00:22:51 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/1479792618/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip
00:22:51 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1479792618/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1
00:22:51 INFO - Fetch https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1479792618/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip into memory
00:22:51 INFO - Http code: 200
00:22:51 INFO - via: 1.1 a75342fa94ff4a9431476624fe74f02e.cloudfront.net (CloudFront)
00:22:51 INFO - x-amz-cf-id: gKoHt-6Hhf9vC7OvtToEhjx1CAzfMbM1mfkcg-5rwptQ0WA1NZjA3w==
00:22:51 INFO - x-amz-replication-status: COMPLETED
00:22:51 INFO - x-amz-version-id: 8Wb0JhuIIPITVLljSNLas2QAcYoO8e.l
00:22:51 INFO - Expected file size: 21966636
00:22:51 INFO - Obtained file size: 21966636
00:22:55 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
00:22:55 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/1479792618/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip
00:22:55 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1479792618/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1
00:22:55 INFO - Fetch https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1479792618/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip into memory
00:22:55 INFO - Http code: 200
00:22:55 INFO - via: 1.1 23172d761378a3865feafcda78328053.cloudfront.net (CloudFront)
00:22:55 INFO - x-amz-cf-id: RgvWv4DTzk_pnvRoC-q_QM3tqIjRX1QVOVVpddCM_XbC_7qmDqPF2Q==
00:22:55 INFO - x-amz-replication-status: COMPLETED
00:22:55 INFO - x-amz-version-id: 8Wb0JhuIIPITVLljSNLas2QAcYoO8e.l
00:22:55 INFO - Expected file size: 21966636
00:22:55 INFO - Obtained file size: 21966636
00:23:00 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/1479792618/firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip
00:23:00 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1479792618/firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1
00:23:00 INFO - Fetch https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1479792618/firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip into memory
00:23:00 INFO - Http code: 200
00:23:00 INFO - via: 1.1 23172d761378a3865feafcda78328053.cloudfront.net (CloudFront)
00:23:00 INFO - x-amz-cf-id: O5FUGzjU3v-sdp7PGAF2MSL2Vud78arn2CpNuGsL4eGwAOxKB7Wjhw==
00:23:00 INFO - x-amz-replication-status: COMPLETED
00:23:00 INFO - x-amz-version-id: J8yV5TgJWVzmotqytLorv67PzihJcS74
00:23:00 INFO - Expected file size: 14409392
00:23:00 INFO - Obtained file size: 14409392
00:23:00 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')]}
00:23:00 INFO - trying https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1479792618/firefox-53.0a1.en-US.linux-x86_64.tar.bz2
00:23:00 INFO - Downloading https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1479792618/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
00:23:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1479792618/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
00:23:01 INFO - Downloaded 59796725 bytes.
00:23:01 INFO - Setting buildbot property build_url to https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1479792618/firefox-53.0a1.en-US.linux-x86_64.tar.bz2
00:23:01 INFO - mkdir: /builds/slave/test/properties
00:23:01 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url
00:23:01 INFO - Writing to file /builds/slave/test/properties/build_url
00:23:01 INFO - Contents:
00:23:01 INFO - build_url:https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1479792618/firefox-53.0a1.en-US.linux-x86_64.tar.bz2
00:23:01 INFO - Running post-action listener: _resource_record_post_action
00:23:01 INFO - Running post-action listener: set_extra_try_arguments
00:23:01 INFO - [mozharness: 2016-11-22 08:23:01.613315Z] Finished download-and-extract step (success)
00:23:01 INFO - [mozharness: 2016-11-22 08:23:01.613543Z] Running populate-webroot step.
00:23:01 INFO - Running pre-action listener: _resource_record_pre_action
00:23:01 INFO - Running main action method: populate_webroot
00:23:01 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']},
00:23:01 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']},
00:23:01 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome',
00:23:01 INFO - '--tppagecycles',
00:23:01 INFO - '7'],
00:23:01 INFO - 'tests': ['tsvgm']}},
00:23:01 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'],
00:23:01 INFO - 'tests': ['tresize', 'tcanvasmark']},
00:23:01 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']},
00:23:01 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'],
00:23:01 INFO - 'tests': ['dromaeo_css', 'kraken']},
00:23:01 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']},
00:23:01 INFO - 'g1': {'pagesets_name': 'tp5n.zip',
00:23:01 INFO - 'talos_options': ['--disable-e10s'],
00:23:01 INFO - 'tests': ['tp5o_scroll', 'glterrain']},
00:23:01 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip',
00:23:01 INFO - 'tests': ['tp5o_scroll', 'glterrain']},
00:23:01 INFO - 'g2': {'pagesets_name': 'tp5n.zip',
00:23:01 INFO - 'talos_options': ['--disable-e10s'],
00:23:01 INFO - 'tests': ['damp', 'tps']},
00:23:01 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip',
00:23:01 INFO - 'tests': ['damp', 'tps']},
00:23:01 INFO - 'g3': {'talos_options': ['--disable-e10s'],
00:23:01 INFO - 'tests': ['dromaeo_dom']},
00:23:01 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']},
00:23:01 INFO - 'g4': {'talos_options': ['--disable-e10s'],
00:23:01 INFO - 'tests': ['basic_compositor_video']},
00:23:01 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']},
00:23:01 INFO - 'other': {'talos_options': ['--disable-e10s'],
00:23:01 INFO - 'tests': ['a11yr',
00:23:01 INFO - 'ts_paint',
00:23:01 INFO - 'tpaint',
00:23:01 INFO - 'sessionrestore',
00:23:01 INFO - 'sessionrestore_no_auto_restore',
00:23:01 INFO - 'tabpaint']},
00:23:01 INFO - 'other-e10s': {'tests': ['a11yr',
00:23:01 INFO - 'ts_paint',
00:23:01 INFO - 'tpaint',
00:23:01 INFO - 'sessionrestore',
00:23:01 INFO - 'sessionrestore_no_auto_restore',
00:23:01 INFO - 'tabpaint']},
00:23:01 INFO - 'other-e10s_l64': {'tests': ['a11yr',
00:23:01 INFO - 'ts_paint',
00:23:01 INFO - 'tpaint',
00:23:01 INFO - 'sessionrestore',
00:23:01 INFO - 'sessionrestore_no_auto_restore',
00:23:01 INFO - 'tabpaint']},
00:23:01 INFO - 'other-e10s_nol64': {'tests': ['a11yr',
00:23:01 INFO - 'ts_paint',
00:23:01 INFO - 'tpaint',
00:23:01 INFO - 'sessionrestore',
00:23:01 INFO - 'sessionrestore_no_auto_restore',
00:23:01 INFO - 'tabpaint']},
00:23:01 INFO - 'other_l64': {'talos_options': ['--disable-e10s'],
00:23:01 INFO - 'tests': ['a11yr',
00:23:01 INFO - 'ts_paint',
00:23:01 INFO - 'tpaint',
00:23:01 INFO - 'sessionrestore',
00:23:01 INFO - 'sessionrestore_no_auto_restore',
00:23:01 INFO - 'tabpaint']},
00:23:01 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'],
00:23:01 INFO - 'tests': ['a11yr',
00:23:01 INFO - 'ts_paint',
00:23:01 INFO - 'tpaint',
00:23:01 INFO - 'sessionrestore',
00:23:01 INFO - 'sessionrestore_no_auto_restore',
00:23:01 INFO - 'tabpaint']},
00:23:01 INFO - 'svgr': {'talos_options': ['--disable-e10s'],
00:23:01 INFO - 'tests': ['tsvgx',
00:23:01 INFO - 'tsvgr_opacity',
00:23:01 INFO - 'tart',
00:23:01 INFO - 'tscrollx',
00:23:01 INFO - 'cart']},
00:23:01 INFO - 'svgr-e10s': {'tests': ['tsvgx',
00:23:01 INFO - 'tsvgr_opacity',
00:23:01 INFO - 'tart',
00:23:01 INFO - 'tscrollx',
00:23:01 INFO - 'cart']},
00:23:01 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip',
00:23:01 INFO - 'talos_options': ['--disable-e10s'],
00:23:01 INFO - 'tests': ['tp5o']},
00:23:01 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']},
00:23:01 INFO - 'xperf': {'pagesets_name': 'tp5n.zip',
00:23:01 INFO - 'talos_options': ['--disable-e10s',
00:23:01 INFO - '--xperf_path',
00:23:01 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'],
00:23:01 INFO - 'tests': ['tp5n']},
00:23:01 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip',
00:23:01 INFO - 'talos_options': ['--xperf_path',
00:23:01 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'],
00:23:01 INFO - 'tests': ['tp5n']}},
00:23:01 INFO - 'talos.zip': {'path': '',
00:23:01 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}}
00:23:01 INFO - Running post-action listener: _resource_record_post_action
00:23:01 INFO - [mozharness: 2016-11-22 08:23:01.633598Z] Finished populate-webroot step (success)
00:23:01 INFO - [mozharness: 2016-11-22 08:23:01.633693Z] Running create-virtualenv step.
00:23:01 INFO - Running pre-action listener: _resource_record_pre_action
00:23:01 INFO - Running main action method: create_virtualenv
00:23:01 INFO - Creating virtualenv /builds/slave/test/build/venv
00:23:01 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
00:23:01 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv
00:23:01 INFO - The --no-site-packages flag is deprecated; it is now the default behavior.
00:23:01 INFO - Using real prefix '/usr'
00:23:01 INFO - New python executable in /builds/slave/test/build/venv/bin/python
00:23:02 INFO - Installing distribute.............................................................................................................................................................................................done.
00:23:04 INFO - Installing pip.................done.
00:23:04 INFO - Return code: 0
00:23:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version']
00:23:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version
00:23:04 INFO - Reading from file tmpfile_stdout
00:23:04 INFO - Output received:
00:23:04 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)
00:23:04 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv
00:23:04 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')]}
00:23:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org
00:23:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub
00:23:04 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')]}
00:23:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org
00:23:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub
00:23:04 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 0x7f1309d20e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15d6b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1772130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1800fc0>, '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 0x1801ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1802350>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1479794234.66368-1222926869', '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
00:23:04 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
00:23:04 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
00:23:04 INFO - Using env: {'DISPLAY': ':0',
00:23:04 INFO - 'HOME': '/home/cltbld',
00:23:04 INFO - 'LANG': 'en_US.UTF-8',
00:23:04 INFO - 'LANGUAGE': 'en_US:en',
00:23:04 INFO - 'LOGNAME': 'cltbld',
00:23:04 INFO - 'MAIL': '/var/mail/cltbld',
00:23:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1',
00:23:04 INFO - 'MOZ_NO_REMOTE': '1',
00:23:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript',
00:23:04 INFO - 'NO_EM_RESTART': '1',
00:23:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games',
00:23:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json',
00:23:04 INFO - 'PWD': '/builds/slave/test',
00:23:04 INFO - 'SHELL': '/bin/bash',
00:23:04 INFO - 'SHLVL': '1',
00:23:04 INFO - 'TERM': 'linux',
00:23:04 INFO - 'TMOUT': '86400',
00:23:04 INFO - 'USER': 'cltbld',
00:23:04 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1479794234.66368-1222926869',
00:23:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn',
00:23:04 INFO - '_': '/tools/buildbot/bin/python'}
00:23:04 INFO - Ignoring indexes: https://pypi.python.org/simple/
00:23:04 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
00:23:04 INFO - Cleaning up...
00:23:04 INFO - Return code: 0
00:23:04 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv
00:23:04 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')]}
00:23:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org
00:23:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub
00:23:04 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')]}
00:23:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org
00:23:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub
00:23:04 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 0x7f1309d20e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15d6b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1772130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1800fc0>, '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 0x1801ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1802350>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1479794234.66368-1222926869', '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
00:23:04 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
00:23:04 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
00:23:04 INFO - Using env: {'DISPLAY': ':0',
00:23:04 INFO - 'HOME': '/home/cltbld',
00:23:04 INFO - 'LANG': 'en_US.UTF-8',
00:23:04 INFO - 'LANGUAGE': 'en_US:en',
00:23:04 INFO - 'LOGNAME': 'cltbld',
00:23:04 INFO - 'MAIL': '/var/mail/cltbld',
00:23:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1',
00:23:04 INFO - 'MOZ_NO_REMOTE': '1',
00:23:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript',
00:23:04 INFO - 'NO_EM_RESTART': '1',
00:23:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games',
00:23:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json',
00:23:04 INFO - 'PWD': '/builds/slave/test',
00:23:04 INFO - 'SHELL': '/bin/bash',
00:23:04 INFO - 'SHLVL': '1',
00:23:04 INFO - 'TERM': 'linux',
00:23:04 INFO - 'TMOUT': '86400',
00:23:04 INFO - 'USER': 'cltbld',
00:23:04 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1479794234.66368-1222926869',
00:23:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn',
00:23:04 INFO - '_': '/tools/buildbot/bin/python'}
00:23:04 INFO - Ignoring indexes: https://pypi.python.org/simple/
00:23:04 INFO - Downloading/unpacking psutil>=3.1.1
00:23:04 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
00:23:04 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
00:23:04 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
00:23:04 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
00:23:04 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
00:23:04 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
00:23:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil
00:23:06 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build'
00:23:06 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects
...
00:23:06 INFO - Installing collected packages: psutil
00:23:06 INFO - Running setup.py install for psutil
00:23:06 INFO - building 'psutil._psutil_linux' extension
00:23:06 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
00:23:07 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
00:23:07 INFO - building 'psutil._psutil_posix' extension
00:23:07 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
00:23:07 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
00:23:07 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build'
00:23:07 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ...
00:23:07 INFO - Successfully installed psutil
00:23:07 INFO - Cleaning up...
00:23:07 INFO - Return code: 0
00:23:07 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv
00:23:07 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')]}
00:23:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org
00:23:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub
00:23:07 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')]}
00:23:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org
00:23:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub
00:23:07 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 0x7f1309d20e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15d6b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1772130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1800fc0>, '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 0x1801ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1802350>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1479794234.66368-1222926869', '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
00:23:07 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
00:23:07 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
00:23:07 INFO - Using env: {'DISPLAY': ':0',
00:23:07 INFO - 'HOME': '/home/cltbld',
00:23:07 INFO - 'LANG': 'en_US.UTF-8',
00:23:07 INFO - 'LANGUAGE': 'en_US:en',
00:23:07 INFO - 'LOGNAME': 'cltbld',
00:23:07 INFO - 'MAIL': '/var/mail/cltbld',
00:23:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1',
00:23:07 INFO - 'MOZ_NO_REMOTE': '1',
00:23:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript',
00:23:07 INFO - 'NO_EM_RESTART': '1',
00:23:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games',
00:23:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json',
00:23:07 INFO - 'PWD': '/builds/slave/test',
00:23:07 INFO - 'SHELL': '/bin/bash',
00:23:07 INFO - 'SHLVL': '1',
00:23:07 INFO - 'TERM': 'linux',
00:23:07 INFO - 'TMOUT': '86400',
00:23:07 INFO - 'USER': 'cltbld',
00:23:07 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1479794234.66368-1222926869',
00:23:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn',
00:23:07 INFO - '_': '/tools/buildbot/bin/python'}
00:23:07 INFO - Ignoring indexes: https://pypi.python.org/simple/
00:23:07 INFO - Downloading/unpacking mozsystemmonitor==0.3
00:23:07 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
00:23:07 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
00:23:07 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
00:23:07 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
00:23:07 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
00:23:07 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
00:23:09 INFO - Downloading mozsystemmonitor-0.3.tar.gz
00:23:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor
00:23:09 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3)
00:23:09 INFO - Installing collected packages: mozsystemmonitor
00:23:09 INFO - Running setup.py install for mozsystemmonitor
00:23:09 INFO - Successfully installed mozsystemmonitor
00:23:09 INFO - Cleaning up...
00:23:09 INFO - Return code: 0
00:23:09 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv
00:23:09 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')]}
00:23:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org
00:23:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub
00:23:09 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')]}
00:23:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org
00:23:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub
00:23:09 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 0x7f1309d20e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15d6b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1772130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1800fc0>, '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 0x1801ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1802350>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1479794234.66368-1222926869', '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
00:23:09 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
00:23:09 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
00:23:09 INFO - Using env: {'DISPLAY': ':0',
00:23:09 INFO - 'HOME': '/home/cltbld',
00:23:09 INFO - 'LANG': 'en_US.UTF-8',
00:23:09 INFO - 'LANGUAGE': 'en_US:en',
00:23:09 INFO - 'LOGNAME': 'cltbld',
00:23:09 INFO - 'MAIL': '/var/mail/cltbld',
00:23:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1',
00:23:09 INFO - 'MOZ_NO_REMOTE': '1',
00:23:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript',
00:23:09 INFO - 'NO_EM_RESTART': '1',
00:23:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games',
00:23:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json',
00:23:09 INFO - 'PWD': '/builds/slave/test',
00:23:09 INFO - 'SHELL': '/bin/bash',
00:23:09 INFO - 'SHLVL': '1',
00:23:09 INFO - 'TERM': 'linux',
00:23:09 INFO - 'TMOUT': '86400',
00:23:09 INFO - 'USER': 'cltbld',
00:23:09 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1479794234.66368-1222926869',
00:23:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn',
00:23:09 INFO - '_': '/tools/buildbot/bin/python'}
00:23:10 INFO - Ignoring indexes: https://pypi.python.org/simple/
00:23:10 INFO - Downloading/unpacking jsonschema==2.5.1
00:23:10 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
00:23:10 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
00:23:10 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
00:23:10 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
00:23:10 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
00:23:10 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
00:23:11 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl
00:23:11 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1)
00:23:11 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
00:23:11 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
00:23:11 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
00:23:11 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
00:23:11 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
00:23:11 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
00:23:12 INFO - Downloading functools32-3.2.3-2.tar.gz
00:23:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32
00:23:12 INFO - warning: no files found matching '*.txt'
00:23:12 INFO - no previously-included directories found matching 'build'
00:23:12 INFO - no previously-included directories found matching 'dist'
00:23:12 INFO - no previously-included directories found matching '.git*'
00:23:12 INFO - Installing collected packages: jsonschema, functools32
00:23:12 INFO - Running setup.py install for functools32
00:23:12 INFO - warning: no files found matching '*.txt'
00:23:12 INFO - no previously-included directories found matching 'build'
00:23:12 INFO - no previously-included directories found matching 'dist'
00:23:12 INFO - no previously-included directories found matching '.git*'
00:23:12 INFO - Successfully installed jsonschema functools32
00:23:12 INFO - Cleaning up...
00:23:12 INFO - Return code: 0
00:23:12 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv
00:23:12 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')]}
00:23:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org
00:23:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub
00:23:12 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')]}
00:23:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org
00:23:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub
00:23:12 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 0x7f1309d20e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15d6b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1772130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1800fc0>, '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 0x1801ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1802350>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1479794234.66368-1222926869', '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
00:23:12 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
00:23:12 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
00:23:12 INFO - Using env: {'DISPLAY': ':0',
00:23:12 INFO - 'HOME': '/home/cltbld',
00:23:12 INFO - 'LANG': 'en_US.UTF-8',
00:23:12 INFO - 'LANGUAGE': 'en_US:en',
00:23:12 INFO - 'LOGNAME': 'cltbld',
00:23:12 INFO - 'MAIL': '/var/mail/cltbld',
00:23:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1',
00:23:12 INFO - 'MOZ_NO_REMOTE': '1',
00:23:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript',
00:23:12 INFO - 'NO_EM_RESTART': '1',
00:23:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games',
00:23:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json',
00:23:12 INFO - 'PWD': '/builds/slave/test',
00:23:12 INFO - 'SHELL': '/bin/bash',
00:23:12 INFO - 'SHLVL': '1',
00:23:12 INFO - 'TERM': 'linux',
00:23:12 INFO - 'TMOUT': '86400',
00:23:12 INFO - 'USER': 'cltbld',
00:23:12 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1479794234.66368-1222926869',
00:23:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn',
00:23:12 INFO - '_': '/tools/buildbot/bin/python'}
00:23:12 INFO - Ignoring indexes: https://pypi.python.org/simple/
00:23:12 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages
00:23:12 INFO - Cleaning up...
00:23:12 INFO - Return code: 0
00:23:12 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv
00:23:12 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')]}
00:23:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org
00:23:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub
00:23:12 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')]}
00:23:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org
00:23:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub
00:23:12 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 0x7f1309d20e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15d6b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1772130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1800fc0>, '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 0x1801ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1802350>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1479794234.66368-1222926869', '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
00:23:12 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
00:23:12 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
00:23:12 INFO - Using env: {'DISPLAY': ':0',
00:23:12 INFO - 'HOME': '/home/cltbld',
00:23:12 INFO - 'LANG': 'en_US.UTF-8',
00:23:12 INFO - 'LANGUAGE': 'en_US:en',
00:23:12 INFO - 'LOGNAME': 'cltbld',
00:23:12 INFO - 'MAIL': '/var/mail/cltbld',
00:23:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1',
00:23:12 INFO - 'MOZ_NO_REMOTE': '1',
00:23:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript',
00:23:12 INFO - 'NO_EM_RESTART': '1',
00:23:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games',
00:23:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json',
00:23:12 INFO - 'PWD': '/builds/slave/test',
00:23:12 INFO - 'SHELL': '/bin/bash',
00:23:12 INFO - 'SHLVL': '1',
00:23:12 INFO - 'TERM': 'linux',
00:23:12 INFO - 'TMOUT': '86400',
00:23:12 INFO - 'USER': 'cltbld',
00:23:12 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1479794234.66368-1222926869',
00:23:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn',
00:23:12 INFO - '_': '/tools/buildbot/bin/python'}
00:23:13 INFO - Ignoring indexes: https://pypi.python.org/simple/
00:23:13 INFO - Downloading/unpacking blobuploader==1.2.4
00:23:13 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
00:23:13 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
00:23:13 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
00:23:13 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
00:23:13 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
00:23:13 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
00:23:15 INFO - Downloading blobuploader-1.2.4.tar.gz
00:23:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader
00:23:15 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4)
00:23:15 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
00:23:15 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
00:23:15 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
00:23:15 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
00:23:15 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
00:23:15 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
00:23:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests
00:23:15 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4)
00:23:15 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
00:23:15 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
00:23:15 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
00:23:15 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
00:23:15 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
00:23:15 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
00:23:15 INFO - Downloading docopt-0.6.1.tar.gz
00:23:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt
00:23:15 INFO - Installing collected packages: blobuploader, requests, docopt
00:23:15 INFO - Running setup.py install for blobuploader
00:23:15 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775
00:23:15 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775
00:23:15 INFO - Running setup.py install for requests
00:23:16 INFO - Running setup.py install for docopt
00:23:16 INFO - Successfully installed blobuploader requests docopt
00:23:16 INFO - Cleaning up...
00:23:16 INFO - Return code: 0
00:23:16 INFO - Installing None into virtualenv /builds/slave/test/build/venv
00:23: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')]}
00:23:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org
00:23:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub
00:23: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')]}
00:23:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org
00:23:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub
00:23:16 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 0x7f1309d20e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15d6b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1772130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1800fc0>, '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 0x1801ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1802350>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1479794234.66368-1222926869', '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
00:23:16 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
00:23:16 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
00:23:16 INFO - Using env: {'DISPLAY': ':0',
00:23:16 INFO - 'HOME': '/home/cltbld',
00:23:16 INFO - 'LANG': 'en_US.UTF-8',
00:23:16 INFO - 'LANGUAGE': 'en_US:en',
00:23:16 INFO - 'LOGNAME': 'cltbld',
00:23:16 INFO - 'MAIL': '/var/mail/cltbld',
00:23:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1',
00:23:16 INFO - 'MOZ_NO_REMOTE': '1',
00:23:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript',
00:23:16 INFO - 'NO_EM_RESTART': '1',
00:23:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games',
00:23:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json',
00:23:16 INFO - 'PWD': '/builds/slave/test',
00:23:16 INFO - 'SHELL': '/bin/bash',
00:23:16 INFO - 'SHLVL': '1',
00:23:16 INFO - 'TERM': 'linux',
00:23:16 INFO - 'TMOUT': '86400',
00:23:16 INFO - 'USER': 'cltbld',
00:23:16 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1479794234.66368-1222926869',
00:23:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn',
00:23:16 INFO - '_': '/tools/buildbot/bin/python'}
00:23:16 INFO - Ignoring indexes: https://pypi.python.org/simple/
00:23:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser
00:23:16 INFO - Running setup.py (path:/tmp/pip-fB2Nor-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser
00:23:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash
00:23:16 INFO - Running setup.py (path:/tmp/pip-dkWAQU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash
00:23:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug
00:23:16 INFO - Running setup.py (path:/tmp/pip-xlZCLO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug
00:23:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice
00:23:16 INFO - Running setup.py (path:/tmp/pip-FSZfeQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice
00:23:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile
00:23:16 INFO - Running setup.py (path:/tmp/pip-y2iZLL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile
00:23:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd
00:23:17 INFO - Running setup.py (path:/tmp/pip-0XsdGI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd
00:23:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo
00:23:17 INFO - Running setup.py (path:/tmp/pip-fqdr8I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo
00:23:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall
00:23:17 INFO - Running setup.py (path:/tmp/pip-od4Rvn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall
00:23:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak
00:23:17 INFO - Running setup.py (path:/tmp/pip-5ofhKu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak
00:23:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog
00:23:17 INFO - Running setup.py (path:/tmp/pip-kF1BzK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog
00:23:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork
00:23:17 INFO - Running setup.py (path:/tmp/pip-3rjjwC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork
00:23:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess
00:23:17 INFO - Running setup.py (path:/tmp/pip-Ix1iI6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess
00:23:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile
00:23:17 INFO - Running setup.py (path:/tmp/pip-8AMwix-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile
00:23:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner
00:23:17 INFO - Running setup.py (path:/tmp/pip-xHDrIx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner
00:23:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot
00:23:17 INFO - Running setup.py (path:/tmp/pip-6bNAdn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot
00:23:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest
00:23:17 INFO - Running setup.py (path:/tmp/pip-7mUrsw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest
00:23:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion
00:23:17 INFO - Running setup.py (path:/tmp/pip-56ZHRu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion
00:23:17 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion
00:23:17 INFO - Running setup.py install for manifestparser
00:23:17 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin
00:23:17 INFO - Running setup.py install for mozcrash
00:23:18 INFO - Running setup.py install for mozdebug
00:23:18 INFO - Running setup.py install for mozdevice
00:23:18 INFO - Installing sutini script to /builds/slave/test/build/venv/bin
00:23:18 INFO - Installing dm script to /builds/slave/test/build/venv/bin
00:23:18 INFO - Running setup.py install for mozfile
00:23:18 INFO - Running setup.py install for mozhttpd
00:23:18 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin
00:23:18 INFO - Running setup.py install for mozinfo
00:23:18 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin
00:23:18 INFO - Running setup.py install for mozInstall
00:23:18 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin
00:23:18 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin
00:23:18 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin
00:23:18 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin
00:23:18 INFO - Running setup.py install for mozleak
00:23:18 INFO - Running setup.py install for mozlog
00:23:18 INFO - Installing structlog script to /builds/slave/test/build/venv/bin
00:23:18 INFO - Running setup.py install for moznetwork
00:23:19 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin
00:23:19 INFO - Running setup.py install for mozprocess
00:23:19 INFO - Running setup.py install for mozprofile
00:23:19 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin
00:23:19 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin
00:23:19 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin
00:23:19 INFO - Running setup.py install for mozrunner
00:23:19 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin
00:23:19 INFO - Running setup.py install for mozscreenshot
00:23:19 INFO - Running setup.py install for moztest
00:23:19 INFO - Running setup.py install for mozversion
00:23:19 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin
00:23:19 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion
00:23:19 INFO - Cleaning up...
00:23:19 INFO - Return code: 0
00:23:19 INFO - Installing None into virtualenv /builds/slave/test/build/venv
00:23: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')]}
00:23:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org
00:23:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub
00:23: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')]}
00:23:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org
00:23:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub
00:23:19 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 0x7f1309d20e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15d6b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1772130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1800fc0>, '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 0x1801ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1802350>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1479794234.66368-1222926869', '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
00:23:19 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
00:23:19 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
00:23:19 INFO - Using env: {'DISPLAY': ':0',
00:23:19 INFO - 'HOME': '/home/cltbld',
00:23:19 INFO - 'LANG': 'en_US.UTF-8',
00:23:19 INFO - 'LANGUAGE': 'en_US:en',
00:23:19 INFO - 'LOGNAME': 'cltbld',
00:23:19 INFO - 'MAIL': '/var/mail/cltbld',
00:23:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1',
00:23:19 INFO - 'MOZ_NO_REMOTE': '1',
00:23:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript',
00:23:19 INFO - 'NO_EM_RESTART': '1',
00:23:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games',
00:23:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json',
00:23:19 INFO - 'PWD': '/builds/slave/test',
00:23:19 INFO - 'SHELL': '/bin/bash',
00:23:19 INFO - 'SHLVL': '1',
00:23:19 INFO - 'TERM': 'linux',
00:23:19 INFO - 'TMOUT': '86400',
00:23:19 INFO - 'USER': 'cltbld',
00:23:19 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1479794234.66368-1222926869',
00:23:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn',
00:23:19 INFO - '_': '/tools/buildbot/bin/python'}
00:23:19 INFO - Ignoring indexes: https://pypi.python.org/simple/
00:23:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser
00:23:19 INFO - Running setup.py (path:/tmp/pip-s43bQm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser
00:23:19 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))
00:23:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash
00:23:19 INFO - Running setup.py (path:/tmp/pip-_4Hqd5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash
00:23:20 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))
00:23:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug
00:23:20 INFO - Running setup.py (path:/tmp/pip-l_ZQdo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug
00:23:20 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))
00:23:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice
00:23:20 INFO - Running setup.py (path:/tmp/pip-xbx2JG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice
00:23:20 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))
00:23:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile
00:23:20 INFO - Running setup.py (path:/tmp/pip-GlMxdX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile
00:23:20 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))
00:23:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd
00:23:20 INFO - Running setup.py (path:/tmp/pip-tcgsrI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd
00:23:20 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))
00:23:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo
00:23:20 INFO - Running setup.py (path:/tmp/pip-rJam6H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo
00:23:20 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))
00:23:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall
00:23:20 INFO - Running setup.py (path:/tmp/pip-s3U9lw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall
00:23:20 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))
00:23:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak
00:23:20 INFO - Running setup.py (path:/tmp/pip-WmuA7O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak
00:23:20 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))
00:23:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog
00:23:20 INFO - Running setup.py (path:/tmp/pip-q4CbKK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog
00:23:20 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))
00:23:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork
00:23:20 INFO - Running setup.py (path:/tmp/pip-0qd4LG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork
00:23:20 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))
00:23:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess
00:23:20 INFO - Running setup.py (path:/tmp/pip-MOvxEV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess
00:23:20 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))
00:23:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile
00:23:20 INFO - Running setup.py (path:/tmp/pip-kF9xx_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile
00:23:20 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))
00:23:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner
00:23:20 INFO - Running setup.py (path:/tmp/pip-oWdCRo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner
00:23:20 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))
00:23:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot
00:23:20 INFO - Running setup.py (path:/tmp/pip-U1xbwY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot
00:23:21 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))
00:23:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest
00:23:21 INFO - Running setup.py (path:/tmp/pip-dH8igd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest
00:23:21 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))
00:23:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion
00:23:21 INFO - Running setup.py (path:/tmp/pip-zhGlGB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion
00:23:21 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))
00:23:21 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))
00:23:21 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))
00:23:21 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))
00:23:21 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))
00:23:21 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))
00:23:21 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10))
00:23:21 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
00:23:21 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
00:23:21 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
00:23:21 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
00:23:21 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
00:23:21 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
00:23:23 INFO - Downloading blessings-1.6.tar.gz
00:23:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings
00:23:23 INFO - Installing collected packages: blessings
00:23:23 INFO - Running setup.py install for blessings
00:23:23 INFO - Successfully installed blessings
00:23:23 INFO - Cleaning up...
00:23:23 INFO - Return code: 0
00:23:23 INFO - Done creating virtualenv /builds/slave/test/build/venv.
00:23:23 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze']
00:23:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze
00:23:23 INFO - Reading from file tmpfile_stdout
00:23:23 INFO - Current package versions:
00:23:23 INFO - argparse == 1.2.1
00:23:23 INFO - blessings == 1.6
00:23:23 INFO - blobuploader == 1.2.4
00:23:23 INFO - docopt == 0.6.1
00:23:23 INFO - functools32 == 3.2.3-2
00:23:23 INFO - jsonschema == 2.5.1
00:23:23 INFO - manifestparser == 1.1
00:23:23 INFO - mozInstall == 1.12
00:23:23 INFO - mozcrash == 1.0
00:23:23 INFO - mozdebug == 0.1
00:23:23 INFO - mozdevice == 0.49
00:23:23 INFO - mozfile == 1.2
00:23:23 INFO - mozhttpd == 0.7
00:23:23 INFO - mozinfo == 0.9
00:23:23 INFO - mozleak == 0.1
00:23:23 INFO - mozlog == 3.4
00:23:23 INFO - moznetwork == 0.27
00:23:23 INFO - mozprocess == 0.23
00:23:23 INFO - mozprofile == 0.28
00:23:23 INFO - mozrunner == 6.13
00:23:23 INFO - mozscreenshot == 0.1
00:23:23 INFO - mozsystemmonitor == 0.3
00:23:23 INFO - moztest == 0.7
00:23:23 INFO - mozversion == 1.4
00:23:23 INFO - psutil == 3.1.1
00:23:23 INFO - requests == 1.2.3
00:23:23 INFO - wsgiref == 0.1.2
00:23:23 INFO - Installing None into virtualenv /builds/slave/test/build/venv
00:23:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]}
00:23:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org
00:23:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub
00:23:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]}
00:23:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org
00:23:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub
00:23:23 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 0x7f1309d20e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15d6b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1772130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1800fc0>, '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 0x1801ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1802350>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1479794234.66368-1222926869', '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
00:23:23 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
00:23:23 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
00:23:23 INFO - Using env: {'DISPLAY': ':0',
00:23:23 INFO - 'HOME': '/home/cltbld',
00:23:23 INFO - 'LANG': 'en_US.UTF-8',
00:23:23 INFO - 'LANGUAGE': 'en_US:en',
00:23:23 INFO - 'LOGNAME': 'cltbld',
00:23:23 INFO - 'MAIL': '/var/mail/cltbld',
00:23:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1',
00:23:23 INFO - 'MOZ_NO_REMOTE': '1',
00:23:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript',
00:23:23 INFO - 'NO_EM_RESTART': '1',
00:23:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games',
00:23:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json',
00:23:23 INFO - 'PWD': '/builds/slave/test',
00:23:23 INFO - 'SHELL': '/bin/bash',
00:23:23 INFO - 'SHLVL': '1',
00:23:23 INFO - 'TERM': 'linux',
00:23:23 INFO - 'TMOUT': '86400',
00:23:23 INFO - 'USER': 'cltbld',
00:23:23 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1479794234.66368-1222926869',
00:23:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn',
00:23:23 INFO - '_': '/tools/buildbot/bin/python'}
00:23:23 INFO - Ignoring indexes: https://pypi.python.org/simple/
00:23:23 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))
00:23:23 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))
00:23:23 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))
00:23:23 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))
00:23:23 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))
00:23:23 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))
00:23:23 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))
00:23:23 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))
00:23:23 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))
00:23:23 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))
00:23:23 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))
00:23:23 INFO - Cleaning up...
00:23:23 INFO - Return code: 0
00:23:23 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv
00:23:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]}
00:23:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org
00:23:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub
00:23:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]}
00:23:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org
00:23:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub
00:23: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', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f1309d20e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15d6b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1772130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1800fc0>, '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 0x1801ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1802350>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1479794234.66368-1222926869', '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
00:23: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', 'jsonschema'] in /builds/slave/test/build
00:23: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 jsonschema
00:23:23 INFO - Using env: {'DISPLAY': ':0',
00:23:23 INFO - 'HOME': '/home/cltbld',
00:23:23 INFO - 'LANG': 'en_US.UTF-8',
00:23:23 INFO - 'LANGUAGE': 'en_US:en',
00:23:23 INFO - 'LOGNAME': 'cltbld',
00:23:23 INFO - 'MAIL': '/var/mail/cltbld',
00:23:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1',
00:23:23 INFO - 'MOZ_NO_REMOTE': '1',
00:23:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript',
00:23:23 INFO - 'NO_EM_RESTART': '1',
00:23:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games',
00:23:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json',
00:23:23 INFO - 'PWD': '/builds/slave/test',
00:23:23 INFO - 'SHELL': '/bin/bash',
00:23:23 INFO - 'SHLVL': '1',
00:23:23 INFO - 'TERM': 'linux',
00:23:23 INFO - 'TMOUT': '86400',
00:23:23 INFO - 'USER': 'cltbld',
00:23:23 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1479794234.66368-1222926869',
00:23:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn',
00:23:23 INFO - '_': '/tools/buildbot/bin/python'}
00:23:23 INFO - Ignoring indexes: https://pypi.python.org/simple/
00:23:23 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages
00:23:23 INFO - Cleaning up...
00:23:24 INFO - Return code: 0
00:23:24 INFO - Running post-action listener: _resource_record_post_action
00:23:24 INFO - Running post-action listener: _start_resource_monitoring
00:23:24 INFO - Starting resource monitoring.
00:23:24 INFO - [mozharness: 2016-11-22 08:23:24.033448Z] Finished create-virtualenv step (success)
00:23:24 INFO - [mozharness: 2016-11-22 08:23:24.033914Z] Running install step.
00:23:24 INFO - Running pre-action listener: _resource_record_pre_action
00:23:24 INFO - Running main action method: install
00:23:24 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze']
00:23:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze
00:23:24 INFO - Reading from file tmpfile_stdout
00:23:24 INFO - Detecting whether we're running mozinstall >=1.0...
00:23:24 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h']
00:23:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h
00:23:24 INFO - Reading from file tmpfile_stdout
00:23:24 INFO - Output received:
00:23:24 INFO - Usage: mozinstall [options] installer
00:23:24 INFO - Options:
00:23:24 INFO - -h, --help show this help message and exit
00:23:24 INFO - -d DEST, --destination=DEST
00:23:24 INFO - Directory to install application into. [default:
00:23:24 INFO - "/builds/slave/test"]
00:23:24 INFO - --app=APP Application being installed. [default: firefox]
00:23:24 INFO - mkdir: /builds/slave/test/build/application
00:23:24 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']
00:23:24 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
00:23:41 INFO - Reading from file tmpfile_stdout
00:23:41 INFO - Output received:
00:23:41 INFO - /builds/slave/test/build/application/firefox/firefox
00:23:41 INFO - Running post-action listener: _resource_record_post_action
00:23:41 INFO - [mozharness: 2016-11-22 08:23:41.287545Z] Finished install step (success)
00:23:41 INFO - [mozharness: 2016-11-22 08:23:41.287819Z] Running run-tests step.
00:23:41 INFO - Running pre-action listener: _resource_record_pre_action
00:23:41 INFO - Running main action method: run_tests
00:23:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version']
00:23:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version
00:23:41 INFO - Python 2.7.3
00:23:41 INFO - Return code: 0
00:23:41 INFO - grabbing minidump binary from tooltool
00:23:41 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')]}
00:23:41 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 0x1800fc0>, '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 0x1801ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1802350>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1
00:23:41 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
00:23:41 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
00:23:41 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
00:23:41 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache
00:23:41 INFO - Return code: 0
00:23:41 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755
00:23:41 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir
00:23:41 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir
00:23:41 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk
00:23:41 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir
00:23:41 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/1479792618/firefox-53.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-022', '--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
00:23:41 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/1479792618/firefox-53.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-022 --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
00:23:41 INFO - Using env: {'DISPLAY': ':0',
00:23:41 INFO - 'HOME': '/home/cltbld',
00:23:41 INFO - 'LANG': 'en_US.UTF-8',
00:23:41 INFO - 'LANGUAGE': 'en_US:en',
00:23:41 INFO - 'LOGNAME': 'cltbld',
00:23:41 INFO - 'MAIL': '/var/mail/cltbld',
00:23:41 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir',
00:23:41 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk',
00:23:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1',
00:23:41 INFO - 'MOZ_NO_REMOTE': '1',
00:23:41 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir',
00:23:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript',
00:23:41 INFO - 'NO_EM_RESTART': '1',
00:23:41 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games',
00:23:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json',
00:23:41 INFO - 'PWD': '/builds/slave/test',
00:23:41 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos',
00:23:41 INFO - 'SHELL': '/bin/bash',
00:23:41 INFO - 'SHLVL': '1',
00:23:41 INFO - 'TERM': 'linux',
00:23:41 INFO - 'TMOUT': '86400',
00:23:41 INFO - 'USER': 'cltbld',
00:23:41 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1479794234.66368-1222926869',
00:23:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn',
00:23:41 INFO - '_': '/tools/buildbot/bin/python'}
00:23:41 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/1479792618/firefox-53.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-022', '--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
00:23:41 INFO - mozversion application_buildid: 20161121213018
00:23:41 INFO - mozversion application_changeset: 68240063e11a7274c5b593aaa3fda9b714a4b139
00:23:41 INFO - mozversion application_display_name: Nightly
00:23:41 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384}
00:23:41 INFO - mozversion application_name: Firefox
00:23:41 INFO - mozversion application_remotingname: firefox
00:23:41 INFO - mozversion application_repository: https://hg.mozilla.org/integration/mozilla-inbound
00:23:41 INFO - mozversion application_vendor: Mozilla
00:23:41 INFO - mozversion application_version: 53.0a1
00:23:41 INFO - mozversion platform_buildid: 20161121213018
00:23:41 INFO - mozversion platform_changeset: 68240063e11a7274c5b593aaa3fda9b714a4b139
00:23:41 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/mozilla-inbound
00:23:41 INFO - mozversion platform_version: 53.0a1
00:23:41 INFO - using testdate: 1479803021
00:23:41 INFO - actual date: 1479803021
00:23:41 INFO - starting webserver on 'localhost:44192'
00:23:41 INFO - SUITE-START | Running 2 tests
00:23:41 INFO - TEST-START | dromaeo_css
00:23:41 INFO - operating with platform_type : linux_
00:23:41 INFO - Initialising browser for dromaeo_css test...
00:23:41 INFO - TEST-INFO | started process 10953 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmplTcIWc/profile http://localhost:44192/getInfo.html)
00:23:46 INFO - PROCESS | 10953 | __metrics Screen width/height:1600/1200
00:23:46 INFO - PROCESS | 10953 | colorDepth:24
00:23:46 INFO - PROCESS | 10953 | Browser inner width/height: 1024/697
00:23:46 INFO - PROCESS | 10953 | __metrics
00:23:46 INFO - PROCESS | 10953 | 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"
00:23:46 INFO - PROCESS | 10953 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver]
00:23:47 INFO - TEST-INFO | 10953: exit 0
00:23:47 INFO - Browser initialized.
00:23:47 INFO - Running cycle 1/1 for dromaeo_css test...
00:23:47 INFO - TEST-INFO | started process 11037 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmplTcIWc/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1)
00:23:59 INFO - PROCESS | 11037 | RSS: Main: 173547520
00:23:59 INFO - PROCESS | 11037 |
00:24:51 INFO - PROCESS | 11037 | 1479803091132 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]
00:27:00 INFO - PROCESS | 11037 | Cycle 1(1): loaded http://localhost:44192/tests/dromaeo/cssquery-dojo.html (next: http://localhost:44192/tests/dromaeo/cssquery-ext.html)
00:27:03 INFO - PROCESS | 11037 | RSS: Main: 406773760
00:27:03 INFO - PROCESS | 11037 |
00:30:06 INFO - PROCESS | 11037 | Cycle 1(1): loaded http://localhost:44192/tests/dromaeo/cssquery-ext.html (next: http://localhost:44192/tests/dromaeo/cssquery-jquery.html)
00:30:06 INFO - PROCESS | 11037 | RSS: Main: 280752128
00:30:06 INFO - PROCESS | 11037 |
00:33:08 INFO - PROCESS | 11037 | Cycle 1(1): loaded http://localhost:44192/tests/dromaeo/cssquery-jquery.html (next: http://localhost:44192/tests/dromaeo/cssquery-mootools.html)
00:33:09 INFO - PROCESS | 11037 | RSS: Main: 225558528
00:33:09 INFO - PROCESS | 11037 |
00:36:11 INFO - PROCESS | 11037 | Cycle 1(1): loaded http://localhost:44192/tests/dromaeo/cssquery-mootools.html (next: http://localhost:44192/tests/dromaeo/cssquery-prototype.html)
00:36:12 INFO - PROCESS | 11037 | RSS: Main: 220729344
00:36:12 INFO - PROCESS | 11037 |
00:39:14 INFO - PROCESS | 11037 | Cycle 1(1): loaded http://localhost:44192/tests/dromaeo/cssquery-prototype.html (next: http://localhost:44192/tests/dromaeo/cssquery-yui.html)
00:39:15 INFO - PROCESS | 11037 | RSS: Main: 219987968
00:39:15 INFO - PROCESS | 11037 |
00:42:18 INFO - PROCESS | 11037 | Cycle 1(1): loaded http://localhost:44192/tests/dromaeo/cssquery-yui.html (next: http://localhost:44192/tests/dromaeo/cssquery-dojo.html)
00:42:18 INFO - PROCESS | 11037 | RSS: Main: 318517248
00:42:18 INFO - PROCESS | 11037 |
00:42:18 INFO - PROCESS | 11037 | __start_tp_report
00:42:18 INFO - PROCESS | 11037 | _x_x_mozilla_page_load
00:42:18 INFO - PROCESS | 11037 | _x_x_mozilla_page_load_details
00:42:18 INFO - PROCESS | 11037 | |i|pagename|runs|
00:42:18 INFO - PROCESS | 11037 | |0;dojo.html;2948.3661012882226;2964.2737529305323;2993.0571869861;3005.3388254583997;3014.32177760004;5138.075146473638;5190.351206099238;5209.192575150853;5243.449437809023;5290.656107353019;5278;5279.524842764151;5327.653702509334;5331.040412725708;5437.075697131488;4783.952160478386;4802.471728109905;4829;4912.926306105403;4918.458969513351;4860.295257187706;4865.708057516543;4899;4902.975485122587;4957.058158949806;4954.628402869781;4965.379327584052;4966.751662416883;4989.251612258154;5010.448850626446;4772.0217355442055;4812.494688057738;4812.759362031885;4850.005748821518;4884.462709101996;4826.251930950708;4831.806727730886;4841.080194763019;4844.7819848106565;4847.684900481458;5143;5196.68819870809;5207.297014902978;5277.076511610453;5289.074411977888;5605.80379686709;5646.520045796112;5648.209250704905;5649.039663257215;5662.348829884533;5592.245046918695;5645.830625081254;5655.208270842086;5655.717214139277;5657.462541058593;5171.4311425743135;5276.7889284428575;5281.36623605166;5286.577073834084;5320.201969704575;5685.1756495307945;5724.055530837449;5745.2818397700285;5769.07694768835;5811.3026436827;5585.245991791137;5587.273654424899;5588.161775733673;5592.440755924375;5592.664440133605;5552.888942221133;5661.575381846378;5664.830055098354;5674.432556744293;5674.886502269931;5557.166425036277;5585.832425027255;5591.161325801162;5598.412166722517;5699.800506982236;5659.264295641623;5661.377248502661;5666.15007748841;5666.631668941588;5708.600397972102;4334.4798624165305;4337;4337.891552711208;4339.414179085846;4378.715383500063;3821.235752849386;3844.7308688392104;3848.3073046851837;3857.286402015636;3861.787601681878;5401.7029063401105;5403.945960540423;5404.0272750905215;5427.9185812212845;5452.5365343946205;5686.914696279559;5703.8859222816145;5733.283339582552;5733.741981610838;5742.942570574324;5209.7916083356995;5296.92054619181;5318.22885681574;5359.812406565751;5426.70153141581;4920.188168952154;4953.950460495349;4960.330355402047;4991.376077990251;5007.298978143063;5888.735006924699;5893.970530147321;5894.970525147432;5898.734556944948;5901.498372638202;5546.223528705904;5591.720413979366;5598.076317407582;5724.112762521816;5729.255196824386;5815.098659707752;5848.327442344185;5861.853453663522;5866.560007999503;5877.382874798255;5546.195801608664;5581.888362232651;5584.776608935597;5586.692731899784;5594.300712410949;5679.829605111853;5688.288963879515;5688.63023903445;5691.4877661010705;5706.885862282814;5548.112302031655;5551.555875530029;5561.4716601922755;5563.02647036775;5572.86067848307;5515.117581186991;5534.1145416733125;5534.39121696605;5537.584681148849;5538.723063846872;5432.239486471818;5435.239066530768;5474.589405794661;5477.986572484103;5482.8081017165805;5625.46558076982;5629.493345598916;5632.042552765957;5634.85912852182;5641.774329026957;5359.946400536101;5497.230387745639;5512.118061110203;5516.834494965157;5556.805511807067
00:42:18 INFO - PROCESS | 11037 | |1;ext.html;601.9916639628622;618.4186864347514;643.1478291264074;649.3830860682347;653.4445721137034;32122;41729.3740593891;43156.784216078915;43271.35092973608;46590;42939.57060429395;43375.78312108443;43404.92331073644;43410.565894341045;43428.78285608567;7930.167332430098;8533.615987280571;8590.699325523608;8677.349198810083;8683.2185103341;8081.878771818428;10043.296969212159;10350.948245258764;10361.481925903674;10635.096016838577;10382.428966406844;10399.220058495604;10463.84304235437;10484.108850747658;10487.685369438928;10243.28297019209;10274.126699230574;10306.381617102998;10312.175025997902;10314.484275786255;10072.496375181212;10112.848307275397;10125.139363154141;10137.645182418653;10140.645077422329;41242.79378603118;41283.7935810322;41451.37822932658;41548.584514154776;41589.376159357635;3484.6515348465205;3498.4577390504514;3530.9823450882836;3546.113471632092;3574.8391322390294;31646.525302120488;31726;31788.523172152436;31865.84067079673;31953;4046.858359957387;4062.7968601569805;4229.49246090468;4261.147770445892;4366.257736184824;312630;313022.4348878264;313489;315795;316418;58471;58873.41126588765;59029.704851475464;59205.40794591999;59377;61791.38208617946;62030.68984655048;62495.375046249865;62746.37253627497;62770.23378597299;16902.32390704358;17185.570360741083;17208.1395930203;17210.31158753661;17213.483595492155;11862.169648124722;12208.267503949792;12287.508499659914;12329.753404931851;12840.357982100857;18695.345662902004;18766.343177988703;19299.075086433695;19615.607687846164;19629;7186;7238.384737297389;7283.4537409694485;7410.258974102654;7500.699972001168;961.6345788600287;1030.4178139351393;1068.4123731947398;1090.3566895531674;1155.1451925575013;31440.213994650316;31914.361712765614;32052;32403.837980809945;32497.51253731196;994.4778991029767;1094.9616763413242;1108.7671588966246;1125.651048175052;1134;16113.597160070858;17007.40474083426;17011.319547217972;17109.572260693334;17413.564660883578;456121;469859;470260;470757;472008;58857.87702906056;59645.10532342018;59712;59785;59816.40183598108;1253.7868562344424;1298.8766067223598;1315.855255921867;1354.9390277437342;1360.394624392136;29656.110316690534;33439.66560334463;33483.823551469075;33537.49693754644;33598.83200583982;50591.747041264556;50896;51112.233316499536;51218.48781512286;51237.74381128071;363610;364606;366219.70242380013;366563;366778;26900;27613.30966725848;27670.16989490238;28759.281017974718;29009.564856526747;47114.52885471102;47120.057598848514;47838.52161478341;47965.760171200316;48094.75952620214;39436.27111260726;39855.601443985186;39909.20181596294;40935;41103.794481027406;39331.2133757329;40167.530714794586;40493.59506405016;40560.1887962245;42147.15705685808;40325.79837100796;40677;41112;41781.164376712906;41941;33443.498347525296;35891.820540897126;36258.136433305415;36566.817165914;36862.262754745294;27514.587281191198;27728.306792330353;27744.44511109807;27782.305442363293;27987.440251194454
00:42:18 INFO - PROCESS | 11037 | |2;jquery.html;370.4128955605365;400.86170271256407;403.67907513526745;406.8982754311423;421.93249080147183;13842.723145537084;18635.534111647197;18644.254229830825;18674.813251867476;18786.248550058015;17894.284228630873;18298.634027319447;18476.260949562;18532.258709651633;18639.440816775485;5425.674459532421;5432.859099589081;5650.180723795047;5651.689157096358;5655.886882262353;5506.944930550703;5636.7181640918;5660.235868157808;5675.6878371689545;5677;5361.222622719703;5625.296837895263;5645.604807663465;5648.350439699446;5648.576356773258;5472.480114389126;5510.338759348863;5545.916811247795;5546.805861794818;5552.472515111058;4787.832425865078;4957.876053098666;4973.825916092956;4977.800887964477;4990.326305948723;21549.56900861974;21610;21651.78348216529;21911.233106841344;21945.231916882833;2360.480694247263;2400.6759087523137;2430.2101816909576;2692.9362901653735;2720.8775605097817;13202.141860779115;13464.798028029587;13470.86529134706;13749.725005499935;13938;1847.8521718262507;1929.556202073517;1941.107090738262;1991.3030439346257;2027.7769445360998;77657;78246.82768313719;78784;79497.60251198708;80709.59645201854;10171.694849154537;10359.844602330972;10567.577296908192;10599.364038157735;10722.78554428907;14503;14534.127952322682;14539.636509087357;14541.491047813275;14554.41782328695;7710.575918324434;7845.686172553148;7878.487898286593;8053.34906344198;8215.260626543639;7385.113786345673;7415.925840741632;7646.9617651911385;7668.578228197391;7704.730334438268;6240.157578726905;6377.64922929234;6414.61512309263;6446.580972236789;6514.54398192122;1823.2314654784836;1874.3252429125505;1883.50087226885;1908.6278175755872;1922.0774028466415;764.6711913877086;788.2787249666605;846.090452763282;849.9915000850036;953.6471505542994;17783.288668453377;18631.347902823338;19154.52113697141;19163.61672766537;19554.31559895397;882.3691060891493;898.6809682562726;916.7341470973477;918.9678361257457;930.3534043839467;8349.33205343571;11039.337639741641;11107.888921110847;11123.16576256784;11123.499442525106;430812;437943;437949;441937;443452;72315;75317;76762.23237767663;77611.61194194105;77736;1002.2282842211456;1024.774549599087;1046.1317106801337;1050.947452627381;1058.4919238765435;16237.675246494768;16722.163891805605;16734.246958887124;16871.240794164536;17084.74372884383;37036.25927481381;37590;37874.43188352122;38617.42073868838;38788;49151;49351.50648493469;49360.50639493703;49364;49586.75206623944;8016.599170041592;8041.155678653891;8233.300169485421;8261;8351.791205219919;12009.579664711693;12117.57588484434;12302.507899683913;12326.938365308117;12380.133390662568;10835.945820271163;11109.388983605979;11153.107751380032;11175.21773475849;11394.316341019565;10415.895841041796;10616.946915265375;10832.620858269922;10949.56201751921;11215.271007384494;11038.282511636718;11133.347640127771;11196;11321.547138114383;11338.659840204808;8103.918960810553;8146.370725854734;8344.040435350013;8391.412601117863;8534.359923005675;10648.574057037631;10650.094741946712;10823.783524329312;10879.456027198767;11371.943140284246
00:42:18 INFO - PROCESS | 11037 | |3;mootools.html;1275.445181346114;1293.514931900537;1363.6999860030794;1411.6964852556705;1724.1551639696552;7439.776806695801;8085.636146373413;8304.543250121242;8331.083580806115;8546.05993340732;8392.62233199506;8395.286400655936;8436.831263374728;8458.281046111073;8458.788530286745;2317.9420514487106;2351.5061837014246;2352.6588644646517;2353.682252895863;2357.092519380034;2297.368223738477;2366;2369.360272726363;2370.442945907719;2390.043982407042;2299.839011269212;2313.8033267172227;2324.6164382876805;2344.906203751848;2347.85912845229;2246.3710161154904;2267.501149747053;2285.542891421714;2286.4055345610177;2309.307207837659;2276.920307789236;2331.5336932613377;2335.135999680112;2340.7659234076627;2342.8008619267384;8145.633446494922;8463.195996380335;8466.238038576557;8508.276796472246;8526.74419767408;5182.792688292464;5312.893742125175;5348.973255133699;5377.247185394048;5379.731013449351;3311.787566060917;3330.96669033309;3402.6427225141497;3409.7442691797964;3518.190816112283;1221.822835688829;1231.778279909616;1249.1505776072268;1285.1774864086992;2017.6166528359565;11321.490532926038;11751.177417580773;11763.588274410355;11763.64709058721;11775.7056073598;4604.470485894098;4722.598579120745;4751.881202969954;4898.926516102261;4902.117618828645;9347.813043739086;9457.76355591102;9465.100815422524;9478.715638530855;9493.477858717699;5348.91976620351;5353.170258609922;5358.54452371545;5363.168708850135;5368.91946620801;4025.7383270087353;4314.482262128565;4811.903761924812;4815.277708343707;5012.8496145115705;3644.5079914211774;3702.33357995558;3738.6448287412654;3764.134249122717;3773.056735816046;1061.946902654864;1167.0663469224587;1178.9469473873696;1187.827764974074;1202.7173614200656;768.3622593247591;868.1795703060548;875.2210532625968;887.2502735188755;923.4874644572193;5315.946840531546;5376.1398176291605;5435.157550579666;5483.232347471358;5521.089020311684;901.4816480523594;903.4940433357341;917.2249449215402;932.8227636748996;934.1125930366044;3467.4278744006956;3619.5113659656135;3649.2154186849953;3701.8149092545264;3732.104294969188;10007.299489035697;10027.949860250797;10379.896201038044;10434.217433692504;10570.365778053188;10233.48832558369;10377.066064054272;10396.792064158675;10399.636012739518;10411.47942602882;7555.848883022309;7645.235476452422;7722.111957125003;7729.3043626072795;7732.188120247405;5470.9179362308805;5557.305336832896;5609.186667933209;5622.212890195294;5875.618084824473;9423.905760942303;9434.764130896783;9524.14282714559;9566.56950437218;9602.807943841224;9720.902790971999;9753.122219000325;9832.655857044969;9832.803343933225;9907.405555666683;6524.543281970216;6765.729370825112;7499.437542184467;7559.092908850973;7733.883991740241;8190.385721070825;8280.544570048705;8292.585370731318;8293.295069919124;8295.336373090018;7317.19510853795;7325.926740732738;7345.22875098107;7440.851182976418;7699.538027718355;7148.928510714826;7478.551286922802;7486.401087912845;7492.475526713078;7496.212897645669;6730.721162979018;6859.794206173823;6860.897086543806;6861.691223894837;6874.6562671867205;4716.858494245178;4980.750962451935;4999.075171093359;5115.56517696;5227.085260079547;4744.952550474451;4948.257761335828;4966.652334336706;5016.6237532184505;5017.2724954880605
00:42:18 INFO - PROCESS | 11037 | |4;prototype.html;340.02074026802813;343.7988776565709;346.791924845093;351.7590450541378;352.4624946955893;5213.9478605213935;5223.425423203449;5232.6075544334135;5248.921266181011;5250.343707036621;5222.92165617516;5234.54520016789;5236.6857988520715;5244.895102097956;5253.080710875601;3977.3238549446664;4018.8191531381012;4032.3064312988467;4067.1458993611227;4073.30753771858;4086.5300490443533;4089.407035979781;4102.917941641165;4116.300228961069;4127.917441651165;4070.9185816283657;4071;4071.8167682454214;4085.9182816343655;4124.8143833527565;3704.74066815323;3900.544054544193;3971.1137209825392;4087.7342972706974;4105.979470102645;3619.6742293193474;3624.238909828939;3639.1629925117372;3640.1809592841664;3649.4160934250394;5047.167217409123;5050.7222102784335;5059.367579052619;5093.490650934914;5101.69389836611;4449.844255451044;4571.3600095986585;4614.284785858197;4642.419697537808;4645.767711614406;5342.599305052097;5372.623916325859;5374.408815030343;5384;5388.676679399209;3960.6237407446247;3969.9007524811823;3985.8007099645192;3987.461692671481;3988.481497405319;5386.811461598864;5484.930438564482;5506.889862202774;5648.85877853057;5665.915011274834;4034.919301613951;4035.5157381114454;4059.188162367538;4059.9797001014804;4060.553339132693;4084.7344922579937;4096.508418989681;4117.949922769674;4119.546849846514;4128.195001974646;4329.76186309756;4620.353150558924;4680.742559159279;4688.132695451352;4693.6949098308505;5365.785368585213;5378.7041712705395;5384.657673911783;5391.676499409969;5401.513863752281;1328.7209685965863;1329.8204742359658;1336.5765459785298;1337.104140226051;1345.387848528917;882.567541904475;903.8779764731809;940.1773448232797;944.9716508504756;956.8277710012264;5166.844994650167;5225.294585230945;5230.476952304815;5230.581553475713;5238.135707608279;5525.723713814374;5527.944720552823;5554.722263886871;5593.188987596775;5593.972030139823;5115.641905066684;5275.498827611371;5281.973590132025;5282.181261904411;5291.788328466895;2825.420788738345;2832.787540934397;2847.1743194473784;2847.3343094289658;2853.258152880266;5544.168374743821;5546.944530554642;5554.389017208104;5577.386487486373;5578.135389014709;5303.15149576066;5409.24270602116;5412.83761487156;5438.864028399243;5457.345118585795;5519.448055194529;5522.723863806794;5541.420695101877;5541.750621222055;5565.135679547316;5220.9477905220465;5381.461853814587;5406.89131238825;5468.5351745100525;5473.644213126134;5456.7627272819545;5478.780848766005;5482.314710661168;5505.366882808528;5509.47659972302;5716.971415142898;5735.225744524602;5750.30996280449;5772.884542309214;5806.4193580641595;3940.5074365704286;3996.9000774979695;4023.93964090533;4033.1328764315813;4043.878683639378;5534.7509362078;5560.415281644712;5570.58220633446;5589.273394458857;5593.440655934374;5407.270018547603;5434.402215756185;5435.184722291688;5447.237386765935;5473.233747275464;5238.795077132357;5399.83800485986;5425.1862220665635;5437.972810135924;5449;5320.973395133;5345.22494238341;5359.829269146002;5375.3280839895015;5378.112611419072;5268.1044222481505;5343.732813359395;5400.648957817729;5449.891002180014;5490.478404551562;5367.114426119647;5380.408155103014;5401.72991350423;5402.486763757437;5405.567464659891
00:42:18 INFO - PROCESS | 11037 | |5;yui.html;762.0588573112205;762.1580584817375;764.4228607401411;787.3622365883633;792.6829268292686;13447.1259368141;14125.152490850543;14545.272736363193;14856.777148342784;15017.774733379008;13264.668383290422;13450.798238026437;13458.259795711232;13459.192448453075;13480;795.2246559604368;805.04602046575;805.114374188394;805.5166899860095;806;674.3728332650633;689.7861662884521;778.2023425988351;801.8757092650649;802.9759107226793;852.0286872964825;853.9957300213521;854.5342788180426;855.0252711908398;855.1277696749343;849.2059923971076;851.5018714052287;855.3627547477107;856.1139220906394;856.7429771068654;516.7906997665951;531.8590573498026;598.5032423088826;613.0558939233575;623.1494010675395;14341.928290358586;14392.208428536427;14398.856011439857;14407.423703051865;14409;12474.750504989941;12609.936950315281;12797.552085677049;12808;13133.86866131336;10907.400092994882;11059.391733454657;11110.388928608923;11151.57280379707;11401.657950261506;4074.0629655179177;4087;4162.708610397273;4219.767912764797;4320.1575692739925;51936.74031629856;54352;54416.72791636056;60790.088148678245;61396.386036139964;10291.588336466608;10688.83966740484;10748.247622666338;10869.891301086887;10967.50646220922;19117.904410478135;19333;19540.31608893682;19555.511112222022;19620.215191392184;8045.15525869787;8239.299659529008;8291.751247462586;8304.501729896225;8481.024682161507;4299.312110062375;4399.868003959887;4459.264221403432;4465.821367145343;4599.793009314589;3319.4854797506423;3427.657234276602;3434.4676575130893;3548.449990251515;3739.8504059837846;627.2567008095422;629.3171908479351;629.4397985792648;640.9391107844747;651.4625434016955;696.7073828991836;699.912510936133;722.4112348436113;725.39067183565;725.4258259576732;8629.69796057135;8947.955260223658;8983.910160898438;9087.454752714859;9135.680251191176;675.3651567526509;683.4361651637419;684.5379368925956;694.5624256718336;698.769406095987;4319.848805291863;4448.35498852671;4612.723236605814;4687.273472611751;4814.831480898151;85283;89012.5549372249;89648;90015;91681;49201.26198107031;49362.75318623384;50719.74640126776;58072;67820.98268525976;71731;73031.26968730244;73132.26867731361;73178.26821731715;73701.89447158297;9412;9499.57251923679;9585.520723963635;9593.088656577615;9595.856062158933;46237.53762462332;46492;47095.52904470912;47890.760546197045;48522.5147748518;40199.79900100481;40480.59519404768;58702;64567.35432645614;66447.66776166088;12114.75770484603;12357.691057723629;12394;13052.086353955512;13199.67000824987;14151.787723184367;14200.644983875485;14284.642883927569;14562.490312839;15093.698126037638;12326;13275.336233188495;13543.932280338535;13583.388747506584;13980.300984950509;12995.870041299844;13107.213567186;13195.142315749446;13327.66680832948;13337.133086349357;12610.117291789487;12963.805542916674;13224.272665003133;13363.599092027254;13741.725165496435;10201.38791672502;10534.315269507457;10991.120710342993;11038.17213708959;11283.040941519734;10816.651219500081;11210.831837522606;11373.20387572862;11459.885401145882;11554.826677599674
00:42:18 INFO - PROCESS | 11037 | __end_tp_report
00:42:18 INFO - PROCESS | 11037 | __start_cc_report
00:42:18 INFO - PROCESS | 11037 | _x_x_mozilla_cycle_collect,2506
00:42:18 INFO - PROCESS | 11037 | __end_cc_report
00:42:18 INFO - PROCESS | 11037 | __startTimestamp1479804138599__endTimestamp
00:42:18 INFO - PROCESS | 11037 |
00:42:18 INFO - PROCESS | 11037 | ------- Summary: start -------
00:42:18 INFO - PROCESS | 11037 | Number of tests: 6
00:42:18 INFO - PROCESS | 11037 |
00:42:18 INFO - PROCESS | 11037 | [#0] dojo.html Cycles:165 Average:5269.77 Median:5512.12 stddev:599.55 (10.9%) stddev-sans-first:573.06
00:42:18 INFO - PROCESS | 11037 | Values: 2948.4 2964.3 2993.1 3005.3 3014.3 5138.1 5190.4 5209.2 5243.4 5290.7 5278.0 5279.5 5327.7 5331.0 5437.1 4784.0 4802.5 4829.0 4912.9 4918.5 4860.3 4865.7 4899.0 4903.0 4957.1 4954.6 4965.4 4966.8 4989.3 5010.4 4772.0 4812.5 4812.8 4850.0 4884.5 4826.3 4831.8 4841.1 4844.8 4847.7 5143.0 5196.7 5207.3 5277.1 5289.1 5605.8 5646.5 5648.2 5649.0 5662.3 5592.2 5645.8 5655.2 5655.7 5657.5 5171.4 5276.8 5281.4 5286.6 5320.2 5685.2 5724.1 5745.3 5769.1 5811.3 5585.2 5587.3 5588.2 5592.4 5592.7 5552.9 5661.6 5664.8 5674.4 5674.9 5557.2 5585.8 5591.2 5598.4 5699.8 5659.3 5661.4 5666.2 5666.6 5708.6 4334.5 4337.0 4337.9 4339.4 4378.7 3821.2 3844.7 3848.3 3857.3 3861.8 5401.7 5403.9 5404.0 5427.9 5452.5 5686.9 5703.9 5733.3 5733.7 5742.9 5209.8 5296.9 5318.2 5359.8 5426.7 4920.2 4954.0 4960.3 4991.4 5007.3 5888.7 5894.0 5895.0 5898.7 5901.5 5546.2 5591.7 5598.1 5724.1 5729.3 5815.1 5848.3 5861.9 5866.6 5877.4 5546.2 5581.9 5584.8 5586.7 5594.3 5679.8 5688.3 5688.6 5691.5 5706.9 5548.1 5551.6 5561.5 5563.0 5572.9 5515.1 5534.1 5534.4 5537.6 5538.7 5432.2 5435.2 5474.6 5478.0 5482.8 5625.5 5629.5 5632.0 5634.9 5641.8 5359.9 5497.2 5512.1 5516.8 5556.8
00:42:18 INFO - PROCESS | 11037 |
00:42:18 INFO - PROCESS | 11037 | [#1] ext.html Cycles:180 Average:55482.10 Median:199934.07 stddev:102232.11 (51.1%) stddev-sans-first:102435.86
00:42:18 INFO - PROCESS | 11037 | Values: 602.0 618.4 643.1 649.4 653.4 32122.0 41729.4 43156.8 43271.4 46590.0 42939.6 43375.8 43404.9 43410.6 43428.8 7930.2 8533.6 8590.7 8677.3 8683.2 8081.9 10043.3 10350.9 10361.5 10635.1 10382.4 10399.2 10463.8 10484.1 10487.7 10243.3 10274.1 10306.4 10312.2 10314.5 10072.5 10112.8 10125.1 10137.6 10140.6 41242.8 41283.8 41451.4 41548.6 41589.4 3484.7 3498.5 3531.0 3546.1 3574.8 31646.5 31726.0 31788.5 31865.8 31953.0 4046.9 4062.8 4229.5 4261.1 4366.3 312630.0 313022.4 313489.0 315795.0 316418.0 58471.0 58873.4 59029.7 59205.4 59377.0 61791.4 62030.7 62495.4 62746.4 62770.2 16902.3 17185.6 17208.1 17210.3 17213.5 11862.2 12208.3 12287.5 12329.8 12840.4 18695.3 18766.3 19299.1 19615.6 19629.0 7186.0 7238.4 7283.5 7410.3 7500.7 961.6 1030.4 1068.4 1090.4 1155.1 31440.2 31914.4 32052.0 32403.8 32497.5 994.5 1095.0 1108.8 1125.7 1134.0 16113.6 17007.4 17011.3 17109.6 17413.6 456121.0 469859.0 470260.0 470757.0 472008.0 58857.9 59645.1 59712.0 59785.0 59816.4 1253.8 1298.9 1315.9 1354.9 1360.4 29656.1 33439.7 33483.8 33537.5 33598.8 50591.7 50896.0 51112.2 51218.5 51237.7 363610.0 364606.0 366219.7 366563.0 366778.0 26900.0 27613.3 27670.2 28759.3 29009.6 47114.5 47120.1 47838.5 47965.8 48094.8 39436.3 39855.6 39909.2 40935.0 41103.8 39331.2 40167.5 40493.6 40560.2 42147.2 40325.8 40677.0 41112.0 41781.2 41941.0 33443.5 35891.8 36258.1 36566.8 36862.3 27514.6 27728.3 27744.4 27782.3 27987.4
00:42:18 INFO - PROCESS | 11037 |
00:42:18 INFO - PROCESS | 11037 | [#2] jquery.html Cycles:180 Average:26517.94 Median:37313.13 stddev:72134.94 (193.3%) stddev-sans-first:72310.58
00:42:18 INFO - PROCESS | 11037 | Values: 370.4 400.9 403.7 406.9 421.9 13842.7 18635.5 18644.3 18674.8 18786.2 17894.3 18298.6 18476.3 18532.3 18639.4 5425.7 5432.9 5650.2 5651.7 5655.9 5506.9 5636.7 5660.2 5675.7 5677.0 5361.2 5625.3 5645.6 5648.4 5648.6 5472.5 5510.3 5545.9 5546.8 5552.5 4787.8 4957.9 4973.8 4977.8 4990.3 21549.6 21610.0 21651.8 21911.2 21945.2 2360.5 2400.7 2430.2 2692.9 2720.9 13202.1 13464.8 13470.9 13749.7 13938.0 1847.9 1929.6 1941.1 1991.3 2027.8 77657.0 78246.8 78784.0 79497.6 80709.6 10171.7 10359.8 10567.6 10599.4 10722.8 14503.0 14534.1 14539.6 14541.5 14554.4 7710.6 7845.7 7878.5 8053.3 8215.3 7385.1 7415.9 7647.0 7668.6 7704.7 6240.2 6377.6 6414.6 6446.6 6514.5 1823.2 1874.3 1883.5 1908.6 1922.1 764.7 788.3 846.1 850.0 953.6 17783.3 18631.3 19154.5 19163.6 19554.3 882.4 898.7 916.7 919.0 930.4 8349.3 11039.3 11107.9 11123.2 11123.5 430812.0 437943.0 437949.0 441937.0 443452.0 72315.0 75317.0 76762.2 77611.6 77736.0 1002.2 1024.8 1046.1 1050.9 1058.5 16237.7 16722.2 16734.2 16871.2 17084.7 37036.3 37590.0 37874.4 38617.4 38788.0 49151.0 49351.5 49360.5 49364.0 49586.8 8016.6 8041.2 8233.3 8261.0 8351.8 12009.6 12117.6 12302.5 12326.9 12380.1 10835.9 11109.4 11153.1 11175.2 11394.3 10415.9 10616.9 10832.6 10949.6 11215.3 11038.3 11133.3 11196.0 11321.5 11338.7 8103.9 8146.4 8344.0 8391.4 8534.4 10648.6 10650.1 10823.8 10879.5 11371.9
00:42:18 INFO - PROCESS | 11037 |
00:42:18 INFO - PROCESS | 11037 | [#3] mootools.html Cycles:180 Average:5559.10 Median:5269.99 stddev:3093.21 (58.7%) stddev-sans-first:3085.13
00:42:18 INFO - PROCESS | 11037 | Values: 1275.4 1293.5 1363.7 1411.7 1724.2 7439.8 8085.6 8304.5 8331.1 8546.1 8392.6 8395.3 8436.8 8458.3 8458.8 2317.9 2351.5 2352.7 2353.7 2357.1 2297.4 2366.0 2369.4 2370.4 2390.0 2299.8 2313.8 2324.6 2344.9 2347.9 2246.4 2267.5 2285.5 2286.4 2309.3 2276.9 2331.5 2335.1 2340.8 2342.8 8145.6 8463.2 8466.2 8508.3 8526.7 5182.8 5312.9 5349.0 5377.2 5379.7 3311.8 3331.0 3402.6 3409.7 3518.2 1221.8 1231.8 1249.2 1285.2 2017.6 11321.5 11751.2 11763.6 11763.6 11775.7 4604.5 4722.6 4751.9 4898.9 4902.1 9347.8 9457.8 9465.1 9478.7 9493.5 5348.9 5353.2 5358.5 5363.2 5368.9 4025.7 4314.5 4811.9 4815.3 5012.8 3644.5 3702.3 3738.6 3764.1 3773.1 1061.9 1167.1 1178.9 1187.8 1202.7 768.4 868.2 875.2 887.3 923.5 5315.9 5376.1 5435.2 5483.2 5521.1 901.5 903.5 917.2 932.8 934.1 3467.4 3619.5 3649.2 3701.8 3732.1 10007.3 10027.9 10379.9 10434.2 10570.4 10233.5 10377.1 10396.8 10399.6 10411.5 7555.8 7645.2 7722.1 7729.3 7732.2 5470.9 5557.3 5609.2 5622.2 5875.6 9423.9 9434.8 9524.1 9566.6 9602.8 9720.9 9753.1 9832.7 9832.8 9907.4 6524.5 6765.7 7499.4 7559.1 7733.9 8190.4 8280.5 8292.6 8293.3 8295.3 7317.2 7325.9 7345.2 7440.9 7699.5 7148.9 7478.6 7486.4 7492.5 7496.2 6730.7 6859.8 6860.9 6861.7 6874.7 4716.9 4980.8 4999.1 5115.6 5227.1 4745.0 4948.3 4966.7 5016.6 5017.3
00:42:18 INFO - PROCESS | 11037 |
00:42:18 INFO - PROCESS | 11037 | [#4] prototype.html Cycles:180 Average:4559.23 Median:5249.63 stddev:1326.28 (25.3%) stddev-sans-first:1291.64
00:42:18 INFO - PROCESS | 11037 | Values: 340.0 343.8 346.8 351.8 352.5 5213.9 5223.4 5232.6 5248.9 5250.3 5222.9 5234.5 5236.7 5244.9 5253.1 3977.3 4018.8 4032.3 4067.1 4073.3 4086.5 4089.4 4102.9 4116.3 4127.9 4070.9 4071.0 4071.8 4085.9 4124.8 3704.7 3900.5 3971.1 4087.7 4106.0 3619.7 3624.2 3639.2 3640.2 3649.4 5047.2 5050.7 5059.4 5093.5 5101.7 4449.8 4571.4 4614.3 4642.4 4645.8 5342.6 5372.6 5374.4 5384.0 5388.7 3960.6 3969.9 3985.8 3987.5 3988.5 5386.8 5484.9 5506.9 5648.9 5665.9 4034.9 4035.5 4059.2 4060.0 4060.6 4084.7 4096.5 4117.9 4119.5 4128.2 4329.8 4620.4 4680.7 4688.1 4693.7 5365.8 5378.7 5384.7 5391.7 5401.5 1328.7 1329.8 1336.6 1337.1 1345.4 882.6 903.9 940.2 945.0 956.8 5166.8 5225.3 5230.5 5230.6 5238.1 5525.7 5527.9 5554.7 5593.2 5594.0 5115.6 5275.5 5282.0 5282.2 5291.8 2825.4 2832.8 2847.2 2847.3 2853.3 5544.2 5546.9 5554.4 5577.4 5578.1 5303.2 5409.2 5412.8 5438.9 5457.3 5519.4 5522.7 5541.4 5541.8 5565.1 5220.9 5381.5 5406.9 5468.5 5473.6 5456.8 5478.8 5482.3 5505.4 5509.5 5717.0 5735.2 5750.3 5772.9 5806.4 3940.5 3996.9 4023.9 4033.1 4043.9 5534.8 5560.4 5570.6 5589.3 5593.4 5407.3 5434.4 5435.2 5447.2 5473.2 5238.8 5399.8 5425.2 5438.0 5449.0 5321.0 5345.2 5359.8 5375.3 5378.1 5268.1 5343.7 5400.6 5449.9 5490.5 5367.1 5380.4 5401.7 5402.5 5405.6
00:42:18 INFO - PROCESS | 11037 |
00:42:18 INFO - PROCESS | 11037 | [#5] yui.html Cycles:180 Average:16951.81 Median:46364.77 stddev:22008.49 (47.5%) stddev-sans-first:22036.66
00:42:18 INFO - PROCESS | 11037 | Values: 762.1 762.2 764.4 787.4 792.7 13447.1 14125.2 14545.3 14856.8 15017.8 13264.7 13450.8 13458.3 13459.2 13480.0 795.2 805.0 805.1 805.5 806.0 674.4 689.8 778.2 801.9 803.0 852.0 854.0 854.5 855.0 855.1 849.2 851.5 855.4 856.1 856.7 516.8 531.9 598.5 613.1 623.1 14341.9 14392.2 14398.9 14407.4 14409.0 12474.8 12609.9 12797.6 12808.0 13133.9 10907.4 11059.4 11110.4 11151.6 11401.7 4074.1 4087.0 4162.7 4219.8 4320.2 51936.7 54352.0 54416.7 60790.1 61396.4 10291.6 10688.8 10748.2 10869.9 10967.5 19117.9 19333.0 19540.3 19555.5 19620.2 8045.2 8239.3 8291.8 8304.5 8481.0 4299.3 4399.9 4459.3 4465.8 4599.8 3319.5 3427.7 3434.5 3548.4 3739.9 627.3 629.3 629.4 640.9 651.5 696.7 699.9 722.4 725.4 725.4 8629.7 8948.0 8983.9 9087.5 9135.7 675.4 683.4 684.5 694.6 698.8 4319.8 4448.4 4612.7 4687.3 4814.8 85283.0 89012.6 89648.0 90015.0 91681.0 49201.3 49362.8 50719.7 58072.0 67821.0 71731.0 73031.3 73132.3 73178.3 73701.9 9412.0 9499.6 9585.5 9593.1 9595.9 46237.5 46492.0 47095.5 47890.8 48522.5 40199.8 40480.6 58702.0 64567.4 66447.7 12114.8 12357.7 12394.0 13052.1 13199.7 14151.8 14200.6 14284.6 14562.5 15093.7 12326.0 13275.3 13543.9 13583.4 13980.3 12995.9 13107.2 13195.1 13327.7 13337.1 12610.1 12963.8 13224.3 13363.6 13741.7 10201.4 10534.3 10991.1 11038.2 11283.0 10816.7 11210.8 11373.2 11459.9 11554.8
00:42:18 INFO - PROCESS | 11037 | -------- Summary: end --------
00:42:18 INFO - PROCESS | 11037 |
00:42:19 INFO - TEST-INFO | 11037: exit 0
00:42:19 INFO - TEST-OK | dromaeo_css | took 1117959ms
00:42:19 INFO - TEST-START | kraken
00:42:19 INFO - operating with platform_type : linux_
00:42:19 INFO - Initialising browser for kraken test...
00:42:19 INFO - TEST-INFO | started process 11348 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpwXtb1r/profile http://localhost:44192/getInfo.html)
00:42:23 INFO - PROCESS | 11348 | __metrics Screen width/height:1600/1200
00:42:23 INFO - PROCESS | 11348 | colorDepth:24
00:42:23 INFO - PROCESS | 11348 | Browser inner width/height: 1024/697
00:42:23 INFO - PROCESS | 11348 | __metrics
00:42:24 INFO - PROCESS | 11348 | 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"
00:42:24 INFO - PROCESS | 11348 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver]
00:42:24 INFO - PROCESS | 11348 | console.error: PushService:
00:42:24 INFO - PROCESS | 11348 | stateChangeProcessEnqueue: Error transitioning state
00:42:24 INFO - PROCESS | 11348 | UnknownError
00:42:25 INFO - TEST-INFO | 11348: exit 0
00:42:25 INFO - Browser initialized.
00:42:25 INFO - Running cycle 1/1 for kraken test...
00:42:25 INFO - TEST-INFO | started process 11437 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpwXtb1r/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1)
00:42:37 INFO - PROCESS | 11437 | RSS: Main: 172990464
00:42:37 INFO - PROCESS | 11437 |
00:42:40 INFO - PROCESS | 11437 | Cycle 1(1): loaded http://localhost:44192/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:44192/tests/kraken/driver.html?testName=audio-beat-detection)
00:42:41 INFO - PROCESS | 11437 | RSS: Main: 238903296
00:42:41 INFO - PROCESS | 11437 |
00:42:43 INFO - PROCESS | 11437 | Cycle 1(1): loaded http://localhost:44192/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:44192/tests/kraken/driver.html?testName=audio-dft)
00:42:44 INFO - PROCESS | 11437 | RSS: Main: 216797184
00:42:44 INFO - PROCESS | 11437 |
00:42:47 INFO - PROCESS | 11437 | Cycle 1(1): loaded http://localhost:44192/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:44192/tests/kraken/driver.html?testName=audio-fft)
00:42:48 INFO - PROCESS | 11437 | RSS: Main: 296878080
00:42:48 INFO - PROCESS | 11437 |
00:42:50 INFO - PROCESS | 11437 | Cycle 1(1): loaded http://localhost:44192/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:44192/tests/kraken/driver.html?testName=audio-oscillator)
00:42:50 INFO - PROCESS | 11437 | RSS: Main: 206979072
00:42:50 INFO - PROCESS | 11437 |
00:42:52 INFO - PROCESS | 11437 | Cycle 1(1): loaded http://localhost:44192/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:44192/tests/kraken/driver.html?testName=imaging-gaussian-blur)
00:42:53 INFO - PROCESS | 11437 | RSS: Main: 213168128
00:42:53 INFO - PROCESS | 11437 |
00:42:56 INFO - PROCESS | 11437 | Cycle 1(1): loaded http://localhost:44192/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:44192/tests/kraken/driver.html?testName=imaging-darkroom)
00:42:57 INFO - PROCESS | 11437 | RSS: Main: 252231680
00:42:57 INFO - PROCESS | 11437 |
00:43:00 INFO - PROCESS | 11437 | Cycle 1(1): loaded http://localhost:44192/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:44192/tests/kraken/driver.html?testName=imaging-desaturate)
00:43:01 INFO - PROCESS | 11437 | RSS: Main: 252067840
00:43:01 INFO - PROCESS | 11437 |
00:43:03 INFO - PROCESS | 11437 | Cycle 1(1): loaded http://localhost:44192/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:44192/tests/kraken/driver.html?testName=json-parse-financial)
00:43:04 INFO - PROCESS | 11437 | RSS: Main: 251224064
00:43:04 INFO - PROCESS | 11437 |
00:43:05 INFO - PROCESS | 11437 | Cycle 1(1): loaded http://localhost:44192/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:44192/tests/kraken/driver.html?testName=json-stringify-tinderbox)
00:43:06 INFO - PROCESS | 11437 | RSS: Main: 213536768
00:43:06 INFO - PROCESS | 11437 |
00:43:08 INFO - PROCESS | 11437 | Cycle 1(1): loaded http://localhost:44192/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:44192/tests/kraken/driver.html?testName=stanford-crypto-aes)
00:43:08 INFO - PROCESS | 11437 | RSS: Main: 220041216
00:43:08 INFO - PROCESS | 11437 |
00:43:10 INFO - PROCESS | 11437 | Cycle 1(1): loaded http://localhost:44192/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:44192/tests/kraken/driver.html?testName=stanford-crypto-ccm)
00:43:11 INFO - PROCESS | 11437 | RSS: Main: 229543936
00:43:11 INFO - PROCESS | 11437 |
00:43:14 INFO - PROCESS | 11437 | Cycle 1(1): loaded http://localhost:44192/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:44192/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2)
00:43:14 INFO - PROCESS | 11437 | RSS: Main: 238129152
00:43:14 INFO - PROCESS | 11437 |
00:43:17 INFO - PROCESS | 11437 | Cycle 1(1): loaded http://localhost:44192/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:44192/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative)
00:43:18 INFO - PROCESS | 11437 | RSS: Main: 235134976
00:43:18 INFO - PROCESS | 11437 |
00:43:19 INFO - PROCESS | 11437 | Cycle 1(1): loaded http://localhost:44192/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:44192/tests/kraken/driver.html?testName=ai-astar)
00:43:20 INFO - PROCESS | 11437 | RSS: Main: 285184000
00:43:20 INFO - PROCESS | 11437 |
00:43:20 INFO - PROCESS | 11437 | __start_tp_report
00:43:20 INFO - PROCESS | 11437 | _x_x_mozilla_page_load
00:43:20 INFO - PROCESS | 11437 | _x_x_mozilla_page_load_details
00:43:20 INFO - PROCESS | 11437 | |i|pagename|runs|
00:43:20 INFO - PROCESS | 11437 | |0;ai-astar;104;111;112;113;112;111;111;111;112;112
00:43:20 INFO - PROCESS | 11437 | |1;audio-beat-detection;153;130;128;163;125;125;126;121;160;131
00:43:20 INFO - PROCESS | 11437 | |2;audio-dft;161;161;160;162;161;159;160;161;161;162
00:43:20 INFO - PROCESS | 11437 | |3;audio-fft;75;76;75;121;76;75;75;75;102;77
00:43:20 INFO - PROCESS | 11437 | |4;audio-oscillator;83;83;107;81;82;82;108;82;81;114
00:43:20 INFO - PROCESS | 11437 | |5;imaging-gaussian-blur;116;117;116;117;116;116;117;117;117;117
00:43:20 INFO - PROCESS | 11437 | |6;imaging-darkroom;145;146;146;146;146;147;145;145;146;145
00:43:20 INFO - PROCESS | 11437 | |7;imaging-desaturate;96;96;97;95;96;95;96;96;95;95
00:43:20 INFO - PROCESS | 11437 | |8;json-parse-financial;53;51;52;51;50;53;51;52;52;52
00:43:20 INFO - PROCESS | 11437 | |9;json-stringify-tinderbox;63;62;62;62;62;63;62;62;62;63
00:43:20 INFO - PROCESS | 11437 | |10;stanford-crypto-aes;85;87;80;81;80;87;81;88;86;81
00:43:20 INFO - PROCESS | 11437 | |11;stanford-crypto-ccm;142;137;131;129;134;141;131;137;185;133
00:43:20 INFO - PROCESS | 11437 | |12;stanford-crypto-pbkdf2;166;170;168;168;164;165;162;168;167;164
00:43:20 INFO - PROCESS | 11437 | |13;stanford-crypto-sha256-iterative;66;68;64;65;66;66;65;66;68;66
00:43:20 INFO - PROCESS | 11437 | __end_tp_report
00:43:20 INFO - PROCESS | 11437 | __start_cc_report
00:43:20 INFO - PROCESS | 11437 | _x_x_mozilla_cycle_collect,1687
00:43:20 INFO - PROCESS | 11437 | __end_cc_report
00:43:20 INFO - PROCESS | 11437 | __startTimestamp1479804200151__endTimestamp
00:43:20 INFO - PROCESS | 11437 |
00:43:20 INFO - PROCESS | 11437 | ------- Summary: start -------
00:43:20 INFO - PROCESS | 11437 | Number of tests: 14
00:43:20 INFO - PROCESS | 11437 |
00:43:20 INFO - PROCESS | 11437 | [#0] ai-astar Cycles:10 Average:110.90 Median:112.00 stddev:2.51 (2.2%) stddev-sans-first:0.71
00:43:20 INFO - PROCESS | 11437 | Values: 104.0 111.0 112.0 113.0 112.0 111.0 111.0 111.0 112.0 112.0
00:43:20 INFO - PROCESS | 11437 |
00:43:20 INFO - PROCESS | 11437 | [#1] audio-beat-detection Cycles:10 Average:136.20 Median:130.50 stddev:15.94 (12.2%) stddev-sans-first:15.70
00:43:20 INFO - PROCESS | 11437 | Values: 153.0 130.0 128.0 163.0 125.0 125.0 126.0 121.0 160.0 131.0
00:43:20 INFO - PROCESS | 11437 |
00:43:20 INFO - PROCESS | 11437 | [#2] audio-dft Cycles:10 Average:160.80 Median:161.00 stddev:0.92 (0.6%) stddev-sans-first:0.97
00:43:20 INFO - PROCESS | 11437 | Values: 161.0 161.0 160.0 162.0 161.0 159.0 160.0 161.0 161.0 162.0
00:43:20 INFO - PROCESS | 11437 |
00:43:20 INFO - PROCESS | 11437 | [#3] audio-fft Cycles:10 Average:82.70 Median:75.00 stddev:15.84 (21.1%) stddev-sans-first:16.55
00:43:20 INFO - PROCESS | 11437 | Values: 75.0 76.0 75.0 121.0 76.0 75.0 75.0 75.0 102.0 77.0
00:43:20 INFO - PROCESS | 11437 |
00:43:20 INFO - PROCESS | 11437 | [#4] audio-oscillator Cycles:10 Average:90.30 Median:82.00 stddev:13.50 (16.5%) stddev-sans-first:14.06
00:43:20 INFO - PROCESS | 11437 | Values: 83.0 83.0 107.0 81.0 82.0 82.0 108.0 82.0 81.0 114.0
00:43:20 INFO - PROCESS | 11437 |
00:43:20 INFO - PROCESS | 11437 | [#5] imaging-gaussian-blur Cycles:10 Average:116.60 Median:117.00 stddev:0.52 (0.4%) stddev-sans-first:0.50
00:43:20 INFO - PROCESS | 11437 | Values: 116.0 117.0 116.0 117.0 116.0 116.0 117.0 117.0 117.0 117.0
00:43:20 INFO - PROCESS | 11437 |
00:43:20 INFO - PROCESS | 11437 | [#6] imaging-darkroom Cycles:10 Average:145.70 Median:146.00 stddev:0.67 (0.5%) stddev-sans-first:0.67
00:43:20 INFO - PROCESS | 11437 | Values: 145.0 146.0 146.0 146.0 146.0 147.0 145.0 145.0 146.0 145.0
00:43:20 INFO - PROCESS | 11437 |
00:43:20 INFO - PROCESS | 11437 | [#7] imaging-desaturate Cycles:10 Average:95.70 Median:96.00 stddev:0.67 (0.7%) stddev-sans-first:0.71
00:43:20 INFO - PROCESS | 11437 | Values: 96.0 96.0 97.0 95.0 96.0 95.0 96.0 96.0 95.0 95.0
00:43:20 INFO - PROCESS | 11437 |
00:43:20 INFO - PROCESS | 11437 | [#8] json-parse-financial Cycles:10 Average:51.70 Median:52.00 stddev:0.95 (1.8%) stddev-sans-first:0.88
00:43:20 INFO - PROCESS | 11437 | Values: 53.0 51.0 52.0 51.0 50.0 53.0 51.0 52.0 52.0 52.0
00:43:20 INFO - PROCESS | 11437 |
00:43:20 INFO - PROCESS | 11437 | [#9] json-stringify-tinderbox Cycles:10 Average:62.30 Median:62.00 stddev:0.48 (0.8%) stddev-sans-first:0.44
00:43:20 INFO - PROCESS | 11437 | Values: 63.0 62.0 62.0 62.0 62.0 63.0 62.0 62.0 62.0 63.0
00:43:20 INFO - PROCESS | 11437 |
00:43:20 INFO - PROCESS | 11437 | [#10] stanford-crypto-aes Cycles:10 Average:83.60 Median:85.50 stddev:3.27 (3.8%) stddev-sans-first:3.43
00:43:20 INFO - PROCESS | 11437 | Values: 85.0 87.0 80.0 81.0 80.0 87.0 81.0 88.0 86.0 81.0
00:43:20 INFO - PROCESS | 11437 |
00:43:20 INFO - PROCESS | 11437 | [#11] stanford-crypto-ccm Cycles:10 Average:140.00 Median:137.00 stddev:16.38 (12.0%) stddev-sans-first:17.36
00:43:20 INFO - PROCESS | 11437 | Values: 142.0 137.0 131.0 129.0 134.0 141.0 131.0 137.0 185.0 133.0
00:43:20 INFO - PROCESS | 11437 |
00:43:20 INFO - PROCESS | 11437 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:166.20 Median:167.50 stddev:2.44 (1.5%) stddev-sans-first:2.59
00:43:20 INFO - PROCESS | 11437 | Values: 166.0 170.0 168.0 168.0 164.0 165.0 162.0 168.0 167.0 164.0
00:43:20 INFO - PROCESS | 11437 |
00:43:20 INFO - PROCESS | 11437 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.00 Median:66.00 stddev:1.25 (1.9%) stddev-sans-first:1.32
00:43:20 INFO - PROCESS | 11437 | Values: 66.0 68.0 64.0 65.0 66.0 66.0 65.0 66.0 68.0 66.0
00:43:20 INFO - PROCESS | 11437 | -------- Summary: end --------
00:43:20 INFO - PROCESS | 11437 |
00:43:21 INFO - TEST-INFO | 11437: exit 0
00:43:21 INFO - TEST-OK | kraken | took 61880ms
00:43:21 INFO - SUITE-END | took 1179s
00:43:21 INFO - Completed test suite (00:19:40)
00:43:21 INFO - javascript benchmark
00:43:21 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2948.3661012882226, 2964.2737529305323, 2993.0571869861, 3005.3388254583997, 3014.32177760004, 5138.075146473638, 5190.351206099238, 5209.192575150853, 5243.449437809023, 5290.656107353019, 5278.0, 5279.524842764151, 5327.653702509334, 5331.040412725708, 5437.075697131488, 4783.952160478386, 4802.471728109905, 4829.0, 4912.926306105403, 4918.458969513351, 4860.295257187706, 4865.708057516543, 4899.0, 4902.975485122587, 4957.058158949806, 4954.628402869781, 4965.379327584052, 4966.751662416883, 4989.251612258154, 5010.448850626446, 4772.0217355442055, 4812.494688057738, 4812.759362031885, 4850.005748821518, 4884.462709101996, 4826.251930950708, 4831.806727730886, 4841.080194763019, 4844.7819848106565, 4847.684900481458, 5143.0, 5196.68819870809, 5207.297014902978, 5277.076511610453, 5289.074411977888, 5605.80379686709, 5646.520045796112, 5648.209250704905, 5649.039663257215, 5662.348829884533, 5592.245046918695, 5645.830625081254, 5655.208270842086, 5655.717214139277, 5657.462541058593, 5171.4311425743135, 5276.7889284428575, 5281.36623605166, 5286.577073834084, 5320.201969704575, 5685.1756495307945, 5724.055530837449, 5745.2818397700285, 5769.07694768835, 5811.3026436827, 5585.245991791137, 5587.273654424899, 5588.161775733673, 5592.440755924375, 5592.664440133605, 5552.888942221133, 5661.575381846378, 5664.830055098354, 5674.432556744293, 5674.886502269931, 5557.166425036277, 5585.832425027255, 5591.161325801162, 5598.412166722517, 5699.800506982236, 5659.264295641623, 5661.377248502661, 5666.15007748841, 5666.631668941588, 5708.600397972102, 4334.4798624165305, 4337.0, 4337.891552711208, 4339.414179085846, 4378.715383500063, 3821.235752849386, 3844.7308688392104, 3848.3073046851837, 3857.286402015636, 3861.787601681878, 5401.7029063401105, 5403.945960540423, 5404.0272750905215, 5427.9185812212845, 5452.5365343946205, 5686.914696279559, 5703.8859222816145, 5733.283339582552, 5733.741981610838, 5742.942570574324, 5209.7916083356995, 5296.92054619181, 5318.22885681574, 5359.812406565751, 5426.70153141581, 4920.188168952154, 4953.950460495349, 4960.330355402047, 4991.376077990251, 5007.298978143063, 5888.735006924699, 5893.970530147321, 5894.970525147432, 5898.734556944948, 5901.498372638202, 5546.223528705904, 5591.720413979366, 5598.076317407582, 5724.112762521816, 5729.255196824386, 5815.098659707752, 5848.327442344185, 5861.853453663522, 5866.560007999503, 5877.382874798255, 5546.195801608664, 5581.888362232651, 5584.776608935597, 5586.692731899784, 5594.300712410949, 5679.829605111853, 5688.288963879515, 5688.63023903445, 5691.4877661010705, 5706.885862282814, 5548.112302031655, 5551.555875530029, 5561.4716601922755, 5563.02647036775, 5572.86067848307, 5515.117581186991, 5534.1145416733125, 5534.39121696605, 5537.584681148849, 5538.723063846872, 5432.239486471818, 5435.239066530768, 5474.589405794661, 5477.986572484103, 5482.8081017165805, 5625.46558076982, 5629.493345598916, 5632.042552765957, 5634.85912852182, 5641.774329026957, 5359.946400536101, 5497.230387745639, 5512.118061110203, 5516.834494965157, 5556.805511807067], "value": 5228.278129001746, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [601.9916639628622, 618.4186864347514, 643.1478291264074, 649.3830860682347, 653.4445721137034, 32122.0, 41729.3740593891, 43156.784216078915, 43271.35092973608, 46590.0, 42939.57060429395, 43375.78312108443, 43404.92331073644, 43410.565894341045, 43428.78285608567, 7930.167332430098, 8533.615987280571, 8590.699325523608, 8677.349198810083, 8683.2185103341, 8081.878771818428, 10043.296969212159, 10350.948245258764, 10361.481925903674, 10635.096016838577, 10382.428966406844, 10399.220058495604, 10463.84304235437, 10484.108850747658, 10487.685369438928, 10243.28297019209, 10274.126699230574, 10306.381617102998, 10312.175025997902, 10314.484275786255, 10072.496375181212, 10112.848307275397, 10125.139363154141, 10137.645182418653, 10140.645077422329, 41242.79378603118, 41283.7935810322, 41451.37822932658, 41548.584514154776, 41589.376159357635, 3484.6515348465205, 3498.4577390504514, 3530.9823450882836, 3546.113471632092, 3574.8391322390294, 31646.525302120488, 31726.0, 31788.523172152436, 31865.84067079673, 31953.0, 4046.858359957387, 4062.7968601569805, 4229.49246090468, 4261.147770445892, 4366.257736184824, 312630.0, 313022.4348878264, 313489.0, 315795.0, 316418.0, 58471.0, 58873.41126588765, 59029.704851475464, 59205.40794591999, 59377.0, 61791.38208617946, 62030.68984655048, 62495.375046249865, 62746.37253627497, 62770.23378597299, 16902.32390704358, 17185.570360741083, 17208.1395930203, 17210.31158753661, 17213.483595492155, 11862.169648124722, 12208.267503949792, 12287.508499659914, 12329.753404931851, 12840.357982100857, 18695.345662902004, 18766.343177988703, 19299.075086433695, 19615.607687846164, 19629.0, 7186.0, 7238.384737297389, 7283.4537409694485, 7410.258974102654, 7500.699972001168, 961.6345788600287, 1030.4178139351393, 1068.4123731947398, 1090.3566895531674, 1155.1451925575013, 31440.213994650316, 31914.361712765614, 32052.0, 32403.837980809945, 32497.51253731196, 994.4778991029767, 1094.9616763413242, 1108.7671588966246, 1125.651048175052, 1134.0, 16113.597160070858, 17007.40474083426, 17011.319547217972, 17109.572260693334, 17413.564660883578, 456121.0, 469859.0, 470260.0, 470757.0, 472008.0, 58857.87702906056, 59645.10532342018, 59712.0, 59785.0, 59816.40183598108, 1253.7868562344424, 1298.8766067223598, 1315.855255921867, 1354.9390277437342, 1360.394624392136, 29656.110316690534, 33439.66560334463, 33483.823551469075, 33537.49693754644, 33598.83200583982, 50591.747041264556, 50896.0, 51112.233316499536, 51218.48781512286, 51237.74381128071, 363610.0, 364606.0, 366219.70242380013, 366563.0, 366778.0, 26900.0, 27613.30966725848, 27670.16989490238, 28759.281017974718, 29009.564856526747, 47114.52885471102, 47120.057598848514, 47838.52161478341, 47965.760171200316, 48094.75952620214, 39436.27111260726, 39855.601443985186, 39909.20181596294, 40935.0, 41103.794481027406, 39331.2133757329, 40167.530714794586, 40493.59506405016, 40560.1887962245, 42147.15705685808, 40325.79837100796, 40677.0, 41112.0, 41781.164376712906, 41941.0, 33443.498347525296, 35891.820540897126, 36258.136433305415, 36566.817165914, 36862.262754745294, 27514.587281191198, 27728.306792330353, 27744.44511109807, 27782.305442363293, 27987.440251194454], "value": 20132.145255901403, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [370.4128955605365, 400.86170271256407, 403.67907513526745, 406.8982754311423, 421.93249080147183, 13842.723145537084, 18635.534111647197, 18644.254229830825, 18674.813251867476, 18786.248550058015, 17894.284228630873, 18298.634027319447, 18476.260949562, 18532.258709651633, 18639.440816775485, 5425.674459532421, 5432.859099589081, 5650.180723795047, 5651.689157096358, 5655.886882262353, 5506.944930550703, 5636.7181640918, 5660.235868157808, 5675.6878371689545, 5677.0, 5361.222622719703, 5625.296837895263, 5645.604807663465, 5648.350439699446, 5648.576356773258, 5472.480114389126, 5510.338759348863, 5545.916811247795, 5546.805861794818, 5552.472515111058, 4787.832425865078, 4957.876053098666, 4973.825916092956, 4977.800887964477, 4990.326305948723, 21549.56900861974, 21610.0, 21651.78348216529, 21911.233106841344, 21945.231916882833, 2360.480694247263, 2400.6759087523137, 2430.2101816909576, 2692.9362901653735, 2720.8775605097817, 13202.141860779115, 13464.798028029587, 13470.86529134706, 13749.725005499935, 13938.0, 1847.8521718262507, 1929.556202073517, 1941.107090738262, 1991.3030439346257, 2027.7769445360998, 77657.0, 78246.82768313719, 78784.0, 79497.60251198708, 80709.59645201854, 10171.694849154537, 10359.844602330972, 10567.577296908192, 10599.364038157735, 10722.78554428907, 14503.0, 14534.127952322682, 14539.636509087357, 14541.491047813275, 14554.41782328695, 7710.575918324434, 7845.686172553148, 7878.487898286593, 8053.34906344198, 8215.260626543639, 7385.113786345673, 7415.925840741632, 7646.9617651911385, 7668.578228197391, 7704.730334438268, 6240.157578726905, 6377.64922929234, 6414.61512309263, 6446.580972236789, 6514.54398192122, 1823.2314654784836, 1874.3252429125505, 1883.50087226885, 1908.6278175755872, 1922.0774028466415, 764.6711913877086, 788.2787249666605, 846.090452763282, 849.9915000850036, 953.6471505542994, 17783.288668453377, 18631.347902823338, 19154.52113697141, 19163.61672766537, 19554.31559895397, 882.3691060891493, 898.6809682562726, 916.7341470973477, 918.9678361257457, 930.3534043839467, 8349.33205343571, 11039.337639741641, 11107.888921110847, 11123.16576256784, 11123.499442525106, 430812.0, 437943.0, 437949.0, 441937.0, 443452.0, 72315.0, 75317.0, 76762.23237767663, 77611.61194194105, 77736.0, 1002.2282842211456, 1024.774549599087, 1046.1317106801337, 1050.947452627381, 1058.4919238765435, 16237.675246494768, 16722.163891805605, 16734.246958887124, 16871.240794164536, 17084.74372884383, 37036.25927481381, 37590.0, 37874.43188352122, 38617.42073868838, 38788.0, 49151.0, 49351.50648493469, 49360.50639493703, 49364.0, 49586.75206623944, 8016.599170041592, 8041.155678653891, 8233.300169485421, 8261.0, 8351.791205219919, 12009.579664711693, 12117.57588484434, 12302.507899683913, 12326.938365308117, 12380.133390662568, 10835.945820271163, 11109.388983605979, 11153.107751380032, 11175.21773475849, 11394.316341019565, 10415.895841041796, 10616.946915265375, 10832.620858269922, 10949.56201751921, 11215.271007384494, 11038.282511636718, 11133.347640127771, 11196.0, 11321.547138114383, 11338.659840204808, 8103.918960810553, 8146.370725854734, 8344.040435350013, 8391.412601117863, 8534.359923005675, 10648.574057037631, 10650.094741946712, 10823.783524329312, 10879.456027198767, 11371.943140284246], "value": 8912.102072234404, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1275.445181346114, 1293.514931900537, 1363.6999860030794, 1411.6964852556705, 1724.1551639696552, 7439.776806695801, 8085.636146373413, 8304.543250121242, 8331.083580806115, 8546.05993340732, 8392.62233199506, 8395.286400655936, 8436.831263374728, 8458.281046111073, 8458.788530286745, 2317.9420514487106, 2351.5061837014246, 2352.6588644646517, 2353.682252895863, 2357.092519380034, 2297.368223738477, 2366.0, 2369.360272726363, 2370.442945907719, 2390.043982407042, 2299.839011269212, 2313.8033267172227, 2324.6164382876805, 2344.906203751848, 2347.85912845229, 2246.3710161154904, 2267.501149747053, 2285.542891421714, 2286.4055345610177, 2309.307207837659, 2276.920307789236, 2331.5336932613377, 2335.135999680112, 2340.7659234076627, 2342.8008619267384, 8145.633446494922, 8463.195996380335, 8466.238038576557, 8508.276796472246, 8526.74419767408, 5182.792688292464, 5312.893742125175, 5348.973255133699, 5377.247185394048, 5379.731013449351, 3311.787566060917, 3330.96669033309, 3402.6427225141497, 3409.7442691797964, 3518.190816112283, 1221.822835688829, 1231.778279909616, 1249.1505776072268, 1285.1774864086992, 2017.6166528359565, 11321.490532926038, 11751.177417580773, 11763.588274410355, 11763.64709058721, 11775.7056073598, 4604.470485894098, 4722.598579120745, 4751.881202969954, 4898.926516102261, 4902.117618828645, 9347.813043739086, 9457.76355591102, 9465.100815422524, 9478.715638530855, 9493.477858717699, 5348.91976620351, 5353.170258609922, 5358.54452371545, 5363.168708850135, 5368.91946620801, 4025.7383270087353, 4314.482262128565, 4811.903761924812, 4815.277708343707, 5012.8496145115705, 3644.5079914211774, 3702.33357995558, 3738.6448287412654, 3764.134249122717, 3773.056735816046, 1061.946902654864, 1167.0663469224587, 1178.9469473873696, 1187.827764974074, 1202.7173614200656, 768.3622593247591, 868.1795703060548, 875.2210532625968, 887.2502735188755, 923.4874644572193, 5315.946840531546, 5376.1398176291605, 5435.157550579666, 5483.232347471358, 5521.089020311684, 901.4816480523594, 903.4940433357341, 917.2249449215402, 932.8227636748996, 934.1125930366044, 3467.4278744006956, 3619.5113659656135, 3649.2154186849953, 3701.8149092545264, 3732.104294969188, 10007.299489035697, 10027.949860250797, 10379.896201038044, 10434.217433692504, 10570.365778053188, 10233.48832558369, 10377.066064054272, 10396.792064158675, 10399.636012739518, 10411.47942602882, 7555.848883022309, 7645.235476452422, 7722.111957125003, 7729.3043626072795, 7732.188120247405, 5470.9179362308805, 5557.305336832896, 5609.186667933209, 5622.212890195294, 5875.618084824473, 9423.905760942303, 9434.764130896783, 9524.14282714559, 9566.56950437218, 9602.807943841224, 9720.902790971999, 9753.122219000325, 9832.655857044969, 9832.803343933225, 9907.405555666683, 6524.543281970216, 6765.729370825112, 7499.437542184467, 7559.092908850973, 7733.883991740241, 8190.385721070825, 8280.544570048705, 8292.585370731318, 8293.295069919124, 8295.336373090018, 7317.19510853795, 7325.926740732738, 7345.22875098107, 7440.851182976418, 7699.538027718355, 7148.928510714826, 7478.551286922802, 7486.401087912845, 7492.475526713078, 7496.212897645669, 6730.721162979018, 6859.794206173823, 6860.897086543806, 6861.691223894837, 6874.6562671867205, 4716.858494245178, 4980.750962451935, 4999.075171093359, 5115.56517696, 5227.085260079547, 4744.952550474451, 4948.257761335828, 4966.652334336706, 5016.6237532184505, 5017.2724954880605], "value": 4487.393996734563, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [340.02074026802813, 343.7988776565709, 346.791924845093, 351.7590450541378, 352.4624946955893, 5213.9478605213935, 5223.425423203449, 5232.6075544334135, 5248.921266181011, 5250.343707036621, 5222.92165617516, 5234.54520016789, 5236.6857988520715, 5244.895102097956, 5253.080710875601, 3977.3238549446664, 4018.8191531381012, 4032.3064312988467, 4067.1458993611227, 4073.30753771858, 4086.5300490443533, 4089.407035979781, 4102.917941641165, 4116.300228961069, 4127.917441651165, 4070.9185816283657, 4071.0, 4071.8167682454214, 4085.9182816343655, 4124.8143833527565, 3704.74066815323, 3900.544054544193, 3971.1137209825392, 4087.7342972706974, 4105.979470102645, 3619.6742293193474, 3624.238909828939, 3639.1629925117372, 3640.1809592841664, 3649.4160934250394, 5047.167217409123, 5050.7222102784335, 5059.367579052619, 5093.490650934914, 5101.69389836611, 4449.844255451044, 4571.3600095986585, 4614.284785858197, 4642.419697537808, 4645.767711614406, 5342.599305052097, 5372.623916325859, 5374.408815030343, 5384.0, 5388.676679399209, 3960.6237407446247, 3969.9007524811823, 3985.8007099645192, 3987.461692671481, 3988.481497405319, 5386.811461598864, 5484.930438564482, 5506.889862202774, 5648.85877853057, 5665.915011274834, 4034.919301613951, 4035.5157381114454, 4059.188162367538, 4059.9797001014804, 4060.553339132693, 4084.7344922579937, 4096.508418989681, 4117.949922769674, 4119.546849846514, 4128.195001974646, 4329.76186309756, 4620.353150558924, 4680.742559159279, 4688.132695451352, 4693.6949098308505, 5365.785368585213, 5378.7041712705395, 5384.657673911783, 5391.676499409969, 5401.513863752281, 1328.7209685965863, 1329.8204742359658, 1336.5765459785298, 1337.104140226051, 1345.387848528917, 882.567541904475, 903.8779764731809, 940.1773448232797, 944.9716508504756, 956.8277710012264, 5166.844994650167, 5225.294585230945, 5230.476952304815, 5230.581553475713, 5238.135707608279, 5525.723713814374, 5527.944720552823, 5554.722263886871, 5593.188987596775, 5593.972030139823, 5115.641905066684, 5275.498827611371, 5281.973590132025, 5282.181261904411, 5291.788328466895, 2825.420788738345, 2832.787540934397, 2847.1743194473784, 2847.3343094289658, 2853.258152880266, 5544.168374743821, 5546.944530554642, 5554.389017208104, 5577.386487486373, 5578.135389014709, 5303.15149576066, 5409.24270602116, 5412.83761487156, 5438.864028399243, 5457.345118585795, 5519.448055194529, 5522.723863806794, 5541.420695101877, 5541.750621222055, 5565.135679547316, 5220.9477905220465, 5381.461853814587, 5406.89131238825, 5468.5351745100525, 5473.644213126134, 5456.7627272819545, 5478.780848766005, 5482.314710661168, 5505.366882808528, 5509.47659972302, 5716.971415142898, 5735.225744524602, 5750.30996280449, 5772.884542309214, 5806.4193580641595, 3940.5074365704286, 3996.9000774979695, 4023.93964090533, 4033.1328764315813, 4043.878683639378, 5534.7509362078, 5560.415281644712, 5570.58220633446, 5589.273394458857, 5593.440655934374, 5407.270018547603, 5434.402215756185, 5435.184722291688, 5447.237386765935, 5473.233747275464, 5238.795077132357, 5399.83800485986, 5425.1862220665635, 5437.972810135924, 5449.0, 5320.973395133, 5345.22494238341, 5359.829269146002, 5375.3280839895015, 5378.112611419072, 5268.1044222481505, 5343.732813359395, 5400.648957817729, 5449.891002180014, 5490.478404551562, 5367.114426119647, 5380.408155103014, 5401.72991350423, 5402.486763757437, 5405.567464659891], "value": 4139.6881490197775, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [762.0588573112205, 762.1580584817375, 764.4228607401411, 787.3622365883633, 792.6829268292686, 13447.1259368141, 14125.152490850543, 14545.272736363193, 14856.777148342784, 15017.774733379008, 13264.668383290422, 13450.798238026437, 13458.259795711232, 13459.192448453075, 13480.0, 795.2246559604368, 805.04602046575, 805.114374188394, 805.5166899860095, 806.0, 674.3728332650633, 689.7861662884521, 778.2023425988351, 801.8757092650649, 802.9759107226793, 852.0286872964825, 853.9957300213521, 854.5342788180426, 855.0252711908398, 855.1277696749343, 849.2059923971076, 851.5018714052287, 855.3627547477107, 856.1139220906394, 856.7429771068654, 516.7906997665951, 531.8590573498026, 598.5032423088826, 613.0558939233575, 623.1494010675395, 14341.928290358586, 14392.208428536427, 14398.856011439857, 14407.423703051865, 14409.0, 12474.750504989941, 12609.936950315281, 12797.552085677049, 12808.0, 13133.86866131336, 10907.400092994882, 11059.391733454657, 11110.388928608923, 11151.57280379707, 11401.657950261506, 4074.0629655179177, 4087.0, 4162.708610397273, 4219.767912764797, 4320.1575692739925, 51936.74031629856, 54352.0, 54416.72791636056, 60790.088148678245, 61396.386036139964, 10291.588336466608, 10688.83966740484, 10748.247622666338, 10869.891301086887, 10967.50646220922, 19117.904410478135, 19333.0, 19540.31608893682, 19555.511112222022, 19620.215191392184, 8045.15525869787, 8239.299659529008, 8291.751247462586, 8304.501729896225, 8481.024682161507, 4299.312110062375, 4399.868003959887, 4459.264221403432, 4465.821367145343, 4599.793009314589, 3319.4854797506423, 3427.657234276602, 3434.4676575130893, 3548.449990251515, 3739.8504059837846, 627.2567008095422, 629.3171908479351, 629.4397985792648, 640.9391107844747, 651.4625434016955, 696.7073828991836, 699.912510936133, 722.4112348436113, 725.39067183565, 725.4258259576732, 8629.69796057135, 8947.955260223658, 8983.910160898438, 9087.454752714859, 9135.680251191176, 675.3651567526509, 683.4361651637419, 684.5379368925956, 694.5624256718336, 698.769406095987, 4319.848805291863, 4448.35498852671, 4612.723236605814, 4687.273472611751, 4814.831480898151, 85283.0, 89012.5549372249, 89648.0, 90015.0, 91681.0, 49201.26198107031, 49362.75318623384, 50719.74640126776, 58072.0, 67820.98268525976, 71731.0, 73031.26968730244, 73132.26867731361, 73178.26821731715, 73701.89447158297, 9412.0, 9499.57251923679, 9585.520723963635, 9593.088656577615, 9595.856062158933, 46237.53762462332, 46492.0, 47095.52904470912, 47890.760546197045, 48522.5147748518, 40199.79900100481, 40480.59519404768, 58702.0, 64567.35432645614, 66447.66776166088, 12114.75770484603, 12357.691057723629, 12394.0, 13052.086353955512, 13199.67000824987, 14151.787723184367, 14200.644983875485, 14284.642883927569, 14562.490312839, 15093.698126037638, 12326.0, 13275.336233188495, 13543.932280338535, 13583.388747506584, 13980.300984950509, 12995.870041299844, 13107.213567186, 13195.142315749446, 13327.66680832948, 13337.133086349357, 12610.117291789487, 12963.805542916674, 13224.272665003133, 13363.599092027254, 13741.725165496435, 10201.38791672502, 10534.315269507457, 10991.120710342993, 11038.17213708959, 11283.040941519734, 10816.651219500081, 11210.831837522606, 11373.20387572862, 11459.885401145882, 11554.826677599674], "value": 7013.4589331551715, "unit": "score"}], "name": "dromaeo_css", "value": 7044.686581231486, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [104.0, 111.0, 112.0, 113.0, 112.0, 111.0, 111.0, 111.0, 112.0, 112.0], "value": 110.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [153.0, 130.0, 128.0, 163.0, 125.0, 125.0, 126.0, 121.0, 160.0, 131.0], "value": 136.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 161.0, 160.0, 162.0, 161.0, 159.0, 160.0, 161.0, 161.0, 162.0], "value": 160.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 76.0, 75.0, 121.0, 76.0, 75.0, 75.0, 75.0, 102.0, 77.0], "value": 82.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 83.0, 107.0, 81.0, 82.0, 82.0, 108.0, 82.0, 81.0, 114.0], "value": 90.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 117.0, 116.0, 117.0, 116.0, 116.0, 117.0, 117.0, 117.0, 117.0], "value": 116.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 146.0, 146.0, 146.0, 146.0, 147.0, 145.0, 145.0, 146.0, 145.0], "value": 145.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 96.0, 97.0, 95.0, 96.0, 95.0, 96.0, 96.0, 95.0, 95.0], "value": 95.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 51.0, 52.0, 51.0, 50.0, 53.0, 51.0, 52.0, 52.0, 52.0], "value": 51.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 62.0, 62.0, 62.0, 62.0, 63.0, 62.0, 62.0, 62.0, 63.0], "value": 62.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 87.0, 80.0, 81.0, 80.0, 87.0, 81.0, 88.0, 86.0, 81.0], "value": 83.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [142.0, 137.0, 131.0, 129.0, 134.0, 141.0, 131.0, 137.0, 185.0, 133.0], "value": 140.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [166.0, 170.0, 168.0, 168.0, 164.0, 165.0, 162.0, 168.0, 167.0, 164.0], "value": 166.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 68.0, 64.0, 65.0, 66.0, 66.0, 65.0, 66.0, 68.0, 66.0], "value": 66.0, "unit": "score"}], "name": "kraken", "value": 1508.7, "alertThreshold": 2.0}]}
00:43:21 INFO - Return code: 0
00:43:21 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json
00:43:21 INFO - # TBPL SUCCESS #
00:43:21 INFO - Running post-action listener: _resource_record_post_action
00:43:21 INFO - [mozharness: 2016-11-22 08:43:21.992917Z] Finished run-tests step (success)
00:43:21 INFO - Running post-run listener: _resource_record_post_run
00:43:22 INFO - Total resource usage - Wall time: 1197s; CPU: 13.0%; Read bytes: 8192; Write bytes: 407695360; Read time: 20; Write time: 299548
00:43:22 INFO - TinderboxPrint: CPU usage
13.1%
00:43:22 INFO - TinderboxPrint: I/O read bytes / time
8,192 / 20
00:43:22 INFO - TinderboxPrint: I/O write bytes / time
407,695,360 / 299,548
00:43:22 INFO - TinderboxPrint: CPU idle
8,298.3 (86.9%)
00:43:22 INFO - TinderboxPrint: CPU user
1,202.1 (12.6%)
00:43:22 INFO - TinderboxPrint: Swap in / out
0 / 0
00:43:22 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 115822592; Read time: 0; Write time: 104332
00:43:22 INFO - run-tests - Wall time: 1181s; CPU: 13.0%; Read bytes: 0; Write bytes: 288309248; Read time: 0; Write time: 194400
00:43:22 INFO - Running post-run listener: _upload_blobber_files
00:43:22 INFO - Blob upload gear active.
00:43:22 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir.
00:43:22 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
00:43:22 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']
00:43:22 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
00:43:23 INFO - (blobuploader) - INFO - Open directory for files ...
00:43:23 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ...
00:43:23 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com
00:43:23 INFO - (blobuploader) - INFO - Uploading, attempt #1.
00:43:23 INFO - (blobuploader) - WARNING - File uploaded to blobserver but failed uploading to Amazon S3.
00:43:23 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded!
00:43:23 INFO - (blobuploader) - INFO - Done attempting.
00:43:23 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ...
00:43:23 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com
00:43:23 INFO - (blobuploader) - INFO - Uploading, attempt #1.
00:43:28 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded
00:43:28 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded!
00:43:28 INFO - (blobuploader) - INFO - Done attempting.
00:43:28 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ...
00:43:28 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com
00:43:28 INFO - (blobuploader) - INFO - Uploading, attempt #1.
00:43:29 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded
00:43:29 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded!
00:43:29 INFO - (blobuploader) - INFO - Done attempting.
00:43:29 INFO - (blobuploader) - INFO - Iteration through files over.
00:43:29 INFO - Return code: 0
00:43:29 INFO - rmtree: /builds/slave/test/build/uploaded_files.json
00:43:29 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1
00:43:29 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/d5df34415abe99ca96aa0c88dab3713bde8bd13caf740a30e7c94d8501461ab8c1c3bd1eb92e4354a8c346356c92ddcb222429e70065e5571fbc62617a026049", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/1c813037f6f115d4023ee90444741445ba224119e7ca2f85fab0e1a2c0ed7274ac05d8123103cae97aba7454cc6a449a62cbf6722c7b3b6f7784c4ddd904968a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/38205ed71a7e4f3a8e2676d03e267ad96f709929aeb74feee24454de48bf3194902e0d7af6c4e2b010e0bd2721398c51902e96d7595d2af6e5800b365a14d7aa"}
00:43:29 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files
00:43:29 INFO - Writing to file /builds/slave/test/properties/blobber_files
00:43:29 INFO - Contents:
00:43:29 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/d5df34415abe99ca96aa0c88dab3713bde8bd13caf740a30e7c94d8501461ab8c1c3bd1eb92e4354a8c346356c92ddcb222429e70065e5571fbc62617a026049", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/1c813037f6f115d4023ee90444741445ba224119e7ca2f85fab0e1a2c0ed7274ac05d8123103cae97aba7454cc6a449a62cbf6722c7b3b6f7784c4ddd904968a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/38205ed71a7e4f3a8e2676d03e267ad96f709929aeb74feee24454de48bf3194902e0d7af6c4e2b010e0bd2721398c51902e96d7595d2af6e5800b365a14d7aa"}
00:43:29 INFO - Running post-run listener: copy_logs_to_upload_dir
00:43:29 INFO - Copying logs to upload dir...
00:43:29 INFO - mkdir: /builds/slave/test/build/upload/logs
00:43:29 INFO - Copying logs to upload dir...
program finished with exit code 0
elapsedTime=1238.550032
========= master_lag: 0.03 =========
========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 38 secs) (at 2016-11-22 00:43:28.718858) =========
========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-22 00:43:28.722322) =========
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=9c43b49b387003dc8f5b4e5c000001c4-1479794234.66368-1222926869
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/d5df34415abe99ca96aa0c88dab3713bde8bd13caf740a30e7c94d8501461ab8c1c3bd1eb92e4354a8c346356c92ddcb222429e70065e5571fbc62617a026049", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/1c813037f6f115d4023ee90444741445ba224119e7ca2f85fab0e1a2c0ed7274ac05d8123103cae97aba7454cc6a449a62cbf6722c7b3b6f7784c4ddd904968a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/38205ed71a7e4f3a8e2676d03e267ad96f709929aeb74feee24454de48bf3194902e0d7af6c4e2b010e0bd2721398c51902e96d7595d2af6e5800b365a14d7aa"}
build_url:https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1479792618/firefox-53.0a1.en-US.linux-x86_64.tar.bz2
program finished with exit code 0
elapsedTime=0.011251
build_url: 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1479792618/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/d5df34415abe99ca96aa0c88dab3713bde8bd13caf740a30e7c94d8501461ab8c1c3bd1eb92e4354a8c346356c92ddcb222429e70065e5571fbc62617a026049", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/1c813037f6f115d4023ee90444741445ba224119e7ca2f85fab0e1a2c0ed7274ac05d8123103cae97aba7454cc6a449a62cbf6722c7b3b6f7784c4ddd904968a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/38205ed71a7e4f3a8e2676d03e267ad96f709929aeb74feee24454de48bf3194902e0d7af6c4e2b010e0bd2721398c51902e96d7595d2af6e5800b365a14d7aa"}'
========= master_lag: 0.02 =========
========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-22 00:43:28.748696) =========
========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-22 00:43:28.749041) =========
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=9c43b49b387003dc8f5b4e5c000001c4-1479794234.66368-1222926869
XPCOM_DEBUG_BREAK=warn
_=/tools/buildbot/bin/python
using PTY: False
program finished with exit code 0
elapsedTime=0.004506
========= master_lag: 0.83 =========
========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-22 00:43:29.580276) =========
========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-22 00:43:29.580607) =========
========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-22 00:43:29.581510) =========
========= Total master_lag: 0.93 =========