builder: mozilla-central_ubuntu64_hw_styloseq_test-dromaeojs-e10s
slave: talos-linux64-ix-036
starttime: 1504787549.01
results: success (0)
revision: 37b95547f0d27565452136d16b2df2857be840f6
========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-09-07 05:32:29.014566) =========
master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/
========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-09-07 05:32:29.015107) =========
========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-07 05:32:29.015401) =========
========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-07 05:32:29.039152) =========
========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-07 05:32:29.039443) =========
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=14ef55db36f7623abb31b9cf000001d5-1504787543.907280-299696051
XPCOM_DEBUG_BREAK=warn
_=/tools/buildbot/bin/python
using PTY: False
--2017-09-07 05:32:29-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py
Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102
Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected.
HTTP request sent, awaiting response... 200 Script output follows
Length: 12179 (12K) [text/x-python]
Saving to: `archiver_client.py'
0K .......... . 100% 36.8M=0s
2017-09-07 05:32:29 (36.8 MB/s) - `archiver_client.py' saved [12179/12179]
program finished with exit code 0
elapsedTime=0.261980
========= master_lag: 0.06 =========
========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-07 05:32:29.361935) =========
========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-07 05:32:29.362306) =========
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=14ef55db36f7623abb31b9cf000001d5-1504787543.907280-299696051
XPCOM_DEBUG_BREAK=warn
_=/tools/buildbot/bin/python
using PTY: False
program finished with exit code 0
elapsedTime=0.034031
========= master_lag: 0.02 =========
========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-07 05:32:29.419183) =========
========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-09-07 05:32:29.419649) =========
bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 37b95547f0d27565452136d16b2df2857be840f6 --destination scripts --debug'
in dir /builds/slave/test/. (timeout 1200 secs)
watching logfiles {}
argv: ['bash', '-c', 'python archiver_client.py mozharness --repo mozilla-central --rev 37b95547f0d27565452136d16b2df2857be840f6 --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=14ef55db36f7623abb31b9cf000001d5-1504787543.907280-299696051
XPCOM_DEBUG_BREAK=warn
_=/tools/buildbot/bin/python
using PTY: False
2017-09-07 05:32:29,734 truncating revision to first 12 chars
2017-09-07 05:32:29,734 Setting DEBUG logging.
2017-09-07 05:32:29,734 attempt 1/10
2017-09-07 05:32:29,734 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/37b95547f0d2?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness
2017-09-07 05:32:30,465 unpacking tar archive at: mozilla-central-37b95547f0d2/testing/mozharness/
program finished with exit code 0
elapsedTime=1.081503
========= master_lag: 0.02 =========
========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-09-07 05:32:30.522124) =========
========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-07 05:32:30.522479) =========
script_repo_revision: 37b95547f0d27565452136d16b2df2857be840f6
========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-07 05:32:30.524998) =========
========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-07 05:32:30.525350) =========
========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-07 05:32:30.541849) =========
========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 59 secs) (at 2017-09-07 05:32:30.542319) =========
/tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox
in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs)
watching logfiles {}
argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox']
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=14ef55db36f7623abb31b9cf000001d5-1504787543.907280-299696051
XPCOM_DEBUG_BREAK=warn
_=/tools/buildbot/bin/python
using PTY: False
05:32:31 INFO - MultiFileLogger online at 20170907 05:32:31 in /builds/slave/test
05:32:31 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox
05:32:31 INFO - Dumping config to /builds/slave/test/logs/localconfig.json.
05:32:31 INFO - {'append_to_log': False,
05:32:31 INFO - 'base_work_dir': '/builds/slave/test',
05:32:31 INFO - 'blob_upload_branch': 'Firefox',
05:32:31 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt',
05:32:31 INFO - 'branch': 'Firefox',
05:32:31 INFO - 'buildbot_json_path': 'buildprops.json',
05:32:31 INFO - 'code_coverage': False,
05:32:31 INFO - 'config_files': ('talos/linux_config.py',),
05:32:31 INFO - 'default_actions': ('clobber',
05:32:31 INFO - 'read-buildbot-config',
05:32:31 INFO - 'download-and-extract',
05:32:31 INFO - 'populate-webroot',
05:32:31 INFO - 'create-virtualenv',
05:32:31 INFO - 'install',
05:32:31 INFO - 'setup-mitmproxy',
05:32:31 INFO - 'run-tests'),
05:32:31 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',),
05:32:31 INFO - 'disable_ccov_upload': False,
05:32:31 INFO - 'disable_stylo': False,
05:32:31 INFO - 'download_minidump_stackwalk': True,
05:32:31 INFO - 'download_symbols': 'ondemand',
05:32:31 INFO - 'enable_stylo': False,
05:32:31 INFO - 'enable_webrender': False,
05:32:31 INFO - 'exes': {'tooltool.py': '/tools/tooltool.py'},
05:32:31 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub',
05:32:31 INFO - 'http://pypi.pub.build.mozilla.org/pub'),
05:32:31 INFO - 'gecko_profile': False,
05:32:31 INFO - 'gecko_profile_interval': 0,
05:32:31 INFO - 'installer_path': 'installer.exe',
05:32:31 INFO - 'log_level': 'info',
05:32:31 INFO - 'log_name': 'talos',
05:32:31 INFO - 'log_to_console': True,
05:32:31 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk',
05:32:31 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest',
05:32:31 INFO - 'opt_config_files': (),
05:32:31 INFO - 'pip_index': False,
05:32:31 INFO - 'suite': 'dromaeojs-e10s',
05:32:31 INFO - 'system_bits': '32',
05:32:31 INFO - 'talos_extra_options': ('--webServer', 'localhost'),
05:32:31 INFO - 'title': 'talos-linux64-ix-036',
05:32:31 INFO - 'tooltool_cache': '/builds/tooltool_cache',
05:32:31 INFO - 'use_talos_json': True,
05:32:31 INFO - 'verify': 'False',
05:32:31 INFO - 'virtualenv_path': '/builds/slave/test/build/venv',
05:32:31 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None},
05:32:31 INFO - 'work_dir': 'build'}
05:32:31 INFO - [mozharness: 2017-09-07 12:32:31.092792Z] Running clobber step.
05:32:31 INFO - Running pre-action listener: _resource_record_pre_action
05:32:31 INFO - Running main action method: clobber
05:32:31 INFO - rmtree: /builds/slave/test/build
05:32:31 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1
05:32:33 INFO - Running post-action listener: _resource_record_post_action
05:32:33 INFO - [mozharness: 2017-09-07 12:32:33.541341Z] Finished clobber step (success)
05:32:33 INFO - [mozharness: 2017-09-07 12:32:33.541463Z] Running read-buildbot-config step.
05:32:33 INFO - Running pre-action listener: _resource_record_pre_action
05:32:33 INFO - Running main action method: read_buildbot_config
05:32:33 INFO - Using buildbot properties:
05:32:33 INFO - {
05:32:33 INFO - "project": "",
05:32:33 INFO - "product": "firefox",
05:32:33 INFO - "who": "archaeopteryx@coole-files.de",
05:32:33 INFO - "installer_path": "public/build/target.tar.bz2",
05:32:33 INFO - "builddir": "mozilla-central_ubuntu64_hw_styloseq_test-dromaeojs-e10s",
05:32:33 INFO - "repository": "https://hg.mozilla.org/mozilla-central",
05:32:33 INFO - "buildername": "Ubuntu HW 12.04 x64 stylo-sequential mozilla-central talos dromaeojs-e10s",
05:32:33 INFO - "stage_platform": "linux64-stylosequential",
05:32:33 INFO - "basedir": "/builds/slave/test",
05:32:33 INFO - "buildnumber": 63,
05:32:33 INFO - "platform": "ubuntu64_hw_styloseq",
05:32:33 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/",
05:32:33 INFO - "slavebuilddir": "test",
05:32:33 INFO - "taskId": "WLpaGvWYQRynMWOjkyyJwA",
05:32:33 INFO - "branch": "mozilla-central",
05:32:33 INFO - "script_repo_revision": "production",
05:32:33 INFO - "revision": "37b95547f0d27565452136d16b2df2857be840f6",
05:32:33 INFO - "slavename": "talos-linux64-ix-036",
05:32:33 INFO - "repo_path": "mozilla-central"
05:32:33 INFO - }
05:32:33 INFO - Finding installer, test and symbols from parent task.
05:32:33 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/WLpaGvWYQRynMWOjkyyJwA'}, attempt #1
05:32:34 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/WLpaGvWYQRynMWOjkyyJwA'}, attempt #1
05:32:34 INFO - Task dependencies: O4Y3kdYKTk6AYNU8oh2jiA
05:32:34 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/O4Y3kdYKTk6AYNU8oh2jiA'}, attempt #1
05:32:34 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/O4Y3kdYKTk6AYNU8oh2jiA/artifacts/public/build/target.tar.bz2
05:32:34 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/O4Y3kdYKTk6AYNU8oh2jiA/artifacts/public/build/target.test_packages.json
05:32:34 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/O4Y3kdYKTk6AYNU8oh2jiA/artifacts/public/build/target.crashreporter-symbols.zip
05:32:34 INFO - Running post-action listener: _resource_record_post_action
05:32:34 INFO - [mozharness: 2017-09-07 12:32:34.956647Z] Finished read-buildbot-config step (success)
05:32:34 INFO - [mozharness: 2017-09-07 12:32:34.956867Z] Running download-and-extract step.
05:32:34 INFO - Running pre-action listener: _resource_record_pre_action
05:32:34 INFO - Running main action method: download_and_extract
05:32:34 INFO - mkdir: /builds/slave/test/build/tests
05:32:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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')]}
05:32:34 INFO - trying https://queue.taskcluster.net/v1/task/O4Y3kdYKTk6AYNU8oh2jiA/artifacts/public/build/target.test_packages.json
05:32:34 INFO - Downloading https://queue.taskcluster.net/v1/task/O4Y3kdYKTk6AYNU8oh2jiA/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json
05:32:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/O4Y3kdYKTk6AYNU8oh2jiA/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1
05:32:35 INFO - Downloaded 989 bytes.
05:32:35 INFO - Reading from file /builds/slave/test/build/target.test_packages.json
05:32:35 INFO - Using the following test package requirements:
05:32:35 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'],
05:32:35 INFO - u'common': [u'target.common.tests.zip'],
05:32:35 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'],
05:32:35 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'],
05:32:35 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'],
05:32:35 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'],
05:32:35 INFO - u'mozbase': [u'target.common.tests.zip'],
05:32:35 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'],
05:32:35 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'],
05:32:35 INFO - u'web-platform': [u'target.common.tests.zip',
05:32:35 INFO - u'target.web-platform.tests.tar.gz'],
05:32:35 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']}
05:32:35 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common
05:32:35 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/O4Y3kdYKTk6AYNU8oh2jiA/artifacts/public/build/target.common.tests.zip
05:32:35 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/O4Y3kdYKTk6AYNU8oh2jiA/artifacts/public/build/target.common.tests.zip'}, attempt #1
05:32:35 INFO - Fetch https://queue.taskcluster.net/v1/task/O4Y3kdYKTk6AYNU8oh2jiA/artifacts/public/build/target.common.tests.zip into memory
05:32:36 INFO - Content-Length response header: 55021160
05:32:36 INFO - Bytes received: 55021160
05:32:48 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos
05:32:48 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/O4Y3kdYKTk6AYNU8oh2jiA/artifacts/public/build/target.common.tests.zip
05:32:48 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/O4Y3kdYKTk6AYNU8oh2jiA/artifacts/public/build/target.common.tests.zip'}, attempt #1
05:32:48 INFO - Fetch https://queue.taskcluster.net/v1/task/O4Y3kdYKTk6AYNU8oh2jiA/artifacts/public/build/target.common.tests.zip into memory
05:32:49 INFO - Content-Length response header: 55021160
05:32:49 INFO - Bytes received: 55021160
05:33:03 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/O4Y3kdYKTk6AYNU8oh2jiA/artifacts/public/build/target.talos.tests.zip
05:33:03 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/O4Y3kdYKTk6AYNU8oh2jiA/artifacts/public/build/target.talos.tests.zip'}, attempt #1
05:33:03 INFO - Fetch https://queue.taskcluster.net/v1/task/O4Y3kdYKTk6AYNU8oh2jiA/artifacts/public/build/target.talos.tests.zip into memory
05:33:04 INFO - Content-Length response header: 14496665
05:33:04 INFO - Bytes received: 14496665
05:33:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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')]}
05:33:04 INFO - trying https://queue.taskcluster.net/v1/task/O4Y3kdYKTk6AYNU8oh2jiA/artifacts/public/build/target.tar.bz2
05:33:04 INFO - Downloading https://queue.taskcluster.net/v1/task/O4Y3kdYKTk6AYNU8oh2jiA/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2
05:33:04 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/O4Y3kdYKTk6AYNU8oh2jiA/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1
05:33:05 INFO - Downloaded 62729505 bytes.
05:33:05 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/O4Y3kdYKTk6AYNU8oh2jiA/artifacts/public/build/target.tar.bz2
05:33:05 INFO - mkdir: /builds/slave/test/properties
05:33:05 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url
05:33:05 INFO - Writing to file /builds/slave/test/properties/build_url
05:33:05 INFO - Contents:
05:33:05 INFO - build_url:https://queue.taskcluster.net/v1/task/O4Y3kdYKTk6AYNU8oh2jiA/artifacts/public/build/target.tar.bz2
05:33:05 INFO - Running post-action listener: _resource_record_post_action
05:33:05 INFO - Running post-action listener: find_tests_for_verification
05:33:05 INFO - Running post-action listener: set_extra_try_arguments
05:33:05 INFO - [mozharness: 2017-09-07 12:33:05.930050Z] Finished download-and-extract step (success)
05:33:05 INFO - [mozharness: 2017-09-07 12:33:05.930159Z] Running populate-webroot step.
05:33:05 INFO - Running pre-action listener: _resource_record_pre_action
05:33:05 INFO - Running main action method: populate_webroot
05:33:05 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']},
05:33:05 INFO - 'chromez-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'],
05:33:05 INFO - 'tests': ['tresize',
05:33:05 INFO - 'tcanvasmark']},
05:33:05 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']},
05:33:05 INFO - 'dromaeojs-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'],
05:33:05 INFO - 'tests': ['dromaeo_css',
05:33:05 INFO - 'kraken']},
05:33:05 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip',
05:33:05 INFO - 'tests': ['tp5o_scroll', 'glterrain']},
05:33:05 INFO - 'g1-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip',
05:33:05 INFO - 'talos_options': ['--disable-stylo'],
05:33:05 INFO - 'tests': ['tp5o_scroll', 'glterrain']},
05:33:05 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip',
05:33:05 INFO - 'tests': ['damp', 'tps']},
05:33:05 INFO - 'g2-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip',
05:33:05 INFO - 'talos_options': ['--disable-stylo'],
05:33:05 INFO - 'tests': ['damp', 'tps']},
05:33:05 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']},
05:33:05 INFO - 'g3-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'],
05:33:05 INFO - 'tests': ['dromaeo_dom']},
05:33:05 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']},
05:33:05 INFO - 'g4-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'],
05:33:05 INFO - 'tests': ['basic_compositor_video',
05:33:05 INFO - 'glvideo']},
05:33:05 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip',
05:33:05 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']},
05:33:05 INFO - 'g5-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip',
05:33:05 INFO - 'talos_options': ['--disable-stylo'],
05:33:05 INFO - 'tests': ['ts_paint_webext',
05:33:05 INFO - 'tp5o_webext']},
05:33:05 INFO - 'other-e10s': {'tests': ['a11yr',
05:33:05 INFO - 'ts_paint',
05:33:05 INFO - 'tpaint',
05:33:05 INFO - 'sessionrestore',
05:33:05 INFO - 'sessionrestore_many_windows',
05:33:05 INFO - 'sessionrestore_no_auto_restore',
05:33:05 INFO - 'tabpaint']},
05:33:05 INFO - 'other-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'],
05:33:05 INFO - 'tests': ['a11yr',
05:33:05 INFO - 'ts_paint',
05:33:05 INFO - 'tpaint',
05:33:05 INFO - 'sessionrestore',
05:33:05 INFO - 'sessionrestore_many_windows',
05:33:05 INFO - 'sessionrestore_no_auto_restore',
05:33:05 INFO - 'tabpaint']},
05:33:05 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']},
05:33:05 INFO - 'perf-reftest-singletons-e10s': {'tests': ['bloom_basic_singleton']},
05:33:05 INFO - 'perf-reftest-singletons-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'],
05:33:05 INFO - 'tests': ['bloom_basic_singleton']},
05:33:05 INFO - 'perf-reftest-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'],
05:33:05 INFO - 'tests': ['bloom_basic']},
05:33:05 INFO - 'svgr-e10s': {'tests': ['tsvgx',
05:33:05 INFO - 'tsvgr_opacity',
05:33:05 INFO - 'tart',
05:33:05 INFO - 'tscrollx',
05:33:05 INFO - 'tsvg_static']},
05:33:05 INFO - 'svgr-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'],
05:33:05 INFO - 'tests': ['tsvgx',
05:33:05 INFO - 'tsvgr_opacity',
05:33:05 INFO - 'tart',
05:33:05 INFO - 'tscrollx',
05:33:05 INFO - 'tsvg_static']},
05:33:05 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']},
05:33:05 INFO - 'tp5o-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip',
05:33:05 INFO - 'talos_options': ['--disable-stylo'],
05:33:05 INFO - 'tests': ['tp5o']},
05:33:05 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip',
05:33:05 INFO - 'talos_options': ['--mitmproxy',
05:33:05 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp',
05:33:05 INFO - '--firstNonBlankPaint'],
05:33:05 INFO - 'tests': ['tp6_google',
05:33:05 INFO - 'tp6_youtube',
05:33:05 INFO - 'tp6_amazon',
05:33:05 INFO - 'tp6_facebook']},
05:33:05 INFO - 'tp6-stylo-disabled-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip',
05:33:05 INFO - 'talos_options': ['--disable-stylo',
05:33:05 INFO - '--mitmproxy',
05:33:05 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp',
05:33:05 INFO - '--firstNonBlankPaint'],
05:33:05 INFO - 'tests': ['tp6_google',
05:33:05 INFO - 'tp6_youtube',
05:33:05 INFO - 'tp6_amazon',
05:33:05 INFO - 'tp6_facebook']},
05:33:05 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip',
05:33:05 INFO - 'talos_options': ['--stylo-threads=1',
05:33:05 INFO - '--mitmproxy',
05:33:05 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp',
05:33:05 INFO - '--firstNonBlankPaint'],
05:33:05 INFO - 'tests': ['tp6_google',
05:33:05 INFO - 'tp6_youtube',
05:33:05 INFO - 'tp6_amazon',
05:33:05 INFO - 'tp6_facebook']},
05:33:05 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip',
05:33:05 INFO - 'talos_options': ['--xperf_path',
05:33:05 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'],
05:33:05 INFO - 'tests': ['tp5n']},
05:33:05 INFO - 'xperf-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip',
05:33:05 INFO - 'talos_options': ['--disable-stylo',
05:33:05 INFO - '--xperf_path',
05:33:05 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'],
05:33:05 INFO - 'tests': ['tp5n']}}}
05:33:05 INFO - Running post-action listener: _resource_record_post_action
05:33:05 INFO - [mozharness: 2017-09-07 12:33:05.946131Z] Finished populate-webroot step (success)
05:33:05 INFO - [mozharness: 2017-09-07 12:33:05.946231Z] Running create-virtualenv step.
05:33:05 INFO - Running pre-action listener: _resource_record_pre_action
05:33:05 INFO - Running main action method: create_virtualenv
05:33:05 INFO - Creating virtualenv /builds/slave/test/build/venv
05:33:05 INFO - Running command: ['virtualenv', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build
05:33:05 INFO - Copy/paste: virtualenv --no-site-packages --distribute /builds/slave/test/build/venv
05:33:05 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'}
05:33:06 INFO - The --no-site-packages flag is deprecated; it is now the default behavior.
05:33:06 INFO - New python executable in /builds/slave/test/build/venv/bin/python
05:33:06 INFO - Installing distribute.............................................................................................................................................................................................done.
05:33:07 INFO - Installing pip...............done.
05:33:07 INFO - Return code: 0
05:33:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version']
05:33:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version
05:33:07 INFO - Reading from file tmpfile_stdout
05:33:07 INFO - Output received:
05:33:07 INFO - pip 1.1 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.1-py2.7.egg (python 2.7)
05:33:07 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv
05:33:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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')]}
05:33:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org
05:33:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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')]}
05:33:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org
05:33:07 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/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 0xd571f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf20a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10c3a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c7090>, '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 0x10c7d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c1f90>, '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': '14ef55db36f7623abb31b9cf000001d5-1504787543.907280-299696051', '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
05:33:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--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
05:33:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5
05:33:07 INFO - Using env: {'DISPLAY': ':0',
05:33:07 INFO - 'HOME': '/home/cltbld',
05:33:07 INFO - 'LANG': 'en_US.UTF-8',
05:33:07 INFO - 'LANGUAGE': 'en_US:en',
05:33:07 INFO - 'LOGNAME': 'cltbld',
05:33:07 INFO - 'MAIL': '/var/mail/cltbld',
05:33:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1',
05:33:07 INFO - 'MOZ_NO_REMOTE': '1',
05:33:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript',
05:33:07 INFO - 'NO_EM_RESTART': '1',
05:33:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games',
05:33:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json',
05:33:07 INFO - 'PWD': '/builds/slave/test',
05:33:07 INFO - 'SHELL': '/bin/bash',
05:33:07 INFO - 'SHLVL': '1',
05:33:07 INFO - 'TERM': 'linux',
05:33:07 INFO - 'TMOUT': '86400',
05:33:07 INFO - 'USER': 'cltbld',
05:33:07 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1504787543.907280-299696051',
05:33:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn',
05:33:07 INFO - '_': '/tools/buildbot/bin/python'}
05:33:08 INFO - Ignoring indexes: http://pypi.python.org/simple/
05:33:08 INFO - Downloading/unpacking pip>=1.5
05:33:08 INFO - Running setup.py egg_info for package pip
05:33:08 INFO - warning: no files found matching 'pip/cacert.pem'
05:33:08 INFO - warning: no files found matching '*.html' under directory 'docs'
05:33:08 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build'
05:33:08 INFO - no previously-included directories found matching 'docs/_build/_sources'
05:33:08 INFO - Installing collected packages: pip
05:33:08 INFO - Found existing installation: pip 1.1
05:33:08 INFO - Uninstalling pip:
05:33:08 INFO - Successfully uninstalled pip
05:33:08 INFO - Running setup.py install for pip
05:33:08 INFO - warning: no files found matching 'pip/cacert.pem'
05:33:08 INFO - warning: no files found matching '*.html' under directory 'docs'
05:33:08 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build'
05:33:08 INFO - no previously-included directories found matching 'docs/_build/_sources'
05:33:08 INFO - Installing pip script to /builds/slave/test/build/venv/bin
05:33:08 INFO - Installing pip2.7 script to /builds/slave/test/build/venv/bin
05:33:08 INFO - Installing pip2 script to /builds/slave/test/build/venv/bin
05:33:08 INFO - Successfully installed pip
05:33:08 INFO - Cleaning up...
05:33:08 INFO - Return code: 0
05:33:08 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv
05:33:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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')]}
05:33:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org
05:33:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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')]}
05:33:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org
05:33:08 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/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 0xd571f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf20a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10c3a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c7090>, '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 0x10c7d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c1f90>, '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': '14ef55db36f7623abb31b9cf000001d5-1504787543.907280-299696051', '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
05:33:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--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
05:33:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1
05:33:08 INFO - Using env: {'DISPLAY': ':0',
05:33:08 INFO - 'HOME': '/home/cltbld',
05:33:08 INFO - 'LANG': 'en_US.UTF-8',
05:33:08 INFO - 'LANGUAGE': 'en_US:en',
05:33:08 INFO - 'LOGNAME': 'cltbld',
05:33:08 INFO - 'MAIL': '/var/mail/cltbld',
05:33:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1',
05:33:08 INFO - 'MOZ_NO_REMOTE': '1',
05:33:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript',
05:33:08 INFO - 'NO_EM_RESTART': '1',
05:33:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games',
05:33:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json',
05:33:08 INFO - 'PWD': '/builds/slave/test',
05:33:08 INFO - 'SHELL': '/bin/bash',
05:33:08 INFO - 'SHLVL': '1',
05:33:08 INFO - 'TERM': 'linux',
05:33:08 INFO - 'TMOUT': '86400',
05:33:08 INFO - 'USER': 'cltbld',
05:33:08 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1504787543.907280-299696051',
05:33:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn',
05:33:08 INFO - '_': '/tools/buildbot/bin/python'}
05:33:08 INFO - Ignoring indexes: https://pypi.python.org/simple/
05:33:08 INFO - Downloading/unpacking psutil>=3.1.1
05:33:08 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
05:33:08 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
05:33:08 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
05:33:08 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
05:33:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil
05:33:09 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build'
05:33:09 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects
...
05:33:09 INFO - Installing collected packages: psutil
05:33:09 INFO - Running setup.py install for psutil
05:33:09 INFO - building 'psutil._psutil_linux' extension
05:33:09 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
05:33:11 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
05:33:11 INFO - building 'psutil._psutil_posix' extension
05:33:11 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
05:33:11 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
05:33:11 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build'
05:33:11 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ...
05:33:11 INFO - Successfully installed psutil
05:33:11 INFO - Cleaning up...
05:33:11 INFO - Return code: 0
05:33:11 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv
05:33:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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')]}
05:33:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org
05:33:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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')]}
05:33:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org
05:33:11 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/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 0xd571f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf20a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10c3a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c7090>, '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 0x10c7d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c1f90>, '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': '14ef55db36f7623abb31b9cf000001d5-1504787543.907280-299696051', '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
05:33:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--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
05:33:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3
05:33:11 INFO - Using env: {'DISPLAY': ':0',
05:33:11 INFO - 'HOME': '/home/cltbld',
05:33:11 INFO - 'LANG': 'en_US.UTF-8',
05:33:11 INFO - 'LANGUAGE': 'en_US:en',
05:33:11 INFO - 'LOGNAME': 'cltbld',
05:33:11 INFO - 'MAIL': '/var/mail/cltbld',
05:33:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1',
05:33:11 INFO - 'MOZ_NO_REMOTE': '1',
05:33:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript',
05:33:11 INFO - 'NO_EM_RESTART': '1',
05:33:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games',
05:33:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json',
05:33:11 INFO - 'PWD': '/builds/slave/test',
05:33:11 INFO - 'SHELL': '/bin/bash',
05:33:11 INFO - 'SHLVL': '1',
05:33:11 INFO - 'TERM': 'linux',
05:33:11 INFO - 'TMOUT': '86400',
05:33:11 INFO - 'USER': 'cltbld',
05:33:11 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1504787543.907280-299696051',
05:33:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn',
05:33:11 INFO - '_': '/tools/buildbot/bin/python'}
05:33:11 INFO - Ignoring indexes: https://pypi.python.org/simple/
05:33:11 INFO - Downloading/unpacking mozsystemmonitor==0.3
05:33:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available
05:33:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available
05:33:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available
05:33:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available
05:33:12 INFO - Downloading mozsystemmonitor-0.3.tar.gz
05:33:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor
05:33:12 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3)
05:33:12 INFO - Installing collected packages: mozsystemmonitor
05:33:12 INFO - Running setup.py install for mozsystemmonitor
05:33:13 INFO - Successfully installed mozsystemmonitor
05:33:13 INFO - Cleaning up...
05:33:13 INFO - Return code: 0
05:33:13 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv
05:33:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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')]}
05:33:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org
05:33:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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')]}
05:33:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org
05:33:13 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/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 0xd571f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf20a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10c3a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c7090>, '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 0x10c7d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c1f90>, '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': '14ef55db36f7623abb31b9cf000001d5-1504787543.907280-299696051', '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
05:33:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--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
05:33:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1
05:33:13 INFO - Using env: {'DISPLAY': ':0',
05:33:13 INFO - 'HOME': '/home/cltbld',
05:33:13 INFO - 'LANG': 'en_US.UTF-8',
05:33:13 INFO - 'LANGUAGE': 'en_US:en',
05:33:13 INFO - 'LOGNAME': 'cltbld',
05:33:13 INFO - 'MAIL': '/var/mail/cltbld',
05:33:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1',
05:33:13 INFO - 'MOZ_NO_REMOTE': '1',
05:33:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript',
05:33:13 INFO - 'NO_EM_RESTART': '1',
05:33:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games',
05:33:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json',
05:33:13 INFO - 'PWD': '/builds/slave/test',
05:33:13 INFO - 'SHELL': '/bin/bash',
05:33:13 INFO - 'SHLVL': '1',
05:33:13 INFO - 'TERM': 'linux',
05:33:13 INFO - 'TMOUT': '86400',
05:33:13 INFO - 'USER': 'cltbld',
05:33:13 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1504787543.907280-299696051',
05:33:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn',
05:33:13 INFO - '_': '/tools/buildbot/bin/python'}
05:33:13 INFO - Ignoring indexes: https://pypi.python.org/simple/
05:33:13 INFO - Downloading/unpacking jsonschema==2.5.1
05:33:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available
05:33:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available
05:33:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available
05:33:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available
05:33:14 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl
05:33:14 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1)
05:33: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
05:33: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
05:33: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
05:33: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
05:33:14 INFO - Downloading functools32-3.2.3-2.tar.gz
05:33:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32
05:33:14 INFO - warning: no files found matching '*.txt'
05:33:14 INFO - no previously-included directories found matching 'build'
05:33:14 INFO - no previously-included directories found matching 'dist'
05:33:14 INFO - no previously-included directories found matching '.git*'
05:33:14 INFO - Installing collected packages: jsonschema, functools32
05:33:14 INFO - Running setup.py install for functools32
05:33:14 INFO - warning: no files found matching '*.txt'
05:33:14 INFO - no previously-included directories found matching 'build'
05:33:14 INFO - no previously-included directories found matching 'dist'
05:33:14 INFO - no previously-included directories found matching '.git*'
05:33:14 INFO - Successfully installed jsonschema functools32
05:33:14 INFO - Cleaning up...
05:33:14 INFO - Return code: 0
05:33:14 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv
05:33:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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')]}
05:33:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org
05:33:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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')]}
05:33:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org
05:33: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/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 0xd571f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf20a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10c3a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c7090>, '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 0x10c7d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c1f90>, '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': '14ef55db36f7623abb31b9cf000001d5-1504787543.907280-299696051', '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
05:33:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--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
05:33:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2
05:33:14 INFO - Using env: {'DISPLAY': ':0',
05:33:14 INFO - 'HOME': '/home/cltbld',
05:33:14 INFO - 'LANG': 'en_US.UTF-8',
05:33:14 INFO - 'LANGUAGE': 'en_US:en',
05:33:14 INFO - 'LOGNAME': 'cltbld',
05:33:14 INFO - 'MAIL': '/var/mail/cltbld',
05:33:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1',
05:33:14 INFO - 'MOZ_NO_REMOTE': '1',
05:33:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript',
05:33:14 INFO - 'NO_EM_RESTART': '1',
05:33:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games',
05:33:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json',
05:33:14 INFO - 'PWD': '/builds/slave/test',
05:33:14 INFO - 'SHELL': '/bin/bash',
05:33:14 INFO - 'SHLVL': '1',
05:33:14 INFO - 'TERM': 'linux',
05:33:14 INFO - 'TMOUT': '86400',
05:33:14 INFO - 'USER': 'cltbld',
05:33:14 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1504787543.907280-299696051',
05:33:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn',
05:33:14 INFO - '_': '/tools/buildbot/bin/python'}
05:33:14 INFO - Ignoring indexes: https://pypi.python.org/simple/
05:33:14 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages
05:33:14 INFO - Cleaning up...
05:33:15 INFO - Return code: 0
05:33:15 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv
05:33:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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')]}
05:33:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org
05:33:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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')]}
05:33:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org
05:33:15 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/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 0xd571f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf20a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10c3a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c7090>, '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 0x10c7d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c1f90>, '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': '14ef55db36f7623abb31b9cf000001d5-1504787543.907280-299696051', '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
05:33:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--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
05:33:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4
05:33:15 INFO - Using env: {'DISPLAY': ':0',
05:33:15 INFO - 'HOME': '/home/cltbld',
05:33:15 INFO - 'LANG': 'en_US.UTF-8',
05:33:15 INFO - 'LANGUAGE': 'en_US:en',
05:33:15 INFO - 'LOGNAME': 'cltbld',
05:33:15 INFO - 'MAIL': '/var/mail/cltbld',
05:33:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1',
05:33:15 INFO - 'MOZ_NO_REMOTE': '1',
05:33:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript',
05:33:15 INFO - 'NO_EM_RESTART': '1',
05:33:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games',
05:33:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json',
05:33:15 INFO - 'PWD': '/builds/slave/test',
05:33:15 INFO - 'SHELL': '/bin/bash',
05:33:15 INFO - 'SHLVL': '1',
05:33:15 INFO - 'TERM': 'linux',
05:33:15 INFO - 'TMOUT': '86400',
05:33:15 INFO - 'USER': 'cltbld',
05:33:15 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1504787543.907280-299696051',
05:33:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn',
05:33:15 INFO - '_': '/tools/buildbot/bin/python'}
05:33:15 INFO - Ignoring indexes: https://pypi.python.org/simple/
05:33:15 INFO - Downloading/unpacking blobuploader==1.2.4
05:33:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available
05:33:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available
05:33:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available
05:33:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available
05:33:16 INFO - Downloading blobuploader-1.2.4.tar.gz
05:33:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader
05:33:16 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4)
05:33: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
05:33: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
05:33: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
05:33: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
05:33:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests
05:33:16 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4)
05:33: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
05:33: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
05:33: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
05:33: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
05:33:16 INFO - Downloading docopt-0.6.1.tar.gz
05:33:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt
05:33:16 INFO - Installing collected packages: blobuploader, requests, docopt
05:33:16 INFO - Running setup.py install for blobuploader
05:33:17 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775
05:33:17 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775
05:33:17 INFO - Running setup.py install for requests
05:33:17 INFO - Running setup.py install for docopt
05:33:17 INFO - Successfully installed blobuploader requests docopt
05:33:17 INFO - Cleaning up...
05:33:17 INFO - Return code: 0
05:33:17 INFO - Installing None into virtualenv /builds/slave/test/build/venv
05:33:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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')]}
05:33:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org
05:33:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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')]}
05:33:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org
05:33:17 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/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 0xd571f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf20a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10c3a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c7090>, '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 0x10c7d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c1f90>, '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': '14ef55db36f7623abb31b9cf000001d5-1504787543.907280-299696051', '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
05:33:17 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/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config
05:33:17 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/pub --find-links http://pypi.pub.build.mozilla.org/pub
05:33:17 INFO - Using env: {'DISPLAY': ':0',
05:33:17 INFO - 'HOME': '/home/cltbld',
05:33:17 INFO - 'LANG': 'en_US.UTF-8',
05:33:17 INFO - 'LANGUAGE': 'en_US:en',
05:33:17 INFO - 'LOGNAME': 'cltbld',
05:33:17 INFO - 'MAIL': '/var/mail/cltbld',
05:33:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1',
05:33:17 INFO - 'MOZ_NO_REMOTE': '1',
05:33:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript',
05:33:17 INFO - 'NO_EM_RESTART': '1',
05:33:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games',
05:33:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json',
05:33:17 INFO - 'PWD': '/builds/slave/test',
05:33:17 INFO - 'SHELL': '/bin/bash',
05:33:17 INFO - 'SHLVL': '1',
05:33:17 INFO - 'TERM': 'linux',
05:33:17 INFO - 'TMOUT': '86400',
05:33:17 INFO - 'USER': 'cltbld',
05:33:17 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1504787543.907280-299696051',
05:33:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn',
05:33:17 INFO - '_': '/tools/buildbot/bin/python'}
05:33:17 INFO - Ignoring indexes: https://pypi.python.org/simple/
05:33:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser
05:33:17 INFO - Running setup.py (path:/tmp/pip-2pa6DD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser
05:33:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash
05:33:17 INFO - Running setup.py (path:/tmp/pip-jsk76Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash
05:33:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug
05:33:17 INFO - Running setup.py (path:/tmp/pip-1qUdi0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug
05:33:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice
05:33:17 INFO - Running setup.py (path:/tmp/pip-G5ZT2g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice
05:33:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile
05:33:18 INFO - Running setup.py (path:/tmp/pip-YQIlGC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile
05:33:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd
05:33:18 INFO - Running setup.py (path:/tmp/pip-2_r6Cl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd
05:33:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo
05:33:18 INFO - Running setup.py (path:/tmp/pip-CDsR3Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo
05:33:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall
05:33:18 INFO - Running setup.py (path:/tmp/pip-oJsJFG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall
05:33:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak
05:33:18 INFO - Running setup.py (path:/tmp/pip-peEDNe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak
05:33:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog
05:33:18 INFO - Running setup.py (path:/tmp/pip-Tn2A4t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog
05:33:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork
05:33:18 INFO - Running setup.py (path:/tmp/pip-Mic6Xj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork
05:33:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess
05:33:18 INFO - Running setup.py (path:/tmp/pip-AhQ7su-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess
05:33:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile
05:33:18 INFO - Running setup.py (path:/tmp/pip-0XVweh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile
05:33:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner
05:33:18 INFO - Running setup.py (path:/tmp/pip-Hk8Jws-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner
05:33:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot
05:33:18 INFO - Running setup.py (path:/tmp/pip-e0GCeh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot
05:33:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest
05:33:18 INFO - Running setup.py (path:/tmp/pip-z9Hoin-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest
05:33:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion
05:33:18 INFO - Running setup.py (path:/tmp/pip-LVtOKt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion
05:33:18 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion
05:33:18 INFO - Running setup.py install for manifestparser
05:33:19 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin
05:33:19 INFO - Running setup.py install for mozcrash
05:33:19 INFO - Running setup.py install for mozdebug
05:33:19 INFO - Running setup.py install for mozdevice
05:33:19 INFO - Installing dm script to /builds/slave/test/build/venv/bin
05:33:19 INFO - Running setup.py install for mozfile
05:33:19 INFO - Running setup.py install for mozhttpd
05:33:19 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin
05:33:19 INFO - Running setup.py install for mozinfo
05:33:19 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin
05:33:19 INFO - Running setup.py install for mozInstall
05:33:19 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin
05:33:19 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin
05:33:19 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin
05:33:19 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin
05:33:19 INFO - Running setup.py install for mozleak
05:33:19 INFO - Running setup.py install for mozlog
05:33:19 INFO - Installing structlog script to /builds/slave/test/build/venv/bin
05:33:19 INFO - Running setup.py install for moznetwork
05:33:20 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin
05:33:20 INFO - Running setup.py install for mozprocess
05:33:20 INFO - Running setup.py install for mozprofile
05:33:20 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin
05:33:20 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin
05:33:20 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin
05:33:20 INFO - Running setup.py install for mozrunner
05:33:20 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin
05:33:20 INFO - Running setup.py install for mozscreenshot
05:33:20 INFO - Running setup.py install for moztest
05:33:20 INFO - Running setup.py install for mozversion
05:33:20 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin
05:33:20 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion
05:33:20 INFO - Cleaning up...
05:33:20 INFO - Return code: 0
05:33:20 INFO - Installing None into virtualenv /builds/slave/test/build/venv
05:33:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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')]}
05:33:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org
05:33:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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')]}
05:33:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org
05:33:20 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/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 0xd571f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf20a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10c3a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c7090>, '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 0x10c7d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c1f90>, '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': '14ef55db36f7623abb31b9cf000001d5-1504787543.907280-299696051', '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
05:33:20 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/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config
05:33:20 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/pub --find-links http://pypi.pub.build.mozilla.org/pub
05:33:20 INFO - Using env: {'DISPLAY': ':0',
05:33:20 INFO - 'HOME': '/home/cltbld',
05:33:20 INFO - 'LANG': 'en_US.UTF-8',
05:33:20 INFO - 'LANGUAGE': 'en_US:en',
05:33:20 INFO - 'LOGNAME': 'cltbld',
05:33:20 INFO - 'MAIL': '/var/mail/cltbld',
05:33:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1',
05:33:20 INFO - 'MOZ_NO_REMOTE': '1',
05:33:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript',
05:33:20 INFO - 'NO_EM_RESTART': '1',
05:33:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games',
05:33:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json',
05:33:20 INFO - 'PWD': '/builds/slave/test',
05:33:20 INFO - 'SHELL': '/bin/bash',
05:33:20 INFO - 'SHLVL': '1',
05:33:20 INFO - 'TERM': 'linux',
05:33:20 INFO - 'TMOUT': '86400',
05:33:20 INFO - 'USER': 'cltbld',
05:33:20 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1504787543.907280-299696051',
05:33:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn',
05:33:20 INFO - '_': '/tools/buildbot/bin/python'}
05:33:20 INFO - Ignoring indexes: https://pypi.python.org/simple/
05:33:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser
05:33:20 INFO - Running setup.py (path:/tmp/pip-yYUBnB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser
05:33:21 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))
05:33:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash
05:33:21 INFO - Running setup.py (path:/tmp/pip-CNTUAe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash
05:33:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2))
05:33:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug
05:33:21 INFO - Running setup.py (path:/tmp/pip-fmoLMw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug
05:33:21 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))
05:33:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice
05:33:21 INFO - Running setup.py (path:/tmp/pip-wHgZaa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice
05:33:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.51 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))
05:33:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile
05:33:21 INFO - Running setup.py (path:/tmp/pip-ORpFzU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile
05:33:21 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))
05:33:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd
05:33:21 INFO - Running setup.py (path:/tmp/pip-Rz2uUT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd
05:33:21 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))
05:33:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo
05:33:21 INFO - Running setup.py (path:/tmp/pip-9VhPvs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo
05:33:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.10 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))
05:33:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall
05:33:21 INFO - Running setup.py (path:/tmp/pip-TIBO1Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall
05:33:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.13 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))
05:33:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak
05:33:21 INFO - Running setup.py (path:/tmp/pip-fXeo1i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak
05:33:21 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))
05:33:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog
05:33:21 INFO - Running setup.py (path:/tmp/pip-vxd0aJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog
05:33:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.5 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))
05:33:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork
05:33:21 INFO - Running setup.py (path:/tmp/pip-9zrkSg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork
05:33:21 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))
05:33:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess
05:33:21 INFO - Running setup.py (path:/tmp/pip-uxYw8K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess
05:33:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.25 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))
05:33:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile
05:33:21 INFO - Running setup.py (path:/tmp/pip-BAhJPY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile
05:33:21 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))
05:33:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner
05:33:21 INFO - Running setup.py (path:/tmp/pip-Tqrr5b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner
05:33:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14))
05:33:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot
05:33:21 INFO - Running setup.py (path:/tmp/pip-tZNTgW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot
05:33:22 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))
05:33:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest
05:33:22 INFO - Running setup.py (path:/tmp/pip-3w6goF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest
05:33:22 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16))
05:33:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion
05:33:22 INFO - Running setup.py (path:/tmp/pip-U5769k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion
05:33:22 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))
05:33:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2))
05:33:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2))
05:33:22 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))
05:33:22 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.51->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4))
05:33:22 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.51->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4))
05:33:22 INFO - Requirement already satisfied (use --upgrade to upgrade): requests in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozInstall==1.13->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8))
05:33:22 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10))
05:33:22 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
05:33:22 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
05:33:22 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
05:33:22 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
05:33:23 INFO - Downloading blessings-1.6.tar.gz
05:33:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings
05:33:23 INFO - Installing collected packages: blessings
05:33:23 INFO - Running setup.py install for blessings
05:33:23 INFO - Successfully installed blessings
05:33:23 INFO - Cleaning up...
05:33:23 INFO - Return code: 0
05:33:23 INFO - Done creating virtualenv /builds/slave/test/build/venv.
05:33:23 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze']
05:33:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze
05:33:23 INFO - Reading from file tmpfile_stdout
05:33:23 INFO - Current package versions:
05:33:23 INFO - argparse == 1.2.1
05:33:23 INFO - blessings == 1.6
05:33:23 INFO - blobuploader == 1.2.4
05:33:23 INFO - docopt == 0.6.1
05:33:23 INFO - functools32 == 3.2.3-2
05:33:23 INFO - jsonschema == 2.5.1
05:33:23 INFO - manifestparser == 1.1
05:33:23 INFO - mozInstall == 1.13
05:33:23 INFO - mozcrash == 1.0
05:33:23 INFO - mozdebug == 0.1
05:33:23 INFO - mozdevice == 0.51
05:33:23 INFO - mozfile == 1.2
05:33:23 INFO - mozhttpd == 0.7
05:33:23 INFO - mozinfo == 0.10
05:33:23 INFO - mozleak == 0.1
05:33:23 INFO - mozlog == 3.5
05:33:23 INFO - moznetwork == 0.27
05:33:23 INFO - mozprocess == 0.25
05:33:23 INFO - mozprofile == 0.28
05:33:23 INFO - mozrunner == 6.13
05:33:23 INFO - mozscreenshot == 0.1
05:33:23 INFO - mozsystemmonitor == 0.3
05:33:23 INFO - moztest == 0.8
05:33:23 INFO - mozversion == 1.4
05:33:23 INFO - psutil == 3.1.1
05:33:23 INFO - requests == 1.2.3
05:33:23 INFO - wsgiref == 0.1.2
05:33:23 INFO - Installing None into virtualenv /builds/slave/test/build/venv
05:33:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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')]}
05:33:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org
05:33:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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')]}
05:33:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org
05:33:23 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/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 0xd571f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf20a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10c3a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c7090>, '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 0x10c7d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c1f90>, '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': '14ef55db36f7623abb31b9cf000001d5-1504787543.907280-299696051', '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
05:33:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos
05:33:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub
05:33:23 INFO - Using env: {'DISPLAY': ':0',
05:33:23 INFO - 'HOME': '/home/cltbld',
05:33:23 INFO - 'LANG': 'en_US.UTF-8',
05:33:23 INFO - 'LANGUAGE': 'en_US:en',
05:33:23 INFO - 'LOGNAME': 'cltbld',
05:33:23 INFO - 'MAIL': '/var/mail/cltbld',
05:33:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1',
05:33:23 INFO - 'MOZ_NO_REMOTE': '1',
05:33:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript',
05:33:23 INFO - 'NO_EM_RESTART': '1',
05:33:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games',
05:33:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json',
05:33:23 INFO - 'PWD': '/builds/slave/test',
05:33:23 INFO - 'SHELL': '/bin/bash',
05:33:23 INFO - 'SHLVL': '1',
05:33:23 INFO - 'TERM': 'linux',
05:33:23 INFO - 'TMOUT': '86400',
05:33:23 INFO - 'USER': 'cltbld',
05:33:23 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1504787543.907280-299696051',
05:33:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn',
05:33:23 INFO - '_': '/tools/buildbot/bin/python'}
05:33:23 INFO - Ignoring indexes: https://pypi.python.org/simple/
05:33:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1))
05:33:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2))
05:33:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3))
05:33:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4))
05:33:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5))
05:33:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6))
05:33:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7))
05:33:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8))
05:33:23 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9))
05:33:23 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10))
05:33:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available
05:33:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available
05:33:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available
05:33:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available
05:33:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson
05:33:25 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))
05:33:25 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))
05:33:25 INFO - Installing collected packages: simplejson
05:33:25 INFO - Running setup.py install for simplejson
05:33:25 INFO - building 'simplejson._speedups' extension
05:33:25 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c simplejson/_speedups.c -o build/temp.linux-x86_64-2.7/simplejson/_speedups.o
05:33:26 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/simplejson/_speedups.o -o build/lib.linux-x86_64-2.7/simplejson/_speedups.so
05:33:26 INFO - Successfully installed simplejson
05:33:26 INFO - Cleaning up...
05:33:26 INFO - Return code: 0
05:33:26 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv
05:33:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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')]}
05:33:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org
05:33:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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')]}
05:33:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org
05:33:26 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/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 0xd571f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf20a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10c3a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c7090>, '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 0x10c7d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c1f90>, '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': '14ef55db36f7623abb31b9cf000001d5-1504787543.907280-299696051', '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
05:33:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build
05:33:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema
05:33:26 INFO - Using env: {'DISPLAY': ':0',
05:33:26 INFO - 'HOME': '/home/cltbld',
05:33:26 INFO - 'LANG': 'en_US.UTF-8',
05:33:26 INFO - 'LANGUAGE': 'en_US:en',
05:33:26 INFO - 'LOGNAME': 'cltbld',
05:33:26 INFO - 'MAIL': '/var/mail/cltbld',
05:33:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1',
05:33:26 INFO - 'MOZ_NO_REMOTE': '1',
05:33:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript',
05:33:26 INFO - 'NO_EM_RESTART': '1',
05:33:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games',
05:33:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json',
05:33:26 INFO - 'PWD': '/builds/slave/test',
05:33:26 INFO - 'SHELL': '/bin/bash',
05:33:26 INFO - 'SHLVL': '1',
05:33:26 INFO - 'TERM': 'linux',
05:33:26 INFO - 'TMOUT': '86400',
05:33:26 INFO - 'USER': 'cltbld',
05:33:26 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1504787543.907280-299696051',
05:33:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn',
05:33:26 INFO - '_': '/tools/buildbot/bin/python'}
05:33:26 INFO - Ignoring indexes: https://pypi.python.org/simple/
05:33:26 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages
05:33:26 INFO - Cleaning up...
05:33:26 INFO - Return code: 0
05:33:26 INFO - Running post-action listener: _resource_record_post_action
05:33:26 INFO - Running post-action listener: _start_resource_monitoring
05:33:26 INFO - Starting resource monitoring.
05:33:26 INFO - [mozharness: 2017-09-07 12:33:26.454097Z] Finished create-virtualenv step (success)
05:33:26 INFO - [mozharness: 2017-09-07 12:33:26.455028Z] Running install step.
05:33:26 INFO - Running pre-action listener: _resource_record_pre_action
05:33:26 INFO - Running main action method: install
05:33:26 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze']
05:33:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze
05:33:26 INFO - Reading from file tmpfile_stdout
05:33:26 INFO - Detecting whether we're running mozinstall >=1.0...
05:33:26 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h']
05:33:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h
05:33:26 INFO - Reading from file tmpfile_stdout
05:33:26 INFO - Output received:
05:33:26 INFO - Usage: mozinstall [options] installer
05:33:26 INFO - Options:
05:33:26 INFO - -h, --help show this help message and exit
05:33:26 INFO - -d DEST, --destination=DEST
05:33:26 INFO - Directory to install application into. [default:
05:33:26 INFO - "/builds/slave/test"]
05:33:26 INFO - --app=APP Application being installed. [default: firefox]
05:33:26 INFO - mkdir: /builds/slave/test/build/application
05:33:26 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/target.tar.bz2', '--destination', '/builds/slave/test/build/application']
05:33:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application
05:33:43 INFO - Reading from file tmpfile_stdout
05:33:43 INFO - Output received:
05:33:43 INFO - /builds/slave/test/build/application/firefox/firefox
05:33:43 INFO - Running post-action listener: _resource_record_post_action
05:33:43 INFO - [mozharness: 2017-09-07 12:33:43.279982Z] Finished install step (success)
05:33:43 INFO - [mozharness: 2017-09-07 12:33:43.280130Z] Running setup-mitmproxy step.
05:33:43 INFO - Running pre-action listener: _resource_record_pre_action
05:33:43 INFO - Running main action method: setup_mitmproxy
05:33:43 INFO - Skipping: mitmproxy is not required
05:33:43 INFO - Running post-action listener: _resource_record_post_action
05:33:43 INFO - [mozharness: 2017-09-07 12:33:43.280832Z] Finished setup-mitmproxy step (success)
05:33:43 INFO - [mozharness: 2017-09-07 12:33:43.280965Z] Running run-tests step.
05:33:43 INFO - Running pre-action listener: _resource_record_pre_action
05:33:43 INFO - Running pre-action listener: _set_gcov_prefix
05:33:43 INFO - Running main action method: run_tests
05:33:43 WARNING - Try message not found.
05:33:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version']
05:33:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version
05:33:43 INFO - Python 2.7.3
05:33:43 INFO - Return code: 0
05:33:43 INFO - grabbing minidump binary from tooltool
05:33:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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')]}
05:33:43 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://tooltool.mozilla-releng.net/', '--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 0x10c7090>, '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 0x10c7d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c1f90>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1
05:33:43 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://tooltool.mozilla-releng.net/', '--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
05:33:43 INFO - Copy/paste: /tools/tooltool.py --url https://tooltool.mozilla-releng.net/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache
05:33:43 INFO - Calling ['/tools/tooltool.py', '--url', 'https://tooltool.mozilla-releng.net/', '--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
05:33:43 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache
05:33:43 INFO - Return code: 0
05:33:43 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755
05:33:43 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir
05:33:43 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir
05:33:43 INFO - ENV: RUST_BACKTRACE is now full
05:33:43 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk
05:33:43 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir
05:33:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/O4Y3kdYKTk6AYNU8oh2jiA/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-036', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build
05:33:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/O4Y3kdYKTk6AYNU8oh2jiA/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-036 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log
05:33:43 INFO - Using env: {'DISPLAY': ':0',
05:33:43 INFO - 'HOME': '/home/cltbld',
05:33:43 INFO - 'LANG': 'en_US.UTF-8',
05:33:43 INFO - 'LANGUAGE': 'en_US:en',
05:33:43 INFO - 'LOGNAME': 'cltbld',
05:33:43 INFO - 'MAIL': '/var/mail/cltbld',
05:33:43 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir',
05:33:43 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk',
05:33:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1',
05:33:43 INFO - 'MOZ_NO_REMOTE': '1',
05:33:43 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir',
05:33:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript',
05:33:43 INFO - 'NO_EM_RESTART': '1',
05:33:43 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games',
05:33:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json',
05:33:43 INFO - 'PWD': '/builds/slave/test',
05:33:43 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos',
05:33:43 INFO - 'RUST_BACKTRACE': 'full',
05:33:43 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts',
05:33:43 INFO - 'SHELL': '/bin/bash',
05:33:43 INFO - 'SHLVL': '1',
05:33:43 INFO - 'STYLO_FORCE_ENABLED': '1',
05:33:43 INFO - 'STYLO_THREADS': '1',
05:33:43 INFO - 'TERM': 'linux',
05:33:43 INFO - 'TMOUT': '86400',
05:33:43 INFO - 'USER': 'cltbld',
05:33:43 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1504787543.907280-299696051',
05:33:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn',
05:33:43 INFO - '_': '/tools/buildbot/bin/python'}
05:33:43 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/O4Y3kdYKTk6AYNU8oh2jiA/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-036', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600
05:33:43 INFO - mozversion application_buildid: 20170907103944
05:33:43 INFO - mozversion application_changeset: 37b95547f0d27565452136d16b2df2857be840f6
05:33:43 INFO - mozversion application_display_name: Nightly
05:33:43 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384}
05:33:43 INFO - mozversion application_name: Firefox
05:33:43 INFO - mozversion application_remotingname: firefox
05:33:43 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central
05:33:43 INFO - mozversion application_vendor: Mozilla
05:33:43 INFO - mozversion application_version: 57.0a1
05:33:43 INFO - mozversion platform_buildid: 20170907103944
05:33:43 INFO - mozversion platform_changeset: 37b95547f0d27565452136d16b2df2857be840f6
05:33:43 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central
05:33:43 INFO - mozversion platform_version: 57.0a1
05:33:43 INFO - using testdate: 1504787623
05:33:43 INFO - actual date: 1504787623
05:33:43 INFO - starting webserver on 'localhost:55233'
05:33:43 INFO - SUITE-START | Running 2 tests
05:33:43 INFO - TEST-START | dromaeo_css
05:33:43 INFO - Initialising browser for dromaeo_css test...
05:33:43 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:55233/getInfo.html -profile /tmp/tmpK109yh/profile
05:33:43 INFO - TEST-INFO | started process 3811 (/builds/slave/test/build/application/firefox/firefox http://localhost:55233/getInfo.html)
05:33:53 INFO - TEST-INFO | 3811: exit 0
05:33:53 INFO - Browser initialized.
05:33:53 INFO - Running cycle 1/1 for dromaeo_css test...
05:33:53 INFO - Using env: {'DISPLAY': ':0',
05:33:53 INFO - 'HOME': '/home/cltbld',
05:33:53 INFO - 'JSGC_DISABLE_POISONING': '1',
05:33:53 INFO - 'LANG': 'en_US.UTF-8',
05:33:53 INFO - 'LANGUAGE': 'en_US:en',
05:33:53 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox',
05:33:53 INFO - 'LOGNAME': 'cltbld',
05:33:53 INFO - 'MAIL': '/var/mail/cltbld',
05:33:53 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir',
05:33:53 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk',
05:33:53 INFO - 'MOZ_CRASHREPORTER': '1',
05:33:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1',
05:33:53 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1',
05:33:53 INFO - 'MOZ_NO_REMOTE': '1',
05:33:53 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir',
05:33:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript',
05:33:53 INFO - 'NO_EM_RESTART': '1',
05:33:53 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games',
05:33:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json',
05:33:53 INFO - 'PWD': '/builds/slave/test',
05:33:53 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos',
05:33:53 INFO - 'RUST_BACKTRACE': 'full',
05:33:53 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts',
05:33:53 INFO - 'SHELL': '/bin/bash',
05:33:53 INFO - 'SHLVL': '1',
05:33:53 INFO - 'STYLO_FORCE_ENABLED': '1',
05:33:53 INFO - 'STYLO_THREADS': '1',
05:33:53 INFO - 'TERM': 'linux',
05:33:53 INFO - 'TMOUT': '86400',
05:33:53 INFO - 'USER': 'cltbld',
05:33:53 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1504787543.907280-299696051',
05:33:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn',
05:33:53 INFO - '_': '/tools/buildbot/bin/python'}
05:33:53 INFO - TEST-INFO | started process 4000 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpK109yh/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1)
05:33:54 INFO - PID 4000 |
05:33:54 INFO - PID 4000 | (/builds/slave/test/build/application/firefox/firefox:4051): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied
05:33:54 INFO - PID 4000 |
05:34:04 INFO - PID 4000 | RSS: Main: 170405888
05:34:04 INFO - PID 4000 |
05:37:02 INFO - PID 4000 | Cycle 1(1): loaded http://localhost:55233/tests/dromaeo/cssquery-dojo.html (next: http://localhost:55233/tests/dromaeo/cssquery-ext.html)
05:37:03 INFO - PID 4000 | RSS: Main: 174301184
05:37:03 INFO - PID 4000 |
05:40:05 INFO - PID 4000 | Cycle 1(1): loaded http://localhost:55233/tests/dromaeo/cssquery-ext.html (next: http://localhost:55233/tests/dromaeo/cssquery-jquery.html)
05:40:06 INFO - PID 4000 | RSS: Main: 168148992
05:40:06 INFO - PID 4000 |
05:43:07 INFO - PID 4000 | Cycle 1(1): loaded http://localhost:55233/tests/dromaeo/cssquery-jquery.html (next: http://localhost:55233/tests/dromaeo/cssquery-mootools.html)
05:43:08 INFO - PID 4000 | RSS: Main: 173039616
05:43:08 INFO - PID 4000 |
05:46:10 INFO - PID 4000 | Cycle 1(1): loaded http://localhost:55233/tests/dromaeo/cssquery-mootools.html (next: http://localhost:55233/tests/dromaeo/cssquery-prototype.html)
05:46:10 INFO - PID 4000 | RSS: Main: 169164800
05:46:10 INFO - PID 4000 |
05:49:14 INFO - PID 4000 | Cycle 1(1): loaded http://localhost:55233/tests/dromaeo/cssquery-prototype.html (next: http://localhost:55233/tests/dromaeo/cssquery-yui.html)
05:49:14 INFO - PID 4000 | RSS: Main: 172998656
05:49:14 INFO - PID 4000 |
05:52:16 INFO - PID 4000 | Cycle 1(1): loaded http://localhost:55233/tests/dromaeo/cssquery-yui.html (next: http://localhost:55233/tests/dromaeo/cssquery-dojo.html)
05:52:16 INFO - PID 4000 | RSS: Main: 175714304
05:52:16 INFO - PID 4000 |
05:52:16 INFO - PID 4000 | __start_tp_report
05:52:16 INFO - PID 4000 | _x_x_mozilla_page_load
05:52:16 INFO - PID 4000 | _x_x_mozilla_page_load_details
05:52:16 INFO - PID 4000 | |i|pagename|runs|
05:52:16 INFO - PID 4000 | |0;dojo.html;3279.3441311737656;3303.405387030335;3312.370649576582;3327.7670563060597;3335.8498867550957;6313.053042043695;6415.45468635166;6428.614283143009;6455.096286519891;6479.676016199189;6375.968120159404;6432.935670643304;6441.066045423411;6459.063435801818;6584.012398140281;5948.494377977877;5965.284165900076;5982.8803423931495;6022.397760223987;6025.307089684698;1210.9425995201248;5519.806806761764;5810.941890581083;5955.761769529214;6062.42406971337;5904.084866845646;5930.318013428468;5943.554233432488;5986.191864098357;6012.098185272201;5912.704364781786;5937.168796368512;5989.221401217814;5999.820005399845;6016.037434010581;5878.030125029408;5894.17481552583;5962.403759624046;5982.222311099529;5990.101484777275;6428.357164283581;6428.5178611604315;6473.676316184172;6532.934670653281;6558.508111891627;6601.240857301424;6695.765648202289;6823.624700641462;6899.344562266577;6993.510454268203;6982.371586557234;7023.648817559101;7043.436525077981;7044.436445084381;7057.435405167575;6436.999999999954;6470.708818103197;6541.901871471931;6550.901736473957;6554.541182117254;7149.177844547944;7152.499325047197;7239.058922340062;7241.167265764399;7255.4921155518605;6525.543211975211;6650.3349665034075;6736.292689267654;6795.218549866829;6818.863622727517;6805.149356330458;6929.064576282138;6936.653167341613;6943.861122777516;6947.270536593584;6864.519483636098;6941.132358455193;6945.89581156283;6948.791536253921;6953.026576279325;6627;6702.19573651165;6861.4853885958755;6878.793636190822;6957.339052789976;5360.544353729899;5384.219288203267;5395.514403703685;5396.892062158735;5401.243825864303;4708.458527269339;4728.432588089451;4762.095201911695;4857.198562237262;4866.902661946741;5925.051991681396;5931.525477961753;5983.371745966698;6002.39976002405;6007.15899774032;6841.692123854438;6860.6912688929115;6934.341237582422;6947.166340039228;6961.23426423093;5784.421557844182;5893.5579831512805;5921.970390148022;5978.461938425563;5985.521158307412;5885.264341957255;5944.989351810203;5963.105534169822;5969.462748352669;5981.641101533922;6648.700808463534;6662.733490660319;6706.731730730814;6761.323867613298;6798;6901.206361268418;6937.826554336182;6951.026856240131;7009.404200642798;7027.086478757728;6336.809895703136;6438.67806609677;6599.835004124935;6648.700808463727;6760.560563563353;6803.183617965876;6810.046593476818;6858.794236172923;6859.965700171667;6861.897071544031;6970.268121847133;7018.33325834045;7047.7180912762915;7051.894221586577;7053.118360204974;6705.932940670531;6719;6730.629815360202;6810.148731408574;6832.726690932307;6468.870622587616;6612.206535215805;6613.074169616161;6635.834104147435;6671.366220209073;6648.434883034803;6653.268140504638;6719.697613607497;6723.7646682365885;6736.124303840469;6740.022696708852;6741.089952856498;6824.965875170592;6851.246362900177;6871.03805467225;6342.556021078481;6445.16212892321;6489.967550162219;6502.967485162544;6588.242352129567
05:52:16 INFO - PID 4000 | |1;ext.html;833.0960907415454;858.9012263589689;862.504060165405;865.2472349056322;867.5618812499687;42404;43254.56745432545;43409.13181736363;43456.78271608642;43684.34473482901;38617.806910965475;38678.61321386785;42370;43175.56824431755;43316;7807.6876924922935;7933.444658873881;7938.563379014152;7967.960160199191;7969.800754981143;7830.6084695764985;7929.1277959424415;7931.881021784649;7938.364930805522;7956.6817327306835;7987.5606841623685;7992.160823113577;7999.600019999006;8000.199980002011;8015.519068855858;7855.607219639024;7935.127136015062;7946.841063178733;7965.641546130438;7976.322012628933;7828.686852525892;7853.371730261622;7862.803429914241;7874.606269686493;7883.7240696575345;38434.615653843386;39040.609593904264;39196;39263.41104883429;39339.606603933884;3615.7288203384587;3651.94522082169;3652.086978255436;3653.251083527897;3654.634536546351;31489.21276968071;31602.841985789924;31678.208044799063;31723.52414713781;31846;5078.822241221539;5235;5258.0535503609335;5268.367795864482;5293.841184764463;180721;183735.99999999866;186763;186983;187449;49264;49434.25848612274;49565.75217123891;49706.50293497019;50019.24971125436;51600.48399516032;51682;51725.741371292905;51779;51791.115666325175;16124.516264511849;16238.675226495405;16239.431619893247;16266.674666506604;16281;13632.65918352049;13636.113652612548;13648.795268070988;13653.317334133253;13661.385237664328;13247.668808279677;13265.336733163304;13292.202467851766;13316.800247996287;13365.866341336656;5206.64627196924;5309.761060752276;5312.309399778082;5338.839834804962;5452;1022.3865680591734;1022.9079382855579;1027.7430642339416;1035.052926572178;1039.2465462539749;22219.444513887283;22373;23203.187888423825;28742.568861467094;29715.85142074319;1099.3568762273999;1108.5344155454568;1112.8720197177267;1126.4086354663866;1136.8408422820812;12429.37853107341;12820.679483013;12866.549670761478;12945.54690585825;13045.673858153623;248061;248106;248481;250933;251231;54866.725666371414;54874.17688734672;54875.451245487835;54893.45106548963;55072.17391739127;1460.350144185827;1478.9038712483655;1497.5133081748475;1497.7453832848441;1507.3895072495657;22981.310560683207;23064.538709226057;23121.88439057794;23155.3053408398;23363.415914602272;40182.39726404165;40315.596844031184;40421;40463.595364045985;40473.19053618852;205447;205710;206019;206457;207890;34228;34603.65396346105;38195.42706859455;38735.22529549337;38797.6120238794;45915.77042114768;47588.57234282977;48309;48405.51594484151;48501.5149848497;34444.82777586096;34653.653463465045;34727.65272347244;35004.12489687778;35149.121271968404;33738.325233495685;34084.25366048713;34130.82934585311;34287.48568771421;34950.30099398048;38930.4160437588;39311.60688393079;39316;39339.2132157361;39492.40761388524;33040.50439243365;33334.66665333316;33615.15962100967;33641.66358336385;34242.65757342494;24710.382240444134;24898.377540561632;24933.252002439956;25094.49811003806;25159.49681006406
05:52:16 INFO - PID 4000 | |2;jquery.html;563.7547666764955;576.4063015094453;581.4911952041963;585.6690969602172;595.6604735300879;22383.328500145002;23044.88477557612;23096.769032309672;23108.768912310912;23161.884190579065;23040;24639.507209855794;24851.627225591586;25032;25194.874025629848;6496.12302339184;6688.966555167217;6689.531732778707;6694.0962969999155;6708.396244338033;6386.552941294111;6595.53831231814;6644.900326495106;6651.534392592521;6697.799066028003;6604.108445359863;6608.636524991123;6618.669066546678;6625.403713665769;6626.635535045571;6370.968145159244;6633.601983880959;6634.933650663504;6638.800835974928;6666.6333351665635;6147.139400483936;6152.323244443108;6158.168647232611;6160.1375807387;6171.475424588871;28575.28561785972;28904;28986.42027159445;29008;29053.273668158254;2063.8039386258283;2085.95828083439;2091.0381224636535;2095.8847263400507;2097.328854766475;18588.163532640927;19038.238470461165;19211.51971200717;19261.61476770471;19330.80669193304;2332.696749422581;2379.9286021419384;2409.325388891113;2409.542186984467;2413.879306034691;118346;124840;137832;144767.27616361956;145123;14456.230811619434;14632.90253231012;14660.413583456755;14729.705405892037;14949.08492843885;22153.335399938027;22169.334919952427;22185.667214991787;22190.889045554668;22191.44521386978;10246.282760206714;10333.638322658671;10362.119219866245;10405.739856503647;10475.266731328733;9634.325597208268;9667.178289845302;9670.178034866974;9729.9027009729;9877.555510002067;8712.607932643046;8821.2060914518;8900.510471924106;8972.237359824358;9157.49633770149;2682.9463410732064;2695.7734230925275;2696.7438093381097;2721.8230814996964;2785.3175971886612;939.3424602778083;966.6858271061933;966.9564869580886;968.7578105473632;974.6004138303404;18734.501239900776;18826.62346753057;18966.810331896504;19130.808691912902;19379.127939242768;1014.5586669798661;1016.1667432705259;1019.2661283875746;1026.707388394319;1028.8713910761155;10198.796024079476;10330.380177189392;10458.111060559786;10498.947505262426;10658.307210031324;432747;437005;438740;439682;444715;117092;117635;121816;121949;122104.38947805203;1209.854817421915;1216.191232830158;1241.5716577780652;1250.9124361294805;1256.1018871506917;20255.4936126598;20467.4883127923;20531.076101575167;21064.789352106283;21408.57182856303;57952.42047579639;58871;59612;61460;62051.069233960625;79232.20767792479;79471;79757.60121199356;82344;84226;19870.403887883385;20879.164833406492;20979.685304720748;21097.05063272187;21121.6831747527;23063.769362306834;23314.65028024547;23603.29190124299;23763.524729504967;23803.64294535549;18152.818471815113;18514.814851851308;18595.34916277924;18748.06259686983;18794;16708.749368759236;16994.405195818086;17031.318747250465;17539.298428062735;17706.291748330437;18743.34398296053;18899.811001889804;18986.620267594295;19128.90435547869;19367.903160484108;20188;20304.289349872684;20312.59374812466;20356.389308320773;20377;17532.474025779247;18362.724559131355;18935.526611834815;19021.144048517574;19211
05:52:16 INFO - PID 4000 | |3;mootools.html;1363.40010395426;1433.7132573485305;1438.8057612222353;1446.3491428857014;1452.5642307307805;14696.632584185401;15307.693846123071;15312.0812751235;15352.155631440266;15374.154421506813;14952.401903923857;15158.090514569134;15158.469453569127;15167.317470713817;15168.469103581348;2711.4577084583066;2728.686201086871;2758.0622588319966;2767.986160069197;2783.1928740665185;2698.7031426543062;2721.2380533450664;2722.891084356633;2726.2775364528416;2731.808773385864;2695.986520067397;2719.687235967859;2791.804573679843;2793.1620513845864;2797.4125433658955;2820.6333176687103;2821.520341541943;2848.5442329227326;2853.857307134656;2857.1000134957526;2668.9199324020115;2678.665166854143;2691.87886545104;2742.2595899107127;2750.2024412920227;14411.639709007253;14628.195449250286;14632.195229262386;14648.560543183721;14649.707005859824;7673.50122242058;7914.3272821810215;7920.326772224368;7922.524648521107;7924.841503169904;5383.515483606455;5445.264889239981;5513.228148059275;5560.7219639017885;5600.859978500529;1836.669399508088;1849.3342396737298;1856.053412759489;1884.076802366844;1890.4801179675562;26193.476130477473;26700.198994030212;26774.464510709677;26789.598156027674;26801;6882.793516194522;6944.618046007417;6967.268436814163;7081.964590177016;7183.030290910765;19637.31269405564;19870.30453934134;19893.701594476093;19896;19898.60202795936;8039.598020098972;8238.134995825472;8238.423310368216;8245.95877020611;8255.628496717662;6975.825604359931;7099.290070992859;7231.746888858865;7338.596377199198;7342.889856652155;5318.946810531923;5446.428125046892;5482.095454250084;5518.117101263779;5554.91667624986;1718.2096235731453;1726.240454200148;1729.619483713581;1737.9405404595595;1749.9562510937074;898.1647068226612;931.2177770672668;933.262722449271;933.290699068699;946.4888959961544;7788.532688038623;7825.569593672402;8374.916250837536;8438.367122465717;8536.70121545743;686.543448606681;703.1175874277851;708.5606923707335;715.9654299537119;723.2550473012806;4529.411176547028;4571.519990401027;5381.408045115034;5387.4073851876265;5409.459054094559;20913.79086209149;21696.89151554232;21741.565168696536;21754.782452175594;21759.564808703737;21006.894965525076;21125.366239012856;21310;21574;22004;11158.665240042812;11380;11391.373474458984;11407.885921140849;11421;7675.616219188906;7764.6894124234395;7781.883271751041;7812.726554570563;7894.447388682737;18072.367467139113;18227.908860455613;18246.0876956149;18440;18631.906840465712;18873.622527549647;19026.42920712381;19092.713609295595;19331.613367732847;19417.902910485358;12044.518219271482;12435.440405181607;12483.812742809047;12506.68733281639;12566.371681416076;13634.181949083088;14240.287985600471;14331.426742930584;14332.713345733235;14362.210078445369;11330;11371.772564548828;11419.371934543347;11509.597164099552;11653.417329133339;11244.26912250701;11299.43502824872;11349.432528373713;11413.372264525198;11488.885111148782;10040.69877903664;10055.69832905014;10119.241056920613;10144.644937427154;10159;7284.125904891447;7300.96349518249;7319.487635865438;7340.816479588053;7368.59472729005;7232;7317.487775855852;7374.299441553044;7389.371903388273;7391.556506609621
05:52:16 INFO - PID 4000 | |4;prototype.html;490.2402366807796;512.2367672168469;521.759990404414;525.7161132988186;532.1724718063412;6346.778627480379;6426.164598602187;6437.839054023651;6483.643399613019;6531.877139929524;6246.187995560582;6253.374662533744;6356.52326075545;6373.904391434132;6401.199850018747;5224.660397074197;5281.524662780349;5294.10000299948;5300.655457395276;5347.385050719178;4911.238757992517;5062.417821950486;5228.640553456091;5300.496452836975;5354.982553314877;4987.551120399164;5025;5042.319286896277;5091.454272863568;5129.153689641204;4944.134776414113;4994.900101997958;5034.622403319729;5036.722980236085;5103.800606857386;4415.315626077963;4508.233600287959;4533.252013417782;4552.793509719927;4579.267317229261;6173.475254603364;6240.4071613196675;6279.277883043417;6311.211098612674;6329.556931014785;5713.14302854571;5771.682557459338;5784.913226301609;5785.566082543826;5790.392008839095;6606.174228221473;6649.567778094457;6678.43233325168;6686.632235227061;6698.464122870208;4934.407871055496;4957.900841983176;4985.376827896513;4987.975060124712;5003.649744517885;6755.763548275836;6863.416609588191;6887.862242755117;6979.720811167547;7092.503524753218;5494.76367817246;5502.862428439241;5516.889662206813;5524.171374293888;5560.471755183251;5602.467765562265;5613.887722245532;5621.747021384048;5630.634008789416;5649.943300745809;6095.268567771807;6123.785667501616;6133.558613725771;6150.415710507495;6164.722587483574;6738;6780.762673306509;6801.65991700413;6852.486063545154;6861.142357205349;1928.3250862198117;1943.4461178564325;1976.209516193534;1977.9703304450156;2002.8698134621202;1392.540461647654;1425.8094491099841;1443.9422423102958;1462.354850792858;1474.7566651502596;5784.21913041734;5789.102689083199;5849.607227807861;5852.473277405054;5907.616004959664;6660.267370589231;6769.932300677028;6804.489663275175;6850.794476165624;6858.348456896687;5759.452851979056;5833.154192642128;5849.824505264849;5899.793507227227;5927.8221653350465;3517.56030496188;3528.4530897710897;3558.3594952908725;3571.607123216444;3625.4380571011534;6561.1470508833545;6562.212534495891;6595.241547222035;6605.24039735427;6620.337966203341;6854.314568543105;6907.309269073053;6923.757668481579;6925.342092501204;6981.5461994970165;6528.281888992207;6611.801645950629;6669.166354205724;6674.566153200123;6677.432418244406;6772.11962444879;6813.4549236061985;6868.828279293058;6869.381755642016;6894.689738961659;6784.457243420416;6806.591604503746;6834.8633027340165;6883.382405134889;6887.414569761426;6446.67766611677;6515.315891831479;6595.670216489252;6669.633170175687;6693.497987650849;5391.622586418913;5431.212474191141;5464.863378415572;5495.8016793283;5499.587530935116;6556.967215163893;6630.46956243509;6715.5299129060495;6741.494387921024;6769.424598908951;6484.740610375721;6522.05430212607;6558.8360290993105;6569.572977756622;6680.06278179342;6459.289478157493;6478.2550006749825;6524.217093948757;6592.472602191718;6647.867042659023;6305.527085468517;6412.775552855627;6426.646534440463;6471.352864713679;6594.505412094208;6635.900461493178;6652.268250492345;6715.899261510984;6764.661766911733;6787.762428314985;6417.518686098468;6451.258105317948;6471.967640161957;6484.708188131451;6537.607743535403
05:52:16 INFO - PID 4000 | |5;yui.html;906.4108329585772;913.6025828764488;925.5742358515087;931.4550987672216;950.5247376311846;19201.327953521628;20186.798132018695;20287.797122028776;20301;20304.796952030476;17917.193726282316;18596.628067438643;18759.43721688348;18823.435296941112;18985.715214271764;960.1598601223947;979.5102448775613;981.2444417798326;982.327105932435;986.842105263158;978.6868202175307;999.1157825324567;1001.2640709078821;1017.4912543728136;1020.2807021050179;1043.4469731042523;1048.2033654422655;1053.2995557953989;1054.8470471781586;1054.8734151901783;993.5926270229207;1029.073833549811;1042.8748550173952;1050.3592808386877;1057.471264367816;747.7083937264471;753.4913933095194;753.506453273107;756.4591317208223;756.7956651704064;19179.52051198717;19270.61458770817;19311.613767724568;19342.709859352122;19344.32294869687;21427.46431339229;22763.203287884844;22776;22786;22844.086236550516;17505.7374139388;18341;18431.72352414715;18457.077146142638;18513.352032678926;3579.534660494145;3607.2244467439627;3608.1340478285283;3613.512175856278;3648.6351364863567;138511.30744346214;141763.29118354342;142870.28564857214;143882.28058859744;145536;16334.75497867533;16776.748348774778;16878.156092195342;16893.577660558338;16900.070496122586;28737.137885863456;28741.28146796347;28818.567721484196;28854.855725721238;29025.41949161005;8317.667293308199;8434.451760635538;8517.06312305646;8533.317334613215;8534.658613655385;4029.5366032906004;4142.2751018572235;4146.564610715892;4147.004718867511;4152.356384760367;5333.919991200135;5432.212329212242;5441.29263195782;5445.782168713286;5462.808801691922;933.0576118120612;957.4011400960413;974.0600320690568;979.715882394112;980.9852852207223;694.1635329428027;709.4501761135058;714.9821254468679;716.2880715090937;724.0225695311393;11639.359835209145;12611;12626.684332891751;13111.868881311255;13164.539241126706;630.6594439002979;637.1366797988751;642.1908395421802;650.2619526837074;653.5882394091692;5734.627249228787;5814.534837213013;6320.273168585672;6321.65230912295;6472.967635161888;118463;120852;121708;121867.39066304611;127019;98576.50711746396;101993.49003254937;104863;107115.46442267738;109354;92479.53760231155;95267.52366238124;96779.51610241903;97918.51040744894;98542.52186217213;12619.242845429304;13155.210687358407;13251.536196233086;13547.661308466973;13680;42674.78662606667;43991.78004109959;44237;44825.327620085074;45090.77454612706;77162.61418692871;79902;80041;81704;84106.57946710472;18808.341708040152;19156.904215478833;19671.803281966997;19704.507387315432;19786.10962506662;21945.780542194374;22487;22491.325260242218;22505.09979600863;22773.658395124417;19509.12208950629;19688;19745.308914187935;20203.090860911587;20404.28584999518;19013.809861901205;19592.60814783668;19827.900860495603;19971.400857974284;20313.79686203119;18552.81447185511;18676.159572819528;19143;19221.807781922562;19442.319518816774;12438.689032773891;12955.222686638832;13188.27464489424;13443.663908402368;13528.323583820966;13563.59309220725;13991;14210.431582736988;15032.849671503582;15077.924610376878
05:52:16 INFO - PID 4000 | __end_tp_report
05:52:16 INFO - PID 4000 | __start_cc_report
05:52:16 INFO - PID 4000 | _x_x_mozilla_cycle_collect,369
05:52:16 INFO - PID 4000 | __end_cc_report
05:52:16 INFO - PID 4000 | __startTimestamp1504788736603__endTimestamp
05:52:16 INFO - PID 4000 |
05:52:16 INFO - PID 4000 | ------- Summary: start -------
05:52:16 INFO - PID 4000 | Number of tests: 6
05:52:16 INFO - PID 4000 |
05:52:16 INFO - PID 4000 | [#0] dojo.html Cycles:165 Average:6324.25 Median:6584.01 stddev:854.15 (13.0%) stddev-sans-first:822.69
05:52:16 INFO - PID 4000 | Values: 3279.3 3303.4 3312.4 3327.8 3335.8 6313.1 6415.5 6428.6 6455.1 6479.7 6376.0 6432.9 6441.1 6459.1 6584.0 5948.5 5965.3 5982.9 6022.4 6025.3 1210.9 5519.8 5810.9 5955.8 6062.4 5904.1 5930.3 5943.6 5986.2 6012.1 5912.7 5937.2 5989.2 5999.8 6016.0 5878.0 5894.2 5962.4 5982.2 5990.1 6428.4 6428.5 6473.7 6532.9 6558.5 6601.2 6695.8 6823.6 6899.3 6993.5 6982.4 7023.6 7043.4 7044.4 7057.4 6437.0 6470.7 6541.9 6550.9 6554.5 7149.2 7152.5 7239.1 7241.2 7255.5 6525.5 6650.3 6736.3 6795.2 6818.9 6805.1 6929.1 6936.7 6943.9 6947.3 6864.5 6941.1 6945.9 6948.8 6953.0 6627.0 6702.2 6861.5 6878.8 6957.3 5360.5 5384.2 5395.5 5396.9 5401.2 4708.5 4728.4 4762.1 4857.2 4866.9 5925.1 5931.5 5983.4 6002.4 6007.2 6841.7 6860.7 6934.3 6947.2 6961.2 5784.4 5893.6 5922.0 5978.5 5985.5 5885.3 5945.0 5963.1 5969.5 5981.6 6648.7 6662.7 6706.7 6761.3 6798.0 6901.2 6937.8 6951.0 7009.4 7027.1 6336.8 6438.7 6599.8 6648.7 6760.6 6803.2 6810.0 6858.8 6860.0 6861.9 6970.3 7018.3 7047.7 7051.9 7053.1 6705.9 6719.0 6730.6 6810.1 6832.7 6468.9 6612.2 6613.1 6635.8 6671.4 6648.4 6653.3 6719.7 6723.8 6736.1 6740.0 6741.1 6825.0 6851.2 6871.0 6342.6 6445.2 6490.0 6503.0 6588.2
05:52:16 INFO - PID 4000 |
05:52:16 INFO - PID 4000 | [#1] ext.html Cycles:180 Average:39077.93 Median:3653.94 stddev:55838.08 (1528.2%) stddev-sans-first:55920.87
05:52:16 INFO - PID 4000 | Values: 833.1 858.9 862.5 865.2 867.6 42404.0 43254.6 43409.1 43456.8 43684.3 38617.8 38678.6 42370.0 43175.6 43316.0 7807.7 7933.4 7938.6 7968.0 7969.8 7830.6 7929.1 7931.9 7938.4 7956.7 7987.6 7992.2 7999.6 8000.2 8015.5 7855.6 7935.1 7946.8 7965.6 7976.3 7828.7 7853.4 7862.8 7874.6 7883.7 38434.6 39040.6 39196.0 39263.4 39339.6 3615.7 3651.9 3652.1 3653.3 3654.6 31489.2 31602.8 31678.2 31723.5 31846.0 5078.8 5235.0 5258.1 5268.4 5293.8 180721.0 183736.0 186763.0 186983.0 187449.0 49264.0 49434.3 49565.8 49706.5 50019.2 51600.5 51682.0 51725.7 51779.0 51791.1 16124.5 16238.7 16239.4 16266.7 16281.0 13632.7 13636.1 13648.8 13653.3 13661.4 13247.7 13265.3 13292.2 13316.8 13365.9 5206.6 5309.8 5312.3 5338.8 5452.0 1022.4 1022.9 1027.7 1035.1 1039.2 22219.4 22373.0 23203.2 28742.6 29715.9 1099.4 1108.5 1112.9 1126.4 1136.8 12429.4 12820.7 12866.5 12945.5 13045.7 248061.0 248106.0 248481.0 250933.0 251231.0 54866.7 54874.2 54875.5 54893.5 55072.2 1460.4 1478.9 1497.5 1497.7 1507.4 22981.3 23064.5 23121.9 23155.3 23363.4 40182.4 40315.6 40421.0 40463.6 40473.2 205447.0 205710.0 206019.0 206457.0 207890.0 34228.0 34603.7 38195.4 38735.2 38797.6 45915.8 47588.6 48309.0 48405.5 48501.5 34444.8 34653.7 34727.7 35004.1 35149.1 33738.3 34084.3 34130.8 34287.5 34950.3 38930.4 39311.6 39316.0 39339.2 39492.4 33040.5 33334.7 33615.2 33641.7 34242.7 24710.4 24898.4 24933.3 25094.5 25159.5
05:52:16 INFO - PID 4000 |
05:52:16 INFO - PID 4000 | [#2] jquery.html Cycles:180 Average:34084.00 Median:22711.66 stddev:74830.68 (329.5%) stddev-sans-first:74998.28
05:52:16 INFO - PID 4000 | Values: 563.8 576.4 581.5 585.7 595.7 22383.3 23044.9 23096.8 23108.8 23161.9 23040.0 24639.5 24851.6 25032.0 25194.9 6496.1 6689.0 6689.5 6694.1 6708.4 6386.6 6595.5 6644.9 6651.5 6697.8 6604.1 6608.6 6618.7 6625.4 6626.6 6371.0 6633.6 6634.9 6638.8 6666.6 6147.1 6152.3 6158.2 6160.1 6171.5 28575.3 28904.0 28986.4 29008.0 29053.3 2063.8 2086.0 2091.0 2095.9 2097.3 18588.2 19038.2 19211.5 19261.6 19330.8 2332.7 2379.9 2409.3 2409.5 2413.9 118346.0 124840.0 137832.0 144767.3 145123.0 14456.2 14632.9 14660.4 14729.7 14949.1 22153.3 22169.3 22185.7 22190.9 22191.4 10246.3 10333.6 10362.1 10405.7 10475.3 9634.3 9667.2 9670.2 9729.9 9877.6 8712.6 8821.2 8900.5 8972.2 9157.5 2682.9 2695.8 2696.7 2721.8 2785.3 939.3 966.7 967.0 968.8 974.6 18734.5 18826.6 18966.8 19130.8 19379.1 1014.6 1016.2 1019.3 1026.7 1028.9 10198.8 10330.4 10458.1 10498.9 10658.3 432747.0 437005.0 438740.0 439682.0 444715.0 117092.0 117635.0 121816.0 121949.0 122104.4 1209.9 1216.2 1241.6 1250.9 1256.1 20255.5 20467.5 20531.1 21064.8 21408.6 57952.4 58871.0 59612.0 61460.0 62051.1 79232.2 79471.0 79757.6 82344.0 84226.0 19870.4 20879.2 20979.7 21097.1 21121.7 23063.8 23314.7 23603.3 23763.5 23803.6 18152.8 18514.8 18595.3 18748.1 18794.0 16708.7 16994.4 17031.3 17539.3 17706.3 18743.3 18899.8 18986.6 19128.9 19367.9 20188.0 20304.3 20312.6 20356.4 20377.0 17532.5 18362.7 18935.5 19021.1 19211.0
05:52:16 INFO - PID 4000 |
05:52:16 INFO - PID 4000 | [#3] mootools.html Cycles:180 Average:9447.37 Median:26795.30 stddev:6759.85 (25.2%) stddev-sans-first:6751.53
05:52:16 INFO - PID 4000 | Values: 1363.4 1433.7 1438.8 1446.3 1452.6 14696.6 15307.7 15312.1 15352.2 15374.2 14952.4 15158.1 15158.5 15167.3 15168.5 2711.5 2728.7 2758.1 2768.0 2783.2 2698.7 2721.2 2722.9 2726.3 2731.8 2696.0 2719.7 2791.8 2793.2 2797.4 2820.6 2821.5 2848.5 2853.9 2857.1 2668.9 2678.7 2691.9 2742.3 2750.2 14411.6 14628.2 14632.2 14648.6 14649.7 7673.5 7914.3 7920.3 7922.5 7924.8 5383.5 5445.3 5513.2 5560.7 5600.9 1836.7 1849.3 1856.1 1884.1 1890.5 26193.5 26700.2 26774.5 26789.6 26801.0 6882.8 6944.6 6967.3 7082.0 7183.0 19637.3 19870.3 19893.7 19896.0 19898.6 8039.6 8238.1 8238.4 8246.0 8255.6 6975.8 7099.3 7231.7 7338.6 7342.9 5318.9 5446.4 5482.1 5518.1 5554.9 1718.2 1726.2 1729.6 1737.9 1750.0 898.2 931.2 933.3 933.3 946.5 7788.5 7825.6 8374.9 8438.4 8536.7 686.5 703.1 708.6 716.0 723.3 4529.4 4571.5 5381.4 5387.4 5409.5 20913.8 21696.9 21741.6 21754.8 21759.6 21006.9 21125.4 21310.0 21574.0 22004.0 11158.7 11380.0 11391.4 11407.9 11421.0 7675.6 7764.7 7781.9 7812.7 7894.4 18072.4 18227.9 18246.1 18440.0 18631.9 18873.6 19026.4 19092.7 19331.6 19417.9 12044.5 12435.4 12483.8 12506.7 12566.4 13634.2 14240.3 14331.4 14332.7 14362.2 11330.0 11371.8 11419.4 11509.6 11653.4 11244.3 11299.4 11349.4 11413.4 11488.9 10040.7 10055.7 10119.2 10144.6 10159.0 7284.1 7301.0 7319.5 7340.8 7368.6 7232.0 7317.5 7374.3 7389.4 7391.6
05:52:16 INFO - PID 4000 |
05:52:16 INFO - PID 4000 | [#4] prototype.html Cycles:180 Average:5659.42 Median:6308.37 stddev:1535.39 (24.3%) stddev-sans-first:1489.87
05:52:16 INFO - PID 4000 | Values: 490.2 512.2 521.8 525.7 532.2 6346.8 6426.2 6437.8 6483.6 6531.9 6246.2 6253.4 6356.5 6373.9 6401.2 5224.7 5281.5 5294.1 5300.7 5347.4 4911.2 5062.4 5228.6 5300.5 5355.0 4987.6 5025.0 5042.3 5091.5 5129.2 4944.1 4994.9 5034.6 5036.7 5103.8 4415.3 4508.2 4533.3 4552.8 4579.3 6173.5 6240.4 6279.3 6311.2 6329.6 5713.1 5771.7 5784.9 5785.6 5790.4 6606.2 6649.6 6678.4 6686.6 6698.5 4934.4 4957.9 4985.4 4988.0 5003.6 6755.8 6863.4 6887.9 6979.7 7092.5 5494.8 5502.9 5516.9 5524.2 5560.5 5602.5 5613.9 5621.7 5630.6 5649.9 6095.3 6123.8 6133.6 6150.4 6164.7 6738.0 6780.8 6801.7 6852.5 6861.1 1928.3 1943.4 1976.2 1978.0 2002.9 1392.5 1425.8 1443.9 1462.4 1474.8 5784.2 5789.1 5849.6 5852.5 5907.6 6660.3 6769.9 6804.5 6850.8 6858.3 5759.5 5833.2 5849.8 5899.8 5927.8 3517.6 3528.5 3558.4 3571.6 3625.4 6561.1 6562.2 6595.2 6605.2 6620.3 6854.3 6907.3 6923.8 6925.3 6981.5 6528.3 6611.8 6669.2 6674.6 6677.4 6772.1 6813.5 6868.8 6869.4 6894.7 6784.5 6806.6 6834.9 6883.4 6887.4 6446.7 6515.3 6595.7 6669.6 6693.5 5391.6 5431.2 5464.9 5495.8 5499.6 6557.0 6630.5 6715.5 6741.5 6769.4 6484.7 6522.1 6558.8 6569.6 6680.1 6459.3 6478.3 6524.2 6592.5 6647.9 6305.5 6412.8 6426.6 6471.4 6594.5 6635.9 6652.3 6715.9 6764.7 6787.8 6417.5 6451.3 6472.0 6484.7 6537.6
05:52:16 INFO - PID 4000 |
05:52:16 INFO - PID 4000 | [#5] yui.html Cycles:180 Average:25662.84 Median:20915.88 stddev:35887.15 (171.6%) stddev-sans-first:35939.68
05:52:16 INFO - PID 4000 | Values: 906.4 913.6 925.6 931.5 950.5 19201.3 20186.8 20287.8 20301.0 20304.8 17917.2 18596.6 18759.4 18823.4 18985.7 960.2 979.5 981.2 982.3 986.8 978.7 999.1 1001.3 1017.5 1020.3 1043.4 1048.2 1053.3 1054.8 1054.9 993.6 1029.1 1042.9 1050.4 1057.5 747.7 753.5 753.5 756.5 756.8 19179.5 19270.6 19311.6 19342.7 19344.3 21427.5 22763.2 22776.0 22786.0 22844.1 17505.7 18341.0 18431.7 18457.1 18513.4 3579.5 3607.2 3608.1 3613.5 3648.6 138511.3 141763.3 142870.3 143882.3 145536.0 16334.8 16776.7 16878.2 16893.6 16900.1 28737.1 28741.3 28818.6 28854.9 29025.4 8317.7 8434.5 8517.1 8533.3 8534.7 4029.5 4142.3 4146.6 4147.0 4152.4 5333.9 5432.2 5441.3 5445.8 5462.8 933.1 957.4 974.1 979.7 981.0 694.2 709.5 715.0 716.3 724.0 11639.4 12611.0 12626.7 13111.9 13164.5 630.7 637.1 642.2 650.3 653.6 5734.6 5814.5 6320.3 6321.7 6473.0 118463.0 120852.0 121708.0 121867.4 127019.0 98576.5 101993.5 104863.0 107115.5 109354.0 92479.5 95267.5 96779.5 97918.5 98542.5 12619.2 13155.2 13251.5 13547.7 13680.0 42674.8 43991.8 44237.0 44825.3 45090.8 77162.6 79902.0 80041.0 81704.0 84106.6 18808.3 19156.9 19671.8 19704.5 19786.1 21945.8 22487.0 22491.3 22505.1 22773.7 19509.1 19688.0 19745.3 20203.1 20404.3 19013.8 19592.6 19827.9 19971.4 20313.8 18552.8 18676.2 19143.0 19221.8 19442.3 12438.7 12955.2 13188.3 13443.7 13528.3 13563.6 13991.0 14210.4 15032.8 15077.9
05:52:16 INFO - PID 4000 | -------- Summary: end --------
05:52:16 INFO - PID 4000 |
05:52:17 INFO - TEST-INFO | 4000: exit 0
05:52:17 INFO - TEST-OK | dromaeo_css | took 1113516ms
05:52:17 INFO - TEST-START | kraken
05:52:17 INFO - Initialising browser for kraken test...
05:52:17 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:55233/getInfo.html -profile /tmp/tmpD0qcrV/profile
05:52:17 INFO - TEST-INFO | started process 4422 (/builds/slave/test/build/application/firefox/firefox http://localhost:55233/getInfo.html)
05:52:22 INFO - TEST-INFO | 4422: exit 0
05:52:22 INFO - Browser initialized.
05:52:22 INFO - Running cycle 1/1 for kraken test...
05:52:22 INFO - Using env: {'DISPLAY': ':0',
05:52:22 INFO - 'HOME': '/home/cltbld',
05:52:22 INFO - 'JSGC_DISABLE_POISONING': '1',
05:52:22 INFO - 'LANG': 'en_US.UTF-8',
05:52:22 INFO - 'LANGUAGE': 'en_US:en',
05:52:22 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox',
05:52:22 INFO - 'LOGNAME': 'cltbld',
05:52:22 INFO - 'MAIL': '/var/mail/cltbld',
05:52:22 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir',
05:52:22 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk',
05:52:22 INFO - 'MOZ_CRASHREPORTER': '1',
05:52:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1',
05:52:22 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1',
05:52:22 INFO - 'MOZ_NO_REMOTE': '1',
05:52:22 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir',
05:52:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript',
05:52:22 INFO - 'NO_EM_RESTART': '1',
05:52:22 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games',
05:52:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json',
05:52:22 INFO - 'PWD': '/builds/slave/test',
05:52:22 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos',
05:52:22 INFO - 'RUST_BACKTRACE': 'full',
05:52:22 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts',
05:52:22 INFO - 'SHELL': '/bin/bash',
05:52:22 INFO - 'SHLVL': '1',
05:52:22 INFO - 'STYLO_FORCE_ENABLED': '1',
05:52:22 INFO - 'STYLO_THREADS': '1',
05:52:22 INFO - 'TERM': 'linux',
05:52:22 INFO - 'TMOUT': '86400',
05:52:22 INFO - 'USER': 'cltbld',
05:52:22 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1504787543.907280-299696051',
05:52:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn',
05:52:22 INFO - '_': '/tools/buildbot/bin/python'}
05:52:22 INFO - TEST-INFO | started process 4604 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpD0qcrV/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1)
05:52:23 INFO - PID 4604 |
05:52:23 INFO - PID 4604 | (/builds/slave/test/build/application/firefox/firefox:4655): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied
05:52:23 INFO - PID 4604 |
05:52:34 INFO - PID 4604 | RSS: Main: 172138496
05:52:34 INFO - PID 4604 |
05:52:36 INFO - PID 4604 | Cycle 1(1): loaded http://localhost:55233/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:55233/tests/kraken/driver.html?testName=audio-beat-detection)
05:52:37 INFO - PID 4604 | RSS: Main: 178204672
05:52:37 INFO - PID 4604 |
05:52:40 INFO - PID 4604 | Cycle 1(1): loaded http://localhost:55233/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:55233/tests/kraken/driver.html?testName=audio-dft)
05:52:41 INFO - PID 4604 | RSS: Main: 178491392
05:52:41 INFO - PID 4604 |
05:52:44 INFO - PID 4604 | Cycle 1(1): loaded http://localhost:55233/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:55233/tests/kraken/driver.html?testName=audio-fft)
05:52:44 INFO - PID 4604 | RSS: Main: 173060096
05:52:44 INFO - PID 4604 |
05:52:46 INFO - PID 4604 | Cycle 1(1): loaded http://localhost:55233/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:55233/tests/kraken/driver.html?testName=audio-oscillator)
05:52:47 INFO - PID 4604 | RSS: Main: 173903872
05:52:47 INFO - PID 4604 |
05:52:49 INFO - PID 4604 | Cycle 1(1): loaded http://localhost:55233/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:55233/tests/kraken/driver.html?testName=imaging-gaussian-blur)
05:52:50 INFO - PID 4604 | RSS: Main: 173821952
05:52:50 INFO - PID 4604 |
05:52:53 INFO - PID 4604 | Cycle 1(1): loaded http://localhost:55233/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:55233/tests/kraken/driver.html?testName=imaging-darkroom)
05:52:54 INFO - PID 4604 | RSS: Main: 176836608
05:52:54 INFO - PID 4604 |
05:52:57 INFO - PID 4604 | Cycle 1(1): loaded http://localhost:55233/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:55233/tests/kraken/driver.html?testName=imaging-desaturate)
05:52:58 INFO - PID 4604 | RSS: Main: 176558080
05:52:58 INFO - PID 4604 |
05:53:01 INFO - PID 4604 | Cycle 1(1): loaded http://localhost:55233/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:55233/tests/kraken/driver.html?testName=json-parse-financial)
05:53:01 INFO - PID 4604 | RSS: Main: 176914432
05:53:01 INFO - PID 4604 |
05:53:03 INFO - PID 4604 | Cycle 1(1): loaded http://localhost:55233/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:55233/tests/kraken/driver.html?testName=json-stringify-tinderbox)
05:53:03 INFO - PID 4604 | RSS: Main: 177065984
05:53:03 INFO - PID 4604 |
05:53:05 INFO - PID 4604 | Cycle 1(1): loaded http://localhost:55233/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:55233/tests/kraken/driver.html?testName=stanford-crypto-aes)
05:53:06 INFO - PID 4604 | RSS: Main: 177274880
05:53:06 INFO - PID 4604 |
05:53:08 INFO - PID 4604 | Cycle 1(1): loaded http://localhost:55233/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:55233/tests/kraken/driver.html?testName=stanford-crypto-ccm)
05:53:09 INFO - PID 4604 | RSS: Main: 174673920
05:53:09 INFO - PID 4604 |
05:53:11 INFO - PID 4604 | Cycle 1(1): loaded http://localhost:55233/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:55233/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2)
05:53:12 INFO - PID 4604 | RSS: Main: 174407680
05:53:12 INFO - PID 4604 |
05:53:15 INFO - PID 4604 | Cycle 1(1): loaded http://localhost:55233/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:55233/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative)
05:53:15 INFO - PID 4604 | RSS: Main: 174481408
05:53:15 INFO - PID 4604 |
05:53:17 INFO - PID 4604 | Cycle 1(1): loaded http://localhost:55233/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:55233/tests/kraken/driver.html?testName=ai-astar)
05:53:17 INFO - PID 4604 | RSS: Main: 176025600
05:53:17 INFO - PID 4604 |
05:53:17 INFO - PID 4604 | __start_tp_report
05:53:17 INFO - PID 4604 | _x_x_mozilla_page_load
05:53:17 INFO - PID 4604 | _x_x_mozilla_page_load_details
05:53:17 INFO - PID 4604 | |i|pagename|runs|
05:53:17 INFO - PID 4604 | |0;ai-astar;110;106;107;107;97;109;109;107;107;109
05:53:17 INFO - PID 4604 | |1;audio-beat-detection;116;120;117;119;122;118;121;119;148;123
05:53:17 INFO - PID 4604 | |2;audio-dft;162;162;163;163;161;162;169;166;163;168
05:53:17 INFO - PID 4604 | |3;audio-fft;74;74;75;76;75;73;74;72;74;75
05:53:17 INFO - PID 4604 | |4;audio-oscillator;80;79;79;79;79;87;80;79;82;80
05:53:17 INFO - PID 4604 | |5;imaging-gaussian-blur;110;113;110;113;114;113;116;117;114;116
05:53:17 INFO - PID 4604 | |6;imaging-darkroom;150;149;149;149;148;148;148;149;148;149
05:53:17 INFO - PID 4604 | |7;imaging-desaturate;94;95;94;94;94;94;94;94;95;94
05:53:17 INFO - PID 4604 | |8;json-parse-financial;53;54;49;51;51;50;52;51;54;54
05:53:17 INFO - PID 4604 | |9;json-stringify-tinderbox;38;38;38;38;38;38;37;38;39;39
05:53:17 INFO - PID 4604 | |10;stanford-crypto-aes;75;75;76;77;73;77;76;74;77;75
05:53:17 INFO - PID 4604 | |11;stanford-crypto-ccm;123;115;113;129;121;125;124;123;114;130
05:53:17 INFO - PID 4604 | |12;stanford-crypto-pbkdf2;175;171;176;169;175;177;175;174;171;171
05:53:17 INFO - PID 4604 | |13;stanford-crypto-sha256-iterative;63;62;64;66;69;63;65;63;64;68
05:53:17 INFO - PID 4604 | __end_tp_report
05:53:17 INFO - PID 4604 | __start_cc_report
05:53:17 INFO - PID 4604 | _x_x_mozilla_cycle_collect,944
05:53:17 INFO - PID 4604 | __end_cc_report
05:53:17 INFO - PID 4604 | __startTimestamp1504788797984__endTimestamp
05:53:17 INFO - PID 4604 |
05:53:17 INFO - PID 4604 | ------- Summary: start -------
05:53:17 INFO - PID 4604 | Number of tests: 14
05:53:17 INFO - PID 4604 |
05:53:17 INFO - PID 4604 | [#0] ai-astar Cycles:10 Average:106.80 Median:109.00 stddev:3.68 (3.4%) stddev-sans-first:3.71
05:53:17 INFO - PID 4604 | Values: 110.0 106.0 107.0 107.0 97.0 109.0 109.0 107.0 107.0 109.0
05:53:17 INFO - PID 4604 |
05:53:17 INFO - PID 4604 | [#1] audio-beat-detection Cycles:10 Average:122.30 Median:120.50 stddev:9.29 (7.7%) stddev-sans-first:9.57
05:53:17 INFO - PID 4604 | Values: 116.0 120.0 117.0 119.0 122.0 118.0 121.0 119.0 148.0 123.0
05:53:17 INFO - PID 4604 |
05:53:17 INFO - PID 4604 | [#2] audio-dft Cycles:10 Average:163.90 Median:163.00 stddev:2.77 (1.7%) stddev-sans-first:2.85
05:53:17 INFO - PID 4604 | Values: 162.0 162.0 163.0 163.0 161.0 162.0 169.0 166.0 163.0 168.0
05:53:17 INFO - PID 4604 |
05:53:17 INFO - PID 4604 | [#3] audio-fft Cycles:10 Average:74.20 Median:74.50 stddev:1.14 (1.5%) stddev-sans-first:1.20
05:53:17 INFO - PID 4604 | Values: 74.0 74.0 75.0 76.0 75.0 73.0 74.0 72.0 74.0 75.0
05:53:17 INFO - PID 4604 |
05:53:17 INFO - PID 4604 | [#4] audio-oscillator Cycles:10 Average:80.40 Median:80.00 stddev:2.50 (3.1%) stddev-sans-first:2.65
05:53:17 INFO - PID 4604 | Values: 80.0 79.0 79.0 79.0 79.0 87.0 80.0 79.0 82.0 80.0
05:53:17 INFO - PID 4604 |
05:53:17 INFO - PID 4604 | [#5] imaging-gaussian-blur Cycles:10 Average:113.60 Median:114.00 stddev:2.37 (2.1%) stddev-sans-first:2.12
05:53:17 INFO - PID 4604 | Values: 110.0 113.0 110.0 113.0 114.0 113.0 116.0 117.0 114.0 116.0
05:53:17 INFO - PID 4604 |
05:53:17 INFO - PID 4604 | [#6] imaging-darkroom Cycles:10 Average:148.70 Median:149.00 stddev:0.67 (0.5%) stddev-sans-first:0.53
05:53:17 INFO - PID 4604 | Values: 150.0 149.0 149.0 149.0 148.0 148.0 148.0 149.0 148.0 149.0
05:53:17 INFO - PID 4604 |
05:53:17 INFO - PID 4604 | [#7] imaging-desaturate Cycles:10 Average:94.20 Median:94.00 stddev:0.42 (0.4%) stddev-sans-first:0.44
05:53:17 INFO - PID 4604 | Values: 94.0 95.0 94.0 94.0 94.0 94.0 94.0 94.0 95.0 94.0
05:53:17 INFO - PID 4604 |
05:53:17 INFO - PID 4604 | [#8] json-parse-financial Cycles:10 Average:51.90 Median:52.50 stddev:1.79 (3.4%) stddev-sans-first:1.86
05:53:18 INFO - PID 4604 | Values: 53.0 54.0 49.0 51.0 51.0 50.0 52.0 51.0 54.0 54.0
05:53:18 INFO - PID 4604 |
05:53:18 INFO - PID 4604 | [#9] json-stringify-tinderbox Cycles:10 Average:38.10 Median:38.00 stddev:0.57 (1.5%) stddev-sans-first:0.60
05:53:18 INFO - PID 4604 | Values: 38.0 38.0 38.0 38.0 38.0 38.0 37.0 38.0 39.0 39.0
05:53:18 INFO - PID 4604 |
05:53:18 INFO - PID 4604 | [#10] stanford-crypto-aes Cycles:10 Average:75.50 Median:76.00 stddev:1.35 (1.8%) stddev-sans-first:1.42
05:53:18 INFO - PID 4604 | Values: 75.0 75.0 76.0 77.0 73.0 77.0 76.0 74.0 77.0 75.0
05:53:18 INFO - PID 4604 |
05:53:18 INFO - PID 4604 | [#11] stanford-crypto-ccm Cycles:10 Average:121.70 Median:123.50 stddev:5.98 (4.8%) stddev-sans-first:6.33
05:53:18 INFO - PID 4604 | Values: 123.0 115.0 113.0 129.0 121.0 125.0 124.0 123.0 114.0 130.0
05:53:18 INFO - PID 4604 |
05:53:18 INFO - PID 4604 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:173.40 Median:175.00 stddev:2.67 (1.5%) stddev-sans-first:2.77
05:53:18 INFO - PID 4604 | Values: 175.0 171.0 176.0 169.0 175.0 177.0 175.0 174.0 171.0 171.0
05:53:18 INFO - PID 4604 |
05:53:18 INFO - PID 4604 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:64.70 Median:64.50 stddev:2.31 (3.6%) stddev-sans-first:2.37
05:53:18 INFO - PID 4604 | Values: 63.0 62.0 64.0 66.0 69.0 63.0 65.0 63.0 64.0 68.0
05:53:18 INFO - PID 4604 | -------- Summary: end --------
05:53:18 INFO - PID 4604 |
05:53:18 INFO - PID 4604 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping
05:53:18 INFO - TEST-INFO | 4604: exit 0
05:53:18 INFO - TEST-OK | kraken | took 61613ms
05:53:18 INFO - SUITE-END | took 1175s
05:53:19 INFO - Completed test suite (00:19:35)
05:53:19 INFO - javascript benchmark
05:53:19 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8757.445386786265, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3279.3441311737656, 3303.405387030335, 3312.370649576582, 3327.7670563060597, 3335.8498867550957, 6313.053042043695, 6415.45468635166, 6428.614283143009, 6455.096286519891, 6479.676016199189, 6375.968120159404, 6432.935670643304, 6441.066045423411, 6459.063435801818, 6584.012398140281, 5948.494377977877, 5965.284165900076, 5982.8803423931495, 6022.397760223987, 6025.307089684698, 1210.9425995201248, 5519.806806761764, 5810.941890581083, 5955.761769529214, 6062.42406971337, 5904.084866845646, 5930.318013428468, 5943.554233432488, 5986.191864098357, 6012.098185272201, 5912.704364781786, 5937.168796368512, 5989.221401217814, 5999.820005399845, 6016.037434010581, 5878.030125029408, 5894.17481552583, 5962.403759624046, 5982.222311099529, 5990.101484777275, 6428.357164283581, 6428.5178611604315, 6473.676316184172, 6532.934670653281, 6558.508111891627, 6601.240857301424, 6695.765648202289, 6823.624700641462, 6899.344562266577, 6993.510454268203, 6982.371586557234, 7023.648817559101, 7043.436525077981, 7044.436445084381, 7057.435405167575, 6436.999999999954, 6470.708818103197, 6541.901871471931, 6550.901736473957, 6554.541182117254, 7149.177844547944, 7152.499325047197, 7239.058922340062, 7241.167265764399, 7255.4921155518605, 6525.543211975211, 6650.3349665034075, 6736.292689267654, 6795.218549866829, 6818.863622727517, 6805.149356330458, 6929.064576282138, 6936.653167341613, 6943.861122777516, 6947.270536593584, 6864.519483636098, 6941.132358455193, 6945.89581156283, 6948.791536253921, 6953.026576279325, 6627.0, 6702.19573651165, 6861.4853885958755, 6878.793636190822, 6957.339052789976, 5360.544353729899, 5384.219288203267, 5395.514403703685, 5396.892062158735, 5401.243825864303, 4708.458527269339, 4728.432588089451, 4762.095201911695, 4857.198562237262, 4866.902661946741, 5925.051991681396, 5931.525477961753, 5983.371745966698, 6002.39976002405, 6007.15899774032, 6841.692123854438, 6860.6912688929115, 6934.341237582422, 6947.166340039228, 6961.23426423093, 5784.421557844182, 5893.5579831512805, 5921.970390148022, 5978.461938425563, 5985.521158307412, 5885.264341957255, 5944.989351810203, 5963.105534169822, 5969.462748352669, 5981.641101533922, 6648.700808463534, 6662.733490660319, 6706.731730730814, 6761.323867613298, 6798.0, 6901.206361268418, 6937.826554336182, 6951.026856240131, 7009.404200642798, 7027.086478757728, 6336.809895703136, 6438.67806609677, 6599.835004124935, 6648.700808463727, 6760.560563563353, 6803.183617965876, 6810.046593476818, 6858.794236172923, 6859.965700171667, 6861.897071544031, 6970.268121847133, 7018.33325834045, 7047.7180912762915, 7051.894221586577, 7053.118360204974, 6705.932940670531, 6719.0, 6730.629815360202, 6810.148731408574, 6832.726690932307, 6468.870622587616, 6612.206535215805, 6613.074169616161, 6635.834104147435, 6671.366220209073, 6648.434883034803, 6653.268140504638, 6719.697613607497, 6723.7646682365885, 6736.124303840469, 6740.022696708852, 6741.089952856498, 6824.965875170592, 6851.246362900177, 6871.03805467225, 6342.556021078481, 6445.16212892321, 6489.967550162219, 6502.967485162544, 6588.242352129567], "value": 6263.282871749331, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [833.0960907415454, 858.9012263589689, 862.504060165405, 865.2472349056322, 867.5618812499687, 42404.0, 43254.56745432545, 43409.13181736363, 43456.78271608642, 43684.34473482901, 38617.806910965475, 38678.61321386785, 42370.0, 43175.56824431755, 43316.0, 7807.6876924922935, 7933.444658873881, 7938.563379014152, 7967.960160199191, 7969.800754981143, 7830.6084695764985, 7929.1277959424415, 7931.881021784649, 7938.364930805522, 7956.6817327306835, 7987.5606841623685, 7992.160823113577, 7999.600019999006, 8000.199980002011, 8015.519068855858, 7855.607219639024, 7935.127136015062, 7946.841063178733, 7965.641546130438, 7976.322012628933, 7828.686852525892, 7853.371730261622, 7862.803429914241, 7874.606269686493, 7883.7240696575345, 38434.615653843386, 39040.609593904264, 39196.0, 39263.41104883429, 39339.606603933884, 3615.7288203384587, 3651.94522082169, 3652.086978255436, 3653.251083527897, 3654.634536546351, 31489.21276968071, 31602.841985789924, 31678.208044799063, 31723.52414713781, 31846.0, 5078.822241221539, 5235.0, 5258.0535503609335, 5268.367795864482, 5293.841184764463, 180721.0, 183735.99999999866, 186763.0, 186983.0, 187449.0, 49264.0, 49434.25848612274, 49565.75217123891, 49706.50293497019, 50019.24971125436, 51600.48399516032, 51682.0, 51725.741371292905, 51779.0, 51791.115666325175, 16124.516264511849, 16238.675226495405, 16239.431619893247, 16266.674666506604, 16281.0, 13632.65918352049, 13636.113652612548, 13648.795268070988, 13653.317334133253, 13661.385237664328, 13247.668808279677, 13265.336733163304, 13292.202467851766, 13316.800247996287, 13365.866341336656, 5206.64627196924, 5309.761060752276, 5312.309399778082, 5338.839834804962, 5452.0, 1022.3865680591734, 1022.9079382855579, 1027.7430642339416, 1035.052926572178, 1039.2465462539749, 22219.444513887283, 22373.0, 23203.187888423825, 28742.568861467094, 29715.85142074319, 1099.3568762273999, 1108.5344155454568, 1112.8720197177267, 1126.4086354663866, 1136.8408422820812, 12429.37853107341, 12820.679483013, 12866.549670761478, 12945.54690585825, 13045.673858153623, 248061.0, 248106.0, 248481.0, 250933.0, 251231.0, 54866.725666371414, 54874.17688734672, 54875.451245487835, 54893.45106548963, 55072.17391739127, 1460.350144185827, 1478.9038712483655, 1497.5133081748475, 1497.7453832848441, 1507.3895072495657, 22981.310560683207, 23064.538709226057, 23121.88439057794, 23155.3053408398, 23363.415914602272, 40182.39726404165, 40315.596844031184, 40421.0, 40463.595364045985, 40473.19053618852, 205447.0, 205710.0, 206019.0, 206457.0, 207890.0, 34228.0, 34603.65396346105, 38195.42706859455, 38735.22529549337, 38797.6120238794, 45915.77042114768, 47588.57234282977, 48309.0, 48405.51594484151, 48501.5149848497, 34444.82777586096, 34653.653463465045, 34727.65272347244, 35004.12489687778, 35149.121271968404, 33738.325233495685, 34084.25366048713, 34130.82934585311, 34287.48568771421, 34950.30099398048, 38930.4160437588, 39311.60688393079, 39316.0, 39339.2132157361, 39492.40761388524, 33040.50439243365, 33334.66665333316, 33615.15962100967, 33641.66358336385, 34242.65757342494, 24710.382240444134, 24898.377540561632, 24933.252002439956, 25094.49811003806, 25159.49681006406], "value": 17703.601389562675, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [563.7547666764955, 576.4063015094453, 581.4911952041963, 585.6690969602172, 595.6604735300879, 22383.328500145002, 23044.88477557612, 23096.769032309672, 23108.768912310912, 23161.884190579065, 23040.0, 24639.507209855794, 24851.627225591586, 25032.0, 25194.874025629848, 6496.12302339184, 6688.966555167217, 6689.531732778707, 6694.0962969999155, 6708.396244338033, 6386.552941294111, 6595.53831231814, 6644.900326495106, 6651.534392592521, 6697.799066028003, 6604.108445359863, 6608.636524991123, 6618.669066546678, 6625.403713665769, 6626.635535045571, 6370.968145159244, 6633.601983880959, 6634.933650663504, 6638.800835974928, 6666.6333351665635, 6147.139400483936, 6152.323244443108, 6158.168647232611, 6160.1375807387, 6171.475424588871, 28575.28561785972, 28904.0, 28986.42027159445, 29008.0, 29053.273668158254, 2063.8039386258283, 2085.95828083439, 2091.0381224636535, 2095.8847263400507, 2097.328854766475, 18588.163532640927, 19038.238470461165, 19211.51971200717, 19261.61476770471, 19330.80669193304, 2332.696749422581, 2379.9286021419384, 2409.325388891113, 2409.542186984467, 2413.879306034691, 118346.0, 124840.0, 137832.0, 144767.27616361956, 145123.0, 14456.230811619434, 14632.90253231012, 14660.413583456755, 14729.705405892037, 14949.08492843885, 22153.335399938027, 22169.334919952427, 22185.667214991787, 22190.889045554668, 22191.44521386978, 10246.282760206714, 10333.638322658671, 10362.119219866245, 10405.739856503647, 10475.266731328733, 9634.325597208268, 9667.178289845302, 9670.178034866974, 9729.9027009729, 9877.555510002067, 8712.607932643046, 8821.2060914518, 8900.510471924106, 8972.237359824358, 9157.49633770149, 2682.9463410732064, 2695.7734230925275, 2696.7438093381097, 2721.8230814996964, 2785.3175971886612, 939.3424602778083, 966.6858271061933, 966.9564869580886, 968.7578105473632, 974.6004138303404, 18734.501239900776, 18826.62346753057, 18966.810331896504, 19130.808691912902, 19379.127939242768, 1014.5586669798661, 1016.1667432705259, 1019.2661283875746, 1026.707388394319, 1028.8713910761155, 10198.796024079476, 10330.380177189392, 10458.111060559786, 10498.947505262426, 10658.307210031324, 432747.0, 437005.0, 438740.0, 439682.0, 444715.0, 117092.0, 117635.0, 121816.0, 121949.0, 122104.38947805203, 1209.854817421915, 1216.191232830158, 1241.5716577780652, 1250.9124361294805, 1256.1018871506917, 20255.4936126598, 20467.4883127923, 20531.076101575167, 21064.789352106283, 21408.57182856303, 57952.42047579639, 58871.0, 59612.0, 61460.0, 62051.069233960625, 79232.20767792479, 79471.0, 79757.60121199356, 82344.0, 84226.0, 19870.403887883385, 20879.164833406492, 20979.685304720748, 21097.05063272187, 21121.6831747527, 23063.769362306834, 23314.65028024547, 23603.29190124299, 23763.524729504967, 23803.64294535549, 18152.818471815113, 18514.814851851308, 18595.34916277924, 18748.06259686983, 18794.0, 16708.749368759236, 16994.405195818086, 17031.318747250465, 17539.298428062735, 17706.291748330437, 18743.34398296053, 18899.811001889804, 18986.620267594295, 19128.90435547869, 19367.903160484108, 20188.0, 20304.289349872684, 20312.59374812466, 20356.389308320773, 20377.0, 17532.474025779247, 18362.724559131355, 18935.526611834815, 19021.144048517574, 19211.0], "value": 12280.685973939615, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1363.40010395426, 1433.7132573485305, 1438.8057612222353, 1446.3491428857014, 1452.5642307307805, 14696.632584185401, 15307.693846123071, 15312.0812751235, 15352.155631440266, 15374.154421506813, 14952.401903923857, 15158.090514569134, 15158.469453569127, 15167.317470713817, 15168.469103581348, 2711.4577084583066, 2728.686201086871, 2758.0622588319966, 2767.986160069197, 2783.1928740665185, 2698.7031426543062, 2721.2380533450664, 2722.891084356633, 2726.2775364528416, 2731.808773385864, 2695.986520067397, 2719.687235967859, 2791.804573679843, 2793.1620513845864, 2797.4125433658955, 2820.6333176687103, 2821.520341541943, 2848.5442329227326, 2853.857307134656, 2857.1000134957526, 2668.9199324020115, 2678.665166854143, 2691.87886545104, 2742.2595899107127, 2750.2024412920227, 14411.639709007253, 14628.195449250286, 14632.195229262386, 14648.560543183721, 14649.707005859824, 7673.50122242058, 7914.3272821810215, 7920.326772224368, 7922.524648521107, 7924.841503169904, 5383.515483606455, 5445.264889239981, 5513.228148059275, 5560.7219639017885, 5600.859978500529, 1836.669399508088, 1849.3342396737298, 1856.053412759489, 1884.076802366844, 1890.4801179675562, 26193.476130477473, 26700.198994030212, 26774.464510709677, 26789.598156027674, 26801.0, 6882.793516194522, 6944.618046007417, 6967.268436814163, 7081.964590177016, 7183.030290910765, 19637.31269405564, 19870.30453934134, 19893.701594476093, 19896.0, 19898.60202795936, 8039.598020098972, 8238.134995825472, 8238.423310368216, 8245.95877020611, 8255.628496717662, 6975.825604359931, 7099.290070992859, 7231.746888858865, 7338.596377199198, 7342.889856652155, 5318.946810531923, 5446.428125046892, 5482.095454250084, 5518.117101263779, 5554.91667624986, 1718.2096235731453, 1726.240454200148, 1729.619483713581, 1737.9405404595595, 1749.9562510937074, 898.1647068226612, 931.2177770672668, 933.262722449271, 933.290699068699, 946.4888959961544, 7788.532688038623, 7825.569593672402, 8374.916250837536, 8438.367122465717, 8536.70121545743, 686.543448606681, 703.1175874277851, 708.5606923707335, 715.9654299537119, 723.2550473012806, 4529.411176547028, 4571.519990401027, 5381.408045115034, 5387.4073851876265, 5409.459054094559, 20913.79086209149, 21696.89151554232, 21741.565168696536, 21754.782452175594, 21759.564808703737, 21006.894965525076, 21125.366239012856, 21310.0, 21574.0, 22004.0, 11158.665240042812, 11380.0, 11391.373474458984, 11407.885921140849, 11421.0, 7675.616219188906, 7764.6894124234395, 7781.883271751041, 7812.726554570563, 7894.447388682737, 18072.367467139113, 18227.908860455613, 18246.0876956149, 18440.0, 18631.906840465712, 18873.622527549647, 19026.42920712381, 19092.713609295595, 19331.613367732847, 19417.902910485358, 12044.518219271482, 12435.440405181607, 12483.812742809047, 12506.68733281639, 12566.371681416076, 13634.181949083088, 14240.287985600471, 14331.426742930584, 14332.713345733235, 14362.210078445369, 11330.0, 11371.772564548828, 11419.371934543347, 11509.597164099552, 11653.417329133339, 11244.26912250701, 11299.43502824872, 11349.432528373713, 11413.372264525198, 11488.885111148782, 10040.69877903664, 10055.69832905014, 10119.241056920613, 10144.644937427154, 10159.0, 7284.125904891447, 7300.96349518249, 7319.487635865438, 7340.816479588053, 7368.59472729005, 7232.0, 7317.487775855852, 7374.299441553044, 7389.371903388273, 7391.556506609621], "value": 6722.353280662327, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [490.2402366807796, 512.2367672168469, 521.759990404414, 525.7161132988186, 532.1724718063412, 6346.778627480379, 6426.164598602187, 6437.839054023651, 6483.643399613019, 6531.877139929524, 6246.187995560582, 6253.374662533744, 6356.52326075545, 6373.904391434132, 6401.199850018747, 5224.660397074197, 5281.524662780349, 5294.10000299948, 5300.655457395276, 5347.385050719178, 4911.238757992517, 5062.417821950486, 5228.640553456091, 5300.496452836975, 5354.982553314877, 4987.551120399164, 5025.0, 5042.319286896277, 5091.454272863568, 5129.153689641204, 4944.134776414113, 4994.900101997958, 5034.622403319729, 5036.722980236085, 5103.800606857386, 4415.315626077963, 4508.233600287959, 4533.252013417782, 4552.793509719927, 4579.267317229261, 6173.475254603364, 6240.4071613196675, 6279.277883043417, 6311.211098612674, 6329.556931014785, 5713.14302854571, 5771.682557459338, 5784.913226301609, 5785.566082543826, 5790.392008839095, 6606.174228221473, 6649.567778094457, 6678.43233325168, 6686.632235227061, 6698.464122870208, 4934.407871055496, 4957.900841983176, 4985.376827896513, 4987.975060124712, 5003.649744517885, 6755.763548275836, 6863.416609588191, 6887.862242755117, 6979.720811167547, 7092.503524753218, 5494.76367817246, 5502.862428439241, 5516.889662206813, 5524.171374293888, 5560.471755183251, 5602.467765562265, 5613.887722245532, 5621.747021384048, 5630.634008789416, 5649.943300745809, 6095.268567771807, 6123.785667501616, 6133.558613725771, 6150.415710507495, 6164.722587483574, 6738.0, 6780.762673306509, 6801.65991700413, 6852.486063545154, 6861.142357205349, 1928.3250862198117, 1943.4461178564325, 1976.209516193534, 1977.9703304450156, 2002.8698134621202, 1392.540461647654, 1425.8094491099841, 1443.9422423102958, 1462.354850792858, 1474.7566651502596, 5784.21913041734, 5789.102689083199, 5849.607227807861, 5852.473277405054, 5907.616004959664, 6660.267370589231, 6769.932300677028, 6804.489663275175, 6850.794476165624, 6858.348456896687, 5759.452851979056, 5833.154192642128, 5849.824505264849, 5899.793507227227, 5927.8221653350465, 3517.56030496188, 3528.4530897710897, 3558.3594952908725, 3571.607123216444, 3625.4380571011534, 6561.1470508833545, 6562.212534495891, 6595.241547222035, 6605.24039735427, 6620.337966203341, 6854.314568543105, 6907.309269073053, 6923.757668481579, 6925.342092501204, 6981.5461994970165, 6528.281888992207, 6611.801645950629, 6669.166354205724, 6674.566153200123, 6677.432418244406, 6772.11962444879, 6813.4549236061985, 6868.828279293058, 6869.381755642016, 6894.689738961659, 6784.457243420416, 6806.591604503746, 6834.8633027340165, 6883.382405134889, 6887.414569761426, 6446.67766611677, 6515.315891831479, 6595.670216489252, 6669.633170175687, 6693.497987650849, 5391.622586418913, 5431.212474191141, 5464.863378415572, 5495.8016793283, 5499.587530935116, 6556.967215163893, 6630.46956243509, 6715.5299129060495, 6741.494387921024, 6769.424598908951, 6484.740610375721, 6522.05430212607, 6558.8360290993105, 6569.572977756622, 6680.06278179342, 6459.289478157493, 6478.2550006749825, 6524.217093948757, 6592.472602191718, 6647.867042659023, 6305.527085468517, 6412.775552855627, 6426.646534440463, 6471.352864713679, 6594.505412094208, 6635.900461493178, 6652.268250492345, 6715.899261510984, 6764.661766911733, 6787.762428314985, 6417.518686098468, 6451.258105317948, 6471.967640161957, 6484.708188131451, 6537.607743535403], "value": 5218.4179521421, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [906.4108329585772, 913.6025828764488, 925.5742358515087, 931.4550987672216, 950.5247376311846, 19201.327953521628, 20186.798132018695, 20287.797122028776, 20301.0, 20304.796952030476, 17917.193726282316, 18596.628067438643, 18759.43721688348, 18823.435296941112, 18985.715214271764, 960.1598601223947, 979.5102448775613, 981.2444417798326, 982.327105932435, 986.842105263158, 978.6868202175307, 999.1157825324567, 1001.2640709078821, 1017.4912543728136, 1020.2807021050179, 1043.4469731042523, 1048.2033654422655, 1053.2995557953989, 1054.8470471781586, 1054.8734151901783, 993.5926270229207, 1029.073833549811, 1042.8748550173952, 1050.3592808386877, 1057.471264367816, 747.7083937264471, 753.4913933095194, 753.506453273107, 756.4591317208223, 756.7956651704064, 19179.52051198717, 19270.61458770817, 19311.613767724568, 19342.709859352122, 19344.32294869687, 21427.46431339229, 22763.203287884844, 22776.0, 22786.0, 22844.086236550516, 17505.7374139388, 18341.0, 18431.72352414715, 18457.077146142638, 18513.352032678926, 3579.534660494145, 3607.2244467439627, 3608.1340478285283, 3613.512175856278, 3648.6351364863567, 138511.30744346214, 141763.29118354342, 142870.28564857214, 143882.28058859744, 145536.0, 16334.75497867533, 16776.748348774778, 16878.156092195342, 16893.577660558338, 16900.070496122586, 28737.137885863456, 28741.28146796347, 28818.567721484196, 28854.855725721238, 29025.41949161005, 8317.667293308199, 8434.451760635538, 8517.06312305646, 8533.317334613215, 8534.658613655385, 4029.5366032906004, 4142.2751018572235, 4146.564610715892, 4147.004718867511, 4152.356384760367, 5333.919991200135, 5432.212329212242, 5441.29263195782, 5445.782168713286, 5462.808801691922, 933.0576118120612, 957.4011400960413, 974.0600320690568, 979.715882394112, 980.9852852207223, 694.1635329428027, 709.4501761135058, 714.9821254468679, 716.2880715090937, 724.0225695311393, 11639.359835209145, 12611.0, 12626.684332891751, 13111.868881311255, 13164.539241126706, 630.6594439002979, 637.1366797988751, 642.1908395421802, 650.2619526837074, 653.5882394091692, 5734.627249228787, 5814.534837213013, 6320.273168585672, 6321.65230912295, 6472.967635161888, 118463.0, 120852.0, 121708.0, 121867.39066304611, 127019.0, 98576.50711746396, 101993.49003254937, 104863.0, 107115.46442267738, 109354.0, 92479.53760231155, 95267.52366238124, 96779.51610241903, 97918.51040744894, 98542.52186217213, 12619.242845429304, 13155.210687358407, 13251.536196233086, 13547.661308466973, 13680.0, 42674.78662606667, 43991.78004109959, 44237.0, 44825.327620085074, 45090.77454612706, 77162.61418692871, 79902.0, 80041.0, 81704.0, 84106.57946710472, 18808.341708040152, 19156.904215478833, 19671.803281966997, 19704.507387315432, 19786.10962506662, 21945.780542194374, 22487.0, 22491.325260242218, 22505.09979600863, 22773.658395124417, 19509.12208950629, 19688.0, 19745.308914187935, 20203.090860911587, 20404.28584999518, 19013.809861901205, 19592.60814783668, 19827.900860495603, 19971.400857974284, 20313.79686203119, 18552.81447185511, 18676.159572819528, 19143.0, 19221.807781922562, 19442.319518816774, 12438.689032773891, 12955.222686638832, 13188.27464489424, 13443.663908402368, 13528.323583820966, 13563.59309220725, 13991.0, 14210.431582736988, 15032.849671503582, 15077.924610376878], "value": 9442.623145444462, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1429.4000000000003, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 106.0, 107.0, 107.0, 97.0, 109.0, 109.0, 107.0, 107.0, 109.0], "value": 106.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 120.0, 117.0, 119.0, 122.0, 118.0, 121.0, 119.0, 148.0, 123.0], "value": 122.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 162.0, 163.0, 163.0, 161.0, 162.0, 169.0, 166.0, 163.0, 168.0], "value": 163.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 74.0, 75.0, 76.0, 75.0, 73.0, 74.0, 72.0, 74.0, 75.0], "value": 74.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 79.0, 79.0, 79.0, 79.0, 87.0, 80.0, 79.0, 82.0, 80.0], "value": 80.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 113.0, 110.0, 113.0, 114.0, 113.0, 116.0, 117.0, 114.0, 116.0], "value": 113.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 149.0, 149.0, 149.0, 148.0, 148.0, 148.0, 149.0, 148.0, 149.0], "value": 148.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 95.0, 94.0, 94.0, 94.0, 94.0, 94.0, 94.0, 95.0, 94.0], "value": 94.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 54.0, 49.0, 51.0, 51.0, 50.0, 52.0, 51.0, 54.0, 54.0], "value": 51.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [38.0, 38.0, 38.0, 38.0, 38.0, 38.0, 37.0, 38.0, 39.0, 39.0], "value": 38.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 76.0, 77.0, 73.0, 77.0, 76.0, 74.0, 77.0, 75.0], "value": 75.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [123.0, 115.0, 113.0, 129.0, 121.0, 125.0, 124.0, 123.0, 114.0, 130.0], "value": 121.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [175.0, 171.0, 176.0, 169.0, 175.0, 177.0, 175.0, 174.0, 171.0, 171.0], "value": 173.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 62.0, 64.0, 66.0, 69.0, 63.0, 65.0, 63.0, 64.0, 68.0], "value": 64.7, "unit": "score"}]}]}
05:53:19 INFO - Return code: 0
05:53:19 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json
05:53:19 INFO - # TBPL SUCCESS #
05:53:19 INFO - Running post-action listener: _package_coverage_data
05:53:19 INFO - Running post-action listener: _resource_record_post_action
05:53:19 INFO - [mozharness: 2017-09-07 12:53:19.269776Z] Finished run-tests step (success)
05:53:19 INFO - Running post-run listener: _resource_record_post_run
05:53:19 INFO - Total resource usage - Wall time: 1192s; CPU: 13.0%; Read bytes: 11341824; Write bytes: 405667840; Read time: 3852; Write time: 543032
05:53:19 INFO - TinderboxPrint: CPU usage
13.2%
05:53:19 INFO - TinderboxPrint: I/O read bytes / time
11,341,824 / 3,852
05:53:19 INFO - TinderboxPrint: I/O write bytes / time
405,667,840 / 543,032
05:53:19 INFO - TinderboxPrint: CPU idle
8,250.8 (86.8%)
05:53:19 INFO - TinderboxPrint: CPU user
1,192.4 (12.5%)
05:53:19 INFO - TinderboxPrint: Swap in / out
0 / 0
05:53:19 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 4096; Write bytes: 116752384; Read time: 208; Write time: 138968
05:53:19 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0
05:53:19 INFO - run-tests - Wall time: 1176s; CPU: 13.0%; Read bytes: 9592832; Write bytes: 288915456; Read time: 3568; Write time: 404064
05:53:19 INFO - Running post-run listener: _upload_blobber_files
05:53:19 INFO - Blob upload gear active.
05:53:19 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir.
05:53:19 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
05:53:19 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', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json']
05:53:19 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 -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json
05:53:20 INFO - (blobuploader) - INFO - Open directory for files ...
05:53:20 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ...
05:53:20 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com
05:53:20 INFO - (blobuploader) - INFO - Uploading, attempt #1.
05:53:21 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded
05:53:21 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded!
05:53:21 INFO - (blobuploader) - INFO - Done attempting.
05:53:21 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ...
05:53:21 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com
05:53:21 INFO - (blobuploader) - INFO - Uploading, attempt #1.
05:53:22 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded
05:53:22 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded!
05:53:22 INFO - (blobuploader) - INFO - Done attempting.
05:53:22 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ...
05:53:22 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com
05:53:22 INFO - (blobuploader) - INFO - Uploading, attempt #1.
05:53:23 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded
05:53:23 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded!
05:53:23 INFO - (blobuploader) - INFO - Done attempting.
05:53:23 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ...
05:53:23 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com
05:53:23 INFO - (blobuploader) - INFO - Uploading, attempt #1.
05:53:30 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded
05:53:30 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded!
05:53:30 INFO - (blobuploader) - INFO - Done attempting.
05:53:30 INFO - (blobuploader) - INFO - Iteration through files over.
05:53:30 INFO - Return code: 0
05:53:30 INFO - rmtree: /builds/slave/test/build/uploaded_files.json
05:53:30 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1
05:53:30 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a50fc91e7b9e3487c5533feedc08c8dd5c4323a83f06bc0c71eae77f789dabcdff375ab1ee337a112b3dd5bd368408f67cea51b5fefb1f9533ea592aa775dd0f", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/bfb275b2800e04980824fb72f3000974c4a75dfc1d4151f46194a6f8d47dec3db626e020f85a939f53cfa8b547461418b3f5960b06bbc3a6980492784f375a66", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0f971b0448d15af31c856f6703ed4713b7e2c10e4f3075eff60b61ce46820ca4be7d35651b1f16c26d9b0d98c54dd828a7b451ce284a6b831fd6eb7733ef7c9b", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/03140b504df954440571f76fbb715dcb80fafeeb511b17053986cf532f43117b3d5ec4831267d56c882b1af63e133163c85518343df05ae3c756991db63643c8"}
05:53:30 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files
05:53:30 INFO - Writing to file /builds/slave/test/properties/blobber_files
05:53:30 INFO - Contents:
05:53:30 INFO - blobber_files:{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a50fc91e7b9e3487c5533feedc08c8dd5c4323a83f06bc0c71eae77f789dabcdff375ab1ee337a112b3dd5bd368408f67cea51b5fefb1f9533ea592aa775dd0f", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/bfb275b2800e04980824fb72f3000974c4a75dfc1d4151f46194a6f8d47dec3db626e020f85a939f53cfa8b547461418b3f5960b06bbc3a6980492784f375a66", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0f971b0448d15af31c856f6703ed4713b7e2c10e4f3075eff60b61ce46820ca4be7d35651b1f16c26d9b0d98c54dd828a7b451ce284a6b831fd6eb7733ef7c9b", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/03140b504df954440571f76fbb715dcb80fafeeb511b17053986cf532f43117b3d5ec4831267d56c882b1af63e133163c85518343df05ae3c756991db63643c8"}
05:53:30 INFO - Running post-run listener: copy_logs_to_upload_dir
05:53:30 INFO - Copying logs to upload dir...
05:53:30 INFO - mkdir: /builds/slave/test/build/upload/logs
05:53:30 INFO - Copying logs to upload dir...
program finished with exit code 0
elapsedTime=1259.510627
========= master_lag: -0.15 =========
========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 59 secs) (at 2017-09-07 05:53:29.898678) =========
========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-07 05:53:29.906071) =========
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=14ef55db36f7623abb31b9cf000001d5-1504787543.907280-299696051
XPCOM_DEBUG_BREAK=warn
_=/tools/buildbot/bin/python
using PTY: False
blobber_files:{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a50fc91e7b9e3487c5533feedc08c8dd5c4323a83f06bc0c71eae77f789dabcdff375ab1ee337a112b3dd5bd368408f67cea51b5fefb1f9533ea592aa775dd0f", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/bfb275b2800e04980824fb72f3000974c4a75dfc1d4151f46194a6f8d47dec3db626e020f85a939f53cfa8b547461418b3f5960b06bbc3a6980492784f375a66", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0f971b0448d15af31c856f6703ed4713b7e2c10e4f3075eff60b61ce46820ca4be7d35651b1f16c26d9b0d98c54dd828a7b451ce284a6b831fd6eb7733ef7c9b", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/03140b504df954440571f76fbb715dcb80fafeeb511b17053986cf532f43117b3d5ec4831267d56c882b1af63e133163c85518343df05ae3c756991db63643c8"}
build_url:https://queue.taskcluster.net/v1/task/O4Y3kdYKTk6AYNU8oh2jiA/artifacts/public/build/target.tar.bz2
program finished with exit code 0
elapsedTime=0.011306
build_url: 'https://queue.taskcluster.net/v1/task/O4Y3kdYKTk6AYNU8oh2jiA/artifacts/public/build/target.tar.bz2'
blobber_files: '{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a50fc91e7b9e3487c5533feedc08c8dd5c4323a83f06bc0c71eae77f789dabcdff375ab1ee337a112b3dd5bd368408f67cea51b5fefb1f9533ea592aa775dd0f", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/bfb275b2800e04980824fb72f3000974c4a75dfc1d4151f46194a6f8d47dec3db626e020f85a939f53cfa8b547461418b3f5960b06bbc3a6980492784f375a66", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0f971b0448d15af31c856f6703ed4713b7e2c10e4f3075eff60b61ce46820ca4be7d35651b1f16c26d9b0d98c54dd828a7b451ce284a6b831fd6eb7733ef7c9b", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/03140b504df954440571f76fbb715dcb80fafeeb511b17053986cf532f43117b3d5ec4831267d56c882b1af63e133163c85518343df05ae3c756991db63643c8"}'
========= master_lag: 0.02 =========
========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-07 05:53:29.933993) =========
========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-07 05:53:29.934318) =========
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=14ef55db36f7623abb31b9cf000001d5-1504787543.907280-299696051
XPCOM_DEBUG_BREAK=warn
_=/tools/buildbot/bin/python
using PTY: False
program finished with exit code 0
elapsedTime=0.004417
========= master_lag: 0.08 =========
========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-07 05:53:30.016596) =========
========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-07 05:53:30.019916) =========
========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-07 05:53:30.020203) =========
========= Total master_lag: 0.04 =========