builder: mozilla-central_ubuntu64_hw_test-dromaeojs
slave: talos-linux64-ix-056
starttime: 1475307765.27
results: success (0)
buildid: 20160930232455
builduid: 0adfd1e553fc4268b849f4ce32614265
revision: b0706e5d7ae3ca450ce1017dcc17cefdf0b0a08e
========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-01 00:42:45.272251) =========
master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/
========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-01 00:42:45.272743) =========
========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-01 00:42:45.273067) =========
========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-01 00:42:45.321620) =========
========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-01 00:42:45.321924) =========
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=52faae308a556c440401f8e5000001e8-1475297560.916926-1269991624
XPCOM_DEBUG_BREAK=warn
_=/tools/buildbot/bin/python
using PTY: False
--2016-10-01 00:42:45-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py
Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25
Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected.
HTTP request sent, awaiting response... 200 Script output follows
Length: 12141 (12K) [text/x-python]
Saving to: `archiver_client.py'
0K .......... . 100% 46.3M=0s
2016-10-01 00:42:46 (46.3 MB/s) - `archiver_client.py' saved [12141/12141]
program finished with exit code 0
elapsedTime=0.090748
========= master_lag: 0.03 =========
========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-01 00:42:45.445123) =========
========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-01 00:42:45.445547) =========
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=52faae308a556c440401f8e5000001e8-1475297560.916926-1269991624
XPCOM_DEBUG_BREAK=warn
_=/tools/buildbot/bin/python
using PTY: False
program finished with exit code 0
elapsedTime=0.019629
========= master_lag: 0.05 =========
========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-01 00:42:45.511708) =========
========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-01 00:42:45.512065) =========
bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev b0706e5d7ae3ca450ce1017dcc17cefdf0b0a08e --destination scripts --debug'
in dir /builds/slave/test/. (timeout 1200 secs)
watching logfiles {}
argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev b0706e5d7ae3ca450ce1017dcc17cefdf0b0a08e --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=52faae308a556c440401f8e5000001e8-1475297560.916926-1269991624
XPCOM_DEBUG_BREAK=warn
_=/tools/buildbot/bin/python
using PTY: False
2016-10-01 00:42:46,193 truncating revision to first 12 chars
2016-10-01 00:42:46,193 Setting DEBUG logging.
2016-10-01 00:42:46,193 attempt 1/10
2016-10-01 00:42:46,193 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/b0706e5d7ae3?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness
2016-10-01 00:42:46,501 unpacking tar archive at: mozilla-central-b0706e5d7ae3/testing/mozharness/
program finished with exit code 0
elapsedTime=0.611196
========= master_lag: 0.02 =========
========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-01 00:42:46.143744) =========
========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-01 00:42:46.144512) =========
script_repo_revision: b0706e5d7ae3ca450ce1017dcc17cefdf0b0a08e
========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-01 00:42:46.145485) =========
========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-01 00:42:46.146065) =========
========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-01 00:42:46.158161) =========
========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 53 secs) (at 2016-10-01 00:42:46.158496) =========
/tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO
in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs)
watching logfiles {}
argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-Non-PGO']
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=52faae308a556c440401f8e5000001e8-1475297560.916926-1269991624
XPCOM_DEBUG_BREAK=warn
_=/tools/buildbot/bin/python
using PTY: False
00:42:46 INFO - MultiFileLogger online at 20161001 00:42:46 in /builds/slave/test
00:42:46 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO
00:42:46 INFO - Dumping config to /builds/slave/test/logs/localconfig.json.
00:42:46 INFO - {'append_to_log': False,
00:42:46 INFO - 'base_work_dir': '/builds/slave/test',
00:42:46 INFO - 'blob_upload_branch': 'Firefox-Non-PGO',
00:42:46 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt',
00:42:46 INFO - 'branch': 'Firefox-Non-PGO',
00:42:46 INFO - 'buildbot_json_path': 'buildprops.json',
00:42:46 INFO - 'config_files': ('talos/linux_config.py',),
00:42:46 INFO - 'default_actions': ('clobber',
00:42:46 INFO - 'read-buildbot-config',
00:42:46 INFO - 'download-and-extract',
00:42:46 INFO - 'populate-webroot',
00:42:46 INFO - 'create-virtualenv',
00:42:46 INFO - 'install',
00:42:46 INFO - 'run-tests'),
00:42:46 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',),
00:42:46 INFO - 'download_minidump_stackwalk': True,
00:42:46 INFO - 'download_symbols': 'ondemand',
00:42:46 INFO - 'exes': {'python': '/tools/buildbot/bin/python',
00:42:46 INFO - 'tooltool.py': '/tools/tooltool.py',
00:42:46 INFO - 'virtualenv': ('/tools/buildbot/bin/python',
00:42:46 INFO - '/tools/misc-python/virtualenv.py')},
00:42:46 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub',
00:42:46 INFO - 'http://pypi.pub.build.mozilla.org/pub'),
00:42:46 INFO - 'installer_path': 'installer.exe',
00:42:46 INFO - 'log_level': 'info',
00:42:46 INFO - 'log_name': 'talos',
00:42:46 INFO - 'log_to_console': True,
00:42:46 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk',
00:42:46 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest',
00:42:46 INFO - 'opt_config_files': (),
00:42:46 INFO - 'pip_index': False,
00:42:46 INFO - 'sps_profile': False,
00:42:46 INFO - 'sps_profile_interval': 0,
00:42:46 INFO - 'suite': 'dromaeojs',
00:42:46 INFO - 'system_bits': '32',
00:42:46 INFO - 'talos_extra_options': ('--webServer', 'localhost'),
00:42:46 INFO - 'title': 'talos-linux64-ix-056',
00:42:46 INFO - 'tooltool_cache': '/builds/tooltool_cache',
00:42:46 INFO - 'use_talos_json': True,
00:42:46 INFO - 'virtualenv_path': '/builds/slave/test/build/venv',
00:42:46 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None},
00:42:46 INFO - 'work_dir': 'build'}
00:42:46 INFO - [mozharness: 2016-10-01 07:42:46.933424Z] Running clobber step.
00:42:46 INFO - Running pre-action listener: _resource_record_pre_action
00:42:46 INFO - Running main action method: clobber
00:42:46 INFO - rmtree: /builds/slave/test/build
00:42:46 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1
00:42:47 INFO - Running post-action listener: _resource_record_post_action
00:42:47 INFO - [mozharness: 2016-10-01 07:42:47.903556Z] Finished clobber step (success)
00:42:47 INFO - [mozharness: 2016-10-01 07:42:47.903654Z] Running read-buildbot-config step.
00:42:47 INFO - Running pre-action listener: _resource_record_pre_action
00:42:47 INFO - Running main action method: read_buildbot_config
00:42:47 INFO - Using buildbot properties:
00:42:47 INFO - {
00:42:47 INFO - "project": "",
00:42:47 INFO - "product": "firefox",
00:42:47 INFO - "script_repo_revision": "production",
00:42:47 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs",
00:42:47 INFO - "repository": "",
00:42:47 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs",
00:42:47 INFO - "buildid": "20160930232455",
00:42:47 INFO - "pgo_build": "False",
00:42:47 INFO - "basedir": "/builds/slave/test",
00:42:47 INFO - "buildnumber": 656,
00:42:47 INFO - "slavename": "talos-linux64-ix-056",
00:42:47 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/",
00:42:47 INFO - "platform": "ubuntu64_hw",
00:42:47 INFO - "scheduler": "tests-mozilla-central-linux64-talos",
00:42:47 INFO - "branch": "mozilla-central",
00:42:47 INFO - "repo_path": "mozilla-central",
00:42:47 INFO - "revision": "b0706e5d7ae3ca450ce1017dcc17cefdf0b0a08e",
00:42:47 INFO - "stage_platform": "linux64",
00:42:47 INFO - "builduid": "0adfd1e553fc4268b849f4ce32614265",
00:42:47 INFO - "slavebuilddir": "test"
00:42:47 INFO - }
00:42:47 INFO - Found installer url https://queue.taskcluster.net/v1/task/courxZ-lQCqUI_Y5noYnWw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2.
00:42:47 INFO - Running post-action listener: _resource_record_post_action
00:42:47 INFO - [mozharness: 2016-10-01 07:42:47.906085Z] Finished read-buildbot-config step (success)
00:42:47 INFO - [mozharness: 2016-10-01 07:42:47.906172Z] Running download-and-extract step.
00:42:47 INFO - Running pre-action listener: _resource_record_pre_action
00:42:47 INFO - Running main action method: download_and_extract
00:42:47 INFO - mkdir: /builds/slave/test/build/tests
00:42:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]}
00:42:47 INFO - trying https://queue.taskcluster.net/v1/task/courxZ-lQCqUI_Y5noYnWw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json
00:42:47 INFO - Downloading https://queue.taskcluster.net/v1/task/courxZ-lQCqUI_Y5noYnWw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json
00:42:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/courxZ-lQCqUI_Y5noYnWw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1
00:42:48 INFO - Downloaded 1361 bytes.
00:42:48 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json
00:42:48 INFO - Using the following test package requirements:
00:42:48 INFO - {u'common': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'],
00:42:48 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip',
00:42:48 INFO - u'firefox-52.0a1.en-US.linux-x86_64.cppunittest.tests.zip'],
00:42:48 INFO - u'gtest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip',
00:42:48 INFO - u'firefox-52.0a1.en-US.linux-x86_64.gtest.tests.zip'],
00:42:48 INFO - u'jittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip',
00:42:48 INFO - u'jsshell-linux-x86_64.zip'],
00:42:48 INFO - u'mochitest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip',
00:42:48 INFO - u'firefox-52.0a1.en-US.linux-x86_64.mochitest.tests.zip'],
00:42:48 INFO - u'mozbase': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'],
00:42:48 INFO - u'reftest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip',
00:42:48 INFO - u'firefox-52.0a1.en-US.linux-x86_64.reftest.tests.zip'],
00:42:48 INFO - u'talos': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip',
00:42:48 INFO - u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'],
00:42:48 INFO - u'web-platform': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip',
00:42:48 INFO - u'firefox-52.0a1.en-US.linux-x86_64.web-platform.tests.zip'],
00:42:48 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip',
00:42:48 INFO - u'firefox-52.0a1.en-US.linux-x86_64.xpcshell.tests.zip']}
00:42:48 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common
00:42:48 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/courxZ-lQCqUI_Y5noYnWw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip
00:42:48 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/courxZ-lQCqUI_Y5noYnWw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1
00:42:48 INFO - Fetch https://queue.taskcluster.net/v1/task/courxZ-lQCqUI_Y5noYnWw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory
00:42:49 INFO - Http code: 200
00:42:49 INFO - via: 1.1 336f0e6ef9a3462f682d6ca49029b665.cloudfront.net (CloudFront)
00:42:49 INFO - x-amz-cf-id: yg6C1DX7Zco7IHn2XYSx2ZZyTb9R-cwMGZo4QO52CivL3BvehDjS_g==
00:42:49 INFO - x-amz-version-id: UOAfWKoH0n1o4OWgjAnvmV6MufTuXXF5
00:42:49 INFO - Expected file size: 20417507
00:42:49 INFO - Obtained file size: 20417507
00:42:53 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos
00:42:53 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/courxZ-lQCqUI_Y5noYnWw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip
00:42:53 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/courxZ-lQCqUI_Y5noYnWw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1
00:42:53 INFO - Fetch https://queue.taskcluster.net/v1/task/courxZ-lQCqUI_Y5noYnWw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory
00:42:53 INFO - Http code: 200
00:42:53 INFO - via: 1.1 9552af4ceb2e0dd55964a80d1e549fd5.cloudfront.net (CloudFront)
00:42:53 INFO - x-amz-cf-id: pLyMv1ZHeAFAZVG7LD6yl-pfEuAN9fh_MZy65fNbv3pQsXqtVUVTqg==
00:42:53 INFO - x-amz-version-id: UOAfWKoH0n1o4OWgjAnvmV6MufTuXXF5
00:42:54 INFO - Expected file size: 20417507
00:42:54 INFO - Obtained file size: 20417507
00:42:58 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/courxZ-lQCqUI_Y5noYnWw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip
00:42:58 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/courxZ-lQCqUI_Y5noYnWw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1
00:42:58 INFO - Fetch https://queue.taskcluster.net/v1/task/courxZ-lQCqUI_Y5noYnWw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip into memory
00:42:59 INFO - Http code: 200
00:42:59 INFO - via: 1.1 a75342fa94ff4a9431476624fe74f02e.cloudfront.net (CloudFront)
00:42:59 INFO - x-amz-cf-id: oAyb3pVbcq1LPYfKwHthMxFv7RCyQhNkQx-PWlgeZH1Ah5CII5g7RQ==
00:42:59 INFO - x-amz-version-id: ml7Ymjl.H3icvkSkd8WWZn597jNqu_mj
00:42:59 INFO - Expected file size: 14408522
00:42:59 INFO - Obtained file size: 14408522
00:42:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]}
00:42:59 INFO - trying https://queue.taskcluster.net/v1/task/courxZ-lQCqUI_Y5noYnWw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2
00:42:59 INFO - Downloading https://queue.taskcluster.net/v1/task/courxZ-lQCqUI_Y5noYnWw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2
00:42:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/courxZ-lQCqUI_Y5noYnWw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1
00:43:05 INFO - Downloaded 55715577 bytes.
00:43:05 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/courxZ-lQCqUI_Y5noYnWw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2
00:43:05 INFO - mkdir: /builds/slave/test/properties
00:43:05 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url
00:43:05 INFO - Writing to file /builds/slave/test/properties/build_url
00:43:05 INFO - Contents:
00:43:05 INFO - build_url:https://queue.taskcluster.net/v1/task/courxZ-lQCqUI_Y5noYnWw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2
00:43:06 INFO - Running post-action listener: _resource_record_post_action
00:43:06 INFO - Running post-action listener: set_extra_try_arguments
00:43:06 INFO - [mozharness: 2016-10-01 07:43:06.579896Z] Finished download-and-extract step (success)
00:43:06 INFO - [mozharness: 2016-10-01 07:43:06.580122Z] Running populate-webroot step.
00:43:06 INFO - Running pre-action listener: _resource_record_pre_action
00:43:06 INFO - Running main action method: populate_webroot
00:43:06 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']},
00:43:06 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']},
00:43:06 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome',
00:43:06 INFO - '--tppagecycles',
00:43:06 INFO - '7'],
00:43:06 INFO - 'tests': ['tsvgm']}},
00:43:06 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'],
00:43:06 INFO - 'tests': ['tresize', 'tcanvasmark']},
00:43:06 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']},
00:43:06 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'],
00:43:06 INFO - 'tests': ['dromaeo_css', 'kraken']},
00:43:06 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']},
00:43:06 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip',
00:43:06 INFO - 'talos_options': ['--disable-e10s'],
00:43:06 INFO - 'tests': ['tp5o_scroll', 'glterrain']},
00:43:06 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip',
00:43:06 INFO - 'tests': ['tp5o_scroll', 'glterrain']},
00:43:06 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip',
00:43:06 INFO - 'talos_options': ['--disable-e10s'],
00:43:06 INFO - 'tests': ['damp', 'tps']},
00:43:06 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip',
00:43:06 INFO - 'tests': ['damp', 'tps']},
00:43:06 INFO - 'g3': {'talos_options': ['--disable-e10s'],
00:43:06 INFO - 'tests': ['dromaeo_dom']},
00:43:06 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']},
00:43:06 INFO - 'g4': {'talos_options': ['--disable-e10s'],
00:43:06 INFO - 'tests': ['basic_compositor_video']},
00:43:06 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']},
00:43:06 INFO - 'other': {'talos_options': ['--disable-e10s'],
00:43:06 INFO - 'tests': ['a11yr',
00:43:06 INFO - 'ts_paint',
00:43:06 INFO - 'tpaint',
00:43:06 INFO - 'sessionrestore',
00:43:06 INFO - 'sessionrestore_no_auto_restore',
00:43:06 INFO - 'tabpaint']},
00:43:06 INFO - 'other-e10s': {'tests': ['a11yr',
00:43:06 INFO - 'ts_paint',
00:43:06 INFO - 'tpaint',
00:43:06 INFO - 'sessionrestore',
00:43:06 INFO - 'sessionrestore_no_auto_restore',
00:43:06 INFO - 'tabpaint']},
00:43:06 INFO - 'other-e10s_l64': {'tests': ['a11yr',
00:43:06 INFO - 'ts_paint',
00:43:06 INFO - 'tpaint',
00:43:06 INFO - 'sessionrestore',
00:43:06 INFO - 'sessionrestore_no_auto_restore',
00:43:06 INFO - 'tabpaint']},
00:43:06 INFO - 'other-e10s_nol64': {'tests': ['a11yr',
00:43:06 INFO - 'ts_paint',
00:43:06 INFO - 'tpaint',
00:43:06 INFO - 'sessionrestore',
00:43:06 INFO - 'sessionrestore_no_auto_restore',
00:43:06 INFO - 'tabpaint']},
00:43:06 INFO - 'other_l64': {'talos_options': ['--disable-e10s'],
00:43:06 INFO - 'tests': ['a11yr',
00:43:06 INFO - 'ts_paint',
00:43:06 INFO - 'tpaint',
00:43:06 INFO - 'sessionrestore',
00:43:06 INFO - 'sessionrestore_no_auto_restore',
00:43:06 INFO - 'tabpaint']},
00:43:06 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'],
00:43:06 INFO - 'tests': ['a11yr',
00:43:06 INFO - 'ts_paint',
00:43:06 INFO - 'tpaint',
00:43:06 INFO - 'sessionrestore',
00:43:06 INFO - 'sessionrestore_no_auto_restore',
00:43:06 INFO - 'tabpaint']},
00:43:06 INFO - 'svgr': {'talos_options': ['--disable-e10s'],
00:43:06 INFO - 'tests': ['tsvgx',
00:43:06 INFO - 'tsvgr_opacity',
00:43:06 INFO - 'tart',
00:43:06 INFO - 'tscrollx',
00:43:06 INFO - 'cart']},
00:43:06 INFO - 'svgr-e10s': {'tests': ['tsvgx',
00:43:06 INFO - 'tsvgr_opacity',
00:43:06 INFO - 'tart',
00:43:06 INFO - 'tscrollx',
00:43:06 INFO - 'cart']},
00:43:06 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip',
00:43:06 INFO - 'talos_options': ['--disable-e10s'],
00:43:06 INFO - 'tests': ['tp5o']},
00:43:06 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip',
00:43:06 INFO - 'tests': ['tp5o']},
00:43:06 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip',
00:43:06 INFO - 'talos_options': ['--disable-e10s',
00:43:06 INFO - '--xperf_path',
00:43:06 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'],
00:43:06 INFO - 'tests': ['tp5n']},
00:43:06 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip',
00:43:06 INFO - 'talos_options': ['--xperf_path',
00:43:06 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'],
00:43:06 INFO - 'tests': ['tp5n']}},
00:43:06 INFO - 'talos.zip': {'path': '',
00:43:06 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}}
00:43:06 INFO - Running post-action listener: _resource_record_post_action
00:43:06 INFO - [mozharness: 2016-10-01 07:43:06.602675Z] Finished populate-webroot step (success)
00:43:06 INFO - [mozharness: 2016-10-01 07:43:06.602769Z] Running create-virtualenv step.
00:43:06 INFO - Running pre-action listener: _resource_record_pre_action
00:43:06 INFO - Running main action method: create_virtualenv
00:43:06 INFO - Creating virtualenv /builds/slave/test/build/venv
00:43:06 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build
00:43:06 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv
00:43:06 INFO - The --no-site-packages flag is deprecated; it is now the default behavior.
00:43:06 INFO - Using real prefix '/usr'
00:43:06 INFO - New python executable in /builds/slave/test/build/venv/bin/python
00:43:07 INFO - Installing distribute.............................................................................................................................................................................................done.
00:43:09 INFO - Installing pip.................done.
00:43:09 INFO - Return code: 0
00:43:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version']
00:43:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version
00:43:09 INFO - Reading from file tmpfile_stdout
00:43:09 INFO - Output received:
00:43:09 INFO - pip 1.5.5 from /builds/slave/test/build/venv/local/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7)
00:43:09 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv
00:43:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]}
00:43:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org
00:43:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub
00:43:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]}
00:43:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org
00:43:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub
00:43:09 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f0bba6c2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13988a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1465ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1462f60>, '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 0x1463d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14641d0>, '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': '52faae308a556c440401f8e5000001e8-1475297560.916926-1269991624', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1
00:43:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build
00:43:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5
00:43:09 INFO - Using env: {'DISPLAY': ':0',
00:43:09 INFO - 'HOME': '/home/cltbld',
00:43:09 INFO - 'LANG': 'en_US.UTF-8',
00:43:09 INFO - 'LANGUAGE': 'en_US:en',
00:43:09 INFO - 'LOGNAME': 'cltbld',
00:43:09 INFO - 'MAIL': '/var/mail/cltbld',
00:43:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1',
00:43:09 INFO - 'MOZ_NO_REMOTE': '1',
00:43:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript',
00:43:09 INFO - 'NO_EM_RESTART': '1',
00:43:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games',
00:43:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json',
00:43:09 INFO - 'PWD': '/builds/slave/test',
00:43:09 INFO - 'SHELL': '/bin/bash',
00:43:09 INFO - 'SHLVL': '1',
00:43:09 INFO - 'TERM': 'linux',
00:43:09 INFO - 'TMOUT': '86400',
00:43:09 INFO - 'USER': 'cltbld',
00:43:09 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1475297560.916926-1269991624',
00:43:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn',
00:43:09 INFO - '_': '/tools/buildbot/bin/python'}
00:43:09 INFO - Ignoring indexes: https://pypi.python.org/simple/
00:43:09 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg
00:43:09 INFO - Cleaning up...
00:43:09 INFO - Return code: 0
00:43:09 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv
00:43:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]}
00:43:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org
00:43:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub
00:43:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]}
00:43:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org
00:43:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub
00:43:09 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f0bba6c2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13988a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1465ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1462f60>, '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 0x1463d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14641d0>, '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': '52faae308a556c440401f8e5000001e8-1475297560.916926-1269991624', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1
00:43:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build
00:43:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1
00:43:09 INFO - Using env: {'DISPLAY': ':0',
00:43:09 INFO - 'HOME': '/home/cltbld',
00:43:09 INFO - 'LANG': 'en_US.UTF-8',
00:43:09 INFO - 'LANGUAGE': 'en_US:en',
00:43:09 INFO - 'LOGNAME': 'cltbld',
00:43:09 INFO - 'MAIL': '/var/mail/cltbld',
00:43:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1',
00:43:09 INFO - 'MOZ_NO_REMOTE': '1',
00:43:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript',
00:43:09 INFO - 'NO_EM_RESTART': '1',
00:43:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games',
00:43:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json',
00:43:09 INFO - 'PWD': '/builds/slave/test',
00:43:09 INFO - 'SHELL': '/bin/bash',
00:43:09 INFO - 'SHLVL': '1',
00:43:09 INFO - 'TERM': 'linux',
00:43:09 INFO - 'TMOUT': '86400',
00:43:09 INFO - 'USER': 'cltbld',
00:43:09 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1475297560.916926-1269991624',
00:43:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn',
00:43:09 INFO - '_': '/tools/buildbot/bin/python'}
00:43:09 INFO - Ignoring indexes: https://pypi.python.org/simple/
00:43:09 INFO - Downloading/unpacking psutil>=3.1.1
00:43:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available
00:43:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available
00:43:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available
00:43:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available
00:43:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available
00:43:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available
00:43:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil
00:43:11 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build'
00:43:11 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects
...
00:43:11 INFO - Installing collected packages: psutil
00:43:11 INFO - Running setup.py install for psutil
00:43:11 INFO - building 'psutil._psutil_linux' extension
00:43:11 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o
00:43:12 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so
00:43:12 INFO - building 'psutil._psutil_posix' extension
00:43:12 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o
00:43:12 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so
00:43:12 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build'
00:43:12 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ...
00:43:12 INFO - Successfully installed psutil
00:43:12 INFO - Cleaning up...
00:43:12 INFO - Return code: 0
00:43:12 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv
00:43:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]}
00:43:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org
00:43:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub
00:43:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]}
00:43:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org
00:43:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub
00:43:12 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f0bba6c2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13988a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1465ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1462f60>, '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 0x1463d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14641d0>, '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': '52faae308a556c440401f8e5000001e8-1475297560.916926-1269991624', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1
00:43:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build
00:43:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3
00:43:12 INFO - Using env: {'DISPLAY': ':0',
00:43:12 INFO - 'HOME': '/home/cltbld',
00:43:12 INFO - 'LANG': 'en_US.UTF-8',
00:43:12 INFO - 'LANGUAGE': 'en_US:en',
00:43:12 INFO - 'LOGNAME': 'cltbld',
00:43:12 INFO - 'MAIL': '/var/mail/cltbld',
00:43:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1',
00:43:12 INFO - 'MOZ_NO_REMOTE': '1',
00:43:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript',
00:43:12 INFO - 'NO_EM_RESTART': '1',
00:43:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games',
00:43:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json',
00:43:12 INFO - 'PWD': '/builds/slave/test',
00:43:12 INFO - 'SHELL': '/bin/bash',
00:43:12 INFO - 'SHLVL': '1',
00:43:12 INFO - 'TERM': 'linux',
00:43:12 INFO - 'TMOUT': '86400',
00:43:12 INFO - 'USER': 'cltbld',
00:43:12 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1475297560.916926-1269991624',
00:43:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn',
00:43:12 INFO - '_': '/tools/buildbot/bin/python'}
00:43:12 INFO - Ignoring indexes: https://pypi.python.org/simple/
00:43:12 INFO - Downloading/unpacking mozsystemmonitor==0.3
00:43:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available
00:43:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available
00:43:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available
00:43:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available
00:43:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available
00:43:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available
00:43:14 INFO - Downloading mozsystemmonitor-0.3.tar.gz
00:43:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor
00:43:14 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3)
00:43:14 INFO - Installing collected packages: mozsystemmonitor
00:43:14 INFO - Running setup.py install for mozsystemmonitor
00:43:14 INFO - Successfully installed mozsystemmonitor
00:43:14 INFO - Cleaning up...
00:43:14 INFO - Return code: 0
00:43:14 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv
00:43: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')]}
00:43:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org
00:43:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub
00:43: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')]}
00:43:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org
00:43:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub
00:43:14 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 0x7f0bba6c2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13988a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1465ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1462f60>, '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 0x1463d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14641d0>, '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': '52faae308a556c440401f8e5000001e8-1475297560.916926-1269991624', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1
00:43:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build
00:43:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1
00:43:14 INFO - Using env: {'DISPLAY': ':0',
00:43:14 INFO - 'HOME': '/home/cltbld',
00:43:14 INFO - 'LANG': 'en_US.UTF-8',
00:43:14 INFO - 'LANGUAGE': 'en_US:en',
00:43:14 INFO - 'LOGNAME': 'cltbld',
00:43:14 INFO - 'MAIL': '/var/mail/cltbld',
00:43:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1',
00:43:14 INFO - 'MOZ_NO_REMOTE': '1',
00:43:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript',
00:43:14 INFO - 'NO_EM_RESTART': '1',
00:43:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games',
00:43:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json',
00:43:14 INFO - 'PWD': '/builds/slave/test',
00:43:14 INFO - 'SHELL': '/bin/bash',
00:43:14 INFO - 'SHLVL': '1',
00:43:14 INFO - 'TERM': 'linux',
00:43:14 INFO - 'TMOUT': '86400',
00:43:14 INFO - 'USER': 'cltbld',
00:43:14 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1475297560.916926-1269991624',
00:43:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn',
00:43:14 INFO - '_': '/tools/buildbot/bin/python'}
00:43:14 INFO - Ignoring indexes: https://pypi.python.org/simple/
00:43:14 INFO - Downloading/unpacking jsonschema==2.5.1
00:43:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available
00:43:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available
00:43:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available
00:43:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available
00:43:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available
00:43:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available
00:43:16 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl
00:43:16 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1)
00:43:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available
00:43:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available
00:43:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available
00:43:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available
00:43:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available
00:43:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available
00:43:17 INFO - Downloading functools32-3.2.3-2.tar.gz
00:43:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32
00:43:17 INFO - warning: no files found matching '*.txt'
00:43:17 INFO - no previously-included directories found matching 'build'
00:43:17 INFO - no previously-included directories found matching 'dist'
00:43:17 INFO - no previously-included directories found matching '.git*'
00:43:17 INFO - Installing collected packages: jsonschema, functools32
00:43:17 INFO - Running setup.py install for functools32
00:43:17 INFO - warning: no files found matching '*.txt'
00:43:17 INFO - no previously-included directories found matching 'build'
00:43:17 INFO - no previously-included directories found matching 'dist'
00:43:17 INFO - no previously-included directories found matching '.git*'
00:43:17 INFO - Successfully installed jsonschema functools32
00:43:17 INFO - Cleaning up...
00:43:17 INFO - Return code: 0
00:43:17 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv
00:43:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]}
00:43:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org
00:43:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub
00:43:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]}
00:43:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org
00:43:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub
00:43:17 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 0x7f0bba6c2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13988a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1465ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1462f60>, '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 0x1463d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14641d0>, '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': '52faae308a556c440401f8e5000001e8-1475297560.916926-1269991624', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1
00:43:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build
00:43:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2
00:43:17 INFO - Using env: {'DISPLAY': ':0',
00:43:17 INFO - 'HOME': '/home/cltbld',
00:43:17 INFO - 'LANG': 'en_US.UTF-8',
00:43:17 INFO - 'LANGUAGE': 'en_US:en',
00:43:17 INFO - 'LOGNAME': 'cltbld',
00:43:17 INFO - 'MAIL': '/var/mail/cltbld',
00:43:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1',
00:43:17 INFO - 'MOZ_NO_REMOTE': '1',
00:43:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript',
00:43:17 INFO - 'NO_EM_RESTART': '1',
00:43:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games',
00:43:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json',
00:43:17 INFO - 'PWD': '/builds/slave/test',
00:43:17 INFO - 'SHELL': '/bin/bash',
00:43:17 INFO - 'SHLVL': '1',
00:43:17 INFO - 'TERM': 'linux',
00:43:17 INFO - 'TMOUT': '86400',
00:43:17 INFO - 'USER': 'cltbld',
00:43:17 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1475297560.916926-1269991624',
00:43:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn',
00:43:17 INFO - '_': '/tools/buildbot/bin/python'}
00:43:17 INFO - Ignoring indexes: https://pypi.python.org/simple/
00:43:17 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages
00:43:17 INFO - Cleaning up...
00:43:17 INFO - Return code: 0
00:43:17 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv
00:43:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]}
00:43:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org
00:43:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub
00:43:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]}
00:43:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org
00:43:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub
00:43:17 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 0x7f0bba6c2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13988a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1465ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1462f60>, '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 0x1463d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14641d0>, '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': '52faae308a556c440401f8e5000001e8-1475297560.916926-1269991624', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1
00:43:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build
00:43:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4
00:43:17 INFO - Using env: {'DISPLAY': ':0',
00:43:17 INFO - 'HOME': '/home/cltbld',
00:43:17 INFO - 'LANG': 'en_US.UTF-8',
00:43:17 INFO - 'LANGUAGE': 'en_US:en',
00:43:17 INFO - 'LOGNAME': 'cltbld',
00:43:17 INFO - 'MAIL': '/var/mail/cltbld',
00:43:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1',
00:43:17 INFO - 'MOZ_NO_REMOTE': '1',
00:43:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript',
00:43:17 INFO - 'NO_EM_RESTART': '1',
00:43:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games',
00:43:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json',
00:43:17 INFO - 'PWD': '/builds/slave/test',
00:43:17 INFO - 'SHELL': '/bin/bash',
00:43:17 INFO - 'SHLVL': '1',
00:43:17 INFO - 'TERM': 'linux',
00:43:17 INFO - 'TMOUT': '86400',
00:43:17 INFO - 'USER': 'cltbld',
00:43:17 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1475297560.916926-1269991624',
00:43:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn',
00:43:17 INFO - '_': '/tools/buildbot/bin/python'}
00:43:17 INFO - Ignoring indexes: https://pypi.python.org/simple/
00:43:17 INFO - Downloading/unpacking blobuploader==1.2.4
00:43:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available
00:43:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available
00:43:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available
00:43:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available
00:43:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available
00:43:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available
00:43:19 INFO - Downloading blobuploader-1.2.4.tar.gz
00:43:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader
00:43:19 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4)
00:43:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available
00:43:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available
00:43:19 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available
00:43:19 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available
00:43:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available
00:43:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available
00:43:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests
00:43:20 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4)
00:43:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available
00:43:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available
00:43:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available
00:43:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available
00:43:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available
00:43:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available
00:43:20 INFO - Downloading docopt-0.6.1.tar.gz
00:43:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt
00:43:20 INFO - Installing collected packages: blobuploader, requests, docopt
00:43:20 INFO - Running setup.py install for blobuploader
00:43:20 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775
00:43:20 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775
00:43:20 INFO - Running setup.py install for requests
00:43:20 INFO - Running setup.py install for docopt
00:43:20 INFO - Successfully installed blobuploader requests docopt
00:43:20 INFO - Cleaning up...
00:43:21 INFO - Return code: 0
00:43:21 INFO - Installing None into virtualenv /builds/slave/test/build/venv
00:43:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]}
00:43:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org
00:43:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub
00:43:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]}
00:43:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org
00:43:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub
00:43:21 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 0x7f0bba6c2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13988a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1465ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1462f60>, '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 0x1463d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14641d0>, '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': '52faae308a556c440401f8e5000001e8-1475297560.916926-1269991624', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1
00:43:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config
00:43:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub
00:43:21 INFO - Using env: {'DISPLAY': ':0',
00:43:21 INFO - 'HOME': '/home/cltbld',
00:43:21 INFO - 'LANG': 'en_US.UTF-8',
00:43:21 INFO - 'LANGUAGE': 'en_US:en',
00:43:21 INFO - 'LOGNAME': 'cltbld',
00:43:21 INFO - 'MAIL': '/var/mail/cltbld',
00:43:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1',
00:43:21 INFO - 'MOZ_NO_REMOTE': '1',
00:43:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript',
00:43:21 INFO - 'NO_EM_RESTART': '1',
00:43:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games',
00:43:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json',
00:43:21 INFO - 'PWD': '/builds/slave/test',
00:43:21 INFO - 'SHELL': '/bin/bash',
00:43:21 INFO - 'SHLVL': '1',
00:43:21 INFO - 'TERM': 'linux',
00:43:21 INFO - 'TMOUT': '86400',
00:43:21 INFO - 'USER': 'cltbld',
00:43:21 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1475297560.916926-1269991624',
00:43:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn',
00:43:21 INFO - '_': '/tools/buildbot/bin/python'}
00:43:21 INFO - Ignoring indexes: https://pypi.python.org/simple/
00:43:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser
00:43:21 INFO - Running setup.py (path:/tmp/pip-HW0fCs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser
00:43:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash
00:43:21 INFO - Running setup.py (path:/tmp/pip-GISz6o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash
00:43:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug
00:43:21 INFO - Running setup.py (path:/tmp/pip-0Hhty9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug
00:43:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice
00:43:21 INFO - Running setup.py (path:/tmp/pip-T9k2_o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice
00:43:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile
00:43:21 INFO - Running setup.py (path:/tmp/pip-aTmhLm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile
00:43:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd
00:43:21 INFO - Running setup.py (path:/tmp/pip-7Em98u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd
00:43:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo
00:43:21 INFO - Running setup.py (path:/tmp/pip-oSGdvi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo
00:43:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall
00:43:21 INFO - Running setup.py (path:/tmp/pip-6i0wIf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall
00:43:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak
00:43:21 INFO - Running setup.py (path:/tmp/pip-SVfStU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak
00:43:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog
00:43:21 INFO - Running setup.py (path:/tmp/pip-tI_jCd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog
00:43:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork
00:43:21 INFO - Running setup.py (path:/tmp/pip-5E4_2o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork
00:43:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess
00:43:22 INFO - Running setup.py (path:/tmp/pip-VVEIhn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess
00:43:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile
00:43:22 INFO - Running setup.py (path:/tmp/pip-0iekhR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile
00:43:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner
00:43:22 INFO - Running setup.py (path:/tmp/pip-Hmu4lA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner
00:43:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot
00:43:22 INFO - Running setup.py (path:/tmp/pip-DN_6ah-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot
00:43:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest
00:43:22 INFO - Running setup.py (path:/tmp/pip-tHnDDX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest
00:43:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion
00:43:22 INFO - Running setup.py (path:/tmp/pip-hkF9yK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion
00:43:22 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion
00:43:22 INFO - Running setup.py install for manifestparser
00:43:22 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin
00:43:22 INFO - Running setup.py install for mozcrash
00:43:22 INFO - Running setup.py install for mozdebug
00:43:22 INFO - Running setup.py install for mozdevice
00:43:22 INFO - Installing sutini script to /builds/slave/test/build/venv/bin
00:43:22 INFO - Installing dm script to /builds/slave/test/build/venv/bin
00:43:22 INFO - Running setup.py install for mozfile
00:43:22 INFO - Running setup.py install for mozhttpd
00:43:23 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin
00:43:23 INFO - Running setup.py install for mozinfo
00:43:23 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin
00:43:23 INFO - Running setup.py install for mozInstall
00:43:23 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin
00:43:23 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin
00:43:23 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin
00:43:23 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin
00:43:23 INFO - Running setup.py install for mozleak
00:43:23 INFO - Running setup.py install for mozlog
00:43:23 INFO - Installing structlog script to /builds/slave/test/build/venv/bin
00:43:23 INFO - Running setup.py install for moznetwork
00:43:23 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin
00:43:23 INFO - Running setup.py install for mozprocess
00:43:23 INFO - Running setup.py install for mozprofile
00:43:23 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin
00:43:23 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin
00:43:23 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin
00:43:23 INFO - Running setup.py install for mozrunner
00:43:23 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin
00:43:23 INFO - Running setup.py install for mozscreenshot
00:43:24 INFO - Running setup.py install for moztest
00:43:24 INFO - Running setup.py install for mozversion
00:43:24 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin
00:43:24 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion
00:43:24 INFO - Cleaning up...
00:43:24 INFO - Return code: 0
00:43:24 INFO - Installing None into virtualenv /builds/slave/test/build/venv
00:43:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]}
00:43:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org
00:43:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub
00:43:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]}
00:43:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org
00:43:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub
00:43:24 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 0x7f0bba6c2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13988a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1465ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1462f60>, '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 0x1463d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14641d0>, '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': '52faae308a556c440401f8e5000001e8-1475297560.916926-1269991624', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1
00:43:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config
00:43:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub
00:43:24 INFO - Using env: {'DISPLAY': ':0',
00:43:24 INFO - 'HOME': '/home/cltbld',
00:43:24 INFO - 'LANG': 'en_US.UTF-8',
00:43:24 INFO - 'LANGUAGE': 'en_US:en',
00:43:24 INFO - 'LOGNAME': 'cltbld',
00:43:24 INFO - 'MAIL': '/var/mail/cltbld',
00:43:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1',
00:43:24 INFO - 'MOZ_NO_REMOTE': '1',
00:43:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript',
00:43:24 INFO - 'NO_EM_RESTART': '1',
00:43:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games',
00:43:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json',
00:43:24 INFO - 'PWD': '/builds/slave/test',
00:43:24 INFO - 'SHELL': '/bin/bash',
00:43:24 INFO - 'SHLVL': '1',
00:43:24 INFO - 'TERM': 'linux',
00:43:24 INFO - 'TMOUT': '86400',
00:43:24 INFO - 'USER': 'cltbld',
00:43:24 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1475297560.916926-1269991624',
00:43:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn',
00:43:24 INFO - '_': '/tools/buildbot/bin/python'}
00:43:24 INFO - Ignoring indexes: https://pypi.python.org/simple/
00:43:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser
00:43:24 INFO - Running setup.py (path:/tmp/pip-KXftFq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser
00:43:24 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1))
00:43:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash
00:43:24 INFO - Running setup.py (path:/tmp/pip-3AKrSj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash
00:43:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2))
00:43:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug
00:43:24 INFO - Running setup.py (path:/tmp/pip-7cYVsp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug
00:43:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3))
00:43:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice
00:43:24 INFO - Running setup.py (path:/tmp/pip-dEmtF2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice
00:43:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4))
00:43:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile
00:43:24 INFO - Running setup.py (path:/tmp/pip-ImGuCb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile
00:43:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5))
00:43:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd
00:43:24 INFO - Running setup.py (path:/tmp/pip-i9sHU4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd
00:43:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6))
00:43:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo
00:43:24 INFO - Running setup.py (path:/tmp/pip-CwMcsx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo
00:43:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7))
00:43:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall
00:43:25 INFO - Running setup.py (path:/tmp/pip-liZ4_G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall
00:43:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8))
00:43:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak
00:43:25 INFO - Running setup.py (path:/tmp/pip-tUrM_9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak
00:43:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9))
00:43:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog
00:43:25 INFO - Running setup.py (path:/tmp/pip-vR8LkU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog
00:43:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10))
00:43:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork
00:43:25 INFO - Running setup.py (path:/tmp/pip-aj0C6K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork
00:43:25 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11))
00:43:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess
00:43:25 INFO - Running setup.py (path:/tmp/pip-8kzSlv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess
00:43:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12))
00:43:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile
00:43:25 INFO - Running setup.py (path:/tmp/pip-d7xpgp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile
00:43:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13))
00:43:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner
00:43:25 INFO - Running setup.py (path:/tmp/pip-l9gxXe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner
00:43:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14))
00:43:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot
00:43:25 INFO - Running setup.py (path:/tmp/pip-TQKANf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot
00:43:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15))
00:43:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest
00:43:25 INFO - Running setup.py (path:/tmp/pip-LnGSyv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest
00:43:25 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16))
00:43:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion
00:43:25 INFO - Running setup.py (path:/tmp/pip-GuKR21-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion
00:43:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17))
00:43:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2))
00:43:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2))
00:43:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3))
00:43:25 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4))
00:43:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4))
00:43:25 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10))
00:43:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available
00:43:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available
00:43:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available
00:43:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available
00:43:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available
00:43:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available
00:43:27 INFO - Downloading blessings-1.6.tar.gz
00:43:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings
00:43:27 INFO - Installing collected packages: blessings
00:43:27 INFO - Running setup.py install for blessings
00:43:28 INFO - Successfully installed blessings
00:43:28 INFO - Cleaning up...
00:43:28 INFO - Return code: 0
00:43:28 INFO - Done creating virtualenv /builds/slave/test/build/venv.
00:43:28 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze']
00:43:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze
00:43:28 INFO - Reading from file tmpfile_stdout
00:43:28 INFO - Current package versions:
00:43:28 INFO - argparse == 1.2.1
00:43:28 INFO - blessings == 1.6
00:43:28 INFO - blobuploader == 1.2.4
00:43:28 INFO - docopt == 0.6.1
00:43:28 INFO - functools32 == 3.2.3-2
00:43:28 INFO - jsonschema == 2.5.1
00:43:28 INFO - manifestparser == 1.1
00:43:28 INFO - mozInstall == 1.12
00:43:28 INFO - mozcrash == 0.17
00:43:28 INFO - mozdebug == 0.1
00:43:28 INFO - mozdevice == 0.48
00:43:28 INFO - mozfile == 1.2
00:43:28 INFO - mozhttpd == 0.7
00:43:28 INFO - mozinfo == 0.9
00:43:28 INFO - mozleak == 0.1
00:43:28 INFO - mozlog == 3.4
00:43:28 INFO - moznetwork == 0.27
00:43:28 INFO - mozprocess == 0.23
00:43:28 INFO - mozprofile == 0.28
00:43:28 INFO - mozrunner == 6.12
00:43:28 INFO - mozscreenshot == 0.1
00:43:28 INFO - mozsystemmonitor == 0.3
00:43:28 INFO - moztest == 0.7
00:43:28 INFO - mozversion == 1.4
00:43:28 INFO - psutil == 3.1.1
00:43:28 INFO - requests == 1.2.3
00:43:28 INFO - wsgiref == 0.1.2
00:43:28 INFO - Installing None into virtualenv /builds/slave/test/build/venv
00:43: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')]}
00:43:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org
00:43:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub
00:43: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')]}
00:43:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org
00:43:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub
00:43:28 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 0x7f0bba6c2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13988a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1465ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1462f60>, '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 0x1463d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14641d0>, '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': '52faae308a556c440401f8e5000001e8-1475297560.916926-1269991624', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1
00:43:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos
00:43:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub
00:43:28 INFO - Using env: {'DISPLAY': ':0',
00:43:28 INFO - 'HOME': '/home/cltbld',
00:43:28 INFO - 'LANG': 'en_US.UTF-8',
00:43:28 INFO - 'LANGUAGE': 'en_US:en',
00:43:28 INFO - 'LOGNAME': 'cltbld',
00:43:28 INFO - 'MAIL': '/var/mail/cltbld',
00:43:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1',
00:43:28 INFO - 'MOZ_NO_REMOTE': '1',
00:43:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript',
00:43:28 INFO - 'NO_EM_RESTART': '1',
00:43:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games',
00:43:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json',
00:43:28 INFO - 'PWD': '/builds/slave/test',
00:43:28 INFO - 'SHELL': '/bin/bash',
00:43:28 INFO - 'SHLVL': '1',
00:43:28 INFO - 'TERM': 'linux',
00:43:28 INFO - 'TMOUT': '86400',
00:43:28 INFO - 'USER': 'cltbld',
00:43:28 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1475297560.916926-1269991624',
00:43:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn',
00:43:28 INFO - '_': '/tools/buildbot/bin/python'}
00:43:28 INFO - Ignoring indexes: https://pypi.python.org/simple/
00:43:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1))
00:43:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2))
00:43:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3))
00:43:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4))
00:43:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5))
00:43:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6))
00:43:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7))
00:43:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8))
00:43:28 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9))
00:43:28 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1))
00:43:28 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4))
00:43:28 INFO - Cleaning up...
00:43:28 INFO - Return code: 0
00:43:28 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv
00:43: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')]}
00:43:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org
00:43:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub
00:43: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')]}
00:43:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org
00:43:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub
00:43: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']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f0bba6c2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13988a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1465ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1462f60>, '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 0x1463d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14641d0>, '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': '52faae308a556c440401f8e5000001e8-1475297560.916926-1269991624', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1
00:43: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'] in /builds/slave/test/build
00:43: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
00:43:28 INFO - Using env: {'DISPLAY': ':0',
00:43:28 INFO - 'HOME': '/home/cltbld',
00:43:28 INFO - 'LANG': 'en_US.UTF-8',
00:43:28 INFO - 'LANGUAGE': 'en_US:en',
00:43:28 INFO - 'LOGNAME': 'cltbld',
00:43:28 INFO - 'MAIL': '/var/mail/cltbld',
00:43:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1',
00:43:28 INFO - 'MOZ_NO_REMOTE': '1',
00:43:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript',
00:43:28 INFO - 'NO_EM_RESTART': '1',
00:43:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games',
00:43:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json',
00:43:28 INFO - 'PWD': '/builds/slave/test',
00:43:28 INFO - 'SHELL': '/bin/bash',
00:43:28 INFO - 'SHLVL': '1',
00:43:28 INFO - 'TERM': 'linux',
00:43:28 INFO - 'TMOUT': '86400',
00:43:28 INFO - 'USER': 'cltbld',
00:43:28 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1475297560.916926-1269991624',
00:43:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn',
00:43:28 INFO - '_': '/tools/buildbot/bin/python'}
00:43:28 INFO - Ignoring indexes: https://pypi.python.org/simple/
00:43:28 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages
00:43:28 INFO - Cleaning up...
00:43:28 INFO - Return code: 0
00:43:28 INFO - Running post-action listener: _resource_record_post_action
00:43:28 INFO - Running post-action listener: _start_resource_monitoring
00:43:28 INFO - Starting resource monitoring.
00:43:28 INFO - [mozharness: 2016-10-01 07:43:28.872082Z] Finished create-virtualenv step (success)
00:43:28 INFO - [mozharness: 2016-10-01 07:43:28.872655Z] Running install step.
00:43:28 INFO - Running pre-action listener: _resource_record_pre_action
00:43:28 INFO - Running main action method: install
00:43:28 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze']
00:43:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze
00:43:29 INFO - Reading from file tmpfile_stdout
00:43:29 INFO - Detecting whether we're running mozinstall >=1.0...
00:43:29 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h']
00:43:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h
00:43:29 INFO - Reading from file tmpfile_stdout
00:43:29 INFO - Output received:
00:43:29 INFO - Usage: mozinstall [options] installer
00:43:29 INFO - Options:
00:43:29 INFO - -h, --help show this help message and exit
00:43:29 INFO - -d DEST, --destination=DEST
00:43:29 INFO - Directory to install application into. [default:
00:43:29 INFO - "/builds/slave/test"]
00:43:29 INFO - --app=APP Application being installed. [default: firefox]
00:43:29 INFO - mkdir: /builds/slave/test/build/application
00:43:29 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application']
00:43:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application
00:43:45 INFO - Reading from file tmpfile_stdout
00:43:45 INFO - Output received:
00:43:45 INFO - /builds/slave/test/build/application/firefox/firefox
00:43:45 INFO - Running post-action listener: _resource_record_post_action
00:43:45 INFO - [mozharness: 2016-10-01 07:43:45.304003Z] Finished install step (success)
00:43:45 INFO - [mozharness: 2016-10-01 07:43:45.304247Z] Running run-tests step.
00:43:45 INFO - Running pre-action listener: _resource_record_pre_action
00:43:45 INFO - Running main action method: run_tests
00:43:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version']
00:43:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version
00:43:45 INFO - Python 2.7.3
00:43:45 INFO - Return code: 0
00:43:45 INFO - grabbing minidump binary from tooltool
00:43:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]}
00:43:45 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 0x1462f60>, '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 0x1463d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14641d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1
00:43:45 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build
00:43:45 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache
00:43:45 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600
00:43:45 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache
00:43:45 INFO - Return code: 0
00:43:45 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755
00:43:45 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir
00:43:45 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir
00:43:45 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk
00:43:45 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir
00:43:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/courxZ-lQCqUI_Y5noYnWw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-056', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build
00:43:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/courxZ-lQCqUI_Y5noYnWw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-056 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log
00:43:45 INFO - Using env: {'DISPLAY': ':0',
00:43:45 INFO - 'HOME': '/home/cltbld',
00:43:45 INFO - 'LANG': 'en_US.UTF-8',
00:43:45 INFO - 'LANGUAGE': 'en_US:en',
00:43:45 INFO - 'LOGNAME': 'cltbld',
00:43:45 INFO - 'MAIL': '/var/mail/cltbld',
00:43:45 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir',
00:43:45 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk',
00:43:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1',
00:43:45 INFO - 'MOZ_NO_REMOTE': '1',
00:43:45 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir',
00:43:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript',
00:43:45 INFO - 'NO_EM_RESTART': '1',
00:43:45 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games',
00:43:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json',
00:43:45 INFO - 'PWD': '/builds/slave/test',
00:43:45 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos',
00:43:45 INFO - 'SHELL': '/bin/bash',
00:43:45 INFO - 'SHLVL': '1',
00:43:45 INFO - 'TERM': 'linux',
00:43:45 INFO - 'TMOUT': '86400',
00:43:45 INFO - 'USER': 'cltbld',
00:43:45 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1475297560.916926-1269991624',
00:43:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn',
00:43:45 INFO - '_': '/tools/buildbot/bin/python'}
00:43:45 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/courxZ-lQCqUI_Y5noYnWw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-056', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600
00:43:45 INFO - mozversion application_buildid: 20160930232455
00:43:45 INFO - mozversion application_changeset: b0706e5d7ae3ca450ce1017dcc17cefdf0b0a08e
00:43:45 INFO - mozversion application_display_name: Nightly
00:43:45 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384}
00:43:45 INFO - mozversion application_name: Firefox
00:43:45 INFO - mozversion application_remotingname: firefox
00:43:45 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central
00:43:45 INFO - mozversion application_vendor: Mozilla
00:43:45 INFO - mozversion application_version: 52.0a1
00:43:45 INFO - mozversion platform_buildid: 20160930232455
00:43:45 INFO - mozversion platform_changeset: b0706e5d7ae3ca450ce1017dcc17cefdf0b0a08e
00:43:45 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central
00:43:45 INFO - mozversion platform_version: 52.0a1
00:43:45 INFO - using testdate: 1475307825
00:43:45 INFO - actual date: 1475307825
00:43:45 INFO - starting webserver on 'localhost:48410'
00:43:45 INFO - SUITE-START | Running 2 tests
00:43:45 INFO - TEST-START | dromaeo_css
00:43:45 INFO - operating with platform_type : linux_
00:43:45 INFO - Initialising browser for dromaeo_css test...
00:43:45 INFO - TEST-INFO | started process 28084 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpakEngh/profile http://localhost:48410/getInfo.html)
00:43:50 INFO - PROCESS | 28084 | __metrics Screen width/height:1600/1200
00:43:50 INFO - PROCESS | 28084 | colorDepth:24
00:43:50 INFO - PROCESS | 28084 | Browser inner width/height: 1024/697
00:43:50 INFO - PROCESS | 28084 | __metrics
00:43:51 INFO - PROCESS | 28084 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows"
00:43:51 INFO - PROCESS | 28084 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver]
00:43:51 INFO - PROCESS | 28084 | console.error: PushService:
00:43:51 INFO - PROCESS | 28084 | stateChangeProcessEnqueue: Error transitioning state
00:43:51 INFO - PROCESS | 28084 | UnknownError
00:43:52 INFO - TEST-INFO | 28084: exit 0
00:43:52 INFO - Browser initialized.
00:43:52 INFO - Running cycle 1/1 for dromaeo_css test...
00:43:52 INFO - TEST-INFO | started process 28166 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpakEngh/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1)
00:44:05 INFO - PROCESS | 28166 | RSS: Main: 175075328
00:44:05 INFO - PROCESS | 28166 |
00:44:55 INFO - PROCESS | 28166 | 1475307895861 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no]
00:47:09 INFO - PROCESS | 28166 | Cycle 1(1): loaded http://localhost:48410/tests/dromaeo/cssquery-dojo.html (next: http://localhost:48410/tests/dromaeo/cssquery-ext.html)
00:47:10 INFO - PROCESS | 28166 | RSS: Main: 282173440
00:47:10 INFO - PROCESS | 28166 |
00:50:13 INFO - PROCESS | 28166 | Cycle 1(1): loaded http://localhost:48410/tests/dromaeo/cssquery-ext.html (next: http://localhost:48410/tests/dromaeo/cssquery-jquery.html)
00:50:13 INFO - PROCESS | 28166 | RSS: Main: 269221888
00:50:13 INFO - PROCESS | 28166 |
00:53:15 INFO - PROCESS | 28166 | Cycle 1(1): loaded http://localhost:48410/tests/dromaeo/cssquery-jquery.html (next: http://localhost:48410/tests/dromaeo/cssquery-mootools.html)
00:53:16 INFO - PROCESS | 28166 | RSS: Main: 261267456
00:53:16 INFO - PROCESS | 28166 |
00:56:18 INFO - PROCESS | 28166 | Cycle 1(1): loaded http://localhost:48410/tests/dromaeo/cssquery-mootools.html (next: http://localhost:48410/tests/dromaeo/cssquery-prototype.html)
00:56:19 INFO - PROCESS | 28166 | RSS: Main: 219549696
00:56:19 INFO - PROCESS | 28166 |
00:59:22 INFO - PROCESS | 28166 | Cycle 1(1): loaded http://localhost:48410/tests/dromaeo/cssquery-prototype.html (next: http://localhost:48410/tests/dromaeo/cssquery-yui.html)
00:59:23 INFO - PROCESS | 28166 | RSS: Main: 219467776
00:59:23 INFO - PROCESS | 28166 |
01:02:26 INFO - PROCESS | 28166 | Cycle 1(1): loaded http://localhost:48410/tests/dromaeo/cssquery-yui.html (next: http://localhost:48410/tests/dromaeo/cssquery-dojo.html)
01:02:26 INFO - PROCESS | 28166 | RSS: Main: 310546432
01:02:26 INFO - PROCESS | 28166 |
01:02:26 INFO - PROCESS | 28166 | __start_tp_report
01:02:26 INFO - PROCESS | 28166 | _x_x_mozilla_page_load
01:02:26 INFO - PROCESS | 28166 | _x_x_mozilla_page_load_details
01:02:26 INFO - PROCESS | 28166 | |i|pagename|runs|
01:02:26 INFO - PROCESS | 28166 | |0;dojo.html;2534.860582667953;2559.8592077435756;2604.1927002629186;2604.661394018777;2611.6213149093383;4422.314541246112;4490.797914093865;4559.772011399429;4565.383673204116;4576.450825900893;4504.391907092541;4508.97745511272;4530.773461326929;4560.498345182027;4567.634589232862;4144.896377590554;4177.310743727281;4191.308434108384;4202.915941681164;4228.281192197333;3946.2699400610977;4226.577342265764;4292.399064131024;4337.110892267094;4371.27873900806;4273.829046838123;4336.479622445311;4342.609165175118;4372.409724687174;4378.058717375764;4100.835966561334;4155.729877557949;4156.293430116887;4215.620594146541;4256.765877876715;4197.601227883377;4203.285441474956;4212.726172798758;4285.871423857289;4304.225239456897;4616.1229366420275;4650.604698600623;4656.906861862778;4678.228092364756;4708.034852855157;4764.404449443819;4821.108095002401;4918.532739389752;4939;4959.727215003173;4862.708237505761;4893.853184404474;4945.752712364368;4963.255511673278;4970.478099799541;4609.562091601292;4621.445426548836;4631.3516107744945;4633.30500424939;4643.674942753974;4842.685225460334;5039.3448851649055;5044.394672639307;5053.166227572483;5115.2582875483595;4686.718796872198;4737.668363214542;4790.544898234732;4793.736344501086;4833.516648335139;4866.367372241586;4867.780949857265;4886.364772579542;4910.06708725341;4938.678985865908;4827.541383568555;4845.41854977405;4851.078295123915;4885.218365061573;4901.509849015141;4616.907661846744;4668.976655116703;4673.719576825333;4868.050730107595;4880.243562247857;4013.337799263089;4068.898277543085;4105.137921036616;4112.09533902541;4154.896127596834;3616.6202548732003;3624.6737793598704;3658.451232315174;3661.9450708239397;3678.8528458861883;4252.55348188442;4265.253580623378;4289.1850548395705;4291.935620965688;4348.239058164809;4720.976395118002;4773.809047638056;4906.656534042583;4939;4968.254761785761;4253.298205796009;4335.696501244883;4381.40850985113;4388.626966707801;4388.648908087345;4424.137293227854;4434.401355816988;4437.7781110944325;4438.755868427203;4490.101979604092;4435.82256709728;4464.3973063635995;4562.270036794097;4697.037107392976;4761.40482439695;4872.342233798534;4906.656534042726;4914.508549145057;4944.406671199479;4945.77744001528;4612.607928325996;4627.53724627548;4633.837815676435;4644.303354496852;4683.36774535447;4685.695429797052;4751.9287210692555;4832.661713680009;4833.73414462208;4890.095332363524;4857.392825896763;4937.086638971802;4952.925706114339;4955.479674634112;5015.749212539431;4759.857204283877;4774.236122220428;4787.664863459524;4789.760511974457;4839.491853355347;4587.839425620087;4765.571098601143;4772.117158325721;4783.904321913612;4837.806487740591;4559.931601026054;4645.233536466445;4686.0862131885315;4698.154332220233;4745.572898439157;4760.6191504678845;4771.355866958055;4775.689580177277;4777.880552986203;4821.710697358169;4486.147631949919;4554.817807287672;4575.473820510684;4627.236505976476;4649.442066951988
01:02:26 INFO - PROCESS | 28166 | |1;ext.html;559.8348487196276;574.8103125968431;578.8697543052813;579.32219303415;580.1066357808975;28237.71762282379;39533;40690.79654601723;40704.38943415844;43691.78154109233;40032.79983600085;40371.59628403715;40391.39412908809;40394.980250987406;40402.797986010104;7523.962380188105;7665.4634175607725;7677.539347639132;7689.192634773352;7698.923010769877;7574.9242507575045;7694;7723.150453450144;7728.806779830493;7731.690732370698;7705.267999540063;7750.302472777449;7755.108162561293;7762.611869406507;7769.728059517918;7652.780693598849;7685.385169186479;7728.459007869451;7729.961350193213;7734.265244801763;7671.462997590171;7731.922680773177;7742.651580678883;7744.186860379636;7756.146823849372;38296.617033829585;38482.80758596217;38555.807220963994;38656.42015369772;38741.612583874085;2884.538473844196;2895.884164633412;2919.8832046718107;2928.8389138597367;2950.468915595192;28217.294567635974;28384.858075709697;28406.28984275389;29046;29146.125616231548;3385.5937287525408;3418.1454636340914;3505.3164632896596;3527.94708079379;3534.3108093921696;252077;252592;253480;253779;254654.72672636702;52197.7390113047;52421.7378913103;52522;52554;52584;32581.18547036343;33512.329753404796;33614.15964600856;54222.186667200025;54586;13055;13218;13222;13226.272555009567;13250.933745331211;11673.941630291794;11818.881811181951;11820.704482387837;11821.940890295493;11823.88176118245;17582.736258956127;17623.471295861145;17720.55698607545;17747.46757597274;17829.910850445664;6667.566608170453;6690.966545167243;6717.596944183365;6811.727530898807;6889.552179108342;770.8034451215017;824.7855557555079;921.9858156028315;948.127722495306;984.9655262065793;27420.17739467819;27590;28415.289617759307;28556.286092847844;28839.711602884123;758.962051897403;917.1104029091771;926.6849271247808;961.7543037008663;964.9276304277207;13643.454261829615;14687.926560367343;14809.48166814178;14893.77659335111;15031.098134111988;664391.1024003931;681070;682074;683025;683726;49570.752146239036;50399.74800125976;50411.49588504068;50438.243426348636;50459.24311135336;1028.2082796246848;1088.9455527223606;1130.9264897781618;1176.4882276209876;1196.1447564991074;27229.72770272351;29525.26186845346;29578.704212957597;29938.550921736627;30218.395632087675;41971.790141049096;42506.36240456458;42528;42584;42607.360889587304;325588;328852;329016;329038;330145;25053.624195637443;25315;25543.6168457477;26026.479470410864;27048.024717281478;41558.37662435006;41706.79146604247;41809.79095104505;42080;42178.578214217465;35429.1142721434;35494.112647184025;35680;35798.28403431969;36371.27257454783;35714.821425893744;35836.82081589576;35877.28245435129;36313.818430907675;36536.26927461489;35239.29521409506;35748.821255893556;35770.64229357673;35991.460128098624;36085.27829443344;31037.15131634856;33044.339113217124;33300.333993320484;33520.32959340848;33753.49369759505;25090.37274068163;25374;25465.61801573015;25619.743802561738;25709.3572660685
01:02:26 INFO - PROCESS | 28166 | |2;jquery.html;334.63859032245176;345.62672313900987;359.53799367812366;362.46174430970007;374.6178897524525;12170.939145304272;15688.450904218354;16132.596685082879;16513.752293715574;17579.208935597897;16154.919225403857;16501.0924399158;16577.585560360967;16627.584310392245;16693.49919502414;3986.8637438330084;4968.677035992658;5169.844904652848;5191.402988656297;5216.426193118754;5054.115529782292;5078.720670363128;5097.694138351692;5103.081445339837;5142.974285128569;4897.926531102036;5019.29729837823;5077.593792496591;5091.821786237482;5113.284140220372;5064.594832413398;5092.159793634064;5094.847154585368;5096.92354614683;5106.617003724736;4383.232934236527;4496.348029535699;4549.454065512126;4552.8861778455475;4559.52125026874;20431;20505.38483845487;20581.8970905146;20657.690134647994;20764.896175519025;1803.9549011274823;1819.1904602451914;2307.031046960264;2369.4194922243987;2402.1712509184304;11307.886921130766;12363.505459781598;12793.55222567215;13300.667483312898;13438.596842094752;1550.3643506162418;1641.564985278902;1647.7281248593968;1666.8583170430527;1704.7613334133232;68478.65760671215;69583;69952.3004769951;69985.65007174932;70798;9251.167394934488;9491.715248542554;9546.522673866419;9628.75928101789;9757;12678.84459641863;12708.936455317664;12716.936415318049;12717.173383730027;12721.109522333349;6928.341807528277;7273.927260727431;7303.525270857377;7431.628418579049;7433.070866141732;7118.006958051754;7155.284471552907;7308.817279567947;7333.669984850694;7348.816279593053;3906.746061505993;3970.6426421621613;3980.402939559089;4044.51465824103;4061.6442463371764;1636.3781762930248;1646.6295083606092;1677.3123019561922;1684.7005224453608;1712;790.4861839804173;801.9198080192051;827.4084029918637;882.9867551986725;923.690563661181;16455.25951332193;17125.743113853303;17361.47915562535;17791.911040444975;17925.46223613294;777.7355699062233;792.1880072925183;793.6111305460283;797.4736673795268;883.7083762358407;7206.56760594366;9204.217641500414;9500.524973751284;9635.22918166545;9675.951620241854;363299;368666;371764;372907;383466;46640.7667961658;46719.29921051119;49740.75129624401;76389.6180519105;76598.23401766023;846.2595229174473;850.3919697416377;853.3685073045901;870.3211495033884;875.0636818604032;15062.246887655792;15117.319720612379;15809.841901580838;16034.358625654842;16063.518094457186;35961.82019089888;36729;36775.632243677224;37248.25503489861;37816;48537;49780.253296201314;49994.500054998985;50079;50609.24086138637;4661.277501987197;5068.847934561969;7264.418846492374;7460.962695186489;7542.773716788505;8540.658373665232;10954.671359859218;11319.660410187707;11324.660260192208;11675.649730508097;9849.212063034796;9962.103410693073;10259.538320775733;10536.209784266057;10543.525541350504;10145.137663298703;10197.133243674074;10260.435676037889;10414.583416663248;10510;10012.749681258027;10549.208809339483;10585.100266477435;10687.572497100029;10974.231803773659;7247.420206383582;7382.630868456663;7454.105507339154;7493.250674932463;7583.848323033398;10310.123639490726;10426.843597346198;10460.110890574082;10464.476776161313;10931.289466184673
01:02:26 INFO - PROCESS | 28166 | |3;mootools.html;1183.6863231243717;1332.2406228449784;1365.7609918264304;1410.2948525737131;1667.7581750646164;6174.907376389352;6822.215445223795;7132.3580877721;7154.570725756452;7334.046573945393;7188.748393806205;7257.854842903139;7270.781876543712;7275.781726548199;7286.599237041961;2049.4261606750097;2074.450270678264;2075.584883023394;2077.6156411064003;2081.5628717969244;2063.2675400232924;2104.642210824156;2104.747430308365;2108.2410332280365;2115.576884623074;2039.8776073435567;2043.9080241389174;2049.6925461180867;2052.568960518293;2057.310800881706;1985.9404217873414;2008.9598208035904;2009.5679428922706;2011.5675129847152;2013.7784843667184;1955.7261983322346;1962.2445358537066;2019.2225992992658;2022.4741567192489;2025.5341271507489;7051.753188638373;7084.539504932214;7135.4648401370105;7169.175544812361;7334.1565719942355;4264.765437900915;4405.581469760367;4408.801603927799;4412.75729834859;4415.028693687384;2657.601359796027;2796.4127533218048;2832.2919270182456;2837.9432411351863;2847.2739451439957;922.3313098003961;928.168880974526;940.3934462271797;955.2787645327802;960.2510042167121;9547.379420337726;9611.711648650551;9639.951800240953;9644.083812037845;9644.75888102796;3702;3762.9435558466644;3769.076576238839;3824.4454554089502;3833.1375440525658;7768.456208065494;7787.688492460238;7840.33357164636;7855.450118491765;7864.882026769603;4282.5075116361395;4287.935680964788;4290.334998075304;4292.441982542249;4292.59220374064;3372.578427696538;3497.6852083312624;3841.4237864320016;3998.640122388999;4001.4397984282223;3091.27355071558;3134.8902788402297;3199.6480387157394;3211.0527394418705;3214.9357012860078;899.0515006668028;902.4449963272672;907.6823111910778;921.4793641592479;932.3892850183141;804.6861723927556;805.3315747929205;806.0689903161857;811.6104269950457;811.8660421030464;4702.059588082398;4712.787924543404;4757.762111894461;4783.856484305476;5052.9494705052475;359.64934189165876;372.0865275748032;882.0870399136991;902.8916530016309;942.189716843514;3391.6438773928876;3539.239063601338;3572.160542272564;3596.6223546527763;3597.1725804196844;8264.752057438287;8508.532030738244;8666.566671666518;8772.429792063496;8774.649014039494;8654.78363040929;8658.826823463496;8660.13398660129;8754.781130471662;8777.166169213915;6690.297518760557;6813.454923606099;6819.931800681929;6829.931700683128;6834.350736680107;4902.117618828645;4963.70217786934;5008.824691135793;5063.417706963746;5131.692098474104;7893.842123157619;7959.602019898866;8134.715284964997;8153.7553873383895;8169.468984515987;7738.613069346397;8332.16678332162;8386.538740369338;8403.495790252604;8404.243618074403;5934.673592952429;6298.338674439118;6298.338674439118;6302.117703521602;6308.211473565804;6066;6144.109104179958;6307.085472606538;6374.394432528902;6387.425131738166;5767.106098554731;5786.450287222707;5831.212786273968;5838.532917366685;5861.589688721749;5613.1860880171325;5661.46216109469;5667.3765885753355;5690.430956904442;5694.572907031907;5608.38307786135;5657.094864821609;5661.179129026351;5664.631798933056;5666.660000399989;4043.130726893732;4192.392103144966;4272.893177670583;4325.24308246062;4451.132029254264;4133.875983720493;4193.601607847249;4327.956720432755;4363.367311739843;4449.3326001100095
01:02:26 INFO - PROCESS | 28166 | |4;prototype.html;287.7036652248184;290.72526462492954;293.5244903256724;296.845640267061;298.9551567264909;4680.368150299709;4735.8816029599275;4737.157705376777;4751.382320298365;4764.40340014692;4685.953140468594;4691.530846915307;4694.9765251173785;4696.943187782747;4700.553447422498;3505.5442792436947;3629.909252268688;3638.7634803737674;3646.8723594674193;3648.3250598639206;3550.236699109691;3646.1613828819386;3702.0934218877164;3718.4794128821986;3729;3684.6315368463206;3688.17016171362;3688.856454499114;3690.5571331440265;3707.1658876752786;3627.854885804591;3678.1172518595345;3681.37416639172;3694.926101477969;3698.3158115748674;3269.9346013079844;3276.459384201604;3278.918027049319;3280.2783387654677;3300.3069355435387;4562.498125206224;4566.908661826745;4580.770961451914;4584.15193189261;4588.609968152711;4217.957820421818;4221.55673654265;4227.513835908849;4229.7462152270655;4231.048014196781;4764;4846.9515304846855;4882.975585122087;4910.582600478963;4919.499552636445;3571.160777217352;3573.982130089359;3575.6781889630056;3583.4803953426867;3584.5698516177963;5110.95225478776;5121.28302037715;5124.231365295198;5125.948740512585;5137.845864624067;3545.2200515886466;3650.0509867434125;3653.8903832885057;3655.853765849389;3667.4779966314213;3697.90755231116;3711.5175027246287;3715.2755212733796;3725.7578257413184;3730.459083432887;4172.413103875556;4172.457580514574;4175.853845115406;4184.581541845791;4198.9370159447635;4862.6839255448285;4870.125001874233;4873.171560834667;4881.389826271716;4886.486918873467;1227.7851376009162;1268.5243033862303;1271.5740227023866;1284.640300715801;1288.072587736828;809.7854068671807;822.8974968954379;836.3768992100923;837.7947402886332;844.859439756324;3921.941170882439;4170.749755014648;4297.871063868089;4332.653387728974;4349.151915376535;4971.676841005323;4988.90022199554;5021.171506701427;5079.74601269935;5091.592672586185;4340.218760623118;4366.01346387393;4373.759443230653;4376.783064447628;4379.846705365297;2585.3407381117695;2640.828346157494;2654.9734502655115;2669.7196794336314;2684.597310403416;4745.857624271277;4745.905081898342;4748.358971538798;4762.618990480753;4766.332713420124;5121.974390128025;5125.794968201305;5130.743462826844;5153.175491921274;5161.81933632321;4520.932186017212;4714.834980775725;4728.432588089451;4732.148213321635;4738.175802316133;5004.474530174425;5013.323201367769;5024.819167495709;5035.899282014412;5051.393832740095;4957.454679985127;4960.206366981266;4967.130752118437;4991.650584459053;5003.674761140514;4561.703489273186;4754.720751323836;4784.851635607499;4810.42274926997;4813.807447702053;3597.1906321078595;3609.7473176877365;3618.0773902654655;3627.1476203091725;3627.383344831332;5101.617378696538;5107.336046314104;5109.514596113363;5109.948900510947;5123.257127716386;4850.223964165716;4852.1103356597605;4926.556609905126;4951.2078067510465;4958.107540642719;4925.38432695913;4935.457099718957;4950.77721502526;4953.390148201921;4955.736287246729;4818.975905120452;4864.343313652753;4879.560839524318;4891.584215341736;4894.045661096195;4738.147133516;4821.6383771218;4921.606271498343;4941.481144479778;4949.57928576075;4712.151812673752;4776.355192049029;4841.201201801663;4867.95132048675;4871
01:02:26 INFO - PROCESS | 28166 | |5;yui.html;592.2216260259545;637.3626373626371;677.9593224406536;690.5821977703492;695.4158506854242;12385.752284954295;13432.32838358083;13440.596782096529;13450.394732237048;13476.932615336922;12798.488060477594;12827.551035713752;12849.93575032126;12866.356682165877;12889.548865789675;604.2899592978255;607.5686262753451;747.6411322565172;748.5209465941801;766.7661363284196;765.162147448543;770.7880332908439;777.2693667952135;778.2334400615389;778.291754503402;817.0114161864121;819.1685439279137;819.8688209886419;820.4748960665179;820.5404973214988;637.6078711592384;646.8221239159221;785.1481142959896;787.5274835098952;819.0621738109891;590.9202257695199;592.6207227374484;592.6651441935293;592.9140274660193;593.1547544748759;12944.093913426064;12989.545365912241;13003.739925201538;13037.413316400785;13053.804192937114;12265.202761820454;12571.685707857378;12757.170783899017;12804.61586152417;13183.538576149884;11475.885241147565;11567.710807229803;11763.941180294129;11778.764424711544;12060.698482538006;3926.823292951824;3966.504186976628;3985.0834308109297;4036.455078564415;4044.5348784889525;61923.38076619221;61988;62941.6852915737;63899.36100638981;67330.66334668295;9856.852147217798;9915.553800079013;10042.598296068221;10132.645357412455;10196.4391958443;19316.420507384802;19340.516487087934;19348.70976935347;19353.225870965005;19365.225390984204;6616.139901812733;6629.303923088103;6735.595864248063;6838.623875686785;6917.861642767117;3527.224010717638;3563.465480177994;3599.874004409833;3670.871519496805;3722.106694393326;2716.4159705662983;2811.381496070861;2811.9015834446104;2814.4933911896055;2817.9295517611813;436.1669211805436;437.9474463064453;440.68711215037683;442.48671541012914;466.52414537171893;470.4848191230597;483.5623760496756;488.5676176583749;561.5675929534317;572.387545326505;8046.83906321882;8181.590920453954;8289.336853051742;8372.455790373606;8373.790655233546;530.9707966061826;532.8782911970246;565.1409857017311;568.3833041150316;591.2284468768213;3755.5681096673684;3970.50368703912;4003.3594624860466;4043.7169398141846;4119.752814831059;55313;96415.51792240994;97584.51207744058;99473.50263248783;100061;47820;48058.519414806105;86092;86427.56786216029;87487.56256218806;66342;67561.3243867555;68661.999999999;69492.65253673801;70687.64656176789;8354.248117669438;8979.46123232608;9028.845867608514;9100;9338.719838404859;43109.78445107755;43190.35214471848;43474.565254348316;43773;45932.54067459283;54312.45687543074;59660.261152991145;59670.403295966484;60722.08916866339;64891.35108648853;11054.889451105708;11100.389478578756;11380.328162113368;11408.828867566826;11669.35818529989;12749.745005100032;12968.870311297143;12986.844209852756;13147.737045259233;13552.59342219735;11468.4265786712;11536.826947595624;11715.531378744754;12093.57672481459;12218;11750.353730544903;11912.642620721392;12088.39558022113;12649.93675031619;12664.113512054068;11653.65039048796;11710.70723231926;11966.282023078295;12623;12624.116311858083;9566.569504372459;10077.697669069647;10262.692119236435;10617.203709721956;10719.624813131815;10402.895971040192;10765.784684306427;10889.346639201356;10975.396353200651;10988.780224395627
01:02:26 INFO - PROCESS | 28166 | __end_tp_report
01:02:26 INFO - PROCESS | 28166 | __start_cc_report
01:02:26 INFO - PROCESS | 28166 | _x_x_mozilla_cycle_collect,929
01:02:26 INFO - PROCESS | 28166 | __end_cc_report
01:02:26 INFO - PROCESS | 28166 | __startTimestamp1475308946390__endTimestamp
01:02:26 INFO - PROCESS | 28166 |
01:02:26 INFO - PROCESS | 28166 | ------- Summary: start -------
01:02:26 INFO - PROCESS | 28166 | Number of tests: 6
01:02:26 INFO - PROCESS | 28166 |
01:02:26 INFO - PROCESS | 28166 | [#0] dojo.html Cycles:165 Average:4525.47 Median:4633.84 stddev:463.32 (10.0%) stddev-sans-first:437.63
01:02:26 INFO - PROCESS | 28166 | Values: 2534.9 2559.9 2604.2 2604.7 2611.6 4422.3 4490.8 4559.8 4565.4 4576.5 4504.4 4509.0 4530.8 4560.5 4567.6 4144.9 4177.3 4191.3 4202.9 4228.3 3946.3 4226.6 4292.4 4337.1 4371.3 4273.8 4336.5 4342.6 4372.4 4378.1 4100.8 4155.7 4156.3 4215.6 4256.8 4197.6 4203.3 4212.7 4285.9 4304.2 4616.1 4650.6 4656.9 4678.2 4708.0 4764.4 4821.1 4918.5 4939.0 4959.7 4862.7 4893.9 4945.8 4963.3 4970.5 4609.6 4621.4 4631.4 4633.3 4643.7 4842.7 5039.3 5044.4 5053.2 5115.3 4686.7 4737.7 4790.5 4793.7 4833.5 4866.4 4867.8 4886.4 4910.1 4938.7 4827.5 4845.4 4851.1 4885.2 4901.5 4616.9 4669.0 4673.7 4868.1 4880.2 4013.3 4068.9 4105.1 4112.1 4154.9 3616.6 3624.7 3658.5 3661.9 3678.9 4252.6 4265.3 4289.2 4291.9 4348.2 4721.0 4773.8 4906.7 4939.0 4968.3 4253.3 4335.7 4381.4 4388.6 4388.6 4424.1 4434.4 4437.8 4438.8 4490.1 4435.8 4464.4 4562.3 4697.0 4761.4 4872.3 4906.7 4914.5 4944.4 4945.8 4612.6 4627.5 4633.8 4644.3 4683.4 4685.7 4751.9 4832.7 4833.7 4890.1 4857.4 4937.1 4952.9 4955.5 5015.7 4759.9 4774.2 4787.7 4789.8 4839.5 4587.8 4765.6 4772.1 4783.9 4837.8 4559.9 4645.2 4686.1 4698.2 4745.6 4760.6 4771.4 4775.7 4777.9 4821.7 4486.1 4554.8 4575.5 4627.2 4649.4
01:02:26 INFO - PROCESS | 28166 |
01:02:26 INFO - PROCESS | 28166 | [#1] ext.html Cycles:180 Average:55477.40 Median:36199.55 stddev:123660.19 (341.6%) stddev-sans-first:123938.34
01:02:26 INFO - PROCESS | 28166 | Values: 559.8 574.8 578.9 579.3 580.1 28237.7 39533.0 40690.8 40704.4 43691.8 40032.8 40371.6 40391.4 40395.0 40402.8 7524.0 7665.5 7677.5 7689.2 7698.9 7574.9 7694.0 7723.2 7728.8 7731.7 7705.3 7750.3 7755.1 7762.6 7769.7 7652.8 7685.4 7728.5 7730.0 7734.3 7671.5 7731.9 7742.7 7744.2 7756.1 38296.6 38482.8 38555.8 38656.4 38741.6 2884.5 2895.9 2919.9 2928.8 2950.5 28217.3 28384.9 28406.3 29046.0 29146.1 3385.6 3418.1 3505.3 3527.9 3534.3 252077.0 252592.0 253480.0 253779.0 254654.7 52197.7 52421.7 52522.0 52554.0 52584.0 32581.2 33512.3 33614.2 54222.2 54586.0 13055.0 13218.0 13222.0 13226.3 13250.9 11673.9 11818.9 11820.7 11821.9 11823.9 17582.7 17623.5 17720.6 17747.5 17829.9 6667.6 6691.0 6717.6 6811.7 6889.6 770.8 824.8 922.0 948.1 985.0 27420.2 27590.0 28415.3 28556.3 28839.7 759.0 917.1 926.7 961.8 964.9 13643.5 14687.9 14809.5 14893.8 15031.1 664391.1 681070.0 682074.0 683025.0 683726.0 49570.8 50399.7 50411.5 50438.2 50459.2 1028.2 1088.9 1130.9 1176.5 1196.1 27229.7 29525.3 29578.7 29938.6 30218.4 41971.8 42506.4 42528.0 42584.0 42607.4 325588.0 328852.0 329016.0 329038.0 330145.0 25053.6 25315.0 25543.6 26026.5 27048.0 41558.4 41706.8 41809.8 42080.0 42178.6 35429.1 35494.1 35680.0 35798.3 36371.3 35714.8 35836.8 35877.3 36313.8 36536.3 35239.3 35748.8 35770.6 35991.5 36085.3 31037.2 33044.3 33300.3 33520.3 33753.5 25090.4 25374.0 25465.6 25619.7 25709.4
01:02:26 INFO - PROCESS | 28166 |
01:02:26 INFO - PROCESS | 28166 | [#2] jquery.html Cycles:180 Average:23194.25 Median:4015.69 stddev:61267.10 (1525.7%) stddev-sans-first:61414.93
01:02:26 INFO - PROCESS | 28166 | Values: 334.6 345.6 359.5 362.5 374.6 12170.9 15688.5 16132.6 16513.8 17579.2 16154.9 16501.1 16577.6 16627.6 16693.5 3986.9 4968.7 5169.8 5191.4 5216.4 5054.1 5078.7 5097.7 5103.1 5143.0 4897.9 5019.3 5077.6 5091.8 5113.3 5064.6 5092.2 5094.8 5096.9 5106.6 4383.2 4496.3 4549.5 4552.9 4559.5 20431.0 20505.4 20581.9 20657.7 20764.9 1804.0 1819.2 2307.0 2369.4 2402.2 11307.9 12363.5 12793.6 13300.7 13438.6 1550.4 1641.6 1647.7 1666.9 1704.8 68478.7 69583.0 69952.3 69985.7 70798.0 9251.2 9491.7 9546.5 9628.8 9757.0 12678.8 12708.9 12716.9 12717.2 12721.1 6928.3 7273.9 7303.5 7431.6 7433.1 7118.0 7155.3 7308.8 7333.7 7348.8 3906.7 3970.6 3980.4 4044.5 4061.6 1636.4 1646.6 1677.3 1684.7 1712.0 790.5 801.9 827.4 883.0 923.7 16455.3 17125.7 17361.5 17791.9 17925.5 777.7 792.2 793.6 797.5 883.7 7206.6 9204.2 9500.5 9635.2 9676.0 363299.0 368666.0 371764.0 372907.0 383466.0 46640.8 46719.3 49740.8 76389.6 76598.2 846.3 850.4 853.4 870.3 875.1 15062.2 15117.3 15809.8 16034.4 16063.5 35961.8 36729.0 36775.6 37248.3 37816.0 48537.0 49780.3 49994.5 50079.0 50609.2 4661.3 5068.8 7264.4 7461.0 7542.8 8540.7 10954.7 11319.7 11324.7 11675.6 9849.2 9962.1 10259.5 10536.2 10543.5 10145.1 10197.1 10260.4 10414.6 10510.0 10012.7 10549.2 10585.1 10687.6 10974.2 7247.4 7382.6 7454.1 7493.3 7583.8 10310.1 10426.8 10460.1 10464.5 10931.3
01:02:26 INFO - PROCESS | 28166 |
01:02:26 INFO - PROCESS | 28166 | [#3] mootools.html Cycles:180 Average:4662.08 Median:5661.32 stddev:2562.42 (45.3%) stddev-sans-first:2556.28
01:02:26 INFO - PROCESS | 28166 | Values: 1183.7 1332.2 1365.8 1410.3 1667.8 6174.9 6822.2 7132.4 7154.6 7334.0 7188.7 7257.9 7270.8 7275.8 7286.6 2049.4 2074.5 2075.6 2077.6 2081.6 2063.3 2104.6 2104.7 2108.2 2115.6 2039.9 2043.9 2049.7 2052.6 2057.3 1985.9 2009.0 2009.6 2011.6 2013.8 1955.7 1962.2 2019.2 2022.5 2025.5 7051.8 7084.5 7135.5 7169.2 7334.2 4264.8 4405.6 4408.8 4412.8 4415.0 2657.6 2796.4 2832.3 2837.9 2847.3 922.3 928.2 940.4 955.3 960.3 9547.4 9611.7 9640.0 9644.1 9644.8 3702.0 3762.9 3769.1 3824.4 3833.1 7768.5 7787.7 7840.3 7855.5 7864.9 4282.5 4287.9 4290.3 4292.4 4292.6 3372.6 3497.7 3841.4 3998.6 4001.4 3091.3 3134.9 3199.6 3211.1 3214.9 899.1 902.4 907.7 921.5 932.4 804.7 805.3 806.1 811.6 811.9 4702.1 4712.8 4757.8 4783.9 5052.9 359.6 372.1 882.1 902.9 942.2 3391.6 3539.2 3572.2 3596.6 3597.2 8264.8 8508.5 8666.6 8772.4 8774.6 8654.8 8658.8 8660.1 8754.8 8777.2 6690.3 6813.5 6819.9 6829.9 6834.4 4902.1 4963.7 5008.8 5063.4 5131.7 7893.8 7959.6 8134.7 8153.8 8169.5 7738.6 8332.2 8386.5 8403.5 8404.2 5934.7 6298.3 6298.3 6302.1 6308.2 6066.0 6144.1 6307.1 6374.4 6387.4 5767.1 5786.5 5831.2 5838.5 5861.6 5613.2 5661.5 5667.4 5690.4 5694.6 5608.4 5657.1 5661.2 5664.6 5666.7 4043.1 4192.4 4272.9 4325.2 4451.1 4133.9 4193.6 4328.0 4363.4 4449.3
01:02:26 INFO - PROCESS | 28166 |
01:02:26 INFO - PROCESS | 28166 | [#4] prototype.html Cycles:180 Average:4090.25 Median:4695.96 stddev:1180.13 (25.1%) stddev-sans-first:1148.41
01:02:26 INFO - PROCESS | 28166 | Values: 287.7 290.7 293.5 296.8 299.0 4680.4 4735.9 4737.2 4751.4 4764.4 4686.0 4691.5 4695.0 4696.9 4700.6 3505.5 3629.9 3638.8 3646.9 3648.3 3550.2 3646.2 3702.1 3718.5 3729.0 3684.6 3688.2 3688.9 3690.6 3707.2 3627.9 3678.1 3681.4 3694.9 3698.3 3269.9 3276.5 3278.9 3280.3 3300.3 4562.5 4566.9 4580.8 4584.2 4588.6 4218.0 4221.6 4227.5 4229.7 4231.0 4764.0 4847.0 4883.0 4910.6 4919.5 3571.2 3574.0 3575.7 3583.5 3584.6 5111.0 5121.3 5124.2 5125.9 5137.8 3545.2 3650.1 3653.9 3655.9 3667.5 3697.9 3711.5 3715.3 3725.8 3730.5 4172.4 4172.5 4175.9 4184.6 4198.9 4862.7 4870.1 4873.2 4881.4 4886.5 1227.8 1268.5 1271.6 1284.6 1288.1 809.8 822.9 836.4 837.8 844.9 3921.9 4170.7 4297.9 4332.7 4349.2 4971.7 4988.9 5021.2 5079.7 5091.6 4340.2 4366.0 4373.8 4376.8 4379.8 2585.3 2640.8 2655.0 2669.7 2684.6 4745.9 4745.9 4748.4 4762.6 4766.3 5122.0 5125.8 5130.7 5153.2 5161.8 4520.9 4714.8 4728.4 4732.1 4738.2 5004.5 5013.3 5024.8 5035.9 5051.4 4957.5 4960.2 4967.1 4991.7 5003.7 4561.7 4754.7 4784.9 4810.4 4813.8 3597.2 3609.7 3618.1 3627.1 3627.4 5101.6 5107.3 5109.5 5109.9 5123.3 4850.2 4852.1 4926.6 4951.2 4958.1 4925.4 4935.5 4950.8 4953.4 4955.7 4819.0 4864.3 4879.6 4891.6 4894.0 4738.1 4821.6 4921.6 4941.5 4949.6 4712.2 4776.4 4841.2 4868.0 4871.0
01:02:26 INFO - PROCESS | 28166 |
01:02:26 INFO - PROCESS | 28166 | [#5] yui.html Cycles:180 Average:17097.09 Median:21955.37 stddev:23651.16 (107.7%) stddev-sans-first:23685.04
01:02:26 INFO - PROCESS | 28166 | Values: 592.2 637.4 678.0 690.6 695.4 12385.8 13432.3 13440.6 13450.4 13476.9 12798.5 12827.6 12849.9 12866.4 12889.5 604.3 607.6 747.6 748.5 766.8 765.2 770.8 777.3 778.2 778.3 817.0 819.2 819.9 820.5 820.5 637.6 646.8 785.1 787.5 819.1 590.9 592.6 592.7 592.9 593.2 12944.1 12989.5 13003.7 13037.4 13053.8 12265.2 12571.7 12757.2 12804.6 13183.5 11475.9 11567.7 11763.9 11778.8 12060.7 3926.8 3966.5 3985.1 4036.5 4044.5 61923.4 61988.0 62941.7 63899.4 67330.7 9856.9 9915.6 10042.6 10132.6 10196.4 19316.4 19340.5 19348.7 19353.2 19365.2 6616.1 6629.3 6735.6 6838.6 6917.9 3527.2 3563.5 3599.9 3670.9 3722.1 2716.4 2811.4 2811.9 2814.5 2817.9 436.2 437.9 440.7 442.5 466.5 470.5 483.6 488.6 561.6 572.4 8046.8 8181.6 8289.3 8372.5 8373.8 531.0 532.9 565.1 568.4 591.2 3755.6 3970.5 4003.4 4043.7 4119.8 55313.0 96415.5 97584.5 99473.5 100061.0 47820.0 48058.5 86092.0 86427.6 87487.6 66342.0 67561.3 68662.0 69492.7 70687.6 8354.2 8979.5 9028.8 9100.0 9338.7 43109.8 43190.4 43474.6 43773.0 45932.5 54312.5 59660.3 59670.4 60722.1 64891.4 11054.9 11100.4 11380.3 11408.8 11669.4 12749.7 12968.9 12986.8 13147.7 13552.6 11468.4 11536.8 11715.5 12093.6 12218.0 11750.4 11912.6 12088.4 12649.9 12664.1 11653.7 11710.7 11966.3 12623.0 12624.1 9566.6 10077.7 10262.7 10617.2 10719.6 10402.9 10765.8 10889.3 10975.4 10988.8
01:02:26 INFO - PROCESS | 28166 | -------- Summary: end --------
01:02:26 INFO - PROCESS | 28166 |
01:02:27 INFO - TEST-INFO | 28166: exit 0
01:02:27 INFO - TEST-OK | dromaeo_css | took 1121816ms
01:02:27 INFO - TEST-START | kraken
01:02:27 INFO - operating with platform_type : linux_
01:02:27 INFO - Initialising browser for kraken test...
01:02:27 INFO - TEST-INFO | started process 28472 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp4bHQXc/profile http://localhost:48410/getInfo.html)
01:02:32 INFO - PROCESS | 28472 | __metrics Screen width/height:1600/1200
01:02:32 INFO - PROCESS | 28472 | colorDepth:24
01:02:32 INFO - PROCESS | 28472 | Browser inner width/height: 1024/697
01:02:32 INFO - PROCESS | 28472 | __metrics
01:02:33 INFO - PROCESS | 28472 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows"
01:02:33 INFO - PROCESS | 28472 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver]
01:02:33 INFO - PROCESS | 28472 | console.error: PushService:
01:02:33 INFO - PROCESS | 28472 | stateChangeProcessEnqueue: Error transitioning state
01:02:33 INFO - PROCESS | 28472 | UnknownError
01:02:34 INFO - TEST-INFO | 28472: exit 0
01:02:34 INFO - Browser initialized.
01:02:34 INFO - Running cycle 1/1 for kraken test...
01:02:34 INFO - TEST-INFO | started process 28553 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp4bHQXc/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1)
01:02:46 INFO - PROCESS | 28553 | RSS: Main: 175321088
01:02:46 INFO - PROCESS | 28553 |
01:02:49 INFO - PROCESS | 28553 | Cycle 1(1): loaded http://localhost:48410/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:48410/tests/kraken/driver.html?testName=audio-beat-detection)
01:02:50 INFO - PROCESS | 28553 | RSS: Main: 242479104
01:02:50 INFO - PROCESS | 28553 |
01:02:53 INFO - PROCESS | 28553 | Cycle 1(1): loaded http://localhost:48410/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:48410/tests/kraken/driver.html?testName=audio-dft)
01:02:53 INFO - PROCESS | 28553 | RSS: Main: 217939968
01:02:53 INFO - PROCESS | 28553 |
01:02:56 INFO - PROCESS | 28553 | Cycle 1(1): loaded http://localhost:48410/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:48410/tests/kraken/driver.html?testName=audio-fft)
01:02:57 INFO - PROCESS | 28553 | RSS: Main: 300208128
01:02:57 INFO - PROCESS | 28553 |
01:02:59 INFO - PROCESS | 28553 | Cycle 1(1): loaded http://localhost:48410/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:48410/tests/kraken/driver.html?testName=audio-oscillator)
01:03:00 INFO - PROCESS | 28553 | RSS: Main: 210210816
01:03:00 INFO - PROCESS | 28553 |
01:03:02 INFO - PROCESS | 28553 | Cycle 1(1): loaded http://localhost:48410/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:48410/tests/kraken/driver.html?testName=imaging-gaussian-blur)
01:03:03 INFO - PROCESS | 28553 | RSS: Main: 213729280
01:03:03 INFO - PROCESS | 28553 |
01:03:06 INFO - PROCESS | 28553 | Cycle 1(1): loaded http://localhost:48410/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:48410/tests/kraken/driver.html?testName=imaging-darkroom)
01:03:06 INFO - PROCESS | 28553 | RSS: Main: 250744832
01:03:06 INFO - PROCESS | 28553 |
01:03:10 INFO - PROCESS | 28553 | Cycle 1(1): loaded http://localhost:48410/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:48410/tests/kraken/driver.html?testName=imaging-desaturate)
01:03:11 INFO - PROCESS | 28553 | RSS: Main: 249450496
01:03:11 INFO - PROCESS | 28553 |
01:03:13 INFO - PROCESS | 28553 | Cycle 1(1): loaded http://localhost:48410/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:48410/tests/kraken/driver.html?testName=json-parse-financial)
01:03:14 INFO - PROCESS | 28553 | RSS: Main: 249667584
01:03:14 INFO - PROCESS | 28553 |
01:03:16 INFO - PROCESS | 28553 | Cycle 1(1): loaded http://localhost:48410/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:48410/tests/kraken/driver.html?testName=json-stringify-tinderbox)
01:03:16 INFO - PROCESS | 28553 | RSS: Main: 212033536
01:03:16 INFO - PROCESS | 28553 |
01:03:18 INFO - PROCESS | 28553 | Cycle 1(1): loaded http://localhost:48410/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:48410/tests/kraken/driver.html?testName=stanford-crypto-aes)
01:03:19 INFO - PROCESS | 28553 | RSS: Main: 218886144
01:03:19 INFO - PROCESS | 28553 |
01:03:21 INFO - PROCESS | 28553 | Cycle 1(1): loaded http://localhost:48410/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:48410/tests/kraken/driver.html?testName=stanford-crypto-ccm)
01:03:22 INFO - PROCESS | 28553 | RSS: Main: 223428608
01:03:22 INFO - PROCESS | 28553 |
01:03:25 INFO - PROCESS | 28553 | Cycle 1(1): loaded http://localhost:48410/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:48410/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2)
01:03:25 INFO - PROCESS | 28553 | RSS: Main: 224428032
01:03:25 INFO - PROCESS | 28553 |
01:03:28 INFO - PROCESS | 28553 | Cycle 1(1): loaded http://localhost:48410/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:48410/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative)
01:03:29 INFO - PROCESS | 28553 | RSS: Main: 222715904
01:03:29 INFO - PROCESS | 28553 |
01:03:31 INFO - PROCESS | 28553 | Cycle 1(1): loaded http://localhost:48410/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:48410/tests/kraken/driver.html?testName=ai-astar)
01:03:31 INFO - PROCESS | 28553 | RSS: Main: 274276352
01:03:31 INFO - PROCESS | 28553 |
01:03:31 INFO - PROCESS | 28553 | __start_tp_report
01:03:31 INFO - PROCESS | 28553 | _x_x_mozilla_page_load
01:03:31 INFO - PROCESS | 28553 | _x_x_mozilla_page_load_details
01:03:31 INFO - PROCESS | 28553 | |i|pagename|runs|
01:03:31 INFO - PROCESS | 28553 | |0;ai-astar;115;116;117;116;114;116;116;116;116;116
01:03:31 INFO - PROCESS | 28553 | |1;audio-beat-detection;158;135;132;175;140;127;129;130;172;133
01:03:31 INFO - PROCESS | 28553 | |2;audio-dft;162;162;162;163;161;161;163;162;161;163
01:03:31 INFO - PROCESS | 28553 | |3;audio-fft;78;77;76;109;77;76;76;79;114;78
01:03:31 INFO - PROCESS | 28553 | |4;audio-oscillator;84;84;111;85;85;85;110;84;84;109
01:03:31 INFO - PROCESS | 28553 | |5;imaging-gaussian-blur;117;117;116;117;117;117;117;117;121;117
01:03:31 INFO - PROCESS | 28553 | |6;imaging-darkroom;146;146;147;147;148;147;147;146;146;146
01:03:31 INFO - PROCESS | 28553 | |7;imaging-desaturate;96;96;95;96;96;95;95;95;95;95
01:03:31 INFO - PROCESS | 28553 | |8;json-parse-financial;67;63;62;63;66;70;66;68;69;67
01:03:31 INFO - PROCESS | 28553 | |9;json-stringify-tinderbox;66;69;66;67;69;68;66;67;67;67
01:03:31 INFO - PROCESS | 28553 | |10;stanford-crypto-aes;85;85;83;84;85;84;84;93;82;84
01:03:31 INFO - PROCESS | 28553 | |11;stanford-crypto-ccm;143;146;150;151;146;141;151;146;177;145
01:03:31 INFO - PROCESS | 28553 | |12;stanford-crypto-pbkdf2;183;173;175;176;175;174;173;178;179;180
01:03:31 INFO - PROCESS | 28553 | |13;stanford-crypto-sha256-iterative;77;73;71;71;71;71;70;73;70;71
01:03:31 INFO - PROCESS | 28553 | __end_tp_report
01:03:31 INFO - PROCESS | 28553 | __start_cc_report
01:03:31 INFO - PROCESS | 28553 | _x_x_mozilla_cycle_collect,1943
01:03:31 INFO - PROCESS | 28553 | __end_cc_report
01:03:31 INFO - PROCESS | 28553 | __startTimestamp1475309011599__endTimestamp
01:03:31 INFO - PROCESS | 28553 |
01:03:31 INFO - PROCESS | 28553 | ------- Summary: start -------
01:03:31 INFO - PROCESS | 28553 | Number of tests: 14
01:03:31 INFO - PROCESS | 28553 |
01:03:31 INFO - PROCESS | 28553 | [#0] ai-astar Cycles:10 Average:115.80 Median:116.00 stddev:0.79 (0.7%) stddev-sans-first:0.78
01:03:31 INFO - PROCESS | 28553 | Values: 115.0 116.0 117.0 116.0 114.0 116.0 116.0 116.0 116.0 116.0
01:03:31 INFO - PROCESS | 28553 |
01:03:31 INFO - PROCESS | 28553 | [#1] audio-beat-detection Cycles:10 Average:143.10 Median:137.50 stddev:18.27 (13.3%) stddev-sans-first:18.57
01:03:31 INFO - PROCESS | 28553 | Values: 158.0 135.0 132.0 175.0 140.0 127.0 129.0 130.0 172.0 133.0
01:03:31 INFO - PROCESS | 28553 |
01:03:31 INFO - PROCESS | 28553 | [#2] audio-dft Cycles:10 Average:162.00 Median:162.00 stddev:0.82 (0.5%) stddev-sans-first:0.87
01:03:31 INFO - PROCESS | 28553 | Values: 162.0 162.0 162.0 163.0 161.0 161.0 163.0 162.0 161.0 163.0
01:03:31 INFO - PROCESS | 28553 |
01:03:31 INFO - PROCESS | 28553 | [#3] audio-fft Cycles:10 Average:84.00 Median:77.00 stddev:14.58 (18.9%) stddev-sans-first:15.30
01:03:31 INFO - PROCESS | 28553 | Values: 78.0 77.0 76.0 109.0 77.0 76.0 76.0 79.0 114.0 78.0
01:03:31 INFO - PROCESS | 28553 |
01:03:31 INFO - PROCESS | 28553 | [#4] audio-oscillator Cycles:10 Average:92.10 Median:84.00 stddev:12.37 (14.7%) stddev-sans-first:12.77
01:03:31 INFO - PROCESS | 28553 | Values: 84.0 84.0 111.0 85.0 85.0 85.0 110.0 84.0 84.0 109.0
01:03:31 INFO - PROCESS | 28553 |
01:03:31 INFO - PROCESS | 28553 | [#5] imaging-gaussian-blur Cycles:10 Average:117.30 Median:117.00 stddev:1.34 (1.1%) stddev-sans-first:1.41
01:03:31 INFO - PROCESS | 28553 | Values: 117.0 117.0 116.0 117.0 117.0 117.0 117.0 117.0 121.0 117.0
01:03:31 INFO - PROCESS | 28553 |
01:03:31 INFO - PROCESS | 28553 | [#6] imaging-darkroom Cycles:10 Average:146.60 Median:147.00 stddev:0.70 (0.5%) stddev-sans-first:0.71
01:03:31 INFO - PROCESS | 28553 | Values: 146.0 146.0 147.0 147.0 148.0 147.0 147.0 146.0 146.0 146.0
01:03:31 INFO - PROCESS | 28553 |
01:03:31 INFO - PROCESS | 28553 | [#7] imaging-desaturate Cycles:10 Average:95.40 Median:95.50 stddev:0.52 (0.5%) stddev-sans-first:0.50
01:03:31 INFO - PROCESS | 28553 | Values: 96.0 96.0 95.0 96.0 96.0 95.0 95.0 95.0 95.0 95.0
01:03:31 INFO - PROCESS | 28553 |
01:03:31 INFO - PROCESS | 28553 | [#8] json-parse-financial Cycles:10 Average:66.10 Median:67.00 stddev:2.69 (4.0%) stddev-sans-first:2.83
01:03:31 INFO - PROCESS | 28553 | Values: 67.0 63.0 62.0 63.0 66.0 70.0 66.0 68.0 69.0 67.0
01:03:31 INFO - PROCESS | 28553 |
01:03:31 INFO - PROCESS | 28553 | [#9] json-stringify-tinderbox Cycles:10 Average:67.20 Median:67.00 stddev:1.14 (1.7%) stddev-sans-first:1.12
01:03:31 INFO - PROCESS | 28553 | Values: 66.0 69.0 66.0 67.0 69.0 68.0 66.0 67.0 67.0 67.0
01:03:31 INFO - PROCESS | 28553 |
01:03:31 INFO - PROCESS | 28553 | [#10] stanford-crypto-aes Cycles:10 Average:84.90 Median:84.50 stddev:3.00 (3.5%) stddev-sans-first:3.18
01:03:31 INFO - PROCESS | 28553 | Values: 85.0 85.0 83.0 84.0 85.0 84.0 84.0 93.0 82.0 84.0
01:03:31 INFO - PROCESS | 28553 |
01:03:31 INFO - PROCESS | 28553 | [#11] stanford-crypto-ccm Cycles:10 Average:149.60 Median:148.00 stddev:10.18 (6.9%) stddev-sans-first:10.51
01:03:31 INFO - PROCESS | 28553 | Values: 143.0 146.0 150.0 151.0 146.0 141.0 151.0 146.0 177.0 145.0
01:03:31 INFO - PROCESS | 28553 |
01:03:31 INFO - PROCESS | 28553 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:176.60 Median:177.00 stddev:3.31 (1.9%) stddev-sans-first:2.57
01:03:31 INFO - PROCESS | 28553 | Values: 183.0 173.0 175.0 176.0 175.0 174.0 173.0 178.0 179.0 180.0
01:03:31 INFO - PROCESS | 28553 |
01:03:31 INFO - PROCESS | 28553 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:71.80 Median:71.00 stddev:2.10 (3.0%) stddev-sans-first:1.09
01:03:31 INFO - PROCESS | 28553 | Values: 77.0 73.0 71.0 71.0 71.0 71.0 70.0 73.0 70.0 71.0
01:03:31 INFO - PROCESS | 28553 | -------- Summary: end --------
01:03:31 INFO - PROCESS | 28553 |
01:03:32 INFO - TEST-INFO | 28553: exit 0
01:03:32 INFO - TEST-OK | kraken | took 65550ms
01:03:32 INFO - SUITE-END | took 1187s
01:03:33 INFO - Completed test suite (00:19:47)
01:03:33 INFO - javascript benchmark
01:03:33 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2534.860582667953, 2559.8592077435756, 2604.1927002629186, 2604.661394018777, 2611.6213149093383, 4422.314541246112, 4490.797914093865, 4559.772011399429, 4565.383673204116, 4576.450825900893, 4504.391907092541, 4508.97745511272, 4530.773461326929, 4560.498345182027, 4567.634589232862, 4144.896377590554, 4177.310743727281, 4191.308434108384, 4202.915941681164, 4228.281192197333, 3946.2699400610977, 4226.577342265764, 4292.399064131024, 4337.110892267094, 4371.27873900806, 4273.829046838123, 4336.479622445311, 4342.609165175118, 4372.409724687174, 4378.058717375764, 4100.835966561334, 4155.729877557949, 4156.293430116887, 4215.620594146541, 4256.765877876715, 4197.601227883377, 4203.285441474956, 4212.726172798758, 4285.871423857289, 4304.225239456897, 4616.1229366420275, 4650.604698600623, 4656.906861862778, 4678.228092364756, 4708.034852855157, 4764.404449443819, 4821.108095002401, 4918.532739389752, 4939.0, 4959.727215003173, 4862.708237505761, 4893.853184404474, 4945.752712364368, 4963.255511673278, 4970.478099799541, 4609.562091601292, 4621.445426548836, 4631.3516107744945, 4633.30500424939, 4643.674942753974, 4842.685225460334, 5039.3448851649055, 5044.394672639307, 5053.166227572483, 5115.2582875483595, 4686.718796872198, 4737.668363214542, 4790.544898234732, 4793.736344501086, 4833.516648335139, 4866.367372241586, 4867.780949857265, 4886.364772579542, 4910.06708725341, 4938.678985865908, 4827.541383568555, 4845.41854977405, 4851.078295123915, 4885.218365061573, 4901.509849015141, 4616.907661846744, 4668.976655116703, 4673.719576825333, 4868.050730107595, 4880.243562247857, 4013.337799263089, 4068.898277543085, 4105.137921036616, 4112.09533902541, 4154.896127596834, 3616.6202548732003, 3624.6737793598704, 3658.451232315174, 3661.9450708239397, 3678.8528458861883, 4252.55348188442, 4265.253580623378, 4289.1850548395705, 4291.935620965688, 4348.239058164809, 4720.976395118002, 4773.809047638056, 4906.656534042583, 4939.0, 4968.254761785761, 4253.298205796009, 4335.696501244883, 4381.40850985113, 4388.626966707801, 4388.648908087345, 4424.137293227854, 4434.401355816988, 4437.7781110944325, 4438.755868427203, 4490.101979604092, 4435.82256709728, 4464.3973063635995, 4562.270036794097, 4697.037107392976, 4761.40482439695, 4872.342233798534, 4906.656534042726, 4914.508549145057, 4944.406671199479, 4945.77744001528, 4612.607928325996, 4627.53724627548, 4633.837815676435, 4644.303354496852, 4683.36774535447, 4685.695429797052, 4751.9287210692555, 4832.661713680009, 4833.73414462208, 4890.095332363524, 4857.392825896763, 4937.086638971802, 4952.925706114339, 4955.479674634112, 5015.749212539431, 4759.857204283877, 4774.236122220428, 4787.664863459524, 4789.760511974457, 4839.491853355347, 4587.839425620087, 4765.571098601143, 4772.117158325721, 4783.904321913612, 4837.806487740591, 4559.931601026054, 4645.233536466445, 4686.0862131885315, 4698.154332220233, 4745.572898439157, 4760.6191504678845, 4771.355866958055, 4775.689580177277, 4777.880552986203, 4821.710697358169, 4486.147631949919, 4554.817807287672, 4575.473820510684, 4627.236505976476, 4649.442066951988], "value": 4496.768252719, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [559.8348487196276, 574.8103125968431, 578.8697543052813, 579.32219303415, 580.1066357808975, 28237.71762282379, 39533.0, 40690.79654601723, 40704.38943415844, 43691.78154109233, 40032.79983600085, 40371.59628403715, 40391.39412908809, 40394.980250987406, 40402.797986010104, 7523.962380188105, 7665.4634175607725, 7677.539347639132, 7689.192634773352, 7698.923010769877, 7574.9242507575045, 7694.0, 7723.150453450144, 7728.806779830493, 7731.690732370698, 7705.267999540063, 7750.302472777449, 7755.108162561293, 7762.611869406507, 7769.728059517918, 7652.780693598849, 7685.385169186479, 7728.459007869451, 7729.961350193213, 7734.265244801763, 7671.462997590171, 7731.922680773177, 7742.651580678883, 7744.186860379636, 7756.146823849372, 38296.617033829585, 38482.80758596217, 38555.807220963994, 38656.42015369772, 38741.612583874085, 2884.538473844196, 2895.884164633412, 2919.8832046718107, 2928.8389138597367, 2950.468915595192, 28217.294567635974, 28384.858075709697, 28406.28984275389, 29046.0, 29146.125616231548, 3385.5937287525408, 3418.1454636340914, 3505.3164632896596, 3527.94708079379, 3534.3108093921696, 252077.0, 252592.0, 253480.0, 253779.0, 254654.72672636702, 52197.7390113047, 52421.7378913103, 52522.0, 52554.0, 52584.0, 32581.18547036343, 33512.329753404796, 33614.15964600856, 54222.186667200025, 54586.0, 13055.0, 13218.0, 13222.0, 13226.272555009567, 13250.933745331211, 11673.941630291794, 11818.881811181951, 11820.704482387837, 11821.940890295493, 11823.88176118245, 17582.736258956127, 17623.471295861145, 17720.55698607545, 17747.46757597274, 17829.910850445664, 6667.566608170453, 6690.966545167243, 6717.596944183365, 6811.727530898807, 6889.552179108342, 770.8034451215017, 824.7855557555079, 921.9858156028315, 948.127722495306, 984.9655262065793, 27420.17739467819, 27590.0, 28415.289617759307, 28556.286092847844, 28839.711602884123, 758.962051897403, 917.1104029091771, 926.6849271247808, 961.7543037008663, 964.9276304277207, 13643.454261829615, 14687.926560367343, 14809.48166814178, 14893.77659335111, 15031.098134111988, 664391.1024003931, 681070.0, 682074.0, 683025.0, 683726.0, 49570.752146239036, 50399.74800125976, 50411.49588504068, 50438.243426348636, 50459.24311135336, 1028.2082796246848, 1088.9455527223606, 1130.9264897781618, 1176.4882276209876, 1196.1447564991074, 27229.72770272351, 29525.26186845346, 29578.704212957597, 29938.550921736627, 30218.395632087675, 41971.790141049096, 42506.36240456458, 42528.0, 42584.0, 42607.360889587304, 325588.0, 328852.0, 329016.0, 329038.0, 330145.0, 25053.624195637443, 25315.0, 25543.6168457477, 26026.479470410864, 27048.024717281478, 41558.37662435006, 41706.79146604247, 41809.79095104505, 42080.0, 42178.578214217465, 35429.1142721434, 35494.112647184025, 35680.0, 35798.28403431969, 36371.27257454783, 35714.821425893744, 35836.82081589576, 35877.28245435129, 36313.818430907675, 36536.26927461489, 35239.29521409506, 35748.821255893556, 35770.64229357673, 35991.460128098624, 36085.27829443344, 31037.15131634856, 33044.339113217124, 33300.333993320484, 33520.32959340848, 33753.49369759505, 25090.37274068163, 25374.0, 25465.61801573015, 25619.743802561738, 25709.3572660685], "value": 17540.52396702713, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [334.63859032245176, 345.62672313900987, 359.53799367812366, 362.46174430970007, 374.6178897524525, 12170.939145304272, 15688.450904218354, 16132.596685082879, 16513.752293715574, 17579.208935597897, 16154.919225403857, 16501.0924399158, 16577.585560360967, 16627.584310392245, 16693.49919502414, 3986.8637438330084, 4968.677035992658, 5169.844904652848, 5191.402988656297, 5216.426193118754, 5054.115529782292, 5078.720670363128, 5097.694138351692, 5103.081445339837, 5142.974285128569, 4897.926531102036, 5019.29729837823, 5077.593792496591, 5091.821786237482, 5113.284140220372, 5064.594832413398, 5092.159793634064, 5094.847154585368, 5096.92354614683, 5106.617003724736, 4383.232934236527, 4496.348029535699, 4549.454065512126, 4552.8861778455475, 4559.52125026874, 20431.0, 20505.38483845487, 20581.8970905146, 20657.690134647994, 20764.896175519025, 1803.9549011274823, 1819.1904602451914, 2307.031046960264, 2369.4194922243987, 2402.1712509184304, 11307.886921130766, 12363.505459781598, 12793.55222567215, 13300.667483312898, 13438.596842094752, 1550.3643506162418, 1641.564985278902, 1647.7281248593968, 1666.8583170430527, 1704.7613334133232, 68478.65760671215, 69583.0, 69952.3004769951, 69985.65007174932, 70798.0, 9251.167394934488, 9491.715248542554, 9546.522673866419, 9628.75928101789, 9757.0, 12678.84459641863, 12708.936455317664, 12716.936415318049, 12717.173383730027, 12721.109522333349, 6928.341807528277, 7273.927260727431, 7303.525270857377, 7431.628418579049, 7433.070866141732, 7118.006958051754, 7155.284471552907, 7308.817279567947, 7333.669984850694, 7348.816279593053, 3906.746061505993, 3970.6426421621613, 3980.402939559089, 4044.51465824103, 4061.6442463371764, 1636.3781762930248, 1646.6295083606092, 1677.3123019561922, 1684.7005224453608, 1712.0, 790.4861839804173, 801.9198080192051, 827.4084029918637, 882.9867551986725, 923.690563661181, 16455.25951332193, 17125.743113853303, 17361.47915562535, 17791.911040444975, 17925.46223613294, 777.7355699062233, 792.1880072925183, 793.6111305460283, 797.4736673795268, 883.7083762358407, 7206.56760594366, 9204.217641500414, 9500.524973751284, 9635.22918166545, 9675.951620241854, 363299.0, 368666.0, 371764.0, 372907.0, 383466.0, 46640.7667961658, 46719.29921051119, 49740.75129624401, 76389.6180519105, 76598.23401766023, 846.2595229174473, 850.3919697416377, 853.3685073045901, 870.3211495033884, 875.0636818604032, 15062.246887655792, 15117.319720612379, 15809.841901580838, 16034.358625654842, 16063.518094457186, 35961.82019089888, 36729.0, 36775.632243677224, 37248.25503489861, 37816.0, 48537.0, 49780.253296201314, 49994.500054998985, 50079.0, 50609.24086138637, 4661.277501987197, 5068.847934561969, 7264.418846492374, 7460.962695186489, 7542.773716788505, 8540.658373665232, 10954.671359859218, 11319.660410187707, 11324.660260192208, 11675.649730508097, 9849.212063034796, 9962.103410693073, 10259.538320775733, 10536.209784266057, 10543.525541350504, 10145.137663298703, 10197.133243674074, 10260.435676037889, 10414.583416663248, 10510.0, 10012.749681258027, 10549.208809339483, 10585.100266477435, 10687.572497100029, 10974.231803773659, 7247.420206383582, 7382.630868456663, 7454.105507339154, 7493.250674932463, 7583.848323033398, 10310.123639490726, 10426.843597346198, 10460.110890574082, 10464.476776161313, 10931.289466184673], "value": 7945.377246070297, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1183.6863231243717, 1332.2406228449784, 1365.7609918264304, 1410.2948525737131, 1667.7581750646164, 6174.907376389352, 6822.215445223795, 7132.3580877721, 7154.570725756452, 7334.046573945393, 7188.748393806205, 7257.854842903139, 7270.781876543712, 7275.781726548199, 7286.599237041961, 2049.4261606750097, 2074.450270678264, 2075.584883023394, 2077.6156411064003, 2081.5628717969244, 2063.2675400232924, 2104.642210824156, 2104.747430308365, 2108.2410332280365, 2115.576884623074, 2039.8776073435567, 2043.9080241389174, 2049.6925461180867, 2052.568960518293, 2057.310800881706, 1985.9404217873414, 2008.9598208035904, 2009.5679428922706, 2011.5675129847152, 2013.7784843667184, 1955.7261983322346, 1962.2445358537066, 2019.2225992992658, 2022.4741567192489, 2025.5341271507489, 7051.753188638373, 7084.539504932214, 7135.4648401370105, 7169.175544812361, 7334.1565719942355, 4264.765437900915, 4405.581469760367, 4408.801603927799, 4412.75729834859, 4415.028693687384, 2657.601359796027, 2796.4127533218048, 2832.2919270182456, 2837.9432411351863, 2847.2739451439957, 922.3313098003961, 928.168880974526, 940.3934462271797, 955.2787645327802, 960.2510042167121, 9547.379420337726, 9611.711648650551, 9639.951800240953, 9644.083812037845, 9644.75888102796, 3702.0, 3762.9435558466644, 3769.076576238839, 3824.4454554089502, 3833.1375440525658, 7768.456208065494, 7787.688492460238, 7840.33357164636, 7855.450118491765, 7864.882026769603, 4282.5075116361395, 4287.935680964788, 4290.334998075304, 4292.441982542249, 4292.59220374064, 3372.578427696538, 3497.6852083312624, 3841.4237864320016, 3998.640122388999, 4001.4397984282223, 3091.27355071558, 3134.8902788402297, 3199.6480387157394, 3211.0527394418705, 3214.9357012860078, 899.0515006668028, 902.4449963272672, 907.6823111910778, 921.4793641592479, 932.3892850183141, 804.6861723927556, 805.3315747929205, 806.0689903161857, 811.6104269950457, 811.8660421030464, 4702.059588082398, 4712.787924543404, 4757.762111894461, 4783.856484305476, 5052.9494705052475, 359.64934189165876, 372.0865275748032, 882.0870399136991, 902.8916530016309, 942.189716843514, 3391.6438773928876, 3539.239063601338, 3572.160542272564, 3596.6223546527763, 3597.1725804196844, 8264.752057438287, 8508.532030738244, 8666.566671666518, 8772.429792063496, 8774.649014039494, 8654.78363040929, 8658.826823463496, 8660.13398660129, 8754.781130471662, 8777.166169213915, 6690.297518760557, 6813.454923606099, 6819.931800681929, 6829.931700683128, 6834.350736680107, 4902.117618828645, 4963.70217786934, 5008.824691135793, 5063.417706963746, 5131.692098474104, 7893.842123157619, 7959.602019898866, 8134.715284964997, 8153.7553873383895, 8169.468984515987, 7738.613069346397, 8332.16678332162, 8386.538740369338, 8403.495790252604, 8404.243618074403, 5934.673592952429, 6298.338674439118, 6298.338674439118, 6302.117703521602, 6308.211473565804, 6066.0, 6144.109104179958, 6307.085472606538, 6374.394432528902, 6387.425131738166, 5767.106098554731, 5786.450287222707, 5831.212786273968, 5838.532917366685, 5861.589688721749, 5613.1860880171325, 5661.46216109469, 5667.3765885753355, 5690.430956904442, 5694.572907031907, 5608.38307786135, 5657.094864821609, 5661.179129026351, 5664.631798933056, 5666.660000399989, 4043.130726893732, 4192.392103144966, 4272.893177670583, 4325.24308246062, 4451.132029254264, 4133.875983720493, 4193.601607847249, 4327.956720432755, 4363.367311739843, 4449.3326001100095], "value": 3774.15318201298, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [287.7036652248184, 290.72526462492954, 293.5244903256724, 296.845640267061, 298.9551567264909, 4680.368150299709, 4735.8816029599275, 4737.157705376777, 4751.382320298365, 4764.40340014692, 4685.953140468594, 4691.530846915307, 4694.9765251173785, 4696.943187782747, 4700.553447422498, 3505.5442792436947, 3629.909252268688, 3638.7634803737674, 3646.8723594674193, 3648.3250598639206, 3550.236699109691, 3646.1613828819386, 3702.0934218877164, 3718.4794128821986, 3729.0, 3684.6315368463206, 3688.17016171362, 3688.856454499114, 3690.5571331440265, 3707.1658876752786, 3627.854885804591, 3678.1172518595345, 3681.37416639172, 3694.926101477969, 3698.3158115748674, 3269.9346013079844, 3276.459384201604, 3278.918027049319, 3280.2783387654677, 3300.3069355435387, 4562.498125206224, 4566.908661826745, 4580.770961451914, 4584.15193189261, 4588.609968152711, 4217.957820421818, 4221.55673654265, 4227.513835908849, 4229.7462152270655, 4231.048014196781, 4764.0, 4846.9515304846855, 4882.975585122087, 4910.582600478963, 4919.499552636445, 3571.160777217352, 3573.982130089359, 3575.6781889630056, 3583.4803953426867, 3584.5698516177963, 5110.95225478776, 5121.28302037715, 5124.231365295198, 5125.948740512585, 5137.845864624067, 3545.2200515886466, 3650.0509867434125, 3653.8903832885057, 3655.853765849389, 3667.4779966314213, 3697.90755231116, 3711.5175027246287, 3715.2755212733796, 3725.7578257413184, 3730.459083432887, 4172.413103875556, 4172.457580514574, 4175.853845115406, 4184.581541845791, 4198.9370159447635, 4862.6839255448285, 4870.125001874233, 4873.171560834667, 4881.389826271716, 4886.486918873467, 1227.7851376009162, 1268.5243033862303, 1271.5740227023866, 1284.640300715801, 1288.072587736828, 809.7854068671807, 822.8974968954379, 836.3768992100923, 837.7947402886332, 844.859439756324, 3921.941170882439, 4170.749755014648, 4297.871063868089, 4332.653387728974, 4349.151915376535, 4971.676841005323, 4988.90022199554, 5021.171506701427, 5079.74601269935, 5091.592672586185, 4340.218760623118, 4366.01346387393, 4373.759443230653, 4376.783064447628, 4379.846705365297, 2585.3407381117695, 2640.828346157494, 2654.9734502655115, 2669.7196794336314, 2684.597310403416, 4745.857624271277, 4745.905081898342, 4748.358971538798, 4762.618990480753, 4766.332713420124, 5121.974390128025, 5125.794968201305, 5130.743462826844, 5153.175491921274, 5161.81933632321, 4520.932186017212, 4714.834980775725, 4728.432588089451, 4732.148213321635, 4738.175802316133, 5004.474530174425, 5013.323201367769, 5024.819167495709, 5035.899282014412, 5051.393832740095, 4957.454679985127, 4960.206366981266, 4967.130752118437, 4991.650584459053, 5003.674761140514, 4561.703489273186, 4754.720751323836, 4784.851635607499, 4810.42274926997, 4813.807447702053, 3597.1906321078595, 3609.7473176877365, 3618.0773902654655, 3627.1476203091725, 3627.383344831332, 5101.617378696538, 5107.336046314104, 5109.514596113363, 5109.948900510947, 5123.257127716386, 4850.223964165716, 4852.1103356597605, 4926.556609905126, 4951.2078067510465, 4958.107540642719, 4925.38432695913, 4935.457099718957, 4950.77721502526, 4953.390148201921, 4955.736287246729, 4818.975905120452, 4864.343313652753, 4879.560839524318, 4891.584215341736, 4894.045661096195, 4738.147133516, 4821.6383771218, 4921.606271498343, 4941.481144479778, 4949.57928576075, 4712.151812673752, 4776.355192049029, 4841.201201801663, 4867.95132048675, 4871.0], "value": 3714.8899453616204, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [592.2216260259545, 637.3626373626371, 677.9593224406536, 690.5821977703492, 695.4158506854242, 12385.752284954295, 13432.32838358083, 13440.596782096529, 13450.394732237048, 13476.932615336922, 12798.488060477594, 12827.551035713752, 12849.93575032126, 12866.356682165877, 12889.548865789675, 604.2899592978255, 607.5686262753451, 747.6411322565172, 748.5209465941801, 766.7661363284196, 765.162147448543, 770.7880332908439, 777.2693667952135, 778.2334400615389, 778.291754503402, 817.0114161864121, 819.1685439279137, 819.8688209886419, 820.4748960665179, 820.5404973214988, 637.6078711592384, 646.8221239159221, 785.1481142959896, 787.5274835098952, 819.0621738109891, 590.9202257695199, 592.6207227374484, 592.6651441935293, 592.9140274660193, 593.1547544748759, 12944.093913426064, 12989.545365912241, 13003.739925201538, 13037.413316400785, 13053.804192937114, 12265.202761820454, 12571.685707857378, 12757.170783899017, 12804.61586152417, 13183.538576149884, 11475.885241147565, 11567.710807229803, 11763.941180294129, 11778.764424711544, 12060.698482538006, 3926.823292951824, 3966.504186976628, 3985.0834308109297, 4036.455078564415, 4044.5348784889525, 61923.38076619221, 61988.0, 62941.6852915737, 63899.36100638981, 67330.66334668295, 9856.852147217798, 9915.553800079013, 10042.598296068221, 10132.645357412455, 10196.4391958443, 19316.420507384802, 19340.516487087934, 19348.70976935347, 19353.225870965005, 19365.225390984204, 6616.139901812733, 6629.303923088103, 6735.595864248063, 6838.623875686785, 6917.861642767117, 3527.224010717638, 3563.465480177994, 3599.874004409833, 3670.871519496805, 3722.106694393326, 2716.4159705662983, 2811.381496070861, 2811.9015834446104, 2814.4933911896055, 2817.9295517611813, 436.1669211805436, 437.9474463064453, 440.68711215037683, 442.48671541012914, 466.52414537171893, 470.4848191230597, 483.5623760496756, 488.5676176583749, 561.5675929534317, 572.387545326505, 8046.83906321882, 8181.590920453954, 8289.336853051742, 8372.455790373606, 8373.790655233546, 530.9707966061826, 532.8782911970246, 565.1409857017311, 568.3833041150316, 591.2284468768213, 3755.5681096673684, 3970.50368703912, 4003.3594624860466, 4043.7169398141846, 4119.752814831059, 55313.0, 96415.51792240994, 97584.51207744058, 99473.50263248783, 100061.0, 47820.0, 48058.519414806105, 86092.0, 86427.56786216029, 87487.56256218806, 66342.0, 67561.3243867555, 68661.999999999, 69492.65253673801, 70687.64656176789, 8354.248117669438, 8979.46123232608, 9028.845867608514, 9100.0, 9338.719838404859, 43109.78445107755, 43190.35214471848, 43474.565254348316, 43773.0, 45932.54067459283, 54312.45687543074, 59660.261152991145, 59670.403295966484, 60722.08916866339, 64891.35108648853, 11054.889451105708, 11100.389478578756, 11380.328162113368, 11408.828867566826, 11669.35818529989, 12749.745005100032, 12968.870311297143, 12986.844209852756, 13147.737045259233, 13552.59342219735, 11468.4265786712, 11536.826947595624, 11715.531378744754, 12093.57672481459, 12218.0, 11750.353730544903, 11912.642620721392, 12088.39558022113, 12649.93675031619, 12664.113512054068, 11653.65039048796, 11710.70723231926, 11966.282023078295, 12623.0, 12624.116311858083, 9566.569504372459, 10077.697669069647, 10262.692119236435, 10617.203709721956, 10719.624813131815, 10402.895971040192, 10765.784684306427, 10889.346639201356, 10975.396353200651, 10988.780224395627], "value": 6491.778013729449, "unit": "score"}], "name": "dromaeo_css", "value": 6204.50207434955, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [115.0, 116.0, 117.0, 116.0, 114.0, 116.0, 116.0, 116.0, 116.0, 116.0], "value": 115.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [158.0, 135.0, 132.0, 175.0, 140.0, 127.0, 129.0, 130.0, 172.0, 133.0], "value": 143.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 162.0, 162.0, 163.0, 161.0, 161.0, 163.0, 162.0, 161.0, 163.0], "value": 162.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 77.0, 76.0, 109.0, 77.0, 76.0, 76.0, 79.0, 114.0, 78.0], "value": 84.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 84.0, 111.0, 85.0, 85.0, 85.0, 110.0, 84.0, 84.0, 109.0], "value": 92.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 116.0, 117.0, 117.0, 117.0, 117.0, 117.0, 121.0, 117.0], "value": 117.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 147.0, 147.0, 148.0, 147.0, 147.0, 146.0, 146.0, 146.0], "value": 146.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 96.0, 95.0, 96.0, 96.0, 95.0, 95.0, 95.0, 95.0, 95.0], "value": 95.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 63.0, 62.0, 63.0, 66.0, 70.0, 66.0, 68.0, 69.0, 67.0], "value": 66.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 69.0, 66.0, 67.0, 69.0, 68.0, 66.0, 67.0, 67.0, 67.0], "value": 67.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 85.0, 83.0, 84.0, 85.0, 84.0, 84.0, 93.0, 82.0, 84.0], "value": 84.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [143.0, 146.0, 150.0, 151.0, 146.0, 141.0, 151.0, 146.0, 177.0, 145.0], "value": 149.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [183.0, 173.0, 175.0, 176.0, 175.0, 174.0, 173.0, 178.0, 179.0, 180.0], "value": 176.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 73.0, 71.0, 71.0, 71.0, 71.0, 70.0, 73.0, 70.0, 71.0], "value": 71.8, "unit": "score"}], "name": "kraken", "value": 1572.4999999999998, "alertThreshold": 2.0}]}
01:03:33 INFO - Return code: 0
01:03:33 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json
01:03:33 INFO - # TBPL SUCCESS #
01:03:33 INFO - Running post-action listener: _resource_record_post_action
01:03:33 INFO - [mozharness: 2016-10-01 08:03:33.418600Z] Finished run-tests step (success)
01:03:33 INFO - Running post-run listener: _resource_record_post_run
01:03:33 INFO - Total resource usage - Wall time: 1204s; CPU: 13.0%; Read bytes: 4096; Write bytes: 389881856; Read time: 16; Write time: 292624
01:03:33 INFO - TinderboxPrint: CPU usage
13.0%
01:03:33 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 16
01:03:33 INFO - TinderboxPrint: I/O write bytes / time
389,881,856 / 292,624
01:03:33 INFO - TinderboxPrint: CPU idle
8,352.2 (86.9%)
01:03:33 INFO - TinderboxPrint: CPU user
1,200.8 (12.5%)
01:03:33 INFO - TinderboxPrint: Swap in / out
0 / 0
01:03:33 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 99082240; Read time: 0; Write time: 72208
01:03:33 INFO - run-tests - Wall time: 1188s; CPU: 13.0%; Read bytes: 0; Write bytes: 290799616; Read time: 0; Write time: 220416
01:03:34 INFO - Running post-run listener: _upload_blobber_files
01:03:34 INFO - Blob upload gear active.
01:03:34 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir.
01:03:34 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
01:03:34 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', 'Firefox-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json']
01:03:34 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 Firefox-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json
01:03:34 INFO - (blobuploader) - INFO - Open directory for files ...
01:03:34 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ...
01:03:34 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com
01:03:34 INFO - (blobuploader) - INFO - Uploading, attempt #1.
01:03:38 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded
01:03:38 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded!
01:03:38 INFO - (blobuploader) - INFO - Done attempting.
01:03:38 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ...
01:03:38 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com
01:03:38 INFO - (blobuploader) - INFO - Uploading, attempt #1.
01:03:39 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded
01:03:39 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded!
01:03:39 INFO - (blobuploader) - INFO - Done attempting.
01:03:39 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ...
01:03:39 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com
01:03:39 INFO - (blobuploader) - INFO - Uploading, attempt #1.
01:03:40 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded
01:03:40 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded!
01:03:40 INFO - (blobuploader) - INFO - Done attempting.
01:03:40 INFO - (blobuploader) - INFO - Iteration through files over.
01:03:40 INFO - Return code: 0
01:03:40 INFO - rmtree: /builds/slave/test/build/uploaded_files.json
01:03:40 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1
01:03:40 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/cce5525eb1103ac0bbe0b44056e245f060578eef10a1e87c2ca87c8b0c3fef9c7f6378ad950944dd753bd1940a769e37857e173a460120ddae08686a05d9f613", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/1f55902c0db98654dc525a7b306428d7339c8e17cf52632175f6ca779ce6e26cc03c6770cfeb773f6967f68ea78edc3edf464156e0037b16359ef89d774a8f04", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/e93d484a59769e737baf994a82f4454a45000ff2c4467b78cdd0fdeeb495866169a40259b68bbc652946a6ff6381bf864515b5dcc3e8c1b613bb5b29c1335d85"}
01:03:40 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files
01:03:40 INFO - Writing to file /builds/slave/test/properties/blobber_files
01:03:40 INFO - Contents:
01:03:40 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/cce5525eb1103ac0bbe0b44056e245f060578eef10a1e87c2ca87c8b0c3fef9c7f6378ad950944dd753bd1940a769e37857e173a460120ddae08686a05d9f613", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/1f55902c0db98654dc525a7b306428d7339c8e17cf52632175f6ca779ce6e26cc03c6770cfeb773f6967f68ea78edc3edf464156e0037b16359ef89d774a8f04", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/e93d484a59769e737baf994a82f4454a45000ff2c4467b78cdd0fdeeb495866169a40259b68bbc652946a6ff6381bf864515b5dcc3e8c1b613bb5b29c1335d85"}
01:03:40 INFO - Running post-run listener: copy_logs_to_upload_dir
01:03:40 INFO - Copying logs to upload dir...
01:03:40 INFO - mkdir: /builds/slave/test/build/upload/logs
01:03:40 INFO - Copying logs to upload dir...
program finished with exit code 0
elapsedTime=1253.257771
========= master_lag: -0.01 =========
========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 53 secs) (at 2016-10-01 01:03:39.410574) =========
========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-01 01:03:39.414254) =========
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=52faae308a556c440401f8e5000001e8-1475297560.916926-1269991624
XPCOM_DEBUG_BREAK=warn
_=/tools/buildbot/bin/python
using PTY: False
blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/cce5525eb1103ac0bbe0b44056e245f060578eef10a1e87c2ca87c8b0c3fef9c7f6378ad950944dd753bd1940a769e37857e173a460120ddae08686a05d9f613", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/1f55902c0db98654dc525a7b306428d7339c8e17cf52632175f6ca779ce6e26cc03c6770cfeb773f6967f68ea78edc3edf464156e0037b16359ef89d774a8f04", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/e93d484a59769e737baf994a82f4454a45000ff2c4467b78cdd0fdeeb495866169a40259b68bbc652946a6ff6381bf864515b5dcc3e8c1b613bb5b29c1335d85"}
build_url:https://queue.taskcluster.net/v1/task/courxZ-lQCqUI_Y5noYnWw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2
program finished with exit code 0
elapsedTime=0.011522
build_url: 'https://queue.taskcluster.net/v1/task/courxZ-lQCqUI_Y5noYnWw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2'
blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/cce5525eb1103ac0bbe0b44056e245f060578eef10a1e87c2ca87c8b0c3fef9c7f6378ad950944dd753bd1940a769e37857e173a460120ddae08686a05d9f613", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/1f55902c0db98654dc525a7b306428d7339c8e17cf52632175f6ca779ce6e26cc03c6770cfeb773f6967f68ea78edc3edf464156e0037b16359ef89d774a8f04", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/e93d484a59769e737baf994a82f4454a45000ff2c4467b78cdd0fdeeb495866169a40259b68bbc652946a6ff6381bf864515b5dcc3e8c1b613bb5b29c1335d85"}'
========= master_lag: 0.01 =========
========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-01 01:03:39.440084) =========
========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-01 01:03:39.440418) =========
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=52faae308a556c440401f8e5000001e8-1475297560.916926-1269991624
XPCOM_DEBUG_BREAK=warn
_=/tools/buildbot/bin/python
using PTY: False
program finished with exit code 0
elapsedTime=0.004495
========= master_lag: 0.08 =========
========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-01 01:03:39.524969) =========
========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-01 01:03:39.525310) =========
========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-01 01:03:39.525668) =========
========= Total master_lag: 0.19 =========