builder: mozilla-inbound_ubuntu64_hw_test-dromaeojs-e10s-pgo
slave: talos-linux64-ix-069
starttime: 1483211641.29
results: success (0)
buildid: 20161231111339
builduid: 8b2b5953ba274baeb7c52b4830b68074
revision: fc12fe53968e08b95e47b1cbc55cd622b484b31e
========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-12-31 11:14:01.288391) =========
master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/
========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-12-31 11:14:01.289136) =========
========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-12-31 11:14:01.289458) =========
========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-12-31 11:14:01.343563) =========
========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-31 11:14:01.343870) =========
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=05b19d94dfa9f3ce7b6e62cc000001f7-1483207382.342317-102745228
XPCOM_DEBUG_BREAK=warn
_=/tools/buildbot/bin/python
using PTY: False
--2016-12-31 11:14:01-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py
Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102
Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected.
HTTP request sent, awaiting response... 200 Script output follows
Length: 12179 (12K) [text/x-python]
Saving to: `archiver_client.py'
0K .......... . 100% 42.8M=0s
2016-12-31 11:14:01 (42.8 MB/s) - `archiver_client.py' saved [12179/12179]
program finished with exit code 0
elapsedTime=0.124837
========= master_lag: 0.02 =========
========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-31 11:14:01.487492) =========
========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-12-31 11:14:01.487876) =========
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=05b19d94dfa9f3ce7b6e62cc000001f7-1483207382.342317-102745228
XPCOM_DEBUG_BREAK=warn
_=/tools/buildbot/bin/python
using PTY: False
program finished with exit code 0
elapsedTime=0.015315
========= master_lag: 0.04 =========
========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-12-31 11:14:01.538717) =========
========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-31 11:14:01.539066) =========
bash -c 'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev fc12fe53968e08b95e47b1cbc55cd622b484b31e --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 fc12fe53968e08b95e47b1cbc55cd622b484b31e --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=05b19d94dfa9f3ce7b6e62cc000001f7-1483207382.342317-102745228
XPCOM_DEBUG_BREAK=warn
_=/tools/buildbot/bin/python
using PTY: False
2016-12-31 11:14:01,776 truncating revision to first 12 chars
2016-12-31 11:14:01,777 Setting DEBUG logging.
2016-12-31 11:14:01,777 attempt 1/10
2016-12-31 11:14:01,777 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/fc12fe53968e?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness
2016-12-31 11:14:02,089 unpacking tar archive at: mozilla-inbound-fc12fe53968e/testing/mozharness/
program finished with exit code 0
elapsedTime=0.625226
========= master_lag: 0.01 =========
========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-31 11:14:02.174745) =========
========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-12-31 11:14:02.175118) =========
script_repo_revision: fc12fe53968e08b95e47b1cbc55cd622b484b31e
========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-12-31 11:14:02.175509) =========
========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-12-31 11:14:02.175773) =========
========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-12-31 11:14:02.183395) =========
========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 41 secs) (at 2016-12-31 11:14:02.183759) =========
/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=05b19d94dfa9f3ce7b6e62cc000001f7-1483207382.342317-102745228
XPCOM_DEBUG_BREAK=warn
_=/tools/buildbot/bin/python
using PTY: False
11:14:02 INFO - MultiFileLogger online at 20161231 11:14:02 in /builds/slave/test
11:14:02 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
11:14:02 INFO - Dumping config to /builds/slave/test/logs/localconfig.json.
11:14:02 INFO - {'append_to_log': False,
11:14:02 INFO - 'base_work_dir': '/builds/slave/test',
11:14:02 INFO - 'blob_upload_branch': 'Mozilla-Inbound',
11:14:02 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt',
11:14:02 INFO - 'branch': 'Mozilla-Inbound',
11:14:02 INFO - 'buildbot_json_path': 'buildprops.json',
11:14:02 INFO - 'config_files': ('talos/linux_config.py',),
11:14:02 INFO - 'default_actions': ('clobber',
11:14:02 INFO - 'read-buildbot-config',
11:14:02 INFO - 'download-and-extract',
11:14:02 INFO - 'populate-webroot',
11:14:02 INFO - 'create-virtualenv',
11:14:02 INFO - 'install',
11:14:02 INFO - 'run-tests'),
11:14:02 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',),
11:14:02 INFO - 'download_minidump_stackwalk': True,
11:14:02 INFO - 'download_symbols': 'ondemand',
11:14:02 INFO - 'exes': {'python': '/tools/buildbot/bin/python',
11:14:02 INFO - 'tooltool.py': '/tools/tooltool.py',
11:14:02 INFO - 'virtualenv': ('/tools/buildbot/bin/python',
11:14:02 INFO - '/tools/misc-python/virtualenv.py')},
11:14:02 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub',
11:14:02 INFO - 'http://pypi.pub.build.mozilla.org/pub'),
11:14:02 INFO - 'installer_path': 'installer.exe',
11:14:02 INFO - 'log_level': 'info',
11:14:02 INFO - 'log_name': 'talos',
11:14:02 INFO - 'log_to_console': True,
11:14:02 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk',
11:14:02 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest',
11:14:02 INFO - 'opt_config_files': (),
11:14:02 INFO - 'pip_index': False,
11:14:02 INFO - 'sps_profile': False,
11:14:02 INFO - 'sps_profile_interval': 0,
11:14:02 INFO - 'suite': 'dromaeojs-e10s',
11:14:02 INFO - 'system_bits': '32',
11:14:02 INFO - 'talos_extra_options': ('--webServer', 'localhost'),
11:14:02 INFO - 'title': 'talos-linux64-ix-069',
11:14:02 INFO - 'tooltool_cache': '/builds/tooltool_cache',
11:14:02 INFO - 'use_talos_json': True,
11:14:02 INFO - 'virtualenv_path': '/builds/slave/test/build/venv',
11:14:02 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None},
11:14:02 INFO - 'work_dir': 'build'}
11:14:02 INFO - [mozharness: 2016-12-31 19:14:02.515836Z] Running clobber step.
11:14:02 INFO - Running pre-action listener: _resource_record_pre_action
11:14:02 INFO - Running main action method: clobber
11:14:02 INFO - rmtree: /builds/slave/test/build
11:14:02 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1
11:14:02 INFO - Running post-action listener: _resource_record_post_action
11:14:02 INFO - [mozharness: 2016-12-31 19:14:02.961943Z] Finished clobber step (success)
11:14:02 INFO - [mozharness: 2016-12-31 19:14:02.962044Z] Running read-buildbot-config step.
11:14:02 INFO - Running pre-action listener: _resource_record_pre_action
11:14:02 INFO - Running main action method: read_buildbot_config
11:14:02 INFO - Using buildbot properties:
11:14:02 INFO - {
11:14:02 INFO - "project": "",
11:14:02 INFO - "product": "firefox",
11:14:02 INFO - "script_repo_revision": "production",
11:14:02 INFO - "builddir": "mozilla-inbound_ubuntu64_hw_test-dromaeojs-e10s",
11:14:02 INFO - "repository": "",
11:14:02 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-inbound pgo talos dromaeojs-e10s",
11:14:02 INFO - "buildid": "20161231111339",
11:14:02 INFO - "stage_platform": "linux64-pgo",
11:14:02 INFO - "basedir": "/builds/slave/test",
11:14:02 INFO - "buildnumber": 2188,
11:14:02 INFO - "platform": "ubuntu64_hw",
11:14:02 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/",
11:14:02 INFO - "slavebuilddir": "test",
11:14:02 INFO - "branch": "mozilla-inbound",
11:14:02 INFO - "revision": "fc12fe53968e08b95e47b1cbc55cd622b484b31e",
11:14:02 INFO - "slavename": "talos-linux64-ix-069",
11:14:02 INFO - "builduid": "8b2b5953ba274baeb7c52b4830b68074",
11:14:02 INFO - "repo_path": "integration/mozilla-inbound"
11:14:02 INFO - }
11:14:02 INFO - Found installer url https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1483205412/firefox-53.0a1.en-US.linux-x86_64.tar.bz2.
11:14:02 INFO - Found a test packages url https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1483205412/firefox-53.0a1.en-US.linux-x86_64.test_packages.json.
11:14:02 INFO - Running post-action listener: _resource_record_post_action
11:14:02 INFO - [mozharness: 2016-12-31 19:14:02.964495Z] Finished read-buildbot-config step (success)
11:14:02 INFO - [mozharness: 2016-12-31 19:14:02.964585Z] Running download-and-extract step.
11:14:02 INFO - Running pre-action listener: _resource_record_pre_action
11:14:02 INFO - Running main action method: download_and_extract
11:14:02 INFO - mkdir: /builds/slave/test/build/tests
11:14:02 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')]}
11:14:02 INFO - trying https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1483205412/firefox-53.0a1.en-US.linux-x86_64.test_packages.json
11:14:02 INFO - Downloading https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1483205412/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
11:14:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1483205412/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
11:14:02 INFO - Downloaded 1361 bytes.
11:14:02 INFO - Reading from file /builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json
11:14:02 INFO - Using the following test package requirements:
11:14:02 INFO - {u'common': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'],
11:14:02 INFO - u'cppunittest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip',
11:14:02 INFO - u'firefox-53.0a1.en-US.linux-x86_64.cppunittest.tests.zip'],
11:14:02 INFO - u'gtest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip',
11:14:02 INFO - u'firefox-53.0a1.en-US.linux-x86_64.gtest.tests.zip'],
11:14:02 INFO - u'jittest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip',
11:14:02 INFO - u'jsshell-linux-x86_64.zip'],
11:14:02 INFO - u'mochitest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip',
11:14:02 INFO - u'firefox-53.0a1.en-US.linux-x86_64.mochitest.tests.zip'],
11:14:02 INFO - u'mozbase': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'],
11:14:02 INFO - u'reftest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip',
11:14:02 INFO - u'firefox-53.0a1.en-US.linux-x86_64.reftest.tests.zip'],
11:14:02 INFO - u'talos': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip',
11:14:02 INFO - u'firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip'],
11:14:02 INFO - u'web-platform': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip',
11:14:02 INFO - u'firefox-53.0a1.en-US.linux-x86_64.web-platform.tests.zip'],
11:14:02 INFO - u'xpcshell': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip',
11:14:02 INFO - u'firefox-53.0a1.en-US.linux-x86_64.xpcshell.tests.zip']}
11:14:02 INFO - Downloading packages: [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common
11:14:02 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/1483205412/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip
11:14:02 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1483205412/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1
11:14:02 INFO - Fetch https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1483205412/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip into memory
11:14:03 INFO - Expected file size: 21836610
11:14:03 INFO - Obtained file size: 21836610
11:14:07 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
11:14:07 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/1483205412/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip
11:14:07 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1483205412/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1
11:14:07 INFO - Fetch https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1483205412/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip into memory
11:14:07 INFO - Expected file size: 21836610
11:14:07 INFO - Obtained file size: 21836610
11:14:12 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/1483205412/firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip
11:14:12 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1483205412/firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1
11:14:12 INFO - Fetch https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1483205412/firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip into memory
11:14:14 INFO - Expected file size: 14409776
11:14:14 INFO - Obtained file size: 14409776
11:14:14 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')]}
11:14:14 INFO - trying https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1483205412/firefox-53.0a1.en-US.linux-x86_64.tar.bz2
11:14:14 INFO - Downloading https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1483205412/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
11:14:14 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1483205412/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
11:14:20 INFO - Downloaded 61377599 bytes.
11:14:20 INFO - Setting buildbot property build_url to https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1483205412/firefox-53.0a1.en-US.linux-x86_64.tar.bz2
11:14:20 INFO - mkdir: /builds/slave/test/properties
11:14:20 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url
11:14:20 INFO - Writing to file /builds/slave/test/properties/build_url
11:14:20 INFO - Contents:
11:14:20 INFO - build_url:https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1483205412/firefox-53.0a1.en-US.linux-x86_64.tar.bz2
11:14:20 INFO - Running post-action listener: _resource_record_post_action
11:14:20 INFO - Running post-action listener: set_extra_try_arguments
11:14:20 INFO - [mozharness: 2016-12-31 19:14:20.620142Z] Finished download-and-extract step (success)
11:14:20 INFO - [mozharness: 2016-12-31 19:14:20.620370Z] Running populate-webroot step.
11:14:20 INFO - Running pre-action listener: _resource_record_pre_action
11:14:20 INFO - Running main action method: populate_webroot
11:14:20 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']},
11:14:20 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']},
11:14:20 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome',
11:14:20 INFO - '--tppagecycles',
11:14:20 INFO - '7'],
11:14:20 INFO - 'tests': ['tsvgm']}},
11:14:20 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'],
11:14:20 INFO - 'tests': ['tresize', 'tcanvasmark']},
11:14:20 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']},
11:14:20 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'],
11:14:20 INFO - 'tests': ['dromaeo_css', 'kraken']},
11:14:20 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']},
11:14:20 INFO - 'g1': {'pagesets_name': 'tp5n.zip',
11:14:20 INFO - 'talos_options': ['--disable-e10s'],
11:14:20 INFO - 'tests': ['tp5o_scroll', 'glterrain']},
11:14:20 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip',
11:14:20 INFO - 'tests': ['tp5o_scroll', 'glterrain']},
11:14:20 INFO - 'g2': {'pagesets_name': 'tp5n.zip',
11:14:20 INFO - 'talos_options': ['--disable-e10s'],
11:14:20 INFO - 'tests': ['damp', 'tps']},
11:14:20 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip',
11:14:20 INFO - 'tests': ['damp', 'tps']},
11:14:20 INFO - 'g3': {'talos_options': ['--disable-e10s'],
11:14:20 INFO - 'tests': ['dromaeo_dom']},
11:14:20 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']},
11:14:20 INFO - 'g4': {'talos_options': ['--disable-e10s'],
11:14:20 INFO - 'tests': ['basic_compositor_video']},
11:14:20 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']},
11:14:20 INFO - 'other': {'talos_options': ['--disable-e10s'],
11:14:20 INFO - 'tests': ['a11yr',
11:14:20 INFO - 'ts_paint',
11:14:20 INFO - 'tpaint',
11:14:20 INFO - 'sessionrestore',
11:14:20 INFO - 'sessionrestore_no_auto_restore',
11:14:20 INFO - 'tabpaint']},
11:14:20 INFO - 'other-e10s': {'tests': ['a11yr',
11:14:20 INFO - 'ts_paint',
11:14:20 INFO - 'tpaint',
11:14:20 INFO - 'sessionrestore',
11:14:20 INFO - 'sessionrestore_no_auto_restore',
11:14:20 INFO - 'tabpaint']},
11:14:20 INFO - 'other-e10s_l64': {'tests': ['a11yr',
11:14:20 INFO - 'ts_paint',
11:14:20 INFO - 'tpaint',
11:14:20 INFO - 'sessionrestore',
11:14:20 INFO - 'sessionrestore_no_auto_restore',
11:14:20 INFO - 'tabpaint']},
11:14:20 INFO - 'other-e10s_nol64': {'tests': ['a11yr',
11:14:20 INFO - 'ts_paint',
11:14:20 INFO - 'tpaint',
11:14:20 INFO - 'sessionrestore',
11:14:20 INFO - 'sessionrestore_no_auto_restore',
11:14:20 INFO - 'tabpaint']},
11:14:20 INFO - 'other_l64': {'talos_options': ['--disable-e10s'],
11:14:20 INFO - 'tests': ['a11yr',
11:14:20 INFO - 'ts_paint',
11:14:20 INFO - 'tpaint',
11:14:20 INFO - 'sessionrestore',
11:14:20 INFO - 'sessionrestore_no_auto_restore',
11:14:20 INFO - 'tabpaint']},
11:14:20 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'],
11:14:20 INFO - 'tests': ['a11yr',
11:14:20 INFO - 'ts_paint',
11:14:20 INFO - 'tpaint',
11:14:20 INFO - 'sessionrestore',
11:14:20 INFO - 'sessionrestore_no_auto_restore',
11:14:20 INFO - 'tabpaint']},
11:14:20 INFO - 'svgr': {'talos_options': ['--disable-e10s'],
11:14:20 INFO - 'tests': ['tsvgx',
11:14:20 INFO - 'tsvgr_opacity',
11:14:20 INFO - 'tart',
11:14:20 INFO - 'tscrollx',
11:14:20 INFO - 'cart',
11:14:20 INFO - 'tsvg_static']},
11:14:20 INFO - 'svgr-e10s': {'tests': ['tsvgx',
11:14:20 INFO - 'tsvgr_opacity',
11:14:20 INFO - 'tart',
11:14:20 INFO - 'tscrollx',
11:14:20 INFO - 'cart',
11:14:20 INFO - 'tsvg_static']},
11:14:20 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip',
11:14:20 INFO - 'talos_options': ['--disable-e10s'],
11:14:20 INFO - 'tests': ['tp5o']},
11:14:20 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']},
11:14:20 INFO - 'xperf': {'pagesets_name': 'tp5n.zip',
11:14:20 INFO - 'talos_options': ['--disable-e10s',
11:14:20 INFO - '--xperf_path',
11:14:20 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'],
11:14:20 INFO - 'tests': ['tp5n']},
11:14:20 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip',
11:14:20 INFO - 'talos_options': ['--xperf_path',
11:14:20 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'],
11:14:20 INFO - 'tests': ['tp5n']}},
11:14:20 INFO - 'talos.zip': {'path': '',
11:14:20 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}}
11:14:20 INFO - Running post-action listener: _resource_record_post_action
11:14:20 INFO - [mozharness: 2016-12-31 19:14:20.640402Z] Finished populate-webroot step (success)
11:14:20 INFO - [mozharness: 2016-12-31 19:14:20.640490Z] Running create-virtualenv step.
11:14:20 INFO - Running pre-action listener: _resource_record_pre_action
11:14:20 INFO - Running main action method: create_virtualenv
11:14:20 INFO - Creating virtualenv /builds/slave/test/build/venv
11:14:20 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
11:14:20 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv
11:14:20 INFO - The --no-site-packages flag is deprecated; it is now the default behavior.
11:14:20 INFO - Using real prefix '/usr'
11:14:20 INFO - New python executable in /builds/slave/test/build/venv/bin/python
11:14:21 INFO - Installing distribute.............................................................................................................................................................................................done.
11:14:23 INFO - Installing pip.................done.
11:14:23 INFO - Return code: 0
11:14:23 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version']
11:14:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version
11:14:23 INFO - Reading from file tmpfile_stdout
11:14:23 INFO - Output received:
11:14:23 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)
11:14:23 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv
11:14:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]}
11:14:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org
11:14:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub
11:14:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]}
11:14:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org
11:14:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub
11:14:23 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23fb1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x250ca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x276d480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x276a820>, '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 0x276b520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x276b9b0>, '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': '05b19d94dfa9f3ce7b6e62cc000001f7-1483207382.342317-102745228', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1
11:14:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build
11:14:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5
11:14:23 INFO - Using env: {'DISPLAY': ':0',
11:14:23 INFO - 'HOME': '/home/cltbld',
11:14:23 INFO - 'LANG': 'en_US.UTF-8',
11:14:23 INFO - 'LANGUAGE': 'en_US:en',
11:14:23 INFO - 'LOGNAME': 'cltbld',
11:14:23 INFO - 'MAIL': '/var/mail/cltbld',
11:14:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1',
11:14:23 INFO - 'MOZ_NO_REMOTE': '1',
11:14:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript',
11:14:23 INFO - 'NO_EM_RESTART': '1',
11:14:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games',
11:14:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json',
11:14:23 INFO - 'PWD': '/builds/slave/test',
11:14:23 INFO - 'SHELL': '/bin/bash',
11:14:23 INFO - 'SHLVL': '1',
11:14:23 INFO - 'TERM': 'linux',
11:14:23 INFO - 'TMOUT': '86400',
11:14:23 INFO - 'USER': 'cltbld',
11:14:23 INFO - 'XDG_SESSION_COOKIE': '05b19d94dfa9f3ce7b6e62cc000001f7-1483207382.342317-102745228',
11:14:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn',
11:14:23 INFO - '_': '/tools/buildbot/bin/python'}
11:14:23 INFO - Ignoring indexes: https://pypi.python.org/simple/
11:14:23 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
11:14:23 INFO - Cleaning up...
11:14:23 INFO - Return code: 0
11:14:23 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv
11:14:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]}
11:14:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org
11:14:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub
11:14:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]}
11:14:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org
11:14:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub
11:14:23 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x23fb1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x250ca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x276d480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x276a820>, '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 0x276b520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x276b9b0>, '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': '05b19d94dfa9f3ce7b6e62cc000001f7-1483207382.342317-102745228', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1
11:14:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build
11:14:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1
11:14:23 INFO - Using env: {'DISPLAY': ':0',
11:14:23 INFO - 'HOME': '/home/cltbld',
11:14:23 INFO - 'LANG': 'en_US.UTF-8',
11:14:23 INFO - 'LANGUAGE': 'en_US:en',
11:14:23 INFO - 'LOGNAME': 'cltbld',
11:14:23 INFO - 'MAIL': '/var/mail/cltbld',
11:14:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1',
11:14:23 INFO - 'MOZ_NO_REMOTE': '1',
11:14:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript',
11:14:23 INFO - 'NO_EM_RESTART': '1',
11:14:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games',
11:14:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json',
11:14:23 INFO - 'PWD': '/builds/slave/test',
11:14:23 INFO - 'SHELL': '/bin/bash',
11:14:23 INFO - 'SHLVL': '1',
11:14:23 INFO - 'TERM': 'linux',
11:14:23 INFO - 'TMOUT': '86400',
11:14:23 INFO - 'USER': 'cltbld',
11:14:23 INFO - 'XDG_SESSION_COOKIE': '05b19d94dfa9f3ce7b6e62cc000001f7-1483207382.342317-102745228',
11:14:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn',
11:14:23 INFO - '_': '/tools/buildbot/bin/python'}
11:14:23 INFO - Ignoring indexes: https://pypi.python.org/simple/
11:14:23 INFO - Downloading/unpacking psutil>=3.1.1
11:14:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available
11:14:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available
11:14:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available
11:14:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available
11:14:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available
11:14:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available
11:14:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil
11:14:25 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build'
11:14:25 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects
...
11:14:25 INFO - Installing collected packages: psutil
11:14:25 INFO - Running setup.py install for psutil
11:14:26 INFO - building 'psutil._psutil_linux' extension
11:14:26 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
11:14:26 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
11:14:26 INFO - building 'psutil._psutil_posix' extension
11:14:26 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
11:14:26 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
11:14:26 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build'
11:14:26 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ...
11:14:26 INFO - Successfully installed psutil
11:14:26 INFO - Cleaning up...
11:14:26 INFO - Return code: 0
11:14:26 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv
11:14:26 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')]}
11:14:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org
11:14:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub
11:14:26 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')]}
11:14:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org
11:14:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub
11:14:26 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 0x23fb1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x250ca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x276d480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x276a820>, '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 0x276b520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x276b9b0>, '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': '05b19d94dfa9f3ce7b6e62cc000001f7-1483207382.342317-102745228', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1
11:14:26 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
11:14:26 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
11:14:26 INFO - Using env: {'DISPLAY': ':0',
11:14:26 INFO - 'HOME': '/home/cltbld',
11:14:26 INFO - 'LANG': 'en_US.UTF-8',
11:14:26 INFO - 'LANGUAGE': 'en_US:en',
11:14:26 INFO - 'LOGNAME': 'cltbld',
11:14:26 INFO - 'MAIL': '/var/mail/cltbld',
11:14:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1',
11:14:26 INFO - 'MOZ_NO_REMOTE': '1',
11:14:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript',
11:14:26 INFO - 'NO_EM_RESTART': '1',
11:14:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games',
11:14:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json',
11:14:26 INFO - 'PWD': '/builds/slave/test',
11:14:26 INFO - 'SHELL': '/bin/bash',
11:14:26 INFO - 'SHLVL': '1',
11:14:26 INFO - 'TERM': 'linux',
11:14:26 INFO - 'TMOUT': '86400',
11:14:26 INFO - 'USER': 'cltbld',
11:14:26 INFO - 'XDG_SESSION_COOKIE': '05b19d94dfa9f3ce7b6e62cc000001f7-1483207382.342317-102745228',
11:14:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn',
11:14:26 INFO - '_': '/tools/buildbot/bin/python'}
11:14:26 INFO - Ignoring indexes: https://pypi.python.org/simple/
11:14:26 INFO - Downloading/unpacking mozsystemmonitor==0.3
11:14:26 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
11:14:26 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
11:14:26 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
11:14:26 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
11:14:26 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
11:14:26 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
11:14:28 INFO - Downloading mozsystemmonitor-0.3.tar.gz
11:14:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor
11:14:28 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3)
11:14:28 INFO - Installing collected packages: mozsystemmonitor
11:14:28 INFO - Running setup.py install for mozsystemmonitor
11:14:28 INFO - Successfully installed mozsystemmonitor
11:14:28 INFO - Cleaning up...
11:14:28 INFO - Return code: 0
11:14:28 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv
11:14:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]}
11:14:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org
11:14:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub
11:14:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]}
11:14:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org
11:14:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub
11:14:28 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x23fb1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x250ca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x276d480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x276a820>, '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 0x276b520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x276b9b0>, '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': '05b19d94dfa9f3ce7b6e62cc000001f7-1483207382.342317-102745228', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1
11:14:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build
11:14:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1
11:14:28 INFO - Using env: {'DISPLAY': ':0',
11:14:28 INFO - 'HOME': '/home/cltbld',
11:14:28 INFO - 'LANG': 'en_US.UTF-8',
11:14:28 INFO - 'LANGUAGE': 'en_US:en',
11:14:28 INFO - 'LOGNAME': 'cltbld',
11:14:28 INFO - 'MAIL': '/var/mail/cltbld',
11:14:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1',
11:14:28 INFO - 'MOZ_NO_REMOTE': '1',
11:14:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript',
11:14:28 INFO - 'NO_EM_RESTART': '1',
11:14:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games',
11:14:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json',
11:14:28 INFO - 'PWD': '/builds/slave/test',
11:14:28 INFO - 'SHELL': '/bin/bash',
11:14:28 INFO - 'SHLVL': '1',
11:14:28 INFO - 'TERM': 'linux',
11:14:28 INFO - 'TMOUT': '86400',
11:14:28 INFO - 'USER': 'cltbld',
11:14:28 INFO - 'XDG_SESSION_COOKIE': '05b19d94dfa9f3ce7b6e62cc000001f7-1483207382.342317-102745228',
11:14:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn',
11:14:28 INFO - '_': '/tools/buildbot/bin/python'}
11:14:29 INFO - Ignoring indexes: https://pypi.python.org/simple/
11:14:29 INFO - Downloading/unpacking jsonschema==2.5.1
11:14:29 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
11:14:29 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
11:14:29 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
11:14:29 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
11:14:29 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
11:14:29 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
11:14:31 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl
11:14:31 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1)
11:14:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available
11:14:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available
11:14:31 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available
11:14:31 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available
11:14:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available
11:14:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available
11:14:31 INFO - Downloading functools32-3.2.3-2.tar.gz
11:14:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32
11:14:31 INFO - warning: no files found matching '*.txt'
11:14:31 INFO - no previously-included directories found matching 'build'
11:14:31 INFO - no previously-included directories found matching 'dist'
11:14:31 INFO - no previously-included directories found matching '.git*'
11:14:31 INFO - Installing collected packages: jsonschema, functools32
11:14:31 INFO - Running setup.py install for functools32
11:14:31 INFO - warning: no files found matching '*.txt'
11:14:31 INFO - no previously-included directories found matching 'build'
11:14:31 INFO - no previously-included directories found matching 'dist'
11:14:31 INFO - no previously-included directories found matching '.git*'
11:14:31 INFO - Successfully installed jsonschema functools32
11:14:31 INFO - Cleaning up...
11:14:31 INFO - Return code: 0
11:14:31 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv
11:14:31 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')]}
11:14:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org
11:14:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub
11:14:31 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')]}
11:14:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org
11:14:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub
11:14:31 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 0x23fb1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x250ca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x276d480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x276a820>, '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 0x276b520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x276b9b0>, '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': '05b19d94dfa9f3ce7b6e62cc000001f7-1483207382.342317-102745228', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1
11:14:31 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
11:14:31 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
11:14:31 INFO - Using env: {'DISPLAY': ':0',
11:14:31 INFO - 'HOME': '/home/cltbld',
11:14:31 INFO - 'LANG': 'en_US.UTF-8',
11:14:31 INFO - 'LANGUAGE': 'en_US:en',
11:14:31 INFO - 'LOGNAME': 'cltbld',
11:14:31 INFO - 'MAIL': '/var/mail/cltbld',
11:14:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1',
11:14:31 INFO - 'MOZ_NO_REMOTE': '1',
11:14:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript',
11:14:31 INFO - 'NO_EM_RESTART': '1',
11:14:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games',
11:14:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json',
11:14:31 INFO - 'PWD': '/builds/slave/test',
11:14:31 INFO - 'SHELL': '/bin/bash',
11:14:31 INFO - 'SHLVL': '1',
11:14:31 INFO - 'TERM': 'linux',
11:14:31 INFO - 'TMOUT': '86400',
11:14:31 INFO - 'USER': 'cltbld',
11:14:31 INFO - 'XDG_SESSION_COOKIE': '05b19d94dfa9f3ce7b6e62cc000001f7-1483207382.342317-102745228',
11:14:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn',
11:14:31 INFO - '_': '/tools/buildbot/bin/python'}
11:14:31 INFO - Ignoring indexes: https://pypi.python.org/simple/
11:14:31 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages
11:14:31 INFO - Cleaning up...
11:14:31 INFO - Return code: 0
11:14:31 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv
11:14:31 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')]}
11:14:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org
11:14:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub
11:14:31 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')]}
11:14:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org
11:14:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub
11:14:31 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 0x23fb1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x250ca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x276d480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x276a820>, '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 0x276b520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x276b9b0>, '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': '05b19d94dfa9f3ce7b6e62cc000001f7-1483207382.342317-102745228', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1
11:14:31 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
11:14:31 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
11:14:31 INFO - Using env: {'DISPLAY': ':0',
11:14:31 INFO - 'HOME': '/home/cltbld',
11:14:31 INFO - 'LANG': 'en_US.UTF-8',
11:14:31 INFO - 'LANGUAGE': 'en_US:en',
11:14:31 INFO - 'LOGNAME': 'cltbld',
11:14:31 INFO - 'MAIL': '/var/mail/cltbld',
11:14:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1',
11:14:31 INFO - 'MOZ_NO_REMOTE': '1',
11:14:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript',
11:14:31 INFO - 'NO_EM_RESTART': '1',
11:14:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games',
11:14:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json',
11:14:31 INFO - 'PWD': '/builds/slave/test',
11:14:31 INFO - 'SHELL': '/bin/bash',
11:14:31 INFO - 'SHLVL': '1',
11:14:31 INFO - 'TERM': 'linux',
11:14:31 INFO - 'TMOUT': '86400',
11:14:31 INFO - 'USER': 'cltbld',
11:14:31 INFO - 'XDG_SESSION_COOKIE': '05b19d94dfa9f3ce7b6e62cc000001f7-1483207382.342317-102745228',
11:14:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn',
11:14:31 INFO - '_': '/tools/buildbot/bin/python'}
11:14:32 INFO - Ignoring indexes: https://pypi.python.org/simple/
11:14:32 INFO - Downloading/unpacking blobuploader==1.2.4
11:14:32 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
11:14:32 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
11:14:32 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
11:14:32 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
11:14:32 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
11:14:32 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
11:14:34 INFO - Downloading blobuploader-1.2.4.tar.gz
11:14:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader
11:14:34 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4)
11:14:34 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
11:14:34 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
11:14:34 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
11:14:34 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
11:14:34 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
11:14:34 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
11:14:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests
11:14:34 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4)
11:14:34 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
11:14:34 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
11:14:34 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
11:14:34 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
11:14:34 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
11:14:34 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
11:14:34 INFO - Downloading docopt-0.6.1.tar.gz
11:14:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt
11:14:34 INFO - Installing collected packages: blobuploader, requests, docopt
11:14:34 INFO - Running setup.py install for blobuploader
11:14:34 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775
11:14:34 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775
11:14:34 INFO - Running setup.py install for requests
11:14:35 INFO - Running setup.py install for docopt
11:14:35 INFO - Successfully installed blobuploader requests docopt
11:14:35 INFO - Cleaning up...
11:14:35 INFO - Return code: 0
11:14:35 INFO - Installing None into virtualenv /builds/slave/test/build/venv
11:14: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')]}
11:14:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org
11:14:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub
11:14: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')]}
11:14:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org
11:14:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub
11:14:35 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 0x23fb1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x250ca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x276d480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x276a820>, '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 0x276b520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x276b9b0>, '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': '05b19d94dfa9f3ce7b6e62cc000001f7-1483207382.342317-102745228', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1
11:14:35 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
11:14:35 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
11:14:35 INFO - Using env: {'DISPLAY': ':0',
11:14:35 INFO - 'HOME': '/home/cltbld',
11:14:35 INFO - 'LANG': 'en_US.UTF-8',
11:14:35 INFO - 'LANGUAGE': 'en_US:en',
11:14:35 INFO - 'LOGNAME': 'cltbld',
11:14:35 INFO - 'MAIL': '/var/mail/cltbld',
11:14:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1',
11:14:35 INFO - 'MOZ_NO_REMOTE': '1',
11:14:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript',
11:14:35 INFO - 'NO_EM_RESTART': '1',
11:14:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games',
11:14:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json',
11:14:35 INFO - 'PWD': '/builds/slave/test',
11:14:35 INFO - 'SHELL': '/bin/bash',
11:14:35 INFO - 'SHLVL': '1',
11:14:35 INFO - 'TERM': 'linux',
11:14:35 INFO - 'TMOUT': '86400',
11:14:35 INFO - 'USER': 'cltbld',
11:14:35 INFO - 'XDG_SESSION_COOKIE': '05b19d94dfa9f3ce7b6e62cc000001f7-1483207382.342317-102745228',
11:14:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn',
11:14:35 INFO - '_': '/tools/buildbot/bin/python'}
11:14:35 INFO - Ignoring indexes: https://pypi.python.org/simple/
11:14:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser
11:14:35 INFO - Running setup.py (path:/tmp/pip-9bg0Up-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser
11:14:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash
11:14:35 INFO - Running setup.py (path:/tmp/pip-DbBglQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash
11:14:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug
11:14:35 INFO - Running setup.py (path:/tmp/pip-5cHVAG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug
11:14:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice
11:14:35 INFO - Running setup.py (path:/tmp/pip-xOOO5Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice
11:14:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile
11:14:35 INFO - Running setup.py (path:/tmp/pip-m09dEv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile
11:14:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd
11:14:36 INFO - Running setup.py (path:/tmp/pip-divLEK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd
11:14:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo
11:14:36 INFO - Running setup.py (path:/tmp/pip-FVsBvw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo
11:14:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall
11:14:36 INFO - Running setup.py (path:/tmp/pip-dnXHrZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall
11:14:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak
11:14:36 INFO - Running setup.py (path:/tmp/pip-qKHA1Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak
11:14:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog
11:14:36 INFO - Running setup.py (path:/tmp/pip-TeW4i0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog
11:14:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork
11:14:36 INFO - Running setup.py (path:/tmp/pip-FK1upc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork
11:14:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess
11:14:36 INFO - Running setup.py (path:/tmp/pip-6ykanz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess
11:14:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile
11:14:36 INFO - Running setup.py (path:/tmp/pip-UTv6m2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile
11:14:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner
11:14:36 INFO - Running setup.py (path:/tmp/pip-d4vaob-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner
11:14:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot
11:14:36 INFO - Running setup.py (path:/tmp/pip-xHErNH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot
11:14:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest
11:14:36 INFO - Running setup.py (path:/tmp/pip-9wdn7R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest
11:14:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion
11:14:36 INFO - Running setup.py (path:/tmp/pip-3siRfP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion
11:14:36 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion
11:14:36 INFO - Running setup.py install for manifestparser
11:14:36 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin
11:14:36 INFO - Running setup.py install for mozcrash
11:14:37 INFO - Running setup.py install for mozdebug
11:14:37 INFO - Running setup.py install for mozdevice
11:14:37 INFO - Installing sutini script to /builds/slave/test/build/venv/bin
11:14:37 INFO - Installing dm script to /builds/slave/test/build/venv/bin
11:14:37 INFO - Running setup.py install for mozfile
11:14:37 INFO - Running setup.py install for mozhttpd
11:14:37 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin
11:14:37 INFO - Running setup.py install for mozinfo
11:14:37 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin
11:14:37 INFO - Running setup.py install for mozInstall
11:14:37 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin
11:14:37 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin
11:14:37 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin
11:14:37 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin
11:14:37 INFO - Running setup.py install for mozleak
11:14:37 INFO - Running setup.py install for mozlog
11:14:37 INFO - Installing structlog script to /builds/slave/test/build/venv/bin
11:14:37 INFO - Running setup.py install for moznetwork
11:14:37 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin
11:14:37 INFO - Running setup.py install for mozprocess
11:14:38 INFO - Running setup.py install for mozprofile
11:14:38 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin
11:14:38 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin
11:14:38 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin
11:14:38 INFO - Running setup.py install for mozrunner
11:14:38 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin
11:14:38 INFO - Running setup.py install for mozscreenshot
11:14:38 INFO - Running setup.py install for moztest
11:14:38 INFO - Running setup.py install for mozversion
11:14:38 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin
11:14:38 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion
11:14:38 INFO - Cleaning up...
11:14:38 INFO - Return code: 0
11:14:38 INFO - Installing None into virtualenv /builds/slave/test/build/venv
11:14: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')]}
11:14:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org
11:14:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub
11:14: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')]}
11:14:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org
11:14:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub
11:14:38 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 0x23fb1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x250ca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x276d480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x276a820>, '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 0x276b520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x276b9b0>, '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': '05b19d94dfa9f3ce7b6e62cc000001f7-1483207382.342317-102745228', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1
11:14:38 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
11:14:38 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
11:14:38 INFO - Using env: {'DISPLAY': ':0',
11:14:38 INFO - 'HOME': '/home/cltbld',
11:14:38 INFO - 'LANG': 'en_US.UTF-8',
11:14:38 INFO - 'LANGUAGE': 'en_US:en',
11:14:38 INFO - 'LOGNAME': 'cltbld',
11:14:38 INFO - 'MAIL': '/var/mail/cltbld',
11:14:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1',
11:14:38 INFO - 'MOZ_NO_REMOTE': '1',
11:14:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript',
11:14:38 INFO - 'NO_EM_RESTART': '1',
11:14:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games',
11:14:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json',
11:14:38 INFO - 'PWD': '/builds/slave/test',
11:14:38 INFO - 'SHELL': '/bin/bash',
11:14:38 INFO - 'SHLVL': '1',
11:14:38 INFO - 'TERM': 'linux',
11:14:38 INFO - 'TMOUT': '86400',
11:14:38 INFO - 'USER': 'cltbld',
11:14:38 INFO - 'XDG_SESSION_COOKIE': '05b19d94dfa9f3ce7b6e62cc000001f7-1483207382.342317-102745228',
11:14:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn',
11:14:38 INFO - '_': '/tools/buildbot/bin/python'}
11:14:38 INFO - Ignoring indexes: https://pypi.python.org/simple/
11:14:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser
11:14:38 INFO - Running setup.py (path:/tmp/pip-3L3F68-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser
11:14:38 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1))
11:14:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash
11:14:38 INFO - Running setup.py (path:/tmp/pip-KgNf5t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash
11:14:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2))
11:14:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug
11:14:39 INFO - Running setup.py (path:/tmp/pip-GSnidQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug
11:14:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3))
11:14:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice
11:14:39 INFO - Running setup.py (path:/tmp/pip-3gUoPh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice
11:14:39 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))
11:14:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile
11:14:39 INFO - Running setup.py (path:/tmp/pip-LW0iQd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile
11:14:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5))
11:14:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd
11:14:39 INFO - Running setup.py (path:/tmp/pip-Dp1RWf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd
11:14:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6))
11:14:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo
11:14:39 INFO - Running setup.py (path:/tmp/pip-7ldkna-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo
11:14:39 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))
11:14:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall
11:14:39 INFO - Running setup.py (path:/tmp/pip-s2W3Z7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall
11:14:39 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))
11:14:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak
11:14:39 INFO - Running setup.py (path:/tmp/pip-VI61Rk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak
11:14:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9))
11:14:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog
11:14:39 INFO - Running setup.py (path:/tmp/pip-gmZTf5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog
11:14:39 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))
11:14:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork
11:14:39 INFO - Running setup.py (path:/tmp/pip-GzgQOE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork
11:14:39 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11))
11:14:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess
11:14:39 INFO - Running setup.py (path:/tmp/pip-H7GLCQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess
11:14:39 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))
11:14:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile
11:14:39 INFO - Running setup.py (path:/tmp/pip-XJczUD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile
11:14:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13))
11:14:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner
11:14:39 INFO - Running setup.py (path:/tmp/pip-B5RzG1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner
11:14:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14))
11:14:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot
11:14:39 INFO - Running setup.py (path:/tmp/pip-iB3Yx0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot
11:14:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15))
11:14:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest
11:14:40 INFO - Running setup.py (path:/tmp/pip-H5VcqO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest
11:14:40 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16))
11:14:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion
11:14:40 INFO - Running setup.py (path:/tmp/pip-0nS3Tn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion
11:14:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17))
11:14:40 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))
11:14:40 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))
11:14:40 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))
11:14:40 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))
11:14:40 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))
11:14:40 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10))
11:14:40 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
11:14:40 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
11:14:40 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
11:14:40 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
11:14:40 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
11:14:40 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
11:14:42 INFO - Downloading blessings-1.6.tar.gz
11:14:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings
11:14:42 INFO - Installing collected packages: blessings
11:14:42 INFO - Running setup.py install for blessings
11:14:42 INFO - Successfully installed blessings
11:14:42 INFO - Cleaning up...
11:14:42 INFO - Return code: 0
11:14:42 INFO - Done creating virtualenv /builds/slave/test/build/venv.
11:14:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze']
11:14:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze
11:14:42 INFO - Reading from file tmpfile_stdout
11:14:42 INFO - Current package versions:
11:14:42 INFO - argparse == 1.2.1
11:14:42 INFO - blessings == 1.6
11:14:42 INFO - blobuploader == 1.2.4
11:14:42 INFO - docopt == 0.6.1
11:14:42 INFO - functools32 == 3.2.3-2
11:14:42 INFO - jsonschema == 2.5.1
11:14:42 INFO - manifestparser == 1.1
11:14:42 INFO - mozInstall == 1.12
11:14:42 INFO - mozcrash == 1.0
11:14:42 INFO - mozdebug == 0.1
11:14:42 INFO - mozdevice == 0.49
11:14:42 INFO - mozfile == 1.2
11:14:42 INFO - mozhttpd == 0.7
11:14:42 INFO - mozinfo == 0.9
11:14:42 INFO - mozleak == 0.1
11:14:42 INFO - mozlog == 3.4
11:14:42 INFO - moznetwork == 0.27
11:14:42 INFO - mozprocess == 0.23
11:14:42 INFO - mozprofile == 0.28
11:14:42 INFO - mozrunner == 6.13
11:14:42 INFO - mozscreenshot == 0.1
11:14:42 INFO - mozsystemmonitor == 0.3
11:14:42 INFO - moztest == 0.8
11:14:42 INFO - mozversion == 1.4
11:14:42 INFO - psutil == 3.1.1
11:14:42 INFO - requests == 1.2.3
11:14:42 INFO - wsgiref == 0.1.2
11:14:42 INFO - Installing None into virtualenv /builds/slave/test/build/venv
11:14:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]}
11:14:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org
11:14:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub
11:14:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]}
11:14:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org
11:14:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub
11:14:42 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 0x23fb1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x250ca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x276d480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x276a820>, '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 0x276b520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x276b9b0>, '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': '05b19d94dfa9f3ce7b6e62cc000001f7-1483207382.342317-102745228', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1
11:14:42 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
11:14:42 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
11:14:42 INFO - Using env: {'DISPLAY': ':0',
11:14:42 INFO - 'HOME': '/home/cltbld',
11:14:42 INFO - 'LANG': 'en_US.UTF-8',
11:14:42 INFO - 'LANGUAGE': 'en_US:en',
11:14:42 INFO - 'LOGNAME': 'cltbld',
11:14:42 INFO - 'MAIL': '/var/mail/cltbld',
11:14:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1',
11:14:42 INFO - 'MOZ_NO_REMOTE': '1',
11:14:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript',
11:14:42 INFO - 'NO_EM_RESTART': '1',
11:14:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games',
11:14:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json',
11:14:42 INFO - 'PWD': '/builds/slave/test',
11:14:42 INFO - 'SHELL': '/bin/bash',
11:14:42 INFO - 'SHLVL': '1',
11:14:42 INFO - 'TERM': 'linux',
11:14:42 INFO - 'TMOUT': '86400',
11:14:42 INFO - 'USER': 'cltbld',
11:14:42 INFO - 'XDG_SESSION_COOKIE': '05b19d94dfa9f3ce7b6e62cc000001f7-1483207382.342317-102745228',
11:14:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn',
11:14:42 INFO - '_': '/tools/buildbot/bin/python'}
11:14:42 INFO - Ignoring indexes: https://pypi.python.org/simple/
11:14:42 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))
11:14:42 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))
11:14:42 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))
11:14:42 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))
11:14:42 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))
11:14:42 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))
11:14:42 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))
11:14:42 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))
11:14:42 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))
11:14:42 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))
11:14:42 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))
11:14:42 INFO - Cleaning up...
11:14:42 INFO - Return code: 0
11:14:42 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv
11:14:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]}
11:14:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org
11:14:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub
11:14:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]}
11:14:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org
11:14:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub
11:14: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', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23fb1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x250ca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x276d480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x276a820>, '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 0x276b520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x276b9b0>, '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': '05b19d94dfa9f3ce7b6e62cc000001f7-1483207382.342317-102745228', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1
11:14: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', 'jsonschema'] in /builds/slave/test/build
11:14: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 jsonschema
11:14:42 INFO - Using env: {'DISPLAY': ':0',
11:14:42 INFO - 'HOME': '/home/cltbld',
11:14:42 INFO - 'LANG': 'en_US.UTF-8',
11:14:42 INFO - 'LANGUAGE': 'en_US:en',
11:14:42 INFO - 'LOGNAME': 'cltbld',
11:14:42 INFO - 'MAIL': '/var/mail/cltbld',
11:14:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1',
11:14:42 INFO - 'MOZ_NO_REMOTE': '1',
11:14:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript',
11:14:42 INFO - 'NO_EM_RESTART': '1',
11:14:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games',
11:14:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json',
11:14:42 INFO - 'PWD': '/builds/slave/test',
11:14:42 INFO - 'SHELL': '/bin/bash',
11:14:42 INFO - 'SHLVL': '1',
11:14:42 INFO - 'TERM': 'linux',
11:14:42 INFO - 'TMOUT': '86400',
11:14:42 INFO - 'USER': 'cltbld',
11:14:42 INFO - 'XDG_SESSION_COOKIE': '05b19d94dfa9f3ce7b6e62cc000001f7-1483207382.342317-102745228',
11:14:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn',
11:14:42 INFO - '_': '/tools/buildbot/bin/python'}
11:14:43 INFO - Ignoring indexes: https://pypi.python.org/simple/
11:14:43 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages
11:14:43 INFO - Cleaning up...
11:14:43 INFO - Return code: 0
11:14:43 INFO - Running post-action listener: _resource_record_post_action
11:14:43 INFO - Running post-action listener: _start_resource_monitoring
11:14:43 INFO - Starting resource monitoring.
11:14:43 INFO - [mozharness: 2016-12-31 19:14:43.143119Z] Finished create-virtualenv step (success)
11:14:43 INFO - [mozharness: 2016-12-31 19:14:43.143660Z] Running install step.
11:14:43 INFO - Running pre-action listener: _resource_record_pre_action
11:14:43 INFO - Running main action method: install
11:14:43 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze']
11:14:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze
11:14:43 INFO - Reading from file tmpfile_stdout
11:14:43 INFO - Detecting whether we're running mozinstall >=1.0...
11:14:43 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h']
11:14:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h
11:14:43 INFO - Reading from file tmpfile_stdout
11:14:43 INFO - Output received:
11:14:43 INFO - Usage: mozinstall [options] installer
11:14:43 INFO - Options:
11:14:43 INFO - -h, --help show this help message and exit
11:14:43 INFO - -d DEST, --destination=DEST
11:14:43 INFO - Directory to install application into. [default:
11:14:43 INFO - "/builds/slave/test"]
11:14:43 INFO - --app=APP Application being installed. [default: firefox]
11:14:43 INFO - mkdir: /builds/slave/test/build/application
11:14:43 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']
11:14:43 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
11:15:00 INFO - Reading from file tmpfile_stdout
11:15:00 INFO - Output received:
11:15:00 INFO - /builds/slave/test/build/application/firefox/firefox
11:15:00 INFO - Running post-action listener: _resource_record_post_action
11:15:00 INFO - [mozharness: 2016-12-31 19:15:00.772708Z] Finished install step (success)
11:15:00 INFO - [mozharness: 2016-12-31 19:15:00.772982Z] Running run-tests step.
11:15:00 INFO - Running pre-action listener: _resource_record_pre_action
11:15:00 INFO - Running main action method: run_tests
11:15:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version']
11:15:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version
11:15:00 INFO - Python 2.7.3
11:15:00 INFO - Return code: 0
11:15:00 INFO - grabbing minidump binary from tooltool
11:15:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]}
11:15:00 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 0x276a820>, '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 0x276b520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x276b9b0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1
11:15:00 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
11:15:00 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
11:15:00 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
11:15:00 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache
11:15:00 INFO - Return code: 0
11:15:00 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755
11:15:00 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir
11:15:00 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir
11:15:00 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk
11:15:00 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir
11:15:00 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/1483205412/firefox-53.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-069', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build
11:15:00 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/1483205412/firefox-53.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-069 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log
11:15:00 INFO - Using env: {'DISPLAY': ':0',
11:15:00 INFO - 'HOME': '/home/cltbld',
11:15:00 INFO - 'LANG': 'en_US.UTF-8',
11:15:00 INFO - 'LANGUAGE': 'en_US:en',
11:15:00 INFO - 'LOGNAME': 'cltbld',
11:15:00 INFO - 'MAIL': '/var/mail/cltbld',
11:15:00 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir',
11:15:00 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk',
11:15:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1',
11:15:00 INFO - 'MOZ_NO_REMOTE': '1',
11:15:00 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir',
11:15:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript',
11:15:00 INFO - 'NO_EM_RESTART': '1',
11:15:00 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games',
11:15:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json',
11:15:00 INFO - 'PWD': '/builds/slave/test',
11:15:00 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos',
11:15:00 INFO - 'SHELL': '/bin/bash',
11:15:00 INFO - 'SHLVL': '1',
11:15:00 INFO - 'TERM': 'linux',
11:15:00 INFO - 'TMOUT': '86400',
11:15:00 INFO - 'USER': 'cltbld',
11:15:00 INFO - 'XDG_SESSION_COOKIE': '05b19d94dfa9f3ce7b6e62cc000001f7-1483207382.342317-102745228',
11:15:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn',
11:15:00 INFO - '_': '/tools/buildbot/bin/python'}
11:15:00 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/1483205412/firefox-53.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-069', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600
11:15:01 INFO - mozversion application_buildid: 20161231093012
11:15:01 INFO - mozversion application_changeset: fc12fe53968e08b95e47b1cbc55cd622b484b31e
11:15:01 INFO - mozversion application_display_name: Nightly
11:15:01 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384}
11:15:01 INFO - mozversion application_name: Firefox
11:15:01 INFO - mozversion application_remotingname: firefox
11:15:01 INFO - mozversion application_repository: https://hg.mozilla.org/integration/mozilla-inbound
11:15:01 INFO - mozversion application_vendor: Mozilla
11:15:01 INFO - mozversion application_version: 53.0a1
11:15:01 INFO - mozversion platform_buildid: 20161231093012
11:15:01 INFO - mozversion platform_changeset: fc12fe53968e08b95e47b1cbc55cd622b484b31e
11:15:01 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/mozilla-inbound
11:15:01 INFO - mozversion platform_version: 53.0a1
11:15:01 INFO - using testdate: 1483211701
11:15:01 INFO - actual date: 1483211701
11:15:01 INFO - starting webserver on 'localhost:37007'
11:15:01 INFO - SUITE-START | Running 2 tests
11:15:01 INFO - TEST-START | dromaeo_css
11:15:01 INFO - operating with platform_type : linux_
11:15:01 INFO - Initialising browser for dromaeo_css test...
11:15:01 INFO - TEST-INFO | started process 4533 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpOxHPLG/profile http://localhost:37007/getInfo.html)
11:15:01 INFO - PROCESS | 4533 | 1483211701515 addons.xpi WARN Exception running bootstrap method install on shield-recipe-client@mozilla.org: [Exception... "Component returned failure code: 0x8000ffff (NS_ERROR_UNEXPECTED) [nsIPrefBranch.getBoolPref]" nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/firefox/browser/features/shield-recipe-client@mozilla.org.xpi!/bootstrap.js :: this.install :: line 38" data: no] Stack trace: this.install()@resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/firefox/browser/features/shield-recipe-client@mozilla.org.xpi!/bootstrap.js:38 < callBootstrapMethod()@resource://gre/modules/addons/XPIProvider.jsm:4986 < processFileChanges()@resource://gre/modules/addons/XPIProvider.jsm -> resource://gre/modules/addons/XPIProviderUtils.js:2097 < checkForChanges()@resource://gre/modules/addons/XPIProvider.jsm:3827 < startup()@resource://gre/modules/addons/XPIProvider.jsm:2831 < callProvider()@resource://gre/modules/AddonManager.jsm:264 < _startProvider()@resource://gre/modules/AddonManager.jsm:771 < startup()@resource://gre/modules/AddonManager.jsm:957 < startup()@resource://gre/modules/AddonManager.jsm:2923 < observe()@resource://gre/components/addonManager.js:65
11:15:04 INFO - PROCESS | 4533 | __metrics Screen width/height:1600/1200
11:15:04 INFO - PROCESS | 4533 | colorDepth:24
11:15:04 INFO - PROCESS | 4533 | Browser inner width/height: 1024/697
11:15:04 INFO - PROCESS | 4533 | __metrics
11:15:05 ERROR - PROCESS | 4533 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3256: TypeError: this.tabs is undefined
11:15:06 INFO - TEST-INFO | 4533: exit 0
11:15:06 INFO - Browser initialized.
11:15:06 INFO - Running cycle 1/1 for dromaeo_css test...
11:15:06 INFO - TEST-INFO | started process 4659 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpOxHPLG/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1)
11:15:18 INFO - PROCESS | 4659 | RSS: Main: 154275840
11:15:18 INFO - PROCESS | 4659 |
11:16:07 INFO - PROCESS | 4659 | 1483211767956 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]
11:18:18 INFO - PROCESS | 4659 | Cycle 1(1): loaded http://localhost:37007/tests/dromaeo/cssquery-dojo.html (next: http://localhost:37007/tests/dromaeo/cssquery-ext.html)
11:18:19 INFO - PROCESS | 4659 | RSS: Main: 165347328
11:18:19 INFO - PROCESS | 4659 |
11:20:06 INFO - PROCESS | 4659 | *************************
11:20:06 INFO - PROCESS | 4659 | A coding exception was thrown and uncaught in a Task.
11:20:06 INFO - PROCESS | 4659 |
11:20:06 INFO - PROCESS | 4659 | Full message: ReferenceError: fetch is not defined
11:20:06 INFO - PROCESS | 4659 | Full stack: apiCall@resource://shield-recipe-client/lib/NormandyApi.jsm:37:5
11:20:06 INFO - PROCESS | 4659 | get@resource://shield-recipe-client/lib/NormandyApi.jsm:44:12
11:20:06 INFO - PROCESS | 4659 | this.NormandyApi.fetchRecipes<@resource://shield-recipe-client/lib/NormandyApi.jsm:52:34
11:20:06 INFO - PROCESS | 4659 | TaskImpl_run@resource://gre/modules/Task.jsm:319:42
11:20:06 INFO - PROCESS | 4659 | TaskImpl@resource://gre/modules/Task.jsm:277:3
11:20:06 INFO - PROCESS | 4659 | asyncFunction@resource://gre/modules/Task.jsm:252:14
11:20:06 INFO - PROCESS | 4659 | this.RecipeRunner.start<@resource://shield-recipe-client/lib/RecipeRunner.jsm:64:23
11:20:06 INFO - PROCESS | 4659 | TaskImpl_run@resource://gre/modules/Task.jsm:319:42
11:20:06 INFO - PROCESS | 4659 | TaskImpl@resource://gre/modules/Task.jsm:277:3
11:20:06 INFO - PROCESS | 4659 | asyncFunction@resource://gre/modules/Task.jsm:252:14
11:20:06 INFO - PROCESS | 4659 | setTimeout_timer@resource://gre/modules/Timer.jsm:30:5
11:20:06 INFO - PROCESS | 4659 |
11:20:06 INFO - PROCESS | 4659 | *************************
11:21:22 INFO - PROCESS | 4659 | Cycle 1(1): loaded http://localhost:37007/tests/dromaeo/cssquery-ext.html (next: http://localhost:37007/tests/dromaeo/cssquery-jquery.html)
11:21:22 INFO - PROCESS | 4659 | RSS: Main: 160997376
11:21:22 INFO - PROCESS | 4659 |
11:24:24 INFO - PROCESS | 4659 | Cycle 1(1): loaded http://localhost:37007/tests/dromaeo/cssquery-jquery.html (next: http://localhost:37007/tests/dromaeo/cssquery-mootools.html)
11:24:25 INFO - PROCESS | 4659 | RSS: Main: 165593088
11:24:25 INFO - PROCESS | 4659 |
11:27:27 INFO - PROCESS | 4659 | Cycle 1(1): loaded http://localhost:37007/tests/dromaeo/cssquery-mootools.html (next: http://localhost:37007/tests/dromaeo/cssquery-prototype.html)
11:27:27 INFO - PROCESS | 4659 | RSS: Main: 160628736
11:27:27 INFO - PROCESS | 4659 |
11:30:30 INFO - PROCESS | 4659 | Cycle 1(1): loaded http://localhost:37007/tests/dromaeo/cssquery-prototype.html (next: http://localhost:37007/tests/dromaeo/cssquery-yui.html)
11:30:31 INFO - PROCESS | 4659 | RSS: Main: 165998592
11:30:31 INFO - PROCESS | 4659 |
11:33:33 INFO - PROCESS | 4659 | Cycle 1(1): loaded http://localhost:37007/tests/dromaeo/cssquery-yui.html (next: http://localhost:37007/tests/dromaeo/cssquery-dojo.html)
11:33:33 INFO - PROCESS | 4659 | RSS: Main: 164392960
11:33:33 INFO - PROCESS | 4659 |
11:33:33 INFO - PROCESS | 4659 | __start_tp_report
11:33:33 INFO - PROCESS | 4659 | _x_x_mozilla_page_load
11:33:33 INFO - PROCESS | 4659 | _x_x_mozilla_page_load_details
11:33:33 INFO - PROCESS | 4659 | |i|pagename|runs|
11:33:33 INFO - PROCESS | 4659 | |0;dojo.html;3196.6164060312767;3203.695648913354;3220.259340351719;3233.288676491171;3255.3977514159883;5276.9208461873;5408.188771684249;5440.782368705252;5472.644278121924;5474.042042642542;5309.946900531003;5386.703731294787;5422.9728851355785;5436.864078398042;5501.449855014506;4863;4912.828051018215;4943.8516844494725;5017.573506251973;5041.067402530525;4869.902601947977;5006.824761133361;5015.0972824891505;5016.799328026875;5028.446870844205;4854.6116310695415;4941.283513890466;4997.250412438163;4998.2752500887345;5026.296318515392;4868.367112275381;4881;4895.363602731658;4929.704217746911;4982.750862456899;4877.585405240558;4881.971851962193;4892.143874821892;4912.828051018198;4926.0394223126505;5345.973270133624;5377.381601115843;5390.380106287748;5394.946050539484;5399.460053994609;5669.8582535436535;5700;5731.799387021434;5782.3350314713925;5799.101139323411;5850.64896106235;5871.3541510433815;5874.765009399619;5877.588568800185;5907.2911250650195;5359.249705041298;5422.457754224585;5434.972825135849;5435.945640543544;5436.728163591844;5808.5933984621515;5819.592628516048;5863.442972917566;5863.794767183128;5952.7023648817385;5653.038983372837;5668.9716551417805;5673.432656734293;5708;5722.399148089474;5682.374938756733;5704.22992895962;5745.454181852718;5762.567807414461;5770.798022069207;5663.773449061991;5708.286464191976;5732.254806875079;5732.656040637575;5742.052561327334;5723.027085395493;5744.913826292609;5751.568632352507;5751.827445176567;5791.391903850119;4310.159518893848;4324.935125973113;4325.870223893288;4335.436393268855;4364.454443194601;3824.521934758155;3825.254075455315;3845.673117784964;3847.1728578355787;3889.027743064234;5560.36055853582;5564.721763911788;5572.275604171432;5646.265985421951;5661.688607126647;5785.363610002896;5794.159846822272;5795.362510123883;5829.912551311733;5847.766089356463;5472.781088756485;5532.6680399176175;5535.33575970878;5613.382527921925;5617.8033768817895;4762.9523704763205;4794.520547945178;4800.66395352329;4825.565699087099;4836.854894353175;6057.939420605738;6089.025755879038;6092.634441933498;6094.329623741385;6109.48069414087;5687;5736.42635736423;5771.307443106686;5798.072308430631;5810;6009.819705408845;6083.178770865877;6096.708114890978;6100.217864923719;6103.664298463449;5652.745626446902;5717.285339332583;5722.914156287742;5730.1977723119635;5750.856228594319;5681.715914204356;5772.826815195551;5817.272840894888;5826.475617194473;5838.4453476919625;5594.188842617879;5615.466530679579;5622.522085622768;5644.774209031592;5723.656580605177;5657.094864821609;5663.32040155184;5682.77268909239;5684.77260909559;5684.8010319638615;5500.642458240201;5523.502884740393;5593.860153496195;5639.8590035249445;5655.4910058094965;5635.351934527582;5678.77284908599;5691.260136182435;5696.088625819849;5733.397993210653;5452.863678407913;5479.287692599936;5494.642848214853;5502.559795216293;5509.3664228612615
11:33:33 INFO - PROCESS | 4659 | |1;ext.html;544.2000259618361;557.8856334451441;566.6373520946597;575.2004713448307;575.9020966435708;41617;43165.56834431658;43265.99999999996;47242.291365629455;47300;44791;45093.09813803722;45373.77313113438;45408.77295613525;45455.99999999992;8899.911000890006;9014.2788576914;9025.413348132382;9039.186473217409;10145.847812282822;10085.344452610594;10401.68794936153;10405.271630985833;10464.42445665488;10467.424291663956;10486.528106235237;10547;10551.947240263826;10614.840777388345;10623.20325975551;10429.113525350354;10443.582256709722;10487.842682359771;10515.842262365994;10549.789004219872;10310.639127630571;10362;10368.32605880623;10375.948120259425;10396.376217426978;37929.81035094807;38056.048598784975;38066.80966595149;38255.808720956215;38293;4078.388241763759;4087.1417002429525;4161.646260067868;4195.223883581547;4198.223328684203;29168.708312916813;29209.41581168386;29602.851985740148;29890.252743681365;30474.238144046354;3772.6038765929457;3817.9618203817886;3824.3116239076953;3844.673202777767;3859.1702783901314;326478;328495;329092.1544022444;330608.9999999976;331036;53159.20261196085;53233.467665323624;53332;53452;53802.7309863456;54804.72597637066;55111.72444137834;55145;55353.7858485656;55518;15546.067235965878;15924.522264332089;16059.919700401424;16121;16126.113063781604;12366.505339786489;12458.75082498345;12479.750404992032;12553.686157846127;12945.352732363344;17373.47879563615;17579.73630395545;17586.560335991446;17620.9118954407;17625.118744062747;6793.660316984131;6806.251312355637;6875.5874647521305;6903.378695917391;7010.334018268256;883.960221790021;901.193431878465;913.2602591900582;918.5590916360051;940.5955439161089;29559.408811824072;30013.699863001526;30659.540106898414;31023.68976310208;31319.217019574236;994.8756405449319;1067.5996501312009;1069.502681253221;1076.5155679944057;1109.5339957217989;16042.197890105448;16300.26648800783;16407.1796410179;16416.75374869378;16637.33450661984;510579;515925;516903;517132;518102;60240;60423.39576604265;60517.394826051175;60766;60919.69540152271;1366.3646404421793;1391.2834890031643;1411.943522259098;1413.3074793351184;1415.6531649745878;29259.58697640943;30138.397232055675;30325;30813;31140.951676281937;51531.74234128955;52114;52116;52131.47868521418;52382.73808630933;434143;434798;435002;436043;438290;25076.373090672878;25584.23247302584;26983.595246071716;27803.721962780113;28088.157355279374;42287.1542569153;43775.56224437842;46271.76864115658;46352.768236158605;46919.76540117278;38847.6115238844;39024.41463377995;40073.057902379594;40470.392944106454;41115.588844111175;37920.81039594785;38192.809035955754;39239.41140882946;39343;39849.80075099606;38508.614913850506;38871.805640971616;38924;39255;39544.604553954094;33309.83345083259;35247.29505409929;35535.822320888234;35629.82185089162;35798.8210058948;26458.470830583665;26467;26773.196804095907;32529;32530
11:33:33 INFO - PROCESS | 4659 | |2;jquery.html;376.94722738816586;381.8491695780166;392.8703527835814;398.7208953732388;403.9272930872444;17112.82887171128;18465.261389544437;18640.627187456244;18699.3455229067;18977;18230.088495575234;18280.81719182811;18413.53966150847;18523.073846307663;18708.90645546774;5382.2195781611645;5415.13357862742;5588.30146231721;5605.523530499912;5618.15727640853;5415.13357862742;5554.91667624986;5557.833265002057;5568.16477528372;5570.192322113291;5410.188471729252;5492.752826122834;5505.532029777473;5516.14499752537;5531.502164805167;5524.530414914737;5597.328320601513;5601.187827764971;5610.438956104377;5616.438356164392;4980.352554167971;4995.175795993693;5034.446210916796;5036.647434679574;5044.092063428581;21565.67651485229;21777;21788.673169902304;21802;21927.12291508338;2673.8262012969094;2718.225305787841;2744.0807329544427;2746.615473833665;2749.7250274972344;9366.34435589509;9762.170215531689;9872.35829671069;9912.405255684609;14198.503052393116;1934.5260411199347;1968.6711469758;1982.33591746765;2005.46855083403;2009.1260301768777;78593.60703196448;78838.6058069706;79677;80198;81988.18011819925;10113.544890479947;10143.442110683836;10440.42577658236;11100.222984391015;11153.888461115284;14369.56891293242;14415.567532974028;14482.855171448362;14490.420383184766;14497.782533262009;7555.09338879338;7673.11759147694;7784.766457006299;7894.960525197337;7944.483608565425;7599.544027358265;7656.349210317186;7752.379809615217;7869.2130786922;7904.32813210872;4474.821007159677;4477.2164871147415;4509.526499717483;4702.31816386622;4734.130018642686;1911.8798988180492;1925.3838771592955;1957.6574099532525;1975.836459077308;1982.0684278389133;892.4779004282437;898.8943599372808;902.2826852652157;912.3157631776168;946.8532377481501;16740.246688899028;16914.661706765797;17089.974601523947;17240.741388879178;17693;933.2160984772823;941.1999800169938;948.1419315519466;948.7390967483859;966.6520052780993;9645.71062868115;9886.555105020292;9946.850797238047;10019.599216031276;10064.798704025878;429027;436455;442793;453762;455280;80355;80482.5975870117;81066.10938070212;83764;84497;1035.4253389368973;1042.6819819954835;1050.4642632257603;1053.6259627832162;1060.9628662996913;15461.458848940232;15540.922295388451;15654.9217253913;15734.9213253933;15841.762373564176;39309.2138157241;39369.65492494431;39749.80750577487;39758.80120599378;40074.19851602893;53438;53478;53896.19155712589;53898.461015390916;54054.189187161435;7740.535567865946;7930.365570754441;8165.469244499089;8298.543580103153;8502.659893604186;10330.48347582633;11958.282503049844;12441.502339906303;12569.336311581808;12790.232586044867;10695.572177112828;10956.945215274192;11220.1023918088;11512.424378781196;11617.6514704559;10673.35959842412;10698.62554810578;10768.300060496356;10871.347719136877;10951.397673128055;10623.309484883457;10686.786264274826;10768.730781730519;11263.605773797877;11313.773724525628;7800.45396822217;7853.8036549084445;7890.132085470708;7969.880451793344;8234.094249632655;8661.91338086611;10718.571257149626;11154.330740155616;11160.995510404102;11500.424978751196
11:33:33 INFO - PROCESS | 4659 | |3;mootools.html;1347.9056466047375;1366.7334869700405;1376.428782055447;1380.4685196199466;1381.1367895065584;7527.811804704885;7756.806079848006;7959.72140975066;8463.238308552229;8503.447275927068;7617.885731714029;7849.215078492162;7867.095284042337;7929.563873986928;7947.324477419412;2322.1756276521887;2366.1363602285214;2375.03810956562;2375.3349062262596;2376.275236053003;2307.676925230469;2332.9883350583223;2383.594788885885;2390.7489713580085;2403.2189538400003;2309.8383113182085;2334.8365614407;2337.7545357737363;2338.7661233876647;2343.871087090209;2286.0741399733133;2288.2105673542683;2297.873616951067;2299.724033116037;2307.849989750661;2266.218154736613;2284.6001949658744;2336.976630233693;2337.742848286704;2356.3873392917794;7971.322437592811;8040.798980025487;8048.034235891672;8235.588220588947;8357.623906924204;5175.715335656538;5274.024305503494;5303.204519322094;5313.123334649778;5333.2000199969925;3412.4028295048265;3579.7315201359743;3617.5297211362617;3696.5194524711883;3738.2710371477574;1368.753624347617;1425.1662777275305;1428.614274145985;1460.4888289098838;1506.947256846005;10868.67393978182;10969.670909872717;11020.44897755109;11040.503177357119;11048.613298534512;4223.450951376301;4452.5992660660695;4485.102979404132;4528.049109687003;4546.249868771615;8803.515806630568;8829.60266787996;8844.248238899765;8861.158189971942;8861.867071993925;5020.899582008413;5090.0583392072585;5094.337736094284;5097.08252514551;5132.897342053138;4780.709208513751;4822.397200349957;4835.685680430761;4848.878778030577;4905.9264111038365;3550.3076900004767;3621.94567081494;3646;3660;3692.3722967095123;1102.2174256278133;1138.7950168969664;1180.7697498987786;1180.7756526259984;1224.155332820351;921.7925966657582;940.9153176214173;950.4772375193616;951.6621599332276;970.8737864077625;5458.699771512605;5582.86042848932;5715.142728590661;5743.511801496919;5809.564282678732;936.134075979716;953.4374718915873;954.1841725324886;955.9044095590524;963.9469829159464;3666;3778.244351129785;3779.111908701453;3826.8660596878976;3904.1020565270146;9097.363184577016;9383.343165978316;9416.435013899189;9417.858732119024;9447.149756521945;9197.632094716137;9244.537773111317;9290.767730806783;9297.442153470813;9402.200812930978;7415.073115860518;7811;7817.960910195527;7850.293473587404;7858.685652573833;5574.609777315549;5575.832725018256;5747.281589801275;5770.307563092456;5841.094630332305;9097.999220085652;9098.408603440756;9119.817603648022;9205.585748641193;9242.630294788134;8640.827183456422;8843.159899809507;8921.420107692978;9044;9057.77355566116;7230.566166030055;7283.963580182277;7350.154732205651;7373.668184931584;7466.925330746623;8101.311388532041;8142.3486121111355;8156.83686326282;8158.3473322132895;8162.306203972729;7252.601106938958;7371.078615173104;7436.73971410998;7461.552306861606;7567.735129270449;7117.82205444868;7119.181294151239;7205.279472052753;7297.270272972661;7354.374878135419;6311.431971122621;6444.709988050456;6453.41919227253;6453.741850326122;6455;4742.719465744299;4791.377120974251;4923.163062279349;4939.160342741814;4977.153883839684;4769.594584460359;4817.445993710628;4872.634552408513;4920.21276595743;4996
11:33:33 INFO - PROCESS | 4659 | |4;prototype.html;381.36121995657265;393.45310019073486;394.26666400495077;402.9838806447742;408.46491096663357;5181.3264275644115;5282.947170528294;5348.598855085869;5388.568914486841;5411.323584551931;5252.422233554306;5339.9733001334935;5341.813036543712;5343.545798607113;5385.973070134653;4320.1575692739925;4326.935095973563;4340.457442819647;4350.499692535352;4366.1049484855685;3977.244323578511;4175.937360939588;4296.656267498608;4328.805203765838;4333.544977777336;4148.826147996785;4154.605312495323;4168.395582640515;4176.45706058212;4196.748195108304;4137;4141.5237247716595;4159.604837540429;4171;4183.330667093251;3705.277470893177;3706.388445906422;3720.6651401374006;3724.7578907371203;3745.513083299181;5081.415637201732;5174.404943431516;5180.1452760294505;5190.06578815813;5215.165573508259;4701.976490117561;4758.500357462486;4761.357216775726;4769.427668679746;4781.665283430161;5407.621466497347;5572.8234906103535;5574.442555744393;5599.720013999284;5608.635438696471;3946.3291240488898;3984.880453586397;4001.4998125234347;4021.2560676274984;4047.615476529725;5750.597458177929;5803.9396014415115;5821.708914554255;5863.472287494146;5874.706264686749;4114.5679703630685;4121.52602450722;4127.442795222667;4128.669706423479;4142.378643203544;4033.596640335943;4093;4134.986928202549;4166.291730405838;4168.270552653274;4711.939813541926;4717.575418212309;4727.810887564459;4744.312074749142;4764;5654.604177707521;5673.801416950387;5686.60193786431;5690.573207009408;5728.513076388554;1357.457017193111;1396.3018490754623;1401.1382999455261;1406.423366419763;1410.2243765928904;944.0889541592396;963.4508330251689;963.6482683820356;974.5614473486959;977.4575110813566;5235.099850611319;5270.736463176826;5289.20661900718;5324.9733751331;5338.412774594792;5499.587530935196;5517.586181036358;5539.7784088636;5549.472800083986;5617.354004289477;5156.5616922562;5248.3701955765555;5311.468853114658;5319.973400132974;5339.252504649352;2949.8672559734864;2950.9704902950693;2968.584398184256;2986.685318877887;2990.4916164251695;5864.589478736448;5873.383294754075;5891;5903.203067585821;5918.526517878559;5339.599530035263;5603.3836278009385;5647.548196144298;5655.4344565543115;5676.347220069662;5762.415335782694;5829.562782791308;5836.9124463133085;5845.444682755132;5850.678212698343;5469.945300546943;5488.1493368527945;5543.196236545759;5615.634983726045;5782.710864456676;5699.743511542073;5721.456461636138;5725.971370143123;5738.282714660668;5747.770089196552;6058.363871793398;6070.6357618543025;6082.330943596113;6103.481204097524;6110.602810817282;3920.294347017564;4076.6534844538546;4083.244599749056;4097.303458412018;4098.938515922323;5628.60599758013;5801.970990145022;5808.273965754281;5810.970945145247;5815.94184058171;5614.185943038318;5617.5505959522325;5654.784221392256;5665.263515742927;5665.3201615806365;5641.830745077655;5642.605017648725;5649.406812284651;5652.5477961762135;5676.375598684224;5371.650842695212;5565.359983601776;5589.80435684749;5697.971510142423;5715.428457154251;5632.324121105494;5633.155026745857;5673.858153546194;5679.5172410345585;5680.460356266148;5438.830651409966;5484.698341591091;5494.862628434321;5499.955008548363;5506.421825708243
11:33:33 INFO - PROCESS | 4659 | |5;yui.html;756.8297133145043;765.5062484697373;791.7743443118709;827.2967977219363;872.5070335260577;15363.615909602251;16834.66330673386;16844.57888552787;16847.32610695571;16940.576485587866;15075.396984120649;15240.542783716479;15247.771283430757;15291.847081529182;15817;783.9294463498284;801.0867610923552;818.4557269415832;819.9344052475788;827.3794654009492;811.1928631012122;816.143049797713;817.284875733733;818.443458448255;819.737683941139;854.8504011797942;860.496609483453;861.1818772166436;862.7670528957178;865.398548009134;842.1872892658583;846.2257034813139;850.9531975741331;852.9679088303161;853.9487630742175;624.6252248650818;625.7966160997694;628.2084573437456;628.6542401679059;629.512128100721;15530.378784848706;15952.840471595251;16006.439774607832;16480.83519164817;16724.331026758915;14489.927550362287;14659.486917957927;14726.48457304;14914.62713432162;14982.850171498363;11908.523659053628;11965.700857478545;12004.579839705655;12011.099167562468;12060.336681482515;3750.624937506255;3750.9497340744633;3781.8676346327748;3801.137442653108;3822.6559609635265;80715;81157.59421202916;81291;83688.58155709182;83746;10837.891621083689;10916.781664366668;10929.180311476672;10930.125589952784;11044.723881902855;21600.567988640138;21623.891880540497;21810.672839907096;21849.563008739737;21963.560728785335;7616.276453736886;7878.684852605831;7964.561949092739;8125.1062383137805;8202.712905048294;4398.098389830077;4436.689431739812;4440.489343725513;4480.820767169342;4502.752348620857;3656.945145822815;3673.3387990162028;3700.9259814803554;3743.232637309345;3750.456183853326;607.1378642327905;607.4745345276305;614.115673430268;616.5006344860677;621.7916997805786;723.6237156678498;737.325347307208;741.229121713412;762.0969151555424;783.8471498057824;9356.859647105299;9427.952860235655;9675.383093677276;10154.441505717108;10403.84394234087;711.2993701204309;728.9562626242442;738.8152961759561;746.3208480282916;750.313463181194;4509.2559727644575;4545.636349092065;4634.837780677727;4648.930266046012;4684.025643716264;77288;80426;80575;80659.19340806635;80740.5962970193;55005.44994550083;68903.3109668907;71880;73572;74953;60988;62269;64198.67900660467;66747.33252667508;66937.99999999903;8580.613872375883;8646.394752367525;8900.243479304332;9025.593848276712;9081.921045010253;45244.54755452403;45392;45783.313250300605;46339.30491042705;46618.76690616661;50928.74535627298;51157.23264151115;56746.71626641841;57932.71033644973;58387.70806145942;13138.737225255632;13264.336783160996;13273.535426260034;13393.397297121848;13558.11872228302;14962.551123466314;15134.621634459227;15262.160581168142;15329.233538323262;16323;13976.930115349358;14144.646383840487;14411.639709007359;14588.270586470422;14805;13741.931290343484;14189.929050354682;14309.35607897668;14322.355494003003;14736.48422305257;13548.254845983565;13695.178289302674;13795.241261730702;14180.787288190479;14482.493112741426;11480.311181329147;11724.70688232801;11928.940355298168;11982.70043248891;11982.820257696316;10872;11302.604408845651;11410.94294528522;11446.427678616203;11533.250338727956
11:33:33 INFO - PROCESS | 4659 | __end_tp_report
11:33:33 INFO - PROCESS | 4659 | __start_cc_report
11:33:33 INFO - PROCESS | 4659 | _x_x_mozilla_cycle_collect,313
11:33:33 INFO - PROCESS | 4659 | __end_cc_report
11:33:33 INFO - PROCESS | 4659 | __startTimestamp1483212813921__endTimestamp
11:33:33 INFO - PROCESS | 4659 |
11:33:33 INFO - PROCESS | 4659 | ------- Summary: start -------
11:33:33 INFO - PROCESS | 4659 | Number of tests: 6
11:33:33 INFO - PROCESS | 4659 |
11:33:33 INFO - PROCESS | 4659 | [#0] dojo.html Cycles:165 Average:5375.02 Median:5617.80 stddev:617.60 (11.0%) stddev-sans-first:595.38
11:33:33 INFO - PROCESS | 4659 | Values: 3196.6 3203.7 3220.3 3233.3 3255.4 5276.9 5408.2 5440.8 5472.6 5474.0 5309.9 5386.7 5423.0 5436.9 5501.4 4863.0 4912.8 4943.9 5017.6 5041.1 4869.9 5006.8 5015.1 5016.8 5028.4 4854.6 4941.3 4997.3 4998.3 5026.3 4868.4 4881.0 4895.4 4929.7 4982.8 4877.6 4882.0 4892.1 4912.8 4926.0 5346.0 5377.4 5390.4 5394.9 5399.5 5669.9 5700.0 5731.8 5782.3 5799.1 5850.6 5871.4 5874.8 5877.6 5907.3 5359.2 5422.5 5435.0 5435.9 5436.7 5808.6 5819.6 5863.4 5863.8 5952.7 5653.0 5669.0 5673.4 5708.0 5722.4 5682.4 5704.2 5745.5 5762.6 5770.8 5663.8 5708.3 5732.3 5732.7 5742.1 5723.0 5744.9 5751.6 5751.8 5791.4 4310.2 4324.9 4325.9 4335.4 4364.5 3824.5 3825.3 3845.7 3847.2 3889.0 5560.4 5564.7 5572.3 5646.3 5661.7 5785.4 5794.2 5795.4 5829.9 5847.8 5472.8 5532.7 5535.3 5613.4 5617.8 4763.0 4794.5 4800.7 4825.6 4836.9 6057.9 6089.0 6092.6 6094.3 6109.5 5687.0 5736.4 5771.3 5798.1 5810.0 6009.8 6083.2 6096.7 6100.2 6103.7 5652.7 5717.3 5722.9 5730.2 5750.9 5681.7 5772.8 5817.3 5826.5 5838.4 5594.2 5615.5 5622.5 5644.8 5723.7 5657.1 5663.3 5682.8 5684.8 5684.8 5500.6 5523.5 5593.9 5639.9 5655.5 5635.4 5678.8 5691.3 5696.1 5733.4 5452.9 5479.3 5494.6 5502.6 5509.4
11:33:33 INFO - PROCESS | 4659 |
11:33:33 INFO - PROCESS | 4659 | [#1] ext.html Cycles:180 Average:58501.69 Median:21005.39 stddev:114879.24 (546.9%) stddev-sans-first:115119.09
11:33:33 INFO - PROCESS | 4659 | Values: 544.2 557.9 566.6 575.2 575.9 41617.0 43165.6 43266.0 47242.3 47300.0 44791.0 45093.1 45373.8 45408.8 45456.0 8899.9 9014.3 9025.4 9039.2 10145.8 10085.3 10401.7 10405.3 10464.4 10467.4 10486.5 10547.0 10551.9 10614.8 10623.2 10429.1 10443.6 10487.8 10515.8 10549.8 10310.6 10362.0 10368.3 10375.9 10396.4 37929.8 38056.0 38066.8 38255.8 38293.0 4078.4 4087.1 4161.6 4195.2 4198.2 29168.7 29209.4 29602.9 29890.3 30474.2 3772.6 3818.0 3824.3 3844.7 3859.2 326478.0 328495.0 329092.2 330609.0 331036.0 53159.2 53233.5 53332.0 53452.0 53802.7 54804.7 55111.7 55145.0 55353.8 55518.0 15546.1 15924.5 16059.9 16121.0 16126.1 12366.5 12458.8 12479.8 12553.7 12945.4 17373.5 17579.7 17586.6 17620.9 17625.1 6793.7 6806.3 6875.6 6903.4 7010.3 884.0 901.2 913.3 918.6 940.6 29559.4 30013.7 30659.5 31023.7 31319.2 994.9 1067.6 1069.5 1076.5 1109.5 16042.2 16300.3 16407.2 16416.8 16637.3 510579.0 515925.0 516903.0 517132.0 518102.0 60240.0 60423.4 60517.4 60766.0 60919.7 1366.4 1391.3 1411.9 1413.3 1415.7 29259.6 30138.4 30325.0 30813.0 31141.0 51531.7 52114.0 52116.0 52131.5 52382.7 434143.0 434798.0 435002.0 436043.0 438290.0 25076.4 25584.2 26983.6 27803.7 28088.2 42287.2 43775.6 46271.8 46352.8 46919.8 38847.6 39024.4 40073.1 40470.4 41115.6 37920.8 38192.8 39239.4 39343.0 39849.8 38508.6 38871.8 38924.0 39255.0 39544.6 33309.8 35247.3 35535.8 35629.8 35798.8 26458.5 26467.0 26773.2 32529.0 32530.0
11:33:33 INFO - PROCESS | 4659 |
11:33:33 INFO - PROCESS | 4659 | [#2] jquery.html Cycles:180 Average:26793.80 Median:20239.06 stddev:73190.09 (361.6%) stddev-sans-first:73368.53
11:33:33 INFO - PROCESS | 4659 | Values: 376.9 381.8 392.9 398.7 403.9 17112.8 18465.3 18640.6 18699.3 18977.0 18230.1 18280.8 18413.5 18523.1 18708.9 5382.2 5415.1 5588.3 5605.5 5618.2 5415.1 5554.9 5557.8 5568.2 5570.2 5410.2 5492.8 5505.5 5516.1 5531.5 5524.5 5597.3 5601.2 5610.4 5616.4 4980.4 4995.2 5034.4 5036.6 5044.1 21565.7 21777.0 21788.7 21802.0 21927.1 2673.8 2718.2 2744.1 2746.6 2749.7 9366.3 9762.2 9872.4 9912.4 14198.5 1934.5 1968.7 1982.3 2005.5 2009.1 78593.6 78838.6 79677.0 80198.0 81988.2 10113.5 10143.4 10440.4 11100.2 11153.9 14369.6 14415.6 14482.9 14490.4 14497.8 7555.1 7673.1 7784.8 7895.0 7944.5 7599.5 7656.3 7752.4 7869.2 7904.3 4474.8 4477.2 4509.5 4702.3 4734.1 1911.9 1925.4 1957.7 1975.8 1982.1 892.5 898.9 902.3 912.3 946.9 16740.2 16914.7 17090.0 17240.7 17693.0 933.2 941.2 948.1 948.7 966.7 9645.7 9886.6 9946.9 10019.6 10064.8 429027.0 436455.0 442793.0 453762.0 455280.0 80355.0 80482.6 81066.1 83764.0 84497.0 1035.4 1042.7 1050.5 1053.6 1061.0 15461.5 15540.9 15654.9 15734.9 15841.8 39309.2 39369.7 39749.8 39758.8 40074.2 53438.0 53478.0 53896.2 53898.5 54054.2 7740.5 7930.4 8165.5 8298.5 8502.7 10330.5 11958.3 12441.5 12569.3 12790.2 10695.6 10956.9 11220.1 11512.4 11617.7 10673.4 10698.6 10768.3 10871.3 10951.4 10623.3 10686.8 10768.7 11263.6 11313.8 7800.5 7853.8 7890.1 7969.9 8234.1 8661.9 10718.6 11154.3 11161.0 11500.4
11:33:33 INFO - PROCESS | 4659 |
11:33:33 INFO - PROCESS | 4659 | [#3] mootools.html Cycles:180 Average:5393.90 Median:5516.65 stddev:2863.83 (51.9%) stddev-sans-first:2855.71
11:33:33 INFO - PROCESS | 4659 | Values: 1347.9 1366.7 1376.4 1380.5 1381.1 7527.8 7756.8 7959.7 8463.2 8503.4 7617.9 7849.2 7867.1 7929.6 7947.3 2322.2 2366.1 2375.0 2375.3 2376.3 2307.7 2333.0 2383.6 2390.7 2403.2 2309.8 2334.8 2337.8 2338.8 2343.9 2286.1 2288.2 2297.9 2299.7 2307.8 2266.2 2284.6 2337.0 2337.7 2356.4 7971.3 8040.8 8048.0 8235.6 8357.6 5175.7 5274.0 5303.2 5313.1 5333.2 3412.4 3579.7 3617.5 3696.5 3738.3 1368.8 1425.2 1428.6 1460.5 1506.9 10868.7 10969.7 11020.4 11040.5 11048.6 4223.5 4452.6 4485.1 4528.0 4546.2 8803.5 8829.6 8844.2 8861.2 8861.9 5020.9 5090.1 5094.3 5097.1 5132.9 4780.7 4822.4 4835.7 4848.9 4905.9 3550.3 3621.9 3646.0 3660.0 3692.4 1102.2 1138.8 1180.8 1180.8 1224.2 921.8 940.9 950.5 951.7 970.9 5458.7 5582.9 5715.1 5743.5 5809.6 936.1 953.4 954.2 955.9 963.9 3666.0 3778.2 3779.1 3826.9 3904.1 9097.4 9383.3 9416.4 9417.9 9447.1 9197.6 9244.5 9290.8 9297.4 9402.2 7415.1 7811.0 7818.0 7850.3 7858.7 5574.6 5575.8 5747.3 5770.3 5841.1 9098.0 9098.4 9119.8 9205.6 9242.6 8640.8 8843.2 8921.4 9044.0 9057.8 7230.6 7284.0 7350.2 7373.7 7466.9 8101.3 8142.3 8156.8 8158.3 8162.3 7252.6 7371.1 7436.7 7461.6 7567.7 7117.8 7119.2 7205.3 7297.3 7354.4 6311.4 6444.7 6453.4 6453.7 6455.0 4742.7 4791.4 4923.2 4939.2 4977.2 4769.6 4817.4 4872.6 4920.2 4996.0
11:33:33 INFO - PROCESS | 4659 |
11:33:33 INFO - PROCESS | 4659 | [#4] prototype.html Cycles:180 Average:4711.55 Median:5342.68 stddev:1376.37 (25.8%) stddev-sans-first:1341.31
11:33:33 INFO - PROCESS | 4659 | Values: 381.4 393.5 394.3 403.0 408.5 5181.3 5282.9 5348.6 5388.6 5411.3 5252.4 5340.0 5341.8 5343.5 5386.0 4320.2 4326.9 4340.5 4350.5 4366.1 3977.2 4175.9 4296.7 4328.8 4333.5 4148.8 4154.6 4168.4 4176.5 4196.7 4137.0 4141.5 4159.6 4171.0 4183.3 3705.3 3706.4 3720.7 3724.8 3745.5 5081.4 5174.4 5180.1 5190.1 5215.2 4702.0 4758.5 4761.4 4769.4 4781.7 5407.6 5572.8 5574.4 5599.7 5608.6 3946.3 3984.9 4001.5 4021.3 4047.6 5750.6 5803.9 5821.7 5863.5 5874.7 4114.6 4121.5 4127.4 4128.7 4142.4 4033.6 4093.0 4135.0 4166.3 4168.3 4711.9 4717.6 4727.8 4744.3 4764.0 5654.6 5673.8 5686.6 5690.6 5728.5 1357.5 1396.3 1401.1 1406.4 1410.2 944.1 963.5 963.6 974.6 977.5 5235.1 5270.7 5289.2 5325.0 5338.4 5499.6 5517.6 5539.8 5549.5 5617.4 5156.6 5248.4 5311.5 5320.0 5339.3 2949.9 2951.0 2968.6 2986.7 2990.5 5864.6 5873.4 5891.0 5903.2 5918.5 5339.6 5603.4 5647.5 5655.4 5676.3 5762.4 5829.6 5836.9 5845.4 5850.7 5469.9 5488.1 5543.2 5615.6 5782.7 5699.7 5721.5 5726.0 5738.3 5747.8 6058.4 6070.6 6082.3 6103.5 6110.6 3920.3 4076.7 4083.2 4097.3 4098.9 5628.6 5802.0 5808.3 5811.0 5815.9 5614.2 5617.6 5654.8 5665.3 5665.3 5641.8 5642.6 5649.4 5652.5 5676.4 5371.7 5565.4 5589.8 5698.0 5715.4 5632.3 5633.2 5673.9 5679.5 5680.5 5438.8 5484.7 5494.9 5500.0 5506.4
11:33:33 INFO - PROCESS | 4659 |
11:33:33 INFO - PROCESS | 4659 | [#5] yui.html Cycles:180 Average:18000.08 Median:25164.47 stddev:22957.26 (91.2%) stddev-sans-first:22985.15
11:33:33 INFO - PROCESS | 4659 | Values: 756.8 765.5 791.8 827.3 872.5 15363.6 16834.7 16844.6 16847.3 16940.6 15075.4 15240.5 15247.8 15291.8 15817.0 783.9 801.1 818.5 819.9 827.4 811.2 816.1 817.3 818.4 819.7 854.9 860.5 861.2 862.8 865.4 842.2 846.2 851.0 853.0 853.9 624.6 625.8 628.2 628.7 629.5 15530.4 15952.8 16006.4 16480.8 16724.3 14489.9 14659.5 14726.5 14914.6 14982.9 11908.5 11965.7 12004.6 12011.1 12060.3 3750.6 3750.9 3781.9 3801.1 3822.7 80715.0 81157.6 81291.0 83688.6 83746.0 10837.9 10916.8 10929.2 10930.1 11044.7 21600.6 21623.9 21810.7 21849.6 21963.6 7616.3 7878.7 7964.6 8125.1 8202.7 4398.1 4436.7 4440.5 4480.8 4502.8 3656.9 3673.3 3700.9 3743.2 3750.5 607.1 607.5 614.1 616.5 621.8 723.6 737.3 741.2 762.1 783.8 9356.9 9428.0 9675.4 10154.4 10403.8 711.3 729.0 738.8 746.3 750.3 4509.3 4545.6 4634.8 4648.9 4684.0 77288.0 80426.0 80575.0 80659.2 80740.6 55005.4 68903.3 71880.0 73572.0 74953.0 60988.0 62269.0 64198.7 66747.3 66938.0 8580.6 8646.4 8900.2 9025.6 9081.9 45244.5 45392.0 45783.3 46339.3 46618.8 50928.7 51157.2 56746.7 57932.7 58387.7 13138.7 13264.3 13273.5 13393.4 13558.1 14962.6 15134.6 15262.2 15329.2 16323.0 13976.9 14144.6 14411.6 14588.3 14805.0 13741.9 14189.9 14309.4 14322.4 14736.5 13548.3 13695.2 13795.2 14180.8 14482.5 11480.3 11724.7 11928.9 11982.7 11982.8 10872.0 11302.6 11410.9 11446.4 11533.3
11:33:33 INFO - PROCESS | 4659 | -------- Summary: end --------
11:33:33 INFO - PROCESS | 4659 |
11:33:34 INFO - TEST-INFO | 4659: exit 0
11:33:34 INFO - TEST-OK | dromaeo_css | took 1113653ms
11:33:34 INFO - TEST-START | kraken
11:33:34 INFO - operating with platform_type : linux_
11:33:34 INFO - Initialising browser for kraken test...
11:33:34 INFO - TEST-INFO | started process 5020 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpz6wuOs/profile http://localhost:37007/getInfo.html)
11:33:35 INFO - PROCESS | 5020 | 1483212815144 addons.xpi WARN Exception running bootstrap method install on shield-recipe-client@mozilla.org: [Exception... "Component returned failure code: 0x8000ffff (NS_ERROR_UNEXPECTED) [nsIPrefBranch.getBoolPref]" nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/firefox/browser/features/shield-recipe-client@mozilla.org.xpi!/bootstrap.js :: this.install :: line 38" data: no] Stack trace: this.install()@resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/firefox/browser/features/shield-recipe-client@mozilla.org.xpi!/bootstrap.js:38 < callBootstrapMethod()@resource://gre/modules/addons/XPIProvider.jsm:4986 < processFileChanges()@resource://gre/modules/addons/XPIProvider.jsm -> resource://gre/modules/addons/XPIProviderUtils.js:2097 < checkForChanges()@resource://gre/modules/addons/XPIProvider.jsm:3827 < startup()@resource://gre/modules/addons/XPIProvider.jsm:2831 < callProvider()@resource://gre/modules/AddonManager.jsm:264 < _startProvider()@resource://gre/modules/AddonManager.jsm:771 < startup()@resource://gre/modules/AddonManager.jsm:957 < startup()@resource://gre/modules/AddonManager.jsm:2923 < observe()@resource://gre/components/addonManager.js:65
11:33:38 INFO - PROCESS | 5020 | __metrics Screen width/height:1600/1200
11:33:38 INFO - PROCESS | 5020 | colorDepth:24
11:33:38 INFO - PROCESS | 5020 | Browser inner width/height: 1024/697
11:33:38 INFO - PROCESS | 5020 | __metrics
11:33:39 ERROR - PROCESS | 5020 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3256: TypeError: this.tabs is undefined
11:33:40 INFO - TEST-INFO | 5020: exit 0
11:33:40 INFO - Browser initialized.
11:33:40 INFO - Running cycle 1/1 for kraken test...
11:33:40 INFO - TEST-INFO | started process 5146 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpz6wuOs/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1)
11:33:52 INFO - PROCESS | 5146 | RSS: Main: 154255360
11:33:52 INFO - PROCESS | 5146 |
11:33:54 INFO - PROCESS | 5146 | Cycle 1(1): loaded http://localhost:37007/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:37007/tests/kraken/driver.html?testName=audio-beat-detection)
11:33:55 INFO - PROCESS | 5146 | RSS: Main: 160739328
11:33:55 INFO - PROCESS | 5146 |
11:33:58 INFO - PROCESS | 5146 | Cycle 1(1): loaded http://localhost:37007/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:37007/tests/kraken/driver.html?testName=audio-dft)
11:33:58 INFO - PROCESS | 5146 | RSS: Main: 159670272
11:33:58 INFO - PROCESS | 5146 |
11:34:01 INFO - PROCESS | 5146 | Cycle 1(1): loaded http://localhost:37007/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:37007/tests/kraken/driver.html?testName=audio-fft)
11:34:02 INFO - PROCESS | 5146 | RSS: Main: 156446720
11:34:02 INFO - PROCESS | 5146 |
11:34:04 INFO - PROCESS | 5146 | Cycle 1(1): loaded http://localhost:37007/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:37007/tests/kraken/driver.html?testName=audio-oscillator)
11:34:05 INFO - PROCESS | 5146 | RSS: Main: 156819456
11:34:05 INFO - PROCESS | 5146 |
11:34:07 INFO - PROCESS | 5146 | Cycle 1(1): loaded http://localhost:37007/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:37007/tests/kraken/driver.html?testName=imaging-gaussian-blur)
11:34:07 INFO - PROCESS | 5146 | RSS: Main: 157696000
11:34:07 INFO - PROCESS | 5146 |
11:34:10 INFO - PROCESS | 5146 | Cycle 1(1): loaded http://localhost:37007/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:37007/tests/kraken/driver.html?testName=imaging-darkroom)
11:34:11 INFO - PROCESS | 5146 | RSS: Main: 161206272
11:34:11 INFO - PROCESS | 5146 |
11:34:14 INFO - PROCESS | 5146 | Cycle 1(1): loaded http://localhost:37007/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:37007/tests/kraken/driver.html?testName=imaging-desaturate)
11:34:15 INFO - PROCESS | 5146 | RSS: Main: 159256576
11:34:15 INFO - PROCESS | 5146 |
11:34:18 INFO - PROCESS | 5146 | Cycle 1(1): loaded http://localhost:37007/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:37007/tests/kraken/driver.html?testName=json-parse-financial)
11:34:19 INFO - PROCESS | 5146 | RSS: Main: 159412224
11:34:19 INFO - PROCESS | 5146 |
11:34:20 INFO - PROCESS | 5146 | Cycle 1(1): loaded http://localhost:37007/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:37007/tests/kraken/driver.html?testName=json-stringify-tinderbox)
11:34:21 INFO - PROCESS | 5146 | RSS: Main: 158896128
11:34:21 INFO - PROCESS | 5146 |
11:34:23 INFO - PROCESS | 5146 | Cycle 1(1): loaded http://localhost:37007/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:37007/tests/kraken/driver.html?testName=stanford-crypto-aes)
11:34:23 INFO - PROCESS | 5146 | RSS: Main: 160083968
11:34:23 INFO - PROCESS | 5146 |
11:34:25 INFO - PROCESS | 5146 | Cycle 1(1): loaded http://localhost:37007/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:37007/tests/kraken/driver.html?testName=stanford-crypto-ccm)
11:34:26 INFO - PROCESS | 5146 | RSS: Main: 160333824
11:34:26 INFO - PROCESS | 5146 |
11:34:29 INFO - PROCESS | 5146 | Cycle 1(1): loaded http://localhost:37007/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:37007/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2)
11:34:29 INFO - PROCESS | 5146 | RSS: Main: 160198656
11:34:29 INFO - PROCESS | 5146 |
11:34:32 INFO - PROCESS | 5146 | Cycle 1(1): loaded http://localhost:37007/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:37007/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative)
11:34:33 INFO - PROCESS | 5146 | RSS: Main: 160190464
11:34:33 INFO - PROCESS | 5146 |
11:34:34 INFO - PROCESS | 5146 | Cycle 1(1): loaded http://localhost:37007/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:37007/tests/kraken/driver.html?testName=ai-astar)
11:34:35 INFO - PROCESS | 5146 | RSS: Main: 162500608
11:34:35 INFO - PROCESS | 5146 |
11:34:35 INFO - PROCESS | 5146 | __start_tp_report
11:34:35 INFO - PROCESS | 5146 | _x_x_mozilla_page_load
11:34:35 INFO - PROCESS | 5146 | _x_x_mozilla_page_load_details
11:34:35 INFO - PROCESS | 5146 | |i|pagename|runs|
11:34:35 INFO - PROCESS | 5146 | |0;ai-astar;105;113;112;112;111;112;113;112;111;112
11:34:35 INFO - PROCESS | 5146 | |1;audio-beat-detection;153;122;122;174;125;123;123;126;141;125
11:34:35 INFO - PROCESS | 5146 | |2;audio-dft;164;166;167;161;166;168;166;163;163;161
11:34:35 INFO - PROCESS | 5146 | |3;audio-fft;76;76;77;113;78;79;75;75;98;75
11:34:35 INFO - PROCESS | 5146 | |4;audio-oscillator;83;83;114;84;88;84;98;85;89;107
11:34:35 INFO - PROCESS | 5146 | |5;imaging-gaussian-blur;122;118;118;117;117;118;117;117;117;120
11:34:35 INFO - PROCESS | 5146 | |6;imaging-darkroom;150;149;147;148;149;148;148;148;147;149
11:34:35 INFO - PROCESS | 5146 | |7;imaging-desaturate;101;97;96;97;96;96;96;97;96;96
11:34:35 INFO - PROCESS | 5146 | |8;json-parse-financial;56;58;55;56;62;57;59;60;57;59
11:34:35 INFO - PROCESS | 5146 | |9;json-stringify-tinderbox;68;70;74;69;70;69;69;69;68;69
11:34:35 INFO - PROCESS | 5146 | |10;stanford-crypto-aes;82;82;81;84;81;83;81;91;93;87
11:34:35 INFO - PROCESS | 5146 | |11;stanford-crypto-ccm;141;138;133;125;124;130;129;126;174;131
11:34:35 INFO - PROCESS | 5146 | |12;stanford-crypto-pbkdf2;166;167;168;167;179;167;174;165;166;176
11:34:35 INFO - PROCESS | 5146 | |13;stanford-crypto-sha256-iterative;63;65;69;64;62;66;62;65;64;63
11:34:35 INFO - PROCESS | 5146 | __end_tp_report
11:34:35 INFO - PROCESS | 5146 | __start_cc_report
11:34:35 INFO - PROCESS | 5146 | _x_x_mozilla_cycle_collect,735
11:34:35 INFO - PROCESS | 5146 | __end_cc_report
11:34:35 INFO - PROCESS | 5146 | __startTimestamp1483212875242__endTimestamp
11:34:35 INFO - PROCESS | 5146 |
11:34:35 INFO - PROCESS | 5146 | ------- Summary: start -------
11:34:35 INFO - PROCESS | 5146 | Number of tests: 14
11:34:35 INFO - PROCESS | 5146 |
11:34:35 INFO - PROCESS | 5146 | [#0] ai-astar Cycles:10 Average:111.30 Median:112.00 stddev:2.31 (2.1%) stddev-sans-first:0.71
11:34:35 INFO - PROCESS | 5146 | Values: 105.0 113.0 112.0 112.0 111.0 112.0 113.0 112.0 111.0 112.0
11:34:35 INFO - PROCESS | 5146 |
11:34:35 INFO - PROCESS | 5146 | [#1] audio-beat-detection Cycles:10 Average:133.40 Median:125.50 stddev:17.52 (14.0%) stddev-sans-first:17.09
11:34:35 INFO - PROCESS | 5146 | Values: 153.0 122.0 122.0 174.0 125.0 123.0 123.0 126.0 141.0 125.0
11:34:35 INFO - PROCESS | 5146 |
11:34:35 INFO - PROCESS | 5146 | [#2] audio-dft Cycles:10 Average:164.50 Median:166.00 stddev:2.46 (1.5%) stddev-sans-first:2.60
11:34:35 INFO - PROCESS | 5146 | Values: 164.0 166.0 167.0 161.0 166.0 168.0 166.0 163.0 163.0 161.0
11:34:35 INFO - PROCESS | 5146 |
11:34:35 INFO - PROCESS | 5146 | [#3] audio-fft Cycles:10 Average:82.20 Median:76.50 stddev:12.85 (16.8%) stddev-sans-first:13.43
11:34:35 INFO - PROCESS | 5146 | Values: 76.0 76.0 77.0 113.0 78.0 79.0 75.0 75.0 98.0 75.0
11:34:35 INFO - PROCESS | 5146 |
11:34:35 INFO - PROCESS | 5146 | [#4] audio-oscillator Cycles:10 Average:91.50 Median:84.50 stddev:11.09 (13.1%) stddev-sans-first:11.33
11:34:35 INFO - PROCESS | 5146 | Values: 83.0 83.0 114.0 84.0 88.0 84.0 98.0 85.0 89.0 107.0
11:34:35 INFO - PROCESS | 5146 |
11:34:35 INFO - PROCESS | 5146 | [#5] imaging-gaussian-blur Cycles:10 Average:118.10 Median:118.00 stddev:1.66 (1.4%) stddev-sans-first:1.00
11:34:35 INFO - PROCESS | 5146 | Values: 122.0 118.0 118.0 117.0 117.0 118.0 117.0 117.0 117.0 120.0
11:34:35 INFO - PROCESS | 5146 |
11:34:35 INFO - PROCESS | 5146 | [#6] imaging-darkroom Cycles:10 Average:148.30 Median:148.50 stddev:0.95 (0.6%) stddev-sans-first:0.78
11:34:35 INFO - PROCESS | 5146 | Values: 150.0 149.0 147.0 148.0 149.0 148.0 148.0 148.0 147.0 149.0
11:34:35 INFO - PROCESS | 5146 |
11:34:35 INFO - PROCESS | 5146 | [#7] imaging-desaturate Cycles:10 Average:96.80 Median:96.00 stddev:1.55 (1.6%) stddev-sans-first:0.50
11:34:35 INFO - PROCESS | 5146 | Values: 101.0 97.0 96.0 97.0 96.0 96.0 96.0 97.0 96.0 96.0
11:34:35 INFO - PROCESS | 5146 |
11:34:35 INFO - PROCESS | 5146 | [#8] json-parse-financial Cycles:10 Average:57.90 Median:58.50 stddev:2.13 (3.6%) stddev-sans-first:2.15
11:34:35 INFO - PROCESS | 5146 | Values: 56.0 58.0 55.0 56.0 62.0 57.0 59.0 60.0 57.0 59.0
11:34:35 INFO - PROCESS | 5146 |
11:34:35 INFO - PROCESS | 5146 | [#9] json-stringify-tinderbox Cycles:10 Average:69.50 Median:69.00 stddev:1.72 (2.5%) stddev-sans-first:1.73
11:34:35 INFO - PROCESS | 5146 | Values: 68.0 70.0 74.0 69.0 70.0 69.0 69.0 69.0 68.0 69.0
11:34:35 INFO - PROCESS | 5146 |
11:34:35 INFO - PROCESS | 5146 | [#10] stanford-crypto-aes Cycles:10 Average:84.50 Median:83.50 stddev:4.38 (5.2%) stddev-sans-first:4.55
11:34:35 INFO - PROCESS | 5146 | Values: 82.0 82.0 81.0 84.0 81.0 83.0 81.0 91.0 93.0 87.0
11:34:35 INFO - PROCESS | 5146 |
11:34:35 INFO - PROCESS | 5146 | [#11] stanford-crypto-ccm Cycles:10 Average:135.10 Median:132.00 stddev:14.72 (11.1%) stddev-sans-first:15.45
11:34:35 INFO - PROCESS | 5146 | Values: 141.0 138.0 133.0 125.0 124.0 130.0 129.0 126.0 174.0 131.0
11:34:35 INFO - PROCESS | 5146 |
11:34:35 INFO - PROCESS | 5146 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:169.50 Median:167.50 stddev:4.93 (2.9%) stddev-sans-first:5.06
11:34:35 INFO - PROCESS | 5146 | Values: 166.0 167.0 168.0 167.0 179.0 167.0 174.0 165.0 166.0 176.0
11:34:35 INFO - PROCESS | 5146 |
11:34:35 INFO - PROCESS | 5146 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:64.30 Median:64.50 stddev:2.11 (3.3%) stddev-sans-first:2.19
11:34:35 INFO - PROCESS | 5146 | Values: 63.0 65.0 69.0 64.0 62.0 66.0 62.0 65.0 64.0 63.0
11:34:35 INFO - PROCESS | 5146 | -------- Summary: end --------
11:34:35 INFO - PROCESS | 5146 |
11:34:36 INFO - TEST-INFO | 5146: exit 0
11:34:36 INFO - TEST-OK | kraken | took 61567ms
11:34:36 INFO - SUITE-END | took 1175s
11:34:36 INFO - Completed test suite (00:19:35)
11:34:36 INFO - javascript benchmark
11:34:36 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7123.0675087760255, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3196.6164060312767, 3203.695648913354, 3220.259340351719, 3233.288676491171, 3255.3977514159883, 5276.9208461873, 5408.188771684249, 5440.782368705252, 5472.644278121924, 5474.042042642542, 5309.946900531003, 5386.703731294787, 5422.9728851355785, 5436.864078398042, 5501.449855014506, 4863.0, 4912.828051018215, 4943.8516844494725, 5017.573506251973, 5041.067402530525, 4869.902601947977, 5006.824761133361, 5015.0972824891505, 5016.799328026875, 5028.446870844205, 4854.6116310695415, 4941.283513890466, 4997.250412438163, 4998.2752500887345, 5026.296318515392, 4868.367112275381, 4881.0, 4895.363602731658, 4929.704217746911, 4982.750862456899, 4877.585405240558, 4881.971851962193, 4892.143874821892, 4912.828051018198, 4926.0394223126505, 5345.973270133624, 5377.381601115843, 5390.380106287748, 5394.946050539484, 5399.460053994609, 5669.8582535436535, 5700.0, 5731.799387021434, 5782.3350314713925, 5799.101139323411, 5850.64896106235, 5871.3541510433815, 5874.765009399619, 5877.588568800185, 5907.2911250650195, 5359.249705041298, 5422.457754224585, 5434.972825135849, 5435.945640543544, 5436.728163591844, 5808.5933984621515, 5819.592628516048, 5863.442972917566, 5863.794767183128, 5952.7023648817385, 5653.038983372837, 5668.9716551417805, 5673.432656734293, 5708.0, 5722.399148089474, 5682.374938756733, 5704.22992895962, 5745.454181852718, 5762.567807414461, 5770.798022069207, 5663.773449061991, 5708.286464191976, 5732.254806875079, 5732.656040637575, 5742.052561327334, 5723.027085395493, 5744.913826292609, 5751.568632352507, 5751.827445176567, 5791.391903850119, 4310.159518893848, 4324.935125973113, 4325.870223893288, 4335.436393268855, 4364.454443194601, 3824.521934758155, 3825.254075455315, 3845.673117784964, 3847.1728578355787, 3889.027743064234, 5560.36055853582, 5564.721763911788, 5572.275604171432, 5646.265985421951, 5661.688607126647, 5785.363610002896, 5794.159846822272, 5795.362510123883, 5829.912551311733, 5847.766089356463, 5472.781088756485, 5532.6680399176175, 5535.33575970878, 5613.382527921925, 5617.8033768817895, 4762.9523704763205, 4794.520547945178, 4800.66395352329, 4825.565699087099, 4836.854894353175, 6057.939420605738, 6089.025755879038, 6092.634441933498, 6094.329623741385, 6109.48069414087, 5687.0, 5736.42635736423, 5771.307443106686, 5798.072308430631, 5810.0, 6009.819705408845, 6083.178770865877, 6096.708114890978, 6100.217864923719, 6103.664298463449, 5652.745626446902, 5717.285339332583, 5722.914156287742, 5730.1977723119635, 5750.856228594319, 5681.715914204356, 5772.826815195551, 5817.272840894888, 5826.475617194473, 5838.4453476919625, 5594.188842617879, 5615.466530679579, 5622.522085622768, 5644.774209031592, 5723.656580605177, 5657.094864821609, 5663.32040155184, 5682.77268909239, 5684.77260909559, 5684.8010319638615, 5500.642458240201, 5523.502884740393, 5593.860153496195, 5639.8590035249445, 5655.4910058094965, 5635.351934527582, 5678.77284908599, 5691.260136182435, 5696.088625819849, 5733.397993210653, 5452.863678407913, 5479.287692599936, 5494.642848214853, 5502.559795216293, 5509.3664228612615], "value": 5333.24413859996, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [544.2000259618361, 557.8856334451441, 566.6373520946597, 575.2004713448307, 575.9020966435708, 41617.0, 43165.56834431658, 43265.99999999996, 47242.291365629455, 47300.0, 44791.0, 45093.09813803722, 45373.77313113438, 45408.77295613525, 45455.99999999992, 8899.911000890006, 9014.2788576914, 9025.413348132382, 9039.186473217409, 10145.847812282822, 10085.344452610594, 10401.68794936153, 10405.271630985833, 10464.42445665488, 10467.424291663956, 10486.528106235237, 10547.0, 10551.947240263826, 10614.840777388345, 10623.20325975551, 10429.113525350354, 10443.582256709722, 10487.842682359771, 10515.842262365994, 10549.789004219872, 10310.639127630571, 10362.0, 10368.32605880623, 10375.948120259425, 10396.376217426978, 37929.81035094807, 38056.048598784975, 38066.80966595149, 38255.808720956215, 38293.0, 4078.388241763759, 4087.1417002429525, 4161.646260067868, 4195.223883581547, 4198.223328684203, 29168.708312916813, 29209.41581168386, 29602.851985740148, 29890.252743681365, 30474.238144046354, 3772.6038765929457, 3817.9618203817886, 3824.3116239076953, 3844.673202777767, 3859.1702783901314, 326478.0, 328495.0, 329092.1544022444, 330608.9999999976, 331036.0, 53159.20261196085, 53233.467665323624, 53332.0, 53452.0, 53802.7309863456, 54804.72597637066, 55111.72444137834, 55145.0, 55353.7858485656, 55518.0, 15546.067235965878, 15924.522264332089, 16059.919700401424, 16121.0, 16126.113063781604, 12366.505339786489, 12458.75082498345, 12479.750404992032, 12553.686157846127, 12945.352732363344, 17373.47879563615, 17579.73630395545, 17586.560335991446, 17620.9118954407, 17625.118744062747, 6793.660316984131, 6806.251312355637, 6875.5874647521305, 6903.378695917391, 7010.334018268256, 883.960221790021, 901.193431878465, 913.2602591900582, 918.5590916360051, 940.5955439161089, 29559.408811824072, 30013.699863001526, 30659.540106898414, 31023.68976310208, 31319.217019574236, 994.8756405449319, 1067.5996501312009, 1069.502681253221, 1076.5155679944057, 1109.5339957217989, 16042.197890105448, 16300.26648800783, 16407.1796410179, 16416.75374869378, 16637.33450661984, 510579.0, 515925.0, 516903.0, 517132.0, 518102.0, 60240.0, 60423.39576604265, 60517.394826051175, 60766.0, 60919.69540152271, 1366.3646404421793, 1391.2834890031643, 1411.943522259098, 1413.3074793351184, 1415.6531649745878, 29259.58697640943, 30138.397232055675, 30325.0, 30813.0, 31140.951676281937, 51531.74234128955, 52114.0, 52116.0, 52131.47868521418, 52382.73808630933, 434143.0, 434798.0, 435002.0, 436043.0, 438290.0, 25076.373090672878, 25584.23247302584, 26983.595246071716, 27803.721962780113, 28088.157355279374, 42287.1542569153, 43775.56224437842, 46271.76864115658, 46352.768236158605, 46919.76540117278, 38847.6115238844, 39024.41463377995, 40073.057902379594, 40470.392944106454, 41115.588844111175, 37920.81039594785, 38192.809035955754, 39239.41140882946, 39343.0, 39849.80075099606, 38508.614913850506, 38871.805640971616, 38924.0, 39255.0, 39544.604553954094, 33309.83345083259, 35247.29505409929, 35535.822320888234, 35629.82185089162, 35798.8210058948, 26458.470830583665, 26467.0, 26773.196804095907, 32529.0, 32530.0], "value": 19895.416943874738, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [376.94722738816586, 381.8491695780166, 392.8703527835814, 398.7208953732388, 403.9272930872444, 17112.82887171128, 18465.261389544437, 18640.627187456244, 18699.3455229067, 18977.0, 18230.088495575234, 18280.81719182811, 18413.53966150847, 18523.073846307663, 18708.90645546774, 5382.2195781611645, 5415.13357862742, 5588.30146231721, 5605.523530499912, 5618.15727640853, 5415.13357862742, 5554.91667624986, 5557.833265002057, 5568.16477528372, 5570.192322113291, 5410.188471729252, 5492.752826122834, 5505.532029777473, 5516.14499752537, 5531.502164805167, 5524.530414914737, 5597.328320601513, 5601.187827764971, 5610.438956104377, 5616.438356164392, 4980.352554167971, 4995.175795993693, 5034.446210916796, 5036.647434679574, 5044.092063428581, 21565.67651485229, 21777.0, 21788.673169902304, 21802.0, 21927.12291508338, 2673.8262012969094, 2718.225305787841, 2744.0807329544427, 2746.615473833665, 2749.7250274972344, 9366.34435589509, 9762.170215531689, 9872.35829671069, 9912.405255684609, 14198.503052393116, 1934.5260411199347, 1968.6711469758, 1982.33591746765, 2005.46855083403, 2009.1260301768777, 78593.60703196448, 78838.6058069706, 79677.0, 80198.0, 81988.18011819925, 10113.544890479947, 10143.442110683836, 10440.42577658236, 11100.222984391015, 11153.888461115284, 14369.56891293242, 14415.567532974028, 14482.855171448362, 14490.420383184766, 14497.782533262009, 7555.09338879338, 7673.11759147694, 7784.766457006299, 7894.960525197337, 7944.483608565425, 7599.544027358265, 7656.349210317186, 7752.379809615217, 7869.2130786922, 7904.32813210872, 4474.821007159677, 4477.2164871147415, 4509.526499717483, 4702.31816386622, 4734.130018642686, 1911.8798988180492, 1925.3838771592955, 1957.6574099532525, 1975.836459077308, 1982.0684278389133, 892.4779004282437, 898.8943599372808, 902.2826852652157, 912.3157631776168, 946.8532377481501, 16740.246688899028, 16914.661706765797, 17089.974601523947, 17240.741388879178, 17693.0, 933.2160984772823, 941.1999800169938, 948.1419315519466, 948.7390967483859, 966.6520052780993, 9645.71062868115, 9886.555105020292, 9946.850797238047, 10019.599216031276, 10064.798704025878, 429027.0, 436455.0, 442793.0, 453762.0, 455280.0, 80355.0, 80482.5975870117, 81066.10938070212, 83764.0, 84497.0, 1035.4253389368973, 1042.6819819954835, 1050.4642632257603, 1053.6259627832162, 1060.9628662996913, 15461.458848940232, 15540.922295388451, 15654.9217253913, 15734.9213253933, 15841.762373564176, 39309.2138157241, 39369.65492494431, 39749.80750577487, 39758.80120599378, 40074.19851602893, 53438.0, 53478.0, 53896.19155712589, 53898.461015390916, 54054.189187161435, 7740.535567865946, 7930.365570754441, 8165.469244499089, 8298.543580103153, 8502.659893604186, 10330.48347582633, 11958.282503049844, 12441.502339906303, 12569.336311581808, 12790.232586044867, 10695.572177112828, 10956.945215274192, 11220.1023918088, 11512.424378781196, 11617.6514704559, 10673.35959842412, 10698.62554810578, 10768.300060496356, 10871.347719136877, 10951.397673128055, 10623.309484883457, 10686.786264274826, 10768.730781730519, 11263.605773797877, 11313.773724525628, 7800.45396822217, 7853.8036549084445, 7890.132085470708, 7969.880451793344, 8234.094249632655, 8661.91338086611, 10718.571257149626, 11154.330740155616, 11160.995510404102, 11500.424978751196], "value": 8810.713112087033, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1347.9056466047375, 1366.7334869700405, 1376.428782055447, 1380.4685196199466, 1381.1367895065584, 7527.811804704885, 7756.806079848006, 7959.72140975066, 8463.238308552229, 8503.447275927068, 7617.885731714029, 7849.215078492162, 7867.095284042337, 7929.563873986928, 7947.324477419412, 2322.1756276521887, 2366.1363602285214, 2375.03810956562, 2375.3349062262596, 2376.275236053003, 2307.676925230469, 2332.9883350583223, 2383.594788885885, 2390.7489713580085, 2403.2189538400003, 2309.8383113182085, 2334.8365614407, 2337.7545357737363, 2338.7661233876647, 2343.871087090209, 2286.0741399733133, 2288.2105673542683, 2297.873616951067, 2299.724033116037, 2307.849989750661, 2266.218154736613, 2284.6001949658744, 2336.976630233693, 2337.742848286704, 2356.3873392917794, 7971.322437592811, 8040.798980025487, 8048.034235891672, 8235.588220588947, 8357.623906924204, 5175.715335656538, 5274.024305503494, 5303.204519322094, 5313.123334649778, 5333.2000199969925, 3412.4028295048265, 3579.7315201359743, 3617.5297211362617, 3696.5194524711883, 3738.2710371477574, 1368.753624347617, 1425.1662777275305, 1428.614274145985, 1460.4888289098838, 1506.947256846005, 10868.67393978182, 10969.670909872717, 11020.44897755109, 11040.503177357119, 11048.613298534512, 4223.450951376301, 4452.5992660660695, 4485.102979404132, 4528.049109687003, 4546.249868771615, 8803.515806630568, 8829.60266787996, 8844.248238899765, 8861.158189971942, 8861.867071993925, 5020.899582008413, 5090.0583392072585, 5094.337736094284, 5097.08252514551, 5132.897342053138, 4780.709208513751, 4822.397200349957, 4835.685680430761, 4848.878778030577, 4905.9264111038365, 3550.3076900004767, 3621.94567081494, 3646.0, 3660.0, 3692.3722967095123, 1102.2174256278133, 1138.7950168969664, 1180.7697498987786, 1180.7756526259984, 1224.155332820351, 921.7925966657582, 940.9153176214173, 950.4772375193616, 951.6621599332276, 970.8737864077625, 5458.699771512605, 5582.86042848932, 5715.142728590661, 5743.511801496919, 5809.564282678732, 936.134075979716, 953.4374718915873, 954.1841725324886, 955.9044095590524, 963.9469829159464, 3666.0, 3778.244351129785, 3779.111908701453, 3826.8660596878976, 3904.1020565270146, 9097.363184577016, 9383.343165978316, 9416.435013899189, 9417.858732119024, 9447.149756521945, 9197.632094716137, 9244.537773111317, 9290.767730806783, 9297.442153470813, 9402.200812930978, 7415.073115860518, 7811.0, 7817.960910195527, 7850.293473587404, 7858.685652573833, 5574.609777315549, 5575.832725018256, 5747.281589801275, 5770.307563092456, 5841.094630332305, 9097.999220085652, 9098.408603440756, 9119.817603648022, 9205.585748641193, 9242.630294788134, 8640.827183456422, 8843.159899809507, 8921.420107692978, 9044.0, 9057.77355566116, 7230.566166030055, 7283.963580182277, 7350.154732205651, 7373.668184931584, 7466.925330746623, 8101.311388532041, 8142.3486121111355, 8156.83686326282, 8158.3473322132895, 8162.306203972729, 7252.601106938958, 7371.078615173104, 7436.73971410998, 7461.552306861606, 7567.735129270449, 7117.82205444868, 7119.181294151239, 7205.279472052753, 7297.270272972661, 7354.374878135419, 6311.431971122621, 6444.709988050456, 6453.41919227253, 6453.741850326122, 6455.0, 4742.719465744299, 4791.377120974251, 4923.163062279349, 4939.160342741814, 4977.153883839684, 4769.594584460359, 4817.445993710628, 4872.634552408513, 4920.21276595743, 4996.0], "value": 4424.561742636542, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [381.36121995657265, 393.45310019073486, 394.26666400495077, 402.9838806447742, 408.46491096663357, 5181.3264275644115, 5282.947170528294, 5348.598855085869, 5388.568914486841, 5411.323584551931, 5252.422233554306, 5339.9733001334935, 5341.813036543712, 5343.545798607113, 5385.973070134653, 4320.1575692739925, 4326.935095973563, 4340.457442819647, 4350.499692535352, 4366.1049484855685, 3977.244323578511, 4175.937360939588, 4296.656267498608, 4328.805203765838, 4333.544977777336, 4148.826147996785, 4154.605312495323, 4168.395582640515, 4176.45706058212, 4196.748195108304, 4137.0, 4141.5237247716595, 4159.604837540429, 4171.0, 4183.330667093251, 3705.277470893177, 3706.388445906422, 3720.6651401374006, 3724.7578907371203, 3745.513083299181, 5081.415637201732, 5174.404943431516, 5180.1452760294505, 5190.06578815813, 5215.165573508259, 4701.976490117561, 4758.500357462486, 4761.357216775726, 4769.427668679746, 4781.665283430161, 5407.621466497347, 5572.8234906103535, 5574.442555744393, 5599.720013999284, 5608.635438696471, 3946.3291240488898, 3984.880453586397, 4001.4998125234347, 4021.2560676274984, 4047.615476529725, 5750.597458177929, 5803.9396014415115, 5821.708914554255, 5863.472287494146, 5874.706264686749, 4114.5679703630685, 4121.52602450722, 4127.442795222667, 4128.669706423479, 4142.378643203544, 4033.596640335943, 4093.0, 4134.986928202549, 4166.291730405838, 4168.270552653274, 4711.939813541926, 4717.575418212309, 4727.810887564459, 4744.312074749142, 4764.0, 5654.604177707521, 5673.801416950387, 5686.60193786431, 5690.573207009408, 5728.513076388554, 1357.457017193111, 1396.3018490754623, 1401.1382999455261, 1406.423366419763, 1410.2243765928904, 944.0889541592396, 963.4508330251689, 963.6482683820356, 974.5614473486959, 977.4575110813566, 5235.099850611319, 5270.736463176826, 5289.20661900718, 5324.9733751331, 5338.412774594792, 5499.587530935196, 5517.586181036358, 5539.7784088636, 5549.472800083986, 5617.354004289477, 5156.5616922562, 5248.3701955765555, 5311.468853114658, 5319.973400132974, 5339.252504649352, 2949.8672559734864, 2950.9704902950693, 2968.584398184256, 2986.685318877887, 2990.4916164251695, 5864.589478736448, 5873.383294754075, 5891.0, 5903.203067585821, 5918.526517878559, 5339.599530035263, 5603.3836278009385, 5647.548196144298, 5655.4344565543115, 5676.347220069662, 5762.415335782694, 5829.562782791308, 5836.9124463133085, 5845.444682755132, 5850.678212698343, 5469.945300546943, 5488.1493368527945, 5543.196236545759, 5615.634983726045, 5782.710864456676, 5699.743511542073, 5721.456461636138, 5725.971370143123, 5738.282714660668, 5747.770089196552, 6058.363871793398, 6070.6357618543025, 6082.330943596113, 6103.481204097524, 6110.602810817282, 3920.294347017564, 4076.6534844538546, 4083.244599749056, 4097.303458412018, 4098.938515922323, 5628.60599758013, 5801.970990145022, 5808.273965754281, 5810.970945145247, 5815.94184058171, 5614.185943038318, 5617.5505959522325, 5654.784221392256, 5665.263515742927, 5665.3201615806365, 5641.830745077655, 5642.605017648725, 5649.406812284651, 5652.5477961762135, 5676.375598684224, 5371.650842695212, 5565.359983601776, 5589.80435684749, 5697.971510142423, 5715.428457154251, 5632.324121105494, 5633.155026745857, 5673.858153546194, 5679.5172410345585, 5680.460356266148, 5438.830651409966, 5484.698341591091, 5494.862628434321, 5499.955008548363, 5506.421825708243], "value": 4288.258626738238, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [756.8297133145043, 765.5062484697373, 791.7743443118709, 827.2967977219363, 872.5070335260577, 15363.615909602251, 16834.66330673386, 16844.57888552787, 16847.32610695571, 16940.576485587866, 15075.396984120649, 15240.542783716479, 15247.771283430757, 15291.847081529182, 15817.0, 783.9294463498284, 801.0867610923552, 818.4557269415832, 819.9344052475788, 827.3794654009492, 811.1928631012122, 816.143049797713, 817.284875733733, 818.443458448255, 819.737683941139, 854.8504011797942, 860.496609483453, 861.1818772166436, 862.7670528957178, 865.398548009134, 842.1872892658583, 846.2257034813139, 850.9531975741331, 852.9679088303161, 853.9487630742175, 624.6252248650818, 625.7966160997694, 628.2084573437456, 628.6542401679059, 629.512128100721, 15530.378784848706, 15952.840471595251, 16006.439774607832, 16480.83519164817, 16724.331026758915, 14489.927550362287, 14659.486917957927, 14726.48457304, 14914.62713432162, 14982.850171498363, 11908.523659053628, 11965.700857478545, 12004.579839705655, 12011.099167562468, 12060.336681482515, 3750.624937506255, 3750.9497340744633, 3781.8676346327748, 3801.137442653108, 3822.6559609635265, 80715.0, 81157.59421202916, 81291.0, 83688.58155709182, 83746.0, 10837.891621083689, 10916.781664366668, 10929.180311476672, 10930.125589952784, 11044.723881902855, 21600.567988640138, 21623.891880540497, 21810.672839907096, 21849.563008739737, 21963.560728785335, 7616.276453736886, 7878.684852605831, 7964.561949092739, 8125.1062383137805, 8202.712905048294, 4398.098389830077, 4436.689431739812, 4440.489343725513, 4480.820767169342, 4502.752348620857, 3656.945145822815, 3673.3387990162028, 3700.9259814803554, 3743.232637309345, 3750.456183853326, 607.1378642327905, 607.4745345276305, 614.115673430268, 616.5006344860677, 621.7916997805786, 723.6237156678498, 737.325347307208, 741.229121713412, 762.0969151555424, 783.8471498057824, 9356.859647105299, 9427.952860235655, 9675.383093677276, 10154.441505717108, 10403.84394234087, 711.2993701204309, 728.9562626242442, 738.8152961759561, 746.3208480282916, 750.313463181194, 4509.2559727644575, 4545.636349092065, 4634.837780677727, 4648.930266046012, 4684.025643716264, 77288.0, 80426.0, 80575.0, 80659.19340806635, 80740.5962970193, 55005.44994550083, 68903.3109668907, 71880.0, 73572.0, 74953.0, 60988.0, 62269.0, 64198.67900660467, 66747.33252667508, 66937.99999999903, 8580.613872375883, 8646.394752367525, 8900.243479304332, 9025.593848276712, 9081.921045010253, 45244.54755452403, 45392.0, 45783.313250300605, 46339.30491042705, 46618.76690616661, 50928.74535627298, 51157.23264151115, 56746.71626641841, 57932.71033644973, 58387.70806145942, 13138.737225255632, 13264.336783160996, 13273.535426260034, 13393.397297121848, 13558.11872228302, 14962.551123466314, 15134.621634459227, 15262.160581168142, 15329.233538323262, 16323.0, 13976.930115349358, 14144.646383840487, 14411.639709007359, 14588.270586470422, 14805.0, 13741.931290343484, 14189.929050354682, 14309.35607897668, 14322.355494003003, 14736.48422305257, 13548.254845983565, 13695.178289302674, 13795.241261730702, 14180.787288190479, 14482.493112741426, 11480.311181329147, 11724.70688232801, 11928.940355298168, 11982.70043248891, 11982.820257696316, 10872.0, 11302.604408845651, 11410.94294528522, 11446.427678616203, 11533.250338727956], "value": 7362.925885033171, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1526.8999999999999, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [105.0, 113.0, 112.0, 112.0, 111.0, 112.0, 113.0, 112.0, 111.0, 112.0], "value": 111.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [153.0, 122.0, 122.0, 174.0, 125.0, 123.0, 123.0, 126.0, 141.0, 125.0], "value": 133.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 166.0, 167.0, 161.0, 166.0, 168.0, 166.0, 163.0, 163.0, 161.0], "value": 164.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 76.0, 77.0, 113.0, 78.0, 79.0, 75.0, 75.0, 98.0, 75.0], "value": 82.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 83.0, 114.0, 84.0, 88.0, 84.0, 98.0, 85.0, 89.0, 107.0], "value": 91.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [122.0, 118.0, 118.0, 117.0, 117.0, 118.0, 117.0, 117.0, 117.0, 120.0], "value": 118.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 149.0, 147.0, 148.0, 149.0, 148.0, 148.0, 148.0, 147.0, 149.0], "value": 148.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [101.0, 97.0, 96.0, 97.0, 96.0, 96.0, 96.0, 97.0, 96.0, 96.0], "value": 96.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 58.0, 55.0, 56.0, 62.0, 57.0, 59.0, 60.0, 57.0, 59.0], "value": 57.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 70.0, 74.0, 69.0, 70.0, 69.0, 69.0, 69.0, 68.0, 69.0], "value": 69.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 82.0, 81.0, 84.0, 81.0, 83.0, 81.0, 91.0, 93.0, 87.0], "value": 84.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [141.0, 138.0, 133.0, 125.0, 124.0, 130.0, 129.0, 126.0, 174.0, 131.0], "value": 135.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [166.0, 167.0, 168.0, 167.0, 179.0, 167.0, 174.0, 165.0, 166.0, 176.0], "value": 169.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 65.0, 69.0, 64.0, 62.0, 66.0, 62.0, 65.0, 64.0, 63.0], "value": 64.3, "unit": "score"}]}]}
11:34:36 INFO - Return code: 0
11:34:36 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json
11:34:36 ERROR - # TBPL SUCCESS #
11:34:36 INFO - Running post-action listener: _resource_record_post_action
11:34:36 INFO - [mozharness: 2016-12-31 19:34:36.573224Z] Finished run-tests step (success)
11:34:36 INFO - Running post-run listener: _resource_record_post_run
11:34:36 INFO - Total resource usage - Wall time: 1193s; CPU: 13.0%; Read bytes: 12288; Write bytes: 400195584; Read time: 568; Write time: 439828
11:34:36 INFO - TinderboxPrint: CPU usage
13.4%
11:34:36 INFO - TinderboxPrint: I/O read bytes / time
12,288 / 568
11:34:36 INFO - TinderboxPrint: I/O write bytes / time
400,195,584 / 439,828
11:34:36 INFO - TinderboxPrint: CPU idle
8,241.1 (86.6%)
11:34:36 INFO - TinderboxPrint: CPU user
1,215.3 (12.8%)
11:34:36 INFO - TinderboxPrint: Swap in / out
0 / 0
11:34:36 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 4096; Write bytes: 105385984; Read time: 300; Write time: 106180
11:34:36 INFO - run-tests - Wall time: 1176s; CPU: 13.0%; Read bytes: 4096; Write bytes: 294809600; Read time: 260; Write time: 333648
11:34:37 INFO - Running post-run listener: _upload_blobber_files
11:34:37 INFO - Blob upload gear active.
11:34:37 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir.
11:34:37 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com
11:34:37 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']
11:34:37 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
11:34:37 INFO - (blobuploader) - INFO - Open directory for files ...
11:34:37 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ...
11:34:37 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com
11:34:37 INFO - (blobuploader) - INFO - Uploading, attempt #1.
11:34:38 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded
11:34:38 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded!
11:34:38 INFO - (blobuploader) - INFO - Done attempting.
11:34:38 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ...
11:34:38 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com
11:34:38 INFO - (blobuploader) - INFO - Uploading, attempt #1.
11:34:42 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded
11:34:42 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded!
11:34:42 INFO - (blobuploader) - INFO - Done attempting.
11:34:42 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ...
11:34:42 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com
11:34:42 INFO - (blobuploader) - INFO - Uploading, attempt #1.
11:34:42 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded
11:34:42 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded!
11:34:42 INFO - (blobuploader) - INFO - Done attempting.
11:34:42 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ...
11:34:42 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com
11:34:42 INFO - (blobuploader) - INFO - Uploading, attempt #1.
11:34:43 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded
11:34:43 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded!
11:34:43 INFO - (blobuploader) - INFO - Done attempting.
11:34:43 INFO - (blobuploader) - INFO - Iteration through files over.
11:34:43 INFO - Return code: 0
11:34:43 INFO - rmtree: /builds/slave/test/build/uploaded_files.json
11:34:43 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1
11:34:43 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/bed682d4f3ff51c28cc995d2a7795978f184ded44f9acea1c3ef846feac7fc93f23f643f40fe0499e2adccdf4ae9b054292bf4d20c368078c6d02926e7e32eb2", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/04471d31cf137ea09578fe9c512096c74d37e2b70a2b32294d91bdbc14baac7542f8f23f145d001fee965391a672221e6fea9ab66f5993d93c53fb47892c6d24", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/ad1d3a8537cdc8b00317e54b8fb16e55577a64fd05a498a102cf1be9dc0f879540670256645a2ef703fba1b0d7557be54d83a961ec4559e88e1b741311ecf965", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/fc1d4d068d06f399f306210d5d24c86cc586501306b9cb19b81d590a6feae79fea10388efd9d210d0b8785f42daffe756b89a2d21f5877ffbe33b4fa72c17f23"}
11:34:43 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files
11:34:43 INFO - Writing to file /builds/slave/test/properties/blobber_files
11:34:43 INFO - Contents:
11:34:43 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/bed682d4f3ff51c28cc995d2a7795978f184ded44f9acea1c3ef846feac7fc93f23f643f40fe0499e2adccdf4ae9b054292bf4d20c368078c6d02926e7e32eb2", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/04471d31cf137ea09578fe9c512096c74d37e2b70a2b32294d91bdbc14baac7542f8f23f145d001fee965391a672221e6fea9ab66f5993d93c53fb47892c6d24", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/ad1d3a8537cdc8b00317e54b8fb16e55577a64fd05a498a102cf1be9dc0f879540670256645a2ef703fba1b0d7557be54d83a961ec4559e88e1b741311ecf965", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/fc1d4d068d06f399f306210d5d24c86cc586501306b9cb19b81d590a6feae79fea10388efd9d210d0b8785f42daffe756b89a2d21f5877ffbe33b4fa72c17f23"}
11:34:43 INFO - Running post-run listener: copy_logs_to_upload_dir
11:34:43 INFO - Copying logs to upload dir...
11:34:43 INFO - mkdir: /builds/slave/test/build/upload/logs
11:34:43 INFO - Copying logs to upload dir...
program finished with exit code 0
elapsedTime=1241.332664
========= master_lag: -0.01 =========
========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 41 secs) (at 2016-12-31 11:34:43.509655) =========
========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-12-31 11:34:43.513355) =========
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=05b19d94dfa9f3ce7b6e62cc000001f7-1483207382.342317-102745228
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/bed682d4f3ff51c28cc995d2a7795978f184ded44f9acea1c3ef846feac7fc93f23f643f40fe0499e2adccdf4ae9b054292bf4d20c368078c6d02926e7e32eb2", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/04471d31cf137ea09578fe9c512096c74d37e2b70a2b32294d91bdbc14baac7542f8f23f145d001fee965391a672221e6fea9ab66f5993d93c53fb47892c6d24", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/ad1d3a8537cdc8b00317e54b8fb16e55577a64fd05a498a102cf1be9dc0f879540670256645a2ef703fba1b0d7557be54d83a961ec4559e88e1b741311ecf965", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/fc1d4d068d06f399f306210d5d24c86cc586501306b9cb19b81d590a6feae79fea10388efd9d210d0b8785f42daffe756b89a2d21f5877ffbe33b4fa72c17f23"}
build_url:https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1483205412/firefox-53.0a1.en-US.linux-x86_64.tar.bz2
program finished with exit code 0
elapsedTime=0.011223
build_url: 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1483205412/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/bed682d4f3ff51c28cc995d2a7795978f184ded44f9acea1c3ef846feac7fc93f23f643f40fe0499e2adccdf4ae9b054292bf4d20c368078c6d02926e7e32eb2", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/04471d31cf137ea09578fe9c512096c74d37e2b70a2b32294d91bdbc14baac7542f8f23f145d001fee965391a672221e6fea9ab66f5993d93c53fb47892c6d24", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/ad1d3a8537cdc8b00317e54b8fb16e55577a64fd05a498a102cf1be9dc0f879540670256645a2ef703fba1b0d7557be54d83a961ec4559e88e1b741311ecf965", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/fc1d4d068d06f399f306210d5d24c86cc586501306b9cb19b81d590a6feae79fea10388efd9d210d0b8785f42daffe756b89a2d21f5877ffbe33b4fa72c17f23"}'
========= master_lag: 0.73 =========
========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-12-31 11:34:44.252348) =========
========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-12-31 11:34:44.252669) =========
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=05b19d94dfa9f3ce7b6e62cc000001f7-1483207382.342317-102745228
XPCOM_DEBUG_BREAK=warn
_=/tools/buildbot/bin/python
using PTY: False
program finished with exit code 0
elapsedTime=0.004535
========= master_lag: 0.01 =========
========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-12-31 11:34:44.268880) =========
========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-12-31 11:34:44.269166) =========
========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-12-31 11:34:44.269418) =========
========= Total master_lag: 0.80 =========