builder: mozilla-central_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-023 starttime: 1460729464.86 results: success (0) buildid: 20160415043051 builduid: 242cb14a77734064a3b63c3611f6a431 revision: afd82f887093e5e9e4015115ca5795ec82a6f732 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-15 07:11:04.863321) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-15 07:11:04.863818) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-15 07:11:04.864105) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-15 07:11:04.881122) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-15 07:11:04.881399) ========= 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=6d15e502d8e29d5d2676d664000001c3-1460728747.621117-1993446067 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-04-15 07:11:06-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 58.8M=0s 2016-04-15 07:11:06 (58.8 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.245296 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-15 07:11:05.139909) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-15 07:11:05.140217) ========= 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=6d15e502d8e29d5d2676d664000001c3-1460728747.621117-1993446067 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019630 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-15 07:11:05.193122) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-15 07:11:05.193474) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev afd82f887093e5e9e4015115ca5795ec82a6f732 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev afd82f887093e5e9e4015115ca5795ec82a6f732 --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=6d15e502d8e29d5d2676d664000001c3-1460728747.621117-1993446067 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-04-15 07:11:06,790 truncating revision to first 12 chars 2016-04-15 07:11:06,790 Setting DEBUG logging. 2016-04-15 07:11:06,790 attempt 1/10 2016-04-15 07:11:06,790 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/afd82f887093?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-15 07:11:07,038 unpacking tar archive at: mozilla-central-afd82f887093/testing/mozharness/ program finished with exit code 0 elapsedTime=0.524456 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-15 07:11:05.733924) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-15 07:11:05.734224) ========= script_repo_revision: afd82f887093e5e9e4015115ca5795ec82a6f732 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-15 07:11:05.734714) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-15 07:11:05.734978) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-15 07:11:05.743848) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 28 secs) (at 2016-04-15 07:11:05.744114) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --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', '--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=6d15e502d8e29d5d2676d664000001c3-1460728747.621117-1993446067 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 07:11:07 INFO - MultiFileLogger online at 20160415 07:11:07 in /builds/slave/test 07:11:07 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 07:11:07 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 07:11:07 INFO - {'append_to_log': False, 07:11:07 INFO - 'base_work_dir': '/builds/slave/test', 07:11:07 INFO - 'blob_upload_branch': 'Firefox', 07:11:07 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 07:11:07 INFO - 'branch': 'Firefox', 07:11:07 INFO - 'buildbot_json_path': 'buildprops.json', 07:11:07 INFO - 'config_files': ('talos/linux_config.py',), 07:11:07 INFO - 'default_actions': ('clobber', 07:11:07 INFO - 'read-buildbot-config', 07:11:07 INFO - 'download-and-extract', 07:11:07 INFO - 'populate-webroot', 07:11:07 INFO - 'create-virtualenv', 07:11:07 INFO - 'install', 07:11:07 INFO - 'run-tests'), 07:11:07 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 07:11:07 INFO - 'download_minidump_stackwalk': True, 07:11:07 INFO - 'download_symbols': 'ondemand', 07:11:07 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 07:11:07 INFO - 'tooltool.py': '/tools/tooltool.py', 07:11:07 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 07:11:07 INFO - '/tools/misc-python/virtualenv.py')}, 07:11:07 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 07:11:07 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 07:11:07 INFO - 'installer_path': 'installer.exe', 07:11:07 INFO - 'log_level': 'info', 07:11:07 INFO - 'log_name': 'talos', 07:11:07 INFO - 'log_to_console': True, 07:11:07 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 07:11:07 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 07:11:07 INFO - 'opt_config_files': (), 07:11:07 INFO - 'pip_index': False, 07:11:07 INFO - 'sps_profile': False, 07:11:07 INFO - 'sps_profile_interval': 0, 07:11:07 INFO - 'suite': 'dromaeojs', 07:11:07 INFO - 'system_bits': '32', 07:11:07 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 07:11:07 INFO - 'title': 'talos-linux64-ix-023', 07:11:07 INFO - 'tooltool_cache': '/builds/tooltool_cache', 07:11:07 INFO - 'use_talos_json': True, 07:11:07 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 07:11:07 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 07:11:07 INFO - 'work_dir': 'build'} 07:11:07 INFO - ##### 07:11:07 INFO - ##### Running clobber step. 07:11:07 INFO - ##### 07:11:07 INFO - Running pre-action listener: _resource_record_pre_action 07:11:07 INFO - Running main action method: clobber 07:11:07 INFO - rmtree: /builds/slave/test/build 07:11:07 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 07:11:08 INFO - Running post-action listener: _resource_record_post_action 07:11:08 INFO - ##### 07:11:08 INFO - ##### Running read-buildbot-config step. 07:11:08 INFO - ##### 07:11:08 INFO - Running pre-action listener: _resource_record_pre_action 07:11:08 INFO - Running main action method: read_buildbot_config 07:11:08 INFO - Using buildbot properties: 07:11:08 INFO - { 07:11:08 INFO - "project": "", 07:11:08 INFO - "product": "firefox", 07:11:08 INFO - "script_repo_revision": "production", 07:11:08 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 07:11:08 INFO - "repository": "", 07:11:08 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs", 07:11:08 INFO - "buildid": "20160415043051", 07:11:08 INFO - "pgo_build": "True", 07:11:08 INFO - "basedir": "/builds/slave/test", 07:11:08 INFO - "buildnumber": 260, 07:11:08 INFO - "slavename": "talos-linux64-ix-023", 07:11:08 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 07:11:08 INFO - "platform": "ubuntu64_hw", 07:11:08 INFO - "scheduler": "tests-mozilla-central-linux64-pgo-talos", 07:11:08 INFO - "branch": "mozilla-central", 07:11:08 INFO - "repo_path": "mozilla-central", 07:11:08 INFO - "revision": "afd82f887093e5e9e4015115ca5795ec82a6f732", 07:11:08 INFO - "stage_platform": "linux64-pgo", 07:11:08 INFO - "builduid": "242cb14a77734064a3b63c3611f6a431", 07:11:08 INFO - "slavebuilddir": "test" 07:11:08 INFO - } 07:11:08 INFO - Found installer url https://queue.taskcluster.net/v1/task/LXNexNl9S72MlJTktb1MnA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2. 07:11:08 INFO - Running post-action listener: _resource_record_post_action 07:11:08 INFO - ##### 07:11:08 INFO - ##### Running download-and-extract step. 07:11:08 INFO - ##### 07:11:08 INFO - Running pre-action listener: _resource_record_pre_action 07:11:08 INFO - Running main action method: download_and_extract 07:11:08 INFO - mkdir: /builds/slave/test/build/tests 07:11:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:11:08 INFO - https://queue.taskcluster.net/v1/task/LXNexNl9S72MlJTktb1MnA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 07:11:08 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LXNexNl9S72MlJTktb1MnA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 07:11:08 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LXNexNl9S72MlJTktb1MnA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 07:11:08 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LXNexNl9S72MlJTktb1MnA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 07:11:08 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LXNexNl9S72MlJTktb1MnA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 07:11:09 INFO - Downloaded 1361 bytes. 07:11:09 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 07:11:09 INFO - Using the following test package requirements: 07:11:09 INFO - {u'common': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 07:11:09 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 07:11:09 INFO - u'firefox-48.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 07:11:09 INFO - u'gtest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 07:11:09 INFO - u'firefox-48.0a1.en-US.linux-x86_64.gtest.tests.zip'], 07:11:09 INFO - u'jittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 07:11:09 INFO - u'jsshell-linux-x86_64.zip'], 07:11:09 INFO - u'mochitest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 07:11:09 INFO - u'firefox-48.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 07:11:09 INFO - u'mozbase': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 07:11:09 INFO - u'reftest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 07:11:09 INFO - u'firefox-48.0a1.en-US.linux-x86_64.reftest.tests.zip'], 07:11:09 INFO - u'talos': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 07:11:09 INFO - u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'], 07:11:09 INFO - u'web-platform': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 07:11:09 INFO - u'firefox-48.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 07:11:09 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 07:11:09 INFO - u'firefox-48.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 07:11:09 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 07:11:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:11:09 INFO - https://queue.taskcluster.net/v1/task/LXNexNl9S72MlJTktb1MnA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 07:11:09 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LXNexNl9S72MlJTktb1MnA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 07:11:09 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LXNexNl9S72MlJTktb1MnA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 07:11:09 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LXNexNl9S72MlJTktb1MnA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 07:11:09 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LXNexNl9S72MlJTktb1MnA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 07:11:11 INFO - Downloaded 23777380 bytes. 07:11:11 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 07:11:11 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 07:11:12 INFO - Return code: 0 07:11:12 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 07:11:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:11:12 INFO - https://queue.taskcluster.net/v1/task/LXNexNl9S72MlJTktb1MnA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 07:11:12 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LXNexNl9S72MlJTktb1MnA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 07:11:12 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LXNexNl9S72MlJTktb1MnA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 07:11:12 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LXNexNl9S72MlJTktb1MnA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 07:11:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LXNexNl9S72MlJTktb1MnA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 07:11:27 INFO - Downloaded 23777380 bytes. 07:11:27 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 07:11:27 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 07:11:29 INFO - Return code: 0 07:11:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:11:29 INFO - https://queue.taskcluster.net/v1/task/LXNexNl9S72MlJTktb1MnA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 07:11:29 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LXNexNl9S72MlJTktb1MnA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 07:11:29 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LXNexNl9S72MlJTktb1MnA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 07:11:29 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LXNexNl9S72MlJTktb1MnA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 07:11:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LXNexNl9S72MlJTktb1MnA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 07:11:30 INFO - Downloaded 10841076 bytes. 07:11:30 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 07:11:30 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 07:11:31 INFO - Return code: 0 07:11:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:11:31 INFO - https://queue.taskcluster.net/v1/task/LXNexNl9S72MlJTktb1MnA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 07:11:31 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LXNexNl9S72MlJTktb1MnA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 07:11:31 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LXNexNl9S72MlJTktb1MnA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 07:11:31 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LXNexNl9S72MlJTktb1MnA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 07:11:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LXNexNl9S72MlJTktb1MnA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 07:11:34 INFO - Downloaded 58245930 bytes. 07:11:34 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/LXNexNl9S72MlJTktb1MnA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 07:11:34 INFO - mkdir: /builds/slave/test/properties 07:11:34 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 07:11:34 INFO - Writing to file /builds/slave/test/properties/build_url 07:11:34 INFO - Contents: 07:11:34 INFO - build_url:https://queue.taskcluster.net/v1/task/LXNexNl9S72MlJTktb1MnA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 07:11:35 INFO - Running post-action listener: _resource_record_post_action 07:11:35 INFO - Running post-action listener: set_extra_try_arguments 07:11:35 INFO - ##### 07:11:35 INFO - ##### Running populate-webroot step. 07:11:35 INFO - ##### 07:11:35 INFO - Running pre-action listener: _resource_record_pre_action 07:11:35 INFO - Running main action method: populate_webroot 07:11:35 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 07:11:35 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 07:11:35 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 07:11:35 INFO - '--tppagecycles', 07:11:35 INFO - '7'], 07:11:35 INFO - 'tests': ['tsvgm']}}, 07:11:35 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 07:11:35 INFO - 'tests': ['tresize', 'tcanvasmark']}, 07:11:35 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 07:11:35 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 07:11:35 INFO - 'tests': ['dromaeo_css', 'kraken']}, 07:11:35 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 07:11:35 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:11:35 INFO - 'talos_options': ['--disable-e10s'], 07:11:35 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:11:35 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:11:35 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:11:35 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:11:35 INFO - 'talos_options': ['--disable-e10s'], 07:11:35 INFO - 'tests': ['damp', 'tps']}, 07:11:35 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:11:35 INFO - 'tests': ['damp', 'tps']}, 07:11:35 INFO - 'g3': {'talos_options': ['--disable-e10s'], 07:11:35 INFO - 'tests': ['dromaeo_dom']}, 07:11:35 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 07:11:35 INFO - 'other': {'talos_options': ['--disable-e10s'], 07:11:35 INFO - 'tests': ['a11yr', 07:11:35 INFO - 'ts_paint', 07:11:35 INFO - 'tpaint', 07:11:35 INFO - 'sessionrestore', 07:11:35 INFO - 'sessionrestore_no_auto_restore', 07:11:35 INFO - 'tabpaint']}, 07:11:35 INFO - 'other-e10s': {'tests': ['a11yr', 07:11:35 INFO - 'ts_paint', 07:11:35 INFO - 'tpaint', 07:11:35 INFO - 'sessionrestore', 07:11:35 INFO - 'sessionrestore_no_auto_restore', 07:11:35 INFO - 'tabpaint']}, 07:11:35 INFO - 'other-e10s_l64': {'tests': ['a11yr', 07:11:35 INFO - 'ts_paint', 07:11:35 INFO - 'tpaint', 07:11:35 INFO - 'sessionrestore', 07:11:35 INFO - 'sessionrestore_no_auto_restore', 07:11:35 INFO - 'tabpaint']}, 07:11:35 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 07:11:35 INFO - 'ts_paint', 07:11:35 INFO - 'tpaint', 07:11:35 INFO - 'sessionrestore', 07:11:35 INFO - 'sessionrestore_no_auto_restore', 07:11:35 INFO - 'tabpaint']}, 07:11:35 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 07:11:35 INFO - 'tests': ['a11yr', 07:11:35 INFO - 'ts_paint', 07:11:35 INFO - 'tpaint', 07:11:35 INFO - 'sessionrestore', 07:11:35 INFO - 'sessionrestore_no_auto_restore', 07:11:35 INFO - 'tabpaint']}, 07:11:35 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 07:11:35 INFO - 'tests': ['a11yr', 07:11:35 INFO - 'ts_paint', 07:11:35 INFO - 'tpaint', 07:11:35 INFO - 'sessionrestore', 07:11:35 INFO - 'sessionrestore_no_auto_restore', 07:11:35 INFO - 'tabpaint']}, 07:11:35 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 07:11:35 INFO - 'tests': ['tsvgx', 07:11:35 INFO - 'tsvgr_opacity', 07:11:35 INFO - 'tart', 07:11:35 INFO - 'tscrollx', 07:11:35 INFO - 'cart']}, 07:11:35 INFO - 'svgr-e10s': {'tests': ['tsvgx', 07:11:35 INFO - 'tsvgr_opacity', 07:11:35 INFO - 'tart', 07:11:35 INFO - 'tscrollx', 07:11:35 INFO - 'cart']}, 07:11:35 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:11:35 INFO - 'talos_options': ['--disable-e10s'], 07:11:35 INFO - 'tests': ['tp5o']}, 07:11:35 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:11:35 INFO - 'tests': ['tp5o']}, 07:11:35 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:11:35 INFO - 'talos_options': ['--disable-e10s', 07:11:35 INFO - '--xperf_path', 07:11:35 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:11:35 INFO - 'tests': ['tp5n']}, 07:11:35 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:11:35 INFO - 'talos_options': ['--xperf_path', 07:11:35 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:11:35 INFO - 'tests': ['tp5n']}}, 07:11:35 INFO - 'talos.zip': {'path': '', 07:11:35 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 07:11:35 INFO - Running post-action listener: _resource_record_post_action 07:11:35 INFO - ##### 07:11:35 INFO - ##### Running create-virtualenv step. 07:11:35 INFO - ##### 07:11:35 INFO - Running pre-action listener: _resource_record_pre_action 07:11:35 INFO - Running main action method: create_virtualenv 07:11:35 INFO - Creating virtualenv /builds/slave/test/build/venv 07:11:35 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 07:11:35 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 07:11:35 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 07:11:35 INFO - Using real prefix '/usr' 07:11:35 INFO - New python executable in /builds/slave/test/build/venv/bin/python 07:11:36 INFO - Installing distribute.............................................................................................................................................................................................done. 07:11:38 INFO - Installing pip.................done. 07:11:38 INFO - Return code: 0 07:11:38 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 07:11:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:11:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:11:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:11:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:11:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:11:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:11:38 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc7d6d57f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a048a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2acf9a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b5e810>, '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 0x2b5f710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b5fba0>, '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': '6d15e502d8e29d5d2676d664000001c3-1460728747.621117-1993446067', '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 07:11:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 07:11:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 07:11:38 INFO - Using env: {'DISPLAY': ':0', 07:11:38 INFO - 'HOME': '/home/cltbld', 07:11:38 INFO - 'LANG': 'en_US.UTF-8', 07:11:38 INFO - 'LANGUAGE': 'en_US:en', 07:11:38 INFO - 'LOGNAME': 'cltbld', 07:11:38 INFO - 'MAIL': '/var/mail/cltbld', 07:11:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:11:38 INFO - 'MOZ_NO_REMOTE': '1', 07:11:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:11:38 INFO - 'NO_EM_RESTART': '1', 07:11:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:11:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:11:38 INFO - 'PWD': '/builds/slave/test', 07:11:38 INFO - 'SHELL': '/bin/bash', 07:11:38 INFO - 'SHLVL': '1', 07:11:38 INFO - 'TERM': 'linux', 07:11:38 INFO - 'TMOUT': '86400', 07:11:38 INFO - 'USER': 'cltbld', 07:11:38 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1460728747.621117-1993446067', 07:11:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:11:38 INFO - '_': '/tools/buildbot/bin/python'} 07:11:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:11:38 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 07:11:38 INFO - Cleaning up... 07:11:38 INFO - Return code: 0 07:11:38 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 07:11:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:11:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:11:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:11:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:11:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:11:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:11:38 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc7d6d57f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a048a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2acf9a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b5e810>, '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 0x2b5f710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b5fba0>, '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': '6d15e502d8e29d5d2676d664000001c3-1460728747.621117-1993446067', '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 07:11:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 07:11:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 07:11:38 INFO - Using env: {'DISPLAY': ':0', 07:11:38 INFO - 'HOME': '/home/cltbld', 07:11:38 INFO - 'LANG': 'en_US.UTF-8', 07:11:38 INFO - 'LANGUAGE': 'en_US:en', 07:11:38 INFO - 'LOGNAME': 'cltbld', 07:11:38 INFO - 'MAIL': '/var/mail/cltbld', 07:11:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:11:38 INFO - 'MOZ_NO_REMOTE': '1', 07:11:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:11:38 INFO - 'NO_EM_RESTART': '1', 07:11:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:11:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:11:38 INFO - 'PWD': '/builds/slave/test', 07:11:38 INFO - 'SHELL': '/bin/bash', 07:11:38 INFO - 'SHLVL': '1', 07:11:38 INFO - 'TERM': 'linux', 07:11:38 INFO - 'TMOUT': '86400', 07:11:38 INFO - 'USER': 'cltbld', 07:11:38 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1460728747.621117-1993446067', 07:11:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:11:38 INFO - '_': '/tools/buildbot/bin/python'} 07:11:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:11:38 INFO - Downloading/unpacking psutil>=0.7.1 07:11:38 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 07:11:38 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 07:11:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:11:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:11:38 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 07:11:38 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 07:11:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 07:11:40 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:11:40 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:11:40 INFO - Installing collected packages: psutil 07:11:40 INFO - Running setup.py install for psutil 07:11:40 INFO - building 'psutil._psutil_linux' extension 07:11:40 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 07:11:41 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 07:11:41 INFO - building 'psutil._psutil_posix' extension 07:11:41 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 07:11:41 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 07:11:41 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:11:41 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:11:41 INFO - Successfully installed psutil 07:11:41 INFO - Cleaning up... 07:11:41 INFO - Return code: 0 07:11:41 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 07:11:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:11:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:11:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:11:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:11:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:11:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:11:41 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc7d6d57f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a048a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2acf9a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b5e810>, '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 0x2b5f710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b5fba0>, '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': '6d15e502d8e29d5d2676d664000001c3-1460728747.621117-1993446067', '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 07:11:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 07:11:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 07:11:41 INFO - Using env: {'DISPLAY': ':0', 07:11:41 INFO - 'HOME': '/home/cltbld', 07:11:41 INFO - 'LANG': 'en_US.UTF-8', 07:11:41 INFO - 'LANGUAGE': 'en_US:en', 07:11:41 INFO - 'LOGNAME': 'cltbld', 07:11:41 INFO - 'MAIL': '/var/mail/cltbld', 07:11:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:11:41 INFO - 'MOZ_NO_REMOTE': '1', 07:11:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:11:41 INFO - 'NO_EM_RESTART': '1', 07:11:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:11:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:11:41 INFO - 'PWD': '/builds/slave/test', 07:11:41 INFO - 'SHELL': '/bin/bash', 07:11:41 INFO - 'SHLVL': '1', 07:11:41 INFO - 'TERM': 'linux', 07:11:41 INFO - 'TMOUT': '86400', 07:11:41 INFO - 'USER': 'cltbld', 07:11:41 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1460728747.621117-1993446067', 07:11:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:11:41 INFO - '_': '/tools/buildbot/bin/python'} 07:11:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:11:41 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 07:11:41 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 07:11:41 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 07:11:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:11:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:11:41 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 07:11:41 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 07:11:43 INFO - Downloading mozsystemmonitor-0.0.tar.gz 07:11:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 07:11:43 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 07:11:43 INFO - Installing collected packages: mozsystemmonitor 07:11:43 INFO - Running setup.py install for mozsystemmonitor 07:11:43 INFO - Successfully installed mozsystemmonitor 07:11:43 INFO - Cleaning up... 07:11:43 INFO - Return code: 0 07:11:43 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 07:11:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:11:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:11:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:11:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:11:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:11:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:11:43 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc7d6d57f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a048a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2acf9a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b5e810>, '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 0x2b5f710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b5fba0>, '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': '6d15e502d8e29d5d2676d664000001c3-1460728747.621117-1993446067', '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 07:11:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 07:11:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 07:11:43 INFO - Using env: {'DISPLAY': ':0', 07:11:43 INFO - 'HOME': '/home/cltbld', 07:11:43 INFO - 'LANG': 'en_US.UTF-8', 07:11:43 INFO - 'LANGUAGE': 'en_US:en', 07:11:43 INFO - 'LOGNAME': 'cltbld', 07:11:43 INFO - 'MAIL': '/var/mail/cltbld', 07:11:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:11:43 INFO - 'MOZ_NO_REMOTE': '1', 07:11:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:11:43 INFO - 'NO_EM_RESTART': '1', 07:11:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:11:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:11:43 INFO - 'PWD': '/builds/slave/test', 07:11:43 INFO - 'SHELL': '/bin/bash', 07:11:43 INFO - 'SHLVL': '1', 07:11:43 INFO - 'TERM': 'linux', 07:11:43 INFO - 'TMOUT': '86400', 07:11:43 INFO - 'USER': 'cltbld', 07:11:43 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1460728747.621117-1993446067', 07:11:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:11:43 INFO - '_': '/tools/buildbot/bin/python'} 07:11:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:11:43 INFO - Downloading/unpacking blobuploader==1.2.4 07:11:43 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 07:11:43 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 07:11:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:11:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:11:43 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 07:11:43 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 07:11:45 INFO - Downloading blobuploader-1.2.4.tar.gz 07:11:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 07:11:45 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 07:11:45 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 07:11:45 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 07:11:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:11:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:11:45 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 07:11:45 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 07:11:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 07:11:46 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 07:11:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:11:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:11:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:11:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:11:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:11:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:11:46 INFO - Downloading docopt-0.6.1.tar.gz 07:11:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 07:11:46 INFO - Installing collected packages: blobuploader, requests, docopt 07:11:46 INFO - Running setup.py install for blobuploader 07:11:46 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 07:11:46 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 07:11:46 INFO - Running setup.py install for requests 07:11:47 INFO - Running setup.py install for docopt 07:11:47 INFO - Successfully installed blobuploader requests docopt 07:11:47 INFO - Cleaning up... 07:11:47 INFO - Return code: 0 07:11:47 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:11:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:11:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:11:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:11:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:11:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:11:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:11:47 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc7d6d57f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a048a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2acf9a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b5e810>, '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 0x2b5f710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b5fba0>, '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': '6d15e502d8e29d5d2676d664000001c3-1460728747.621117-1993446067', '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 07:11:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 07:11:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 07:11:47 INFO - Using env: {'DISPLAY': ':0', 07:11:47 INFO - 'HOME': '/home/cltbld', 07:11:47 INFO - 'LANG': 'en_US.UTF-8', 07:11:47 INFO - 'LANGUAGE': 'en_US:en', 07:11:47 INFO - 'LOGNAME': 'cltbld', 07:11:47 INFO - 'MAIL': '/var/mail/cltbld', 07:11:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:11:47 INFO - 'MOZ_NO_REMOTE': '1', 07:11:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:11:47 INFO - 'NO_EM_RESTART': '1', 07:11:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:11:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:11:47 INFO - 'PWD': '/builds/slave/test', 07:11:47 INFO - 'SHELL': '/bin/bash', 07:11:47 INFO - 'SHLVL': '1', 07:11:47 INFO - 'TERM': 'linux', 07:11:47 INFO - 'TMOUT': '86400', 07:11:47 INFO - 'USER': 'cltbld', 07:11:47 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1460728747.621117-1993446067', 07:11:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:11:47 INFO - '_': '/tools/buildbot/bin/python'} 07:11:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:11:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:11:47 INFO - Running setup.py (path:/tmp/pip-l2jbpV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:11:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:11:47 INFO - Running setup.py (path:/tmp/pip-PhfbvM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:11:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:11:47 INFO - Running setup.py (path:/tmp/pip-5wneJl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:11:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:11:47 INFO - Running setup.py (path:/tmp/pip-fFvlHD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:11:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:11:47 INFO - Running setup.py (path:/tmp/pip-UyD0iE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:11:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:11:47 INFO - Running setup.py (path:/tmp/pip-FjgPz9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:11:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:11:47 INFO - Running setup.py (path:/tmp/pip-PhKls3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:11:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:11:47 INFO - Running setup.py (path:/tmp/pip-CZA_Uc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:11:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:11:47 INFO - Running setup.py (path:/tmp/pip-V8BoEZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:11:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:11:48 INFO - Running setup.py (path:/tmp/pip-PGGr2Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:11:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:11:48 INFO - Running setup.py (path:/tmp/pip-Os3f_B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:11:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:11:48 INFO - Running setup.py (path:/tmp/pip-HPhcxK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:11:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:11:48 INFO - Running setup.py (path:/tmp/pip-86RKpy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:11:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:11:48 INFO - Running setup.py (path:/tmp/pip-uswo6H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:11:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:11:48 INFO - Running setup.py (path:/tmp/pip-uUgJtz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:11:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:11:48 INFO - Running setup.py (path:/tmp/pip-XO_STq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:11:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:11:48 INFO - Running setup.py (path:/tmp/pip-LZyNOU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:11:48 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 07:11:48 INFO - Running setup.py install for manifestparser 07:11:48 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 07:11:48 INFO - Running setup.py install for mozcrash 07:11:48 INFO - Running setup.py install for mozdebug 07:11:48 INFO - Running setup.py install for mozdevice 07:11:49 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 07:11:49 INFO - Installing dm script to /builds/slave/test/build/venv/bin 07:11:49 INFO - Running setup.py install for mozfile 07:11:49 INFO - Running setup.py install for mozhttpd 07:11:49 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 07:11:49 INFO - Running setup.py install for mozinfo 07:11:49 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 07:11:49 INFO - Running setup.py install for mozInstall 07:11:49 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 07:11:49 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 07:11:49 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 07:11:49 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 07:11:49 INFO - Running setup.py install for mozleak 07:11:49 INFO - Running setup.py install for mozlog 07:11:49 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 07:11:49 INFO - Running setup.py install for moznetwork 07:11:49 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 07:11:49 INFO - Running setup.py install for mozprocess 07:11:49 INFO - Running setup.py install for mozprofile 07:11:49 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 07:11:49 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 07:11:49 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 07:11:49 INFO - Running setup.py install for mozrunner 07:11:50 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 07:11:50 INFO - Running setup.py install for mozscreenshot 07:11:50 INFO - Running setup.py install for moztest 07:11:50 INFO - Running setup.py install for mozversion 07:11:50 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 07:11:50 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 07:11:50 INFO - Cleaning up... 07:11:50 INFO - Return code: 0 07:11:50 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:11:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:11:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:11:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:11:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:11:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:11:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:11:50 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc7d6d57f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a048a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2acf9a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b5e810>, '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 0x2b5f710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b5fba0>, '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': '6d15e502d8e29d5d2676d664000001c3-1460728747.621117-1993446067', '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 07:11:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 07:11:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 07:11:50 INFO - Using env: {'DISPLAY': ':0', 07:11:50 INFO - 'HOME': '/home/cltbld', 07:11:50 INFO - 'LANG': 'en_US.UTF-8', 07:11:50 INFO - 'LANGUAGE': 'en_US:en', 07:11:50 INFO - 'LOGNAME': 'cltbld', 07:11:50 INFO - 'MAIL': '/var/mail/cltbld', 07:11:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:11:50 INFO - 'MOZ_NO_REMOTE': '1', 07:11:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:11:50 INFO - 'NO_EM_RESTART': '1', 07:11:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:11:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:11:50 INFO - 'PWD': '/builds/slave/test', 07:11:50 INFO - 'SHELL': '/bin/bash', 07:11:50 INFO - 'SHLVL': '1', 07:11:50 INFO - 'TERM': 'linux', 07:11:50 INFO - 'TMOUT': '86400', 07:11:50 INFO - 'USER': 'cltbld', 07:11:50 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1460728747.621117-1993446067', 07:11:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:11:50 INFO - '_': '/tools/buildbot/bin/python'} 07:11:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:11:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:11:50 INFO - Running setup.py (path:/tmp/pip-BSqKfU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:11:50 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)) 07:11:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:11:50 INFO - Running setup.py (path:/tmp/pip-PwkuDr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:11:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 07:11:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:11:50 INFO - Running setup.py (path:/tmp/pip-mEs9ux-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:11:50 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)) 07:11:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:11:50 INFO - Running setup.py (path:/tmp/pip-e4cEwM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:11:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 07:11:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:11:50 INFO - Running setup.py (path:/tmp/pip-PY9m9t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:11:50 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)) 07:11:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:11:50 INFO - Running setup.py (path:/tmp/pip-D5kA6M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:11:51 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)) 07:11:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:11:51 INFO - Running setup.py (path:/tmp/pip-cjBaqu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:11:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 07:11:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:11:51 INFO - Running setup.py (path:/tmp/pip-80nUxB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:11:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 07:11:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:11:51 INFO - Running setup.py (path:/tmp/pip-5mgkfD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:11:51 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)) 07:11:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:11:51 INFO - Running setup.py (path:/tmp/pip-fGxide-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:11:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 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)) 07:11:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:11:51 INFO - Running setup.py (path:/tmp/pip-mW7LVO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:11:51 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)) 07:11:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:11:51 INFO - Running setup.py (path:/tmp/pip-xgBi44-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:11:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 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)) 07:11:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:11:51 INFO - Running setup.py (path:/tmp/pip-UbixgM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:11:51 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)) 07:11:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:11:51 INFO - Running setup.py (path:/tmp/pip-RUZi7w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:11:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 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)) 07:11:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:11:51 INFO - Running setup.py (path:/tmp/pip-EoqX67-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:11:51 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)) 07:11:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:11:51 INFO - Running setup.py (path:/tmp/pip-OHGcuw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:11:51 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 07:11:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:11:51 INFO - Running setup.py (path:/tmp/pip-pgNEqg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:11:51 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)) 07:11:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 07:11:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 07:11:51 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)) 07:11:51 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 07:11:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 07:11:51 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 07:11:51 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 07:11:51 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 07:11:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:11:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:11:51 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 07:11:51 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 07:11:53 INFO - Downloading blessings-1.6.tar.gz 07:11:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 07:11:53 INFO - Installing collected packages: blessings 07:11:53 INFO - Running setup.py install for blessings 07:11:53 INFO - Successfully installed blessings 07:11:53 INFO - Cleaning up... 07:11:54 INFO - Return code: 0 07:11:54 INFO - Done creating virtualenv /builds/slave/test/build/venv. 07:11:54 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:11:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:11:54 INFO - Reading from file tmpfile_stdout 07:11:54 INFO - Current package versions: 07:11:54 INFO - argparse == 1.2.1 07:11:54 INFO - blessings == 1.6 07:11:54 INFO - blobuploader == 1.2.4 07:11:54 INFO - docopt == 0.6.1 07:11:54 INFO - manifestparser == 1.1 07:11:54 INFO - mozInstall == 1.12 07:11:54 INFO - mozcrash == 0.17 07:11:54 INFO - mozdebug == 0.1 07:11:54 INFO - mozdevice == 0.48 07:11:54 INFO - mozfile == 1.2 07:11:54 INFO - mozhttpd == 0.7 07:11:54 INFO - mozinfo == 0.9 07:11:54 INFO - mozleak == 0.1 07:11:54 INFO - mozlog == 3.1 07:11:54 INFO - moznetwork == 0.27 07:11:54 INFO - mozprocess == 0.22 07:11:54 INFO - mozprofile == 0.28 07:11:54 INFO - mozrunner == 6.11 07:11:54 INFO - mozscreenshot == 0.1 07:11:54 INFO - mozsystemmonitor == 0.0 07:11:54 INFO - moztest == 0.7 07:11:54 INFO - mozversion == 1.4 07:11:54 INFO - psutil == 3.1.1 07:11:54 INFO - requests == 1.2.3 07:11:54 INFO - wsgiref == 0.1.2 07:11:54 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:11:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:11:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:11:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:11:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:11:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:11:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:11:54 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc7d6d57f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a048a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2acf9a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b5e810>, '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 0x2b5f710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b5fba0>, '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': '6d15e502d8e29d5d2676d664000001c3-1460728747.621117-1993446067', '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 07:11:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 07:11:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 07:11:54 INFO - Using env: {'DISPLAY': ':0', 07:11:54 INFO - 'HOME': '/home/cltbld', 07:11:54 INFO - 'LANG': 'en_US.UTF-8', 07:11:54 INFO - 'LANGUAGE': 'en_US:en', 07:11:54 INFO - 'LOGNAME': 'cltbld', 07:11:54 INFO - 'MAIL': '/var/mail/cltbld', 07:11:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:11:54 INFO - 'MOZ_NO_REMOTE': '1', 07:11:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:11:54 INFO - 'NO_EM_RESTART': '1', 07:11:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:11:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:11:54 INFO - 'PWD': '/builds/slave/test', 07:11:54 INFO - 'SHELL': '/bin/bash', 07:11:54 INFO - 'SHLVL': '1', 07:11:54 INFO - 'TERM': 'linux', 07:11:54 INFO - 'TMOUT': '86400', 07:11:54 INFO - 'USER': 'cltbld', 07:11:54 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1460728747.621117-1993446067', 07:11:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:11:54 INFO - '_': '/tools/buildbot/bin/python'} 07:11:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:11:54 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)) 07:11:54 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)) 07:11:54 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)) 07:11:54 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)) 07:11:54 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)) 07:11:54 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)) 07:11:54 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)) 07:11:54 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)) 07:11:54 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)) 07:11:54 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)) 07:11:54 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)) 07:11:54 INFO - Cleaning up... 07:11:54 INFO - Return code: 0 07:11:54 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 07:11:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:11:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:11:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:11:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:11:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:11:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:11:54 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc7d6d57f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a048a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2acf9a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b5e810>, '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 0x2b5f710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b5fba0>, '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': '6d15e502d8e29d5d2676d664000001c3-1460728747.621117-1993446067', '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 07:11:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 07:11:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 07:11:54 INFO - Using env: {'DISPLAY': ':0', 07:11:54 INFO - 'HOME': '/home/cltbld', 07:11:54 INFO - 'LANG': 'en_US.UTF-8', 07:11:54 INFO - 'LANGUAGE': 'en_US:en', 07:11:54 INFO - 'LOGNAME': 'cltbld', 07:11:54 INFO - 'MAIL': '/var/mail/cltbld', 07:11:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:11:54 INFO - 'MOZ_NO_REMOTE': '1', 07:11:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:11:54 INFO - 'NO_EM_RESTART': '1', 07:11:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:11:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:11:54 INFO - 'PWD': '/builds/slave/test', 07:11:54 INFO - 'SHELL': '/bin/bash', 07:11:54 INFO - 'SHLVL': '1', 07:11:54 INFO - 'TERM': 'linux', 07:11:54 INFO - 'TMOUT': '86400', 07:11:54 INFO - 'USER': 'cltbld', 07:11:54 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1460728747.621117-1993446067', 07:11:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:11:54 INFO - '_': '/tools/buildbot/bin/python'} 07:11:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:11:54 INFO - Downloading/unpacking jsonschema 07:11:54 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 07:11:54 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 07:11:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:11:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:11:54 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 07:11:54 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 07:11:56 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 07:11:56 INFO - Downloading/unpacking functools32 (from jsonschema) 07:11:56 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 07:11:56 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 07:11:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:11:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:11:56 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 07:11:56 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 07:11:56 INFO - Downloading functools32-3.2.3-2.tar.gz 07:11:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 07:11:56 INFO - warning: no files found matching '*.txt' 07:11:56 INFO - no previously-included directories found matching 'build' 07:11:56 INFO - no previously-included directories found matching 'dist' 07:11:56 INFO - no previously-included directories found matching '.git*' 07:11:56 INFO - Installing collected packages: jsonschema, functools32 07:11:56 INFO - Running setup.py install for functools32 07:11:56 INFO - warning: no files found matching '*.txt' 07:11:56 INFO - no previously-included directories found matching 'build' 07:11:56 INFO - no previously-included directories found matching 'dist' 07:11:56 INFO - no previously-included directories found matching '.git*' 07:11:57 INFO - Successfully installed jsonschema functools32 07:11:57 INFO - Cleaning up... 07:11:57 INFO - Return code: 0 07:11:57 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 07:11:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:11:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:11:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:11:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:11:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:11:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:11:57 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc7d6d57f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a048a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2acf9a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b5e810>, '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 0x2b5f710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b5fba0>, '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': '6d15e502d8e29d5d2676d664000001c3-1460728747.621117-1993446067', '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 07:11:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 07:11:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 07:11:57 INFO - Using env: {'DISPLAY': ':0', 07:11:57 INFO - 'HOME': '/home/cltbld', 07:11:57 INFO - 'LANG': 'en_US.UTF-8', 07:11:57 INFO - 'LANGUAGE': 'en_US:en', 07:11:57 INFO - 'LOGNAME': 'cltbld', 07:11:57 INFO - 'MAIL': '/var/mail/cltbld', 07:11:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:11:57 INFO - 'MOZ_NO_REMOTE': '1', 07:11:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:11:57 INFO - 'NO_EM_RESTART': '1', 07:11:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:11:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:11:57 INFO - 'PWD': '/builds/slave/test', 07:11:57 INFO - 'SHELL': '/bin/bash', 07:11:57 INFO - 'SHLVL': '1', 07:11:57 INFO - 'TERM': 'linux', 07:11:57 INFO - 'TMOUT': '86400', 07:11:57 INFO - 'USER': 'cltbld', 07:11:57 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1460728747.621117-1993446067', 07:11:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:11:57 INFO - '_': '/tools/buildbot/bin/python'} 07:11:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:11:57 INFO - Downloading/unpacking flake8 07:11:57 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 07:11:57 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 07:11:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:11:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:11:57 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 07:11:57 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 07:11:59 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 07:11:59 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 07:11:59 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 07:11:59 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 07:11:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:11:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:11:59 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 07:11:59 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 07:11:59 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 07:11:59 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 07:11:59 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 07:11:59 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 07:11:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:11:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:11:59 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 07:11:59 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 07:11:59 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 07:11:59 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 07:11:59 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 07:11:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:11:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:11:59 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 07:11:59 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 07:11:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 07:11:59 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 07:11:59 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 07:11:59 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 07:11:59 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 07:11:59 INFO - no previously-included directories found matching 'docs/_build' 07:11:59 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 07:11:59 INFO - Running setup.py install for pep8 07:12:00 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 07:12:00 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 07:12:00 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 07:12:00 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 07:12:00 INFO - no previously-included directories found matching 'docs/_build' 07:12:00 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 07:12:00 INFO - Successfully installed flake8 mccabe pyflakes pep8 07:12:00 INFO - Cleaning up... 07:12:00 INFO - Return code: 0 07:12:00 INFO - Running post-action listener: _resource_record_post_action 07:12:00 INFO - Running post-action listener: _start_resource_monitoring 07:12:00 INFO - Starting resource monitoring. 07:12:00 INFO - ##### 07:12:00 INFO - ##### Running install step. 07:12:00 INFO - ##### 07:12:00 INFO - Running pre-action listener: _resource_record_pre_action 07:12:00 INFO - Running main action method: install 07:12:00 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:12:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:12:00 INFO - Reading from file tmpfile_stdout 07:12:00 INFO - Detecting whether we're running mozinstall >=1.0... 07:12:00 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 07:12:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 07:12:00 INFO - Reading from file tmpfile_stdout 07:12:00 INFO - Output received: 07:12:00 INFO - Usage: mozinstall [options] installer 07:12:00 INFO - Options: 07:12:00 INFO - -h, --help show this help message and exit 07:12:00 INFO - -d DEST, --destination=DEST 07:12:00 INFO - Directory to install application into. [default: 07:12:00 INFO - "/builds/slave/test"] 07:12:00 INFO - --app=APP Application being installed. [default: firefox] 07:12:00 INFO - mkdir: /builds/slave/test/build/application 07:12:00 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 07:12:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 07:12:17 INFO - Reading from file tmpfile_stdout 07:12:17 INFO - Output received: 07:12:17 INFO - /builds/slave/test/build/application/firefox/firefox 07:12:17 INFO - Running post-action listener: _resource_record_post_action 07:12:17 INFO - ##### 07:12:17 INFO - ##### Running run-tests step. 07:12:17 INFO - ##### 07:12:17 INFO - Running pre-action listener: _resource_record_pre_action 07:12:17 INFO - Running main action method: run_tests 07:12:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 07:12:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 07:12:17 INFO - Python 2.7.3 07:12:17 INFO - Return code: 0 07:12:17 INFO - grabbing minidump binary from tooltool 07:12:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:12:17 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b5e810>, '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 0x2b5f710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b5fba0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 07:12:17 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 07:12:17 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 07:12:17 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 07:12:17 INFO - Return code: 0 07:12:17 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 07:12:17 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 07:12:17 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 07:12:17 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 07:12:17 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 07:12:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 07:12:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 07:12:18 INFO - Return code: 0 07:12:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/LXNexNl9S72MlJTktb1MnA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-023', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 07:12:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/LXNexNl9S72MlJTktb1MnA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-023 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 07:12:18 INFO - Using env: {'DISPLAY': ':0', 07:12:18 INFO - 'HOME': '/home/cltbld', 07:12:18 INFO - 'LANG': 'en_US.UTF-8', 07:12:18 INFO - 'LANGUAGE': 'en_US:en', 07:12:18 INFO - 'LOGNAME': 'cltbld', 07:12:18 INFO - 'MAIL': '/var/mail/cltbld', 07:12:18 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 07:12:18 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 07:12:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:12:18 INFO - 'MOZ_NO_REMOTE': '1', 07:12:18 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 07:12:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:12:18 INFO - 'NO_EM_RESTART': '1', 07:12:18 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:12:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:12:18 INFO - 'PWD': '/builds/slave/test', 07:12:18 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 07:12:18 INFO - 'SHELL': '/bin/bash', 07:12:18 INFO - 'SHLVL': '1', 07:12:18 INFO - 'TERM': 'linux', 07:12:18 INFO - 'TMOUT': '86400', 07:12:18 INFO - 'USER': 'cltbld', 07:12:18 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1460728747.621117-1993446067', 07:12:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:12:18 INFO - '_': '/tools/buildbot/bin/python'} 07:12:18 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/LXNexNl9S72MlJTktb1MnA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-023', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 07:12:18 INFO - mozversion application_buildid: 20160415043051 07:12:18 INFO - mozversion application_changeset: afd82f887093e5e9e4015115ca5795ec82a6f732 07:12:18 INFO - mozversion application_display_name: Nightly 07:12:18 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 07:12:18 INFO - mozversion application_name: Firefox 07:12:18 INFO - mozversion application_remotingname: firefox 07:12:18 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 07:12:18 INFO - mozversion application_vendor: Mozilla 07:12:18 INFO - mozversion application_version: 48.0a1 07:12:18 INFO - mozversion platform_buildid: 20160415043051 07:12:18 INFO - mozversion platform_changeset: afd82f887093e5e9e4015115ca5795ec82a6f732 07:12:18 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 07:12:18 INFO - mozversion platform_version: 48.0a1 07:12:18 INFO - using testdate: 1460729538 07:12:18 INFO - actual date: 1460729538 07:12:18 INFO - starting webserver on 'localhost:55026' 07:12:18 INFO - SUITE-START | Running 2 tests 07:12:18 INFO - TEST-START | dromaeo_css 07:12:18 INFO - operating with platform_type : linux_ 07:12:18 INFO - Initialising browser for dromaeo_css test... 07:12:18 INFO - TEST-INFO | started process 6990 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmphO8OFX/profile http://localhost:55026/getInfo.html) 07:12:22 INFO - PROCESS | 6990 | __metrics Screen width/height:1600/1200 07:12:22 INFO - PROCESS | 6990 | colorDepth:24 07:12:22 INFO - PROCESS | 6990 | Browser inner width/height: 1024/697 07:12:22 INFO - PROCESS | 6990 | __metrics 07:12:23 ERROR - PROCESS | 6990 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 07:12:24 INFO - TEST-INFO | 6990: exit 0 07:12:24 INFO - Browser initialized. 07:12:24 INFO - Running cycle 1/1 for dromaeo_css test... 07:12:24 INFO - TEST-INFO | started process 7072 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmphO8OFX/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:12:35 INFO - PROCESS | 7072 | RSS: Main: 153337856 07:12:35 INFO - PROCESS | 7072 | 07:13:26 INFO - PROCESS | 7072 | 1460729606736 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 07:15:34 INFO - PROCESS | 7072 | Cycle 1(1): loaded http://localhost:55026/tests/dromaeo/cssquery-dojo.html (next: http://localhost:55026/tests/dromaeo/cssquery-ext.html) 07:15:35 INFO - PROCESS | 7072 | RSS: Main: 261967872 07:15:35 INFO - PROCESS | 7072 | 07:18:37 INFO - PROCESS | 7072 | Cycle 1(1): loaded http://localhost:55026/tests/dromaeo/cssquery-ext.html (next: http://localhost:55026/tests/dromaeo/cssquery-jquery.html) 07:18:37 INFO - PROCESS | 7072 | RSS: Main: 235794432 07:18:37 INFO - PROCESS | 7072 | 07:21:39 INFO - PROCESS | 7072 | Cycle 1(1): loaded http://localhost:55026/tests/dromaeo/cssquery-jquery.html (next: http://localhost:55026/tests/dromaeo/cssquery-mootools.html) 07:21:40 INFO - PROCESS | 7072 | RSS: Main: 237420544 07:21:40 INFO - PROCESS | 7072 | 07:24:42 INFO - PROCESS | 7072 | Cycle 1(1): loaded http://localhost:55026/tests/dromaeo/cssquery-mootools.html (next: http://localhost:55026/tests/dromaeo/cssquery-prototype.html) 07:24:43 INFO - PROCESS | 7072 | RSS: Main: 230383616 07:24:43 INFO - PROCESS | 7072 | 07:27:45 INFO - PROCESS | 7072 | Cycle 1(1): loaded http://localhost:55026/tests/dromaeo/cssquery-prototype.html (next: http://localhost:55026/tests/dromaeo/cssquery-yui.html) 07:27:46 INFO - PROCESS | 7072 | RSS: Main: 224325632 07:27:46 INFO - PROCESS | 7072 | 07:30:48 INFO - PROCESS | 7072 | Cycle 1(1): loaded http://localhost:55026/tests/dromaeo/cssquery-yui.html (next: http://localhost:55026/tests/dromaeo/cssquery-dojo.html) 07:30:48 INFO - PROCESS | 7072 | RSS: Main: 273174528 07:30:48 INFO - PROCESS | 7072 | 07:30:48 INFO - PROCESS | 7072 | __start_tp_report 07:30:48 INFO - PROCESS | 7072 | _x_x_mozilla_page_load 07:30:48 INFO - PROCESS | 7072 | _x_x_mozilla_page_load_details 07:30:48 INFO - PROCESS | 7072 | |i|pagename|runs| 07:30:48 INFO - PROCESS | 7072 | |0;dojo.html;2988.6264216972877;3050;3102.364015376848;3107.176598201477;3134.153778479811;5025.422076461208;5145.202493613491;5153.046686363025;5191.325127733389;5210.791568337267;5138.203578445337;5146.588272938166;5161.071007218699;5213.8957220855655;5269.683818970864;4621.9306710399205;4661.976690116545;4767.809287628491;4780.760961951906;4792.089502994438;4668.393108895839;4733.502982186872;4762.309465127554;4785.688930219542;4800.975995120019;4589.2886602576655;4645.256758918556;4647.34937108805;4647.67466277359;4707.435107787071;4737.834175803865;4740.170470167742;4746.620270378361;4756.025014871978;4779.569838714532;4598.885027874297;4630.791614377361;4724.952750472486;4736.8578942631775;4740.454847692525;5098.745062746848;5116.795328186868;5119.206522988943;5128.410232823198;5172.793088276502;5481;5508.586855985777;5511.53151982082;5554;5554;5386.622936394454;5537.861553461155;5584;5647.519960803336;5662.292213473316;5146.768395422215;5187.299714538527;5194.558462530652;5196.58427325813;5201.037808005493;5645.435456454404;5669.659820410789;5679.687617181012;5681.460261275172;5682.54539636828;5353.357597088374;5493.423190565013;5535.25274087993;5573.275474188411;5583.637063590853;5501.477359650827;5503.284573005483;5504.80733174337;5507;5509.283793106951;5422.132458806651;5473.151661492475;5485;5491.203775452617;5532.944670553324;5517.5585953123655;5576;5578.776848925998;5583.720813959286;5621.8594535136945;4145.730527515701;4153.7507749535125;4157.293260145782;4157.708960372805;4194.874153775391;3621.3662609043313;3740.6633402993316;3743.307488114653;3768.7550309229814;3789.6399842014966;5155.845324640267;5184.170532714747;5185.559227465632;5207.427183009866;5225.503577160163;5473.781048758085;5476.123820188751;5483.561315094783;5492.313460817398;5514.255575497256;5074.67014644047;5109.380129525215;5171.896562068738;5273.5253827154975;5346.358436987509;4760.047990401933;4782.569568738761;4783.234682450791;4791.137595232822;4819.95180048202;5736.6844823534275;5739.196512488255;5740.253767010262;5741.167530708024;5744.684042377626;5359.437259087739;5488.862778430571;5540.501354878081;5568.081266591129;5623.971880140573;5744.994625940527;5752.511036561939;5762.7694892203845;5769.423057694197;5772.942270577409;5468.4531546845;5469.562435005269;5469.890602188014;5470.316210473691;5472.726363681721;5412.377576578744;5514.145307477347;5578.86052848682;5588;5620.803271885465;5339.919901201562;5351.946480535301;5353.78584856617;5356.223347614497;5360.70516121617;5213;5367.651102678314;5373.435789242073;5380.058489764354;5421.810236641699;5350.3312085989255;5396.4333744957785;5418.674879507243;5451.509364157245;5466.3986961435;5467.562594992471;5470.17947307907;5470.56235501151;5473.151661492475;5479.561635069264;5224.921626175535;5342.118550439134;5366.409694933476;5367.704776237344;5368.946310536845 07:30:48 INFO - PROCESS | 7072 | |1;ext.html;599.1342510072947;640.6828619833183;652.4943169043992;657.684311530465;681.6966449929783;30137.24656883579;37275.25449491012;38011.23977520448;38295.42556861649;38467.03832404188;40376.79811600945;40934.38598421026;41011.38482922759;41025.17949641013;41075;8454.408191426588;8647.69733059343;8651.394402391836;8653.95673021634;8654.653813847439;8551.486910785341;8632.050474447806;8633.870491942625;8634.050254472004;8643.438176518537;8863.468191908474;8917.108289171096;8961.820763584725;8962;8971;8822.2942164627;8913.777155571097;8920.955395223014;8927.464352138828;8931.910680893174;8686.391952563323;8793.252573531257;8800;8802.075782042857;8808.119188081204;40091.39862902059;40567.7971610143;40586.579469718716;40590.59409405898;40612.39081413781;3484.216051388443;3626.9637303627155;3772.1512659651635;3983.4423180754716;4254;28230.576541351897;28343.85828070867;28385;28521.857390712914;31259.531107033414;4333.761643109628;4364.781760911942;4442.2226110430865;4485.147821913859;4574.702644328108;301993;303501;304845;304952.9999999978;305750;55715.44284557102;56682;56820.431795681514;56967.86064278691;57053.42946570481;58422.12366814501;58944.705276473345;58981.41018589845;59155.70422147862;59198;16924.915375423043;17042.403515877133;17102.657946840995;17126;17130.657386852443;12325.691857703629;12340.876591233973;12375.257484550775;12377.133600648049;12389.070819688559;15146.772798408032;16552.924059936067;16768.6646267074;16782.58043548921;16791.748123778154;5201.36157110509;6118.724657390429;6201.224846894138;6310.305866354697;6355.173827402408;963.9348519885566;1068.0974576482859;1125.1785997777463;1166.8424762657103;1188.928664280146;29596.704032959395;29783.553246701318;29868.70131298703;30087.247818804706;30191;1121.4280716834473;1167.8656954450178;1169.1465230381698;1171.1801738782885;1205.572021932219;17022.914885425493;17200.225989830487;17207;17229.22468488921;17251.39620113315;402496;405033;406956;408248;408878;57137;57633;57652.71173644105;57682.7115864418;57743.133852992236;1281.6923938254752;1386.4523513212225;1435.5836807325968;1440.2582669924998;1444.2345556854884;28178.71821281761;29109.563356550094;29234.707652924048;29437.554052500356;29904.551431728105;40348.79825600853;40810;40821.1835763289;40827.7958610205;40989.38515922323;256766;263027;263385;263459;264956;27242.182734517995;34947.825260873535;42515.7874210627;44084.559154408045;45074.098518030114;41859.35376604768;42265.1546969065;42311;42562;46114.308285375075;38407.80796096114;39051.41422878716;39216.411753824286;39548.802255988536;40358.596414035484;37271;39636.80181599074;39703;40482.595174049064;41337.379939300336;37515.43726844045;37530.437043444916;38097.809510953375;38117.80941095277;38259;31438.214044648154;32746.34507309888;32977.67022329746;33126.834365828014;35291.47062794112;27537.86231068912;28026.159215223575;28095.297617559725;28115.297117571405;28271 07:30:48 INFO - PROCESS | 7072 | |2;jquery.html;378.9393697008479;387.16111181721305;391.5555844116926;392.0297264270929;406.82506522195456;14257.073290236127;15297.541073767805;17446.302147914084;18232;18233.17950692217;17008.82991170088;17334.306627734906;17392.043437610926;17514.82485175148;18393.90803045986;5047.47001564836;5181.689098654093;5181.948180518203;5213.061648903196;5216.035033518792;3797.221569578244;5172.818951336704;5231.712255825928;5233.528982391584;5531.3915469298545;5485.286912701344;5497.697626630534;5528.806491772789;5532.197831314477;5534.501894829465;5278.709670968115;5450.345958484987;6013.098035294697;6013.729382177812;6027.035674292092;5323.3763702070855;5326.067938110854;5328.120860058086;5337.8131765388025;5345.732713364355;12515.123941324111;12607.810882836764;12608.936955315165;12676;14995.875309351843;2312.340982819905;2322.9419264518524;2381.071382160959;2409.9397515062265;2459.86470744109;10102.747431314203;10514.369137851676;13305.534306299232;13595.932020339835;14450.712324149648;1834.8348648621688;1854.2582966813247;1873.8032506586749;1901.115981068796;1958.6768183249746;54127.18809217865;56288;71024.6448767758;74739;76700.61649691772;10640.840387394195;10697.572097116185;10809.83785243222;10868.782624347627;10917.890821091847;15485;15489.690206195814;15501;15554.144522051396;15556.45552405683;8116.228958248957;8171.10117887032;8240.093589705128;8247.257746802816;8265.628046737911;7735.883961740578;7752.26353496417;7766.145723970359;7786.961065194638;7839.137694853562;4721.811127554859;4743.312219728189;4765.928511072337;4801.375821143229;4818.494058123846;1929.7201905723591;1999.3002449142684;2009.728686627316;2018.5676260106536;2033.572949680554;890.9242714369221;964.7009427077628;997.4065431068502;1052.9789404211872;1090.6455401994383;17617.295308187786;18856.34002809895;19155.233790648217;19261.711074333896;19336.903315483614;1030.99484502577;1058.1481907064888;1079.2768844873954;1089.319175515303;1092.1099304067159;10207.234457415723;10753.180788287758;10832.837507437394;10860.022597966063;10983.835242471368;429206;451142;480568;488625;491825;84389.57805211058;86206.56896715476;86830.56584717036;87052.1294787044;87804;1038.683201623512;1047.9685609431729;1055.5777688924338;1076.8438576406377;1082.4046774274118;16311.364360854375;16481.423150190167;16711.582210444834;16742.246598902835;17102.401415950382;36205.27589448249;36248.637513624526;37897.81051094727;38129.61870381261;38190;51961;52131.47868521266;53014;53271;53360.1995970053;8252.257296843072;8363.707270245512;8610.225079742853;8670.349723770616;8684.478931263891;11532.308061516336;11890.227135236182;12036.63890083299;12302.876971230531;12839.10126291188;10788.390037180465;10828.24202305831;10834.783304334027;11131.443427828739;11180.608678696532;10455;10539.57841686324;10798.244122911321;10802.621908233174;11139.610113645984;11233.438328083399;11341.639003319655;11427.314361138358;11528;11790.646280611596;8439;8577;8611.8708219378;8794.60424280896;8803.647854085764;10994.780104398027;11162.107031437628;11213.551457941918;11537.134714896249;11693.532258709556 07:30:48 INFO - PROCESS | 7072 | |3;mootools.html;1163.0869767232723;1503.9774403383951;1510.5770384292398;1677.1865645162095;1805.620819627878;7918.802029949247;8215.424920255584;8265.876011859827;8266.504009759412;8286.41995060346;8043.55760433176;8188.140245274235;8189.017317921857;8191.8771218431775;8208.261256486914;1985.3944546913185;2197.6154173019736;2257.413072601119;2273.386185729852;2295.1278514164596;2263.400198947272;2276.5788329159077;2281.954360912781;2283.54329134173;2285.5885940530698;2234.3632064861517;2288.199130304397;2289.9656505152434;2290.450291929933;2290.530441259538;1946.0561627610598;2221.278084622496;2289.496310811619;2291.873946932918;2293.977060229393;2167.1873047607146;2205.933821985327;2208.0615738311153;2212.7565967743535;2235.284708893155;8340.416170868042;8398.706045288385;8426;8448.197421244971;8457.746267611981;4903.803847846082;5014.222795466709;5029.019341228462;5033.899322013539;5059.848204553869;3347.4978753186974;3374.8312584370683;3401.727861771052;3430.9656903430896;3448.603410607762;1068.358984609236;1075.2204651627585;1083.1389045708681;1095.1786160379716;1104.9337039777638;11424.485898134604;11435.771284574344;11449.484773185226;11453.65639030822;11464.656060318204;4291.184674911757;4357.716748411343;4508.616767574793;4539.228331183706;4550.067236216568;9574.04259574037;9607.039296070478;9612.231021518402;9637.518124093767;9657.372270802376;4457.375967364572;5063.594912406998;5073.619478539051;5083.796648134107;5086.491350864884;4541.818327266872;4597.747123908217;4634.189016922025;4658.277966915133;4659.044895796354;3774.509313789245;3776.131489757371;3819.25524522721;3886.5724770275247;3915.7650540967634;1181.474243961446;1218.0803493362455;1223.4677915106956;1224.7489264700894;1231.1566576894857;925.9444433333887;951.5670369981642;968.8885778135464;975.3855071305175;1007.3250921882357;5442.564594832404;5508.228847961289;5652.802151924663;5670.149477578314;5766.04860198071;403.3888658682099;410.11415342859283;413.9960595555765;415.9542450330461;421.1660911395454;3753.305638456894;3784.6026167252594;3825.7513261637905;3851.7496362736333;3882.7864467453996;9781.364211326241;9995;10101;10242.180625549938;10329;9568;10093.949530252301;10183.981601839756;10214.540345684461;10219.540120694586;7711.0746710395115;7773.727919522903;7825;7858.0963189232825;7859.174786647434;5408.972955135199;5626.971865140648;5652.915206271991;5702.942970570241;5822.272215973004;9053.230475409664;9270.490123043028;9438.716838494856;9447.291453141179;9466.148046675833;9112.954435228046;9418.905810941802;9436.669716559887;9450.054994500495;9541.475218862752;7239.565626062453;7247.673854676657;7348.191698913009;7349.55902645843;7351.338379545867;7717.2668596483245;7741.109772376249;7812.3750099993;7964.721234756756;7969.521828690065;7035.613041282779;7152.499325047197;7204.423646108404;7345.742898998509;7368;6938.653067346713;7198.280171982759;7373.152087510005;7463.029806125169;7493.475456717977;6569.408753212234;6582.572132811352;6622.437092846969;6656.434203092791;6679.098321726699;4715.457722361835;4927.679700819435;4955.306257123933;4968.478309777422;5027.2207807789855;4903.77932993009;4972.5276098770555;4997.3253610762085;5072.59419246452;5073.492650734897 07:30:48 INFO - PROCESS | 7072 | |4;prototype.html;336.1611193471136;336.4952571143285;347.3643232883823;350.49353683926734;351.8487050568258;5435.456454354572;5490.121580547113;5491.560675145989;5514.531264842483;5526.949879522887;5187.221916712495;5375.193720941861;5382.761964748111;5393.865153371158;5404.297441332621;4156.937645935313;4305.655547556188;4329.242382583051;4332.0469496710675;4341.153475072362;4313.482382114135;4321.135772845428;4323.156984388045;4329.826806927735;4331.3719510670935;4043.5147782266167;4194.916101677964;4203.4115223868685;4219.704620676538;4292.1630282095;4202.075543380452;4220.978895105535;4225.218334608092;4228.154369126156;4234.407182994383;3707.9073023174365;3722.683571896392;3739.925201495982;3741.28915506053;3742.6257374262627;5147.665401748912;5235.345581802275;5237.607179461517;5260.736963151827;5299.920501192485;4820.855374338776;4834.250691142878;4857.417109946829;4867.099586576494;4873.805047798084;5739.971300143514;5742.081266997302;5743.425657434265;5744.712764361807;5751.4536119068625;3988.9202215955806;4086.1827634473225;4092.836286548564;4095.4675892133832;4100;5864.1203819427;5887.175795388649;5897.734601942923;5898.115282707586;5919.230500035011;4138.772367519755;4146.979265103655;4155.314373128461;4156.542780294165;4177.289860723684;4028.3756017817286;4186.413902053715;4191.245575796386;4198.244316023145;4253.595908388698;4785.066911952205;4826.348442960226;4859.611231101503;4862.07620552094;4864.17309057454;5737.270773996852;5743.770249189985;5763.654180749085;5787.102999035072;5841.883162336814;1371.8270878399026;1438.3024233246867;1467.4130347860942;1477.4902658582987;1484.9902066594602;973.4402718436927;992.4392718114242;994.4977786217913;1007.5919252702668;1012.8126296635146;5542.528885044736;5561.77752889888;5562.249096372019;5587.44125587438;5601.5238704709745;5840;5844.444777746107;5851.297844258716;5897.675627840425;5917.201177841022;5344.198370244417;5510.504054635022;5517.779288828402;5553.861153471114;5581.581381396411;3057.3426713256313;3116.65716771155;3121.453745594512;3131.091983324856;3137.8744850205735;5858.502027327725;6062.120992456069;6064.696765161724;6071.726772295257;6089.695515224221;5869.647821130746;5924.377940316291;5946.43508866657;5955.642661440241;5959.970200148971;6055.424734650202;6093.6039157454625;6099.200735782954;6105.938940610626;6113.388661133851;5727.878306323148;5817.76728930838;5835;5848.239728835224;5882.352941176553;5739.598228124159;5747.885042299047;5772.307323121252;5794.855128621818;5795.420457954339;5849.3858144894175;6031.215941927521;6063.969125248806;6072.119542666201;6084.969575152273;4158.2307273154565;4185.330347144442;4194.266003449323;4194.559571244975;4195.958040419679;5698.230738850202;5752.33848107473;5862.267216597926;5867.20792692981;5884.9705751470965;5572.359178694502;5815.41845815415;5815.854603634943;5824.155497452761;5838.153467747238;5730.5129064030025;5780.104083867007;5796.855078623068;5828.59199856006;5830.53355731549;5582.916256256078;5691.630044047124;5698.943010569841;5741.942580574308;5756.280464941882;5688.914666280092;5788.9131663024245;5796.0436527972415;5834.620749651259;5857.297124345106;5517.36550296721;5666.320041595035;5680.6591604503865;5714.371419143974;5728.455796699307 07:30:48 INFO - PROCESS | 7072 | |5;yui.html;834.3783881008648;835;846.1453931529154;848.7835601921513;865.4720620421543;13684.726305473885;14102.64743381416;14292.499762508314;14300.141991480505;14304.213268270241;13645.18128912266;13842;14007.579772606838;14037.438502459914;14074.859251407483;691.0808624529363;816.1593558634601;828.7306625346756;835.0730688935276;835.7325655790149;806.1092492795465;833.075286432063;835.6907944060675;836.8493671139192;837.3217693668148;859.4499520307008;869.2003356911625;869.326272139091;869.6695255802786;870.6473878079388;714.5855403865745;740.822202671355;862.4437237981498;865.9004214515348;866.2377108144824;546.0962107711744;623.4420193926411;640.3180612647516;641.8587910659647;642.4410762636489;14724.631884202874;14747.631309217248;14763.926180369137;14806.777898331533;14833.258337083103;14213.14721116726;14565.49020784278;14569.781453278209;14624.26878656063;14672.779908301383;11220.551177952872;11472.4837382318;11475.483603237873;11521.539138434453;11528.077753779677;3794.1273507093247;3835.271298453285;3857.209272099241;3930.9213815723524;3958.3666613342016;54219.45780542223;54541.454585454034;55547.72226138884;55651.44348556503;55762.44237557654;11101.44492775358;11107.888921110847;11200.719982000515;11269.887301126884;11294.322340659586;20095.799042009392;20101.19595216175;20117.798822011886;20122.39632811018;20155.39533813988;8153.388495862834;8323.750287491384;8588.957055214683;8635.784105397415;8654;4711.717296962193;4881.438634557071;4894.535019173244;4930.457649658535;5036.244563315458;3181.5068664357063;3289.309245058517;3291.5227292043;3295.8846440374473;3304.603447586305;598.4912824099567;604.4922265297083;607.4714997951722;615.0497481391261;627.2410383436003;701.7999870037015;720.5352547606869;770.8920751094852;771.9112302085219;798.2416704131099;8225.177482251727;8645.567721613894;8699.391042627081;8873.866891996626;8890.59992300348;656.7143292667705;664.2593508238376;726.3027493606197;740.6296851574212;760.9619519024027;4132.028973191298;4147.730397524151;4201.957980420218;4245.299525578245;4313.827446902152;59623.70188149118;60565.394346056855;61260.387396125465;61410.402543643926;61497.692511537156;53765.1935220972;53946;54544.72727636337;55063;55576;48520;48946.510534894194;49473.75263123733;49735.75132124316;50044;8107.432479726598;8276.462029968034;8277.875831862648;8309.584520774059;8371.58197028343;32769.50845737364;32970.867767563;33543.664563354054;33969.830150849084;34414.311713765084;41300.793496032325;43029.56970430256;45308;45348.54651453575;45502.77248613736;11600.825987610362;11766.88233117658;11836.526538938346;11859.34773587461;12008.63974080779;12457.439415226518;12570.87429125697;12640.051996100145;13107.67230819199;13216.405261763051;11646.324790573897;11809.468573914366;11943.522259109886;12060.216085954386;12405.503779849067;11174.608888688857;11711.590094346657;11804.055675545764;11838;12327.445264963277;11465.369404682822;11493.367864767519;11640.825387619361;11662.358570278717;11745.706357341134;9440.150386465251;9489.051094890456;9513.66702165421;9640.517974101127;9682.9031709682;9938.602455901972;10008.549615267477;10097.091261786474;10248;10251.94874025655 07:30:48 INFO - PROCESS | 7072 | __end_tp_report 07:30:48 INFO - PROCESS | 7072 | __start_cc_report 07:30:48 INFO - PROCESS | 7072 | _x_x_mozilla_cycle_collect,803 07:30:48 INFO - PROCESS | 7072 | __end_cc_report 07:30:48 INFO - PROCESS | 7072 | __startTimestamp1460730648932__endTimestamp 07:30:48 INFO - PROCESS | 7072 | 07:30:48 INFO - PROCESS | 7072 | ------- Summary: start ------- 07:30:48 INFO - PROCESS | 7072 | Number of tests: 6 07:30:48 INFO - PROCESS | 7072 | 07:30:48 INFO - PROCESS | 7072 | [#0] dojo.html Cycles:165 Average:5140.03 Median:5353.79 stddev:582.01 (10.9%) stddev-sans-first:558.79 07:30:48 INFO - PROCESS | 7072 | Values: 2988.6 3050.0 3102.4 3107.2 3134.2 5025.4 5145.2 5153.0 5191.3 5210.8 5138.2 5146.6 5161.1 5213.9 5269.7 4621.9 4662.0 4767.8 4780.8 4792.1 4668.4 4733.5 4762.3 4785.7 4801.0 4589.3 4645.3 4647.3 4647.7 4707.4 4737.8 4740.2 4746.6 4756.0 4779.6 4598.9 4630.8 4725.0 4736.9 4740.5 5098.7 5116.8 5119.2 5128.4 5172.8 5481.0 5508.6 5511.5 5554.0 5554.0 5386.6 5537.9 5584.0 5647.5 5662.3 5146.8 5187.3 5194.6 5196.6 5201.0 5645.4 5669.7 5679.7 5681.5 5682.5 5353.4 5493.4 5535.3 5573.3 5583.6 5501.5 5503.3 5504.8 5507.0 5509.3 5422.1 5473.2 5485.0 5491.2 5532.9 5517.6 5576.0 5578.8 5583.7 5621.9 4145.7 4153.8 4157.3 4157.7 4194.9 3621.4 3740.7 3743.3 3768.8 3789.6 5155.8 5184.2 5185.6 5207.4 5225.5 5473.8 5476.1 5483.6 5492.3 5514.3 5074.7 5109.4 5171.9 5273.5 5346.4 4760.0 4782.6 4783.2 4791.1 4820.0 5736.7 5739.2 5740.3 5741.2 5744.7 5359.4 5488.9 5540.5 5568.1 5624.0 5745.0 5752.5 5762.8 5769.4 5772.9 5468.5 5469.6 5469.9 5470.3 5472.7 5412.4 5514.1 5578.9 5588.0 5620.8 5339.9 5351.9 5353.8 5356.2 5360.7 5213.0 5367.7 5373.4 5380.1 5421.8 5350.3 5396.4 5418.7 5451.5 5466.4 5467.6 5470.2 5470.6 5473.2 5479.6 5224.9 5342.1 5366.4 5367.7 5368.9 07:30:48 INFO - PROCESS | 7072 | 07:30:48 INFO - PROCESS | 7072 | [#1] ext.html Cycles:180 Average:49386.46 Median:21843.22 stddev:86662.14 (396.7%) stddev-sans-first:86827.84 07:30:48 INFO - PROCESS | 7072 | Values: 599.1 640.7 652.5 657.7 681.7 30137.2 37275.3 38011.2 38295.4 38467.0 40376.8 40934.4 41011.4 41025.2 41075.0 8454.4 8647.7 8651.4 8654.0 8654.7 8551.5 8632.1 8633.9 8634.1 8643.4 8863.5 8917.1 8961.8 8962.0 8971.0 8822.3 8913.8 8921.0 8927.5 8931.9 8686.4 8793.3 8800.0 8802.1 8808.1 40091.4 40567.8 40586.6 40590.6 40612.4 3484.2 3627.0 3772.2 3983.4 4254.0 28230.6 28343.9 28385.0 28521.9 31259.5 4333.8 4364.8 4442.2 4485.1 4574.7 301993.0 303501.0 304845.0 304953.0 305750.0 55715.4 56682.0 56820.4 56967.9 57053.4 58422.1 58944.7 58981.4 59155.7 59198.0 16924.9 17042.4 17102.7 17126.0 17130.7 12325.7 12340.9 12375.3 12377.1 12389.1 15146.8 16552.9 16768.7 16782.6 16791.7 5201.4 6118.7 6201.2 6310.3 6355.2 963.9 1068.1 1125.2 1166.8 1188.9 29596.7 29783.6 29868.7 30087.2 30191.0 1121.4 1167.9 1169.1 1171.2 1205.6 17022.9 17200.2 17207.0 17229.2 17251.4 402496.0 405033.0 406956.0 408248.0 408878.0 57137.0 57633.0 57652.7 57682.7 57743.1 1281.7 1386.5 1435.6 1440.3 1444.2 28178.7 29109.6 29234.7 29437.6 29904.6 40348.8 40810.0 40821.2 40827.8 40989.4 256766.0 263027.0 263385.0 263459.0 264956.0 27242.2 34947.8 42515.8 44084.6 45074.1 41859.4 42265.2 42311.0 42562.0 46114.3 38407.8 39051.4 39216.4 39548.8 40358.6 37271.0 39636.8 39703.0 40482.6 41337.4 37515.4 37530.4 38097.8 38117.8 38259.0 31438.2 32746.3 32977.7 33126.8 35291.5 27537.9 28026.2 28095.3 28115.3 28271.0 07:30:48 INFO - PROCESS | 7072 | 07:30:48 INFO - PROCESS | 7072 | [#2] jquery.html Cycles:180 Average:27074.94 Median:2026.07 stddev:77094.19 (3805.1%) stddev-sans-first:77284.40 07:30:48 INFO - PROCESS | 7072 | Values: 378.9 387.2 391.6 392.0 406.8 14257.1 15297.5 17446.3 18232.0 18233.2 17008.8 17334.3 17392.0 17514.8 18393.9 5047.5 5181.7 5181.9 5213.1 5216.0 3797.2 5172.8 5231.7 5233.5 5531.4 5485.3 5497.7 5528.8 5532.2 5534.5 5278.7 5450.3 6013.1 6013.7 6027.0 5323.4 5326.1 5328.1 5337.8 5345.7 12515.1 12607.8 12608.9 12676.0 14995.9 2312.3 2322.9 2381.1 2409.9 2459.9 10102.7 10514.4 13305.5 13595.9 14450.7 1834.8 1854.3 1873.8 1901.1 1958.7 54127.2 56288.0 71024.6 74739.0 76700.6 10640.8 10697.6 10809.8 10868.8 10917.9 15485.0 15489.7 15501.0 15554.1 15556.5 8116.2 8171.1 8240.1 8247.3 8265.6 7735.9 7752.3 7766.1 7787.0 7839.1 4721.8 4743.3 4765.9 4801.4 4818.5 1929.7 1999.3 2009.7 2018.6 2033.6 890.9 964.7 997.4 1053.0 1090.6 17617.3 18856.3 19155.2 19261.7 19336.9 1031.0 1058.1 1079.3 1089.3 1092.1 10207.2 10753.2 10832.8 10860.0 10983.8 429206.0 451142.0 480568.0 488625.0 491825.0 84389.6 86206.6 86830.6 87052.1 87804.0 1038.7 1048.0 1055.6 1076.8 1082.4 16311.4 16481.4 16711.6 16742.2 17102.4 36205.3 36248.6 37897.8 38129.6 38190.0 51961.0 52131.5 53014.0 53271.0 53360.2 8252.3 8363.7 8610.2 8670.3 8684.5 11532.3 11890.2 12036.6 12302.9 12839.1 10788.4 10828.2 10834.8 11131.4 11180.6 10455.0 10539.6 10798.2 10802.6 11139.6 11233.4 11341.6 11427.3 11528.0 11790.6 8439.0 8577.0 8611.9 8794.6 8803.6 10994.8 11162.1 11213.6 11537.1 11693.5 07:30:48 INFO - PROCESS | 7072 | 07:30:48 INFO - PROCESS | 7072 | [#3] mootools.html Cycles:180 Average:5456.60 Median:4984.93 stddev:3059.43 (61.4%) stddev-sans-first:3050.99 07:30:48 INFO - PROCESS | 7072 | Values: 1163.1 1504.0 1510.6 1677.2 1805.6 7918.8 8215.4 8265.9 8266.5 8286.4 8043.6 8188.1 8189.0 8191.9 8208.3 1985.4 2197.6 2257.4 2273.4 2295.1 2263.4 2276.6 2282.0 2283.5 2285.6 2234.4 2288.2 2290.0 2290.5 2290.5 1946.1 2221.3 2289.5 2291.9 2294.0 2167.2 2205.9 2208.1 2212.8 2235.3 8340.4 8398.7 8426.0 8448.2 8457.7 4903.8 5014.2 5029.0 5033.9 5059.8 3347.5 3374.8 3401.7 3431.0 3448.6 1068.4 1075.2 1083.1 1095.2 1104.9 11424.5 11435.8 11449.5 11453.7 11464.7 4291.2 4357.7 4508.6 4539.2 4550.1 9574.0 9607.0 9612.2 9637.5 9657.4 4457.4 5063.6 5073.6 5083.8 5086.5 4541.8 4597.7 4634.2 4658.3 4659.0 3774.5 3776.1 3819.3 3886.6 3915.8 1181.5 1218.1 1223.5 1224.7 1231.2 925.9 951.6 968.9 975.4 1007.3 5442.6 5508.2 5652.8 5670.1 5766.0 403.4 410.1 414.0 416.0 421.2 3753.3 3784.6 3825.8 3851.7 3882.8 9781.4 9995.0 10101.0 10242.2 10329.0 9568.0 10093.9 10184.0 10214.5 10219.5 7711.1 7773.7 7825.0 7858.1 7859.2 5409.0 5627.0 5652.9 5702.9 5822.3 9053.2 9270.5 9438.7 9447.3 9466.1 9113.0 9418.9 9436.7 9450.1 9541.5 7239.6 7247.7 7348.2 7349.6 7351.3 7717.3 7741.1 7812.4 7964.7 7969.5 7035.6 7152.5 7204.4 7345.7 7368.0 6938.7 7198.3 7373.2 7463.0 7493.5 6569.4 6582.6 6622.4 6656.4 6679.1 4715.5 4927.7 4955.3 4968.5 5027.2 4903.8 4972.5 4997.3 5072.6 5073.5 07:30:48 INFO - PROCESS | 7072 | 07:30:48 INFO - PROCESS | 7072 | [#4] prototype.html Cycles:180 Average:4821.22 Median:5534.74 stddev:1420.13 (25.7%) stddev-sans-first:1383.64 07:30:48 INFO - PROCESS | 7072 | Values: 336.2 336.5 347.4 350.5 351.8 5435.5 5490.1 5491.6 5514.5 5526.9 5187.2 5375.2 5382.8 5393.9 5404.3 4156.9 4305.7 4329.2 4332.0 4341.2 4313.5 4321.1 4323.2 4329.8 4331.4 4043.5 4194.9 4203.4 4219.7 4292.2 4202.1 4221.0 4225.2 4228.2 4234.4 3707.9 3722.7 3739.9 3741.3 3742.6 5147.7 5235.3 5237.6 5260.7 5299.9 4820.9 4834.3 4857.4 4867.1 4873.8 5740.0 5742.1 5743.4 5744.7 5751.5 3988.9 4086.2 4092.8 4095.5 4100.0 5864.1 5887.2 5897.7 5898.1 5919.2 4138.8 4147.0 4155.3 4156.5 4177.3 4028.4 4186.4 4191.2 4198.2 4253.6 4785.1 4826.3 4859.6 4862.1 4864.2 5737.3 5743.8 5763.7 5787.1 5841.9 1371.8 1438.3 1467.4 1477.5 1485.0 973.4 992.4 994.5 1007.6 1012.8 5542.5 5561.8 5562.2 5587.4 5601.5 5840.0 5844.4 5851.3 5897.7 5917.2 5344.2 5510.5 5517.8 5553.9 5581.6 3057.3 3116.7 3121.5 3131.1 3137.9 5858.5 6062.1 6064.7 6071.7 6089.7 5869.6 5924.4 5946.4 5955.6 5960.0 6055.4 6093.6 6099.2 6105.9 6113.4 5727.9 5817.8 5835.0 5848.2 5882.4 5739.6 5747.9 5772.3 5794.9 5795.4 5849.4 6031.2 6064.0 6072.1 6085.0 4158.2 4185.3 4194.3 4194.6 4196.0 5698.2 5752.3 5862.3 5867.2 5885.0 5572.4 5815.4 5815.9 5824.2 5838.2 5730.5 5780.1 5796.9 5828.6 5830.5 5582.9 5691.6 5698.9 5741.9 5756.3 5688.9 5788.9 5796.0 5834.6 5857.3 5517.4 5666.3 5680.7 5714.4 5728.5 07:30:48 INFO - PROCESS | 7072 | 07:30:48 INFO - PROCESS | 7072 | [#5] yui.html Cycles:180 Average:14605.86 Median:26700.72 stddev:16912.47 (63.3%) stddev-sans-first:16928.29 07:30:48 INFO - PROCESS | 7072 | Values: 834.4 835.0 846.1 848.8 865.5 13684.7 14102.6 14292.5 14300.1 14304.2 13645.2 13842.0 14007.6 14037.4 14074.9 691.1 816.2 828.7 835.1 835.7 806.1 833.1 835.7 836.8 837.3 859.4 869.2 869.3 869.7 870.6 714.6 740.8 862.4 865.9 866.2 546.1 623.4 640.3 641.9 642.4 14724.6 14747.6 14763.9 14806.8 14833.3 14213.1 14565.5 14569.8 14624.3 14672.8 11220.6 11472.5 11475.5 11521.5 11528.1 3794.1 3835.3 3857.2 3930.9 3958.4 54219.5 54541.5 55547.7 55651.4 55762.4 11101.4 11107.9 11200.7 11269.9 11294.3 20095.8 20101.2 20117.8 20122.4 20155.4 8153.4 8323.8 8589.0 8635.8 8654.0 4711.7 4881.4 4894.5 4930.5 5036.2 3181.5 3289.3 3291.5 3295.9 3304.6 598.5 604.5 607.5 615.0 627.2 701.8 720.5 770.9 771.9 798.2 8225.2 8645.6 8699.4 8873.9 8890.6 656.7 664.3 726.3 740.6 761.0 4132.0 4147.7 4202.0 4245.3 4313.8 59623.7 60565.4 61260.4 61410.4 61497.7 53765.2 53946.0 54544.7 55063.0 55576.0 48520.0 48946.5 49473.8 49735.8 50044.0 8107.4 8276.5 8277.9 8309.6 8371.6 32769.5 32970.9 33543.7 33969.8 34414.3 41300.8 43029.6 45308.0 45348.5 45502.8 11600.8 11766.9 11836.5 11859.3 12008.6 12457.4 12570.9 12640.1 13107.7 13216.4 11646.3 11809.5 11943.5 12060.2 12405.5 11174.6 11711.6 11804.1 11838.0 12327.4 11465.4 11493.4 11640.8 11662.4 11745.7 9440.2 9489.1 9513.7 9640.5 9682.9 9938.6 10008.5 10097.1 10248.0 10251.9 07:30:48 INFO - PROCESS | 7072 | -------- Summary: end -------- 07:30:48 INFO - PROCESS | 7072 | 07:30:49 INFO - TEST-INFO | 7072: exit 0 07:30:49 INFO - TEST-OK | dromaeo_css | took 1111219ms 07:30:49 INFO - TEST-START | kraken 07:30:49 INFO - operating with platform_type : linux_ 07:30:49 INFO - Initialising browser for kraken test... 07:30:49 INFO - TEST-INFO | started process 7272 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp5o2usH/profile http://localhost:55026/getInfo.html) 07:30:53 INFO - PROCESS | 7272 | __metrics Screen width/height:1600/1200 07:30:53 INFO - PROCESS | 7272 | colorDepth:24 07:30:53 INFO - PROCESS | 7272 | Browser inner width/height: 1024/697 07:30:53 INFO - PROCESS | 7272 | __metrics 07:30:54 ERROR - PROCESS | 7272 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 07:30:55 INFO - TEST-INFO | 7272: exit 0 07:30:55 INFO - Browser initialized. 07:30:55 INFO - Running cycle 1/1 for kraken test... 07:30:55 INFO - TEST-INFO | started process 7354 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp5o2usH/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:31:06 INFO - PROCESS | 7354 | RSS: Main: 153808896 07:31:06 INFO - PROCESS | 7354 | 07:31:09 INFO - PROCESS | 7354 | Cycle 1(1): loaded http://localhost:55026/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:55026/tests/kraken/driver.html?testName=audio-beat-detection) 07:31:10 INFO - PROCESS | 7354 | RSS: Main: 208351232 07:31:10 INFO - PROCESS | 7354 | 07:31:12 INFO - PROCESS | 7354 | Cycle 1(1): loaded http://localhost:55026/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:55026/tests/kraken/driver.html?testName=audio-dft) 07:31:13 INFO - PROCESS | 7354 | RSS: Main: 194809856 07:31:13 INFO - PROCESS | 7354 | 07:31:16 INFO - PROCESS | 7354 | Cycle 1(1): loaded http://localhost:55026/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:55026/tests/kraken/driver.html?testName=audio-fft) 07:31:17 INFO - PROCESS | 7354 | RSS: Main: 265195520 07:31:17 INFO - PROCESS | 7354 | 07:31:19 INFO - PROCESS | 7354 | Cycle 1(1): loaded http://localhost:55026/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:55026/tests/kraken/driver.html?testName=audio-oscillator) 07:31:19 INFO - PROCESS | 7354 | RSS: Main: 172335104 07:31:19 INFO - PROCESS | 7354 | 07:31:22 INFO - PROCESS | 7354 | Cycle 1(1): loaded http://localhost:55026/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:55026/tests/kraken/driver.html?testName=imaging-gaussian-blur) 07:31:22 INFO - PROCESS | 7354 | RSS: Main: 177602560 07:31:22 INFO - PROCESS | 7354 | 07:31:25 INFO - PROCESS | 7354 | Cycle 1(1): loaded http://localhost:55026/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:55026/tests/kraken/driver.html?testName=imaging-darkroom) 07:31:26 INFO - PROCESS | 7354 | RSS: Main: 213397504 07:31:26 INFO - PROCESS | 7354 | 07:31:29 INFO - PROCESS | 7354 | Cycle 1(1): loaded http://localhost:55026/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:55026/tests/kraken/driver.html?testName=imaging-desaturate) 07:31:30 INFO - PROCESS | 7354 | RSS: Main: 214659072 07:31:30 INFO - PROCESS | 7354 | 07:31:33 INFO - PROCESS | 7354 | Cycle 1(1): loaded http://localhost:55026/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:55026/tests/kraken/driver.html?testName=json-parse-financial) 07:31:33 INFO - PROCESS | 7354 | RSS: Main: 214609920 07:31:33 INFO - PROCESS | 7354 | 07:31:35 INFO - PROCESS | 7354 | Cycle 1(1): loaded http://localhost:55026/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:55026/tests/kraken/driver.html?testName=json-stringify-tinderbox) 07:31:35 INFO - PROCESS | 7354 | RSS: Main: 199602176 07:31:35 INFO - PROCESS | 7354 | 07:31:37 INFO - PROCESS | 7354 | Cycle 1(1): loaded http://localhost:55026/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:55026/tests/kraken/driver.html?testName=stanford-crypto-aes) 07:31:38 INFO - PROCESS | 7354 | RSS: Main: 205643776 07:31:38 INFO - PROCESS | 7354 | 07:31:40 INFO - PROCESS | 7354 | Cycle 1(1): loaded http://localhost:55026/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:55026/tests/kraken/driver.html?testName=stanford-crypto-ccm) 07:31:40 INFO - PROCESS | 7354 | RSS: Main: 212459520 07:31:40 INFO - PROCESS | 7354 | 07:31:43 INFO - PROCESS | 7354 | Cycle 1(1): loaded http://localhost:55026/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:55026/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 07:31:44 INFO - PROCESS | 7354 | RSS: Main: 223027200 07:31:44 INFO - PROCESS | 7354 | 07:31:46 INFO - PROCESS | 7354 | Cycle 1(1): loaded http://localhost:55026/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:55026/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 07:31:47 INFO - PROCESS | 7354 | RSS: Main: 214642688 07:31:47 INFO - PROCESS | 7354 | 07:31:49 INFO - PROCESS | 7354 | Cycle 1(1): loaded http://localhost:55026/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:55026/tests/kraken/driver.html?testName=ai-astar) 07:31:49 INFO - PROCESS | 7354 | RSS: Main: 277966848 07:31:49 INFO - PROCESS | 7354 | 07:31:49 INFO - PROCESS | 7354 | __start_tp_report 07:31:49 INFO - PROCESS | 7354 | _x_x_mozilla_page_load 07:31:49 INFO - PROCESS | 7354 | _x_x_mozilla_page_load_details 07:31:49 INFO - PROCESS | 7354 | |i|pagename|runs| 07:31:49 INFO - PROCESS | 7354 | |0;ai-astar;111;112;107;111;111;114;100;111;113;111 07:31:49 INFO - PROCESS | 7354 | |1;audio-beat-detection;151;128;153;189;137;157;160;128;187;133 07:31:49 INFO - PROCESS | 7354 | |2;audio-dft;159;161;162;160;161;163;162;162;160;160 07:31:49 INFO - PROCESS | 7354 | |3;audio-fft;73;73;131;118;77;76;76;124;103;76 07:31:49 INFO - PROCESS | 7354 | |4;audio-oscillator;93;93;145;93;92;98;153;93;93;143 07:31:49 INFO - PROCESS | 7354 | |5;imaging-gaussian-blur;117;116;118;117;117;116;116;117;117;116 07:31:49 INFO - PROCESS | 7354 | |6;imaging-darkroom;145;146;145;146;145;145;145;145;145;146 07:31:49 INFO - PROCESS | 7354 | |7;imaging-desaturate;95;95;95;95;94;95;95;95;95;94 07:31:49 INFO - PROCESS | 7354 | |8;json-parse-financial;56;57;58;57;57;56;57;77;55;53 07:31:49 INFO - PROCESS | 7354 | |9;json-stringify-tinderbox;61;61;62;61;62;61;64;61;61;67 07:31:49 INFO - PROCESS | 7354 | |10;stanford-crypto-aes;76;77;75;78;77;77;77;77;78;77 07:31:49 INFO - PROCESS | 7354 | |11;stanford-crypto-ccm;124;125;127;120;124;124;121;122;159;123 07:31:49 INFO - PROCESS | 7354 | |12;stanford-crypto-pbkdf2;170;159;161;169;168;163;157;159;159;169 07:31:49 INFO - PROCESS | 7354 | |13;stanford-crypto-sha256-iterative;67;69;69;68;68;67;66;67;69;66 07:31:49 INFO - PROCESS | 7354 | __end_tp_report 07:31:49 INFO - PROCESS | 7354 | __start_cc_report 07:31:49 INFO - PROCESS | 7354 | _x_x_mozilla_cycle_collect,1649 07:31:49 INFO - PROCESS | 7354 | __end_cc_report 07:31:49 INFO - PROCESS | 7354 | __startTimestamp1460730709297__endTimestamp 07:31:49 INFO - PROCESS | 7354 | 07:31:49 INFO - PROCESS | 7354 | ------- Summary: start ------- 07:31:49 INFO - PROCESS | 7354 | Number of tests: 14 07:31:49 INFO - PROCESS | 7354 | 07:31:49 INFO - PROCESS | 7354 | [#0] ai-astar Cycles:10 Average:110.10 Median:111.00 stddev:3.98 (3.6%) stddev-sans-first:4.21 07:31:49 INFO - PROCESS | 7354 | Values: 111.0 112.0 107.0 111.0 111.0 114.0 100.0 111.0 113.0 111.0 07:31:49 INFO - PROCESS | 7354 | 07:31:49 INFO - PROCESS | 7354 | [#1] audio-beat-detection Cycles:10 Average:152.30 Median:155.00 stddev:22.17 (14.3%) stddev-sans-first:23.51 07:31:49 INFO - PROCESS | 7354 | Values: 151.0 128.0 153.0 189.0 137.0 157.0 160.0 128.0 187.0 133.0 07:31:49 INFO - PROCESS | 7354 | 07:31:49 INFO - PROCESS | 7354 | [#2] audio-dft Cycles:10 Average:161.00 Median:161.50 stddev:1.25 (0.8%) stddev-sans-first:1.09 07:31:49 INFO - PROCESS | 7354 | Values: 159.0 161.0 162.0 160.0 161.0 163.0 162.0 162.0 160.0 160.0 07:31:49 INFO - PROCESS | 7354 | 07:31:49 INFO - PROCESS | 7354 | [#3] audio-fft Cycles:10 Average:92.70 Median:74.50 stddev:23.69 (31.8%) stddev-sans-first:24.03 07:31:49 INFO - PROCESS | 7354 | Values: 73.0 73.0 131.0 118.0 77.0 76.0 76.0 124.0 103.0 76.0 07:31:49 INFO - PROCESS | 7354 | 07:31:49 INFO - PROCESS | 7354 | [#4] audio-oscillator Cycles:10 Average:109.60 Median:93.00 stddev:25.98 (27.9%) stddev-sans-first:26.85 07:31:49 INFO - PROCESS | 7354 | Values: 93.0 93.0 145.0 93.0 92.0 98.0 153.0 93.0 93.0 143.0 07:31:49 INFO - PROCESS | 7354 | 07:31:49 INFO - PROCESS | 7354 | [#5] imaging-gaussian-blur Cycles:10 Average:116.70 Median:117.00 stddev:0.67 (0.6%) stddev-sans-first:0.71 07:31:49 INFO - PROCESS | 7354 | Values: 117.0 116.0 118.0 117.0 117.0 116.0 116.0 117.0 117.0 116.0 07:31:49 INFO - PROCESS | 7354 | 07:31:49 INFO - PROCESS | 7354 | [#6] imaging-darkroom Cycles:10 Average:145.30 Median:145.00 stddev:0.48 (0.3%) stddev-sans-first:0.50 07:31:49 INFO - PROCESS | 7354 | Values: 145.0 146.0 145.0 146.0 145.0 145.0 145.0 145.0 145.0 146.0 07:31:49 INFO - PROCESS | 7354 | 07:31:49 INFO - PROCESS | 7354 | [#7] imaging-desaturate Cycles:10 Average:94.80 Median:95.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 07:31:49 INFO - PROCESS | 7354 | Values: 95.0 95.0 95.0 95.0 94.0 95.0 95.0 95.0 95.0 94.0 07:31:49 INFO - PROCESS | 7354 | 07:31:49 INFO - PROCESS | 7354 | [#8] json-parse-financial Cycles:10 Average:58.30 Median:57.00 stddev:6.72 (11.8%) stddev-sans-first:7.07 07:31:49 INFO - PROCESS | 7354 | Values: 56.0 57.0 58.0 57.0 57.0 56.0 57.0 77.0 55.0 53.0 07:31:49 INFO - PROCESS | 7354 | 07:31:49 INFO - PROCESS | 7354 | [#9] json-stringify-tinderbox Cycles:10 Average:62.10 Median:61.50 stddev:1.97 (3.2%) stddev-sans-first:2.05 07:31:49 INFO - PROCESS | 7354 | Values: 61.0 61.0 62.0 61.0 62.0 61.0 64.0 61.0 61.0 67.0 07:31:49 INFO - PROCESS | 7354 | 07:31:49 INFO - PROCESS | 7354 | [#10] stanford-crypto-aes Cycles:10 Average:76.90 Median:77.00 stddev:0.88 (1.1%) stddev-sans-first:0.87 07:31:49 INFO - PROCESS | 7354 | Values: 76.0 77.0 75.0 78.0 77.0 77.0 77.0 77.0 78.0 77.0 07:31:49 INFO - PROCESS | 7354 | 07:31:49 INFO - PROCESS | 7354 | [#11] stanford-crypto-ccm Cycles:10 Average:126.90 Median:124.00 stddev:11.45 (9.2%) stddev-sans-first:12.10 07:31:49 INFO - PROCESS | 7354 | Values: 124.0 125.0 127.0 120.0 124.0 124.0 121.0 122.0 159.0 123.0 07:31:49 INFO - PROCESS | 7354 | 07:31:49 INFO - PROCESS | 7354 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:163.40 Median:165.50 stddev:5.08 (3.1%) stddev-sans-first:4.80 07:31:49 INFO - PROCESS | 7354 | Values: 170.0 159.0 161.0 169.0 168.0 163.0 157.0 159.0 159.0 169.0 07:31:49 INFO - PROCESS | 7354 | 07:31:49 INFO - PROCESS | 7354 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.60 Median:68.00 stddev:1.17 (1.7%) stddev-sans-first:1.22 07:31:49 INFO - PROCESS | 7354 | Values: 67.0 69.0 69.0 68.0 68.0 67.0 66.0 67.0 69.0 66.0 07:31:49 INFO - PROCESS | 7354 | -------- Summary: end -------- 07:31:49 INFO - PROCESS | 7354 | 07:31:50 INFO - TEST-INFO | 7354: exit 0 07:31:50 INFO - TEST-OK | kraken | took 60585ms 07:31:50 INFO - SUITE-END | took 1171s 07:31:50 INFO - Completed test suite (00:19:32) 07:31:50 INFO - javascript benchmark 07:31:50 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2988.6264216972877, 3050.0, 3102.364015376848, 3107.176598201477, 3134.153778479811, 5025.422076461208, 5145.202493613491, 5153.046686363025, 5191.325127733389, 5210.791568337267, 5138.203578445337, 5146.588272938166, 5161.071007218699, 5213.8957220855655, 5269.683818970864, 4621.9306710399205, 4661.976690116545, 4767.809287628491, 4780.760961951906, 4792.089502994438, 4668.393108895839, 4733.502982186872, 4762.309465127554, 4785.688930219542, 4800.975995120019, 4589.2886602576655, 4645.256758918556, 4647.34937108805, 4647.67466277359, 4707.435107787071, 4737.834175803865, 4740.170470167742, 4746.620270378361, 4756.025014871978, 4779.569838714532, 4598.885027874297, 4630.791614377361, 4724.952750472486, 4736.8578942631775, 4740.454847692525, 5098.745062746848, 5116.795328186868, 5119.206522988943, 5128.410232823198, 5172.793088276502, 5481.0, 5508.586855985777, 5511.53151982082, 5554.0, 5554.0, 5386.622936394454, 5537.861553461155, 5584.0, 5647.519960803336, 5662.292213473316, 5146.768395422215, 5187.299714538527, 5194.558462530652, 5196.58427325813, 5201.037808005493, 5645.435456454404, 5669.659820410789, 5679.687617181012, 5681.460261275172, 5682.54539636828, 5353.357597088374, 5493.423190565013, 5535.25274087993, 5573.275474188411, 5583.637063590853, 5501.477359650827, 5503.284573005483, 5504.80733174337, 5507.0, 5509.283793106951, 5422.132458806651, 5473.151661492475, 5485.0, 5491.203775452617, 5532.944670553324, 5517.5585953123655, 5576.0, 5578.776848925998, 5583.720813959286, 5621.8594535136945, 4145.730527515701, 4153.7507749535125, 4157.293260145782, 4157.708960372805, 4194.874153775391, 3621.3662609043313, 3740.6633402993316, 3743.307488114653, 3768.7550309229814, 3789.6399842014966, 5155.845324640267, 5184.170532714747, 5185.559227465632, 5207.427183009866, 5225.503577160163, 5473.781048758085, 5476.123820188751, 5483.561315094783, 5492.313460817398, 5514.255575497256, 5074.67014644047, 5109.380129525215, 5171.896562068738, 5273.5253827154975, 5346.358436987509, 4760.047990401933, 4782.569568738761, 4783.234682450791, 4791.137595232822, 4819.95180048202, 5736.6844823534275, 5739.196512488255, 5740.253767010262, 5741.167530708024, 5744.684042377626, 5359.437259087739, 5488.862778430571, 5540.501354878081, 5568.081266591129, 5623.971880140573, 5744.994625940527, 5752.511036561939, 5762.7694892203845, 5769.423057694197, 5772.942270577409, 5468.4531546845, 5469.562435005269, 5469.890602188014, 5470.316210473691, 5472.726363681721, 5412.377576578744, 5514.145307477347, 5578.86052848682, 5588.0, 5620.803271885465, 5339.919901201562, 5351.946480535301, 5353.78584856617, 5356.223347614497, 5360.70516121617, 5213.0, 5367.651102678314, 5373.435789242073, 5380.058489764354, 5421.810236641699, 5350.3312085989255, 5396.4333744957785, 5418.674879507243, 5451.509364157245, 5466.3986961435, 5467.562594992471, 5470.17947307907, 5470.56235501151, 5473.151661492475, 5479.561635069264, 5224.921626175535, 5342.118550439134, 5366.409694933476, 5367.704776237344, 5368.946310536845], "value": 5101.312876353933, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [599.1342510072947, 640.6828619833183, 652.4943169043992, 657.684311530465, 681.6966449929783, 30137.24656883579, 37275.25449491012, 38011.23977520448, 38295.42556861649, 38467.03832404188, 40376.79811600945, 40934.38598421026, 41011.38482922759, 41025.17949641013, 41075.0, 8454.408191426588, 8647.69733059343, 8651.394402391836, 8653.95673021634, 8654.653813847439, 8551.486910785341, 8632.050474447806, 8633.870491942625, 8634.050254472004, 8643.438176518537, 8863.468191908474, 8917.108289171096, 8961.820763584725, 8962.0, 8971.0, 8822.2942164627, 8913.777155571097, 8920.955395223014, 8927.464352138828, 8931.910680893174, 8686.391952563323, 8793.252573531257, 8800.0, 8802.075782042857, 8808.119188081204, 40091.39862902059, 40567.7971610143, 40586.579469718716, 40590.59409405898, 40612.39081413781, 3484.216051388443, 3626.9637303627155, 3772.1512659651635, 3983.4423180754716, 4254.0, 28230.576541351897, 28343.85828070867, 28385.0, 28521.857390712914, 31259.531107033414, 4333.761643109628, 4364.781760911942, 4442.2226110430865, 4485.147821913859, 4574.702644328108, 301993.0, 303501.0, 304845.0, 304952.9999999978, 305750.0, 55715.44284557102, 56682.0, 56820.431795681514, 56967.86064278691, 57053.42946570481, 58422.12366814501, 58944.705276473345, 58981.41018589845, 59155.70422147862, 59198.0, 16924.915375423043, 17042.403515877133, 17102.657946840995, 17126.0, 17130.657386852443, 12325.691857703629, 12340.876591233973, 12375.257484550775, 12377.133600648049, 12389.070819688559, 15146.772798408032, 16552.924059936067, 16768.6646267074, 16782.58043548921, 16791.748123778154, 5201.36157110509, 6118.724657390429, 6201.224846894138, 6310.305866354697, 6355.173827402408, 963.9348519885566, 1068.0974576482859, 1125.1785997777463, 1166.8424762657103, 1188.928664280146, 29596.704032959395, 29783.553246701318, 29868.70131298703, 30087.247818804706, 30191.0, 1121.4280716834473, 1167.8656954450178, 1169.1465230381698, 1171.1801738782885, 1205.572021932219, 17022.914885425493, 17200.225989830487, 17207.0, 17229.22468488921, 17251.39620113315, 402496.0, 405033.0, 406956.0, 408248.0, 408878.0, 57137.0, 57633.0, 57652.71173644105, 57682.7115864418, 57743.133852992236, 1281.6923938254752, 1386.4523513212225, 1435.5836807325968, 1440.2582669924998, 1444.2345556854884, 28178.71821281761, 29109.563356550094, 29234.707652924048, 29437.554052500356, 29904.551431728105, 40348.79825600853, 40810.0, 40821.1835763289, 40827.7958610205, 40989.38515922323, 256766.0, 263027.0, 263385.0, 263459.0, 264956.0, 27242.182734517995, 34947.825260873535, 42515.7874210627, 44084.559154408045, 45074.098518030114, 41859.35376604768, 42265.1546969065, 42311.0, 42562.0, 46114.308285375075, 38407.80796096114, 39051.41422878716, 39216.411753824286, 39548.802255988536, 40358.596414035484, 37271.0, 39636.80181599074, 39703.0, 40482.595174049064, 41337.379939300336, 37515.43726844045, 37530.437043444916, 38097.809510953375, 38117.80941095277, 38259.0, 31438.214044648154, 32746.34507309888, 32977.67022329746, 33126.834365828014, 35291.47062794112, 27537.86231068912, 28026.159215223575, 28095.297617559725, 28115.297117571405, 28271.0], "value": 19098.558735884766, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [378.9393697008479, 387.16111181721305, 391.5555844116926, 392.0297264270929, 406.82506522195456, 14257.073290236127, 15297.541073767805, 17446.302147914084, 18232.0, 18233.17950692217, 17008.82991170088, 17334.306627734906, 17392.043437610926, 17514.82485175148, 18393.90803045986, 5047.47001564836, 5181.689098654093, 5181.948180518203, 5213.061648903196, 5216.035033518792, 3797.221569578244, 5172.818951336704, 5231.712255825928, 5233.528982391584, 5531.3915469298545, 5485.286912701344, 5497.697626630534, 5528.806491772789, 5532.197831314477, 5534.501894829465, 5278.709670968115, 5450.345958484987, 6013.098035294697, 6013.729382177812, 6027.035674292092, 5323.3763702070855, 5326.067938110854, 5328.120860058086, 5337.8131765388025, 5345.732713364355, 12515.123941324111, 12607.810882836764, 12608.936955315165, 12676.0, 14995.875309351843, 2312.340982819905, 2322.9419264518524, 2381.071382160959, 2409.9397515062265, 2459.86470744109, 10102.747431314203, 10514.369137851676, 13305.534306299232, 13595.932020339835, 14450.712324149648, 1834.8348648621688, 1854.2582966813247, 1873.8032506586749, 1901.115981068796, 1958.6768183249746, 54127.18809217865, 56288.0, 71024.6448767758, 74739.0, 76700.61649691772, 10640.840387394195, 10697.572097116185, 10809.83785243222, 10868.782624347627, 10917.890821091847, 15485.0, 15489.690206195814, 15501.0, 15554.144522051396, 15556.45552405683, 8116.228958248957, 8171.10117887032, 8240.093589705128, 8247.257746802816, 8265.628046737911, 7735.883961740578, 7752.26353496417, 7766.145723970359, 7786.961065194638, 7839.137694853562, 4721.811127554859, 4743.312219728189, 4765.928511072337, 4801.375821143229, 4818.494058123846, 1929.7201905723591, 1999.3002449142684, 2009.728686627316, 2018.5676260106536, 2033.572949680554, 890.9242714369221, 964.7009427077628, 997.4065431068502, 1052.9789404211872, 1090.6455401994383, 17617.295308187786, 18856.34002809895, 19155.233790648217, 19261.711074333896, 19336.903315483614, 1030.99484502577, 1058.1481907064888, 1079.2768844873954, 1089.319175515303, 1092.1099304067159, 10207.234457415723, 10753.180788287758, 10832.837507437394, 10860.022597966063, 10983.835242471368, 429206.0, 451142.0, 480568.0, 488625.0, 491825.0, 84389.57805211058, 86206.56896715476, 86830.56584717036, 87052.1294787044, 87804.0, 1038.683201623512, 1047.9685609431729, 1055.5777688924338, 1076.8438576406377, 1082.4046774274118, 16311.364360854375, 16481.423150190167, 16711.582210444834, 16742.246598902835, 17102.401415950382, 36205.27589448249, 36248.637513624526, 37897.81051094727, 38129.61870381261, 38190.0, 51961.0, 52131.47868521266, 53014.0, 53271.0, 53360.1995970053, 8252.257296843072, 8363.707270245512, 8610.225079742853, 8670.349723770616, 8684.478931263891, 11532.308061516336, 11890.227135236182, 12036.63890083299, 12302.876971230531, 12839.10126291188, 10788.390037180465, 10828.24202305831, 10834.783304334027, 11131.443427828739, 11180.608678696532, 10455.0, 10539.57841686324, 10798.244122911321, 10802.621908233174, 11139.610113645984, 11233.438328083399, 11341.639003319655, 11427.314361138358, 11528.0, 11790.646280611596, 8439.0, 8577.0, 8611.8708219378, 8794.60424280896, 8803.647854085764, 10994.780104398027, 11162.107031437628, 11213.551457941918, 11537.134714896249, 11693.532258709556], "value": 8806.10762637378, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1163.0869767232723, 1503.9774403383951, 1510.5770384292398, 1677.1865645162095, 1805.620819627878, 7918.802029949247, 8215.424920255584, 8265.876011859827, 8266.504009759412, 8286.41995060346, 8043.55760433176, 8188.140245274235, 8189.017317921857, 8191.8771218431775, 8208.261256486914, 1985.3944546913185, 2197.6154173019736, 2257.413072601119, 2273.386185729852, 2295.1278514164596, 2263.400198947272, 2276.5788329159077, 2281.954360912781, 2283.54329134173, 2285.5885940530698, 2234.3632064861517, 2288.199130304397, 2289.9656505152434, 2290.450291929933, 2290.530441259538, 1946.0561627610598, 2221.278084622496, 2289.496310811619, 2291.873946932918, 2293.977060229393, 2167.1873047607146, 2205.933821985327, 2208.0615738311153, 2212.7565967743535, 2235.284708893155, 8340.416170868042, 8398.706045288385, 8426.0, 8448.197421244971, 8457.746267611981, 4903.803847846082, 5014.222795466709, 5029.019341228462, 5033.899322013539, 5059.848204553869, 3347.4978753186974, 3374.8312584370683, 3401.727861771052, 3430.9656903430896, 3448.603410607762, 1068.358984609236, 1075.2204651627585, 1083.1389045708681, 1095.1786160379716, 1104.9337039777638, 11424.485898134604, 11435.771284574344, 11449.484773185226, 11453.65639030822, 11464.656060318204, 4291.184674911757, 4357.716748411343, 4508.616767574793, 4539.228331183706, 4550.067236216568, 9574.04259574037, 9607.039296070478, 9612.231021518402, 9637.518124093767, 9657.372270802376, 4457.375967364572, 5063.594912406998, 5073.619478539051, 5083.796648134107, 5086.491350864884, 4541.818327266872, 4597.747123908217, 4634.189016922025, 4658.277966915133, 4659.044895796354, 3774.509313789245, 3776.131489757371, 3819.25524522721, 3886.5724770275247, 3915.7650540967634, 1181.474243961446, 1218.0803493362455, 1223.4677915106956, 1224.7489264700894, 1231.1566576894857, 925.9444433333887, 951.5670369981642, 968.8885778135464, 975.3855071305175, 1007.3250921882357, 5442.564594832404, 5508.228847961289, 5652.802151924663, 5670.149477578314, 5766.04860198071, 403.3888658682099, 410.11415342859283, 413.9960595555765, 415.9542450330461, 421.1660911395454, 3753.305638456894, 3784.6026167252594, 3825.7513261637905, 3851.7496362736333, 3882.7864467453996, 9781.364211326241, 9995.0, 10101.0, 10242.180625549938, 10329.0, 9568.0, 10093.949530252301, 10183.981601839756, 10214.540345684461, 10219.540120694586, 7711.0746710395115, 7773.727919522903, 7825.0, 7858.0963189232825, 7859.174786647434, 5408.972955135199, 5626.971865140648, 5652.915206271991, 5702.942970570241, 5822.272215973004, 9053.230475409664, 9270.490123043028, 9438.716838494856, 9447.291453141179, 9466.148046675833, 9112.954435228046, 9418.905810941802, 9436.669716559887, 9450.054994500495, 9541.475218862752, 7239.565626062453, 7247.673854676657, 7348.191698913009, 7349.55902645843, 7351.338379545867, 7717.2668596483245, 7741.109772376249, 7812.3750099993, 7964.721234756756, 7969.521828690065, 7035.613041282779, 7152.499325047197, 7204.423646108404, 7345.742898998509, 7368.0, 6938.653067346713, 7198.280171982759, 7373.152087510005, 7463.029806125169, 7493.475456717977, 6569.408753212234, 6582.572132811352, 6622.437092846969, 6656.434203092791, 6679.098321726699, 4715.457722361835, 4927.679700819435, 4955.306257123933, 4968.478309777422, 5027.2207807789855, 4903.77932993009, 4972.5276098770555, 4997.3253610762085, 5072.59419246452, 5073.492650734897], "value": 4321.878662370487, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [336.1611193471136, 336.4952571143285, 347.3643232883823, 350.49353683926734, 351.8487050568258, 5435.456454354572, 5490.121580547113, 5491.560675145989, 5514.531264842483, 5526.949879522887, 5187.221916712495, 5375.193720941861, 5382.761964748111, 5393.865153371158, 5404.297441332621, 4156.937645935313, 4305.655547556188, 4329.242382583051, 4332.0469496710675, 4341.153475072362, 4313.482382114135, 4321.135772845428, 4323.156984388045, 4329.826806927735, 4331.3719510670935, 4043.5147782266167, 4194.916101677964, 4203.4115223868685, 4219.704620676538, 4292.1630282095, 4202.075543380452, 4220.978895105535, 4225.218334608092, 4228.154369126156, 4234.407182994383, 3707.9073023174365, 3722.683571896392, 3739.925201495982, 3741.28915506053, 3742.6257374262627, 5147.665401748912, 5235.345581802275, 5237.607179461517, 5260.736963151827, 5299.920501192485, 4820.855374338776, 4834.250691142878, 4857.417109946829, 4867.099586576494, 4873.805047798084, 5739.971300143514, 5742.081266997302, 5743.425657434265, 5744.712764361807, 5751.4536119068625, 3988.9202215955806, 4086.1827634473225, 4092.836286548564, 4095.4675892133832, 4100.0, 5864.1203819427, 5887.175795388649, 5897.734601942923, 5898.115282707586, 5919.230500035011, 4138.772367519755, 4146.979265103655, 4155.314373128461, 4156.542780294165, 4177.289860723684, 4028.3756017817286, 4186.413902053715, 4191.245575796386, 4198.244316023145, 4253.595908388698, 4785.066911952205, 4826.348442960226, 4859.611231101503, 4862.07620552094, 4864.17309057454, 5737.270773996852, 5743.770249189985, 5763.654180749085, 5787.102999035072, 5841.883162336814, 1371.8270878399026, 1438.3024233246867, 1467.4130347860942, 1477.4902658582987, 1484.9902066594602, 973.4402718436927, 992.4392718114242, 994.4977786217913, 1007.5919252702668, 1012.8126296635146, 5542.528885044736, 5561.77752889888, 5562.249096372019, 5587.44125587438, 5601.5238704709745, 5840.0, 5844.444777746107, 5851.297844258716, 5897.675627840425, 5917.201177841022, 5344.198370244417, 5510.504054635022, 5517.779288828402, 5553.861153471114, 5581.581381396411, 3057.3426713256313, 3116.65716771155, 3121.453745594512, 3131.091983324856, 3137.8744850205735, 5858.502027327725, 6062.120992456069, 6064.696765161724, 6071.726772295257, 6089.695515224221, 5869.647821130746, 5924.377940316291, 5946.43508866657, 5955.642661440241, 5959.970200148971, 6055.424734650202, 6093.6039157454625, 6099.200735782954, 6105.938940610626, 6113.388661133851, 5727.878306323148, 5817.76728930838, 5835.0, 5848.239728835224, 5882.352941176553, 5739.598228124159, 5747.885042299047, 5772.307323121252, 5794.855128621818, 5795.420457954339, 5849.3858144894175, 6031.215941927521, 6063.969125248806, 6072.119542666201, 6084.969575152273, 4158.2307273154565, 4185.330347144442, 4194.266003449323, 4194.559571244975, 4195.958040419679, 5698.230738850202, 5752.33848107473, 5862.267216597926, 5867.20792692981, 5884.9705751470965, 5572.359178694502, 5815.41845815415, 5815.854603634943, 5824.155497452761, 5838.153467747238, 5730.5129064030025, 5780.104083867007, 5796.855078623068, 5828.59199856006, 5830.53355731549, 5582.916256256078, 5691.630044047124, 5698.943010569841, 5741.942580574308, 5756.280464941882, 5688.914666280092, 5788.9131663024245, 5796.0436527972415, 5834.620749651259, 5857.297124345106, 5517.36550296721, 5666.320041595035, 5680.6591604503865, 5714.371419143974, 5728.455796699307], "value": 4370.0307120948555, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [834.3783881008648, 835.0, 846.1453931529154, 848.7835601921513, 865.4720620421543, 13684.726305473885, 14102.64743381416, 14292.499762508314, 14300.141991480505, 14304.213268270241, 13645.18128912266, 13842.0, 14007.579772606838, 14037.438502459914, 14074.859251407483, 691.0808624529363, 816.1593558634601, 828.7306625346756, 835.0730688935276, 835.7325655790149, 806.1092492795465, 833.075286432063, 835.6907944060675, 836.8493671139192, 837.3217693668148, 859.4499520307008, 869.2003356911625, 869.326272139091, 869.6695255802786, 870.6473878079388, 714.5855403865745, 740.822202671355, 862.4437237981498, 865.9004214515348, 866.2377108144824, 546.0962107711744, 623.4420193926411, 640.3180612647516, 641.8587910659647, 642.4410762636489, 14724.631884202874, 14747.631309217248, 14763.926180369137, 14806.777898331533, 14833.258337083103, 14213.14721116726, 14565.49020784278, 14569.781453278209, 14624.26878656063, 14672.779908301383, 11220.551177952872, 11472.4837382318, 11475.483603237873, 11521.539138434453, 11528.077753779677, 3794.1273507093247, 3835.271298453285, 3857.209272099241, 3930.9213815723524, 3958.3666613342016, 54219.45780542223, 54541.454585454034, 55547.72226138884, 55651.44348556503, 55762.44237557654, 11101.44492775358, 11107.888921110847, 11200.719982000515, 11269.887301126884, 11294.322340659586, 20095.799042009392, 20101.19595216175, 20117.798822011886, 20122.39632811018, 20155.39533813988, 8153.388495862834, 8323.750287491384, 8588.957055214683, 8635.784105397415, 8654.0, 4711.717296962193, 4881.438634557071, 4894.535019173244, 4930.457649658535, 5036.244563315458, 3181.5068664357063, 3289.309245058517, 3291.5227292043, 3295.8846440374473, 3304.603447586305, 598.4912824099567, 604.4922265297083, 607.4714997951722, 615.0497481391261, 627.2410383436003, 701.7999870037015, 720.5352547606869, 770.8920751094852, 771.9112302085219, 798.2416704131099, 8225.177482251727, 8645.567721613894, 8699.391042627081, 8873.866891996626, 8890.59992300348, 656.7143292667705, 664.2593508238376, 726.3027493606197, 740.6296851574212, 760.9619519024027, 4132.028973191298, 4147.730397524151, 4201.957980420218, 4245.299525578245, 4313.827446902152, 59623.70188149118, 60565.394346056855, 61260.387396125465, 61410.402543643926, 61497.692511537156, 53765.1935220972, 53946.0, 54544.72727636337, 55063.0, 55576.0, 48520.0, 48946.510534894194, 49473.75263123733, 49735.75132124316, 50044.0, 8107.432479726598, 8276.462029968034, 8277.875831862648, 8309.584520774059, 8371.58197028343, 32769.50845737364, 32970.867767563, 33543.664563354054, 33969.830150849084, 34414.311713765084, 41300.793496032325, 43029.56970430256, 45308.0, 45348.54651453575, 45502.77248613736, 11600.825987610362, 11766.88233117658, 11836.526538938346, 11859.34773587461, 12008.63974080779, 12457.439415226518, 12570.87429125697, 12640.051996100145, 13107.67230819199, 13216.405261763051, 11646.324790573897, 11809.468573914366, 11943.522259109886, 12060.216085954386, 12405.503779849067, 11174.608888688857, 11711.590094346657, 11804.055675545764, 11838.0, 12327.445264963277, 11465.369404682822, 11493.367864767519, 11640.825387619361, 11662.358570278717, 11745.706357341134, 9440.150386465251, 9489.051094890456, 9513.66702165421, 9640.517974101127, 9682.9031709682, 9938.602455901972, 10008.549615267477, 10097.091261786474, 10248.0, 10251.94874025655], "value": 6660.791287526715, "unit": "score"}], "name": "dromaeo_css", "value": 6900.263476641983, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 112.0, 107.0, 111.0, 111.0, 114.0, 100.0, 111.0, 113.0, 111.0], "value": 110.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 128.0, 153.0, 189.0, 137.0, 157.0, 160.0, 128.0, 187.0, 133.0], "value": 152.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [159.0, 161.0, 162.0, 160.0, 161.0, 163.0, 162.0, 162.0, 160.0, 160.0], "value": 161.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 73.0, 131.0, 118.0, 77.0, 76.0, 76.0, 124.0, 103.0, 76.0], "value": 92.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 93.0, 145.0, 93.0, 92.0, 98.0, 153.0, 93.0, 93.0, 143.0], "value": 109.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 116.0, 118.0, 117.0, 117.0, 116.0, 116.0, 117.0, 117.0, 116.0], "value": 116.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 146.0, 145.0, 146.0, 145.0, 145.0, 145.0, 145.0, 145.0, 146.0], "value": 145.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 94.0, 95.0, 95.0, 95.0, 95.0, 94.0], "value": 94.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 57.0, 58.0, 57.0, 57.0, 56.0, 57.0, 77.0, 55.0, 53.0], "value": 58.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 61.0, 62.0, 61.0, 62.0, 61.0, 64.0, 61.0, 61.0, 67.0], "value": 62.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 77.0, 75.0, 78.0, 77.0, 77.0, 77.0, 77.0, 78.0, 77.0], "value": 76.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [124.0, 125.0, 127.0, 120.0, 124.0, 124.0, 121.0, 122.0, 159.0, 123.0], "value": 126.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [170.0, 159.0, 161.0, 169.0, 168.0, 163.0, 157.0, 159.0, 159.0, 169.0], "value": 163.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 69.0, 69.0, 68.0, 68.0, 67.0, 66.0, 67.0, 69.0, 66.0], "value": 67.6, "unit": "score"}], "name": "kraken", "value": 1537.7, "alertThreshold": 2.0}]} 07:31:50 INFO - Return code: 0 07:31:50 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 07:31:50 ERROR - # TBPL SUCCESS # 07:31:50 INFO - Running post-action listener: _resource_record_post_action 07:31:50 INFO - Running post-run listener: _resource_record_post_run 07:31:51 INFO - Total resource usage - Wall time: 1190s; CPU: 13.0%; Read bytes: 0; Write bytes: 535932928; Read time: 0; Write time: 484616 07:31:51 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 244092928; Read time: 0; Write time: 233916 07:31:51 INFO - run-tests - Wall time: 1173s; CPU: 13.0%; Read bytes: 0; Write bytes: 291840000; Read time: 0; Write time: 250700 07:31:51 INFO - Running post-run listener: _upload_blobber_files 07:31:51 INFO - Blob upload gear active. 07:31:51 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 07:31:51 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 07:31:51 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'] 07:31:51 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 07:31:52 INFO - (blobuploader) - INFO - Open directory for files ... 07:31:52 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 07:31:52 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:31:52 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:31:52 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 07:31:52 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:31:52 INFO - (blobuploader) - INFO - Done attempting. 07:31:52 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 07:31:52 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:31:52 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:31:53 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 07:31:53 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:31:53 INFO - (blobuploader) - INFO - Done attempting. 07:31:53 INFO - (blobuploader) - INFO - Iteration through files over. 07:31:53 INFO - Return code: 0 07:31:53 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 07:31:53 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 07:31:53 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ecd64ba6f0b23854dc0865476a1d99a840d88b862c8d45fbba3492df303b30af54faa5a1bb38ad8a79011ce6042c60776504e1bb866ae4a8eaafa394518c0aa7", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4aef0e9bbe883a4accbc8249abd8fae466f6666f0e9f4a36d7b7c1883f68c36656f112d1eefe617a3ea523f1a5b236aa54544b4a8e63a2e7adac8bbc1b591d5c"} 07:31:53 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 07:31:53 INFO - Writing to file /builds/slave/test/properties/blobber_files 07:31:53 INFO - Contents: 07:31:53 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ecd64ba6f0b23854dc0865476a1d99a840d88b862c8d45fbba3492df303b30af54faa5a1bb38ad8a79011ce6042c60776504e1bb866ae4a8eaafa394518c0aa7", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4aef0e9bbe883a4accbc8249abd8fae466f6666f0e9f4a36d7b7c1883f68c36656f112d1eefe617a3ea523f1a5b236aa54544b4a8e63a2e7adac8bbc1b591d5c"} 07:31:53 INFO - Running post-run listener: copy_logs_to_upload_dir 07:31:53 INFO - Copying logs to upload dir... 07:31:53 INFO - mkdir: /builds/slave/test/build/upload/logs 07:31:53 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1246.339236 ========= master_lag: 42.10 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 28 secs) (at 2016-04-15 07:32:34.179783) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-15 07:32:34.183473) ========= 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=6d15e502d8e29d5d2676d664000001c3-1460728747.621117-1993446067 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ecd64ba6f0b23854dc0865476a1d99a840d88b862c8d45fbba3492df303b30af54faa5a1bb38ad8a79011ce6042c60776504e1bb866ae4a8eaafa394518c0aa7", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4aef0e9bbe883a4accbc8249abd8fae466f6666f0e9f4a36d7b7c1883f68c36656f112d1eefe617a3ea523f1a5b236aa54544b4a8e63a2e7adac8bbc1b591d5c"} build_url:https://queue.taskcluster.net/v1/task/LXNexNl9S72MlJTktb1MnA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011352 build_url: 'https://queue.taskcluster.net/v1/task/LXNexNl9S72MlJTktb1MnA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ecd64ba6f0b23854dc0865476a1d99a840d88b862c8d45fbba3492df303b30af54faa5a1bb38ad8a79011ce6042c60776504e1bb866ae4a8eaafa394518c0aa7", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4aef0e9bbe883a4accbc8249abd8fae466f6666f0e9f4a36d7b7c1883f68c36656f112d1eefe617a3ea523f1a5b236aa54544b4a8e63a2e7adac8bbc1b591d5c"}' ========= master_lag: 0.38 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-15 07:32:34.574086) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-15 07:32:34.574399) ========= 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=6d15e502d8e29d5d2676d664000001c3-1460728747.621117-1993446067 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004588 ========= master_lag: 0.90 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-15 07:32:35.477728) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-15 07:32:35.478029) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-15 07:32:35.606985) ========= ========= Total master_lag: 43.44 =========