builder: mozilla-inbound_ubuntu64_hw_test-dromaeojs-e10s-pgo
slave: talos-linux64-ix-055
starttime: 1479447982.63
results: success (0)
buildid: 20161117213849
builduid: 1472cf6b5c22491793493355e61aac31
revision: dcd436e553ed85cadb6538ca4f4382610a7bcd5f
========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-11-17 21:46:22.627388) =========
master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/
========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-11-17 21:46:22.627881) =========
========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-17 21:46:22.628162) =========
========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-17 21:46:22.642718) =========
========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-17 21:46:22.642994) =========
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=bb9b54edd4a927dc735d112f000001d9-1479447980.912237-1650614955
XPCOM_DEBUG_BREAK=warn
_=/tools/buildbot/bin/python
using PTY: False
--2016-11-17 21:46:22-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py
Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25
Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected.
HTTP request sent, awaiting response... 200 Script output follows
Length: 12179 (12K) [text/x-python]
Saving to: `archiver_client.py'
0K .......... . 100% 218M=0s
2016-11-17 21:46:22 (218 MB/s) - `archiver_client.py' saved [12179/12179]
program finished with exit code 0
elapsedTime=0.087057
========= master_lag: 0.01 =========
========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-17 21:46:22.744268) =========
========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-17 21:46:22.744627) =========
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=bb9b54edd4a927dc735d112f000001d9-1479447980.912237-1650614955
XPCOM_DEBUG_BREAK=warn
_=/tools/buildbot/bin/python
using PTY: False
program finished with exit code 0
elapsedTime=0.015574
========= master_lag: 0.03 =========
========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-17 21:46:22.794635) =========
========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-11-17 21:46:22.795109) =========
bash -c 'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev dcd436e553ed85cadb6538ca4f4382610a7bcd5f --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 dcd436e553ed85cadb6538ca4f4382610a7bcd5f --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=bb9b54edd4a927dc735d112f000001d9-1479447980.912237-1650614955
XPCOM_DEBUG_BREAK=warn
_=/tools/buildbot/bin/python
using PTY: False
2016-11-17 21:46:23,042 truncating revision to first 12 chars
2016-11-17 21:46:23,043 Setting DEBUG logging.
2016-11-17 21:46:23,043 attempt 1/10
2016-11-17 21:46:23,043 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/dcd436e553ed?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness
2016-11-17 21:46:23,645 unpacking tar archive at: mozilla-inbound-dcd436e553ed/testing/mozharness/
program finished with exit code 0
elapsedTime=1.200063
========= master_lag: 0.01 =========
========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-11-17 21:46:24.008677) =========
========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-17 21:46:24.009016) =========
script_repo_revision: dcd436e553ed85cadb6538ca4f4382610a7bcd5f
========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-17 21:46:24.009414) =========
========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-17 21:46:24.009699) =========
========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-17 21:46:24.018492) =========
========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 37 secs) (at 2016-11-17 21:46:24.018905) =========
/tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound
in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs)
watching logfiles {}
argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Inbound', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Inbound']
environment:
DISPLAY=:0
HOME=/home/cltbld
LANG=en_US.UTF-8
LANGUAGE=en_US:en
LOGNAME=cltbld
MAIL=/var/mail/cltbld
MOZ_CRASHREPORTER_NO_REPORT=1
MOZ_NO_REMOTE=1
NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript
NO_EM_RESTART=1
PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games
PROPERTIES_FILE=/builds/slave/test/buildprops.json
PWD=/builds/slave/test
SHELL=/bin/bash
SHLVL=1
TERM=linux
TMOUT=86400
USER=cltbld
XDG_SESSION_COOKIE=bb9b54edd4a927dc735d112f000001d9-1479447980.912237-1650614955
XPCOM_DEBUG_BREAK=warn
_=/tools/buildbot/bin/python
using PTY: False
21:46:24 INFO - MultiFileLogger online at 20161117 21:46:24 in /builds/slave/test
21:46:24 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound
21:46:24 INFO - Dumping config to /builds/slave/test/logs/localconfig.json.
21:46:24 INFO - {'append_to_log': False,
21:46:24 INFO - 'base_work_dir': '/builds/slave/test',
21:46:24 INFO - 'blob_upload_branch': 'Mozilla-Inbound',
21:46:24 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt',
21:46:24 INFO - 'branch': 'Mozilla-Inbound',
21:46:24 INFO - 'buildbot_json_path': 'buildprops.json',
21:46:24 INFO - 'config_files': ('talos/linux_config.py',),
21:46:24 INFO - 'default_actions': ('clobber',
21:46:24 INFO - 'read-buildbot-config',
21:46:24 INFO - 'download-and-extract',
21:46:24 INFO - 'populate-webroot',
21:46:24 INFO - 'create-virtualenv',
21:46:24 INFO - 'install',
21:46:24 INFO - 'run-tests'),
21:46:24 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',),
21:46:24 INFO - 'download_minidump_stackwalk': True,
21:46:24 INFO - 'download_symbols': 'ondemand',
21:46:24 INFO - 'exes': {'python': '/tools/buildbot/bin/python',
21:46:24 INFO - 'tooltool.py': '/tools/tooltool.py',
21:46:24 INFO - 'virtualenv': ('/tools/buildbot/bin/python',
21:46:24 INFO - '/tools/misc-python/virtualenv.py')},
21:46:24 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub',
21:46:24 INFO - 'http://pypi.pub.build.mozilla.org/pub'),
21:46:24 INFO - 'installer_path': 'installer.exe',
21:46:24 INFO - 'log_level': 'info',
21:46:24 INFO - 'log_name': 'talos',
21:46:24 INFO - 'log_to_console': True,
21:46:24 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk',
21:46:24 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest',
21:46:24 INFO - 'opt_config_files': (),
21:46:24 INFO - 'pip_index': False,
21:46:24 INFO - 'sps_profile': False,
21:46:24 INFO - 'sps_profile_interval': 0,
21:46:24 INFO - 'suite': 'dromaeojs-e10s',
21:46:24 INFO - 'system_bits': '32',
21:46:24 INFO - 'talos_extra_options': ('--webServer', 'localhost'),
21:46:24 INFO - 'title': 'talos-linux64-ix-055',
21:46:24 INFO - 'tooltool_cache': '/builds/tooltool_cache',
21:46:24 INFO - 'use_talos_json': True,
21:46:24 INFO - 'virtualenv_path': '/builds/slave/test/build/venv',
21:46:24 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None},
21:46:24 INFO - 'work_dir': 'build'}
21:46:24 INFO - [mozharness: 2016-11-18 05:46:24.366662Z] Running clobber step.
21:46:24 INFO - Running pre-action listener: _resource_record_pre_action
21:46:24 INFO - Running main action method: clobber
21:46:24 INFO - rmtree: /builds/slave/test/build
21:46:24 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1
21:46:25 INFO - Running post-action listener: _resource_record_post_action
21:46:25 INFO - [mozharness: 2016-11-18 05:46:25.346796Z] Finished clobber step (success)
21:46:25 INFO - [mozharness: 2016-11-18 05:46:25.346895Z] Running read-buildbot-config step.
21:46:25 INFO - Running pre-action listener: _resource_record_pre_action
21:46:25 INFO - Running main action method: read_buildbot_config
21:46:25 INFO - Using buildbot properties:
21:46:25 INFO - {
21:46:25 INFO - "project": "",
21:46:25 INFO - "product": "firefox",
21:46:25 INFO - "script_repo_revision": "production",
21:46:25 INFO - "builddir": "mozilla-inbound_ubuntu64_hw_test-dromaeojs-e10s",
21:46:25 INFO - "repository": "",
21:46:25 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-inbound pgo talos dromaeojs-e10s",
21:46:25 INFO - "buildid": "20161117213849",
21:46:25 INFO - "stage_platform": "linux64-pgo",
21:46:25 INFO - "basedir": "/builds/slave/test",
21:46:25 INFO - "buildnumber": 2086,
21:46:25 INFO - "platform": "ubuntu64_hw",
21:46:25 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/",
21:46:25 INFO - "slavebuilddir": "test",
21:46:25 INFO - "branch": "mozilla-inbound",
21:46:25 INFO - "revision": "dcd436e553ed85cadb6538ca4f4382610a7bcd5f",
21:46:25 INFO - "slavename": "talos-linux64-ix-055",
21:46:25 INFO - "builduid": "1472cf6b5c22491793493355e61aac31",
21:46:25 INFO - "repo_path": "integration/mozilla-inbound"
21:46:25 INFO - }
21:46:25 INFO - Found installer url https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1479436622/firefox-53.0a1.en-US.linux-x86_64.tar.bz2.
21:46:25 INFO - Found a test packages url https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1479436622/firefox-53.0a1.en-US.linux-x86_64.test_packages.json.
21:46:25 INFO - Running post-action listener: _resource_record_post_action
21:46:25 INFO - [mozharness: 2016-11-18 05:46:25.349238Z] Finished read-buildbot-config step (success)
21:46:25 INFO - [mozharness: 2016-11-18 05:46:25.349327Z] Running download-and-extract step.
21:46:25 INFO - Running pre-action listener: _resource_record_pre_action
21:46:25 INFO - Running main action method: download_and_extract
21:46:25 INFO - mkdir: /builds/slave/test/build/tests
21:46:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]}
21:46:25 INFO - trying https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1479436622/firefox-53.0a1.en-US.linux-x86_64.test_packages.json
21:46:25 INFO - Downloading https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1479436622/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
21:46:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1479436622/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
21:46:25 INFO - Downloaded 1361 bytes.
21:46:25 INFO - Reading from file /builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json
21:46:25 INFO - Using the following test package requirements:
21:46:25 INFO - {u'common': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'],
21:46:25 INFO - u'cppunittest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip',
21:46:25 INFO - u'firefox-53.0a1.en-US.linux-x86_64.cppunittest.tests.zip'],
21:46:25 INFO - u'gtest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip',
21:46:25 INFO - u'firefox-53.0a1.en-US.linux-x86_64.gtest.tests.zip'],
21:46:25 INFO - u'jittest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip',
21:46:25 INFO - u'jsshell-linux-x86_64.zip'],
21:46:25 INFO - u'mochitest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip',
21:46:25 INFO - u'firefox-53.0a1.en-US.linux-x86_64.mochitest.tests.zip'],
21:46:25 INFO - u'mozbase': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'],
21:46:25 INFO - u'reftest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip',
21:46:25 INFO - u'firefox-53.0a1.en-US.linux-x86_64.reftest.tests.zip'],
21:46:25 INFO - u'talos': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip',
21:46:25 INFO - u'firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip'],
21:46:25 INFO - u'web-platform': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip',
21:46:25 INFO - u'firefox-53.0a1.en-US.linux-x86_64.web-platform.tests.zip'],
21:46:25 INFO - u'xpcshell': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip',
21:46:25 INFO - u'firefox-53.0a1.en-US.linux-x86_64.xpcshell.tests.zip']}
21:46:25 INFO - Downloading packages: [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common
21:46:25 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/1479436622/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip
21:46:25 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1479436622/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1
21:46:25 INFO - Fetch https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1479436622/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip into memory
21:46:25 INFO - Http code: 200
21:46:25 INFO - via: 1.1 e2af8a85927835558866752f53562ecd.cloudfront.net (CloudFront)
21:46:25 INFO - x-amz-cf-id: 6h-VJVymw9-ecDhViaNdXai7H0w7hxX2bAOHu7DbPgTcWKNux85GNA==
21:46:25 INFO - x-amz-replication-status: COMPLETED
21:46:25 INFO - x-amz-version-id: ANIYUXMsVHB6L0JBqXxQ3yTWpA5rNvAX
21:46:25 INFO - Expected file size: 21917295
21:46:25 INFO - Obtained file size: 21917295
21:46:29 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
21:46:29 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/1479436622/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip
21:46:29 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1479436622/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1
21:46:29 INFO - Fetch https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1479436622/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip into memory
21:46:29 INFO - Http code: 200
21:46:29 INFO - via: 1.1 24b0e5a3429d07ef12381da50e07f70f.cloudfront.net (CloudFront)
21:46:29 INFO - x-amz-cf-id: DDki2EL36xCyM3q8tmWqT7P1Gpq-w_WN63sA0WceFQBwyNdTBiB5Gg==
21:46:29 INFO - x-amz-replication-status: COMPLETED
21:46:29 INFO - x-amz-version-id: ANIYUXMsVHB6L0JBqXxQ3yTWpA5rNvAX
21:46:30 INFO - Expected file size: 21917295
21:46:30 INFO - Obtained file size: 21917295
21:46:34 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/1479436622/firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip
21:46:34 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1479436622/firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1
21:46:34 INFO - Fetch https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1479436622/firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip into memory
21:46:34 INFO - Http code: 200
21:46:34 INFO - via: 1.1 e30ae5b3d9f6779a9b8bc992faad0b09.cloudfront.net (CloudFront)
21:46:34 INFO - x-amz-cf-id: p1xTqxjelElx-S9ozmuBatqP_tARmXRv-bfeCpy_tYBfMDGiL2OTgA==
21:46:34 INFO - x-amz-replication-status: COMPLETED
21:46:34 INFO - x-amz-version-id: IayhyQYflzpzAyQ4h_pWxOxWSK3LtA5S
21:46:34 INFO - Expected file size: 14409392
21:46:34 INFO - Obtained file size: 14409392
21:46:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]}
21:46:35 INFO - trying https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1479436622/firefox-53.0a1.en-US.linux-x86_64.tar.bz2
21:46:35 INFO - Downloading https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1479436622/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
21:46:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1479436622/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
21:46:35 INFO - Downloaded 59544743 bytes.
21:46:35 INFO - Setting buildbot property build_url to https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1479436622/firefox-53.0a1.en-US.linux-x86_64.tar.bz2
21:46:35 INFO - mkdir: /builds/slave/test/properties
21:46:35 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url
21:46:35 INFO - Writing to file /builds/slave/test/properties/build_url
21:46:35 INFO - Contents:
21:46:35 INFO - build_url:https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1479436622/firefox-53.0a1.en-US.linux-x86_64.tar.bz2
21:46:36 INFO - Running post-action listener: _resource_record_post_action
21:46:36 INFO - Running post-action listener: set_extra_try_arguments
21:46:36 INFO - [mozharness: 2016-11-18 05:46:36.128816Z] Finished download-and-extract step (success)
21:46:36 INFO - [mozharness: 2016-11-18 05:46:36.129042Z] Running populate-webroot step.
21:46:36 INFO - Running pre-action listener: _resource_record_pre_action
21:46:36 INFO - Running main action method: populate_webroot
21:46:36 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']},
21:46:36 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']},
21:46:36 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome',
21:46:36 INFO - '--tppagecycles',
21:46:36 INFO - '7'],
21:46:36 INFO - 'tests': ['tsvgm']}},
21:46:36 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'],
21:46:36 INFO - 'tests': ['tresize', 'tcanvasmark']},
21:46:36 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']},
21:46:36 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'],
21:46:36 INFO - 'tests': ['dromaeo_css', 'kraken']},
21:46:36 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']},
21:46:36 INFO - 'g1': {'pagesets_name': 'tp5n.zip',
21:46:36 INFO - 'talos_options': ['--disable-e10s'],
21:46:36 INFO - 'tests': ['tp5o_scroll', 'glterrain']},
21:46:36 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip',
21:46:36 INFO - 'tests': ['tp5o_scroll', 'glterrain']},
21:46:36 INFO - 'g2': {'pagesets_name': 'tp5n.zip',
21:46:36 INFO - 'talos_options': ['--disable-e10s'],
21:46:36 INFO - 'tests': ['damp', 'tps']},
21:46:36 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip',
21:46:36 INFO - 'tests': ['damp', 'tps']},
21:46:36 INFO - 'g3': {'talos_options': ['--disable-e10s'],
21:46:36 INFO - 'tests': ['dromaeo_dom']},
21:46:36 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']},
21:46:36 INFO - 'g4': {'talos_options': ['--disable-e10s'],
21:46:36 INFO - 'tests': ['basic_compositor_video']},
21:46:36 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']},
21:46:36 INFO - 'other': {'talos_options': ['--disable-e10s'],
21:46:36 INFO - 'tests': ['a11yr',
21:46:36 INFO - 'ts_paint',
21:46:36 INFO - 'tpaint',
21:46:36 INFO - 'sessionrestore',
21:46:36 INFO - 'sessionrestore_no_auto_restore',
21:46:36 INFO - 'tabpaint']},
21:46:36 INFO - 'other-e10s': {'tests': ['a11yr',
21:46:36 INFO - 'ts_paint',
21:46:36 INFO - 'tpaint',
21:46:36 INFO - 'sessionrestore',
21:46:36 INFO - 'sessionrestore_no_auto_restore',
21:46:36 INFO - 'tabpaint']},
21:46:36 INFO - 'other-e10s_l64': {'tests': ['a11yr',
21:46:36 INFO - 'ts_paint',
21:46:36 INFO - 'tpaint',
21:46:36 INFO - 'sessionrestore',
21:46:36 INFO - 'sessionrestore_no_auto_restore',
21:46:36 INFO - 'tabpaint']},
21:46:36 INFO - 'other-e10s_nol64': {'tests': ['a11yr',
21:46:36 INFO - 'ts_paint',
21:46:36 INFO - 'tpaint',
21:46:36 INFO - 'sessionrestore',
21:46:36 INFO - 'sessionrestore_no_auto_restore',
21:46:36 INFO - 'tabpaint']},
21:46:36 INFO - 'other_l64': {'talos_options': ['--disable-e10s'],
21:46:36 INFO - 'tests': ['a11yr',
21:46:36 INFO - 'ts_paint',
21:46:36 INFO - 'tpaint',
21:46:36 INFO - 'sessionrestore',
21:46:36 INFO - 'sessionrestore_no_auto_restore',
21:46:36 INFO - 'tabpaint']},
21:46:36 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'],
21:46:36 INFO - 'tests': ['a11yr',
21:46:36 INFO - 'ts_paint',
21:46:36 INFO - 'tpaint',
21:46:36 INFO - 'sessionrestore',
21:46:36 INFO - 'sessionrestore_no_auto_restore',
21:46:36 INFO - 'tabpaint']},
21:46:36 INFO - 'svgr': {'talos_options': ['--disable-e10s'],
21:46:36 INFO - 'tests': ['tsvgx',
21:46:36 INFO - 'tsvgr_opacity',
21:46:36 INFO - 'tart',
21:46:36 INFO - 'tscrollx',
21:46:36 INFO - 'cart']},
21:46:36 INFO - 'svgr-e10s': {'tests': ['tsvgx',
21:46:36 INFO - 'tsvgr_opacity',
21:46:36 INFO - 'tart',
21:46:36 INFO - 'tscrollx',
21:46:36 INFO - 'cart']},
21:46:36 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip',
21:46:36 INFO - 'talos_options': ['--disable-e10s'],
21:46:36 INFO - 'tests': ['tp5o']},
21:46:36 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']},
21:46:36 INFO - 'xperf': {'pagesets_name': 'tp5n.zip',
21:46:36 INFO - 'talos_options': ['--disable-e10s',
21:46:36 INFO - '--xperf_path',
21:46:36 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'],
21:46:36 INFO - 'tests': ['tp5n']},
21:46:36 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip',
21:46:36 INFO - 'talos_options': ['--xperf_path',
21:46:36 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'],
21:46:36 INFO - 'tests': ['tp5n']}},
21:46:36 INFO - 'talos.zip': {'path': '',
21:46:36 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}}
21:46:36 INFO - Running post-action listener: _resource_record_post_action
21:46:36 INFO - [mozharness: 2016-11-18 05:46:36.147183Z] Finished populate-webroot step (success)
21:46:36 INFO - [mozharness: 2016-11-18 05:46:36.147270Z] Running create-virtualenv step.
21:46:36 INFO - Running pre-action listener: _resource_record_pre_action
21:46:36 INFO - Running main action method: create_virtualenv
21:46:36 INFO - Creating virtualenv /builds/slave/test/build/venv
21:46:36 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
21:46:36 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv
21:46:36 INFO - The --no-site-packages flag is deprecated; it is now the default behavior.
21:46:36 INFO - Using real prefix '/usr'
21:46:36 INFO - New python executable in /builds/slave/test/build/venv/bin/python
21:46:36 INFO - Installing distribute.............................................................................................................................................................................................done.
21:46:38 INFO - Installing pip.................done.
21:46:38 INFO - Return code: 0
21:46:38 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version']
21:46:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version
21:46:38 INFO - Reading from file tmpfile_stdout
21:46:38 INFO - Output received:
21:46:38 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)
21:46:38 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv
21:46:38 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')]}
21:46:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org
21:46:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub
21:46:38 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')]}
21:46:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org
21:46:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub
21:46:38 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 0x7fd56688fe30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12a2b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x143e130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14ccfc0>, '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 0x14cdec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14ce350>, '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': 'bb9b54edd4a927dc735d112f000001d9-1479447980.912237-1650614955', '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
21:46:38 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
21:46:38 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
21:46:38 INFO - Using env: {'DISPLAY': ':0',
21:46:38 INFO - 'HOME': '/home/cltbld',
21:46:38 INFO - 'LANG': 'en_US.UTF-8',
21:46:38 INFO - 'LANGUAGE': 'en_US:en',
21:46:38 INFO - 'LOGNAME': 'cltbld',
21:46:38 INFO - 'MAIL': '/var/mail/cltbld',
21:46:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1',
21:46:38 INFO - 'MOZ_NO_REMOTE': '1',
21:46:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript',
21:46:38 INFO - 'NO_EM_RESTART': '1',
21:46:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games',
21:46:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json',
21:46:38 INFO - 'PWD': '/builds/slave/test',
21:46:38 INFO - 'SHELL': '/bin/bash',
21:46:38 INFO - 'SHLVL': '1',
21:46:38 INFO - 'TERM': 'linux',
21:46:38 INFO - 'TMOUT': '86400',
21:46:38 INFO - 'USER': 'cltbld',
21:46:38 INFO - 'XDG_SESSION_COOKIE': 'bb9b54edd4a927dc735d112f000001d9-1479447980.912237-1650614955',
21:46:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn',
21:46:38 INFO - '_': '/tools/buildbot/bin/python'}
21:46:39 INFO - Ignoring indexes: https://pypi.python.org/simple/
21:46:39 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
21:46:39 INFO - Cleaning up...
21:46:39 INFO - Return code: 0
21:46:39 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv
21:46:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]}
21:46:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org
21:46:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub
21:46:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]}
21:46:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org
21:46:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub
21:46:39 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fd56688fe30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12a2b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x143e130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14ccfc0>, '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 0x14cdec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14ce350>, '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': 'bb9b54edd4a927dc735d112f000001d9-1479447980.912237-1650614955', '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
21:46:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build
21:46:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1
21:46:39 INFO - Using env: {'DISPLAY': ':0',
21:46:39 INFO - 'HOME': '/home/cltbld',
21:46:39 INFO - 'LANG': 'en_US.UTF-8',
21:46:39 INFO - 'LANGUAGE': 'en_US:en',
21:46:39 INFO - 'LOGNAME': 'cltbld',
21:46:39 INFO - 'MAIL': '/var/mail/cltbld',
21:46:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1',
21:46:39 INFO - 'MOZ_NO_REMOTE': '1',
21:46:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript',
21:46:39 INFO - 'NO_EM_RESTART': '1',
21:46:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games',
21:46:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json',
21:46:39 INFO - 'PWD': '/builds/slave/test',
21:46:39 INFO - 'SHELL': '/bin/bash',
21:46:39 INFO - 'SHLVL': '1',
21:46:39 INFO - 'TERM': 'linux',
21:46:39 INFO - 'TMOUT': '86400',
21:46:39 INFO - 'USER': 'cltbld',
21:46:39 INFO - 'XDG_SESSION_COOKIE': 'bb9b54edd4a927dc735d112f000001d9-1479447980.912237-1650614955',
21:46:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn',
21:46:39 INFO - '_': '/tools/buildbot/bin/python'}
21:46:39 INFO - Ignoring indexes: https://pypi.python.org/simple/
21:46:39 INFO - Downloading/unpacking psutil>=3.1.1
21:46:39 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
21:46:39 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
21:46:39 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
21:46:39 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
21:46:39 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
21:46:39 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
21:46:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil
21:46:41 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build'
21:46:41 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects
...
21:46:41 INFO - Installing collected packages: psutil
21:46:41 INFO - Running setup.py install for psutil
21:46:41 INFO - building 'psutil._psutil_linux' extension
21:46:41 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
21:46:41 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
21:46:41 INFO - building 'psutil._psutil_posix' extension
21:46:41 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
21:46:41 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
21:46:41 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build'
21:46:41 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ...
21:46:41 INFO - Successfully installed psutil
21:46:41 INFO - Cleaning up...
21:46:41 INFO - Return code: 0
21:46:41 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv
21:46: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')]}
21:46:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org
21:46:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub
21:46: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')]}
21:46:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org
21:46:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub
21:46:42 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 0x7fd56688fe30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12a2b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x143e130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14ccfc0>, '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 0x14cdec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14ce350>, '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': 'bb9b54edd4a927dc735d112f000001d9-1479447980.912237-1650614955', '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
21:46:42 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
21:46:42 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
21:46:42 INFO - Using env: {'DISPLAY': ':0',
21:46:42 INFO - 'HOME': '/home/cltbld',
21:46:42 INFO - 'LANG': 'en_US.UTF-8',
21:46:42 INFO - 'LANGUAGE': 'en_US:en',
21:46:42 INFO - 'LOGNAME': 'cltbld',
21:46:42 INFO - 'MAIL': '/var/mail/cltbld',
21:46:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1',
21:46:42 INFO - 'MOZ_NO_REMOTE': '1',
21:46:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript',
21:46:42 INFO - 'NO_EM_RESTART': '1',
21:46:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games',
21:46:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json',
21:46:42 INFO - 'PWD': '/builds/slave/test',
21:46:42 INFO - 'SHELL': '/bin/bash',
21:46:42 INFO - 'SHLVL': '1',
21:46:42 INFO - 'TERM': 'linux',
21:46:42 INFO - 'TMOUT': '86400',
21:46:42 INFO - 'USER': 'cltbld',
21:46:42 INFO - 'XDG_SESSION_COOKIE': 'bb9b54edd4a927dc735d112f000001d9-1479447980.912237-1650614955',
21:46:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn',
21:46:42 INFO - '_': '/tools/buildbot/bin/python'}
21:46:42 INFO - Ignoring indexes: https://pypi.python.org/simple/
21:46:42 INFO - Downloading/unpacking mozsystemmonitor==0.3
21:46:42 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
21:46:42 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
21:46:42 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
21:46:42 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
21:46:42 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
21:46:42 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
21:46:44 INFO - Downloading mozsystemmonitor-0.3.tar.gz
21:46:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor
21:46:44 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3)
21:46:44 INFO - Installing collected packages: mozsystemmonitor
21:46:44 INFO - Running setup.py install for mozsystemmonitor
21:46:44 INFO - Successfully installed mozsystemmonitor
21:46:44 INFO - Cleaning up...
21:46:44 INFO - Return code: 0
21:46:44 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv
21:46:44 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')]}
21:46:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org
21:46:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub
21:46:44 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')]}
21:46:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org
21:46:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub
21:46:44 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 0x7fd56688fe30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12a2b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x143e130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14ccfc0>, '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 0x14cdec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14ce350>, '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': 'bb9b54edd4a927dc735d112f000001d9-1479447980.912237-1650614955', '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
21:46:44 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
21:46:44 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
21:46:44 INFO - Using env: {'DISPLAY': ':0',
21:46:44 INFO - 'HOME': '/home/cltbld',
21:46:44 INFO - 'LANG': 'en_US.UTF-8',
21:46:44 INFO - 'LANGUAGE': 'en_US:en',
21:46:44 INFO - 'LOGNAME': 'cltbld',
21:46:44 INFO - 'MAIL': '/var/mail/cltbld',
21:46:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1',
21:46:44 INFO - 'MOZ_NO_REMOTE': '1',
21:46:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript',
21:46:44 INFO - 'NO_EM_RESTART': '1',
21:46:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games',
21:46:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json',
21:46:44 INFO - 'PWD': '/builds/slave/test',
21:46:44 INFO - 'SHELL': '/bin/bash',
21:46:44 INFO - 'SHLVL': '1',
21:46:44 INFO - 'TERM': 'linux',
21:46:44 INFO - 'TMOUT': '86400',
21:46:44 INFO - 'USER': 'cltbld',
21:46:44 INFO - 'XDG_SESSION_COOKIE': 'bb9b54edd4a927dc735d112f000001d9-1479447980.912237-1650614955',
21:46:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn',
21:46:44 INFO - '_': '/tools/buildbot/bin/python'}
21:46:44 INFO - Ignoring indexes: https://pypi.python.org/simple/
21:46:44 INFO - Downloading/unpacking jsonschema==2.5.1
21:46:44 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
21:46:44 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
21:46:44 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
21:46:44 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
21:46:44 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
21:46:44 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
21:46:46 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl
21:46:46 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1)
21:46:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available
21:46:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available
21:46:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available
21:46:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available
21:46:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available
21:46:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available
21:46:46 INFO - Downloading functools32-3.2.3-2.tar.gz
21:46:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32
21:46:46 INFO - warning: no files found matching '*.txt'
21:46:46 INFO - no previously-included directories found matching 'build'
21:46:46 INFO - no previously-included directories found matching 'dist'
21:46:46 INFO - no previously-included directories found matching '.git*'
21:46:46 INFO - Installing collected packages: jsonschema, functools32
21:46:46 INFO - Running setup.py install for functools32
21:46:46 INFO - warning: no files found matching '*.txt'
21:46:46 INFO - no previously-included directories found matching 'build'
21:46:46 INFO - no previously-included directories found matching 'dist'
21:46:46 INFO - no previously-included directories found matching '.git*'
21:46:46 INFO - Successfully installed jsonschema functools32
21:46:46 INFO - Cleaning up...
21:46:46 INFO - Return code: 0
21:46:46 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv
21:46:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]}
21:46:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org
21:46:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub
21:46:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]}
21:46:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org
21:46:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub
21:46:46 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fd56688fe30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12a2b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x143e130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14ccfc0>, '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 0x14cdec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14ce350>, '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': 'bb9b54edd4a927dc735d112f000001d9-1479447980.912237-1650614955', '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
21:46:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build
21:46:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2
21:46:46 INFO - Using env: {'DISPLAY': ':0',
21:46:46 INFO - 'HOME': '/home/cltbld',
21:46:46 INFO - 'LANG': 'en_US.UTF-8',
21:46:46 INFO - 'LANGUAGE': 'en_US:en',
21:46:46 INFO - 'LOGNAME': 'cltbld',
21:46:46 INFO - 'MAIL': '/var/mail/cltbld',
21:46:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1',
21:46:46 INFO - 'MOZ_NO_REMOTE': '1',
21:46:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript',
21:46:46 INFO - 'NO_EM_RESTART': '1',
21:46:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games',
21:46:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json',
21:46:46 INFO - 'PWD': '/builds/slave/test',
21:46:46 INFO - 'SHELL': '/bin/bash',
21:46:46 INFO - 'SHLVL': '1',
21:46:46 INFO - 'TERM': 'linux',
21:46:46 INFO - 'TMOUT': '86400',
21:46:46 INFO - 'USER': 'cltbld',
21:46:46 INFO - 'XDG_SESSION_COOKIE': 'bb9b54edd4a927dc735d112f000001d9-1479447980.912237-1650614955',
21:46:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn',
21:46:46 INFO - '_': '/tools/buildbot/bin/python'}
21:46:47 INFO - Ignoring indexes: https://pypi.python.org/simple/
21:46:47 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages
21:46:47 INFO - Cleaning up...
21:46:47 INFO - Return code: 0
21:46:47 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv
21:46:47 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')]}
21:46:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org
21:46:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub
21:46:47 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')]}
21:46:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org
21:46:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub
21:46:47 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 0x7fd56688fe30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12a2b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x143e130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14ccfc0>, '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 0x14cdec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14ce350>, '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': 'bb9b54edd4a927dc735d112f000001d9-1479447980.912237-1650614955', '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
21:46:47 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
21:46:47 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
21:46:47 INFO - Using env: {'DISPLAY': ':0',
21:46:47 INFO - 'HOME': '/home/cltbld',
21:46:47 INFO - 'LANG': 'en_US.UTF-8',
21:46:47 INFO - 'LANGUAGE': 'en_US:en',
21:46:47 INFO - 'LOGNAME': 'cltbld',
21:46:47 INFO - 'MAIL': '/var/mail/cltbld',
21:46:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1',
21:46:47 INFO - 'MOZ_NO_REMOTE': '1',
21:46:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript',
21:46:47 INFO - 'NO_EM_RESTART': '1',
21:46:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games',
21:46:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json',
21:46:47 INFO - 'PWD': '/builds/slave/test',
21:46:47 INFO - 'SHELL': '/bin/bash',
21:46:47 INFO - 'SHLVL': '1',
21:46:47 INFO - 'TERM': 'linux',
21:46:47 INFO - 'TMOUT': '86400',
21:46:47 INFO - 'USER': 'cltbld',
21:46:47 INFO - 'XDG_SESSION_COOKIE': 'bb9b54edd4a927dc735d112f000001d9-1479447980.912237-1650614955',
21:46:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn',
21:46:47 INFO - '_': '/tools/buildbot/bin/python'}
21:46:47 INFO - Ignoring indexes: https://pypi.python.org/simple/
21:46:47 INFO - Downloading/unpacking blobuploader==1.2.4
21:46:47 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
21:46:47 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
21:46:47 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
21:46:47 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
21:46:47 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
21:46:47 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
21:46:49 INFO - Downloading blobuploader-1.2.4.tar.gz
21:46:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader
21:46:49 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4)
21:46:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available
21:46:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available
21:46:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available
21:46:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available
21:46:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available
21:46:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available
21:46:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests
21:46:49 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4)
21:46:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available
21:46:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available
21:46:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available
21:46:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available
21:46:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available
21:46:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available
21:46:50 INFO - Downloading docopt-0.6.1.tar.gz
21:46:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt
21:46:50 INFO - Installing collected packages: blobuploader, requests, docopt
21:46:50 INFO - Running setup.py install for blobuploader
21:46:50 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775
21:46:50 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775
21:46:50 INFO - Running setup.py install for requests
21:46:50 INFO - Running setup.py install for docopt
21:46:50 INFO - Successfully installed blobuploader requests docopt
21:46:50 INFO - Cleaning up...
21:46:50 INFO - Return code: 0
21:46:50 INFO - Installing None into virtualenv /builds/slave/test/build/venv
21:46:50 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')]}
21:46:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org
21:46:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub
21:46:50 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')]}
21:46:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org
21:46:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub
21:46:50 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 0x7fd56688fe30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12a2b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x143e130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14ccfc0>, '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 0x14cdec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14ce350>, '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': 'bb9b54edd4a927dc735d112f000001d9-1479447980.912237-1650614955', '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
21:46:50 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
21:46:50 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
21:46:50 INFO - Using env: {'DISPLAY': ':0',
21:46:50 INFO - 'HOME': '/home/cltbld',
21:46:50 INFO - 'LANG': 'en_US.UTF-8',
21:46:50 INFO - 'LANGUAGE': 'en_US:en',
21:46:50 INFO - 'LOGNAME': 'cltbld',
21:46:50 INFO - 'MAIL': '/var/mail/cltbld',
21:46:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1',
21:46:50 INFO - 'MOZ_NO_REMOTE': '1',
21:46:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript',
21:46:50 INFO - 'NO_EM_RESTART': '1',
21:46:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games',
21:46:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json',
21:46:50 INFO - 'PWD': '/builds/slave/test',
21:46:50 INFO - 'SHELL': '/bin/bash',
21:46:50 INFO - 'SHLVL': '1',
21:46:50 INFO - 'TERM': 'linux',
21:46:50 INFO - 'TMOUT': '86400',
21:46:50 INFO - 'USER': 'cltbld',
21:46:50 INFO - 'XDG_SESSION_COOKIE': 'bb9b54edd4a927dc735d112f000001d9-1479447980.912237-1650614955',
21:46:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn',
21:46:50 INFO - '_': '/tools/buildbot/bin/python'}
21:46:50 INFO - Ignoring indexes: https://pypi.python.org/simple/
21:46:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser
21:46:50 INFO - Running setup.py (path:/tmp/pip-9W5M8u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser
21:46:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash
21:46:51 INFO - Running setup.py (path:/tmp/pip-vgJ1Og-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash
21:46:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug
21:46:51 INFO - Running setup.py (path:/tmp/pip-RNKw_7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug
21:46:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice
21:46:51 INFO - Running setup.py (path:/tmp/pip-FdtzHY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice
21:46:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile
21:46:51 INFO - Running setup.py (path:/tmp/pip-bW53Fd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile
21:46:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd
21:46:51 INFO - Running setup.py (path:/tmp/pip-yprmpw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd
21:46:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo
21:46:51 INFO - Running setup.py (path:/tmp/pip-ZULAYg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo
21:46:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall
21:46:51 INFO - Running setup.py (path:/tmp/pip-w_xdTE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall
21:46:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak
21:46:51 INFO - Running setup.py (path:/tmp/pip-PEIvaF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak
21:46:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog
21:46:51 INFO - Running setup.py (path:/tmp/pip-zjRUVs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog
21:46:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork
21:46:51 INFO - Running setup.py (path:/tmp/pip-56zfUG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork
21:46:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess
21:46:51 INFO - Running setup.py (path:/tmp/pip-TotTXZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess
21:46:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile
21:46:51 INFO - Running setup.py (path:/tmp/pip-TEPhEW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile
21:46:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner
21:46:51 INFO - Running setup.py (path:/tmp/pip-WEMQMx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner
21:46:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot
21:46:51 INFO - Running setup.py (path:/tmp/pip-ibp5Oi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot
21:46:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest
21:46:52 INFO - Running setup.py (path:/tmp/pip-aYWJ3E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest
21:46:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion
21:46:52 INFO - Running setup.py (path:/tmp/pip-n_ev4Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion
21:46:52 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion
21:46:52 INFO - Running setup.py install for manifestparser
21:46:52 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin
21:46:52 INFO - Running setup.py install for mozcrash
21:46:52 INFO - Running setup.py install for mozdebug
21:46:52 INFO - Running setup.py install for mozdevice
21:46:52 INFO - Installing sutini script to /builds/slave/test/build/venv/bin
21:46:52 INFO - Installing dm script to /builds/slave/test/build/venv/bin
21:46:52 INFO - Running setup.py install for mozfile
21:46:52 INFO - Running setup.py install for mozhttpd
21:46:52 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin
21:46:52 INFO - Running setup.py install for mozinfo
21:46:52 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin
21:46:52 INFO - Running setup.py install for mozInstall
21:46:53 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin
21:46:53 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin
21:46:53 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin
21:46:53 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin
21:46:53 INFO - Running setup.py install for mozleak
21:46:53 INFO - Running setup.py install for mozlog
21:46:53 INFO - Installing structlog script to /builds/slave/test/build/venv/bin
21:46:53 INFO - Running setup.py install for moznetwork
21:46:53 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin
21:46:53 INFO - Running setup.py install for mozprocess
21:46:53 INFO - Running setup.py install for mozprofile
21:46:53 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin
21:46:53 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin
21:46:53 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin
21:46:53 INFO - Running setup.py install for mozrunner
21:46:53 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin
21:46:53 INFO - Running setup.py install for mozscreenshot
21:46:53 INFO - Running setup.py install for moztest
21:46:53 INFO - Running setup.py install for mozversion
21:46:53 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin
21:46:53 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion
21:46:53 INFO - Cleaning up...
21:46:54 INFO - Return code: 0
21:46:54 INFO - Installing None into virtualenv /builds/slave/test/build/venv
21:46:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]}
21:46:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org
21:46:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub
21:46:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]}
21:46:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org
21:46:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub
21:46:54 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 0x7fd56688fe30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12a2b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x143e130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14ccfc0>, '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 0x14cdec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14ce350>, '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': 'bb9b54edd4a927dc735d112f000001d9-1479447980.912237-1650614955', '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
21:46:54 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
21:46:54 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
21:46:54 INFO - Using env: {'DISPLAY': ':0',
21:46:54 INFO - 'HOME': '/home/cltbld',
21:46:54 INFO - 'LANG': 'en_US.UTF-8',
21:46:54 INFO - 'LANGUAGE': 'en_US:en',
21:46:54 INFO - 'LOGNAME': 'cltbld',
21:46:54 INFO - 'MAIL': '/var/mail/cltbld',
21:46:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1',
21:46:54 INFO - 'MOZ_NO_REMOTE': '1',
21:46:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript',
21:46:54 INFO - 'NO_EM_RESTART': '1',
21:46:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games',
21:46:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json',
21:46:54 INFO - 'PWD': '/builds/slave/test',
21:46:54 INFO - 'SHELL': '/bin/bash',
21:46:54 INFO - 'SHLVL': '1',
21:46:54 INFO - 'TERM': 'linux',
21:46:54 INFO - 'TMOUT': '86400',
21:46:54 INFO - 'USER': 'cltbld',
21:46:54 INFO - 'XDG_SESSION_COOKIE': 'bb9b54edd4a927dc735d112f000001d9-1479447980.912237-1650614955',
21:46:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn',
21:46:54 INFO - '_': '/tools/buildbot/bin/python'}
21:46:54 INFO - Ignoring indexes: https://pypi.python.org/simple/
21:46:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser
21:46:54 INFO - Running setup.py (path:/tmp/pip-sd55bq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser
21:46:54 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))
21:46:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash
21:46:54 INFO - Running setup.py (path:/tmp/pip-bvFacd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash
21:46:54 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))
21:46:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug
21:46:54 INFO - Running setup.py (path:/tmp/pip-actw_f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug
21:46:54 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))
21:46:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice
21:46:54 INFO - Running setup.py (path:/tmp/pip-KMlyCH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice
21:46:54 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))
21:46:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile
21:46:54 INFO - Running setup.py (path:/tmp/pip-SR4olE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile
21:46:54 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))
21:46:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd
21:46:54 INFO - Running setup.py (path:/tmp/pip-XVLM1B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd
21:46:54 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))
21:46:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo
21:46:54 INFO - Running setup.py (path:/tmp/pip-scXRI7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo
21:46:54 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))
21:46:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall
21:46:54 INFO - Running setup.py (path:/tmp/pip-VKCBmi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall
21:46:54 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))
21:46:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak
21:46:54 INFO - Running setup.py (path:/tmp/pip-zKqgLR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak
21:46:54 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))
21:46:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog
21:46:54 INFO - Running setup.py (path:/tmp/pip-cQMxF5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog
21:46:54 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))
21:46:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork
21:46:54 INFO - Running setup.py (path:/tmp/pip-2aE0v6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork
21:46:55 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))
21:46:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess
21:46:55 INFO - Running setup.py (path:/tmp/pip-uozm8G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess
21:46:55 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))
21:46:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile
21:46:55 INFO - Running setup.py (path:/tmp/pip-pW_klm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile
21:46:55 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))
21:46:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner
21:46:55 INFO - Running setup.py (path:/tmp/pip-wZzTrK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner
21:46:55 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))
21:46:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot
21:46:55 INFO - Running setup.py (path:/tmp/pip-U9ohrf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot
21:46:55 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))
21:46:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest
21:46:55 INFO - Running setup.py (path:/tmp/pip-kEjsz_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest
21:46:55 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))
21:46:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion
21:46:55 INFO - Running setup.py (path:/tmp/pip-btluSZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion
21:46:55 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))
21:46:55 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))
21:46:55 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))
21:46:55 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))
21:46:55 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))
21:46:55 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))
21:46:55 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10))
21:46:55 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
21:46:55 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
21:46:55 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
21:46:55 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
21:46:55 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
21:46:55 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
21:46:57 INFO - Downloading blessings-1.6.tar.gz
21:46:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings
21:46:57 INFO - Installing collected packages: blessings
21:46:57 INFO - Running setup.py install for blessings
21:46:57 INFO - Successfully installed blessings
21:46:57 INFO - Cleaning up...
21:46:57 INFO - Return code: 0
21:46:57 INFO - Done creating virtualenv /builds/slave/test/build/venv.
21:46:57 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze']
21:46:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze
21:46:57 INFO - Reading from file tmpfile_stdout
21:46:57 INFO - Current package versions:
21:46:57 INFO - argparse == 1.2.1
21:46:57 INFO - blessings == 1.6
21:46:57 INFO - blobuploader == 1.2.4
21:46:57 INFO - docopt == 0.6.1
21:46:57 INFO - functools32 == 3.2.3-2
21:46:57 INFO - jsonschema == 2.5.1
21:46:57 INFO - manifestparser == 1.1
21:46:57 INFO - mozInstall == 1.12
21:46:57 INFO - mozcrash == 1.0
21:46:57 INFO - mozdebug == 0.1
21:46:57 INFO - mozdevice == 0.49
21:46:57 INFO - mozfile == 1.2
21:46:57 INFO - mozhttpd == 0.7
21:46:57 INFO - mozinfo == 0.9
21:46:57 INFO - mozleak == 0.1
21:46:57 INFO - mozlog == 3.4
21:46:57 INFO - moznetwork == 0.27
21:46:57 INFO - mozprocess == 0.23
21:46:57 INFO - mozprofile == 0.28
21:46:57 INFO - mozrunner == 6.13
21:46:57 INFO - mozscreenshot == 0.1
21:46:57 INFO - mozsystemmonitor == 0.3
21:46:57 INFO - moztest == 0.7
21:46:57 INFO - mozversion == 1.4
21:46:57 INFO - psutil == 3.1.1
21:46:57 INFO - requests == 1.2.3
21:46:57 INFO - wsgiref == 0.1.2
21:46:57 INFO - Installing None into virtualenv /builds/slave/test/build/venv
21:46:57 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')]}
21:46:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org
21:46:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub
21:46:57 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')]}
21:46:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org
21:46:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub
21:46:57 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 0x7fd56688fe30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12a2b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x143e130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14ccfc0>, '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 0x14cdec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14ce350>, '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': 'bb9b54edd4a927dc735d112f000001d9-1479447980.912237-1650614955', '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
21:46:57 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
21:46:57 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
21:46:57 INFO - Using env: {'DISPLAY': ':0',
21:46:57 INFO - 'HOME': '/home/cltbld',
21:46:57 INFO - 'LANG': 'en_US.UTF-8',
21:46:57 INFO - 'LANGUAGE': 'en_US:en',
21:46:57 INFO - 'LOGNAME': 'cltbld',
21:46:57 INFO - 'MAIL': '/var/mail/cltbld',
21:46:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1',
21:46:57 INFO - 'MOZ_NO_REMOTE': '1',
21:46:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript',
21:46:57 INFO - 'NO_EM_RESTART': '1',
21:46:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games',
21:46:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json',
21:46:57 INFO - 'PWD': '/builds/slave/test',
21:46:57 INFO - 'SHELL': '/bin/bash',
21:46:57 INFO - 'SHLVL': '1',
21:46:57 INFO - 'TERM': 'linux',
21:46:57 INFO - 'TMOUT': '86400',
21:46:57 INFO - 'USER': 'cltbld',
21:46:57 INFO - 'XDG_SESSION_COOKIE': 'bb9b54edd4a927dc735d112f000001d9-1479447980.912237-1650614955',
21:46:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn',
21:46:57 INFO - '_': '/tools/buildbot/bin/python'}
21:46:58 INFO - Ignoring indexes: https://pypi.python.org/simple/
21:46:58 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))
21:46:58 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))
21:46:58 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))
21:46:58 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))
21:46:58 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))
21:46:58 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))
21:46:58 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))
21:46:58 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))
21:46:58 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))
21:46:58 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))
21:46:58 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))
21:46:58 INFO - Cleaning up...
21:46:58 INFO - Return code: 0
21:46:58 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv
21:46:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]}
21:46:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org
21:46:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub
21:46:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]}
21:46:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org
21:46:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub
21:46:58 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 0x7fd56688fe30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12a2b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x143e130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14ccfc0>, '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 0x14cdec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14ce350>, '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': 'bb9b54edd4a927dc735d112f000001d9-1479447980.912237-1650614955', '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
21:46:58 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
21:46:58 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
21:46:58 INFO - Using env: {'DISPLAY': ':0',
21:46:58 INFO - 'HOME': '/home/cltbld',
21:46:58 INFO - 'LANG': 'en_US.UTF-8',
21:46:58 INFO - 'LANGUAGE': 'en_US:en',
21:46:58 INFO - 'LOGNAME': 'cltbld',
21:46:58 INFO - 'MAIL': '/var/mail/cltbld',
21:46:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1',
21:46:58 INFO - 'MOZ_NO_REMOTE': '1',
21:46:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript',
21:46:58 INFO - 'NO_EM_RESTART': '1',
21:46:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games',
21:46:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json',
21:46:58 INFO - 'PWD': '/builds/slave/test',
21:46:58 INFO - 'SHELL': '/bin/bash',
21:46:58 INFO - 'SHLVL': '1',
21:46:58 INFO - 'TERM': 'linux',
21:46:58 INFO - 'TMOUT': '86400',
21:46:58 INFO - 'USER': 'cltbld',
21:46:58 INFO - 'XDG_SESSION_COOKIE': 'bb9b54edd4a927dc735d112f000001d9-1479447980.912237-1650614955',
21:46:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn',
21:46:58 INFO - '_': '/tools/buildbot/bin/python'}
21:46:58 INFO - Ignoring indexes: https://pypi.python.org/simple/
21:46:58 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages
21:46:58 INFO - Cleaning up...
21:46:58 INFO - Return code: 0
21:46:58 INFO - Running post-action listener: _resource_record_post_action
21:46:58 INFO - Running post-action listener: _start_resource_monitoring
21:46:58 INFO - Starting resource monitoring.
21:46:58 INFO - [mozharness: 2016-11-18 05:46:58.389787Z] Finished create-virtualenv step (success)
21:46:58 INFO - [mozharness: 2016-11-18 05:46:58.390306Z] Running install step.
21:46:58 INFO - Running pre-action listener: _resource_record_pre_action
21:46:58 INFO - Running main action method: install
21:46:58 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze']
21:46:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze
21:46:58 INFO - Reading from file tmpfile_stdout
21:46:58 INFO - Detecting whether we're running mozinstall >=1.0...
21:46:58 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h']
21:46:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h
21:46:58 INFO - Reading from file tmpfile_stdout
21:46:58 INFO - Output received:
21:46:58 INFO - Usage: mozinstall [options] installer
21:46:58 INFO - Options:
21:46:58 INFO - -h, --help show this help message and exit
21:46:58 INFO - -d DEST, --destination=DEST
21:46:58 INFO - Directory to install application into. [default:
21:46:58 INFO - "/builds/slave/test"]
21:46:58 INFO - --app=APP Application being installed. [default: firefox]
21:46:58 INFO - mkdir: /builds/slave/test/build/application
21:46:58 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']
21:46:58 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
21:47:15 INFO - Reading from file tmpfile_stdout
21:47:15 INFO - Output received:
21:47:15 INFO - /builds/slave/test/build/application/firefox/firefox
21:47:15 INFO - Running post-action listener: _resource_record_post_action
21:47:15 INFO - [mozharness: 2016-11-18 05:47:15.566937Z] Finished install step (success)
21:47:15 INFO - [mozharness: 2016-11-18 05:47:15.567207Z] Running run-tests step.
21:47:15 INFO - Running pre-action listener: _resource_record_pre_action
21:47:15 INFO - Running main action method: run_tests
21:47:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version']
21:47:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version
21:47:15 INFO - Python 2.7.3
21:47:15 INFO - Return code: 0
21:47:15 INFO - grabbing minidump binary from tooltool
21:47:15 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')]}
21:47:15 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 0x14ccfc0>, '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 0x14cdec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14ce350>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1
21:47:15 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
21:47:15 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
21:47:15 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
21:47:15 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache
21:47:15 INFO - Return code: 0
21:47:15 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755
21:47:15 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir
21:47:15 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir
21:47:15 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk
21:47:15 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir
21:47:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1479436622/firefox-53.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-055', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build
21:47:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Inbound --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1479436622/firefox-53.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-055 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log
21:47:15 INFO - Using env: {'DISPLAY': ':0',
21:47:15 INFO - 'HOME': '/home/cltbld',
21:47:15 INFO - 'LANG': 'en_US.UTF-8',
21:47:15 INFO - 'LANGUAGE': 'en_US:en',
21:47:15 INFO - 'LOGNAME': 'cltbld',
21:47:15 INFO - 'MAIL': '/var/mail/cltbld',
21:47:15 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir',
21:47:15 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk',
21:47:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1',
21:47:15 INFO - 'MOZ_NO_REMOTE': '1',
21:47:15 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir',
21:47:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript',
21:47:15 INFO - 'NO_EM_RESTART': '1',
21:47:15 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games',
21:47:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json',
21:47:15 INFO - 'PWD': '/builds/slave/test',
21:47:15 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos',
21:47:15 INFO - 'SHELL': '/bin/bash',
21:47:15 INFO - 'SHLVL': '1',
21:47:15 INFO - 'TERM': 'linux',
21:47:15 INFO - 'TMOUT': '86400',
21:47:15 INFO - 'USER': 'cltbld',
21:47:15 INFO - 'XDG_SESSION_COOKIE': 'bb9b54edd4a927dc735d112f000001d9-1479447980.912237-1650614955',
21:47:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn',
21:47:15 INFO - '_': '/tools/buildbot/bin/python'}
21:47:15 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1479436622/firefox-53.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-055', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600
21:47:15 INFO - mozversion application_buildid: 20161117183702
21:47:15 INFO - mozversion application_changeset: dcd436e553ed85cadb6538ca4f4382610a7bcd5f
21:47:15 INFO - mozversion application_display_name: Nightly
21:47:15 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384}
21:47:15 INFO - mozversion application_name: Firefox
21:47:15 INFO - mozversion application_remotingname: firefox
21:47:15 INFO - mozversion application_repository: https://hg.mozilla.org/integration/mozilla-inbound
21:47:15 INFO - mozversion application_vendor: Mozilla
21:47:15 INFO - mozversion application_version: 53.0a1
21:47:15 INFO - mozversion platform_buildid: 20161117183702
21:47:15 INFO - mozversion platform_changeset: dcd436e553ed85cadb6538ca4f4382610a7bcd5f
21:47:15 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/mozilla-inbound
21:47:15 INFO - mozversion platform_version: 53.0a1
21:47:15 INFO - using testdate: 1479448035
21:47:15 INFO - actual date: 1479448035
21:47:15 INFO - starting webserver on 'localhost:56204'
21:47:15 INFO - SUITE-START | Running 2 tests
21:47:15 INFO - TEST-START | dromaeo_css
21:47:15 INFO - operating with platform_type : linux_
21:47:15 INFO - Initialising browser for dromaeo_css test...
21:47:15 INFO - TEST-INFO | started process 29566 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpfp0v3g/profile http://localhost:56204/getInfo.html)
21:47:20 INFO - PROCESS | 29566 | __metrics Screen width/height:1600/1200
21:47:20 INFO - PROCESS | 29566 | colorDepth:24
21:47:20 INFO - PROCESS | 29566 | Browser inner width/height: 1024/697
21:47:20 INFO - PROCESS | 29566 | __metrics
21:47:20 ERROR - PROCESS | 29566 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3179: TypeError: this.tabs is undefined
21:47:21 INFO - TEST-INFO | 29566: exit 0
21:47:21 INFO - Browser initialized.
21:47:21 INFO - Running cycle 1/1 for dromaeo_css test...
21:47:21 INFO - TEST-INFO | started process 29690 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpfp0v3g/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1)
21:47:34 INFO - PROCESS | 29690 | RSS: Main: 186302464
21:47:34 INFO - PROCESS | 29690 |
21:48:23 INFO - PROCESS | 29690 | 1479448103760 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]
21:50:35 INFO - PROCESS | 29690 | Cycle 1(1): loaded http://localhost:56204/tests/dromaeo/cssquery-dojo.html (next: http://localhost:56204/tests/dromaeo/cssquery-ext.html)
21:50:37 INFO - PROCESS | 29690 | RSS: Main: 198090752
21:50:37 INFO - PROCESS | 29690 |
21:53:39 INFO - PROCESS | 29690 | Cycle 1(1): loaded http://localhost:56204/tests/dromaeo/cssquery-ext.html (next: http://localhost:56204/tests/dromaeo/cssquery-jquery.html)
21:53:39 INFO - PROCESS | 29690 | RSS: Main: 197054464
21:53:39 INFO - PROCESS | 29690 |
21:56:42 INFO - PROCESS | 29690 | Cycle 1(1): loaded http://localhost:56204/tests/dromaeo/cssquery-jquery.html (next: http://localhost:56204/tests/dromaeo/cssquery-mootools.html)
21:56:42 INFO - PROCESS | 29690 | RSS: Main: 198332416
21:56:42 INFO - PROCESS | 29690 |
21:59:44 INFO - PROCESS | 29690 | Cycle 1(1): loaded http://localhost:56204/tests/dromaeo/cssquery-mootools.html (next: http://localhost:56204/tests/dromaeo/cssquery-prototype.html)
21:59:45 INFO - PROCESS | 29690 | RSS: Main: 195657728
21:59:45 INFO - PROCESS | 29690 |
22:02:47 INFO - PROCESS | 29690 | Cycle 1(1): loaded http://localhost:56204/tests/dromaeo/cssquery-prototype.html (next: http://localhost:56204/tests/dromaeo/cssquery-yui.html)
22:02:48 INFO - PROCESS | 29690 | RSS: Main: 199024640
22:02:48 INFO - PROCESS | 29690 |
22:05:51 INFO - PROCESS | 29690 | Cycle 1(1): loaded http://localhost:56204/tests/dromaeo/cssquery-yui.html (next: http://localhost:56204/tests/dromaeo/cssquery-dojo.html)
22:05:51 INFO - PROCESS | 29690 | RSS: Main: 199073792
22:05:51 INFO - PROCESS | 29690 |
22:05:51 INFO - PROCESS | 29690 | __start_tp_report
22:05:51 INFO - PROCESS | 29690 | _x_x_mozilla_page_load
22:05:51 INFO - PROCESS | 29690 | _x_x_mozilla_page_load_details
22:05:51 INFO - PROCESS | 29690 | |i|pagename|runs|
22:05:51 INFO - PROCESS | 29690 | |0;dojo.html;3056.205386599485;3079.8306093164874;3099.039297817675;3131.170239886429;3133.514305282681;5391.703456309911;5505.642133261335;5558.221848941146;5601.579881508887;5620.1288800235925;5441.863953401167;5444.727763611813;5468.371137319209;5498.560115190785;5506.5870059745475;4939.481354457784;4953.727544985024;5015.623828212881;5038.067957427869;5084.339035925324;5030.949690503103;5050.444451110375;5064.215046667754;5086.79652813887;5099.643024988252;4946.554810067111;5001.44984051754;5012.448630650625;5071;5076.6700164489375;4983.626228032876;5001.624878134155;5007.649464537484;5011.2483127530795;5018.7490625468945;4910.950890491121;4930.556249937523;4969.503049695038;4969.875753106165;5032.4212715537815;5483.232347471358;5496.450354964471;5522.337319521643;5527.143292789584;5532.3914369419335;5772.480476757112;5903.481808806875;5909.9704501477645;5910.940890591082;5974.312954010301;5827.679477628729;5876.941230587725;5892.793752218695;5905.645661260295;5919.5560332974765;5453.672779633234;5529.612927095145;5533.142362933751;5541.584381171388;5563.610547261694;5966.0454327307425;6009.609375390585;6016.639001659827;6017.548683848729;6052.152698622196;5630.127330263816;5696.487316141567;5770.740316685759;5770.769169233184;5801.767929282866;5898.4101589840675;5906.40935906406;5908.793192238337;5948.494377977834;5959.106134079922;5698.7435565399655;5753.309602847685;5763.423657634287;5784.1034639630925;5835.066389377679;5814.505767009767;5837.591368604157;5849;5887.646741195542;5895.852603684856;4375.934360984587;4391.429114215131;4391.956080439155;4406.779661017001;4486.528914463999;3923.9803800981385;3962.366021436614;3966.345552983783;3993.1414745829784;3998.100427403869;5602.971985140048;5615;5616.326040875121;5617.859553511195;5627.606067575231;5733.226014488074;5802.622829516068;5886.117082437669;5890.852728681817;5905.527557795366;5515.310586176728;5635.887282254332;5644.407337229614;5644.887102258014;5659.688717120598;5049.899002019939;5091.490850914879;5109.105906466353;5121.641485096007;5154.768035438415;5913.911291330547;6055.424734650289;6064.151018857364;6065.181200537871;6080.513558915276;5784.132380143013;5817.854553636023;5878.265216847894;5893.44012318829;5897.941020589911;5998.820035398945;6015.578909476295;6018.3379828217985;6037.849053773691;6081.604695694766;5760.135979603093;5790.160426738015;5800.187973683604;5819.388964158702;5836.445537673914;5901.970490147522;5919.082542205965;5926.199963005111;5934.1988831508925;5950.434708702666;5652.745626446737;5664.178694089416;5690.032694442038;5707.885842283048;5817.650940943557;5647.29408823897;5683.658980461186;5712.0860662293835;5727.055035919193;5769.307683078057;5735.770569177186;5750.942490575041;5763.394843541536;5781.190633311424;5797.449242321973;5881.235439393023;5884.205632239764;5885.47030767233;5895.734691938959;5903.616264942765;5438.864028399322;5445.128779395436;5456;5575.693336866511;5608.383077861514
22:05:51 INFO - PROCESS | 29690 | |1;ext.html;557.8187089196011;576.3228206856943;597.9013462778641;600.636614848017;606.1786279591157;39984;41423.37864932025;41759.58240417595;44907.77546112273;45012.549874501245;42904.785476072575;43203.78398108005;43205.35191972123;43245.35131973015;43795.56204437955;8502.149785021511;8615.35384846136;8644.610992505352;8651.567421628924;8662.61018254177;8602.311815054813;8717.825643487127;8741.43180693256;8747.16901894319;8763.912360876406;8697.260732837716;8715.607797649121;8765.912340876605;8768.167024132697;8795.560221988906;8608.612612432456;8657.567121643924;8682.652693892236;8718.738437846843;8738.082501337396;8453.154684531559;8459.873101903477;8511.57442127891;8547.35894807892;8587.61355738987;39331.803340983395;39536;39588.20823583541;39591;39650;3427.8286085695863;3437.673421025024;3445.43150380187;3450.9309813803834;3457.4468085106264;29990.40019199604;30106.24734381636;30305.696943030507;30366.84816575925;31620.841895790374;4119.573465393965;4130.091379896418;4159.91680166395;4161.3549899765585;4250.574942505756;314216;315433;316630;317531;318615;55710.44289557134;55777.72111139418;55961.16058259129;56061.71969140128;56405.43594564084;58288;58342;58358.416415836145;58380;58456.41543584595;15301.693966120838;15355.846441535441;15480.5355839325;15546.611334716496;15548.76676849848;10884.72788180286;10919.890801091888;10930.56277748881;10940.288881222696;10987.835182472269;15611.453599124203;15743.606409839616;15895.841041589667;15956.521304360887;16244.507430902413;6086.391360863879;6147.784827531015;6243.500519958392;6282.371762823681;6408.711607977652;948.6252930092575;1021.8518314844306;1040.2822052783556;1115.358668765463;1150.9021733152608;31509.212269692984;31568.368632627677;31870.203244919063;32086.518702219484;32230;1026.9383836969805;1107.5237647811518;1131.9434028298551;1146.4611632532697;1185.5435657272012;16197.51407457778;16311.347546098023;16431;16463.91768041176;16647.91676041612;468781;470124;472128;472266;472280;54131.72934135304;54153.45846541563;54422.72788636031;54438;54482.18276725852;1307.8561358250586;1337.6588969812635;1359.2252416122715;1374.6632075141654;1383.2876068824564;30130.548041779828;31691.890783822455;32508.349833003682;32576;35184.296314073064;51791.74104129606;52967.47032529626;53017;58293;58345.416545834;438050;438569.9501552419;439370;439856;441328;27191.72808271892;27345.589816152376;27564.173074807786;27748.8612556944;27773.444531109668;45262.77368613136;46161.76919115383;46494;47007.29489057735;47198;39212;39214.607853922236;39494.65228620311;40931.795341023106;41184.176316472905;38136.61863381442;39728.80135599303;39902.60097398989;40016;40698.38952415657;39504;40211.79894100511;40809.387859181545;41357.37963930603;41422.58577414187;29689.851550742107;34551.4817277736;35824.46263306;36168.819155905105;36218.09454763652;25833.956397090915;26202.73797262003;26334.736652633994;26401;26807.463850723267
22:05:51 INFO - PROCESS | 29690 | |2;jquery.html;378.94884190634275;386.75247841381537;400.2555247240133;406.1633035945951;407.3767136281489;18770.343037993673;19087.522811929673;19338.323158689447;19358.806411935875;19878.20487180515;19066.33267835626;19244.230230790785;19331.130099145535;19433.611327773473;19593.902030489862;5338.199270109495;5350.866228344284;5511.9724401377935;5557.861053473675;5582.553395728332;5428.4842939920645;5471.316085489314;5500.257465242201;5509.586780991422;5510.5316048135755;5343.126737090022;5382.434844341346;5469.453054694519;5493;5500;5376.677399356051;5424.83725488236;5425.104857698495;5425.9728701356635;5458.181272809091;4657.4876763555985;4882.389701287339;4894.951050489485;4927.211646136601;4961.8511444656715;21101.894490527447;21759.45601359963;21847.781522184734;22331.330060098222;22789.31632051041;2206.2498750424934;2302.1482051640833;2492.401823562332;2696.6224728538023;2864.140757772681;9439.197668198143;9637.855432168522;9695.854562181574;9967;15440.845591544054;1961.3331467301186;1978.9802101979085;2024.665930121543;2041.612093702192;2091.968620470694;79740;83582.58208708979;87883.12116878813;94525.5273723627;104232.70371074027;17194.828051719323;17436.825631743774;17548.473545793648;17717.202725877367;17796.021218833088;31309.8434507826;31630.367392652017;31831.681683182873;31981.360372792413;31988.840055799574;9198.218151457068;9345.859812102824;9558;9612.711618651452;9623.807523849624;7828.373730101692;7906.881396779053;8096.311813495919;8112.472689275178;8134.633941472648;8359.289460395934;8730.257928076184;8778.253848422828;8991.775205619912;9007.973206028591;3246.4318744219668;3398.3543126805826;3526.982365088158;3549.3078849624076;3595.2270261893295;982.921366290695;1006.7231511334442;1008.9646862359782;1021.2902033087082;1023.534291897185;19635.538495371668;19870.90064549668;19902;19964.101615427342;20168;962.932594718363;976.5751897924425;993.3642468819961;1000.1398797034544;1036.5024788101753;10651.680449586525;10911.781764364669;11072.612458563912;11095.944520277508;11144.554217831359;442258;442370;445395;446817;447781;85485;86495.1350486487;93001;95419;97637.51181244191;1020.7448137965508;1036.8548403223556;1044.4829809244472;1046.1682962045193;1049.2130901823632;17168.484945451655;17405.651886961936;17938.103094845468;18143.546411339823;18271.725924110884;27991.860040699667;33041.173970649965;41379.58620413757;42484.362734559625;43362.13275734404;56578.43421565732;57084.71457642685;57178.14232786595;57726.7113664429;57953.710231448575;7673.61631918413;7775.261350171951;7789.883151752615;7895.1315355309725;7931.929189559336;12033.338166400932;12060.396980151132;12085.335306558223;12283;12393.814092788434;11097.778044439228;11141.554337826396;11427.771584540935;11481.885181148082;11604.6518604442;10610.52252648648;10632.41521716313;10671.839922401015;10931.83602245951;11157.10743140563;10810.729731756768;10820.621278255538;11134.721631959266;11154.16343774204;11552.59565915189;7894.921050789419;7906.644201011083;7910.683572657029;8161.265486106279;8292.12932642064;7858.44990850635;9914.30599858003;11030.669079927615;11075.224734268524;11463.770724585629
22:05:51 INFO - PROCESS | 29690 | |3;mootools.html;1456.766917293233;1490.716763814875;1608.9356425742963;1646.7941507311587;1701.3194722111155;7553.395728341733;7764.223577642233;7794.220577942203;8237.299829514492;8246.711365102215;7849;8124;8164.959175204131;8174.6730130794695;8319.126491718358;2219.522802597445;2291.072115793098;2301.493671392291;2303.5047464795066;2311.341267738695;2240.4958884250996;2281.680564720932;2283.2122917593406;2305.227748704178;2311.595470792613;2307.492351682627;2313.7570555091725;2334.754850740673;2338.4504641409253;2339.485313231095;2205.9889700551553;2210.4363387336125;2227.9777202228015;2248;2249.167807911075;2264.671622614728;2279.327598358488;2283.2807665585456;2284.805791507724;2287.085165933623;8183.304419124382;8216.178382161735;8329.208725171098;8430.704925327645;8433.873491897626;4979.601631869442;5065.670731402447;5081.79672813087;5118.334616499831;5133.383993920716;3157.258044359574;3196.856141473639;3443.1736383268085;3452.4648679454726;3481.947770783415;1054.0460882900986;1068.4604274841156;1089.2538611051455;1104.1553211792984;1122.8091224491775;11609.941950290195;11669.124815638861;11771.94114029433;11782.823257651142;11786.35175065371;4324.762138082373;4420.469543654718;4529.660275479287;4543.614197669676;4560.703554268962;9715.805683886283;9758.756031099138;9763.414195148314;9766.706998790047;9780.608775648894;5177.896442071213;5216.400113986864;5223.817166399158;5236.1098613235845;5241;4309.159713855831;4573.49691533931;4670.719756814602;4737.147313483537;4849.442314133919;3865.942010869839;3972.920541589152;3985.8206380712936;3997.9400308995387;4028.5367182774357;1276.6425400887767;1317.1636011133;1332.4403750424651;1332.4936524120772;1361.86381361865;835.5529791561607;903.7605034665819;915.8809354783835;931.9301052421096;962.7881865989472;5604.019296623074;5704.258446401941;5773.942260577424;5806.593538452268;6047.425494578008;413.85928784213513;426.9210196113729;430.72003197920975;1000.2648053680539;1028.6605420211313;3934.7442416243425;4061.147159096564;4090.6318431341324;4102.466679331727;4245.724027938174;9890.109890109925;10167.898321016843;10240.027197416233;10310.793784124426;10333.070023697754;10067.194624430029;10168;10222.846657300146;10234.283600147919;10271.9486402569;7644.655990480442;7995;8007.199280071946;8023.959880200561;8038.236367545074;5752.9712351437975;5763.9135412968;5817.0983497557945;5865.384134665969;5929.229200203946;9622.13400793932;9632.711018669452;9700.854487182556;9734.221262299141;9774.413535187912;9467.479288639192;9765.316427849983;9810.313278070467;9902.702918912444;9925.305228634215;6539.509536784665;6695.765648202289;6854.3549548109095;7064.929350706633;7252.746153884589;7802.648880800264;8165.346772258324;8178.83642327162;8181.550014749246;8199.549024803693;7102.715891364288;7164.462665300228;7239.819004524929;7259.310365515267;7452.515586486861;6999.6850141742725;7050.576965381888;7195.13658361;7296.562206267641;7553.7356192533;6670.132882725215;6711.463082953254;6744.898826517508;6762.797116086525;6778.2205046420295;5058.570021548209;5082.313887625123;5123.436421993652;5151.6908985461;5175.042617115846;5074.543291103819;5076.162433198481;5134.9486505135965;5149.716765577929;5157.226416037624
22:05:51 INFO - PROCESS | 29690 | |4;prototype.html;303.17536301260577;312.4766016921656;316.1653235458389;317.04253155470474;317.16110886704666;5397.487238712316;5468.890622187564;5544;5581.413951535086;5618.522425593825;5225.555827754645;5307.946920530793;5351.7324133793345;5390.380106287768;5390.946090539093;4105.178964207155;4151.584841515854;4153.730007549515;4155.439015732883;4170.854020109282;4107.54816970133;4179.895502612429;4181.351890456984;4189.581041895816;4214.7681877496725;4128.174365126972;4132.731372460796;4137.54487006429;4151.169766046788;4176.874693759192;4122.567130451304;4141.295979683431;4147.066909945238;4147.315692910666;4147.6889233307475;3540.6813386795056;3587.3722098632634;3588;3608.278344331144;3630.366335149193;5316.9734151329385;5318.547923426475;5340.570040631504;5358.4373640767935;5446.183072539111;4729.172394830891;4748.3589715388325;4766.618670506386;4778.395774303013;4783.354247176656;5506.752196151183;5675.34733505648;5711.602066408842;5719.971400142973;5732.3407808101765;3982.82077306519;3985.5217373915316;3985.7608543487486;3993.6206060424215;4008.2183974125055;5975.820725378246;5978.312494063195;6010.8497287567725;6012.849678758066;6064.3935606439445;3989.7007724420782;3993.6405723485027;4050.2709512287483;4050.4936882889638;4074.4703188585295;4078.775667338325;4093.91812163761;4125.092479654471;4126.401671757639;4130.793460326971;4806.2310030394965;4814.807407703723;4816.133096042746;4820.4456487504385;4847.5394837490385;5447.945520544744;5708.4862362387585;5729.369769325371;5832.1834943108;5852.678102704307;1340.8870637371153;1383.4604504243352;1387.1399732166121;1387.6461502316845;1388.805627160641;860.5267103093273;924.8751418558409;925.2967744514218;937.6905621145006;945.6122989574242;5282.920756188661;5291.576673866081;5297.629165958346;5333.919991200135;5339.86650333737;5697.230873832063;5702.173184888168;5730.598858079978;5732.942670573324;5762.711864406763;5251.291075704808;5272.2355258487305;5318.202269659505;5406.351237851483;5419.593530485229;2981.701829817001;3004.4742170120144;3013.9698603014126;3022.3653032862903;3025.8940937067096;5741.85645358861;5765.913511297334;5809.88380232393;5853.414658534198;5863.501602363762;5501.229827824028;5700.0929525942065;5746.540276777848;5777.277840269966;5792.88414231713;5807.767689292466;5820.3888591698105;5838.182654428383;5844.473997340175;5898.292204935436;5560.443955604407;5573.554115670818;5675.77296908119;5715.542536653127;5888.499477544286;5813.447722466359;5840.445157710011;5850.561207909509;5854.4730974212525;5880.118362124079;6124.284301088226;6161.537884658579;6168.414000669929;6205.6586887721605;6224.657643829632;3887.317750752085;4057.2494088592525;4064.451299074587;4069;4087.5503694594167;5720.19917211599;5878.911816322673;5898.174255604133;5927.792527261525;5957.523398128226;5673.234113394804;5780.826575202583;5786.479216870502;5790.681512516852;5816;5750.223719797941;5750.281214848144;5754.769809207585;5756.913646295393;5762.827115186551;5650.576206784425;5659.518940889906;5686.658800471985;5695.686737229492;5729.828105156852;5751.884962300815;5766.913496297475;5779.624324418899;5794.391588883106;5825.475707186373;5465.180222966586;5672.376038635664;5678.829635110953;5714.114342267125;5721.771129154788
22:05:51 INFO - PROCESS | 29690 | |5;yui.html;721.3507842941356;731.7109741652047;743.9590822504761;762.8207371267752;829.3696790439265;12108.334041627719;12366.242530265195;12602.873971260286;13007.869921300784;13500.392482338293;13612.931935340333;13740.862591374083;13762.93118534406;13764.65588360289;13773.173609583408;753.7776355974974;756.8410633766915;761.5773245848552;767.5931756169239;772.3705180278083;782.6165179062247;785.783909424907;786.5438045933345;786.9881951770728;789.5105034878384;821.8685010398337;822.5229366967145;825.628467189767;827.6027506796742;830.6469750356074;814.352589691197;818.1082619944259;818.1491249100928;819.868820988639;820.5733018830175;599.9490043346277;604;604.1662505742091;604.9153118563361;605.3764622438895;12695;12747.936260318731;13007;13048.739025219442;13054.412551435209;12812.42344094518;13799.310034498234;13883.37524811386;13942.37259323333;13963.37164827575;11393.601223957205;11411.885881141248;11425.657230283105;11531.827022594667;12303.32331721755;3573.76770509916;3587.3947778935126;3676.558812942464;3695.3533131702115;3797.373433383488;66666.66666666685;67653.66173169152;68667.31332686658;68747.65626171888;69297.65351173263;10220.948895255477;10407.791844163074;10550.788984220273;10570.577176912837;10637.73405664849;19570.315038973567;19589.31437399684;19726;19882.801171988383;19932.20271189136;7801.648925798353;7827.373810095179;7858.8428231435055;7883.36933045355;7959.761207163794;4406.713563618355;4413.558644135561;4419.0940857124215;4518.186726389215;4592.747398893093;3054;3143.167060728909;3145.119366577362;3146.7639927005107;3150.7321877640657;572.7794799002331;581.3779256195915;586.2027642406324;589.3899813692807;597.235538510707;641.1632819170933;655.3844772635476;659.5317324699421;670.9396154346034;683.4907993544841;8520.403571750043;8686.6525338987;8717.389782715276;8793.516356600448;9264.39781414206;563.7773079633522;575.8790653962715;607.802464199137;640.0271587187542;676.1109141478939;4263.76549289792;4342.609165175149;4358.607725304738;4428.402165707588;4480.0367920896515;67989;72510;72520.63739681267;73072.26927730655;75104.62447687837;41841.58158418438;48712.269315960286;65136;66784.99645010657;69624;62660;64190;64405.67797160984;64421;65241.34758652353;9354.53227338644;9452.527373631428;9560.713178604654;9733.756656083655;9824.55789489489;43688.34467482927;44280.7785961081;45526;45683.31475027811;46354;56439.43560564342;58510.511227903415;59068.704656476446;59338.70330648319;60547.78904421975;11818.290902545874;11835.526578936746;12146.514139434325;12147.635570932885;12161.574344897886;13252.403641835948;13394.330283485591;13485.40155097568;13572.253526056162;13765.518206862711;11948.462319195483;12419.627411177678;12524.624261272176;13267.469301227842;13499.257540835348;12045.277283363026;12524.436400362189;12757.123608962374;12883.227006379648;13130.409131589293;12309.876901230873;12613.74772504563;12784.105112642026;13518.188908665512;13520.12119212248;10189.23580731463;10538.57845686164;10554.736131596772;10856.511456984612;10933.343999360064;10811.13510919109;11014.724631884266;11385.896424684792;11535.480903359537;11554.653360399201
22:05:51 INFO - PROCESS | 29690 | __end_tp_report
22:05:51 INFO - PROCESS | 29690 | __start_cc_report
22:05:51 INFO - PROCESS | 29690 | _x_x_mozilla_cycle_collect,324
22:05:51 INFO - PROCESS | 29690 | __end_cc_report
22:05:51 INFO - PROCESS | 29690 | __startTimestamp1479449151445__endTimestamp
22:05:51 INFO - PROCESS | 29690 |
22:05:51 INFO - PROCESS | 29690 | ------- Summary: start -------
22:05:51 INFO - PROCESS | 29690 | Number of tests: 6
22:05:51 INFO - PROCESS | 29690 |
22:05:51 INFO - PROCESS | 29690 | [#0] dojo.html Cycles:165 Average:5456.56 Median:5659.69 stddev:631.10 (11.2%) stddev-sans-first:604.29
22:05:51 INFO - PROCESS | 29690 | Values: 3056.2 3079.8 3099.0 3131.2 3133.5 5391.7 5505.6 5558.2 5601.6 5620.1 5441.9 5444.7 5468.4 5498.6 5506.6 4939.5 4953.7 5015.6 5038.1 5084.3 5030.9 5050.4 5064.2 5086.8 5099.6 4946.6 5001.4 5012.4 5071.0 5076.7 4983.6 5001.6 5007.6 5011.2 5018.7 4911.0 4930.6 4969.5 4969.9 5032.4 5483.2 5496.5 5522.3 5527.1 5532.4 5772.5 5903.5 5910.0 5910.9 5974.3 5827.7 5876.9 5892.8 5905.6 5919.6 5453.7 5529.6 5533.1 5541.6 5563.6 5966.0 6009.6 6016.6 6017.5 6052.2 5630.1 5696.5 5770.7 5770.8 5801.8 5898.4 5906.4 5908.8 5948.5 5959.1 5698.7 5753.3 5763.4 5784.1 5835.1 5814.5 5837.6 5849.0 5887.6 5895.9 4375.9 4391.4 4392.0 4406.8 4486.5 3924.0 3962.4 3966.3 3993.1 3998.1 5603.0 5615.0 5616.3 5617.9 5627.6 5733.2 5802.6 5886.1 5890.9 5905.5 5515.3 5635.9 5644.4 5644.9 5659.7 5049.9 5091.5 5109.1 5121.6 5154.8 5913.9 6055.4 6064.2 6065.2 6080.5 5784.1 5817.9 5878.3 5893.4 5897.9 5998.8 6015.6 6018.3 6037.8 6081.6 5760.1 5790.2 5800.2 5819.4 5836.4 5902.0 5919.1 5926.2 5934.2 5950.4 5652.7 5664.2 5690.0 5707.9 5817.7 5647.3 5683.7 5712.1 5727.1 5769.3 5735.8 5750.9 5763.4 5781.2 5797.4 5881.2 5884.2 5885.5 5895.7 5903.6 5438.9 5445.1 5456.0 5575.7 5608.4
22:05:51 INFO - PROCESS | 29690 |
22:05:51 INFO - PROCESS | 29690 | [#1] ext.html Cycles:180 Average:56827.75 Median:40870.59 stddev:109683.37 (268.4%) stddev-sans-first:109909.69
22:05:51 INFO - PROCESS | 29690 | Values: 557.8 576.3 597.9 600.6 606.2 39984.0 41423.4 41759.6 44907.8 45012.5 42904.8 43203.8 43205.4 43245.4 43795.6 8502.1 8615.4 8644.6 8651.6 8662.6 8602.3 8717.8 8741.4 8747.2 8763.9 8697.3 8715.6 8765.9 8768.2 8795.6 8608.6 8657.6 8682.7 8718.7 8738.1 8453.2 8459.9 8511.6 8547.4 8587.6 39331.8 39536.0 39588.2 39591.0 39650.0 3427.8 3437.7 3445.4 3450.9 3457.4 29990.4 30106.2 30305.7 30366.8 31620.8 4119.6 4130.1 4159.9 4161.4 4250.6 314216.0 315433.0 316630.0 317531.0 318615.0 55710.4 55777.7 55961.2 56061.7 56405.4 58288.0 58342.0 58358.4 58380.0 58456.4 15301.7 15355.8 15480.5 15546.6 15548.8 10884.7 10919.9 10930.6 10940.3 10987.8 15611.5 15743.6 15895.8 15956.5 16244.5 6086.4 6147.8 6243.5 6282.4 6408.7 948.6 1021.9 1040.3 1115.4 1150.9 31509.2 31568.4 31870.2 32086.5 32230.0 1026.9 1107.5 1131.9 1146.5 1185.5 16197.5 16311.3 16431.0 16463.9 16647.9 468781.0 470124.0 472128.0 472266.0 472280.0 54131.7 54153.5 54422.7 54438.0 54482.2 1307.9 1337.7 1359.2 1374.7 1383.3 30130.5 31691.9 32508.3 32576.0 35184.3 51791.7 52967.5 53017.0 58293.0 58345.4 438050.0 438570.0 439370.0 439856.0 441328.0 27191.7 27345.6 27564.2 27748.9 27773.4 45262.8 46161.8 46494.0 47007.3 47198.0 39212.0 39214.6 39494.7 40931.8 41184.2 38136.6 39728.8 39902.6 40016.0 40698.4 39504.0 40211.8 40809.4 41357.4 41422.6 29689.9 34551.5 35824.5 36168.8 36218.1 25834.0 26202.7 26334.7 26401.0 26807.5
22:05:51 INFO - PROCESS | 29690 |
22:05:51 INFO - PROCESS | 29690 | [#2] jquery.html Cycles:180 Average:28521.07 Median:3538.15 stddev:73738.03 (2084.1%) stddev-sans-first:73914.61
22:05:51 INFO - PROCESS | 29690 | Values: 378.9 386.8 400.3 406.2 407.4 18770.3 19087.5 19338.3 19358.8 19878.2 19066.3 19244.2 19331.1 19433.6 19593.9 5338.2 5350.9 5512.0 5557.9 5582.6 5428.5 5471.3 5500.3 5509.6 5510.5 5343.1 5382.4 5469.5 5493.0 5500.0 5376.7 5424.8 5425.1 5426.0 5458.2 4657.5 4882.4 4895.0 4927.2 4961.9 21101.9 21759.5 21847.8 22331.3 22789.3 2206.2 2302.1 2492.4 2696.6 2864.1 9439.2 9637.9 9695.9 9967.0 15440.8 1961.3 1979.0 2024.7 2041.6 2092.0 79740.0 83582.6 87883.1 94525.5 104232.7 17194.8 17436.8 17548.5 17717.2 17796.0 31309.8 31630.4 31831.7 31981.4 31988.8 9198.2 9345.9 9558.0 9612.7 9623.8 7828.4 7906.9 8096.3 8112.5 8134.6 8359.3 8730.3 8778.3 8991.8 9008.0 3246.4 3398.4 3527.0 3549.3 3595.2 982.9 1006.7 1009.0 1021.3 1023.5 19635.5 19870.9 19902.0 19964.1 20168.0 962.9 976.6 993.4 1000.1 1036.5 10651.7 10911.8 11072.6 11095.9 11144.6 442258.0 442370.0 445395.0 446817.0 447781.0 85485.0 86495.1 93001.0 95419.0 97637.5 1020.7 1036.9 1044.5 1046.2 1049.2 17168.5 17405.7 17938.1 18143.5 18271.7 27991.9 33041.2 41379.6 42484.4 43362.1 56578.4 57084.7 57178.1 57726.7 57953.7 7673.6 7775.3 7789.9 7895.1 7931.9 12033.3 12060.4 12085.3 12283.0 12393.8 11097.8 11141.6 11427.8 11481.9 11604.7 10610.5 10632.4 10671.8 10931.8 11157.1 10810.7 10820.6 11134.7 11154.2 11552.6 7894.9 7906.6 7910.7 8161.3 8292.1 7858.4 9914.3 11030.7 11075.2 11463.8
22:05:51 INFO - PROCESS | 29690 |
22:05:51 INFO - PROCESS | 29690 | [#3] mootools.html Cycles:180 Average:5539.95 Median:5100.32 stddev:3082.54 (60.4%) stddev-sans-first:3075.91
22:05:51 INFO - PROCESS | 29690 | Values: 1456.8 1490.7 1608.9 1646.8 1701.3 7553.4 7764.2 7794.2 8237.3 8246.7 7849.0 8124.0 8165.0 8174.7 8319.1 2219.5 2291.1 2301.5 2303.5 2311.3 2240.5 2281.7 2283.2 2305.2 2311.6 2307.5 2313.8 2334.8 2338.5 2339.5 2206.0 2210.4 2228.0 2248.0 2249.2 2264.7 2279.3 2283.3 2284.8 2287.1 8183.3 8216.2 8329.2 8430.7 8433.9 4979.6 5065.7 5081.8 5118.3 5133.4 3157.3 3196.9 3443.2 3452.5 3481.9 1054.0 1068.5 1089.3 1104.2 1122.8 11609.9 11669.1 11771.9 11782.8 11786.4 4324.8 4420.5 4529.7 4543.6 4560.7 9715.8 9758.8 9763.4 9766.7 9780.6 5177.9 5216.4 5223.8 5236.1 5241.0 4309.2 4573.5 4670.7 4737.1 4849.4 3865.9 3972.9 3985.8 3997.9 4028.5 1276.6 1317.2 1332.4 1332.5 1361.9 835.6 903.8 915.9 931.9 962.8 5604.0 5704.3 5773.9 5806.6 6047.4 413.9 426.9 430.7 1000.3 1028.7 3934.7 4061.1 4090.6 4102.5 4245.7 9890.1 10167.9 10240.0 10310.8 10333.1 10067.2 10168.0 10222.8 10234.3 10271.9 7644.7 7995.0 8007.2 8024.0 8038.2 5753.0 5763.9 5817.1 5865.4 5929.2 9622.1 9632.7 9700.9 9734.2 9774.4 9467.5 9765.3 9810.3 9902.7 9925.3 6539.5 6695.8 6854.4 7064.9 7252.7 7802.6 8165.3 8178.8 8181.6 8199.5 7102.7 7164.5 7239.8 7259.3 7452.5 6999.7 7050.6 7195.1 7296.6 7553.7 6670.1 6711.5 6744.9 6762.8 6778.2 5058.6 5082.3 5123.4 5151.7 5175.0 5074.5 5076.2 5134.9 5149.7 5157.2
22:05:51 INFO - PROCESS | 29690 |
22:05:51 INFO - PROCESS | 29690 | [#4] prototype.html Cycles:180 Average:4753.29 Median:5447.06 stddev:1431.23 (26.3%) stddev-sans-first:1395.73
22:05:51 INFO - PROCESS | 29690 | Values: 303.2 312.5 316.2 317.0 317.2 5397.5 5468.9 5544.0 5581.4 5618.5 5225.6 5307.9 5351.7 5390.4 5390.9 4105.2 4151.6 4153.7 4155.4 4170.9 4107.5 4179.9 4181.4 4189.6 4214.8 4128.2 4132.7 4137.5 4151.2 4176.9 4122.6 4141.3 4147.1 4147.3 4147.7 3540.7 3587.4 3588.0 3608.3 3630.4 5317.0 5318.5 5340.6 5358.4 5446.2 4729.2 4748.4 4766.6 4778.4 4783.4 5506.8 5675.3 5711.6 5720.0 5732.3 3982.8 3985.5 3985.8 3993.6 4008.2 5975.8 5978.3 6010.8 6012.8 6064.4 3989.7 3993.6 4050.3 4050.5 4074.5 4078.8 4093.9 4125.1 4126.4 4130.8 4806.2 4814.8 4816.1 4820.4 4847.5 5447.9 5708.5 5729.4 5832.2 5852.7 1340.9 1383.5 1387.1 1387.6 1388.8 860.5 924.9 925.3 937.7 945.6 5282.9 5291.6 5297.6 5333.9 5339.9 5697.2 5702.2 5730.6 5732.9 5762.7 5251.3 5272.2 5318.2 5406.4 5419.6 2981.7 3004.5 3014.0 3022.4 3025.9 5741.9 5765.9 5809.9 5853.4 5863.5 5501.2 5700.1 5746.5 5777.3 5792.9 5807.8 5820.4 5838.2 5844.5 5898.3 5560.4 5573.6 5675.8 5715.5 5888.5 5813.4 5840.4 5850.6 5854.5 5880.1 6124.3 6161.5 6168.4 6205.7 6224.7 3887.3 4057.2 4064.5 4069.0 4087.6 5720.2 5878.9 5898.2 5927.8 5957.5 5673.2 5780.8 5786.5 5790.7 5816.0 5750.2 5750.3 5754.8 5756.9 5762.8 5650.6 5659.5 5686.7 5695.7 5729.8 5751.9 5766.9 5779.6 5794.4 5825.5 5465.2 5672.4 5678.8 5714.1 5721.8
22:05:51 INFO - PROCESS | 29690 |
22:05:51 INFO - PROCESS | 29690 | [#5] yui.html Cycles:180 Average:16551.32 Median:4499.11 stddev:21046.00 (467.8%) stddev-sans-first:21071.47
22:05:51 INFO - PROCESS | 29690 | Values: 721.4 731.7 744.0 762.8 829.4 12108.3 12366.2 12602.9 13007.9 13500.4 13612.9 13740.9 13762.9 13764.7 13773.2 753.8 756.8 761.6 767.6 772.4 782.6 785.8 786.5 787.0 789.5 821.9 822.5 825.6 827.6 830.6 814.4 818.1 818.1 819.9 820.6 599.9 604.0 604.2 604.9 605.4 12695.0 12747.9 13007.0 13048.7 13054.4 12812.4 13799.3 13883.4 13942.4 13963.4 11393.6 11411.9 11425.7 11531.8 12303.3 3573.8 3587.4 3676.6 3695.4 3797.4 66666.7 67653.7 68667.3 68747.7 69297.7 10220.9 10407.8 10550.8 10570.6 10637.7 19570.3 19589.3 19726.0 19882.8 19932.2 7801.6 7827.4 7858.8 7883.4 7959.8 4406.7 4413.6 4419.1 4518.2 4592.7 3054.0 3143.2 3145.1 3146.8 3150.7 572.8 581.4 586.2 589.4 597.2 641.2 655.4 659.5 670.9 683.5 8520.4 8686.7 8717.4 8793.5 9264.4 563.8 575.9 607.8 640.0 676.1 4263.8 4342.6 4358.6 4428.4 4480.0 67989.0 72510.0 72520.6 73072.3 75104.6 41841.6 48712.3 65136.0 66785.0 69624.0 62660.0 64190.0 64405.7 64421.0 65241.3 9354.5 9452.5 9560.7 9733.8 9824.6 43688.3 44280.8 45526.0 45683.3 46354.0 56439.4 58510.5 59068.7 59338.7 60547.8 11818.3 11835.5 12146.5 12147.6 12161.6 13252.4 13394.3 13485.4 13572.3 13765.5 11948.5 12419.6 12524.6 13267.5 13499.3 12045.3 12524.4 12757.1 12883.2 13130.4 12309.9 12613.7 12784.1 13518.2 13520.1 10189.2 10538.6 10554.7 10856.5 10933.3 10811.1 11014.7 11385.9 11535.5 11554.7
22:05:51 INFO - PROCESS | 29690 | -------- Summary: end --------
22:05:51 INFO - PROCESS | 29690 |
22:05:52 INFO - TEST-INFO | 29690: exit 0
22:05:52 INFO - TEST-OK | dromaeo_css | took 1116607ms
22:05:52 INFO - TEST-START | kraken
22:05:52 INFO - operating with platform_type : linux_
22:05:52 INFO - Initialising browser for kraken test...
22:05:52 INFO - TEST-INFO | started process 30051 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpkRmouw/profile http://localhost:56204/getInfo.html)
22:05:57 INFO - PROCESS | 30051 | __metrics Screen width/height:1600/1200
22:05:57 INFO - PROCESS | 30051 | colorDepth:24
22:05:57 INFO - PROCESS | 30051 | Browser inner width/height: 1024/697
22:05:57 INFO - PROCESS | 30051 | __metrics
22:05:57 ERROR - PROCESS | 30051 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3179: TypeError: this.tabs is undefined
22:05:58 INFO - TEST-INFO | 30051: exit 0
22:05:58 INFO - Browser initialized.
22:05:58 INFO - Running cycle 1/1 for kraken test...
22:05:58 INFO - TEST-INFO | started process 30178 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpkRmouw/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1)
22:06:10 INFO - PROCESS | 30178 | RSS: Main: 185700352
22:06:10 INFO - PROCESS | 30178 |
22:06:13 INFO - PROCESS | 30178 | Cycle 1(1): loaded http://localhost:56204/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:56204/tests/kraken/driver.html?testName=audio-beat-detection)
22:06:14 INFO - PROCESS | 30178 | RSS: Main: 198086656
22:06:14 INFO - PROCESS | 30178 |
22:06:17 INFO - PROCESS | 30178 | Cycle 1(1): loaded http://localhost:56204/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:56204/tests/kraken/driver.html?testName=audio-dft)
22:06:17 INFO - PROCESS | 30178 | RSS: Main: 196554752
22:06:17 INFO - PROCESS | 30178 |
22:06:20 INFO - PROCESS | 30178 | Cycle 1(1): loaded http://localhost:56204/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:56204/tests/kraken/driver.html?testName=audio-fft)
22:06:21 INFO - PROCESS | 30178 | RSS: Main: 192872448
22:06:21 INFO - PROCESS | 30178 |
22:06:23 INFO - PROCESS | 30178 | Cycle 1(1): loaded http://localhost:56204/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:56204/tests/kraken/driver.html?testName=audio-oscillator)
22:06:23 INFO - PROCESS | 30178 | RSS: Main: 193826816
22:06:23 INFO - PROCESS | 30178 |
22:06:26 INFO - PROCESS | 30178 | Cycle 1(1): loaded http://localhost:56204/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:56204/tests/kraken/driver.html?testName=imaging-gaussian-blur)
22:06:26 INFO - PROCESS | 30178 | RSS: Main: 193613824
22:06:26 INFO - PROCESS | 30178 |
22:06:29 INFO - PROCESS | 30178 | Cycle 1(1): loaded http://localhost:56204/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:56204/tests/kraken/driver.html?testName=imaging-darkroom)
22:06:30 INFO - PROCESS | 30178 | RSS: Main: 198983680
22:06:30 INFO - PROCESS | 30178 |
22:06:33 INFO - PROCESS | 30178 | Cycle 1(1): loaded http://localhost:56204/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:56204/tests/kraken/driver.html?testName=imaging-desaturate)
22:06:34 INFO - PROCESS | 30178 | RSS: Main: 195821568
22:06:34 INFO - PROCESS | 30178 |
22:06:37 INFO - PROCESS | 30178 | Cycle 1(1): loaded http://localhost:56204/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:56204/tests/kraken/driver.html?testName=json-parse-financial)
22:06:37 INFO - PROCESS | 30178 | RSS: Main: 196636672
22:06:37 INFO - PROCESS | 30178 |
22:06:39 INFO - PROCESS | 30178 | Cycle 1(1): loaded http://localhost:56204/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:56204/tests/kraken/driver.html?testName=json-stringify-tinderbox)
22:06:40 INFO - PROCESS | 30178 | RSS: Main: 196722688
22:06:40 INFO - PROCESS | 30178 |
22:06:41 INFO - PROCESS | 30178 | Cycle 1(1): loaded http://localhost:56204/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:56204/tests/kraken/driver.html?testName=stanford-crypto-aes)
22:06:42 INFO - PROCESS | 30178 | RSS: Main: 196468736
22:06:42 INFO - PROCESS | 30178 |
22:06:44 INFO - PROCESS | 30178 | Cycle 1(1): loaded http://localhost:56204/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:56204/tests/kraken/driver.html?testName=stanford-crypto-ccm)
22:06:45 INFO - PROCESS | 30178 | RSS: Main: 197148672
22:06:45 INFO - PROCESS | 30178 |
22:06:48 INFO - PROCESS | 30178 | Cycle 1(1): loaded http://localhost:56204/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:56204/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2)
22:06:48 INFO - PROCESS | 30178 | RSS: Main: 196993024
22:06:48 INFO - PROCESS | 30178 |
22:06:51 INFO - PROCESS | 30178 | Cycle 1(1): loaded http://localhost:56204/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:56204/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative)
22:06:52 INFO - PROCESS | 30178 | RSS: Main: 197242880
22:06:52 INFO - PROCESS | 30178 |
22:06:53 INFO - PROCESS | 30178 | Cycle 1(1): loaded http://localhost:56204/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:56204/tests/kraken/driver.html?testName=ai-astar)
22:06:54 INFO - PROCESS | 30178 | RSS: Main: 198430720
22:06:54 INFO - PROCESS | 30178 |
22:06:54 INFO - PROCESS | 30178 | __start_tp_report
22:06:54 INFO - PROCESS | 30178 | _x_x_mozilla_page_load
22:06:54 INFO - PROCESS | 30178 | _x_x_mozilla_page_load_details
22:06:54 INFO - PROCESS | 30178 | |i|pagename|runs|
22:06:54 INFO - PROCESS | 30178 | |0;ai-astar;104;112;111;111;112;113;111;113;113;111
22:06:54 INFO - PROCESS | 30178 | |1;audio-beat-detection;151;124;126;167;124;129;127;131;157;131
22:06:54 INFO - PROCESS | 30178 | |2;audio-dft;169;170;167;173;165;163;161;166;162;162
22:06:54 INFO - PROCESS | 30178 | |3;audio-fft;75;78;76;104;77;77;78;76;108;76
22:06:54 INFO - PROCESS | 30178 | |4;audio-oscillator;84;84;105;84;84;84;101;84;84;114
22:06:54 INFO - PROCESS | 30178 | |5;imaging-gaussian-blur;117;119;117;119;118;118;119;117;119;118
22:06:54 INFO - PROCESS | 30178 | |6;imaging-darkroom;149;147;148;149;149;148;148;147;150;148
22:06:54 INFO - PROCESS | 30178 | |7;imaging-desaturate;97;98;96;96;98;97;96;97;96;95
22:06:54 INFO - PROCESS | 30178 | |8;json-parse-financial;55;53;57;54;52;54;55;55;57;54
22:06:54 INFO - PROCESS | 30178 | |9;json-stringify-tinderbox;64;63;64;65;65;63;65;65;63;64
22:06:54 INFO - PROCESS | 30178 | |10;stanford-crypto-aes;82;88;82;83;82;81;81;86;87;85
22:06:54 INFO - PROCESS | 30178 | |11;stanford-crypto-ccm;147;138;144;136;139;136;145;143;184;137
22:06:54 INFO - PROCESS | 30178 | |12;stanford-crypto-pbkdf2;166;176;165;169;165;165;167;164;165;163
22:06:54 INFO - PROCESS | 30178 | |13;stanford-crypto-sha256-iterative;68;69;68;65;64;66;66;64;65;68
22:06:54 INFO - PROCESS | 30178 | __end_tp_report
22:06:54 INFO - PROCESS | 30178 | __start_cc_report
22:06:54 INFO - PROCESS | 30178 | _x_x_mozilla_cycle_collect,813
22:06:54 INFO - PROCESS | 30178 | __end_cc_report
22:06:54 INFO - PROCESS | 30178 | __startTimestamp1479449214151__endTimestamp
22:06:54 INFO - PROCESS | 30178 |
22:06:54 INFO - PROCESS | 30178 | ------- Summary: start -------
22:06:54 INFO - PROCESS | 30178 | Number of tests: 14
22:06:54 INFO - PROCESS | 30178 |
22:06:54 INFO - PROCESS | 30178 | [#0] ai-astar Cycles:10 Average:111.10 Median:112.00 stddev:2.64 (2.4%) stddev-sans-first:0.93
22:06:54 INFO - PROCESS | 30178 | Values: 104.0 112.0 111.0 111.0 112.0 113.0 111.0 113.0 113.0 111.0
22:06:54 INFO - PROCESS | 30178 |
22:06:54 INFO - PROCESS | 30178 | [#1] audio-beat-detection Cycles:10 Average:136.70 Median:131.00 stddev:15.60 (11.9%) stddev-sans-first:15.66
22:06:54 INFO - PROCESS | 30178 | Values: 151.0 124.0 126.0 167.0 124.0 129.0 127.0 131.0 157.0 131.0
22:06:54 INFO - PROCESS | 30178 |
22:06:54 INFO - PROCESS | 30178 | [#2] audio-dft Cycles:10 Average:165.80 Median:166.50 stddev:3.97 (2.4%) stddev-sans-first:4.03
22:06:54 INFO - PROCESS | 30178 | Values: 169.0 170.0 167.0 173.0 165.0 163.0 161.0 166.0 162.0 162.0
22:06:54 INFO - PROCESS | 30178 |
22:06:54 INFO - PROCESS | 30178 | [#3] audio-fft Cycles:10 Average:82.50 Median:76.50 stddev:12.46 (16.3%) stddev-sans-first:12.91
22:06:54 INFO - PROCESS | 30178 | Values: 75.0 78.0 76.0 104.0 77.0 77.0 78.0 76.0 108.0 76.0
22:06:54 INFO - PROCESS | 30178 |
22:06:54 INFO - PROCESS | 30178 | [#4] audio-oscillator Cycles:10 Average:90.80 Median:84.00 stddev:11.39 (13.6%) stddev-sans-first:11.81
22:06:54 INFO - PROCESS | 30178 | Values: 84.0 84.0 105.0 84.0 84.0 84.0 101.0 84.0 84.0 114.0
22:06:54 INFO - PROCESS | 30178 |
22:06:54 INFO - PROCESS | 30178 | [#5] imaging-gaussian-blur Cycles:10 Average:118.10 Median:118.50 stddev:0.88 (0.7%) stddev-sans-first:0.83
22:06:54 INFO - PROCESS | 30178 | Values: 117.0 119.0 117.0 119.0 118.0 118.0 119.0 117.0 119.0 118.0
22:06:54 INFO - PROCESS | 30178 |
22:06:54 INFO - PROCESS | 30178 | [#6] imaging-darkroom Cycles:10 Average:148.30 Median:148.50 stddev:0.95 (0.6%) stddev-sans-first:0.97
22:06:54 INFO - PROCESS | 30178 | Values: 149.0 147.0 148.0 149.0 149.0 148.0 148.0 147.0 150.0 148.0
22:06:54 INFO - PROCESS | 30178 |
22:06:54 INFO - PROCESS | 30178 | [#7] imaging-desaturate Cycles:10 Average:96.60 Median:97.00 stddev:0.97 (1.0%) stddev-sans-first:1.01
22:06:54 INFO - PROCESS | 30178 | Values: 97.0 98.0 96.0 96.0 98.0 97.0 96.0 97.0 96.0 95.0
22:06:54 INFO - PROCESS | 30178 |
22:06:54 INFO - PROCESS | 30178 | [#8] json-parse-financial Cycles:10 Average:54.60 Median:55.00 stddev:1.58 (2.9%) stddev-sans-first:1.67
22:06:54 INFO - PROCESS | 30178 | Values: 55.0 53.0 57.0 54.0 52.0 54.0 55.0 55.0 57.0 54.0
22:06:54 INFO - PROCESS | 30178 |
22:06:54 INFO - PROCESS | 30178 | [#9] json-stringify-tinderbox Cycles:10 Average:64.10 Median:64.50 stddev:0.88 (1.4%) stddev-sans-first:0.93
22:06:54 INFO - PROCESS | 30178 | Values: 64.0 63.0 64.0 65.0 65.0 63.0 65.0 65.0 63.0 64.0
22:06:54 INFO - PROCESS | 30178 |
22:06:54 INFO - PROCESS | 30178 | [#10] stanford-crypto-aes Cycles:10 Average:83.70 Median:84.00 stddev:2.58 (3.1%) stddev-sans-first:2.67
22:06:54 INFO - PROCESS | 30178 | Values: 82.0 88.0 82.0 83.0 82.0 81.0 81.0 86.0 87.0 85.0
22:06:54 INFO - PROCESS | 30178 |
22:06:54 INFO - PROCESS | 30178 | [#11] stanford-crypto-ccm Cycles:10 Average:144.90 Median:143.50 stddev:14.30 (10.0%) stddev-sans-first:15.15
22:06:54 INFO - PROCESS | 30178 | Values: 147.0 138.0 144.0 136.0 139.0 136.0 145.0 143.0 184.0 137.0
22:06:54 INFO - PROCESS | 30178 |
22:06:54 INFO - PROCESS | 30178 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:166.50 Median:165.50 stddev:3.72 (2.2%) stddev-sans-first:3.94
22:06:54 INFO - PROCESS | 30178 | Values: 166.0 176.0 165.0 169.0 165.0 165.0 167.0 164.0 165.0 163.0
22:06:54 INFO - PROCESS | 30178 |
22:06:54 INFO - PROCESS | 30178 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.30 Median:67.00 stddev:1.83 (2.7%) stddev-sans-first:1.83
22:06:54 INFO - PROCESS | 30178 | Values: 68.0 69.0 68.0 65.0 64.0 66.0 66.0 64.0 65.0 68.0
22:06:54 INFO - PROCESS | 30178 | -------- Summary: end --------
22:06:54 INFO - PROCESS | 30178 |
22:06:55 INFO - TEST-INFO | 30178: exit 0
22:06:55 INFO - TEST-OK | kraken | took 62926ms
22:06:55 INFO - SUITE-END | took 1179s
22:06:55 INFO - Completed test suite (00:19:39)
22:06:55 INFO - javascript benchmark
22:06:55 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7131.463142966438, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3056.205386599485, 3079.8306093164874, 3099.039297817675, 3131.170239886429, 3133.514305282681, 5391.703456309911, 5505.642133261335, 5558.221848941146, 5601.579881508887, 5620.1288800235925, 5441.863953401167, 5444.727763611813, 5468.371137319209, 5498.560115190785, 5506.5870059745475, 4939.481354457784, 4953.727544985024, 5015.623828212881, 5038.067957427869, 5084.339035925324, 5030.949690503103, 5050.444451110375, 5064.215046667754, 5086.79652813887, 5099.643024988252, 4946.554810067111, 5001.44984051754, 5012.448630650625, 5071.0, 5076.6700164489375, 4983.626228032876, 5001.624878134155, 5007.649464537484, 5011.2483127530795, 5018.7490625468945, 4910.950890491121, 4930.556249937523, 4969.503049695038, 4969.875753106165, 5032.4212715537815, 5483.232347471358, 5496.450354964471, 5522.337319521643, 5527.143292789584, 5532.3914369419335, 5772.480476757112, 5903.481808806875, 5909.9704501477645, 5910.940890591082, 5974.312954010301, 5827.679477628729, 5876.941230587725, 5892.793752218695, 5905.645661260295, 5919.5560332974765, 5453.672779633234, 5529.612927095145, 5533.142362933751, 5541.584381171388, 5563.610547261694, 5966.0454327307425, 6009.609375390585, 6016.639001659827, 6017.548683848729, 6052.152698622196, 5630.127330263816, 5696.487316141567, 5770.740316685759, 5770.769169233184, 5801.767929282866, 5898.4101589840675, 5906.40935906406, 5908.793192238337, 5948.494377977834, 5959.106134079922, 5698.7435565399655, 5753.309602847685, 5763.423657634287, 5784.1034639630925, 5835.066389377679, 5814.505767009767, 5837.591368604157, 5849.0, 5887.646741195542, 5895.852603684856, 4375.934360984587, 4391.429114215131, 4391.956080439155, 4406.779661017001, 4486.528914463999, 3923.9803800981385, 3962.366021436614, 3966.345552983783, 3993.1414745829784, 3998.100427403869, 5602.971985140048, 5615.0, 5616.326040875121, 5617.859553511195, 5627.606067575231, 5733.226014488074, 5802.622829516068, 5886.117082437669, 5890.852728681817, 5905.527557795366, 5515.310586176728, 5635.887282254332, 5644.407337229614, 5644.887102258014, 5659.688717120598, 5049.899002019939, 5091.490850914879, 5109.105906466353, 5121.641485096007, 5154.768035438415, 5913.911291330547, 6055.424734650289, 6064.151018857364, 6065.181200537871, 6080.513558915276, 5784.132380143013, 5817.854553636023, 5878.265216847894, 5893.44012318829, 5897.941020589911, 5998.820035398945, 6015.578909476295, 6018.3379828217985, 6037.849053773691, 6081.604695694766, 5760.135979603093, 5790.160426738015, 5800.187973683604, 5819.388964158702, 5836.445537673914, 5901.970490147522, 5919.082542205965, 5926.199963005111, 5934.1988831508925, 5950.434708702666, 5652.745626446737, 5664.178694089416, 5690.032694442038, 5707.885842283048, 5817.650940943557, 5647.29408823897, 5683.658980461186, 5712.0860662293835, 5727.055035919193, 5769.307683078057, 5735.770569177186, 5750.942490575041, 5763.394843541536, 5781.190633311424, 5797.449242321973, 5881.235439393023, 5884.205632239764, 5885.47030767233, 5895.734691938959, 5903.616264942765, 5438.864028399322, 5445.128779395436, 5456.0, 5575.693336866511, 5608.383077861514], "value": 5412.369942110635, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [557.8187089196011, 576.3228206856943, 597.9013462778641, 600.636614848017, 606.1786279591157, 39984.0, 41423.37864932025, 41759.58240417595, 44907.77546112273, 45012.549874501245, 42904.785476072575, 43203.78398108005, 43205.35191972123, 43245.35131973015, 43795.56204437955, 8502.149785021511, 8615.35384846136, 8644.610992505352, 8651.567421628924, 8662.61018254177, 8602.311815054813, 8717.825643487127, 8741.43180693256, 8747.16901894319, 8763.912360876406, 8697.260732837716, 8715.607797649121, 8765.912340876605, 8768.167024132697, 8795.560221988906, 8608.612612432456, 8657.567121643924, 8682.652693892236, 8718.738437846843, 8738.082501337396, 8453.154684531559, 8459.873101903477, 8511.57442127891, 8547.35894807892, 8587.61355738987, 39331.803340983395, 39536.0, 39588.20823583541, 39591.0, 39650.0, 3427.8286085695863, 3437.673421025024, 3445.43150380187, 3450.9309813803834, 3457.4468085106264, 29990.40019199604, 30106.24734381636, 30305.696943030507, 30366.84816575925, 31620.841895790374, 4119.573465393965, 4130.091379896418, 4159.91680166395, 4161.3549899765585, 4250.574942505756, 314216.0, 315433.0, 316630.0, 317531.0, 318615.0, 55710.44289557134, 55777.72111139418, 55961.16058259129, 56061.71969140128, 56405.43594564084, 58288.0, 58342.0, 58358.416415836145, 58380.0, 58456.41543584595, 15301.693966120838, 15355.846441535441, 15480.5355839325, 15546.611334716496, 15548.76676849848, 10884.72788180286, 10919.890801091888, 10930.56277748881, 10940.288881222696, 10987.835182472269, 15611.453599124203, 15743.606409839616, 15895.841041589667, 15956.521304360887, 16244.507430902413, 6086.391360863879, 6147.784827531015, 6243.500519958392, 6282.371762823681, 6408.711607977652, 948.6252930092575, 1021.8518314844306, 1040.2822052783556, 1115.358668765463, 1150.9021733152608, 31509.212269692984, 31568.368632627677, 31870.203244919063, 32086.518702219484, 32230.0, 1026.9383836969805, 1107.5237647811518, 1131.9434028298551, 1146.4611632532697, 1185.5435657272012, 16197.51407457778, 16311.347546098023, 16431.0, 16463.91768041176, 16647.91676041612, 468781.0, 470124.0, 472128.0, 472266.0, 472280.0, 54131.72934135304, 54153.45846541563, 54422.72788636031, 54438.0, 54482.18276725852, 1307.8561358250586, 1337.6588969812635, 1359.2252416122715, 1374.6632075141654, 1383.2876068824564, 30130.548041779828, 31691.890783822455, 32508.349833003682, 32576.0, 35184.296314073064, 51791.74104129606, 52967.47032529626, 53017.0, 58293.0, 58345.416545834, 438050.0, 438569.9501552419, 439370.0, 439856.0, 441328.0, 27191.72808271892, 27345.589816152376, 27564.173074807786, 27748.8612556944, 27773.444531109668, 45262.77368613136, 46161.76919115383, 46494.0, 47007.29489057735, 47198.0, 39212.0, 39214.607853922236, 39494.65228620311, 40931.795341023106, 41184.176316472905, 38136.61863381442, 39728.80135599303, 39902.60097398989, 40016.0, 40698.38952415657, 39504.0, 40211.79894100511, 40809.387859181545, 41357.37963930603, 41422.58577414187, 29689.851550742107, 34551.4817277736, 35824.46263306, 36168.819155905105, 36218.09454763652, 25833.956397090915, 26202.73797262003, 26334.736652633994, 26401.0, 26807.463850723267], "value": 19319.951962841522, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [378.94884190634275, 386.75247841381537, 400.2555247240133, 406.1633035945951, 407.3767136281489, 18770.343037993673, 19087.522811929673, 19338.323158689447, 19358.806411935875, 19878.20487180515, 19066.33267835626, 19244.230230790785, 19331.130099145535, 19433.611327773473, 19593.902030489862, 5338.199270109495, 5350.866228344284, 5511.9724401377935, 5557.861053473675, 5582.553395728332, 5428.4842939920645, 5471.316085489314, 5500.257465242201, 5509.586780991422, 5510.5316048135755, 5343.126737090022, 5382.434844341346, 5469.453054694519, 5493.0, 5500.0, 5376.677399356051, 5424.83725488236, 5425.104857698495, 5425.9728701356635, 5458.181272809091, 4657.4876763555985, 4882.389701287339, 4894.951050489485, 4927.211646136601, 4961.8511444656715, 21101.894490527447, 21759.45601359963, 21847.781522184734, 22331.330060098222, 22789.31632051041, 2206.2498750424934, 2302.1482051640833, 2492.401823562332, 2696.6224728538023, 2864.140757772681, 9439.197668198143, 9637.855432168522, 9695.854562181574, 9967.0, 15440.845591544054, 1961.3331467301186, 1978.9802101979085, 2024.665930121543, 2041.612093702192, 2091.968620470694, 79740.0, 83582.58208708979, 87883.12116878813, 94525.5273723627, 104232.70371074027, 17194.828051719323, 17436.825631743774, 17548.473545793648, 17717.202725877367, 17796.021218833088, 31309.8434507826, 31630.367392652017, 31831.681683182873, 31981.360372792413, 31988.840055799574, 9198.218151457068, 9345.859812102824, 9558.0, 9612.711618651452, 9623.807523849624, 7828.373730101692, 7906.881396779053, 8096.311813495919, 8112.472689275178, 8134.633941472648, 8359.289460395934, 8730.257928076184, 8778.253848422828, 8991.775205619912, 9007.973206028591, 3246.4318744219668, 3398.3543126805826, 3526.982365088158, 3549.3078849624076, 3595.2270261893295, 982.921366290695, 1006.7231511334442, 1008.9646862359782, 1021.2902033087082, 1023.534291897185, 19635.538495371668, 19870.90064549668, 19902.0, 19964.101615427342, 20168.0, 962.932594718363, 976.5751897924425, 993.3642468819961, 1000.1398797034544, 1036.5024788101753, 10651.680449586525, 10911.781764364669, 11072.612458563912, 11095.944520277508, 11144.554217831359, 442258.0, 442370.0, 445395.0, 446817.0, 447781.0, 85485.0, 86495.1350486487, 93001.0, 95419.0, 97637.51181244191, 1020.7448137965508, 1036.8548403223556, 1044.4829809244472, 1046.1682962045193, 1049.2130901823632, 17168.484945451655, 17405.651886961936, 17938.103094845468, 18143.546411339823, 18271.725924110884, 27991.860040699667, 33041.173970649965, 41379.58620413757, 42484.362734559625, 43362.13275734404, 56578.43421565732, 57084.71457642685, 57178.14232786595, 57726.7113664429, 57953.710231448575, 7673.61631918413, 7775.261350171951, 7789.883151752615, 7895.1315355309725, 7931.929189559336, 12033.338166400932, 12060.396980151132, 12085.335306558223, 12283.0, 12393.814092788434, 11097.778044439228, 11141.554337826396, 11427.771584540935, 11481.885181148082, 11604.6518604442, 10610.52252648648, 10632.41521716313, 10671.839922401015, 10931.83602245951, 11157.10743140563, 10810.729731756768, 10820.621278255538, 11134.721631959266, 11154.16343774204, 11552.59565915189, 7894.921050789419, 7906.644201011083, 7910.683572657029, 8161.265486106279, 8292.12932642064, 7858.44990850635, 9914.30599858003, 11030.669079927615, 11075.224734268524, 11463.770724585629], "value": 9703.66174119458, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1456.766917293233, 1490.716763814875, 1608.9356425742963, 1646.7941507311587, 1701.3194722111155, 7553.395728341733, 7764.223577642233, 7794.220577942203, 8237.299829514492, 8246.711365102215, 7849.0, 8124.0, 8164.959175204131, 8174.6730130794695, 8319.126491718358, 2219.522802597445, 2291.072115793098, 2301.493671392291, 2303.5047464795066, 2311.341267738695, 2240.4958884250996, 2281.680564720932, 2283.2122917593406, 2305.227748704178, 2311.595470792613, 2307.492351682627, 2313.7570555091725, 2334.754850740673, 2338.4504641409253, 2339.485313231095, 2205.9889700551553, 2210.4363387336125, 2227.9777202228015, 2248.0, 2249.167807911075, 2264.671622614728, 2279.327598358488, 2283.2807665585456, 2284.805791507724, 2287.085165933623, 8183.304419124382, 8216.178382161735, 8329.208725171098, 8430.704925327645, 8433.873491897626, 4979.601631869442, 5065.670731402447, 5081.79672813087, 5118.334616499831, 5133.383993920716, 3157.258044359574, 3196.856141473639, 3443.1736383268085, 3452.4648679454726, 3481.947770783415, 1054.0460882900986, 1068.4604274841156, 1089.2538611051455, 1104.1553211792984, 1122.8091224491775, 11609.941950290195, 11669.124815638861, 11771.94114029433, 11782.823257651142, 11786.35175065371, 4324.762138082373, 4420.469543654718, 4529.660275479287, 4543.614197669676, 4560.703554268962, 9715.805683886283, 9758.756031099138, 9763.414195148314, 9766.706998790047, 9780.608775648894, 5177.896442071213, 5216.400113986864, 5223.817166399158, 5236.1098613235845, 5241.0, 4309.159713855831, 4573.49691533931, 4670.719756814602, 4737.147313483537, 4849.442314133919, 3865.942010869839, 3972.920541589152, 3985.8206380712936, 3997.9400308995387, 4028.5367182774357, 1276.6425400887767, 1317.1636011133, 1332.4403750424651, 1332.4936524120772, 1361.86381361865, 835.5529791561607, 903.7605034665819, 915.8809354783835, 931.9301052421096, 962.7881865989472, 5604.019296623074, 5704.258446401941, 5773.942260577424, 5806.593538452268, 6047.425494578008, 413.85928784213513, 426.9210196113729, 430.72003197920975, 1000.2648053680539, 1028.6605420211313, 3934.7442416243425, 4061.147159096564, 4090.6318431341324, 4102.466679331727, 4245.724027938174, 9890.109890109925, 10167.898321016843, 10240.027197416233, 10310.793784124426, 10333.070023697754, 10067.194624430029, 10168.0, 10222.846657300146, 10234.283600147919, 10271.9486402569, 7644.655990480442, 7995.0, 8007.199280071946, 8023.959880200561, 8038.236367545074, 5752.9712351437975, 5763.9135412968, 5817.0983497557945, 5865.384134665969, 5929.229200203946, 9622.13400793932, 9632.711018669452, 9700.854487182556, 9734.221262299141, 9774.413535187912, 9467.479288639192, 9765.316427849983, 9810.313278070467, 9902.702918912444, 9925.305228634215, 6539.509536784665, 6695.765648202289, 6854.3549548109095, 7064.929350706633, 7252.746153884589, 7802.648880800264, 8165.346772258324, 8178.83642327162, 8181.550014749246, 8199.549024803693, 7102.715891364288, 7164.462665300228, 7239.819004524929, 7259.310365515267, 7452.515586486861, 6999.6850141742725, 7050.576965381888, 7195.13658361, 7296.562206267641, 7553.7356192533, 6670.132882725215, 6711.463082953254, 6744.898826517508, 6762.797116086525, 6778.2205046420295, 5058.570021548209, 5082.313887625123, 5123.436421993652, 5151.6908985461, 5175.042617115846, 5074.543291103819, 5076.162433198481, 5134.9486505135965, 5149.716765577929, 5157.226416037624], "value": 4444.322639725917, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [303.17536301260577, 312.4766016921656, 316.1653235458389, 317.04253155470474, 317.16110886704666, 5397.487238712316, 5468.890622187564, 5544.0, 5581.413951535086, 5618.522425593825, 5225.555827754645, 5307.946920530793, 5351.7324133793345, 5390.380106287768, 5390.946090539093, 4105.178964207155, 4151.584841515854, 4153.730007549515, 4155.439015732883, 4170.854020109282, 4107.54816970133, 4179.895502612429, 4181.351890456984, 4189.581041895816, 4214.7681877496725, 4128.174365126972, 4132.731372460796, 4137.54487006429, 4151.169766046788, 4176.874693759192, 4122.567130451304, 4141.295979683431, 4147.066909945238, 4147.315692910666, 4147.6889233307475, 3540.6813386795056, 3587.3722098632634, 3588.0, 3608.278344331144, 3630.366335149193, 5316.9734151329385, 5318.547923426475, 5340.570040631504, 5358.4373640767935, 5446.183072539111, 4729.172394830891, 4748.3589715388325, 4766.618670506386, 4778.395774303013, 4783.354247176656, 5506.752196151183, 5675.34733505648, 5711.602066408842, 5719.971400142973, 5732.3407808101765, 3982.82077306519, 3985.5217373915316, 3985.7608543487486, 3993.6206060424215, 4008.2183974125055, 5975.820725378246, 5978.312494063195, 6010.8497287567725, 6012.849678758066, 6064.3935606439445, 3989.7007724420782, 3993.6405723485027, 4050.2709512287483, 4050.4936882889638, 4074.4703188585295, 4078.775667338325, 4093.91812163761, 4125.092479654471, 4126.401671757639, 4130.793460326971, 4806.2310030394965, 4814.807407703723, 4816.133096042746, 4820.4456487504385, 4847.5394837490385, 5447.945520544744, 5708.4862362387585, 5729.369769325371, 5832.1834943108, 5852.678102704307, 1340.8870637371153, 1383.4604504243352, 1387.1399732166121, 1387.6461502316845, 1388.805627160641, 860.5267103093273, 924.8751418558409, 925.2967744514218, 937.6905621145006, 945.6122989574242, 5282.920756188661, 5291.576673866081, 5297.629165958346, 5333.919991200135, 5339.86650333737, 5697.230873832063, 5702.173184888168, 5730.598858079978, 5732.942670573324, 5762.711864406763, 5251.291075704808, 5272.2355258487305, 5318.202269659505, 5406.351237851483, 5419.593530485229, 2981.701829817001, 3004.4742170120144, 3013.9698603014126, 3022.3653032862903, 3025.8940937067096, 5741.85645358861, 5765.913511297334, 5809.88380232393, 5853.414658534198, 5863.501602363762, 5501.229827824028, 5700.0929525942065, 5746.540276777848, 5777.277840269966, 5792.88414231713, 5807.767689292466, 5820.3888591698105, 5838.182654428383, 5844.473997340175, 5898.292204935436, 5560.443955604407, 5573.554115670818, 5675.77296908119, 5715.542536653127, 5888.499477544286, 5813.447722466359, 5840.445157710011, 5850.561207909509, 5854.4730974212525, 5880.118362124079, 6124.284301088226, 6161.537884658579, 6168.414000669929, 6205.6586887721605, 6224.657643829632, 3887.317750752085, 4057.2494088592525, 4064.451299074587, 4069.0, 4087.5503694594167, 5720.19917211599, 5878.911816322673, 5898.174255604133, 5927.792527261525, 5957.523398128226, 5673.234113394804, 5780.826575202583, 5786.479216870502, 5790.681512516852, 5816.0, 5750.223719797941, 5750.281214848144, 5754.769809207585, 5756.913646295393, 5762.827115186551, 5650.576206784425, 5659.518940889906, 5686.658800471985, 5695.686737229492, 5729.828105156852, 5751.884962300815, 5766.913496297475, 5779.624324418899, 5794.391588883106, 5825.475707186373, 5465.180222966586, 5672.376038635664, 5678.829635110953, 5714.114342267125, 5721.771129154788], "value": 4284.574669582318, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [721.3507842941356, 731.7109741652047, 743.9590822504761, 762.8207371267752, 829.3696790439265, 12108.334041627719, 12366.242530265195, 12602.873971260286, 13007.869921300784, 13500.392482338293, 13612.931935340333, 13740.862591374083, 13762.93118534406, 13764.65588360289, 13773.173609583408, 753.7776355974974, 756.8410633766915, 761.5773245848552, 767.5931756169239, 772.3705180278083, 782.6165179062247, 785.783909424907, 786.5438045933345, 786.9881951770728, 789.5105034878384, 821.8685010398337, 822.5229366967145, 825.628467189767, 827.6027506796742, 830.6469750356074, 814.352589691197, 818.1082619944259, 818.1491249100928, 819.868820988639, 820.5733018830175, 599.9490043346277, 604.0, 604.1662505742091, 604.9153118563361, 605.3764622438895, 12695.0, 12747.936260318731, 13007.0, 13048.739025219442, 13054.412551435209, 12812.42344094518, 13799.310034498234, 13883.37524811386, 13942.37259323333, 13963.37164827575, 11393.601223957205, 11411.885881141248, 11425.657230283105, 11531.827022594667, 12303.32331721755, 3573.76770509916, 3587.3947778935126, 3676.558812942464, 3695.3533131702115, 3797.373433383488, 66666.66666666685, 67653.66173169152, 68667.31332686658, 68747.65626171888, 69297.65351173263, 10220.948895255477, 10407.791844163074, 10550.788984220273, 10570.577176912837, 10637.73405664849, 19570.315038973567, 19589.31437399684, 19726.0, 19882.801171988383, 19932.20271189136, 7801.648925798353, 7827.373810095179, 7858.8428231435055, 7883.36933045355, 7959.761207163794, 4406.713563618355, 4413.558644135561, 4419.0940857124215, 4518.186726389215, 4592.747398893093, 3054.0, 3143.167060728909, 3145.119366577362, 3146.7639927005107, 3150.7321877640657, 572.7794799002331, 581.3779256195915, 586.2027642406324, 589.3899813692807, 597.235538510707, 641.1632819170933, 655.3844772635476, 659.5317324699421, 670.9396154346034, 683.4907993544841, 8520.403571750043, 8686.6525338987, 8717.389782715276, 8793.516356600448, 9264.39781414206, 563.7773079633522, 575.8790653962715, 607.802464199137, 640.0271587187542, 676.1109141478939, 4263.76549289792, 4342.609165175149, 4358.607725304738, 4428.402165707588, 4480.0367920896515, 67989.0, 72510.0, 72520.63739681267, 73072.26927730655, 75104.62447687837, 41841.58158418438, 48712.269315960286, 65136.0, 66784.99645010657, 69624.0, 62660.0, 64190.0, 64405.67797160984, 64421.0, 65241.34758652353, 9354.53227338644, 9452.527373631428, 9560.713178604654, 9733.756656083655, 9824.55789489489, 43688.34467482927, 44280.7785961081, 45526.0, 45683.31475027811, 46354.0, 56439.43560564342, 58510.511227903415, 59068.704656476446, 59338.70330648319, 60547.78904421975, 11818.290902545874, 11835.526578936746, 12146.514139434325, 12147.635570932885, 12161.574344897886, 13252.403641835948, 13394.330283485591, 13485.40155097568, 13572.253526056162, 13765.518206862711, 11948.462319195483, 12419.627411177678, 12524.624261272176, 13267.469301227842, 13499.257540835348, 12045.277283363026, 12524.436400362189, 12757.123608962374, 12883.227006379648, 13130.409131589293, 12309.876901230873, 12613.74772504563, 12784.105112642026, 13518.188908665512, 13520.12119212248, 10189.23580731463, 10538.57845686164, 10554.736131596772, 10856.511456984612, 10933.343999360064, 10811.13510919109, 11014.724631884266, 11385.896424684792, 11535.480903359537, 11554.653360399201], "value": 6807.4496869681925, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1530.0, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [104.0, 112.0, 111.0, 111.0, 112.0, 113.0, 111.0, 113.0, 113.0, 111.0], "value": 111.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 124.0, 126.0, 167.0, 124.0, 129.0, 127.0, 131.0, 157.0, 131.0], "value": 136.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [169.0, 170.0, 167.0, 173.0, 165.0, 163.0, 161.0, 166.0, 162.0, 162.0], "value": 165.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 78.0, 76.0, 104.0, 77.0, 77.0, 78.0, 76.0, 108.0, 76.0], "value": 82.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 84.0, 105.0, 84.0, 84.0, 84.0, 101.0, 84.0, 84.0, 114.0], "value": 90.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 119.0, 117.0, 119.0, 118.0, 118.0, 119.0, 117.0, 119.0, 118.0], "value": 118.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 147.0, 148.0, 149.0, 149.0, 148.0, 148.0, 147.0, 150.0, 148.0], "value": 148.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [97.0, 98.0, 96.0, 96.0, 98.0, 97.0, 96.0, 97.0, 96.0, 95.0], "value": 96.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 53.0, 57.0, 54.0, 52.0, 54.0, 55.0, 55.0, 57.0, 54.0], "value": 54.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 63.0, 64.0, 65.0, 65.0, 63.0, 65.0, 65.0, 63.0, 64.0], "value": 64.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 88.0, 82.0, 83.0, 82.0, 81.0, 81.0, 86.0, 87.0, 85.0], "value": 83.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 138.0, 144.0, 136.0, 139.0, 136.0, 145.0, 143.0, 184.0, 137.0], "value": 144.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [166.0, 176.0, 165.0, 169.0, 165.0, 165.0, 167.0, 164.0, 165.0, 163.0], "value": 166.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 69.0, 68.0, 65.0, 64.0, 66.0, 66.0, 64.0, 65.0, 68.0], "value": 66.3, "unit": "score"}]}]}
22:06:55 INFO - Return code: 0
22:06:55 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json
22:06:55 ERROR - # TBPL SUCCESS #
22:06:55 INFO - Running post-action listener: _resource_record_post_action
22:06:55 INFO - [mozharness: 2016-11-18 06:06:55.956223Z] Finished run-tests step (success)
22:06:55 INFO - Running post-run listener: _resource_record_post_run
22:06:56 INFO - Total resource usage - Wall time: 1197s; CPU: 13.0%; Read bytes: 4096; Write bytes: 394010624; Read time: 8; Write time: 253688
22:06:56 INFO - TinderboxPrint: CPU usage
13.4%
22:06:56 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 8
22:06:56 INFO - TinderboxPrint: I/O write bytes / time
394,010,624 / 253,688
22:06:56 INFO - TinderboxPrint: CPU idle
8,261.6 (86.5%)
22:06:56 INFO - TinderboxPrint: CPU user
1,222.2 (12.8%)
22:06:56 INFO - TinderboxPrint: Swap in / out
0 / 0
22:06:56 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 103088128; Read time: 0; Write time: 61744
22:06:56 INFO - run-tests - Wall time: 1180s; CPU: 13.0%; Read bytes: 0; Write bytes: 289644544; Read time: 0; Write time: 191884
22:06:56 INFO - Running post-run listener: _upload_blobber_files
22:06:56 INFO - Blob upload gear active.
22:06:56 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir.
22:06:56 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
22:06:56 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']
22:06:56 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
22:06:57 INFO - (blobuploader) - INFO - Open directory for files ...
22:06:57 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ...
22:06:57 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com
22:06:57 INFO - (blobuploader) - INFO - Uploading, attempt #1.
22:06:57 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded
22:06:57 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded!
22:06:57 INFO - (blobuploader) - INFO - Done attempting.
22:06:57 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ...
22:06:57 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com
22:06:57 INFO - (blobuploader) - INFO - Uploading, attempt #1.
22:07:00 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded
22:07:00 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded!
22:07:00 INFO - (blobuploader) - INFO - Done attempting.
22:07:00 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ...
22:07:00 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com
22:07:00 INFO - (blobuploader) - INFO - Uploading, attempt #1.
22:07:01 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded
22:07:01 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded!
22:07:01 INFO - (blobuploader) - INFO - Done attempting.
22:07:01 INFO - (blobuploader) - INFO - Iteration through files over.
22:07:01 INFO - Return code: 0
22:07:01 INFO - rmtree: /builds/slave/test/build/uploaded_files.json
22:07:01 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1
22:07:01 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/cbc400c4bbd8a4991beb1656bd4b70e6389966acedf9115f50de5d4915eefeab5031b77af89a9dc255684ce1600c9c078f5d541e589d94d4a87b14f1b2e1afa1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/a09e98e8681dda7f9df1f4ca5c04efc9a341526fbb99aae6480074ede32366dc282b21291dc6cb3ef6e2367ce5cae5b12d1da5f7591be13e377ea341fac51674", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/14d7ac04f1acf5ddb6642b6508f0c3a8ed625e22300aa17c6252ccd2539aa8a586a77607d52d12c25a78a50b58283609a59c4aced2d5806ee428cfdcd92291cd"}
22:07:01 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files
22:07:01 INFO - Writing to file /builds/slave/test/properties/blobber_files
22:07:01 INFO - Contents:
22:07:01 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/cbc400c4bbd8a4991beb1656bd4b70e6389966acedf9115f50de5d4915eefeab5031b77af89a9dc255684ce1600c9c078f5d541e589d94d4a87b14f1b2e1afa1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/a09e98e8681dda7f9df1f4ca5c04efc9a341526fbb99aae6480074ede32366dc282b21291dc6cb3ef6e2367ce5cae5b12d1da5f7591be13e377ea341fac51674", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/14d7ac04f1acf5ddb6642b6508f0c3a8ed625e22300aa17c6252ccd2539aa8a586a77607d52d12c25a78a50b58283609a59c4aced2d5806ee428cfdcd92291cd"}
22:07:01 INFO - Running post-run listener: copy_logs_to_upload_dir
22:07:01 INFO - Copying logs to upload dir...
22:07:01 INFO - mkdir: /builds/slave/test/build/upload/logs
22:07:01 INFO - Copying logs to upload dir...
program finished with exit code 0
elapsedTime=1237.368595
========= master_lag: 0.01 =========
========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 37 secs) (at 2016-11-17 22:07:01.395645) =========
========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-17 22:07:01.399176) =========
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=bb9b54edd4a927dc735d112f000001d9-1479447980.912237-1650614955
XPCOM_DEBUG_BREAK=warn
_=/tools/buildbot/bin/python
using PTY: False
blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/cbc400c4bbd8a4991beb1656bd4b70e6389966acedf9115f50de5d4915eefeab5031b77af89a9dc255684ce1600c9c078f5d541e589d94d4a87b14f1b2e1afa1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/a09e98e8681dda7f9df1f4ca5c04efc9a341526fbb99aae6480074ede32366dc282b21291dc6cb3ef6e2367ce5cae5b12d1da5f7591be13e377ea341fac51674", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/14d7ac04f1acf5ddb6642b6508f0c3a8ed625e22300aa17c6252ccd2539aa8a586a77607d52d12c25a78a50b58283609a59c4aced2d5806ee428cfdcd92291cd"}
build_url:https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1479436622/firefox-53.0a1.en-US.linux-x86_64.tar.bz2
program finished with exit code 0
elapsedTime=0.011623
build_url: 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1479436622/firefox-53.0a1.en-US.linux-x86_64.tar.bz2'
blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/cbc400c4bbd8a4991beb1656bd4b70e6389966acedf9115f50de5d4915eefeab5031b77af89a9dc255684ce1600c9c078f5d541e589d94d4a87b14f1b2e1afa1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/a09e98e8681dda7f9df1f4ca5c04efc9a341526fbb99aae6480074ede32366dc282b21291dc6cb3ef6e2367ce5cae5b12d1da5f7591be13e377ea341fac51674", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/14d7ac04f1acf5ddb6642b6508f0c3a8ed625e22300aa17c6252ccd2539aa8a586a77607d52d12c25a78a50b58283609a59c4aced2d5806ee428cfdcd92291cd"}'
========= master_lag: 0.01 =========
========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-17 22:07:01.424952) =========
========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-17 22:07:01.425277) =========
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=bb9b54edd4a927dc735d112f000001d9-1479447980.912237-1650614955
XPCOM_DEBUG_BREAK=warn
_=/tools/buildbot/bin/python
using PTY: False
program finished with exit code 0
elapsedTime=0.004403
========= master_lag: 0.08 =========
========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-17 22:07:01.508684) =========
========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-17 22:07:01.509050) =========
========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-17 22:07:01.509428) =========
========= Total master_lag: 0.16 =========